======================================
| [   23.918126][  T277] softirqs last disabled at (19272): netlink_release (./include/net/sock.h:2138 net/netlink/af_netlink.c:727)
| [   23.918129][  T277] Preemption disabled at:
| [   23.918129][  T277] 0x0
| [   23.918140][  T277] Tainted: [W]=WARN
[   23.918141][  T277] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[   23.918143][  T277] Call Trace:
[   23.918145][  T277]  <TASK>
[   23.918146][  T277]  dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120)
[   23.918152][  T277]  __might_resched.cold (kernel/sched/core.c:9234)
[   23.918157][  T277]  ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3))
[   23.918161][  T277]  ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439)
[   23.918166][  T277]  __kmalloc_noprof (./include/linux/sched/mm.h:322 (discriminator 2) mm/slub.c:4636 (discriminator 2) mm/slub.c:4974 (discriminator 2) mm/slub.c:5413 (discriminator 2) mm/slub.c:5439 (discriminator 2))
[   23.918168][  T277]  ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429)
[   23.918174][  T277]  ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141)
[   23.918176][  T277]  alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429)
[   23.918179][  T277]  put_chars (drivers/char/virtio_console.c:1176)
[   23.918182][  T277]  ? __send_to_port (drivers/char/virtio_console.c:654)
[   23.918184][  T277]  ? printk_get_next_message (kernel/printk/printk.c:3072)
[   23.918187][  T277]  ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380)
[   23.918190][  T277]  ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2))
[   23.918195][  T277]  hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2))
[   23.918198][  T277]  ? __lock_acquire (kernel/locking/lockdep.c:5254)
[   23.918199][  T277]  ? __lock_acquire (kernel/locking/lockdep.c:5254)
[   23.918203][  T277]  ? hvc_write (drivers/tty/hvc/hvc_console.c:501)
[   23.918206][  T277]  ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[   23.918210][  T277]  ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[   23.918213][  T277]  console_emit_next_record (kernel/printk/printk.c:3183)
[   23.918217][  T277]  ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20)
[   23.918222][  T277]  ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[   23.918224][  T277]  ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[   23.918228][  T277]  console_flush_one_record (kernel/printk/printk.c:3268)
[   23.918232][  T277]  ? console_emit_next_record (kernel/printk/printk.c:3150)
[   23.918233][  T277]  ? __lock_acquire (kernel/locking/lockdep.c:5254)
[   23.918239][  T277]  console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420)
[   23.918241][  T277]  ? console_flush_one_record (kernel/printk/printk.c:3316)
[   23.918243][  T277]  ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[   23.918245][  T277]  ? lock_acquire (kernel/locking/lockdep.c:5913)
[   23.918252][  T277]  ? __down_trylock_console_sem (kernel/printk/printk.c:334)
[   23.918254][  T277]  ? vprintk_emit (kernel/printk/printk.c:2478)
[   23.918259][  T277]  vprintk_emit (kernel/printk/printk.c:2479)
[   23.918262][  T277]  ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126))
[   23.918266][  T277]  ? __lock_acquire (kernel/locking/lockdep.c:5254)
[   23.918269][  T277]  _printk (kernel/printk/printk.c:2504)
[   23.918273][  T277]  ? snapshot_read.cold (user.c:?)
[   23.918276][  T277]  ? do_raw_spin_lock (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1301 ./include/asm-generic/qspinlock.h:112 kernel/locking/spinlock_debug.c:116)
[   23.918279][  T277]  ? __rwlock_init (kernel/locking/spinlock_debug.c:48)
[   23.918282][  T277]  ? do_raw_spin_lock (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1301 ./include/asm-generic/qspinlock.h:112 kernel/locking/spinlock_debug.c:116)
[   23.918285][  T277]  do_exit.cold (kernel/exit.c:889 (discriminator 4) kernel/exit.c:1043 (discriminator 4))
[   23.918289][  T277]  ? exit_notify (kernel/exit.c:780)
[   23.918291][  T277]  ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554)
[   23.918293][  T277]  ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[   23.918297][  T277]  do_group_exit (kernel/exit.c:1151)
[   23.918301][  T277]  __x64_sys_exit_group (kernel/exit.c:1162 kernel/exit.c:1160 kernel/exit.c:1160)
[   23.918303][  T277]  x64_sys_call (./arch/x86/include/generated/asm/syscalls_64.h:232)
[   23.918306][  T277]  do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84)
[   23.918309][  T277]  ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3))
[   23.918312][  T277]  entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121)
[   23.918314][  T277] RIP: 0033:0x7ff81176b1b8
[   23.918317][  T277] Code: Unable to access opcode bytes at 0x7ff81176b18e.

