[ 11.918043][ C0] clocksource: Watchdog remote CPU 2 read timed out [ 11.918194][ C0] [ 11.918196][ C0] ======================================================== [ 11.918197][ C0] WARNING: possible irq lock inversion dependency detected [ 11.918199][ C0] 7.2.0-virtme #1 Tainted: G W [ 11.918200][ C0] -------------------------------------------------------- [ 11.918201][ C0] sh/140 just changed the state of lock: [ 11.918202][ C0] ffffffff9f889660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.918215][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 11.918216][ C0] (fs_reclaim){+.+.}-{0:0} [ 11.918218][ C0] [ 11.918218][ C0] [ 11.918218][ C0] and interrupts could create inverse lock ordering between them. [ 11.918218][ C0] [ 11.918218][ C0] [ 11.918218][ C0] other info that might help us debug this: [ 11.918219][ C0] Possible interrupt unsafe locking scenario: [ 11.918219][ C0] [ 11.918220][ C0] CPU0 CPU1 [ 11.918220][ C0] ---- ---- [ 11.918220][ C0] lock(fs_reclaim); [ 11.918222][ C0] local_irq_disable(); [ 11.918222][ C0] lock(console_owner); [ 11.918223][ C0] lock(fs_reclaim); [ 11.918224][ C0] [ 11.918224][ C0] lock(console_owner); [ 11.918225][ C0] [ 11.918225][ C0] *** DEADLOCK *** [ 11.918225][ C0] [ 11.918226][ C0] locks held by sh/140: 4, last CPU#0: [ 11.918227][ C0] #0: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 11.918233][ C0] #1: ffffffff9f9ce8b8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 11.918237][ C0] #2: ffffffff9f969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.918241][ C0] #3: ffffffff9f969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.918244][ C0] [ 11.918244][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 11.918249][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 11.918252][ C0] HARDIRQ-ON-W at: [ 11.918254][ C0] __lock_acquire+0x388/0xc20 [ 11.918256][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.918258][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.918261][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.918263][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.918266][ C0] workqueue_init+0x2a/0x680 [ 11.918270][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.918272][ C0] kernel_init+0x21/0x150 [ 11.918276][ C0] ret_from_fork+0x474/0x6b0 [ 11.918279][ C0] ret_from_fork_asm+0x11/0x20 [ 11.918282][ C0] SOFTIRQ-ON-W at: [ 11.918283][ C0] __lock_acquire+0x388/0xc20 [ 11.918284][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.918286][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.918287][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.918288][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.918289][ C0] workqueue_init+0x2a/0x680 [ 11.918291][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.918292][ C0] kernel_init+0x21/0x150 [ 11.918293][ C0] ret_from_fork+0x474/0x6b0 [ 11.918294][ C0] ret_from_fork_asm+0x11/0x20 [ 11.918295][ C0] INITIAL USE at: [ 11.918296][ C0] __lock_acquire+0x388/0xc20 [ 11.918298][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.918299][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.918300][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.918301][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.918303][ C0] workqueue_init+0x2a/0x680 [ 11.918304][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.918305][ C0] kernel_init+0x21/0x150 [ 11.918306][ C0] ret_from_fork+0x474/0x6b0 [ 11.918307][ C0] ret_from_fork_asm+0x11/0x20 [ 11.918309][ C0] } [ 11.918309][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 11.918313][ C0] ... acquired at: [ 11.918314][ C0] __lock_acquire+0x518/0xc20 [ 11.918316][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.918317][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.918318][ C0] __kmalloc_noprof+0xd3/0x760 [ 11.918319][ C0] alloc_buf.isra.0+0x4b/0x260 [ 11.918322][ C0] put_chars+0x1e1/0x2f0 [ 11.918324][ C0] hvc_console_print+0x292/0x780 [ 11.918325][ C0] console_emit_next_record+0x22f/0x4c0 [ 11.918327][ C0] console_flush_one_record+0x46f/0x710 [ 11.918329][ C0] console_unlock+0xee/0x1f0 [ 11.918330][ C0] vprintk_emit+0x37c/0x3e0 [ 11.918331][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 11.918335][ C0] dev_printk_emit+0xb9/0xee [ 11.918336][ C0] _dev_info+0xe2/0x116 [ 11.918338][ C0] __devm_rtc_register_device.cold+0x338/0x3a8 [ 11.918341][ C0] cmos_do_probe+0x73b/0x98a [ 11.918343][ C0] platform_probe+0xfe/0x1f0 [ 11.918346][ C0] call_driver_probe+0x61/0x1c0 [ 11.918348][ C0] really_probe+0x199/0x760 [ 11.918349][ C0] __driver_probe_device+0x24f/0x440 [ 11.918351][ C0] driver_probe_device+0x4a/0xf0 [ 11.918352][ C0] __driver_attach+0x1b8/0x540 [ 11.918353][ C0] bus_for_each_dev+0x130/0x1e0 [ 11.918355][ C0] bus_add_driver+0x2c8/0x530 [ 11.918356][ C0] driver_register+0x1a3/0x390 [ 11.918357][ C0] __platform_driver_probe+0x13f/0x270 [ 11.918359][ C0] cmos_init+0x31/0x40 [ 11.918362][ C0] do_one_initcall+0x124/0x4f0 [ 11.918364][ C0] kernel_init_freeable+0x596/0x630 [ 11.918365][ C0] kernel_init+0x21/0x150 [ 11.918366][ C0] ret_from_fork+0x474/0x6b0 [ 11.918367][ C0] ret_from_fork_asm+0x11/0x20 [ 11.918368][ C0] [ 11.918369][ C0] -> (console_owner){..-.}-{0:0} { [ 11.918371][ C0] IN-SOFTIRQ-W at: [ 11.918371][ C0] __lock_acquire+0x388/0xc20 [ 11.918373][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.918374][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.918376][ C0] console_emit_next_record+0x1d1/0x4c0 [ 11.918377][ C0] console_flush_one_record+0x46f/0x710 [ 11.918379][ C0] console_unlock+0xee/0x1f0 [ 11.918380][ C0] vprintk_emit+0x37c/0x3e0 [ 11.918382][ C0] _printk+0xc7/0x100 [ 11.918385][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.918387][ C0] call_timer_fn+0x160/0x4d0 [ 11.918389][ C0] __run_timers+0x68f/0xaa0 [ 11.918390][ C0] run_timer_softirq+0xf0/0x160 [ 11.918392][ C0] handle_softirqs+0x1d3/0x900 [ 11.918394][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.918395][ C0] irq_exit_rcu+0xe/0x30 [ 11.918396][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.918399][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.918400][ C0] rcu_is_watching+0x51/0xd0 [ 11.918403][ C0] lock_acquire+0x13c/0x160 [ 11.918405][ C0] unwind_next_frame+0x192/0x1ea0 [ 11.918407][ C0] __unwind_start+0x42e/0x900 [ 11.918408][ C0] arch_stack_walk+0xb3/0x130 [ 11.918410][ C0] stack_trace_save+0x93/0xc0 [ 11.918412][ C0] kasan_save_stack+0x2f/0x50 [ 11.918414][ C0] kasan_save_track+0x14/0x30 [ 11.918416][ C0] __kasan_slab_alloc+0x60/0x70 [ 11.918417][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 11.918419][ C0] __alloc_object+0x30/0x260 [ 11.918421][ C0] __create_object+0x30/0x110 [ 11.918423][ C0] __kmalloc_noprof+0x4e5/0x760 [ 11.918424][ C0] alloc_pipe_info+0x161/0x4a0 [ 11.918427][ C0] create_pipe_files+0x9b/0x930 [ 11.918429][ C0] __do_pipe_flags+0x3a/0x1b0 [ 11.918431][ C0] do_pipe2+0xa4/0x1b0 [ 11.918432][ C0] __x64_sys_pipe2+0x53/0x90 [ 11.918434][ C0] do_syscall_64+0xff/0x530 [ 11.918435][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.918437][ C0] INITIAL USE at: [ 11.918438][ C0] } [ 11.918438][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 11.918441][ C0] ... acquired at: [ 11.918442][ C0] mark_lock+0x1d7/0xa00 [ 11.918443][ C0] mark_usage+0x42/0x170 [ 11.918444][ C0] __lock_acquire+0x388/0xc20 [ 11.918445][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.918447][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.918448][ C0] console_emit_next_record+0x1d1/0x4c0 [ 11.918450][ C0] console_flush_one_record+0x46f/0x710 [ 11.918451][ C0] console_unlock+0xee/0x1f0 [ 11.918453][ C0] vprintk_emit+0x37c/0x3e0 [ 11.918454][ C0] _printk+0xc7/0x100 [ 11.918456][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.918457][ C0] call_timer_fn+0x160/0x4d0 [ 11.918458][ C0] __run_timers+0x68f/0xaa0 [ 11.918460][ C0] run_timer_softirq+0xf0/0x160 [ 11.918461][ C0] handle_softirqs+0x1d3/0x900 [ 11.918462][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.918463][ C0] irq_exit_rcu+0xe/0x30 [ 11.918465][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.918466][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.918467][ C0] rcu_is_watching+0x51/0xd0 [ 11.918469][ C0] lock_acquire+0x13c/0x160 [ 11.918470][ C0] unwind_next_frame+0x192/0x1ea0 [ 11.918471][ C0] __unwind_start+0x42e/0x900 [ 11.918472][ C0] arch_stack_walk+0xb3/0x130 [ 11.918473][ C0] stack_trace_save+0x93/0xc0 [ 11.918475][ C0] kasan_save_stack+0x2f/0x50 [ 11.918476][ C0] kasan_save_track+0x14/0x30 [ 11.918477][ C0] __kasan_slab_alloc+0x60/0x70 [ 11.918479][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 11.918480][ C0] __alloc_object+0x30/0x260 [ 11.918481][ C0] __create_object+0x30/0x110 [ 11.918483][ C0] __kmalloc_noprof+0x4e5/0x760 [ 11.918484][ C0] alloc_pipe_info+0x161/0x4a0 [ 11.918486][ C0] create_pipe_files+0x9b/0x930 [ 11.918487][ C0] __do_pipe_flags+0x3a/0x1b0 [ 11.918489][ C0] do_pipe2+0xa4/0x1b0 [ 11.918490][ C0] __x64_sys_pipe2+0x53/0x90 [ 11.918492][ C0] do_syscall_64+0xff/0x530 [ 11.918493][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.918494][ C0] [ 11.918495][ C0] [ 11.918495][ C0] stack backtrace: [ 11.918497][ C0] CPU: 0 UID: 0 PID: 140 Comm: sh Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.918501][ C0] Tainted: [W]=WARN [ 11.918502][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.918503][ C0] Call Trace: [ 11.918504][ C0] [ 11.918506][ C0] dump_stack_lvl+0x6f/0xa0 [ 11.918510][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 11.918512][ C0] mark_lock_irq+0x989/0x9c0 [ 11.918514][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 11.918516][ C0] mark_lock+0x1d7/0xa00 [ 11.918518][ C0] mark_usage+0x42/0x170 [ 11.918520][ C0] __lock_acquire+0x388/0xc20 [ 11.918522][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.918524][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 11.918526][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918527][ C0] ? lock_acquire+0x13c/0x160 [ 11.918529][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.918531][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 11.918533][ C0] console_emit_next_record+0x1d1/0x4c0 [ 11.918535][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 11.918536][ C0] ? console_flush_one_record+0x106/0x710 [ 11.918538][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918540][ C0] ? lock_acquire+0x13c/0x160 [ 11.918542][ C0] console_flush_one_record+0x46f/0x710 [ 11.918544][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 11.918546][ C0] ? __lock_acquire+0x518/0xc20 [ 11.918548][ C0] console_unlock+0xee/0x1f0 [ 11.918550][ C0] ? console_flush_one_record+0x710/0x710 [ 11.918552][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918553][ C0] ? lock_acquire+0x60/0x160 [ 11.918562][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.918564][ C0] ? vprintk_emit+0x320/0x3e0 [ 11.918566][ C0] vprintk_emit+0x37c/0x3e0 [ 11.918568][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 11.918571][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 11.918572][ C0] _printk+0xc7/0x100 [ 11.918574][ C0] ? snapshot_read.cold+0x21/0x21 [ 11.918576][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 11.918578][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.918580][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.918581][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.918583][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.918585][ C0] call_timer_fn+0x160/0x4d0 [ 11.918587][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 11.918588][ C0] ? debug_object_active_state+0x430/0x430 [ 11.918592][ C0] ? find_held_lock+0x2b/0x80 [ 11.918593][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.918595][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918597][ C0] __run_timers+0x68f/0xaa0 [ 11.918599][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.918601][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.918603][ C0] ? __lock_acquire+0x518/0xc20 [ 11.918606][ C0] ? __rwlock_init+0x150/0x150 [ 11.918608][ C0] run_timer_softirq+0xf0/0x160 [ 11.918610][ C0] ? __run_timers+0xaa0/0xaa0 [ 11.918611][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.918614][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918616][ C0] handle_softirqs+0x1d3/0x900 [ 11.918617][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.918619][ C0] ? _local_bh_enable+0xc0/0xc0 [ 11.918621][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.918622][ C0] irq_exit_rcu+0xe/0x30 [ 11.918624][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.918625][ C0] [ 11.918626][ C0] [ 11.918627][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.918628][ C0] RIP: 0010:rcu_is_watching+0x51/0xd0 [ 11.918631][ C0] Code: 00 00 00 48 8d 3c c5 80 89 4d 9f 48 ba 00 00 00 00 00 fc ff df 48 89 f9 48 c1 e9 03 80 3c 11 00 75 5b 48 03 1c c5 80 89 4d 9f <48> ba 00 00 00 00 00 fc ff df 48 89 d9 48 c1 e9 03 0f b6 0c 11 48 [ 11.918632][ C0] RSP: 0018:ffa0000000787730 EFLAGS: 00000283 [ 11.918635][ C0] RAX: 0000000000000000 RBX: ff11000035231d10 RCX: 1ffffffff3e9b130 [ 11.918636][ C0] RDX: dffffc0000000000 RSI: ffffffff9ee8d860 RDI: ffffffff9f4d8980 [ 11.918637][ C0] RBP: ffffffff9c55669e R08: 0000000000000000 R09: 0000000000000000 [ 11.918638][ C0] R10: 0000000000000000 R11: fff3fc00000f0f2b R12: 0000000000000000 [ 11.918639][ C0] R13: 0000000000000002 R14: ffffffff9f980b00 R15: 0000000000000000 [ 11.918640][ C0] ? unwind_next_frame+0x17e/0x1ea0 [ 11.918642][ C0] lock_acquire+0x13c/0x160 [ 11.918644][ C0] ? __lock_acquire+0x518/0xc20 [ 11.918646][ C0] unwind_next_frame+0x192/0x1ea0 [ 11.918647][ C0] ? unwind_next_frame+0x17e/0x1ea0 [ 11.918648][ C0] ? __unwind_start+0x357/0x900 [ 11.918650][ C0] ? find_held_lock+0x2/0x80 [ 11.918651][ C0] ? stack_access_ok+0x1e0/0x1e0 [ 11.918652][ C0] ? find_held_lock+0x2b/0x80 [ 11.918654][ C0] ? mark_usage+0x61/0x170 [ 11.918655][ C0] ? get_stack_info_noinstr+0x1a/0x120 [ 11.918657][ C0] ? __lock_acquire+0x518/0xc20 [ 11.918658][ C0] __unwind_start+0x42e/0x900 [ 11.918660][ C0] ? write_profile+0xf0/0xf0 [ 11.918661][ C0] arch_stack_walk+0xb3/0x130 [ 11.918664][ C0] ? __unwind_start+0x357/0x900 [ 11.918666][ C0] stack_trace_save+0x93/0xc0 [ 11.918667][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 11.918669][ C0] kasan_save_stack+0x2f/0x50 [ 11.918675][ C0] kasan_save_track+0x14/0x30 [ 11.918677][ C0] __kasan_slab_alloc+0x60/0x70 [ 11.918679][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 11.918680][ C0] ? __alloc_object+0x30/0x260 [ 11.918683][ C0] __alloc_object+0x30/0x260 [ 11.918684][ C0] __create_object+0x30/0x110 [ 11.918686][ C0] __kmalloc_noprof+0x4e5/0x760 [ 11.918688][ C0] ? alloc_pipe_info+0x161/0x4a0 [ 11.918691][ C0] alloc_pipe_info+0x161/0x4a0 [ 11.918693][ C0] create_pipe_files+0x9b/0x930 [ 11.918695][ C0] __do_pipe_flags+0x3a/0x1b0 [ 11.918697][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.918698][ C0] do_pipe2+0xa4/0x1b0 [ 11.918700][ C0] ? __do_pipe_flags+0x1b0/0x1b0 [ 11.918703][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918705][ C0] __x64_sys_pipe2+0x53/0x90 [ 11.918707][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 11.918708][ C0] ? do_syscall_64+0xa6/0x530 [ 11.918709][ C0] do_syscall_64+0xff/0x530 [ 11.918711][ C0] ? exc_page_fault+0xee/0x100 [ 11.918712][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.918714][ C0] RIP: 0033:0x7fc614a7ed7d [ 11.918716][ C0] Code: 07 31 c0 e9 25 ff ff ff 55 48 8d 3d f5 22 0d 00 48 89 e5 e8 05 92 01 00 0f 1f 44 00 00 f3 0f 1e fa 31 f6 b8 25 01 00 00 0f 05 <48> 3d 00 f0 ff ff 77 0b c3 66 2e 0f 1f 84 00 00 00 00 00 48 8b 15 [ 11.918717][ C0] RSP: 002b:00007ffc5aab61e8 EFLAGS: 00000246 ORIG_RAX: 0000000000000125 [ 11.918719][ C0] RAX: ffffffffffffffda RBX: 00000000ffffffff RCX: 00007fc614a7ed7d [ 11.918720][ C0] RDX: 000055b49f2ea0f0 RSI: 0000000000000000 RDI: 00007ffc5aab6218 [ 11.918721][ C0] RBP: 00007ffc5aab6390 R08: 000055b49f2c2d90 R09: 0000000000000200 [ 11.918722][ C0] R10: 0000000000000201 R11: 0000000000000246 R12: 00007ffc5aab64f0 [ 11.918722][ C0] R13: 0000000000000000 R14: 0000000000000008 R15: 0000000000000000 [ 11.918725][ C0] [ 11.918728][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.918730][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 140, name: sh [ 11.918731][ C0] preempt_count: 103, expected: 0 [ 11.918732][ C0] RCU nest depth: 1, expected: 0 [ 11.918733][ C0] INFO: lockdep is turned off. [ 11.918733][ C0] irq event stamp: 19327 [ 11.918734][ C0] hardirqs last enabled at (19326): [] __down_trylock_console_sem+0x86/0xa0 [ 11.918736][ C0] hardirqs last disabled at (19327): [] console_emit_next_record+0x3d4/0x4c0 [ 11.918738][ C0] softirqs last enabled at (19250): [] restore_fpregs_from_user+0x1cf/0x490 [ 11.918740][ C0] softirqs last disabled at (19313): [] __irq_exit_rcu+0x145/0x1c0 [ 11.918742][ C0] Preemption disabled at: [ 11.918742][ C0] [<0000000000000000>] 0x0 [ 11.918745][ C0] CPU: 0 UID: 0 PID: 140 Comm: sh Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.918747][ C0] Tainted: [W]=WARN [ 11.918747][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.918748][ C0] Call Trace: [ 11.918748][ C0] [ 11.918749][ C0] dump_stack_lvl+0x6f/0xa0 [ 11.918751][ C0] __might_resched.cold+0x1fe/0x2c1 [ 11.918754][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.918757][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918759][ C0] __kmalloc_noprof+0x443/0x760 [ 11.918761][ C0] ? __rwlock_init+0x150/0x150 [ 11.918762][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 11.918764][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 11.918766][ C0] alloc_buf.isra.0+0x4b/0x260 [ 11.918768][ C0] put_chars+0x1e1/0x2f0 [ 11.918770][ C0] ? __send_to_port+0x420/0x420 [ 11.918772][ C0] ? mark_lock+0x1d7/0xa00 [ 11.918774][ C0] hvc_console_print+0x292/0x780 [ 11.918776][ C0] ? hvc_write+0x3a0/0x3a0 [ 11.918778][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918779][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918782][ C0] console_emit_next_record+0x22f/0x4c0 [ 11.918784][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 11.918786][ C0] ? console_flush_one_record+0x106/0x710 [ 11.918787][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918789][ C0] ? lock_acquire+0x13c/0x160 [ 11.918791][ C0] console_flush_one_record+0x46f/0x710 [ 11.918793][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 11.918795][ C0] ? __lock_acquire+0x518/0xc20 [ 11.918797][ C0] console_unlock+0xee/0x1f0 [ 11.918799][ C0] ? console_flush_one_record+0x710/0x710 [ 11.918801][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918803][ C0] ? lock_acquire+0x60/0x160 [ 11.918804][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.918806][ C0] ? vprintk_emit+0x320/0x3e0 [ 11.918808][ C0] vprintk_emit+0x37c/0x3e0 [ 11.918810][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 11.918812][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 11.918814][ C0] _printk+0xc7/0x100 [ 11.918816][ C0] ? snapshot_read.cold+0x21/0x21 [ 11.918818][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 11.918819][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.918822][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.918823][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.918826][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.918828][ C0] call_timer_fn+0x160/0x4d0 [ 11.918831][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 11.918834][ C0] ? debug_object_active_state+0x430/0x430 [ 11.918836][ C0] ? find_held_lock+0x2b/0x80 [ 11.918838][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.918839][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918842][ C0] __run_timers+0x68f/0xaa0 [ 11.918843][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.918846][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.918847][ C0] ? __lock_acquire+0x518/0xc20 [ 11.918850][ C0] ? __rwlock_init+0x150/0x150 [ 11.918852][ C0] run_timer_softirq+0xf0/0x160 [ 11.918854][ C0] ? __run_timers+0xaa0/0xaa0 [ 11.918856][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.918857][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918859][ C0] handle_softirqs+0x1d3/0x900 [ 11.918861][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.918862][ C0] ? _local_bh_enable+0xc0/0xc0 [ 11.918864][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.918866][ C0] irq_exit_rcu+0xe/0x30 [ 11.918867][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.918869][ C0] [ 11.918869][ C0] [ 11.918870][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.918872][ C0] RIP: 0010:rcu_is_watching+0x51/0xd0 [ 11.918874][ C0] Code: 00 00 00 48 8d 3c c5 80 89 4d 9f 48 ba 00 00 00 00 00 fc ff df 48 89 f9 48 c1 e9 03 80 3c 11 00 75 5b 48 03 1c c5 80 89 4d 9f <48> ba 00 00 00 00 00 fc ff df 48 89 d9 48 c1 e9 03 0f b6 0c 11 48 [ 11.918875][ C0] RSP: 0018:ffa0000000787730 EFLAGS: 00000283 [ 11.918876][ C0] RAX: 0000000000000000 RBX: ff11000035231d10 RCX: 1ffffffff3e9b130 [ 11.918877][ C0] RDX: dffffc0000000000 RSI: ffffffff9ee8d860 RDI: ffffffff9f4d8980 [ 11.918877][ C0] RBP: ffffffff9c55669e R08: 0000000000000000 R09: 0000000000000000 [ 11.918878][ C0] R10: 0000000000000000 R11: fff3fc00000f0f2b R12: 0000000000000000 [ 11.918879][ C0] R13: 0000000000000002 R14: ffffffff9f980b00 R15: 0000000000000000 [ 11.918880][ C0] ? unwind_next_frame+0x17e/0x1ea0 [ 11.918882][ C0] lock_acquire+0x13c/0x160 [ 11.918884][ C0] ? __lock_acquire+0x518/0xc20 [ 11.918886][ C0] unwind_next_frame+0x192/0x1ea0 [ 11.918887][ C0] ? unwind_next_frame+0x17e/0x1ea0 [ 11.918888][ C0] ? __unwind_start+0x357/0x900 [ 11.918890][ C0] ? find_held_lock+0x2/0x80 [ 11.918891][ C0] ? stack_access_ok+0x1e0/0x1e0 [ 11.918893][ C0] ? find_held_lock+0x2b/0x80 [ 11.918894][ C0] ? mark_usage+0x61/0x170 [ 11.918895][ C0] ? get_stack_info_noinstr+0x1a/0x120 [ 11.918900][ C0] ? __lock_acquire+0x518/0xc20 [ 11.918902][ C0] __unwind_start+0x42e/0x900 [ 11.918903][ C0] ? write_profile+0xf0/0xf0 [ 11.918905][ C0] arch_stack_walk+0xb3/0x130 [ 11.918908][ C0] ? __unwind_start+0x357/0x900 [ 11.918909][ C0] stack_trace_save+0x93/0xc0 [ 11.918911][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 11.918913][ C0] kasan_save_stack+0x2f/0x50 [ 11.918919][ C0] kasan_save_track+0x14/0x30 [ 11.918920][ C0] __kasan_slab_alloc+0x60/0x70 [ 11.918922][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 11.918924][ C0] ? __alloc_object+0x30/0x260 [ 11.918926][ C0] __alloc_object+0x30/0x260 [ 11.918928][ C0] __create_object+0x30/0x110 [ 11.918930][ C0] __kmalloc_noprof+0x4e5/0x760 [ 11.918932][ C0] ? alloc_pipe_info+0x161/0x4a0 [ 11.918934][ C0] alloc_pipe_info+0x161/0x4a0 [ 11.918936][ C0] create_pipe_files+0x9b/0x930 [ 11.918939][ C0] __do_pipe_flags+0x3a/0x1b0 [ 11.918941][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.918942][ C0] do_pipe2+0xa4/0x1b0 [ 11.918944][ C0] ? __do_pipe_flags+0x1b0/0x1b0 [ 11.918947][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.918949][ C0] __x64_sys_pipe2+0x53/0x90 [ 11.918951][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 11.918952][ C0] ? do_syscall_64+0xa6/0x530 [ 11.918953][ C0] do_syscall_64+0xff/0x530 [ 11.918954][ C0] ? exc_page_fault+0xee/0x100 [ 11.918956][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.918957][ C0] RIP: 0033:0x7fc614a7ed7d [ 11.918959][ C0] Code: 07 31 c0 e9 25 ff ff ff 55 48 8d 3d f5 22 0d 00 48 89 e5 e8 05 92 01 00 0f 1f 44 00 00 f3 0f 1e fa 31 f6 b8 25 01 00 00 0f 05 <48> 3d 00 f0 ff ff 77 0b c3 66 2e 0f 1f 84 00 00 00 00 00 48 8b 15 [ 11.918959][ C0] RSP: 002b:00007ffc5aab61e8 EFLAGS: 00000246 ORIG_RAX: 0000000000000125 [ 11.918961][ C0] RAX: ffffffffffffffda RBX: 00000000ffffffff RCX: 00007fc614a7ed7d [ 11.918961][ C0] RDX: 000055b49f2ea0f0 RSI: 0000000000000000 RDI: 00007ffc5aab6218 [ 11.918962][ C0] RBP: 00007ffc5aab6390 R08: 000055b49f2c2d90 R09: 0000000000000200 [ 11.918963][ C0] R10: 0000000000000201 R11: 0000000000000246 R12: 00007ffc5aab64f0 [ 11.918963][ C0] R13: 0000000000000000 R14: 0000000000000008 R15: 0000000000000000 [ 11.918965][ C0] [ 14.161957][ T268] br1: port 1(vx1) entered blocking state [ 14.161972][ T268] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.161974][ T268] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 268, name: ip [ 14.161975][ T268] preempt_count: 1, expected: 0 [ 14.161976][ T268] RCU nest depth: 0, expected: 0 [ 14.161977][ T268] INFO: lockdep is turned off. [ 14.161978][ T268] irq event stamp: 0 [ 14.161979][ T268] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 14.161983][ T268] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 14.161990][ T268] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 14.161992][ T268] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 14.161993][ T268] Preemption disabled at: [ 14.161994][ T268] [] vprintk_emit+0x31b/0x3e0 [ 14.162001][ T268] CPU: 0 UID: 0 PID: 268 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.162005][ T268] Tainted: [W]=WARN [ 14.162006][ T268] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.162007][ T268] Call Trace: [ 14.162009][ T268] [ 14.162010][ T268] dump_stack_lvl+0x6f/0xa0 [ 14.162015][ T268] ? vprintk_emit+0x31b/0x3e0 [ 14.162017][ T268] __might_resched.cold+0x1fe/0x2c1 [ 14.162021][ T268] ? __module_address+0x36/0x330 [ 14.162025][ T268] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.162028][ T268] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 14.162029][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162033][ T268] __kmalloc_noprof+0x443/0x760 [ 14.162037][ T268] ? __rwlock_init+0x150/0x150 [ 14.162039][ T268] ? alloc_buf.isra.0+0x4b/0x260 [ 14.162043][ T268] ? do_raw_spin_unlock+0x59/0x250 [ 14.162045][ T268] alloc_buf.isra.0+0x4b/0x260 [ 14.162047][ T268] put_chars+0x1e1/0x2f0 [ 14.162049][ T268] ? prb_final_commit+0x50/0x50 [ 14.162050][ T268] ? __send_to_port+0x420/0x420 [ 14.162052][ T268] ? printk_get_next_message+0x240/0x650 [ 14.162054][ T268] hvc_console_print+0x292/0x780 [ 14.162058][ T268] ? hvc_write+0x3a0/0x3a0 [ 14.162059][ T268] ? do_raw_spin_lock+0x131/0x280 [ 14.162061][ T268] ? vsnprintf+0x668/0x1700 [ 14.162064][ T268] ? __rwlock_init+0x150/0x150 [ 14.162066][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162067][ T268] ? lock_acquire+0x13c/0x160 [ 14.162070][ T268] console_emit_next_record+0x22f/0x4c0 [ 14.162072][ T268] ? devkmsg_read+0x4b0/0x4b0 [ 14.162074][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162076][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162077][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162079][ T268] ? lock_acquire+0x13c/0x160 [ 14.162081][ T268] ? console_flush_one_record+0x111/0x710 [ 14.162083][ T268] console_flush_one_record+0x46f/0x710 [ 14.162085][ T268] ? console_emit_next_record+0x4c0/0x4c0 [ 14.162088][ T268] console_unlock+0xee/0x1f0 [ 14.162089][ T268] ? lock_acquire+0x13c/0x160 [ 14.162091][ T268] ? console_flush_one_record+0x710/0x710 [ 14.162093][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162094][ T268] ? lock_release+0x184/0x1f0 [ 14.162096][ T268] ? lock_acquire+0x60/0x160 [ 14.162097][ T268] ? __rcu_read_lock+0x30/0x70 [ 14.162099][ T268] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.162102][ T268] ? vprintk_emit+0x320/0x3e0 [ 14.162104][ T268] vprintk_emit+0x37c/0x3e0 [ 14.162106][ T268] ? wake_up_klogd_work_func+0x90/0x90 [ 14.162108][ T268] ? __rwlock_init+0x150/0x150 [ 14.162110][ T268] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 14.162113][ T268] ? lock_acquire+0x13c/0x160 [ 14.162114][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162116][ T268] _printk+0xc7/0x100 [ 14.162120][ T268] ? snapshot_read.cold+0x21/0x21 [ 14.162122][ T268] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 14.162134][ T268] ? do_setlink.isra.0+0xa31/0x2750 [ 14.162136][ T268] ? rtnl_newlink+0x9f1/0x11c0 [ 14.162138][ T268] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 14.162140][ T268] br_set_state+0x22f/0x430 [bridge] [ 14.162148][ T268] br_init_port+0xc4/0x200 [bridge] [ 14.162156][ T268] new_nbp+0x39c/0x580 [bridge] [ 14.162163][ T268] br_add_if+0x212/0x1320 [bridge] [ 14.162170][ T268] ? bpf_address_lookup+0x250/0x290 [ 14.162174][ T268] ? is_bpf_text_address+0x72/0x110 [ 14.162176][ T268] ? kernel_text_address+0x149/0x170 [ 14.162178][ T268] ? __kernel_text_address+0x12/0x30 [ 14.162180][ T268] do_set_master+0x357/0x580 [ 14.162183][ T268] do_setlink.isra.0+0xa31/0x2750 [ 14.162185][ T268] ? stack_trace_save+0x93/0xc0 [ 14.162187][ T268] ? rtnl_link_get_size+0x350/0x350 [ 14.162188][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162189][ T268] ? stack_depot_save_flags+0x1bc/0x790 [ 14.162193][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162195][ T268] ? lock_acquire+0x13c/0x160 [ 14.162196][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162198][ T268] ? kasan_save_stack+0x3d/0x50 [ 14.162201][ T268] ? lock_release+0x184/0x1f0 [ 14.162202][ T268] ? kvm_clock_get_cycles+0x19/0x30 [ 14.162205][ T268] ? ktime_get+0x1dd/0x2d0 [ 14.162208][ T268] ? ___sys_sendmsg+0x14e/0x1d0 [ 14.162210][ T268] ? __sys_sendmsg+0x12c/0x1d0 [ 14.162212][ T268] ? do_syscall_64+0xff/0x530 [ 14.162214][ T268] ? clockevents_program_event+0x307/0x7e0 [ 14.162218][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162220][ T268] ? lock_acquire+0x13c/0x160 [ 14.162221][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162223][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162224][ T268] ? trace_contention_end+0xb3/0x180 [ 14.162228][ T268] ? __mutex_lock+0x1db/0x1ea0 [ 14.162229][ T268] ? __mutex_lock+0x9a3/0x1ea0 [ 14.162230][ T268] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.162233][ T268] ? rtnl_newlink+0x9a8/0x11c0 [ 14.162234][ T268] ? _raw_spin_unlock+0x2d/0x50 [ 14.162235][ T268] ? trace_hardirqs_on+0x36/0x40 [ 14.162236][ T268] ? irqentry_exit+0x21c/0x790 [ 14.162238][ T268] ? ww_mutex_lock+0x160/0x160 [ 14.162241][ T268] ? __rtnl_newlink+0x3fa/0xa50 [ 14.162243][ T268] rtnl_newlink+0x9f1/0x11c0 [ 14.162245][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162246][ T268] ? rtnl_bridge_getlink+0x850/0x850 [ 14.162248][ T268] ? lock_acquire+0x13c/0x160 [ 14.162249][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162251][ T268] ? is_bpf_text_address+0x3e/0x110 [ 14.162253][ T268] ? is_bpf_text_address+0x72/0x110 [ 14.162254][ T268] ? kernel_text_address+0x149/0x170 [ 14.162256][ T268] ? __kernel_text_address+0x12/0x30 [ 14.162257][ T268] ? write_profile+0xf0/0xf0 [ 14.162258][ T268] ? unwind_get_return_address+0x67/0xd0 [ 14.162260][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162261][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162263][ T268] ? cap_capable+0x1d7/0x3d0 [ 14.162267][ T268] ? lock_acquire+0x13c/0x160 [ 14.162268][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162270][ T268] ? rtnl_bridge_getlink+0x850/0x850 [ 14.162271][ T268] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 14.162273][ T268] ? rtnl_link_fill+0x920/0x920 [ 14.162274][ T268] ? filter_irq_stacks+0xd0/0xd0 [ 14.162276][ T268] ? stack_depot_save_flags+0x1bc/0x790 [ 14.162278][ T268] netlink_rcv_skb+0x14e/0x3a0 [ 14.162281][ T268] ? rtnl_link_fill+0x920/0x920 [ 14.162282][ T268] ? lock_release+0x184/0x1f0 [ 14.162284][ T268] ? netlink_ack+0xcf0/0xcf0 [ 14.162285][ T268] ? __netlink_lookup+0xb9/0x6b0 [ 14.162287][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162289][ T268] ? lock_release+0x184/0x1f0 [ 14.162291][ T268] netlink_unicast+0x486/0x750 [ 14.162293][ T268] ? netlink_attachskb+0x810/0x810 [ 14.162295][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162296][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162298][ T268] ? lock_acquire+0x13c/0x160 [ 14.162300][ T268] netlink_sendmsg+0x735/0xc60 [ 14.162302][ T268] ? netlink_unicast+0x750/0x750 [ 14.162304][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162305][ T268] ? lock_release+0x184/0x1f0 [ 14.162307][ T268] ____sys_sendmsg+0x415/0x880 [ 14.162309][ T268] ? copy_msghdr_from_user+0x279/0x420 [ 14.162310][ T268] ? get_timestamp.constprop.0+0x390/0x390 [ 14.162312][ T268] ? move_addr_to_kernel+0x40/0x40 [ 14.162313][ T268] ? filter_irq_stacks+0xd0/0xd0 [ 14.162316][ T268] ___sys_sendmsg+0x14e/0x1d0 [ 14.162317][ T268] ? copy_msghdr_from_user+0x420/0x420 [ 14.162323][ T268] __sys_sendmsg+0x12c/0x1d0 [ 14.162324][ T268] ? __sys_sendmsg_sock+0x20/0x20 [ 14.162327][ T268] ? rcu_is_watching+0x16/0xd0 [ 14.162329][ T268] do_syscall_64+0xff/0x530 [ 14.162331][ T268] ? exc_page_fault+0xee/0x100 [ 14.162332][ T268] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.162335][ T268] RIP: 0033:0x7f6b68c3854e [ 14.162337][ T268] 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 [ 14.162338][ T268] RSP: 002b:00007ffe37142980 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 14.162342][ T268] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f6b68c3854e [ 14.162343][ T268] RDX: 0000000000000000 RSI: 00007ffe37142a30 RDI: 0000000000000005 [ 14.162344][ T268] RBP: 00007ffe37142990 R08: 0000000000000000 R09: 0000000000000000 [ 14.162345][ T268] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90d90b [ 14.162346][ T268] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe371430f0 [ 14.162348][ T268] [ 14.190824][ T268] br1: port 1(vx1) entered disabled state [ 14.191039][ T268] vx1: entered allmulticast mode [ 14.191974][ T268] vx1: entered promiscuous mode [ 14.192454][ T268] br1: port 1(vx1) entered blocking state [ 14.192618][ T268] br1: port 1(vx1) entered forwarding state [ 14.205197][ T268] ip (268) used greatest stack depth: 23336 bytes left [ 14.222453][ T270] br1: port 2(veth1) entered blocking state [ 14.222666][ T270] br1: port 2(veth1) entered disabled state [ 14.222861][ T270] veth1: entered allmulticast mode [ 14.223757][ T270] veth1: entered promiscuous mode [ 14.248082][ T63] br1: port 2(veth1) entered blocking state [ 14.248406][ T63] br1: port 2(veth1) entered forwarding state [ 14.318650][ T273] br1: port 3(veth2) entered blocking state [ 14.319047][ T273] br1: port 3(veth2) entered disabled state [ 14.319413][ T273] veth2: entered allmulticast mode [ 14.321623][ T273] veth2: entered promiscuous mode [ 14.347303][ T63] br1: port 3(veth2) entered blocking state [ 14.347617][ T63] br1: port 3(veth2) entered forwarding state [ 15.297382][ T318] br2: port 1(w1) entered blocking state [ 15.297397][ T318] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.297399][ T318] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 318, name: ip [ 15.297401][ T318] preempt_count: 1, expected: 0 [ 15.297401][ T318] RCU nest depth: 0, expected: 0 [ 15.297402][ T318] INFO: lockdep is turned off. [ 15.297403][ T318] irq event stamp: 0 [ 15.297404][ T318] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 15.297409][ T318] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 15.297415][ T318] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 15.297417][ T318] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 15.297419][ T318] Preemption disabled at: [ 15.297419][ T318] [] vprintk_emit+0x31b/0x3e0 [ 15.297427][ T318] CPU: 0 UID: 0 PID: 318 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.297430][ T318] Tainted: [W]=WARN [ 15.297431][ T318] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.297433][ T318] Call Trace: [ 15.297434][ T318] [ 15.297436][ T318] dump_stack_lvl+0x6f/0xa0 [ 15.297441][ T318] ? vprintk_emit+0x31b/0x3e0 [ 15.297443][ T318] __might_resched.cold+0x1fe/0x2c1 [ 15.297447][ T318] ? __module_address+0x36/0x330 [ 15.297450][ T318] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.297454][ T318] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 15.297455][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297459][ T318] __kmalloc_noprof+0x443/0x760 [ 15.297462][ T318] ? __rwlock_init+0x150/0x150 [ 15.297465][ T318] ? alloc_buf.isra.0+0x4b/0x260 [ 15.297469][ T318] ? do_raw_spin_unlock+0x59/0x250 [ 15.297470][ T318] alloc_buf.isra.0+0x4b/0x260 [ 15.297472][ T318] put_chars+0x1e1/0x2f0 [ 15.297474][ T318] ? prb_final_commit+0x50/0x50 [ 15.297475][ T318] ? __send_to_port+0x420/0x420 [ 15.297477][ T318] ? printk_get_next_message+0x240/0x650 [ 15.297480][ T318] hvc_console_print+0x292/0x780 [ 15.297483][ T318] ? hvc_write+0x3a0/0x3a0 [ 15.297484][ T318] ? do_raw_spin_lock+0x131/0x280 [ 15.297486][ T318] ? vsnprintf+0x668/0x1700 [ 15.297489][ T318] ? __rwlock_init+0x150/0x150 [ 15.297491][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297493][ T318] ? lock_acquire+0x13c/0x160 [ 15.297495][ T318] console_emit_next_record+0x22f/0x4c0 [ 15.297497][ T318] ? devkmsg_read+0x4b0/0x4b0 [ 15.297499][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297501][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297503][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297504][ T318] ? lock_acquire+0x13c/0x160 [ 15.297506][ T318] ? console_flush_one_record+0x111/0x710 [ 15.297508][ T318] console_flush_one_record+0x46f/0x710 [ 15.297510][ T318] ? console_emit_next_record+0x4c0/0x4c0 [ 15.297513][ T318] console_unlock+0xee/0x1f0 [ 15.297515][ T318] ? lock_acquire+0x13c/0x160 [ 15.297516][ T318] ? console_flush_one_record+0x710/0x710 [ 15.297518][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297519][ T318] ? lock_release+0x184/0x1f0 [ 15.297521][ T318] ? lock_acquire+0x60/0x160 [ 15.297522][ T318] ? __rcu_read_lock+0x30/0x70 [ 15.297524][ T318] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.297526][ T318] ? vprintk_emit+0x320/0x3e0 [ 15.297528][ T318] vprintk_emit+0x37c/0x3e0 [ 15.297531][ T318] ? wake_up_klogd_work_func+0x90/0x90 [ 15.297533][ T318] ? __rwlock_init+0x150/0x150 [ 15.297535][ T318] ? filter_irq_stacks+0xd0/0xd0 [ 15.297536][ T318] ? lock_acquire+0x13c/0x160 [ 15.297538][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297540][ T318] _printk+0xc7/0x100 [ 15.297543][ T318] ? snapshot_read.cold+0x21/0x21 [ 15.297545][ T318] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 15.297558][ T318] ? do_setlink.isra.0+0xa31/0x2750 [ 15.297560][ T318] ? rtnl_newlink+0x9f1/0x11c0 [ 15.297561][ T318] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 15.297563][ T318] br_set_state+0x22f/0x430 [bridge] [ 15.297572][ T318] br_init_port+0xc4/0x200 [bridge] [ 15.297580][ T318] new_nbp+0x39c/0x580 [bridge] [ 15.297596][ T318] br_add_if+0x212/0x1320 [bridge] [ 15.297602][ T318] ? bpf_address_lookup+0x250/0x290 [ 15.297606][ T318] ? is_bpf_text_address+0x72/0x110 [ 15.297608][ T318] ? kernel_text_address+0x149/0x170 [ 15.297610][ T318] ? __kernel_text_address+0x12/0x30 [ 15.297612][ T318] do_set_master+0x357/0x580 [ 15.297615][ T318] do_setlink.isra.0+0xa31/0x2750 [ 15.297617][ T318] ? stack_trace_save+0x93/0xc0 [ 15.297618][ T318] ? rtnl_link_get_size+0x350/0x350 [ 15.297619][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297621][ T318] ? stack_depot_save_flags+0x1bc/0x790 [ 15.297625][ T318] ? kasan_save_stack+0x3d/0x50 [ 15.297627][ T318] ? kasan_save_stack+0x2f/0x50 [ 15.297629][ T318] ? kasan_save_track+0x14/0x30 [ 15.297630][ T318] ? __kasan_kmalloc+0x7b/0x90 [ 15.297632][ T318] ? __kmalloc_cache_noprof+0x29a/0x620 [ 15.297633][ T318] ? rtnl_newlink+0x124/0x11c0 [ 15.297634][ T318] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 15.297636][ T318] ? netlink_rcv_skb+0x14e/0x3a0 [ 15.297638][ T318] ? netlink_unicast+0x486/0x750 [ 15.297639][ T318] ? netlink_sendmsg+0x735/0xc60 [ 15.297641][ T318] ? ____sys_sendmsg+0x415/0x880 [ 15.297643][ T318] ? ___sys_sendmsg+0x14e/0x1d0 [ 15.297645][ T318] ? __sys_sendmsg+0x12c/0x1d0 [ 15.297646][ T318] ? do_syscall_64+0xff/0x530 [ 15.297648][ T318] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.297651][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297653][ T318] ? lock_acquire+0x13c/0x160 [ 15.297654][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297656][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297658][ T318] ? trace_contention_end+0xb3/0x180 [ 15.297660][ T318] ? __mutex_lock+0x1db/0x1ea0 [ 15.297663][ T318] ? __mutex_lock+0x9a3/0x1ea0 [ 15.297664][ T318] ? rtnl_newlink+0x9a8/0x11c0 [ 15.297666][ T318] ? ww_mutex_lock+0x160/0x160 [ 15.297667][ T318] ? nla_get_range_signed+0x3d0/0x3d0 [ 15.297669][ T318] ? __rtnl_newlink+0x3fa/0xa50 [ 15.297672][ T318] rtnl_newlink+0x9f1/0x11c0 [ 15.297673][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297675][ T318] ? rtnl_bridge_getlink+0x850/0x850 [ 15.297677][ T318] ? lock_acquire+0x13c/0x160 [ 15.297678][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297680][ T318] ? is_bpf_text_address+0x3e/0x110 [ 15.297682][ T318] ? is_bpf_text_address+0x72/0x110 [ 15.297684][ T318] ? kernel_text_address+0x149/0x170 [ 15.297685][ T318] ? __kernel_text_address+0x12/0x30 [ 15.297686][ T318] ? write_profile+0xf0/0xf0 [ 15.297688][ T318] ? unwind_get_return_address+0x67/0xd0 [ 15.297690][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297692][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297693][ T318] ? cap_capable+0x1d7/0x3d0 [ 15.297697][ T318] ? lock_acquire+0x13c/0x160 [ 15.297698][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297700][ T318] ? rtnl_bridge_getlink+0x850/0x850 [ 15.297701][ T318] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 15.297703][ T318] ? rtnl_link_fill+0x920/0x920 [ 15.297704][ T318] ? filter_irq_stacks+0xd0/0xd0 [ 15.297706][ T318] ? stack_depot_save_flags+0x1bc/0x790 [ 15.297708][ T318] netlink_rcv_skb+0x14e/0x3a0 [ 15.297710][ T318] ? rtnl_link_fill+0x920/0x920 [ 15.297711][ T318] ? lock_release+0x184/0x1f0 [ 15.297712][ T318] ? netlink_ack+0xcf0/0xcf0 [ 15.297714][ T318] ? __netlink_lookup+0xb9/0x6b0 [ 15.297716][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297718][ T318] ? lock_release+0x184/0x1f0 [ 15.297720][ T318] netlink_unicast+0x486/0x750 [ 15.297722][ T318] ? netlink_attachskb+0x810/0x810 [ 15.297723][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297725][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297727][ T318] ? lock_acquire+0x13c/0x160 [ 15.297729][ T318] netlink_sendmsg+0x735/0xc60 [ 15.297731][ T318] ? netlink_unicast+0x750/0x750 [ 15.297732][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297734][ T318] ? lock_release+0x184/0x1f0 [ 15.297736][ T318] ____sys_sendmsg+0x415/0x880 [ 15.297738][ T318] ? copy_msghdr_from_user+0x279/0x420 [ 15.297740][ T318] ? get_timestamp.constprop.0+0x390/0x390 [ 15.297741][ T318] ? move_addr_to_kernel+0x40/0x40 [ 15.297743][ T318] ? filter_irq_stacks+0xd0/0xd0 [ 15.297745][ T318] ___sys_sendmsg+0x14e/0x1d0 [ 15.297747][ T318] ? copy_msghdr_from_user+0x420/0x420 [ 15.297752][ T318] __sys_sendmsg+0x12c/0x1d0 [ 15.297754][ T318] ? __sys_sendmsg_sock+0x20/0x20 [ 15.297757][ T318] ? rcu_is_watching+0x16/0xd0 [ 15.297759][ T318] do_syscall_64+0xff/0x530 [ 15.297760][ T318] ? exc_page_fault+0xee/0x100 [ 15.297762][ T318] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.297764][ T318] RIP: 0033:0x7f4cd51db54e [ 15.297766][ T318] 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 [ 15.297768][ T318] RSP: 002b:00007ffe12f75da0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 15.297771][ T318] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f4cd51db54e [ 15.297773][ T318] RDX: 0000000000000000 RSI: 00007ffe12f75e50 RDI: 0000000000000005 [ 15.297773][ T318] RBP: 00007ffe12f75db0 R08: 0000000000000000 R09: 0000000000000000 [ 15.297774][ T318] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90d90c [ 15.297775][ T318] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe12f76510 [ 15.297778][ T318] [ 15.330015][ T318] br2: port 1(w1) entered disabled state [ 15.330324][ T318] w1: entered allmulticast mode [ 15.331929][ T318] w1: entered promiscuous mode [ 15.359712][ T319] br2: port 1(w1) entered blocking state [ 15.359933][ T319] br2: port 1(w1) entered forwarding state [ 15.445986][ T46] br2: port 1(w1) entered disabled state [ 15.484077][ T324] br2: port 2(vx2) entered blocking state [ 15.484357][ T324] br2: port 2(vx2) entered disabled state [ 15.484624][ T324] vx2: entered allmulticast mode [ 15.486820][ T324] vx2: entered promiscuous mode [ 15.487540][ T324] br2: port 2(vx2) entered blocking state [ 15.487812][ T324] br2: port 2(vx2) entered forwarding state [ 15.661933][ T37] br2: port 1(w1) entered blocking state [ 15.662140][ T37] br2: port 1(w1) entered forwarding state [ 16.224394][ T356] br2: port 1(w1) entered blocking state [ 16.224591][ T356] br2: port 1(w1) entered disabled state [ 16.224768][ T356] w1: entered allmulticast mode [ 16.225730][ T356] w1: entered promiscuous mode [ 16.255523][ T357] br2: port 1(w1) entered blocking state [ 16.255848][ T357] br2: port 1(w1) entered forwarding state [ 16.393533][ T362] br2: port 2(vx2) entered blocking state [ 16.393553][ T362] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 16.393556][ T362] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 362, name: ip [ 16.393558][ T362] preempt_count: 1, expected: 0 [ 16.393560][ T362] RCU nest depth: 0, expected: 0 [ 16.393561][ T362] INFO: lockdep is turned off. [ 16.393563][ T362] irq event stamp: 0 [ 16.393564][ T362] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 16.393570][ T362] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 16.393578][ T362] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 16.393580][ T362] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 16.393583][ T362] Preemption disabled at: [ 16.393584][ T362] [] vprintk_emit+0x31b/0x3e0 [ 16.393593][ T362] CPU: 3 UID: 0 PID: 362 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 16.393605][ T362] Tainted: [W]=WARN [ 16.393606][ T362] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.393609][ T362] Call Trace: [ 16.393611][ T362] [ 16.393612][ T362] dump_stack_lvl+0x6f/0xa0 [ 16.393619][ T362] ? vprintk_emit+0x31b/0x3e0 [ 16.393622][ T362] __might_resched.cold+0x1fe/0x2c1 [ 16.393626][ T362] ? __module_address+0x36/0x330 [ 16.393631][ T362] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 16.393635][ T362] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 16.393637][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393642][ T362] __kmalloc_noprof+0x443/0x760 [ 16.393646][ T362] ? __rwlock_init+0x150/0x150 [ 16.393649][ T362] ? alloc_buf.isra.0+0x4b/0x260 [ 16.393655][ T362] ? do_raw_spin_unlock+0x59/0x250 [ 16.393657][ T362] alloc_buf.isra.0+0x4b/0x260 [ 16.393660][ T362] put_chars+0x1e1/0x2f0 [ 16.393663][ T362] ? prb_final_commit+0x50/0x50 [ 16.393665][ T362] ? __send_to_port+0x420/0x420 [ 16.393668][ T362] ? printk_get_next_message+0x240/0x650 [ 16.393671][ T362] hvc_console_print+0x292/0x780 [ 16.393676][ T362] ? hvc_write+0x3a0/0x3a0 [ 16.393678][ T362] ? do_raw_spin_lock+0x131/0x280 [ 16.393681][ T362] ? vsnprintf+0x668/0x1700 [ 16.393685][ T362] ? __rwlock_init+0x150/0x150 [ 16.393687][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393690][ T362] ? lock_acquire+0x13c/0x160 [ 16.393693][ T362] console_emit_next_record+0x22f/0x4c0 [ 16.393697][ T362] ? devkmsg_read+0x4b0/0x4b0 [ 16.393700][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393702][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393705][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393707][ T362] ? lock_acquire+0x13c/0x160 [ 16.393710][ T362] ? console_flush_one_record+0x111/0x710 [ 16.393713][ T362] console_flush_one_record+0x46f/0x710 [ 16.393716][ T362] ? console_emit_next_record+0x4c0/0x4c0 [ 16.393720][ T362] console_unlock+0xee/0x1f0 [ 16.393723][ T362] ? lock_acquire+0x13c/0x160 [ 16.393725][ T362] ? console_flush_one_record+0x710/0x710 [ 16.393728][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393730][ T362] ? lock_release+0x184/0x1f0 [ 16.393732][ T362] ? lock_acquire+0x60/0x160 [ 16.393734][ T362] ? __rcu_read_lock+0x30/0x70 [ 16.393738][ T362] ? __down_trylock_console_sem+0x5e/0xa0 [ 16.393741][ T362] ? vprintk_emit+0x320/0x3e0 [ 16.393744][ T362] vprintk_emit+0x37c/0x3e0 [ 16.393748][ T362] ? wake_up_klogd_work_func+0x90/0x90 [ 16.393750][ T362] ? __rwlock_init+0x150/0x150 [ 16.393753][ T362] ? filter_irq_stacks+0xd0/0xd0 [ 16.393755][ T362] ? lock_acquire+0x13c/0x160 [ 16.393757][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393761][ T362] _printk+0xc7/0x100 [ 16.393765][ T362] ? snapshot_read.cold+0x21/0x21 [ 16.393768][ T362] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 16.393785][ T362] ? do_setlink.isra.0+0xa31/0x2750 [ 16.393789][ T362] ? rtnl_newlink+0x9f1/0x11c0 [ 16.393791][ T362] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 16.393794][ T362] br_set_state+0x22f/0x430 [bridge] [ 16.393809][ T362] br_init_port+0xc4/0x200 [bridge] [ 16.393822][ T362] new_nbp+0x39c/0x580 [bridge] [ 16.393835][ T362] br_add_if+0x212/0x1320 [bridge] [ 16.393847][ T362] ? bpf_address_lookup+0x250/0x290 [ 16.393851][ T362] ? is_bpf_text_address+0x72/0x110 [ 16.393854][ T362] ? kernel_text_address+0x149/0x170 [ 16.393857][ T362] ? __kernel_text_address+0x12/0x30 [ 16.393860][ T362] do_set_master+0x357/0x580 [ 16.393864][ T362] do_setlink.isra.0+0xa31/0x2750 [ 16.393867][ T362] ? stack_trace_save+0x93/0xc0 [ 16.393870][ T362] ? rtnl_link_get_size+0x350/0x350 [ 16.393873][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393877][ T362] ? stack_depot_save_flags+0x1bc/0x790 [ 16.393883][ T362] ? kasan_save_stack+0x3d/0x50 [ 16.393886][ T362] ? kasan_save_stack+0x2f/0x50 [ 16.393888][ T362] ? kasan_save_track+0x14/0x30 [ 16.393891][ T362] ? __kasan_kmalloc+0x7b/0x90 [ 16.393893][ T362] ? __kmalloc_cache_noprof+0x29a/0x620 [ 16.393895][ T362] ? rtnl_newlink+0x124/0x11c0 [ 16.393897][ T362] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 16.393901][ T362] ? netlink_rcv_skb+0x14e/0x3a0 [ 16.393905][ T362] ? netlink_unicast+0x486/0x750 [ 16.393907][ T362] ? netlink_sendmsg+0x735/0xc60 [ 16.393910][ T362] ? ____sys_sendmsg+0x415/0x880 [ 16.393915][ T362] ? ___sys_sendmsg+0x14e/0x1d0 [ 16.393918][ T362] ? __sys_sendmsg+0x12c/0x1d0 [ 16.393920][ T362] ? do_syscall_64+0xff/0x530 [ 16.393923][ T362] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 16.393927][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393930][ T362] ? lock_acquire+0x13c/0x160 [ 16.393932][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393934][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393937][ T362] ? trace_contention_end+0xb3/0x180 [ 16.393941][ T362] ? __mutex_lock+0x1db/0x1ea0 [ 16.393944][ T362] ? __mutex_lock+0x9a3/0x1ea0 [ 16.393946][ T362] ? rtnl_newlink+0x9a8/0x11c0 [ 16.393949][ T362] ? ww_mutex_lock+0x160/0x160 [ 16.393951][ T362] ? nla_get_range_signed+0x3d0/0x3d0 [ 16.393955][ T362] ? __rtnl_newlink+0x3fa/0xa50 [ 16.393958][ T362] rtnl_newlink+0x9f1/0x11c0 [ 16.393962][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393964][ T362] ? rtnl_bridge_getlink+0x850/0x850 [ 16.393966][ T362] ? lock_acquire+0x13c/0x160 [ 16.393968][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393971][ T362] ? is_bpf_text_address+0x3e/0x110 [ 16.393974][ T362] ? is_bpf_text_address+0x72/0x110 [ 16.393977][ T362] ? kernel_text_address+0x149/0x170 [ 16.393979][ T362] ? __kernel_text_address+0x12/0x30 [ 16.393981][ T362] ? write_profile+0xf0/0xf0 [ 16.393983][ T362] ? unwind_get_return_address+0x67/0xd0 [ 16.393986][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393989][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.393991][ T362] ? cap_capable+0x1d7/0x3d0 [ 16.393996][ T362] ? lock_acquire+0x13c/0x160 [ 16.393998][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.394001][ T362] ? rtnl_bridge_getlink+0x850/0x850 [ 16.394003][ T362] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 16.394006][ T362] ? rtnl_link_fill+0x920/0x920 [ 16.394008][ T362] ? filter_irq_stacks+0xd0/0xd0 [ 16.394010][ T362] ? stack_depot_save_flags+0x1bc/0x790 [ 16.394014][ T362] netlink_rcv_skb+0x14e/0x3a0 [ 16.394016][ T362] ? rtnl_link_fill+0x920/0x920 [ 16.394018][ T362] ? lock_release+0x184/0x1f0 [ 16.394021][ T362] ? netlink_ack+0xcf0/0xcf0 [ 16.394023][ T362] ? __netlink_lookup+0xb9/0x6b0 [ 16.394027][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.394030][ T362] ? lock_release+0x184/0x1f0 [ 16.394033][ T362] netlink_unicast+0x486/0x750 [ 16.394036][ T362] ? netlink_attachskb+0x810/0x810 [ 16.394038][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.394041][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.394043][ T362] ? lock_acquire+0x13c/0x160 [ 16.394046][ T362] netlink_sendmsg+0x735/0xc60 [ 16.394049][ T362] ? netlink_unicast+0x750/0x750 [ 16.394052][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.394055][ T362] ? lock_release+0x184/0x1f0 [ 16.394058][ T362] ____sys_sendmsg+0x415/0x880 [ 16.394060][ T362] ? copy_msghdr_from_user+0x279/0x420 [ 16.394063][ T362] ? get_timestamp.constprop.0+0x390/0x390 [ 16.394065][ T362] ? move_addr_to_kernel+0x40/0x40 [ 16.394068][ T362] ? filter_irq_stacks+0xd0/0xd0 [ 16.394072][ T362] ___sys_sendmsg+0x14e/0x1d0 [ 16.394075][ T362] ? copy_msghdr_from_user+0x420/0x420 [ 16.394083][ T362] __sys_sendmsg+0x12c/0x1d0 [ 16.394086][ T362] ? __sys_sendmsg_sock+0x20/0x20 [ 16.394090][ T362] ? rcu_is_watching+0x16/0xd0 [ 16.394093][ T362] do_syscall_64+0xff/0x530 [ 16.394095][ T362] ? exc_page_fault+0xee/0x100 [ 16.394098][ T362] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 16.394101][ T362] RIP: 0033:0x7fe83ab8754e [ 16.394104][ T362] 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 [ 16.394106][ T362] RSP: 002b:00007ffe7411ba90 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 16.394111][ T362] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fe83ab8754e [ 16.394113][ T362] RDX: 0000000000000000 RSI: 00007ffe7411bb40 RDI: 0000000000000005 [ 16.394115][ T362] RBP: 00007ffe7411baa0 R08: 0000000000000000 R09: 0000000000000000 [ 16.394116][ T362] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90d90d [ 16.394118][ T362] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe7411c200 [ 16.394122][ T362] [ 16.444395][ T362] br2: port 2(vx2) entered disabled state [ 16.444708][ T362] vx2: entered allmulticast mode [ 16.446263][ T362] vx2: entered promiscuous mode [ 16.447084][ T362] br2: port 2(vx2) entered blocking state [ 16.447352][ T362] br2: port 2(vx2) entered forwarding state [ 16.456017][ T63] br2: port 1(w1) entered disabled state [ 16.638194][ T63] br2: port 1(w1) entered blocking state [ 16.638403][ T63] br2: port 1(w1) entered forwarding state [ 23.561990][ T444] GACT probability NOT on [ 23.562004][ T444] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 23.562006][ T444] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 444, name: modprobe [ 23.562008][ T444] preempt_count: 1, expected: 0 [ 23.562009][ T444] RCU nest depth: 0, expected: 0 [ 23.562010][ T444] INFO: lockdep is turned off. [ 23.562011][ T444] irq event stamp: 0 [ 23.562012][ T444] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 23.562016][ T444] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 23.562022][ T444] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 23.562024][ T444] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 23.562026][ T444] Preemption disabled at: [ 23.562026][ T444] [] vprintk_emit+0x31b/0x3e0 [ 23.562034][ T444] CPU: 0 UID: 0 PID: 444 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 23.562037][ T444] Tainted: [W]=WARN [ 23.562038][ T444] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 23.562040][ T444] Call Trace: [ 23.562041][ T444] [ 23.562042][ T444] dump_stack_lvl+0x6f/0xa0 [ 23.562048][ T444] ? vprintk_emit+0x31b/0x3e0 [ 23.562050][ T444] __might_resched.cold+0x1fe/0x2c1 [ 23.562053][ T444] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 23.562057][ T444] ? rcu_is_watching+0x16/0xd0 [ 23.562060][ T444] __kmalloc_noprof+0x443/0x760 [ 23.562064][ T444] ? __rwlock_init+0x150/0x150 [ 23.562066][ T444] ? alloc_buf.isra.0+0x4b/0x260 [ 23.562070][ T444] ? do_raw_spin_unlock+0x59/0x250 [ 23.562072][ T444] alloc_buf.isra.0+0x4b/0x260 [ 23.562074][ T444] put_chars+0x1e1/0x2f0 [ 23.562076][ T444] ? desc_read_finalized_seq+0x79/0x120 [ 23.562077][ T444] ? __send_to_port+0x420/0x420 [ 23.562079][ T444] ? console_prepend_replay+0x20/0x20 [ 23.562081][ T444] hvc_console_print+0x292/0x780 [ 23.562084][ T444] ? hvc_write+0x3a0/0x3a0 [ 23.562086][ T444] ? do_raw_spin_lock+0x131/0x280 [ 23.562087][ T444] ? __rwlock_init+0x150/0x150 [ 23.562089][ T444] ? rcu_is_watching+0x16/0xd0 [ 23.562090][ T444] ? rcu_is_watching+0x16/0xd0 [ 23.562092][ T444] ? lock_acquire+0x13c/0x160 [ 23.562094][ T444] console_emit_next_record+0x22f/0x4c0 [ 23.562097][ T444] ? devkmsg_read+0x4b0/0x4b0 [ 23.562098][ T444] ? rcu_is_watching+0x16/0xd0 [ 23.562100][ T444] ? rcu_is_watching+0x16/0xd0 [ 23.562102][ T444] ? rcu_is_watching+0x16/0xd0 [ 23.562103][ T444] ? lock_acquire+0x13c/0x160 [ 23.562105][ T444] ? console_flush_one_record+0x111/0x710 [ 23.562107][ T444] console_flush_one_record+0x46f/0x710 [ 23.562109][ T444] ? console_emit_next_record+0x4c0/0x4c0 [ 23.562111][ T444] console_unlock+0xee/0x1f0 [ 23.562113][ T444] ? lock_acquire+0x13c/0x160 [ 23.562114][ T444] ? console_flush_one_record+0x710/0x710 [ 23.562116][ T444] ? rcu_is_watching+0x16/0xd0 [ 23.562118][ T444] ? lock_release+0x184/0x1f0 [ 23.562119][ T444] ? lock_acquire+0x60/0x160 [ 23.562120][ T444] ? __rcu_read_lock+0x30/0x70 [ 23.562122][ T444] ? __down_trylock_console_sem+0x5e/0xa0 [ 23.562125][ T444] ? vprintk_emit+0x320/0x3e0 [ 23.562126][ T444] vprintk_emit+0x37c/0x3e0 [ 23.562129][ T444] ? wake_up_klogd_work_func+0x90/0x90 [ 23.562132][ T444] ? llc_exit+0x3e0/0x3e0 [llc] [ 23.562135][ T444] _printk+0xc7/0x100 [ 23.562138][ T444] ? snapshot_read.cold+0x21/0x21 [ 23.562140][ T444] ? do_one_initcall+0x113/0x4f0 [ 23.562143][ T444] gact_init_module+0x15/0x1000 [act_gact] [ 23.562145][ T444] do_one_initcall+0x124/0x4f0 [ 23.562147][ T444] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 23.562149][ T444] ? do_init_module+0xae/0x8a0 [ 23.562152][ T444] ? kasan_unpoison+0x44/0x70 [ 23.562155][ T444] do_init_module+0x2ad/0x8a0 [ 23.562157][ T444] ? free_module+0x470/0x470 [ 23.562159][ T444] ? kfree+0x123/0x590 [ 23.562161][ T444] load_module+0x1424/0x1bb0 [ 23.562164][ T444] ? layout_and_allocate.isra.0+0x680/0x680 [ 23.562166][ T444] ? __ia32_sys_fsconfig+0x180/0x180 [ 23.562169][ T444] ? ovl_real_file+0x172/0x1e0 [ 23.562173][ T444] ? backing_file_read_iter+0x541/0x790 [ 23.562175][ T444] init_module_from_file+0x11f/0x1a0 [ 23.562177][ T444] ? __do_sys_init_module+0x220/0x220 [ 23.562179][ T444] ? rcu_read_unlock+0x20/0x70 [ 23.562183][ T444] ? ovl_mmap+0x270/0x270 [ 23.562185][ T444] ? __rwlock_init+0x150/0x150 [ 23.562187][ T444] ? rcu_is_watching+0x16/0xd0 [ 23.562188][ T444] ? lock_release+0x184/0x1f0 [ 23.562190][ T444] ? do_raw_spin_unlock+0x59/0x250 [ 23.562191][ T444] idempotent_init_module+0x37b/0x7c0 [ 23.562194][ T444] ? init_module_from_file+0x1a0/0x1a0 [ 23.562196][ T444] ? rcu_is_watching+0x16/0xd0 [ 23.562198][ T444] ? cap_capable+0x1d7/0x3d0 [ 23.562202][ T444] __x64_sys_finit_module+0xdf/0x190 [ 23.562204][ T444] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 23.562206][ T444] do_syscall_64+0xff/0x530 [ 23.562209][ T444] ? exc_page_fault+0xee/0x100 [ 23.562211][ T444] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.562213][ T444] RIP: 0033:0x7fa55771c37d [ 23.562216][ T444] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 [ 23.562217][ T444] RSP: 002b:00007ffde9f592e8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 23.562221][ T444] RAX: ffffffffffffffda RBX: 0000559232e9c810 RCX: 00007fa55771c37d [ 23.562222][ T444] RDX: 0000000000000000 RSI: 0000559224e88ffd RDI: 0000000000000000 [ 23.562223][ T444] RBP: 00007ffde9f59380 R08: 0000000000000000 R09: 0000000000000000 [ 23.562224][ T444] R10: 0000000000000000 R11: 0000000000000246 R12: 0000559224e88ffd [ 23.562225][ T444] R13: 0000559232e9c960 R14: 0000000000040000 R15: 0000000000000000 [ 23.562227][ T444] [ 66.788230][ T71] vx2: left allmulticast mode [ 66.788247][ T71] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 66.788250][ T71] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 71, name: kworker/u16:1 [ 66.788252][ T71] preempt_count: 1, expected: 0 [ 66.788253][ T71] RCU nest depth: 0, expected: 0 [ 66.788253][ T71] INFO: lockdep is turned off. [ 66.788255][ T71] irq event stamp: 16 [ 66.788255][ T71] hardirqs last enabled at (15): [] _raw_spin_unlock_irq+0x28/0x50 [ 66.788264][ T71] hardirqs last disabled at (16): [] __schedule+0x1246/0x20e0 [ 66.788266][ T71] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 66.788271][ T71] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 66.788274][ T71] Preemption disabled at: [ 66.788274][ T71] [] vprintk_emit+0x31b/0x3e0 [ 66.788282][ T71] CPU: 2 UID: 0 PID: 71 Comm: kworker/u16:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 66.788286][ T71] Tainted: [W]=WARN [ 66.788287][ T71] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 66.788288][ T71] Workqueue: netns cleanup_net [ 66.788295][ T71] Call Trace: [ 66.788296][ T71] [ 66.788297][ T71] dump_stack_lvl+0x6f/0xa0 [ 66.788303][ T71] ? vprintk_emit+0x31b/0x3e0 [ 66.788305][ T71] __might_resched.cold+0x1fe/0x2c1 [ 66.788309][ T71] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 66.788312][ T71] ? rcu_is_watching+0x16/0xd0 [ 66.788316][ T71] __kmalloc_noprof+0x443/0x760 [ 66.788319][ T71] ? __rwlock_init+0x150/0x150 [ 66.788322][ T71] ? alloc_buf.isra.0+0x4b/0x260 [ 66.788325][ T71] ? do_raw_spin_unlock+0x59/0x250 [ 66.788327][ T71] alloc_buf.isra.0+0x4b/0x260 [ 66.788329][ T71] put_chars+0x1e1/0x2f0 [ 66.788331][ T71] ? desc_read_finalized_seq+0x79/0x120 [ 66.788332][ T71] ? __send_to_port+0x420/0x420 [ 66.788334][ T71] ? console_prepend_replay+0x20/0x20 [ 66.788336][ T71] hvc_console_print+0x292/0x780 [ 66.788340][ T71] ? hvc_write+0x3a0/0x3a0 [ 66.788341][ T71] ? do_raw_spin_lock+0x131/0x280 [ 66.788343][ T71] ? __rwlock_init+0x150/0x150 [ 66.788344][ T71] ? rcu_is_watching+0x16/0xd0 [ 66.788346][ T71] ? rcu_is_watching+0x16/0xd0 [ 66.788348][ T71] ? lock_acquire+0x13c/0x160 [ 66.788350][ T71] console_emit_next_record+0x22f/0x4c0 [ 66.788352][ T71] ? devkmsg_read+0x4b0/0x4b0 [ 66.788354][ T71] ? rcu_is_watching+0x16/0xd0 [ 66.788356][ T71] ? rcu_is_watching+0x16/0xd0 [ 66.788358][ T71] ? rcu_is_watching+0x16/0xd0 [ 66.788359][ T71] ? lock_acquire+0x13c/0x160 [ 66.788361][ T71] ? console_flush_one_record+0x111/0x710 [ 66.788363][ T71] console_flush_one_record+0x46f/0x710 [ 66.788365][ T71] ? console_emit_next_record+0x4c0/0x4c0 [ 66.788368][ T71] console_unlock+0xee/0x1f0 [ 66.788370][ T71] ? lock_acquire+0x13c/0x160 [ 66.788371][ T71] ? console_flush_one_record+0x710/0x710 [ 66.788373][ T71] ? rcu_is_watching+0x16/0xd0 [ 66.788374][ T71] ? lock_release+0x184/0x1f0 [ 66.788376][ T71] ? lock_acquire+0x60/0x160 [ 66.788377][ T71] ? __rcu_read_lock+0x30/0x70 [ 66.788379][ T71] ? __down_trylock_console_sem+0x5e/0xa0 [ 66.788381][ T71] ? vprintk_emit+0x320/0x3e0 [ 66.788383][ T71] vprintk_emit+0x37c/0x3e0 [ 66.788386][ T71] ? wake_up_klogd_work_func+0x90/0x90 [ 66.788387][ T71] ? process_one_work+0xe3e/0x1560 [ 66.788390][ T71] ? kthread+0x367/0x460 [ 66.788392][ T71] ? ret_from_fork+0x474/0x6b0 [ 66.788395][ T71] ? ret_from_fork_asm+0x11/0x20 [ 66.788397][ T71] _printk+0xc7/0x100 [ 66.788400][ T71] ? snapshot_read.cold+0x21/0x21 [ 66.788402][ T71] ? netdev_name+0x43/0x60 [ 66.788405][ T71] ? __netdev_printk+0x17f/0x1d0 [ 66.788407][ T71] netdev_info+0xe2/0x116 [ 66.788408][ T71] ? netdev_notice+0x120/0x120 [ 66.788410][ T71] ? rcu_is_watching+0x16/0xd0 [ 66.788412][ T71] ? __up_read+0x355/0x9e0 [ 66.788414][ T71] ? trace_hardirqs_on+0x36/0x40 [ 66.788417][ T71] ? down_write_nested+0x200/0x200 [ 66.788418][ T71] ? mutex_is_locked+0x1c/0x50 [ 66.788421][ T71] netif_set_allmulti.cold+0x7c/0x166 [ 66.788424][ T71] dev_set_allmulti+0xa2/0x150 [ 66.788426][ T71] del_nbp+0xb7/0xc10 [bridge] [ 66.788439][ T71] br_dev_delete+0x9d/0x1e0 [bridge] [ 66.788447][ T71] br_net_exit_rtnl+0xb8/0x110 [bridge] [ 66.788454][ T71] ops_undo_list+0x5be/0x8f0 [ 66.788456][ T71] ? rtnl_net_dumpid_one+0x2d0/0x2d0 [ 66.788458][ T71] ? idr_destroy+0x121/0x250 [ 66.788461][ T71] cleanup_net+0x431/0x890 [ 66.788463][ T71] ? net_passive_dec+0x230/0x230 [ 66.788465][ T71] ? lock_acquire+0x13c/0x160 [ 66.788467][ T71] ? rcu_is_watching+0x16/0xd0 [ 66.788469][ T71] process_one_work+0xe3e/0x1560 [ 66.788472][ T71] ? __queue_delayed_work+0x470/0x470 [ 66.788474][ T71] ? __rwlock_init+0x150/0x150 [ 66.788477][ T71] worker_thread+0x4f1/0xd60 [ 66.788479][ T71] ? rescuer_thread+0x1340/0x1340 [ 66.788480][ T71] ? __kthread_parkme+0xbd/0x210 [ 66.788482][ T71] ? rescuer_thread+0x1340/0x1340 [ 66.788484][ T71] ? rescuer_thread+0x1340/0x1340 [ 66.788486][ T71] kthread+0x367/0x460 [ 66.788487][ T71] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 66.788488][ T71] ? kthread_affine_preferred+0x4c0/0x4c0 [ 66.788490][ T71] ret_from_fork+0x474/0x6b0 [ 66.788492][ T71] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 66.788494][ T71] ? __switch_to+0x5a3/0xe00 [ 66.788496][ T71] ? kthread_affine_preferred+0x4c0/0x4c0 [ 66.788498][ T71] ret_from_fork_asm+0x11/0x20 [ 66.788501][ T71] [ 66.810736][ T71] vx2: left promiscuous mode [ 66.811981][ T71] br2: port 2(vx2) entered disabled state [ 66.816014][ T71] w1: left allmulticast mode [ 66.816211][ T71] w1: left promiscuous mode [ 66.816463][ T71] br2: port 1(w1) entered disabled state [ 66.889215][ T71] vx2: left allmulticast mode [ 66.889399][ T71] vx2: left promiscuous mode [ 66.889648][ T71] br2: port 2(vx2) entered disabled state [ 66.891169][ T71] w1: left allmulticast mode [ 66.891326][ T71] w1: left promiscuous mode [ 66.891512][ T71] br2: port 1(w1) entered disabled state [ 67.282567][ T576] br1: port 3(veth2) entered disabled state [ 67.303754][ T577] veth2: left allmulticast mode [ 67.303966][ T577] veth2: left promiscuous mode [ 67.304182][ T577] br1: port 3(veth2) entered disabled state [ 67.345853][ T579] br1: port 2(veth1) entered disabled state [ 67.371460][ T580] veth1: left allmulticast mode [ 67.371712][ T580] veth1: left promiscuous mode [ 67.372053][ T580] br1: port 2(veth1) entered disabled state [ 67.389516][ T581] vx1: left allmulticast mode [ 67.389743][ T581] vx1: left promiscuous mode [ 67.390639][ T581] br1: port 1(vx1) entered disabled state