early console in setup code
early console in extract_kernel
input_data: 0x0000000007682276
input_len: 0x0000000001ae524e
output: 0x0000000001000000
output_len: 0x00000000070d5a50
kernel_total_size: 0x0000000008584000
booted via startup_32()
Physical KASLR using RDTSC...
Virtual KASLR using RDTSC...

Decompressing Linux... Parsing ELF... Performing relocations... done.
Booting the kernel.
[    0.000000] Linux version 4.16.0-rc2-00103-gdf2af62 (kbuild@lkp-g5) (gcc version 7.3.0 (Debian 7.3.0-1)) #1 SMP Wed Feb 28 07:22:16 CST 2018
[    0.000000] Command line: ip=::::vm-lkp-hsw01-openwrt-ia32-18::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-hsw01-openwrt-ia32-18/boot-1-openwrt-i386-2016-03-16.cgz-df2af627c79ad4273b4b4c49711252c084490fd2-20180228-24267-b44iq4-1.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s4-02180035 branch=linus/master commit=df2af627c79ad4273b4b4c49711252c084490fd2 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s4-02180035/gcc-7/df2af627c79ad4273b4b4c49711252c084490fd2/vmlinuz-4.16.0-rc2-00103-gdf2af62 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-hsw01-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-s4-02180035/gcc-7/df2af627c79ad4273b4b4c49711252c084490fd2/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=
[    0.000000] x86/fpu: x87 FPU will use FXSAVE
[    0.000000] e820: BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000001a3dffff] usable
[    0.000000] BIOS-e820: [mem 0x000000001a3e0000-0x000000001a3fffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] debug: ignoring loglevel setting.
[    0.000000] bootconsole [earlyser0] enabled
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] Hypervisor detected: KVM
[    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000000] e820: last_pfn = 0x1a3e0 max_arch_pfn = 0x400000000
[    0.000000] MTRR default type: write-back
[    0.000000] MTRR fixed ranges enabled:
[    0.000000]   00000-9FFFF write-back
[    0.000000]   A0000-BFFFF uncachable
[    0.000000]   C0000-FFFFF write-protect
[    0.000000] MTRR variable ranges enabled:
[    0.000000]   0 base 0080000000 mask FF80000000 uncachable
[    0.000000]   1 disabled
[    0.000000]   2 disabled
[    0.000000]   3 disabled
[    0.000000]   4 disabled
[    0.000000]   5 disabled
[    0.000000]   6 disabled
[    0.000000]   7 disabled
[    0.000000] x86/PAT: PAT not supported by CPU.
[    0.000000] x86/PAT: Configuration [0-7]: WB  WT  UC- UC  WB  WT  UC- UC  
[    0.000000] Scan for SMP in [mem 0x00000000-0x000003ff]
[    0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff]
[    0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff]
[    0.000000] found SMP MP-table at [mem 0x000f6aa0-0x000f6aaf] mapped at [        (ptrval)]
[    0.000000]   mpc: f6ab0-f6b80
[    0.000000] Scanning 1 areas for low memory corruption
[    0.000000] Base memory trampoline at [        (ptrval)] 99000 size 24576
[    0.000000] BRK [0x15768000, 0x15768fff] PGTABLE
[    0.000000] BRK [0x15769000, 0x15769fff] PGTABLE
[    0.000000] BRK [0x1576a000, 0x1576afff] PGTABLE
[    0.000000] BRK [0x1576b000, 0x1576bfff] PGTABLE
[    0.000000] BRK [0x1576c000, 0x1576cfff] PGTABLE
[    0.000000] BRK [0x1576d000, 0x1576dfff] PGTABLE
[    0.000000] RAMDISK: [mem 0x1a0c5000-0x1a3dffff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000F68D0 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x000000001A3E15CE 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x000000001A3E142A 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x000000001A3E0040 0013EA (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACS 0x000000001A3E0000 000040
[    0.000000] ACPI: APIC 0x000000001A3E151E 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 0x000000001A3E1596 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5fd000 (        fee00000)
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at [mem 0x0000000000000000-0x000000001a3dffff]
[    0.000000] NODE_DATA(0) allocated [mem 0x1a0a3000-0x1a0c4fff]
[    0.000000] kvm-clock: cpu 0, msr 0:1a022001, primary cpu clock
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: using sched offset of 4984266631 cycles
[    0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000000]   DMA32    [mem 0x0000000001000000-0x000000001a3dffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.000000]   node   0: [mem 0x0000000000100000-0x000000001a3dffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000001a3dffff]
[    0.000000] On node 0 totalpages: 107390
[    0.000000]   DMA zone: 56 pages used for memmap
[    0.000000]   DMA zone: 21 pages reserved
[    0.000000]   DMA zone: 3998 pages, LIFO batch:0
[    0.000000]   DMA32 zone: 1414 pages used for memmap
[    0.000000]   DMA32 zone: 103392 pages, LIFO batch:31
[    0.000000] Reserved but unavailable: 98 pages
[    0.000000] kasan: KernelAddressSanitizer initialized
[    0.000000] ACPI: PM-Timer IO Port: 0x608
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b
[    0.000000] ACPI: IRQ0 used by override.
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04
[    0.000000] ACPI: IRQ5 used by override.
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08
[    0.000000] ACPI: IRQ9 used by override.
[    0.000000] ACPI: IRQ10 used by override.
[    0.000000] ACPI: IRQ11 used by override.
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
[    0.000000] mapped IOAPIC to ffffffffff5fc000 (fec00000)
[    0.000000] e820: [mem 0x1a400000-0xfeffbfff] available for PCI devices
[    0.000000] Booting paravirtualized kernel on KVM
[    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[    0.000000] random: fast init done
[    0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] percpu: Embedded 498 pages/cpu @        (ptrval) s2011136 r0 d28672 u2097152
[    0.000000] pcpu-alloc: s2011136 r0 d28672 u2097152 alloc=1*2097152
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] KVM setup async PF for cpu 0
[    0.000000] kvm-stealtime: cpu 0, msr 61e340
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 105899
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: ip=::::vm-lkp-hsw01-openwrt-ia32-18::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-hsw01-openwrt-ia32-18/boot-1-openwrt-i386-2016-03-16.cgz-df2af627c79ad4273b4b4c49711252c084490fd2-20180228-24267-b44iq4-1.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s4-02180035 branch=linus/master commit=df2af627c79ad4273b4b4c49711252c084490fd2 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s4-02180035/gcc-7/df2af627c79ad4273b4b4c49711252c084490fd2/vmlinuz-4.16.0-rc2-00103-gdf2af62 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-hsw01-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-s4-02180035/gcc-7/df2af627c79ad4273b4b4c49711252c084490fd2/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,1152
[    0.000000] sysrq: sysrq always enabled.
[    0.000000] Memory: 6332K/429560K available (36876K kernel code, 35897K rwdata, 17252K rodata, 5268K init, 32536K bss, 423228K reserved, 0K cma-reserved)
[    0.001000] Hierarchical RCU implementation.
[    0.001000] 	RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=1.
[    0.001000] 	RCU debug extended QS entry/exit.
[    0.001000] 	RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout).
[    0.001000] 	Tasks RCU enabled.
[    0.001000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.001000] NR_IRQS: 4352, nr_irqs: 48, preallocated irqs: 16
[    0.001000] 	Offload RCU callbacks from CPUs: .
[    0.001000] ==================================================================
[    0.001000] ==================================================================
[    0.001000] BUG: KASAN: use-after-scope in console_unlock+0x504/0x940
[    0.001000] BUG: KASAN: use-after-scope in console_unlock+0x504/0x940
[    0.001000] Write of size 1 at addr ffffffffa3207978 by task swapper/0
[    0.001000] Write of size 1 at addr ffffffffa3207978 by task swapper/0
[    0.001000] 
[    0.001000] 
[    0.001000] CPU: 0 PID: 0 Comm: swapper Not tainted 4.16.0-rc2-00103-gdf2af62 #1
[    0.001000] CPU: 0 PID: 0 Comm: swapper Not tainted 4.16.0-rc2-00103-gdf2af62 #1
[    0.001000] Call Trace:
[    0.001000] Call Trace:
[    0.001000]  ? dump_stack+0x14b/0x22d
[    0.001000]  ? dump_stack+0x14b/0x22d
[    0.001000]  ? arch_local_irq_restore+0x16/0x16
[    0.001000]  ? arch_local_irq_restore+0x16/0x16
[    0.001000]  ? cpumask_weight+0x52/0x52
[    0.001000]  ? cpumask_weight+0x52/0x52
[    0.001000]  ? print_address_description+0x82/0x2f3
[    0.001000]  ? print_address_description+0x82/0x2f3
[    0.001000]  ? console_unlock+0x504/0x940
[    0.001000]  ? console_unlock+0x504/0x940
[    0.001000]  ? kasan_report+0x33e/0x3a8
[    0.001000]  ? kasan_report+0x33e/0x3a8
[    0.001000]  ? __asan_report_store1_noabort+0x21/0x29
[    0.001000]  ? __asan_report_store1_noabort+0x21/0x29
[    0.001000]  ? console_unlock+0x504/0x940
[    0.001000]  ? console_unlock+0x504/0x940
[    0.001000]  ? __lock_acquire+0x684/0xfd2
[    0.001000]  ? __lock_acquire+0x684/0xfd2
[    0.001000]  ? wake_up_klogd+0x149/0x149
[    0.001000]  ? wake_up_klogd+0x149/0x149
[    0.001000]  ? lock_acquire+0xf1/0x15b
[    0.001000]  ? lock_acquire+0xf1/0x15b
[    0.001000]  ? arch_local_irq_restore+0xe/0x16
[    0.001000]  ? arch_local_irq_restore+0xe/0x16
[    0.001000]  ? lock_acquire+0x148/0x15b
[    0.001000]  ? lock_acquire+0x148/0x15b
[    0.001000]  ? vprintk_emit+0x593/0x895
[    0.001000]  ? vprintk_emit+0x593/0x895
[    0.001000]  ? vprintk_emit+0x83a/0x895
[    0.001000]  ? vprintk_emit+0x83a/0x895
[    0.001000]  ? resume_console+0x6e/0x6e
[    0.001000]  ? resume_console+0x6e/0x6e
[    0.001000]  ? memblock_reserve+0x133/0x194
[    0.001000]  ? memblock_reserve+0x133/0x194
[    0.001000]  ? memblock_add_range+0x87f/0x940
[    0.001000]  ? memblock_add_range+0x87f/0x940
[    0.001000]  ? memset+0x42/0x4e
[    0.001000]  ? memset+0x42/0x4e
[    0.001000]  ? vprintk_default+0x1b/0x23
[    0.001000]  ? vprintk_default+0x1b/0x23
[    0.001000]  ? vprintk_func+0xb8/0xc0
[    0.001000]  ? vprintk_func+0xb8/0xc0
[    0.001000]  ? printk+0xa5/0xda
[    0.001000]  ? printk+0xa5/0xda
[    0.001000]  ? cpumask_weight+0x52/0x52
[    0.001000]  ? cpumask_weight+0x52/0x52
[    0.001000]  ? kasan_populate_zero_shadow+0x599/0x811
[    0.001000]  ? kasan_populate_zero_shadow+0x599/0x811
[    0.001000]  ? native_flush_tlb_global+0xbc/0x12d
[    0.001000]  ? native_flush_tlb_global+0xbc/0x12d
[    0.001000]  ? kasan_init+0x379/0x3fb
[    0.001000]  ? kasan_init+0x379/0x3fb
[    0.001000]  ? setup_arch+0x2652/0x2927
[    0.001000]  ? setup_arch+0x2652/0x2927
[    0.001000]  ? reserve_standard_io_resources+0x98/0x98
[    0.001000]  ? reserve_standard_io_resources+0x98/0x98
[    0.001000]  ? init_cgroup_root+0x157/0x394
[    0.001000]  ? init_cgroup_root+0x157/0x394
[    0.001000]  ? rebind_subsystems+0xbd/0xbd
[    0.001000]  ? rebind_subsystems+0xbd/0xbd
[    0.001000]  ? vprintk_default+0x1b/0x23
[    0.001000]  ? vprintk_default+0x1b/0x23
[    0.001000]  ? vprintk_func+0xb8/0xc0
[    0.001000]  ? vprintk_func+0xb8/0xc0
[    0.001000]  ? printk+0xa5/0xda
[    0.001000]  ? printk+0xa5/0xda
[    0.001000]  ? cpumask_weight+0x52/0x52
[    0.001000]  ? cpumask_weight+0x52/0x52
[    0.001000]  ? cgroup_init_early+0xbc/0x1a1
[    0.001000]  ? cgroup_init_early+0xbc/0x1a1
[    0.001000]  ? load_idt+0x16/0x16
[    0.001000]  ? load_idt+0x16/0x16
[    0.001000]  ? start_kernel+0x115/0xe00
[    0.001000]  ? start_kernel+0x115/0xe00
[    0.001000]  ? thread_stack_cache_init+0x35/0x35
[    0.001000]  ? thread_stack_cache_init+0x35/0x35
[    0.001000]  ? early_idt_handler_common+0x3b/0x52
[    0.001000]  ? early_idt_handler_common+0x3b/0x52
[    0.001000]  ? x86_64_start_reservations+0x6b/0x93
[    0.001000]  ? x86_64_start_reservations+0x6b/0x93
[    0.001000]  ? x86_64_start_kernel+0xe9/0x113
[    0.001000]  ? x86_64_start_kernel+0xe9/0x113
[    0.001000]  ? secondary_startup_64+0xa5/0xb0
[    0.001000]  ? secondary_startup_64+0xa5/0xb0
[    0.001000] 
[    0.001000] 
[    0.001000] 
[    0.001000] 
[    0.001000] Memory state around the buggy address:
[    0.001000] Memory state around the buggy address:
[    0.001000]  ffffffffa3207800: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
[    0.001000]  ffffffffa3207800: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
[    0.001000]  ffffffffa3207880: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
[    0.001000]  ffffffffa3207880: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
[    0.001000] >ffffffffa3207900: 00 00 00 00 00 00 00 00 00 00 00 f1 f1 f1 f1 f8
[    0.001000] >ffffffffa3207900: 00 00 00 00 00 00 00 00 00 00 00 f1 f1 f1 f1 f8
[    0.001000]                                                                 ^
[    0.001000]                                                                 ^
[    0.001000]  ffffffffa3207980: f2 f2 f2 f2 f2 f2 f2 01 f2 f2 f2 00 00 00 00 00
[    0.001000]  ffffffffa3207980: f2 f2 f2 f2 f2 f2 f2 01 f2 f2 f2 00 00 00 00 00
[    0.001000]  ffffffffa3207a00: 00 00 00 00 00 00 00 00 00 00 00 00 f1 f1 f1 f1
[    0.001000]  ffffffffa3207a00: 00 00 00 00 00 00 00 00 00 00 00 00 f1 f1 f1 f1
[    0.001000] ==================================================================
[    0.001000] ==================================================================
[    0.001000] Disabling lock debugging due to kernel taint
[    0.001000] Disabling lock debugging due to kernel taint
[    0.001000] console [ttyS0] enabled
[    0.001000] console [ttyS0] enabled
[    0.001000] bootconsole [earlyser0] disabled
[    0.001000] bootconsole [earlyser0] disabled
[    0.001000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.001000] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.001000] ... MAX_LOCK_DEPTH:          48
[    0.001000] ... MAX_LOCKDEP_KEYS:        8191
[    0.001000] ... CLASSHASH_SIZE:          4096
[    0.001000] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.001000] ... MAX_LOCKDEP_CHAINS:      65536
[    0.001000] ... CHAINHASH_SIZE:          32768
[    0.001000]  memory used by lock dependency info: 7871 kB
[    0.001000]  per task-struct memory footprint: 2688 bytes
[    0.001000] ----------------------------------
[    0.001000] | Locking API testsuite disabled |
[    0.001000] ----------------------------------
[    0.001000] ACPI: Core revision 20180105
[    0.001000] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.001000] hpet clockevent registered
[    0.001032] APIC: Switch to symmetric I/O mode setup
[    0.002224] x2apic enabled
[    0.003012] Switched APIC routing to physical x2apic.
[    0.003615] enabled ExtINT on CPU#0
[    0.004790] ENABLING IO-APIC IRQs
[    0.005196] init IO_APIC IRQs
[    0.005515]  apic 0 pin 0 not connected
[    0.006157] IOAPIC[0]: Set routing entry (0-1 -> 0xef -> IRQ 1 Mode:0 Active:0 Dest:0)
[    0.007190] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-3 -> 0xef -> IRQ 3 Mode:0 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-4 -> 0xef -> IRQ 4 Mode:0 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-5 -> 0xef -> IRQ 5 Mode:1 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-6 -> 0xef -> IRQ 6 Mode:0 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-7 -> 0xef -> IRQ 7 Mode:0 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-8 -> 0xef -> IRQ 8 Mode:0 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-9 -> 0xef -> IRQ 9 Mode:1 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-10 -> 0xef -> IRQ 10 Mode:1 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-11 -> 0xef -> IRQ 11 Mode:1 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-12 -> 0xef -> IRQ 12 Mode:0 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-13 -> 0xef -> IRQ 13 Mode:0 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-14 -> 0xef -> IRQ 14 Mode:0 Active:0 Dest:0)
[    0.008000] IOAPIC[0]: Set routing entry (0-15 -> 0xef -> IRQ 15 Mode:0 Active:0 Dest:0)
[    0.008000]  apic 0 pin 16 not connected
[    0.008000]  apic 0 pin 17 not connected
[    0.008000]  apic 0 pin 18 not connected
[    0.008000]  apic 0 pin 19 not connected
[    0.008000]  apic 0 pin 20 not connected
[    0.008000]  apic 0 pin 21 not connected
[    0.008000]  apic 0 pin 22 not connected
[    0.008000]  apic 0 pin 23 not connected
[    0.008000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.008000] tsc: Detected 2593.992 MHz processor
[    0.008031] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x25641074d3b, max_idle_ns: 440795244898 ns
[    0.009021] Calibrating delay loop (skipped) preset value.. 5187.98 BogoMIPS (lpj=2593992)
[    0.010010] pid_max: default: 32768 minimum: 301
[    0.012187] Security Framework initialized
[    0.012702] Yama: becoming mindful.
[    0.013160] AppArmor: AppArmor disabled by boot time parameter
[    0.015824] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.018112] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.019182] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.019975] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.023447] CPU: Physical Processor ID: 0
[    0.023935] mce: CPU supports 10 MCE banks
[    0.024138] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.025011] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.025645] Spectre V2 : Mitigation: Full generic retpoline
[    0.026010] Spectre V2 : Spectre v2 mitigation: Filling RSB on context switch
[    0.034858] debug: unmapping init [mem 0xffffffffa5f9d000-0xffffffffa5fa1fff]
[    0.037307] Using local APIC timer interrupts.
[    0.037307] calibrating APIC timer ...
[    0.039000] ... lapic delta = 7124622
[    0.039000] ... PM-Timer delta = 408037
[    0.039000] APIC calibration not consistent with PM-Timer: 113ms instead of 100ms
[    0.039000] APIC delta adjusted to PM-Timer: 6250136 (7124622)
[    0.039000] TSC delta adjusted to PM-Timer: 259397263 (295690735)
[    0.039000] ..... delta 6250136
[    0.039000] ..... mult: 268441297
[    0.039000] ..... calibration result: 1000021
[    0.039000] ..... CPU clock speed is 2593.0972 MHz.
[    0.039000] ..... host bus clock speed is 1000.0021 MHz.
[    0.040090] smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)
[    0.042916] Performance Events: PMU not available due to virtualization, using software events only.
[    0.045568] Hierarchical SRCU implementation.
[    0.048391] smp: Bringing up secondary CPUs ...
[    0.048919] smp: Brought up 1 node, 1 CPU
[    0.049010] smpboot: Max logical packages: 1
[    0.049501] smpboot: Total of 1 processors activated (5187.98 BogoMIPS)
[    0.054881] BUG: sleeping function called from invalid context at include/linux/percpu-rwsem.h:34
[    0.055015] in_atomic(): 1, irqs_disabled(): 0, pid: 1, name: swapper/0
[    0.055749] INFO: lockdep is turned off.
[    0.056015] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G    B            4.16.0-rc2-00103-gdf2af62 #1
[    0.057000] Call Trace:
[    0.057000]  dump_stack+0x14b/0x22d
[    0.057000]  ? arch_local_irq_restore+0x16/0x16
[    0.057000]  ___might_sleep+0x335/0x382
[    0.057000]  ? in_sched_functions+0x54/0x54
[    0.057000]  ? page_alloc_init_late+0x8f/0x3b6
[    0.057000]  ? lock_contended+0x578/0x578
[    0.057000]  __might_sleep+0x190/0x1a3
[    0.057000]  cpus_read_lock+0x28/0xc0
[    0.057000]  static_key_disable+0x11/0x36
[    0.057000]  page_alloc_init_late+0xa2/0x3b6
[    0.057000]  ? setup_nr_node_ids+0x57/0x57
[    0.057000]  ? __bitmap_weight+0xab/0xb8
[    0.057000]  kernel_init_freeable+0x28b/0x69d
[    0.057000]  ? __clear_rsb+0x15/0x3d
[    0.057000]  ? rest_init+0x156/0x156
[    0.057000]  ? rest_init+0x156/0x156
[    0.057000]  kernel_init+0xe/0x1b3
[    0.057000]  ? rest_init+0x156/0x156
[    0.057000]  ret_from_fork+0x35/0x40
[    0.058382] node 0 initialised, 0 pages in 0ms
[    0.059079] pgdatinit0 (12) used greatest stack depth: 30272 bytes left
[    0.061285] devtmpfs: initialized
[    0.066273] gcov: version magic: 0x4137332a
[    0.094475] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[    0.095155] futex hash table entries: 256 (order: 3, 32768 bytes)
[    0.104040] NET: Registered protocol family 16
[    0.109641] audit: initializing netlink subsys (disabled)
[    0.114096] cpuidle: using governor menu
[    0.117157] ACPI: bus type PCI registered
[    0.118569] PCI: Using configuration type 1 for base access
[    0.120449] audit: type=2000 audit(1519774283.546:1): state=initialized audit_enabled=0 res=1
[    0.234918] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.237759] cryptd: max_cpu_qlen set to 1000
[    0.240431] ACPI: Added _OSI(Module Device)
[    0.240918] ACPI: Added _OSI(Processor Device)
[    0.241012] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.241547] ACPI: Added _OSI(Processor Aggregator Device)
[    0.287077] ACPI: Interpreter enabled
[    0.287864] ACPI: (supports S0 S3 S5)
[    0.288013] ACPI: Using IOAPIC for interrupt routing
[    0.289315] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.296964] ACPI: Enabled 2 GPEs in block 00 to 0F
[    0.513386] swapper/0 invoked oom-killer: gfp_mask=0x14002c0(GFP_KERNEL|__GFP_NOWARN), nodemask=(null), order=2, oom_score_adj=0
[    0.514014] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G    B   W        4.16.0-rc2-00103-gdf2af62 #1
[    0.514979] Call Trace:
[    0.515000]  dump_stack+0x14b/0x22d
[    0.515000]  ? arch_local_irq_restore+0x16/0x16
[    0.515000]  dump_header+0x1bf/0x7f4
[    0.515000]  ? global_node_page_state+0xfd/0xfd
[    0.515000]  ? lock_release+0x769/0x7b1
[    0.515000]  ? rcu_read_unlock+0x43/0x43
[    0.515000]  ? rcu_read_lock+0x51/0x51
[    0.515000]  ? reacquire_held_locks+0x1a5/0x1a5
[    0.515000]  ? lock_acquire+0xf1/0x15b
[    0.515000]  ? mark_oom_victim+0x15e/0x15e
[    0.515000]  ? lock_acquire+0x148/0x15b
[    0.515000]  out_of_memory+0xdf2/0xeee
[    0.515000]  ? cpumask_next+0x53/0x5d
[    0.515000]  ? unregister_oom_notifier+0x1e/0x1e
[    0.515000]  ? lock_acquire+0xf1/0x15b
[    0.515000]  ? lock_acquire+0x148/0x15b
[    0.515000]  __alloc_pages_slowpath+0x130e/0x184d
[    0.515000]  ? __alloc_pages_cpuset_fallback+0x4f/0x4f
[    0.515000]  ? stack_access_ok+0x16/0x76
[    0.515000]  ? deref_stack_reg+0xc2/0x158
[    0.515000]  ? stack_access_ok+0x16/0x76
[    0.515000]  ? __free_pages+0x43/0x43
[    0.515000]  ? deref_stack_reg+0xc2/0x158
[    0.515000]  ? stack_access_ok+0x16/0x76
[    0.515000]  ? stack_access_ok+0x16/0x76
[    0.515000]  ? deref_stack_reg+0xc2/0x158
[    0.515000]  ? in_sched_functions+0x54/0x54
[    0.515000]  ? fs_reclaim_release+0x10/0x37
[    0.515000]  ? __might_sleep+0x190/0x1a3
[    0.515000]  __alloc_pages_nodemask+0x50b/0x586
[    0.515000]  ? __alloc_pages_slowpath+0x184d/0x184d
[    0.515000]  ? ret_from_fork+0x34/0x40
[    0.515000]  ? ret_from_fork+0x34/0x40
[    0.515000]  ? unwind_next_frame+0x374/0x14f3
[    0.515000]  __alloc_pages+0xe/0x16
[    0.515000]  alloc_page_interleave+0x12/0x12d
[    0.515000]  alloc_pages_current+0x9d/0xf6
[    0.515000]  depot_save_stack+0x1c8/0x484
[    0.515000]  save_stack+0x100/0x110
[    0.515000]  ? save_stack+0x37/0x110
[    0.515000]  ? set_track+0x23/0x2f
[    0.515000]  ? kasan_kmalloc+0xa9/0xbb
[    0.515000]  ? __kmalloc+0x18e/0x1bc
[    0.515000]  ? acpi_os_allocate_zeroed+0x4c/0x5b
[    0.515000]  ? acpi_ut_execute_CID+0x237/0x4c8
[    0.515000]  ? acpi_get_object_info+0x3f8/0xc8c
[    0.515000]  ? acpi_init_device_object+0x7c2/0x1678
[    0.515000]  ? acpi_add_single_object+0x24c/0x156c
[    0.515000]  ? acpi_bus_check_add+0x549/0x864
[    0.515000]  ? acpi_ns_walk_namespace+0x1a4/0x35b
[    0.515000]  ? acpi_walk_namespace+0xd5/0x112
[    0.515000]  ? acpi_bus_scan+0xc5/0x14a
[    0.515000]  ? acpi_scan_init+0x49e/0xc57
[    0.515000]  ? acpi_init+0xc2f/0xdc6
[    0.515000]  ? do_one_initcall+0x1d2/0x472
[    0.515000]  ? kernel_init_freeable+0x4c4/0x69d
[    0.515000]  ? kernel_init+0xe/0x1b3
[    0.515000]  ? ret_from_fork+0x35/0x40
[    0.515000]  ? acpi_ns_check_object_type+0x3ee/0x63c
[    0.515000]  ? acpi_ns_parse_table+0xaf/0xaf
[    0.515000]  ? _raw_spin_unlock_irqrestore+0x4e/0x6d
[    0.515000]  ? down_timeout+0x8f/0x8f
[    0.515000]  ? ___might_sleep+0xbf/0x382
[    0.515000]  ? in_sched_functions+0x54/0x54
[    0.515000]  ? kasan_poison_shadow+0x32/0x3a
[    0.515000]  ? set_track+0x23/0x2f
[    0.515000]  ? kasan_poison_shadow+0x32/0x3a
[    0.515000]  set_track+0x23/0x2f
[    0.515000]  kasan_kmalloc+0xa9/0xbb
[    0.515000]  __kmalloc+0x18e/0x1bc
[    0.515000]  acpi_os_allocate_zeroed+0x4c/0x5b
[    0.515000]  acpi_ut_execute_CID+0x237/0x4c8
[    0.515000]  ? acpi_ut_execute_UID+0x304/0x304
[    0.515000]  acpi_get_object_info+0x3f8/0xc8c
[    0.515000]  ? acpi_get_name+0xc1/0xc1
[    0.515000]  ? _raw_spin_unlock_irqrestore+0x4e/0x6d
[    0.515000]  ? up+0x14d/0x188
[    0.515000]  ? down_timeout+0x8f/0x8f
[    0.515000]  ? acpi_ut_repair_name+0xa0/0x163
[    0.515000]  ? acpi_os_signal_semaphore+0x3f/0x4f
[    0.515000]  ? acpi_ut_release_mutex+0xdc/0xeb
[    0.515000]  acpi_init_device_object+0x7c2/0x1678
[    0.515000]  ? acpi_dma_deconfigure+0x8/0x8
[    0.515000]  ? depot_save_stack+0x17c/0x484
[    0.515000]  ? save_stack+0x100/0x110
[    0.515000]  ? save_stack+0x37/0x110
[    0.515000]  ? set_track+0x23/0x2f
[    0.515000]  ? kasan_kmalloc+0xa9/0xbb
[    0.515000]  ? acpi_add_single_object+0x203/0x156c
[    0.515000]  ? acpi_ns_walk_namespace+0x1a4/0x35b
[    0.515000]  ? acpi_walk_namespace+0xd5/0x112
[    0.515000]  ? acpi_bus_scan+0xc5/0x14a
[    0.515000]  ? acpi_scan_init+0x49e/0xc57
[    0.515000]  ? acpi_init+0xc2f/0xdc6
[    0.515000]  ? do_one_initcall+0x1d2/0x472
[    0.515000]  ? kernel_init_freeable+0x4c4/0x69d
[    0.515000]  ? ret_from_fork+0x35/0x40
[    0.515000]  ? lock_acquire+0x148/0x15b
[    0.515000]  ? do_raw_spin_trylock+0x19b/0x19b
[    0.515000]  ? cache_grow_end+0xa6/0xb5
[    0.515000]  ? reacquire_held_locks+0x1a5/0x1a5
[    0.515000]  ? do_raw_spin_lock+0x1b3/0x1b3
[    0.515000]  ? __list_add+0x19/0x40
[    0.515000]  ? kasan_poison_shadow+0x32/0x3a
[    0.515000]  ? kasan_poison_shadow+0x32/0x3a
[    0.515000]  ? set_track+0x23/0x2f
[    0.515000]  ? kasan_kmalloc+0xa9/0xbb
[    0.515000]  ? kasan_poison_shadow+0x32/0x3a
[    0.515000]  ? set_track+0x23/0x2f
[    0.515000]  acpi_add_single_object+0x24c/0x156c
[    0.515000]  ? do_raw_spin_trylock+0x19b/0x19b
[    0.515000]  ? acpi_device_add_finalize+0x57/0x57
[    0.515000]  ? reacquire_held_locks+0x1a5/0x1a5
[    0.515000]  ? do_raw_spin_lock+0x1b3/0x1b3
[    0.515000]  ? lock_acquire+0x148/0x15b
[    0.515000]  ? _raw_spin_unlock_irqrestore+0x4e/0x6d
[    0.515000]  ? up+0x14d/0x188
[    0.515000]  ? down_timeout+0x8f/0x8f
[    0.515000]  ? _raw_spin_unlock_irqrestore+0x4e/0x6d
[    0.515000]  ? down_timeout+0x7e/0x8f
[    0.515000]  ? acpi_os_signal_semaphore+0x3f/0x4f
[    0.515000]  acpi_bus_check_add+0x549/0x864
[    0.515000]  ? acpi_add_single_object+0x156c/0x156c
[    0.515000]  ? do_raw_spin_trylock+0x19b/0x19b
[    0.515000]  ? up+0x14d/0x188
[    0.515000]  ? reacquire_held_locks+0x1a5/0x1a5
[    0.515000]  ? do_raw_spin_lock+0x1b3/0x1b3
[    0.515000]  ? lock_acquire+0x148/0x15b
[    0.515000]  ? _raw_spin_unlock_irqrestore+0x4e/0x6d
[    0.515000]  ? up+0x14d/0x188
[    0.515000]  ? down_timeout+0x7e/0x8f
[    0.515000]  acpi_ns_walk_namespace+0x1a4/0x35b
[    0.515000]  ? acpi_add_single_object+0x156c/0x156c
[    0.515000]  ? acpi_add_single_object+0x156c/0x156c
[    0.515000]  acpi_walk_namespace+0xd5/0x112
[    0.515000]  acpi_bus_scan+0xc5/0x14a
[    0.515000]  ? acpi_walk_dep_device_list+0x217/0x217
[    0.515000]  acpi_scan_init+0x49e/0xc57
[    0.515000]  ? acpi_match_madt+0x167/0x167
[    0.515000]  ? kernfs_add_one+0x33b/0x37d
[    0.515000]  ? refcount_inc+0x59/0x59
[    0.515000]  ? sysfs_add_file_mode_ns+0x31a/0x450
[    0.515000]  ? refcount_dec_and_test+0x14/0x1c
[    0.515000]  ? kobject_put+0xb3/0x236
[    0.515000]  ? bus_put+0x46/0x50
[    0.515000]  acpi_init+0xc2f/0xdc6
[    0.515000]  ? acpi_sleep_proc_init+0x91/0x91
[    0.515000]  ? add_device_randomness+0x14f/0x191
[    0.515000]  ? reacquire_held_locks+0x1a5/0x1a5
[    0.515000]  ? do_raw_spin_lock+0x1b3/0x1b3
[    0.515000]  ? add_device_randomness+0x14f/0x191
[    0.515000]  ? urandom_read+0x2f4/0x2f4
[    0.515000]  ? __class_create+0x13d/0x176
[    0.515000]  ? acpi_sleep_proc_init+0x91/0x91
[    0.515000]  do_one_initcall+0x1d2/0x472
[    0.515000]  ? start_kernel+0xe00/0xe00
[    0.515000]  ? up_write+0x78/0x172
[    0.515000]  ? up_read+0x3d/0x3d
[    0.515000]  ? lock_acquire+0x148/0x15b
[    0.515000]  kernel_init_freeable+0x4c4/0x69d
[    0.515000]  ? rest_init+0x156/0x156
[    0.515000]  kernel_init+0xe/0x1b3
[    0.515000]  ? rest_init+0x156/0x156
[    0.515000]  ret_from_fork+0x35/0x40
[    0.515023] Mem-Info:
[    0.515317] active_anon:0 inactive_anon:0 isolated_anon:0
[    0.515317]  active_file:0 inactive_file:0 isolated_file:0
[    0.515317]  unevictable:0 dirty:0 writeback:0 unstable:0
[    0.515317]  slab_reclaimable:40 slab_unreclaimable:832
[    0.515317]  mapped:0 shmem:0 pagetables:0 bounce:0
[    0.515317]  free:81 free_pcp:0 free_cma:0
[    0.516019] Node 0 active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:0kB dirty:0kB writeback:0kB shmem:0kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[    0.517012] Node 0 DMA free:324kB min:316kB low:392kB high:468kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:6332kB mlocked:0kB kernel_stack:672kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[    0.518009] lowmem_reserve[]: 0 0 0 0
[    0.519009] Node 0 DMA32 free:0kB min:0kB low:0kB high:0kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:413568kB managed:0kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[    0.520011] lowmem_reserve[]: 0 0 0 0
[    0.521010] Node 0 DMA: 4*4kB (E) 2*8kB (ME) 2*16kB (ME) 2*32kB (UM) 1*64kB (U) 1*128kB (U) 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 320kB
[    0.522010] Node 0 DMA32: 0*4kB 0*8kB 0*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 0kB
[    0.523014] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
[    0.524010] 0 total pagecache pages
[    0.525042] 107390 pages RAM
[    0.525367] 0 pages HighMem/MovableOnly
[    0.525800] 105807 pages reserved
[    0.526011] Unreclaimable slab info:
[    0.526421] Name                      Used          Total
[    0.527016] dmaengine-unmap-256          2KB          2KB
[    0.527634] dmaengine-unmap-128          3KB          3KB
[    0.528011] dmaengine-unmap-16          4KB          4KB
[    0.529011] dmaengine-unmap-2          1KB          3KB
[    0.529603] audit_buffer               0KB          3KB
[    0.530011] skbuff_head_cache          3KB          3KB
[    0.530556] shmem_inode_cache          2KB          2KB
[    0.531013] kernfs_node_cache        494KB        494KB
[    0.532010] mnt_cache                  7KB          7KB
[    0.532584] names_cache               12KB         12KB
[    0.533012] nsproxy                    1KB          3KB
[    0.533608] fs_cache                   4KB          4KB
[    0.534011] files_cache                3KB          3KB
[    0.535018] signal_cache              34KB         34KB
[    0.535600] sighand_cache             48KB         48KB
[    0.536011] task_struct              173KB        173KB
[    0.536609] cred_jar                   7KB          7KB
[    0.537012] pid                        4KB          4KB
[    0.538011] Acpi-Operand              59KB         59KB
[    0.538601] Acpi-ParseExt              7KB          7KB
[    0.539012] Acpi-Parse                27KB         27KB
[    0.539562] Acpi-State                47KB         47KB
[    0.540010] Acpi-Namespace            18KB         19KB
[    0.540564] numa_policy                3KB          3KB
[    0.541011] pool_workqueue             4KB          4KB
[    0.542017] page->ptl                  1KB          3KB
[    0.542627] kmalloc-16384             16KB         16KB
[    0.543011] kmalloc-4096             425KB        425KB
[    0.543599] kmalloc-2048             163KB        163KB
[    0.544011] kmalloc-1024             168KB        168KB
[    0.545011] kmalloc-512               45KB         45KB
[    0.545597] kmalloc-256              101KB        101KB
[    0.546011] kmalloc-128               27KB         27KB
[    0.546596] kmalloc-96               180KB        180KB
[    0.547011] kmalloc-64                36KB         36KB
[    0.548011] kmalloc-32               295KB        295KB
[    0.548600] kmalloc-192               44KB         44KB
[    0.549583] kmem_cache                24KB         24KB
[    0.550011] [ pid ]   uid  tgid total_vm      rss pgtables_bytes swapents oom_score_adj name
[    0.551022] Kernel panic - not syncing: Out of memory and no killable processes...
[    0.551022] 
[    0.551992] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G    B   W        4.16.0-rc2-00103-gdf2af62 #1
[    0.552000] Call Trace:
[    0.552000]  dump_stack+0x14b/0x22d
[    0.552000]  ? arch_local_irq_restore+0x16/0x16
[    0.552000]  panic+0x207/0x435
[    0.552000]  ? refcount_error_report+0x231/0x231
[    0.552000]  ? reacquire_held_locks+0x1a5/0x1a5
[    0.552000]  out_of_memory+0xe0a/0xeee
[    0.552000]  ? cpumask_next+0x53/0x5d
[    0.552000]  ? unregister_oom_notifier+0x1e/0x1e
[    0.552000]  ? lock_acquire+0xf1/0x15b
[    0.552000]  ? lock_acquire+0x148/0x15b
[    0.552000]  __alloc_pages_slowpath+0x130e/0x184d
[    0.552000]  ? __alloc_pages_cpuset_fallback+0x4f/0x4f
[    0.552000]  ? stack_access_ok+0x16/0x76
[    0.552000]  ? deref_stack_reg+0xc2/0x158
[    0.552000]  ? stack_access_ok+0x16/0x76
[    0.552000]  ? __free_pages+0x43/0x43
[    0.552000]  ? deref_stack_reg+0xc2/0x158
[    0.552000]  ? stack_access_ok+0x16/0x76
[    0.552000]  ? stack_access_ok+0x16/0x76
[    0.552000]  ? deref_stack_reg+0xc2/0x158
[    0.552000]  ? in_sched_functions+0x54/0x54
[    0.552000]  ? fs_reclaim_release+0x10/0x37
[    0.552000]  ? __might_sleep+0x190/0x1a3
[    0.552000]  __alloc_pages_nodemask+0x50b/0x586
[    0.552000]  ? __alloc_pages_slowpath+0x184d/0x184d
[    0.552000]  ? ret_from_fork+0x34/0x40
[    0.552000]  ? ret_from_fork+0x34/0x40
[    0.552000]  ? unwind_next_frame+0x374/0x14f3
[    0.552000]  __alloc_pages+0xe/0x16
[    0.552000]  alloc_page_interleave+0x12/0x12d
[    0.552000]  alloc_pages_current+0x9d/0xf6
[    0.552000]  depot_save_stack+0x1c8/0x484
[    0.552000]  save_stack+0x100/0x110
[    0.552000]  ? save_stack+0x37/0x110
[    0.552000]  ? set_track+0x23/0x2f
[    0.552000]  ? kasan_kmalloc+0xa9/0xbb
[    0.552000]  ? __kmalloc+0x18e/0x1bc
[    0.552000]  ? acpi_os_allocate_zeroed+0x4c/0x5b
[    0.552000]  ? acpi_ut_execute_CID+0x237/0x4c8
[    0.552000]  ? acpi_get_object_info+0x3f8/0xc8c
[    0.552000]  ? acpi_init_device_object+0x7c2/0x1678
[    0.552000]  ? acpi_add_single_object+0x24c/0x156c
[    0.552000]  ? acpi_bus_check_add+0x549/0x864
[    0.552000]  ? acpi_ns_walk_namespace+0x1a4/0x35b
[    0.552000]  ? acpi_walk_namespace+0xd5/0x112
[    0.552000]  ? acpi_bus_scan+0xc5/0x14a
[    0.552000]  ? acpi_scan_init+0x49e/0xc57
[    0.552000]  ? acpi_init+0xc2f/0xdc6
[    0.552000]  ? do_one_initcall+0x1d2/0x472
[    0.552000]  ? kernel_init_freeable+0x4c4/0x69d
[    0.552000]  ? kernel_init+0xe/0x1b3
[    0.552000]  ? ret_from_fork+0x35/0x40
[    0.552000]  ? acpi_ns_check_object_type+0x3ee/0x63c
[    0.552000]  ? acpi_ns_parse_table+0xaf/0xaf
[    0.552000]  ? _raw_spin_unlock_irqrestore+0x4e/0x6d
[    0.552000]  ? down_timeout+0x8f/0x8f
[    0.552000]  ? ___might_sleep+0xbf/0x382
[    0.552000]  ? in_sched_functions+0x54/0x54
[    0.552000]  ? kasan_poison_shadow+0x32/0x3a
[    0.552000]  ? set_track+0x23/0x2f
[    0.552000]  ? kasan_poison_shadow+0x32/0x3a
[    0.552000]  set_track+0x23/0x2f
[    0.552000]  kasan_kmalloc+0xa9/0xbb
[    0.552000]  __kmalloc+0x18e/0x1bc
[    0.552000]  acpi_os_allocate_zeroed+0x4c/0x5b
[    0.552000]  acpi_ut_execute_CID+0x237/0x4c8
[    0.552000]  ? acpi_ut_execute_UID+0x304/0x304
[    0.552000]  acpi_get_object_info+0x3f8/0xc8c
[    0.552000]  ? acpi_get_name+0xc1/0xc1
[    0.552000]  ? _raw_spin_unlock_irqrestore+0x4e/0x6d
[    0.552000]  ? up+0x14d/0x188
[    0.552000]  ? down_timeout+0x8f/0x8f
[    0.552000]  ? acpi_ut_repair_name+0xa0/0x163
[    0.552000]  ? acpi_os_signal_semaphore+0x3f/0x4f
[    0.552000]  ? acpi_ut_release_mutex+0xdc/0xeb
[    0.552000]  acpi_init_device_object+0x7c2/0x1678
[    0.552000]  ? acpi_dma_deconfigure+0x8/0x8
[    0.552000]  ? depot_save_stack+0x17c/0x484
[    0.552000]  ? save_stack+0x100/0x110
[    0.552000]  ? save_stack+0x37/0x110
[    0.552000]  ? set_track+0x23/0x2f
[    0.552000]  ? kasan_kmalloc+0xa9/0xbb
[    0.552000]  ? acpi_add_single_object+0x203/0x156c
[    0.552000]  ? acpi_ns_walk_namespace+0x1a4/0x35b
[    0.552000]  ? acpi_walk_namespace+0xd5/0x112
[    0.552000]  ? acpi_bus_scan+0xc5/0x14a
[    0.552000]  ? acpi_scan_init+0x49e/0xc57
[    0.552000]  ? acpi_init+0xc2f/0xdc6
[    0.552000]  ? do_one_initcall+0x1d2/0x472
[    0.552000]  ? kernel_init_freeable+0x4c4/0x69d
[    0.552000]  ? ret_from_fork+0x35/0x40
[    0.552000]  ? lock_acquire+0x148/0x15b
[    0.552000]  ? do_raw_spin_trylock+0x19b/0x19b
[    0.552000]  ? cache_grow_end+0xa6/0xb5
[    0.552000]  ? reacquire_held_locks+0x1a5/0x1a5
[    0.552000]  ? do_raw_spin_lock+0x1b3/0x1b3
[    0.552000]  ? __list_add+0x19/0x40
[    0.552000]  ? kasan_poison_shadow+0x32/0x3a
[    0.552000]  ? kasan_poison_shadow+0x32/0x3a
[    0.552000]  ? set_track+0x23/0x2f
[    0.552000]  ? kasan_kmalloc+0xa9/0xbb
[    0.552000]  ? kasan_poison_shadow+0x32/0x3a
[    0.552000]  ? set_track+0x23/0x2f
[    0.552000]  acpi_add_single_object+0x24c/0x156c
[    0.552000]  ? do_raw_spin_trylock+0x19b/0x19b
[    0.552000]  ? acpi_device_add_finalize+0x57/0x57
[    0.552000]  ? reacquire_held_locks+0x1a5/0x1a5
[    0.552000]  ? do_raw_spin_lock+0x1b3/0x1b3
[    0.552000]  ? lock_acquire+0x148/0x15b
[    0.552000]  ? _raw_spin_unlock_irqrestore+0x4e/0x6d
[    0.552000]  ? up+0x14d/0x188
[    0.552000]  ? down_timeout+0x8f/0x8f
[    0.552000]  ? _raw_spin_unlock_irqrestore+0x4e/0x6d
[    0.552000]  ? down_timeout+0x7e/0x8f
[    0.552000]  ? acpi_os_signal_semaphore+0x3f/0x4f
[    0.552000]  acpi_bus_check_add+0x549/0x864
[    0.552000]  ? acpi_add_single_object+0x156c/0x156c
[    0.552000]  ? do_raw_spin_trylock+0x19b/0x19b
[    0.552000]  ? up+0x14d/0x188
[    0.552000]  ? reacquire_held_locks+0x1a5/0x1a5
[    0.552000]  ? do_raw_spin_lock+0x1b3/0x1b3
[    0.552000]  ? lock_acquire+0x148/0x15b
[    0.552000]  ? _raw_spin_unlock_irqrestore+0x4e/0x6d
[    0.552000]  ? up+0x14d/0x188
[    0.552000]  ? down_timeout+0x7e/0x8f
[    0.552000]  acpi_ns_walk_namespace+0x1a4/0x35b
[    0.552000]  ? acpi_add_single_object+0x156c/0x156c
[    0.552000]  ? acpi_add_single_object+0x156c/0x156c
[    0.552000]  acpi_walk_namespace+0xd5/0x112
[    0.552000]  acpi_bus_scan+0xc5/0x14a
[    0.552000]  ? acpi_walk_dep_device_list+0x217/0x217
[    0.552000]  acpi_scan_init+0x49e/0xc57
[    0.552000]  ? acpi_match_madt+0x167/0x167
[    0.552000]  ? kernfs_add_one+0x33b/0x37d
[    0.552000]  ? refcount_inc+0x59/0x59
[    0.552000]  ? sysfs_add_file_mode_ns+0x31a/0x450
[    0.552000]  ? refcount_dec_and_test+0x14/0x1c
[    0.552000]  ? kobject_put+0xb3/0x236
[    0.552000]  ? bus_put+0x46/0x50
[    0.552000]  acpi_init+0xc2f/0xdc6
[    0.552000]  ? acpi_sleep_proc_init+0x91/0x91
[    0.552000]  ? add_device_randomness+0x14f/0x191
[    0.552000]  ? reacquire_held_locks+0x1a5/0x1a5
[    0.552000]  ? do_raw_spin_lock+0x1b3/0x1b3
[    0.552000]  ? add_device_randomness+0x14f/0x191
[    0.552000]  ? urandom_read+0x2f4/0x2f4
[    0.552000]  ? __class_create+0x13d/0x176
[    0.552000]  ? acpi_sleep_proc_init+0x91/0x91
[    0.552000]  do_one_initcall+0x1d2/0x472
[    0.552000]  ? start_kernel+0xe00/0xe00
[    0.552000]  ? up_write+0x78/0x172
[    0.552000]  ? up_read+0x3d/0x3d
[    0.552000]  ? lock_acquire+0x148/0x15b
[    0.552000]  kernel_init_freeable+0x4c4/0x69d
[    0.552000]  ? rest_init+0x156/0x156
[    0.552000]  kernel_init+0xe/0x1b3
[    0.552000]  ? rest_init+0x156/0x156
[    0.552000]  ret_from_fork+0x35/0x40

