[ 10.531762][ C0] clocksource: Watchdog remote CPU 3 read timed out [ 10.532105][ C0] [ 10.532106][ C0] ======================================================== [ 10.532107][ C0] WARNING: possible irq lock inversion dependency detected [ 10.532110][ C0] 7.2.0-virtme #1 Tainted: G W [ 10.532111][ C0] -------------------------------------------------------- [ 10.532112][ C0] modprobe/212 just changed the state of lock: [ 10.532113][ C0] ffffffffa809d760 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.532125][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 10.532127][ C0] (fs_reclaim){+.+.}-{0:0} [ 10.532128][ C0] [ 10.532128][ C0] [ 10.532128][ C0] and interrupts could create inverse lock ordering between them. [ 10.532128][ C0] [ 10.532129][ C0] [ 10.532129][ C0] other info that might help us debug this: [ 10.532130][ C0] Possible interrupt unsafe locking scenario: [ 10.532130][ C0] [ 10.532130][ C0] CPU0 CPU1 [ 10.532130][ C0] ---- ---- [ 10.532131][ C0] lock(fs_reclaim); [ 10.532132][ C0] local_irq_disable(); [ 10.532132][ C0] lock(console_owner); [ 10.532133][ C0] lock(fs_reclaim); [ 10.532134][ C0] [ 10.532134][ C0] lock(console_owner); [ 10.532135][ C0] [ 10.532135][ C0] *** DEADLOCK *** [ 10.532135][ C0] [ 10.532136][ C0] locks held by modprobe/212: 6, last CPU#0: [ 10.532137][ C0] #0: ffffffffa83c5fb8 (remove_cache_srcu){.+.+}-{0:0}, at: kasan_quarantine_reduce+0x84/0x240 [ 10.532144][ C0] #1: ffffffffa8194c00 (rcu_read_lock){....}-{1:3}, at: unwind_next_frame+0x17e/0x1ea0 [ 10.532148][ C0] #2: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 10.532153][ C0] #3: ffffffffa81e29f8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 10.532157][ C0] #4: ffffffffa817ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.532160][ C0] #5: ffffffffa817de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.532163][ C0] [ 10.532163][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 10.532168][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 10.532170][ C0] HARDIRQ-ON-W at: [ 10.532172][ C0] __lock_acquire+0x388/0xc20 [ 10.532176][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.532177][ C0] fs_reclaim_acquire+0xd5/0x120 [ 10.532180][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 10.532182][ C0] kthread_create_worker_on_node+0xea/0x210 [ 10.532185][ C0] workqueue_init+0x2a/0x680 [ 10.532189][ C0] kernel_init_freeable+0x2fe/0x630 [ 10.532192][ C0] kernel_init+0x21/0x150 [ 10.532196][ C0] ret_from_fork+0x474/0x6b0 [ 10.532199][ C0] ret_from_fork_asm+0x11/0x20 [ 10.532202][ C0] SOFTIRQ-ON-W at: [ 10.532203][ C0] __lock_acquire+0x388/0xc20 [ 10.532205][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.532206][ C0] fs_reclaim_acquire+0xd5/0x120 [ 10.532207][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 10.532208][ C0] kthread_create_worker_on_node+0xea/0x210 [ 10.532210][ C0] workqueue_init+0x2a/0x680 [ 10.532211][ C0] kernel_init_freeable+0x2fe/0x630 [ 10.532213][ C0] kernel_init+0x21/0x150 [ 10.532214][ C0] ret_from_fork+0x474/0x6b0 [ 10.532216][ C0] ret_from_fork_asm+0x11/0x20 [ 10.532217][ C0] INITIAL USE at: [ 10.532218][ C0] __lock_acquire+0x388/0xc20 [ 10.532219][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.532221][ C0] fs_reclaim_acquire+0xd5/0x120 [ 10.532222][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 10.532223][ C0] kthread_create_worker_on_node+0xea/0x210 [ 10.532225][ C0] workqueue_init+0x2a/0x680 [ 10.532226][ C0] kernel_init_freeable+0x2fe/0x630 [ 10.532228][ C0] kernel_init+0x21/0x150 [ 10.532229][ C0] ret_from_fork+0x474/0x6b0 [ 10.532230][ C0] ret_from_fork_asm+0x11/0x20 [ 10.532232][ C0] } [ 10.532232][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 10.532236][ C0] ... acquired at: [ 10.532237][ C0] __lock_acquire+0x518/0xc20 [ 10.532238][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.532240][ C0] fs_reclaim_acquire+0xd5/0x120 [ 10.532241][ C0] __kmalloc_noprof+0xd3/0x760 [ 10.532242][ C0] alloc_buf.isra.0+0x4b/0x260 [ 10.532246][ C0] put_chars+0x1e1/0x2f0 [ 10.532247][ C0] hvc_console_print+0x292/0x780 [ 10.532250][ C0] console_emit_next_record+0x22f/0x4c0 [ 10.532252][ C0] console_flush_one_record+0x46f/0x710 [ 10.532254][ C0] console_unlock+0xee/0x1f0 [ 10.532255][ C0] vprintk_emit+0x37c/0x3e0 [ 10.532256][ C0] _printk+0xc7/0x100 [ 10.532259][ C0] tun_init+0x24/0xb0 [ 10.532262][ C0] do_one_initcall+0x124/0x4f0 [ 10.532263][ C0] kernel_init_freeable+0x596/0x630 [ 10.532265][ C0] kernel_init+0x21/0x150 [ 10.532266][ C0] ret_from_fork+0x474/0x6b0 [ 10.532267][ C0] ret_from_fork_asm+0x11/0x20 [ 10.532269][ C0] [ 10.532269][ C0] -> (console_owner){..-.}-{0:0} { [ 10.532271][ C0] IN-SOFTIRQ-W at: [ 10.532271][ C0] __lock_acquire+0x388/0xc20 [ 10.532273][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.532274][ C0] console_lock_spinning_enable+0x5c/0x60 [ 10.532276][ C0] console_emit_next_record+0x1d1/0x4c0 [ 10.532278][ C0] console_flush_one_record+0x46f/0x710 [ 10.532279][ C0] console_unlock+0xee/0x1f0 [ 10.532281][ C0] vprintk_emit+0x37c/0x3e0 [ 10.532282][ C0] _printk+0xc7/0x100 [ 10.532283][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 10.532286][ C0] call_timer_fn+0x160/0x4d0 [ 10.532287][ C0] __run_timers+0x68f/0xaa0 [ 10.532289][ C0] run_timer_softirq+0xf0/0x160 [ 10.532291][ C0] handle_softirqs+0x1d3/0x900 [ 10.532293][ C0] __irq_exit_rcu+0x145/0x1c0 [ 10.532294][ C0] irq_exit_rcu+0xe/0x30 [ 10.532296][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.532297][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.532299][ C0] __orc_find+0x91/0x100 [ 10.532300][ C0] unwind_next_frame+0x272/0x1ea0 [ 10.532302][ C0] arch_stack_walk+0xd7/0x130 [ 10.532303][ C0] stack_trace_save+0x93/0xc0 [ 10.532305][ C0] set_track_prepare+0x62/0x90 [ 10.532307][ C0] free_to_partial_list+0x1c6/0x310 [ 10.532309][ C0] qlist_free_all+0x5c/0x110 [ 10.532310][ C0] kasan_quarantine_reduce+0x196/0x240 [ 10.532312][ C0] __kasan_slab_alloc+0x4b/0x70 [ 10.532314][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 10.532315][ C0] fuse_request_alloc+0x27/0x210 [ 10.532318][ C0] fuse_chan_send+0x78/0x7a0 [ 10.532319][ C0] fuse_file_put+0x286/0x470 [ 10.532321][ C0] fuse_release+0x12c/0x230 [ 10.532322][ C0] __fput+0x36c/0xad0 [ 10.532324][ C0] task_work_run+0x12b/0x240 [ 10.532326][ C0] exit_to_user_mode_loop+0x158/0x5a0 [ 10.532328][ C0] do_syscall_64+0x3e3/0x530 [ 10.532331][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.532332][ C0] INITIAL USE at: [ 10.532333][ C0] } [ 10.532333][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 10.532336][ C0] ... acquired at: [ 10.532336][ C0] mark_lock+0x1d7/0xa00 [ 10.532337][ C0] mark_usage+0x42/0x170 [ 10.532339][ C0] __lock_acquire+0x388/0xc20 [ 10.532340][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.532342][ C0] console_lock_spinning_enable+0x5c/0x60 [ 10.532343][ C0] console_emit_next_record+0x1d1/0x4c0 [ 10.532345][ C0] console_flush_one_record+0x46f/0x710 [ 10.532346][ C0] console_unlock+0xee/0x1f0 [ 10.532348][ C0] vprintk_emit+0x37c/0x3e0 [ 10.532349][ C0] _printk+0xc7/0x100 [ 10.532350][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 10.532351][ C0] call_timer_fn+0x160/0x4d0 [ 10.532353][ C0] __run_timers+0x68f/0xaa0 [ 10.532354][ C0] run_timer_softirq+0xf0/0x160 [ 10.532356][ C0] handle_softirqs+0x1d3/0x900 [ 10.532357][ C0] __irq_exit_rcu+0x145/0x1c0 [ 10.532358][ C0] irq_exit_rcu+0xe/0x30 [ 10.532360][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.532361][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.532362][ C0] __orc_find+0x91/0x100 [ 10.532363][ C0] unwind_next_frame+0x272/0x1ea0 [ 10.532364][ C0] arch_stack_walk+0xd7/0x130 [ 10.532365][ C0] stack_trace_save+0x93/0xc0 [ 10.532366][ C0] set_track_prepare+0x62/0x90 [ 10.532367][ C0] free_to_partial_list+0x1c6/0x310 [ 10.532369][ C0] qlist_free_all+0x5c/0x110 [ 10.532370][ C0] kasan_quarantine_reduce+0x196/0x240 [ 10.532372][ C0] __kasan_slab_alloc+0x4b/0x70 [ 10.532373][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 10.532374][ C0] fuse_request_alloc+0x27/0x210 [ 10.532375][ C0] fuse_chan_send+0x78/0x7a0 [ 10.532377][ C0] fuse_file_put+0x286/0x470 [ 10.532378][ C0] fuse_release+0x12c/0x230 [ 10.532385][ C0] __fput+0x36c/0xad0 [ 10.532387][ C0] task_work_run+0x12b/0x240 [ 10.532389][ C0] exit_to_user_mode_loop+0x158/0x5a0 [ 10.532390][ C0] do_syscall_64+0x3e3/0x530 [ 10.532392][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.532393][ C0] [ 10.532393][ C0] [ 10.532393][ C0] stack backtrace: [ 10.532396][ C0] CPU: 0 UID: 0 PID: 212 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.532399][ C0] Tainted: [W]=WARN [ 10.532400][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.532402][ C0] Call Trace: [ 10.532403][ C0] [ 10.532404][ C0] dump_stack_lvl+0x6f/0xa0 [ 10.532408][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 10.532411][ C0] mark_lock_irq+0x989/0x9c0 [ 10.532413][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 10.532416][ C0] mark_lock+0x1d7/0xa00 [ 10.532418][ C0] mark_usage+0x42/0x170 [ 10.532419][ C0] __lock_acquire+0x388/0xc20 [ 10.532422][ C0] lock_acquire.part.0+0xd4/0x280 [ 10.532423][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 10.532425][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532428][ C0] ? lock_acquire+0x13c/0x160 [ 10.532430][ C0] console_lock_spinning_enable+0x5c/0x60 [ 10.532431][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 10.532433][ C0] console_emit_next_record+0x1d1/0x4c0 [ 10.532435][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 10.532437][ C0] ? console_flush_one_record+0x106/0x710 [ 10.532439][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532440][ C0] ? lock_acquire+0x13c/0x160 [ 10.532442][ C0] console_flush_one_record+0x46f/0x710 [ 10.532445][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 10.532446][ C0] ? __lock_acquire+0x518/0xc20 [ 10.532449][ C0] console_unlock+0xee/0x1f0 [ 10.532451][ C0] ? console_flush_one_record+0x710/0x710 [ 10.532452][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532454][ C0] ? lock_acquire+0xe0/0x160 [ 10.532456][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.532457][ C0] ? vprintk_emit+0x320/0x3e0 [ 10.532459][ C0] vprintk_emit+0x37c/0x3e0 [ 10.532460][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 10.532462][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 10.532464][ C0] _printk+0xc7/0x100 [ 10.532466][ C0] ? snapshot_read.cold+0x21/0x21 [ 10.532468][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 10.532469][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 10.532472][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 10.532473][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 10.532475][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 10.532477][ C0] call_timer_fn+0x160/0x4d0 [ 10.532479][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 10.532481][ C0] ? debug_object_active_state+0x430/0x430 [ 10.532484][ C0] ? find_held_lock+0x2b/0x80 [ 10.532486][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 10.532488][ C0] ? mark_held_locks+0x40/0x70 [ 10.532490][ C0] __run_timers+0x68f/0xaa0 [ 10.532492][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 10.532494][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 10.532496][ C0] ? __lock_acquire+0x518/0xc20 [ 10.532499][ C0] ? __rwlock_init+0x150/0x150 [ 10.532501][ C0] run_timer_softirq+0xf0/0x160 [ 10.532503][ C0] ? __run_timers+0xaa0/0xaa0 [ 10.532505][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532507][ C0] handle_softirqs+0x1d3/0x900 [ 10.532509][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 10.532510][ C0] ? _local_bh_enable+0xc0/0xc0 [ 10.532512][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 10.532514][ C0] __irq_exit_rcu+0x145/0x1c0 [ 10.532516][ C0] irq_exit_rcu+0xe/0x30 [ 10.532517][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.532519][ C0] [ 10.532519][ C0] [ 10.532520][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.532522][ C0] RIP: 0010:__orc_find+0x91/0x100 [ 10.532524][ C0] Code: 48 c1 e9 03 0f b6 3c 01 48 89 d1 83 e1 07 83 c1 03 40 38 f9 7c 05 40 84 ff 75 30 48 63 0a 48 01 d1 49 39 ca 73 b0 4c 8d 4a fc <4d> 39 c1 73 b3 49 29 f3 48 83 c4 30 49 c1 fb 02 4b 8d 04 5b 48 8d [ 10.532526][ C0] RSP: 0018:ffa00000006978a0 EFLAGS: 00000287 [ 10.532528][ C0] RAX: dffffc0000000000 RBX: ffffffffa8eea2a8 RCX: ffffffffa4ddcfc8 [ 10.532529][ C0] RDX: ffffffffa8c6f888 RSI: ffffffffa8c6f83c RDI: 0000000000000000 [ 10.532530][ C0] RBP: 0000000000000001 R08: ffffffffa8c6f870 R09: ffffffffa8c6f884 [ 10.532531][ C0] R10: ffffffffa4ddcfaa R11: ffffffffa8c6f86c R12: ffa0000000697a38 [ 10.532532][ C0] R13: ffa00000006979e0 R14: ff1100000f804740 R15: ff11000001169080 [ 10.532533][ C0] ? __kasan_slab_alloc+0x4a/0x70 [ 10.532534][ C0] ? __kasan_slab_alloc+0x68/0x70 [ 10.532537][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532538][ C0] unwind_next_frame+0x272/0x1ea0 [ 10.532539][ C0] ? __kasan_slab_alloc+0x4b/0x70 [ 10.532541][ C0] ? stack_access_ok+0x1e0/0x1e0 [ 10.532543][ C0] ? __unwind_start+0x42e/0x900 [ 10.532545][ C0] ? write_profile+0xf0/0xf0 [ 10.532546][ C0] arch_stack_walk+0xd7/0x130 [ 10.532548][ C0] ? __kasan_slab_alloc+0x4b/0x70 [ 10.532550][ C0] stack_trace_save+0x93/0xc0 [ 10.532552][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 10.532554][ C0] set_track_prepare+0x62/0x90 [ 10.532555][ C0] ? kasan_quarantine_reduce+0x196/0x240 [ 10.532557][ C0] ? __kasan_slab_alloc+0x4b/0x70 [ 10.532559][ C0] free_to_partial_list+0x1c6/0x310 [ 10.532561][ C0] ? qlist_free_all+0x57/0x110 [ 10.532563][ C0] qlist_free_all+0x5c/0x110 [ 10.532565][ C0] kasan_quarantine_reduce+0x196/0x240 [ 10.532567][ C0] __kasan_slab_alloc+0x4b/0x70 [ 10.532568][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 10.532569][ C0] ? fuse_request_alloc+0x27/0x210 [ 10.532572][ C0] fuse_request_alloc+0x27/0x210 [ 10.532574][ C0] fuse_chan_send+0x78/0x7a0 [ 10.532576][ C0] fuse_file_put+0x286/0x470 [ 10.532577][ C0] ? fuse_file_release+0x57/0x290 [ 10.532579][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 10.532580][ C0] fuse_release+0x12c/0x230 [ 10.532582][ C0] ? security_file_release+0x1f/0x30 [ 10.532585][ C0] __fput+0x36c/0xad0 [ 10.532586][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532588][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.532590][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 10.532592][ C0] ? _raw_spin_unlock_irq+0x28/0x50 [ 10.532594][ C0] ? _raw_spin_unlock_irq+0x33/0x50 [ 10.532595][ C0] task_work_run+0x12b/0x240 [ 10.532597][ C0] ? task_work_cancel+0x30/0x30 [ 10.532599][ C0] ? fput_close_sync+0xde/0x1b0 [ 10.532600][ C0] ? alloc_file_clone+0xe0/0xe0 [ 10.532602][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532603][ C0] ? exit_to_user_mode_loop+0x6d/0x5a0 [ 10.532605][ C0] exit_to_user_mode_loop+0x158/0x5a0 [ 10.532606][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532608][ C0] do_syscall_64+0x3e3/0x530 [ 10.532610][ C0] ? exc_page_fault+0xee/0x100 [ 10.532611][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.532613][ C0] RIP: 0033:0x7f8f6324cf8b [ 10.532615][ C0] Code: 0f 1e fa 55 48 63 ff 45 31 c9 45 31 c0 31 c9 48 89 e5 48 83 ec 08 6a 01 e8 e2 55 f8 ff c9 c3 f3 0f 1e fa b8 03 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 05 c3 0f 1f 40 00 48 8b 15 39 4e 10 00 f7 d8 [ 10.532616][ C0] RSP: 002b:00007ffde1215378 EFLAGS: 00000297 ORIG_RAX: 0000000000000003 [ 10.532618][ C0] RAX: 0000000000000000 RBX: 000055e44109a4f0 RCX: 00007f8f6324cf8b [ 10.532618][ C0] RDX: 00007f8f63350ec0 RSI: 4969aeaed8c4408b RDI: 0000000000000000 [ 10.532619][ C0] RBP: 00007ffde12153b0 R08: 000055e44109b7f0 R09: 0000000000000110 [ 10.532620][ C0] R10: 0000000000000111 R11: 0000000000000297 R12: 00007f8f63351010 [ 10.532621][ C0] R13: 0000000000000000 R14: 000055e44109a4f0 R15: 000055e44109a120 [ 10.532625][ C0] [ 10.532629][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.532630][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 212, name: modprobe [ 10.532632][ C0] preempt_count: 102, expected: 0 [ 10.532632][ C0] RCU nest depth: 1, expected: 0 [ 10.532633][ C0] INFO: lockdep is turned off. [ 10.532634][ C0] irq event stamp: 45959 [ 10.532634][ C0] hardirqs last enabled at (45958): [] __down_trylock_console_sem+0x86/0xa0 [ 10.532637][ C0] hardirqs last disabled at (45959): [] console_emit_next_record+0x3d4/0x4c0 [ 10.532639][ C0] softirqs last enabled at (43708): [] handle_softirqs+0x67c/0x900 [ 10.532640][ C0] softirqs last disabled at (45945): [] __irq_exit_rcu+0x145/0x1c0 [ 10.532642][ C0] Preemption disabled at: [ 10.532642][ C0] [] handle_softirqs+0xf6/0x900 [ 10.532645][ C0] CPU: 0 UID: 0 PID: 212 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.532647][ C0] Tainted: [W]=WARN [ 10.532648][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.532648][ C0] Call Trace: [ 10.532649][ C0] [ 10.532649][ C0] dump_stack_lvl+0x6f/0xa0 [ 10.532652][ C0] ? handle_softirqs+0xf6/0x900 [ 10.532653][ C0] __might_resched.cold+0x1fe/0x2c1 [ 10.532656][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.532659][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532661][ C0] __kmalloc_noprof+0x443/0x760 [ 10.532662][ C0] ? __rwlock_init+0x150/0x150 [ 10.532664][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 10.532666][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 10.532668][ C0] alloc_buf.isra.0+0x4b/0x260 [ 10.532670][ C0] put_chars+0x1e1/0x2f0 [ 10.532672][ C0] ? __send_to_port+0x420/0x420 [ 10.532674][ C0] ? mark_lock+0x1d7/0xa00 [ 10.532676][ C0] hvc_console_print+0x292/0x780 [ 10.532679][ C0] ? hvc_write+0x3a0/0x3a0 [ 10.532681][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532682][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532684][ C0] console_emit_next_record+0x22f/0x4c0 [ 10.532686][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 10.532688][ C0] ? console_flush_one_record+0x106/0x710 [ 10.532690][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532691][ C0] ? lock_acquire+0x13c/0x160 [ 10.532693][ C0] console_flush_one_record+0x46f/0x710 [ 10.532695][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 10.532697][ C0] ? __lock_acquire+0x518/0xc20 [ 10.532699][ C0] console_unlock+0xee/0x1f0 [ 10.532701][ C0] ? console_flush_one_record+0x710/0x710 [ 10.532703][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532704][ C0] ? lock_acquire+0xe0/0x160 [ 10.532706][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.532708][ C0] ? vprintk_emit+0x320/0x3e0 [ 10.532709][ C0] vprintk_emit+0x37c/0x3e0 [ 10.532711][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 10.532713][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 10.532714][ C0] _printk+0xc7/0x100 [ 10.532716][ C0] ? snapshot_read.cold+0x21/0x21 [ 10.532718][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 10.532719][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 10.532722][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 10.532723][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 10.532725][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 10.532727][ C0] call_timer_fn+0x160/0x4d0 [ 10.532729][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 10.532731][ C0] ? debug_object_active_state+0x430/0x430 [ 10.532732][ C0] ? find_held_lock+0x2b/0x80 [ 10.532734][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 10.532735][ C0] ? mark_held_locks+0x40/0x70 [ 10.532738][ C0] __run_timers+0x68f/0xaa0 [ 10.532739][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 10.532742][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 10.532743][ C0] ? __lock_acquire+0x518/0xc20 [ 10.532746][ C0] ? __rwlock_init+0x150/0x150 [ 10.532749][ C0] run_timer_softirq+0xf0/0x160 [ 10.532751][ C0] ? __run_timers+0xaa0/0xaa0 [ 10.532753][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532754][ C0] handle_softirqs+0x1d3/0x900 [ 10.532756][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 10.532757][ C0] ? _local_bh_enable+0xc0/0xc0 [ 10.532759][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 10.532761][ C0] __irq_exit_rcu+0x145/0x1c0 [ 10.532763][ C0] irq_exit_rcu+0xe/0x30 [ 10.532764][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.532766][ C0] [ 10.532766][ C0] [ 10.532767][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.532768][ C0] RIP: 0010:__orc_find+0x91/0x100 [ 10.532770][ C0] Code: 48 c1 e9 03 0f b6 3c 01 48 89 d1 83 e1 07 83 c1 03 40 38 f9 7c 05 40 84 ff 75 30 48 63 0a 48 01 d1 49 39 ca 73 b0 4c 8d 4a fc <4d> 39 c1 73 b3 49 29 f3 48 83 c4 30 49 c1 fb 02 4b 8d 04 5b 48 8d [ 10.532771][ C0] RSP: 0018:ffa00000006978a0 EFLAGS: 00000287 [ 10.532772][ C0] RAX: dffffc0000000000 RBX: ffffffffa8eea2a8 RCX: ffffffffa4ddcfc8 [ 10.532772][ C0] RDX: ffffffffa8c6f888 RSI: ffffffffa8c6f83c RDI: 0000000000000000 [ 10.532773][ C0] RBP: 0000000000000001 R08: ffffffffa8c6f870 R09: ffffffffa8c6f884 [ 10.532774][ C0] R10: ffffffffa4ddcfaa R11: ffffffffa8c6f86c R12: ffa0000000697a38 [ 10.532774][ C0] R13: ffa00000006979e0 R14: ff1100000f804740 R15: ff11000001169080 [ 10.532776][ C0] ? __kasan_slab_alloc+0x4a/0x70 [ 10.532777][ C0] ? __kasan_slab_alloc+0x68/0x70 [ 10.532779][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532781][ C0] unwind_next_frame+0x272/0x1ea0 [ 10.532782][ C0] ? __kasan_slab_alloc+0x4b/0x70 [ 10.532784][ C0] ? stack_access_ok+0x1e0/0x1e0 [ 10.532786][ C0] ? __unwind_start+0x42e/0x900 [ 10.532787][ C0] ? write_profile+0xf0/0xf0 [ 10.532789][ C0] arch_stack_walk+0xd7/0x130 [ 10.532791][ C0] ? __kasan_slab_alloc+0x4b/0x70 [ 10.532792][ C0] stack_trace_save+0x93/0xc0 [ 10.532794][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 10.532796][ C0] set_track_prepare+0x62/0x90 [ 10.532798][ C0] ? kasan_quarantine_reduce+0x196/0x240 [ 10.532799][ C0] ? __kasan_slab_alloc+0x4b/0x70 [ 10.532801][ C0] free_to_partial_list+0x1c6/0x310 [ 10.532803][ C0] ? qlist_free_all+0x57/0x110 [ 10.532805][ C0] qlist_free_all+0x5c/0x110 [ 10.532807][ C0] kasan_quarantine_reduce+0x196/0x240 [ 10.532809][ C0] __kasan_slab_alloc+0x4b/0x70 [ 10.532811][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 10.532812][ C0] ? fuse_request_alloc+0x27/0x210 [ 10.532814][ C0] fuse_request_alloc+0x27/0x210 [ 10.532816][ C0] fuse_chan_send+0x78/0x7a0 [ 10.532819][ C0] fuse_file_put+0x286/0x470 [ 10.532820][ C0] ? fuse_file_release+0x57/0x290 [ 10.532821][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 10.532823][ C0] fuse_release+0x12c/0x230 [ 10.532824][ C0] ? security_file_release+0x1f/0x30 [ 10.532826][ C0] __fput+0x36c/0xad0 [ 10.532828][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532829][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.532830][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 10.532832][ C0] ? _raw_spin_unlock_irq+0x28/0x50 [ 10.532833][ C0] ? _raw_spin_unlock_irq+0x33/0x50 [ 10.532835][ C0] task_work_run+0x12b/0x240 [ 10.532836][ C0] ? task_work_cancel+0x30/0x30 [ 10.532838][ C0] ? fput_close_sync+0xde/0x1b0 [ 10.532839][ C0] ? alloc_file_clone+0xe0/0xe0 [ 10.532841][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532842][ C0] ? exit_to_user_mode_loop+0x6d/0x5a0 [ 10.532843][ C0] exit_to_user_mode_loop+0x158/0x5a0 [ 10.532845][ C0] ? rcu_is_watching+0x16/0xd0 [ 10.532846][ C0] do_syscall_64+0x3e3/0x530 [ 10.532848][ C0] ? exc_page_fault+0xee/0x100 [ 10.532850][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.532851][ C0] RIP: 0033:0x7f8f6324cf8b [ 10.532852][ C0] Code: 0f 1e fa 55 48 63 ff 45 31 c9 45 31 c0 31 c9 48 89 e5 48 83 ec 08 6a 01 e8 e2 55 f8 ff c9 c3 f3 0f 1e fa b8 03 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 05 c3 0f 1f 40 00 48 8b 15 39 4e 10 00 f7 d8 [ 10.532853][ C0] RSP: 002b:00007ffde1215378 EFLAGS: 00000297 ORIG_RAX: 0000000000000003 [ 10.532854][ C0] RAX: 0000000000000000 RBX: 000055e44109a4f0 RCX: 00007f8f6324cf8b [ 10.532855][ C0] RDX: 00007f8f63350ec0 RSI: 4969aeaed8c4408b RDI: 0000000000000000 [ 10.532855][ C0] RBP: 00007ffde12153b0 R08: 000055e44109b7f0 R09: 0000000000000110 [ 10.532856][ C0] R10: 0000000000000111 R11: 0000000000000297 R12: 00007f8f63351010 [ 10.532857][ C0] R13: 0000000000000000 R14: 000055e44109a4f0 R15: 000055e44109a120 [ 10.532859][ C0] [ 10.686475][ T206] tun (206) used greatest stack depth: 24512 bytes left