Code starting with the faulting instruction
===========================================
[   23.918318][  T277] RSP: 002b:00007ffce8817f48 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7
[   23.918321][  T277] RAX: ffffffffffffffda RBX: 00007ff81189bf88 RCX: 00007ff81176b1b8
[   23.918322][  T277] RDX: 00007ff8114b5fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000
[   23.918323][  T277] RBP: 00007ffce8817fa0 R08: 0000000000000000 R09: 0000000000000050
[   23.918324][  T277] R10: 00007ffce8817d60 R11: 0000000000000246 R12: 0000000000000001
[   23.918325][  T277] R13: 0000000000000000 R14: 00007ff81189a680 R15: 00007ff81189bfa0
| [   23.925635][    C0]
| [   23.925636][    C0]
| [   23.925636][    C0] stack backtrace:
| [   23.925641][    C0] Tainted: [W]=WARN
[   23.925641][    C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[   23.925642][    C0] Call Trace:
[   23.925643][    C0]  <IRQ>
[   23.925644][    C0]  dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120)
[   23.925647][    C0]  print_irq_inversion_bug.part.0.cold (kernel/locking/lockdep.c:4141)
[   23.925649][    C0]  mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310)
[   23.925651][    C0]  ? add_lock_to_list (./include/linux/find.h:391 kernel/locking/lockdep.c:1419 kernel/locking/lockdep.c:1450)
[   23.925655][    C0]  mark_lock (kernel/locking/lockdep.c:4769)
[   23.925656][    C0]  mark_usage (kernel/locking/lockdep.c:4658)
[   23.925658][    C0]  __lock_acquire (kernel/locking/lockdep.c:5208)
[   23.925660][    C0]  lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2))
[   23.925661][    C0]  ? console_trylock_spinning (kernel/printk/printk.c:2026 (discriminator 2))
[   23.925663][    C0]  ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[   23.925665][    C0]  ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[   23.925667][    C0]  console_trylock_spinning (kernel/printk/printk.c:2026 (discriminator 2))
[   23.925668][    C0]  ? console_trylock_spinning (kernel/printk/printk.c:2026 (discriminator 2))
[   23.925670][    C0]  vprintk_emit (kernel/printk/printk.c:2478)
[   23.925672][    C0]  ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126))
[   23.925674][    C0]  ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:434 kernel/time/clocksource.c:664)
[   23.925676][    C0]  _printk (kernel/printk/printk.c:2504)
[   23.925678][    C0]  ? snapshot_read.cold (user.c:?)
[   23.925680][    C0]  ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:434 kernel/time/clocksource.c:664)
[   23.925681][    C0]  ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554)
[   23.925683][    C0]  clocksource_watchdog.part.0.cold (kernel/time/clocksource.c:589 (discriminator 10) kernel/time/clocksource.c:632 (discriminator 10) kernel/time/clocksource.c:667 (discriminator 10))
[   23.925685][    C0]  ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4))
[   23.925686][    C0]  ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4))
[   23.925687][    C0]  call_timer_fn (kernel/time/timer.c:1748)
[   23.925689][    C0]  ? detach_if_pending (./include/linux/list.h:1159)
[   23.925691][    C0]  ? debug_object_active_state (lib/debugobjects.c:1122)
[   23.925695][    C0]  ? find_held_lock (kernel/locking/lockdep.c:5367)
[   23.925697][    C0]  ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554)
[   23.925698][    C0]  ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[   23.925701][    C0]  __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374)
[   23.925702][    C0]  ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4))
[   23.925704][    C0]  ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407)
[   23.925706][    C0]  ? __lock_acquire (kernel/locking/lockdep.c:5254)
[   23.925708][    C0]  ? __rwlock_init (kernel/locking/spinlock_debug.c:48)
[   23.925710][    C0]  run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403)
[   23.925712][    C0]  ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19))
[   23.925714][    C0]  ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22))
[   23.925717][    C0]  ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[   23.925718][    C0]  handle_softirqs (kernel/softirq.c:645)
[   23.925721][    C0]  ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554)
[   23.925722][    C0]  ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1))
[   23.925725][    C0]  __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767)
[   23.925727][    C0]  irq_exit_rcu (kernel/softirq.c:784)
[   23.925729][    C0]  sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37))
[   23.925731][    C0]  </IRQ>
[   23.925731][    C0]  <TASK>
[   23.925732][    C0]  ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:470 (discriminator 2) kernel/locking/lockdep.c:4427 (discriminator 2))
[   23.925733][    C0]  asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674)
[   23.925735][    C0] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:63)
[   23.925737][    C0] Code: 48 8b 3d 94 e2 f7 01 e8 1f 00 00 00 48 2b 05 58 a3 98 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 06 11 00 fb f4 <c3> 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01
All code
========
   0:	48 8b 3d 94 e2 f7 01 	mov    0x1f7e294(%rip),%rdi        # 0x1f7e29b
   7:	e8 1f 00 00 00       	call   0x2b
   c:	48 2b 05 58 a3 98 00 	sub    0x98a358(%rip),%rax        # 0x98a36b
  13:	c3                   	ret
  14:	0f 1f 80 00 00 00 00 	nopl   0x0(%rax)
  1b:	f3 0f 1e fa          	endbr64
  1f:	eb 07                	jmp    0x28
  21:	0f 00 2d 13 06 11 00 	verw   0x110613(%rip)        # 0x11063b
  28:	fb                   	sti
  29:	f4                   	hlt
  2a:*	c3                   	ret		<-- trapping instruction
  2b:	0f 1f 40 d6          	nopl   -0x2a(%rax)
  2f:	48 83 ec 20          	sub    $0x20,%rsp
  33:	8b 17                	mov    (%rdi),%edx
  35:	49 89 f8             	mov    %rdi,%r8
  38:	83 e2 fe             	and    $0xfffffffe,%edx
  3b:	41 89 d2             	mov    %edx,%r10d
  3e:	0f                   	.byte 0xf
  3f:	01                   	.byte 0x1

