======================================
| [ 560.500662][ C2] ret_from_fork_asm (arch/x86/entry/entry_64.S:258)
| [ 560.500664][ C2]
| [ 560.500665][ C2]
| [ 560.500665][ C2] stack backtrace:
[ 560.500672][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 560.500675][ C2] Workqueue: pm pm_runtime_work
[ 560.500682][ C2] Call Trace:
[ 560.500685][ C2]
[ 560.500689][ C2] dump_stack_lvl (lib/dump_stack.c:123)
[ 560.500695][ C2] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4127)
[ 560.500699][ C2] mark_lock_irq (kernel/locking/lockdep.c:4295)
[ 560.500706][ C2] mark_lock (kernel/locking/lockdep.c:4753)
[ 560.500709][ C2] mark_usage (kernel/locking/lockdep.c:4639)
[ 560.500712][ C2] __lock_acquire (kernel/locking/lockdep.c:5191)
[ 560.500716][ C2] lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870)
[ 560.500719][ C2] ? console_lock_spinning_enable (kernel/printk/printk.c:1924)
[ 560.500723][ C2] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:751)
[ 560.500729][ C2] ? lock_acquire (./include/trace/events/lock.h:24 kernel/locking/lockdep.c:5831)
[ 560.500732][ C2] ? console_lock_spinning_enable (kernel/printk/printk.c:1924)
[ 560.500736][ C2] console_lock_spinning_enable (kernel/printk/printk.c:1925)
[ 560.500739][ C2] ? console_lock_spinning_enable (kernel/printk/printk.c:1924)
[ 560.500742][ C2] console_emit_next_record (kernel/printk/printk.c:3050 (discriminator 3) kernel/printk/printk.c:3137 (discriminator 3))
[ 560.500746][ C2] ? devkmsg_read (kernel/printk/printk.c:3082)
[ 560.500750][ C2] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:751)
[ 560.500756][ C2] console_flush_all (kernel/printk/printk.c:3227)
[ 560.500760][ C2] ? console_emit_next_record (kernel/printk/printk.c:3188)
[ 560.500763][ C2] ? __lock_acquire (kernel/locking/lockdep.c:5237)
[ 560.500768][ C2] console_unlock (kernel/printk/printk.c:3286 kernel/printk/printk.c:3325)
[ 560.500771][ C2] ? console_flush_all (kernel/printk/printk.c:3320)
[ 560.500774][ C2] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:751)
[ 560.500778][ C2] ? irq_work_single (kernel/irq_work.c:222)
[ 560.500781][ C2] ? irq_work_single (kernel/irq_work.c:222)
[ 560.500786][ C2] wake_up_klogd_work_func (kernel/printk/printk.c:4529)
[ 560.500789][ C2] irq_work_single (kernel/irq_work.c:222)
[ 560.500793][ C2] irq_work_run_list (kernel/irq_work.c:251 (discriminator 3))
[ 560.500796][ C2] ? irq_work_tick (kernel/irq_work.c:277)
[ 560.500799][ C2] update_process_times (kernel/time/timer.c:2478)
[ 560.500803][ C2] tick_nohz_handler (kernel/time/tick-sched.c:277 kernel/time/tick-sched.c:297)
[ 560.500806][ C2] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:751)
[ 560.500810][ C2] __run_hrtimer (kernel/time/hrtimer.c:1761)
[ 560.500814][ C2] ? tick_do_update_jiffies64.part.0 (kernel/time/tick-sched.c:285)
[ 560.500818][ C2] __hrtimer_run_queues (./include/linux/timerqueue.h:25 kernel/time/hrtimer.c:1805)
[ 560.500822][ C2] ? hrtimer_interrupt (kernel/time/hrtimer.c:640 (discriminator 2) kernel/time/hrtimer.c:1869 (discriminator 2))
[ 560.500826][ C2] ? __run_hrtimer (kernel/time/hrtimer.c:1795)
[ 560.500829][ C2] ? kvm_clock_get_cycles (./arch/x86/include/asm/preempt.h:95 arch/x86/kernel/kvmclock.c:80 arch/x86/kernel/kvmclock.c:86)
[ 560.500837][ C2] hrtimer_interrupt (kernel/time/hrtimer.c:1890)
[ 560.500841][ C2] ? __common_interrupt (./include/asm-generic/irq_regs.h:28 arch/x86/kernel/irq.c:295)
[ 560.500849][ C2] __sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1057)
[ 560.500852][ C2] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1050 arch/x86/kernel/apic/apic.c:1050)
[ 560.500856][ C2]
[ 560.500857][ C2]
[ 560.500859][ C2] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702)
[ 560.500861][ C2] RIP: 0010:_raw_spin_unlock_irq (./include/linux/spinlock_api_smp.h:160 kernel/locking/spinlock.c:202)
[ 560.500865][ C2] Code: 0f 1f 44 00 00 55 48 8b 74 24 08 48 89 fd 48 83 c7 18 e8 85 da f9 fd 48 89 ef e8 ad 29 fa fd e8 58 df 1d fe fb bf 01 00 00 00 fd 5d ee fd 65 8b 05 76 7c 03 02 85 c0 74 02 5d c3 e8 bb 76 aa
All code
========
0: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1)
5: 55 push %rbp
6: 48 8b 74 24 08 mov 0x8(%rsp),%rsi
b: 48 89 fd mov %rdi,%rbp
e: 48 83 c7 18 add $0x18,%rdi
12: e8 85 da f9 fd call 0xfffffffffdf9da9c
17: 48 89 ef mov %rbp,%rdi
1a: e8 ad 29 fa fd call 0xfffffffffdfa29cc
1f: e8 58 df 1d fe call 0xfffffffffe1ddf7c
24: fb sti
25: bf 01 00 00 00 mov $0x1,%edi
2a:* e8 fd 5d ee fd call 0xfffffffffdee5e2c <-- trapping instruction
2f: 65 8b 05 76 7c 03 02 mov %gs:0x2037c76(%rip),%eax # 0x2037cac
36: 85 c0 test %eax,%eax
38: 74 02 je 0x3c
3a: 5d pop %rbp
3b: c3 ret
3c: e8 .byte 0xe8
3d: bb .byte 0xbb
3e: 76 aa jbe 0xffffffffffffffea
Code starting with the faulting instruction
===========================================
0: e8 fd 5d ee fd call 0xfffffffffdee5e02
5: 65 8b 05 76 7c 03 02 mov %gs:0x2037c76(%rip),%eax # 0x2037c82
c: 85 c0 test %eax,%eax
e: 74 02 je 0x12
10: 5d pop %rbp
11: c3 ret
12: e8 .byte 0xe8
13: bb .byte 0xbb
14: 76 aa jbe 0xffffffffffffffc0
[ 560.500868][ C2] RSP: 0018:ffffc900001ffc88 EFLAGS: 00000202
[ 560.500871][ C2] RAX: 0000000000008443 RBX: ffffffff8f01d264 RCX: ffffffff8bbcd1ff
[ 560.500873][ C2] RDX: 0000000000000000 RSI: ffffffff8e1ea6cb RDI: 0000000000000001
[ 560.500875][ C2] RBP: ffff888036335880 R08: 0000000000000001 R09: 0000000000000001
[ 560.500877][ C2] R10: ffffffff8f01c217 R11: ffffffff9096b760 R12: ffff8880058e0a58
[ 560.500879][ C2] R13: ffff888001c60040 R14: ffff888001965540 R15: 0000000000000000
[ 560.500882][ C2] ? trace_irq_enable.constprop.0 (./arch/x86/include/asm/bitops.h:227 ./arch/x86/include/asm/bitops.h:239 ./include/asm-generic/bitops/instrumented-non-atomic.h:142 ./include/linux/cpumask.h:646 ./include/linux/cpumask.h:1205 ./include/trace/events/preemptirq.h:40)
[ 560.500890][ C2] ? _raw_spin_unlock_irq (./arch/x86/include/asm/irqflags.h:42 ./arch/x86/include/asm/irqflags.h:119 ./include/linux/spinlock_api_smp.h:159 kernel/locking/spinlock.c:202)
[ 560.500893][ C2] process_one_work (kernel/workqueue.c:3207)
[ 560.500899][ C2] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3138)
[ 560.500905][ C2] ? assign_work (kernel/workqueue.c:1204)
[ 560.500909][ C2] worker_thread (kernel/workqueue.c:3313 kernel/workqueue.c:3400)
[ 560.500915][ C2] ? rescuer_thread (kernel/workqueue.c:3346)
[ 560.500918][ C2] kthread (kernel/kthread.c:463)
[ 560.500922][ C2] ? kthread_is_per_cpu (kernel/kthread.c:412)
[ 560.500925][ C2] ? ret_from_fork (arch/x86/kernel/process.c:147)
[ 560.500927][ C2] ? __lock_release (kernel/locking/lockdep.c:5536)
[ 560.500930][ C2] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:751)
[ 560.500934][ C2] ? kthread_is_per_cpu (kernel/kthread.c:412)
[ 560.500938][ C2] ret_from_fork (arch/x86/kernel/process.c:154)
[ 560.500940][ C2] ? kthread_is_per_cpu (kernel/kthread.c:412)
Finger prints:
ret_from_fork_asm:dump_stack_lvl:mark_lock_irq:mark_lock:mark_usage