BUG 4.16? - perf: interrupt took too long/CPU: 0 PID: 0 Comm: swapper/0 Not tainted

[David C. Rankin]

Sorry for the bump on this thread, but bringing up CPU0 on 4.16 causes ~60 sec
delay and then injects another 120 seconds of dumps. 4.14 has no delay:

Hardware: Supermicro H8DM8-2/H8DM8-2, 2-Quad Core Opetron

dmesg Summary (full dmesg attached):

[    0.464392] NET: Registered protocol family 1
[    0.464769] PCI Interrupt Link [LUB0] enabled at IRQ 23
<snip>

[   10.412957] perf: interrupt took too long (10078 > 2500), lowering
kernel.perf_event_max_sample_rate to 19800
[   10.466267] INFO: NMI handler (perf_event_nmi_handler) took too long to
run: 3.398 msecs
[   10.466267] perf: interrupt took too long (23235 > 12597), lowering
kernel.perf_event_max_sample_rate to 8400
[   11.139636] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to
run: 38.086 msecs
[   11.138340] perf: interrupt took too long (979330 > 911352), lowering
kernel.perf_event_max_sample_rate to 300
[   11.391081] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to
run: 72.692 msecs
[   11.139636] INFO: NMI handler (perf_event_nmi_handler) took too long to
run: 381.378 msecs
[   12.138796] perf: interrupt took too long (1897735 > 1224162), lowering
kernel.perf_event_max_sample_rate to 300
[   25.142864] INFO: NMI handler (perf_event_nmi_handler) took too long to
run: 1947.833 msecs
[   28.140139] perf: interrupt took too long (13755889 > 2372168), lowering
kernel.perf_event_max_sample_rate to 300
[   28.138850] watchdog: BUG: soft lockup - CPU#0 stuck for 23s! [swapper/0:0]
[   28.138850] Modules linked in:
[   28.138850] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.16.13-1-ARCH #1
[   86.138261] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[   90.139366] RIP: 0010:__do_softirq+0x75/0x2e0
[   90.139366] RSP: 0018:ffff9b36e7c03f70 EFLAGS: 00000297 ORIG_RAX:
ffffffffffffff12
[   90.139366] RAX: 0000000000021000 RBX: ffff9b36e7c15f00 RCX: 000000003543891f
[   91.138917] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to
run: 467.840 msecs
[   91.138917] RDX: 0000000000000000 RSI: 000000003543891f RDI: 0000000000000100
[   91.138917] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000078
[   91.138917] R10: 000000005b1397ce R11: 0000000000000000 R12: 0000000000000000
[   91.138917] R13: 0000000000000000 R14: 0000000000000282 R15: 0000000000000000
[   91.138917] FS:  0000000000000000(0000) GS:ffff9b36e7c00000(0000)
knlGS:0000000000000000
[   91.138917] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[   91.138917] NMI watchdog: Watchdog detected hard LOCKUP on cpu 4
[   92.138146] CR2: ffff9b33d2655000 CR3: 000000011200a000 CR4: 00000000000006f0
[   92.138146] Call Trace:
[   92.138146]  <IRQ>
[   92.138146]  irq_exit+0xc9/0xe0
[   93.138944]  smp_apic_timer_interrupt+0x73/0x160
[   94.137773] Modules linked in:
[   94.137772]  apic_timer_interrupt+0xf/0x20
[   95.137578]  </IRQ>
[   95.137578] RIP: 0010:native_safe_halt+0x2/0x10
[   95.137578] RSP: 0018:ffffffffbf003ea0 EFLAGS: 00000202
[   96.136670] CPU: 4 PID: 0 Comm: swapper/4 Not tainted 4.16.13-1-ARCH #1
[   97.138510] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[   97.138081]  ORIG_RAX: ffffffffffffff12

<Roughly 900 lines snipped>

then continues

[  151.438482] Sending NMI from CPU 1 to CPUs 3:
[  151.469721] NMI backtrace for cpu 3
[  151.469722] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G             L
4.16.13-1-ARCH #1
[  151.469723] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.469724] RIP: 0010:native_queued_spin_lock_slowpath+0x19a/0x1c0
[  151.469725] RSP: 0018:ffff9b36e7cc3ef8 EFLAGS: 00000046
[  151.469726] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7ce2480
[  151.469726] RDX: 0000000000000002 RSI: ffffffffbee70e1c RDI: 0000000000100000
[  151.469727] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000101
[  151.469728] R10: 0000000000338518 R11: 0000000000000000 R12: ffff9b36e7ce2480
[  151.469728] R13: ffffffffbeed81f2 R14: 0000000000000009 R15: 0000000000000000
[  151.469729] FS:  0000000000000000(0000) GS:ffff9b36e7cc0000(0000)
knlGS:0000000000000000
[  151.469730] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.469731] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.469731] Call Trace:
[  151.469732]  <IRQ>
[  151.469733]  _raw_spin_lock_irqsave+0x44/0x50
[  151.469735]  rcu_process_callbacks+0xce/0x3b0
[  151.469737]  __do_softirq+0xf1/0x2e0
[  151.469739]  irq_exit+0xc9/0xe0
[  151.469741]  smp_apic_timer_interrupt+0x73/0x160
[  151.469743]  apic_timer_interrupt+0xf/0x20
[  151.469744]  </IRQ>
[  151.469745] RIP: 0010:native_safe_halt+0x2/0x10
[  151.469745] RSP: 0018:ffff9d6a431bbec0 EFLAGS: 00000202 ORIG_RAX:
ffffffffffffff12
[  151.469747] RAX: 0000000000000003 RBX: 0000000000000003 RCX: 0000000000000000
[  151.469747] RDX: 0000000000000000 RSI: ffffffffbee70e1c RDI: ffffffffbee7107a
[  151.469748] RBP: ffffffffbf132b60 R08: 0000000000000000 R09: 0000000000000000
[  151.469748] R10: 0000000000000000 R11: 0000000000000000 R12: ffffffffbeed81f2
[  151.469749] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[  151.469752]  default_idle+0x18/0x100
[  151.469753]  do_idle+0x179/0x1b0
[  151.469755]  cpu_startup_entry+0x6f/0x80
[  151.469757]  start_secondary+0x1aa/0x200
[  151.469758]  secondary_startup_64+0xa5/0xb0
[  151.469760] Code: 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02
00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 8b 41 08 <85>
c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 c0 0f 0d
[  151.438482] Sending NMI from CPU 1 to CPUs 4:
[  151.470739] NMI backtrace for cpu 4 skipped: idling at
native_safe_halt+0x2/0x10
[  151.438482] Sending NMI from CPU 1 to CPUs 5:
[  151.470007] NMI backtrace for cpu 5 skipped: idling at
native_safe_halt+0x2/0x10
[  151.438482] Sending NMI from CPU 1 to CPUs 7:
[  151.471011] NMI backtrace for cpu 7 skipped: idling at
native_safe_halt+0x2/0x10
[  151.474216] PCI Interrupt Link [LUB2] enabled at IRQ 22
[  151.490261] pci 0000:00:00.0: Found enabled HT MSI Mapping

and boot then completes normally.

All earlier kernels continue to boot fine without this delay. I have Archlinux
with both 4.16.13 and 4.14.47-LTS installed on this server, and 4.14.47 has no
such delay.

I have had no success trying to bisect the differences (I'm not that practiced
at it), but need help figuring out what changed and why I now have a 150
second delay where some test no loops through every core dumping info -- just
to figure out everything is OK and then continue the boot.

I have attached the full dmesg output here. If you need anything further, just
ask.


-- 
David C. Rankin, J.D.,P.E.

