What happens before or in `schedule_preempt_disabled()`?
From: Paul Menzel
Date: Wed Oct 17 2018 - 11:50:41 EST
Dear Linux folks,
On the ASRock E350M1, I am trying to profile and decrease the boot time of
the Linux kernel.
Currently, my kernel needs 790 ms, and 100 ms are spent in the section below.
```
[ 0.000000] Linux version 4.19.0-rc8-00045-gc92161e11c2a (root@5661fb7fd9d5) (gcc version 8.1.0 (Debian 8.1.0-11)) #226 SMP Tue Oct 16 07:15:09 UTC 2018
[â]
[ 0.132977] mce: CPU supports 6 MCE banks
[ 0.132996] Last level iTLB entries: 4KB 512, 2MB 8, 4MB 4
[ 0.132998] Last level dTLB entries: 4KB 512, 2MB 8, 4MB 4, 1GB 0
[ 0.133005] Spectre V2 : Mitigation: Full AMD retpoline
[ 0.133006] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[ 0.133008] Speculative Store Bypass: Vulnerable
[ 0.133244] Freeing SMP alternatives memory: 32K
[ 0.133247] After check_bugs
[ 0.133251] After acpi_subsystem_init
[ 0.133252] After arch_post_acpi_subsys_init
[ 0.133253] After sfi_init_late
[ 0.133255] After rcu_scheduler_starting
[ 0.133392] After find_task_by_pid_ns
[ 0.133394] After numa_default_policy
[ 0.133430] After rcu_read_lock
[ 0.133431] After rcu_read_unlock
[ 0.133437] After kthreadd_done
[ 0.134354] random: 1
[ 0.134354] random: 2
[ 0.134354] random: 3
[ 0.134354] random: 4
[ 0.153357] random: 1
[ 0.153358] random: 2
[ 0.153359] random: 3
[ 0.153360] random: 4
[ 0.217357] random: 1
[ 0.217358] random: 2
[ 0.217359] random: 3
[ 0.217360] random: 4
[ 0.235354] smpboot: CPU0: AMD E-350D APU with Radeon(tm) HD Graphics (family: 0x14, model: 0x2, stepping: 0x0)
[ 0.235354] calling trace_init_flags_sys_enter+0x0/0x13 @ 1
[ 0.235354] initcall trace_init_flags_sys_enter+0x0/0x13 returned 0 after 0 usecs
[ 0.235354] calling trace_init_flags_sys_exit+0x0/0x13 @ 1
[ 0.235354] initcall trace_init_flags_sys_exit+0x0/0x13 returned 0 after 0 usecs
[ 0.235354] calling init_hw_perf_events+0x0/0x5bd @ 1
[ 0.235354] Performance Events: AMD PMU driver.
[â]
[ 0.235720] smp: Bringing up secondary CPUs ...
[ 0.235953] CPU 1 irqstacks, hard=(ptrval) soft=(ptrval)
[ 0.235956] x86: Booting SMP configuration:
[ 0.235958] .... node #0, CPUs: #1
[ 0.004323] Initializing CPU#1
[ 0.236418] After schedule_preempt_disabled
[â]
```
Please find the debug patches attached. The `random: %i` messages are from
`crng_fast_load()`.
My question is, how can I figure out, what happens in the code below?
complete(&kthreadd_done);
pr_info("After kthreadd_done\n");
/*
* The boot idle thread must execute schedule()
* at least once to get things moving:
*/
schedule_preempt_disabled();
pr_info("After schedule_preempt_disabled\n");
Looking at `schedule_preempt_disabled()`, it shouldnât take much time, and I
was unable to find out where `crng_fast_load()` is called from.
I guess threading is somehow working at that point, and I would though that
it is the `complete()` call, but wonder why the `After kthreadd_done` is
printed earlier.
Could you recommend easier ways than using printk debugging to figure this
out?
Kind regards,
Paul
[ 0.000000] Linux version 4.19.0-rc8-00045-gc92161e11c2a (root@5661fb7fd9d5) (gcc version 8.1.0 (Debian 8.1.0-11)) #226 SMP Tue Oct 16 07:15:09 UTC 2018
[ 0.000000] x86/fpu: x87 FPU will use FXSAVE
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x0000000000000fff] type 16
[ 0.000000] BIOS-e820: [mem 0x0000000000001000-0x000000000009ffff] usable
[ 0.000000] BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000c7d3bfff] usable
[ 0.000000] BIOS-e820: [mem 0x00000000c7d3c000-0x00000000c7ffffff] type 16
[ 0.000000] BIOS-e820: [mem 0x00000000c8000000-0x00000000dfffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000f8000000-0x00000000fbffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000011effffff] usable
[ 0.000000] kmemleak: Kernel memory leak detector disabled
[ 0.000000] NX (Execute Disable) protection: active
[ 0.000000] SMBIOS 2.7 present.
[ 0.000000] DMI: ASROCK E350M1/E350M1, BIOS 4.8-1785-g672d5ad20b 10/14/2018
[ 0.000000] tsc: Fast TSC calibration using PIT
[ 0.000000] tsc: Detected 1599.974 MHz processor
[ 0.006507] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[ 0.006514] e820: remove [mem 0x000a0000-0x000fffff] usable
[ 0.006524] last_pfn = 0x11f000 max_arch_pfn = 0x1000000
[ 0.006535] MTRR default type: uncachable
[ 0.006537] MTRR fixed ranges enabled:
[ 0.006540] 00000-9FFFF write-back
[ 0.006542] A0000-BFFFF uncachable
[ 0.006545] C0000-FFFFF write-back
[ 0.006547] MTRR variable ranges enabled:
[ 0.006550] 0 base 0FFC00000 mask FFFC00000 write-protect
[ 0.006553] 1 base 0C0000000 mask FF8000000 write-back
[ 0.006556] 2 base 080000000 mask FC0000000 write-back
[ 0.006558] 3 base 000000000 mask F80000000 write-back
[ 0.006560] 4 disabled
[ 0.006561] 5 disabled
[ 0.006562] 6 disabled
[ 0.006564] 7 disabled
[ 0.006566] TOM2: 000000011f000000 aka 4592M
[ 0.006758] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT
[ 0.006855] initial memory mapped: [mem 0x00000000-0x0b3fffff]
[ 0.006866] Base memory trampoline at [(ptrval)] 9b000 size 16384
[ 0.007019] BRK [0x0ae38000, 0x0ae38fff] PGTABLE
[ 0.007041] BRK [0x0ae39000, 0x0ae39fff] PGTABLE
[ 0.007054] ACPI: Early table checksum verification disabled
[ 0.007184] ACPI: RSDP 0x00000000000F0800 000024 (v02 CORE )
[ 0.007193] ACPI: XSDT 0x00000000C7D4D0E0 00006C (v01 CORE COREBOOT 00000000 CORE 00000000)
[ 0.007206] ACPI: FACP 0x00000000C7D4F840 0000F4 (v04 CORE COREBOOT 00000000 CORE 00000000)
[ 0.007220] ACPI: DSDT 0x00000000C7D4D280 0025B6 (v02 ASROCK COREBOOT 00010001 INTL 20180810)
[ 0.007228] ACPI: FACS 0x00000000C7D4D240 000040
[ 0.007233] ACPI: FACS 0x00000000C7D4D240 000040
[ 0.007239] ACPI: SSDT 0x00000000C7D4F940 00008A (v02 CORE COREBOOT 0000002A CORE 0000002A)
[ 0.007245] ACPI: TCPA 0x00000000C7D4F9D0 000032 (v02 CORE COREBOOT 00000000 CORE 00000000)
[ 0.007252] ACPI: APIC 0x00000000C7D4FA10 00005C (v02 CORE COREBOOT 00000000 CORE 00000000)
[ 0.007258] ACPI: HEST 0x00000000C7D4FA70 000028 (v01 CORE COREBOOT 00000000 CORE 00000000)
[ 0.007265] ACPI: SSDT 0x00000000C7D4FAA0 00168E (v02 AMD ALIB 00000001 MSFT 04000000)
[ 0.007272] ACPI: SSDT 0x00000000C7D51130 0003DE (v01 AMD POWERNOW 00000001 AMD 00000001)
[ 0.007279] ACPI: VFCT 0x00000000C7D51510 00E269 (v01 CORE COREBOOT 00000000 CORE 00000000)
[ 0.007285] ACPI: HPET 0x00000000C7D5F780 000038 (v01 CORE COREBOOT 00000000 CORE 00000000)
[ 0.007305] ACPI: Local APIC address 0xfee00000
[ 0.007312] 3706MB HIGHMEM available.
[ 0.007316] 885MB LOWMEM available.
[ 0.007317] mapped low ram: 0 - 375fe000
[ 0.007319] low ram: 0 - 375fe000
[ 0.007333] BRK [0x0ae3a000, 0x0ae3afff] PGTABLE
[ 0.018133] Zone ranges:
[ 0.018136] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.018141] Normal [mem 0x0000000001000000-0x00000000375fdfff]
[ 0.018144] HighMem [mem 0x00000000375fe000-0x000000011effffff]
[ 0.018146] Movable zone start for each node
[ 0.018147] Early memory node ranges
[ 0.018149] node 0: [mem 0x0000000000001000-0x000000000009ffff]
[ 0.018151] node 0: [mem 0x0000000000100000-0x00000000c7d3bfff]
[ 0.018153] node 0: [mem 0x0000000100000000-0x000000011effffff]
[ 0.022138] Reserved but unavailable: 99109 pages
[ 0.022143] Initmem setup node 0 [mem 0x0000000000001000-0x000000011effffff]
[ 0.022147] On node 0 totalpages: 945371
[ 0.022150] DMA zone: 40 pages used for memmap
[ 0.022151] DMA zone: 0 pages reserved
[ 0.022153] DMA zone: 3999 pages, LIFO batch:0
[ 0.022370] Normal zone: 2175 pages used for memmap
[ 0.022372] Normal zone: 222718 pages, LIFO batch:63
[ 0.033934] HighMem zone: 718654 pages, LIFO batch:63
[ 0.077462] Using APIC driver default
[ 0.077741] ACPI: Local APIC address 0xfee00000
[ 0.077766] IOAPIC[0]: apic_id 2, version 33, address 0xfec00000, GSI 0-23
[ 0.077770] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.077774] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 low level)
[ 0.077779] ACPI: IRQ0 used by override.
[ 0.077781] ACPI: IRQ9 used by override.
[ 0.077786] Using ACPI (MADT) for SMP configuration information
[ 0.077789] ACPI: HPET id: 0x43538210 base: 0xfed00000
[ 0.077801] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
[ 0.077828] [mem 0xe0000000-0xf7ffffff] available for PCI devices
[ 0.077835] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[ 0.077838] After setup_arch
[ 0.077839] After add_latent_entropy
[ 0.077860] After add_device_randomness
[ 0.077871] random: get_random_bytes called from start_kernel+0x9b/0x509 with crng_init=0
[ 0.077875] After boot_init_stack_canary
[ 0.077876] After mm_init_cpumask
[ 0.077887] After setup_command_line
[ 0.077888] After setup_nr_cpu_ids
[ 0.077891] setup_percpu: NR_CPUS:2 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
[ 0.078130] percpu: Embedded 29 pages/cpu @(ptrval) s89996 r0 d28788 u118784
[ 0.078143] pcpu-alloc: s89996 r0 d28788 u118784 alloc=29*4096
[ 0.078146] pcpu-alloc: [0] 0 [0] 1
[ 0.078173] After setup_per_cpu_areas
[ 0.078175] After smp_perpare_boot_cpu
[ 0.078176] After boot_cpu_hotplug_init
[ 0.078182] Built 1 zonelists, mobility grouping on. Total pages: 943156
[ 0.078186] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.19.0-rc8-00045-gc92161e11c2a root=/dev/sda1 rw noisapnp cryptomgr.notests quiet initcall_debug init=/lib/systemd/systemd-bootchart iomem=relaxed apparmor=0 selinux=0 kmemleak=off initcall_blacklist=serial8250_init,init_graph_trace udev.children_max=2 udev.log_priority=info
[ 0.078456] blacklisting initcall serial8250_init
[ 0.078464] blacklisting initcall init_graph_trace
[ 0.078814] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.079007] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.079018] Initializing CPU#0
[ 0.079031] Initializing HighMem for node 0 (000375fe:0011f000)
[ 0.079034] add_highpages_with_active_regions: start_pfn = 226814, end_pfn = 1175552
[ 0.079038] add_highpages_with_active_regions: for_each_free_mem_range: i = 8589934592, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079041] add_highpages_with_active_regions: for_each_free_mem_range: i = 12884901889, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079043] add_highpages_with_active_regions: for_each_free_mem_range: i = 17179869185, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079046] add_highpages_with_active_regions: for_each_free_mem_range: i = 21474836481, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079048] add_highpages_with_active_regions: for_each_free_mem_range: i = 25769803777, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079050] add_highpages_with_active_regions: for_each_free_mem_range: i = 30064771073, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079052] add_highpages_with_active_regions: for_each_free_mem_range: i = 34359738369, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079054] add_highpages_with_active_regions: for_each_free_mem_range: i = 38654705665, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079056] add_highpages_with_active_regions: for_each_free_mem_range: i = 42949672961, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079059] add_highpages_with_active_regions: for_each_free_mem_range: i = 47244640257, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079061] add_highpages_with_active_regions: for_each_free_mem_range: i = 51539607553, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079063] add_highpages_with_active_regions: for_each_free_mem_range: i = 55834574849, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079065] add_highpages_with_active_regions: for_each_free_mem_range: i = 60129542145, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079067] add_highpages_with_active_regions: for_each_free_mem_range: i = 64424509441, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079069] add_highpages_with_active_regions: for_each_free_mem_range: i = 68719476737, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079072] add_highpages_with_active_regions: for_each_free_mem_range: i = 73014444033, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079074] add_highpages_with_active_regions: for_each_free_mem_range: i = 77309411329, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079076] add_highpages_with_active_regions: for_each_free_mem_range: i = 81604378625, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079078] add_highpages_with_active_regions: for_each_free_mem_range: i = 85899345921, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079080] add_highpages_with_active_regions: for_each_free_mem_range: i = 90194313217, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079083] add_highpages_with_active_regions: for_each_free_mem_range: i = 94489280513, nid = 0, pfn = 226814, e_pfn = 226814, before for loop
[ 0.079085] add_highpages_with_active_regions: for_each_free_mem_range: i = 94489280514, nid = 0, pfn = 226814, e_pfn = 818492, before for loop
[ 0.079087] add_highpages_with_active_regions: for_each_free_mem_range: i = 98784247811, nid = 0, pfn = 1048576, e_pfn = 1175552, before for loop
[ 0.079089] Initializing Movable for node 0 (00000000:00000000)
[ 0.079090] add_highpages_with_active_regions: start_pfn = 0, end_pfn = 0
[ 0.079093] add_highpages_with_active_regions: for_each_free_mem_range: i = 8589934592, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079095] add_highpages_with_active_regions: for_each_free_mem_range: i = 12884901889, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079097] add_highpages_with_active_regions: for_each_free_mem_range: i = 17179869185, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079099] add_highpages_with_active_regions: for_each_free_mem_range: i = 21474836481, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079101] add_highpages_with_active_regions: for_each_free_mem_range: i = 25769803777, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079103] add_highpages_with_active_regions: for_each_free_mem_range: i = 30064771073, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079106] add_highpages_with_active_regions: for_each_free_mem_range: i = 34359738369, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079108] add_highpages_with_active_regions: for_each_free_mem_range: i = 38654705665, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079110] add_highpages_with_active_regions: for_each_free_mem_range: i = 42949672961, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079112] add_highpages_with_active_regions: for_each_free_mem_range: i = 47244640257, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079114] add_highpages_with_active_regions: for_each_free_mem_range: i = 51539607553, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079116] add_highpages_with_active_regions: for_each_free_mem_range: i = 55834574849, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079118] add_highpages_with_active_regions: for_each_free_mem_range: i = 60129542145, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079120] add_highpages_with_active_regions: for_each_free_mem_range: i = 64424509441, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079122] add_highpages_with_active_regions: for_each_free_mem_range: i = 68719476737, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079124] add_highpages_with_active_regions: for_each_free_mem_range: i = 73014444033, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079126] add_highpages_with_active_regions: for_each_free_mem_range: i = 77309411329, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079128] add_highpages_with_active_regions: for_each_free_mem_range: i = 81604378625, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079131] add_highpages_with_active_regions: for_each_free_mem_range: i = 85899345921, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079133] add_highpages_with_active_regions: for_each_free_mem_range: i = 90194313217, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079135] add_highpages_with_active_regions: for_each_free_mem_range: i = 94489280513, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079137] add_highpages_with_active_regions: for_each_free_mem_range: i = 94489280514, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.079139] add_highpages_with_active_regions: for_each_free_mem_range: i = 98784247811, nid = 0, pfn = 0, e_pfn = 0, before for loop
[ 0.088566] Memory: 837936K/3781484K available (8706K kernel code, 756K rwdata, 2840K rodata, 1112K init, 644K bss, 2943548K reserved, 0K cma-reserved, 0K highmem)
[ 0.088577] virtual kernel memory layout:
fixmap : 0xfff8f000 - 0xfffff000 ( 448 kB)
cpu_entry : 0xffa00000 - 0xffa4f000 ( 316 kB)
pkmap : 0xff600000 - 0xff800000 (2048 kB)
vmalloc : 0xf7dfe000 - 0xff5fe000 ( 120 MB)
lowmem : 0xc0000000 - 0xf75fe000 ( 885 MB)
.init : 0xcac1d000 - 0xcad33000 (1112 kB)
.data : 0xca880b9c - 0xcac0b000 (3625 kB)
.text : 0xca000000 - 0xca880b9c (8706 kB)
[ 0.088578] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.088890] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.088894] After mm_init
[ 0.088896] ftrace: allocating 33663 entries in 66 pages
[ 0.117268] After sched_init
[ 0.117334] rcu: Hierarchical RCU implementation.
[ 0.117336] rcu: RCU event tracing is enabled.
[ 0.117350] After rcu_init
[ 0.123427] NR_IRQS: 2304, nr_irqs: 440, preallocated irqs: 16
[ 0.124009] CPU 0 irqstacks, hard=(ptrval) soft=(ptrval)
[ 0.124076] calling con_init+0x0/0x1e3 @ 0
[ 0.126623] Console: colour VGA+ 80x25
[ 0.126635] console [tty0] enabled
[ 0.126640] initcall con_init+0x0/0x1e3 returned 0 after 0 usecs
[ 0.126643] calling univ8250_console_init+0x0/0x2a @ 0
[ 0.126652] initcall univ8250_console_init+0x0/0x2a returned 0 after 0 usecs
[ 0.126694] ACPI: Core revision 20180810
[ 0.127247] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484873504 ns
[ 0.127268] hpet clockevent registered
[ 0.127277] APIC: Switch to symmetric I/O mode setup
[ 0.127279] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.127901] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=0 pin2=0
[ 0.132351] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x17100c6f8d5, max_idle_ns: 440795227657 ns
[ 0.132369] Calibrating delay loop (skipped), value calculated using timer frequency.. 3199.94 BogoMIPS (lpj=1599974)
[ 0.132376] pid_max: default: 32768 minimum: 301
[ 0.132466] Security Framework initialized
[ 0.132469] Yama: becoming mindful.
[ 0.132483] calling selinux_init+0x0/0x1c3 @ 0
[ 0.132485] SELinux: Disabled at boot.
[ 0.132489] initcall selinux_init+0x0/0x1c3 returned 0 after 0 usecs
[ 0.132520] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.132527] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.132977] mce: CPU supports 6 MCE banks
[ 0.132996] Last level iTLB entries: 4KB 512, 2MB 8, 4MB 4
[ 0.132998] Last level dTLB entries: 4KB 512, 2MB 8, 4MB 4, 1GB 0
[ 0.133005] Spectre V2 : Mitigation: Full AMD retpoline
[ 0.133006] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[ 0.133008] Speculative Store Bypass: Vulnerable
[ 0.133244] Freeing SMP alternatives memory: 32K
[ 0.133247] After check_bugs
[ 0.133251] After acpi_subsystem_init
[ 0.133252] After arch_post_acpi_subsys_init
[ 0.133253] After sfi_init_late
[ 0.133255] After rcu_scheduler_starting
[ 0.133392] After find_task_by_pid_ns
[ 0.133394] After numa_default_policy
[ 0.133430] After rcu_read_lock
[ 0.133431] After rcu_read_unlock
[ 0.133437] After kthreadd_done
[ 0.134354] random: 1
[ 0.134354] random: 2
[ 0.134354] random: 3
[ 0.134354] random: 4
[ 0.153357] random: 1
[ 0.153358] random: 2
[ 0.153359] random: 3
[ 0.153360] random: 4
[ 0.217357] random: 1
[ 0.217358] random: 2
[ 0.217359] random: 3
[ 0.217360] random: 4
[ 0.235354] smpboot: CPU0: AMD E-350D APU with Radeon(tm) HD Graphics (family: 0x14, model: 0x2, stepping: 0x0)
[ 0.235354] calling trace_init_flags_sys_enter+0x0/0x13 @ 1
[ 0.235354] initcall trace_init_flags_sys_enter+0x0/0x13 returned 0 after 0 usecs
[ 0.235354] calling trace_init_flags_sys_exit+0x0/0x13 @ 1
[ 0.235354] initcall trace_init_flags_sys_exit+0x0/0x13 returned 0 after 0 usecs
[ 0.235354] calling init_hw_perf_events+0x0/0x5bd @ 1
[ 0.235354] Performance Events: AMD PMU driver.
[ 0.235354] ... version: 0
[ 0.235354] ... bit width: 48
[ 0.235354] ... generic registers: 4
[ 0.235354] ... value mask: 0000ffffffffffff
[ 0.235354] ... max period: 00007fffffffffff
[ 0.235354] ... fixed-purpose events: 0
[ 0.235354] ... event mask: 000000000000000f
[ 0.235354] initcall init_hw_perf_events+0x0/0x5bd returned 0 after 0 usecs
[ 0.235354] calling init_real_mode+0x0/0x108 @ 1
[ 0.235354] initcall init_real_mode+0x0/0x108 returned 0 after 0 usecs
[ 0.235354] calling trace_init_perf_perm_irq_work_exit+0x0/0x16 @ 1
[ 0.235354] initcall trace_init_perf_perm_irq_work_exit+0x0/0x16 returned 0 after 0 usecs
[ 0.235354] calling validate_x2apic+0x0/0x49 @ 1
[ 0.235354] initcall validate_x2apic+0x0/0x49 returned 0 after 0 usecs
[ 0.235354] calling register_nmi_cpu_backtrace_handler+0x0/0x18 @ 1
[ 0.235354] initcall register_nmi_cpu_backtrace_handler+0x0/0x18 returned 0 after 0 usecs
[ 0.235354] calling spawn_ksoftirqd+0x0/0x39 @ 1
[ 0.235354] initcall spawn_ksoftirqd+0x0/0x39 returned 0 after 0 usecs
[ 0.235354] calling migration_init+0x0/0x31 @ 1
[ 0.235354] initcall migration_init+0x0/0x31 returned 0 after 0 usecs
[ 0.235354] calling check_cpu_stall_init+0x0/0x1b @ 1
[ 0.235354] initcall check_cpu_stall_init+0x0/0x1b returned 0 after 0 usecs
[ 0.235354] calling srcu_bootup_announce+0x0/0x30 @ 1
[ 0.235354] rcu: Hierarchical SRCU implementation.
[ 0.235354] initcall srcu_bootup_announce+0x0/0x30 returned 0 after 0 usecs
[ 0.235354] calling rcu_spawn_gp_kthread+0x0/0xfc @ 1
[ 0.235354] initcall rcu_spawn_gp_kthread+0x0/0xfc returned 0 after 0 usecs
[ 0.235354] calling cpu_stop_init+0x0/0x78 @ 1
[ 0.235354] initcall cpu_stop_init+0x0/0x78 returned 0 after 0 usecs
[ 0.235354] calling init_events+0x0/0x3a @ 1
[ 0.235354] initcall init_events+0x0/0x3a returned 0 after 0 usecs
[ 0.235354] calling init_trace_printk+0x0/0xf @ 1
[ 0.235354] initcall init_trace_printk+0x0/0xf returned 0 after 0 usecs
[ 0.235354] calling event_trace_enable_again+0x0/0x21 @ 1
[ 0.235354] initcall event_trace_enable_again+0x0/0x21 returned 0 after 0 usecs
[ 0.235354] calling jump_label_init_module+0x0/0x14 @ 1
[ 0.235354] initcall jump_label_init_module+0x0/0x14 returned 0 after 0 usecs
[ 0.235354] calling dynamic_debug_init+0x0/0x211 @ 1
[ 0.235529] initcall dynamic_debug_init+0x0/0x211 returned 0 after 976 usecs
[ 0.235534] calling rand_initialize+0x0/0x110 @ 1
[ 0.235613] initcall rand_initialize+0x0/0x110 returned 0 after 0 usecs
[ 0.235618] calling initialize_ptr_random+0x0/0x47 @ 1
[ 0.235623] initcall initialize_ptr_random+0x0/0x47 returned 0 after 0 usecs
[ 0.235720] smp: Bringing up secondary CPUs ...
[ 0.235953] CPU 1 irqstacks, hard=(ptrval) soft=(ptrval)
[ 0.235956] x86: Booting SMP configuration:
[ 0.235958] .... node #0, CPUs: #1
[ 0.004323] Initializing CPU#1
[ 0.236418] After schedule_preempt_disabled
[ 0.236448] smp: Brought up 1 node, 2 CPUs
[ 0.236448] smpboot: Max logical packages: 1
[ 0.236448] smpboot: Total of 2 processors activated (6399.89 BogoMIPS)
[ 0.238403] devtmpfs: initialized
[ 0.238900] calling ipc_ns_init+0x0/0x48 @ 1
[ 0.238920] initcall ipc_ns_init+0x0/0x48 returned 0 after 0 usecs
[ 0.238924] calling init_mmap_min_addr+0x0/0x27 @ 1
[ 0.238927] initcall init_mmap_min_addr+0x0/0x27 returned 0 after 0 usecs
[ 0.238932] calling net_ns_init+0x0/0xdc @ 1
[ 0.239095] initcall net_ns_init+0x0/0xdc returned 0 after 0 usecs
[ 0.239098] calling e820__register_nvs_regions+0x0/0x3e @ 1
[ 0.239098] initcall e820__register_nvs_regions+0x0/0x3e returned 0 after 0 usecs
[ 0.239098] calling cpufreq_register_tsc_scaling+0x0/0x2a @ 1
[ 0.239098] initcall cpufreq_register_tsc_scaling+0x0/0x2a returned 0 after 0 usecs
[ 0.239098] calling init_cpu_syscore+0x0/0x11 @ 1
[ 0.239098] initcall init_cpu_syscore+0x0/0x11 returned 0 after 0 usecs
[ 0.239098] calling reboot_init+0x0/0x22 @ 1
[ 0.239098] initcall reboot_init+0x0/0x22 returned 0 after 0 usecs
[ 0.239098] calling init_lapic_sysfs+0x0/0x24 @ 1
[ 0.239098] initcall init_lapic_sysfs+0x0/0x24 returned 0 after 0 usecs
[ 0.239098] calling pgd_cache_init+0x0/0x35 @ 1
[ 0.239098] initcall pgd_cache_init+0x0/0x35 returned 0 after 0 usecs
[ 0.239098] calling alloc_frozen_cpus+0x0/0xc @ 1
[ 0.239098] initcall alloc_frozen_cpus+0x0/0xc returned 0 after 0 usecs
[ 0.239098] calling cpu_hotplug_pm_sync_init+0x0/0x16 @ 1
[ 0.239098] initcall cpu_hotplug_pm_sync_init+0x0/0x16 returned 0 after 0 usecs
[ 0.239098] calling wq_sysfs_init+0x0/0x29 @ 1
[ 0.239098] initcall wq_sysfs_init+0x0/0x29 returned 0 after 0 usecs
[ 0.239098] calling ksysfs_init+0x0/0x7d @ 1
[ 0.239098] initcall ksysfs_init+0x0/0x7d returned 0 after 0 usecs
[ 0.239098] calling pm_init+0x0/0x63 @ 1
[ 0.239367] initcall pm_init+0x0/0x63 returned 0 after 0 usecs
[ 0.239367] calling rcu_set_runtime_mode+0x0/0x16 @ 1
[ 0.239367] initcall rcu_set_runtime_mode+0x0/0x16 returned 0 after 0 usecs
[ 0.239367] calling init_jiffies_clocksource+0x0/0x1b @ 1
[ 0.239367] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.239367] initcall init_jiffies_clocksource+0x0/0x1b returned 0 after 0 usecs
[ 0.239367] calling futex_init+0x0/0xd5 @ 1
[ 0.239367] futex hash table entries: 512 (order: 3, 32768 bytes)
[ 0.239367] initcall futex_init+0x0/0xd5 returned 0 after 0 usecs
[ 0.239367] calling cgroup_wq_init+0x0/0x2c @ 1
[ 0.239367] initcall cgroup_wq_init+0x0/0x2c returned 0 after 0 usecs
[ 0.239367] calling cgroup1_wq_init+0x0/0x2c @ 1
[ 0.239367] initcall cgroup1_wq_init+0x0/0x2c returned 0 after 0 usecs
[ 0.239367] calling ftrace_mod_cmd_init+0x0/0xf @ 1
[ 0.239367] initcall ftrace_mod_cmd_init+0x0/0xf returned 0 after 0 usecs
[ 0.239367] calling init_wakeup_tracer+0x0/0x2b @ 1
[ 0.239367] initcall init_wakeup_tracer+0x0/0x2b returned 0 after 0 usecs
[ 0.239367] initcall init_graph_trace blacklisted
[ 0.239367] calling init_per_zone_wmark_min+0x0/0x66 @ 1
[ 0.239367] initcall init_per_zone_wmark_min+0x0/0x66 returned 0 after 0 usecs
[ 0.239367] calling init_zero_pfn+0x0/0x47 @ 1
[ 0.239367] initcall init_zero_pfn+0x0/0x47 returned 0 after 0 usecs
[ 0.239367] calling cma_init_reserved_areas+0x0/0x170 @ 1
[ 0.239367] initcall cma_init_reserved_areas+0x0/0x170 returned 0 after 0 usecs
[ 0.239367] calling fsnotify_init+0x0/0x44 @ 1
[ 0.239367] initcall fsnotify_init+0x0/0x44 returned 0 after 0 usecs
[ 0.239367] calling filelock_init+0x0/0x7f @ 1
[ 0.239367] initcall filelock_init+0x0/0x7f returned 0 after 0 usecs
[ 0.239367] calling init_script_binfmt+0x0/0x18 @ 1
[ 0.239367] initcall init_script_binfmt+0x0/0x18 returned 0 after 0 usecs
[ 0.239367] calling init_elf_binfmt+0x0/0x18 @ 1
[ 0.239367] initcall init_elf_binfmt+0x0/0x18 returned 0 after 0 usecs
[ 0.239367] calling configfs_init+0x0/0x88 @ 1
[ 0.239367] initcall configfs_init+0x0/0x88 returned 0 after 0 usecs
[ 0.239367] calling debugfs_init+0x0/0x4b @ 1
[ 0.239367] initcall debugfs_init+0x0/0x4b returned 0 after 0 usecs
[ 0.239367] calling tracefs_init+0x0/0x39 @ 1
[ 0.239367] initcall tracefs_init+0x0/0x39 returned 0 after 0 usecs
[ 0.239367] calling securityfs_init+0x0/0x63 @ 1
[ 0.239367] initcall securityfs_init+0x0/0x63 returned 0 after 0 usecs
[ 0.239367] calling prandom_init+0x0/0xb1 @ 1
[ 0.239367] initcall prandom_init+0x0/0xb1 returned 0 after 0 usecs
[ 0.239367] calling pinctrl_init+0x0/0x9d @ 1
[ 0.239367] pinctrl core: initialized pinctrl subsystem
[ 0.239367] initcall pinctrl_init+0x0/0x9d returned 0 after 0 usecs
[ 0.239367] calling gpiolib_dev_init+0x0/0xb3 @ 1
[ 0.239367] initcall gpiolib_dev_init+0x0/0xb3 returned 0 after 0 usecs
[ 0.239367] calling component_debug_init+0x0/0x1d @ 1
[ 0.239367] initcall component_debug_init+0x0/0x1d returned 0 after 0 usecs
[ 0.239367] calling early_resume_init+0x0/0xf0 @ 1
[ 0.239367] RTC time: 22:20:28, date: 10/16/18
[ 0.239367] initcall early_resume_init+0x0/0xf0 returned 0 after 0 usecs
[ 0.239367] calling opp_debug_init+0x0/0x39 @ 1
[ 0.239367] initcall opp_debug_init+0x0/0x39 returned 0 after 0 usecs
[ 0.239367] calling cpufreq_core_init+0x0/0x46 @ 1
[ 0.239367] initcall cpufreq_core_init+0x0/0x46 returned 0 after 0 usecs
[ 0.239367] calling cpuidle_init+0x0/0x3b @ 1
[ 0.239367] initcall cpuidle_init+0x0/0x3b returned 0 after 0 usecs
[ 0.239367] calling bsp_pm_check_init+0x0/0x16 @ 1
[ 0.239367] initcall bsp_pm_check_init+0x0/0x16 returned 0 after 0 usecs
[ 0.239367] calling sock_init+0x0/0x8e @ 1
[ 0.239425] initcall sock_init+0x0/0x8e returned 0 after 0 usecs
[ 0.239430] calling net_inuse_init+0x0/0x24 @ 1
[ 0.239437] initcall net_inuse_init+0x0/0x24 returned 0 after 0 usecs
[ 0.239441] calling net_defaults_init+0x0/0x24 @ 1
[ 0.239445] initcall net_defaults_init+0x0/0x24 returned 0 after 0 usecs
[ 0.239449] calling init_default_flow_dissectors+0x0/0x48 @ 1
[ 0.239453] initcall init_default_flow_dissectors+0x0/0x48 returned 0 after 0 usecs
[ 0.239457] calling netpoll_init+0x0/0x34 @ 1
[ 0.239460] initcall netpoll_init+0x0/0x34 returned 0 after 0 usecs
[ 0.239464] calling netlink_proto_init+0x0/0x123 @ 1
[ 0.239506] NET: Registered protocol family 16
[ 0.239530] initcall netlink_proto_init+0x0/0x123 returned 0 after 976 usecs
[ 0.239721] calling irq_sysfs_init+0x0/0x7e @ 1
[ 0.239887] initcall irq_sysfs_init+0x0/0x7e returned 0 after 0 usecs
[ 0.239892] calling audit_init+0x0/0x164 @ 1
[ 0.239899] audit: initializing netlink subsys (disabled)
[ 0.240427] initcall audit_init+0x0/0x164 returned 0 after 0 usecs
[ 0.240427] audit: type=2000 audit(1539728428.113:1): state=initialized audit_enabled=0 res=1
[ 0.240427] calling release_early_probes+0x0/0x36 @ 1
[ 0.240431] initcall release_early_probes+0x0/0x36 returned 0 after 0 usecs
[ 0.240436] calling bdi_class_init+0x0/0x41 @ 1
[ 0.240470] initcall bdi_class_init+0x0/0x41 returned 0 after 0 usecs
[ 0.240474] calling mm_sysfs_init+0x0/0x27 @ 1
[ 0.240481] initcall mm_sysfs_init+0x0/0x27 returned 0 after 0 usecs
[ 0.240485] calling gpiolib_sysfs_init+0x0/0x85 @ 1
[ 0.240499] initcall gpiolib_sysfs_init+0x0/0x85 returned 0 after 0 usecs
[ 0.240504] calling pcibus_class_init+0x0/0x19 @ 1
[ 0.240512] initcall pcibus_class_init+0x0/0x19 returned 0 after 0 usecs
[ 0.240516] calling pci_driver_init+0x0/0x22 @ 1
[ 0.240547] initcall pci_driver_init+0x0/0x22 returned 0 after 0 usecs
[ 0.240552] calling backlight_class_init+0x0/0x91 @ 1
[ 0.240561] initcall backlight_class_init+0x0/0x91 returned 0 after 0 usecs
[ 0.240565] calling tty_class_init+0x0/0x30 @ 1
[ 0.240573] initcall tty_class_init+0x0/0x30 returned 0 after 0 usecs
[ 0.240577] calling vtconsole_class_init+0x0/0xc0 @ 1
[ 0.240625] initcall vtconsole_class_init+0x0/0xc0 returned 0 after 0 usecs
[ 0.240630] calling wakeup_sources_debugfs_init+0x0/0x24 @ 1
[ 0.240638] initcall wakeup_sources_debugfs_init+0x0/0x24 returned 0 after 0 usecs
[ 0.240642] calling regmap_initcall+0x0/0x11 @ 1
[ 0.240648] initcall regmap_initcall+0x0/0x11 returned 0 after 0 usecs
[ 0.240653] calling i2c_init+0x0/0xa5 @ 1
[ 0.240689] initcall i2c_init+0x0/0xa5 returned 0 after 0 usecs
[ 0.240695] calling init_menu+0x0/0x14 @ 1
[ 0.240721] cpuidle: using governor menu
[ 0.240721] initcall init_menu+0x0/0x14 returned 0 after 0 usecs
[ 0.240721] calling pcc_init+0x0/0x2e4 @ 1
[ 0.240721] initcall pcc_init+0x0/0x2e4 returned -19 after 0 usecs
[ 0.240721] calling amd_postcore_init+0x0/0xf2 @ 1
[ 0.241372] initcall amd_postcore_init+0x0/0xf2 returned 0 after 0 usecs
[ 0.241378] calling kobject_uevent_init+0x0/0xf @ 1
[ 0.241400] initcall kobject_uevent_init+0x0/0xf returned 0 after 0 usecs
[ 0.241602] calling bts_init+0x0/0xae @ 1
[ 0.241606] initcall bts_init+0x0/0xae returned -19 after 0 usecs
[ 0.241609] calling pt_init+0x0/0x2f9 @ 1
[ 0.241613] initcall pt_init+0x0/0x2f9 returned -19 after 0 usecs
[ 0.241618] calling boot_params_ksysfs_init+0x0/0x216 @ 1
[ 0.241638] initcall boot_params_ksysfs_init+0x0/0x216 returned 0 after 0 usecs
[ 0.241642] calling sbf_init+0x0/0xc8 @ 1
[ 0.241645] initcall sbf_init+0x0/0xc8 returned 0 after 0 usecs
[ 0.241650] calling arch_kdebugfs_init+0x0/0x23 @ 1
[ 0.241668] initcall arch_kdebugfs_init+0x0/0x23 returned 0 after 0 usecs
[ 0.241673] calling init_pit_clocksource+0x0/0x37 @ 1
[ 0.241676] initcall init_pit_clocksource+0x0/0x37 returned 0 after 0 usecs
[ 0.241681] calling intel_pconfig_init+0x0/0xbb @ 1
[ 0.241685] initcall intel_pconfig_init+0x0/0xbb returned 0 after 0 usecs
[ 0.241690] calling mtrr_if_init+0x0/0x51 @ 1
[ 0.241699] initcall mtrr_if_init+0x0/0x51 returned 0 after 0 usecs
[ 0.241703] calling ffh_cstate_init+0x0/0x2d @ 1
[ 0.241715] initcall ffh_cstate_init+0x0/0x2d returned 0 after 0 usecs
[ 0.241720] calling kdump_buf_page_init+0x0/0x3b @ 1
[ 0.241724] initcall kdump_buf_page_init+0x0/0x3b returned 0 after 0 usecs
[ 0.241729] calling acpi_pci_init+0x0/0x5b @ 1
[ 0.241731] ACPI: bus type PCI registered
[ 0.241736] initcall acpi_pci_init+0x0/0x5b returned 0 after 0 usecs
[ 0.241740] calling dma_channel_table_init+0x0/0xc2 @ 1
[ 0.241752] initcall dma_channel_table_init+0x0/0xc2 returned 0 after 0 usecs
[ 0.241755] calling dma_bus_init+0x0/0x91 @ 1
[ 0.241790] initcall dma_bus_init+0x0/0x91 returned 0 after 0 usecs
[ 0.241794] calling dmi_id_init+0x0/0x2b8 @ 1
[ 0.241868] initcall dmi_id_init+0x0/0x2b8 returned 0 after 0 usecs
[ 0.241872] calling pci_arch_init+0x0/0x6b @ 1
[ 0.242285] PCI: Using configuration type 1 for base access
[ 0.242286] PCI: Using configuration type 1 for extended access
[ 0.242300] initcall pci_arch_init+0x0/0x6b returned 0 after 976 usecs
[ 0.242496] calling fixup_ht_bug+0x0/0x8e @ 1
[ 0.242500] initcall fixup_ht_bug+0x0/0x8e returned 0 after 0 usecs
[ 0.242504] calling topology_init+0x0/0x30 @ 1
[ 0.242641] initcall topology_init+0x0/0x30 returned 0 after 976 usecs
[ 0.242646] calling mtrr_init_finialize+0x0/0x41 @ 1
[ 0.242648] mtrr: your CPUs had inconsistent variable MTRR settings
[ 0.242650] mtrr: probably your BIOS does not setup all CPUs.
[ 0.242650] mtrr: corrected configuration.
[ 0.242654] initcall mtrr_init_finialize+0x0/0x41 returned 0 after 0 usecs
[ 0.242658] calling uid_cache_init+0x0/0x7b @ 1
[ 0.242666] initcall uid_cache_init+0x0/0x7b returned 0 after 0 usecs
[ 0.242670] calling param_sysfs_init+0x0/0x196 @ 1
[ 0.246172] initcall param_sysfs_init+0x0/0x196 returned 0 after 2929 usecs
[ 0.246177] calling user_namespace_sysctl_init+0x0/0x40 @ 1
[ 0.246200] initcall user_namespace_sysctl_init+0x0/0x40 returned 0 after 0 usecs
[ 0.246204] calling proc_schedstat_init+0x0/0x23 @ 1
[ 0.246211] initcall proc_schedstat_init+0x0/0x23 returned 0 after 0 usecs
[ 0.246215] calling pm_sysrq_init+0x0/0x1b @ 1
[ 0.246414] initcall pm_sysrq_init+0x0/0x1b returned 0 after 0 usecs
[ 0.246414] calling create_proc_profile+0x0/0x100 @ 1
[ 0.246414] initcall create_proc_profile+0x0/0x100 returned 0 after 0 usecs
[ 0.246414] calling crash_save_vmcoreinfo_init+0x0/0x4e1 @ 1
[ 0.246432] initcall crash_save_vmcoreinfo_init+0x0/0x4e1 returned 0 after 0 usecs
[ 0.246436] calling crash_notes_memory_init+0x0/0x36 @ 1
[ 0.246452] initcall crash_notes_memory_init+0x0/0x36 returned 0 after 0 usecs
[ 0.246457] calling cgroup_sysfs_init+0x0/0x19 @ 1
[ 0.246466] initcall cgroup_sysfs_init+0x0/0x19 returned 0 after 0 usecs
[ 0.246471] calling cgroup_namespaces_init+0x0/0xc @ 1
[ 0.246475] initcall cgroup_namespaces_init+0x0/0xc returned 0 after 0 usecs
[ 0.246479] calling user_namespaces_init+0x0/0x2c @ 1
[ 0.246502] initcall user_namespaces_init+0x0/0x2c returned 0 after 0 usecs
[ 0.246506] calling dev_map_init+0x0/0x16 @ 1
[ 0.246511] initcall dev_map_init+0x0/0x16 returned 0 after 0 usecs
[ 0.246514] calling stack_map_init+0x0/0x40 @ 1
[ 0.246517] initcall stack_map_init+0x0/0x40 returned 0 after 0 usecs
[ 0.246521] calling oom_init+0x0/0x2e @ 1
[ 0.247415] initcall oom_init+0x0/0x2e returned 0 after 0 usecs
[ 0.247415] calling default_bdi_init+0x0/0xa7 @ 1
[ 0.247456] initcall default_bdi_init+0x0/0xa7 returned 0 after 0 usecs
[ 0.247461] calling cgwb_init+0x0/0x2c @ 1
[ 0.247475] initcall cgwb_init+0x0/0x2c returned 0 after 0 usecs
[ 0.247479] calling percpu_enable_async+0x0/0x13 @ 1
[ 0.247483] initcall percpu_enable_async+0x0/0x13 returned 0 after 0 usecs
[ 0.247488] calling kcompactd_init+0x0/0x49 @ 1
[ 0.247500] initcall kcompactd_init+0x0/0x49 returned 0 after 0 usecs
[ 0.247500] calling init_user_reserve+0x0/0x40 @ 1
[ 0.247500] initcall init_user_reserve+0x0/0x40 returned 0 after 0 usecs
[ 0.247500] calling init_admin_reserve+0x0/0x40 @ 1
[ 0.247500] initcall init_admin_reserve+0x0/0x40 returned 0 after 0 usecs
[ 0.247500] calling init_reserve_notifier+0x0/0x3 @ 1
[ 0.247500] initcall init_reserve_notifier+0x0/0x3 returned 0 after 0 usecs
[ 0.247500] calling swap_init_sysfs+0x0/0x5d @ 1
[ 0.247500] initcall swap_init_sysfs+0x0/0x5d returned 0 after 0 usecs
[ 0.247500] calling swapfile_init+0x0/0x40 @ 1
[ 0.247500] initcall swapfile_init+0x0/0x40 returned 0 after 0 usecs
[ 0.247500] calling hugetlb_init+0x0/0x3ba @ 1
[ 0.247500] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[ 0.247500] initcall hugetlb_init+0x0/0x3ba returned 0 after 0 usecs
[ 0.247500] calling ksm_init+0x0/0x154 @ 1
[ 0.247500] initcall ksm_init+0x0/0x154 returned 0 after 0 usecs
[ 0.247500] calling hugepage_init+0x0/0x12e @ 1
[ 0.247500] initcall hugepage_init+0x0/0x12e returned 0 after 0 usecs
[ 0.247500] calling mem_cgroup_init+0x0/0xc0 @ 1
[ 0.247500] initcall mem_cgroup_init+0x0/0xc0 returned 0 after 0 usecs
[ 0.247500] calling mem_cgroup_swap_init+0x0/0x4e @ 1
[ 0.247500] initcall mem_cgroup_swap_init+0x0/0x4e returned 0 after 0 usecs
[ 0.247500] calling sel_ib_pkey_init+0x0/0x30 @ 1
[ 0.247500] initcall sel_ib_pkey_init+0x0/0x30 returned 0 after 0 usecs
[ 0.247500] calling crypto_wq_init+0x0/0x2c @ 1
[ 0.247523] initcall crypto_wq_init+0x0/0x2c returned 0 after 0 usecs
[ 0.247527] calling cryptomgr_init+0x0/0x14 @ 1
[ 0.247530] initcall cryptomgr_init+0x0/0x14 returned 0 after 0 usecs
[ 0.247533] calling cryptd_init+0x0/0xa2 @ 1
[ 0.247538] cryptd: max_cpu_qlen set to 1000
[ 0.247541] initcall cryptd_init+0x0/0xa2 returned 0 after 0 usecs
[ 0.247545] calling init_bio+0x0/0xbe @ 1
[ 0.247598] initcall init_bio+0x0/0xbe returned 0 after 0 usecs
[ 0.247598] calling blk_settings_init+0x0/0x22 @ 1
[ 0.247598] initcall blk_settings_init+0x0/0x22 returned 0 after 0 usecs
[ 0.247598] calling blk_ioc_init+0x0/0x29 @ 1
[ 0.247598] initcall blk_ioc_init+0x0/0x29 returned 0 after 0 usecs
[ 0.247598] calling blk_softirq_init+0x0/0x63 @ 1
[ 0.247598] initcall blk_softirq_init+0x0/0x63 returned 0 after 0 usecs
[ 0.247598] calling blk_mq_init+0x0/0x26 @ 1
[ 0.247598] initcall blk_mq_init+0x0/0x26 returned 0 after 0 usecs
[ 0.247598] calling genhd_device_init+0x0/0x66 @ 1
[ 0.248420] initcall genhd_device_init+0x0/0x66 returned 0 after 976 usecs
[ 0.248420] calling irq_poll_setup+0x0/0x5e @ 1
[ 0.248420] initcall irq_poll_setup+0x0/0x5e returned 0 after 0 usecs
[ 0.248420] calling byt_gpio_init+0x0/0x16 @ 1
[ 0.248420] initcall byt_gpio_init+0x0/0x16 returned 0 after 0 usecs
[ 0.248424] calling gpiolib_debugfs_init+0x0/0x24 @ 1
[ 0.248432] initcall gpiolib_debugfs_init+0x0/0x24 returned 0 after 0 usecs
[ 0.248436] calling pwm_debugfs_init+0x0/0x24 @ 1
[ 0.248441] initcall pwm_debugfs_init+0x0/0x24 returned 0 after 0 usecs
[ 0.248445] calling pwm_sysfs_init+0x0/0x19 @ 1
[ 0.248454] initcall pwm_sysfs_init+0x0/0x19 returned 0 after 0 usecs
[ 0.248460] calling pci_slot_init+0x0/0x40 @ 1
[ 0.248467] initcall pci_slot_init+0x0/0x40 returned 0 after 0 usecs
[ 0.248471] calling fbmem_init+0x0/0xcc @ 1
[ 0.248526] initcall fbmem_init+0x0/0xcc returned 0 after 0 usecs
[ 0.248531] calling scan_for_dmi_ipmi+0x0/0x10f @ 1
[ 0.248535] initcall scan_for_dmi_ipmi+0x0/0x10f returned 0 after 0 usecs
[ 0.248540] calling acpi_init+0x0/0x2e2 @ 1
[ 0.248572] ACPI: Added _OSI(Module Device)
[ 0.248574] ACPI: Added _OSI(Processor Device)
[ 0.248575] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.248577] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.248580] ACPI: Added _OSI(Linux-Dell-Video)
[ 0.248583] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[ 0.259842] ACPI: 4 ACPI AML tables successfully acquired and loaded
[ 0.263742] ACPI: Interpreter enabled
[ 0.263787] ACPI: (supports S0 S1 S3 S5)
[ 0.263790] ACPI: Using IOAPIC for interrupt routing
[ 0.263829] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.264229] ACPI: Enabled 19 GPEs in block 00 to 1F
[ 0.274304] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.274319] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI]
[ 0.274494] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability LTR]
[ 0.274933] PCI host bridge to bus 0000:00
[ 0.274939] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 0.274942] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
[ 0.274945] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
[ 0.274948] pci_bus 0000:00: root bus resource [mem 0xe0000000-0xffffffff]
[ 0.274952] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.274971] pci 0000:00:00.0: [1022:1510] type 00 class 0x060000
[ 0.274983] pci 0000:00:00.0: calling quirk_mmio_always_on+0x0/0x10 @ 1
[ 0.274989] pci 0000:00:00.0: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[ 0.275266] pci 0000:00:01.0: [1002:9802] type 00 class 0x030000
[ 0.275290] pci 0000:00:01.0: reg 0x10: [mem 0xe0000000-0xefffffff pref]
[ 0.275299] pci 0000:00:01.0: reg 0x14: [io 0x2000-0x20ff]
[ 0.275309] pci 0000:00:01.0: reg 0x18: [mem 0xf0100000-0xf013ffff]
[ 0.275340] pci 0000:00:01.0: enabling Extended Tags
[ 0.275372] pci 0000:00:01.0: calling quirk_no_pm_reset+0x0/0x20 @ 1
[ 0.275377] pci 0000:00:01.0: quirk_no_pm_reset+0x0/0x20 took 0 usecs
[ 0.275411] pci 0000:00:01.0: supports D1 D2
[ 0.275646] pci 0000:00:01.1: [1002:1314] type 00 class 0x040300
[ 0.275668] pci 0000:00:01.1: reg 0x10: [mem 0xf0140000-0xf0143fff]
[ 0.275710] pci 0000:00:01.1: enabling Extended Tags
[ 0.275757] pci 0000:00:01.1: supports D1 D2
[ 0.276085] pci 0000:00:11.0: [1002:4391] type 00 class 0x010601
[ 0.276114] pci 0000:00:11.0: reg 0x10: [io 0x2410-0x2417]
[ 0.276127] pci 0000:00:11.0: reg 0x14: [io 0x2420-0x2423]
[ 0.276141] pci 0000:00:11.0: reg 0x18: [io 0x2418-0x241f]
[ 0.276154] pci 0000:00:11.0: reg 0x1c: [io 0x2424-0x2427]
[ 0.276168] pci 0000:00:11.0: reg 0x20: [io 0x2400-0x240f]
[ 0.276181] pci 0000:00:11.0: reg 0x24: [mem 0xf014b000-0xf014b3ff]
[ 0.276531] pci 0000:00:12.0: [1002:4397] type 00 class 0x0c0310
[ 0.276556] pci 0000:00:12.0: reg 0x10: [mem 0xf0148000-0xf0148fff]
[ 0.276926] pci 0000:00:12.2: [1002:4396] type 00 class 0x0c0320
[ 0.276956] pci 0000:00:12.2: reg 0x10: [mem 0xf014c000-0xf014c0ff]
[ 0.277067] pci 0000:00:12.2: supports D1 D2
[ 0.277070] pci 0000:00:12.2: PME# supported from D0 D1 D2 D3hot
[ 0.277073] pci 0000:00:12.2: pme_poll = true
[ 0.277075] pci 0000:00:12.2: after device_set_wakeup_capable()
[ 0.277081] pci 0000:00:12.2: after pci_pme_active()
[ 0.277380] pci 0000:00:13.0: [1002:4397] type 00 class 0x0c0310
[ 0.277405] pci 0000:00:13.0: reg 0x10: [mem 0xf0149000-0xf0149fff]
[ 0.277772] pci 0000:00:13.2: [1002:4396] type 00 class 0x0c0320
[ 0.277801] pci 0000:00:13.2: reg 0x10: [mem 0xf014d000-0xf014d0ff]
[ 0.277911] pci 0000:00:13.2: supports D1 D2
[ 0.277914] pci 0000:00:13.2: PME# supported from D0 D1 D2 D3hot
[ 0.277917] pci 0000:00:13.2: pme_poll = true
[ 0.277919] pci 0000:00:13.2: after device_set_wakeup_capable()
[ 0.277924] pci 0000:00:13.2: after pci_pme_active()
[ 0.278223] pci 0000:00:14.0: [1002:4385] type 00 class 0x0c0500
[ 0.278233] pci 0000:00:14.0: calling sb600_disable_hpet_bar+0x0/0x80 @ 1
[ 0.278239] pci 0000:00:14.0: sb600_disable_hpet_bar+0x0/0x80 took 0 usecs
[ 0.278331] pci 0000:00:14.0: calling force_disable_hpet_msi+0x0/0x20 @ 1
[ 0.278336] pci 0000:00:14.0: force_disable_hpet_msi+0x0/0x20 took 0 usecs
[ 0.278341] pci 0000:00:14.0: calling sb600_hpet_quirk+0x0/0x80 @ 1
[ 0.278364] pci 0000:00:14.0: sb600_hpet_quirk+0x0/0x80 took 0 usecs
[ 0.278651] pci 0000:00:14.2: [1002:4383] type 00 class 0x040300
[ 0.278685] pci 0000:00:14.2: reg 0x10: [mem 0xf0144000-0xf0147fff 64bit]
[ 0.278781] pci 0000:00:14.2: PME# supported from D0 D3hot D3cold
[ 0.278783] pci 0000:00:14.2: pme_poll = true
[ 0.278785] pci 0000:00:14.2: after device_set_wakeup_capable()
[ 0.278790] pci 0000:00:14.2: after pci_pme_active()
[ 0.279078] pci 0000:00:14.3: [1002:439d] type 00 class 0x060100
[ 0.279463] pci 0000:00:14.4: [1002:4384] type 01 class 0x060401
[ 0.279813] pci 0000:00:14.5: [1002:4399] type 00 class 0x0c0310
[ 0.279838] pci 0000:00:14.5: reg 0x10: [mem 0xf014a000-0xf014afff]
[ 0.280211] pci 0000:00:15.0: [1002:43a0] type 01 class 0x060400
[ 0.280263] pci 0000:00:15.0: enabling Extended Tags
[ 0.280334] pci 0000:00:15.0: supports D1 D2
[ 0.280659] pci 0000:00:15.1: [1002:43a1] type 01 class 0x060400
[ 0.280719] pci 0000:00:15.1: enabling Extended Tags
[ 0.280789] pci 0000:00:15.1: supports D1 D2
[ 0.281116] pci 0000:00:18.0: [1022:1700] type 00 class 0x060000
[ 0.281126] pci 0000:00:18.0: calling quirk_mmio_always_on+0x0/0x10 @ 1
[ 0.281130] pci 0000:00:18.0: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[ 0.281378] pci 0000:00:18.1: [1022:1701] type 00 class 0x060000
[ 0.281387] pci 0000:00:18.1: calling quirk_mmio_always_on+0x0/0x10 @ 1
[ 0.281392] pci 0000:00:18.1: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[ 0.281628] pci 0000:00:18.2: [1022:1702] type 00 class 0x060000
[ 0.281637] pci 0000:00:18.2: calling quirk_mmio_always_on+0x0/0x10 @ 1
[ 0.281642] pci 0000:00:18.2: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[ 0.281878] pci 0000:00:18.3: [1022:1703] type 00 class 0x060000
[ 0.281887] pci 0000:00:18.3: calling quirk_mmio_always_on+0x0/0x10 @ 1
[ 0.281891] pci 0000:00:18.3: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[ 0.282146] pci 0000:00:18.4: [1022:1704] type 00 class 0x060000
[ 0.282155] pci 0000:00:18.4: calling quirk_mmio_always_on+0x0/0x10 @ 1
[ 0.282160] pci 0000:00:18.4: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[ 0.282402] pci 0000:00:18.5: [1022:1718] type 00 class 0x060000
[ 0.282411] pci 0000:00:18.5: calling quirk_mmio_always_on+0x0/0x10 @ 1
[ 0.282416] pci 0000:00:18.5: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[ 0.282650] pci 0000:00:18.6: [1022:1716] type 00 class 0x060000
[ 0.282658] pci 0000:00:18.6: calling quirk_mmio_always_on+0x0/0x10 @ 1
[ 0.282663] pci 0000:00:18.6: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[ 0.282893] pci 0000:00:18.7: [1022:1719] type 00 class 0x060000
[ 0.282902] pci 0000:00:18.7: calling quirk_mmio_always_on+0x0/0x10 @ 1
[ 0.282907] pci 0000:00:18.7: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[ 0.283235] pci_bus 0000:01: extended config space not accessible
[ 0.283414] pci 0000:00:14.4: PCI bridge to [bus 01] (subtractive decode)
[ 0.283428] pci 0000:00:14.4: bridge window [io 0x0000-0x0cf7 window] (subtractive decode)
[ 0.283431] pci 0000:00:14.4: bridge window [io 0x0d00-0xffff window] (subtractive decode)
[ 0.283434] pci 0000:00:14.4: bridge window [mem 0x000a0000-0x000bffff] (subtractive decode)
[ 0.283437] pci 0000:00:14.4: bridge window [mem 0xe0000000-0xffffffff] (subtractive decode)
[ 0.283520] pci 0000:00:15.0: PCI bridge to [bus 02]
[ 0.283633] pci 0000:03:00.0: [10ec:8168] type 00 class 0x020000
[ 0.283676] pci 0000:03:00.0: reg 0x10: [io 0x1000-0x10ff]
[ 0.283715] pci 0000:03:00.0: reg 0x18: [mem 0xf0004000-0xf0004fff 64bit pref]
[ 0.283740] pci 0000:03:00.0: reg 0x20: [mem 0xf0000000-0xf0003fff 64bit pref]
[ 0.283884] pci 0000:03:00.0: supports D1 D2
[ 0.283887] pci 0000:03:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.283889] pci 0000:03:00.0: pme_poll = true
[ 0.283891] pci 0000:03:00.0: after device_set_wakeup_capable()
[ 0.283898] pci 0000:03:00.0: after pci_pme_active()
[ 0.283953] pci 0000:03:00.0: 2.000 Gb/s available PCIe bandwidth, limited by 2.5 GT/s x1 link at 0000:00:15.1 (capable of 7.876 Gb/s with 8 GT/s x1 link)
[ 0.287454] pci 0000:00:15.1: PCI bridge to [bus 03]
[ 0.287468] pci 0000:00:15.1: bridge window [io 0x1000-0x1fff]
[ 0.287484] pci 0000:00:15.1: bridge window [mem 0xf0000000-0xf00fffff 64bit pref]
[ 0.287527] pci_bus 0000:00: on NUMA node 0
[ 0.288991] ACPI: PCI Interrupt Link [INTA] (IRQs 3 4 5 7 10 11 12 15) *0, disabled.
[ 0.289321] ACPI: PCI Interrupt Link [INTB] (IRQs 3 4 5 7 10 11 12 15) *0, disabled.
[ 0.289682] ACPI: PCI Interrupt Link [INTC] (IRQs 3 4 5 7 10 11 12 15) *0, disabled.
[ 0.290007] ACPI: PCI Interrupt Link [INTD] (IRQs 3 4 5 7 10 11 12 15) *0, disabled.
[ 0.290331] ACPI: PCI Interrupt Link [INTE] (IRQs 3 4 5 7 10 11 12 15) *0, disabled.
[ 0.290670] ACPI: PCI Interrupt Link [INTF] (IRQs 9) *0, disabled.
[ 0.290990] ACPI: PCI Interrupt Link [INTG] (IRQs 3 4 5 7 10 11 12 15) *0, disabled.
[ 0.291313] ACPI: PCI Interrupt Link [INTH] (IRQs 3 4 5 7 10 11 12 15) *0, disabled.
[ 0.292358] initcall acpi_init+0x0/0x2e2 returned 0 after 42968 usecs
[ 0.292358] calling pnp_init+0x0/0x14 @ 1
[ 0.292358] initcall pnp_init+0x0/0x14 returned 0 after 0 usecs
[ 0.292358] calling misc_init+0x0/0xae @ 1
[ 0.292358] initcall misc_init+0x0/0xae returned 0 after 0 usecs
[ 0.292358] calling vga_arb_device_init+0x0/0x231 @ 1
[ 0.292435] pci 0000:00:01.0: vgaarb: setting as boot VGA device
[ 0.292435] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[ 0.292435] pci 0000:00:01.0: vgaarb: bridge control possible
[ 0.292435] vgaarb: loaded
[ 0.292443] initcall vga_arb_device_init+0x0/0x231 returned 0 after 0 usecs
[ 0.292452] calling cn_init+0x0/0xd0 @ 1
[ 0.292490] initcall cn_init+0x0/0xd0 returned 0 after 0 usecs
[ 0.292495] calling dax_fs_init+0x0/0xab @ 1
[ 0.292560] initcall dax_fs_init+0x0/0xab returned 0 after 0 usecs
[ 0.292564] calling dma_buf_init+0x0/0x99 @ 1
[ 0.292582] initcall dma_buf_init+0x0/0x99 returned 0 after 0 usecs
[ 0.292586] calling init_scsi+0x0/0x90 @ 1
[ 0.292681] SCSI subsystem initialized
[ 0.292681] initcall init_scsi+0x0/0x90 returned 0 after 0 usecs
[ 0.292681] calling ata_init+0x0/0x2a7 @ 1
[ 0.293388] libata version 3.00 loaded.
[ 0.293393] initcall ata_init+0x0/0x2a7 returned 0 after 976 usecs
[ 0.293397] calling phy_init+0x0/0x4c @ 1
[ 0.293439] initcall phy_init+0x0/0x4c returned 0 after 0 usecs
[ 0.293443] calling usb_init+0x0/0x11b @ 1
[ 0.293452] ACPI: bus type USB registered
[ 0.293497] usbcore: registered new interface driver usbfs
[ 0.293516] usbcore: registered new interface driver hub
[ 0.293549] usbcore: registered new device driver usb
[ 0.293554] initcall usb_init+0x0/0x11b returned 0 after 0 usecs
[ 0.293558] calling serio_init+0x0/0x2d @ 1
[ 0.293579] initcall serio_init+0x0/0x2d returned 0 after 0 usecs
[ 0.293583] calling input_init+0x0/0xe3 @ 1
[ 0.293596] initcall input_init+0x0/0xe3 returned 0 after 0 usecs
[ 0.293601] calling rtc_init+0x0/0x47 @ 1
[ 0.293611] initcall rtc_init+0x0/0x47 returned 0 after 0 usecs
[ 0.293616] calling power_supply_class_init+0x0/0x3a @ 1
[ 0.293626] initcall power_supply_class_init+0x0/0x3a returned 0 after 0 usecs
[ 0.293630] calling hwmon_init+0x0/0xd5 @ 1
[ 0.293642] initcall hwmon_init+0x0/0xd5 returned 0 after 0 usecs
[ 0.293647] calling leds_init+0x0/0x37 @ 1
[ 0.293656] initcall leds_init+0x0/0x37 returned 0 after 0 usecs
[ 0.293661] calling dmi_init+0x0/0xf8 @ 1
[ 0.293689] initcall dmi_init+0x0/0xf8 returned 0 after 0 usecs
[ 0.293693] calling devfreq_init+0x0/0x90 @ 1
[ 0.293753] initcall devfreq_init+0x0/0x90 returned 0 after 0 usecs
[ 0.293753] calling ras_init+0x0/0x14 @ 1
[ 0.293753] initcall ras_init+0x0/0x14 returned 0 after 0 usecs
[ 0.293753] calling nvmem_init+0x0/0x14 @ 1
[ 0.293753] initcall nvmem_init+0x0/0x14 returned 0 after 0 usecs
[ 0.293753] calling pci_subsys_init+0x0/0x65 @ 1
[ 0.293753] PCI: Using ACPI for IRQ routing
[ 0.293753] PCI: pci_cache_line_size set to 64 bytes
[ 0.293753] e820: reserve RAM buffer [mem 0xc7d3c000-0xc7ffffff]
[ 0.293753] e820: reserve RAM buffer [mem 0x11f000000-0x11fffffff]
[ 0.293753] initcall pci_subsys_init+0x0/0x65 returned 0 after 0 usecs
[ 0.293753] calling proto_init+0x0/0x14 @ 1
[ 0.293753] initcall proto_init+0x0/0x14 returned 0 after 0 usecs
[ 0.293753] calling net_dev_init+0x0/0x1e9 @ 1
[ 0.293753] initcall net_dev_init+0x0/0x1e9 returned 0 after 0 usecs
[ 0.293753] calling neigh_init+0x0/0x78 @ 1
[ 0.293753] initcall neigh_init+0x0/0x78 returned 0 after 0 usecs
[ 0.293753] calling fib_notifier_init+0x0/0x14 @ 1
[ 0.293753] initcall fib_notifier_init+0x0/0x14 returned 0 after 0 usecs
[ 0.293753] calling fib_rules_init+0x0/0xa6 @ 1
[ 0.293753] initcall fib_rules_init+0x0/0xa6 returned 0 after 0 usecs
[ 0.293753] calling init_cgroup_netprio+0x0/0x16 @ 1
[ 0.293753] initcall init_cgroup_netprio+0x0/0x16 returned 0 after 0 usecs
[ 0.293753] calling bpf_lwt_init+0x0/0x19 @ 1
[ 0.293753] initcall bpf_lwt_init+0x0/0x19 returned 0 after 0 usecs
[ 0.293753] calling pktsched_init+0x0/0xf6 @ 1
[ 0.293753] initcall pktsched_init+0x0/0xf6 returned 0 after 0 usecs
[ 0.293753] calling tc_filter_init+0x0/0xe3 @ 1
[ 0.294360] initcall tc_filter_init+0x0/0xe3 returned 0 after 0 usecs
[ 0.294360] calling tc_action_init+0x0/0x65 @ 1
[ 0.294360] initcall tc_action_init+0x0/0x65 returned 0 after 0 usecs
[ 0.294360] calling genl_init+0x0/0x33 @ 1
[ 0.294360] initcall genl_init+0x0/0x33 returned 0 after 0 usecs
[ 0.294360] calling nmi_warning_debugfs+0x0/0x26 @ 1
[ 0.294360] initcall nmi_warning_debugfs+0x0/0x26 returned 0 after 0 usecs
[ 0.294360] calling hpet_late_init+0x0/0xf6 @ 1
[ 0.294360] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 0.294360] hpet0: 3 comparators, 32-bit 14.318180 MHz counter
[ 0.296361] initcall hpet_late_init+0x0/0xf6 returned 0 after 1953 usecs
[ 0.296365] calling init_amd_nbs+0x0/0x103 @ 1
[ 0.296404] initcall init_amd_nbs+0x0/0x103 returned 0 after 0 usecs
[ 0.296408] calling sugov_register+0x0/0x14 @ 1
[ 0.296412] initcall sugov_register+0x0/0x14 returned 0 after 0 usecs
[ 0.296417] calling clocksource_done_booting+0x0/0x40 @ 1
[ 0.296442] clocksource: Switched to clocksource tsc-early
[ 0.296447] initcall clocksource_done_booting+0x0/0x40 returned 0 after 10 usecs
[ 0.296451] calling tracer_init_tracefs+0x0/0x178 @ 1
[ 0.322720] initcall tracer_init_tracefs+0x0/0x178 returned 0 after 25717 usecs
[ 0.322737] calling init_trace_printk_function_export+0x0/0x2d @ 1
[ 0.322745] initcall init_trace_printk_function_export+0x0/0x2d returned 0 after 3 usecs
[ 0.322748] calling init_graph_tracefs+0x0/0x2d @ 1
[ 0.322754] initcall init_graph_tracefs+0x0/0x2d returned 0 after 2 usecs
[ 0.322758] calling init_kprobe_trace+0x0/0x83 @ 1
[ 0.322766] initcall init_kprobe_trace+0x0/0x83 returned 0 after 4 usecs
[ 0.322770] calling init_uprobe_trace+0x0/0x4c @ 1
[ 0.322777] initcall init_uprobe_trace+0x0/0x4c returned 0 after 4 usecs
[ 0.322781] calling bpf_init+0x0/0x42 @ 1
[ 0.322797] initcall bpf_init+0x0/0x42 returned 0 after 13 usecs
[ 0.322802] calling init_pipe_fs+0x0/0x42 @ 1
[ 0.322835] initcall init_pipe_fs+0x0/0x42 returned 0 after 28 usecs
[ 0.322839] calling cgroup_writeback_init+0x0/0x2c @ 1
[ 0.322886] initcall cgroup_writeback_init+0x0/0x2c returned 0 after 41 usecs
[ 0.322890] calling inotify_user_setup+0x0/0x4a @ 1
[ 0.322918] initcall inotify_user_setup+0x0/0x4a returned 0 after 23 usecs
[ 0.322922] calling eventpoll_init+0x0/0xab @ 1
[ 0.322941] initcall eventpoll_init+0x0/0xab returned 0 after 15 usecs
[ 0.322945] calling anon_inode_init+0x0/0x4e @ 1
[ 0.322961] initcall anon_inode_init+0x0/0x4e returned 0 after 12 usecs
[ 0.322966] calling init_dax_wait_table+0x0/0x2f @ 1
[ 0.323003] initcall init_dax_wait_table+0x0/0x2f returned 0 after 33 usecs
[ 0.323007] calling proc_locks_init+0x0/0x23 @ 1
[ 0.323016] initcall proc_locks_init+0x0/0x23 returned 0 after 5 usecs
[ 0.323020] calling dquot_init+0x0/0xfa @ 1
[ 0.323022] VFS: Disk quotas dquot_6.6.0
[ 0.323059] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.323063] initcall dquot_init+0x0/0xfa returned 0 after 38 usecs
[ 0.323067] calling quota_init+0x0/0x25 @ 1
[ 0.323091] initcall quota_init+0x0/0x25 returned 0 after 20 usecs
[ 0.323095] calling proc_cmdline_init+0x0/0x21 @ 1
[ 0.323101] initcall proc_cmdline_init+0x0/0x21 returned 0 after 2 usecs
[ 0.323105] calling proc_consoles_init+0x0/0x23 @ 1
[ 0.323110] initcall proc_consoles_init+0x0/0x23 returned 0 after 2 usecs
[ 0.323114] calling proc_cpuinfo_init+0x0/0x1f @ 1
[ 0.323119] initcall proc_cpuinfo_init+0x0/0x1f returned 0 after 1 usecs
[ 0.323123] calling proc_devices_init+0x0/0x23 @ 1
[ 0.323128] initcall proc_devices_init+0x0/0x23 returned 0 after 2 usecs
[ 0.323132] calling proc_interrupts_init+0x0/0x23 @ 1
[ 0.323137] initcall proc_interrupts_init+0x0/0x23 returned 0 after 1 usecs
[ 0.323141] calling proc_loadavg_init+0x0/0x21 @ 1
[ 0.323149] initcall proc_loadavg_init+0x0/0x21 returned 0 after 5 usecs
[ 0.323153] calling proc_meminfo_init+0x0/0x21 @ 1
[ 0.323158] initcall proc_meminfo_init+0x0/0x21 returned 0 after 2 usecs
[ 0.323162] calling proc_stat_init+0x0/0x1f @ 1
[ 0.323167] initcall proc_stat_init+0x0/0x1f returned 0 after 1 usecs
[ 0.323171] calling proc_uptime_init+0x0/0x21 @ 1
[ 0.323175] initcall proc_uptime_init+0x0/0x21 returned 0 after 1 usecs
[ 0.323179] calling proc_version_init+0x0/0x21 @ 1
[ 0.323184] initcall proc_version_init+0x0/0x21 returned 0 after 1 usecs
[ 0.323188] calling proc_softirqs_init+0x0/0x21 @ 1
[ 0.323192] initcall proc_softirqs_init+0x0/0x21 returned 0 after 1 usecs
[ 0.323196] calling proc_kcore_init+0x0/0x6e @ 1
[ 0.323203] initcall proc_kcore_init+0x0/0x6e returned 0 after 3 usecs
[ 0.323207] calling vmcore_init+0x0/0x679 @ 1
[ 0.323211] initcall vmcore_init+0x0/0x679 returned 0 after 0 usecs
[ 0.323215] calling proc_kmsg_init+0x0/0x22 @ 1
[ 0.323219] initcall proc_kmsg_init+0x0/0x22 returned 0 after 1 usecs
[ 0.323223] calling proc_page_init+0x0/0x4e @ 1
[ 0.323230] initcall proc_page_init+0x0/0x4e returned 0 after 3 usecs
[ 0.323235] calling init_ramfs_fs+0x0/0x23 @ 1
[ 0.323239] initcall init_ramfs_fs+0x0/0x23 returned 0 after 0 usecs
[ 0.323244] calling init_hugetlbfs_fs+0x0/0x142 @ 1
[ 0.323290] initcall init_hugetlbfs_fs+0x0/0x142 returned 0 after 40 usecs
[ 0.323295] calling blk_scsi_ioctl_init+0x0/0x352 @ 1
[ 0.323299] initcall blk_scsi_ioctl_init+0x0/0x352 returned 0 after 1 usecs
[ 0.323304] calling dynamic_debug_init_debugfs+0x0/0x5f @ 1
[ 0.323326] initcall dynamic_debug_init_debugfs+0x0/0x5f returned 0 after 17 usecs
[ 0.323332] calling acpi_event_init+0x0/0x31 @ 1
[ 0.323344] initcall acpi_event_init+0x0/0x31 returned 0 after 8 usecs
[ 0.323347] calling pnp_system_init+0x0/0x14 @ 1
[ 0.323375] initcall pnp_system_init+0x0/0x14 returned 0 after 24 usecs
[ 0.323379] calling pnpacpi_init+0x0/0x67 @ 1
[ 0.323380] pnp: PnP ACPI init
[ 0.324200] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[ 0.324304] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 PNP030b (active)
[ 0.324386] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[ 0.325066] pnp 00:03: Plug and Play ACPI device, IDs PNP0303 PNP030b (active)
[ 0.325144] pnp 00:04: Plug and Play ACPI device, IDs PNP0f13 (active)
[ 0.325175] pnp: PnP ACPI: found 5 devices
[ 0.325180] initcall pnpacpi_init+0x0/0x67 returned 0 after 1755 usecs
[ 0.325185] calling chr_dev_init+0x0/0x9b @ 1
[ 0.330926] initcall chr_dev_init+0x0/0x9b returned 0 after 5594 usecs
[ 0.330936] calling firmware_class_init+0x0/0xe0 @ 1
[ 0.330942] initcall firmware_class_init+0x0/0xe0 returned 0 after 2 usecs
[ 0.330947] calling thermal_init+0x0/0xce @ 1
[ 0.330987] initcall thermal_init+0x0/0xce returned 0 after 34 usecs
[ 0.330992] calling cpufreq_gov_performance_init+0x0/0x14 @ 1
[ 0.330997] initcall cpufreq_gov_performance_init+0x0/0x14 returned 0 after 1 usecs
[ 0.331002] calling cpufreq_gov_dbs_init+0x0/0x14 @ 1
[ 0.331006] initcall cpufreq_gov_dbs_init+0x0/0x14 returned 0 after 0 usecs
[ 0.331010] calling pcibios_assign_resources+0x0/0x96 @ 1
[ 0.331129] pci 0000:00:14.4: PCI bridge to [bus 01]
[ 0.331149] pci 0000:00:15.0: PCI bridge to [bus 02]
[ 0.331164] pci 0000:00:15.1: PCI bridge to [bus 03]
[ 0.331169] pci 0000:00:15.1: bridge window [io 0x1000-0x1fff]
[ 0.331179] pci 0000:00:15.1: bridge window [mem 0xf0000000-0xf00fffff 64bit pref]
[ 0.331193] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
[ 0.331196] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
[ 0.331199] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
[ 0.331202] pci_bus 0000:00: resource 7 [mem 0xe0000000-0xffffffff]
[ 0.331206] pci_bus 0000:01: resource 4 [io 0x0000-0x0cf7 window]
[ 0.331209] pci_bus 0000:01: resource 5 [io 0x0d00-0xffff window]
[ 0.331212] pci_bus 0000:01: resource 6 [mem 0x000a0000-0x000bffff]
[ 0.331215] pci_bus 0000:01: resource 7 [mem 0xe0000000-0xffffffff]
[ 0.331218] pci_bus 0000:03: resource 0 [io 0x1000-0x1fff]
[ 0.331221] pci_bus 0000:03: resource 2 [mem 0xf0000000-0xf00fffff 64bit pref]
[ 0.331311] initcall pcibios_assign_resources+0x0/0x96 returned 0 after 290 usecs
[ 0.331315] calling sysctl_core_init+0x0/0x28 @ 1
[ 0.331345] initcall sysctl_core_init+0x0/0x28 returned 0 after 25 usecs
[ 0.331350] calling eth_offload_init+0x0/0x16 @ 1
[ 0.331354] initcall eth_offload_init+0x0/0x16 returned 0 after 0 usecs
[ 0.331358] calling ipv4_offload_init+0x0/0x6e @ 1
[ 0.331362] initcall ipv4_offload_init+0x0/0x6e returned 0 after 1 usecs
[ 0.331366] calling inet_init+0x0/0x240 @ 1
[ 0.331419] NET: Registered protocol family 2
[ 0.331771] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
[ 0.331780] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.331808] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 0.331844] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.331905] UDP hash table entries: 512 (order: 2, 16384 bytes)
[ 0.331917] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[ 0.332011] initcall inet_init+0x0/0x240 returned 0 after 621 usecs
[ 0.332016] calling af_unix_init+0x0/0x4c @ 1
[ 0.332031] NET: Registered protocol family 1
[ 0.332047] initcall af_unix_init+0x0/0x4c returned 0 after 25 usecs
[ 0.332052] calling ipv6_offload_init+0x0/0x77 @ 1
[ 0.332057] initcall ipv6_offload_init+0x0/0x77 returned 0 after 1 usecs
[ 0.332063] calling pci_apply_final_quirks+0x0/0x118 @ 1
[ 0.332082] pci 0000:00:01.0: calling pci_fixup_video+0x0/0x110 @ 1
[ 0.332091] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[ 0.332096] pci 0000:00:01.0: pci_fixup_video+0x0/0x110 took 8 usecs
[ 0.332105] pci 0000:00:01.1: calling quirk_gpu_hda+0x0/0xb0 @ 1
[ 0.332113] pci 0000:00:01.1: Linked as a consumer to 0000:00:01.0
[ 0.332128] pci 0000:00:01.1: quirk_gpu_hda+0x0/0xb0 took 18 usecs
[ 0.332136] pci 0000:00:11.0: calling quirk_msi_intx_disable_ati_bug+0x0/0x50 @ 1
[ 0.332143] pci 0000:00:11.0: quirk_msi_intx_disable_ati_bug+0x0/0x50 took 2 usecs
[ 0.332223] pci 0000:00:12.0: calling quirk_usb_early_handoff+0x0/0x6d5 @ 1
[ 0.332955] pci 0000:00:12.0: quirk_usb_early_handoff+0x0/0x6d5 took 704 usecs
[ 0.333035] pci 0000:00:12.2: calling quirk_usb_early_handoff+0x0/0x6d5 @ 1
[ 0.333522] pci 0000:00:12.2: quirk_usb_early_handoff+0x0/0x6d5 took 468 usecs
[ 0.333600] pci 0000:00:13.0: calling quirk_usb_early_handoff+0x0/0x6d5 @ 1
[ 0.334092] pci 0000:00:13.0: quirk_usb_early_handoff+0x0/0x6d5 took 473 usecs
[ 0.334170] pci 0000:00:13.2: calling quirk_usb_early_handoff+0x0/0x6d5 @ 1
[ 0.334651] pci 0000:00:13.2: quirk_usb_early_handoff+0x0/0x6d5 took 463 usecs
[ 0.334742] pci 0000:00:14.2: calling quirk_gpu_hda+0x0/0xb0 @ 1
[ 0.334746] pci 0000:00:14.2: quirk_gpu_hda+0x0/0xb0 took 0 usecs
[ 0.334763] pci 0000:00:14.5: calling quirk_usb_early_handoff+0x0/0x6d5 @ 1
[ 0.335243] pci 0000:00:14.5: quirk_usb_early_handoff+0x0/0x6d5 took 462 usecs
[ 0.335360] PCI: CLS 64 bytes, default 64
[ 0.335364] initcall pci_apply_final_quirks+0x0/0x118 returned 0 after 3220 usecs
[ 0.335370] calling acpi_reserve_resources+0x0/0xcd @ 1
[ 0.335379] initcall acpi_reserve_resources+0x0/0xcd returned 0 after 5 usecs
[ 0.335383] calling populate_rootfs+0x0/0xf9 @ 1
[ 0.335494] initcall populate_rootfs+0x0/0xf9 returned 0 after 104 usecs
[ 0.335500] calling pci_iommu_init+0x0/0x3a @ 1
[ 0.335504] initcall pci_iommu_init+0x0/0x3a returned 0 after 1 usecs
[ 0.335708] calling amd_uncore_init+0x0/0x255 @ 1
[ 0.335712] initcall amd_uncore_init+0x0/0x255 returned -19 after 0 usecs
[ 0.335715] calling amd_ibs_init+0x0/0x196 @ 1
[ 0.335730] LVT offset 0 assigned for vector 0x400
[ 0.335791] perf: AMD IBS detected (0x000000ff)
[ 0.335795] initcall amd_ibs_init+0x0/0x196 returned 0 after 74 usecs
[ 0.335798] calling msr_init+0x0/0xb9 @ 1
[ 0.335805] initcall msr_init+0x0/0xb9 returned 0 after 3 usecs
[ 0.335809] calling register_kernel_offset_dumper+0x0/0x1b @ 1
[ 0.335814] initcall register_kernel_offset_dumper+0x0/0x1b returned 0 after 1 usecs
[ 0.335818] calling i8259A_init_ops+0x0/0x25 @ 1
[ 0.335822] initcall i8259A_init_ops+0x0/0x25 returned 0 after 0 usecs
[ 0.335826] calling init_tsc_clocksource+0x0/0xa4 @ 1
[ 0.335834] initcall init_tsc_clocksource+0x0/0xa4 returned 0 after 4 usecs
[ 0.335839] calling add_rtc_cmos+0x0/0xa6 @ 1
[ 0.335844] initcall add_rtc_cmos+0x0/0xa6 returned 0 after 1 usecs
[ 0.335849] calling i8237A_init_ops+0x0/0x3c @ 1
[ 0.335934] initcall i8237A_init_ops+0x0/0x3c returned 0 after 79 usecs
[ 0.335938] calling msr_init+0x0/0xc9 @ 1
[ 0.336251] initcall msr_init+0x0/0xc9 returned 0 after 292 usecs
[ 0.336260] calling cpuid_init+0x0/0xc9 @ 1
[ 0.336506] initcall cpuid_init+0x0/0xc9 returned 0 after 230 usecs
[ 0.336513] calling ioapic_init_ops+0x0/0x16 @ 1
[ 0.336518] initcall ioapic_init_ops+0x0/0x16 returned 0 after 0 usecs
[ 0.336522] calling add_pcspkr+0x0/0x61 @ 1
[ 0.336588] initcall add_pcspkr+0x0/0x61 returned 0 after 59 usecs
[ 0.336594] calling start_periodic_check_for_corruption+0x0/0x40 @ 1
[ 0.336598] initcall start_periodic_check_for_corruption+0x0/0x40 returned 0 after 0 usecs
[ 0.336602] calling sysfb_init+0x0/0x83 @ 1
[ 0.336644] initcall sysfb_init+0x0/0x83 returned 0 after 36 usecs
[ 0.336650] calling pt_dump_init+0x0/0x57 @ 1
[ 0.336654] initcall pt_dump_init+0x0/0x57 returned 0 after 0 usecs
[ 0.336658] calling pt_dump_debug_init+0x0/0x9b @ 1
[ 0.336679] initcall pt_dump_debug_init+0x0/0x9b returned 0 after 15 usecs
[ 0.336683] calling proc_execdomains_init+0x0/0x21 @ 1
[ 0.336694] initcall proc_execdomains_init+0x0/0x21 returned 0 after 7 usecs
[ 0.336699] calling register_warn_debugfs+0x0/0x24 @ 1
[ 0.336706] initcall register_warn_debugfs+0x0/0x24 returned 0 after 2 usecs
[ 0.336711] calling cpuhp_sysfs_init+0x0/0x79 @ 1
[ 0.336734] initcall cpuhp_sysfs_init+0x0/0x79 returned 0 after 18 usecs
[ 0.336737] calling ioresources_init+0x0/0x40 @ 1
[ 0.336744] initcall ioresources_init+0x0/0x40 returned 0 after 4 usecs
[ 0.336749] calling init_sched_debug_procfs+0x0/0x2f @ 1
[ 0.336754] initcall init_sched_debug_procfs+0x0/0x2f returned 0 after 1 usecs
[ 0.336757] calling irq_pm_init_ops+0x0/0x16 @ 1
[ 0.336761] initcall irq_pm_init_ops+0x0/0x16 returned 0 after 0 usecs
[ 0.336765] calling timekeeping_init_ops+0x0/0x16 @ 1
[ 0.336769] initcall timekeeping_init_ops+0x0/0x16 returned 0 after 0 usecs
[ 0.336773] calling init_clocksource_sysfs+0x0/0x24 @ 1
[ 0.336839] initcall init_clocksource_sysfs+0x0/0x24 returned 0 after 59 usecs
[ 0.336843] calling init_timer_list_procfs+0x0/0x2f @ 1
[ 0.336849] initcall init_timer_list_procfs+0x0/0x2f returned 0 after 1 usecs
[ 0.336853] calling alarmtimer_init+0x0/0x114 @ 1
[ 0.336956] probe of alarmtimer returned 1 after 17 usecs
[ 0.336962] initcall alarmtimer_init+0x0/0x114 returned 0 after 102 usecs
[ 0.336966] calling init_posix_timers+0x0/0x29 @ 1
[ 0.337000] initcall init_posix_timers+0x0/0x29 returned 0 after 28 usecs
[ 0.337004] calling clockevents_init_sysfs+0x0/0x9e @ 1
[ 0.337106] initcall clockevents_init_sysfs+0x0/0x9e returned 0 after 94 usecs
[ 0.337110] calling proc_dma_init+0x0/0x21 @ 1
[ 0.337116] initcall proc_dma_init+0x0/0x21 returned 0 after 2 usecs
[ 0.337120] calling proc_modules_init+0x0/0x1f @ 1
[ 0.337126] initcall proc_modules_init+0x0/0x1f returned 0 after 2 usecs
[ 0.337130] calling kallsyms_init+0x0/0x22 @ 1
[ 0.337135] initcall kallsyms_init+0x0/0x22 returned 0 after 1 usecs
[ 0.337140] calling pid_namespaces_init+0x0/0x2c @ 1
[ 0.337147] initcall pid_namespaces_init+0x0/0x2c returned 0 after 3 usecs
[ 0.337152] calling audit_watch_init+0x0/0x38 @ 1
[ 0.337156] initcall audit_watch_init+0x0/0x38 returned 0 after 1 usecs
[ 0.337161] calling audit_fsnotify_init+0x0/0x38 @ 1
[ 0.337165] initcall audit_fsnotify_init+0x0/0x38 returned 0 after 0 usecs
[ 0.337170] calling audit_tree_init+0x0/0x40 @ 1
[ 0.337175] initcall audit_tree_init+0x0/0x40 returned 0 after 1 usecs
[ 0.337179] calling init_kprobes+0x0/0x172 @ 1
[ 0.337324] initcall init_kprobes+0x0/0x172 returned 0 after 137 usecs
[ 0.337328] calling seccomp_sysctl_init+0x0/0x31 @ 1
[ 0.337343] initcall seccomp_sysctl_init+0x0/0x31 returned 0 after 10 usecs
[ 0.337348] calling utsname_sysctl_init+0x0/0x16 @ 1
[ 0.337360] initcall utsname_sysctl_init+0x0/0x16 returned 0 after 8 usecs
[ 0.337365] calling init_tracepoints+0x0/0x2b @ 1
[ 0.337369] initcall init_tracepoints+0x0/0x2b returned 0 after 0 usecs
[ 0.337372] calling stack_trace_init+0x0/0x9e @ 1
[ 0.337387] initcall stack_trace_init+0x0/0x9e returned 0 after 11 usecs
[ 0.337390] calling init_mmio_trace+0x0/0xf @ 1
[ 0.337396] initcall init_mmio_trace+0x0/0xf returned 0 after 3 usecs
[ 0.337399] calling init_blk_tracer+0x0/0x4d @ 1
[ 0.337412] initcall init_blk_tracer+0x0/0x4d returned 0 after 9 usecs
[ 0.337416] calling perf_event_sysfs_init+0x0/0x78 @ 1
[ 0.337680] initcall perf_event_sysfs_init+0x0/0x78 returned 0 after 254 usecs
[ 0.337684] calling init_uprobes+0x0/0x56 @ 1
[ 0.337691] initcall init_uprobes+0x0/0x56 returned 0 after 4 usecs
[ 0.337695] calling padata_driver_init+0x0/0x35 @ 1
[ 0.337699] initcall padata_driver_init+0x0/0x35 returned 0 after 1 usecs
[ 0.337703] calling system_trusted_keyring_init+0x0/0x55 @ 1
[ 0.337705] Initialise system trusted keyrings
[ 0.337718] initcall system_trusted_keyring_init+0x0/0x55 returned 0 after 11 usecs
[ 0.337723] calling kswapd_init+0x0/0x3b @ 1
[ 0.337897] initcall kswapd_init+0x0/0x3b returned 0 after 163 usecs
[ 0.337902] calling extfrag_debug_init+0x0/0x71 @ 1
[ 0.337919] initcall extfrag_debug_init+0x0/0x71 returned 0 after 13 usecs
[ 0.337924] calling mm_compute_batch_init+0x0/0x3e @ 1
[ 0.337928] initcall mm_compute_batch_init+0x0/0x3e returned 0 after 0 usecs
[ 0.337933] calling slab_proc_init+0x0/0x22 @ 1
[ 0.337950] initcall slab_proc_init+0x0/0x22 returned 0 after 13 usecs
[ 0.337955] calling workingset_init+0x0/0x88 @ 1
[ 0.337957] workingset: timestamp_bits=14 max_order=18 bucket_order=4
[ 0.337966] initcall workingset_init+0x0/0x88 returned 0 after 7 usecs
[ 0.337971] calling proc_vmalloc_init+0x0/0x26 @ 1
[ 0.337976] initcall proc_vmalloc_init+0x0/0x26 returned 0 after 2 usecs
[ 0.337981] calling procswaps_init+0x0/0x1f @ 1
[ 0.337987] initcall procswaps_init+0x0/0x1f returned 0 after 2 usecs
[ 0.337992] calling init_frontswap+0x0/0x82 @ 1
[ 0.338008] initcall init_frontswap+0x0/0x82 returned 0 after 12 usecs
[ 0.338011] calling slab_sysfs_init+0x0/0xd0 @ 1
[ 0.341227] initcall slab_sysfs_init+0x0/0xd0 returned 0 after 3133 usecs
[ 0.341233] calling init_cleancache+0x0/0x82 @ 1
[ 0.341257] initcall init_cleancache+0x0/0x82 returned 0 after 20 usecs
[ 0.341261] calling init_zbud+0x0/0x20 @ 1
[ 0.341262] zbud: loaded
[ 0.341265] initcall init_zbud+0x0/0x20 returned 0 after 1 usecs
[ 0.341268] calling zs_init+0x0/0x6d @ 1
[ 0.341298] initcall zs_init+0x0/0x6d returned 0 after 26 usecs
[ 0.341301] calling init_z3fold+0x0/0x16 @ 1
[ 0.341304] initcall init_z3fold+0x0/0x16 returned 0 after 0 usecs
[ 0.341307] calling fcntl_init+0x0/0x29 @ 1
[ 0.341316] initcall fcntl_init+0x0/0x29 returned 0 after 5 usecs
[ 0.341320] calling proc_filesystems_init+0x0/0x21 @ 1
[ 0.341327] initcall proc_filesystems_init+0x0/0x21 returned 0 after 3 usecs
[ 0.341331] calling start_dirtytime_writeback+0x0/0x2c @ 1
[ 0.341337] initcall start_dirtytime_writeback+0x0/0x2c returned 0 after 2 usecs
[ 0.341341] calling blkdev_init+0x0/0x20 @ 1
[ 0.341358] initcall blkdev_init+0x0/0x20 returned 0 after 13 usecs
[ 0.341362] calling dio_init+0x0/0x2c @ 1
[ 0.341421] initcall dio_init+0x0/0x2c returned 0 after 54 usecs
[ 0.341425] calling dnotify_init+0x0/0x6f @ 1
[ 0.341438] initcall dnotify_init+0x0/0x6f returned 0 after 9 usecs
[ 0.341441] calling fanotify_user_setup+0x0/0x6c @ 1
[ 0.341500] initcall fanotify_user_setup+0x0/0x6c returned 0 after 53 usecs
[ 0.341504] calling userfaultfd_init+0x0/0x2c @ 1
[ 0.341551] initcall userfaultfd_init+0x0/0x2c returned 0 after 41 usecs
[ 0.341554] calling aio_setup+0x0/0x6e @ 1
[ 0.341577] initcall aio_setup+0x0/0x6e returned 0 after 18 usecs
[ 0.341581] calling mbcache_init+0x0/0x31 @ 1
[ 0.341637] initcall mbcache_init+0x0/0x31 returned 0 after 51 usecs
[ 0.341641] calling init_v2_quota_format+0x0/0x22 @ 1
[ 0.341645] initcall init_v2_quota_format+0x0/0x22 returned 0 after 0 usecs
[ 0.341650] calling init_devpts_fs+0x0/0x28 @ 1
[ 0.341670] initcall init_devpts_fs+0x0/0x28 returned 0 after 16 usecs
[ 0.341676] calling ext4_init_fs+0x0/0x166 @ 1
[ 0.341903] initcall ext4_init_fs+0x0/0x166 returned 0 after 217 usecs
[ 0.341909] calling journal_init+0x0/0xfc @ 1
[ 0.342033] initcall journal_init+0x0/0xfc returned 0 after 116 usecs
[ 0.342038] calling init_nls_cp437+0x0/0x16 @ 1
[ 0.342042] initcall init_nls_cp437+0x0/0x16 returned 0 after 0 usecs
[ 0.342047] calling init_nls_ascii+0x0/0x16 @ 1
[ 0.342050] initcall init_nls_ascii+0x0/0x16 returned 0 after 0 usecs
[ 0.342055] calling init_autofs_fs+0x0/0x29 @ 1
[ 0.342190] initcall init_autofs_fs+0x0/0x29 returned 0 after 127 usecs
[ 0.342194] calling init_pstore_fs+0x0/0x47 @ 1
[ 0.342197] pstore: using deflate compression
[ 0.342204] initcall init_pstore_fs+0x0/0x47 returned 0 after 6 usecs
[ 0.342206] calling ipc_init+0x0/0x27 @ 1
[ 0.342224] initcall ipc_init+0x0/0x27 returned 0 after 14 usecs
[ 0.342227] calling ipc_sysctl_init+0x0/0x16 @ 1
[ 0.342241] initcall ipc_sysctl_init+0x0/0x16 returned 0 after 10 usecs
[ 0.342244] calling init_mqueue_fs+0x0/0xee @ 1
[ 0.342326] initcall init_mqueue_fs+0x0/0xee returned 0 after 75 usecs
[ 0.342329] calling key_proc_init+0x0/0x5c @ 1
[ 0.342335] initcall key_proc_init+0x0/0x5c returned 0 after 3 usecs
[ 0.342339] calling selinux_nf_ip_init+0x0/0x49 @ 1
[ 0.342342] initcall selinux_nf_ip_init+0x0/0x49 returned 0 after 0 usecs
[ 0.342345] calling init_sel_fs+0x0/0xfa @ 1
[ 0.342348] initcall init_sel_fs+0x0/0xfa returned 0 after 0 usecs
[ 0.342351] calling selnl_init+0x0/0x6e @ 1
[ 0.342367] initcall selnl_init+0x0/0x6e returned 0 after 12 usecs
[ 0.342370] calling sel_netif_init+0x0/0x36 @ 1
[ 0.342373] initcall sel_netif_init+0x0/0x36 returned 0 after 0 usecs
[ 0.342376] calling sel_netnode_init+0x0/0x30 @ 1
[ 0.342379] initcall sel_netnode_init+0x0/0x30 returned 0 after 0 usecs
[ 0.342383] calling sel_netport_init+0x0/0x30 @ 1
[ 0.342386] initcall sel_netport_init+0x0/0x30 returned 0 after 0 usecs
[ 0.342389] calling aurule_init+0x0/0x2a @ 1
[ 0.342392] initcall aurule_init+0x0/0x2a returned 0 after 0 usecs
[ 0.342396] calling crypto_algapi_init+0x0/0x11 @ 1
[ 0.342401] initcall crypto_algapi_init+0x0/0x11 returned 0 after 1 usecs
[ 0.342404] calling seqiv_module_init+0x0/0x14 @ 1
[ 0.342407] initcall seqiv_module_init+0x0/0x14 returned 0 after 0 usecs
[ 0.342413] calling dh_init+0x0/0x20 @ 1
[ 0.342621] alg: self-tests disabled
[ 0.342654] initcall dh_init+0x0/0x20 returned 0 after 217 usecs
[ 0.342665] calling rsa_init+0x0/0x40 @ 1
[ 0.342769] initcall rsa_init+0x0/0x40 returned 0 after 95 usecs
[ 0.342774] calling hmac_module_init+0x0/0x14 @ 1
[ 0.342778] initcall hmac_module_init+0x0/0x14 returned 0 after 0 usecs
[ 0.342781] calling crypto_null_mod_init+0x0/0x46 @ 1
[ 0.343085] initcall crypto_null_mod_init+0x0/0x46 returned 0 after 285 usecs
[ 0.343092] calling md5_mod_init+0x0/0x14 @ 1
[ 0.343161] initcall md5_mod_init+0x0/0x14 returned 0 after 62 usecs
[ 0.343165] calling sha1_generic_mod_init+0x0/0x14 @ 1
[ 0.343235] initcall sha1_generic_mod_init+0x0/0x14 returned 0 after 63 usecs
[ 0.343241] calling sha256_generic_mod_init+0x0/0x19 @ 1
[ 0.343369] initcall sha256_generic_mod_init+0x0/0x19 returned 0 after 120 usecs
[ 0.343373] calling crypto_ecb_module_init+0x0/0x14 @ 1
[ 0.343376] initcall crypto_ecb_module_init+0x0/0x14 returned 0 after 0 usecs
[ 0.343380] calling crypto_cbc_module_init+0x0/0x14 @ 1
[ 0.343383] initcall crypto_cbc_module_init+0x0/0x14 returned 0 after 0 usecs
[ 0.343387] calling crypto_module_init+0x0/0x14 @ 1
[ 0.343390] initcall crypto_module_init+0x0/0x14 returned 0 after 0 usecs
[ 0.343393] calling crypto_module_init+0x0/0x14 @ 1
[ 0.343396] initcall crypto_module_init+0x0/0x14 returned 0 after 0 usecs
[ 0.343399] calling crypto_ctr_module_init+0x0/0x38 @ 1
[ 0.343403] initcall crypto_ctr_module_init+0x0/0x38 returned 0 after 0 usecs
[ 0.343406] calling crypto_gcm_module_init+0x0/0xa7 @ 1
[ 0.343411] initcall crypto_gcm_module_init+0x0/0xa7 returned 0 after 1 usecs
[ 0.343414] calling aes_init+0x0/0x14 @ 1
[ 0.343488] initcall aes_init+0x0/0x14 returned 0 after 67 usecs
[ 0.343492] calling deflate_mod_init+0x0/0x3d @ 1
[ 0.343874] initcall deflate_mod_init+0x0/0x3d returned 0 after 355 usecs
[ 0.343916] calling crc32c_mod_init+0x0/0x14 @ 1
[ 0.344040] initcall crc32c_mod_init+0x0/0x14 returned 0 after 106 usecs
[ 0.344049] calling crct10dif_mod_init+0x0/0x14 @ 1
[ 0.344119] initcall crct10dif_mod_init+0x0/0x14 returned 0 after 63 usecs
[ 0.344123] calling lzo_mod_init+0x0/0x38 @ 1
[ 0.344251] initcall lzo_mod_init+0x0/0x38 returned 0 after 119 usecs
[ 0.344255] calling drbg_init+0x0/0x71 @ 1
[ 0.345964] initcall drbg_init+0x0/0x71 returned 0 after 1648 usecs
[ 0.345973] calling jent_mod_init+0x0/0x31 @ 1
[ 0.347020] initcall jent_mod_init+0x0/0x31 returned 0 after 1005 usecs
[ 0.347030] calling ghash_mod_init+0x0/0x14 @ 1
[ 0.347103] initcall ghash_mod_init+0x0/0x14 returned 0 after 66 usecs
[ 0.347107] calling af_alg_init+0x0/0x3a @ 1
[ 0.347111] NET: Registered protocol family 38
[ 0.347113] initcall af_alg_init+0x0/0x3a returned 0 after 3 usecs
[ 0.347117] calling algif_hash_init+0x0/0x14 @ 1
[ 0.347121] initcall algif_hash_init+0x0/0x14 returned 0 after 1 usecs
[ 0.347125] calling algif_skcipher_init+0x0/0x14 @ 1
[ 0.347129] initcall algif_skcipher_init+0x0/0x14 returned 0 after 0 usecs
[ 0.347132] calling rng_init+0x0/0x14 @ 1
[ 0.347135] initcall rng_init+0x0/0x14 returned 0 after 0 usecs
[ 0.347138] calling algif_aead_init+0x0/0x14 @ 1
[ 0.347141] initcall algif_aead_init+0x0/0x14 returned 0 after 0 usecs
[ 0.347145] calling asymmetric_key_init+0x0/0x14 @ 1
[ 0.347148] Key type asymmetric registered
[ 0.347151] initcall asymmetric_key_init+0x0/0x14 returned 0 after 3 usecs
[ 0.347154] calling x509_key_init+0x0/0x14 @ 1
[ 0.347156] Asymmetric key parser 'x509' registered
[ 0.347159] initcall x509_key_init+0x0/0x14 returned 0 after 2 usecs
[ 0.347163] calling proc_genhd_init+0x0/0x3a @ 1
[ 0.347175] initcall proc_genhd_init+0x0/0x3a returned 0 after 8 usecs
[ 0.347179] calling init_emergency_pool+0x0/0x9a @ 1
[ 0.347201] bounce: pool size: 64 pages
[ 0.347214] initcall init_emergency_pool+0x0/0x9a returned 0 after 31 usecs
[ 0.347218] calling bsg_init+0x0/0x12c @ 1
[ 0.347245] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[ 0.347248] initcall bsg_init+0x0/0x12c returned 0 after 26 usecs
[ 0.347252] calling throtl_init+0x0/0x3c @ 1
[ 0.347453] initcall throtl_init+0x0/0x3c returned 0 after 180 usecs
[ 0.347461] calling noop_init+0x0/0x14 @ 1
[ 0.347464] io scheduler noop registered
[ 0.347468] initcall noop_init+0x0/0x14 returned 0 after 3 usecs
[ 0.347472] calling deadline_init+0x0/0x14 @ 1
[ 0.347473] io scheduler deadline registered
[ 0.347476] initcall deadline_init+0x0/0x14 returned 0 after 1 usecs
[ 0.347480] calling cfq_init+0x0/0x6e @ 1
[ 0.347645] io scheduler cfq registered (default)
[ 0.347649] initcall cfq_init+0x0/0x6e returned 0 after 161 usecs
[ 0.347653] calling deadline_init+0x0/0x14 @ 1
[ 0.347655] io scheduler mq-deadline registered
[ 0.347658] initcall deadline_init+0x0/0x14 returned 0 after 1 usecs
[ 0.347662] calling kyber_init+0x0/0x14 @ 1
[ 0.347664] io scheduler kyber registered
[ 0.347667] initcall kyber_init+0x0/0x14 returned 0 after 2 usecs
[ 0.347671] calling crc_t10dif_mod_init+0x0/0x35 @ 1
[ 0.347682] initcall crc_t10dif_mod_init+0x0/0x35 returned 0 after 8 usecs
[ 0.347686] calling libcrc32c_mod_init+0x0/0x25 @ 1
[ 0.347692] initcall libcrc32c_mod_init+0x0/0x25 returned 0 after 2 usecs
[ 0.347696] calling percpu_counter_startup+0x0/0x50 @ 1
[ 0.347755] initcall percpu_counter_startup+0x0/0x50 returned 0 after 53 usecs
[ 0.347760] calling audit_classes_init+0x0/0x4f @ 1
[ 0.347768] initcall audit_classes_init+0x0/0x4f returned 0 after 5 usecs
[ 0.347772] calling sg_pool_init+0x0/0xab @ 1
[ 0.347811] initcall sg_pool_init+0x0/0xab returned 0 after 33 usecs
[ 0.347814] calling phy_core_init+0x0/0x44 @ 1
[ 0.347828] initcall phy_core_init+0x0/0x44 returned 0 after 9 usecs
[ 0.347832] calling pci_proc_init+0x0/0x63 @ 1
[ 0.347900] initcall pci_proc_init+0x0/0x63 returned 0 after 62 usecs
[ 0.347904] calling pcie_portdrv_init+0x0/0x34 @ 1
[ 0.348671] probe of 0000:00:15.0 returned 1 after 748 usecs
[ 0.349298] probe of 0000:00:15.1 returned 1 after 615 usecs
[ 0.349325] initcall pcie_portdrv_init+0x0/0x34 returned 0 after 1383 usecs
[ 0.349330] calling aer_service_init+0x0/0x33 @ 1
[ 0.349344] initcall aer_service_init+0x0/0x33 returned 0 after 10 usecs
[ 0.349349] calling pcie_pme_service_init+0x0/0x14 @ 1
[ 0.349466] pcieport 0000:00:15.0: Signaling PME with IRQ 24
[ 0.349478] probe of 0000:00:15.0:pcie001 returned 1 after 123 usecs
[ 0.349522] pcieport 0000:00:15.1: Signaling PME with IRQ 25
[ 0.349533] probe of 0000:00:15.1:pcie001 returned 1 after 41 usecs
[ 0.349545] initcall pcie_pme_service_init+0x0/0x14 returned 0 after 187 usecs
[ 0.349549] calling dpc_service_init+0x0/0x14 @ 1
[ 0.349562] initcall dpc_service_init+0x0/0x14 returned 0 after 9 usecs
[ 0.349566] calling pci_stub_init+0x0/0x133 @ 1
[ 0.349588] initcall pci_stub_init+0x0/0x133 returned 0 after 17 usecs
[ 0.349594] calling acpi_button_driver_init+0x0/0x20 @ 1
[ 0.349733] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
[ 0.349763] ACPI: Power Button [PWRB]
[ 0.349779] probe of PNP0C0C:00 returned 1 after 144 usecs
[ 0.349855] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1
[ 0.349871] ACPI: Power Button [PWRF]
[ 0.349963] probe of LNXPWRBN:00 returned 1 after 176 usecs
[ 0.349976] initcall acpi_button_driver_init+0x0/0x20 returned 0 after 368 usecs
[ 0.349981] calling acpi_fan_driver_init+0x0/0x16 @ 1
[ 0.350003] initcall acpi_fan_driver_init+0x0/0x16 returned 0 after 17 usecs
[ 0.350007] calling acpi_processor_driver_init+0x0/0x8d @ 1
[ 0.350289] probe of cpu0 returned 1 after 275 usecs
[ 0.350509] probe of cpu1 returned 1 after 216 usecs
[ 0.350525] initcall acpi_processor_driver_init+0x0/0x8d returned 0 after 502 usecs
[ 0.350529] calling acpi_thermal_init+0x0/0x78 @ 1
[ 0.351578] thermal LNXTHERM:00: registered as thermal_zone0
[ 0.351583] ACPI: Thermal Zone [TZ00] (52 C)
[ 0.351601] probe of LNXTHERM:00 returned 1 after 913 usecs
[ 0.351645] initcall acpi_thermal_init+0x0/0x78 returned 0 after 1081 usecs
[ 0.351651] calling acpi_hed_driver_init+0x0/0x14 @ 1
[ 0.351677] initcall acpi_hed_driver_init+0x0/0x14 returned 0 after 21 usecs
[ 0.351681] calling gpio_clk_driver_init+0x0/0x16 @ 1
[ 0.351703] initcall gpio_clk_driver_init+0x0/0x16 returned 0 after 18 usecs
[ 0.351706] calling plt_clk_driver_init+0x0/0x16 @ 1
[ 0.351719] initcall plt_clk_driver_init+0x0/0x16 returned 0 after 9 usecs
[ 0.351722] calling dw_pci_driver_init+0x0/0x1b @ 1
[ 0.351760] initcall dw_pci_driver_init+0x0/0x1b returned 0 after 33 usecs
[ 0.351763] calling n_null_init+0x0/0x21 @ 1
[ 0.351766] initcall n_null_init+0x0/0x21 returned 0 after 0 usecs
[ 0.351769] calling pty_init+0x0/0x1d6 @ 1
[ 0.351877] initcall pty_init+0x0/0x1d6 returned 0 after 101 usecs
[ 0.351899] calling sysrq_init+0x0/0x68 @ 1
[ 0.351909] initcall sysrq_init+0x0/0x68 returned 0 after 6 usecs
[ 0.351913] initcall serial8250_init blacklisted
[ 0.351917] calling serial_pci_driver_init+0x0/0x1b @ 1
[ 0.351983] initcall serial_pci_driver_init+0x0/0x1b returned 0 after 61 usecs
[ 0.351987] calling dw8250_platform_driver_init+0x0/0x16 @ 1
[ 0.352005] initcall dw8250_platform_driver_init+0x0/0x16 returned 0 after 13 usecs
[ 0.352009] calling lpss8250_pci_driver_init+0x0/0x1b @ 1
[ 0.352029] initcall lpss8250_pci_driver_init+0x0/0x1b returned 0 after 16 usecs
[ 0.352033] calling mid8250_pci_driver_init+0x0/0x1b @ 1
[ 0.352052] initcall mid8250_pci_driver_init+0x0/0x1b returned 0 after 15 usecs
[ 0.352056] calling raw_init+0x0/0x12d @ 1
[ 0.352323] initcall raw_init+0x0/0x12d returned 0 after 248 usecs
[ 0.352333] calling hpet_init+0x0/0x5c @ 1
[ 0.352560] initcall hpet_init+0x0/0x5c returned 0 after 217 usecs
[ 0.352564] calling nvram_init+0x0/0x75 @ 1
[ 0.352698] Non-volatile memory driver v1.3
[ 0.352702] initcall nvram_init+0x0/0x75 returned 0 after 131 usecs
[ 0.352706] calling hwrng_modinit+0x0/0x71 @ 1
[ 0.352786] initcall hwrng_modinit+0x0/0x71 returned 0 after 73 usecs
[ 0.352789] calling mod_init+0x0/0x94 @ 1
[ 0.352808] initcall mod_init+0x0/0x94 returned -19 after 15 usecs
[ 0.352812] calling agp_init+0x0/0x29 @ 1
[ 0.352814] Linux agpgart interface v0.103
[ 0.352817] initcall agp_init+0x0/0x29 returned 0 after 2 usecs
[ 0.352820] calling agp_amd64_mod_init+0x0/0xf @ 1
[ 0.352996] probe of 0000:00:00.0 returned 0 after 69 usecs
[ 0.353015] probe of 0000:00:01.0 returned 0 after 14 usecs
[ 0.353099] probe of 0000:00:01.1 returned 0 after 80 usecs
[ 0.353186] probe of 0000:00:11.0 returned 0 after 83 usecs
[ 0.353199] probe of 0000:00:12.0 returned 0 after 9 usecs
[ 0.353216] probe of 0000:00:12.2 returned 0 after 13 usecs
[ 0.353228] probe of 0000:00:13.0 returned 0 after 9 usecs
[ 0.353245] probe of 0000:00:13.2 returned 0 after 13 usecs
[ 0.353257] probe of 0000:00:14.0 returned 0 after 9 usecs
[ 0.353273] probe of 0000:00:14.2 returned 0 after 12 usecs
[ 0.353286] probe of 0000:00:14.3 returned 0 after 9 usecs
[ 0.353299] probe of 0000:00:14.4 returned 0 after 9 usecs
[ 0.353311] probe of 0000:00:14.5 returned 0 after 9 usecs
[ 0.353324] probe of 0000:00:18.0 returned 0 after 9 usecs
[ 0.353335] probe of 0000:00:18.1 returned 0 after 8 usecs
[ 0.353347] probe of 0000:00:18.2 returned 0 after 8 usecs
[ 0.353359] probe of 0000:00:18.3 returned 0 after 9 usecs
[ 0.353371] probe of 0000:00:18.4 returned 0 after 8 usecs
[ 0.353382] probe of 0000:00:18.5 returned 0 after 8 usecs
[ 0.353394] probe of 0000:00:18.6 returned 0 after 8 usecs
[ 0.353405] probe of 0000:00:18.7 returned 0 after 8 usecs
[ 0.353499] probe of 0000:03:00.0 returned 0 after 90 usecs
[ 0.353517] initcall agp_amd64_mod_init+0x0/0xf returned -19 after 676 usecs
[ 0.353521] calling agp_intel_init+0x0/0x2a @ 1
[ 0.353548] initcall agp_intel_init+0x0/0x2a returned 0 after 23 usecs
[ 0.353552] calling agp_sis_init+0x0/0x2a @ 1
[ 0.353576] initcall agp_sis_init+0x0/0x2a returned 0 after 20 usecs
[ 0.353579] calling agp_via_init+0x0/0x2a @ 1
[ 0.353604] initcall agp_via_init+0x0/0x2a returned 0 after 20 usecs
[ 0.353607] calling drm_kms_helper_init+0x0/0x18 @ 1
[ 0.353623] initcall drm_kms_helper_init+0x0/0x18 returned 0 after 12 usecs
[ 0.353627] calling drm_core_init+0x0/0xd1 @ 1
[ 0.353657] initcall drm_core_init+0x0/0xd1 returned 0 after 26 usecs
[ 0.353661] calling ttm_init+0x0/0x5f @ 1
[ 0.353688] initcall ttm_init+0x0/0x5f returned 0 after 23 usecs
[ 0.353692] calling radeon_init+0x0/0x9b @ 1
[ 0.353694] [drm] radeon kernel modesetting enabled.
[ 0.353730] initcall radeon_init+0x0/0x9b returned 0 after 33 usecs
[ 0.353734] calling cn_proc_init+0x0/0x35 @ 1
[ 0.353740] initcall cn_proc_init+0x0/0x35 returned 0 after 2 usecs
[ 0.353745] calling topology_sysfs_init+0x0/0x40 @ 1
[ 0.353768] initcall topology_sysfs_init+0x0/0x40 returned 0 after 19 usecs
[ 0.353772] calling cacheinfo_sysfs_init+0x0/0x2a @ 1
[ 0.354641] initcall cacheinfo_sysfs_init+0x0/0x2a returned 173 after 843 usecs
[ 0.354646] calling init_sd+0x0/0x136 @ 1
[ 0.354694] initcall init_sd+0x0/0x136 returned 0 after 43 usecs
[ 0.354698] calling init_sr+0x0/0x42 @ 1
[ 0.354710] initcall init_sr+0x0/0x42 returned 0 after 8 usecs
[ 0.354714] calling init_sg+0x0/0x18d @ 1
[ 0.354741] initcall init_sg+0x0/0x18d returned 0 after 22 usecs
[ 0.354746] calling ahci_pci_driver_init+0x0/0x1b @ 1
[ 0.354774] ahci 0000:00:11.0: version 3.0
[ 0.354921] [drm] initializing kernel modesetting (PALM 0x1002:0x9802 0x1002:0x9802 0x00).
[ 0.355009] ATOM BIOS: AMD
[ 0.355088] radeon 0000:00:01.0: VRAM: 384M 0x0000000000000000 - 0x0000000017FFFFFF (384M used)
[ 0.355092] radeon 0000:00:01.0: GTT: 1024M 0x0000000018000000 - 0x0000000057FFFFFF
[ 0.355099] [drm] Detected VRAM RAM=384M, BAR=256M
[ 0.355100] [drm] RAM width 32bits DDR
[ 0.355231] [TTM] Zone kernel: Available graphics memory: 418984 kiB
[ 0.355232] [TTM] Initializing pool allocator
[ 0.355248] [TTM] Initializing DMA pool allocator
[ 0.355287] [drm] radeon: 384M of VRAM memory ready
[ 0.355290] [drm] radeon: 1024M of GTT memory ready.
[ 0.355306] [drm] Loading PALM Microcode
[ 0.355314] [drm] Internal thermal controller without fan control
[ 0.355455] [drm] Found smc ucode version: 0x00010601
[ 0.355539] ahci 0000:00:11.0: AHCI 0001.0200 32 slots 6 ports 6 Gbps 0x3f impl SATA mode
[ 0.355546] ahci 0000:00:11.0: flags: 64bit ncq sntf ilck led clo pmp pio slum part
[ 0.355557] [drm] radeon: dpm initialized
[ 0.355593] [drm] GART: num cpu pages 262144, num gpu pages 262144
[ 0.358748] scsi host0: ahci
[ 0.362128] scsi host1: ahci
[ 0.362318] scsi host2: ahci
[ 0.362507] scsi host3: ahci
[ 0.362681] scsi host4: ahci
[ 0.362859] scsi host5: ahci
[ 0.363024] ata1: SATA max UDMA/133 abar m1024@0xf014b000 port 0xf014b100 irq 19
[ 0.363028] ata2: SATA max UDMA/133 abar m1024@0xf014b000 port 0xf014b180 irq 19
[ 0.363032] ata3: SATA max UDMA/133 abar m1024@0xf014b000 port 0xf014b200 irq 19
[ 0.363035] ata4: SATA max UDMA/133 abar m1024@0xf014b000 port 0xf014b280 irq 19
[ 0.363038] ata5: SATA max UDMA/133 abar m1024@0xf014b000 port 0xf014b300 irq 19
[ 0.363042] ata6: SATA max UDMA/133 abar m1024@0xf014b000 port 0xf014b380 irq 19
[ 0.363069] probe of 0000:00:11.0 returned 1 after 8306 usecs
[ 0.363144] initcall ahci_pci_driver_init+0x0/0x1b returned 0 after 8192 usecs
[ 0.363151] calling net_olddevs_init+0x0/0x53 @ 1
[ 0.363162] initcall net_olddevs_init+0x0/0x53 returned 0 after 6 usecs
[ 0.363166] calling fixed_mdio_bus_init+0x0/0xd8 @ 1
[ 0.363245] libphy: Fixed MDIO Bus: probed
[ 0.363250] initcall fixed_mdio_bus_init+0x0/0xd8 returned 0 after 77 usecs
[ 0.363255] calling cdrom_init+0x0/0x1d @ 1
[ 0.363269] initcall cdrom_init+0x0/0x1d returned 0 after 11 usecs
[ 0.363274] calling usb_serial_init+0x0/0x143 @ 1
[ 0.363323] usbcore: registered new interface driver usbserial_generic
[ 0.363336] usbserial: USB Serial support registered for generic
[ 0.363341] initcall usb_serial_init+0x0/0x143 returned 0 after 61 usecs
[ 0.363345] calling i8042_init+0x0/0x41a @ 1
[ 0.363379] probe of 00:01 returned 1 after 20 usecs
[ 0.363395] probe of 00:03 returned 1 after 10 usecs
[ 0.363420] probe of 00:02 returned 1 after 10 usecs
[ 0.363433] probe of 00:04 returned 1 after 9 usecs
[ 0.363442] i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
[ 0.367361] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 0.367372] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 0.367383] probe of i8042 returned 1 after 3663 usecs
[ 0.367397] initcall i8042_init+0x0/0x41a returned 0 after 3952 usecs
[ 0.367402] calling serport_init+0x0/0x30 @ 1
[ 0.367406] initcall serport_init+0x0/0x30 returned 0 after 0 usecs
[ 0.367410] calling input_leds_init+0x0/0x14 @ 1
[ 0.367416] initcall input_leds_init+0x0/0x14 returned 0 after 2 usecs
[ 0.367420] calling mousedev_init+0x0/0x56 @ 1
[ 0.367745] mousedev: PS/2 mouse device common for all mice
[ 0.367751] initcall mousedev_init+0x0/0x56 returned 0 after 318 usecs
[ 0.367755] calling evdev_init+0x0/0x14 @ 1
[ 0.367872] initcall evdev_init+0x0/0x14 returned 0 after 109 usecs
[ 0.367889] calling atkbd_init+0x0/0x25 @ 1
[ 0.367922] initcall atkbd_init+0x0/0x25 returned 0 after 28 usecs
[ 0.367926] calling psmouse_init+0x0/0x7e @ 1
[ 0.367972] initcall psmouse_init+0x0/0x7e returned 0 after 40 usecs
[ 0.367976] calling cmos_init+0x0/0x65 @ 1
[ 0.368088] rtc_cmos 00:00: RTC can wake from S4
[ 0.368396] rtc_cmos 00:00: registered as rtc0
[ 0.368434] rtc_cmos 00:00: alarms up to one day, 114 bytes nvram, hpet irqs
[ 0.368440] probe of 00:00 returned 1 after 456 usecs
[ 0.368455] initcall cmos_init+0x0/0x65 returned 0 after 463 usecs
[ 0.368461] calling sensors_w83627ehf_init+0x0/0x16f @ 1
[ 0.368567] w83627ehf: Found NCT6775F chip at 0x290
[ 0.369187] w83627ehf w83627ehf.656: hwmon_device_register() is deprecated. Please convert the driver to use hwmon_device_register_with_info().
[ 0.369222] probe of w83627ehf.656 returned 1 after 600 usecs
[ 0.369228] initcall sensors_w83627ehf_init+0x0/0x16f returned 0 after 744 usecs
[ 0.369232] calling dm_init+0x0/0x3c @ 1
[ 0.369312] device-mapper: uevent: version 1.0.3
[ 0.369445] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: dm-devel@xxxxxxxxxx
[ 0.369450] initcall dm_init+0x0/0x3c returned 0 after 208 usecs
[ 0.369455] calling dm_crypt_init+0x0/0x2d @ 1
[ 0.369459] initcall dm_crypt_init+0x0/0x2d returned 0 after 0 usecs
[ 0.369464] calling cpufreq_gov_powersave_init+0x0/0x14 @ 1
[ 0.369470] initcall cpufreq_gov_powersave_init+0x0/0x14 returned 0 after 1 usecs
[ 0.369475] calling cpufreq_gov_userspace_init+0x0/0x14 @ 1
[ 0.369479] initcall cpufreq_gov_userspace_init+0x0/0x14 returned 0 after 0 usecs
[ 0.369484] calling cpufreq_gov_dbs_init+0x0/0x14 @ 1
[ 0.369488] initcall cpufreq_gov_dbs_init+0x0/0x14 returned 0 after 0 usecs
[ 0.369493] calling intel_pstate_init+0x0/0x340 @ 1
[ 0.369498] initcall intel_pstate_init+0x0/0x340 returned -19 after 1 usecs
[ 0.369503] calling ledtrig_disk_init+0x0/0x48 @ 1
[ 0.369515] initcall ledtrig_disk_init+0x0/0x48 returned 0 after 7 usecs
[ 0.369519] calling ledtrig_panic_init+0x0/0x34 @ 1
[ 0.369525] initcall ledtrig_panic_init+0x0/0x34 returned 0 after 1 usecs
[ 0.369527] calling dmi_sysfs_init+0x0/0xc1 @ 1
[ 0.369631] initcall dmi_sysfs_init+0x0/0xc1 returned 0 after 97 usecs
[ 0.369634] calling hid_init+0x0/0x5d @ 1
[ 0.369659] hidraw: raw HID events driver (C) Jiri Kosina
[ 0.369670] initcall hid_init+0x0/0x5d returned 0 after 31 usecs
[ 0.369673] calling hid_generic_init+0x0/0x1b @ 1
[ 0.369694] initcall hid_generic_init+0x0/0x1b returned 0 after 16 usecs
[ 0.369697] calling ite_driver_init+0x0/0x1b @ 1
[ 0.369711] initcall ite_driver_init+0x0/0x1b returned 0 after 11 usecs
[ 0.369714] calling magicmouse_driver_init+0x0/0x1b @ 1
[ 0.369735] initcall magicmouse_driver_init+0x0/0x1b returned 0 after 17 usecs
[ 0.369739] calling ntrig_driver_init+0x0/0x1b @ 1
[ 0.369759] initcall ntrig_driver_init+0x0/0x1b returned 0 after 16 usecs
[ 0.369762] calling hid_init+0x0/0x58 @ 1
[ 0.369786] usbcore: registered new interface driver usbhid
[ 0.369787] usbhid: USB HID core driver
[ 0.369791] initcall hid_init+0x0/0x58 returned 0 after 25 usecs
[ 0.369794] calling pmc_atom_init+0x0/0x226 @ 1
[ 0.369813] initcall pmc_atom_init+0x0/0x226 returned -19 after 15 usecs
[ 0.369816] calling extcon_class_init+0x0/0x1b @ 1
[ 0.369826] initcall extcon_class_init+0x0/0x1b returned 0 after 6 usecs
[ 0.369829] calling powercap_init+0x0/0x1fa @ 1
[ 0.369940] initcall powercap_init+0x0/0x1fa returned 0 after 104 usecs
[ 0.369947] calling pm_check_save_msr+0x0/0x20 @ 1
[ 0.369951] initcall pm_check_save_msr+0x0/0x20 returned 0 after 1 usecs
[ 0.369956] calling sock_diag_init+0x0/0x34 @ 1
[ 0.370003] initcall sock_diag_init+0x0/0x34 returned 0 after 41 usecs
[ 0.370007] calling blackhole_init+0x0/0x14 @ 1
[ 0.370012] initcall blackhole_init+0x0/0x14 returned 0 after 1 usecs
[ 0.370016] calling fq_codel_module_init+0x0/0x14 @ 1
[ 0.370020] initcall fq_codel_module_init+0x0/0x14 returned 0 after 0 usecs
[ 0.370024] calling init_cgroup_cls+0x0/0x14 @ 1
[ 0.370028] initcall init_cgroup_cls+0x0/0x14 returned 0 after 0 usecs
[ 0.370031] calling xt_init+0x0/0xb2 @ 1
[ 0.370036] initcall xt_init+0x0/0xb2 returned 0 after 1 usecs
[ 0.370040] calling tcpudp_mt_init+0x0/0x19 @ 1
[ 0.370044] initcall tcpudp_mt_init+0x0/0x19 returned 0 after 1 usecs
[ 0.370049] calling gre_offload_init+0x0/0x47 @ 1
[ 0.370054] initcall gre_offload_init+0x0/0x47 returned 0 after 1 usecs
[ 0.370058] calling sysctl_ipv4_init+0x0/0x45 @ 1
[ 0.370152] initcall sysctl_ipv4_init+0x0/0x45 returned 0 after 88 usecs
[ 0.370157] calling ip_tables_init+0x0/0x84 @ 1
[ 0.370171] initcall ip_tables_init+0x0/0x84 returned 0 after 10 usecs
[ 0.370175] calling iptable_filter_init+0x0/0x45 @ 1
[ 0.370412] initcall iptable_filter_init+0x0/0x45 returned 0 after 225 usecs
[ 0.370417] calling reject_tg_init+0x0/0x14 @ 1
[ 0.370420] initcall reject_tg_init+0x0/0x14 returned 0 after 0 usecs
[ 0.370425] calling cubictcp_register+0x0/0x71 @ 1
[ 0.370429] initcall cubictcp_register+0x0/0x71 returned 0 after 1 usecs
[ 0.370433] calling xfrm_user_init+0x0/0x45 @ 1
[ 0.370435] Initializing XFRM netlink socket
[ 0.370443] initcall xfrm_user_init+0x0/0x45 returned 0 after 6 usecs
[ 0.370448] calling inet6_init+0x0/0x32d @ 1
[ 0.370723] NET: Registered protocol family 10
[ 0.371183] Segment Routing with IPv6
[ 0.371221] initcall inet6_init+0x0/0x32d returned 0 after 749 usecs
[ 0.371226] calling mip6_init+0x0/0xac @ 1
[ 0.371227] mip6: Mobile IPv6
[ 0.371232] initcall mip6_init+0x0/0xac returned 0 after 2 usecs
[ 0.371236] calling packet_init+0x0/0x3e @ 1
[ 0.371238] NET: Registered protocol family 17
[ 0.371245] initcall packet_init+0x0/0x3e returned 0 after 4 usecs
[ 0.371251] calling mcheck_init_device+0x0/0x105 @ 1
[ 0.371536] ata2: SATA link down (SStatus 0 SControl 0)
[ 0.371546] [drm] GART: Restore entries: num cpu pages 262144, num gpu pages 262144
[ 0.371564] initcall mcheck_init_device+0x0/0x105 returned 0 after 300 usecs
[ 0.371770] calling mcheck_late_init+0x0/0x69 @ 1
[ 0.371792] initcall mcheck_late_init+0x0/0x69 returned 0 after 17 usecs
[ 0.371797] calling severities_debugfs_init+0x0/0x3a @ 1
[ 0.371805] initcall severities_debugfs_init+0x0/0x3a returned 0 after 3 usecs
[ 0.371810] calling threshold_init_device+0x0/0x47 @ 1
[ 0.371814] initcall threshold_init_device+0x0/0x47 returned 0 after 0 usecs
[ 0.371817] calling hpet_insert_resource+0x0/0x24 @ 1
[ 0.371824] initcall hpet_insert_resource+0x0/0x24 returned 0 after 3 usecs
[ 0.371829] calling lapic_insert_resource+0x0/0x4b @ 1
[ 0.371833] initcall lapic_insert_resource+0x0/0x4b returned 0 after 0 usecs
[ 0.371836] calling print_ICs+0x0/0x17b @ 1
[ 0.371840] initcall print_ICs+0x0/0x17b returned 0 after 0 usecs
[ 0.371844] calling print_ipi_mode+0x0/0x2b @ 1
[ 0.371846] Using IPI No-Shortcut mode
[ 0.371849] initcall print_ipi_mode+0x0/0x2b returned 0 after 1 usecs
[ 0.371854] calling pat_memtype_list_init+0x0/0x36 @ 1
[ 0.371862] initcall pat_memtype_list_init+0x0/0x36 returned 0 after 3 usecs
[ 0.371867] calling create_tlb_single_page_flush_ceiling+0x0/0x28 @ 1
[ 0.371902] initcall create_tlb_single_page_flush_ceiling+0x0/0x28 returned 0 after 28 usecs
[ 0.371910] calling init_oops_id+0x0/0x50 @ 1
[ 0.371917] initcall init_oops_id+0x0/0x50 returned 0 after 2 usecs
[ 0.371921] calling sched_clock_init_late+0x0/0x89 @ 1
[ 0.371925] sched_clock: Marking stable (368562160, 3323605)->(476327428, -104441663)
[ 0.371997] initcall sched_clock_init_late+0x0/0x89 returned 0 after 69 usecs
[ 0.372000] calling sched_init_debug+0x0/0x3a @ 1
[ 0.372009] initcall sched_init_debug+0x0/0x3a returned 0 after 6 usecs
[ 0.372013] calling pm_qos_power_init+0x0/0x9a @ 1
[ 0.372167] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 0)
[ 0.372422] initcall pm_qos_power_init+0x0/0x9a returned 0 after 395 usecs
[ 0.372426] calling pm_debugfs_init+0x0/0x24 @ 1
[ 0.372433] initcall pm_debugfs_init+0x0/0x24 returned 0 after 3 usecs
[ 0.372437] calling printk_late_init+0x0/0x106 @ 1
[ 0.372442] initcall printk_late_init+0x0/0x106 returned 0 after 1 usecs
[ 0.372447] calling tk_debug_sleep_time_init+0x0/0x3c @ 1
[ 0.372454] initcall tk_debug_sleep_time_init+0x0/0x3c returned 0 after 2 usecs
[ 0.372458] calling debugfs_kprobe_init+0x0/0xb7 @ 1
[ 0.372482] initcall debugfs_kprobe_init+0x0/0xb7 returned 0 after 19 usecs
[ 0.372487] calling taskstats_init+0x0/0x38 @ 1
[ 0.372499] registered taskstats version 1
[ 0.372503] initcall taskstats_init+0x0/0x38 returned 0 after 12 usecs
[ 0.372508] calling load_system_certificate_list+0x0/0xc4 @ 1
[ 0.372509] Loading compiled-in X.509 certificates
[ 0.372513] initcall load_system_certificate_list+0x0/0xc4 returned 0 after 1 usecs
[ 0.372518] calling fault_around_debugfs+0x0/0x35 @ 1
[ 0.372525] initcall fault_around_debugfs+0x0/0x35 returned 0 after 2 usecs
[ 0.372530] calling max_swapfiles_check+0x0/0xc @ 1
[ 0.372533] initcall max_swapfiles_check+0x0/0xc returned 0 after 0 usecs
[ 0.372538] calling init_zswap+0x0/0x3a7 @ 1
[ 0.372578] zswap: loaded using pool lzo/zbud
[ 0.372663] initcall init_zswap+0x0/0x3a7 returned 0 after 116 usecs
[ 0.372667] calling split_huge_pages_debugfs+0x0/0x35 @ 1
[ 0.372673] initcall split_huge_pages_debugfs+0x0/0x35 returned 0 after 2 usecs
[ 0.372676] calling kmemleak_late_init+0x0/0x8d @ 1
[ 0.372683] initcall kmemleak_late_init+0x0/0x8d returned -12 after 3 usecs
[ 0.372686] calling check_early_ioremap_leak+0x0/0x38 @ 1
[ 0.372690] initcall check_early_ioremap_leak+0x0/0x38 returned 0 after 0 usecs
[ 0.372693] calling set_hardened_usercopy+0x0/0x28 @ 1
[ 0.372697] initcall set_hardened_usercopy+0x0/0x28 returned 1 after 0 usecs
[ 0.372700] calling init_root_keyring+0x0/0xf @ 1
[ 0.372724] initcall init_root_keyring+0x0/0xf returned 0 after 20 usecs
[ 0.372727] calling big_key_init+0x0/0xa8 @ 1
[ 0.372745] ata1.00: ATA-9: SanDisk SDSSDP064G, 2.0.0, max UDMA/133
[ 0.372749] ata1.00: 125045424 sectors, multi 1: LBA48 NCQ (depth 32)
[ 0.373052] ata3: SATA link down (SStatus 0 SControl 0)
[ 0.373203] ata4: SATA link down (SStatus 0 SControl 0)
[ 0.373287] ata1.00: configured for UDMA/133
[ 0.373405] ata5: SATA link down (SStatus 0 SControl 0)
[ 0.373579] ata6: SATA link down (SStatus 0 SControl 0)
[ 0.374257] Key type big_key registered
[ 0.374266] initcall big_key_init+0x0/0xa8 returned 0 after 1495 usecs
[ 0.374272] calling prandom_reseed+0x0/0x27 @ 1
[ 0.374281] initcall prandom_reseed+0x0/0x27 returned 0 after 6 usecs
[ 0.374285] calling init_error_injection+0x0/0x61 @ 1
[ 0.374428] initcall init_error_injection+0x0/0x61 returned 0 after 135 usecs
[ 0.374433] calling pci_resource_alignment_sysfs_init+0x0/0x23 @ 1
[ 0.374444] initcall pci_resource_alignment_sysfs_init+0x0/0x23 returned 0 after 7 usecs
[ 0.374448] calling pci_sysfs_init+0x0/0x47 @ 1
[ 0.374732] initcall pci_sysfs_init+0x0/0x47 returned 0 after 272 usecs
[ 0.374737] calling clk_debug_init+0x0/0xe7 @ 1
[ 0.374764] initcall clk_debug_init+0x0/0xe7 returned 0 after 23 usecs
[ 0.374769] calling deferred_probe_initcall+0x0/0x90 @ 1
[ 0.374804] initcall deferred_probe_initcall+0x0/0x90 returned 0 after 29 usecs
[ 0.374810] calling late_resume_init+0x0/0xf9 @ 1
[ 0.374812] Magic number: 6:832:350
[ 0.374973] initcall late_resume_init+0x0/0xf9 returned 0 after 153 usecs
[ 0.374978] calling sync_debugfs_init+0x0/0x51 @ 1
[ 0.374990] initcall sync_debugfs_init+0x0/0x51 returned 0 after 7 usecs
[ 0.374994] calling rtc_hctosys+0x0/0xee @ 1
[ 0.375104] rtc_cmos 00:00: setting system clock to 2018-10-16 22:20:28 UTC (1539728428)
[ 0.375108] initcall rtc_hctosys+0x0/0xee returned 0 after 107 usecs
[ 0.375111] calling firmware_memmap_init+0x0/0x2d @ 1
[ 0.375170] initcall firmware_memmap_init+0x0/0x2d returned 0 after 54 usecs
[ 0.375174] calling pci_mmcfg_late_insert_resources+0x0/0x49 @ 1
[ 0.375178] initcall pci_mmcfg_late_insert_resources+0x0/0x49 returned 0 after 0 usecs
[ 0.375183] calling tcp_congestion_default+0x0/0x19 @ 1
[ 0.375188] initcall tcp_congestion_default+0x0/0x19 returned 0 after 1 usecs
[ 0.375194] calling clear_boot_tracer+0x0/0x2a @ 1
[ 0.375199] initcall clear_boot_tracer+0x0/0x2a returned 0 after 0 usecs
[ 0.375204] calling tracing_set_default_clock+0x0/0x36 @ 1
[ 0.375208] initcall tracing_set_default_clock+0x0/0x36 returned 0 after 0 usecs
[ 0.375214] calling acpi_gpio_handle_deferred_request_interrupts+0x0/0xb0 @ 1
[ 0.375218] initcall acpi_gpio_handle_deferred_request_interrupts+0x0/0xb0 returned 0 after 0 usecs
[ 0.375223] calling clk_disable_unused+0x0/0x100 @ 1
[ 0.375228] initcall clk_disable_unused+0x0/0x100 returned 0 after 1 usecs
[ 0.376811] [drm] GART: Done restoring entries
[ 0.376820] [drm] PCIE GART of 1024M enabled (table at 0x0000000000162000).
[ 0.377012] radeon 0000:00:01.0: WB enabled
[ 0.377020] radeon 0000:00:01.0: fence driver on ring 0 use gpu addr 0x0000000018000c00 and cpu addr 0x(ptrval)
[ 0.377024] radeon 0000:00:01.0: fence driver on ring 3 use gpu addr 0x0000000018000c0c and cpu addr 0x(ptrval)
[ 0.377919] radeon 0000:00:01.0: fence driver on ring 5 use gpu addr 0x0000000000072118 and cpu addr 0x(ptrval)
[ 0.377923] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 0.377924] [drm] Driver supports precise vblank timestamp query.
[ 0.377927] radeon 0000:00:01.0: radeon: MSI limited to 32-bit
[ 0.378020] radeon 0000:00:01.0: radeon: using MSI.
[ 0.378064] [drm] radeon: irq initialized.
[ 0.394721] [drm] ring test on 0 succeeded in 1 usecs
[ 0.394729] [drm] ring test on 3 succeeded in 3 usecs
[ 0.396650] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input2
[ 0.396905] probe of serio0 returned 1 after 28613 usecs
[ 0.408793] [drm] ring test on 5 succeeded in 1 usecs
[ 0.410815] [drm] UVD initialized successfully.
[ 0.411106] [drm] ib test on ring 0 succeeded in 0 usecs
[ 0.411218] [drm] ib test on ring 3 succeeded in 0 usecs
[ 0.440372] probe of serio1 returned 0 after 43450 usecs
[ 0.451625] probe of serio1 returned 0 after 11228 usecs
[ 0.464839] [drm] ib test on ring 5 succeeded
[ 0.467664] [drm] Radeon Display Connectors
[ 0.467666] [drm] Connector 0:
[ 0.467667] [drm] HDMI-A-1
[ 0.467668] [drm] HPD1
[ 0.467671] [drm] DDC: 0x6430 0x6430 0x6434 0x6434 0x6438 0x6438 0x643c 0x643c
[ 0.467672] [drm] Encoders:
[ 0.467674] [drm] DFP1: INTERNAL_UNIPHY
[ 0.467675] [drm] Connector 1:
[ 0.467676] [drm] HDMI-A-2
[ 0.467677] [drm] HPD2
[ 0.467679] [drm] DDC: 0x6440 0x6440 0x6444 0x6444 0x6448 0x6448 0x644c 0x644c
[ 0.467680] [drm] Encoders:
[ 0.467681] [drm] DFP2: INTERNAL_UNIPHY
[ 0.467683] [drm] Connector 2:
[ 0.467683] [drm] VGA-1
[ 0.467686] [drm] DDC: 0x64d8 0x64d8 0x64dc 0x64dc 0x64e0 0x64e0 0x64e4 0x64e4
[ 0.467687] [drm] Encoders:
[ 0.467704] [drm] CRT1: INTERNAL_KLDSCP_DAC1
[ 0.508931] [drm] fb mappable at 0xE0366000
[ 0.508932] [drm] vram apper at 0xE0000000
[ 0.508933] [drm] size 5242880
[ 0.508934] [drm] fb depth is 24
[ 0.508936] [drm] pitch is 5120
[ 0.509166] fbcon: radeondrmfb (fb0) is primary device
[ 0.553077] Console: switching to colour frame buffer device 160x64
[ 0.563843] radeon 0000:00:01.0: fb0: radeondrmfb frame buffer device
[ 0.563979] [drm] Initialized radeon 2.50.0 20080528 for 0000:00:01.0 on minor 0
[ 0.564027] probe of 0000:00:01.0 returned 1 after 210111 usecs
[ 0.564764] scsi 0:0:0:0: Direct-Access ATA SanDisk SDSSDP06 0 PQ: 0 ANSI: 5
[ 0.565273] probe of 0:0:0:0 returned 1 after 96 usecs
[ 0.565411] sd 0:0:0:0: Attached scsi generic sg0 type 0
[ 0.565501] sd 0:0:0:0: [sda] 125045424 512-byte logical blocks: (64.0 GB/59.6 GiB)
[ 0.565578] sd 0:0:0:0: [sda] Write Protect is off
[ 0.565583] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 0.565625] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 0.566774] sda: sda1
[ 0.567407] sd 0:0:0:0: [sda] Attached SCSI disk
[ 0.572462] random: 1
[ 0.572465] random: 2
[ 0.572468] random: 3
[ 0.572469] random: 4
[ 0.572473] random: fast init done
[ 0.579108] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null)
[ 0.579143] VFS: Mounted root (ext4 filesystem) on device 8:1.
[ 0.581242] devtmpfs: mounted
[ 0.582800] Freeing init [mem 0xcac1d000-0xcad32fff]
[ 0.583774] Freeing unused kernel image memory: 1112K
[ 0.587966] RO text: 0xca000000 - 0xca880fff
[ 0.588143] Write protecting the kernel text: 8708k
[ 0.588145] RO data: 0xca881000 - 0xcab4cfff
[ 0.588429] Write protecting the kernel read-only data: 2864k
[ 0.588431] NX data: 0xca881000 - 0xcadfffff
[ 0.588432] NX-protecting the kernel data: 5628k
[ 0.589160] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[ 0.589170] Run /lib/systemd/systemd-bootchart as init process
[ 0.698300] random: systemd-bootcha: uninitialized urandom read (16 bytes read)
[ 0.862579] systemd[1]: systemd 239 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[ 0.862958] systemd[1]: Detected architecture x86.
[ 0.867270] systemd[1]: Set hostname to <kodi>.
[ 1.246694] random: systemd: uninitialized urandom read (16 bytes read)
[ 1.248532] systemd[1]: Created slice system-getty.slice.
[ 1.248867] random: systemd: uninitialized urandom read (16 bytes read)
[ 1.249164] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[ 1.249327] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[ 1.249768] systemd[1]: Listening on Journal Socket (/dev/log).
[ 1.249830] systemd[1]: Reached target Network.
[ 1.249877] systemd[1]: Reached target Remote File Systems.
[ 1.250176] systemd[1]: Listening on Network Service Netlink Socket.
[ 1.375544] tsc: Refined TSC clocksource calibration: 1600.001 MHz
[ 1.375560] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x17102604879, max_idle_ns: 440795272763 ns
[ 1.375601] clocksource: Switched to clocksource tsc
[ 1.760900] calling coreboot_bus_init+0x0/0x1000 [coreboot_table] @ 143
[ 1.760934] initcall coreboot_bus_init+0x0/0x1000 [coreboot_table] returned 0 after 24 usecs
[ 1.762852] calling coreboot_table_acpi_init+0x0/0x1000 [coreboot_table_acpi] @ 143
[ 1.765186] probe of BOOT0000:00 returned 1 after 2301 usecs
[ 1.765233] initcall coreboot_table_acpi_init+0x0/0x1000 [coreboot_table_acpi] returned 0 after 2312 usecs
[ 1.789869] calling acpi_cpufreq_init+0x0/0x1000 [acpi_cpufreq] @ 143
[ 1.790039] acpi_cpufreq: overriding BIOS provided _PSD data
[ 1.790264] initcall acpi_cpufreq_init+0x0/0x1000 [acpi_cpufreq] returned 0 after 374 usecs
[ 1.792987] calling pcc_cpufreq_init+0x0/0xebc [pcc_cpufreq] @ 143
[ 1.792998] initcall pcc_cpufreq_init+0x0/0xebc [pcc_cpufreq] returned 0 after 1 usecs
[ 2.022807] calling init_soundcore+0x0/0x1000 [soundcore] @ 144
[ 2.022843] initcall init_soundcore+0x0/0x1000 [soundcore] returned 0 after 27 usecs
[ 2.028416] calling alsa_sound_init+0x0/0x82 [snd] @ 144
[ 2.028482] initcall alsa_sound_init+0x0/0x82 [snd] returned 0 after 48 usecs
[ 2.030960] calling alsa_timer_init+0x0/0x1000 [snd_timer] @ 144
[ 2.031635] initcall alsa_timer_init+0x0/0x1000 [snd_timer] returned 0 after 645 usecs
[ 2.037508] calling alsa_pcm_init+0x0/0x1000 [snd_pcm] @ 144
[ 2.037532] initcall alsa_pcm_init+0x0/0x1000 [snd_pcm] returned 0 after 9 usecs
[ 2.042908] calling hda_bus_init+0x0/0x14 [snd_hda_core] @ 144
[ 2.042950] initcall hda_bus_init+0x0/0x14 [snd_hda_core] returned 0 after 27 usecs
[ 2.083459] calling azx_driver_init+0x0/0xfe4 [snd_hda_intel] @ 144
[ 2.083529] initcall azx_driver_init+0x0/0xfe4 [snd_hda_intel] returned 0 after 56 usecs
[ 2.083597] 1
[ 2.083633] 2
[ 2.083972] 3
[ 2.083973] 4
[ 2.083974] 5
[ 2.083975] 7
[ 2.083981] 8
[ 2.083982] 9
[ 2.084034] probe of 0000:00:01.1 returned 1 after 518 usecs
[ 2.084057] 1
[ 2.084069] 2
[ 2.084338] 3
[ 2.084339] 4
[ 2.084340] 5
[ 2.084341] 7
[ 2.084342] 8
[ 2.084343] 9
[ 2.084401] probe of 0000:00:14.2 returned 1 after 353 usecs
[ 2.106135] calling generic_driver_init+0x0/0x1000 [snd_hda_codec_generic] @ 161
[ 2.106181] initcall generic_driver_init+0x0/0x1000 [snd_hda_codec_generic] returned 0 after 32 usecs
[ 2.110716] calling hdmi_driver_init+0x0/0x1000 [snd_hda_codec_hdmi] @ 160
[ 2.116098] calling realtek_driver_init+0x0/0x1000 [snd_hda_codec_realtek] @ 161
[ 2.116749] snd_hda_codec_realtek hdaudioC1D0: ALC892: SKU not ready 0x00000100
[ 2.117328] snd_hda_codec_realtek hdaudioC1D0: autoconfig for ALC892: line_outs=4 (0x14/0x16/0x15/0x17/0x0) type:line
[ 2.117331] snd_hda_codec_realtek hdaudioC1D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
[ 2.117335] snd_hda_codec_realtek hdaudioC1D0: hp_outs=1 (0x1b/0x0/0x0/0x0/0x0)
[ 2.117337] snd_hda_codec_realtek hdaudioC1D0: mono: mono_out=0x0
[ 2.117340] snd_hda_codec_realtek hdaudioC1D0: dig-out=0x1e/0x0
[ 2.117342] snd_hda_codec_realtek hdaudioC1D0: inputs:
[ 2.117347] snd_hda_codec_realtek hdaudioC1D0: Rear Mic=0x18
[ 2.117351] snd_hda_codec_realtek hdaudioC1D0: Front Mic=0x19
[ 2.117354] snd_hda_codec_realtek hdaudioC1D0: Line=0x1a
[ 2.117393] snd_hda_codec_realtek hdaudioC1D0: CD=0x1c
[ 2.128352] probe of hdaudioC0D0 returned 1 after 17609 usecs
[ 2.128474] initcall hdmi_driver_init+0x0/0x1000 [snd_hda_codec_hdmi] returned 0 after 12064 usecs
[ 2.129335] input: HD-Audio Generic HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:01.1/sound/card0/input5
[ 2.158728] probe of hdaudioC1D0 returned 1 after 42600 usecs
[ 2.158799] initcall realtek_driver_init+0x0/0x1000 [snd_hda_codec_realtek] returned 0 after 41671 usecs
[ 2.161716] input: HDA ATI SB Rear Mic as /devices/pci0000:00/0000:00:14.2/sound/card1/input6
[ 2.161856] input: HDA ATI SB Front Mic as /devices/pci0000:00/0000:00:14.2/sound/card1/input7
[ 2.161977] input: HDA ATI SB Line as /devices/pci0000:00/0000:00:14.2/sound/card1/input8
[ 2.162106] input: HDA ATI SB Line Out Front as /devices/pci0000:00/0000:00:14.2/sound/card1/input9
[ 2.162228] input: HDA ATI SB Line Out Surround as /devices/pci0000:00/0000:00:14.2/sound/card1/input10
[ 2.162765] input: HDA ATI SB Line Out CLFE as /devices/pci0000:00/0000:00:14.2/sound/card1/input11
[ 2.162893] input: HDA ATI SB Line Out Side as /devices/pci0000:00/0000:00:14.2/sound/card1/input12
[ 2.163022] input: HDA ATI SB Front Headphone as /devices/pci0000:00/0000:00:14.2/sound/card1/input13
[ 2.168271] calling ehci_hcd_init+0x0/0x1000 [ehci_hcd] @ 144
[ 2.168277] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 2.168310] initcall ehci_hcd_init+0x0/0x1000 [ehci_hcd] returned 0 after 24 usecs
[ 2.176579] calling ohci_hcd_mod_init+0x0/0x1000 [ohci_hcd] @ 144
[ 2.176585] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 2.176615] initcall ohci_hcd_mod_init+0x0/0x1000 [ohci_hcd] returned 0 after 25 usecs
[ 2.187005] calling ehci_pci_init+0x0/0x1000 [ehci_pci] @ 144
[ 2.187017] ehci-pci: EHCI PCI platform driver
[ 2.187097] initcall ehci_pci_init+0x0/0x1000 [ehci_pci] returned 0 after 74 usecs
[ 2.188126] QUIRK: Enable AMD PLL fix
[ 2.188248] ehci-pci 0000:00:12.2: EHCI Host Controller
[ 2.188264] ehci-pci 0000:00:12.2: new USB bus registered, assigned bus number 1
[ 2.188276] ehci-pci 0000:00:12.2: applying AMD SB700/SB800/Hudson-2/3 EHCI dummy qh workaround
[ 2.188393] ehci-pci 0000:00:12.2: debug port 1
[ 2.188481] ehci-pci 0000:00:12.2: irq 17, io mem 0xf014c000
[ 2.195494] ehci-pci 0000:00:12.2: USB 2.0 started, EHCI 1.00
[ 2.195766] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
[ 2.195770] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 2.195779] usb usb1: Product: EHCI Host Controller
[ 2.195782] usb usb1: Manufacturer: Linux 4.19.0-rc8-00045-gc92161e11c2a ehci_hcd
[ 2.195784] usb usb1: SerialNumber: 0000:00:12.2
[ 2.196329] hub 1-0:1.0: USB hub found
[ 2.196416] hub 1-0:1.0: 5 ports detected
[ 2.196786] probe of 1-0:1.0 returned 1 after 478 usecs
[ 2.196854] probe of usb1 returned 1 after 672 usecs
[ 2.197049] probe of 0000:00:12.2 returned 1 after 9485 usecs
[ 2.197656] ehci-pci 0000:00:13.2: EHCI Host Controller
[ 2.197679] ehci-pci 0000:00:13.2: new USB bus registered, assigned bus number 2
[ 2.197687] ehci-pci 0000:00:13.2: applying AMD SB700/SB800/Hudson-2/3 EHCI dummy qh workaround
[ 2.197715] ehci-pci 0000:00:13.2: debug port 1
[ 2.197791] ehci-pci 0000:00:13.2: irq 17, io mem 0xf014d000
[ 2.204478] ehci-pci 0000:00:13.2: USB 2.0 started, EHCI 1.00
[ 2.204694] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
[ 2.204697] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 2.204701] usb usb2: Product: EHCI Host Controller
[ 2.204704] usb usb2: Manufacturer: Linux 4.19.0-rc8-00045-gc92161e11c2a ehci_hcd
[ 2.204706] usb usb2: SerialNumber: 0000:00:13.2
[ 2.205072] hub 2-0:1.0: USB hub found
[ 2.205093] hub 2-0:1.0: 5 ports detected
[ 2.205539] probe of 2-0:1.0 returned 1 after 481 usecs
[ 2.205592] probe of usb2 returned 1 after 619 usecs
[ 2.205662] probe of 0000:00:13.2 returned 1 after 8605 usecs
[ 2.208993] calling ohci_pci_init+0x0/0x1000 [ohci_pci] @ 144
[ 2.208998] ohci-pci: OHCI PCI platform driver
[ 2.209687] ohci-pci 0000:00:12.0: OHCI PCI host controller
[ 2.209704] ohci-pci 0000:00:12.0: new USB bus registered, assigned bus number 3
[ 2.209803] ohci-pci 0000:00:12.0: irq 18, io mem 0xf0148000
[ 2.210083] initcall ohci_pci_init+0x0/0x1000 [ohci_pci] returned 0 after 1051 usecs
[ 2.268492] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
[ 2.268499] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 2.268502] usb usb3: Product: OHCI PCI host controller
[ 2.268505] usb usb3: Manufacturer: Linux 4.19.0-rc8-00045-gc92161e11c2a ohci_hcd
[ 2.268507] usb usb3: SerialNumber: 0000:00:12.0
[ 2.271715] hub 3-0:1.0: USB hub found
[ 2.271807] hub 3-0:1.0: 5 ports detected
[ 2.272032] probe of 3-0:1.0 returned 1 after 338 usecs
[ 2.272089] probe of usb3 returned 1 after 500 usecs
[ 2.272253] probe of 0000:00:12.0 returned 1 after 63193 usecs
[ 2.273944] ohci-pci 0000:00:13.0: OHCI PCI host controller
[ 2.273969] ohci-pci 0000:00:13.0: new USB bus registered, assigned bus number 4
[ 2.274108] ohci-pci 0000:00:13.0: irq 18, io mem 0xf0149000
[ 2.329783] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
[ 2.329789] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 2.329792] usb usb4: Product: OHCI PCI host controller
[ 2.329795] usb usb4: Manufacturer: Linux 4.19.0-rc8-00045-gc92161e11c2a ohci_hcd
[ 2.329798] usb usb4: SerialNumber: 0000:00:13.0
[ 2.330132] hub 4-0:1.0: USB hub found
[ 2.330221] hub 4-0:1.0: 5 ports detected
[ 2.333390] probe of 4-0:1.0 returned 1 after 3271 usecs
[ 2.333468] probe of usb4 returned 1 after 3425 usecs
[ 2.333638] probe of 0000:00:13.0 returned 1 after 61378 usecs
[ 2.334141] ohci-pci 0000:00:14.5: OHCI PCI host controller
[ 2.334155] ohci-pci 0000:00:14.5: new USB bus registered, assigned bus number 5
[ 2.334217] ohci-pci 0000:00:14.5: irq 18, io mem 0xf014a000
[ 2.389660] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
[ 2.389666] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 2.389669] usb usb5: Product: OHCI PCI host controller
[ 2.389672] usb usb5: Manufacturer: Linux 4.19.0-rc8-00045-gc92161e11c2a ohci_hcd
[ 2.389674] usb usb5: SerialNumber: 0000:00:14.5
[ 2.392649] hub 5-0:1.0: USB hub found
[ 2.392711] hub 5-0:1.0: 2 ports detected
[ 2.392851] probe of 5-0:1.0 returned 1 after 224 usecs
[ 2.392914] probe of usb5 returned 1 after 408 usecs
[ 2.393075] probe of 0000:00:14.5 returned 1 after 59426 usecs
[ 2.413073] calling piix4_driver_init+0x0/0x1000 [i2c_piix4] @ 143
[ 2.413224] piix4_smbus 0000:00:14.0: SMBus Host Controller at 0xb00, revision 0
[ 2.413235] piix4_smbus 0000:00:14.0: Using register 0x2c for SMBus port selection
[ 2.414925] piix4_smbus 0000:00:14.0: Auxiliary SMBus Host Controller at 0x8060
[ 2.414993] probe of 0000:00:14.0 returned 1 after 1890 usecs
[ 2.415040] initcall piix4_driver_init+0x0/0x1000 [i2c_piix4] returned 0 after 1908 usecs
[ 2.464953] calling rtl8169_pci_driver_init+0x0/0x1000 [r8169] @ 144
[ 2.472719] calling k10temp_driver_init+0x0/0x1000 [k10temp] @ 143
[ 2.472901] probe of 0000:00:18.3 returned 1 after 142 usecs
[ 2.472948] initcall k10temp_driver_init+0x0/0x1000 [k10temp] returned 0 after 212 usecs
[ 2.476329] calling phy_module_init+0x0/0x1000 [realtek] @ 165
[ 2.476579] initcall phy_module_init+0x0/0x1000 [realtek] returned 0 after 234 usecs
[ 2.477229] probe of r8169-300:00 returned 1 after 52 usecs
[ 2.477246] libphy: r8169: probed
[ 2.478329] r8169 0000:03:00.0 eth0: RTL8168e/8111e, bc:5f:f4:c8:d3:98, XID 2c200000, IRQ 28
[ 2.478335] r8169 0000:03:00.0 eth0: jumbo features [frames: 9200 bytes, tx checksumming: ko]
[ 2.478416] probe of 0000:03:00.0 returned 1 after 13424 usecs
[ 2.478470] initcall rtl8169_pci_driver_init+0x0/0x1000 [r8169] returned 0 after 2069 usecs
[ 2.677415] usb 3-2: new low-speed USB device number 2 using ohci-pci
[ 2.869665] usb 3-2: New USB device found, idVendor=1241, idProduct=1122, bcdDevice= 1.00
[ 2.869672] usb 3-2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 2.879346] input: HID 1241:1122 as /devices/pci0000:00/0000:00:12.0/usb3/3-2/3-2:1.0/0003:1241:1122.0001/input/input14
[ 2.883355] hid-generic 0003:1241:1122.0001: input,hidraw0: USB HID v1.00 Mouse [HID 1241:1122] on usb-0000:00:12.0-2/input0
[ 2.883396] probe of 0003:1241:1122.0001 returned 1 after 4404 usecs
[ 2.883426] probe of 3-2:1.0 returned 1 after 11761 usecs
[ 2.883492] probe of 3-2 returned 1 after 13572 usecs
[ 3.118169] r8169 0000:03:00.0 enp3s0: renamed from eth0
[ 3.134086] r8169 0000:03:00.0: Direct firmware load for rtl_nic/rtl8168e-2.fw failed with error -2
[ 3.134098] r8169 0000:03:00.0 enp3s0: unable to load firmware patch rtl_nic/rtl8168e-2.fw (-2)
[ 3.134609] RTL8211DN Gigabit Ethernet r8169-300:00: attached PHY driver [RTL8211DN Gigabit Ethernet] (mii_bus:phy_addr=r8169-300:00, irq=IGNORE)
[ 3.232946] IPv6: ADDRCONF(NETDEV_UP): enp3s0: link is not ready
[ 3.234827] r8169 0000:03:00.0 enp3s0: Link is Down
[ 4.585880] random: crng init done
[ 4.585890] random: 7 urandom warning(s) missed due to ratelimiting
[ 5.741952] r8169 0000:03:00.0 enp3s0: Link is Up - 1Gbps/Full - flow control rx/tx
[ 5.741975] IPv6: ADDRCONF(NETDEV_CHANGE): enp3s0: link becomes ready
From 3ebdcee064f301de1fe635a50e5f941fd2050094 Mon Sep 17 00:00:00 2001
From: Paul Menzel <pmenzel@xxxxxxxxxxxxx>
Date: Mon, 8 Oct 2018 00:38:21 +0200
Subject: [PATCH] init/main.c: Add time stamps
Signed-off-by: Paul Menzel <pmenzel@xxxxxxxxxxxxx>
---
init/main.c | 26 ++++++++++++++++++++++++++
1 file changed, 26 insertions(+)
diff --git a/init/main.c b/init/main.c
index 18f8f0140fa0..60f35c716552 100644
--- a/init/main.c
+++ b/init/main.c
@@ -400,6 +400,7 @@ static noinline void __ref rest_init(void)
int pid;
rcu_scheduler_starting();
+ pr_info("After rcu_scheduler_starting\n");
/*
* We need to spawn init first so that it obtains pid 1, however
* the init task will end up wanting to create kthreads, which, if
@@ -413,14 +414,18 @@ static noinline void __ref rest_init(void)
*/
rcu_read_lock();
tsk = find_task_by_pid_ns(pid, &init_pid_ns);
+ pr_info("After find_task_by_pid_ns\n");
set_cpus_allowed_ptr(tsk, cpumask_of(smp_processor_id()));
rcu_read_unlock();
numa_default_policy();
+ pr_info("After numa_default_policy\n");
pid = kernel_thread(kthreadd, NULL, CLONE_FS | CLONE_FILES);
rcu_read_lock();
+ pr_info("After rcu_read_lock\n");
kthreadd_task = find_task_by_pid_ns(pid, &init_pid_ns);
rcu_read_unlock();
+ pr_info("After rcu_read_unlock\n");
/*
* Enable might_sleep() and smp_processor_id() checks.
@@ -432,14 +437,17 @@ static noinline void __ref rest_init(void)
system_state = SYSTEM_SCHEDULING;
complete(&kthreadd_done);
+ pr_info("After kthreadd_done\n");
/*
* The boot idle thread must execute schedule()
* at least once to get things moving:
*/
schedule_preempt_disabled();
+ pr_info("After schedule_preempt_disabled\n");
/* Call into cpu_idle with preempt disabled */
cpu_startup_entry(CPUHP_ONLINE);
+ pr_info("After cpu_startup_entry\n");
}
/* Check for early params. */
@@ -550,19 +558,29 @@ asmlinkage __visible void __init start_kernel(void)
page_address_init();
pr_notice("%s", linux_banner);
setup_arch(&command_line);
+ pr_info("After setup_arch\n");
/*
* Set up the the initial canary and entropy after arch
* and after adding latent and command line entropy.
*/
add_latent_entropy();
+ pr_info("After add_latent_entropy\n");
add_device_randomness(command_line, strlen(command_line));
+ pr_info("After add_device_randomness\n");
boot_init_stack_canary();
+ pr_info("After boot_init_stack_canary\n");
mm_init_cpumask(&init_mm);
+ pr_info("After mm_init_cpumask\n");
setup_command_line(command_line);
+ pr_info("After setup_command_line\n");
setup_nr_cpu_ids();
+ pr_info("After setup_nr_cpu_ids\n");
setup_per_cpu_areas();
+ pr_info("After setup_per_cpu_areas\n");
smp_prepare_boot_cpu(); /* arch-specific boot-cpu hooks */
+ pr_info("After smp_perpare_boot_cpu\n");
boot_cpu_hotplug_init();
+ pr_info("After boot_cpu_hotplug_init\n");
build_all_zonelists(NULL);
page_alloc_init();
@@ -588,6 +606,7 @@ asmlinkage __visible void __init start_kernel(void)
sort_main_extable();
trap_init();
mm_init();
+ pr_info("After mm_init\n");
ftrace_init();
@@ -600,6 +619,7 @@ asmlinkage __visible void __init start_kernel(void)
* time - but meanwhile we still have a functioning scheduler.
*/
sched_init();
+ pr_info("After sched_init\n");
/*
* Disable preemption - early bootup scheduling is extremely
* fragile until we cpu_idle() for the first time.
@@ -624,6 +644,7 @@ asmlinkage __visible void __init start_kernel(void)
workqueue_init_early();
rcu_init();
+ pr_info("After rcu_init\n");
/* Trace events are available after this */
trace_init();
@@ -726,10 +747,14 @@ asmlinkage __visible void __init start_kernel(void)
delayacct_init();
check_bugs();
+ pr_info("After check_bugs\n");
acpi_subsystem_init();
+ pr_info("After acpi_subsystem_init\n");
arch_post_acpi_subsys_init();
+ pr_info("After arch_post_acpi_subsys_init\n");
sfi_init_late();
+ pr_info("After sfi_init_late\n");
if (efi_enabled(EFI_RUNTIME_SERVICES)) {
efi_free_boot_services();
@@ -737,6 +762,7 @@ asmlinkage __visible void __init start_kernel(void)
/* Do the rest non-__init'ed, we're now alive */
rest_init();
+ pr_info("After rest_init\n");
}
/* Call all constructor functions linked into the kernel. */
--
2.17.1
From 256a313f4d92f3e45d526f048d54f23c077f11bc Mon Sep 17 00:00:00 2001
From: Paul Menzel <pmenzel@xxxxxxxxxxxxx>
Date: Tue, 3 Jul 2018 07:32:45 +0200
Subject: [PATCH] random: Debug fast init
---
drivers/char/random.c | 5 +++++
1 file changed, 5 insertions(+)
diff --git a/drivers/char/random.c b/drivers/char/random.c
index c75b6cdf0053..a28d0a23625e 100644
--- a/drivers/char/random.c
+++ b/drivers/char/random.c
@@ -855,6 +855,8 @@ static int crng_fast_load(const char *cp, size_t len)
unsigned long flags;
char *p;
+ pr_notice("random: 1\n");
+
if (!spin_trylock_irqsave(&primary_crng.lock, flags))
return 0;
if (crng_init != 0) {
@@ -862,11 +864,14 @@ static int crng_fast_load(const char *cp, size_t len)
return 0;
}
p = (unsigned char *) &primary_crng.state[4];
+ pr_notice("random: 2\n");
while (len > 0 && crng_init_cnt < CRNG_INIT_CNT_THRESH) {
p[crng_init_cnt % CHACHA20_KEY_SIZE] ^= *cp;
cp++; crng_init_cnt++; len--;
}
+ pr_notice("random: 3\n");
spin_unlock_irqrestore(&primary_crng.lock, flags);
+ pr_notice("random: 4\n");
if (crng_init_cnt >= CRNG_INIT_CNT_THRESH) {
invalidate_batched_entropy();
crng_init = 1;
--
2.17.1
Attachment:
smime.p7s
Description: S/MIME Cryptographic Signature