[ 14.851451][ T384] cmsg_sender (384) used greatest stack depth: 24416 bytes left [ 14.851470][ T384] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.851472][ T384] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 384, name: cmsg_sender [ 14.851474][ T384] preempt_count: 2, expected: 0 [ 14.851474][ T384] RCU nest depth: 0, expected: 0 [ 14.851475][ T384] locks held by cmsg_sender/384: 5, last CPU#0: [ 14.851477][ T384] #0: ffffffffafe167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 14.851489][ T384] #1: ffffffffaff7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 14.851494][ T384] #2: ffffffffaff7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 14.851501][ T384] #3: ffffffffafe9d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 14.851504][ T384] #4: ffffffffafe9d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 14.851508][ T384] irq event stamp: 28336 [ 14.851509][ T384] hardirqs last enabled at (28335): [] __down_trylock_console_sem+0x86/0xa0 [ 14.851512][ T384] hardirqs last disabled at (28336): [] console_emit_next_record+0x3d4/0x4c0 [ 14.851515][ T384] softirqs last enabled at (28018): [] handle_softirqs+0x67c/0x900 [ 14.851517][ T384] softirqs last disabled at (26541): [] __irq_exit_rcu+0x145/0x1c0 [ 14.851520][ T384] Preemption disabled at: [ 14.851520][ T384] [<0000000000000000>] 0x0 [ 14.851527][ T384] CPU: 0 UID: 0 PID: 384 Comm: cmsg_sender Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.851530][ T384] Tainted: [W]=WARN [ 14.851531][ T384] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.851533][ T384] Call Trace: [ 14.851535][ T384] [ 14.851536][ T384] dump_stack_lvl+0x6f/0xa0 [ 14.851543][ T384] __might_resched.cold+0x1fe/0x2c1 [ 14.851547][ T384] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.851551][ T384] ? __kmalloc_noprof+0xdb/0x760 [ 14.851556][ T384] __kmalloc_noprof+0x443/0x760 [ 14.851557][ T384] ? alloc_buf.isra.0+0x4b/0x260 [ 14.851564][ T384] ? do_raw_spin_unlock+0x59/0x250 [ 14.851567][ T384] alloc_buf.isra.0+0x4b/0x260 [ 14.851570][ T384] put_chars+0x1e1/0x2f0 [ 14.851573][ T384] ? __send_to_port+0x420/0x420 [ 14.851574][ T384] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.851577][ T384] ? validate_chain+0x38b/0xc20 [ 14.851583][ T384] hvc_console_print+0x292/0x780 [ 14.851590][ T384] ? hvc_write+0x3a0/0x3a0 [ 14.851593][ T384] ? rcu_is_watching+0x16/0xd0 [ 14.851595][ T384] ? lock_acquire+0x13c/0x160 [ 14.851599][ T384] console_emit_next_record+0x22f/0x4c0 [ 14.851603][ T384] ? devkmsg_read+0x4b0/0x4b0 [ 14.851604][ T384] ? console_flush_one_record+0x106/0x710 [ 14.851608][ T384] ? rcu_is_watching+0x16/0xd0 [ 14.851609][ T384] ? lock_acquire+0x13c/0x160 [ 14.851613][ T384] console_flush_one_record+0x46f/0x710 [ 14.851617][ T384] ? console_emit_next_record+0x4c0/0x4c0 [ 14.851619][ T384] ? __lock_acquire+0x518/0xc20 [ 14.851624][ T384] console_unlock+0xee/0x1f0 [ 14.851627][ T384] ? console_flush_one_record+0x710/0x710 [ 14.851629][ T384] ? rcu_is_watching+0x16/0xd0 [ 14.851631][ T384] ? lock_acquire+0xe0/0x160 [ 14.851634][ T384] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.851636][ T384] ? vprintk_emit+0x320/0x3e0 [ 14.851639][ T384] vprintk_emit+0x37c/0x3e0 [ 14.851642][ T384] ? wake_up_klogd_work_func+0x90/0x90 [ 14.851645][ T384] ? __lock_acquire+0x518/0xc20 [ 14.851648][ T384] _printk+0xc7/0x100 [ 14.851652][ T384] ? snapshot_read.cold+0x21/0x21 [ 14.851655][ T384] ? do_raw_spin_lock+0x131/0x280 [ 14.851657][ T384] ? __rwlock_init+0x150/0x150 [ 14.851661][ T384] ? do_raw_spin_lock+0x131/0x280 [ 14.851664][ T384] do_exit.cold+0x82/0x9c [ 14.851667][ T384] ? exit_notify+0x890/0x890 [ 14.851669][ T384] ? __lock_release.isra.0+0x69/0x1a0 [ 14.851671][ T384] ? rcu_is_watching+0x16/0xd0 [ 14.851678][ T384] do_group_exit+0xb8/0x370 [ 14.851681][ T384] __x64_sys_exit_group+0x3c/0x50 [ 14.851683][ T384] x64_sys_call+0x1567/0x1570 [ 14.851686][ T384] do_syscall_64+0xff/0x530 [ 14.851690][ T384] ? exc_page_fault+0xee/0x100 [ 14.851693][ T384] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.851695][ T384] RIP: 0033:0x7f21ea81f1b8 [ 14.851697][ T384] Code: Unable to access opcode bytes at 0x7f21ea81f18e. [ 14.851698][ T384] RSP: 002b:00007ffccdc2b358 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 14.851700][ T384] RAX: ffffffffffffffda RBX: 00007f21ea94ff88 RCX: 00007f21ea81f1b8 [ 14.851702][ T384] RDX: 00007f21ea75ca48 RSI: ffffffffffffffb0 RDI: 0000000000000000 [ 14.851703][ T384] RBP: 00007ffccdc2b3b0 R08: 0000000000000000 R09: 0000000000000020 [ 14.851703][ T384] R10: 00007ffccdc2b1f0 R11: 0000000000000246 R12: 0000000000000001 [ 14.851704][ T384] R13: 0000000000000000 R14: 00007f21ea94e680 R15: 00007f21ea94ffa0 [ 14.851711][ T384] [ 17.495814][ C0] clocksource: Watchdog remote CPU 1 read timed out [ 17.495852][ C0] [ 17.495854][ C0] ======================================================== [ 17.495855][ C0] WARNING: possible irq lock inversion dependency detected [ 17.495856][ C0] 7.2.0-virtme #1 Tainted: G W [ 17.495858][ C0] -------------------------------------------------------- [ 17.495858][ C0] cmsg_sender/470 just changed the state of lock: [ 17.495860][ C0] ffffffffafe9d760 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 17.495872][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 17.495873][ C0] (fs_reclaim){+.+.}-{0:0} [ 17.495874][ C0] [ 17.495874][ C0] [ 17.495874][ C0] and interrupts could create inverse lock ordering between them. [ 17.495874][ C0] [ 17.495875][ C0] [ 17.495875][ C0] other info that might help us debug this: [ 17.495875][ C0] Possible interrupt unsafe locking scenario: [ 17.495875][ C0] [ 17.495876][ C0] CPU0 CPU1 [ 17.495876][ C0] ---- ---- [ 17.495877][ C0] lock(fs_reclaim); [ 17.495878][ C0] local_irq_disable(); [ 17.495878][ C0] lock(console_owner); [ 17.495879][ C0] lock(fs_reclaim); [ 17.495880][ C0] [ 17.495880][ C0] lock(console_owner); [ 17.495881][ C0] [ 17.495881][ C0] *** DEADLOCK *** [ 17.495881][ C0] [ 17.495882][ C0] locks held by cmsg_sender/470: 5, last CPU#0: [ 17.495883][ C0] #0: ffffffffb01c5fb8 (remove_cache_srcu){.+.+}-{0:0}, at: kasan_quarantine_reduce+0x84/0x240 [ 17.495889][ C0] #1: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 17.495894][ C0] #2: ffffffffaffe29f8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 17.495897][ C0] #3: ffffffffaff7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 17.495900][ C0] #4: ffffffffaff7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 17.495903][ C0] [ 17.495903][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 17.495908][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 17.495910][ C0] HARDIRQ-ON-W at: [ 17.495912][ C0] __lock_acquire+0x388/0xc20 [ 17.495915][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.495916][ C0] fs_reclaim_acquire+0xd5/0x120 [ 17.495919][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 17.495921][ C0] kthread_create_worker_on_node+0xea/0x210 [ 17.495924][ C0] workqueue_init+0x2a/0x680 [ 17.495928][ C0] kernel_init_freeable+0x2fe/0x630 [ 17.495931][ C0] kernel_init+0x21/0x150 [ 17.495935][ C0] ret_from_fork+0x474/0x6b0 [ 17.495938][ C0] ret_from_fork_asm+0x11/0x20 [ 17.495941][ C0] SOFTIRQ-ON-W at: [ 17.495942][ C0] __lock_acquire+0x388/0xc20 [ 17.495943][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.495945][ C0] fs_reclaim_acquire+0xd5/0x120 [ 17.495946][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 17.495947][ C0] kthread_create_worker_on_node+0xea/0x210 [ 17.495949][ C0] workqueue_init+0x2a/0x680 [ 17.495950][ C0] kernel_init_freeable+0x2fe/0x630 [ 17.495952][ C0] kernel_init+0x21/0x150 [ 17.495953][ C0] ret_from_fork+0x474/0x6b0 [ 17.495954][ C0] ret_from_fork_asm+0x11/0x20 [ 17.495955][ C0] INITIAL USE at: [ 17.495956][ C0] __lock_acquire+0x388/0xc20 [ 17.495958][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.495959][ C0] fs_reclaim_acquire+0xd5/0x120 [ 17.495960][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 17.495961][ C0] kthread_create_worker_on_node+0xea/0x210 [ 17.495963][ C0] workqueue_init+0x2a/0x680 [ 17.495964][ C0] kernel_init_freeable+0x2fe/0x630 [ 17.495965][ C0] kernel_init+0x21/0x150 [ 17.495967][ C0] ret_from_fork+0x474/0x6b0 [ 17.495968][ C0] ret_from_fork_asm+0x11/0x20 [ 17.495969][ C0] } [ 17.495970][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 17.495973][ C0] ... acquired at: [ 17.495974][ C0] __lock_acquire+0x518/0xc20 [ 17.495976][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.495977][ C0] fs_reclaim_acquire+0xd5/0x120 [ 17.495978][ C0] __kmalloc_noprof+0xd3/0x760 [ 17.495979][ C0] alloc_buf.isra.0+0x4b/0x260 [ 17.495983][ C0] put_chars+0x1e1/0x2f0 [ 17.495984][ C0] hvc_console_print+0x292/0x780 [ 17.495987][ C0] console_emit_next_record+0x22f/0x4c0 [ 17.495989][ C0] console_flush_one_record+0x46f/0x710 [ 17.495990][ C0] console_unlock+0xee/0x1f0 [ 17.495992][ C0] vprintk_emit+0x37c/0x3e0 [ 17.495993][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 17.495996][ C0] dev_printk_emit+0xb9/0xee [ 17.495998][ C0] _dev_info+0xe2/0x116 [ 17.495999][ C0] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 17.496002][ C0] cmos_do_probe+0x73b/0x98a [ 17.496004][ C0] platform_probe+0xfe/0x1f0 [ 17.496007][ C0] call_driver_probe+0x61/0x1c0 [ 17.496008][ C0] really_probe+0x199/0x760 [ 17.496009][ C0] __driver_probe_device+0x24f/0x440 [ 17.496010][ C0] driver_probe_device+0x4a/0xf0 [ 17.496012][ C0] __driver_attach+0x1b8/0x540 [ 17.496013][ C0] bus_for_each_dev+0x130/0x1e0 [ 17.496014][ C0] bus_add_driver+0x2c8/0x530 [ 17.496015][ C0] driver_register+0x1a3/0x390 [ 17.496017][ C0] __platform_driver_probe+0x13f/0x270 [ 17.496018][ C0] cmos_init+0x31/0x40 [ 17.496021][ C0] do_one_initcall+0x124/0x4f0 [ 17.496022][ C0] kernel_init_freeable+0x596/0x630 [ 17.496024][ C0] kernel_init+0x21/0x150 [ 17.496025][ C0] ret_from_fork+0x474/0x6b0 [ 17.496026][ C0] ret_from_fork_asm+0x11/0x20 [ 17.496027][ C0] [ 17.496028][ C0] -> (console_owner){..-.}-{0:0} { [ 17.496029][ C0] IN-SOFTIRQ-W at: [ 17.496030][ C0] __lock_acquire+0x388/0xc20 [ 17.496031][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.496033][ C0] console_lock_spinning_enable+0x5c/0x60 [ 17.496034][ C0] console_emit_next_record+0x1d1/0x4c0 [ 17.496036][ C0] console_flush_one_record+0x46f/0x710 [ 17.496038][ C0] console_unlock+0xee/0x1f0 [ 17.496039][ C0] vprintk_emit+0x37c/0x3e0 [ 17.496040][ C0] _printk+0xc7/0x100 [ 17.496043][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 17.496045][ C0] call_timer_fn+0x160/0x4d0 [ 17.496047][ C0] __run_timers+0x68f/0xaa0 [ 17.496049][ C0] run_timer_softirq+0xf0/0x160 [ 17.496050][ C0] handle_softirqs+0x1d3/0x900 [ 17.496053][ C0] __irq_exit_rcu+0x145/0x1c0 [ 17.496054][ C0] irq_exit_rcu+0xe/0x30 [ 17.496055][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 17.496057][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.496059][ C0] lock_release+0xdc/0x1f0 [ 17.496060][ C0] unwind_next_frame+0x696/0x1ea0 [ 17.496062][ C0] arch_stack_walk+0xd7/0x130 [ 17.496064][ C0] stack_trace_save+0x93/0xc0 [ 17.496065][ C0] set_track_prepare+0x62/0x90 [ 17.496067][ C0] free_to_partial_list+0x1c6/0x310 [ 17.496068][ C0] qlist_free_all+0x5c/0x110 [ 17.496070][ C0] kasan_quarantine_reduce+0x196/0x240 [ 17.496071][ C0] __kasan_slab_alloc+0x4b/0x70 [ 17.496073][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 17.496074][ C0] fuse_request_alloc+0x27/0x210 [ 17.496077][ C0] fuse_chan_send+0x78/0x7a0 [ 17.496078][ C0] fuse_file_put+0x286/0x470 [ 17.496079][ C0] fuse_release+0x12c/0x230 [ 17.496081][ C0] __fput+0x36c/0xad0 [ 17.496083][ C0] task_work_run+0x12b/0x240 [ 17.496084][ C0] do_exit+0x614/0xdc0 [ 17.496085][ C0] do_group_exit+0xb8/0x370 [ 17.496086][ C0] __x64_sys_exit_group+0x3c/0x50 [ 17.496088][ C0] x64_sys_call+0x1567/0x1570 [ 17.496089][ C0] do_syscall_64+0xff/0x530 [ 17.496091][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 17.496092][ C0] INITIAL USE at: [ 17.496093][ C0] } [ 17.496094][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 17.496096][ C0] ... acquired at: [ 17.496096][ C0] mark_lock+0x1d7/0xa00 [ 17.496098][ C0] mark_usage+0x42/0x170 [ 17.496099][ C0] __lock_acquire+0x388/0xc20 [ 17.496101][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.496102][ C0] console_lock_spinning_enable+0x5c/0x60 [ 17.496104][ C0] console_emit_next_record+0x1d1/0x4c0 [ 17.496105][ C0] console_flush_one_record+0x46f/0x710 [ 17.496107][ C0] console_unlock+0xee/0x1f0 [ 17.496108][ C0] vprintk_emit+0x37c/0x3e0 [ 17.496109][ C0] _printk+0xc7/0x100 [ 17.496110][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 17.496111][ C0] call_timer_fn+0x160/0x4d0 [ 17.496113][ C0] __run_timers+0x68f/0xaa0 [ 17.496114][ C0] run_timer_softirq+0xf0/0x160 [ 17.496116][ C0] handle_softirqs+0x1d3/0x900 [ 17.496117][ C0] __irq_exit_rcu+0x145/0x1c0 [ 17.496118][ C0] irq_exit_rcu+0xe/0x30 [ 17.496120][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 17.496121][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.496122][ C0] lock_release+0xdc/0x1f0 [ 17.496123][ C0] unwind_next_frame+0x696/0x1ea0 [ 17.496124][ C0] arch_stack_walk+0xd7/0x130 [ 17.496125][ C0] stack_trace_save+0x93/0xc0 [ 17.496126][ C0] set_track_prepare+0x62/0x90 [ 17.496127][ C0] free_to_partial_list+0x1c6/0x310 [ 17.496129][ C0] qlist_free_all+0x5c/0x110 [ 17.496130][ C0] kasan_quarantine_reduce+0x196/0x240 [ 17.496131][ C0] __kasan_slab_alloc+0x4b/0x70 [ 17.496133][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 17.496133][ C0] fuse_request_alloc+0x27/0x210 [ 17.496135][ C0] fuse_chan_send+0x78/0x7a0 [ 17.496136][ C0] fuse_file_put+0x286/0x470 [ 17.496137][ C0] fuse_release+0x12c/0x230 [ 17.496138][ C0] __fput+0x36c/0xad0 [ 17.496140][ C0] task_work_run+0x12b/0x240 [ 17.496141][ C0] do_exit+0x614/0xdc0 [ 17.496142][ C0] do_group_exit+0xb8/0x370 [ 17.496143][ C0] __x64_sys_exit_group+0x3c/0x50 [ 17.496144][ C0] x64_sys_call+0x1567/0x1570 [ 17.496145][ C0] do_syscall_64+0xff/0x530 [ 17.496146][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 17.496148][ C0] [ 17.496148][ C0] [ 17.496148][ C0] stack backtrace: [ 17.496151][ C0] CPU: 0 UID: 0 PID: 470 Comm: cmsg_sender Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 17.496154][ C0] Tainted: [W]=WARN [ 17.496155][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.496157][ C0] Call Trace: [ 17.496158][ C0] [ 17.496159][ C0] dump_stack_lvl+0x6f/0xa0 [ 17.496163][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 17.496166][ C0] mark_lock_irq+0x989/0x9c0 [ 17.496168][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 17.496170][ C0] mark_lock+0x1d7/0xa00 [ 17.496172][ C0] mark_usage+0x42/0x170 [ 17.496174][ C0] __lock_acquire+0x388/0xc20 [ 17.496176][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.496178][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 17.496180][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496182][ C0] ? lock_acquire+0x13c/0x160 [ 17.496184][ C0] console_lock_spinning_enable+0x5c/0x60 [ 17.496186][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 17.496187][ C0] console_emit_next_record+0x1d1/0x4c0 [ 17.496189][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 17.496191][ C0] ? console_flush_one_record+0x106/0x710 [ 17.496193][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496194][ C0] ? lock_acquire+0x13c/0x160 [ 17.496196][ C0] console_flush_one_record+0x46f/0x710 [ 17.496198][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 17.496200][ C0] ? __lock_acquire+0x518/0xc20 [ 17.496203][ C0] console_unlock+0xee/0x1f0 [ 17.496204][ C0] ? console_flush_one_record+0x710/0x710 [ 17.496206][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496207][ C0] ? lock_acquire+0xe0/0x160 [ 17.496209][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 17.496211][ C0] ? vprintk_emit+0x320/0x3e0 [ 17.496212][ C0] vprintk_emit+0x37c/0x3e0 [ 17.496214][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 17.496216][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 17.496217][ C0] _printk+0xc7/0x100 [ 17.496219][ C0] ? snapshot_read.cold+0x21/0x21 [ 17.496221][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 17.496222][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.496225][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 17.496226][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.496228][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.496230][ C0] call_timer_fn+0x160/0x4d0 [ 17.496232][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 17.496233][ C0] ? debug_object_active_state+0x430/0x430 [ 17.496236][ C0] ? find_held_lock+0x2b/0x80 [ 17.496238][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.496240][ C0] ? mark_held_locks+0x40/0x70 [ 17.496242][ C0] __run_timers+0x68f/0xaa0 [ 17.496244][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.496246][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 17.496248][ C0] ? __lock_acquire+0x518/0xc20 [ 17.496251][ C0] ? __rwlock_init+0x150/0x150 [ 17.496253][ C0] run_timer_softirq+0xf0/0x160 [ 17.496256][ C0] ? __run_timers+0xaa0/0xaa0 [ 17.496257][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496258][ C0] handle_softirqs+0x1d3/0x900 [ 17.496260][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.496262][ C0] ? _local_bh_enable+0xc0/0xc0 [ 17.496264][ C0] __irq_exit_rcu+0x145/0x1c0 [ 17.496266][ C0] irq_exit_rcu+0xe/0x30 [ 17.496267][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 17.496268][ C0] [ 17.496269][ C0] [ 17.496270][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.496271][ C0] RIP: 0010:lock_release+0xdc/0x1f0 [ 17.496274][ C0] Code: 6f ed 04 83 f8 01 0f 85 fc 00 00 00 9c 58 f6 c4 02 0f 85 11 01 00 00 41 f7 c7 00 02 00 00 0f 84 c7 00 00 00 fb 4c 8b 7c 24 18 <48> 8b 5c 24 08 4c 8b 74 24 10 48 83 c4 20 c3 65 8b 05 b6 2a ed 04 [ 17.496275][ C0] RSP: 0018:ffa0000002517810 EFLAGS: 00000206 [ 17.496277][ C0] RAX: 0000000000000046 RBX: ffffffffaff94c00 RCX: 0000000000000001 [ 17.496279][ C0] RDX: 0000000000000000 RSI: ffffffffaf4f9f03 RDI: ffffffffaee949e0 [ 17.496280][ C0] RBP: ffa0000002517b60 R08: ffffffffb0ce16a4 R09: ffffffffb0a69c74 [ 17.496280][ C0] R10: 0000000000000000 R11: 0000000000000008 R12: ffa0000002517b01 [ 17.496281][ C0] R13: ffa0000002517938 R14: ffffffffac169c11 R15: ff11000001032400 [ 17.496282][ C0] ? unwind_next_frame+0x691/0x1ea0 [ 17.496285][ C0] unwind_next_frame+0x696/0x1ea0 [ 17.496286][ C0] ? free_to_partial_list+0x1c6/0x310 [ 17.496289][ C0] ? stack_access_ok+0x1e0/0x1e0 [ 17.496291][ C0] ? __unwind_start+0x42e/0x900 [ 17.496292][ C0] ? write_profile+0xf0/0xf0 [ 17.496294][ C0] arch_stack_walk+0xd7/0x130 [ 17.496295][ C0] ? qlist_free_all+0x5c/0x110 [ 17.496297][ C0] stack_trace_save+0x93/0xc0 [ 17.496299][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 17.496301][ C0] set_track_prepare+0x62/0x90 [ 17.496304][ C0] free_to_partial_list+0x1c6/0x310 [ 17.496306][ C0] ? qlist_free_all+0x57/0x110 [ 17.496308][ C0] qlist_free_all+0x5c/0x110 [ 17.496309][ C0] kasan_quarantine_reduce+0x196/0x240 [ 17.496311][ C0] __kasan_slab_alloc+0x4b/0x70 [ 17.496313][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 17.496314][ C0] ? fuse_request_alloc+0x27/0x210 [ 17.496316][ C0] fuse_request_alloc+0x27/0x210 [ 17.496318][ C0] fuse_chan_send+0x78/0x7a0 [ 17.496320][ C0] fuse_file_put+0x286/0x470 [ 17.496322][ C0] ? fuse_file_release+0x57/0x290 [ 17.496323][ C0] fuse_release+0x12c/0x230 [ 17.496325][ C0] ? security_file_release+0x1f/0x30 [ 17.496327][ C0] __fput+0x36c/0xad0 [ 17.496329][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 17.496331][ C0] ? __call_rcu_common.constprop.0+0x3d3/0xa20 [ 17.496333][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 17.496336][ C0] task_work_run+0x12b/0x240 [ 17.496337][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 17.496339][ C0] ? task_work_cancel+0x30/0x30 [ 17.496340][ C0] ? kmem_cache_free+0xf8/0x550 [ 17.496342][ C0] do_exit+0x614/0xdc0 [ 17.496343][ C0] ? exit_notify+0x890/0x890 [ 17.496344][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.496346][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496348][ C0] do_group_exit+0xb8/0x370 [ 17.496349][ C0] __x64_sys_exit_group+0x3c/0x50 [ 17.496350][ C0] x64_sys_call+0x1567/0x1570 [ 17.496352][ C0] do_syscall_64+0xff/0x530 [ 17.496354][ C0] ? exc_page_fault+0xee/0x100 [ 17.496355][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 17.496357][ C0] RIP: 0033:0x7f1f467861b8 [ 17.496359][ C0] Code: Unable to access opcode bytes at 0x7f1f4678618e. [ 17.496360][ C0] RSP: 002b:00007ffd390322a8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 17.496361][ C0] RAX: ffffffffffffffda RBX: 00007f1f468b6f88 RCX: 00007f1f467861b8 [ 17.496362][ C0] RDX: 00007f1f466c3a48 RSI: ffffffffffffffb0 RDI: 0000000000000001 [ 17.496363][ C0] RBP: 00007ffd39032300 R08: 0000000000000000 R09: 0000000000000020 [ 17.496363][ C0] R10: 00007ffd39032140 R11: 0000000000000246 R12: 0000000000000001 [ 17.496364][ C0] R13: 0000000000000001 R14: 00007f1f468b5680 R15: 00007f1f468b6fa0 [ 17.496366][ C0] [ 17.496371][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 17.496372][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 470, name: cmsg_sender [ 17.496373][ C0] preempt_count: 102, expected: 0 [ 17.496374][ C0] RCU nest depth: 1, expected: 0 [ 17.496375][ C0] INFO: lockdep is turned off. [ 17.496375][ C0] irq event stamp: 36799 [ 17.496376][ C0] hardirqs last enabled at (36798): [] __down_trylock_console_sem+0x86/0xa0 [ 17.496378][ C0] hardirqs last disabled at (36799): [] console_emit_next_record+0x3d4/0x4c0 [ 17.496380][ C0] softirqs last enabled at (35916): [] handle_softirqs+0x67c/0x900 [ 17.496382][ C0] softirqs last disabled at (36777): [] __irq_exit_rcu+0x145/0x1c0 [ 17.496383][ C0] Preemption disabled at: [ 17.496384][ C0] [] handle_softirqs+0xf6/0x900 [ 17.496386][ C0] CPU: 0 UID: 0 PID: 470 Comm: cmsg_sender Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 17.496388][ C0] Tainted: [W]=WARN [ 17.496389][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.496389][ C0] Call Trace: [ 17.496390][ C0] [ 17.496390][ C0] dump_stack_lvl+0x6f/0xa0 [ 17.496392][ C0] ? handle_softirqs+0xf6/0x900 [ 17.496394][ C0] __might_resched.cold+0x1fe/0x2c1 [ 17.496397][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 17.496400][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496401][ C0] __kmalloc_noprof+0x443/0x760 [ 17.496402][ C0] ? __rwlock_init+0x150/0x150 [ 17.496404][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 17.496406][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 17.496408][ C0] alloc_buf.isra.0+0x4b/0x260 [ 17.496411][ C0] put_chars+0x1e1/0x2f0 [ 17.496412][ C0] ? __send_to_port+0x420/0x420 [ 17.496414][ C0] ? mark_lock+0x1d7/0xa00 [ 17.496416][ C0] hvc_console_print+0x292/0x780 [ 17.496419][ C0] ? hvc_write+0x3a0/0x3a0 [ 17.496421][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496422][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496423][ C0] console_emit_next_record+0x22f/0x4c0 [ 17.496426][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 17.496427][ C0] ? console_flush_one_record+0x106/0x710 [ 17.496429][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496430][ C0] ? lock_acquire+0x13c/0x160 [ 17.496432][ C0] console_flush_one_record+0x46f/0x710 [ 17.496435][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 17.496436][ C0] ? __lock_acquire+0x518/0xc20 [ 17.496439][ C0] console_unlock+0xee/0x1f0 [ 17.496441][ C0] ? console_flush_one_record+0x710/0x710 [ 17.496442][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496443][ C0] ? lock_acquire+0xe0/0x160 [ 17.496445][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 17.496447][ C0] ? vprintk_emit+0x320/0x3e0 [ 17.496448][ C0] vprintk_emit+0x37c/0x3e0 [ 17.496450][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 17.496451][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 17.496453][ C0] _printk+0xc7/0x100 [ 17.496455][ C0] ? snapshot_read.cold+0x21/0x21 [ 17.496456][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 17.496458][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.496460][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 17.496462][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.496463][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.496465][ C0] call_timer_fn+0x160/0x4d0 [ 17.496467][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 17.496469][ C0] ? debug_object_active_state+0x430/0x430 [ 17.496470][ C0] ? find_held_lock+0x2b/0x80 [ 17.496472][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.496473][ C0] ? mark_held_locks+0x40/0x70 [ 17.496475][ C0] __run_timers+0x68f/0xaa0 [ 17.496477][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.496479][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 17.496481][ C0] ? __lock_acquire+0x518/0xc20 [ 17.496484][ C0] ? __rwlock_init+0x150/0x150 [ 17.496486][ C0] run_timer_softirq+0xf0/0x160 [ 17.496488][ C0] ? __run_timers+0xaa0/0xaa0 [ 17.496490][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496491][ C0] handle_softirqs+0x1d3/0x900 [ 17.496493][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.496494][ C0] ? _local_bh_enable+0xc0/0xc0 [ 17.496499][ C0] __irq_exit_rcu+0x145/0x1c0 [ 17.496500][ C0] irq_exit_rcu+0xe/0x30 [ 17.496502][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 17.496503][ C0] [ 17.496504][ C0] [ 17.496504][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.496506][ C0] RIP: 0010:lock_release+0xdc/0x1f0 [ 17.496507][ C0] Code: 6f ed 04 83 f8 01 0f 85 fc 00 00 00 9c 58 f6 c4 02 0f 85 11 01 00 00 41 f7 c7 00 02 00 00 0f 84 c7 00 00 00 fb 4c 8b 7c 24 18 <48> 8b 5c 24 08 4c 8b 74 24 10 48 83 c4 20 c3 65 8b 05 b6 2a ed 04 [ 17.496508][ C0] RSP: 0018:ffa0000002517810 EFLAGS: 00000206 [ 17.496509][ C0] RAX: 0000000000000046 RBX: ffffffffaff94c00 RCX: 0000000000000001 [ 17.496510][ C0] RDX: 0000000000000000 RSI: ffffffffaf4f9f03 RDI: ffffffffaee949e0 [ 17.496511][ C0] RBP: ffa0000002517b60 R08: ffffffffb0ce16a4 R09: ffffffffb0a69c74 [ 17.496511][ C0] R10: 0000000000000000 R11: 0000000000000008 R12: ffa0000002517b01 [ 17.496512][ C0] R13: ffa0000002517938 R14: ffffffffac169c11 R15: ff11000001032400 [ 17.496513][ C0] ? unwind_next_frame+0x691/0x1ea0 [ 17.496516][ C0] unwind_next_frame+0x696/0x1ea0 [ 17.496517][ C0] ? free_to_partial_list+0x1c6/0x310 [ 17.496520][ C0] ? stack_access_ok+0x1e0/0x1e0 [ 17.496521][ C0] ? __unwind_start+0x42e/0x900 [ 17.496523][ C0] ? write_profile+0xf0/0xf0 [ 17.496524][ C0] arch_stack_walk+0xd7/0x130 [ 17.496526][ C0] ? qlist_free_all+0x5c/0x110 [ 17.496528][ C0] stack_trace_save+0x93/0xc0 [ 17.496530][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 17.496532][ C0] set_track_prepare+0x62/0x90 [ 17.496534][ C0] free_to_partial_list+0x1c6/0x310 [ 17.496536][ C0] ? qlist_free_all+0x57/0x110 [ 17.496538][ C0] qlist_free_all+0x5c/0x110 [ 17.496540][ C0] kasan_quarantine_reduce+0x196/0x240 [ 17.496542][ C0] __kasan_slab_alloc+0x4b/0x70 [ 17.496543][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 17.496544][ C0] ? fuse_request_alloc+0x27/0x210 [ 17.496547][ C0] fuse_request_alloc+0x27/0x210 [ 17.496548][ C0] fuse_chan_send+0x78/0x7a0 [ 17.496550][ C0] fuse_file_put+0x286/0x470 [ 17.496552][ C0] ? fuse_file_release+0x57/0x290 [ 17.496553][ C0] fuse_release+0x12c/0x230 [ 17.496555][ C0] ? security_file_release+0x1f/0x30 [ 17.496556][ C0] __fput+0x36c/0xad0 [ 17.496558][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 17.496559][ C0] ? __call_rcu_common.constprop.0+0x3d3/0xa20 [ 17.496560][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 17.496562][ C0] task_work_run+0x12b/0x240 [ 17.496563][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 17.496565][ C0] ? task_work_cancel+0x30/0x30 [ 17.496566][ C0] ? kmem_cache_free+0xf8/0x550 [ 17.496568][ C0] do_exit+0x614/0xdc0 [ 17.496569][ C0] ? exit_notify+0x890/0x890 [ 17.496570][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.496572][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.496574][ C0] do_group_exit+0xb8/0x370 [ 17.496575][ C0] __x64_sys_exit_group+0x3c/0x50 [ 17.496576][ C0] x64_sys_call+0x1567/0x1570 [ 17.496578][ C0] do_syscall_64+0xff/0x530 [ 17.496580][ C0] ? exc_page_fault+0xee/0x100 [ 17.496581][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 17.496582][ C0] RIP: 0033:0x7f1f467861b8 [ 17.496583][ C0] Code: Unable to access opcode bytes at 0x7f1f4678618e. [ 17.496584][ C0] RSP: 002b:00007ffd390322a8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 17.496585][ C0] RAX: ffffffffffffffda RBX: 00007f1f468b6f88 RCX: 00007f1f467861b8 [ 17.496586][ C0] RDX: 00007f1f466c3a48 RSI: ffffffffffffffb0 RDI: 0000000000000001 [ 17.496586][ C0] RBP: 00007ffd39032300 R08: 0000000000000000 R09: 0000000000000020 [ 17.496587][ C0] R10: 00007ffd39032140 R11: 0000000000000246 R12: 0000000000000001 [ 17.496587][ C0] R13: 0000000000000001 R14: 00007f1f468b5680 R15: 00007f1f468b6fa0 [ 17.496590][ C0]