[    0.023333] Calibrating delay loop (skipped), value calculated using timer frequency.. 5229.70 BogoMIPS (lpj=8711520)
[    0.023333] pid_max: default: 32768 minimum: 301
[    0.023333] Security Framework initialized
[    0.023333] Yama: becoming mindful.
[    0.039371] Dentry cache hash table entries: 4194304 (order: 13, 33554432 bytes)
[    0.045744] Inode-cache hash table entries: 2097152 (order: 12, 16777216 bytes)
[    0.045982] Mount-cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.046181] Mountpoint-cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.046517] CPU: Physical Processor ID: 0
[    0.046518] CPU: Processor Core ID: 0
[    0.046520] mce: CPU supports 6 MCE banks
[    0.046526] LVT offset 0 assigned for vector 0xf9
[    0.046529] process: using AMD E400 aware idle routine
[    0.046531] Last level iTLB entries: 4KB 512, 2MB 16, 4MB 8
[    0.046532] Last level dTLB entries: 4KB 512, 2MB 128, 4MB 64, 1GB 0
[    0.046534] Spectre V2 : Mitigation: Full AMD retpoline
[    0.046535] Spectre V2 : Spectre v2 mitigation: Filling RSB on context switch
[    0.052140] Freeing SMP alternatives memory: 24K
[    0.053333] smpboot: CPU0: Quad-Core AMD Opteron(tm) Processor 8382 (family: 0x10, model: 0x4, stepping: 0x2)
[    0.066687] Performance Events: AMD PMU driver.
[    0.066693] ... version:                0
[    0.066694] ... bit width:              48
[    0.066694] ... generic registers:      4
[    0.066695] ... value mask:             0000ffffffffffff
[    0.066696] ... max period:             00007fffffffffff
[    0.066696] ... fixed-purpose events:   0
[    0.066697] ... event mask:             000000000000000f
[    0.073346] Hierarchical SRCU implementation.
[    0.093526] NMI watchdog: Enabled. Permanently consumes one hw-PMU counter.
[    0.100010] smp: Bringing up secondary CPUs ...
[    0.130031] x86: Booting SMP configuration:
[    0.130032] .... node  #0, CPUs:        #1  #2  #3
[    0.220038] .... node  #1, CPUs:    #4  #5  #6  #7
[    0.399283] smp: Brought up 2 nodes, 8 CPUs
[    0.399283] smpboot: Max logical packages: 3
[    0.399283] smpboot: Total of 8 processors activated (41830.01 BogoMIPS)
[    0.403998] devtmpfs: initialized
[    0.403998] x86/mm: Memory block size: 128MB
[    0.406732] PM: Registering ACPI NVS region [mem 0xc7fce000-0xc7ffffff] (204800 bytes)
[    0.406812] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370867519511994 ns
[    0.406812] futex hash table entries: 4096 (order: 6, 262144 bytes)
[    0.406873] pinctrl core: initialized pinctrl subsystem
[    0.406993] RTC time:  7:25:03, date: 06/03/18
[    0.408014] NET: Registered protocol family 16
[    0.408236] cpuidle: using governor ladder
[    0.408236] cpuidle: using governor menu
[    0.408236] node 0 link 2: io port [1000, ffffff]
[    0.408236] TOM: 00000000c8000000 aka 3200M
[    0.408236] Fam 10h mmconf [mem 0xe0000000-0xefffffff]
[    0.408236] node 0 link 2: mmio [e0000000, efffffff] ==> none
[    0.408236] node 0 link 2: mmio [c8000000, dfffffff]
[    0.408236] node 0 link 2: mmio [f0000000, ffe0ffff]
[    0.408236] node 0 link 2: mmio [a0000, bffff]
[    0.408236] TOM2: 0000000838000000 aka 33664M
[    0.408236] bus: [bus 00-7f] on node 0 link 2
[    0.408236] bus: 00 [io  0x0000-0xffff]
[    0.408236] bus: 00 [mem 0xc8000000-0xdfffffff]
[    0.408236] bus: 00 [mem 0xf0000000-0xffffffff]
[    0.408236] bus: 00 [mem 0x000a0000-0x000bffff]
[    0.408236] bus: 00 [mem 0x838000000-0xfcffffffff]
[    0.408236] ACPI: bus type PCI registered
[    0.408236] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    0.408236] PCI: Using configuration type 1 for base access
[    0.408236] PCI: Using configuration type 1 for extended access
[    0.410673] mtrr: your CPUs had inconsistent variable MTRR settings
[    0.410674] mtrr: probably your BIOS does not setup all CPUs.
[    0.410674] mtrr: corrected configuration.
[    0.411563] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    0.411563] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.411563] ACPI: Added _OSI(Module Device)
[    0.411563] ACPI: Added _OSI(Processor Device)
[    0.411563] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.411563] ACPI: Added _OSI(Processor Aggregator Device)
[    0.411563] ACPI: Executed 1 blocks of module-level executable AML code
[    0.416682] ACPI: Interpreter enabled
[    0.416682] ACPI: (supports S0 S1 S4 S5)
[    0.416682] ACPI: Using IOAPIC for interrupt routing
[    0.416682] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.416682] ACPI: Enabled 10 GPEs in block 00 to 1F
[    0.427969] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.427975] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI]
[    0.427980] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    0.428364] PCI host bridge to bus 0000:00
[    0.428367] pci_bus 0000:00: root bus resource [io  0x0000-0x03af window]
[    0.428368] pci_bus 0000:00: root bus resource [io  0x03e0-0x0cf7 window]
[    0.428370] pci_bus 0000:00: root bus resource [io  0x03b0-0x03bb window]
[    0.428371] pci_bus 0000:00: root bus resource [io  0x03c0-0x03df window]
[    0.428372] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.428374] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.428375] pci_bus 0000:00: root bus resource [mem 0x000d0000-0x000dffff window]
[    0.428377] pci_bus 0000:00: root bus resource [mem 0xc8000000-0xdfffffff window]
[    0.428378] pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window]
[    0.428380] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.428399] pci 0000:00:00.0: [10de:0369] type 00 class 0x050000
[    0.428631] pci 0000:00:01.0: [10de:0364] type 00 class 0x060100
[    0.428655] HPET not enabled in BIOS. You might try hpet=force boot option
[    0.428734] pci 0000:00:01.1: [10de:0368] type 00 class 0x0c0500
[    0.428745] pci 0000:00:01.1: reg 0x10: [io  0xec00-0xec3f]
[    0.428760] pci 0000:00:01.1: reg 0x20: [io  0x2d00-0x2d3f]
[    0.428765] pci 0000:00:01.1: reg 0x24: [io  0x2e00-0x2e3f]
[    0.428792] pci 0000:00:01.1: PME# supported from D3hot D3cold
[    0.428880] pci 0000:00:02.0: [10de:036c] type 00 class 0x0c0310
[    0.428889] pci 0000:00:02.0: reg 0x10: [mem 0xff6fb000-0xff6fbfff]
[    0.428918] pci 0000:00:02.0: supports D1 D2
[    0.428919] pci 0000:00:02.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.428997] pci 0000:00:02.1: [10de:036d] type 00 class 0x0c0320
[    0.429005] pci 0000:00:02.1: reg 0x10: [mem 0xff6fac00-0xff6facff]
[    0.429032] pci 0000:00:02.1: supports D1 D2
[    0.429034] pci 0000:00:02.1: PME# supported from D0 D1 D2 D3hot D3cold
[    0.429114] pci 0000:00:04.0: [10de:036e] type 00 class 0x01018a
[    0.429130] pci 0000:00:04.0: reg 0x20: [io  0xffa0-0xffaf]
[    0.429136] pci 0000:00:04.0: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.429137] pci 0000:00:04.0: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.429139] pci 0000:00:04.0: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.429140] pci 0000:00:04.0: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.429222] pci 0000:00:05.0: [10de:037f] type 00 class 0x010185
[    0.429229] pci 0000:00:05.0: reg 0x10: [io  0xe480-0xe487]
[    0.429233] pci 0000:00:05.0: reg 0x14: [io  0xe400-0xe403]
[    0.429236] pci 0000:00:05.0: reg 0x18: [io  0xe080-0xe087]
[    0.429240] pci 0000:00:05.0: reg 0x1c: [io  0xe000-0xe003]
[    0.429243] pci 0000:00:05.0: reg 0x20: [io  0xdc00-0xdc0f]
[    0.429247] pci 0000:00:05.0: reg 0x24: [mem 0xff6ff000-0xff6fffff]
[    0.429333] pci 0000:00:05.1: [10de:037f] type 00 class 0x010185
[    0.429341] pci 0000:00:05.1: reg 0x10: [io  0xd880-0xd887]
[    0.429344] pci 0000:00:05.1: reg 0x14: [io  0xd800-0xd803]
[    0.429347] pci 0000:00:05.1: reg 0x18: [io  0xd480-0xd487]
[    0.429351] pci 0000:00:05.1: reg 0x1c: [io  0xd400-0xd403]
[    0.429354] pci 0000:00:05.1: reg 0x20: [io  0xd080-0xd08f]
[    0.429358] pci 0000:00:05.1: reg 0x24: [mem 0xff6fe000-0xff6fefff]
[    0.429442] pci 0000:00:05.2: [10de:037f] type 00 class 0x010185
[    0.429450] pci 0000:00:05.2: reg 0x10: [io  0xd000-0xd007]
[    0.429453] pci 0000:00:05.2: reg 0x14: [io  0xcc00-0xcc03]
[    0.429456] pci 0000:00:05.2: reg 0x18: [io  0xc880-0xc887]
[    0.429460] pci 0000:00:05.2: reg 0x1c: [io  0xc800-0xc803]
[    0.429463] pci 0000:00:05.2: reg 0x20: [io  0xc480-0xc48f]
[    0.429467] pci 0000:00:05.2: reg 0x24: [mem 0xff6fd000-0xff6fdfff]
[    0.429554] pci 0000:00:06.0: [10de:0370] type 01 class 0x060401
[    0.429658] pci 0000:00:08.0: [10de:0373] type 00 class 0x068000
[    0.429667] pci 0000:00:08.0: reg 0x10: [mem 0xff6f6000-0xff6f6fff]
[    0.429671] pci 0000:00:08.0: reg 0x14: [io  0xc400-0xc407]
[    0.429674] pci 0000:00:08.0: reg 0x18: [mem 0xff6fa800-0xff6fa8ff]
[    0.429678] pci 0000:00:08.0: reg 0x1c: [mem 0xff6fa400-0xff6fa40f]
[    0.429705] pci 0000:00:08.0: supports D1 D2
[    0.429706] pci 0000:00:08.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.429784] pci 0000:00:09.0: [10de:0373] type 00 class 0x068000
[    0.429793] pci 0000:00:09.0: reg 0x10: [mem 0xff6f5000-0xff6f5fff]
[    0.429796] pci 0000:00:09.0: reg 0x14: [io  0xc080-0xc087]
[    0.429799] pci 0000:00:09.0: reg 0x18: [mem 0xff6fa000-0xff6fa0ff]
[    0.429803] pci 0000:00:09.0: reg 0x1c: [mem 0xff6f4c00-0xff6f4c0f]
[    0.429830] pci 0000:00:09.0: supports D1 D2
[    0.429831] pci 0000:00:09.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.429910] pci 0000:00:0a.0: [10de:0376] type 01 class 0x060400
[    0.429939] pci 0000:00:0a.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.430063] pci 0000:00:0d.0: [10de:0378] type 01 class 0x060400
[    0.430090] pci 0000:00:0d.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.430176] pci 0000:00:0e.0: [10de:0375] type 01 class 0x060400
[    0.430203] pci 0000:00:0e.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.430298] pci 0000:00:0f.0: [10de:0377] type 01 class 0x060400
[    0.430324] pci 0000:00:0f.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.430410] pci 0000:00:18.0: [1022:1200] type 00 class 0x060000
[    0.430491] pci 0000:00:18.1: [1022:1201] type 00 class 0x060000
[    0.430566] pci 0000:00:18.2: [1022:1202] type 00 class 0x060000
[    0.430639] pci 0000:00:18.3: [1022:1203] type 00 class 0x060000
[    0.430714] pci 0000:00:18.4: [1022:1204] type 00 class 0x060000
[    0.430791] pci 0000:00:19.0: [1022:1200] type 00 class 0x060000
[    0.430872] pci 0000:00:19.1: [1022:1201] type 00 class 0x060000
[    0.430948] pci 0000:00:19.2: [1022:1202] type 00 class 0x060000
[    0.431023] pci 0000:00:19.3: [1022:1203] type 00 class 0x060000
[    0.431102] pci 0000:00:19.4: [1022:1204] type 00 class 0x060000
[    0.431211] pci 0000:01:05.0: [1002:515e] type 00 class 0x030000
[    0.431224] pci 0000:01:05.0: reg 0x10: [mem 0xd0000000-0xd7ffffff pref]
[    0.431230] pci 0000:01:05.0: reg 0x14: [io  0xb000-0xb0ff]
[    0.431235] pci 0000:01:05.0: reg 0x18: [mem 0xff5f0000-0xff5fffff]
[    0.431254] pci 0000:01:05.0: reg 0x30: [mem 0xff5c0000-0xff5dffff pref]
[    0.431274] pci 0000:01:05.0: supports D1 D2
[    0.431321] pci 0000:00:06.0: PCI bridge to [bus 01] (subtractive decode)
[    0.431323] pci 0000:00:06.0:   bridge window [io  0x9000-0xbfff]
[    0.431325] pci 0000:00:06.0:   bridge window [mem 0xff500000-0xff5fffff]
[    0.431327] pci 0000:00:06.0:   bridge window [mem 0xcff00000-0xdfefffff pref]
[    0.431328] pci 0000:00:06.0:   bridge window [io  0x0000-0x03af window] (subtractive decode)
[    0.431330] pci 0000:00:06.0:   bridge window [io  0x03e0-0x0cf7 window] (subtractive decode)
[    0.431331] pci 0000:00:06.0:   bridge window [io  0x03b0-0x03bb window] (subtractive decode)
[    0.431332] pci 0000:00:06.0:   bridge window [io  0x03c0-0x03df window] (subtractive decode)
[    0.431333] pci 0000:00:06.0:   bridge window [io  0x0d00-0xffff window] (subtractive decode)
[    0.431335] pci 0000:00:06.0:   bridge window [mem 0x000a0000-0x000bffff window] (subtractive decode)
[    0.431336] pci 0000:00:06.0:   bridge window [mem 0x000d0000-0x000dffff window] (subtractive decode)
[    0.431338] pci 0000:00:06.0:   bridge window [mem 0xc8000000-0xdfffffff window] (subtractive decode)
[    0.431339] pci 0000:00:06.0:   bridge window [mem 0xf0000000-0xfebfffff window] (subtractive decode)
[    0.431364] pci 0000:00:0a.0: PCI bridge to [bus 02]
[    0.431393] pci 0000:00:0d.0: PCI bridge to [bus 03]
[    0.431422] pci 0000:00:0e.0: PCI bridge to [bus 04]
[    0.431448] pci 0000:00:0f.0: PCI bridge to [bus 05]
[    0.432390] ACPI: PCI Interrupt Link [LNKA] (IRQs 16 17 18 19) *10
[    0.432528] ACPI: PCI Interrupt Link [LNKB] (IRQs 16 17 18 19) *0, disabled.
[    0.432665] ACPI: PCI Interrupt Link [LNKC] (IRQs 16 17 18 19) *0, disabled.
[    0.432801] ACPI: PCI Interrupt Link [LNKD] (IRQs 16 17 18 19) *0, disabled.
[    0.432936] ACPI: PCI Interrupt Link [LNEA] (IRQs 16 17 18 19) *0, disabled.
[    0.433072] ACPI: PCI Interrupt Link [LNEB] (IRQs 16 17 18 19) *0, disabled.
[    0.433208] ACPI: PCI Interrupt Link [LNEC] (IRQs 16 17 18 19) *0, disabled.
[    0.433353] ACPI: PCI Interrupt Link [LNED] (IRQs 16 17 18 19) *0, disabled.
[    0.433490] ACPI: PCI Interrupt Link [LUB0] (IRQs 21 22 23) *7
[    0.433625] ACPI: PCI Interrupt Link [LMAD] (IRQs 20) *11
[    0.433759] ACPI: PCI Interrupt Link [LUB2] (IRQs 21 22 23) *10
[    0.433894] ACPI: PCI Interrupt Link [LMAC] (IRQs 20) *10
[    0.434029] ACPI: PCI Interrupt Link [LAZA] (IRQs 21 22 23) *0, disabled.
[    0.434164] ACPI: PCI Interrupt Link [LSMB] (IRQs 21 22 23) *11
[    0.434299] ACPI: PCI Interrupt Link [LPMU] (IRQs 21 22 23) *5
[    0.434433] ACPI: PCI Interrupt Link [LSA0] (IRQs 21 22 23) *11
[    0.434568] ACPI: PCI Interrupt Link [LSA1] (IRQs 21 22 23) *5
[    0.434722] ACPI: PCI Interrupt Link [LATA] (IRQs 21 22 23) *0, disabled.
[    0.434858] ACPI: PCI Interrupt Link [LSA2] (IRQs 21 22 23) *10
[    0.436702] pci 0000:01:05.0: vgaarb: setting as boot VGA device
[    0.436702] pci 0000:01:05.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    0.436702] pci 0000:01:05.0: vgaarb: bridge control possible
[    0.436702] vgaarb: loaded
[    0.436875] EDAC MC: Ver: 3.0.0
[    0.436930] PCI: Using ACPI for IRQ routing
[    0.436930] PCI: pci_cache_line_size set to 64 bytes
[    0.436930] pci 0000:00:06.0: can't claim BAR 14 [mem 0xff500000-0xff5fffff]: no compatible bridge window
[    0.436930] pci 0000:00:02.0: can't claim BAR 0 [mem 0xff6fb000-0xff6fbfff]: no compatible bridge window
[    0.436930] pci 0000:00:02.1: can't claim BAR 0 [mem 0xff6fac00-0xff6facff]: no compatible bridge window
[    0.436930] pci 0000:00:05.0: can't claim BAR 5 [mem 0xff6ff000-0xff6fffff]: no compatible bridge window
[    0.436930] pci 0000:00:05.1: can't claim BAR 5 [mem 0xff6fe000-0xff6fefff]: no compatible bridge window
[    0.436930] pci 0000:00:05.2: can't claim BAR 5 [mem 0xff6fd000-0xff6fdfff]: no compatible bridge window
[    0.436930] pci 0000:01:05.0: can't claim BAR 2 [mem 0xff5f0000-0xff5fffff]: no compatible bridge window
[    0.436930] pci 0000:00:08.0: can't claim BAR 0 [mem 0xff6f6000-0xff6f6fff]: no compatible bridge window
[    0.436930] pci 0000:00:08.0: can't claim BAR 2 [mem 0xff6fa800-0xff6fa8ff]: no compatible bridge window
[    0.436930] pci 0000:00:08.0: can't claim BAR 3 [mem 0xff6fa400-0xff6fa40f]: no compatible bridge window
[    0.436930] pci 0000:00:09.0: can't claim BAR 0 [mem 0xff6f5000-0xff6f5fff]: no compatible bridge window
[    0.436930] pci 0000:00:09.0: can't claim BAR 2 [mem 0xff6fa000-0xff6fa0ff]: no compatible bridge window
[    0.436930] pci 0000:00:09.0: can't claim BAR 3 [mem 0xff6f4c00-0xff6f4c0f]: no compatible bridge window
[    0.436930] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.436930] e820: reserve RAM buffer [mem 0xc7fc0000-0xc7ffffff]
[    0.436930] NetLabel: Initializing
[    0.436930] NetLabel:  domain hash size = 128
[    0.436930] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
[    0.436930] NetLabel:  unlabeled traffic allowed by default
[    0.436930] clocksource: Switched to clocksource tsc-early
[    0.452605] VFS: Disk quotas dquot_6.6.0
[    0.452636] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.452729] pnp: PnP ACPI init
[    0.453117] pnp 00:00: [dma 0 disabled]
[    0.453184] pnp 00:00: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.453445] pnp 00:01: [dma 0 disabled]
[    0.453523] pnp 00:01: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.454321] system 00:02: [io  0x04d0-0x04d1] has been reserved
[    0.454323] system 00:02: [io  0x0800-0x080f] has been reserved
[    0.454325] system 00:02: [io  0x2000-0x207f] has been reserved
[    0.454327] system 00:02: [io  0x2080-0x20ff] has been reserved
[    0.454328] system 00:02: [io  0x2400-0x247f] has been reserved
[    0.454329] system 00:02: [io  0x2480-0x24ff] has been reserved
[    0.454331] system 00:02: [io  0x2800-0x287f] has been reserved
[    0.454332] system 00:02: [io  0x2880-0x28ff] has been reserved
[    0.454334] system 00:02: [io  0x2c00-0x2c7f] has been reserved
[    0.454335] system 00:02: [io  0x2c80-0x2cff] has been reserved
[    0.454337] system 00:02: [mem 0x000d0000-0x000d3fff window] has been reserved
[    0.454339] system 00:02: [mem 0x000d4000-0x000d7fff window] has been reserved
[    0.454341] system 00:02: [mem 0x000de000-0x000dffff window] has been reserved
[    0.454343] system 00:02: [mem 0xff680000-0xff6bffff] has been reserved
[    0.454344] system 00:02: [mem 0xfee01000-0xfeefffff] has been reserved
[    0.454349] system 00:02: Plug and Play ACPI device, IDs PNP0c02 (active)
[    0.454440] pnp 00:03: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.454562] system 00:04: [mem 0xfec00000-0xfec00fff] could not be reserved
[    0.454564] system 00:04: [mem 0xfee00000-0xfee00fff] has been reserved
[    0.454568] system 00:04: Plug and Play ACPI device, IDs PNP0c02 (active)
[    0.454626] pnp 00:05: Plug and Play ACPI device, IDs PNP0303 PNP030b (active)
[    0.454772] system 00:06: [io  0x0290-0x029f] has been reserved
[    0.454776] system 00:06: Plug and Play ACPI device, IDs PNP0c02 (active)
[    0.454875] system 00:07: [mem 0xe0000000-0xefffffff] has been reserved
[    0.454879] system 00:07: Plug and Play ACPI device, IDs PNP0c02 (active)
[    0.455135] system 00:08: [mem 0x00000000-0x0009ffff] could not be reserved
[    0.455137] system 00:08: [mem 0x000c0000-0x000cffff] could not be reserved
[    0.455139] system 00:08: [mem 0x000e0000-0x000fffff] could not be reserved
[    0.455140] system 00:08: [mem 0x00100000-0xc7ffffff] could not be reserved
[    0.455142] system 00:08: [mem 0xfec00000-0xffffffff] could not be reserved
[    0.455146] system 00:08: Plug and Play ACPI device, IDs PNP0c01 (active)
[    0.455573] pnp: PnP ACPI: found 9 devices
[    0.461861] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.461868] pci 0000:01:05.0: can't claim BAR 6 [mem 0xff5c0000-0xff5dffff pref]: no compatible bridge window
[    0.461893] pci 0000:00:06.0: BAR 14: assigned [mem 0xc8000000-0xc80fffff]
[    0.461896] pci 0000:00:02.0: BAR 0: assigned [mem 0xc8100000-0xc8100fff]
[    0.461900] pci 0000:00:05.0: BAR 5: assigned [mem 0xc8101000-0xc8101fff]
[    0.461903] pci 0000:00:05.1: BAR 5: assigned [mem 0xc8102000-0xc8102fff]
[    0.461906] pci 0000:00:05.2: BAR 5: assigned [mem 0xc8103000-0xc8103fff]
[    0.461909] pci 0000:00:08.0: BAR 0: assigned [mem 0xc8104000-0xc8104fff]
[    0.461912] pci 0000:00:09.0: BAR 0: assigned [mem 0xc8105000-0xc8105fff]
[    0.461915] pci 0000:00:02.1: BAR 0: assigned [mem 0xc8106000-0xc81060ff]
[    0.461917] pci 0000:00:08.0: BAR 2: assigned [mem 0xc8106100-0xc81061ff]
[    0.461920] pci 0000:00:09.0: BAR 2: assigned [mem 0xc8106200-0xc81062ff]
[    0.461923] pci 0000:00:08.0: BAR 3: assigned [mem 0xc8106300-0xc810630f]
[    0.461925] pci 0000:00:09.0: BAR 3: assigned [mem 0xc8106310-0xc810631f]
[    0.461929] pci 0000:01:05.0: BAR 6: assigned [mem 0xcff00000-0xcff1ffff pref]
[    0.461931] pci 0000:01:05.0: BAR 2: assigned [mem 0xc8000000-0xc800ffff]
[    0.461934] pci 0000:00:06.0: PCI bridge to [bus 01]
[    0.461936] pci 0000:00:06.0:   bridge window [io  0x9000-0xbfff]
[    0.461938] pci 0000:00:06.0:   bridge window [mem 0xc8000000-0xc80fffff]
[    0.461940] pci 0000:00:06.0:   bridge window [mem 0xcff00000-0xdfefffff pref]
[    0.461943] pci 0000:00:0a.0: PCI bridge to [bus 02]
[    0.461947] pci 0000:00:0d.0: PCI bridge to [bus 03]
[    0.461951] pci 0000:00:0e.0: PCI bridge to [bus 04]
[    0.461955] pci 0000:00:0f.0: PCI bridge to [bus 05]
[    0.461960] pci_bus 0000:00: resource 4 [io  0x0000-0x03af window]
[    0.461961] pci_bus 0000:00: resource 5 [io  0x03e0-0x0cf7 window]
[    0.461963] pci_bus 0000:00: resource 6 [io  0x03b0-0x03bb window]
[    0.461964] pci_bus 0000:00: resource 7 [io  0x03c0-0x03df window]
[    0.461965] pci_bus 0000:00: resource 8 [io  0x0d00-0xffff window]
[    0.461967] pci_bus 0000:00: resource 9 [mem 0x000a0000-0x000bffff window]
[    0.461968] pci_bus 0000:00: resource 10 [mem 0x000d0000-0x000dffff window]
[    0.461969] pci_bus 0000:00: resource 11 [mem 0xc8000000-0xdfffffff window]
[    0.461971] pci_bus 0000:00: resource 12 [mem 0xf0000000-0xfebfffff window]
[    0.461972] pci_bus 0000:01: resource 0 [io  0x9000-0xbfff]
[    0.461974] pci_bus 0000:01: resource 1 [mem 0xc8000000-0xc80fffff]
[    0.461975] pci_bus 0000:01: resource 2 [mem 0xcff00000-0xdfefffff pref]
[    0.461976] pci_bus 0000:01: resource 4 [io  0x0000-0x03af window]
[    0.461978] pci_bus 0000:01: resource 5 [io  0x03e0-0x0cf7 window]
[    0.461979] pci_bus 0000:01: resource 6 [io  0x03b0-0x03bb window]
[    0.461980] pci_bus 0000:01: resource 7 [io  0x03c0-0x03df window]
[    0.461981] pci_bus 0000:01: resource 8 [io  0x0d00-0xffff window]
[    0.461983] pci_bus 0000:01: resource 9 [mem 0x000a0000-0x000bffff window]
[    0.461984] pci_bus 0000:01: resource 10 [mem 0x000d0000-0x000dffff window]
[    0.461985] pci_bus 0000:01: resource 11 [mem 0xc8000000-0xdfffffff window]
[    0.461987] pci_bus 0000:01: resource 12 [mem 0xf0000000-0xfebfffff window]
[    0.462098] NET: Registered protocol family 2
[    0.462335] tcp_listen_portaddr_hash hash table entries: 16384 (order: 6, 262144 bytes)
[    0.462535] TCP established hash table entries: 262144 (order: 9, 2097152 bytes)
[    0.463358] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[    0.463732] TCP: Hash tables configured (established 262144 bind 65536)
[    0.463828] UDP hash table entries: 16384 (order: 7, 524288 bytes)
[    0.464057] UDP-Lite hash table entries: 16384 (order: 7, 524288 bytes)
[    0.464392] NET: Registered protocol family 1
[    0.464769] PCI Interrupt Link [LUB0] enabled at IRQ 23
[   10.412957] INFO: NMI handler (perf_event_nmi_handler) took too long to run: 1.718 msecs
[   10.412957] perf: interrupt took too long (10078 > 2500), lowering kernel.perf_event_max_sample_rate to 19800
[   10.466267] INFO: NMI handler (perf_event_nmi_handler) took too long to run: 3.398 msecs
[   10.466267] perf: interrupt took too long (23235 > 12597), lowering kernel.perf_event_max_sample_rate to 8400
[   11.139636] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 38.086 msecs
[   11.138340] perf: interrupt took too long (979330 > 911352), lowering kernel.perf_event_max_sample_rate to 300
[   11.391081] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 72.692 msecs
[   11.139636] INFO: NMI handler (perf_event_nmi_handler) took too long to run: 381.378 msecs
[   12.138796] perf: interrupt took too long (1897735 > 1224162), lowering kernel.perf_event_max_sample_rate to 300
[   25.142864] INFO: NMI handler (perf_event_nmi_handler) took too long to run: 1947.833 msecs
[   28.140139] perf: interrupt took too long (13755889 > 2372168), lowering kernel.perf_event_max_sample_rate to 300
[   28.138850] watchdog: BUG: soft lockup - CPU#0 stuck for 23s! [swapper/0:0]
[   28.138850] Modules linked in:
[   28.138850] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.16.13-1-ARCH #1
[   86.138261] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[   90.139366] RIP: 0010:__do_softirq+0x75/0x2e0
[   90.139366] RSP: 0018:ffff9b36e7c03f70 EFLAGS: 00000297 ORIG_RAX: ffffffffffffff12
[   90.139366] RAX: 0000000000021000 RBX: ffff9b36e7c15f00 RCX: 000000003543891f
[   91.138917] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 467.840 msecs
[   91.138917] RDX: 0000000000000000 RSI: 000000003543891f RDI: 0000000000000100
[   91.138917] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000078
[   91.138917] R10: 000000005b1397ce R11: 0000000000000000 R12: 0000000000000000
[   91.138917] R13: 0000000000000000 R14: 0000000000000282 R15: 0000000000000000
[   91.138917] FS:  0000000000000000(0000) GS:ffff9b36e7c00000(0000) knlGS:0000000000000000
[   91.138917] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[   91.138917] NMI watchdog: Watchdog detected hard LOCKUP on cpu 4
[   92.138146] CR2: ffff9b33d2655000 CR3: 000000011200a000 CR4: 00000000000006f0
[   92.138146] Call Trace:
[   92.138146]  <IRQ>
[   92.138146]  irq_exit+0xc9/0xe0
[   93.138944]  smp_apic_timer_interrupt+0x73/0x160
[   94.137773] Modules linked in:
[   94.137772]  apic_timer_interrupt+0xf/0x20
[   95.137578]  </IRQ>
[   95.137578] RIP: 0010:native_safe_halt+0x2/0x10
[   95.137578] RSP: 0018:ffffffffbf003ea0 EFLAGS: 00000202
[   96.136670] CPU: 4 PID: 0 Comm: swapper/4 Not tainted 4.16.13-1-ARCH #1
[   97.138510] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[   97.138081]  ORIG_RAX: ffffffffffffff12
[   97.138510] RIP: 0010:_raw_spin_unlock+0x5/0x30
[   97.138081] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
[   97.138081] RDX: 0000000000000000 RSI: ffffffffbee70e1c RDI: ffffffffbee7107a
[   97.138081] RBP: ffffffffbf132b60 R08: ffffffffffcd8638 R09: ffff9b3ae58c4178
[   97.138081] R10: 0000000000000002 R11: 0000000000000000 R12: ffffffffbeed81f2
[   97.138081] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[   98.137137] RSP: 0018:ffff9b3af7c03d70 EFLAGS: 00000002
[   98.137137]  default_idle+0x18/0x100
[   99.138495]  do_idle+0x179/0x1b0
[  100.137586] RAX: 000000000000adcc RBX: ffffffffbf5e7950 RCX: 000000000000ad7c
[  100.137586]  cpu_startup_entry+0x6f/0x80
[  100.137586]  start_kernel+0x4ba/0x4da
[  101.138256] RDX: 0000000000000050 RSI: ffffffffbf5dcbd4 RDI: ffffffffbf5d9eec
[  102.138085] RBP: 0000000000000097 R08: 0000000000000005 R09: 000000000000020f
[  102.136817]  secondary_startup_64+0xa5/0xb0
[  102.136817] Code: 
[  102.138085] R10: 0000000000000000 R11: ffffffffbf5dbf2d R12: ffffffffbf132b60
[  102.136817] 00 01 00 00 e8 1d 31 6a ff 
[  103.145019] R13: 000000000000004f R14: 0000000000000001 R15: 0000000000000006
[  103.145019] c7 
[  104.136801] FS:  0000000000000000(0000) GS:ffff9b3af7c00000(0000) knlGS:0000000000000000
[  104.136800] 44 
[  104.136801] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  105.139854] 24 20 
[  105.142014] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  105.142014] Call Trace:
[  106.140854]  <IRQ>
[  106.140854] 0a 00 00 00 44 89 
[  107.139863]  console_unlock.part.6+0x161/0x500
[  107.139863]  vprintk_emit+0x298/0x400
[  107.139863] 74 24 
[  108.142024]  printk+0x58/0x6f
[  108.142024] 04 48 c7 c0 00 10 02 00 65 c7 
[  109.141037]  ? _raw_spin_unlock_irqrestore+0x20/0x40
[  109.140170] 00 
[  109.141037]  irq_work_run_list+0x4d/0x70
[  111.139670]  irq_work_run+0x26/0x50
[  111.139242] 00 00 00 00 fb 66 0f 1f 44 00 00 <48> c7 44 24 08 00 51 00 bf b8 ff ff 
[  112.138548]  smp_irq_work_interrupt+0x32/0xf0
[  112.138548] ff 
[  113.142175]  irq_work_interrupt+0xf/0x20
[  114.139538] RIP: 0010:__do_softirq+0x75/0x2e0
[  114.139538] ff 0f bc 44 
[  114.139538] RSP: 0018:ffff9b3af7c03f70 EFLAGS: 00000297
[  114.139538] 24 04 83 c0 
[  116.138843]  ORIG_RAX: ffffffffffffff09
[  116.138843] INFO: NMI handler (perf_event_nmi_handler) took too long to run: 53457.138 msecs
[  117.140893] RAX: 0000000000021000 RBX: ffff9b3af7c15f00 RCX: 000000010acfcd03
[  117.140460] perf: interrupt took too long (429380244 > 71980910), lowering kernel.perf_event_max_sample_rate to 300
[  117.140893] RDX: 0000000000000000 RSI: 000000010acfcd03 RDI: 0000000000000100
[  118.139618] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000078
[  118.139618] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
[  119.137726] R13: 0000000000000000 R14: 0000000000000282 R15: 0000000000000000
[  120.139505]  ? irq_work_interrupt+0xa/0x20
[  120.139505]  irq_exit+0xc9/0xe0
[  120.139505]  smp_apic_timer_interrupt+0x73/0x160
[  120.139505]  apic_timer_interrupt+0xf/0x20
[  121.139024]  </IRQ>
[  121.139024] RIP: 0010:native_safe_halt+0x2/0x10
[  121.139024] RSP: 0018:ffff9d6a431c3ec0 EFLAGS: 00000202 ORIG_RAX: ffffffffffffff12
[  122.139100] RAX: 0000000000000004 RBX: 0000000000000004 RCX: 0000000000000000
[  122.139100] RDX: 0000000000000000 RSI: ffffffffbee70e1c RDI: ffffffffbee7107a
[  122.139100] RBP: ffffffffbf132b60 R08: ffffffffffce6097 R09: 0000000000000000
[  122.139100] R10: 0000000000000000 R11: 0000000000000000 R12: ffffffffbeed81f2
[  122.139100] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[  122.139100]  default_idle+0x18/0x100
[  123.138648]  do_idle+0x179/0x1b0
[  123.138648]  cpu_startup_entry+0x6f/0x80
[  123.138648]  start_secondary+0x1aa/0x200
[  123.138648]  secondary_startup_64+0xa5/0xb0
[  124.139298] Code: 00 e8 50 aa 97 ff 65 8b 15 f9 d4 8e 41 85 d2 74 06 31 d2 89 d0 5b c3 e8 97 a7 8d ff eb f5 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 <c6> 07 00 0f 1f 40 00 bf 01 00 00 00 e8 1a aa 97 ff 65 8b 05 c3 
[  132.137067] NMI watchdog: Watchdog detected hard LOCKUP on cpu 0
[  132.137067] Modules linked in:
[  132.137067] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.16.13-1-ARCH #1
[  132.137067] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  132.137067] RIP: 0010:native_queued_spin_lock_slowpath+0x14d/0x1c0
[  132.137067] RSP: 0018:ffff9b36e7c03c68 EFLAGS: 00000002
[  132.137067] RAX: 0000000000000101 RBX: ffffffffbf5d9eec RCX: 0000000000000101
[  132.137067] RDX: 0000000000000101 RSI: 0000000000000001 RDI: 0000000000000001
[  132.137067] RBP: 0000000000000000 R08: ffffffffbee63425 R09: ffff9b36e7c03cf0
[  133.137475] R10: 000000000000020e R11: 0000000000015210 R12: 0000000000000000
[  133.137475] R13: 0000000000000000 R14: ffff9b36e7c03cf0 R15: 00000000ffffffff
[  133.137475] FS:  0000000000000000(0000) GS:ffff9b36e7c00000(0000) knlGS:0000000000000000
[  133.137475] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  133.137475] CR2: ffff9b33d2655000 CR3: 000000011200a000 CR4: 00000000000006f0
[  133.137475] Call Trace:
[  133.137475]  <IRQ>
[  133.137475]  _raw_spin_lock+0x2e/0x40
[  133.137475]  vprintk_emit+0x69/0x400
[  133.137475]  printk+0x58/0x6f
[  133.137475]  dump_stack_print_info.cold.16+0x16/0x2a
[  133.137475]  ? show_regs+0x2e/0xf7
[  133.137475]  ? print_modules+0xb8/0xd9
[  133.137475]  ? watchdog_timer_fn+0x233/0x280
[  133.137475]  ? watchdog+0x30/0x30
[  133.137475]  ? __hrtimer_run_queues+0x100/0x2d0
[  133.137475]  ? hrtimer_run_queues+0xd3/0x120
[  133.137475]  ? run_local_timers+0x21/0x50
[  133.137475]  ? update_process_times+0x21/0x60
[  133.137475]  ? tick_periodic+0x27/0x80
[  133.137475]  ? tick_handle_periodic+0x1f/0x60
[  133.137475]  ? smp_apic_timer_interrupt+0x69/0x160
[  134.137636]  ? apic_timer_interrupt+0xf/0x20
[  134.137636]  ? apic_timer_interrupt+0xa/0x20
[  134.137636]  ? __do_softirq+0x75/0x2e0
[  134.137636]  ? irq_exit+0xc9/0xe0
[  134.137636]  ? smp_apic_timer_interrupt+0x73/0x160
[  134.137636]  ? apic_timer_interrupt+0xf/0x20
[  134.137636]  </IRQ>
[  134.137636]  ? native_safe_halt+0x2/0x10
[  134.137636]  ? default_idle+0x18/0x100
[  134.137636]  ? do_idle+0x179/0x1b0
[  134.137636]  ? cpu_startup_entry+0x6f/0x80
[  134.137636]  ? start_kernel+0x4ba/0x4da
[  134.137636]  ? secondary_startup_64+0xa5/0xb0
[  134.137636] Code: 31 c0 39 c7 74 eb c6 03 01 4d 85 c0 74 30 41 c7 40 08 01 00 00 00 eb 8b 83 fa 01 0f 84 e1 fe ff ff 8b 03 84 c0 74 08 f3 90 8b 03 <84> c0 75 f8 b8 01 00 00 00 66 89 03 5b 5d 41 5c c3 f3 90 48 8b 
[  151.431595] pci 0000:00:02.0: OHCI: BIOS handoff failed (BIOS bug?) 000007b4
[  151.435019] INFO: rcu_preempt self-detected stall on CPU
[  151.435022] INFO: rcu_preempt self-detected stall on CPU
[  151.435035] 	5-...!: (1 GPs behind) idle=4e6/0/1 softirq=31/116 fqs=0 last_accelerate: 0000/51e6, nonlazy_posted: 0, .D
[  151.435042] 	
[  151.435046] 	7-...!: (1 GPs behind) idle=bd6/0/1 softirq=12/13 fqs=0 last_accelerate: 0000/51e6, nonlazy_posted: 0, .D
[  151.435048]  (t=45040 jiffies g=-294 c=-295 q=0)
[  151.435052] rcu_preempt kthread starved for 45040 jiffies! g18446744073709551322 c18446744073709551321 f0x0 RCU_GP_WAIT_FQS(3) ->state=0x402 ->cpu=1
[  151.435054] rcu_preempt     I
[  151.435058] 	
[  151.435063]     0     9      2 0x80000000
[  151.435064]  (t=45040 jiffies g=-294 c=-295 q=0)
[  151.435067] rcu_preempt kthread starved for 45040 jiffies! g18446744073709551322 c18446744073709551321 f0x0 RCU_GP_WAIT_FQS(3) ->state=0x402 ->cpu=1
[  151.435070] rcu_preempt     I
[  151.435073] Call Trace:
[  151.435075]     0     9      2 0x80000000
[  151.435076] Call Trace:
[  151.435084]  ? __schedule+0x282/0x890
[  151.435088]  ? __schedule+0x282/0x890
[  151.435091]  ? _raw_spin_lock_irqsave+0x25/0x50
[  151.435093]  ? _raw_spin_lock_irqsave+0x25/0x50
[  151.435095]  schedule+0x32/0x90
[  151.435097]  schedule+0x32/0x90
[  151.435101]  schedule_timeout+0x1d1/0x4a0
[  151.435104]  schedule_timeout+0x1d1/0x4a0
[  151.435109]  ? collect_expired_timers+0xa0/0xa0
[  151.435113]  ? collect_expired_timers+0xa0/0xa0
[  151.435116]  rcu_gp_kthread+0x427/0x8f0
[  151.435118]  rcu_gp_kthread+0x427/0x8f0
[  151.435121]  ? synchronize_rcu_expedited+0x30/0x30
[  151.435122]  ? synchronize_rcu_expedited+0x30/0x30
[  151.435125]  kthread+0x112/0x130
[  151.435128]  kthread+0x112/0x130
[  151.435131]  ? kthread_create_on_node+0x60/0x60
[  151.435132]  ? kthread_create_on_node+0x60/0x60
[  151.435134]  ret_from_fork+0x22/0x40
[  151.435136]  ret_from_fork+0x22/0x40
[  151.435149] Sending NMI from CPU 7 to CPUs 0:
[  151.435163] NMI backtrace for cpu 0 skipped: idling at native_safe_halt+0x2/0x10
[  151.435690] INFO: rcu_preempt self-detected stall on CPU
[  151.435725] INFO: rcu_preempt self-detected stall on CPU
[  151.436162] Sending NMI from CPU 7 to CPUs 1:
[  151.436167] NMI backtrace for cpu 1
[  151.436170] CPU: 1 PID: 9 Comm: rcu_preempt Tainted: G             L   4.16.13-1-ARCH #1
[  151.436170] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.436173] RIP: 0010:native_queued_spin_lock_slowpath+0x107/0x1c0
[  151.436175] RSP: 0018:ffff9d6a43173e28 EFLAGS: 00000002
[  151.436176] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7c62480
[  151.436177] RDX: 0000000000140101 RSI: ffffffffbee70e1c RDI: 0000000000080000
[  151.436177] RBP: 0000000000000000 R08: 0000000000000000 R09: ffff9b3ae58c4178
[  151.436178] R10: 0000000000000002 R11: 0000000000000001 R12: ffff9b36e7c62480
[  151.436179] R13: 0000000000000000 R14: 0000000000000001 R15: 0000000000000000
[  151.436180] FS:  0000000000000000(0000) GS:ffff9b36e7c40000(0000) knlGS:0000000000000000
[  151.436181] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.436181] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.436182] Call Trace:
[  151.436186]  _raw_spin_lock_irqsave+0x44/0x50
[  151.436188]  force_qs_rnp+0x94/0x190
[  151.436190]  ? rcu_oom_callback+0x30/0x30
[  151.436192]  rcu_gp_kthread+0x527/0x8f0
[  151.436194]  ? synchronize_rcu_expedited+0x30/0x30
[  151.436196]  kthread+0x112/0x130
[  151.436197]  ? kthread_create_on_node+0x60/0x60
[  151.436199]  ret_from_fork+0x22/0x40
[  151.436201] Code: c3 f3 90 8b 33 81 fe 00 01 00 00 74 f4 e9 4b ff ff ff 89 f8 c1 e8 10 66 87 43 02 89 c2 c1 e2 10 75 6f 45 31 c0 eb 02 f3 90 8b 13 <66> 85 d2 75 f7 be 01 00 00 00 eb 0c 89 d0 f0 0f b1 33 39 c2 74 
[  151.436669] INFO: rcu_preempt self-detected stall on CPU
[  151.437166] Sending NMI from CPU 7 to CPUs 3:
[  151.437170] NMI backtrace for cpu 3
[  151.437172] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G             L   4.16.13-1-ARCH #1
[  151.437173] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.437176] RIP: 0010:native_queued_spin_lock_slowpath+0x197/0x1c0
[  151.437177] RSP: 0018:ffff9b36e7cc3e30 EFLAGS: 00000046
[  151.437178] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7ce2480
[  151.437179] RDX: 0000000000000002 RSI: ffffffffbee70e1c RDI: 0000000000100000
[  151.437180] RBP: 0000000000000000 R08: 0000000000000000 R09: 00000000000002de
[  151.437180] R10: ffff9b36e78b5be0 R11: ffffffffbf5dbf2d R12: ffff9b36e7ce2480
[  151.437181] R13: ffff9b36e7ce2500 R14: ffffffffbf051640 R15: ffff9b36e7ce2500
[  151.437182] FS:  0000000000000000(0000) GS:ffff9b36e7cc0000(0000) knlGS:0000000000000000
[  151.437183] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.437184] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.437184] Call Trace:
[  151.437186]  <IRQ>
[  151.437189]  _raw_spin_lock_irqsave+0x44/0x50
[  151.437192]  rcu_check_callbacks.cold.54+0xf9/0x482
[  151.437195]  ? tick_sched_handle.isra.5+0x60/0x60
[  151.437196]  ? update_process_times+0x28/0x60
[  151.437198]  ? tick_sched_handle.isra.5+0x20/0x60
[  151.437199]  ? tick_sched_timer+0x38/0x80
[  151.437200]  ? __hrtimer_run_queues+0x100/0x2d0
[  151.437202]  ? hrtimer_interrupt+0x10a/0x220
[  151.437204]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.437206]  ? apic_timer_interrupt+0xf/0x20
[  151.437206]  </IRQ>
[  151.437208]  ? native_safe_halt+0x2/0x10
[  151.437210]  ? default_idle+0x18/0x100
[  151.437211]  ? do_idle+0x179/0x1b0
[  151.437213]  ? cpu_startup_entry+0x6f/0x80
[  151.437215]  ? start_secondary+0x1aa/0x200
[  151.437217]  ? secondary_startup_64+0xa5/0xb0
[  151.437218] Code: c3 c1 ea 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 <8b> 41 08 85 c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 
[  151.438170] Sending NMI from CPU 7 to CPUs 4:
[  151.438176] NMI backtrace for cpu 4
[  151.438179] CPU: 4 PID: 0 Comm: swapper/4 Tainted: G             L   4.16.13-1-ARCH #1
[  151.438179] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438183] RIP: 0010:native_queued_spin_lock_slowpath+0x197/0x1c0
[  151.438184] RSP: 0018:ffff9b3af7c03f00 EFLAGS: 00000046
[  151.438185] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b3af7c22480
[  151.438186] RDX: 0000000000000000 RSI: ffffffffbee70e1c RDI: 0000000000140000
[  151.438187] RBP: 0000000000000000 R08: 0000000000000000 R09: 00000000000002c5
[  151.438188] R10: ffff9b36e78b5b40 R11: ffffffffbf5dbf2d R12: ffff9b3af7c22480
[  151.438188] R13: ffff9b3af7c22500 R14: ffffffffbf051640 R15: ffff9b3af7c22500
[  151.438190] FS:  0000000000000000(0000) GS:ffff9b3af7c00000(0000) knlGS:0000000000000000
[  151.438191] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.438191] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.438192] Call Trace:
[  151.438194]  <IRQ>
[  151.438197]  _raw_spin_lock_irqsave+0x44/0x50
[  151.438201]  rcu_check_callbacks.cold.54+0xf9/0x482
[  151.438203]  ? lapic_next_event+0x1c/0x20
[  151.438205]  ? clockevents_program_event+0x94/0xf0
[  151.438208]  ? update_process_times+0x28/0x60
[  151.438209]  ? tick_periodic+0x27/0x80
[  151.438210]  ? tick_handle_periodic+0x1f/0x60
[  151.438212]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.438213]  ? apic_timer_interrupt+0xf/0x20
[  151.438214]  </IRQ>
[  151.438216]  ? native_safe_halt+0x2/0x10
[  151.438218]  ? default_idle+0x18/0x100
[  151.438219]  ? do_idle+0x179/0x1b0
[  151.438221]  ? cpu_startup_entry+0x6f/0x80
[  151.438222]  ? start_secondary+0x1aa/0x200
[  151.438223]  ? secondary_startup_64+0xa5/0xb0
[  151.438225] Code: c3 c1 ea 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 <8b> 41 08 85 c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 
[  151.438337] Sending NMI from CPU 7 to CPUs 5:
[  151.438335] NMI backtrace for cpu 5
[  151.438335] CPU: 5 PID: 0 Comm: swapper/5 Tainted: G             L   4.16.13-1-ARCH #1
[  151.438335] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438335] RIP: 0010:native_queued_spin_lock_slowpath+0x149/0x1c0
[  151.438335] RSP: 0018:ffff9b3af7c43ed0 EFLAGS: 00000002
[  151.438335] RAX: 0000000000100101 RBX: ffffffffbf051640 RCX: 0000000000000101
[  151.438335] RDX: 0000000000000101 RSI: 0000000000000001 RDI: 0000000000000001
[  151.438335] RBP: 0000000000000087 R08: ffffffffbe8001ea R09: ffffffffbf25c0d0
[  151.438335] R10: ffffffffbf25c0cc R11: 0000000000000012 R12: ffffffffbf051640
[  151.438335] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b3af7c62500
[  151.438335] FS:  0000000000000000(0000) GS:ffff9b3af7c40000(0000) knlGS:0000000000000000
[  151.438335] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.438335] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.438335] Call Trace:
[  151.438335]  <IRQ>
[  151.438335]  _raw_spin_lock_irqsave+0x44/0x50
[  151.438335]  rcu_dump_cpu_stacks+0x48/0xcb
[  151.438335]  rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.438335]  ? lapic_next_event+0x1c/0x20
[  151.438335]  ? clockevents_program_event+0x94/0xf0
[  151.438335]  ? update_process_times+0x28/0x60
[  151.438335]  ? tick_periodic+0x27/0x80
[  151.438335]  ? tick_handle_periodic+0x1f/0x60
[  151.438335]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.438335]  ? apic_timer_interrupt+0xf/0x20
[  151.438335]  </IRQ>
[  151.438335]  ? native_safe_halt+0x2/0x10
[  151.438335]  ? default_idle+0x18/0x100
[  151.438335]  ? do_idle+0x179/0x1b0
[  151.438335]  ? cpu_startup_entry+0x6f/0x80
[  151.438335]  ? start_secondary+0x1aa/0x200
[  151.438335]  ? secondary_startup_64+0xa5/0xb0
[  151.438335] Code: c2 89 d0 66 31 c0 39 c7 74 eb c6 03 01 4d 85 c0 74 30 41 c7 40 08 01 00 00 00 eb 8b 83 fa 01 0f 84 e1 fe ff ff 8b 03 84 c0 74 08 <f3> 90 8b 03 84 c0 75 f8 b8 01 00 00 00 66 89 03 5b 5d 41 5c c3 
[  151.438337] Sending NMI from CPU 7 to CPUs 6:
[  151.438349] NMI backtrace for cpu 6 skipped: idling at native_safe_halt+0x2/0x10
[  151.438337] NMI backtrace for cpu 7
[  151.438337] CPU: 7 PID: 0 Comm: swapper/7 Tainted: G             L   4.16.13-1-ARCH #1
[  151.438337] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438337] Call Trace:
[  151.438337]  <IRQ>
[  151.438337]  dump_stack+0x5c/0x85
[  151.438337]  nmi_cpu_backtrace.cold.0+0x13/0x5b
[  151.438337]  ? lapic_can_unplug_cpu.cold.4+0x3d/0x3d
[  151.438337]  ? nmi_trigger_cpumask_backtrace+0x111/0x11d
[  151.438337]  ? rcu_dump_cpu_stacks+0x9b/0xcb
[  151.438337]  ? rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.438337]  ? lapic_next_event+0x1c/0x20
[  151.438337]  ? clockevents_program_event+0x94/0xf0
[  151.438337]  ? update_process_times+0x28/0x60
[  151.438337]  ? tick_periodic+0x27/0x80
[  151.438337]  ? tick_handle_periodic+0x1f/0x60
[  151.438337]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.438337]  ? apic_timer_interrupt+0xf/0x20
[  151.438337]  </IRQ>
[  151.438337]  ? native_safe_halt+0x2/0x10
[  151.438337]  ? default_idle+0x18/0x100
[  151.438337]  ? do_idle+0x179/0x1b0
[  151.438337]  ? cpu_startup_entry+0x6f/0x80
[  151.438337]  ? start_secondary+0x1aa/0x200
[  151.438337]  ? secondary_startup_64+0xa5/0xb0
[  151.438335] Sending NMI from CPU 5 to CPUs 0:
[  151.439016] NMI backtrace for cpu 0
[  151.439016] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439016] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439016] RIP: 0010:native_queued_spin_lock_slowpath+0x19a/0x1c0
[  151.439016] RSP: 0018:ffff9b36e7c03f00 EFLAGS: 00000046
[  151.439016] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7c22480
[  151.439016] RDX: 0000000000000001 RSI: ffffffffbee70e1c RDI: 0000000000040000
[  151.439016] RBP: 0000000000000000 R08: 0000000000000000 R09: 00000000000002c4
[  151.439016] R10: ffff9b36e78b5aa0 R11: ffffffffbf5dbf2d R12: ffff9b36e7c22480
[  151.439016] R13: ffff9b36e7c22500 R14: ffffffffbf051640 R15: ffff9b36e7c22500
[  151.439016] FS:  0000000000000000(0000) GS:ffff9b36e7c00000(0000) knlGS:0000000000000000
[  151.439016] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439016] CR2: ffff9b33d2655000 CR3: 000000011200a000 CR4: 00000000000006f0
[  151.439016] Call Trace:
[  151.439016]  <IRQ>
[  151.439016]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439016]  rcu_check_callbacks.cold.54+0xf9/0x482
[  151.439016]  ? lapic_next_event+0x1c/0x20
[  151.439016]  ? clockevents_program_event+0x94/0xf0
[  151.439016]  ? update_process_times+0x28/0x60
[  151.439016]  ? tick_periodic+0x27/0x80
[  151.439016]  ? tick_handle_periodic+0x1f/0x60
[  151.439016]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439016]  ? apic_timer_interrupt+0xf/0x20
[  151.439016]  </IRQ>
[  151.439016]  ? native_safe_halt+0x2/0x10
[  151.439016]  ? default_idle+0x18/0x100
[  151.439016]  ? do_idle+0x179/0x1b0
[  151.439016]  ? cpu_startup_entry+0x6f/0x80
[  151.439016]  ? start_kernel+0x4ba/0x4da
[  151.439016]  ? secondary_startup_64+0xa5/0xb0
[  151.439016] Code: 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 8b 41 08 <85> c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 c0 0f 0d 
[  151.438335] Sending NMI from CPU 5 to CPUs 1:
[  151.438482] NMI backtrace for cpu 1
[  151.438482] CPU: 1 PID: 9 Comm: rcu_preempt Tainted: G             L   4.16.13-1-ARCH #1
[  151.438482] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438482] RIP: 0010:native_queued_spin_lock_slowpath+0x105/0x1c0
[  151.438482] RSP: 0018:ffff9d6a43173e28 EFLAGS: 00000002
[  151.438482] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7c62480
[  151.438482] RDX: 0000000000200001 RSI: ffffffffbee70e1c RDI: 0000000000080000
[  151.438482] RBP: 0000000000000000 R08: 0000000000000000 R09: ffff9b3ae58c4178
[  151.438482] R10: 0000000000000002 R11: 0000000000000001 R12: ffff9b36e7c62480
[  151.438482] R13: 0000000000000000 R14: 0000000000000001 R15: 0000000000000000
[  151.438482] FS:  0000000000000000(0000) GS:ffff9b36e7c40000(0000) knlGS:0000000000000000
[  151.438482] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.438482] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.438482] Call Trace:
[  151.438482]  _raw_spin_lock_irqsave+0x44/0x50
[  151.438482]  force_qs_rnp+0x94/0x190
[  151.438482]  ? rcu_oom_callback+0x30/0x30
[  151.438482]  rcu_gp_kthread+0x527/0x8f0
[  151.438482]  ? synchronize_rcu_expedited+0x30/0x30
[  151.438482]  kthread+0x112/0x130
[  151.438482]  ? kthread_create_on_node+0x60/0x60
[  151.438482]  ret_from_fork+0x22/0x40
[  151.438482] Code: 41 5c c3 f3 90 8b 33 81 fe 00 01 00 00 74 f4 e9 4b ff ff ff 89 f8 c1 e8 10 66 87 43 02 89 c2 c1 e2 10 75 6f 45 31 c0 eb 02 f3 90 <8b> 13 66 85 d2 75 f7 be 01 00 00 00 eb 0c 89 d0 f0 0f b1 33 39 
[  151.438335] Sending NMI from CPU 5 to CPUs 3:
[  151.439998] NMI backtrace for cpu 3
[  151.439998] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439998] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439998] RIP: 0010:native_queued_spin_lock_slowpath+0x197/0x1c0
[  151.439998] RSP: 0018:ffff9b36e7cc3e30 EFLAGS: 00000046
[  151.439998] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7ce2480
[  151.439998] RDX: 0000000000000002 RSI: ffffffffbee70e1c RDI: 0000000000100000
[  151.439998] RBP: 0000000000000000 R08: 0000000000000000 R09: 00000000000002de
[  151.439998] R10: ffff9b36e78b5be0 R11: ffffffffbf5dbf2d R12: ffff9b36e7ce2480
[  151.439998] R13: ffff9b36e7ce2500 R14: ffffffffbf051640 R15: ffff9b36e7ce2500
[  151.439998] FS:  0000000000000000(0000) GS:ffff9b36e7cc0000(0000) knlGS:0000000000000000
[  151.439998] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439998] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.439998] Call Trace:
[  151.439998]  <IRQ>
[  151.439998]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439998]  rcu_check_callbacks.cold.54+0xf9/0x482
[  151.439998]  ? tick_sched_handle.isra.5+0x60/0x60
[  151.439998]  ? update_process_times+0x28/0x60
[  151.439998]  ? tick_sched_handle.isra.5+0x20/0x60
[  151.439998]  ? tick_sched_timer+0x38/0x80
[  151.439998]  ? __hrtimer_run_queues+0x100/0x2d0
[  151.439998]  ? hrtimer_interrupt+0x10a/0x220
[  151.439998]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439998]  ? apic_timer_interrupt+0xf/0x20
[  151.439998]  </IRQ>
[  151.439998]  ? native_safe_halt+0x2/0x10
[  151.439998]  ? default_idle+0x18/0x100
[  151.439998]  ? do_idle+0x179/0x1b0
[  151.439998]  ? cpu_startup_entry+0x6f/0x80
[  151.439998]  ? start_secondary+0x1aa/0x200
[  151.439998]  ? secondary_startup_64+0xa5/0xb0
[  151.439998] Code: c3 c1 ea 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 <8b> 41 08 85 c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 
[  151.438335] Sending NMI from CPU 5 to CPUs 4:
[  151.439046] NMI backtrace for cpu 4
[  151.439046] CPU: 4 PID: 0 Comm: swapper/4 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439046] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439046] RIP: 0010:native_queued_spin_lock_slowpath+0x197/0x1c0
[  151.439046] RSP: 0018:ffff9b3af7c03f00 EFLAGS: 00000046
[  151.439046] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b3af7c22480
[  151.439046] RDX: 0000000000000000 RSI: ffffffffbee70e1c RDI: 0000000000140000
[  151.439046] RBP: 0000000000000000 R08: 0000000000000000 R09: 00000000000002c5
[  151.439046] R10: ffff9b36e78b5b40 R11: ffffffffbf5dbf2d R12: ffff9b3af7c22480
[  151.439046] R13: ffff9b3af7c22500 R14: ffffffffbf051640 R15: ffff9b3af7c22500
[  151.439046] FS:  0000000000000000(0000) GS:ffff9b3af7c00000(0000) knlGS:0000000000000000
[  151.439046] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439046] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.439046] Call Trace:
[  151.439046]  <IRQ>
[  151.439046]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439046]  rcu_check_callbacks.cold.54+0xf9/0x482
[  151.439046]  ? lapic_next_event+0x1c/0x20
[  151.439046]  ? clockevents_program_event+0x94/0xf0
[  151.439046]  ? update_process_times+0x28/0x60
[  151.439046]  ? tick_periodic+0x27/0x80
[  151.439046]  ? tick_handle_periodic+0x1f/0x60
[  151.439046]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439046]  ? apic_timer_interrupt+0xf/0x20
[  151.439046]  </IRQ>
[  151.439046]  ? native_safe_halt+0x2/0x10
[  151.439046]  ? default_idle+0x18/0x100
[  151.439046]  ? do_idle+0x179/0x1b0
[  151.439046]  ? cpu_startup_entry+0x6f/0x80
[  151.439046]  ? start_secondary+0x1aa/0x200
[  151.439046]  ? secondary_startup_64+0xa5/0xb0
[  151.439046] Code: c3 c1 ea 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 <8b> 41 08 85 c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 
[  151.438335] NMI backtrace for cpu 5
[  151.438335] CPU: 5 PID: 0 Comm: swapper/5 Tainted: G             L   4.16.13-1-ARCH #1
[  151.438335] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438335] Call Trace:
[  151.438335]  <IRQ>
[  151.438335]  dump_stack+0x5c/0x85
[  151.438335]  nmi_cpu_backtrace.cold.0+0x13/0x5b
[  151.438335]  ? lapic_can_unplug_cpu.cold.4+0x3d/0x3d
[  151.438335]  ? nmi_trigger_cpumask_backtrace+0x111/0x11d
[  151.438335]  ? rcu_dump_cpu_stacks+0x9b/0xcb
[  151.438335]  ? rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.438335]  ? lapic_next_event+0x1c/0x20
[  151.438335]  ? clockevents_program_event+0x94/0xf0
[  151.438335]  ? update_process_times+0x28/0x60
[  151.438335]  ? tick_periodic+0x27/0x80
[  151.438335]  ? tick_handle_periodic+0x1f/0x60
[  151.438335]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.438335]  ? apic_timer_interrupt+0xf/0x20
[  151.438335]  </IRQ>
[  151.438335]  ? native_safe_halt+0x2/0x10
[  151.438335]  ? default_idle+0x18/0x100
[  151.438335]  ? do_idle+0x179/0x1b0
[  151.438335]  ? cpu_startup_entry+0x6f/0x80
[  151.438335]  ? start_secondary+0x1aa/0x200
[  151.438335]  ? secondary_startup_64+0xa5/0xb0
[  151.438335] Sending NMI from CPU 5 to CPUs 6:
[  151.443536] NMI backtrace for cpu 6 skipped: idling at native_safe_halt+0x2/0x10
[  151.438335] Sending NMI from CPU 5 to CPUs 7:
[  151.438337] NMI backtrace for cpu 7
[  151.438337] CPU: 7 PID: 0 Comm: swapper/7 Tainted: G             L   4.16.13-1-ARCH #1
[  151.438337] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438337] RIP: 0010:native_queued_spin_lock_slowpath+0x19a/0x1c0
[  151.438337] RSP: 0018:ffff9b3af7cc3f00 EFLAGS: 00000046
[  151.438337] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b3af7ce2480
[  151.438337] RDX: 0000000000000003 RSI: ffffffffbee70e1c RDI: 0000000000200000
[  151.438337] RBP: 0000000000000000 R08: 0000000000000140 R09: 000000000000035e
[  151.438337] R10: 0000000000000000 R11: 0000000000000001 R12: ffff9b3af7ce2480
[  151.438337] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b3af7ce2500
[  151.438337] FS:  0000000000000000(0000) GS:ffff9b3af7cc0000(0000) knlGS:0000000000000000
[  151.438337] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.438337] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.438337] Call Trace:
[  151.438337]  <IRQ>
[  151.438337]  _raw_spin_lock_irqsave+0x44/0x50
[  151.438337]  rcu_check_callbacks.cold.54+0x2d1/0x482
[  151.438337]  ? lapic_next_event+0x1c/0x20
[  151.438337]  ? clockevents_program_event+0x94/0xf0
[  151.438337]  ? update_process_times+0x28/0x60
[  151.438337]  ? tick_periodic+0x27/0x80
[  151.438337]  ? tick_handle_periodic+0x1f/0x60
[  151.438337]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.438337]  ? apic_timer_interrupt+0xf/0x20
[  151.438337]  </IRQ>
[  151.438337]  ? native_safe_halt+0x2/0x10
[  151.438337]  ? default_idle+0x18/0x100
[  151.438337]  ? do_idle+0x179/0x1b0
[  151.438337]  ? cpu_startup_entry+0x6f/0x80
[  151.438337]  ? start_secondary+0x1aa/0x200
[  151.438337]  ? secondary_startup_64+0xa5/0xb0
[  151.438337] Code: 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 8b 41 08 <85> c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 c0 0f 0d 
[  151.439016] 	0-...!: (1 GPs behind) idle=47a/0/1 softirq=27/29 fqs=1 last_accelerate: 0000/51ea, nonlazy_posted: 8, ..
[  151.438482] INFO: rcu_preempt self-detected stall on CPU
[  151.439016] 	
[  151.439046] 	4-...!: (1 GPs behind) idle=292/0/1 softirq=25/26 fqs=1 last_accelerate: 0000/51ea, nonlazy_posted: 0, .D
[  151.439016]  (t=45044 jiffies g=-294 c=-295 q=0)
[  151.439046] 	
[  151.439997] INFO: rcu_preempt detected stalls on CPUs/tasks:
[  151.439998] 	3-...!: (1 ticks this GP) idle=bb6/0/1 softirq=33/33 fqs=1 last_accelerate: 51e6/51ea, nonlazy_posted: 0, L.
[  151.439046]  (t=45044 jiffies g=-294 c=-295 q=0)
[  151.439998] 	
[  151.439016] NMI backtrace for cpu 0
[  151.439998]  (t=45044 jiffies g=-294 c=-295 q=0)
[  151.439016] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439016] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439016] Call Trace:
[  151.439016]  <IRQ>
[  151.439016]  dump_stack+0x5c/0x85
[  151.439016]  nmi_cpu_backtrace.cold.0+0x13/0x5b
[  151.439016]  ? lapic_can_unplug_cpu.cold.4+0x3d/0x3d
[  151.439016]  ? nmi_trigger_cpumask_backtrace+0x111/0x11d
[  151.439016]  ? rcu_dump_cpu_stacks+0x9b/0xcb
[  151.439016]  ? rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.439016]  ? lapic_next_event+0x1c/0x20
[  151.439016]  ? clockevents_program_event+0x94/0xf0
[  151.439016]  ? update_process_times+0x28/0x60
[  151.439016]  ? tick_periodic+0x27/0x80
[  151.439016]  ? tick_handle_periodic+0x1f/0x60
[  151.439016]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439016]  ? apic_timer_interrupt+0xf/0x20
[  151.439016]  </IRQ>
[  151.439016]  ? native_safe_halt+0x2/0x10
[  151.439016]  ? default_idle+0x18/0x100
[  151.439016]  ? do_idle+0x179/0x1b0
[  151.439016]  ? cpu_startup_entry+0x6f/0x80
[  151.439016]  ? start_kernel+0x4ba/0x4da
[  151.439016]  ? secondary_startup_64+0xa5/0xb0
[  151.439016] Sending NMI from CPU 0 to CPUs 1:
[  151.438482] NMI backtrace for cpu 1
[  151.438482] CPU: 1 PID: 9 Comm: rcu_preempt Tainted: G             L   4.16.13-1-ARCH #1
[  151.438482] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438482] RIP: 0010:native_queued_spin_lock_slowpath+0x197/0x1c0
[  151.438482] RSP: 0018:ffff9b36e7c43f00 EFLAGS: 00000046
[  151.438482] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7c62480
[  151.438482] RDX: 0000000000000004 RSI: ffffffffbee70e1c RDI: 0000000000080000
[  151.438482] RBP: 0000000000000000 R08: 0000000000000000 R09: 0720072007200720
[  151.438482] R10: ffff9b36e78b5f00 R11: 0720072007200720 R12: ffff9b36e7c62480
[  151.438482] R13: ffff9b36e7c62500 R14: ffffffffbf051640 R15: ffff9b36e7c62500
[  151.438482] FS:  0000000000000000(0000) GS:ffff9b36e7c40000(0000) knlGS:0000000000000000
[  151.438482] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.438482] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.438482] Call Trace:
[  151.438482]  <IRQ>
[  151.438482]  _raw_spin_lock_irqsave+0x44/0x50
[  151.438482]  rcu_check_callbacks.cold.54+0xf9/0x482
[  151.438482]  ? lapic_next_event+0x1c/0x20
[  151.438482]  ? clockevents_program_event+0x94/0xf0
[  151.438482]  ? update_process_times+0x28/0x60
[  151.438482]  ? tick_periodic+0x27/0x80
[  151.438482]  ? tick_handle_periodic+0x1f/0x60
[  151.438482]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.438482]  ? apic_timer_interrupt+0xf/0x20
[  151.438482]  </IRQ>
[  151.438482]  ? _raw_spin_unlock_irqrestore+0x11/0x40
[  151.438482]  ? force_qs_rnp+0x158/0x190
[  151.438482]  ? rcu_oom_callback+0x30/0x30
[  151.438482]  ? rcu_gp_kthread+0x527/0x8f0
[  151.438482]  ? synchronize_rcu_expedited+0x30/0x30
[  151.438482]  ? kthread+0x112/0x130
[  151.438482]  ? kthread_create_on_node+0x60/0x60
[  151.438482]  ? ret_from_fork+0x22/0x40
[  151.438482] Code: c3 c1 ea 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 <8b> 41 08 85 c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 
[  151.439016] Sending NMI from CPU 0 to CPUs 3:
[  151.439998] NMI backtrace for cpu 3
[  151.439998] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439998] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439998] RIP: 0010:native_queued_spin_lock_slowpath+0x107/0x1c0
[  151.439998] RSP: 0018:ffff9b36e7cc3e00 EFLAGS: 00000002
[  151.439998] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7ce2480
[  151.439998] RDX: 0000000000080101 RSI: ffffffffbee70e1c RDI: 0000000000100000
[  151.439998] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000024
[  151.439998] R10: 0000000000000421 R11: 000000000000d2c8 R12: ffff9b36e7ce2480
[  151.439998] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b36e7ce2500
[  151.439998] FS:  0000000000000000(0000) GS:ffff9b36e7cc0000(0000) knlGS:0000000000000000
[  151.439998] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439998] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.439998] Call Trace:
[  151.439998]  <IRQ>
[  151.439998]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439998]  rcu_dump_cpu_stacks+0x48/0xcb
[  151.439998]  rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.439998]  ? tick_sched_handle.isra.5+0x60/0x60
[  151.439998]  ? update_process_times+0x28/0x60
[  151.439998]  ? tick_sched_handle.isra.5+0x20/0x60
[  151.439998]  ? tick_sched_timer+0x38/0x80
[  151.439998]  ? __hrtimer_run_queues+0x100/0x2d0
[  151.439998]  ? hrtimer_interrupt+0x10a/0x220
[  151.439998]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439998]  ? apic_timer_interrupt+0xf/0x20
[  151.439998]  </IRQ>
[  151.439998]  ? native_safe_halt+0x2/0x10
[  151.439998]  ? default_idle+0x18/0x100
[  151.439998]  ? do_idle+0x179/0x1b0
[  151.439998]  ? cpu_startup_entry+0x6f/0x80
[  151.439998]  ? start_secondary+0x1aa/0x200
[  151.439998]  ? secondary_startup_64+0xa5/0xb0
[  151.439998] Code: c3 f3 90 8b 33 81 fe 00 01 00 00 74 f4 e9 4b ff ff ff 89 f8 c1 e8 10 66 87 43 02 89 c2 c1 e2 10 75 6f 45 31 c0 eb 02 f3 90 8b 13 <66> 85 d2 75 f7 be 01 00 00 00 eb 0c 89 d0 f0 0f b1 33 39 c2 74 
[  151.439016] Sending NMI from CPU 0 to CPUs 4:
[  151.439046] NMI backtrace for cpu 4
[  151.439046] CPU: 4 PID: 0 Comm: swapper/4 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439046] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439046] RIP: 0010:native_queued_spin_lock_slowpath+0x19a/0x1c0
[  151.439046] RSP: 0018:ffff9b3af7c03ed0 EFLAGS: 00000046
[  151.439046] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b3af7c22480
[  151.439046] RDX: 0000000000000003 RSI: ffffffffbee70e1c RDI: 0000000000140000
[  151.439046] RBP: 0000000000000000 R08: 0000000000000000 R09: 0720072007200720
[  151.439046] R10: ffff9b36e78b5f00 R11: 0720072007200720 R12: ffff9b3af7c22480
[  151.439046] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b3af7c22500
[  151.439046] FS:  0000000000000000(0000) GS:ffff9b3af7c00000(0000) knlGS:0000000000000000
[  151.439046] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439046] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.439046] Call Trace:
[  151.439046]  <IRQ>
[  151.439046]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439046]  rcu_dump_cpu_stacks+0x48/0xcb
[  151.439046]  rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.439046]  ? lapic_next_event+0x1c/0x20
[  151.439046]  ? clockevents_program_event+0x94/0xf0
[  151.439046]  ? update_process_times+0x28/0x60
[  151.439046]  ? tick_periodic+0x27/0x80
[  151.439046]  ? tick_handle_periodic+0x1f/0x60
[  151.439046]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439046]  ? apic_timer_interrupt+0xf/0x20
[  151.439046]  </IRQ>
[  151.439046]  ? native_safe_halt+0x2/0x10
[  151.439046]  ? default_idle+0x18/0x100
[  151.439046]  ? do_idle+0x179/0x1b0
[  151.439046]  ? cpu_startup_entry+0x6f/0x80
[  151.439046]  ? start_secondary+0x1aa/0x200
[  151.439046]  ? secondary_startup_64+0xa5/0xb0
[  151.439046] Code: 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 8b 41 08 <85> c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 c0 0f 0d 
[  151.439016] Sending NMI from CPU 0 to CPUs 5:
[  151.450437] NMI backtrace for cpu 5 skipped: idling at native_safe_halt+0x2/0x10
[  151.439016] Sending NMI from CPU 0 to CPUs 7:
[  151.450680] NMI backtrace for cpu 7 skipped: idling at native_safe_halt+0x2/0x10
[  151.439997] 	0-...!: (1 GPs behind) idle=47a/0/1 softirq=27/29 fqs=1 last_accelerate: 0000/51ec, nonlazy_posted: 8, ..
[  151.439997] 	1-...!: (1 ticks this GP) idle=a6a/1/4611686018427387906 softirq=42/42 fqs=1 last_accelerate: 0000/51ec, nonlazy_posted: 31, ..
[  151.439997] 	3-...!: (1 ticks this GP) idle=bb6/0/1 softirq=33/33 fqs=1 last_accelerate: 51e6/51ec, nonlazy_posted: 0, L.
[  151.439997] 	4-...!: (1 GPs behind) idle=292/0/1 softirq=25/26 fqs=1 last_accelerate: 0000/51ec, nonlazy_posted: 0, .D
[  151.439997] 	5-...!: (1 GPs behind) idle=4f8/0/0 softirq=31/118 fqs=1 last_accelerate: 51ec/51ec, nonlazy_posted: 0, L.
[  151.439997] 	7-...!: (1 GPs behind) idle=be8/0/0 softirq=12/15 fqs=1 last_accelerate: 51ec/51ec, nonlazy_posted: 0, L.
[  151.439997] 	
[  151.439998] Sending NMI from CPU 3 to CPUs 0:
[  151.439997] (detected by 2, t=45046 jiffies, g=-294, c=-295, q=0)
[  151.439016] NMI backtrace for cpu 0
[  151.439016] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439016] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439016] RIP: 0010:native_queued_spin_lock_slowpath+0x197/0x1c0
[  151.439016] RSP: 0018:ffff9b36e7c03f00 EFLAGS: 00000046
[  151.439016] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7c22480
[  151.439016] RDX: 0000000000000001 RSI: ffffffffbee70e1c RDI: 0000000000040000
[  151.439016] RBP: 0000000000000000 R08: 0000000000000140 R09: 00000000000004a5
[  151.439016] R10: 0000000000000000 R11: 0000000000000001 R12: ffff9b36e7c22480
[  151.439016] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b36e7c22500
[  151.439016] FS:  0000000000000000(0000) GS:ffff9b36e7c00000(0000) knlGS:0000000000000000
[  151.439016] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439016] CR2: ffff9b33d2655000 CR3: 000000011200a000 CR4: 00000000000006f0
[  151.439016] Call Trace:
[  151.439016]  <IRQ>
[  151.439016]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439016]  rcu_check_callbacks.cold.54+0x2d1/0x482
[  151.439016]  ? lapic_next_event+0x1c/0x20
[  151.439016]  ? clockevents_program_event+0x94/0xf0
[  151.439016]  ? update_process_times+0x28/0x60
[  151.439016]  ? tick_periodic+0x27/0x80
[  151.439016]  ? tick_handle_periodic+0x1f/0x60
[  151.439016]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439016]  ? apic_timer_interrupt+0xf/0x20
[  151.439016]  </IRQ>
[  151.439016]  ? native_safe_halt+0x2/0x10
[  151.439016]  ? default_idle+0x18/0x100
[  151.439016]  ? do_idle+0x179/0x1b0
[  151.439016]  ? cpu_startup_entry+0x6f/0x80
[  151.439016]  ? start_kernel+0x4ba/0x4da
[  151.439016]  ? secondary_startup_64+0xa5/0xb0
[  151.439016] Code: c3 c1 ea 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 <8b> 41 08 85 c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 
[  151.439998] Sending NMI from CPU 3 to CPUs 1:
[  151.438482] NMI backtrace for cpu 1
[  151.438482] CPU: 1 PID: 9 Comm: rcu_preempt Tainted: G             L   4.16.13-1-ARCH #1
[  151.438482] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438482] RIP: 0010:native_queued_spin_lock_slowpath+0x19a/0x1c0
[  151.438482] RSP: 0018:ffff9b36e7c43f00 EFLAGS: 00000046
[  151.438482] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7c62480
[  151.438482] RDX: 0000000000000004 RSI: ffffffffbee70e1c RDI: 0000000000080000
[  151.438482] RBP: 0000000000000000 R08: 0000000000000000 R09: 0720072007200720
[  151.438482] R10: ffff9b36e78b5f00 R11: 0720072007200720 R12: ffff9b36e7c62480
[  151.438482] R13: ffff9b36e7c62500 R14: ffffffffbf051640 R15: ffff9b36e7c62500
[  151.438482] FS:  0000000000000000(0000) GS:ffff9b36e7c40000(0000) knlGS:0000000000000000
[  151.438482] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.438482] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.438482] Call Trace:
[  151.438482]  <IRQ>
[  151.438482]  _raw_spin_lock_irqsave+0x44/0x50
[  151.438482]  rcu_check_callbacks.cold.54+0xf9/0x482
[  151.438482]  ? lapic_next_event+0x1c/0x20
[  151.438482]  ? clockevents_program_event+0x94/0xf0
[  151.438482]  ? update_process_times+0x28/0x60
[  151.438482]  ? tick_periodic+0x27/0x80
[  151.438482]  ? tick_handle_periodic+0x1f/0x60
[  151.438482]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.438482]  ? apic_timer_interrupt+0xf/0x20
[  151.438482]  </IRQ>
[  151.438482]  ? _raw_spin_unlock_irqrestore+0x11/0x40
[  151.438482]  ? force_qs_rnp+0x158/0x190
[  151.438482]  ? rcu_oom_callback+0x30/0x30
[  151.438482]  ? rcu_gp_kthread+0x527/0x8f0
[  151.438482]  ? synchronize_rcu_expedited+0x30/0x30
[  151.438482]  ? kthread+0x112/0x130
[  151.438482]  ? kthread_create_on_node+0x60/0x60
[  151.438482]  ? ret_from_fork+0x22/0x40
[  151.438482] Code: 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 8b 41 08 <85> c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 c0 0f 0d 
[  151.439998] NMI backtrace for cpu 3
[  151.439998] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439998] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439998] Call Trace:
[  151.439998]  <IRQ>
[  151.439998]  dump_stack+0x5c/0x85
[  151.439998]  nmi_cpu_backtrace.cold.0+0x13/0x5b
[  151.439998]  ? lapic_can_unplug_cpu.cold.4+0x3d/0x3d
[  151.439998]  ? nmi_trigger_cpumask_backtrace+0x111/0x11d
[  151.439998]  ? rcu_dump_cpu_stacks+0x9b/0xcb
[  151.439998]  ? rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.439998]  ? tick_sched_handle.isra.5+0x60/0x60
[  151.439998]  ? update_process_times+0x28/0x60
[  151.439998]  ? tick_sched_handle.isra.5+0x20/0x60
[  151.439998]  ? tick_sched_timer+0x38/0x80
[  151.439998]  ? __hrtimer_run_queues+0x100/0x2d0
[  151.439998]  ? hrtimer_interrupt+0x10a/0x220
[  151.439998]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439998]  ? apic_timer_interrupt+0xf/0x20
[  151.439998]  </IRQ>
[  151.439998]  ? native_safe_halt+0x2/0x10
[  151.439998]  ? default_idle+0x18/0x100
[  151.439998]  ? do_idle+0x179/0x1b0
[  151.439998]  ? cpu_startup_entry+0x6f/0x80
[  151.439998]  ? start_secondary+0x1aa/0x200
[  151.439998]  ? secondary_startup_64+0xa5/0xb0
[  151.439998] Sending NMI from CPU 3 to CPUs 4:
[  151.439046] NMI backtrace for cpu 4
[  151.439046] CPU: 4 PID: 0 Comm: swapper/4 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439046] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439046] RIP: 0010:native_queued_spin_lock_slowpath+0x105/0x1c0
[  151.439046] RSP: 0018:ffff9b3af7c03ed0 EFLAGS: 00000002
[  151.439046] RAX: ffff9b36e7c62480 RBX: ffffffffbf051640 RCX: ffff9b3af7c22480
[  151.439046] RDX: 00000000000c0001 RSI: ffffffffbee70e1c RDI: 0000000000140000
[  151.439046] RBP: 0000000000000000 R08: ffff9b36e7c62480 R09: 0720072007200720
[  151.439046] R10: ffff9b36e78b5f00 R11: 0720072007200720 R12: ffff9b3af7c22480
[  151.439046] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b3af7c22500
[  151.439046] FS:  0000000000000000(0000) GS:ffff9b3af7c00000(0000) knlGS:0000000000000000
[  151.439046] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439046] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.439046] Call Trace:
[  151.439046]  <IRQ>
[  151.439046]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439046]  rcu_dump_cpu_stacks+0x48/0xcb
[  151.439046]  rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.439046]  ? lapic_next_event+0x1c/0x20
[  151.439046]  ? clockevents_program_event+0x94/0xf0
[  151.439046]  ? update_process_times+0x28/0x60
[  151.439046]  ? tick_periodic+0x27/0x80
[  151.439046]  ? tick_handle_periodic+0x1f/0x60
[  151.439046]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439046]  ? apic_timer_interrupt+0xf/0x20
[  151.439046]  </IRQ>
[  151.439046]  ? native_safe_halt+0x2/0x10
[  151.439046]  ? default_idle+0x18/0x100
[  151.439046]  ? do_idle+0x179/0x1b0
[  151.439046]  ? cpu_startup_entry+0x6f/0x80
[  151.439046]  ? start_secondary+0x1aa/0x200
[  151.439046]  ? secondary_startup_64+0xa5/0xb0
[  151.439046] Code: 41 5c c3 f3 90 8b 33 81 fe 00 01 00 00 74 f4 e9 4b ff ff ff 89 f8 c1 e8 10 66 87 43 02 89 c2 c1 e2 10 75 6f 45 31 c0 eb 02 f3 90 <8b> 13 66 85 d2 75 f7 be 01 00 00 00 eb 0c 89 d0 f0 0f b1 33 39 
[  151.439998] Sending NMI from CPU 3 to CPUs 5:
[  151.453774] NMI backtrace for cpu 5 skipped: idling at native_safe_halt+0x2/0x10
[  151.439998] Sending NMI from CPU 3 to CPUs 7:
[  151.454778] NMI backtrace for cpu 7 skipped: idling at native_safe_halt+0x2/0x10
[  151.439046] Sending NMI from CPU 4 to CPUs 0:
[  151.439016] NMI backtrace for cpu 0
[  151.439016] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439016] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439016] RIP: 0010:native_queued_spin_lock_slowpath+0x197/0x1c0
[  151.439016] RSP: 0018:ffff9b36e7c03f00 EFLAGS: 00000046
[  151.439016] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7c22480
[  151.439016] RDX: 0000000000000001 RSI: ffffffffbee70e1c RDI: 0000000000040000
[  151.439016] RBP: 0000000000000000 R08: 0000000000000140 R09: 00000000000004a5
[  151.439016] R10: 0000000000000000 R11: 0000000000000001 R12: ffff9b36e7c22480
[  151.439016] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b36e7c22500
[  151.439016] FS:  0000000000000000(0000) GS:ffff9b36e7c00000(0000) knlGS:0000000000000000
[  151.439016] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439016] CR2: ffff9b33d2655000 CR3: 000000011200a000 CR4: 00000000000006f0
[  151.439016] Call Trace:
[  151.439016]  <IRQ>
[  151.439016]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439016]  rcu_check_callbacks.cold.54+0x2d1/0x482
[  151.439016]  ? lapic_next_event+0x1c/0x20
[  151.439016]  ? clockevents_program_event+0x94/0xf0
[  151.439016]  ? update_process_times+0x28/0x60
[  151.439016]  ? tick_periodic+0x27/0x80
[  151.439016]  ? tick_handle_periodic+0x1f/0x60
[  151.439016]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439016]  ? apic_timer_interrupt+0xf/0x20
[  151.439016]  </IRQ>
[  151.439016]  ? native_safe_halt+0x2/0x10
[  151.439016]  ? default_idle+0x18/0x100
[  151.439016]  ? do_idle+0x179/0x1b0
[  151.439016]  ? cpu_startup_entry+0x6f/0x80
[  151.439016]  ? start_kernel+0x4ba/0x4da
[  151.439016]  ? secondary_startup_64+0xa5/0xb0
[  151.439016] Code: c3 c1 ea 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 <8b> 41 08 85 c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 
[  151.439046] Sending NMI from CPU 4 to CPUs 1:
[  151.438482] NMI backtrace for cpu 1
[  151.438482] CPU: 1 PID: 9 Comm: rcu_preempt Tainted: G             L   4.16.13-1-ARCH #1
[  151.438482] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438482] RIP: 0010:native_queued_spin_lock_slowpath+0x107/0x1c0
[  151.438482] RSP: 0018:ffff9b36e7c43f00 EFLAGS: 00000002
[  151.438482] RAX: ffff9b36e7c22480 RBX: ffffffffbf051640 RCX: ffff9b36e7c62480
[  151.438482] RDX: 0000000000100001 RSI: ffffffffbee70e1c RDI: 0000000000080000
[  151.438482] RBP: 0000000000000000 R08: ffff9b36e7c22480 R09: 0720072007200720
[  151.438482] R10: ffff9b36e78b5f00 R11: 0720072007200720 R12: ffff9b36e7c62480
[  151.438482] R13: ffff9b36e7c62500 R14: ffffffffbf051640 R15: ffff9b36e7c62500
[  151.438482] FS:  0000000000000000(0000) GS:ffff9b36e7c40000(0000) knlGS:0000000000000000
[  151.438482] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.438482] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.438482] Call Trace:
[  151.438482]  <IRQ>
[  151.438482]  _raw_spin_lock_irqsave+0x44/0x50
[  151.438482]  rcu_check_callbacks.cold.54+0xf9/0x482
[  151.438482]  ? lapic_next_event+0x1c/0x20
[  151.438482]  ? clockevents_program_event+0x94/0xf0
[  151.438482]  ? update_process_times+0x28/0x60
[  151.438482]  ? tick_periodic+0x27/0x80
[  151.438482]  ? tick_handle_periodic+0x1f/0x60
[  151.438482]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.438482]  ? apic_timer_interrupt+0xf/0x20
[  151.438482]  </IRQ>
[  151.438482]  ? _raw_spin_unlock_irqrestore+0x11/0x40
[  151.438482]  ? force_qs_rnp+0x158/0x190
[  151.438482]  ? rcu_oom_callback+0x30/0x30
[  151.438482]  ? rcu_gp_kthread+0x527/0x8f0
[  151.438482]  ? synchronize_rcu_expedited+0x30/0x30
[  151.438482]  ? kthread+0x112/0x130
[  151.438482]  ? kthread_create_on_node+0x60/0x60
[  151.438482]  ? ret_from_fork+0x22/0x40
[  151.438482] Code: c3 f3 90 8b 33 81 fe 00 01 00 00 74 f4 e9 4b ff ff ff 89 f8 c1 e8 10 66 87 43 02 89 c2 c1 e2 10 75 6f 45 31 c0 eb 02 f3 90 8b 13 <66> 85 d2 75 f7 be 01 00 00 00 eb 0c 89 d0 f0 0f b1 33 39 c2 74 
[  151.439046] Sending NMI from CPU 4 to CPUs 3:
[  151.439998] NMI backtrace for cpu 3
[  151.439998] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439998] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439998] RIP: 0010:native_queued_spin_lock_slowpath+0x197/0x1c0
[  151.439998] RSP: 0018:ffff9b36e7cc3e30 EFLAGS: 00000046
[  151.439998] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7ce2480
[  151.439998] RDX: 0000000000000002 RSI: ffffffffbee70e1c RDI: 0000000000100000
[  151.439998] RBP: 0000000000000000 R08: 0000000000000140 R09: 0000000000000531
[  151.439998] R10: 0000000000000000 R11: 0000000000000001 R12: ffff9b36e7ce2480
[  151.439998] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b36e7ce2500
[  151.439998] FS:  0000000000000000(0000) GS:ffff9b36e7cc0000(0000) knlGS:0000000000000000
[  151.439998] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439998] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.439998] Call Trace:
[  151.439998]  <IRQ>
[  151.439998]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439998]  rcu_check_callbacks.cold.54+0x2d1/0x482
[  151.439998]  ? tick_sched_handle.isra.5+0x60/0x60
[  151.439998]  ? update_process_times+0x28/0x60
[  151.439998]  ? tick_sched_handle.isra.5+0x20/0x60
[  151.439998]  ? tick_sched_timer+0x38/0x80
[  151.439998]  ? __hrtimer_run_queues+0x100/0x2d0
[  151.439998]  ? hrtimer_interrupt+0x10a/0x220
[  151.439998]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439998]  ? apic_timer_interrupt+0xf/0x20
[  151.439998]  </IRQ>
[  151.439998]  ? native_safe_halt+0x2/0x10
[  151.439998]  ? default_idle+0x18/0x100
[  151.439998]  ? do_idle+0x179/0x1b0
[  151.439998]  ? cpu_startup_entry+0x6f/0x80
[  151.439998]  ? start_secondary+0x1aa/0x200
[  151.439998]  ? secondary_startup_64+0xa5/0xb0
[  151.439998] Code: c3 c1 ea 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 <8b> 41 08 85 c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 
[  151.439046] NMI backtrace for cpu 4
[  151.439046] CPU: 4 PID: 0 Comm: swapper/4 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439046] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439046] Call Trace:
[  151.439046]  <IRQ>
[  151.439046]  dump_stack+0x5c/0x85
[  151.439046]  nmi_cpu_backtrace.cold.0+0x13/0x5b
[  151.439046]  ? lapic_can_unplug_cpu.cold.4+0x3d/0x3d
[  151.439046]  ? nmi_trigger_cpumask_backtrace+0x111/0x11d
[  151.439046]  ? rcu_dump_cpu_stacks+0x9b/0xcb
[  151.439046]  ? rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.439046]  ? lapic_next_event+0x1c/0x20
[  151.439046]  ? clockevents_program_event+0x94/0xf0
[  151.439046]  ? update_process_times+0x28/0x60
[  151.439046]  ? tick_periodic+0x27/0x80
[  151.439046]  ? tick_handle_periodic+0x1f/0x60
[  151.439046]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439046]  ? apic_timer_interrupt+0xf/0x20
[  151.439046]  </IRQ>
[  151.439046]  ? native_safe_halt+0x2/0x10
[  151.439046]  ? default_idle+0x18/0x100
[  151.439046]  ? do_idle+0x179/0x1b0
[  151.439046]  ? cpu_startup_entry+0x6f/0x80
[  151.439046]  ? start_secondary+0x1aa/0x200
[  151.439046]  ? secondary_startup_64+0xa5/0xb0
[  151.439046] Sending NMI from CPU 4 to CPUs 5:
[  151.458900] NMI backtrace for cpu 5 skipped: idling at native_safe_halt+0x2/0x10
[  151.439046] Sending NMI from CPU 4 to CPUs 7:
[  151.459903] NMI backtrace for cpu 7 skipped: idling at native_safe_halt+0x2/0x10
[  151.438482] 	1-...!: (1 ticks this GP) idle=a6a/1/4611686018427387906 softirq=42/42 fqs=1 last_accelerate: 0000/51ef, nonlazy_posted: 31, ..
[  151.438482] 	
[  151.439997] Sending NMI from CPU 2 to CPUs 0:
[  151.438482]  (t=45049 jiffies g=-294 c=-295 q=0)
[  151.462705] NMI backtrace for cpu 0
[  151.462706] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G             L   4.16.13-1-ARCH #1
[  151.462707] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.462707] RIP: 0010:vsnprintf+0x63/0x4d0
[  151.462708] RSP: 0018:ffff9b36e7c03e00 EFLAGS: 00000006
[  151.462709] RAX: 000000000000002e RBX: 0000000000000006 RCX: ffff9b36e7c03da7
[  151.462709] RDX: 0000000000000006 RSI: ffff9b36e7c03e10 RDI: 0000000000000000
[  151.462710] RBP: 0000000000000000 R08: 0000000000000002 R09: 00000000000005b8
[  151.462710] R10: 0000000000000000 R11: 0000000000000006 R12: ffff9b36e7c03e58
[  151.462711] R13: ffffffffbee632e9 R14: 0000000000000000 R15: ffffffffbee632e9
[  151.462712] FS:  0000000000000000(0000) GS:ffff9b36e7c00000(0000) knlGS:0000000000000000
[  151.462712] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.462713] CR2: ffff9b33d2655000 CR3: 000000011200a000 CR4: 00000000000006f0
[  151.462713] Call Trace:
[  151.462713]  <IRQ>
[  151.462714]  snprintf+0x49/0x60
[  151.462714]  ? native_safe_apic_wait_icr_idle+0x39/0x50
[  151.462715]  print_prefix+0xef/0x190
[  151.462715]  msg_print_text+0x3a/0x100
[  151.462715]  console_unlock.part.6+0x10c/0x500
[  151.462716]  ? _raw_spin_unlock_irqrestore+0x20/0x40
[  151.462716]  wake_up_klogd_work_func+0x53/0x80
[  151.462717]  irq_work_run_list+0x4d/0x70
[  151.462717]  update_process_times+0x4a/0x60
[  151.462717]  tick_periodic+0x27/0x80
[  151.462718]  tick_handle_periodic+0x1f/0x60
[  151.462718]  smp_apic_timer_interrupt+0x69/0x160
[  151.462718]  apic_timer_interrupt+0xf/0x20
[  151.462719]  </IRQ>
[  151.462719] RIP: 0010:native_safe_halt+0x2/0x10
[  151.462720] RSP: 0018:ffffffffbf003ea0 EFLAGS: 00000202 ORIG_RAX: ffffffffffffff12
[  151.462721] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
[  151.462721] RDX: 0000000000000000 RSI: ffffffffbee70e1c RDI: ffffffffbee7107a
[  151.462722] RBP: ffffffffbf132b60 R08: ffffffffffcdaa28 R09: 0000000000000000
[  151.462722] R10: 0000000000000000 R11: 0000000000000000 R12: ffffffffbeed81f2
[  151.462723] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[  151.462723]  default_idle+0x18/0x100
[  151.462723]  do_idle+0x179/0x1b0
[  151.462724]  cpu_startup_entry+0x6f/0x80
[  151.462724]  start_kernel+0x4ba/0x4da
[  151.462724]  secondary_startup_64+0xa5/0xb0
[  151.462725] Code: 48 8b 04 24 49 89 f6 49 89 d5 49 89 cc 48 89 c5 48 01 f5 0f 82 87 02 00 00 41 0f b6 45 00 48 8b 1c 24 84 c0 74 30 48 8d 74 24 10 <4c> 89 ef e8 d5 d4 ff ff 0f b6 54 24 10 48 63 c8 4d 8d 7c 0d 00 
[  151.462760] Sending NMI from CPU 2 to CPUs 1:
[  151.438482] NMI backtrace for cpu 1
[  151.438482] CPU: 1 PID: 9 Comm: rcu_preempt Tainted: G             L   4.16.13-1-ARCH #1
[  151.438482] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438482] RIP: 0010:native_queued_spin_lock_slowpath+0x19a/0x1c0
[  151.438482] RSP: 0018:ffff9b36e7c43ed0 EFLAGS: 00000046
[  151.438482] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7c62480
[  151.438482] RDX: 0000000000000004 RSI: ffffffffbee70e1c RDI: 0000000000080000
[  151.438482] RBP: 0000000000000000 R08: 0000000000000034 R09: 00000000000005b9
[  151.438482] R10: 0000000000000000 R11: 0000000000000001 R12: ffff9b36e7c62480
[  151.438482] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b36e7c62500
[  151.438482] FS:  0000000000000000(0000) GS:ffff9b36e7c40000(0000) knlGS:0000000000000000
[  151.438482] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.438482] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.438482] Call Trace:
[  151.438482]  <IRQ>
[  151.438482]  _raw_spin_lock_irqsave+0x44/0x50
[  151.438482]  rcu_dump_cpu_stacks+0x48/0xcb
[  151.438482]  rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.438482]  ? lapic_next_event+0x1c/0x20
[  151.438482]  ? clockevents_program_event+0x94/0xf0
[  151.438482]  ? update_process_times+0x28/0x60
[  151.438482]  ? tick_periodic+0x27/0x80
[  151.438482]  ? tick_handle_periodic+0x1f/0x60
[  151.438482]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.438482]  ? apic_timer_interrupt+0xf/0x20
[  151.438482]  </IRQ>
[  151.438482]  ? _raw_spin_unlock_irqrestore+0x11/0x40
[  151.438482]  ? force_qs_rnp+0x158/0x190
[  151.438482]  ? rcu_oom_callback+0x30/0x30
[  151.438482]  ? rcu_gp_kthread+0x527/0x8f0
[  151.438482]  ? synchronize_rcu_expedited+0x30/0x30
[  151.438482]  ? kthread+0x112/0x130
[  151.438482]  ? kthread_create_on_node+0x60/0x60
[  151.438482]  ? ret_from_fork+0x22/0x40
[  151.438482] Code: 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 8b 41 08 <85> c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 c0 0f 0d 
[  151.462760] Sending NMI from CPU 2 to CPUs 3:
[  151.439998] NMI backtrace for cpu 3
[  151.439998] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439998] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439998] RIP: 0010:native_queued_spin_lock_slowpath+0x107/0x1c0
[  151.439998] RSP: 0018:ffff9b36e7cc3e30 EFLAGS: 00000002
[  151.439998] RAX: ffff9b3af7c22480 RBX: ffffffffbf051640 RCX: ffff9b36e7ce2480
[  151.439998] RDX: 0000000000080001 RSI: ffffffffbee70e1c RDI: 0000000000100000
[  151.439998] RBP: 0000000000000000 R08: ffff9b3af7c22480 R09: 0000000000000531
[  151.439998] R10: 0000000000000000 R11: 0000000000000001 R12: ffff9b36e7ce2480
[  151.439998] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b36e7ce2500
[  151.439998] FS:  0000000000000000(0000) GS:ffff9b36e7cc0000(0000) knlGS:0000000000000000
[  151.439998] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439998] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.439998] Call Trace:
[  151.439998]  <IRQ>
[  151.439998]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439998]  rcu_check_callbacks.cold.54+0x2d1/0x482
[  151.439998]  ? tick_sched_handle.isra.5+0x60/0x60
[  151.439998]  ? update_process_times+0x28/0x60
[  151.439998]  ? tick_sched_handle.isra.5+0x20/0x60
[  151.439998]  ? tick_sched_timer+0x38/0x80
[  151.439998]  ? __hrtimer_run_queues+0x100/0x2d0
[  151.439998]  ? hrtimer_interrupt+0x10a/0x220
[  151.439998]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439998]  ? apic_timer_interrupt+0xf/0x20
[  151.439998]  </IRQ>
[  151.439998]  ? native_safe_halt+0x2/0x10
[  151.439998]  ? default_idle+0x18/0x100
[  151.439998]  ? do_idle+0x179/0x1b0
[  151.439998]  ? cpu_startup_entry+0x6f/0x80
[  151.439998]  ? start_secondary+0x1aa/0x200
[  151.439998]  ? secondary_startup_64+0xa5/0xb0
[  151.439998] Code: c3 f3 90 8b 33 81 fe 00 01 00 00 74 f4 e9 4b ff ff ff 89 f8 c1 e8 10 66 87 43 02 89 c2 c1 e2 10 75 6f 45 31 c0 eb 02 f3 90 8b 13 <66> 85 d2 75 f7 be 01 00 00 00 eb 0c 89 d0 f0 0f b1 33 39 c2 74 
[  151.462760] Sending NMI from CPU 2 to CPUs 4:
[  151.439046] NMI backtrace for cpu 4
[  151.439046] CPU: 4 PID: 0 Comm: swapper/4 Tainted: G             L   4.16.13-1-ARCH #1
[  151.439046] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.439046] RIP: 0010:native_queued_spin_lock_slowpath+0x197/0x1c0
[  151.439046] RSP: 0018:ffff9b3af7c03f00 EFLAGS: 00000046
[  151.439046] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b3af7c22480
[  151.439046] RDX: 0000000000000003 RSI: ffffffffbee70e1c RDI: 0000000000140000
[  151.439046] RBP: 0000000000000000 R08: 0000000000000140 R09: 00000000000005b4
[  151.439046] R10: 0000000000000000 R11: 0000000000000001 R12: ffff9b3af7c22480
[  151.439046] R13: 0000000000000000 R14: ffffffffbf051640 R15: ffff9b3af7c22500
[  151.439046] FS:  0000000000000000(0000) GS:ffff9b3af7c00000(0000) knlGS:0000000000000000
[  151.439046] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.439046] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.439046] Call Trace:
[  151.439046]  <IRQ>
[  151.439046]  _raw_spin_lock_irqsave+0x44/0x50
[  151.439046]  rcu_check_callbacks.cold.54+0x2d1/0x482
[  151.439046]  ? lapic_next_event+0x1c/0x20
[  151.439046]  ? clockevents_program_event+0x94/0xf0
[  151.439046]  ? update_process_times+0x28/0x60
[  151.439046]  ? tick_periodic+0x27/0x80
[  151.439046]  ? tick_handle_periodic+0x1f/0x60
[  151.439046]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.439046]  ? apic_timer_interrupt+0xf/0x20
[  151.439046]  </IRQ>
[  151.439046]  ? native_safe_halt+0x2/0x10
[  151.439046]  ? default_idle+0x18/0x100
[  151.439046]  ? do_idle+0x179/0x1b0
[  151.439046]  ? cpu_startup_entry+0x6f/0x80
[  151.439046]  ? start_secondary+0x1aa/0x200
[  151.439046]  ? secondary_startup_64+0xa5/0xb0
[  151.439046] Code: c3 c1 ea 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 <8b> 41 08 85 c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 
[  151.462760] Sending NMI from CPU 2 to CPUs 5:
[  151.463967] NMI backtrace for cpu 5 skipped: idling at native_safe_halt+0x2/0x10
[  151.462760] Sending NMI from CPU 2 to CPUs 7:
[  151.464970] NMI backtrace for cpu 7 skipped: idling at native_safe_halt+0x2/0x10
[  151.438482] Sending NMI from CPU 1 to CPUs 0:
[  151.466073] NMI backtrace for cpu 0 skipped: idling at native_safe_halt+0x2/0x10
[  151.438482] NMI backtrace for cpu 1
[  151.438482] CPU: 1 PID: 9 Comm: rcu_preempt Tainted: G             L   4.16.13-1-ARCH #1
[  151.438482] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.438482] Call Trace:
[  151.438482]  <IRQ>
[  151.438482]  dump_stack+0x5c/0x85
[  151.438482]  nmi_cpu_backtrace.cold.0+0x13/0x5b
[  151.438482]  ? lapic_can_unplug_cpu.cold.4+0x3d/0x3d
[  151.438482]  ? nmi_trigger_cpumask_backtrace+0x111/0x11d
[  151.438482]  ? rcu_dump_cpu_stacks+0x9b/0xcb
[  151.438482]  ? rcu_check_callbacks.cold.54+0x2c9/0x482
[  151.438482]  ? lapic_next_event+0x1c/0x20
[  151.438482]  ? clockevents_program_event+0x94/0xf0
[  151.438482]  ? update_process_times+0x28/0x60
[  151.438482]  ? tick_periodic+0x27/0x80
[  151.438482]  ? tick_handle_periodic+0x1f/0x60
[  151.438482]  ? smp_apic_timer_interrupt+0x69/0x160
[  151.438482]  ? apic_timer_interrupt+0xf/0x20
[  151.438482]  </IRQ>
[  151.438482]  ? _raw_spin_unlock_irqrestore+0x11/0x40
[  151.438482]  ? force_qs_rnp+0x158/0x190
[  151.438482]  ? rcu_oom_callback+0x30/0x30
[  151.438482]  ? rcu_gp_kthread+0x527/0x8f0
[  151.438482]  ? synchronize_rcu_expedited+0x30/0x30
[  151.438482]  ? kthread+0x112/0x130
[  151.438482]  ? kthread_create_on_node+0x60/0x60
[  151.438482]  ? ret_from_fork+0x22/0x40
[  151.438482] Sending NMI from CPU 1 to CPUs 3:
[  151.469721] NMI backtrace for cpu 3
[  151.469722] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G             L   4.16.13-1-ARCH #1
[  151.469723] Hardware name: Supermicro H8DM8-2/H8DM8-2, BIOS 080014  11/06/2009
[  151.469724] RIP: 0010:native_queued_spin_lock_slowpath+0x19a/0x1c0
[  151.469725] RSP: 0018:ffff9b36e7cc3ef8 EFLAGS: 00000046
[  151.469726] RAX: 0000000000000000 RBX: ffffffffbf051640 RCX: ffff9b36e7ce2480
[  151.469726] RDX: 0000000000000002 RSI: ffffffffbee70e1c RDI: 0000000000100000
[  151.469727] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000101
[  151.469728] R10: 0000000000338518 R11: 0000000000000000 R12: ffff9b36e7ce2480
[  151.469728] R13: ffffffffbeed81f2 R14: 0000000000000009 R15: 0000000000000000
[  151.469729] FS:  0000000000000000(0000) GS:ffff9b36e7cc0000(0000) knlGS:0000000000000000
[  151.469730] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  151.469731] CR2: 0000000000000000 CR3: 000000011200a000 CR4: 00000000000006e0
[  151.469731] Call Trace:
[  151.469732]  <IRQ>
[  151.469733]  _raw_spin_lock_irqsave+0x44/0x50
[  151.469735]  rcu_process_callbacks+0xce/0x3b0
[  151.469737]  __do_softirq+0xf1/0x2e0
[  151.469739]  irq_exit+0xc9/0xe0
[  151.469741]  smp_apic_timer_interrupt+0x73/0x160
[  151.469743]  apic_timer_interrupt+0xf/0x20
[  151.469744]  </IRQ>
[  151.469745] RIP: 0010:native_safe_halt+0x2/0x10
[  151.469745] RSP: 0018:ffff9d6a431bbec0 EFLAGS: 00000202 ORIG_RAX: ffffffffffffff12
[  151.469747] RAX: 0000000000000003 RBX: 0000000000000003 RCX: 0000000000000000
[  151.469747] RDX: 0000000000000000 RSI: ffffffffbee70e1c RDI: ffffffffbee7107a
[  151.469748] RBP: ffffffffbf132b60 R08: 0000000000000000 R09: 0000000000000000
[  151.469748] R10: 0000000000000000 R11: 0000000000000000 R12: ffffffffbeed81f2
[  151.469749] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[  151.469752]  default_idle+0x18/0x100
[  151.469753]  do_idle+0x179/0x1b0
[  151.469755]  cpu_startup_entry+0x6f/0x80
[  151.469757]  start_secondary+0x1aa/0x200
[  151.469758]  secondary_startup_64+0xa5/0xb0
[  151.469760] Code: 12 83 e0 03 83 ea 01 48 c1 e0 04 48 63 d2 48 05 80 24 02 00 48 03 04 d5 80 04 ef be 48 89 08 8b 41 08 85 c0 75 09 f3 90 8b 41 08 <85> c0 74 f7 48 8b 01 48 85 c0 0f 84 54 ff ff ff 49 89 c0 0f 0d 
[  151.438482] Sending NMI from CPU 1 to CPUs 4:
[  151.470739] NMI backtrace for cpu 4 skipped: idling at native_safe_halt+0x2/0x10
[  151.438482] Sending NMI from CPU 1 to CPUs 5:
[  151.470007] NMI backtrace for cpu 5 skipped: idling at native_safe_halt+0x2/0x10
[  151.438482] Sending NMI from CPU 1 to CPUs 7:
[  151.471011] NMI backtrace for cpu 7 skipped: idling at native_safe_halt+0x2/0x10
[  151.474216] PCI Interrupt Link [LUB2] enabled at IRQ 22
[  151.490261] pci 0000:00:00.0: Found enabled HT MSI Mapping
[  151.490302] pci 0000:00:00.0: Found enabled HT MSI Mapping
[  151.490342] pci 0000:00:00.0: Found enabled HT MSI Mapping
[  151.490383] pci 0000:00:00.0: Found enabled HT MSI Mapping
[  151.490428] pci 0000:00:00.0: Found enabled HT MSI Mapping
[  151.490477] pci 0000:00:00.0: Found enabled HT MSI Mapping
[  151.490527] pci 0000:00:00.0: Found enabled HT MSI Mapping
[  151.490581] pci 0000:00:00.0: Found enabled HT MSI Mapping
[  151.490636] pci 0000:00:00.0: Found enabled HT MSI Mapping
[  151.490694] pci 0000:00:00.0: Found enabled HT MSI Mapping
[  151.490723] pci 0000:01:05.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[  151.490725] PCI: CLS 64 bytes, default 64
[  151.490783] Unpacking initramfs...
[  151.620261] Freeing initrd memory: 7660K
[  151.620268] PCI-DMA: Disabling AGP.
[  151.620379] PCI-DMA: aperture base @ bc000000 size 65536 KB
[  151.620380] PCI-DMA: using GART IOMMU.
[  151.620383] PCI-DMA: Reserving 64MB of IOMMU area in the AGP aperture
[  151.627161] LVT offset 1 assigned for vector 0x400
[  151.627176] IBS: LVT offset 1 assigned
[  151.627464] perf: AMD IBS detected (0x0000001f)
[  151.627537] Scanning for low memory corruption every 60 seconds
[  151.628338] Initialise system trusted keyrings
[  151.628350] Key type blacklist registered
[  151.628478] workingset: timestamp_bits=41 max_order=23 bucket_order=0
[  151.630174] zbud: loaded
[  151.632109] Key type asymmetric registered
[  151.632111] Asymmetric key parser 'x509' registered
[  151.632185] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[  151.632270] io scheduler noop registered
[  151.632271] io scheduler deadline registered
[  151.632335] io scheduler cfq registered (default)
[  151.632336] io scheduler mq-deadline registered
[  151.632337] io scheduler kyber registered
[  151.632345] io scheduler bfq registered
[  151.633040] vesafb: mode is 1280x1024x32, linelength=5120, pages=0
[  151.633042] vesafb: scrolling: redraw
[  151.633044] vesafb: Truecolor: size=0:8:8:8, shift=0:16:8:0
[  151.633057] vesafb: framebuffer at 0xd0000000, mapped to 0x        (ptrval), using 5120k, total 5120k
[  151.829185] Console: switching to colour frame buffer device 160x64
[  152.025011] fb0: VESA VGA frame buffer device
[  152.025113] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
[  152.025159] ACPI: Power Button [PWRB]
[  152.025214] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1
[  152.025236] ACPI: Power Button [PWRF]
[  152.026136] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[  152.046719] 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[  152.067376] 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[  152.069302] ledtrig-cpu: registered to indicate activity on CPUs
[  152.069619] NET: Registered protocol family 10
[  152.074138] Segment Routing with IPv6
[  152.074168] NET: Registered protocol family 17
[  152.074748] RAS: Correctable Errors collector initialized.
[  152.074860] microcode: CPU0: patch_level=0x01000086
[  152.074875] microcode: CPU1: patch_level=0x01000086
[  152.074892] microcode: CPU2: patch_level=0x01000086
[  152.074904] microcode: CPU3: patch_level=0x01000086
[  152.074914] microcode: CPU4: patch_level=0x01000086
[  152.074921] microcode: CPU5: patch_level=0x01000086
[  152.074931] microcode: CPU6: patch_level=0x01000086
[  152.074942] microcode: CPU7: patch_level=0x01000086
[  152.075000] microcode: Microcode Update Driver: v2.2.
[  152.075013] sched_clock: Marking stable (152074992029, 0)->(152180163010, -105170981)
[  152.075235] registered taskstats version 1
[  152.075251] Loading compiled-in X.509 certificates
[  152.075278] zswap: loaded using pool lzo/zbud
[  152.078484] Key type big_key registered
[  152.078793]   Magic number: 6:339:419
[  152.078974] hctosys: unable to open rtc device (rtc0)
[  152.439573] Freeing unused kernel memory: 1456K
[  152.439575] Write protecting the kernel read-only data: 16384k
[  152.441487] Freeing unused kernel memory: 2016K
[  152.443550] Freeing unused kernel memory: 688K
[  152.535020] i8042: PNP: PS/2 Controller [PNP0303:PS2K] at 0x60,0x64 irq 1
[  152.535021] i8042: PNP: PS/2 appears to have AUX port disabled, if this is incorrect please boot with i8042.nopnp
[  152.535782] serio: i8042 KBD port at 0x60,0x64 irq 1
[  152.542201] ACPI: bus type USB registered
[  152.542233] usbcore: registered new interface driver usbfs
[  152.542242] usbcore: registered new interface driver hub
[  152.542293] usbcore: registered new device driver usb
[  152.543696] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[  152.543791] SCSI subsystem initialized
[  152.544314] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[  152.544319] Warning! ehci_hcd should always be loaded before uhci_hcd and ohci_hcd, not after
[  152.544654] ehci-pci: EHCI PCI platform driver
[  152.545105] ehci-pci 0000:00:02.1: EHCI Host Controller
[  152.545116] ehci-pci 0000:00:02.1: new USB bus registered, assigned bus number 1
[  152.545125] ehci-pci 0000:00:02.1: debug port 1
[  152.545155] ehci-pci 0000:00:02.1: cache line size of 64 is not supported
[  152.545173] ehci-pci 0000:00:02.1: irq 22, io mem 0xc8106000
[  152.553384] libata version 3.00 loaded.
[  152.556689] ehci-pci 0000:00:02.1: USB 2.0 started, EHCI 1.00
[  152.556750] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[  152.556752] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[  152.556753] usb usb1: Product: EHCI Host Controller
[  152.556754] usb usb1: Manufacturer: Linux 4.16.13-1-ARCH ehci_hcd
[  152.556756] usb usb1: SerialNumber: 0000:00:02.1
[  152.556916] hub 1-0:1.0: USB hub found
[  152.556923] hub 1-0:1.0: 10 ports detected
[  152.557178] pata_amd 0000:00:04.0: version 0.4.1
[  152.557451] ohci-pci: OHCI PCI platform driver
[  152.558300] scsi host0: pata_amd
[  152.560088] scsi host1: pata_amd
[  152.560175] ata1: PATA max UDMA/133 cmd 0x1f0 ctl 0x3f6 bmdma 0xffa0 irq 14
[  152.560177] ata2: PATA max UDMA/133 cmd 0x170 ctl 0x376 bmdma 0xffa8 irq 15
[  152.560280] sata_nv 0000:00:05.0: version 3.5
[  152.560579] PCI Interrupt Link [LSA0] enabled at IRQ 21
[  152.560600] sata_nv 0000:00:05.0: Using SWNCQ mode
[  152.561078] scsi host2: sata_nv
[  152.562043] scsi host3: sata_nv
[  152.562098] ata3: SATA max UDMA/133 cmd 0xe480 ctl 0xe400 bmdma 0xdc00 irq 21
[  152.562099] ata4: SATA max UDMA/133 cmd 0xe080 ctl 0xe000 bmdma 0xdc08 irq 21
[  152.562409] PCI Interrupt Link [LSA1] enabled at IRQ 23
[  152.562425] sata_nv 0000:00:05.1: Using SWNCQ mode
[  152.562806] scsi host4: sata_nv
[  152.562912] scsi host5: sata_nv
[  152.562949] ata5: SATA max UDMA/133 cmd 0xd880 ctl 0xd800 bmdma 0xd080 irq 23
[  152.562950] ata6: SATA max UDMA/133 cmd 0xd480 ctl 0xd400 bmdma 0xd088 irq 23
[  152.563097] ohci-pci 0000:00:02.0: OHCI PCI host controller
[  152.563105] ohci-pci 0000:00:02.0: new USB bus registered, assigned bus number 2
[  152.563123] ohci-pci 0000:00:02.0: irq 23, io mem 0xc8100000
[  152.582639] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input2
[  152.618732] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
[  152.618734] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[  152.618736] usb usb2: Product: OHCI PCI host controller
[  152.618737] usb usb2: Manufacturer: Linux 4.16.13-1-ARCH ohci_hcd
[  152.618738] usb usb2: SerialNumber: 0000:00:02.0
[  152.618870] hub 2-0:1.0: USB hub found
[  152.618878] hub 2-0:1.0: 10 ports detected
[  152.619416] PCI Interrupt Link [LSA2] enabled at IRQ 22
[  152.619621] sata_nv 0000:00:05.2: Using SWNCQ mode
[  152.620012] scsi host6: sata_nv
[  152.620130] scsi host7: sata_nv
[  152.620169] ata7: SATA max UDMA/133 cmd 0xd000 ctl 0xcc00 bmdma 0xc480 irq 22
[  152.620170] ata8: SATA max UDMA/133 cmd 0xc880 ctl 0xc800 bmdma 0xc488 irq 22
[  152.636692] tsc: Refined TSC clocksource calibration: 2613.392 MHz
[  152.636713] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x25aba736b26, max_idle_ns: 440795339743 ns
[  152.636739] clocksource: Switched to clocksource tsc
[  152.730134] ata1.01: ATAPI: DVD-ROM UJDA780, 1.50, max UDMA/33
[  152.730141] ata1: nv_mode_filter: 0x739f&0x739f->0x739f, BIOS=0x7000 (0xc00000) ACPI=0x701f (900:60:0x14)
[  152.734843] ata1.01: configured for UDMA/33
[  152.797191] scsi 0:0:1:0: scsi scan: 96 byte inquiry failed.  Consider BLIST_INQUIRY_36 for this device
[  152.797816] scsi 0:0:1:0: CD-ROM            MATSHITA DVD-ROM UJDA780  1.50 PQ: 0 ANSI: 5
[  152.838357] ata2: port disabled--ignoring
[  152.908273] sr 0:0:1:0: [sr0] scsi-1 drive
[  152.908275] cdrom: Uniform CD-ROM driver Revision: 3.20
[  152.908423] sr 0:0:1:0: Attached scsi CD-ROM sr0
[  152.933152] ata7: SATA link down (SStatus 0 SControl 300)
[  153.026694] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[  153.026697] ata5: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[  153.029189] ata3.00: ATA-8: WDC WD1002FBYS-02A6B0, 03.00C06, max UDMA/133
[  153.029192] ata3.00: 1953525168 sectors, multi 16: LBA48 NCQ (depth 31/32)
[  153.029200] ata5.00: HPA detected: current 1953523055, native 1953525168
[  153.029205] ata5.00: ATA-8: Hitachi HDS721010CLA332, JP4OA3EA, max UDMA/133
[  153.029206] ata5.00: 1953523055 sectors, multi 16: LBA48 NCQ (depth 31/32)
[  153.033856] ata3.00: configured for UDMA/133
[  153.033906] ata5.00: configured for UDMA/133
[  153.034066] scsi 2:0:0:0: Direct-Access     ATA      WDC WD1002FBYS-0 0C06 PQ: 0 ANSI: 5
[  153.035781] sd 2:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB)
[  153.035800] sd 2:0:0:0: [sda] Write Protect is off
[  153.035803] sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00
[  153.035825] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[  153.092278]  sda: sda1 < sda5 sda6 sda7 sda8 >
[  153.092773] sd 2:0:0:0: [sda] Attached SCSI disk
[  153.123345] usb 2-2: new low-speed USB device number 2 using ohci-pci
[  153.346477] ata4: SATA link down (SStatus 0 SControl 300)
[  153.346688] scsi 4:0:0:0: Direct-Access     ATA      Hitachi HDS72101 A3EA PQ: 0 ANSI: 5
[  153.346911] sd 4:0:0:0: [sdb] 1953523055 512-byte logical blocks: (1.00 TB/932 GiB)
[  153.346924] sd 4:0:0:0: [sdb] Write Protect is off
[  153.346926] sd 4:0:0:0: [sdb] Mode Sense: 00 3a 00 00
[  153.346968] sd 4:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[  153.354718] usb 2-2: New USB device found, idVendor=413c, idProduct=3200
[  153.354720] usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[  153.354722] usb 2-2: Product: Dell USB Mouse
[  153.354723] usb 2-2: Manufacturer: Dell
[  153.359670] hidraw: raw HID events driver (C) Jiri Kosina
[  153.365874] usbcore: registered new interface driver usbhid
[  153.365875] usbhid: USB HID core driver
[  153.366830] input: Dell Dell USB Mouse as /devices/pci0000:00/0000:00:02.0/usb2/2-2/2-2:1.0/0003:413C:3200.0001/input/input3
[  153.366871] hid-generic 0003:413C:3200.0001: input,hidraw0: USB HID v1.10 Mouse [Dell Dell USB Mouse] on usb-0000:00:02.0-2/input0
[  153.403272]  sdb: sdb1 < sdb5 sdb6 sdb7 sdb8 >
[  153.403790] sd 4:0:0:0: [sdb] Attached SCSI disk
[  153.560743] random: fast init done
[  153.659764] ata6: SATA link down (SStatus 0 SControl 300)
[  153.969801] ata8: SATA link down (SStatus 0 SControl 300)
[  154.188384] md/raid1:md3: active with 2 out of 2 mirrors
[  154.188413] md3: detected capacity change from 0 to 2166358016
[  154.213158] md/raid1:md1: active with 2 out of 2 mirrors
[  154.213182] md1: detected capacity change from 0 to 53653536768
[  154.246626] md/raid1:md0: active with 2 out of 2 mirrors
[  154.246670] md0: detected capacity change from 0 to 523960320
[  154.352500] md/raid1:md2: active with 2 out of 2 mirrors
[  154.416321] md2: detected capacity change from 0 to 943135391744
[  154.644470] random: crng init done
[  155.428417] EXT4-fs (md1): mounted filesystem with ordered data mode. Opts: (null)
[  156.626430] systemd[1]: systemd 238 running in system mode. (+PAM -AUDIT -SELINUX -IMA -APPARMOR +SMACK -SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN +PCRE2 default-hierarchy=hybrid)
[  156.626639] systemd[1]: Detected architecture x86-64.
[  156.636086] systemd[1]: Set hostname to <fenrir>.
[  157.607489] systemd[1]: multi-user.target: Wants dependency dropin /usr/lib/systemd/system/multi-user.target.wants/hylafax.timer target ../shadow.timer has different name
[  157.788333] systemd[1]: Listening on Device-mapper event daemon FIFOs.
[  157.788398] systemd[1]: Reached target Remote File Systems.
[  157.788463] systemd[1]: Listening on LVM2 poll daemon socket.
[  157.788643] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[  157.789868] systemd[1]: Created slice system-dhcpcd.slice.
[  157.790107] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[  158.024231] EXT4-fs (md1): re-mounted. Opts: data=ordered
[  158.025932] sr 0:0:1:0: Attached scsi generic sg0 type 5
[  158.025988] sd 2:0:0:0: Attached scsi generic sg1 type 0
[  158.026038] sd 4:0:0:0: Attached scsi generic sg2 type 0
[  158.092182] vboxdrv: loading out-of-tree module taints kernel.
[  158.097096] vboxdrv: Found 8 processor cores
[  158.116916] vboxdrv: TSC mode is Invariant, tentative frequency 2613392194 Hz
[  158.116918] vboxdrv: Successfully loaded version 5.2.12 (interface 0x00290001)
[  158.162545] VBoxPciLinuxInit
[  158.162554] vboxpci: IOMMU not found (not registered)
[  158.172224] VBoxNetAdp: Successfully started.
[  158.236633] systemd-journald[326]: Received request to flush runtime journal from PID 1
[  158.416846] VBoxNetFlt: Successfully started.
[  160.503267] acpi_cpufreq: overriding BIOS provided _PSD data
[  160.573976] rtc_cmos 00:03: RTC can wake from S4
[  160.574248] rtc_cmos 00:03: rtc core: registered rtc_cmos as rtc0
[  160.574283] rtc_cmos 00:03: alarms up to one year, y3k, 114 bytes nvram
[  160.614352] i2c i2c-0: nForce2 SMBus adapter at 0x2d00
[  160.614379] i2c i2c-1: nForce2 SMBus adapter at 0x2e00
[  160.624439] nv_tco: NV TCO WatchDog Timer Driver v0.01
[  160.624536] nv_tco: Watchdog reboot not detected
[  160.624592] nv_tco: initialized (0x2440). heartbeat=30 sec (nowayout=0)
[  160.738933] k10temp 0000:00:18.3: unreliable CPU thermal sensor; monitoring disabled
[  160.740777] k10temp 0000:00:19.3: unreliable CPU thermal sensor; monitoring disabled
[  160.772781] ipmi message handler version 39.2
[  160.823678] ipmi device interface
[  160.859327] IPMI System Interface driver.
[  160.859381] ipmi_si dmi-ipmi-si.0: ipmi_platform: probing via SMBIOS
[  160.859388] ipmi_si: SMBIOS: mem 0x0 regsize 1 spacing 1 irq 0
[  160.859391] ipmi_si: Adding SMBIOS-specified kcs state machine
[  160.859538] ipmi_si: Trying SMBIOS-specified kcs state machine at mem address 0x0, slave address 0x0, irq 0
[  160.859545] ipmi_si dmi-ipmi-si.0: Could not set up I/O space
[  160.876759] Linux agpgart interface v0.103
[  160.935523] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[  161.013938] input: PC Speaker as /devices/platform/pcspkr/input/input4
[  161.353973] mousedev: PS/2 mouse device common for all mice
[  161.451545] forcedeth: Reverse Engineered nForce ethernet driver. Version 0.64.
[  161.451922] PCI Interrupt Link [LMAC] enabled at IRQ 20
[  161.457223] forcedeth 0000:00:08.0: ifname eth0, PHY OUI 0x5043 @ 2, addr 00:30:48:c8:42:60
[  161.457226] forcedeth 0000:00:08.0: highdma csum vlan pwrctl mgmt gbit lnktim msi desc-v3
[  161.457576] PCI Interrupt Link [LMAD] enabled at IRQ 20
[  161.657695] kvm: Nested Virtualization enabled
[  161.657702] kvm: Nested Paging enabled
[  161.679392] MCE: In-kernel MCE decoding enabled.
[  161.684440] EDAC amd64: Node 0: DRAM ECC enabled.
[  161.684442] EDAC amd64: F10h detected (node 0).
[  161.684466] EDAC MC: DCT0 chip selects:
[  161.684467] EDAC amd64: MC: 0:  1024MB 1:  1024MB
[  161.684468] EDAC amd64: MC: 2:  1024MB 3:  1024MB
[  161.684469] EDAC amd64: MC: 4:  1024MB 5:  1024MB
[  161.684470] EDAC amd64: MC: 6:  1024MB 7:  1024MB
[  161.684471] EDAC MC: DCT1 chip selects:
[  161.684471] EDAC amd64: MC: 0:  1024MB 1:  1024MB
[  161.684472] EDAC amd64: MC: 2:  1024MB 3:  1024MB
[  161.684473] EDAC amd64: MC: 4:  1024MB 5:  1024MB
[  161.684474] EDAC amd64: MC: 6:  1024MB 7:  1024MB
[  161.684474] EDAC amd64: using x4 syndromes.
[  161.684475] EDAC amd64: MCT channel count: 2
[  161.688011] EDAC MC0: Giving out device to module amd64_edac controller F10h: DEV 0000:00:18.3 (INTERRUPT)
[  161.688020] EDAC amd64: Node 1: DRAM ECC enabled.
[  161.688021] EDAC amd64: F10h detected (node 1).
[  161.688039] EDAC MC: DCT0 chip selects:
[  161.688040] EDAC amd64: MC: 0:  1024MB 1:  1024MB
[  161.688041] EDAC amd64: MC: 2:  1024MB 3:  1024MB
[  161.688042] EDAC amd64: MC: 4:  1024MB 5:  1024MB
[  161.688043] EDAC amd64: MC: 6:  1024MB 7:  1024MB
[  161.688043] EDAC MC: DCT1 chip selects:
[  161.688044] EDAC amd64: MC: 0:  1024MB 1:  1024MB
[  161.688045] EDAC amd64: MC: 2:  1024MB 3:  1024MB
[  161.688046] EDAC amd64: MC: 4:  1024MB 5:  1024MB
[  161.688047] EDAC amd64: MC: 6:  1024MB 7:  1024MB
[  161.688047] EDAC amd64: using x4 syndromes.
[  161.688048] EDAC amd64: MCT channel count: 2
[  161.688692] EDAC MC1: Giving out device to module amd64_edac controller F10h: DEV 0000:00:19.3 (INTERRUPT)
[  161.688709] EDAC PCI0: Giving out device to module amd64_edac controller EDAC PCI controller: DEV 0000:00:18.2 (POLLED)
[  161.688709] AMD64 EDAC driver v3.5.0
[  161.964912] [drm] radeon kernel modesetting enabled.
[  161.965039] checking generic (d0000000 500000) vs hw (d0000000 8000000)
[  161.965043] fb: switching to radeondrmfb from VESA VGA
[  161.965076] Console: switching to colour dummy device 80x25
[  161.965623] PCI Interrupt Link [LNKA] enabled at IRQ 19
[  161.965821] [drm] initializing kernel modesetting (RV100 0x1002:0x515E 0x15D9:0x2511 0x02).
[  161.965866] resource sanity check: requesting [mem 0x000c0000-0x000dffff], which spans more than PCI Bus 0000:00 [mem 0x000d0000-0x000dffff window]
[  161.965871] caller pci_map_rom+0x58/0xe0 mapping multiple BARs
[  161.966453] radeon 0000:01:05.0: VRAM: 128M 0x00000000D0000000 - 0x00000000D7FFFFFF (16M used)
[  161.966454] radeon 0000:01:05.0: GTT: 512M 0x00000000B0000000 - 0x00000000CFFFFFFF
[  161.966462] [drm] Detected VRAM RAM=128M, BAR=128M
[  161.966463] [drm] RAM width 16bits DDR
[  161.966631] [TTM] Zone  kernel: Available graphics memory: 16471422 kiB
[  161.966632] [TTM] Zone   dma32: Available graphics memory: 2097152 kiB
[  161.966633] [TTM] Initializing pool allocator
[  161.966639] [TTM] Initializing DMA pool allocator
[  161.966688] [drm] radeon: 16M of VRAM memory ready
[  161.966690] [drm] radeon: 512M of GTT memory ready.
[  161.966700] [drm] GART: num cpu pages 131072, num gpu pages 131072
[  161.987716] [drm] PCI GART of 512M enabled (table at 0x00000000C7900000).
[  161.987733] radeon 0000:01:05.0: WB disabled
[  161.987736] radeon 0000:01:05.0: fence driver on ring 0 use gpu addr 0x00000000b0000000 and cpu addr 0x000000009eb3e610
[  161.987738] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[  161.987739] [drm] Driver supports precise vblank timestamp query.
[  161.987761] [drm] radeon: irq initialized.
[  161.987772] [drm] Loading R100 Microcode
[  162.007219] forcedeth 0000:00:09.0: ifname eth1, PHY OUI 0x5043 @ 3, addr 00:30:48:c8:42:61
[  162.007222] forcedeth 0000:00:09.0: highdma csum vlan pwrctl mgmt gbit lnktim msi desc-v3
[  162.010554] forcedeth 0000:00:09.0 enp0s9: renamed from eth1
[  162.031546] forcedeth 0000:00:08.0 enp0s8: renamed from eth0
[  162.038300] [drm] radeon: ring at 0x00000000B0001000
[  162.038322] [drm] ring test succeeded in 0 usecs
[  162.038433] [drm] ib test succeeded in 0 usecs
[  162.038762] [drm] No TV DAC info found in BIOS
[  162.038795] [drm] Radeon Display Connectors
[  162.038796] [drm] Connector 0:
[  162.038797] [drm]   VGA-1
[  162.038798] [drm]   DDC: 0x60 0x60 0x60 0x60 0x60 0x60 0x60 0x60
[  162.038799] [drm]   Encoders:
[  162.038799] [drm]     CRT1: INTERNAL_DAC1
[  162.038800] [drm] Connector 1:
[  162.038801] [drm]   DVI-I-1
[  162.038801] [drm]   HPD2
[  162.038802] [drm]   DDC: 0x6c 0x6c 0x6c 0x6c 0x6c 0x6c 0x6c 0x6c
[  162.038803] [drm]   Encoders:
[  162.038803] [drm]     CRT2: INTERNAL_DAC2
[  162.038804] [drm]     DFP2: INTERNAL_DVO1
[  162.120992] [drm] fb mappable at 0xD0040000
[  162.120993] [drm] vram apper at 0xD0000000
[  162.120993] [drm] size 2621440
[  162.120994] [drm] fb depth is 16
[  162.120995] [drm]    pitch is 2560
[  162.121100] fbcon: radeondrmfb (fb0) is primary device
[  162.271745] Console: switching to colour frame buffer device 160x64
[  162.296234] radeon 0000:01:05.0: fb0: radeondrmfb frame buffer device
[  162.320032] [drm] Initialized radeon 2.50.0 20080528 for 0000:01:05.0 on minor 0
[  162.530969] Adding 2115580k swap on /dev/md3.  Priority:-2 extents:1 across:2115580k FS
[  163.705045] EXT4-fs (md0): mounted filesystem with ordered data mode. Opts: data=ordered
[  163.842590] EXT4-fs (md2): mounted filesystem with ordered data mode. Opts: data=ordered
[  163.994390] microcode: CPU4: new patch_level=0x010000db
[  163.994400] microcode: CPU0: new patch_level=0x010000db
[  163.994419] microcode: CPU3: new patch_level=0x010000db
[  163.994433] microcode: CPU5: new patch_level=0x010000db
[  163.994453] microcode: CPU1: new patch_level=0x010000db
[  163.994476] microcode: CPU7: new patch_level=0x010000db
[  163.994496] microcode: CPU2: new patch_level=0x010000db
[  163.994520] microcode: CPU6: new patch_level=0x010000db
[  164.653862] w83627hf: w83627hf: Found W83627HF chip at 0x290
[  164.654387] w83627hf w83627hf.656: hwmon_device_register() is deprecated. Please convert the driver to use hwmon_device_register_with_info().
[  164.717675] 8021q: 802.1Q VLAN Support v1.8
[  164.814811] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[  164.819733] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[  164.819777] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
[  164.819779] cfg80211: failed to load regulatory.db
[  164.846812] w83793 1-002c: hwmon_device_register() is deprecated. Please convert the driver to use hwmon_device_register_with_info().
[  164.886788] w83793 1-002c: Registered watchdog chardev major 10, minor: 212
[  164.936486] forcedeth 0000:00:09.0 enp0s9: MSI enabled
[  164.937462] IPv6: ADDRCONF(NETDEV_UP): enp0s9: link is not ready
[  164.937480] IPv6: ADDRCONF(NETDEV_CHANGE): enp0s9: link becomes ready