early console in setup code
[    0.000000] Linux version 4.20.0-rc1-00144-g30f3312 (kbuild@lkp-hsx03) (gcc version 4.9.4 (Debian 4.9.4-2)) #1 Wed Feb 13 00:17:10 CST 2019
[    0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[    0.000000] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[    0.000000] 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-0x000000003ffdbfff] usable
[    0.000000] BIOS-e820: [mem 0x000000003ffdc000-0x000000003fffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] printk: debug: ignoring loglevel setting.
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] Hypervisor detected: KVM
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000001] kvm-clock: cpu 0, msr 2bf5001, primary cpu clock
[    0.000001] kvm-clock: using sched offset of 552847977 cycles
[    0.000011] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000030] tsc: Detected 2593.992 MHz processor
[    0.002640] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.002653] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.002666] last_pfn = 0x3ffdc max_arch_pfn = 0x1000000
[    0.002709] MTRR default type: write-back
[    0.002716] MTRR fixed ranges enabled:
[    0.002723]   00000-9FFFF write-back
[    0.002730]   A0000-BFFFF uncachable
[    0.002737]   C0000-FFFFF write-protect
[    0.002743] MTRR variable ranges enabled:
[    0.002751]   0 base 0080000000 mask FF80000000 uncachable
[    0.002757]   1 disabled
[    0.002763]   2 disabled
[    0.002769]   3 disabled
[    0.002775]   4 disabled
[    0.002781]   5 disabled
[    0.002786]   6 disabled
[    0.002791]   7 disabled
[    0.002815] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
[    0.002846] initial memory mapped: [mem 0x00000000-0x03dfffff]
[    0.002857] Base memory trampoline at [(ptrval)] 9b000 size 16384
[    0.002949] BRK [0x03881000, 0x03881fff] PGTABLE
[    0.002971] BRK [0x03882000, 0x03882fff] PGTABLE
[    0.002980] RAMDISK: [mem 0x3fca5000-0x3ffcffff]
[    0.002987] Allocated new RAMDISK: [mem 0x372d3000-0x375fd83b]
[    0.004640] Move RAMDISK from [mem 0x3fca5000-0x3ffcf83b] to [mem 0x372d3000-0x375fd83b]
[    0.004650] ACPI: Early table checksum verification disabled
[    0.004752] ACPI: RSDP 0x00000000000F6860 000014 (v00 BOCHS )
[    0.004763] ACPI: RSDT 0x000000003FFE1936 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.004776] ACPI: FACP 0x000000003FFE180A 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.004789] ACPI: DSDT 0x000000003FFE0040 0017CA (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.004799] ACPI: FACS 0x000000003FFE0000 000040
[    0.004809] ACPI: APIC 0x000000003FFE187E 000080 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.004819] ACPI: HPET 0x000000003FFE18FE 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.004834] 137MB HIGHMEM available.
[    0.004841] 885MB LOWMEM available.
[    0.004847]   mapped low ram: 0 - 375fe000
[    0.004852]   low ram: 0 - 375fe000
[    0.004905] BRK [0x03883000, 0x03883fff] PGTABLE
[    0.004914] Zone ranges:
[    0.004921]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.004928]   Normal   [mem 0x0000000001000000-0x00000000375fdfff]
[    0.004935]   HighMem  [mem 0x00000000375fe000-0x000000003ffdbfff]
[    0.004942] Movable zone start for each node
[    0.004949] Early memory node ranges
[    0.004956]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.004962]   node   0: [mem 0x0000000000100000-0x000000003ffdbfff]
[    0.004970] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdbfff]
[    0.004979] On node 0 totalpages: 262010
[    0.007292]   DMA zone: 32 pages used for memmap
[    0.007303]   DMA zone: 0 pages reserved
[    0.007310]   DMA zone: 3998 pages, LIFO batch:0
[    0.007440]   Normal zone: 1740 pages used for memmap
[    0.007447]   Normal zone: 222718 pages, LIFO batch:63
[    0.013776]   HighMem zone: 35294 pages, LIFO batch:7
[    0.015223] ACPI: PM-Timer IO Port: 0x608
[    0.015234] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.015275] KVM setup async PF for cpu 0
[    0.015287] kvm-stealtime: cpu 0, msr 2724a00
[    0.015324] [mem 0x40000000-0xfeffbfff] available for PCI devices
[    0.015330] Booting paravirtualized kernel on KVM
[    0.015338] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[    0.015399] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[    0.015407] pcpu-alloc: [0] 0 
[    0.015435] Built 1 zonelists, mobility grouping on.  Total pages: 260238
[    0.015444] Kernel command line: ip=::::vm-snb-openwrt-ia32-22::dhcp root=/dev/ram0 user=lkp job=/lkp/jobs/scheduled/vm-snb-openwrt-ia32-22/boot-1-openwrt-i386-2016-03-16.cgz-30f33126feca0fe16df9e9-20190213-72162-5wnmju-1.yaml ARCH=i386 kconfig=i386-randconfig-a2-201905 branch=linus/master commit=30f33126feca0fe16df9e9302ffc28a953e2eb37 BOOT_IMAGE=/pkg/linux/i386-randconfig-a2-201905/gcc-4.9/30f33126feca0fe16df9e9302ffc28a953e2eb37/vmlinuz-4.20.0-rc1-00144-g30f3312 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-snb-openwrt-ia32/openwrt-i386-2016-03-16.cgz/i386-randconfig-a2-201905/gcc-4.9/30f33126feca0fe16df9e9302ffc28a953e2eb37/3 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=normal rw rcuperf.shutdown=0
[    0.016357] sysrq: sysrq always enabled.
[    0.017520] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.017598] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.017614] Initializing CPU#0
[    0.035816] Initializing HighMem for node 0 (000375fe:0003ffdc)
[    0.066418] Initializing Movable for node 0 (00000000:00000000)
[    0.072326] Memory: 928300K/1048040K available (16300K kernel code, 3762K rwdata, 7228K rodata, 1160K init, 12780K bss, 119740K reserved, 0K cma-reserved, 141176K highmem)
[    0.072340] virtual kernel memory layout:
[    0.072340]     fixmap  : 0xfffe4000 - 0xfffff000   ( 108 kB)
[    0.072340]   cpu_entry : 0xffa00000 - 0xffa27000   ( 156 kB)
[    0.072340]     pkmap   : 0xff600000 - 0xff800000   (2048 kB)
[    0.072340]     vmalloc : 0xf7dfe000 - 0xff5fe000   ( 120 MB)
[    0.072340]     lowmem  : 0xc0000000 - 0xf75fe000   ( 885 MB)
[    0.072340]       .init : 0xc2ac5000 - 0xc2be7000   (1160 kB)
[    0.072340]       .data : 0xc1feb174 - 0xc2aa9a80   (11002 kB)
[    0.072340]       .text : 0xc1000000 - 0xc1feb174   (16300 kB)
[    0.072351] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[    0.072398] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=0
[    0.073157] ftrace: allocating 59873 entries in 117 pages
[    0.100472] Running RCU self tests
[    0.105466] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.105797] CPU 0 irqstacks, hard=(ptrval) soft=(ptrval)
[    0.106018] random: get_random_u32 called from cache_random_seq_create+0x91/0x120 with crng_init=0
[    0.106054] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=0
[    0.232343] printk: console [ttyS0] enabled
[    0.232903] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.233962] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.234505] ... MAX_LOCK_DEPTH:          48
[    0.235045] ... MAX_LOCKDEP_KEYS:        8191
[    0.235629] ... CLASSHASH_SIZE:          4096
[    0.236209] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.236817] ... MAX_LOCKDEP_CHAINS:      65536
[    0.237357] ... CHAINHASH_SIZE:          32768
[    0.237857]  memory used by lock dependency info: 4623 kB
[    0.238460]  per task-struct memory footprint: 2112 bytes
[    0.239111] ACPI: Core revision 20181003
[    0.239865] ACPI: setting ELCR to 0200 (from 0c00)
[    0.240634] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.262021] hpet clockevent registered
[    0.262559] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x25641074d3b, max_idle_ns: 440795244898 ns
[    0.263975] Calibrating delay loop (skipped) preset value.. 5187.98 BogoMIPS (lpj=10375968)
[    0.265147] pid_max: default: 32768 minimum: 301
[    0.265891] LSM: Security Framework initializing
[    0.268046] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.268920] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.272594] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.273263] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.274013] CPU: Intel Xeon E312xx (Sandy Bridge) (family: 0x6, model: 0x2a, stepping: 0x1)
[    0.275080] Spectre V2 : Spectre mitigation: kernel not compiled with retpoline; no mitigation available!
[    0.275082] Speculative Store Bypass: Vulnerable
[    0.277661] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only.
[    0.280534] NMI watchdog: Perf NMI watchdog permanently disabled
[    0.281916] devtmpfs: initialized
[    0.288070] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.289386] futex hash table entries: 256 (order: 1, 13312 bytes)
[    0.290495] pinctrl core: initialized pinctrl subsystem
[    0.292079] regulator-dummy: Failed to create debugfs directory
[    0.293412] NET: Registered protocol family 16
[    0.297057] cpuidle: using governor ladder
[    0.299411] ACPI: bus type PCI registered
[    0.300346] PCI: PCI BIOS area is rw and x. Use pci=nobios if you want it NX.
[    0.301352] PCI: PCI BIOS revision 2.10 entry at 0xfd501, last bus=0
[    0.368173] workqueue: round-robin CPU selection forced, expect performance impact
[    0.369870] ACPI: Added _OSI(Module Device)
[    0.370416] ACPI: Added _OSI(Processor Device)
[    0.371055] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.371723] ACPI: Added _OSI(Processor Aggregator Device)
[    0.371993] ACPI: Added _OSI(Linux-Dell-Video)
[    0.372573] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    0.380011] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.387133] ACPI: Interpreter enabled
[    0.387716] ACPI: (supports S0 S5)
[    0.388004] ACPI: Using PIC for interrupt routing
[    0.388709] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.390690] ACPI: Enabled 3 GPEs in block 00 to 0F
[    0.413089] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.414016] acpi PNP0A03:00: _OSC: OS supports [Segments]
[    0.415016] PCI host bridge to bus 0000:00
[    0.415592] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.415991] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.416901] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.417823] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]
[    0.418789] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.420080] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.421912] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.424262] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    0.431991] pci 0000:00:01.1: reg 0x20: [io  0xc0c0-0xc0cf]
[    0.436634] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.437596] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.438437] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.439990] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.441615] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    0.443102] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[    0.444007] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[    0.445841] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[    0.449530] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[    0.458164] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[    0.469414] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    0.472919] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    0.475989] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[    0.479987] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    0.494228] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[    0.496831] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[    0.499990] pci 0000:00:04.0: reg 0x10: [io  0xc040-0xc07f]
[    0.505585] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[    0.517777] pci 0000:00:04.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
[    0.524638] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000
[    0.527992] pci 0000:00:05.0: reg 0x10: [io  0xc080-0xc0bf]
[    0.533786] pci 0000:00:05.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff]
[    0.547447] pci 0000:00:05.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref]
[    0.553327] pci 0000:00:06.0: [8086:25ab] type 00 class 0x088000
[    0.555388] pci 0000:00:06.0: reg 0x10: [mem 0xfebf3000-0xfebf300f]
[    0.565077] pci_bus 0000:00: on NUMA node 0
[    0.568009] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    0.570039] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    0.571276] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    0.572861] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    0.573792] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    0.576573] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[    0.577380] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    0.578388] pci 0000:00:02.0: vgaarb: bridge control possible
[    0.579158] vgaarb: loaded
[    0.580340] ACPI: bus type USB registered
[    0.580992] usbcore: registered new interface driver usbfs
[    0.581737] usbcore: registered new interface driver hub
[    0.582511] usbcore: registered new device driver usb
[    0.583386] videodev: Linux video capture interface: v2.00
[    0.584832] Advanced Linux Sound Architecture Driver Initialized.
[    0.585781] PCI: Using ACPI for IRQ routing
[    0.586361] PCI: pci_cache_line_size set to 64 bytes
[    0.587228] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.587994] e820: reserve RAM buffer [mem 0x3ffdc000-0x3fffffff]
[    0.589768] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.3)
[    0.590928] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.3)
[    0.593742] clocksource: Switched to clocksource kvm-clock
[    0.752180] Warning: could not register annotated branches stats
[    0.757249] FS-Cache: Loaded
[    0.757945] pnp: PnP ACPI init
[    0.758624] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.759672] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.760739] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    0.761715] pnp 00:03: [dma 2]
[    0.762329] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    0.763502] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    0.764649] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.765774] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.768054] pnp: PnP ACPI: found 7 devices
[    0.805962] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.807288] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    0.808144] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    0.808942] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    0.809829] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window]
[    0.814913] NET: Registered protocol family 2
[    0.815912] tcp_listen_portaddr_hash hash table entries: 512 (order: 2, 24576 bytes)
[    0.816911] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.822348] TCP bind hash table entries: 8192 (order: 6, 360448 bytes)
[    0.823511] TCP: Hash tables configured (established 8192 bind 8192)
[    0.824461] UDP hash table entries: 512 (order: 3, 49152 bytes)
[    0.825266] UDP-Lite hash table entries: 512 (order: 3, 49152 bytes)
[    0.830416] NET: Registered protocol family 1
[    0.831705] RPC: Registered named UNIX socket transport module.
[    0.832459] RPC: Registered udp transport module.
[    0.833028] RPC: Registered tcp transport module.
[    0.833621] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.838215] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.839025] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.839849] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.840700] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    0.846010] PCI: CLS 0 bytes, default 64
[    0.846899] Unpacking initramfs...
[    1.445944] random: fast init done
[    1.450559] kwatchdog (24) used greatest stack depth: 7356 bytes left
[    1.971713] Freeing initrd memory: 3244K
[    1.972330] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    1.986300] software IO TLB: mapped [mem 0x32a08000-0x36a08000] (64MB)
[    1.988669] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x25641074d3b, max_idle_ns: 440795244898 ns
[    1.990276] cryptomgr_test (26) used greatest stack depth: 7344 bytes left
[    1.990276] NatSemi SCx200 Driver
[    1.990276] spin_lock-torture:--- Start of test [debug]: nwriters_stress=2 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0
[    2.017847] spin_lock-torture: Creating torture_shuffle task
[    2.018779] spin_lock-torture: Creating torture_stutter task
[    2.019570] spin_lock-torture: torture_shuffle task started
[    2.020313] spin_lock-torture: Creating lock_torture_writer task
[    2.021154] spin_lock-torture: torture_stutter task started
[    2.021923] spin_lock-torture: Creating lock_torture_writer task
[    2.022761] spin_lock-torture: lock_torture_writer task started
[    2.023580] spin_lock-torture: Creating lock_torture_stats task
[    2.024396] spin_lock-torture: lock_torture_writer task started
[    2.025338] spin_lock-torture: lock_torture_stats task started
[    2.778171] _warn_unseeded_randomness: 80 callbacks suppressed
[    2.778180] random: get_random_u32 called from get_random_order+0x8d/0xc0 with crng_init=1
[    7.389669] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=1
[    7.401989] random: get_random_u32 called from stress_one_work+0x18/0xb0 with crng_init=1
[    9.704037] torture_init_begin: Refusing rcu init: spin_lock running.
[    9.704800] torture_init_begin: One torture test at a time!
[    9.705420] torture_init_begin: Refusing rcu init: spin_lock running.
[    9.706178] torture_init_begin: One torture test at a time!
[    9.709163] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=1
[    9.710947] Initialise system trusted keyrings
[    9.711530] random: get_random_bytes called from key_alloc+0x1f4/0x3f0 with crng_init=1
[    9.718009] workingset: timestamp_bits=30 max_order=18 bucket_order=0
[    9.718943] zbud: loaded
[    9.719402] random: get_random_u32 called from cache_random_seq_create+0x91/0x120 with crng_init=1
[    9.721523] NFS: Registering the id_resolver key type
[    9.722269] Key type id_resolver registered
[    9.722821] Key type id_legacy registered
[    9.723821] fuse init (API version 7.28)
[    9.749878] Key type asymmetric registered
[   10.065243] String selftests succeeded
[   10.065789] test_string_helpers: Running tests...
[   10.071016] test_hexdump: all 1184 tests passed
[   10.071613] 
[   10.071613] Start testing find_bit() with random-filled bitmap
[   10.076146] find_next_bit:                 2098394 ns, 163815 iterations
[   10.079264] find_next_zero_bit:            2236504 ns, 163866 iterations
[   10.081446] find_last_bit:                 1049743 ns, 163815 iterations
[   10.091260] find_first_bit:                8878431 ns,  16318 iterations
[   10.093350] find_next_and_bit:		2985876 cycles, 73560 iterations
[   10.106835] 
[   10.106835] Start testing find_bit() with sparse bitmap
[   10.107901] find_next_bit:                   31904 ns,    655 iterations
[   10.113426] find_next_zero_bit:            4552955 ns, 327026 iterations
[   10.124939] find_last_bit:                   25215 ns,    655 iterations
[   10.129295] find_first_bit:                3462197 ns,    655 iterations
[   10.130268] find_next_and_bit:		49987 cycles, 1 iterations
[   10.313991] IDA: 147321 of 147321 tests passed
[   10.315512] test_overflow: u8 : 18 arithmetic tests
[   10.316099] test_overflow: s8 : 19 arithmetic tests
[   10.316690] test_overflow: u16: 17 arithmetic tests
[   10.317272] test_overflow: s16: 17 arithmetic tests
[   10.322518] test_overflow: u32: 17 arithmetic tests
[   10.323108] test_overflow: s32: 17 arithmetic tests
[   10.323701] test_overflow: ok: (u8)(1 << 0) == 1 << 0
[   10.324303] test_overflow: ok: (u8)(1 << 4) == 1 << 4
[   10.324902] test_overflow: ok: (u8)(1 << 7) == 1 << 7
[   10.325493] test_overflow: ok: (u8)(0xF << 4) == 0xF << 4
[   10.326986] test_overflow: ok: (u16)(1 << 0) == 1 << 0
[   10.327591] test_overflow: ok: (u16)(1 << 10) == 1 << 10
[   10.328238] test_overflow: ok: (u16)(1 << 15) == 1 << 15
[   10.328896] test_overflow: ok: (u16)(0xFF << 8) == 0xFF << 8
[   10.329581] test_overflow: ok: (int)(1 << 0) == 1 << 0
[   10.330420] test_overflow: ok: (int)(1 << 16) == 1 << 16
[   10.331054] test_overflow: ok: (int)(1 << 30) == 1 << 30
[   10.331678] test_overflow: ok: (s32)(1 << 0) == 1 << 0
[   10.332278] test_overflow: ok: (s32)(1 << 16) == 1 << 16
[   10.332903] test_overflow: ok: (s32)(1 << 30) == 1 << 30
[   10.333528] test_overflow: ok: (unsigned int)(1 << 0) == 1U << 0
[   10.337092] test_overflow: ok: (unsigned int)(1 << 20) == 1U << 20
[   10.337819] test_overflow: ok: (unsigned int)(1 << 31) == 1U << 31
[   10.340759] test_overflow: ok: (unsigned int)(0xFFFFU << 16) == 0xFFFFU << 16
[   10.341587] test_overflow: ok: (u32)(1 << 0) == 1U << 0
[   10.342238] test_overflow: ok: (u32)(1 << 20) == 1U << 20
[   10.342889] test_overflow: ok: (u32)(1 << 31) == 1U << 31
[   10.343545] test_overflow: ok: (u32)(0xFFFFU << 16) == 0xFFFFU << 16
[   10.344304] test_overflow: ok: (u64)(1 << 0) == 1ULL << 0
[   10.344961] test_overflow: ok: (u64)(1 << 40) == 1ULL << 40
[   10.345633] test_overflow: ok: (u64)(1 << 63) == 1ULL << 63
[   10.346226] test_overflow: ok: (u64)(0xFFFFFFFFULL << 32) == 0xFFFFFFFFULL << 32
[   10.346226] test_overflow: ok: (u8)(0 << 7) == 0
[   10.346226] test_overflow: ok: (u16)(0 << 15) == 0
[   10.346226] test_overflow: ok: (unsigned int)(0 << 31) == 0
[   10.349068] test_overflow: ok: (u32)(0 << 31) == 0
[   10.349664] test_overflow: ok: (u64)(0 << 63) == 0
[   10.350283] test_overflow: ok: (s8)(0 << 6) == 0
[   10.350853] test_overflow: ok: (s16)(0 << 14) == 0
[   10.351440] test_overflow: ok: (int)(0 << 30) == 0
[   10.352021] test_overflow: ok: (s32)(0 << 30) == 0
[   10.352609] test_overflow: ok: (s64)(0 << 62) == 0
[   10.353190] test_overflow: ok: (u8)(1 << 8) == overflow
[   10.353830] test_overflow: ok: (u16)(1 << 16) == overflow
[   10.354526] test_overflow: ok: (unsigned int)(1 << 32) == overflow
[   10.355273] test_overflow: ok: (u32)(1 << 32) == overflow
[   10.355940] test_overflow: ok: (u64)(1 << 64) == overflow
[   10.356599] test_overflow: ok: (s8)(1 << 7) == overflow
[   10.357230] test_overflow: ok: (s16)(1 << 15) == overflow
[   10.357933] test_overflow: ok: (int)(1 << 31) == overflow
[   10.358594] test_overflow: ok: (s32)(1 << 31) == overflow
[   10.359247] test_overflow: ok: (s64)(1 << 63) == overflow
[   10.359926] test_overflow: ok: (u8)(150 << 1) == overflow
[   10.360614] test_overflow: ok: (u16)(34966 << 1) == overflow
[   10.361315] test_overflow: ok: (u32)(2215151766U << 1) == overflow
[   10.362145] test_overflow: ok: (unsigned int)(2215151766U << 1) == overflow
[   10.363020] test_overflow: ok: (u64)(9372061470395238550ULL << 1) == overflow
[   10.363904] test_overflow: ok: (s8)(75 << 1) == overflow
[   10.364584] test_overflow: ok: (s16)(17483 << 1) == overflow
[   10.365285] test_overflow: ok: (s32)(1107575883 << 1) == overflow
[   10.366100] test_overflow: ok: (int)(1107575883 << 1) == overflow
[   10.366871] test_overflow: ok: (s64)(4686030735197619275LL << 1) == overflow
[   10.367754] test_overflow: ok: (s8)(75 << 2) == overflow
[   10.368424] test_overflow: ok: (s16)(17483 << 2) == overflow
[   10.369130] test_overflow: ok: (s32)(1107575883 << 2) == overflow
[   10.369942] test_overflow: ok: (int)(1107575883 << 2) == overflow
[   10.370713] test_overflow: ok: (s64)(4686030735197619275LL << 2) == overflow
[   10.371599] test_overflow: ok: (u8)(0x100 << 0) == overflow
[   10.372296] test_overflow: ok: (s8)(0xFF << 0) == overflow
[   10.372998] test_overflow: ok: (u16)(0x10000U << 0) == overflow
[   10.373756] test_overflow: ok: (s16)(0xFFFFU << 0) == overflow
[   10.374535] test_overflow: ok: (u32)(0x100000000ULL << 0) == overflow
[   10.375335] test_overflow: ok: (unsigned int)(0x100000000ULL << 0) == overflow
[   10.376238] test_overflow: ok: (s32)(0xFFFFFFFFUL << 0) == overflow
[   10.377031] test_overflow: ok: (int)(0xFFFFFFFFUL << 0) == overflow
[   10.377835] test_overflow: ok: (s64)(0xFFFFFFFFFFFFFFFFULL << 0) == overflow
[   10.378756] test_overflow: ok: (s8)(-1 << 0) == overflow
[   10.379436] test_overflow: ok: (u8)(-1 << 0) == overflow
[   10.380105] test_overflow: ok: (s16)(-5 << 0) == overflow
[   10.380787] test_overflow: ok: (u16)(-5 << 0) == overflow
[   10.381473] test_overflow: ok: (int)(-10 << 0) == overflow
[   10.382207] test_overflow: ok: (unsigned int)(-10 << 0) == overflow
[   10.383008] test_overflow: ok: (s32)(-100 << 0) == overflow
[   10.383718] test_overflow: ok: (u32)(-100 << 0) == overflow
[   10.384428] test_overflow: ok: (s64)(-10000 << 0) == overflow
[   10.385156] test_overflow: ok: (u64)(-10000 << 0) == overflow
[   10.385941] test_overflow: ok: (s8)(0 << -5) == overflow
[   10.386619] test_overflow: ok: (u8)(0 << -5) == overflow
[   10.387291] test_overflow: ok: (s16)(0 << -10) == overflow
[   10.387980] test_overflow: ok: (u16)(0 << -10) == overflow
[   10.388686] test_overflow: ok: (int)(0 << -15) == overflow
[   10.389387] test_overflow: ok: (unsigned int)(0 << -15) == overflow
[   10.390206] test_overflow: ok: (s32)(0 << -20) == overflow
[   10.390899] test_overflow: ok: (u32)(0 << -20) == overflow
[   10.391592] test_overflow: ok: (s64)(0 << -30) == overflow
[   10.392278] test_overflow: ok: (u64)(0 << -30) == overflow
[   10.392963] test_overflow: ok: (u8)(0 << 8) == overflow
[   10.393622] test_overflow: ok: (u8)(0 << 9) == overflow
[   10.394303] test_overflow: ok: (s8)(0 << 8) == overflow
[   10.394959] test_overflow: ok: (s8)(0 << 9) == overflow
[   10.395613] test_overflow: ok: (u16)(0 << 16) == overflow
[   10.396280] test_overflow: ok: (u16)(0 << 17) == overflow
[   10.396958] test_overflow: ok: (s16)(0 << 16) == overflow
[   10.397630] test_overflow: ok: (s16)(0 << 17) == overflow
[   10.398346] test_overflow: ok: (u32)(0 << 32) == overflow
[   10.399031] test_overflow: ok: (u32)(0 << 33) == overflow
[   10.399711] test_overflow: ok: (int)(0 << 32) == overflow
[   10.400385] test_overflow: ok: (int)(0 << 33) == overflow
[   10.401066] test_overflow: ok: (s32)(0 << 32) == overflow
[   10.401748] test_overflow: ok: (s32)(0 << 33) == overflow
[   10.402484] test_overflow: ok: (u64)(0 << 64) == overflow
[   10.403164] test_overflow: ok: (u64)(0 << 65) == overflow
[   10.403850] test_overflow: ok: (s64)(0 << 64) == overflow
[   10.404523] test_overflow: ok: (s64)(0 << 65) == overflow
[   10.405197] test_overflow: ok: (s8)(0 << 7) == 0
[   10.405782] test_overflow: ok: (s16)(0 << 15) == 0
[   10.406410] test_overflow: ok: (int)(0 << 31) == 0
[   10.406991] test_overflow: ok: (s32)(0 << 31) == 0
[   10.407575] test_overflow: ok: (s64)(0 << 63) == 0
[   10.408191] test_overflow: kmalloc detected saturation
[   10.408814] test_overflow: kmalloc_node detected saturation
[   10.409488] test_overflow: kzalloc detected saturation
[   10.410150] test_overflow: kzalloc_node detected saturation
[   10.410864] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[   10.412025] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.413047] Call Trace:
[   10.413347]  dump_stack+0x16/0x26
[   10.413753]  warn_alloc+0x79/0xf0
[   10.414200]  __vmalloc_node_range+0x240/0x270
[   10.414722]  __vmalloc_node+0x45/0x50
[   10.415159]  ? test_overflow_allocation+0x347/0xd9e
[   10.415740]  __vmalloc_node_flags_caller+0x35/0x40
[   10.416304]  ? test_overflow_allocation+0x347/0xd9e
[   10.416882]  kvmalloc_node+0x61/0x70
[   10.417306]  ? test_overflow_allocation+0x347/0xd9e
[   10.417950]  test_overflow_allocation+0x347/0xd9e
[   10.418511]  ? vprintk_default+0x17/0x20
[   10.418980]  ? vprintk_func+0x39/0xb0
[   10.419421]  ? printk+0x13/0x15
[   10.419804]  test_module_init+0x1c4d/0x1c94
[   10.420300]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.420887]  do_one_initcall+0x104/0x3c2
[   10.421354]  ? parse_args+0xa0/0x280
[   10.421788]  kernel_init_freeable+0x2b4/0x460
[   10.422351]  ? rest_init+0x110/0x110
[   10.422790]  kernel_init+0xd/0xf0
[   10.423189]  ret_from_fork+0x19/0x24
[   10.423640] Mem-Info:
[   10.423931] active_anon:0 inactive_anon:0 isolated_anon:0
[   10.423931]  active_file:0 inactive_file:0 isolated_file:0
[   10.423931]  unevictable:7350 dirty:0 writeback:0 unstable:0
[   10.423931]  slab_reclaimable:3233 slab_unreclaimable:753
[   10.423931]  mapped:0 shmem:0 pagetables:0 bounce:0
[   10.423931]  free:220862 free_pcp:326 free_cma:0
[   10.427664] Node 0 active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:29400kB isolated(anon):0kB isolated(file):0kB mapped:0kB dirty:0kB writeback:0kB shmem:0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[   10.430249] DMA free:15916kB min:68kB low:84kB high:100kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15916kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[   10.433236] lowmem_reserve[]: 0 753 891 891
[   10.433768] Normal free:750184kB min:3476kB low:4344kB high:5212kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:5632kB writepending:0kB present:890872kB managed:774452kB mlocked:0kB kernel_stack:296kB pagetables:0kB bounce:0kB free_pcp:1288kB local_pcp:1288kB free_cma:0kB
[   10.436980] lowmem_reserve[]: 0 0 1102 1102
[   10.437504] HighMem free:117348kB min:136kB low:292kB high:448kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:23768kB writepending:0kB present:141176kB managed:141176kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:16kB local_pcp:16kB free_cma:0kB
[   10.440680] lowmem_reserve[]: 0 0 0 0
[   10.441151] DMA: 1*4kB (U) 1*8kB (U) 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (U) 3*4096kB (M) = 15916kB
[   10.442829] Normal: 6*4kB (UME) 2*8kB (ME) 2*16kB (UM) 11*32kB (UM) 15*64kB (UME) 12*128kB (UM) 9*256kB (UME) 3*512kB (UM) 6*1024kB (UME) 6*2048kB (UME) 177*4096kB (UM) = 750184kB
[   10.444832] HighMem: 1*4kB (U) 0*8kB 2*16kB (UM) 2*32kB (UM) 2*64kB (UM) 1*128kB (U) 1*256kB (M) 2*512kB (UM) 1*1024kB (M) 2*2048kB (UM) 27*4096kB (M) = 117348kB
[   10.446685] 7350 total pagecache pages
[   10.447167] 262010 pages RAM
[   10.447547] 35294 pages HighMem/MovableOnly
[   10.448071] 29124 pages reserved
[   10.448485] 0 pages cma reserved
[   10.448896] test_overflow: kvmalloc detected saturation
[   10.449574] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[   10.450868] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.451974] Call Trace:
[   10.452299]  dump_stack+0x16/0x26
[   10.452740]  warn_alloc+0x79/0xf0
[   10.453170]  __vmalloc_node_range+0x240/0x270
[   10.453732]  __vmalloc_node+0x45/0x50
[   10.454246]  ? test_overflow_allocation+0x45e/0xd9e
[   10.454873]  __vmalloc_node_flags_caller+0x35/0x40
[   10.455464]  ? test_overflow_allocation+0x45e/0xd9e
[   10.456062]  kvmalloc_node+0x61/0x70
[   10.456511]  ? test_overflow_allocation+0x45e/0xd9e
[   10.457107]  test_overflow_allocation+0x45e/0xd9e
[   10.457689]  ? vprintk_default+0x17/0x20
[   10.458219]  ? vprintk_func+0x39/0xb0
[   10.458678]  ? printk+0x13/0x15
[   10.459077]  test_module_init+0x1c4d/0x1c94
[   10.459580]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.460158]  do_one_initcall+0x104/0x3c2
[   10.460633]  ? parse_args+0xa0/0x280
[   10.461063]  kernel_init_freeable+0x2b4/0x460
[   10.461586]  ? rest_init+0x110/0x110
[   10.462066]  kernel_init+0xd/0xf0
[   10.462473]  ret_from_fork+0x19/0x24
[   10.462904] test_overflow: kvmalloc_node detected saturation
[   10.463590] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[   10.464870] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.465964] Call Trace:
[   10.466265]  dump_stack+0x16/0x26
[   10.466671]  warn_alloc+0x79/0xf0
[   10.467071]  __vmalloc_node_range+0x240/0x270
[   10.467594]  __vmalloc_node+0x45/0x50
[   10.468037]  ? test_overflow_allocation+0x56c/0xd9e
[   10.468628]  __vmalloc_node_flags_caller+0x35/0x40
[   10.469196]  ? test_overflow_allocation+0x56c/0xd9e
[   10.469781]  kvmalloc_node+0x61/0x70
[   10.470248]  ? test_overflow_allocation+0x56c/0xd9e
[   10.470832]  test_overflow_allocation+0x56c/0xd9e
[   10.471394]  ? vprintk_func+0x39/0xb0
[   10.471834]  ? printk+0x13/0x15
[   10.472210]  test_module_init+0x1c4d/0x1c94
[   10.472712]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.473302]  do_one_initcall+0x104/0x3c2
[   10.473790]  ? parse_args+0xa0/0x280
[   10.474277]  kernel_init_freeable+0x2b4/0x460
[   10.474824]  ? rest_init+0x110/0x110
[   10.475267]  kernel_init+0xd/0xf0
[   10.475684]  ret_from_fork+0x19/0x24
[   10.476128] test_overflow: kvzalloc detected saturation
[   10.476785] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[   10.478146] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.479210] Call Trace:
[   10.479526]  dump_stack+0x16/0x26
[   10.479939]  warn_alloc+0x79/0xf0
[   10.480353]  __vmalloc_node_range+0x240/0x270
[   10.480893]  __vmalloc_node+0x45/0x50
[   10.481347]  ? test_overflow_allocation+0x670/0xd9e
[   10.481999]  __vmalloc_node_flags_caller+0x35/0x40
[   10.482592]  ? test_overflow_allocation+0x670/0xd9e
[   10.483184]  kvmalloc_node+0x61/0x70
[   10.483629]  ? test_overflow_allocation+0x670/0xd9e
[   10.484244]  test_overflow_allocation+0x670/0xd9e
[   10.484821]  ? vprintk_func+0x39/0xb0
[   10.485269]  ? printk+0x13/0x15
[   10.485670]  test_module_init+0x1c4d/0x1c94
[   10.486225]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.486832]  do_one_initcall+0x104/0x3c2
[   10.487316]  ? parse_args+0xa0/0x280
[   10.487751]  kernel_init_freeable+0x2b4/0x460
[   10.488276]  ? rest_init+0x110/0x110
[   10.488722]  kernel_init+0xd/0xf0
[   10.489123]  ret_from_fork+0x19/0x24
[   10.489559] test_overflow: kvzalloc_node detected saturation
[   10.505945] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[   10.507072] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.508065] Call Trace:
[   10.508360]  dump_stack+0x16/0x26
[   10.508753]  warn_alloc+0x79/0xf0
[   10.509141]  __vmalloc_node_range+0x240/0x270
[   10.509645]  ? trace_hardirqs_on+0x3e/0x120
[   10.510174]  __vmalloc_node+0x45/0x50
[   10.510608]  ? test_overflow_allocation+0x774/0xd9e
[   10.511163]  vmalloc+0x39/0x40
[   10.511524]  ? test_overflow_allocation+0x774/0xd9e
[   10.512078]  test_overflow_allocation+0x774/0xd9e
[   10.512617]  ? vprintk_func+0x39/0xb0
[   10.513039]  ? printk+0x13/0x15
[   10.513407]  test_module_init+0x1c4d/0x1c94
[   10.513935]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.514499]  do_one_initcall+0x104/0x3c2
[   10.514951]  ? parse_args+0xa0/0x280
[   10.515364]  kernel_init_freeable+0x2b4/0x460
[   10.515873]  ? rest_init+0x110/0x110
[   10.516290]  kernel_init+0xd/0xf0
[   10.516679]  ret_from_fork+0x19/0x24
[   10.517101] test_overflow: vmalloc detected saturation
[   10.517721] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[   10.518910] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.519928] Call Trace:
[   10.520227]  dump_stack+0x16/0x26
[   10.520628]  warn_alloc+0x79/0xf0
[   10.521025]  __vmalloc_node_range+0x240/0x270
[   10.521569]  ? trace_hardirqs_on+0x3e/0x120
[   10.522144]  __vmalloc_node+0x45/0x50
[   10.522605]  ? test_overflow_allocation+0x873/0xd9e
[   10.523201]  vmalloc_node+0x39/0x40
[   10.523638]  ? test_overflow_allocation+0x873/0xd9e
[   10.524234]  test_overflow_allocation+0x873/0xd9e
[   10.524816]  ? vprintk_func+0x39/0xb0
[   10.525266]  ? printk+0x13/0x15
[   10.525660]  test_module_init+0x1c4d/0x1c94
[   10.526226]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.526808]  do_one_initcall+0x104/0x3c2
[   10.527274]  ? parse_args+0xa0/0x280
[   10.527712]  kernel_init_freeable+0x2b4/0x460
[   10.528229]  ? rest_init+0x110/0x110
[   10.528660]  kernel_init+0xd/0xf0
[   10.529075]  ret_from_fork+0x19/0x24
[   10.529523] test_overflow: vmalloc_node detected saturation
[   10.530311] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[   10.531617] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.532658] Call Trace:
[   10.532965]  dump_stack+0x16/0x26
[   10.533374]  warn_alloc+0x79/0xf0
[   10.533781]  __vmalloc_node_range+0x240/0x270
[   10.534353]  ? trace_hardirqs_on+0x3e/0x120
[   10.534868]  __vmalloc_node+0x45/0x50
[   10.535318]  ? test_overflow_allocation+0x95c/0xd9e
[   10.535911]  vzalloc+0x39/0x40
[   10.536286]  ? test_overflow_allocation+0x95c/0xd9e
[   10.536879]  test_overflow_allocation+0x95c/0xd9e
[   10.537456]  ? printk+0x13/0x15
[   10.537864]  test_module_init+0x1c4d/0x1c94
[   10.538405]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.538997]  do_one_initcall+0x104/0x3c2
[   10.539480]  ? parse_args+0xa0/0x280
[   10.539921]  kernel_init_freeable+0x2b4/0x460
[   10.540456]  ? rest_init+0x110/0x110
[   10.540894]  kernel_init+0xd/0xf0
[   10.541304]  ret_from_fork+0x19/0x24
[   10.541746] test_overflow: vzalloc detected saturation
[   10.542447] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[   10.543753] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.544844] Call Trace:
[   10.545161]  dump_stack+0x16/0x26
[   10.545587]  warn_alloc+0x79/0xf0
[   10.546078]  __vmalloc_node_range+0x240/0x270
[   10.546632]  ? trace_hardirqs_on+0x3e/0x120
[   10.547158]  __vmalloc_node+0x45/0x50
[   10.547628]  ? test_overflow_allocation+0xa54/0xd9e
[   10.548247]  vzalloc_node+0x39/0x40
[   10.548680]  ? test_overflow_allocation+0xa54/0xd9e
[   10.549291]  test_overflow_allocation+0xa54/0xd9e
[   10.549918]  ? printk+0x13/0x15
[   10.550329]  test_module_init+0x1c4d/0x1c94
[   10.550873]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.551485]  do_one_initcall+0x104/0x3c2
[   10.551962]  ? parse_args+0xa0/0x280
[   10.552402]  kernel_init_freeable+0x2b4/0x460
[   10.552929]  ? rest_init+0x110/0x110
[   10.553364]  kernel_init+0xd/0xf0
[   10.553775]  ret_from_fork+0x19/0x24
[   10.554257] test_overflow: vzalloc_node detected saturation
[   10.554944] test_overflow: devm_kmalloc detected saturation
[   10.555624] test_overflow: devm_kzalloc detected saturation
[   10.556349] test_overflow: all tests passed
[   10.557305] Running rhashtable test nelem=8, max_size=0, shrinking=0
[   10.558126] Test 00:
[   10.558438]   Adding 50000 keys
[   10.846205]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   10.926375]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   10.927469]   Deleting 50000 keys
[   11.029756]   Duration of test: 470933402 ns
[   11.030361] Test 01:
[   11.030770]   Adding 50000 keys
[   11.331182]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   11.404896]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   11.406106]   Deleting 50000 keys
[   11.525810]   Duration of test: 494642892 ns
[   11.526423] Test 02:
[   11.526604]   Adding 50000 keys
[   11.909485]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   11.996872]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   11.998055]   Deleting 50000 keys
[   12.134029]   Duration of test: 606750241 ns
[   12.134622] Test 03:
[   12.135038]   Adding 50000 keys
[   12.553118]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   12.642870]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   12.644043]   Deleting 50000 keys
[   12.768388]   Duration of test: 632951159 ns
[   12.832336] test if its possible to exceed max_size 8192: no, ok
[   12.833243] Average test time: 551319423
[   12.833768] test inserting duplicates
[   12.834377] 
[   12.834377] ---- ht: ----
[   12.834377] bucket[1] -> [[ val 1 (tid=0) ]] -> [[ val 21 (tid=1) ]]
[   12.834377] -------------
[   12.836091] 
[   12.836091] ---- ht: ----
[   12.836091] bucket[1] -> [[ val 1 (tid=2),  val 1 (tid=0) ]] -> [[ val 21 (tid=1) ]]
[   12.836091] -------------
[   12.838128] 
[   12.838128] ---- ht: ----
[   12.838128] bucket[1] -> [[ val 21 (tid=1) ]] -> [[ val 1 (tid=0) ]]
[   12.838128] -------------
[   12.839846] 
[   12.839846] ---- ht: ----
[   12.839846] bucket[1] -> [[ val 21 (tid=1) ]] -> [[ val 1 (tid=2),  val 1 (tid=0) ]]
[   12.839846] -------------
[   12.841672] Testing concurrent rhashtable access from 10 threads
[   12.847002] _warn_unseeded_randomness: 552 callbacks suppressed
[   12.847009] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=1
[   12.849564] random: get_random_u32 called from bucket_table_alloc+0x7e/0x170 with crng_init=1
[   25.117393] rhashtable_thra (118) used greatest stack depth: 7020 bytes left
[   25.129409] test 3125 add/delete pairs into rhlist
[   25.420574] test 3125 random rhlist add/delete operations
[   25.724019] Started 10 threads, 0 failed, rhltable test returns 0
[   25.724960] test_bitmap: test 13: input is '0-2047:128/256' OK, Time: 1051
[   25.729667] test_bitmap: all 1524 tests passed
[   25.730298] test_bitfield: tests passed
[   25.730772] test_uuid: all 18 tests passed
[   25.731766] crc32: CRC_LE_BITS = 32, CRC_BE BITS = 32
[   25.732364] crc32: self tests passed, processed 225944 bytes in 247321 nsec
[   25.733439] crc32c: CRC_LE_BITS = 32
[   25.733925] crc32c: self tests passed, processed 225944 bytes in 128473 nsec
[   25.753713] crc32_combine: 8373 self tests passed
[   25.773650] crc32c_combine: 8373 self tests passed
[   25.774342] rbtree testing
[   25.780472]  -> test 1 (latency of nnodes insert+delete): 15878 cycles
[   25.786861]  -> test 2 (latency of nnodes cached insert+delete): 13575 cycles
[   25.788308]  -> test 3 (latency of inorder traversal): 1459 cycles
[   25.789074]  -> test 4 (latency to fetch first node)
[   25.789686]         non-cached: 21 cycles
[   25.790234]         cached: 0 cycles
[   25.850888] augmented rbtree testing
[   25.858359]  -> test 1 (latency of nnodes insert+delete): 19355 cycles
[   25.867015]  -> test 2 (latency of nnodes cached insert+delete): 19210 cycles
[   25.945733] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=1
[   25.945887] gpio_it87: no device
[   25.947825] gpio_winbond: chip ID at 2e is ffff
[   25.948349] gpio_winbond: not an our chip
[   25.948847] gpio_winbond: chip ID at 4e is ffff
[   25.949364] gpio_winbond: not an our chip
[   25.954850] vmlfb: initializing
[   25.955559] hgafb: HGA card not detected.
[   25.956065] hgafb: probe of hgafb.0 failed with error -22
[   25.956952] usbcore: registered new interface driver udlfb
[   25.957636] usbcore: registered new interface driver smscufx
[   25.958830] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[   25.959742] ACPI: Power Button [PWRF]
[   25.960721] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1
[   25.961608] ACPI: Power Button [PWRF]
[   25.962389] Warning: Processor Platform Limit event detected, but not handled.
[   25.963242] Consider compiling CPUfreq support into your kernel.
[   26.280201] PCI Interrupt Link [LNKD] enabled at IRQ 11
[   26.280833] PCI: setting IRQ 11 as level-triggered
[   27.233444] PCI Interrupt Link [LNKA] enabled at IRQ 10
[   27.234143] PCI: setting IRQ 10 as level-triggered
[   27.948736] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[   27.973982] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[   27.976215] printk: console [ttyS0] disabled
[    0.000000] Linux version 4.20.0-rc1-00144-g30f3312 (kbuild@lkp-hsx03) (gcc version 4.9.4 (Debian 4.9.4-2)) #1 Wed Feb 13 00:17:10 CST 2019
[    0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[    0.000000] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[    0.000000] 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-0x000000003ffdbfff] usable
[    0.000000] BIOS-e820: [mem 0x000000003ffdc000-0x000000003fffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] printk: debug: ignoring loglevel setting.
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] Hypervisor detected: KVM
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000001] kvm-clock: cpu 0, msr 2bf5001, primary cpu clock
[    0.000001] kvm-clock: using sched offset of 552847977 cycles
[    0.000011] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000030] tsc: Detected 2593.992 MHz processor
[    0.002640] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.002653] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.002666] last_pfn = 0x3ffdc max_arch_pfn = 0x1000000
[    0.002709] MTRR default type: write-back
[    0.002716] MTRR fixed ranges enabled:
[    0.002723]   00000-9FFFF write-back
[    0.002730]   A0000-BFFFF uncachable
[    0.002737]   C0000-FFFFF write-protect
[    0.002743] MTRR variable ranges enabled:
[    0.002751]   0 base 0080000000 mask FF80000000 uncachable
[    0.002757]   1 disabled
[    0.002763]   2 disabled
[    0.002769]   3 disabled
[    0.002775]   4 disabled
[    0.002781]   5 disabled
[    0.002786]   6 disabled
[    0.002791]   7 disabled
[    0.002815] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
[    0.002846] initial memory mapped: [mem 0x00000000-0x03dfffff]
[    0.002857] Base memory trampoline at [(ptrval)] 9b000 size 16384
[    0.002949] BRK [0x03881000, 0x03881fff] PGTABLE
[    0.002971] BRK [0x03882000, 0x03882fff] PGTABLE
[    0.002980] RAMDISK: [mem 0x3fca5000-0x3ffcffff]
[    0.002987] Allocated new RAMDISK: [mem 0x372d3000-0x375fd83b]
[    0.004640] Move RAMDISK from [mem 0x3fca5000-0x3ffcf83b] to [mem 0x372d3000-0x375fd83b]
[    0.004650] ACPI: Early table checksum verification disabled
[    0.004752] ACPI: RSDP 0x00000000000F6860 000014 (v00 BOCHS )
[    0.004763] ACPI: RSDT 0x000000003FFE1936 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.004776] ACPI: FACP 0x000000003FFE180A 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.004789] ACPI: DSDT 0x000000003FFE0040 0017CA (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.004799] ACPI: FACS 0x000000003FFE0000 000040
[    0.004809] ACPI: APIC 0x000000003FFE187E 000080 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.004819] ACPI: HPET 0x000000003FFE18FE 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.004834] 137MB HIGHMEM available.
[    0.004841] 885MB LOWMEM available.
[    0.004847]   mapped low ram: 0 - 375fe000
[    0.004852]   low ram: 0 - 375fe000
[    0.004905] BRK [0x03883000, 0x03883fff] PGTABLE
[    0.004914] Zone ranges:
[    0.004921]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.004928]   Normal   [mem 0x0000000001000000-0x00000000375fdfff]
[    0.004935]   HighMem  [mem 0x00000000375fe000-0x000000003ffdbfff]
[    0.004942] Movable zone start for each node
[    0.004949] Early memory node ranges
[    0.004956]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.004962]   node   0: [mem 0x0000000000100000-0x000000003ffdbfff]
[    0.004970] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdbfff]
[    0.004979] On node 0 totalpages: 262010
[    0.007292]   DMA zone: 32 pages used for memmap
[    0.007303]   DMA zone: 0 pages reserved
[    0.007310]   DMA zone: 3998 pages, LIFO batch:0
[    0.007440]   Normal zone: 1740 pages used for memmap
[    0.007447]   Normal zone: 222718 pages, LIFO batch:63
[    0.013776]   HighMem zone: 35294 pages, LIFO batch:7
[    0.015223] ACPI: PM-Timer IO Port: 0x608
[    0.015234] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.015275] KVM setup async PF for cpu 0
[    0.015287] kvm-stealtime: cpu 0, msr 2724a00
[    0.015324] [mem 0x40000000-0xfeffbfff] available for PCI devices
[    0.015330] Booting paravirtualized kernel on KVM
[    0.015338] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[    0.015399] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[    0.015407] pcpu-alloc: [0] 0 
[    0.015435] Built 1 zonelists, mobility grouping on.  Total pages: 260238
[    0.015444] Kernel command line: ip=::::vm-snb-openwrt-ia32-22::dhcp root=/dev/ram0 user=lkp job=/lkp/jobs/scheduled/vm-snb-openwrt-ia32-22/boot-1-openwrt-i386-2016-03-16.cgz-30f33126feca0fe16df9e9-20190213-72162-5wnmju-1.yaml ARCH=i386 kconfig=i386-randconfig-a2-201905 branch=linus/master commit=30f33126feca0fe16df9e9302ffc28a953e2eb37 BOOT_IMAGE=/pkg/linux/i386-randconfig-a2-201905/gcc-4.9/30f33126feca0fe16df9e9302ffc28a953e2eb37/vmlinuz-4.20.0-rc1-00144-g30f3312 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-snb-openwrt-ia32/openwrt-i386-2016-03-16.cgz/i386-randconfig-a2-201905/gcc-4.9/30f33126feca0fe16df9e9302ffc28a953e2eb37/3 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=normal rw rcuperf.shutdown=0
[    0.016357] sysrq: sysrq always enabled.
[    0.017520] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.017598] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.017614] Initializing CPU#0
[    0.035816] Initializing HighMem for node 0 (000375fe:0003ffdc)
[    0.066418] Initializing Movable for node 0 (00000000:00000000)
[    0.072326] Memory: 928300K/1048040K available (16300K kernel code, 3762K rwdata, 7228K rodata, 1160K init, 12780K bss, 119740K reserved, 0K cma-reserved, 141176K highmem)
[    0.072340] virtual kernel memory layout:
[    0.072340]     fixmap  : 0xfffe4000 - 0xfffff000   ( 108 kB)
[    0.072340]   cpu_entry : 0xffa00000 - 0xffa27000   ( 156 kB)
[    0.072340]     pkmap   : 0xff600000 - 0xff800000   (2048 kB)
[    0.072340]     vmalloc : 0xf7dfe000 - 0xff5fe000   ( 120 MB)
[    0.072340]     lowmem  : 0xc0000000 - 0xf75fe000   ( 885 MB)
[    0.072340]       .init : 0xc2ac5000 - 0xc2be7000   (1160 kB)
[    0.072340]       .data : 0xc1feb174 - 0xc2aa9a80   (11002 kB)
[    0.072340]       .text : 0xc1000000 - 0xc1feb174   (16300 kB)
[    0.072351] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[    0.072398] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=0
[    0.073157] ftrace: allocating 59873 entries in 117 pages
[    0.100472] Running RCU self tests
[    0.105466] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[    0.105797] CPU 0 irqstacks, hard=(ptrval) soft=(ptrval)
[    0.106018] random: get_random_u32 called from cache_random_seq_create+0x91/0x120 with crng_init=0
[    0.106054] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=0
[    0.232343] printk: console [ttyS0] enabled
[    0.232903] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.233962] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.234505] ... MAX_LOCK_DEPTH:          48
[    0.235045] ... MAX_LOCKDEP_KEYS:        8191
[    0.235629] ... CLASSHASH_SIZE:          4096
[    0.236209] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.236817] ... MAX_LOCKDEP_CHAINS:      65536
[    0.237357] ... CHAINHASH_SIZE:          32768
[    0.237857]  memory used by lock dependency info: 4623 kB
[    0.238460]  per task-struct memory footprint: 2112 bytes
[    0.239111] ACPI: Core revision 20181003
[    0.239865] ACPI: setting ELCR to 0200 (from 0c00)
[    0.240634] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.262021] hpet clockevent registered
[    0.262559] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x25641074d3b, max_idle_ns: 440795244898 ns
[    0.263975] Calibrating delay loop (skipped) preset value.. 5187.98 BogoMIPS (lpj=10375968)
[    0.265147] pid_max: default: 32768 minimum: 301
[    0.265891] LSM: Security Framework initializing
[    0.268046] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.268920] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.272594] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.273263] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.274013] CPU: Intel Xeon E312xx (Sandy Bridge) (family: 0x6, model: 0x2a, stepping: 0x1)
[    0.275080] Spectre V2 : Spectre mitigation: kernel not compiled with retpoline; no mitigation available!
[    0.275082] Speculative Store Bypass: Vulnerable
[    0.277661] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only.
[    0.280534] NMI watchdog: Perf NMI watchdog permanently disabled
[    0.281916] devtmpfs: initialized
[    0.288070] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.289386] futex hash table entries: 256 (order: 1, 13312 bytes)
[    0.290495] pinctrl core: initialized pinctrl subsystem
[    0.292079] regulator-dummy: Failed to create debugfs directory
[    0.293412] NET: Registered protocol family 16
[    0.297057] cpuidle: using governor ladder
[    0.299411] ACPI: bus type PCI registered
[    0.300346] PCI: PCI BIOS area is rw and x. Use pci=nobios if you want it NX.
[    0.301352] PCI: PCI BIOS revision 2.10 entry at 0xfd501, last bus=0
[    0.368173] workqueue: round-robin CPU selection forced, expect performance impact
[    0.369870] ACPI: Added _OSI(Module Device)
[    0.370416] ACPI: Added _OSI(Processor Device)
[    0.371055] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.371723] ACPI: Added _OSI(Processor Aggregator Device)
[    0.371993] ACPI: Added _OSI(Linux-Dell-Video)
[    0.372573] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    0.380011] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.387133] ACPI: Interpreter enabled
[    0.387716] ACPI: (supports S0 S5)
[    0.388004] ACPI: Using PIC for interrupt routing
[    0.388709] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.390690] ACPI: Enabled 3 GPEs in block 00 to 0F
[    0.413089] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.414016] acpi PNP0A03:00: _OSC: OS supports [Segments]
[    0.415016] PCI host bridge to bus 0000:00
[    0.415592] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.415991] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.416901] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.417823] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]
[    0.418789] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.420080] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.421912] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.424262] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    0.431991] pci 0000:00:01.1: reg 0x20: [io  0xc0c0-0xc0cf]
[    0.436634] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.437596] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.438437] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.439990] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.441615] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    0.443102] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[    0.444007] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[    0.445841] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[    0.449530] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[    0.458164] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[    0.469414] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    0.472919] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    0.475989] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[    0.479987] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    0.494228] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[    0.496831] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[    0.499990] pci 0000:00:04.0: reg 0x10: [io  0xc040-0xc07f]
[    0.505585] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[    0.517777] pci 0000:00:04.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
[    0.524638] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000
[    0.527992] pci 0000:00:05.0: reg 0x10: [io  0xc080-0xc0bf]
[    0.533786] pci 0000:00:05.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff]
[    0.547447] pci 0000:00:05.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref]
[    0.553327] pci 0000:00:06.0: [8086:25ab] type 00 class 0x088000
[    0.555388] pci 0000:00:06.0: reg 0x10: [mem 0xfebf3000-0xfebf300f]
[    0.565077] pci_bus 0000:00: on NUMA node 0
[    0.568009] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    0.570039] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    0.571276] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    0.572861] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    0.573792] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    0.576573] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[    0.577380] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    0.578388] pci 0000:00:02.0: vgaarb: bridge control possible
[    0.579158] vgaarb: loaded
[    0.580340] ACPI: bus type USB registered
[    0.580992] usbcore: registered new interface driver usbfs
[    0.581737] usbcore: registered new interface driver hub
[    0.582511] usbcore: registered new device driver usb
[    0.583386] videodev: Linux video capture interface: v2.00
[    0.584832] Advanced Linux Sound Architecture Driver Initialized.
[    0.585781] PCI: Using ACPI for IRQ routing
[    0.586361] PCI: pci_cache_line_size set to 64 bytes
[    0.587228] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.587994] e820: reserve RAM buffer [mem 0x3ffdc000-0x3fffffff]
[    0.589768] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.3)
[    0.590928] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.3)
[    0.593742] clocksource: Switched to clocksource kvm-clock
[    0.752180] Warning: could not register annotated branches stats
[    0.757249] FS-Cache: Loaded
[    0.757945] pnp: PnP ACPI init
[    0.758624] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.759672] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.760739] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    0.761715] pnp 00:03: [dma 2]
[    0.762329] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    0.763502] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    0.764649] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.765774] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.768054] pnp: PnP ACPI: found 7 devices
[    0.805962] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.807288] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    0.808144] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    0.808942] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    0.809829] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window]
[    0.814913] NET: Registered protocol family 2
[    0.815912] tcp_listen_portaddr_hash hash table entries: 512 (order: 2, 24576 bytes)
[    0.816911] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    0.822348] TCP bind hash table entries: 8192 (order: 6, 360448 bytes)
[    0.823511] TCP: Hash tables configured (established 8192 bind 8192)
[    0.824461] UDP hash table entries: 512 (order: 3, 49152 bytes)
[    0.825266] UDP-Lite hash table entries: 512 (order: 3, 49152 bytes)
[    0.830416] NET: Registered protocol family 1
[    0.831705] RPC: Registered named UNIX socket transport module.
[    0.832459] RPC: Registered udp transport module.
[    0.833028] RPC: Registered tcp transport module.
[    0.833621] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.838215] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.839025] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.839849] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.840700] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    0.846010] PCI: CLS 0 bytes, default 64
[    0.846899] Unpacking initramfs...
[    1.445944] random: fast init done
[    1.450559] kwatchdog (24) used greatest stack depth: 7356 bytes left
[    1.971713] Freeing initrd memory: 3244K
[    1.972330] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    1.986300] software IO TLB: mapped [mem 0x32a08000-0x36a08000] (64MB)
[    1.988669] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x25641074d3b, max_idle_ns: 440795244898 ns
[    1.990276] cryptomgr_test (26) used greatest stack depth: 7344 bytes left
[    1.990276] NatSemi SCx200 Driver
[    1.990276] spin_lock-torture:--- Start of test [debug]: nwriters_stress=2 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0
[    2.017847] spin_lock-torture: Creating torture_shuffle task
[    2.018779] spin_lock-torture: Creating torture_stutter task
[    2.019570] spin_lock-torture: torture_shuffle task started
[    2.020313] spin_lock-torture: Creating lock_torture_writer task
[    2.021154] spin_lock-torture: torture_stutter task started
[    2.021923] spin_lock-torture: Creating lock_torture_writer task
[    2.022761] spin_lock-torture: lock_torture_writer task started
[    2.023580] spin_lock-torture: Creating lock_torture_stats task
[    2.024396] spin_lock-torture: lock_torture_writer task started
[    2.025338] spin_lock-torture: lock_torture_stats task started
[    2.778171] _warn_unseeded_randomness: 80 callbacks suppressed
[    2.778180] random: get_random_u32 called from get_random_order+0x8d/0xc0 with crng_init=1
[    7.389669] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=1
[    7.401989] random: get_random_u32 called from stress_one_work+0x18/0xb0 with crng_init=1
[    9.704037] torture_init_begin: Refusing rcu init: spin_lock running.
[    9.704800] torture_init_begin: One torture test at a time!
[    9.705420] torture_init_begin: Refusing rcu init: spin_lock running.
[    9.706178] torture_init_begin: One torture test at a time!
[    9.709163] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=1
[    9.710947] Initialise system trusted keyrings
[    9.711530] random: get_random_bytes called from key_alloc+0x1f4/0x3f0 with crng_init=1
[    9.718009] workingset: timestamp_bits=30 max_order=18 bucket_order=0
[    9.718943] zbud: loaded
[    9.719402] random: get_random_u32 called from cache_random_seq_create+0x91/0x120 with crng_init=1
[    9.721523] NFS: Registering the id_resolver key type
[    9.722269] Key type id_resolver registered
[    9.722821] Key type id_legacy registered
[    9.723821] fuse init (API version 7.28)
[    9.749878] Key type asymmetric registered
[   10.065243] String selftests succeeded
[   10.065789] test_string_helpers: Running tests...
[   10.071016] test_hexdump: all 1184 tests passed
[   10.071613] 
[   10.071613] Start testing find_bit() with random-filled bitmap
[   10.076146] find_next_bit:                 2098394 ns, 163815 iterations
[   10.079264] find_next_zero_bit:            2236504 ns, 163866 iterations
[   10.081446] find_last_bit:                 1049743 ns, 163815 iterations
[   10.091260] find_first_bit:                8878431 ns,  16318 iterations
[   10.093350] find_next_and_bit:		2985876 cycles, 73560 iterations
[   10.106835] 
[   10.106835] Start testing find_bit() with sparse bitmap
[   10.107901] find_next_bit:                   31904 ns,    655 iterations
[   10.113426] find_next_zero_bit:            4552955 ns, 327026 iterations
[   10.124939] find_last_bit:                   25215 ns,    655 iterations
[   10.129295] find_first_bit:                3462197 ns,    655 iterations
[   10.130268] find_next_and_bit:		49987 cycles, 1 iterations
[   10.313991] IDA: 147321 of 147321 tests passed
[   10.315512] test_overflow: u8 : 18 arithmetic tests
[   10.316099] test_overflow: s8 : 19 arithmetic tests
[   10.316690] test_overflow: u16: 17 arithmetic tests
[   10.317272] test_overflow: s16: 17 arithmetic tests
[   10.322518] test_overflow: u32: 17 arithmetic tests
[   10.323108] test_overflow: s32: 17 arithmetic tests
[   10.323701] test_overflow: ok: (u8)(1 << 0) == 1 << 0
[   10.324303] test_overflow: ok: (u8)(1 << 4) == 1 << 4
[   10.324902] test_overflow: ok: (u8)(1 << 7) == 1 << 7
[   10.325493] test_overflow: ok: (u8)(0xF << 4) == 0xF << 4
[   10.326986] test_overflow: ok: (u16)(1 << 0) == 1 << 0
[   10.327591] test_overflow: ok: (u16)(1 << 10) == 1 << 10
[   10.328238] test_overflow: ok: (u16)(1 << 15) == 1 << 15
[   10.328896] test_overflow: ok: (u16)(0xFF << 8) == 0xFF << 8
[   10.329581] test_overflow: ok: (int)(1 << 0) == 1 << 0
[   10.330420] test_overflow: ok: (int)(1 << 16) == 1 << 16
[   10.331054] test_overflow: ok: (int)(1 << 30) == 1 << 30
[   10.331678] test_overflow: ok: (s32)(1 << 0) == 1 << 0
[   10.332278] test_overflow: ok: (s32)(1 << 16) == 1 << 16
[   10.332903] test_overflow: ok: (s32)(1 << 30) == 1 << 30
[   10.333528] test_overflow: ok: (unsigned int)(1 << 0) == 1U << 0
[   10.337092] test_overflow: ok: (unsigned int)(1 << 20) == 1U << 20
[   10.337819] test_overflow: ok: (unsigned int)(1 << 31) == 1U << 31
[   10.340759] test_overflow: ok: (unsigned int)(0xFFFFU << 16) == 0xFFFFU << 16
[   10.341587] test_overflow: ok: (u32)(1 << 0) == 1U << 0
[   10.342238] test_overflow: ok: (u32)(1 << 20) == 1U << 20
[   10.342889] test_overflow: ok: (u32)(1 << 31) == 1U << 31
[   10.343545] test_overflow: ok: (u32)(0xFFFFU << 16) == 0xFFFFU << 16
[   10.344304] test_overflow: ok: (u64)(1 << 0) == 1ULL << 0
[   10.344961] test_overflow: ok: (u64)(1 << 40) == 1ULL << 40
[   10.345633] test_overflow: ok: (u64)(1 << 63) == 1ULL << 63
[   10.346226] test_overflow: ok: (u64)(0xFFFFFFFFULL << 32) == 0xFFFFFFFFULL << 32
[   10.346226] test_overflow: ok: (u8)(0 << 7) == 0
[   10.346226] test_overflow: ok: (u16)(0 << 15) == 0
[   10.346226] test_overflow: ok: (unsigned int)(0 << 31) == 0
[   10.349068] test_overflow: ok: (u32)(0 << 31) == 0
[   10.349664] test_overflow: ok: (u64)(0 << 63) == 0
[   10.350283] test_overflow: ok: (s8)(0 << 6) == 0
[   10.350853] test_overflow: ok: (s16)(0 << 14) == 0
[   10.351440] test_overflow: ok: (int)(0 << 30) == 0
[   10.352021] test_overflow: ok: (s32)(0 << 30) == 0
[   10.352609] test_overflow: ok: (s64)(0 << 62) == 0
[   10.353190] test_overflow: ok: (u8)(1 << 8) == overflow
[   10.353830] test_overflow: ok: (u16)(1 << 16) == overflow
[   10.354526] test_overflow: ok: (unsigned int)(1 << 32) == overflow
[   10.355273] test_overflow: ok: (u32)(1 << 32) == overflow
[   10.355940] test_overflow: ok: (u64)(1 << 64) == overflow
[   10.356599] test_overflow: ok: (s8)(1 << 7) == overflow
[   10.357230] test_overflow: ok: (s16)(1 << 15) == overflow
[   10.357933] test_overflow: ok: (int)(1 << 31) == overflow
[   10.358594] test_overflow: ok: (s32)(1 << 31) == overflow
[   10.359247] test_overflow: ok: (s64)(1 << 63) == overflow
[   10.359926] test_overflow: ok: (u8)(150 << 1) == overflow
[   10.360614] test_overflow: ok: (u16)(34966 << 1) == overflow
[   10.361315] test_overflow: ok: (u32)(2215151766U << 1) == overflow
[   10.362145] test_overflow: ok: (unsigned int)(2215151766U << 1) == overflow
[   10.363020] test_overflow: ok: (u64)(9372061470395238550ULL << 1) == overflow
[   10.363904] test_overflow: ok: (s8)(75 << 1) == overflow
[   10.364584] test_overflow: ok: (s16)(17483 << 1) == overflow
[   10.365285] test_overflow: ok: (s32)(1107575883 << 1) == overflow
[   10.366100] test_overflow: ok: (int)(1107575883 << 1) == overflow
[   10.366871] test_overflow: ok: (s64)(4686030735197619275LL << 1) == overflow
[   10.367754] test_overflow: ok: (s8)(75 << 2) == overflow
[   10.368424] test_overflow: ok: (s16)(17483 << 2) == overflow
[   10.369130] test_overflow: ok: (s32)(1107575883 << 2) == overflow
[   10.369942] test_overflow: ok: (int)(1107575883 << 2) == overflow
[   10.370713] test_overflow: ok: (s64)(4686030735197619275LL << 2) == overflow
[   10.371599] test_overflow: ok: (u8)(0x100 << 0) == overflow
[   10.372296] test_overflow: ok: (s8)(0xFF << 0) == overflow
[   10.372998] test_overflow: ok: (u16)(0x10000U << 0) == overflow
[   10.373756] test_overflow: ok: (s16)(0xFFFFU << 0) == overflow
[   10.374535] test_overflow: ok: (u32)(0x100000000ULL << 0) == overflow
[   10.375335] test_overflow: ok: (unsigned int)(0x100000000ULL << 0) == overflow
[   10.376238] test_overflow: ok: (s32)(0xFFFFFFFFUL << 0) == overflow
[   10.377031] test_overflow: ok: (int)(0xFFFFFFFFUL << 0) == overflow
[   10.377835] test_overflow: ok: (s64)(0xFFFFFFFFFFFFFFFFULL << 0) == overflow
[   10.378756] test_overflow: ok: (s8)(-1 << 0) == overflow
[   10.379436] test_overflow: ok: (u8)(-1 << 0) == overflow
[   10.380105] test_overflow: ok: (s16)(-5 << 0) == overflow
[   10.380787] test_overflow: ok: (u16)(-5 << 0) == overflow
[   10.381473] test_overflow: ok: (int)(-10 << 0) == overflow
[   10.382207] test_overflow: ok: (unsigned int)(-10 << 0) == overflow
[   10.383008] test_overflow: ok: (s32)(-100 << 0) == overflow
[   10.383718] test_overflow: ok: (u32)(-100 << 0) == overflow
[   10.384428] test_overflow: ok: (s64)(-10000 << 0) == overflow
[   10.385156] test_overflow: ok: (u64)(-10000 << 0) == overflow
[   10.385941] test_overflow: ok: (s8)(0 << -5) == overflow
[   10.386619] test_overflow: ok: (u8)(0 << -5) == overflow
[   10.387291] test_overflow: ok: (s16)(0 << -10) == overflow
[   10.387980] test_overflow: ok: (u16)(0 << -10) == overflow
[   10.388686] test_overflow: ok: (int)(0 << -15) == overflow
[   10.389387] test_overflow: ok: (unsigned int)(0 << -15) == overflow
[   10.390206] test_overflow: ok: (s32)(0 << -20) == overflow
[   10.390899] test_overflow: ok: (u32)(0 << -20) == overflow
[   10.391592] test_overflow: ok: (s64)(0 << -30) == overflow
[   10.392278] test_overflow: ok: (u64)(0 << -30) == overflow
[   10.392963] test_overflow: ok: (u8)(0 << 8) == overflow
[   10.393622] test_overflow: ok: (u8)(0 << 9) == overflow
[   10.394303] test_overflow: ok: (s8)(0 << 8) == overflow
[   10.394959] test_overflow: ok: (s8)(0 << 9) == overflow
[   10.395613] test_overflow: ok: (u16)(0 << 16) == overflow
[   10.396280] test_overflow: ok: (u16)(0 << 17) == overflow
[   10.396958] test_overflow: ok: (s16)(0 << 16) == overflow
[   10.397630] test_overflow: ok: (s16)(0 << 17) == overflow
[   10.398346] test_overflow: ok: (u32)(0 << 32) == overflow
[   10.399031] test_overflow: ok: (u32)(0 << 33) == overflow
[   10.399711] test_overflow: ok: (int)(0 << 32) == overflow
[   10.400385] test_overflow: ok: (int)(0 << 33) == overflow
[   10.401066] test_overflow: ok: (s32)(0 << 32) == overflow
[   10.401748] test_overflow: ok: (s32)(0 << 33) == overflow
[   10.402484] test_overflow: ok: (u64)(0 << 64) == overflow
[   10.403164] test_overflow: ok: (u64)(0 << 65) == overflow
[   10.403850] test_overflow: ok: (s64)(0 << 64) == overflow
[   10.404523] test_overflow: ok: (s64)(0 << 65) == overflow
[   10.405197] test_overflow: ok: (s8)(0 << 7) == 0
[   10.405782] test_overflow: ok: (s16)(0 << 15) == 0
[   10.406410] test_overflow: ok: (int)(0 << 31) == 0
[   10.406991] test_overflow: ok: (s32)(0 << 31) == 0
[   10.407575] test_overflow: ok: (s64)(0 << 63) == 0
[   10.408191] test_overflow: kmalloc detected saturation
[   10.408814] test_overflow: kmalloc_node detected saturation
[   10.409488] test_overflow: kzalloc detected saturation
[   10.410150] test_overflow: kzalloc_node detected saturation
[   10.410864] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[   10.412025] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.413047] Call Trace:
[   10.413347]  dump_stack+0x16/0x26
[   10.413753]  warn_alloc+0x79/0xf0
[   10.414200]  __vmalloc_node_range+0x240/0x270
[   10.414722]  __vmalloc_node+0x45/0x50
[   10.415159]  ? test_overflow_allocation+0x347/0xd9e
[   10.415740]  __vmalloc_node_flags_caller+0x35/0x40
[   10.416304]  ? test_overflow_allocation+0x347/0xd9e
[   10.416882]  kvmalloc_node+0x61/0x70
[   10.417306]  ? test_overflow_allocation+0x347/0xd9e
[   10.417950]  test_overflow_allocation+0x347/0xd9e
[   10.418511]  ? vprintk_default+0x17/0x20
[   10.418980]  ? vprintk_func+0x39/0xb0
[   10.419421]  ? printk+0x13/0x15
[   10.419804]  test_module_init+0x1c4d/0x1c94
[   10.420300]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.420887]  do_one_initcall+0x104/0x3c2
[   10.421354]  ? parse_args+0xa0/0x280
[   10.421788]  kernel_init_freeable+0x2b4/0x460
[   10.422351]  ? rest_init+0x110/0x110
[   10.422790]  kernel_init+0xd/0xf0
[   10.423189]  ret_from_fork+0x19/0x24
[   10.423640] Mem-Info:
[   10.423931] active_anon:0 inactive_anon:0 isolated_anon:0
[   10.423931]  active_file:0 inactive_file:0 isolated_file:0
[   10.423931]  unevictable:7350 dirty:0 writeback:0 unstable:0
[   10.423931]  slab_reclaimable:3233 slab_unreclaimable:753
[   10.423931]  mapped:0 shmem:0 pagetables:0 bounce:0
[   10.423931]  free:220862 free_pcp:326 free_cma:0
[   10.427664] Node 0 active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:29400kB isolated(anon):0kB isolated(file):0kB mapped:0kB dirty:0kB writeback:0kB shmem:0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[   10.430249] DMA free:15916kB min:68kB low:84kB high:100kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15916kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[   10.433236] lowmem_reserve[]: 0 753 891 891
[   10.433768] Normal free:750184kB min:3476kB low:4344kB high:5212kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:5632kB writepending:0kB present:890872kB managed:774452kB mlocked:0kB kernel_stack:296kB pagetables:0kB bounce:0kB free_pcp:1288kB local_pcp:1288kB free_cma:0kB
[   10.436980] lowmem_reserve[]: 0 0 1102 1102
[   10.437504] HighMem free:117348kB min:136kB low:292kB high:448kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:23768kB writepending:0kB present:141176kB managed:141176kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:16kB local_pcp:16kB free_cma:0kB
[   10.440680] lowmem_reserve[]: 0 0 0 0
[   10.441151] DMA: 1*4kB (U) 1*8kB (U) 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (U) 3*4096kB (M) = 15916kB
[   10.442829] Normal: 6*4kB (UME) 2*8kB (ME) 2*16kB (UM) 11*32kB (UM) 15*64kB (UME) 12*128kB (UM) 9*256kB (UME) 3*512kB (UM) 6*1024kB (UME) 6*2048kB (UME) 177*4096kB (UM) = 750184kB
[   10.444832] HighMem: 1*4kB (U) 0*8kB 2*16kB (UM) 2*32kB (UM) 2*64kB (UM) 1*128kB (U) 1*256kB (M) 2*512kB (UM) 1*1024kB (M) 2*2048kB (UM) 27*4096kB (M) = 117348kB
[   10.446685] 7350 total pagecache pages
[   10.447167] 262010 pages RAM
[   10.447547] 35294 pages HighMem/MovableOnly
[   10.448071] 29124 pages reserved
[   10.448485] 0 pages cma reserved
[   10.448896] test_overflow: kvmalloc detected saturation
[   10.449574] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[   10.450868] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.451974] Call Trace:
[   10.452299]  dump_stack+0x16/0x26
[   10.452740]  warn_alloc+0x79/0xf0
[   10.453170]  __vmalloc_node_range+0x240/0x270
[   10.453732]  __vmalloc_node+0x45/0x50
[   10.454246]  ? test_overflow_allocation+0x45e/0xd9e
[   10.454873]  __vmalloc_node_flags_caller+0x35/0x40
[   10.455464]  ? test_overflow_allocation+0x45e/0xd9e
[   10.456062]  kvmalloc_node+0x61/0x70
[   10.456511]  ? test_overflow_allocation+0x45e/0xd9e
[   10.457107]  test_overflow_allocation+0x45e/0xd9e
[   10.457689]  ? vprintk_default+0x17/0x20
[   10.458219]  ? vprintk_func+0x39/0xb0
[   10.458678]  ? printk+0x13/0x15
[   10.459077]  test_module_init+0x1c4d/0x1c94
[   10.459580]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.460158]  do_one_initcall+0x104/0x3c2
[   10.460633]  ? parse_args+0xa0/0x280
[   10.461063]  kernel_init_freeable+0x2b4/0x460
[   10.461586]  ? rest_init+0x110/0x110
[   10.462066]  kernel_init+0xd/0xf0
[   10.462473]  ret_from_fork+0x19/0x24
[   10.462904] test_overflow: kvmalloc_node detected saturation
[   10.463590] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[   10.464870] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.465964] Call Trace:
[   10.466265]  dump_stack+0x16/0x26
[   10.466671]  warn_alloc+0x79/0xf0
[   10.467071]  __vmalloc_node_range+0x240/0x270
[   10.467594]  __vmalloc_node+0x45/0x50
[   10.468037]  ? test_overflow_allocation+0x56c/0xd9e
[   10.468628]  __vmalloc_node_flags_caller+0x35/0x40
[   10.469196]  ? test_overflow_allocation+0x56c/0xd9e
[   10.469781]  kvmalloc_node+0x61/0x70
[   10.470248]  ? test_overflow_allocation+0x56c/0xd9e
[   10.470832]  test_overflow_allocation+0x56c/0xd9e
[   10.471394]  ? vprintk_func+0x39/0xb0
[   10.471834]  ? printk+0x13/0x15
[   10.472210]  test_module_init+0x1c4d/0x1c94
[   10.472712]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.473302]  do_one_initcall+0x104/0x3c2
[   10.473790]  ? parse_args+0xa0/0x280
[   10.474277]  kernel_init_freeable+0x2b4/0x460
[   10.474824]  ? rest_init+0x110/0x110
[   10.475267]  kernel_init+0xd/0xf0
[   10.475684]  ret_from_fork+0x19/0x24
[   10.476128] test_overflow: kvzalloc detected saturation
[   10.476785] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[   10.478146] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.479210] Call Trace:
[   10.479526]  dump_stack+0x16/0x26
[   10.479939]  warn_alloc+0x79/0xf0
[   10.480353]  __vmalloc_node_range+0x240/0x270
[   10.480893]  __vmalloc_node+0x45/0x50
[   10.481347]  ? test_overflow_allocation+0x670/0xd9e
[   10.481999]  __vmalloc_node_flags_caller+0x35/0x40
[   10.482592]  ? test_overflow_allocation+0x670/0xd9e
[   10.483184]  kvmalloc_node+0x61/0x70
[   10.483629]  ? test_overflow_allocation+0x670/0xd9e
[   10.484244]  test_overflow_allocation+0x670/0xd9e
[   10.484821]  ? vprintk_func+0x39/0xb0
[   10.485269]  ? printk+0x13/0x15
[   10.485670]  test_module_init+0x1c4d/0x1c94
[   10.486225]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.486832]  do_one_initcall+0x104/0x3c2
[   10.487316]  ? parse_args+0xa0/0x280
[   10.487751]  kernel_init_freeable+0x2b4/0x460
[   10.488276]  ? rest_init+0x110/0x110
[   10.488722]  kernel_init+0xd/0xf0
[   10.489123]  ret_from_fork+0x19/0x24
[   10.489559] test_overflow: kvzalloc_node detected saturation
[   10.505945] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[   10.507072] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.508065] Call Trace:
[   10.508360]  dump_stack+0x16/0x26
[   10.508753]  warn_alloc+0x79/0xf0
[   10.509141]  __vmalloc_node_range+0x240/0x270
[   10.509645]  ? trace_hardirqs_on+0x3e/0x120
[   10.510174]  __vmalloc_node+0x45/0x50
[   10.510608]  ? test_overflow_allocation+0x774/0xd9e
[   10.511163]  vmalloc+0x39/0x40
[   10.511524]  ? test_overflow_allocation+0x774/0xd9e
[   10.512078]  test_overflow_allocation+0x774/0xd9e
[   10.512617]  ? vprintk_func+0x39/0xb0
[   10.513039]  ? printk+0x13/0x15
[   10.513407]  test_module_init+0x1c4d/0x1c94
[   10.513935]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.514499]  do_one_initcall+0x104/0x3c2
[   10.514951]  ? parse_args+0xa0/0x280
[   10.515364]  kernel_init_freeable+0x2b4/0x460
[   10.515873]  ? rest_init+0x110/0x110
[   10.516290]  kernel_init+0xd/0xf0
[   10.516679]  ret_from_fork+0x19/0x24
[   10.517101] test_overflow: vmalloc detected saturation
[   10.517721] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6000c0(GFP_KERNEL), nodemask=(null)
[   10.518910] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.519928] Call Trace:
[   10.520227]  dump_stack+0x16/0x26
[   10.520628]  warn_alloc+0x79/0xf0
[   10.521025]  __vmalloc_node_range+0x240/0x270
[   10.521569]  ? trace_hardirqs_on+0x3e/0x120
[   10.522144]  __vmalloc_node+0x45/0x50
[   10.522605]  ? test_overflow_allocation+0x873/0xd9e
[   10.523201]  vmalloc_node+0x39/0x40
[   10.523638]  ? test_overflow_allocation+0x873/0xd9e
[   10.524234]  test_overflow_allocation+0x873/0xd9e
[   10.524816]  ? vprintk_func+0x39/0xb0
[   10.525266]  ? printk+0x13/0x15
[   10.525660]  test_module_init+0x1c4d/0x1c94
[   10.526226]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.526808]  do_one_initcall+0x104/0x3c2
[   10.527274]  ? parse_args+0xa0/0x280
[   10.527712]  kernel_init_freeable+0x2b4/0x460
[   10.528229]  ? rest_init+0x110/0x110
[   10.528660]  kernel_init+0xd/0xf0
[   10.529075]  ret_from_fork+0x19/0x24
[   10.529523] test_overflow: vmalloc_node detected saturation
[   10.530311] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[   10.531617] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.532658] Call Trace:
[   10.532965]  dump_stack+0x16/0x26
[   10.533374]  warn_alloc+0x79/0xf0
[   10.533781]  __vmalloc_node_range+0x240/0x270
[   10.534353]  ? trace_hardirqs_on+0x3e/0x120
[   10.534868]  __vmalloc_node+0x45/0x50
[   10.535318]  ? test_overflow_allocation+0x95c/0xd9e
[   10.535911]  vzalloc+0x39/0x40
[   10.536286]  ? test_overflow_allocation+0x95c/0xd9e
[   10.536879]  test_overflow_allocation+0x95c/0xd9e
[   10.537456]  ? printk+0x13/0x15
[   10.537864]  test_module_init+0x1c4d/0x1c94
[   10.538405]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.538997]  do_one_initcall+0x104/0x3c2
[   10.539480]  ? parse_args+0xa0/0x280
[   10.539921]  kernel_init_freeable+0x2b4/0x460
[   10.540456]  ? rest_init+0x110/0x110
[   10.540894]  kernel_init+0xd/0xf0
[   10.541304]  ret_from_fork+0x19/0x24
[   10.541746] test_overflow: vzalloc detected saturation
[   10.542447] swapper: vmalloc: allocation failure: 4294967295 bytes, mode:0x6080c0(GFP_KERNEL|__GFP_ZERO), nodemask=(null)
[   10.543753] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   10.544844] Call Trace:
[   10.545161]  dump_stack+0x16/0x26
[   10.545587]  warn_alloc+0x79/0xf0
[   10.546078]  __vmalloc_node_range+0x240/0x270
[   10.546632]  ? trace_hardirqs_on+0x3e/0x120
[   10.547158]  __vmalloc_node+0x45/0x50
[   10.547628]  ? test_overflow_allocation+0xa54/0xd9e
[   10.548247]  vzalloc_node+0x39/0x40
[   10.548680]  ? test_overflow_allocation+0xa54/0xd9e
[   10.549291]  test_overflow_allocation+0xa54/0xd9e
[   10.549918]  ? printk+0x13/0x15
[   10.550329]  test_module_init+0x1c4d/0x1c94
[   10.550873]  ? test_overflow_allocation+0xd9e/0xd9e
[   10.551485]  do_one_initcall+0x104/0x3c2
[   10.551962]  ? parse_args+0xa0/0x280
[   10.552402]  kernel_init_freeable+0x2b4/0x460
[   10.552929]  ? rest_init+0x110/0x110
[   10.553364]  kernel_init+0xd/0xf0
[   10.553775]  ret_from_fork+0x19/0x24
[   10.554257] test_overflow: vzalloc_node detected saturation
[   10.554944] test_overflow: devm_kmalloc detected saturation
[   10.555624] test_overflow: devm_kzalloc detected saturation
[   10.556349] test_overflow: all tests passed
[   10.557305] Running rhashtable test nelem=8, max_size=0, shrinking=0
[   10.558126] Test 00:
[   10.558438]   Adding 50000 keys
[   10.846205]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   10.926375]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   10.927469]   Deleting 50000 keys
[   11.029756]   Duration of test: 470933402 ns
[   11.030361] Test 01:
[   11.030770]   Adding 50000 keys
[   11.331182]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   11.404896]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   11.406106]   Deleting 50000 keys
[   11.525810]   Duration of test: 494642892 ns
[   11.526423] Test 02:
[   11.526604]   Adding 50000 keys
[   11.909485]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   11.996872]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   11.998055]   Deleting 50000 keys
[   12.134029]   Duration of test: 606750241 ns
[   12.134622] Test 03:
[   12.135038]   Adding 50000 keys
[   12.553118]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   12.642870]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   12.644043]   Deleting 50000 keys
[   12.768388]   Duration of test: 632951159 ns
[   12.832336] test if its possible to exceed max_size 8192: no, ok
[   12.833243] Average test time: 551319423
[   12.833768] test inserting duplicates
[   12.834377] 
[   12.834377] ---- ht: ----
[   12.834377] bucket[1] -> [[ val 1 (tid=0) ]] -> [[ val 21 (tid=1) ]]
[   12.834377] -------------
[   12.836091] 
[   12.836091] ---- ht: ----
[   12.836091] bucket[1] -> [[ val 1 (tid=2),  val 1 (tid=0) ]] -> [[ val 21 (tid=1) ]]
[   12.836091] -------------
[   12.838128] 
[   12.838128] ---- ht: ----
[   12.838128] bucket[1] -> [[ val 21 (tid=1) ]] -> [[ val 1 (tid=0) ]]
[   12.838128] -------------
[   12.839846] 
[   12.839846] ---- ht: ----
[   12.839846] bucket[1] -> [[ val 21 (tid=1) ]] -> [[ val 1 (tid=2),  val 1 (tid=0) ]]
[   12.839846] -------------
[   12.841672] Testing concurrent rhashtable access from 10 threads
[   12.847002] _warn_unseeded_randomness: 552 callbacks suppressed
[   12.847009] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=1
[   12.849564] random: get_random_u32 called from bucket_table_alloc+0x7e/0x170 with crng_init=1
[   25.117393] rhashtable_thra (118) used greatest stack depth: 7020 bytes left
[   25.129409] test 3125 add/delete pairs into rhlist
[   25.420574] test 3125 random rhlist add/delete operations
[   25.724019] Started 10 threads, 0 failed, rhltable test returns 0
[   25.724960] test_bitmap: test 13: input is '0-2047:128/256' OK, Time: 1051
[   25.729667] test_bitmap: all 1524 tests passed
[   25.730298] test_bitfield: tests passed
[   25.730772] test_uuid: all 18 tests passed
[   25.731766] crc32: CRC_LE_BITS = 32, CRC_BE BITS = 32
[   25.732364] crc32: self tests passed, processed 225944 bytes in 247321 nsec
[   25.733439] crc32c: CRC_LE_BITS = 32
[   25.733925] crc32c: self tests passed, processed 225944 bytes in 128473 nsec
[   25.753713] crc32_combine: 8373 self tests passed
[   25.773650] crc32c_combine: 8373 self tests passed
[   25.774342] rbtree testing
[   25.780472]  -> test 1 (latency of nnodes insert+delete): 15878 cycles
[   25.786861]  -> test 2 (latency of nnodes cached insert+delete): 13575 cycles
[   25.788308]  -> test 3 (latency of inorder traversal): 1459 cycles
[   25.789074]  -> test 4 (latency to fetch first node)
[   25.789686]         non-cached: 21 cycles
[   25.790234]         cached: 0 cycles
[   25.850888] augmented rbtree testing
[   25.858359]  -> test 1 (latency of nnodes insert+delete): 19355 cycles
[   25.867015]  -> test 2 (latency of nnodes cached insert+delete): 19210 cycles
[   25.945733] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=1
[   25.945887] gpio_it87: no device
[   25.947825] gpio_winbond: chip ID at 2e is ffff
[   25.948349] gpio_winbond: not an our chip
[   25.948847] gpio_winbond: chip ID at 4e is ffff
[   25.949364] gpio_winbond: not an our chip
[   25.954850] vmlfb: initializing
[   25.955559] hgafb: HGA card not detected.
[   25.956065] hgafb: probe of hgafb.0 failed with error -22
[   25.956952] usbcore: registered new interface driver udlfb
[   25.957636] usbcore: registered new interface driver smscufx
[   25.958830] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[   25.959742] ACPI: Power Button [PWRF]
[   25.960721] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1
[   25.961608] ACPI: Power Button [PWRF]
[   25.962389] Warning: Processor Platform Limit event detected, but not handled.
[   25.963242] Consider compiling CPUfreq support into your kernel.
[   26.280201] PCI Interrupt Link [LNKD] enabled at IRQ 11
[   26.280833] PCI: setting IRQ 11 as level-triggered
[   27.233444] PCI Interrupt Link [LNKA] enabled at IRQ 10
[   27.234143] PCI: setting IRQ 10 as level-triggered
[   27.948736] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[   27.973982] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[   27.976215] printk: console [ttyS0] disabled
[   28.001354] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[   28.574999] printk: console [ttyS0] enabled
[   28.599525] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[   28.627212] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[   28.630866] Applicom driver: $Id: ac.c,v 1.30 2000/03/22 16:03:57 dwmw2 Exp $
[   28.631717] ac.o: No PCI boards found.
[   28.632157] ac.o: For an ISA board you must supply memory and irq parameters.
[   28.632968] sonypi: Sony Programmable I/O Controller Driver v1.26.
[   28.633794] Non-volatile memory driver v1.3
[   28.634350] toshiba: not a supported Toshiba laptop
[   28.635252] platform pc8736x_gpio.0: NatSemi pc8736x GPIO Driver Initializing
[   28.636095] platform pc8736x_gpio.0: no device found
[   28.636759] nsc_gpio initializing
[   28.637166] Linux agpgart interface v0.103
[   28.638906] random: get_random_u32 called from test_drm_mm_init+0x36/0x1b5 with crng_init=1
[   28.639866] drm_mm: Testing DRM range manger (struct drm_mm), with random_seed=0x4e68943c max_iterations=8192 max_prime=128
[   28.641121] drm_mm: igt_sanitycheck - ok!
[   28.641614] igt_debug 0x0000000000000000-0x0000000000000200: 512: free
[   28.642418] igt_debug 0x0000000000000200-0x0000000000000600: 1024: used
[   28.643161] igt_debug 0x0000000000000600-0x0000000000000a00: 1024: free
[   28.643952] igt_debug 0x0000000000000a00-0x0000000000000e00: 1024: used
[   28.644707] igt_debug 0x0000000000000e00-0x0000000000001000: 512: free
[   28.645450] igt_debug total: 4096, used 2048 free 2048
[   31.689225] random: get_random_u32 called from cache_alloc_refill+0x484/0x9d0 with crng_init=1
[   56.306002] random: crng init done
[   65.596208] Writes:  Total: 2274979  Max/Min: 0/0   Fail: 0 
[   84.680255] [drm] radeon kernel modesetting enabled.
[   84.684345] [drm] amdgpu kernel modesetting enabled.
[   84.685815] [drm] Initialized vgem 1.0.0 20120112 for virtual device on minor 0
[   84.686910] usbcore: registered new interface driver udl
[   84.687966] [drm] Found bochs VGA, ID 0xb0c0.
[   84.688552] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebf0000.
[   84.689772] [TTM] Zone  kernel: Available graphics memory: 395184 kiB
[   84.690705] [TTM] Zone highmem: Available graphics memory: 465772 kiB
[   84.691535] [TTM] Initializing pool allocator
[   84.692141] [TTM] Initializing DMA pool allocator
[   84.696358] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
[   84.697814] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 1
[   84.700204] [TTM] Finalizing pool allocator
[   84.700873] [TTM] Finalizing DMA pool allocator
[   84.701807] [TTM] Zone  kernel: Used memory at exit: 0 kiB
[   84.702608] [TTM] Zone highmem: Used memory at exit: 0 kiB
[   84.703666] [drm] Found bochs VGA, ID 0xb0c0.
[   84.704269] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebf0000.
[   84.705345] kobject (11120a87): tried to init an initialized object, something is seriously wrong.
[   84.706614] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   84.707774] Call Trace:
[   84.708118]  dump_stack+0x16/0x26
[   84.708561]  kobject_init+0x6a/0x80
[   84.709032]  kobject_init_and_add+0x12/0x50
[   84.709614]  ttm_mem_global_init+0x86/0x440
[   84.710957]  ? __mutex_lock+0x716/0x7d0
[   84.711519]  ? vprintk_emit+0xfd/0x270
[   84.712019]  ? vprintk_default+0x17/0x20
[   84.712552]  ttm_bo_device_init+0x19a/0x310
[   84.713104]  ? printk+0x13/0x15
[   84.713535]  bochs_mm_init+0x37/0xb0
[   84.716829]  bochs_pci_probe+0x107/0x180
[   84.717260]  pci_device_probe+0x7e/0xf0
[   84.717695]  really_probe+0xb4/0x340
[   84.718139]  driver_probe_device+0x111/0x130
[   84.718615]  __driver_attach+0xb9/0xc0
[   84.719033]  ? driver_probe_device+0x130/0x130
[   84.719526]  bus_for_each_dev+0x4b/0x90
[   84.720115]  driver_attach+0x19/0x20
[   84.720500]  ? driver_probe_device+0x130/0x130
[   84.720962]  bus_add_driver+0x187/0x200
[   84.721365]  ? qxl_init+0x66/0x66
[   84.721736]  ? qxl_init+0x66/0x66
[   84.722154]  driver_register+0x56/0xf0
[   84.722569]  __pci_register_driver+0x50/0x60
[   84.723152]  bochs_init+0x43/0x5c
[   84.723533]  do_one_initcall+0x104/0x3c2
[   84.723959]  ? parse_args+0xa0/0x280
[   84.724351]  kernel_init_freeable+0x2b4/0x460
[   84.724828]  ? rest_init+0x110/0x110
[   84.725221]  kernel_init+0xd/0xf0
[   84.725589]  ret_from_fork+0x19/0x24
[   84.726105] BUG: unable to handle kernel paging request at 7eac1104
[   84.729246] *pdpt = 0000000000000000 *pde = 0000000000000000 
[   84.730024] Oops: 0002 [#1]
[   84.730024] CPU: 0 PID: 1 Comm: swapper Tainted: G                T 4.20.0-rc1-00144-g30f3312 #1
[   84.730024] EIP: ttm_mem_global_init+0x388/0x440
[   84.730024] Code: 89 c3 0f b6 d0 b8 e0 20 a5 c2 e8 03 7f bd ff 84 db 58 0f 85 aa 00 00 00 8b 86 8c 00 00 00 8b 5d b0 8d 50 01 89 96 8c 00 00 00 <89> 9c 86 84 00 00 00 e9 5c fe ff ff 8d 74 26 00 89 f0 e8 51 02 ab
[   84.730024] EAX: eeca1400 EBX: eeca2e00 ECX: 00000000 EDX: eeca1401
[   84.730024] ESI: c383c080 EDI: 00000000 EBP: f2535df0 ESP: f2535d90
[   84.730024] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068 EFLAGS: 00210246
[   84.730024] CR0: 80050033 CR2: 7eac1104 CR3: 02be9000 CR4: 000406b0
[   84.730024] Call Trace:
[   84.730024]  ? vprintk_emit+0xfd/0x270
[   84.730024]  ? vprintk_default+0x17/0x20
[   84.730024]  ttm_bo_device_init+0x19a/0x310
[   84.730024]  ? printk+0x13/0x15
[   84.730024]  bochs_mm_init+0x37/0xb0
[   84.730024]  bochs_pci_probe+0x107/0x180
[   84.730024]  pci_device_probe+0x7e/0xf0
[   84.730024]  really_probe+0xb4/0x340
[   84.730024]  driver_probe_device+0x111/0x130
[   84.730024]  __driver_attach+0xb9/0xc0
[   84.730024]  ? driver_probe_device+0x130/0x130
[   84.730024]  bus_for_each_dev+0x4b/0x90
[   84.730024]  driver_attach+0x19/0x20
[   84.730024]  ? driver_probe_device+0x130/0x130
[   84.730024]  bus_add_driver+0x187/0x200
[   84.730024]  ? qxl_init+0x66/0x66
[   84.730024]  ? qxl_init+0x66/0x66
[   84.730024]  driver_register+0x56/0xf0
[   84.730024]  __pci_register_driver+0x50/0x60
[   84.730024]  bochs_init+0x43/0x5c
[   84.730024]  do_one_initcall+0x104/0x3c2
[   84.730024]  ? parse_args+0xa0/0x280
[   84.730024]  kernel_init_freeable+0x2b4/0x460
[   84.730024]  ? rest_init+0x110/0x110
[   84.730024]  kernel_init+0xd/0xf0
[   84.730024]  ret_from_fork+0x19/0x24
[   84.730024] CR2: 000000007eac1104
[   84.730024] ---[ end trace d1d09e50282c959c ]---
[   84.730024] EIP: ttm_mem_global_init+0x388/0x440
[   84.730024] Code: 89 c3 0f b6 d0 b8 e0 20 a5 c2 e8 03 7f bd ff 84 db 58 0f 85 aa 00 00 00 8b 86 8c 00 00 00 8b 5d b0 8d 50 01 89 96 8c 00 00 00 <89> 9c 86 84 00 00 00 e9 5c fe ff ff 8d 74 26 00 89 f0 e8 51 02 ab
[   84.730024] EAX: eeca1400 EBX: eeca2e00 ECX: 00000000 EDX: eeca1401
[   84.730024] ESI: c383c080 EDI: 00000000 EBP: f2535df0 ESP: c2bed4bc
[   84.730024] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068 EFLAGS: 00210246
[   84.730024] CR0: 80050033 CR2: 7eac1104 CR3: 02be9000 CR4: 000406b0
[   84.730024] Kernel panic - not syncing: Fatal exception
[   84.730024] Kernel Offset: disabled

Elapsed time: 90

qemu-img create -f qcow2 disk-vm-snb-openwrt-ia32-22-0 256G
qemu-img create -f qcow2 disk-vm-snb-openwrt-ia32-22-1 256G

kvm=(
	qemu-system-x86_64
	-enable-kvm
	-cpu SandyBridge
	-kernel $kernel
	-initrd initrd-vm-snb-openwrt-ia32-22
	-m 1024
	-smp 2
	-device e1000,netdev=net0
	-netdev user,id=net0
	-boot order=nc
	-no-reboot
	-watchdog i6300esb
	-watchdog-action debug
	-rtc base=localtime
	-drive file=disk-vm-snb-openwrt-ia32-22-0,media=disk,if=virtio
	-drive file=disk-vm-snb-openwrt-ia32-22-1,media=disk,if=virtio
	-serial stdio
	-display none
	-monitor null
)

append=(
	ip=::::vm-snb-openwrt-ia32-22::dhcp
	root=/dev/ram0
	user=lkp
	job=/job-script
	ARCH=i386
	kconfig=i386-randconfig-a2-201905
	branch=linus/master
	commit=30f33126feca0fe16df9e9302ffc28a953e2eb37
	BOOT_IMAGE=/pkg/linux/i386-randconfig-a2-201905/gcc-4.9/30f33126feca0fe16df9e9302ffc28a953e2eb37/vmlinuz-4.20.0-rc1-00144-g30f3312
	max_uptime=600
	RESULT_ROOT=/result/boot/1/vm-snb-openwrt-ia32/openwrt-i386-2016-03-16.cgz/i386-randconfig-a2-201905/gcc-4.9/30f33126feca0fe16df9e9302ffc28a953e2eb37/3
	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
	rcuperf.shutdown=0
)

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