early console in setup code Probing EDD (edd=off to disable)... ok [ 0.000000] Linux version 4.17.0-rc1 (kbuild@lkp-snb01) (gcc version 7.3.0 (Debian 7.3.0-1)) #1 Mon Apr 16 21:33:07 CST 2018 [ 0.000000] Command line: ip=::::vm-lkp-nhm-dp1-openwrt-ia32-9::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-nhm-dp1-openwrt-ia32-9/trinity-300s-openwrt-i386-2016-03-16.cgz-60cc43fc888428bb2f18f08997432d426a243338-20180416-43017-1tb39m3-wait_kernel-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s5-04161820 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s5-04161820/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-nhm-dp1-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-s5-04161820/gcc-7/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=tt [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] Centaur CentaurHauls [ 0.000000] x86/fpu: x87 FPU will use FXSAVE [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000001a3dffff] usable [ 0.000000] BIOS-e820: [mem 0x000000001a3e0000-0x000000001a3fffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] e820: last_pfn = 0x1a3e0 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC [ 0.000000] Scan for SMP in [mem 0x00000000-0x000003ff] [ 0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff] [ 0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff] [ 0.000000] found SMP MP-table at [mem 0x000f6aa0-0x000f6aaf] mapped at [ (ptrval)] [ 0.000000] mpc: f6ab0-f6b80 [ 0.000000] Base memory trampoline at [ (ptrval)] 99000 size 24576 [ 0.000000] BRK [0x14448000, 0x14448fff] PGTABLE [ 0.000000] BRK [0x14449000, 0x14449fff] PGTABLE [ 0.000000] BRK [0x1444a000, 0x1444afff] PGTABLE [ 0.000000] BRK [0x1444b000, 0x1444bfff] PGTABLE [ 0.000000] RAMDISK: [mem 0x19fa7000-0x1a3dffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F68D0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x000000001A3E15CE 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x000000001A3E142A 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x000000001A3E0040 0013EA (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x000000001A3E0000 000040 [ 0.000000] ACPI: APIC 0x000000001A3E151E 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x000000001A3E1596 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fc000 ( fee00000) [ 0.000000] kvm-clock: cpu 0, msr 0:19fa5001, primary cpu clock [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 5039024823 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] Zone ranges: [ 0.000000] DMA32 [mem 0x0000000000001000-0x000000001a3dffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x000000001a3dffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000001a3dffff] [ 0.000000] On node 0 totalpages: 107390 [ 0.000000] DMA32 zone: 1680 pages used for memmap [ 0.000000] DMA32 zone: 21 pages reserved [ 0.000000] DMA32 zone: 107390 pages, LIFO batch:31 [ 0.000000] Reserved but unavailable: 98 pages [ 0.000000] kasan: KernelAddressSanitizer initialized [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04 [ 0.000000] ACPI: IRQ5 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08 [ 0.000000] ACPI: IRQ9 used by override. [ 0.000000] ACPI: IRQ10 used by override. [ 0.000000] ACPI: IRQ11 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] mapped IOAPIC to ffffffffff5fb000 (fec00000) [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 118d0300 [ 0.000000] e820: [mem 0x1a400000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 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: 105689 [ 0.000000] Kernel command line: ip=::::vm-lkp-nhm-dp1-openwrt-ia32-9::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-nhm-dp1-openwrt-ia32-9/trinity-300s-openwrt-i386-2016-03-16.cgz-60cc43fc888428bb2f18f08997432d426a243338-20180416-43017-1tb39m3-wait_kernel-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s5-04161820 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s5-04161820/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-nhm-dp1-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-s5-04161820/gcc-7/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 con [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) [ 0.000000] Memory: 212148K/429560K available (69644K kernel code, 14684K rwdata, 15036K rodata, 2400K init, 20320K bss, 217412K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Kernel/User page tables isolation: enabled [ 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.010000] NR_IRQS: 4352, nr_irqs: 48, preallocated irqs: 16 [ 0.010000] console [ttyS0] enabled [ 0.010000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.010000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.010000] ... MAX_LOCK_DEPTH: 48 [ 0.010000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.010000] ... CLASSHASH_SIZE: 4096 [ 0.010000] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.010000] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.010000] ... CHAINHASH_SIZE: 32768 [ 0.010000] memory used by lock dependency info: 7871 kB [ 0.010000] per task-struct memory footprint: 2688 bytes [ 0.010000] ------------------------ [ 0.010000] | Locking API testsuite: [ 0.010000] ---------------------------------------------------------------------------- [ 0.010000] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.010000] -------------------------------------------------------------------------- [ 0.010000] A-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.010000] A-B-B-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.010000] A-B-B-C-C-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.010000] A-B-C-A-B-C deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.010000] A-B-B-C-C-D-D-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.010000] A-B-C-D-B-D-D-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.010000] A-B-C-D-B-C-D-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.010000] double unlock: ok | ok | ok | ok | ok | ok | ok | [ 0.010000] initialize held: ok | ok | ok | ok | ok | ok | ok | [ 0.010000] -------------------------------------------------------------------------- [ 0.010000] recursive read-lock: | ok | |failed| [ 0.010000] recursive read-lock #2: | ok | |failed| [ 0.010000] mixed read-write-lock: |failed| |failed| [ 0.010000] mixed write-read-lock: |failed| |failed| [ 0.010000] mixed read-lock/lock-write ABBA: |failed| |failed| [ 0.010000] mixed read-lock/lock-read ABBA: | ok | |failed| [ 0.010000] mixed write-lock/lock-write ABBA: |failed| |failed| [ 0.010000] -------------------------------------------------------------------------- [ 0.010000] hard-irqs-on + irq-safe-A/12:failed|failed| ok | [ 0.010000] soft-irqs-on + irq-safe-A/12:failed|failed| ok | [ 0.010000] hard-irqs-on + irq-safe-A/21:failed|failed| ok | [ 0.010000] soft-irqs-on + irq-safe-A/21:failed|failed| ok | [ 0.010000] sirq-safe-A => hirqs-on/12:failed|failed| ok | [ 0.010000] sirq-safe-A => hirqs-on/21:failed|failed| ok | [ 0.010000] hard-safe-A + irqs-on/12:failed|failed| ok | [ 0.010000] soft-safe-A + irqs-on/12:failed|failed| ok | [ 0.010000] hard-safe-A + irqs-on/21:failed|failed| ok | [ 0.010000] soft-safe-A + irqs-on/21:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #1/123:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #1/123:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #1/132:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #1/132:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #1/213:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #1/213:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #1/231:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #1/231:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #1/312:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #1/312:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #1/321:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #1/321:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #2/123:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #2/123:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #2/132:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #2/132:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #2/213:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #2/213:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #2/231:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #2/231:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #2/312:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #2/312:failed|failed| ok | [ 0.010000] hard-safe-A + unsafe-B #2/321:failed|failed| ok | [ 0.010000] soft-safe-A + unsafe-B #2/321:failed|failed| ok | [ 0.010000] hard-irq lock-inversion/123:failed|failed| ok | [ 0.010000] soft-irq lock-inversion/123:failed|failed| ok | [ 0.010000] hard-irq lock-inversion/132:failed|failed| ok | [ 0.010000] soft-irq lock-inversion/132:failed|failed| ok | [ 0.010000] hard-irq lock-inversion/213:failed|failed| ok | [ 0.010000] soft-irq lock-inversion/213:failed|failed| ok | [ 0.010000] hard-irq lock-inversion/231:failed|failed| ok | [ 0.010000] soft-irq lock-inversion/231:failed|failed| ok | [ 0.010000] hard-irq lock-inversion/312:failed|failed| ok | [ 0.010000] soft-irq lock-inversion/312:failed|failed| ok | [ 0.010000] hard-irq lock-inversion/321:failed|failed| ok | [ 0.010000] soft-irq lock-inversion/321:failed|failed| ok | [ 0.010000] hard-irq read-recursion/123: ok | [ 0.010000] soft-irq read-recursion/123: ok | [ 0.010000] hard-irq read-recursion/132: ok | [ 0.010000] soft-irq read-recursion/132: ok | [ 0.010000] hard-irq read-recursion/213: ok | [ 0.010000] soft-irq read-recursion/213: ok | [ 0.010000] hard-irq read-recursion/231: ok | [ 0.010000] soft-irq read-recursion/231: ok | [ 0.010000] hard-irq read-recursion/312: ok | [ 0.010000] soft-irq read-recursion/312: ok | [ 0.010000] hard-irq read-recursion/321: ok | [ 0.010000] soft-irq read-recursion/321: ok | [ 0.010000] -------------------------------------------------------------------------- [ 0.010000] | Wound/wait tests | [ 0.010000] --------------------- [ 0.010000] ww api failures: ok | ok | ok | [ 0.010000] ww contexts mixing:failed| ok | [ 0.010000] finishing ww context: ok | ok | ok | ok | [ 0.010000] locking mismatches: ok | ok | ok | [ 0.010000] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 0.010000] spinlock nest unlocked: ok | [ 0.010000] ----------------------------------------------------- [ 0.010000] |block | try |context| [ 0.010000] ----------------------------------------------------- [ 0.010000] context:failed| ok | ok | [ 0.010000] try:failed| ok |failed| [ 0.010000] block:failed| ok |failed| [ 0.010000] spinlock:failed| ok |failed| [ 0.010000] -------------------------------------------------------- [ 0.010000] 153 out of 262 testcases failed, as expected. | [ 0.010000] ---------------------------------------------------- [ 0.010000] ACPI: Core revision 20180313 [ 0.010000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.010000] hpet clockevent registered [ 0.010135] APIC: Switch to symmetric I/O mode setup [ 0.011114] enabled ExtINT on CPU#0 [ 0.013048] ENABLING IO-APIC IRQs [ 0.013837] init IO_APIC IRQs [ 0.014363] apic 0 pin 0 not connected [ 0.015216] IOAPIC[0]: Set routing entry (0-1 -> 0xef -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.016670] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.018079] IOAPIC[0]: Set routing entry (0-3 -> 0xef -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-4 -> 0xef -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-5 -> 0xef -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-6 -> 0xef -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-7 -> 0xef -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-8 -> 0xef -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-9 -> 0xef -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-10 -> 0xef -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-11 -> 0xef -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-12 -> 0xef -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-13 -> 0xef -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-14 -> 0xef -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.020000] IOAPIC[0]: Set routing entry (0-15 -> 0xef -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.020000] apic 0 pin 16 not connected [ 0.020000] apic 0 pin 17 not connected [ 0.020000] apic 0 pin 18 not connected [ 0.020000] apic 0 pin 19 not connected [ 0.020000] apic 0 pin 20 not connected [ 0.020000] apic 0 pin 21 not connected [ 0.020000] apic 0 pin 22 not connected [ 0.020000] apic 0 pin 23 not connected [ 0.020000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.020000] tsc: Detected 2925.998 MHz processor [ 0.020000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2a2d3295deb, max_idle_ns: 440795332860 ns [ 0.020057] Calibrating delay loop (skipped) preset value.. 5851.99 BogoMIPS (lpj=29259980) [ 0.021393] pid_max: default: 4096 minimum: 301 [ 0.023851] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.024951] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.034708] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.035617] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.036605] CPU: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3) [ 0.038033] Spectre V2 : Spectre mitigation: kernel not compiled with retpoline; no mitigation available! [ 0.046070] Performance Events: PMU not available due to virtualization, using software events only. [ 0.077542] NMI watchdog: Perf event create on CPU 0 failed with -2 [ 0.078635] NMI watchdog: Perf NMI watchdog permanently disabled [ 0.080219] Using local APIC timer interrupts. [ 0.080219] calibrating APIC timer ... [ 0.090000] ... lapic delta = 6250714 [ 0.090000] ... PM-Timer delta = 358006 [ 0.090000] ... PM-Timer result ok [ 0.090000] ..... delta 6250714 [ 0.090000] ..... mult: 268466122 [ 0.090000] ..... calibration result: 10001142 [ 0.090000] ..... CPU clock speed is 2926.4153 MHz. [ 0.090000] ..... host bus clock speed is 1000.1142 MHz. [ 0.090000] devtmpfs: initialized [ 0.125986] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 0.127584] futex hash table entries: 16 (order: -2, 1536 bytes) [ 0.131054] xor: measuring software checksum speed [ 0.230015] prefetch64-sse: 9437.600 MB/sec [ 0.330020] generic_sse: 3428.400 MB/sec [ 0.330755] xor: using function: prefetch64-sse (9437.600 MB/sec) [ 0.340223] NET: Registered protocol family 16 [ 0.353426] cpuidle: using governor ladder [ 0.354130] cpuidle: using governor menu [ 0.358339] ACPI: bus type PCI registered [ 0.359021] PCI: Using configuration type 1 for base access [ 0.738677] cryptd: max_cpu_qlen set to 1000 [ 0.910033] raid6: sse2x1 gen() 3599 MB/s [ 1.080025] raid6: sse2x1 xor() 2526 MB/s [ 1.250025] raid6: sse2x2 gen() 4272 MB/s [ 1.420019] raid6: sse2x2 xor() 3360 MB/s [ 1.590022] raid6: sse2x4 gen() 4786 MB/s [ 1.760024] raid6: sse2x4 xor() 2929 MB/s [ 1.760866] raid6: using algorithm sse2x4 gen() 4786 MB/s [ 1.766032] raid6: .... xor() 2929 MB/s, rmw enabled [ 1.766998] raid6: using intx1 recovery algorithm [ 1.770445] gpio-f7188x: Not a Fintek device at 0x0000002e [ 1.771634] gpio-f7188x: Not a Fintek device at 0x0000004e [ 1.791270] ACPI: Added _OSI(Module Device) [ 1.792044] ACPI: Added _OSI(Processor Device) [ 1.792892] ACPI: Added _OSI(3.0 _SCP Extensions) [ 1.793792] ACPI: Added _OSI(Processor Aggregator Device) [ 1.794904] ACPI: Added _OSI(Linux-Dell-Video) [ 2.023851] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 2.055337] workqueue: round-robin CPU selection forced, expect performance impact [ 2.094412] ACPI: Interpreter enabled [ 2.095576] ACPI: (supports S0 S3 S5) [ 2.096290] ACPI: Using IOAPIC for interrupt routing [ 2.097937] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 2.107679] ACPI: Enabled 2 GPEs in block 00 to 0F [ 2.542179] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 2.543334] acpi PNP0A03:00: _OSC: OS supports [Segments] [ 2.544998] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 2.548348] PCI host bridge to bus 0000:00 [ 2.549055] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 2.550053] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 2.551218] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 2.560021] pci_bus 0000:00: root bus resource [mem 0x1a400000-0xfebfffff window] [ 2.561225] pci_bus 0000:00: root bus resource [bus 00-ff] [ 2.566306] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 2.577888] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 2.586564] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 2.592801] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f] [ 2.595903] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 2.597128] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 2.598594] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 2.599734] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 2.607043] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 2.608897] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 2.610039] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 2.639059] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 [ 2.647882] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] [ 2.658247] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff] [ 2.680092] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 2.690816] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 2.693495] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff] [ 2.695976] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 2.704813] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 2.715247] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000 [ 2.717089] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f] [ 2.731016] pci_bus 0000:00: on NUMA node 0 [ 2.801853] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 2.814096] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 2.820567] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 2.826770] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 2.830185] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 2.840214] pci 0000:00:02.0: vgaarb: setting as boot VGA device [ 2.841165] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [ 2.842576] pci 0000:00:02.0: vgaarb: bridge control possible [ 2.843521] vgaarb: loaded [ 2.855334] SCSI subsystem initialized [ 2.856615] ACPI: bus type USB registered [ 2.858126] usbcore: registered new interface driver usbfs [ 2.859415] usbcore: registered new interface driver hub [ 2.860343] usbcore: registered new device driver usb [ 2.864357] pps_core: LinuxPPS API ver. 1 registered [ 2.865205] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 2.867046] EDAC MC: Ver: 3.0.0 [ 2.881932] FPGA manager framework [ 2.883236] PCI: Using ACPI for IRQ routing [ 2.890029] PCI: pci_cache_line_size set to 64 bytes [ 2.890991] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 2.900075] e820: reserve RAM buffer [mem 0x1a3e0000-0x1bffffff] [ 2.911583] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2) [ 2.923507] clocksource: Switched to clocksource kvm-clock [ 3.908555] VFS: Disk quotas dquot_6.6.0 [ 3.909474] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 3.916880] FS-Cache: Loaded [ 3.922534] CacheFiles: Loaded [ 3.923760] pnp: PnP ACPI init [ 3.930393] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 3.933174] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 3.935872] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 3.942454] pnp 00:03: [dma 2] [ 3.943753] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 3.947607] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 3.957106] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 3.966058] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 4.008622] pnp: PnP ACPI: found 7 devices [ 4.028467] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 4.031736] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 4.032836] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 4.033766] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 4.034829] pci_bus 0000:00: resource 7 [mem 0x1a400000-0xfebfffff window] [ 4.039712] NET: Registered protocol family 2 [ 4.043995] tcp_listen_portaddr_hash hash table entries: 256 (order: 2, 22528 bytes) [ 4.061448] TCP established hash table entries: 4096 (order: 3, 32768 bytes) [ 4.062676] TCP bind hash table entries: 4096 (order: 6, 327680 bytes) [ 4.064451] TCP: Hash tables configured (established 4096 bind 4096) [ 4.065823] UDP hash table entries: 256 (order: 3, 49152 bytes) [ 4.066889] UDP-Lite hash table entries: 256 (order: 3, 49152 bytes) [ 4.074295] NET: Registered protocol family 1 [ 4.078654] RPC: Registered named UNIX socket transport module. [ 4.079620] RPC: Registered udp transport module. [ 4.080529] RPC: Registered tcp transport module. [ 4.081277] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 4.082284] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 4.083258] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 4.084180] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 4.085342] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [ 4.086687] PCI: CLS 0 bytes, default 64 [ 4.089392] Unpacking initramfs... [ 9.726472] Freeing initrd memory: 4324K [ 9.742016] cryptomgr_test (25) used greatest stack depth: 28096 bytes left [ 9.747416] cryptomgr_test (33) used greatest stack depth: 27272 bytes left [ 9.748648] PCLMULQDQ-NI instructions are not detected. [ 9.749508] AVX or AES-NI instructions are not detected. [ 9.750399] CPU feature 'AVX registers' is not supported. [ 9.751170] CPU feature 'AVX registers' is not supported. [ 9.751956] CPU feature 'AVX registers' is not supported. [ 9.752791] CPU feature 'AVX registers' is not supported. [ 9.753631] AVX2 or AES-NI instructions are not detected. [ 9.754534] AVX2 instructions are not detected. [ 9.756778] 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 [ 9.759439] spin_lock-torture: Creating torture_shuffle task [ 9.760935] spin_lock-torture: Creating torture_stutter task [ 9.761956] spin_lock-torture: torture_shuffle task started [ 9.763148] spin_lock-torture: Creating lock_torture_writer task [ 9.764274] spin_lock-torture: torture_stutter task started [ 9.765248] spin_lock-torture: Creating lock_torture_writer task [ 9.766446] spin_lock-torture: lock_torture_writer task started [ 9.767525] spin_lock-torture: Creating lock_torture_stats task [ 9.768637] spin_lock-torture: lock_torture_writer task started [ 9.770131] spin_lock-torture: lock_torture_stats task started [ 10.800251] tsc: Refined TSC clocksource calibration: 2925.999 MHz [ 10.801316] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2a2d33743a4, max_idle_ns: 440795298620 ns [ 16.459919] torture_init_begin: Refusing rcu init: spin_lock running. [ 16.477172] torture_init_begin: One torture test at a time! [ 16.503875] Key type blacklist registered [ 16.505322] workingset: timestamp_bits=62 max_order=16 bucket_order=0 [ 16.782214] zbud: loaded [ 16.973136] NFS: Registering the id_resolver key type [ 16.974113] Key type id_resolver registered [ 16.974814] Key type id_legacy registered [ 17.003339] efs: 1.0a - http://aeschi.ch.eu.org/efs/ [ 17.061085] QNX4 filesystem 0.2.3 registered. [ 17.078515] befs: version: 0.9.3 [ 17.141874] gfs2: GFS2 installed [ 17.144117] pstore: using deflate compression [ 17.236284] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 17.255658] io scheduler noop registered [ 17.260140] io scheduler cfq registered (default) [ 17.260956] io scheduler mq-deadline registered [ 17.276485] io scheduler bfq registered [ 18.465011] String selftests succeeded [ 18.469461] test_string_helpers: Running tests... [ 18.481458] [ 18.481458] Start testing find_bit() with random-filled bitmap [ 18.501322] find_next_bit: 16108573 ns, 163681 iterations [ 18.504410] find_next_zero_bit: 1957092 ns, 164000 iterations [ 18.507411] find_last_bit: 1836178 ns, 163681 iterations [ 19.824193] find_first_bit: 1315653500 ns, 163682 iterations [ 19.825350] find_next_and_bit: 78436 cycles, 1 iterations [ 19.845682] [ 19.845682] Start testing find_bit() with sparse bitmap [ 19.846828] find_next_bit: 32454 ns, 656 iterations [ 19.851920] find_next_zero_bit: 4045500 ns, 327025 iterations [ 19.853057] find_last_bit: 29663 ns, 656 iterations [ 19.868996] find_first_bit: 14968472 ns, 656 iterations [ 19.870166] find_next_and_bit: 75524 cycles, 1 iterations [ 20.050228] test_firmware: interface ready [ 20.073198] test_hash: __hash_32() has no arch implementation to test. [ 20.074145] test_hash: hash_32() has no arch implementation to test. [ 20.075079] test_hash: hash_64() has no arch implementation to test. [ 20.076052] test_hash: 33152 tests passed. [ 20.076749] test_siphash: self-tests: pass [ 20.092259] test passed [ 20.092984] test_bitmap: test 13: input is '0-2047:128/256' OK, Time: 2240 [ 20.106260] test_bitmap: all 1524 tests passed [ 20.106947] test_uuid: all 18 tests passed [ 20.110430] crc32: CRC_LE_BITS = 8, CRC_BE BITS = 8 [ 20.111201] crc32: self tests passed, processed 225944 bytes in 1394117 nsec [ 20.113780] crc32c: CRC_LE_BITS = 8 [ 20.114307] crc32c: self tests passed, processed 225944 bytes in 732515 nsec [ 20.211902] crc32_combine: 8373 self tests passed [ 20.305782] crc32c_combine: 8373 self tests passed [ 20.307172] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 20.308250] glob: 64 self-tests passed, 0 failed [ 20.334762] rbtree testing [ 20.365913] -> test 1 (latency of nnodes insert+delete): 91005 cycles [ 20.399439] -> test 2 (latency of nnodes cached insert+delete): 93866 cycles [ 20.402750] -> test 3 (latency of inorder traversal): 6222 cycles [ 20.403795] -> test 4 (latency to fetch first node) [ 20.404620] non-cached: 74 cycles [ 20.405272] cached: 0 cycles [ 20.505935] augmented rbtree testing [ 20.541747] -> test 1 (latency of nnodes insert+delete): 104737 cycles [ 20.580119] -> test 2 (latency of nnodes cached insert+delete): 107894 cycles [ 20.719449] interval tree insert/remove [ 20.754880] -> 103607 cycles [ 20.755975] interval tree search [ 20.883861] -> 374098 cycles (2692 results) [ 20.892070] gpio_winbond: chip ID at 2e is ffff [ 20.892778] gpio_winbond: not an our chip [ 20.893496] gpio_winbond: chip ID at 4e is ffff [ 20.894183] gpio_winbond: not an our chip [ 20.908740] cpcihp_zt5550: ZT5550 CompactPCI Hot Plug Driver version: 0.2 [ 20.910332] cpcihp_generic: Generic port I/O CompactPCI Hot Plug Driver version: 0.1 [ 20.911473] cpcihp_generic: not configured, disabling. [ 20.912535] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 20.974023] rivafb_setup START [ 20.976708] VIA Graphics Integration Chipset framebuffer 2.4 initializing [ 20.980541] vmlfb: initializing [ 20.981446] Could not find Carillo Ranch MCH device. [ 20.982780] no IO addresses supplied [ 20.984898] usbcore: registered new interface driver udlfb [ 20.986201] intel_idle: does not run on family 6 model 6 [ 20.989725] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 20.991354] ACPI: Power Button [PWRF] [ 21.438642] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 21.466888] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 21.493208] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 21.511035] Applicom driver: $Id: ac.c,v 1.30 2000/03/22 16:03:57 dwmw2 Exp $ [ 21.512212] ac.o: No PCI boards found. [ 21.512837] ac.o: For an ISA board you must supply memory and irq parameters. [ 21.514790] Non-volatile memory driver v1.3 [ 21.515630] telclk_interrupt = 0xf non-mcpbl0010 hw. [ 21.516484] Linux agpgart interface v0.103 [ 21.519189] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds). [ 21.526775] [drm] radeon kernel modesetting enabled. [ 21.531454] [drm] amdgpu kernel modesetting enabled. [ 21.536125] [drm] Initialized vgem 1.0.0 20120112 for virtual device on minor 0 [ 21.544502] dummy-irq: no IRQ given. Use irq=N [ 21.547372] lkdtm: No crash points registered, enable through debugfs [ 21.548899] Phantom Linux Driver, version n0.9.8, init OK [ 21.551093] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti [ 21.555010] Guest personality initialized and is inactive [ 21.560243] VMCI host device registered (name=vmci, major=10, minor=57) [ 21.561314] Initialized host personality [ 21.563405] usbcore: registered new interface driver rtsx_usb [ 21.569781] Uniform Multi-Platform E-IDE driver [ 21.573705] ide_generic: please use "probe_mask=0x3f" module parameter for probing all legacy ISA IDE ports [ 21.574732] ide-gd driver 1.18 [ 21.579222] Loading Adaptec I2O RAID: Version 2.4 Build 5go [ 21.579810] Detecting Adaptec I2O RAID controllers... [ 21.580875] aic94xx: Adaptec aic94xx SAS/SATA driver version 1.0.3 loaded [ 21.584399] isci: Intel(R) C600 SAS Controller Driver - version 1.2.0 [ 21.586239] Microsemi PQI Driver (v1.1.4-115) [ 21.587753] megasas: 07.704.04.00-rc1 [ 21.588556] mpt3sas version 17.100.00.00 loaded [ 21.591023] 3ware Storage Controller device driver for Linux v1.26.02.003. [ 21.591929] 3ware 9000 Storage Controller device driver for Linux v2.26.02.014. [ 21.592899] LSI 3ware SAS/SATA-RAID Controller device driver for Linux v3.26.02.000. [ 21.594266] RocketRAID 3xxx/4xxx Controller driver v1.10.0 [ 21.595390] stex: Promise SuperTrak EX Driver version: 6.02.0000.01 [ 21.599893] VMware PVSCSI driver - version 1.0.7.0-k [ 21.601018] st: Version 20160209, fixed bufsize 32768, s/g segs 256 [ 21.602498] osst :I: Tape driver with OnStream support version 0.99.4 [ 21.602498] osst :I: $Id: osst.c,v 1.73 2005/01/01 21:13:34 wriede Exp $ [ 21.607813] SCSI Media Changer driver v0.25 [ 21.609777] osd: LOADED open-osd 0.2.1 [ 21.619863] mtdoops: mtd device (mtddev=name/number) must be supplied [ 21.621314] slram: not enough parameters. [ 21.621974] Ramix PMC551 PCI Mezzanine Ram Driver. (C) 1999,2000 Nortel Networks. [ 21.623084] pmc551: not detected [ 21.634737] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI [ 21.635857] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 28.572726] PCI Interrupt Link [LNKC] enabled at IRQ 11 [ 29.281263] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56 [ 29.282300] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection [ 29.283732] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k [ 29.284645] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. [ 29.286023] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k [ 29.287023] igb: Copyright (c) 2007-2014 Intel Corporation. [ 29.288190] ixgbe: Intel(R) 10 Gigabit PCI Express Network Driver - version 5.1.0-k [ 29.289416] ixgbe: Copyright (c) 1999-2016 Intel Corporation. [ 29.297494] usbcore: registered new interface driver hwa-rc [ 29.298635] usbcore: registered new interface driver i1480-dfu-usb [ 29.302081] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 29.303182] ehci-platform: EHCI generic platform driver [ 29.305411] fotg210_hcd: FOTG210 Host Controller (EHCI) Driver [ 29.307937] usbcore: registered new interface driver usblp [ 29.309196] usbcore: registered new interface driver cdc_wdm [ 29.310395] usbcore: registered new interface driver usbtmc [ 29.311690] usbcore: registered new interface driver mdc800 [ 29.312514] mdc800: v0.7.5 (30/10/2000):USB Driver for Mustek MDC800 Digital Camera [ 29.313938] usbcore: registered new interface driver microtekX6 [ 29.315127] usbcore: registered new interface driver adutux [ 29.316260] usbcore: registered new interface driver appledisplay [ 29.317405] usbcore: registered new interface driver cytherm [ 29.318478] usbcore: registered new interface driver emi62 - firmware loader [ 29.319848] usbcore: registered new interface driver idmouse [ 29.321114] usbcore: registered new interface driver iowarrior [ 29.322266] usbcore: registered new interface driver isight_firmware [ 29.323650] usbcore: registered new interface driver usblcd [ 29.324867] usbcore: registered new interface driver ldusb [ 29.326030] usbcore: registered new interface driver legousbtower [ 29.327266] usbcore: registered new interface driver usbtest [ 29.328376] usbcore: registered new interface driver usb_ehset_test [ 29.329685] usbcore: registered new interface driver usbsevseg [ 29.331407] usbcore: registered new interface driver sisusb [ 29.336208] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 29.340054] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 29.340890] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 29.365818] mousedev: PS/2 mouse device common for all mice [ 29.366759] evbug: Connected device: input0 (Power Button at LNXPWRBN/button/input0) [ 29.378176] usbcore: registered new interface driver appletouch [ 29.380939] usbcore: registered new interface driver synaptics_usb [ 29.382443] usbcore: registered new interface driver aiptek [ 29.383564] usbcore: registered new interface driver gtco [ 29.395217] usbcore: registered new interface driver hanwang [ 29.396315] usbcore: registered new interface driver pegasus_notetaker [ 29.466521] usbcore: registered new interface driver usbtouchscreen [ 29.490564] usbcore: registered new interface driver i2c-diolan-u2c [ 29.491573] i2c-parport: adapter type unspecified [ 29.492318] i2c-parport-light: adapter type unspecified [ 29.493427] usbcore: registered new interface driver RobotFuzz Open Source InterFace, OSIF [ 29.495930] pps_parport: parallel port PPS client [ 29.507218] Driver for 1-wire Dallas network protocol. [ 29.509547] usbcore: registered new interface driver DS9490R [ 29.510839] w1_f0d_init() [ 29.545488] pc87360: PC8736x not detected, module not inserted [ 29.549415] intel_powerclamp: CPU does not support MWAIT [ 29.555641] sdhci: Secure Digital Host Controller Interface driver [ 29.556635] sdhci: Copyright(c) Pierre Ossman [ 29.558366] VUB300 Driver rom wait states = 1C irqpoll timeout = 0400 [ 29.560950] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 29.565807] evbug: Connected device: input1 (AT Translated Set 2 keyboard at isa0060/serio0/input0) [ 29.570462] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 29.573463] evbug: Connected device: input4 (VirtualPS/2 VMware VMMouse at isa0060/serio1/input1) [ 29.576526] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 29.606715] evbug: Connected device: input3 (VirtualPS/2 VMware VMMouse at isa0060/serio1/input0) [ 29.610099] usbcore: registered new interface driver vub300 [ 29.650124] usbcore: registered new interface driver usbhid [ 29.651059] usbhid: USB HID core driver [ 29.657031] no options. [ 29.658305] FPGA DOWNLOAD ---> [ 29.658769] FPGA image file name: xlinx_fpga_firmware.bit [ 29.660280] GPIO INIT FAIL!! [ 29.685585] usbcore: registered new interface driver es2_ap_driver [ 29.687260] greybus: registered new driver gb-firmware [ 29.688315] greybus: registered new driver hid [ 29.689204] greybus: registered new driver lights [ 29.690162] greybus: registered new driver log [ 29.691279] greybus: registered new driver loopback [ 29.692257] greybus: registered new driver power_supply [ 29.693508] greybus: registered new driver raw [ 29.694626] greybus: registered new driver vibrator [ 29.695903] greybus: registered new driver gbphy [ 29.696802] gb_gbphy: registered new driver gpio [ 29.697729] gb_gbphy: registered new driver i2c [ 29.698694] gb_gbphy: registered new driver sdio [ 29.710714] gb_gbphy: registered new driver spi [ 29.711678] gb_gbphy: registered new driver usb [ 29.712368] dell_smbios: Unable to run on non-Dell system [ 29.713343] hdaps: supported laptop not found! [ 29.714010] hdaps: driver init failed (ret=-19)! [ 29.839751] IDT PCI-E Non-Transparent Bridge Driver 2.0 [ 29.840950] Intel(R) PCI-E Non-Transparent Bridge Driver 2.0 [ 29.843564] Software Queue-Pair Transport over NTB, version 4 [ 29.855551] intel_rapl: driver does not support CPU family 6 model 6 [ 29.881925] NET: Registered protocol family 10 [ 29.893242] Segment Routing with IPv6 [ 29.894208] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver [ 29.900212] Key type dns_resolver registered [ 29.900905] start plist test [ 29.907785] end plist test [ 29.932043] ... APIC ID: 00000000 (0) [ 29.932704] ... APIC VERSION: 01050014 [ 29.933328] 0000000000000000000000000000000000000000000000000000000000000000 [ 29.934462] 0000000000000000000000000000000000000000000000000000000000000000 [ 29.935553] 0000000000000000000000000000000000000000000000000000000000000000 [ 29.936693] number of MP IRQ sources: 15. [ 29.937334] number of IO-APIC #0 registers: 24. [ 29.938043] testing the IO APIC....................... [ 29.938856] IO APIC #0...... [ 29.939329] .... register #00: 00000000 [ 29.939925] ....... : physical APIC id: 00 [ 29.951669] ....... : Delivery Type: 0 [ 29.952292] ....... : LTS : 0 [ 29.952886] .... register #01: 00170011 [ 29.953449] ....... : max redirection entries: 17 [ 29.954190] ....... : PRQ implemented: 0 [ 29.954826] ....... : IO APIC version: 11 [ 29.955515] .... register #02: 00000000 [ 29.956124] ....... : arbitration: 00 [ 29.956740] .... IRQ redirection table: [ 29.957337] IOAPIC 0: [ 29.957701] pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.958829] pin01, enabled , edge , high, V(22), IRR(0), S(0), logical , D(01), M(0) [ 29.960010] pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(01), M(0) [ 29.961280] pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.962474] pin04, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.963610] pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.964763] pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.965986] pin07, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.967202] pin08, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.968350] pin09, enabled , level, high, V(20), IRR(0), S(0), logical , D(01), M(0) [ 29.969496] pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.970728] pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.971938] pin0c, enabled , edge , high, V(21), IRR(0), S(0), logical , D(01), M(0) [ 29.979787] pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.981043] pin0e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.982267] pin0f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.983476] pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.984618] pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.985771] pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.986980] pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.988208] pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.989404] pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.990615] pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.991811] pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 29.993029] IRQ to pin mappings: [ 29.993551] IRQ0 -> 0:2 [ 29.993971] IRQ1 -> 0:1 [ 29.994381] IRQ3 -> 0:3 [ 29.994775] IRQ4 -> 0:4 [ 29.995184] IRQ5 -> 0:5 [ 29.995561] IRQ6 -> 0:6 [ 29.995930] IRQ7 -> 0:7 [ 29.996336] IRQ8 -> 0:8 [ 29.996729] IRQ9 -> 0:9 [ 29.997141] IRQ10 -> 0:10 [ 29.997574] IRQ11 -> 0:11 [ 29.998014] IRQ12 -> 0:12 [ 29.998455] IRQ13 -> 0:13 [ 29.998987] IRQ14 -> 0:14 [ 29.999414] IRQ15 -> 0:15 [ 29.999826] .................................... done. [ 30.000762] sched_clock: Marking stable (30000594220, 0)->(32265050163, -2264455943) [ 30.006375] page_owner is disabled [ 30.120898] Btrfs loaded, crc32c=crc32c-generic, debug=on, assert=on, integrity-checker=on, ref-verify=on [ 30.124240] cryptomgr_probe (145) used greatest stack depth: 25472 bytes left [ 30.125599] Key type trusted registered [ 30.127393] Key type encrypted registered [ 30.166143] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [ 30.170682] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX [ 30.190123] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 30.220629] Sending DHCP requests ., OK [ 30.241136] IP-Config: Got DHCP answer from 10.0.2.2, my address is 10.0.2.15 [ 30.242258] IP-Config: Complete: [ 30.242764] device=eth0, hwaddr=52:54:00:12:34:56, ipaddr=10.0.2.15, mask=255.255.255.0, gw=10.0.2.2 [ 30.244222] host=vm-lkp-nhm-dp1-openwrt-ia32-9, domain=, nis-domain=(none) [ 30.245406] bootserver=10.0.2.2, rootserver=10.0.2.2, rootpath= nameserver0=10.0.2.3 [ 30.276749] Freeing unused kernel memory: 2400K [ 30.277533] Write protecting the kernel read-only data: 88064k [ 30.296268] Freeing unused kernel memory: 2000K [ 30.315172] Freeing unused kernel memory: 1348K [ 30.565138] init: Console is alive [ 30.574301] kmodloader (149) used greatest stack depth: 22824 bytes left [ 31.573627] init: - preinit - [ 31.628946] procd: - early - [ 31.715094] ================================================================== [ 31.716334] BUG: KASAN: use-after-scope in ep_poll+0x1177/0x131b [ 31.717242] Write of size 24 at addr ffff880000307b80 by task procd/1 [ 31.718361] [ 31.718653] CPU: 0 PID: 1 Comm: procd Tainted: G T 4.17.0-rc1 #1 [ 31.719799] Call Trace: [ 31.720289] print_address_description+0x69/0x24d [ 31.721257] ? ep_poll+0x1177/0x131b [ 31.721910] kasan_report+0x219/0x34e [ 31.722589] ep_poll+0x1177/0x131b [ 31.723218] ? ep_send_events_proc+0x979/0x979 [ 31.724120] ? sched_clock_cpu+0xa9/0x14a [ 31.724861] ? pvclock_read_flags+0x136/0x136 [ 31.725633] ? print_lockdep_off+0x27/0x27 [ 31.726387] ? kvm_sched_clock_read+0x12/0x20 [ 31.727184] ? sched_clock+0x34/0x37 [ 31.727920] ? __context_tracking_exit+0xb5/0x22b [ 31.728750] ? kvm_sched_clock_read+0x12/0x20 [ 31.729508] ? sched_clock+0x34/0x37 [ 31.730138] ? sched_clock_cpu+0xa9/0x14a [ 31.730913] ? clear_sched_clock_stable+0x115/0x115 [ 31.731763] ? find_held_lock+0x39/0x18d [ 31.732494] ? lock_downgrade+0x730/0x730 [ 31.733221] ? lock_release+0xe6b/0xe6b [ 31.733917] ? get_vtime_delta+0x19f/0x239 [ 31.734777] ? in_sched_functions+0x35/0x35 [ 31.735513] ? account_steal_time+0x35/0x35 [ 31.736313] ? mntput_no_expire+0x73/0x6fe [ 31.737082] ? syscall_slow_exit_work+0x5c2/0x5c2 [ 31.737969] ? __fget_light+0xb3/0x305 [ 31.738658] ? __fget+0x366/0x366 [ 31.739231] ? vtime_user_exit+0x134/0x16b [ 31.739878] ? __context_tracking_exit+0xb5/0x22b [ 31.740811] ? __context_tracking_exit+0xc6/0x22b [ 31.741616] ? do_sched_yield+0x2b7/0x2b7 [ 31.742351] ? trace_raw_output_preemptirq_template+0xf9/0xf9 [ 31.743380] do_epoll_wait+0x112/0x148 [ 31.744126] __ia32_sys_epoll_wait+0xd8/0xe0 [ 31.744915] do_int80_syscall_32+0x436/0x8b6 [ 31.745672] ? do_syscall_64+0x84b/0x84b [ 31.746268] ? vtime_user_enter+0xba/0xef [ 31.746951] ? __context_tracking_enter+0x21d/0x266 [ 31.747929] ? __context_tracking_enter+0x21d/0x266 [ 31.748817] ? context_tracking_recursion_enter+0x4a/0x4a [ 31.749791] ? trace_raw_output_sys_exit+0xc6/0xc6 [ 31.750662] ? trace_hardirqs_on_caller+0x1b3/0x1b3 [ 31.751532] ? prepare_exit_to_usermode+0x230/0x262 [ 31.752287] ? trace_hardirqs_off_thunk+0x1a/0x1c [ 31.753106] entry_INT80_compat+0x84/0x90 [ 31.753715] [ 31.753966] The buggy address belongs to the page: [ 31.754784] page:ffffea000000c1c0 count:0 mapcount:0 mapping:0000000000000000 index:0x0 [ 31.756053] flags: 0x0() [ 31.756470] raw: 0000000000000000 0000000000000000 0000000000000000 00000000ffffffff [ 31.757693] raw: ffffea000000c1e0 ffffea000000c1e0 0000000000000000 0000000000000000 [ 31.758863] page dumped because: kasan: bad access detected [ 31.759687] [ 31.759921] Memory state around the buggy address: [ 31.760636] ffff880000307a80: f8 f2 f2 f2 f2 f2 f2 f2 f8 f2 f2 f2 f2 f2 f2 f2 [ 31.761839] ffff880000307b00: 00 00 f2 f2 f2 f2 f2 f2 00 00 f2 f2 f2 f2 f2 f2 [ 31.762946] >ffff880000307b80: f8 f8 f8 f2 f2 f2 f2 f2 00 00 00 00 00 f2 f2 f2 [ 31.764107] ^ [ 31.764607] ffff880000307c00: f3 f3 f3 f3 00 00 00 00 00 00 00 00 00 00 00 00 [ 31.765600] ffff880000307c80: 00 00 00 00 00 00 00 00 f1 f1 f1 f1 04 f2 f2 f2 [ 31.766593] ================================================================== [ 31.767776] Disabling lock debugging due to kernel taint [ 31.983375] hotplug-call (164) used greatest stack depth: 22224 bytes left [ 33.727232] procd: - ubus - [ 34.737247] procd: - init - Please press Enter to activate this console. Elapsed time: 40 #!/bin/bash # To reproduce, # 1) save job-script and this script (both are attached in 0day report email) # 2) run this script with your compiled kernel and optional env $INSTALL_MOD_PATH kernel=$1 initrds=( /osimage/openwrt/openwrt-i386-2016-03-16.cgz /lkp/lkp/lkp-i386.cgz /osimage/pkg/debian-x86_64-2016-08-31.cgz/trinity-static-i386-x86_64-6ddabfd2_2017-11-10.cgz ) HTTP_PREFIX=https://github.com/0day-ci/lkp-qemu/raw/master wget --timestamping "${initrds[@]/#/$HTTP_PREFIX}" { cat "${initrds[@]//*\//}" [[ $INSTALL_MOD_PATH ]] && ( cd "$INSTALL_MOD_PATH" find lib | cpio -o -H newc --quiet | gzip ) echo job-script | cpio -o -H newc --quiet | gzip } > initrd.img kvm=( qemu-system-x86_64 -enable-kvm -kernel $kernel -initrd initrd.img -m 420 -smp 1 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -watchdog-action debug -rtc base=localtime -serial stdio -display none -monitor null ) append=( ip=::::vm-lkp-nhm-dp1-openwrt-ia32-9::dhcp root=/dev/ram0 user=lkp job=/job-script ARCH=x86_64 kconfig=x86_64-randconfig-s5-04161820 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s5-04161820/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-nhm-dp1-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-s5-04161820/gcc-7/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[*]}"