early console in setup code early console in extract_kernel input_data: 0x02a85069 input_len: 0x006fa377 output: 0x01000000 output_len: 0x012ed220 kernel_total_size: 0x02193000 Decompressing Linux... Parsing ELF... done. Booting the kernel. [ 0.000000] Linux version 4.17.0-rc1 (kbuild@lkp-hsx02) (gcc version 6.4.0 20171026 (Debian 6.4.0-9)) #1 PREEMPT Mon Apr 16 20:40:43 CST 2018 [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] Transmeta GenuineTMx86 [ 0.000000] Transmeta TransmetaCPU [ 0.000000] UMC UMC UMC UMC [ 0.000000] x86/fpu: x87 FPU will use FXSAVE [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000000ffdffff] usable [ 0.000000] BIOS-e820: [mem 0x000000000ffe0000-0x000000000fffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] bootconsole [earlyser0] enabled [ 0.000000] Notice: NX (Execute Disable) protection missing in CPU! [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] e820: last_pfn = 0xffe0 max_arch_pfn = 0x1000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC [ 0.000000] initial memory mapped: [mem 0x00000000-0x035fffff] [ 0.000000] Base memory trampoline at [(ptrval)] 9b000 size 16384 [ 0.000000] BRK [0x02d94000, 0x02d94fff] PGTABLE [ 0.000000] BRK [0x02d95000, 0x02d95fff] PGTABLE [ 0.000000] RAMDISK: [mem 0x0fd21000-0x0ffdffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F68D0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x000000000FFE15CE 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x000000000FFE142A 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x000000000FFE0040 0013EA (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x000000000FFE0000 000040 [ 0.000000] ACPI: APIC 0x000000000FFE151E 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x000000000FFE1596 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] 255MB LOWMEM available. [ 0.000000] mapped low ram: 0 - 0ffe0000 [ 0.000000] low ram: 0 - 0ffe0000 [ 0.000000] cma: dma_contiguous_reserve(limit 0ffe0000) [ 0.000000] kvm-clock: cpu 0, msr 0:fd1f001, primary cpu clock [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 1045972660 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] Normal [mem 0x0000000001000000-0x000000000ffdffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x000000000ffdffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000000ffdffff] [ 0.000000] On node 0 totalpages: 65406 [ 0.000000] DMA zone: 32 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] Normal zone: 480 pages used for memmap [ 0.000000] Normal zone: 61408 pages, LIFO batch:15 [ 0.000000] Reserved but unavailable: 98 pages [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 203c2c0 [ 0.000000] e820: [mem 0x10000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] random: fast init done [ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768 [ 0.000000] pcpu-alloc: [0] 0 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 64894 [ 0.000000] Kernel command line: ip=::::vm-lkp-nhm-dp1-yocto-i386-7::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-nhm-dp1-yocto-i386-7/boot-1-yocto-tiny-i386-2016-04-22.cgz-60cc43fc888428bb2f18f08997432d426a243338-20180416-74153-1703sy7-0.yaml ARCH=i386 kconfig=i386-randconfig-s1-201814 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/i386-randconfig-s1-201814/gcc-6/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-nhm-dp1-yocto-i386/yocto-tiny-i386-2016-04-22.cgz/i386-randconfig-s1-201814/gcc-6/60cc43fc888428bb2f18f08997432d426a243338/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw drbd.mi [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Initializing CPU#0 [ 0.000000] Memory: 226136K/261624K available (10931K kernel code, 2040K rwdata, 5520K rodata, 764K init, 10804K bss, 35488K reserved, 0K cma-reserved) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xfffe4000 - 0xfffff000 ( 108 kB) [ 0.000000] cpu_entry : 0xffa00000 - 0xffa28000 ( 160 kB) [ 0.000000] vmalloc : 0x907e0000 - 0xff9fe000 (1778 MB) [ 0.000000] lowmem : 0x80000000 - 0x8ffe0000 ( 255 MB) [ 0.000000] .init : 0x8222d000 - 0x822ec000 ( 764 kB) [ 0.000000] .data : 0x81aace54 - 0x82213040 (7576 kB) [ 0.000000] .text : 0x81000000 - 0x81aace54 (10931 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] [ 0.000000] ********************************************************** [ 0.000000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.000000] ** ** [ 0.000000] ** trace_printk() being used. Allocating extra memory. ** [ 0.000000] ** ** [ 0.000000] ** This means that this is a DEBUG kernel and it is ** [ 0.000000] ** unsafe for production use. ** [ 0.000000] ** ** [ 0.000000] ** If you see this message and you are not debugging ** [ 0.000000] ** the kernel, report this immediately to your vendor! ** [ 0.000000] ** ** [ 0.000000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.000000] ********************************************************** [ 0.001000] Preemptible hierarchical RCU implementation. [ 0.001000] RCU event tracing is enabled. [ 0.001000] RCU debug extended QS entry/exit. [ 0.001000] RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout). [ 0.001000] Tasks RCU enabled. [ 0.001000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 [ 0.001000] CPU 0 irqstacks, hard=(ptrval) soft=(ptrval) [ 0.001000] console [ttyS0] enabled [ 0.001000] bootconsole [earlyser0] disabled [ 0.001000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.001000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.001000] ... MAX_LOCK_DEPTH: 48 [ 0.001000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.001000] ... CLASSHASH_SIZE: 4096 [ 0.001000] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.001000] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.001000] ... CHAINHASH_SIZE: 32768 [ 0.001000] memory used by lock dependency info: 4383 kB [ 0.001000] per task-struct memory footprint: 1344 bytes [ 0.001000] ACPI: Core revision 20180313 [ 0.001000] ACPI: setting ELCR to 0200 (from 0c00) [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001000] hpet clockevent registered [ 0.001009] tsc: Detected 2925.998 MHz processor [ 0.001475] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2a2d3295deb, max_idle_ns: 440795332860 ns [ 0.002008] Calibrating delay loop (skipped) preset value.. 5851.99 BogoMIPS (lpj=2925998) [ 0.003006] pid_max: default: 32768 minimum: 301 [ 0.004027] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.004655] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.005332] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.006006] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.007005] CPU: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3) [ 0.007806] Spectre V2 : Vulnerable: Minimal generic ASM retpoline [ 0.008005] Spectre V2 : Spectre v2 mitigation: Filling RSB on context switch [ 0.009632] Performance Events: PMU not available due to virtualization, using software events only. [ 0.011082] Hierarchical SRCU implementation. [ 0.011658] NMI watchdog: Perf event create on CPU 0 failed with -2 [ 0.012006] NMI watchdog: Perf NMI watchdog permanently disabled [ 0.013238] devtmpfs: initialized [ 0.015894] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.016011] futex hash table entries: 256 (order: 1, 11264 bytes) [ 0.017062] prandom: seed boundary self test passed [ 0.018484] prandom: 100 self tests passed [ 0.018881] pinctrl core: initialized pinctrl subsystem [ 0.019404] RTC time: 20:44:40, date: 04/16/18 [ 0.020188] NET: Registered protocol family 16 [ 0.021978] audit: initializing netlink subsys (disabled) [ 0.022296] EISA bus registered [ 0.023014] workqueue: round-robin CPU selection forced, expect performance impact [ 0.023768] audit: type=2000 audit(1523882680.447:1): state=initialized audit_enabled=0 res=1 [ 0.024059] cpuidle: using governor ladder [ 0.026043] ACPI: bus type PCI registered [ 0.026792] PCI: PCI BIOS revision 2.10 entry at 0xfd501, last bus=0 [ 0.027006] PCI: Using configuration type 1 for base access [ 0.073497] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.074253] cryptd: max_cpu_qlen set to 1000 [ 0.074716] gpio-f7188x: Not a Fintek device at 0x0000002e [ 0.075047] gpio-f7188x: Not a Fintek device at 0x0000004e [ 0.076140] ACPI: Added _OSI(Module Device) [ 0.076541] ACPI: Added _OSI(Processor Device) [ 0.077007] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.077452] ACPI: Added _OSI(Processor Aggregator Device) [ 0.078009] ACPI: Added _OSI(Linux-Dell-Video) [ 0.082807] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.086798] ACPI: Interpreter enabled [ 0.087036] ACPI: (supports S0 S3 S5) [ 0.087408] ACPI: Using PIC for interrupt routing [ 0.088036] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.089373] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.101397] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.102012] acpi PNP0A03:00: _OSC: OS supports [Segments] [ 0.102549] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 0.103018] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.104141] PCI host bridge to bus 0000:00 [ 0.104552] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.105008] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.106008] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.106718] pci_bus 0000:00: root bus resource [mem 0x10000000-0xfebfffff window] [ 0.107010] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.108048] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.109606] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.111023] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.114328] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f] [ 0.116343] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.117008] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.117670] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.118007] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.119417] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.120343] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.121016] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.122478] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 [ 0.124629] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] [ 0.127668] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff] [ 0.134746] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 0.136082] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 0.137463] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff] [ 0.138955] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 0.145467] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.146524] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000 [ 0.147576] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f] [ 0.152138] pci_bus 0000:00: on NUMA node 0 [ 0.153731] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 0.154314] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 0.155287] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 0.156288] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 0.157131] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 0.158914] pci 0000:00:02.0: vgaarb: setting as boot VGA device [ 0.159000] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [ 0.159008] pci 0000:00:02.0: vgaarb: bridge control possible [ 0.159561] vgaarb: loaded [ 0.160524] EDAC MC: Ver: 3.0.0 [ 0.161203] EDAC DEBUG: edac_mc_sysfs_init: device mc created [ 0.162429] FPGA manager framework [ 0.162789] PCI: Using ACPI for IRQ routing [ 0.163013] PCI: pci_cache_line_size set to 32 bytes [ 0.163619] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 0.164010] e820: reserve RAM buffer [mem 0x0ffe0000-0x0fffffff] [ 0.165324] Bluetooth: Core ver 2.22 [ 0.165719] NET: Registered protocol family 31 [ 0.166015] Bluetooth: HCI device and connection manager initialized [ 0.166631] Bluetooth: HCI socket layer initialized [ 0.167015] Bluetooth: L2CAP socket layer initialized [ 0.168069] nfc: nfc_init: NFC Core ver 0.1 [ 0.168504] NET: Registered protocol family 39 [ 0.170061] clocksource: Switched to clocksource kvm-clock [ 0.183743] Warning: could not register annotated branches stats [ 0.228216] pnp: PnP ACPI init [ 0.228695] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 0.229472] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 0.230278] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 0.230989] pnp 00:03: [dma 2] [ 0.231358] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 0.232245] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 0.233058] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 0.233869] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 0.235172] pnp: PnP ACPI: found 7 devices [ 0.270919] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.271860] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.272450] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.273064] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.273717] pci_bus 0000:00: resource 7 [mem 0x10000000-0xfebfffff window] [ 0.274406] NET: Registered protocol family 2 [ 0.275169] tcp_listen_portaddr_hash hash table entries: 128 (order: 0, 5120 bytes) [ 0.276013] TCP established hash table entries: 2048 (order: 1, 8192 bytes) [ 0.276874] TCP bind hash table entries: 2048 (order: 4, 73728 bytes) [ 0.277880] TCP: Hash tables configured (established 2048 bind 2048) [ 0.278538] UDP hash table entries: 256 (order: 2, 20480 bytes) [ 0.279179] UDP-Lite hash table entries: 256 (order: 2, 20480 bytes) [ 0.279868] NET: Registered protocol family 1 [ 0.280860] RPC: Registered named UNIX socket transport module. [ 0.281648] RPC: Registered udp transport module. [ 0.282313] RPC: Registered tcp transport module. [ 0.282874] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.284053] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.284997] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.285984] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.287047] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [ 0.288445] PCI: CLS 0 bytes, default 32 [ 0.289323] Unpacking initramfs... [ 0.691059] Freeing initrd memory: 2812K [ 0.692337] apm: BIOS version 1.2 Flags 0x03 (Driver version 1.16ac) [ 0.692944] apm: overridden by ACPI. [ 0.693874] cryptomgr_test (32) used greatest stack depth: 7424 bytes left [ 0.694553] PCLMULQDQ-NI instructions are not detected. [ 0.695104] The force parameter has not been set to 1. The Iris poweroff handler will not be installed. [ 0.696083] 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 [ 0.697741] spin_lock-torture: Creating torture_shuffle task [ 0.698345] spin_lock-torture: Creating torture_stutter task [ 0.698926] spin_lock-torture: torture_shuffle task started [ 0.699478] spin_lock-torture: Creating lock_torture_writer task [ 0.700139] spin_lock-torture: torture_stutter task started [ 0.700673] spin_lock-torture: Creating lock_torture_writer task [ 0.701300] spin_lock-torture: lock_torture_writer task started [ 0.701872] spin_lock-torture: Creating lock_torture_stats task [ 0.702462] spin_lock-torture: lock_torture_writer task started [ 0.703105] torture_init_begin: Refusing rcu init: spin_lock running. [ 0.703707] torture_init_begin: One torture test at a time! [ 0.706033] spin_lock-torture: lock_torture_stats task started [ 0.707319] Initialise system trusted keyrings [ 0.707773] Key type blacklist registered [ 0.709099] workingset: timestamp_bits=30 max_order=16 bucket_order=0 [ 0.709695] zbud: loaded [ 0.710588] NFS: Registering the id_resolver key type [ 0.711121] Key type id_resolver registered [ 0.711503] Key type id_legacy registered [ 0.712383] Key type cifs.spnego registered [ 0.712790] fuse init (API version 7.26) [ 0.727112] NET: Registered protocol family 38 [ 0.727684] Key type asymmetric registered [ 0.924080] String selftests succeeded [ 0.924435] test_string_helpers: Running tests... [ 0.926539] test_hexdump: all 1184 tests passed [ 0.927015] [ 0.927015] Start testing find_bit() with random-filled bitmap [ 0.930633] find_next_bit: 2262809 ns, 164019 iterations [ 0.933711] find_next_zero_bit: 2241580 ns, 163662 iterations [ 0.936311] find_last_bit: 1165957 ns, 164018 iterations [ 1.697020] tsc: Refined TSC clocksource calibration: 2925.994 MHz [ 1.697602] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2a2d2ead42f, max_idle_ns: 440795314183 ns [ 1.841528] find_first_bit: 904460102 ns, 164019 iterations [ 1.842306] find_next_and_bit: 51811 cycles, 1 iterations [ 1.842909] [ 1.842909] Start testing find_bit() with sparse bitmap [ 1.843625] find_next_bit: 37586 ns, 656 iterations [ 1.848492] find_next_zero_bit: 4160674 ns, 327025 iterations [ 1.849202] find_last_bit: 20041 ns, 656 iterations [ 1.854170] find_first_bit: 4317191 ns, 656 iterations [ 1.854859] find_next_and_bit: 45414 cycles, 1 iterations [ 1.855543] test_firmware: interface ready [ 1.856279] Running rhashtable test nelem=8, max_size=0, shrinking=0 [ 1.856897] Test 00: [ 1.857200] Adding 50000 keys [ 1.939538] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 1.962566] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 1.963410] Deleting 50000 keys [ 1.998911] Duration of test: 141414658 ns [ 1.999365] Test 01: [ 1.999676] Adding 50000 keys [ 2.083822] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 2.107640] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 2.108439] Deleting 50000 keys [ 2.141674] Duration of test: 141644055 ns [ 2.142129] Test 02: [ 2.142377] Adding 50000 keys [ 2.224938] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 2.246349] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 2.247202] Deleting 50000 keys [ 2.281737] Duration of test: 139033256 ns [ 2.282205] Test 03: [ 2.282459] Adding 50000 keys [ 2.364279] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 2.387683] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 2.388478] Deleting 50000 keys [ 2.420742] Duration of test: 137951130 ns [ 2.433933] test if its possible to exceed max_size 8192: no, ok [ 2.434601] Average test time: 140010774 [ 2.435073] test inserting duplicates [ 2.435431] [ 2.435431] ---- ht: ---- [ 2.435431] bucket[1] -> [[ val 1 (tid=0) ]] -> [[ val 21 (tid=1) ]] [ 2.435431] ------------- [ 2.436701] [ 2.436701] ---- ht: ---- [ 2.436701] bucket[1] -> [[ val 1 (tid=2), val 1 (tid=0) ]] -> [[ val 21 (tid=1) ]] [ 2.436701] ------------- [ 2.438979] [ 2.438979] ---- ht: ---- [ 2.438979] bucket[1] -> [[ val 21 (tid=1) ]] -> [[ val 1 (tid=0) ]] [ 2.438979] ------------- [ 2.440225] [ 2.440225] ---- ht: ---- [ 2.440225] bucket[1] -> [[ val 21 (tid=1) ]] -> [[ val 1 (tid=2), val 1 (tid=0) ]] [ 2.440225] ------------- [ 2.441626] Testing concurrent rhashtable access from 10 threads [ 5.434093] rhashtable_thra (121) used greatest stack depth: 7236 bytes left [ 5.439994] rhashtable_thra (126) used greatest stack depth: 7116 bytes left [ 5.440910] rhashtable_thra (122) used greatest stack depth: 7100 bytes left [ 5.443974] test 3125 add/delete pairs into rhlist [ 5.522623] test 3125 random rhlist add/delete operations [ 5.543581] Started 10 threads, 0 failed, rhltable test returns 0 [ 5.544402] test_printf: all 240 tests passed [ 5.545014] xz_dec_test: module loaded [ 5.545387] xz_dec_test: Create a device node with 'mknod xz_dec_test c 250 0' and write .xz files to it. [ 5.547243] glob: 64 self-tests passed, 0 failed [ 5.548680] hgafb: HGA card not detected. [ 5.549126] hgafb: probe of hgafb.0 failed with error -22 [ 5.550128] uvesafb: failed to execute /sbin/v86d [ 5.550590] uvesafb: make sure that the v86d helper is installed and executable [ 5.551375] uvesafb: Getting VBE info block failed (eax=0x4f00, err=-2) [ 5.552101] uvesafb: vbe_init() failed with -22 [ 5.552551] uvesafb: probe of uvesafb.0 failed with error -22 [ 5.553218] intel_idle: does not run on family 6 model 6 [ 5.553748] ipmi message handler version 39.2 [ 5.554245] ipmi device interface [ 5.554591] IPMI System Interface driver. [ 5.555189] ipmi_si: Unable to find any System Interface(s) [ 5.555754] IPMI SSIF Interface driver [ 5.557134] IPMI Watchdog: driver initialized [ 5.557566] Copyright (C) 2004 MontaVista Software - IPMI Powerdown via sys_reboot. [ 5.559200] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 5.560078] ACPI: Power Button [PWRF] [ 5.560532] Warning: Processor Platform Limit event detected, but not handled. [ 5.561295] Consider compiling CPUfreq support into your kernel. [ 5.621163] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 5.647016] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 5.671016] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 5.673459] lp: driver loaded but no devices found [ 5.674036] DoubleTalk PC - not found [ 5.674474] toshiba: not a supported Toshiba laptop [ 5.675276] ppdev: user-space parallel port driver [ 5.675844] platform pc8736x_gpio.0: NatSemi pc8736x GPIO Driver Initializing [ 5.676544] platform pc8736x_gpio.0: no device found [ 5.677123] nsc_gpio initializing [ 5.677453] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds). [ 5.679297] parport_pc 00:04: reported by Plug and Play ACPI [ 5.680085] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] [ 5.680873] lp0: using parport0 (interrupt-driven). [ 5.683282] dummy-irq: no IRQ given. Use irq=N [ 5.683760] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti [ 5.684634] c2port c2port0: C2 port uc added [ 5.685084] c2port c2port0: uc flash has 30 blocks x 512 bytes (15360 bytes total) [ 5.686764] mtdoops: mtd device (mtddev=name/number) must be supplied [ 5.687450] platform physmap-flash.0: failed to claim resource 0: [mem 0x08000000-0x07ffffff] [ 5.688386] slram: not enough parameters. [ 5.721007] No valid DiskOnChip devices found [ 5.721511] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 5.722419] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 5.723346] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 5.724267] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 5.725171] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 5.726079] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 5.726965] nand: device found, Manufacturer ID: 0x98, Chip ID: 0x39 [ 5.727572] nand: Toshiba NAND 128MiB 1,8V 8-bit [ 5.728054] nand: 128 MiB, SLC, erase size: 16 KiB, page size: 512, OOB size: 16 [ 5.728771] flash size: 128 MiB [ 5.729103] page size: 512 bytes [ 5.729419] OOB area size: 16 bytes [ 5.729747] sector size: 16 KiB [ 5.730080] pages number: 262144 [ 5.730398] pages per sector: 32 [ 5.730712] bus width: 8 [ 5.730954] bits in sector size: 14 [ 5.731313] bits in page size: 9 [ 5.731616] bits in OOB size: 4 [ 5.731930] flash size with OOB: 135168 KiB [ 5.732359] page address bytes: 4 [ 5.732686] sector address bytes: 3 [ 5.733050] options: 0x42 [ 5.734098] Scanning device for bad blocks [ 5.755639] Creating 1 MTD partitions on "NAND 128MiB 1,8V 8-bit": [ 5.756418] 0x000000000000-0x000008000000 : "NAND simulator partition 0" [ 5.762567] [nandsim] warning: CONFIG_MTD_PARTITIONED_MASTER must be enabled to expose debugfs stuff [ 5.763836] LocalTalk card not found; 220 = ff, 240 = ff. [ 5.765340] mdio_bus fixed-0: GPIO lookup for consumer reset [ 5.765878] mdio_bus fixed-0: using lookup tables for GPIO lookup [ 5.766491] mdio_bus fixed-0: No GPIO consumer reset found [ 5.767186] libphy: Fixed MDIO Bus: probed [ 5.768454] ipddp.c:v0.01 8/28/97 Bradford W. Johnson [ 5.769639] ipddp0: Appletalk-IP Encap. mode by Bradford W. Johnson [ 5.770477] vcan: Virtual CAN interface driver [ 5.770917] vxcan: Virtual CAN Tunnel driver [ 5.771994] CAN device driver interface [ 5.772396] cc770: CAN netdevice driver [ 5.772762] cc770_isa: insufficient parameters supplied [ 5.773326] sja1000 CAN netdevice driver [ 5.774653] dsa-loop fixed-0:1f: DSA mockup driver: 0x1f [ 5.814164] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI [ 5.814828] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 6.035494] PCI Interrupt Link [LNKC] enabled at IRQ 11 [ 6.036053] PCI: setting IRQ 11 as level-triggered [ 6.364253] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56 [ 6.364943] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection [ 6.365643] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k [ 6.366222] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. [ 6.366815] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k [ 6.367469] igb: Copyright (c) 2007-2014 Intel Corporation. [ 6.368062] ixgbe: Intel(R) 10 Gigabit PCI Express Network Driver - version 5.1.0-k [ 6.368789] ixgbe: Copyright (c) 1999-2016 Intel Corporation. [ 6.370138] atp.c:v1.09=ac 2002/10/01 Donald Becker [ 6.370944] AX.25: Z8530 SCC driver version 3.0.dl1bke [ 6.371841] AX.25: bpqether driver version 004 [ 6.372286] baycom_ser_fdx: (C) 1996-2000 Thomas Sailer, HB9JNX/AE4WA [ 6.372286] baycom_ser_fdx: version 0.10 [ 6.374663] hdlcdrv: (C) 1996-2000 Thomas Sailer HB9JNX/AE4WA [ 6.375237] hdlcdrv: version 0.8 [ 6.375550] baycom_par: (C) 1996-2000 Thomas Sailer, HB9JNX/AE4WA [ 6.375550] baycom_par: version 0.9 [ 6.378454] NET3 PLIP version 2.4-parport gniibe@mri.co.jp [ 6.379033] plip0: Parallel port at 0x378, using IRQ 7. [ 6.379530] PPP generic driver version 2.4.2 [ 6.380124] PPP BSD Compression module registered [ 6.380583] PPP MPPE Compression module registered [ 6.381079] NET: Registered protocol family 24 [ 6.381515] DLCI driver v0.35, 4 Jan 1997, mike.mclagan@linux.org. [ 6.383969] SDLA driver v0.30, 12 Sep 1996, mike.mclagan@linux.org. [ 6.385162] Broadcom 43xx driver loaded [ Features: PNLS ] [ 6.385756] Broadcom 43xx-legacy driver loaded [ Features: PLI ] [ 6.491798] panel: panel driver registered on parport0 (io=0x378). [ 6.492528] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 6.494149] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 6.494996] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 6.496407] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 6.499144] i2c-parport: adapter type unspecified [ 6.499596] i2c-parport-light: adapter type unspecified [ 6.500844] isa i2c-pca-isa.0: Please specify I/O base [ 6.501486] Driver for 1-wire Dallas network protocol. [ 6.502082] DS1WM w1 busmaster driver - (c) 2004 Szabolcs Gyurko [ 6.502715] w1_f0d_init() [ 6.503451] intel_powerclamp: CPU does not support MWAIT [ 6.504519] mixcomwd: No card detected, or port not available [ 6.505169] acquirewdt: WDT driver for Acquire single board computer initialising [ 6.506109] acquirewdt: I/O address 0x0043 already in use [ 6.506634] acquirewdt: probe of acquirewdt failed with error -5 [ 6.507330] ib700wdt: WDT driver for IB700 single board computer initialising [ 6.508402] wafer5823wdt: WDT driver for Wafer 5823 single board computer initialising [ 6.509204] wafer5823wdt: I/O address 0x0443 already in use [ 6.509798] it87_wdt: no device [ 6.510156] sc1200wdt: build 20020303 [ 6.510529] sc1200wdt: io parameter must be specified [ 6.511065] sbc8360: failed to register misc device [ 6.511532] sbc7240_wdt: I/O address 0x0443 already in use [ 6.512995] cpu5wdt: misc_register failed [ 6.513384] w83877f_wdt: I/O address 0x0443 already in use [ 6.513902] w83977f_wdt: driver v1.00 [ 6.514288] w83977f_wdt: cannot register miscdev on minor=130 (err=-16) [ 6.514932] machzwd: MachZ ZF-Logic Watchdog driver initializing [ 6.515512] machzwd: no ZF-Logic found [ 6.516003] Bluetooth: Generic Bluetooth SDIO driver ver 0.1 [ 6.516772] CAPI 2.0 started up with major 68 (no middleware) [ 6.517342] Modular ISDN core version 1.1.29 [ 6.517921] NET: Registered protocol family 34 [ 6.518373] DSP module 2.0 [ 6.518651] mISDN_dsp: DSP clocks every 64 samples. This equals 8 jiffies. [ 6.520241] mISDN: Layer-1-over-IP driver Rev. 2.00 [ 6.520886] 0 virtual devices registered [ 6.521298] sdhci: Secure Digital Host Controller Interface driver [ 6.521893] sdhci: Copyright(c) Pierre Ossman [ 6.523004] sdhci-pltfm: SDHCI platform and OF driver helper [ 6.524361] ledtrig-cpu: registered to indicate activity on CPUs [ 6.527658] NET: Registered protocol family 4 [ 6.528191] comedi: version 0.7.76 - http://www.comedi.org [ 6.528851] LNetError: 1:0:(module.c:546:libcfs_init()) misc_register: error -16 [ 7.220272] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 [ 7.586283] BUG: unable to handle kernel NULL pointer dereference at 00000050 [ 7.586962] *pdpt = 0000000000000000 *pde = f000ff53f000ff53 [ 7.587002] Oops: 0000 [#1] PREEMPT [ 7.587002] CPU: 0 PID: 1 Comm: swapper Not tainted 4.17.0-rc1 #1 [ 7.587002] EIP: cfs_trace_lock_tcd+0xb/0xa0 [ 7.587002] EFLAGS: 00210246 CPU: 0 [ 7.587002] EAX: 00000000 EBX: 00000000 ECX: 81fcb588 EDX: 00000000 [ 7.587002] ESI: 00001800 EDI: 8f5d1e08 EBP: 8f5d1d7c ESP: 8f5d1d70 [ 7.587002] DS: 007b ES: 007b FS: 0000 GS: 00e0 SS: 0068 [ 7.587002] CR0: 80050033 CR2: 00000050 CR3: 022f0000 CR4: 000006b0 [ 7.587002] Call Trace: [ 7.587002] libcfs_debug_vmsg2+0x8f/0x82f [ 7.587002] ? trace_irq_enable_rcuidle+0x25/0x62 [ 7.587002] ? slob_free+0x249/0x251 [ 7.587002] libcfs_debug_msg+0x19/0x1b [ 7.587002] ksocknal_startup+0xe77/0x12b2 [ 7.587002] ? lock_release+0x135/0x1ec [ 7.587002] ? _raw_spin_unlock+0x3c/0x4b [ 7.587002] lnet_startup_lndni+0x4cd/0x9ec [ 7.587002] LNetNIInit+0x880/0xa00 [ 7.587002] ? read_seqcount_retry+0x1b/0x22 [ 7.587002] srpc_startup+0x84/0x381 [ 7.587002] lnet_selftest_init+0x2c4/0x5d9 [ 7.587002] ? lnet_selftest_exit+0x8d/0x8d [ 7.587002] do_one_initcall+0x76/0x1d7 [ 7.587002] ? do_early_param+0x78/0x78 [ 7.587002] ? rcu_read_unlock_sched_notrace+0x1e/0x2d [ 7.587002] ? trace_initcall_level+0x3e/0x64 [ 7.587002] kernel_init_freeable+0xfc/0x177 [ 7.587002] ? rest_init+0xbe/0xbe [ 7.587002] kernel_init+0xd/0xd0 [ 7.587002] ret_from_fork+0x2e/0x38 [ 7.587002] Code: 16 94 ff 8b 15 68 ab 03 82 f7 c2 00 00 0f 00 b8 02 00 00 00 75 08 31 c0 80 e6 ff 0f 95 c0 5d c3 55 89 e5 57 56 53 e8 99 16 94 ff <8b> 78 50 89 d6 6a 00 31 d2 89 c3 b8 50 f0 1b 82 66 83 ff 02 0f [ 7.587002] EIP: cfs_trace_lock_tcd+0xb/0xa0 SS:ESP: 0068:8f5d1d70 [ 7.587002] CR2: 0000000000000050 [ 7.587002] ---[ end trace 4fbdcb515c61525e ]--- [ 7.587002] Kernel panic - not syncing: Fatal exception [ 7.587002] Kernel Offset: disabled Elapsed time: 10 #!/bin/bash # To reproduce, # 1) save job-script and this script (both are attached in 0day report email) # 2) run this script with your compiled kernel and optional env $INSTALL_MOD_PATH kernel=$1 initrds=( /osimage/yocto/yocto-tiny-i386-2016-04-22.cgz /lkp/lkp/lkp-i386.cgz /osimage/deps/debian-x86_64-2016-08-31.cgz/run-ipconfig.i386_2016-09-03.cgz ) HTTP_PREFIX=https://github.com/0day-ci/lkp-qemu/raw/master wget --timestamping "${initrds[@]/#/$HTTP_PREFIX}" { cat "${initrds[@]//*\//}" [[ $INSTALL_MOD_PATH ]] && ( cd "$INSTALL_MOD_PATH" find lib | cpio -o -H newc --quiet | gzip ) echo job-script | cpio -o -H newc --quiet | gzip } > initrd.img kvm=( qemu-system-i386 -enable-kvm -kernel $kernel -initrd initrd.img -m 256 -smp 1 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -watchdog-action debug -rtc base=localtime -serial stdio -display none -monitor null ) append=( ip=::::vm-lkp-nhm-dp1-yocto-i386-7::dhcp root=/dev/ram0 user=lkp job=/job-script ARCH=i386 kconfig=i386-randconfig-s1-201814 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/i386-randconfig-s1-201814/gcc-6/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-nhm-dp1-yocto-i386/yocto-tiny-i386-2016-04-22.cgz/i386-randconfig-s1-201814/gcc-6/60cc43fc888428bb2f18f08997432d426a243338/0 result_service=tmpfs debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw drbd.minor_count=8 rcuperf.shutdown=0 ) "${kvm[@]}" -append "${append[*]}"