early console in setup code [ 0.000000] Linux version 4.14.0-rc8 (kbuild@intel17) (gcc version 4.9.4 (Debian 4.9.4-2)) #65 SMP Mon Nov 6 16:50:09 CST 2017 [ 0.000000] Command line: root=/dev/ram0 hung_task_panic=1 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 link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-it0-11061641/linux-devel:devel-spot-201711061347:39dae59d66acd86d1de24294bd2f343fd5e7a625/.vmlinuz-39dae59d66acd86d1de24294bd2f343fd5e7a625-20171106174331-11:quantal-ivb41-1 branch=linux-devel/devel-hourly-2017110613 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-it0-11061641/gcc-4.9/39dae59d66acd86d1de24294bd2f343fd5e7a625/vmlinuz-4.14.0-rc8 drbd.minor_count=8 [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 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-0x000000001ffd1fff] usable [ 0.000000] BIOS-e820: [mem 0x000000001ffd2000-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] tsc: Fast TSC calibration using PIT [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] e820: last_pfn = 0x1ffd2 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 WC UC- UC WB WC 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 0x000f6a50-0x000f6a5f] mapped at [ffffffffff200a50] [ 0.000000] mpc: f6a60-f6b7c [ 0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576 [ 0.000000] BRK [0x06e56000, 0x06e56fff] PGTABLE [ 0.000000] BRK [0x06e57000, 0x06e57fff] PGTABLE [ 0.000000] BRK [0x06e58000, 0x06e58fff] PGTABLE [ 0.000000] BRK [0x06e59000, 0x06e59fff] PGTABLE [ 0.000000] RAMDISK: [mem 0x1e91d000-0x1ffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F6840 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] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:1ffd1001, primary cpu clock [ 0.000000] kvm-clock: using sched offset of 7280597809 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-0x000000001ffd1fff] [ 0.000000] Normal empty [ 0.000000] Device 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-0x000000001ffd1fff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000001ffd1fff] [ 0.000000] On node 0 totalpages: 130928 [ 0.000000] DMA zone: 56 pages used for memmap [ 0.000000] DMA zone: 21 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 1736 pages used for memmap [ 0.000000] DMA32 zone: 126930 pages, LIFO batch:31 [ 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:64 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] percpu: Embedded 74 pages/cpu @ffff880019000000 s274312 r0 d28792 u1048576 [ 0.000000] pcpu-alloc: s274312 r0 d28792 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 190175c0 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 129115 [ 0.000000] Kernel command line: root=/dev/ram0 hung_task_panic=1 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 link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-it0-11061641/linux-devel:devel-spot-201711061347:39dae59d66acd86d1de24294bd2f343fd5e7a625/.vmlinuz-39dae59d66acd86d1de24294bd2f343fd5e7a625-20171106174331-11:quantal-ivb41-1 branch=linux-devel/devel-hourly-2017110613 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-it0-11061641/gcc-4.9/39dae59d66acd86d1de24294bd2f343fd5e7a625/vmlinuz-4.14.0-rc8 drbd.minor_count=8 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes) [ 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] Calgary: detecting Calgary via BIOS EBDA area [ 0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing! [ 0.000000] Memory: 316312K/523712K available (41339K kernel code, 3796K rwdata, 9364K rodata, 2064K init, 37184K bss, 207400K reserved, 0K cma-reserved) [ 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.004000] Running RCU self tests [ 0.004000] Hierarchical RCU implementation. [ 0.004000] RCU event tracing 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 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] 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] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.004000] hpet clockevent registered [ 0.004109] tsc: Detected 2693.508 MHz processor [ 0.008032] Calibrating delay loop (skipped) preset value.. 5387.01 BogoMIPS (lpj=10774032) [ 0.010265] pid_max: default: 32768 minimum: 301 [ 0.012221] ACPI: Core revision 20170728 [ 0.203211] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.205770] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.208051] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.216713] CPU: Physical Processor ID: 0 [ 0.217942] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.219369] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.224737] Freeing SMP alternatives memory: 52K [ 0.232459] smpboot: Max logical packages: 2 [ 0.233732] enabled ExtINT on CPU#0 [ 0.237093] ENABLING IO-APIC IRQs [ 0.238158] init IO_APIC IRQs [ 0.239001] apic 0 pin 0 not connected [ 0.240339] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.242733] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.244000] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.244000] apic 0 pin 16 not connected [ 0.244000] apic 0 pin 17 not connected [ 0.244000] apic 0 pin 18 not connected [ 0.244000] apic 0 pin 19 not connected [ 0.244000] apic 0 pin 20 not connected [ 0.244000] apic 0 pin 21 not connected [ 0.244000] apic 0 pin 22 not connected [ 0.244000] apic 0 pin 23 not connected [ 0.244000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.244000] Using local APIC timer interrupts. [ 0.244000] calibrating APIC timer ... [ 0.248000] ... lapic delta = 6253301 [ 0.248000] ... PM-Timer delta = 358126 [ 0.248000] ... PM-Timer result ok [ 0.248000] ..... delta 6253301 [ 0.248000] ..... mult: 268577232 [ 0.248000] ..... calibration result: 4002112 [ 0.248000] ..... CPU clock speed is 2694.3202 MHz. [ 0.248000] ..... host bus clock speed is 1000.2112 MHz. [ 0.248144] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1) [ 0.253005] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only. [ 0.256744] Hierarchical SRCU implementation. [ 0.260028] NMI watchdog: Perf event create on CPU 0 failed with -2 [ 0.262081] NMI watchdog: Perf NMI watchdog permanently disabled [ 0.265474] smp: Bringing up secondary CPUs ... [ 0.284353] x86: Booting SMP configuration: [ 0.285833] .... node #0, CPUs: #1 [ 0.004000] kvm-clock: cpu 1, msr 0:1ffd1041, secondary cpu clock [ 0.004000] masked ExtINT on CPU#1 [ 0.304547] KVM setup async PF for cpu 1 [ 0.305632] kvm-stealtime: cpu 1, msr 191175c0 [ 0.308035] smp: Brought up 1 node, 2 CPUs [ 0.309191] ---------------- [ 0.309990] | NMI testsuite: [ 0.310795] -------------------- [ 0.311676] remote IPI: ok | [ 0.313176] local IPI: ok | [ 0.314236] -------------------- [ 0.315126] Good, all 2 testcases passed! | [ 0.316042] --------------------------------- [ 0.317227] smpboot: Total of 2 processors activated (10774.03 BogoMIPS) [ 0.324797] devtmpfs: initialized [ 0.329011] x86/mm: Memory block size: 128MB [ 0.355115] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.356066] futex hash table entries: 512 (order: 4, 65536 bytes) [ 0.360934] xor: measuring software checksum speed [ 0.400028] prefetch64-sse: 6784.000 MB/sec [ 0.439095] generic_sse: 6244.000 MB/sec [ 0.440039] xor: using function: prefetch64-sse (6784.000 MB/sec) [ 0.441688] pinctrl core: initialized pinctrl subsystem [ 0.449736] NET: Registered protocol family 16 [ 0.468418] cpuidle: using governor ladder [ 0.469554] cpuidle: using governor menu [ 0.480349] ACPI: bus type PCI registered [ 0.482510] dca service started, version 1.12.1 [ 0.484131] PCI: Using configuration type 1 for base access [ 1.031161] raid6: sse2x1 gen() 589 MB/s [ 1.100123] raid6: sse2x1 xor() 347 MB/s [ 1.168053] raid6: sse2x2 gen() 1155 MB/s [ 1.236064] raid6: sse2x2 xor() 685 MB/s [ 1.304057] raid6: sse2x4 gen() 2025 MB/s [ 1.372051] raid6: sse2x4 xor() 1187 MB/s [ 1.373254] raid6: using algorithm sse2x4 gen() 2025 MB/s [ 1.374679] raid6: .... xor() 1187 MB/s, rmw enabled [ 1.376036] raid6: using intx1 recovery algorithm [ 1.383055] ACPI: Added _OSI(Module Device) [ 1.384095] ACPI: Added _OSI(Processor Device) [ 1.385307] ACPI: Added _OSI(3.0 _SCP Extensions) [ 1.386564] ACPI: Added _OSI(Processor Aggregator Device) [ 1.470010] ACPI: Interpreter enabled [ 1.471226] ACPI: (supports S0 S5) [ 1.472083] ACPI: Using IOAPIC for interrupt routing [ 1.473985] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 1.862436] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 1.864361] acpi PNP0A03:00: _OSC: OS supports [Segments MSI] [ 1.865827] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 1.902606] PCI host bridge to bus 0000:00 [ 1.903819] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 1.904095] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 1.905931] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 1.908080] pci_bus 0000:00: root bus resource [mem 0x20000000-0xfebfffff window] [ 1.910103] pci_bus 0000:00: root bus resource [bus 00-ff] [ 1.912311] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 1.929535] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 1.943345] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 1.984054] pci 0000:00:01.1: reg 0x20: [io 0xc200-0xc20f] [ 1.998466] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 2.000050] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 2.001786] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 2.004047] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 2.017180] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 2.020229] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 2.022221] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 2.034971] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 [ 2.048065] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] [ 2.072068] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff] [ 2.128081] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 2.140298] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 2.152049] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff] [ 2.164046] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 2.224060] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 2.241278] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 [ 2.256065] pci 0000:00:04.0: reg 0x10: [io 0xc040-0xc07f] [ 2.276069] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff] [ 2.328066] pci 0000:00:04.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] [ 2.365342] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 2.380064] pci 0000:00:05.0: reg 0x10: [io 0xc080-0xc0bf] [ 2.400052] pci 0000:00:05.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff] [ 2.452062] pci 0000:00:05.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] [ 2.487519] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 2.508048] pci 0000:00:06.0: reg 0x10: [io 0xc0c0-0xc0ff] [ 2.528065] pci 0000:00:06.0: reg 0x14: [mem 0xfebf3000-0xfebf3fff] [ 2.576075] pci 0000:00:06.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] [ 2.604766] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 [ 2.620059] pci 0000:00:07.0: reg 0x10: [io 0xc100-0xc13f] [ 2.636051] pci 0000:00:07.0: reg 0x14: [mem 0xfebf4000-0xfebf4fff] [ 2.684059] pci 0000:00:07.0: reg 0x20: [mem 0xfe00c000-0xfe00ffff 64bit pref] [ 2.716769] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 [ 2.732047] pci 0000:00:08.0: reg 0x10: [io 0xc140-0xc17f] [ 2.748046] pci 0000:00:08.0: reg 0x14: [mem 0xfebf5000-0xfebf5fff] [ 2.792050] pci 0000:00:08.0: reg 0x20: [mem 0xfe010000-0xfe013fff 64bit pref] [ 2.825281] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000 [ 2.840048] pci 0000:00:09.0: reg 0x10: [io 0xc180-0xc1bf] [ 2.856048] pci 0000:00:09.0: reg 0x14: [mem 0xfebf6000-0xfebf6fff] [ 2.900052] pci 0000:00:09.0: reg 0x20: [mem 0xfe014000-0xfe017fff 64bit pref] [ 2.933333] pci 0000:00:0a.0: [1af4:1001] type 00 class 0x010000 [ 2.948047] pci 0000:00:0a.0: reg 0x10: [io 0xc1c0-0xc1ff] [ 2.964045] pci 0000:00:0a.0: reg 0x14: [mem 0xfebf7000-0xfebf7fff] [ 3.012057] pci 0000:00:0a.0: reg 0x20: [mem 0xfe018000-0xfe01bfff 64bit pref] [ 3.043835] pci 0000:00:0b.0: [8086:25ab] type 00 class 0x088000 [ 3.050533] pci 0000:00:0b.0: reg 0x10: [mem 0xfebf8000-0xfebf800f] [ 3.098100] pci_bus 0000:00: on NUMA node 0 [ 3.138917] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 3.150193] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 3.161438] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 3.172618] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 3.178121] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 3.197761] pci 0000:00:02.0: vgaarb: setting as boot VGA device [ 3.198173] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [ 3.200101] pci 0000:00:02.0: vgaarb: bridge control possible [ 3.204034] vgaarb: loaded [ 3.220444] media: Linux media interface: v0.10 [ 3.222210] Linux video capture interface: v2.00 [ 3.224761] pps_core: LinuxPPS API ver. 1 registered [ 3.226243] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 3.228991] Unable to find dmi tokens [ 3.233209] FPGA manager framework [ 3.234462] PCI: Using ACPI for IRQ routing [ 3.235670] PCI: pci_cache_line_size set to 64 bytes [ 3.236776] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 3.238489] e820: reserve RAM buffer [mem 0x1ffd2000-0x1fffffff] [ 3.247867] Bluetooth: Core ver 2.22 [ 3.248315] NET: Registered protocol family 31 [ 3.249698] Bluetooth: HCI device and connection manager initialized [ 3.252121] Bluetooth: HCI socket layer initialized [ 3.253465] Bluetooth: L2CAP socket layer initialized [ 3.255144] Bluetooth: SCO socket layer initialized [ 3.269776] HPET: 3 timers in total, 0 timers will be used for per-cpu timer [ 3.271696] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 3.272040] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 3.281687] clocksource: Switched to clocksource kvm-clock [ 5.360320] VFS: Disk quotas dquot_6.6.0 [ 5.365594] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 5.368894] FS-Cache: Loaded [ 5.370450] pnp: PnP ACPI init [ 5.374022] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 5.378174] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 5.382207] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 5.384683] pnp 00:03: [dma 2] [ 5.386545] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 5.392003] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 5.397720] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 5.403843] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 5.425483] pnp: PnP ACPI: found 7 devices [ 5.449509] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 5.453458] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 5.455141] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 5.456851] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 5.458680] pci_bus 0000:00: resource 7 [mem 0x20000000-0xfebfffff window] [ 5.464307] NET: Registered protocol family 2 [ 5.469924] TCP established hash table entries: 4096 (order: 3, 32768 bytes) [ 5.472603] TCP bind hash table entries: 4096 (order: 6, 262144 bytes) [ 5.479122] TCP: Hash tables configured (established 4096 bind 4096) [ 5.482108] UDP hash table entries: 256 (order: 3, 40960 bytes) [ 5.484099] UDP-Lite hash table entries: 256 (order: 3, 40960 bytes) [ 5.487950] NET: Registered protocol family 1 [ 5.492544] RPC: Registered named UNIX socket transport module. [ 5.494188] RPC: Registered udp transport module. [ 5.495447] RPC: Registered tcp transport module. [ 5.496784] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 5.498526] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 5.500390] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 5.502074] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 5.503944] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [ 5.506678] PCI: CLS 0 bytes, default 64 [ 5.510125] Unpacking initramfs... [ 13.252593] Freeing initrd memory: 23244K [ 13.283370] des3_ede-x86_64: performance on this CPU would be suboptimal: disabling des3_ede-x86_64. [ 13.285978] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64. [ 13.288494] blowfish-x86_64: performance on this CPU would be suboptimal: disabling blowfish-x86_64. [ 13.291963] twofish-x86_64-3way: performance on this CPU would be suboptimal: disabling twofish-x86_64-3way. [ 13.295237] PCLMULQDQ-NI instructions are not detected. [ 13.296736] AVX or AES-NI instructions are not detected. [ 13.298155] CPU feature 'AVX registers' is not supported. [ 13.299578] CPU feature 'AVX registers' is not supported. [ 13.301060] CPU feature 'AVX registers' is not supported. [ 13.302481] AVX2 or AES-NI instructions are not detected. [ 13.303916] AVX2 instructions are not detected. [ 13.306586] spin_lock-torture:--- Start of test [debug]: nwriters_stress=4 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0 [ 13.311445] spin_lock-torture: Creating torture_shuffle task [ 13.313699] spin_lock-torture: torture_shuffle task started [ 13.313709] spin_lock-torture: Creating torture_stutter task [ 13.314107] spin_lock-torture: Creating lock_torture_writer task [ 13.314371] spin_lock-torture: torture_stutter task started [ 13.317056] spin_lock-torture: Creating lock_torture_writer task [ 13.317350] spin_lock-torture: lock_torture_writer task started [ 13.317583] spin_lock-torture: Creating lock_torture_writer task [ 13.318996] spin_lock-torture: lock_torture_writer task started [ 13.319178] spin_lock-torture: Creating lock_torture_writer task [ 13.319440] spin_lock-torture: lock_torture_writer task started [ 13.319618] spin_lock-torture: Creating lock_torture_stats task [ 13.322132] spin_lock-torture: lock_torture_writer task started [ 13.322328] torture_init_begin: Refusing rcu init: spin_lock running. [ 13.322335] torture_init_begin: One torture test at a time! [ 13.331226] audit: initializing netlink subsys (disabled) [ 13.331716] spin_lock-torture: lock_torture_stats task started [ 13.339530] audit: type=2000 audit(1509961441.114:1): state=initialized audit_enabled=0 res=1 [ 13.354934] workingset: timestamp_bits=62 max_order=17 bucket_order=0 [ 13.359838] zbud: loaded [ 13.366215] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 13.450392] NFS: Registering the id_resolver key type [ 13.452235] Key type id_resolver registered [ 13.453413] Key type id_legacy registered [ 13.458020] ntfs: driver 2.1.32 [Flags: R/W DEBUG]. [ 13.460101] efs: 1.0a - http://aeschi.ch.eu.org/efs/ [ 13.461594] romfs: ROMFS MTD (C) 2007 Red Hat, Inc. [ 13.463144] QNX4 filesystem 0.2.3 registered. [ 13.465032] orangefs_debugfs_init: called with debug mask: :none: :0: [ 13.468734] orangefs_init: module version upstream loaded [ 13.471429] JFS: nTxBlock = 2653, nTxLock = 21225 [ 13.481542] SGI XFS with security attributes, realtime, debug enabled [ 13.490102] 9p: Installing v9fs 9p2000 file system support [ 13.491841] FS-Cache: Netfs '9p' registered for caching [ 13.494073] NILFS version 2 loaded [ 13.495015] befs: version: 0.9.3 [ 13.497720] OCFS2 User DLM kernel interface loaded [ 13.511810] gfs2: GFS2 installed [ 13.513533] FS-Cache: Netfs 'ceph' registered for caching [ 13.515137] ceph: loaded (mds proto 32) [ 13.564265] NET: Registered protocol family 38 [ 13.567762] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) [ 13.570171] io scheduler noop registered (default) [ 13.571780] io scheduler cfq registered [ 13.572919] io scheduler mq-deadline registered [ 13.574135] io scheduler kyber registered [ 13.575493] io scheduler bfq registered [ 13.576682] test_string_helpers: Running tests... [ 13.605036] test_hexdump: all 1184 tests passed [ 13.675164] test_hash: __hash_32() has no arch implementation to test. [ 13.677092] test_hash: hash_32() has no arch implementation to test. [ 13.678771] test_hash: hash_64() has no arch implementation to test. [ 13.680550] test_hash: 33152 tests passed. [ 13.681723] test_siphash: self-tests: pass [ 13.699254] Running rhashtable test nelem=8, max_size=0, shrinking=0 [ 13.701165] Test 00: [ 13.707880] Adding 50000 keys [ 14.334101] tsc: Refined TSC clocksource calibration: 2693.508 MHz [ 14.335898] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x26d349e8249, max_idle_ns: 440795288087 ns [ 14.695157] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 15.278478] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 15.284139] Deleting 50000 keys [ 15.711510] Duration of test: 1999749713 ns [ 15.713126] Test 01: [ 15.725009] Adding 50000 keys [ 16.552841] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 17.159052] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 17.161374] Deleting 50000 keys [ 17.575356] Duration of test: 1849402512 ns [ 17.576747] Test 02: [ 17.584839] Adding 50000 keys [ 18.463314] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 19.078987] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 19.081416] Deleting 50000 keys [ 19.518994] Duration of test: 1930564260 ns [ 19.521446] Test 03: [ 19.531856] Adding 50000 keys [ 20.328824] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 20.950137] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0 [ 20.952667] Deleting 50000 keys [ 21.377250] Duration of test: 1844370890 ns [ 21.378562] Average test time: 1906021843 [ 21.379678] Testing concurrent rhashtable access from 10 threads [ 49.373966] Started 10 threads, 0 failed [ 49.388339] test passed [ 49.392354] test_printf: all 260 tests passed [ 50.190776] test_bitmap: test 13: input is '0-2047:128/256' OK, Time: 8523 [ 50.258456] test_bitmap: all 460506 tests passed [ 76.308035] watchdog: BUG: soft lockup - CPU#1 stuck for 23s! [swapper/0:1] [ 76.308308] irq event stamp: 3945268 [ 76.308308] hardirqs last enabled at (3945267): [] restore_regs_and_iret+0x0/0x1d [ 76.308308] hardirqs last disabled at (3945268): [] apic_timer_interrupt+0x98/0xb0 [ 76.308308] softirqs last enabled at (3945266): [] __do_softirq+0x41a/0x560 [ 76.308308] softirqs last disabled at (3945257): [] irq_exit+0x99/0xfe [ 76.308308] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 4.14.0-rc8 #65 [ 76.308308] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 76.308308] task: ffff880018fd6000 task.stack: ffff880018fe0000 [ 76.308308] RIP: 0010:__asan_load8+0x67/0x83 [ 76.308308] RSP: 0000:ffff880018fe7d88 EFLAGS: 00000a07 ORIG_RAX: ffffffffffffff10 [ 76.308308] RAX: 1ffff10003ee3800 RBX: ffff88001f73fa08 RCX: ffffffff81d122ec [ 76.308308] RDX: ffff880018fd6000 RSI: 0000000000000007 RDI: ffff88001f71c1f8 [ 76.308308] RBP: ffff880018fe7d88 R08: dffffc0000000000 R09: ffff880018fe7aa8 [ 76.308308] R10: ffffed0002100770 R11: ffff880010803b7f R12: ffff88001f621e80 [ 76.308308] R13: ffff88001f701838 R14: ffff88001f701848 R15: ffff88001f71c1e8 [ 76.308308] FS: 0000000000000000(0000) GS:ffff880019100000(0000) knlGS:0000000000000000 [ 76.308308] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 76.308308] CR2: 00000000ffffffff CR3: 0000000004474000 CR4: 00000000000006a0 [ 76.308308] Call Trace: [ 76.308308] parman_lsort_item_remove+0x24e/0x440 [ 76.308308] parman_item_remove+0x42/0x49 [ 76.308308] test_parman_init+0x6f6/0x742 [ 76.308308] ? test_bitmap_init+0x7b/0x7b [ 76.308308] do_one_initcall+0xc2/0x1f0 [ 76.308308] kernel_init_freeable+0x1e7/0x29b [ 76.308308] ? rest_init+0x29b/0x29b [ 76.308308] kernel_init+0x16/0x15f [ 76.308308] ? rest_init+0x29b/0x29b [ 76.308308] ret_from_fork+0x2a/0x40 [ 76.308308] Code: 03 43 80 3c 01 00 75 16 48 c1 e8 03 30 d2 42 8a 04 00 84 c0 74 08 31 d2 40 38 c6 0f 9d c2 83 e2 01 eb 12 48 c1 e8 03 42 8a 04 00 <84> c0 74 16 40 38 c6 0f 9d c2 84 d2 74 0c 31 d2 be 08 00 00 00 [ 76.308308] Kernel panic - not syncing: softlockup: hung tasks [ 76.308308] CPU: 1 PID: 1 Comm: swapper/0 Tainted: G L 4.14.0-rc8 #65 [ 76.308308] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 76.308308] Call Trace: [ 76.308308] [ 76.308308] dump_stack+0x147/0x1e0 [ 76.308308] panic+0x147/0x345 [ 76.308308] ? trace_hardirqs_off_caller+0x16e/0x196 [ 76.308308] watchdog_timer_fn+0x25f/0x293 [ 76.308308] hrtimer_run_queues+0x1bb/0x72b [ 76.308308] ? __touch_watchdog+0x21/0x21 [ 76.308308] run_local_timers+0x25/0xa3 [ 76.308308] update_process_times+0x26/0x52 [ 76.308308] tick_nohz_handler+0x132/0x194 [ 76.308308] smp_apic_timer_interrupt+0x17b/0x351 [ 76.308308] apic_timer_interrupt+0x9d/0xb0 [ 76.308308] [ 76.308308] RIP: 0010:__asan_load8+0x67/0x83 [ 76.308308] RSP: 0000:ffff880018fe7d88 EFLAGS: 00000a07 ORIG_RAX: ffffffffffffff10 [ 76.308308] RAX: 1ffff10003ee3800 RBX: ffff88001f73fa08 RCX: ffffffff81d122ec [ 76.308308] RDX: ffff880018fd6000 RSI: 0000000000000007 RDI: ffff88001f71c1f8 [ 76.308308] RBP: ffff880018fe7d88 R08: dffffc0000000000 R09: ffff880018fe7aa8 [ 76.308308] R10: ffffed0002100770 R11: ffff880010803b7f R12: ffff88001f621e80 [ 76.308308] R13: ffff88001f701838 R14: ffff88001f701848 R15: ffff88001f71c1e8 [ 76.308308] ? parman_lsort_item_remove+0x24e/0x440 [ 76.308308] parman_lsort_item_remove+0x24e/0x440 [ 76.308308] parman_item_remove+0x42/0x49 [ 76.308308] test_parman_init+0x6f6/0x742 [ 76.308308] ? test_bitmap_init+0x7b/0x7b [ 76.308308] do_one_initcall+0xc2/0x1f0 [ 76.308308] kernel_init_freeable+0x1e7/0x29b [ 76.308308] ? rest_init+0x29b/0x29b [ 76.308308] kernel_init+0x16/0x15f [ 76.308308] ? rest_init+0x29b/0x29b [ 76.308308] ret_from_fork+0x2a/0x40 [ 76.308308] Kernel Offset: disabled Elapsed time: 90 kvm=( qemu-system-x86_64 -enable-kvm -cpu kvm64 -kernel /pkg/linux/x86_64-randconfig-it0-11061641/gcc-4.9/39dae59d66acd86d1de24294bd2f343fd5e7a625/vmlinuz-4.14.0-rc8 -initrd /osimage/quantal/quantal-core-x86_64.cgz -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 -drive file=/fs/sda5/disk0-quantal-ivb41-1,media=disk,if=virtio -drive file=/fs/sda5/disk1-quantal-ivb41-1,media=disk,if=virtio -drive file=/fs/sda5/disk2-quantal-ivb41-1,media=disk,if=virtio -drive file=/fs/sda5/disk3-quantal-ivb41-1,media=disk,if=virtio -drive file=/fs/sda5/disk4-quantal-ivb41-1,media=disk,if=virtio -drive file=/fs/sda5/disk5-quantal-ivb41-1,media=disk,if=virtio -drive file=/fs/sda5/disk6-quantal-ivb41-1,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-quantal-ivb41-1 -serial file:/dev/shm/kboot/quantal-ivb41-1/serial -serial file:/dev/shm/kboot/quantal-ivb41-1/kmsg -daemonize -display none -monitor null ) append=( root=/dev/ram0 hung_task_panic=1 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 link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-it0-11061641/linux-devel:devel-spot-201711061347:39dae59d66acd86d1de24294bd2f343fd5e7a625/.vmlinuz-39dae59d66acd86d1de24294bd2f343fd5e7a625-20171106174331-11:quantal-ivb41-1 branch=linux-devel/devel-hourly-2017110613 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-it0-11061641/gcc-4.9/39dae59d66acd86d1de24294bd2f343fd5e7a625/vmlinuz-4.14.0-rc8 drbd.minor_count=8 ) "${kvm[@]}" -append "${append[*]}"