Code starting with the faulting instruction
===========================================
   0:	c3                   	ret
   1:	0f 1f 40 d6          	nopl   -0x2a(%rax)
   5:	48 83 ec 20          	sub    $0x20,%rsp
   9:	8b 17                	mov    (%rdi),%edx
   b:	49 89 f8             	mov    %rdi,%r8
   e:	83 e2 fe             	and    $0xfffffffe,%edx
  11:	41 89 d2             	mov    %edx,%r10d
  14:	0f                   	.byte 0xf
  15:	01                   	.byte 0x1
[   23.925740][    C0] RSP: 0018:ffffffffa4c07cf8 EFLAGS: 00000296
[   23.925742][    C0] RAX: 0000000000086aaf RBX: ffffffffa4c1c600 RCX: ffffffffa1ced307
[   23.925743][    C0] RDX: ffffffffa4c1c600 RSI: ffffffffa4a70974 RDI: ffffffffa448f560
[   23.925744][    C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[   23.925745][    C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff4980fa2
[   23.925746][    C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770
[   23.925747][    C0]  ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199)
[   23.925750][    C0]  ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488)
[   23.925752][    C0]  default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:768)
[   23.925754][    C0]  default_idle_call (kernel/sched/idle.c:122)
[   23.925755][    C0]  cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199)
[   23.925758][    C0]  ? arch_cpu_idle_exit+0x40/0x40
[   23.925760][    C0]  ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49)
[   23.925763][    C0]  ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[   23.925765][    C0]  do_idle (kernel/sched/idle.c:355)
[   23.925767][    C0]  cpu_startup_entry (kernel/sched/idle.c:454)
[   23.925769][    C0]  rest_init (init/main.c:727)
[   23.925771][    C0]  ? __cpuidle_text_end (??:?)
[   23.925774][    C0]  ? rest_init (init/main.c:727)
[   23.925776][    C0]  ? acpi_hw_set_mode (drivers/acpi/acpica/hwacpi.c:72 (discriminator 1))
[   23.925779][    C0]  ? cpus_read_unlock (./include/linux/percpu-rwsem.h:125 (discriminator 1) kernel/cpu.c:502 (discriminator 1))
[   23.925781][    C0]  ? acpi_enable (drivers/acpi/acpica/evxfevnt.c:47)
[   23.925784][    C0]  start_kernel (init/main.c:1185)
[   23.925785][    C0]  x86_64_start_reservations (arch/x86/kernel/head64.c:310)
[   23.925787][    C0]  x86_64_start_kernel (arch/x86/kernel/head64.c:291)


Finger prints:
mark_lock_irq:mark_lock:mark_usage:__lock_acquire:console_trylock_spinning
netlink_release:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print