[ 11.420283][ C0] clocksource: Watchdog remote CPU 1 read timed out [ 11.420325][ C0] [ 11.420326][ C0] ======================================================== [ 11.420328][ C0] WARNING: possible irq lock inversion dependency detected [ 11.420330][ C0] 7.2.0-virtme #1 Tainted: G W [ 11.420331][ C0] -------------------------------------------------------- [ 11.420332][ C0] (udev-worker)/89 just changed the state of lock: [ 11.420333][ C0] ffffffff87089660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.420345][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 11.420347][ C0] (fs_reclaim){+.+.}-{0:0} [ 11.420348][ C0] [ 11.420348][ C0] [ 11.420348][ C0] and interrupts could create inverse lock ordering between them. [ 11.420348][ C0] [ 11.420349][ C0] [ 11.420349][ C0] other info that might help us debug this: [ 11.420350][ C0] Possible interrupt unsafe locking scenario: [ 11.420350][ C0] [ 11.420350][ C0] CPU0 CPU1 [ 11.420351][ C0] ---- ---- [ 11.420351][ C0] lock(fs_reclaim); [ 11.420353][ C0] local_irq_disable(); [ 11.420353][ C0] lock(console_owner); [ 11.420354][ C0] lock(fs_reclaim); [ 11.420355][ C0] [ 11.420355][ C0] lock(console_owner); [ 11.420356][ C0] [ 11.420356][ C0] *** DEADLOCK *** [ 11.420356][ C0] [ 11.420356][ C0] locks held by (udev-worker)/89: 6, last CPU#0: [ 11.420358][ C0] #0: ffffffff875891a0 (fill_pool_map-wait-type-override){+.+.}-{3:3}, at: debug_objects_fill_pool+0x34/0x80 [ 11.420364][ C0] #1: ffffffff871b0b00 (rcu_read_lock){....}-{1:3}, at: is_module_text_address+0x26/0x250 [ 11.420369][ C0] #2: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 11.420373][ C0] #3: ffffffff871fe8b8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 11.420377][ C0] #4: ffffffff87199cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.420380][ C0] #5: ffffffff87199d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.420383][ C0] [ 11.420383][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 11.420389][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 11.420391][ C0] HARDIRQ-ON-W at: [ 11.420393][ C0] __lock_acquire+0x388/0xc20 [ 11.420396][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.420398][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.420401][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.420404][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.420408][ C0] workqueue_init+0x2a/0x680 [ 11.420411][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.420414][ C0] kernel_init+0x21/0x150 [ 11.420418][ C0] ret_from_fork+0x474/0x6b0 [ 11.420421][ C0] ret_from_fork_asm+0x11/0x20 [ 11.420425][ C0] SOFTIRQ-ON-W at: [ 11.420425][ C0] __lock_acquire+0x388/0xc20 [ 11.420427][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.420429][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.420430][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.420432][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.420434][ C0] workqueue_init+0x2a/0x680 [ 11.420435][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.420436][ C0] kernel_init+0x21/0x150 [ 11.420438][ C0] ret_from_fork+0x474/0x6b0 [ 11.420439][ C0] ret_from_fork_asm+0x11/0x20 [ 11.420441][ C0] INITIAL USE at: [ 11.420441][ C0] __lock_acquire+0x388/0xc20 [ 11.420443][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.420445][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.420446][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.420448][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.420450][ C0] workqueue_init+0x2a/0x680 [ 11.420451][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.420452][ C0] kernel_init+0x21/0x150 [ 11.420453][ C0] ret_from_fork+0x474/0x6b0 [ 11.420455][ C0] ret_from_fork_asm+0x11/0x20 [ 11.420456][ C0] } [ 11.420457][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 11.420461][ C0] ... acquired at: [ 11.420463][ C0] __lock_acquire+0x518/0xc20 [ 11.420464][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.420466][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.420467][ C0] __kmalloc_noprof+0xd3/0x760 [ 11.420469][ C0] alloc_buf.isra.0+0x4b/0x260 [ 11.420473][ C0] put_chars+0x1e1/0x2f0 [ 11.420475][ C0] hvc_console_print+0x292/0x780 [ 11.420478][ C0] console_emit_next_record+0x252/0x4f0 [ 11.420479][ C0] console_flush_one_record+0x46f/0x710 [ 11.420480][ C0] console_unlock+0xee/0x1f0 [ 11.420481][ C0] vprintk_emit+0x37c/0x3e0 [ 11.420482][ C0] _printk+0xc7/0x100 [ 11.420485][ C0] sock_register+0x12d/0x290 [ 11.420488][ C0] inet6_init+0x1a6/0x3c0 [ 11.420490][ C0] do_one_initcall+0x124/0x4f0 [ 11.420492][ C0] kernel_init_freeable+0x596/0x630 [ 11.420493][ C0] kernel_init+0x21/0x150 [ 11.420495][ C0] ret_from_fork+0x474/0x6b0 [ 11.420496][ C0] ret_from_fork_asm+0x11/0x20 [ 11.420498][ C0] [ 11.420498][ C0] -> (console_owner){..-.}-{0:0} { [ 11.420500][ C0] IN-SOFTIRQ-W at: [ 11.420501][ C0] __lock_acquire+0x388/0xc20 [ 11.420502][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.420504][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.420505][ C0] console_emit_next_record+0x1f4/0x4f0 [ 11.420506][ C0] console_flush_one_record+0x46f/0x710 [ 11.420507][ C0] console_unlock+0xee/0x1f0 [ 11.420509][ C0] vprintk_emit+0x37c/0x3e0 [ 11.420510][ C0] _printk+0xc7/0x100 [ 11.420511][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.420513][ C0] call_timer_fn+0x160/0x4d0 [ 11.420514][ C0] __run_timers+0x68f/0xaa0 [ 11.420516][ C0] run_timer_softirq+0xf0/0x160 [ 11.420517][ C0] handle_softirqs+0x1d3/0x900 [ 11.420520][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.420522][ C0] irq_exit_rcu+0xe/0x30 [ 11.420523][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.420525][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.420527][ C0] lock_release+0x7a/0x1f0 [ 11.420529][ C0] is_module_text_address+0x14f/0x250 [ 11.420531][ C0] kernel_text_address+0x97/0x170 [ 11.420532][ C0] __kernel_text_address+0x12/0x30 [ 11.420534][ C0] unwind_get_return_address+0x67/0xd0 [ 11.420536][ C0] arch_stack_walk+0xed/0x130 [ 11.420538][ C0] stack_trace_save+0x93/0xc0 [ 11.420540][ C0] kasan_save_stack+0x2f/0x50 [ 11.420542][ C0] kasan_save_track+0x14/0x30 [ 11.420543][ C0] __kasan_slab_alloc+0x60/0x70 [ 11.420544][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 11.420546][ C0] kmem_alloc_batch+0x43/0x1c0 [ 11.420547][ C0] fill_pool+0x1ec/0x400 [ 11.420548][ C0] debug_objects_fill_pool+0x5d/0x80 [ 11.420550][ C0] debug_object_activate+0xfc/0x4a0 [ 11.420551][ C0] __call_rcu_common.constprop.0+0x3d/0xa20 [ 11.420554][ C0] kmem_cache_free+0x2e5/0x550 [ 11.420555][ C0] do_sys_openat2+0xff/0x170 [ 11.420559][ C0] __x64_sys_openat+0x10e/0x210 [ 11.420560][ C0] do_syscall_64+0xff/0x530 [ 11.420561][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.420562][ C0] INITIAL USE at: [ 11.420563][ C0] } [ 11.420563][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 11.420567][ C0] ... acquired at: [ 11.420567][ C0] mark_lock+0x1d7/0xa00 [ 11.420569][ C0] mark_usage+0x42/0x170 [ 11.420570][ C0] __lock_acquire+0x388/0xc20 [ 11.420572][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.420574][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.420575][ C0] console_emit_next_record+0x1f4/0x4f0 [ 11.420576][ C0] console_flush_one_record+0x46f/0x710 [ 11.420577][ C0] console_unlock+0xee/0x1f0 [ 11.420578][ C0] vprintk_emit+0x37c/0x3e0 [ 11.420579][ C0] _printk+0xc7/0x100 [ 11.420581][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.420582][ C0] call_timer_fn+0x160/0x4d0 [ 11.420583][ C0] __run_timers+0x68f/0xaa0 [ 11.420584][ C0] run_timer_softirq+0xf0/0x160 [ 11.420585][ C0] handle_softirqs+0x1d3/0x900 [ 11.420587][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.420588][ C0] irq_exit_rcu+0xe/0x30 [ 11.420590][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.420591][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.420593][ C0] lock_release+0x7a/0x1f0 [ 11.420594][ C0] is_module_text_address+0x14f/0x250 [ 11.420595][ C0] kernel_text_address+0x97/0x170 [ 11.420597][ C0] __kernel_text_address+0x12/0x30 [ 11.420598][ C0] unwind_get_return_address+0x67/0xd0 [ 11.420600][ C0] arch_stack_walk+0xed/0x130 [ 11.420601][ C0] stack_trace_save+0x93/0xc0 [ 11.420602][ C0] kasan_save_stack+0x2f/0x50 [ 11.420603][ C0] kasan_save_track+0x14/0x30 [ 11.420604][ C0] __kasan_slab_alloc+0x60/0x70 [ 11.420605][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 11.420607][ C0] kmem_alloc_batch+0x43/0x1c0 [ 11.420608][ C0] fill_pool+0x1ec/0x400 [ 11.420609][ C0] debug_objects_fill_pool+0x5d/0x80 [ 11.420611][ C0] debug_object_activate+0xfc/0x4a0 [ 11.420612][ C0] __call_rcu_common.constprop.0+0x3d/0xa20 [ 11.420613][ C0] kmem_cache_free+0x2e5/0x550 [ 11.420615][ C0] do_sys_openat2+0xff/0x170 [ 11.420617][ C0] __x64_sys_openat+0x10e/0x210 [ 11.420618][ C0] do_syscall_64+0xff/0x530 [ 11.420619][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.420620][ C0] [ 11.420620][ C0] [ 11.420620][ C0] stack backtrace: [ 11.420623][ C0] CPU: 0 UID: 0 PID: 89 Comm: (udev-worker) Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.420626][ C0] Tainted: [W]=WARN [ 11.420627][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.420628][ C0] Call Trace: [ 11.420630][ C0] [ 11.420631][ C0] dump_stack_lvl+0x6f/0xa0 [ 11.420634][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 11.420637][ C0] mark_lock_irq+0x989/0x9c0 [ 11.420638][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 11.420642][ C0] mark_lock+0x1d7/0xa00 [ 11.420644][ C0] mark_usage+0x42/0x170 [ 11.420646][ C0] __lock_acquire+0x388/0xc20 [ 11.420648][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.420650][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 11.420652][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420654][ C0] ? lock_acquire+0x13c/0x160 [ 11.420656][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.420658][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 11.420659][ C0] console_emit_next_record+0x1f4/0x4f0 [ 11.420661][ C0] ? devkmsg_read+0x4e0/0x4e0 [ 11.420663][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420664][ C0] ? lock_acquire+0x13c/0x160 [ 11.420667][ C0] console_flush_one_record+0x46f/0x710 [ 11.420668][ C0] ? console_emit_next_record+0x4f0/0x4f0 [ 11.420670][ C0] ? __lock_acquire+0x518/0xc20 [ 11.420672][ C0] console_unlock+0xee/0x1f0 [ 11.420674][ C0] ? console_flush_one_record+0x710/0x710 [ 11.420675][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420677][ C0] ? lock_acquire+0x60/0x160 [ 11.420679][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.420681][ C0] ? vprintk_emit+0x320/0x3e0 [ 11.420683][ C0] vprintk_emit+0x37c/0x3e0 [ 11.420684][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 11.420687][ C0] ? clocksource_watchdog.part.0+0x4d0/0x540 [ 11.420689][ C0] _printk+0xc7/0x100 [ 11.420690][ C0] ? snapshot_read.cold+0x21/0x21 [ 11.420692][ C0] ? clocksource_watchdog.part.0+0x4d0/0x540 [ 11.420694][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.420697][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.420699][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.420701][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.420703][ C0] call_timer_fn+0x160/0x4d0 [ 11.420704][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 11.420706][ C0] ? debug_object_active_state+0x430/0x430 [ 11.420707][ C0] ? find_held_lock+0x2b/0x80 [ 11.420709][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.420711][ C0] ? mark_held_locks+0x40/0x70 [ 11.420714][ C0] __run_timers+0x68f/0xaa0 [ 11.420715][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.420718][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.420719][ C0] ? __lock_acquire+0x518/0xc20 [ 11.420722][ C0] ? __rwlock_init+0x150/0x150 [ 11.420724][ C0] run_timer_softirq+0xf0/0x160 [ 11.420726][ C0] ? __run_timers+0xaa0/0xaa0 [ 11.420727][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420728][ C0] handle_softirqs+0x1d3/0x900 [ 11.420731][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.420733][ C0] ? _local_bh_enable+0xc0/0xc0 [ 11.420735][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.420737][ C0] irq_exit_rcu+0xe/0x30 [ 11.420739][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.420740][ C0] [ 11.420741][ C0] [ 11.420742][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.420743][ C0] RIP: 0010:lock_release+0x7a/0x1f0 [ 11.420746][ C0] Code: 85 d2 0f 85 84 00 00 00 65 48 8b 05 b0 2b 61 04 8b 80 04 0b 00 00 85 c0 75 72 48 81 3b e0 6f 3b 88 74 69 4c 89 7c 24 18 9c 58 <49> 89 c7 fa 48 c7 c7 47 cb cd 86 e8 66 85 58 02 4c 89 f6 48 89 df [ 11.420748][ C0] RSP: 0018:ffa00000005c76b8 EFLAGS: 00000202 [ 11.420750][ C0] RAX: 0000000000000202 RBX: ffffffff871b0b00 RCX: 0000000000000001 [ 11.420751][ C0] RDX: 0000000000000000 RSI: ffffffff8668f4e0 RDI: ffffffff86d4c980 [ 11.420752][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ff1100000bdd2eb8 [ 11.420753][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: ffa00000005c7808 [ 11.420754][ C0] R13: 0000000000000000 R14: ffffffff83e3e6ba R15: ff1100000249ae20 [ 11.420754][ C0] ? is_module_text_address+0x14a/0x250 [ 11.420758][ C0] is_module_text_address+0x14f/0x250 [ 11.420759][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420761][ C0] kernel_text_address+0x97/0x170 [ 11.420763][ C0] __kernel_text_address+0x12/0x30 [ 11.420764][ C0] ? write_profile+0xf0/0xf0 [ 11.420766][ C0] unwind_get_return_address+0x67/0xd0 [ 11.420768][ C0] arch_stack_walk+0xed/0x130 [ 11.420771][ C0] stack_trace_save+0x93/0xc0 [ 11.420773][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 11.420774][ C0] ? rcu_read_lock_any_held+0x66/0x90 [ 11.420778][ C0] kasan_save_stack+0x2f/0x50 [ 11.420779][ C0] ? kasan_save_stack+0x2f/0x50 [ 11.420780][ C0] ? kasan_save_track+0x14/0x30 [ 11.420781][ C0] ? __kasan_slab_alloc+0x60/0x70 [ 11.420783][ C0] ? kmem_cache_alloc_noprof+0x21f/0x5c0 [ 11.420784][ C0] ? kmem_alloc_batch+0x43/0x1c0 [ 11.420786][ C0] ? fill_pool+0x1ec/0x400 [ 11.420787][ C0] ? debug_objects_fill_pool+0x5d/0x80 [ 11.420788][ C0] ? debug_object_activate+0xfc/0x4a0 [ 11.420790][ C0] ? __call_rcu_common.constprop.0+0x3d/0xa20 [ 11.420791][ C0] ? kmem_cache_free+0x2e5/0x550 [ 11.420793][ C0] ? do_sys_openat2+0xff/0x170 [ 11.420795][ C0] ? __x64_sys_openat+0x10e/0x210 [ 11.420796][ C0] ? do_syscall_64+0xff/0x530 [ 11.420797][ C0] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.420801][ C0] kasan_save_track+0x14/0x30 [ 11.420803][ C0] __kasan_slab_alloc+0x60/0x70 [ 11.420804][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 11.420806][ C0] ? fill_pool+0x200/0x400 [ 11.420808][ C0] ? kmem_alloc_batch+0x43/0x1c0 [ 11.420810][ C0] kmem_alloc_batch+0x43/0x1c0 [ 11.420811][ C0] ? do_sys_openat2+0xff/0x170 [ 11.420813][ C0] fill_pool+0x1ec/0x400 [ 11.420815][ C0] ? debug_objects_fill_pool+0x34/0x80 [ 11.420816][ C0] ? put_objects.isra.0+0x2b0/0x2b0 [ 11.420818][ C0] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.420820][ C0] ? lock_acquire+0x13c/0x160 [ 11.420822][ C0] debug_objects_fill_pool+0x5d/0x80 [ 11.420823][ C0] ? debug_objects_fill_pool+0x34/0x80 [ 11.420825][ C0] ? debug_objects_fill_pool+0x34/0x80 [ 11.420826][ C0] debug_object_activate+0xfc/0x4a0 [ 11.420828][ C0] ? debug_object_free+0x530/0x530 [ 11.420831][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.420833][ C0] ? __remove_object+0x90/0x90 [ 11.420834][ C0] __call_rcu_common.constprop.0+0x3d/0xa20 [ 11.420836][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 11.420838][ C0] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 11.420840][ C0] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 11.420842][ C0] kmem_cache_free+0x2e5/0x550 [ 11.420844][ C0] do_sys_openat2+0xff/0x170 [ 11.420846][ C0] ? build_open_flags+0x6e0/0x6e0 [ 11.420849][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420850][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.420853][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 11.420855][ C0] __x64_sys_openat+0x10e/0x210 [ 11.420856][ C0] ? fput_close_sync+0xde/0x1b0 [ 11.420859][ C0] ? __ia32_sys_open+0x1b0/0x1b0 [ 11.420860][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420862][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.420863][ C0] do_syscall_64+0xff/0x530 [ 11.420865][ C0] ? exc_page_fault+0xee/0x100 [ 11.420866][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.420868][ C0] RIP: 0033:0x7fa40fcef54e [ 11.420870][ C0] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 11.420871][ C0] RSP: 002b:00007ffeac310570 EFLAGS: 00000202 ORIG_RAX: 0000000000000101 [ 11.420873][ C0] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fa40fcef54e [ 11.420874][ C0] RDX: 00000000002a0000 RSI: 00005590e3d1d680 RDI: 0000000000000023 [ 11.420875][ C0] RBP: 00007ffeac310580 R08: 0000000000000000 R09: 0000000000000000 [ 11.420876][ C0] R10: 0000000000000000 R11: 0000000000000202 R12: 00005590e3e68c71 [ 11.420877][ C0] R13: 0000000000000023 R14: 00005590e3d1d680 R15: 0000000000000022 [ 11.420879][ C0] [ 11.420883][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.420884][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 89, name: (udev-worker) [ 11.420885][ C0] preempt_count: 102, expected: 0 [ 11.420886][ C0] RCU nest depth: 1, expected: 0 [ 11.420887][ C0] INFO: lockdep is turned off. [ 11.420887][ C0] irq event stamp: 339693 [ 11.420888][ C0] hardirqs last enabled at (339692): [] __down_trylock_console_sem+0x86/0xa0 [ 11.420891][ C0] hardirqs last disabled at (339693): [] console_emit_next_record+0x3f8/0x4f0 [ 11.420893][ C0] softirqs last enabled at (338838): [] handle_softirqs+0x67c/0x900 [ 11.420894][ C0] softirqs last disabled at (339679): [] __irq_exit_rcu+0x145/0x1c0 [ 11.420896][ C0] Preemption disabled at: [ 11.420897][ C0] [] handle_softirqs+0xf6/0x900 [ 11.420900][ C0] CPU: 0 UID: 0 PID: 89 Comm: (udev-worker) Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.420908][ C0] Tainted: [W]=WARN [ 11.420909][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.420910][ C0] Call Trace: [ 11.420910][ C0] [ 11.420911][ C0] dump_stack_lvl+0x6f/0xa0 [ 11.420913][ C0] ? handle_softirqs+0xf6/0x900 [ 11.420914][ C0] __might_resched.cold+0x1fe/0x2c1 [ 11.420917][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.420920][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420921][ C0] __kmalloc_noprof+0x443/0x760 [ 11.420923][ C0] ? __rwlock_init+0x150/0x150 [ 11.420925][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 11.420927][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 11.420928][ C0] alloc_buf.isra.0+0x4b/0x260 [ 11.420930][ C0] put_chars+0x1e1/0x2f0 [ 11.420933][ C0] ? __send_to_port+0x420/0x420 [ 11.420936][ C0] hvc_console_print+0x292/0x780 [ 11.420938][ C0] ? mark_usage+0x42/0x170 [ 11.420940][ C0] ? __lock_acquire+0x388/0xc20 [ 11.420942][ C0] ? hvc_write+0x3a0/0x3a0 [ 11.420944][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 11.420946][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420948][ C0] ? lock_acquire+0x13c/0x160 [ 11.420950][ C0] console_emit_next_record+0x252/0x4f0 [ 11.420952][ C0] ? devkmsg_read+0x4e0/0x4e0 [ 11.420954][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420955][ C0] ? lock_acquire+0x13c/0x160 [ 11.420957][ C0] console_flush_one_record+0x46f/0x710 [ 11.420959][ C0] ? console_emit_next_record+0x4f0/0x4f0 [ 11.420961][ C0] ? __lock_acquire+0x518/0xc20 [ 11.420963][ C0] console_unlock+0xee/0x1f0 [ 11.420965][ C0] ? console_flush_one_record+0x710/0x710 [ 11.420966][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.420968][ C0] ? lock_acquire+0x60/0x160 [ 11.420970][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.420972][ C0] ? vprintk_emit+0x320/0x3e0 [ 11.420973][ C0] vprintk_emit+0x37c/0x3e0 [ 11.420975][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 11.420977][ C0] ? clocksource_watchdog.part.0+0x4d0/0x540 [ 11.420979][ C0] _printk+0xc7/0x100 [ 11.420981][ C0] ? snapshot_read.cold+0x21/0x21 [ 11.420983][ C0] ? clocksource_watchdog.part.0+0x4d0/0x540 [ 11.420985][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.420987][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.420989][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.420991][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.420993][ C0] call_timer_fn+0x160/0x4d0 [ 11.420994][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 11.420996][ C0] ? debug_object_active_state+0x430/0x430 [ 11.420997][ C0] ? find_held_lock+0x2b/0x80 [ 11.420999][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.421001][ C0] ? mark_held_locks+0x40/0x70 [ 11.421003][ C0] __run_timers+0x68f/0xaa0 [ 11.421004][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.421007][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.421008][ C0] ? __lock_acquire+0x518/0xc20 [ 11.421011][ C0] ? __rwlock_init+0x150/0x150 [ 11.421013][ C0] run_timer_softirq+0xf0/0x160 [ 11.421015][ C0] ? __run_timers+0xaa0/0xaa0 [ 11.421016][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.421018][ C0] handle_softirqs+0x1d3/0x900 [ 11.421020][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.421022][ C0] ? _local_bh_enable+0xc0/0xc0 [ 11.421024][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.421026][ C0] irq_exit_rcu+0xe/0x30 [ 11.421028][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.421029][ C0] [ 11.421030][ C0] [ 11.421031][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.421032][ C0] RIP: 0010:lock_release+0x7a/0x1f0 [ 11.421034][ C0] Code: 85 d2 0f 85 84 00 00 00 65 48 8b 05 b0 2b 61 04 8b 80 04 0b 00 00 85 c0 75 72 48 81 3b e0 6f 3b 88 74 69 4c 89 7c 24 18 9c 58 <49> 89 c7 fa 48 c7 c7 47 cb cd 86 e8 66 85 58 02 4c 89 f6 48 89 df [ 11.421035][ C0] RSP: 0018:ffa00000005c76b8 EFLAGS: 00000202 [ 11.421036][ C0] RAX: 0000000000000202 RBX: ffffffff871b0b00 RCX: 0000000000000001 [ 11.421037][ C0] RDX: 0000000000000000 RSI: ffffffff8668f4e0 RDI: ffffffff86d4c980 [ 11.421038][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ff1100000bdd2eb8 [ 11.421039][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: ffa00000005c7808 [ 11.421039][ C0] R13: 0000000000000000 R14: ffffffff83e3e6ba R15: ff1100000249ae20 [ 11.421040][ C0] ? is_module_text_address+0x14a/0x250 [ 11.421043][ C0] is_module_text_address+0x14f/0x250 [ 11.421045][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.421046][ C0] kernel_text_address+0x97/0x170 [ 11.421048][ C0] __kernel_text_address+0x12/0x30 [ 11.421050][ C0] ? write_profile+0xf0/0xf0 [ 11.421051][ C0] unwind_get_return_address+0x67/0xd0 [ 11.421053][ C0] arch_stack_walk+0xed/0x130 [ 11.421056][ C0] stack_trace_save+0x93/0xc0 [ 11.421058][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 11.421059][ C0] ? rcu_read_lock_any_held+0x66/0x90 [ 11.421062][ C0] kasan_save_stack+0x2f/0x50 [ 11.421063][ C0] ? kasan_save_stack+0x2f/0x50 [ 11.421064][ C0] ? kasan_save_track+0x14/0x30 [ 11.421065][ C0] ? __kasan_slab_alloc+0x60/0x70 [ 11.421066][ C0] ? kmem_cache_alloc_noprof+0x21f/0x5c0 [ 11.421068][ C0] ? kmem_alloc_batch+0x43/0x1c0 [ 11.421070][ C0] ? fill_pool+0x1ec/0x400 [ 11.421071][ C0] ? debug_objects_fill_pool+0x5d/0x80 [ 11.421072][ C0] ? debug_object_activate+0xfc/0x4a0 [ 11.421073][ C0] ? __call_rcu_common.constprop.0+0x3d/0xa20 [ 11.421075][ C0] ? kmem_cache_free+0x2e5/0x550 [ 11.421077][ C0] ? do_sys_openat2+0xff/0x170 [ 11.421079][ C0] ? __x64_sys_openat+0x10e/0x210 [ 11.421080][ C0] ? do_syscall_64+0xff/0x530 [ 11.421081][ C0] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.421085][ C0] kasan_save_track+0x14/0x30 [ 11.421086][ C0] __kasan_slab_alloc+0x60/0x70 [ 11.421088][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 11.421090][ C0] ? fill_pool+0x200/0x400 [ 11.421091][ C0] ? kmem_alloc_batch+0x43/0x1c0 [ 11.421093][ C0] kmem_alloc_batch+0x43/0x1c0 [ 11.421095][ C0] ? do_sys_openat2+0xff/0x170 [ 11.421097][ C0] fill_pool+0x1ec/0x400 [ 11.421099][ C0] ? debug_objects_fill_pool+0x34/0x80 [ 11.421100][ C0] ? put_objects.isra.0+0x2b0/0x2b0 [ 11.421102][ C0] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.421103][ C0] ? lock_acquire+0x13c/0x160 [ 11.421106][ C0] debug_objects_fill_pool+0x5d/0x80 [ 11.421107][ C0] ? debug_objects_fill_pool+0x34/0x80 [ 11.421108][ C0] ? debug_objects_fill_pool+0x34/0x80 [ 11.421110][ C0] debug_object_activate+0xfc/0x4a0 [ 11.421112][ C0] ? debug_object_free+0x530/0x530 [ 11.421114][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.421116][ C0] ? __remove_object+0x90/0x90 [ 11.421117][ C0] __call_rcu_common.constprop.0+0x3d/0xa20 [ 11.421119][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 11.421121][ C0] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 11.421122][ C0] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 11.421124][ C0] kmem_cache_free+0x2e5/0x550 [ 11.421126][ C0] do_sys_openat2+0xff/0x170 [ 11.421128][ C0] ? build_open_flags+0x6e0/0x6e0 [ 11.421131][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.421132][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.421134][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 11.421136][ C0] __x64_sys_openat+0x10e/0x210 [ 11.421137][ C0] ? fput_close_sync+0xde/0x1b0 [ 11.421139][ C0] ? __ia32_sys_open+0x1b0/0x1b0 [ 11.421140][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.421144][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.421146][ C0] do_syscall_64+0xff/0x530 [ 11.421148][ C0] ? exc_page_fault+0xee/0x100 [ 11.421150][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.421152][ C0] RIP: 0033:0x7fa40fcef54e [ 11.421153][ C0] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 11.421154][ C0] RSP: 002b:00007ffeac310570 EFLAGS: 00000202 ORIG_RAX: 0000000000000101 [ 11.421155][ C0] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fa40fcef54e [ 11.421156][ C0] RDX: 00000000002a0000 RSI: 00005590e3d1d680 RDI: 0000000000000023 [ 11.421156][ C0] RBP: 00007ffeac310580 R08: 0000000000000000 R09: 0000000000000000 [ 11.421157][ C0] R10: 0000000000000000 R11: 0000000000000202 R12: 00005590e3e68c71 [ 11.421158][ C0] R13: 0000000000000023 R14: 00005590e3d1d680 R15: 0000000000000022 [ 11.421160][ C0] [ 11.701940][ T197] test-bond1: (slave test-bond0): making interface the new active one [ 11.702317][ T197] test-bond1: (slave test-bond0): Enslaving as an active interface with an up link [ 11.856828][ T205] test-bond1: entered promiscuous mode [ 11.857000][ T205] test-bond0: entered promiscuous mode [ 12.871748][ T205] test-bond1: left promiscuous mode [ 12.871763][ T205] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.871765][ T205] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 205, name: tcpdump [ 12.871767][ T205] preempt_count: 1, expected: 0 [ 12.871768][ T205] RCU nest depth: 0, expected: 0 [ 12.871769][ T205] INFO: lockdep is turned off. [ 12.871770][ T205] irq event stamp: 0 [ 12.871771][ T205] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 12.871775][ T205] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 12.871782][ T205] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 12.871783][ T205] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 12.871785][ T205] Preemption disabled at: [ 12.871786][ T205] [] vprintk_emit+0x31b/0x3e0 [ 12.871793][ T205] CPU: 0 UID: 72 PID: 205 Comm: tcpdump Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.871796][ T205] Tainted: [W]=WARN [ 12.871797][ T205] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.871799][ T205] Call Trace: [ 12.871800][ T205] [ 12.871801][ T205] dump_stack_lvl+0x6f/0xa0 [ 12.871806][ T205] ? vprintk_emit+0x31b/0x3e0 [ 12.871808][ T205] __might_resched.cold+0x1fe/0x2c1 [ 12.871812][ T205] ? __asan_memcpy+0x3c/0x60 [ 12.871815][ T205] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.871818][ T205] ? record_print_text+0x2fc/0x3e0 [ 12.871821][ T205] ? rcu_is_watching+0x16/0xd0 [ 12.871824][ T205] __kmalloc_noprof+0x443/0x760 [ 12.871827][ T205] ? __rwlock_init+0x150/0x150 [ 12.871829][ T205] ? alloc_buf.isra.0+0x4b/0x260 [ 12.871833][ T205] ? do_raw_spin_unlock+0x59/0x250 [ 12.871834][ T205] alloc_buf.isra.0+0x4b/0x260 [ 12.871837][ T205] put_chars+0x1e1/0x2f0 [ 12.871839][ T205] ? __send_to_port+0x420/0x420 [ 12.871841][ T205] ? desc_read+0x219/0x2f0 [ 12.871844][ T205] hvc_console_print+0x292/0x780 [ 12.871849][ T205] ? hvc_write+0x3a0/0x3a0 [ 12.871851][ T205] ? rcu_is_watching+0x16/0xd0 [ 12.871852][ T205] ? rcu_is_watching+0x16/0xd0 [ 12.871853][ T205] ? lock_acquire+0x13c/0x160 [ 12.871856][ T205] console_emit_next_record+0x252/0x4f0 [ 12.871858][ T205] ? devkmsg_read+0x4e0/0x4e0 [ 12.871859][ T205] ? _prb_read_valid+0x6e0/0x6e0 [ 12.871861][ T205] ? __asan_memmove+0x3c/0x60 [ 12.871863][ T205] ? rcu_is_watching+0x16/0xd0 [ 12.871864][ T205] ? rcu_is_watching+0x16/0xd0 [ 12.871865][ T205] ? rcu_is_watching+0x16/0xd0 [ 12.871866][ T205] ? lock_acquire+0x13c/0x160 [ 12.871868][ T205] ? console_flush_one_record+0x111/0x710 [ 12.871870][ T205] console_flush_one_record+0x46f/0x710 [ 12.871872][ T205] ? console_emit_next_record+0x4f0/0x4f0 [ 12.871874][ T205] console_unlock+0xee/0x1f0 [ 12.871875][ T205] ? lock_acquire+0x13c/0x160 [ 12.871877][ T205] ? console_flush_one_record+0x710/0x710 [ 12.871878][ T205] ? rcu_is_watching+0x16/0xd0 [ 12.871879][ T205] ? lock_release+0x184/0x1f0 [ 12.871881][ T205] ? lock_acquire+0x60/0x160 [ 12.871882][ T205] ? sync_exp_reset_tree_hotplug+0x3a0/0x3f0 [ 12.871884][ T205] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.871886][ T205] ? vprintk_emit+0x320/0x3e0 [ 12.871888][ T205] vprintk_emit+0x37c/0x3e0 [ 12.871890][ T205] ? wake_up_klogd_work_func+0x90/0x90 [ 12.871891][ T205] ? is_bpf_text_address+0x3e/0x110 [ 12.871894][ T205] ? kernel_text_address+0x149/0x170 [ 12.871897][ T205] ? __kernel_text_address+0x12/0x30 [ 12.871899][ T205] _printk+0xc7/0x100 [ 12.871902][ T205] ? snapshot_read.cold+0x21/0x21 [ 12.871904][ T205] ? rcu_is_watching+0x16/0xd0 [ 12.871905][ T205] ? netdev_name+0x43/0x60 [ 12.871913][ T205] ? __netdev_printk+0x17f/0x1d0 [ 12.871915][ T205] netdev_info+0xe2/0x116 [ 12.871917][ T205] ? netdev_notice+0x120/0x120 [ 12.871919][ T205] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.871922][ T205] ? ww_mutex_lock+0x160/0x160 [ 12.871924][ T205] ? ref_tracker_alloc+0x430/0x430 [ 12.871927][ T205] ? packet_release+0x363/0xc40 [ 12.871930][ T205] ? __fput+0x363/0xac0 [ 12.871932][ T205] ? mutex_is_locked+0x1c/0x50 [ 12.871934][ T205] __dev_set_promiscuity.cold+0x7a/0x104 [ 12.871937][ T205] netif_set_promiscuity+0x4c/0xc0 [ 12.871941][ T205] dev_set_promiscuity+0xa1/0x230 [ 12.871944][ T205] packet_release+0x4cb/0xc40 [ 12.871946][ T205] ? packet_set_ring+0x1740/0x1740 [ 12.871948][ T205] ? rwsem_down_write_slowpath+0xbe0/0xbe0 [ 12.871950][ T205] __sock_release+0xb8/0x280 [ 12.871954][ T205] sock_close+0x18/0x20 [ 12.871956][ T205] __fput+0x363/0xac0 [ 12.871958][ T205] fput_close_sync+0xde/0x1b0 [ 12.871960][ T205] ? alloc_file_clone+0xe0/0xe0 [ 12.871961][ T205] ? lock_release+0x184/0x1f0 [ 12.871963][ T205] ? do_raw_spin_unlock+0x59/0x250 [ 12.871965][ T205] __x64_sys_close+0x8b/0xf0 [ 12.871967][ T205] do_syscall_64+0xff/0x530 [ 12.871968][ T205] ? exc_page_fault+0xee/0x100 [ 12.871971][ T205] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.871972][ T205] RIP: 0033:0x7fde17afc54e [ 12.871974][ T205] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 12.871976][ T205] RSP: 002b:00007fffba653d40 EFLAGS: 00000202 ORIG_RAX: 0000000000000003 [ 12.871979][ T205] RAX: ffffffffffffffda RBX: 000055ffce8b0690 RCX: 00007fde17afc54e [ 12.871981][ T205] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000005 [ 12.871982][ T205] RBP: 00007fffba653d50 R08: 0000000000000000 R09: 0000000000000000 [ 12.871982][ T205] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000000 [ 12.871983][ T205] R13: 0000000000000000 R14: 000055ffbbfd2800 R15: 0000000000000001 [ 12.871985][ T205] [ 12.886046][ T205] test-bond0: left promiscuous mode [ 14.115024][ T208] test-dummy0: entered promiscuous mode [ 14.115043][ T208] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.115046][ T208] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 208, name: python3 [ 14.115048][ T208] preempt_count: 1, expected: 0 [ 14.115049][ T208] RCU nest depth: 0, expected: 0 [ 14.115050][ T208] INFO: lockdep is turned off. [ 14.115051][ T208] irq event stamp: 0 [ 14.115052][ T208] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 14.115056][ T208] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 14.115062][ T208] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 14.115064][ T208] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 14.115066][ T208] Preemption disabled at: [ 14.115066][ T208] [] vprintk_emit+0x31b/0x3e0 [ 14.115074][ T208] CPU: 1 UID: 0 PID: 208 Comm: python3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.115078][ T208] Tainted: [W]=WARN [ 14.115078][ T208] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.115080][ T208] Call Trace: [ 14.115082][ T208] [ 14.115083][ T208] dump_stack_lvl+0x6f/0xa0 [ 14.115087][ T208] ? vprintk_emit+0x31b/0x3e0 [ 14.115089][ T208] __might_resched.cold+0x1fe/0x2c1 [ 14.115093][ T208] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.115096][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115099][ T208] __kmalloc_noprof+0x443/0x760 [ 14.115103][ T208] ? __rwlock_init+0x150/0x150 [ 14.115105][ T208] ? alloc_buf.isra.0+0x4b/0x260 [ 14.115110][ T208] ? do_raw_spin_unlock+0x59/0x250 [ 14.115111][ T208] alloc_buf.isra.0+0x4b/0x260 [ 14.115113][ T208] put_chars+0x1e1/0x2f0 [ 14.115116][ T208] ? __send_to_port+0x420/0x420 [ 14.115118][ T208] ? console_prepend_replay+0x20/0x20 [ 14.115120][ T208] ? desc_read+0x219/0x2f0 [ 14.115122][ T208] hvc_console_print+0x292/0x780 [ 14.115127][ T208] ? hvc_write+0x3a0/0x3a0 [ 14.115129][ T208] ? __rwlock_init+0x150/0x150 [ 14.115130][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115131][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115133][ T208] console_emit_next_record+0x252/0x4f0 [ 14.115135][ T208] ? devkmsg_read+0x4e0/0x4e0 [ 14.115136][ T208] ? _prb_read_valid+0x6e0/0x6e0 [ 14.115138][ T208] ? __asan_memmove+0x3c/0x60 [ 14.115145][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115147][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115149][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115150][ T208] ? lock_acquire+0x13c/0x160 [ 14.115153][ T208] ? console_flush_one_record+0x111/0x710 [ 14.115154][ T208] console_flush_one_record+0x46f/0x710 [ 14.115156][ T208] ? console_emit_next_record+0x4f0/0x4f0 [ 14.115158][ T208] console_unlock+0xee/0x1f0 [ 14.115160][ T208] ? lock_acquire+0x13c/0x160 [ 14.115161][ T208] ? console_flush_one_record+0x710/0x710 [ 14.115163][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115164][ T208] ? lock_release+0x184/0x1f0 [ 14.115166][ T208] ? lock_acquire+0x60/0x160 [ 14.115167][ T208] ? sync_exp_reset_tree_hotplug+0x3a0/0x3f0 [ 14.115169][ T208] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.115171][ T208] ? vprintk_emit+0x320/0x3e0 [ 14.115173][ T208] vprintk_emit+0x37c/0x3e0 [ 14.115175][ T208] ? wake_up_klogd_work_func+0x90/0x90 [ 14.115176][ T208] ? kasan_save_stack+0x3d/0x50 [ 14.115178][ T208] ? kasan_save_track+0x14/0x30 [ 14.115179][ T208] ? __kasan_kmalloc+0x7b/0x90 [ 14.115180][ T208] ? __kmalloc_cache_noprof+0x29a/0x620 [ 14.115182][ T208] ? packet_mc_add+0x13b/0x890 [ 14.115185][ T208] ? packet_setsockopt+0x1953/0x21e0 [ 14.115187][ T208] ? do_sock_setsockopt+0x115/0x490 [ 14.115191][ T208] _printk+0xc7/0x100 [ 14.115194][ T208] ? snapshot_read.cold+0x21/0x21 [ 14.115196][ T208] ? lock_acquire+0x13c/0x160 [ 14.115197][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115198][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115200][ T208] ? netdev_name+0x43/0x60 [ 14.115202][ T208] ? __netdev_printk+0x17f/0x1d0 [ 14.115204][ T208] netdev_info+0xe2/0x116 [ 14.115206][ T208] ? netdev_notice+0x120/0x120 [ 14.115207][ T208] ? ww_mutex_lock+0x160/0x160 [ 14.115211][ T208] ? trace_contention_end+0x34/0x180 [ 14.115213][ T208] __dev_set_promiscuity.cold+0x7a/0x104 [ 14.115215][ T208] netif_set_promiscuity+0x4c/0xc0 [ 14.115219][ T208] dev_set_promiscuity+0xa1/0x230 [ 14.115222][ T208] ? __asan_memset+0x27/0x50 [ 14.115223][ T208] packet_mc_add+0x54e/0x890 [ 14.115225][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115226][ T208] ? lock_release+0x184/0x1f0 [ 14.115228][ T208] ? __might_fault+0x97/0x140 [ 14.115231][ T208] ? _copy_from_user+0x42/0x90 [ 14.115235][ T208] packet_setsockopt+0x1953/0x21e0 [ 14.115237][ T208] ? packet_bind+0x170/0x170 [ 14.115239][ T208] ? lock_acquire+0x13c/0x160 [ 14.115240][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115242][ T208] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.115245][ T208] ? do_raw_spin_unlock+0x59/0x250 [ 14.115246][ T208] ? trace_hardirqs_on+0x36/0x40 [ 14.115247][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115249][ T208] ? __create_object+0x78/0x110 [ 14.115251][ T208] ? __raw_spin_lock_init+0x44/0x120 [ 14.115252][ T208] ? lockdep_init_map_type+0x5d/0x250 [ 14.115254][ T208] ? trace_kfree+0xd2/0x100 [ 14.115256][ T208] ? file_init_path+0x1e1/0x610 [ 14.115258][ T208] ? kfree+0x22/0x590 [ 14.115261][ T208] do_sock_setsockopt+0x115/0x490 [ 14.115263][ T208] ? put_user_ifreq+0x90/0x90 [ 14.115264][ T208] ? rcu_is_watching+0x16/0xd0 [ 14.115265][ T208] ? lock_release+0x184/0x1f0 [ 14.115267][ T208] ? fd_install+0xb4/0x3d0 [ 14.115271][ T208] __sys_setsockopt+0xe4/0x150 [ 14.115273][ T208] __x64_sys_setsockopt+0xbd/0x180 [ 14.115275][ T208] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.115276][ T208] ? trace_hardirqs_off_finish+0x147/0x1a0 [ 14.115278][ T208] ? trace_hardirqs_on+0x36/0x40 [ 14.115280][ T208] do_syscall_64+0xff/0x530 [ 14.115281][ T208] ? exc_page_fault+0xee/0x100 [ 14.115284][ T208] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.115286][ T208] RIP: 0033:0x7f2bede5d2de [ 14.115288][ T208] Code: 55 48 63 c9 48 63 ff 45 89 c9 48 89 e5 48 83 ec 08 6a 2c e8 94 72 f7 ff c9 c3 66 90 f3 0f 1e fa 49 89 ca b8 36 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 0a c3 66 0f 1f 84 00 00 00 00 00 48 8b 15 e1 [ 14.115290][ T208] RSP: 002b:00007fff05a6bee8 EFLAGS: 00000202 ORIG_RAX: 0000000000000036 [ 14.115294][ T208] RAX: ffffffffffffffda RBX: 00007f2be9d8b740 RCX: 00007f2bede5d2de [ 14.115295][ T208] RDX: 0000000000000001 RSI: 0000000000000107 RDI: 0000000000000006 [ 14.115296][ T208] RBP: 00007fff05a6bf70 R08: 0000000000000010 R09: 00007fff05a6be10 [ 14.115297][ T208] R10: 00007f2be9d97f50 R11: 0000000000000202 R12: 00007f2be9d8c600 [ 14.115298][ T208] R13: 0000000000000003 R14: 00007f2be9d8c600 R15: 00007fff05a6c248 [ 14.115300][ T208] [ 16.183059][ T208] test-dummy0: left promiscuous mode [ 16.183077][ T208] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 16.183079][ T208] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 208, name: python3 [ 16.183081][ T208] preempt_count: 1, expected: 0 [ 16.183082][ T208] RCU nest depth: 0, expected: 0 [ 16.183083][ T208] INFO: lockdep is turned off. [ 16.183084][ T208] irq event stamp: 0 [ 16.183085][ T208] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 16.183089][ T208] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 16.183095][ T208] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 16.183097][ T208] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 16.183099][ T208] Preemption disabled at: [ 16.183099][ T208] [] vprintk_emit+0x31b/0x3e0 [ 16.183106][ T208] CPU: 1 UID: 0 PID: 208 Comm: python3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 16.183110][ T208] Tainted: [W]=WARN [ 16.183111][ T208] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.183112][ T208] Call Trace: [ 16.183113][ T208] [ 16.183115][ T208] dump_stack_lvl+0x6f/0xa0 [ 16.183119][ T208] ? vprintk_emit+0x31b/0x3e0 [ 16.183121][ T208] __might_resched.cold+0x1fe/0x2c1 [ 16.183124][ T208] ? __asan_memcpy+0x3c/0x60 [ 16.183128][ T208] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 16.183130][ T208] ? record_print_text+0x2fc/0x3e0 [ 16.183133][ T208] ? rcu_is_watching+0x16/0xd0 [ 16.183136][ T208] __kmalloc_noprof+0x443/0x760 [ 16.183143][ T208] ? __rwlock_init+0x150/0x150 [ 16.183145][ T208] ? alloc_buf.isra.0+0x4b/0x260 [ 16.183150][ T208] ? do_raw_spin_unlock+0x59/0x250 [ 16.183152][ T208] alloc_buf.isra.0+0x4b/0x260 [ 16.183154][ T208] put_chars+0x1e1/0x2f0 [ 16.183157][ T208] ? __send_to_port+0x420/0x420 [ 16.183159][ T208] ? desc_read+0x219/0x2f0 [ 16.183161][ T208] hvc_console_print+0x292/0x780 [ 16.183166][ T208] ? hvc_write+0x3a0/0x3a0 [ 16.183168][ T208] ? rcu_is_watching+0x16/0xd0 [ 16.183169][ T208] ? rcu_is_watching+0x16/0xd0 [ 16.183170][ T208] ? lock_acquire+0x13c/0x160 [ 16.183173][ T208] console_emit_next_record+0x252/0x4f0 [ 16.183175][ T208] ? devkmsg_read+0x4e0/0x4e0 [ 16.183176][ T208] ? _prb_read_valid+0x6e0/0x6e0 [ 16.183178][ T208] ? __asan_memmove+0x3c/0x60 [ 16.183179][ T208] ? rcu_is_watching+0x16/0xd0 [ 16.183181][ T208] ? rcu_is_watching+0x16/0xd0 [ 16.183182][ T208] ? rcu_is_watching+0x16/0xd0 [ 16.183183][ T208] ? lock_acquire+0x13c/0x160 [ 16.183185][ T208] ? console_flush_one_record+0x111/0x710 [ 16.183186][ T208] console_flush_one_record+0x46f/0x710 [ 16.183188][ T208] ? console_emit_next_record+0x4f0/0x4f0 [ 16.183190][ T208] console_unlock+0xee/0x1f0 [ 16.183192][ T208] ? lock_acquire+0x13c/0x160 [ 16.183194][ T208] ? console_flush_one_record+0x710/0x710 [ 16.183195][ T208] ? rcu_is_watching+0x16/0xd0 [ 16.183196][ T208] ? lock_release+0x184/0x1f0 [ 16.183198][ T208] ? lock_acquire+0x60/0x160 [ 16.183199][ T208] ? sync_exp_reset_tree_hotplug+0x3a0/0x3f0 [ 16.183201][ T208] ? __down_trylock_console_sem+0x5e/0xa0 [ 16.183203][ T208] ? vprintk_emit+0x320/0x3e0 [ 16.183205][ T208] vprintk_emit+0x37c/0x3e0 [ 16.183207][ T208] ? wake_up_klogd_work_func+0x90/0x90 [ 16.183208][ T208] ? dummy_xmit+0x13e/0x1c0 [ 16.183211][ T208] _printk+0xc7/0x100 [ 16.183214][ T208] ? snapshot_read.cold+0x21/0x21 [ 16.183216][ T208] ? __dev_queue_xmit+0x93b/0x1a20 [ 16.183219][ T208] ? rcu_is_watching+0x16/0xd0 [ 16.183220][ T208] ? lock_acquire+0x13c/0x160 [ 16.183222][ T208] ? rcu_is_watching+0x16/0xd0 [ 16.183223][ T208] ? rcu_is_watching+0x16/0xd0 [ 16.183224][ T208] ? netdev_name+0x43/0x60 [ 16.183227][ T208] ? __netdev_printk+0x17f/0x1d0 [ 16.183228][ T208] netdev_info+0xe2/0x116 [ 16.183230][ T208] ? netdev_notice+0x120/0x120 [ 16.183231][ T208] ? lock_acquire+0x13c/0x160 [ 16.183233][ T208] ? ww_mutex_lock+0x160/0x160 [ 16.183236][ T208] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 16.183238][ T208] ? trace_hrtimer_start+0xbf/0x1d0 [ 16.183241][ T208] ? trace_contention_end+0x34/0x180 [ 16.183243][ T208] __dev_set_promiscuity.cold+0x7a/0x104 [ 16.183246][ T208] netif_set_promiscuity+0x4c/0xc0 [ 16.183248][ T208] dev_set_promiscuity+0xa1/0x230 [ 16.183251][ T208] packet_setsockopt+0x1bd1/0x21e0 [ 16.183254][ T208] ? packet_bind+0x170/0x170 [ 16.183256][ T208] ? free_object+0x9/0x80 [ 16.183259][ T208] ? debug_object_free+0x27a/0x530 [ 16.183261][ T208] ? hrtimer_sleeper_start_expires+0x64/0x160 [ 16.183263][ T208] ? rt_mutex_postunlock+0x70/0x70 [ 16.183265][ T208] ? __asan_memset+0x27/0x50 [ 16.183267][ T208] ? hrtimer_nanosleep+0x2b6/0x340 [ 16.183269][ T208] ? nanosleep_copyout+0x120/0x120 [ 16.183271][ T208] do_sock_setsockopt+0x115/0x490 [ 16.183274][ T208] ? hrtimer_hres_workfn+0x20/0x20 [ 16.183275][ T208] ? put_user_ifreq+0x90/0x90 [ 16.183277][ T208] ? common_nsleep_timens+0x83/0x1d0 [ 16.183280][ T208] __sys_setsockopt+0xe4/0x150 [ 16.183283][ T208] __x64_sys_setsockopt+0xbd/0x180 [ 16.183285][ T208] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.183288][ T208] ? trace_hardirqs_off_finish+0x147/0x1a0 [ 16.183289][ T208] ? trace_hardirqs_on+0x36/0x40 [ 16.183291][ T208] do_syscall_64+0xff/0x530 [ 16.183292][ T208] ? exc_page_fault+0xee/0x100 [ 16.183294][ T208] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 16.183296][ T208] RIP: 0033:0x7f2bede5d2de [ 16.183298][ T208] Code: 55 48 63 c9 48 63 ff 45 89 c9 48 89 e5 48 83 ec 08 6a 2c e8 94 72 f7 ff c9 c3 66 90 f3 0f 1e fa 49 89 ca b8 36 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 0a c3 66 0f 1f 84 00 00 00 00 00 48 8b 15 e1 [ 16.183300][ T208] RSP: 002b:00007fff05a6c498 EFLAGS: 00000202 ORIG_RAX: 0000000000000036 [ 16.183304][ T208] RAX: ffffffffffffffda RBX: 00007f2be9d89d50 RCX: 00007f2bede5d2de [ 16.183305][ T208] RDX: 0000000000000002 RSI: 0000000000000107 RDI: 0000000000000006 [ 16.183306][ T208] RBP: 00007fff05a6c520 R08: 0000000000000010 R09: 00007fff05a6c3c0 [ 16.183307][ T208] R10: 00007f2be9da9690 R11: 0000000000000202 R12: 00007f2be9d8c600 [ 16.183308][ T208] R13: 0000000000000003 R14: 00007f2be9d8c600 R15: 00007fff05a6c7f8 [ 16.183310][ T208] [ 16.374752][ T211] test-bond1 (unregistering): (slave test-bond0): Releasing backup interface [ 16.382604][ T211] test-bond1 (unregistering): Released all slaves [ 16.422991][ T212] test-bond0 (unregistering): Released all slaves