early console in setup code Probing EDD (edd=off to disable)... ok [ 0.000000] Linux version 4.17.0-rc1 (kbuild@lkp-hsx02) (gcc version 6.4.0 20171026 (Debian 6.4.0-9)) #99 SMP Tue Apr 17 02:33:40 CST 2018 [ 0.000000] Command line: ip=::::vm-lkp-wsx03-quantal-x86_64-28::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-wsx03-quantal-x86_64-28/boot-1-quantal-core-x86_64.cgz-60cc43fc888428bb2f18f08997432d426a243338-20180417-56092-v79ceb-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s0-04170223 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s0-04170223/gcc-6/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-wsx03-quantal-x86_64/quantal-core-x86_64.cgz/x86_64-randconfig-s0-04170223/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] KERNEL supported cpus: [ 0.000000] Centaur CentaurHauls [ 0.000000] CPU: vendor_id 'GenuineIntel' unknown, using generic init. [ 0.000000] CPU: Your system may be unstable. [ 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-0x000000001ffdffff] usable [ 0.000000] BIOS-e820: [mem 0x000000001ffe0000-0x000000001fffffff] 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] random: fast init done [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 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 = 0x1ffe0 max_arch_pfn = 0x400000000 [ 0.000000] MTRR default type: write-back [ 0.000000] MTRR fixed ranges enabled: [ 0.000000] 00000-9FFFF write-back [ 0.000000] A0000-BFFFF uncachable [ 0.000000] C0000-FFFFF write-protect [ 0.000000] MTRR variable ranges enabled: [ 0.000000] 0 base 0080000000 mask FF80000000 uncachable [ 0.000000] 1 disabled [ 0.000000] 2 disabled [ 0.000000] 3 disabled [ 0.000000] 4 disabled [ 0.000000] 5 disabled [ 0.000000] 6 disabled [ 0.000000] 7 disabled [ 0.000000] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC [ 0.000000] Base memory trampoline at [ (ptrval)] 99000 size 24576 [ 0.000000] BRK [0x199bf000, 0x199bffff] PGTABLE [ 0.000000] BRK [0x199c0000, 0x199c0fff] PGTABLE [ 0.000000] BRK [0x199c1000, 0x199c1fff] PGTABLE [ 0.000000] BRK [0x199c2000, 0x199c2fff] PGTABLE [ 0.000000] RAMDISK: [mem 0x1e747000-0x1ffdffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F6870 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x000000001FFE1628 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x000000001FFE147C 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x000000001FFE0040 00143C (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x000000001FFE0000 000040 [ 0.000000] ACPI: APIC 0x000000001FFE1570 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x000000001FFE15F0 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fd000 ( fee00000) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000001ffdffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1e743000-0x1e746fff] [ 0.000000] kvm-clock: cpu 0, msr 0:1e741001, primary cpu clock [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 27279212834 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x000000001ffdffff] [ 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-0x000000001ffdffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000001ffdffff] [ 0.000000] On node 0 totalpages: 130942 [ 0.000000] DMA zone: 64 pages used for memmap [ 0.000000] DMA zone: 21 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 1984 pages used for memmap [ 0.000000] DMA32 zone: 126944 pages, LIFO batch:31 [ 0.000000] Reserved but unavailable: 98 pages [ 0.000000] kasan: KernelAddressSanitizer initialized [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04 [ 0.000000] ACPI: IRQ5 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08 [ 0.000000] ACPI: IRQ9 used by override. [ 0.000000] ACPI: IRQ10 used by override. [ 0.000000] ACPI: IRQ11 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs [ 0.000000] mapped IOAPIC to ffffffffff5fc000 (fec00000) [ 0.000000] e820: [mem 0x20000000-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: 7645519600211568 ns [ 0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] percpu: Embedded 45 pages/cpu @ (ptrval) s152008 r0 d32312 u1048576 [ 0.000000] pcpu-alloc: s152008 r0 d32312 u1048576 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 1 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 10619880 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 128873 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: ip=::::vm-lkp-wsx03-quantal-x86_64-28::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-wsx03-quantal-x86_64-28/boot-1-quantal-core-x86_64.cgz-60cc43fc888428bb2f18f08997432d426a243338-20180417-56092-v79ceb-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s0-04170223 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s0-04170223/gcc-6/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-wsx03-quantal-x86_64/quantal-core-x86_64.cgz/x86_64-randconfig-s0-04170223/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 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] Memory: 269668K/523768K available (47116K kernel code, 30104K rwdata, 20256K rodata, 2920K init, 34144K bss, 254100K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] Kernel/User page tables isolation: enabled [ 0.004000] Running RCU self tests [ 0.004000] Hierarchical RCU implementation. [ 0.004000] RCU dyntick-idle grace-period acceleration is enabled. [ 0.004000] RCU lockdep checking is enabled. [ 0.004000] RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=2. [ 0.004000] RCU callback double-/use-after-free debug enabled. [ 0.004000] RCU debug extended QS entry/exit. [ 0.004000] RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout). [ 0.004000] Tasks RCU enabled. [ 0.004000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.004000] NR_IRQS: 4352, nr_irqs: 440, preallocated irqs: 16 [ 0.004000] Offload RCU callbacks from CPUs: (none). [ 0.004000] console [ttyS0] enabled [ 0.004000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.004000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.004000] ... MAX_LOCK_DEPTH: 48 [ 0.004000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.004000] ... CLASSHASH_SIZE: 4096 [ 0.004000] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.004000] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.004000] ... CHAINHASH_SIZE: 32768 [ 0.004000] memory used by lock dependency info: 7391 kB [ 0.004000] per task-struct memory footprint: 1920 bytes [ 0.004000] ------------------------ [ 0.004000] | Locking API testsuite: [ 0.004000] ---------------------------------------------------------------------------- [ 0.004000] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.004000] -------------------------------------------------------------------------- [ 0.004000] A-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.004000] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.004000] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.004000] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.004000] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.004000] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.004000] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.004000] double unlock: ok | ok | ok | ok | ok | ok | ok | [ 0.004000] initialize held: ok | ok | ok | ok | ok | ok | ok | [ 0.004000] -------------------------------------------------------------------------- [ 0.004000] recursive read-lock: | ok | | ok | [ 0.004000] recursive read-lock #2: | ok | | ok | [ 0.004000] mixed read-write-lock: | ok | | ok | [ 0.004000] mixed write-read-lock: | ok | | ok | [ 0.004000] mixed read-lock/lock-write ABBA: |FAILED| | ok | [ 0.004000] mixed read-lock/lock-read ABBA: | ok | | ok | [ 0.004000] mixed write-lock/lock-write ABBA: | ok | | ok | [ 0.004000] -------------------------------------------------------------------------- [ 0.004000] hard-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.004000] soft-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.004000] hard-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.004000] soft-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.004000] sirq-safe-A => hirqs-on/12: ok | ok | ok | [ 0.004000] sirq-safe-A => hirqs-on/21: ok | ok | ok | [ 0.004000] hard-safe-A + irqs-on/12: ok | ok | ok | [ 0.004000] soft-safe-A + irqs-on/12: ok | ok | ok | [ 0.004000] hard-safe-A + irqs-on/21: ok | ok | ok | [ 0.004000] soft-safe-A + irqs-on/21: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.004000] hard-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.004000] soft-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.004000] hard-irq lock-inversion/123: ok | ok | ok | [ 0.004000] soft-irq lock-inversion/123: ok | ok | ok | [ 0.004000] hard-irq lock-inversion/132: ok | ok | ok | [ 0.004000] soft-irq lock-inversion/132: ok | ok | ok | [ 0.004000] hard-irq lock-inversion/213: ok | ok | ok | [ 0.004000] soft-irq lock-inversion/213: ok | ok | ok | [ 0.004000] hard-irq lock-inversion/231: ok | ok | ok | [ 0.004000] soft-irq lock-inversion/231: ok | ok | ok | [ 0.004000] hard-irq lock-inversion/312: ok | ok | ok | [ 0.004000] soft-irq lock-inversion/312: ok | ok | ok | [ 0.004000] hard-irq lock-inversion/321: ok | ok | ok | [ 0.004000] soft-irq lock-inversion/321: ok | ok | ok | [ 0.004000] hard-irq read-recursion/123: ok | [ 0.004000] soft-irq read-recursion/123: ok | [ 0.004000] hard-irq read-recursion/132: ok | [ 0.004000] soft-irq read-recursion/132: ok | [ 0.004000] hard-irq read-recursion/213: ok | [ 0.004000] soft-irq read-recursion/213: ok | [ 0.004000] hard-irq read-recursion/231: ok | [ 0.004000] soft-irq read-recursion/231: ok | [ 0.004000] hard-irq read-recursion/312: ok | [ 0.004000] soft-irq read-recursion/312: ok | [ 0.004000] hard-irq read-recursion/321: ok | [ 0.004000] soft-irq read-recursion/321: ok | [ 0.004000] -------------------------------------------------------------------------- [ 0.004000] | Wound/wait tests | [ 0.004000] --------------------- [ 0.004000] ww api failures: ok | ok | ok | [ 0.004000] ww contexts mixing: ok | ok | [ 0.004000] finishing ww context: ok | ok | ok | ok | [ 0.004000] locking mismatches: ok | ok | ok | [ 0.004000] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 0.004000] spinlock nest unlocked: ok | [ 0.004000] ----------------------------------------------------- [ 0.004000] |block | try |context| [ 0.004000] ----------------------------------------------------- [ 0.004000] context: ok | ok | ok | [ 0.004000] try: ok | ok | ok | [ 0.004000] block: ok | ok | ok | [ 0.004000] spinlock: ok | ok | ok | [ 0.004000] ------------------------------------------------------- [ 0.004000] Good, all 261 testcases passed! | [ 0.004000] --------------------------------- [ 0.004000] ACPI: Core revision 20180313 [ 0.004000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.004000] hpet clockevent registered [ 0.008362] APIC: Switch to symmetric I/O mode setup [ 0.012777] enabled ExtINT on CPU#0 [ 0.028419] ENABLING IO-APIC IRQs [ 0.032528] init IO_APIC IRQs [ 0.036123] apic 0 pin 0 not connected [ 0.041001] IOAPIC[0]: Set routing entry (0-1 -> 0xef -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.044968] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-3 -> 0xef -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-4 -> 0xef -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-5 -> 0xef -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-6 -> 0xef -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-7 -> 0xef -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-8 -> 0xef -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-9 -> 0xef -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-10 -> 0xef -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-11 -> 0xef -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-12 -> 0xef -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-13 -> 0xef -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-14 -> 0xef -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.048000] IOAPIC[0]: Set routing entry (0-15 -> 0xef -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.048000] apic 0 pin 16 not connected [ 0.048000] apic 0 pin 17 not connected [ 0.048000] apic 0 pin 18 not connected [ 0.048000] apic 0 pin 19 not connected [ 0.048000] apic 0 pin 20 not connected [ 0.048000] apic 0 pin 21 not connected [ 0.048000] apic 0 pin 22 not connected [ 0.048000] apic 0 pin 23 not connected [ 0.048000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.048000] tsc: Detected 2260.998 MHz processor [ 0.052165] tsc: Marking TSC unstable due to TSCs unsynchronized [ 0.056092] Calibrating delay loop (skipped) preset value.. 4521.99 BogoMIPS (lpj=9043992) [ 0.060094] pid_max: default: 4096 minimum: 301 [ 0.071244] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.076495] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) [ 0.084652] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.092189] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.112838] mce: CPU supports 10 MCE banks [ 0.116190] mce: unknown CPU type - not enabling MCE support [ 0.120108] numa_add_cpu cpu 0 node 0: mask now 0 [ 0.124105] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.128108] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.132293] Spectre V2 : Vulnerable: Minimal generic ASM retpoline [ 0.152350] Freeing SMP alternatives memory: 28K [ 0.170715] TSC deadline timer enabled [ 0.172000] smpboot: CPU0: GenuineIntel Intel Core Processor (Haswell) (family: 0x6, model: 0x3c, stepping: 0x4) [ 0.182000] Performance Events: no PMU driver, software events only. [ 0.186242] Hierarchical SRCU implementation. [ 0.203046] smp: Bringing up secondary CPUs ... [ 0.216199] x86: Booting SMP configuration: [ 0.220130] .... node #0, CPUs: #1 [ 0.004000] kvm-clock: cpu 1, msr 0:1e741041, secondary cpu clock [ 0.004000] masked ExtINT on CPU#1 [ 0.004000] numa_add_cpu cpu 1 node 0: mask now 0-1 [ 0.269390] KVM setup async PF for cpu 1 [ 0.272000] kvm-stealtime: cpu 1, msr 10719880 [ 0.276395] smp: Brought up 1 node, 2 CPUs [ 0.284163] smpboot: Max logical packages: 2 [ 0.288222] ---------------- [ 0.291626] | NMI testsuite: [ 0.292153] -------------------- [ 0.295586] remote IPI: ok | [ 0.300133] local IPI: ok | [ 0.304289] -------------------- [ 0.308199] Good, all 2 testcases passed! | [ 0.312199] --------------------------------- [ 0.316162] smpboot: Total of 2 processors activated (9043.99 BogoMIPS) [ 0.349817] devtmpfs: initialized [ 0.363434] x86/mm: Memory block size: 128MB [ 0.386633] gcov: version magic: 0x3630342a [ 0.649784] workqueue: round-robin CPU selection forced, expect performance impact [ 0.666162] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.668416] futex hash table entries: 16 (order: -1, 2048 bytes) [ 0.674689] prandom: seed boundary self test passed [ 0.688838] prandom: 100 self tests passed [ 0.692192] pinctrl core: initialized pinctrl subsystem [ 0.710981] RTC time: 3:05:45, date: 04/17/18 [ 0.723177] NET: Registered protocol family 16 [ 0.764744] cpuidle: using governor ladder [ 0.768805] cpuidle: using governor menu [ 0.807983] ACPI: bus type PCI registered [ 0.810876] dca service started, version 1.12.1 [ 0.814016] PCI: Using configuration type 1 for base access [ 2.028519] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 2.053297] cryptd: max_cpu_qlen set to 1000 [ 2.072127] gpio-f7188x: Not a Fintek device at 0x0000002e [ 2.080780] gpio-f7188x: Not a Fintek device at 0x0000004e [ 2.100775] ACPI: Added _OSI(Module Device) [ 2.108254] ACPI: Added _OSI(Processor Device) [ 2.112295] ACPI: Added _OSI(3.0 _SCP Extensions) [ 2.120193] ACPI: Added _OSI(Processor Aggregator Device) [ 2.128387] ACPI: Added _OSI(Linux-Dell-Video) [ 2.432125] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 2.554890] ACPI: Interpreter enabled [ 2.557452] ACPI: (supports S0 S3 S5) [ 2.560131] ACPI: Using IOAPIC for interrupt routing [ 2.565719] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 2.588840] ACPI: Enabled 2 GPEs in block 00 to 0F [ 3.253266] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 3.256394] acpi PNP0A03:00: _OSC: OS supports [Segments MSI] [ 3.262138] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 3.265651] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 3.278141] PCI host bridge to bus 0000:00 [ 3.280226] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 3.284199] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 3.288258] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 3.292255] pci_bus 0000:00: root bus resource [mem 0x20000000-0xfebfffff window] [ 3.296320] pci_bus 0000:00: root bus resource [bus 00-ff] [ 3.301155] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 3.330824] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 3.356579] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 3.396280] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f] [ 3.412612] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 3.416251] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 3.420265] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 3.424229] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 3.453617] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 3.462785] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 3.464264] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 3.486692] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 [ 3.496260] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] [ 3.517840] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff] [ 3.552324] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 3.587696] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 3.596200] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff] [ 3.608221] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 3.652313] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 3.689006] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000 [ 3.699959] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f] [ 3.863328] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 3.886355] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 3.909816] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 3.933983] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 3.945356] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 4.034261] pci 0000:00:02.0: vgaarb: setting as boot VGA device [ 4.036000] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [ 4.036323] pci 0000:00:02.0: vgaarb: bridge control possible [ 4.040192] vgaarb: loaded [ 4.081200] media: Linux media interface: v0.10 [ 4.086146] Linux video capture interface: v2.00 [ 4.093954] pps_core: LinuxPPS API ver. 1 registered [ 4.096449] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 4.101262] PTP clock support registered [ 4.106624] EDAC MC: Ver: 3.0.0 [ 4.131980] FPGA manager framework [ 4.136418] Advanced Linux Sound Architecture Driver Initialized. [ 4.141224] PCI: Using ACPI for IRQ routing [ 4.144158] PCI: pci_cache_line_size set to 64 bytes [ 4.149336] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 4.152379] e820: reserve RAM buffer [mem 0x1ffe0000-0x1fffffff] [ 4.196742] clocksource: Switched to clocksource kvm-clock [ 4.221217] pnp: PnP ACPI init [ 4.234500] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 4.249575] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 4.263639] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 4.274624] pnp 00:03: [dma 2] [ 4.282142] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 4.299948] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 4.312523] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 4.329520] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 4.379711] pnp: PnP ACPI: found 7 devices [ 4.447543] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 4.477479] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 4.489439] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 4.501435] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 4.514492] pci_bus 0000:00: resource 7 [mem 0x20000000-0xfebfffff window] [ 4.541481] NET: Registered protocol family 2 [ 4.577772] tcp_listen_portaddr_hash hash table entries: 256 (order: 2, 18432 bytes) [ 4.595169] TCP established hash table entries: 4096 (order: 3, 32768 bytes) [ 4.610857] TCP bind hash table entries: 4096 (order: 6, 262144 bytes) [ 4.635642] TCP: Hash tables configured (established 4096 bind 4096) [ 4.651041] UDP hash table entries: 256 (order: 3, 40960 bytes) [ 4.662803] UDP-Lite hash table entries: 256 (order: 3, 40960 bytes) [ 4.678652] NET: Registered protocol family 1 [ 4.706356] RPC: Registered named UNIX socket transport module. [ 4.716482] RPC: Registered udp transport module. [ 4.724483] RPC: Registered tcp transport module. [ 4.732385] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 4.743115] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 4.753245] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 4.763107] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 4.774353] pci 0000:00:01.0: quirk_isa_dma_hangs+0x0/0x77 took 10923 usecs [ 4.789632] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [ 4.804702] pci 0000:00:02.0: pci_fixup_video+0x0/0x303 took 15087 usecs [ 4.817765] PCI: CLS 0 bytes, default 64 [ 4.836366] Unpacking initramfs... [ 40.433754] Freeing initrd memory: 25188K [ 40.659093] PCLMULQDQ-NI instructions are not detected. [ 40.697988] AVX or AES-NI instructions are not detected. [ 40.707246] CPU feature 'AVX registers' is not supported. [ 40.716649] CPU feature 'AVX registers' is not supported. [ 40.723976] AVX2 or AES-NI instructions are not detected. [ 48.031752] rcu-torture:--- Start of test: nreaders=1 nfakewriters=4 stat_interval=60 verbose=1 test_no_idle_hz=1 shuffle_interval=3 stutter=5 irqreader=1 fqs_duration=0 fqs_holdoff=0 fqs_stutter=3 test_boost=1/0 test_boost_interval=7 test_boost_duration=4 shutdown_secs=0 stall_cpu=0 stall_cpu_holdoff=10 stall_cpu_irqsoff=0 n_barrier_cbs=0 onoff_interval=0 onoff_holdoff=0 [ 48.083405] rcu-torture: Creating rcu_torture_writer task [ 48.108588] rcu-torture: Creating rcu_torture_fakewriter task [ 48.109235] rcu-torture: rcu_torture_writer task started [ 48.128612] rcu-torture: Creating rcu_torture_fakewriter task [ 48.129553] rcu-torture: rcu_torture_fakewriter task started [ 48.140729] rcu-torture: Creating rcu_torture_fakewriter task [ 48.157359] rcu-torture: GP expediting controlled from boot/sysfs for rcu. [ 48.157392] rcu_torture_writer: Testing conditional GPs. [ 48.157425] rcu_torture_writer: Testing expedited GPs. [ 48.157456] rcu_torture_writer: Testing asynchronous GPs. [ 48.157486] rcu_torture_writer: Testing normal GPs. [ 48.157813] rcu-torture: rcu_torture_fakewriter task started [ 48.259111] rcu-torture: Creating rcu_torture_fakewriter task [ 48.269450] rcu-torture: rcu_torture_fakewriter task started [ 48.282380] rcu-torture: Creating rcu_torture_reader task [ 48.290511] rcu-torture: rcu_torture_fakewriter task started [ 48.303763] rcu-torture: rcu_torture_reader task started [ 48.313391] rcu-torture: Creating rcu_torture_stats task [ 48.343690] rcu-torture: Creating torture_shuffle task [ 48.351471] rcu-torture: rcu_torture_stats task started [ 48.353835] rcu-torture: Creating torture_stutter task [ 48.381544] rcu-torture: torture_shuffle task started [ 48.390034] rcu-torture: Creating rcu_torture_cbflood task [ 48.390315] rcu-torture: torture_stutter task started [ 48.415786] rcu-torture: rcu_torture_cbflood task started [ 103.035317] Key type blacklist registered [ 103.107707] workingset: timestamp_bits=56 max_order=17 bucket_order=0 [ 103.542858] zbud: loaded [ 103.656824] NFS: Registering the id_resolver key type [ 103.664958] Key type id_resolver registered [ 103.671963] Key type id_legacy registered [ 103.707765] fuse init (API version 7.26) [ 103.739263] pstore: using lzo compression [ 118.375928] String selftests succeeded [ 118.392910] test_string_helpers: Running tests... [ 118.537828] test_hexdump: all 1184 tests passed [ 118.554810] test passed [ 118.575514] test_printf: all 240 tests passed [ 118.591046] test_bitmap: test 13: input is '0-2047:128/256' OK, Time: 5907 [ 118.870736] test_bitmap: all 1524 tests passed [ 118.882564] test_uuid: all 18 tests passed [ 118.916850] crc32: CRC_LE_BITS = 64, CRC_BE BITS = 64 [ 118.927223] crc32: self tests passed, processed 225944 bytes in 9562832 nsec [ 118.956712] crc32c: CRC_LE_BITS = 64 [ 118.965002] crc32c: self tests passed, processed 225944 bytes in 6023032 nsec [ 119.040348] rcu-torture: rtc: 00000000c9045ac8 ver: 228 tfle: 0 rta: 228 rtaf: 0 rtf: 219 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 914 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 10 [ 119.103997] rcu-torture: Reader Pipe: 564060 6 0 0 0 0 0 0 0 0 0 [ 119.130631] rcu-torture: Reader Batch: 557785 6281 0 0 0 0 0 0 0 0 0 [ 119.141193] rcu-torture: Free-Block Circulation: 227 227 226 225 224 223 222 221 220 219 0 [ 120.610724] crc32_combine: 8373 self tests passed [ 121.453783] crc32c_combine: 8373 self tests passed [ 122.130683] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 122.157031] rbtree testing [ 122.325771] -> test 1 (latency of nnodes insert+delete): 381220 cycles [ 122.521917] -> test 2 (latency of nnodes cached insert+delete): 408121 cycles [ 122.558249] -> test 3 (latency of inorder traversal): 53413 cycles [ 122.569659] -> test 4 (latency to fetch first node) [ 122.577823] non-cached: 573 cycles [ 122.591588] cached: 60 cycles [ 123.698071] augmented rbtree testing [ 123.962266] -> test 1 (latency of nnodes insert+delete): 596495 cycles [ 124.316856] -> test 2 (latency of nnodes cached insert+delete): 761880 cycles [ 126.402298] interval tree insert/remove [ 126.759478] -> 807151 cycles [ 126.795413] interval tree search [ 128.902746] -> 4764090 cycles (2692 results) [ 128.949635] gpio_it87: no device [ 128.982631] gpio_winbond: chip ID at 2e is ffff [ 128.993739] gpio_winbond: not an our chip [ 129.002334] gpio_winbond: chip ID at 4e is ffff [ 129.011212] gpio_winbond: not an our chip [ 129.045525] switchtec: loaded. [ 129.084938] cr_bllcd: INTEL CARILLO RANCH LPC not found. [ 129.095729] cr_bllcd: Carillo Ranch Backlight Driver Initialized. [ 129.134714] VIA Graphics Integration Chipset framebuffer 2.4 initializing [ 129.158069] vmlfb: initializing [ 129.166242] Could not find Carillo Ranch MCH device. [ 129.210446] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 129.255199] ACPI: Power Button [PWRF] [ 129.313130] EINJ: EINJ table not found. [ 129.333385] ERST DBG: ERST support is disabled. [ 129.386565] ioatdma: Intel(R) QuickData Technology Driver 4.00 [ 131.720657] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 131.838999] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 132.008550] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 132.087130] Applicom driver: $Id: ac.c,v 1.30 2000/03/22 16:03:57 dwmw2 Exp $ [ 132.099348] ac.o: No PCI boards found. [ 132.104930] ac.o: For an ISA board you must supply memory and irq parameters. [ 132.128937] Non-volatile memory driver v1.3 [ 132.153694] ppdev: user-space parallel port driver [ 132.165854] telclk_interrupt = 0xf non-mcpbl0010 hw. [ 132.176377] Linux agpgart interface v0.103 [ 132.201055] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds). [ 132.230321] drm_mm: Testing DRM range manger (struct drm_mm), with random_seed=0xc31af80b max_iterations=8192 max_prime=128 [ 132.247593] drm_mm: igt_sanitycheck - ok! [ 132.254372] igt_debug 0x0000000000000000-0x0000000000000200: 512: free [ 132.264797] igt_debug 0x0000000000000200-0x0000000000000600: 1024: used [ 132.275199] igt_debug 0x0000000000000600-0x0000000000000a00: 1024: free [ 132.285643] igt_debug 0x0000000000000a00-0x0000000000000e00: 1024: used [ 132.295935] igt_debug 0x0000000000000e00-0x0000000000001000: 512: free [ 132.306182] igt_debug total: 4096, used 2048 free 2048 [ 179.168844] rcu-torture: rtc: 00000000914209c9 ver: 362 tfle: 0 rta: 363 rtaf: 0 rtf: 352 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 2269 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 18 [ 179.215507] rcu-torture: Reader Pipe: 1488936 6 0 0 0 0 0 0 0 0 0 [ 179.227149] rcu-torture: Reader Batch: 1480837 8105 0 0 0 0 0 0 0 0 0 [ 179.239788] rcu-torture: Free-Block Circulation: 362 361 360 359 357 356 355 354 353 352 0 [ 240.623904] rcu-torture: rtc: 00000000f0edd574 ver: 378 tfle: 0 rta: 378 rtaf: 0 rtf: 366 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 4213 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 24 [ 240.671540] rcu-torture: Reader Pipe: 2945624 6 0 0 0 0 0 0 0 0 0 [ 240.682420] rcu-torture: Reader Batch: 2935329 10301 0 0 0 0 0 0 0 0 0 [ 240.693835] rcu-torture: Free-Block Circulation: 377 377 375 374 373 372 371 370 368 366 0 [ 303.022076] rcu-torture: rtc: 00000000e5869cb0 ver: 399 tfle: 0 rta: 399 rtaf: 0 rtf: 387 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 5417 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 31 [ 303.055778] rcu-torture: Reader Pipe: 3868361 6 0 0 0 0 0 0 0 0 0 [ 303.065662] rcu-torture: Reader Batch: 3857324 11043 0 0 0 0 0 0 0 0 0 [ 303.075740] rcu-torture: Free-Block Circulation: 398 398 397 395 394 391 390 389 388 387 0 [ 365.074673] rcu-torture: rtc: 00000000ea12ee94 ver: 418 tfle: 0 rta: 418 rtaf: 0 rtf: 406 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 7433 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 38 [ 365.121245] rcu-torture: Reader Pipe: 5427916 6 0 0 0 0 0 0 0 0 0 [ 365.131769] rcu-torture: Reader Batch: 5416879 11043 0 0 0 0 0 0 0 0 0 [ 365.143405] rcu-torture: Free-Block Circulation: 417 417 416 415 414 413 412 409 407 406 0 [ 427.097767] rcu-torture: rtc: 000000000cf1fc01 ver: 434 tfle: 0 rta: 435 rtaf: 0 rtf: 423 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 9549 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 45 [ 427.147603] rcu-torture: Reader Pipe: 7388778 6 0 0 0 0 0 0 0 0 0 [ 427.158242] rcu-torture: Reader Batch: 7376022 12762 0 0 0 0 0 0 0 0 0 [ 427.169163] rcu-torture: Free-Block Circulation: 434 433 431 430 429 428 427 425 424 423 0 [ 489.056335] rcu-torture: rtc: 00000000fc300d00 ver: 453 tfle: 0 rta: 454 rtaf: 0 rtf: 442 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 11662 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 51 [ 489.092034] rcu-torture: Reader Pipe: 9059590 6 0 0 0 0 0 0 0 0 0 [ 489.102666] rcu-torture: Reader Batch: 9046832 12764 0 0 0 0 0 0 0 0 0 [ 489.113750] rcu-torture: Free-Block Circulation: 453 452 450 449 448 447 445 444 443 442 0 [ 550.664770] rcu-torture: rtc: 00000000f2f235cb ver: 468 tfle: 0 rta: 468 rtaf: 0 rtf: 459 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 13215 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 59 [ 550.711079] rcu-torture: Reader Pipe: 10320622 6 0 0 0 0 0 0 0 0 0 [ 550.721218] rcu-torture: Reader Batch: 10307165 13463 0 0 0 0 0 0 0 0 0 [ 550.732018] rcu-torture: Free-Block Circulation: 467 467 466 465 464 463 462 461 460 459 0 [ 611.499773] rcu-torture: rtc: 00000000b914d51b ver: 488 tfle: 0 rta: 488 rtaf: 0 rtf: 478 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 15038 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 65 [ 611.549623] rcu-torture: Reader Pipe: 11795331 6 0 0 0 0 0 0 0 0 0 [ 611.560255] rcu-torture: Reader Batch: 11773165 22172 0 0 0 0 0 0 0 0 0 [ 611.571429] rcu-torture: Free-Block Circulation: 487 487 486 485 484 483 481 480 479 478 0 [ 672.738162] rcu-torture: rtc: 0000000029871116 ver: 509 tfle: 0 rta: 510 rtaf: 0 rtf: 499 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 16939 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 71 [ 672.790668] rcu-torture: Reader Pipe: 13552545 6 0 0 0 0 0 0 0 0 0 [ 672.802456] rcu-torture: Reader Batch: 13530378 22173 0 0 0 0 0 0 0 0 0 [ 672.816562] rcu-torture: Free-Block Circulation: 509 508 507 506 505 504 503 501 500 499 0 [ 734.829212] rcu-torture: rtc: 00000000882cffd7 ver: 521 tfle: 0 rta: 522 rtaf: 0 rtf: 510 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 19373 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 78 [ 734.875816] rcu-torture: Reader Pipe: 15471403 6 0 0 0 0 0 0 0 0 0 [ 734.886244] rcu-torture: Reader Batch: 15447579 23830 0 0 0 0 0 0 0 0 0 [ 734.896938] rcu-torture: Free-Block Circulation: 521 520 519 517 516 515 514 512 511 510 0 [ 795.616914] rcu-torture: rtc: 000000004ed2312a ver: 543 tfle: 0 rta: 544 rtaf: 0 rtf: 532 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 20820 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 84 [ 795.670032] rcu-torture: Reader Pipe: 17084625 6 0 0 0 0 0 0 0 0 0 [ 795.680591] rcu-torture: Reader Batch: 17060797 23834 0 0 0 0 0 0 0 0 0 [ 795.691442] rcu-torture: Free-Block Circulation: 543 542 541 540 537 536 535 534 533 532 0 [ 857.056495] rcu-torture: rtc: 000000005de6787a ver: 560 tfle: 0 rta: 561 rtaf: 0 rtf: 548 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 22840 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 93 [ 857.092445] rcu-torture: Reader Pipe: 18784869 6 0 0 0 0 0 0 0 0 0 [ 857.102992] rcu-torture: Reader Batch: 18756406 28469 0 0 0 0 0 0 0 0 0 [ 857.114265] rcu-torture: Free-Block Circulation: 560 558 557 556 555 553 552 551 550 548 0 [ 918.724332] rcu-torture: rtc: 00000000c8ff5aab ver: 579 tfle: 0 rta: 579 rtaf: 0 rtf: 567 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 25110 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 102 [ 918.763767] rcu-torture: Reader Pipe: 20573851 6 0 0 0 0 0 0 0 0 0 [ 918.773201] rcu-torture: Reader Batch: 20543828 30029 0 0 0 0 0 0 0 0 0 [ 918.783116] rcu-torture: Free-Block Circulation: 578 577 576 575 572 571 570 569 568 567 0 [ 981.543060] rcu-torture: rtc: 00000000882cffd7 ver: 622 tfle: 0 rta: 623 rtaf: 0 rtf: 610 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 26360 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 113 [ 981.594204] rcu-torture: Reader Pipe: 21559596 7 0 0 0 0 0 0 0 0 0 [ 981.605638] rcu-torture: Reader Batch: 21526702 32901 0 0 0 0 0 0 0 0 0 [ 981.617597] rcu-torture: Free-Block Circulation: 622 621 619 618 617 616 615 614 613 610 0 [ 1043.863042] rcu-torture: rtc: 0000000072e4e826 ver: 669 tfle: 0 rta: 670 rtaf: 0 rtf: 657 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 27465 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 124 [ 1043.898301] rcu-torture: Reader Pipe: 22394124 7 0 0 0 0 0 0 0 0 0 [ 1043.908653] rcu-torture: Reader Batch: 22359054 35077 0 0 0 0 0 0 0 0 0 [ 1043.919758] rcu-torture: Free-Block Circulation: 669 668 667 666 662 661 660 659 658 657 0 [ 1109.691598] rcu-torture: rtc: 000000003d6da35c ver: 685 tfle: 0 rta: 685 rtaf: 0 rtf: 674 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 29429 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 cbflood: 129 [ 1109.739392] rcu-torture: Reader Pipe: 23942278 7 0 0 0 0 0 0 0 0 0 [ 1109.750932] rcu-torture: Reader Batch: 23895152 47133 0 0 0 0 0 0 0 0 0 [ 1109.763056] rcu-torture: Free-Block Circulation: 684 684 683 682 681 680 679 678 677 676 0 [ 1144.200304] watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [swapper/0:1] [ 1144.229662] irq event stamp: 14402106 [ 1144.229662] hardirqs last enabled at (14402105): [] restore_regs_and_return_to_kernel+0x0/0x33 [ 1144.245638] hardirqs last disabled at (14402106): [] interrupt_entry+0xea/0x120 [ 1144.261617] softirqs last enabled at (14390978): [] __do_softirq+0x495/0x550 [ 1144.277763] softirqs last disabled at (14390969): [] irq_exit+0xb1/0x29e [ 1144.285635] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.17.0-rc1 #99 [ 1144.301610] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 1144.309648] RIP: 0010:rb_next+0xa3/0x118 [ 1144.317646] RSP: 0000:ffff88001015f9d8 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13 [ 1144.332748] RAX: dffffc0000000000 RBX: 0000000000000000 RCX: 0000000000000815 [ 1144.341594] RDX: 1ffff920002d9ee8 RSI: 0000000000000816 RDI: ffffc900016cf740 [ 1144.349636] RBP: ffff88001015f9f8 R08: 0000000000001b15 R09: 0000000000000000 [ 1144.365611] R10: 0000000000000000 R11: 00000000d9de409f R12: ffffc900016cf738 [ 1144.373584] R13: ffff88001015fc70 R14: ffff88001015faf8 R15: ffffc900017cce70 [ 1144.381688] FS: 0000000000000000(0000) GS:ffff880010600000(0000) knlGS:0000000000000000 [ 1144.397596] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 1144.405598] CR2: 0000000000000000 CR3: 0000000015814001 CR4: 00000000000206b0 [ 1144.413673] Call Trace: [ 1144.421640] drm_mm_insert_node_in_range+0x3c7/0x917 [ 1144.429639] ? drm_mm_reserve_node+0x4c7/0x4c7 [ 1144.437652] ? rcu_dynticks_curr_cpu_in_eqs+0x35/0x79 [ 1144.445752] ? retint_kernel+0x10/0x10 [ 1144.445752] expect_insert+0x6d/0x118 [ 1144.457609] igt_color_evict+0x1fa/0x7bb [ 1144.457609] ? igt_color_evict_range+0x7b3/0x7b3 [ 1144.465551] ? igt_color+0xa16/0xa64 [ 1144.473560] ? igt_init+0x299/0x299 [ 1144.481561] ? drm_dp_aux_dev_exit+0x40/0x40 [ 1144.489569] ? kasan_check_read+0x1e/0x28 [ 1144.497602] ? next_prime_number+0x3e5/0x3fa [ 1144.504733] test_drm_mm_init+0x2ad/0x3b8 [ 1144.513642] ? drm_fb_helper_modinit+0x37/0x37 [ 1144.521580] do_one_initcall+0x188/0x3ef [ 1144.528710] ? start_kernel+0x14ca/0x14ca [ 1144.529615] ? reacquire_held_locks+0x29f/0x29f [ 1144.537620] kernel_init_freeable+0x504/0x68d [ 1144.545629] ? rest_init+0x37d/0x37d [ 1144.553601] kernel_init+0x13/0x1c6 [ 1144.553601] ? rest_init+0x37d/0x37d [ 1144.561661] ret_from_fork+0x3a/0x50 [ 1144.569633] Code: 8d 7b 10 48 89 f8 48 c1 e8 03 42 80 3c 20 00 74 05 e8 60 3f a0 fd 48 8b 43 10 48 85 c0 74 75 48 ff 05 08 32 ba 05 48 89 c3 eb d4 <48> ff 05 04 32 ba 05 49 be 00 00 00 00 00 fc ff df 4c 89 e0 48 [ 1144.601626] Kernel panic - not syncing: softlockup: hung tasks [ 1144.609656] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G L 4.17.0-rc1 #99 [ 1144.617569] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 1144.633606] Call Trace: [ 1144.640711] [ 1144.641612] dump_stack+0x10f/0x19b [ 1144.649590] panic+0x20d/0x46b [ 1144.649590] ? refcount_error_report+0x268/0x268 [ 1144.657617] ? kasan_check_write+0x22/0x2b [ 1144.673626] ? do_raw_spin_unlock+0x74/0x1fa [ 1144.681566] ? do_raw_spin_unlock+0x74/0x1fa [ 1144.689539] watchdog_timer_fn+0x335/0x366 [ 1144.689539] __hrtimer_run_queues+0x2a9/0x3f8 [ 1144.697609] ? watchdog+0x29/0x29 [ 1144.705614] ? __remove_hrtimer+0x296/0x296 [ 1144.713590] ? ktime_get_update_offsets_now+0x255/0x44d [ 1144.721656] ? kasan_check_write+0x22/0x2b [ 1144.729594] hrtimer_run_queues+0x1be/0x1ef [ 1144.737601] run_local_timers+0x29/0xd7 [ 1144.737601] update_process_times+0x30/0x87 [ 1144.745600] tick_nohz_handler+0x338/0x40b [ 1144.753609] smp_apic_timer_interrupt+0x103/0x12a [ 1144.761608] apic_timer_interrupt+0xf/0x20 [ 1144.769588] [ 1144.769588] RIP: 0010:rb_next+0xa3/0x118 [ 1144.777587] RSP: 0000:ffff88001015f9d8 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13 [ 1144.792716] RAX: dffffc0000000000 RBX: 0000000000000000 RCX: 0000000000000815 [ 1144.801661] RDX: 1ffff920002d9ee8 RSI: 0000000000000816 RDI: ffffc900016cf740 [ 1144.809546] RBP: ffff88001015f9f8 R08: 0000000000001b15 R09: 0000000000000000 [ 1144.825546] R10: 0000000000000000 R11: 00000000d9de409f R12: ffffc900016cf738 [ 1144.833521] R13: ffff88001015fc70 R14: ffff88001015faf8 R15: ffffc900017cce70 [ 1144.857566] drm_mm_insert_node_in_range+0x3c7/0x917 [ 1144.865544] ? drm_mm_reserve_node+0x4c7/0x4c7 [ 1144.873515] ? rcu_dynticks_curr_cpu_in_eqs+0x35/0x79 [ 1144.880731] ? retint_kernel+0x10/0x10 [ 1144.881545] expect_insert+0x6d/0x118 [ 1144.889525] igt_color_evict+0x1fa/0x7bb [ 1144.897558] ? igt_color_evict_range+0x7b3/0x7b3 [ 1144.905559] ? igt_color+0xa16/0xa64 [ 1144.912716] ? igt_init+0x299/0x299 [ 1144.913534] ? drm_dp_aux_dev_exit+0x40/0x40 [ 1144.921507] ? kasan_check_read+0x1e/0x28 [ 1144.929545] ? next_prime_number+0x3e5/0x3fa [ 1144.937549] test_drm_mm_init+0x2ad/0x3b8 [ 1144.946133] ? drm_fb_helper_modinit+0x37/0x37 [ 1144.946973] do_one_initcall+0x188/0x3ef [ 1144.946973] ? start_kernel+0x14ca/0x14ca [ 1144.959316] ? reacquire_held_locks+0x29f/0x29f [ 1144.965543] kernel_init_freeable+0x504/0x68d [ 1144.973548] ? rest_init+0x37d/0x37d [ 1144.981577] kernel_init+0x13/0x1c6 [ 1144.981577] ? rest_init+0x37d/0x37d [ 1144.991308] ret_from_fork+0x3a/0x50 [ 1144.997523] Kernel Offset: 0x2d800000 from 0xffffffff81000000 (relocation range: 0xffffffff80000000-0xffffffffbfffffff) Elapsed time: 1170 #!/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/quantal/quantal-core-x86_64.cgz /lkp/lkp/lkp-x86_64.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 -cpu Haswell,+smep,+smap -kernel $kernel -initrd initrd.img -m 512 -smp 2 -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-wsx03-quantal-x86_64-28::dhcp root=/dev/ram0 user=lkp job=/job-script ARCH=x86_64 kconfig=x86_64-randconfig-s0-04170223 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s0-04170223/gcc-6/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-wsx03-quantal-x86_64/quantal-core-x86_64.cgz/x86_64-randconfig-s0-04170223/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[*]}"