Elapsed time: 10

#!/bin/bash

# To reproduce,
# 1) save job-script and this script (both are attached in 0day report email)
# 2) run this script with your compiled kernel and optional env $INSTALL_MOD_PATH

kernel=$1

initrds=(
	/osimage/openwrt/openwrt-i386-2016-03-16.cgz
	/lkp/lkp/lkp-i386.cgz
)

HTTP_PREFIX=https://github.com/0day-ci/lkp-qemu/raw/master
wget --timestamping "${initrds[@]/#/$HTTP_PREFIX}"

{
	cat "${initrds[@]//*\//}"
	[[ $INSTALL_MOD_PATH ]] && (
		cd "$INSTALL_MOD_PATH"
		find lib | cpio -o -H newc --quiet | gzip
	)
	echo  job-script | cpio -o -H newc --quiet | gzip
} > initrd.img

kvm=(
	qemu-system-x86_64
	-enable-kvm
	-kernel $kernel
	-initrd initrd.img
	-m 420
	-smp 1
	-device e1000,netdev=net0
	-netdev user,id=net0
	-boot order=nc
	-no-reboot
	-watchdog i6300esb
	-watchdog-action debug
	-rtc base=localtime
	-serial stdio
	-display none
	-monitor null
)

append=(
	ip=::::vm-lkp-hsw01-openwrt-ia32-18::dhcp
	root=/dev/ram0
	user=lkp
	job=/job-script
	ARCH=x86_64
	kconfig=x86_64-randconfig-s4-02180035
	branch=linus/master
	commit=df2af627c79ad4273b4b4c49711252c084490fd2
	BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s4-02180035/gcc-7/df2af627c79ad4273b4b4c49711252c084490fd2/vmlinuz-4.16.0-rc2-00103-gdf2af62
	max_uptime=600
	RESULT_ROOT=/result/boot/1/vm-lkp-hsw01-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-s4-02180035/gcc-7/df2af627c79ad4273b4b4c49711252c084490fd2/0
	result_service=tmpfs
	debug
	apic=debug
	sysrq_always_enabled
	rcupdate.rcu_cpu_stall_timeout=100
	net.ifnames=0
	printk.devkmsg=on
	panic=-1
	softlockup_panic=1
	nmi_watchdog=panic
	oops=panic
	load_ramdisk=2
	prompt_ramdisk=0
	drbd.minor_count=8
	systemd.log_level=err
	ignore_loglevel
	console=tty0
	earlyprintk=ttyS0,115200
	console=ttyS0,115200
	vga=normal
	rw
	drbd.minor_count=8
	rcuperf.shutdown=0
)

"${kvm[@]}" -append "${append[*]}"
