[ 11.298866][ T188] ip (188) used greatest stack depth: 24464 bytes left [ 11.298883][ T188] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.298886][ T188] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 188, name: ip [ 11.298887][ T188] preempt_count: 2, expected: 0 [ 11.298888][ T188] RCU nest depth: 0, expected: 0 [ 11.298889][ T188] locks held by ip/188: 5, last CPU#3: [ 11.298892][ T188] #0: ffffffff946027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 11.298903][ T188] #1: ffffffff94769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.298909][ T188] #2: ffffffff94769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.298913][ T188] #3: ffffffff94689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.298917][ T188] #4: ffffffff94689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.298922][ T188] irq event stamp: 53042 [ 11.298923][ T188] hardirqs last enabled at (53041): [] __down_trylock_console_sem+0x86/0xa0 [ 11.298925][ T188] hardirqs last disabled at (53042): [] console_emit_next_record+0x3d4/0x4c0 [ 11.298928][ T188] softirqs last enabled at (51756): [] netlink_release+0x17b/0xcf0 [ 11.298931][ T188] softirqs last disabled at (51754): [] netlink_release+0xd2/0xcf0 [ 11.298934][ T188] Preemption disabled at: [ 11.298935][ T188] [<0000000000000000>] 0x0 [ 11.298942][ T188] CPU: 3 UID: 0 PID: 188 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.298945][ T188] Tainted: [W]=WARN [ 11.298946][ T188] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.298949][ T188] Call Trace: [ 11.298950][ T188] [ 11.298952][ T188] dump_stack_lvl+0x6f/0xa0 [ 11.298958][ T188] __might_resched.cold+0x1fe/0x2c1 [ 11.298964][ T188] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.298970][ T188] ? __kmalloc_noprof+0xdb/0x760 [ 11.298975][ T188] __kmalloc_noprof+0x443/0x760 [ 11.298978][ T188] ? alloc_buf.isra.0+0x4b/0x260 [ 11.298984][ T188] ? do_raw_spin_unlock+0x59/0x250 [ 11.298987][ T188] alloc_buf.isra.0+0x4b/0x260 [ 11.298990][ T188] put_chars+0x1e1/0x2f0 [ 11.298993][ T188] ? __send_to_port+0x420/0x420 [ 11.298995][ T188] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.299000][ T188] ? validate_chain+0x38b/0xc20 [ 11.299006][ T188] hvc_console_print+0x292/0x780 [ 11.299013][ T188] ? hvc_write+0x3a0/0x3a0 [ 11.299015][ T188] ? rcu_is_watching+0x16/0xd0 [ 11.299017][ T188] ? lock_acquire+0x13c/0x160 [ 11.299022][ T188] console_emit_next_record+0x22f/0x4c0 [ 11.299026][ T188] ? devkmsg_read+0x4b0/0x4b0 [ 11.299028][ T188] ? console_flush_one_record+0x106/0x710 [ 11.299031][ T188] ? rcu_is_watching+0x16/0xd0 [ 11.299034][ T188] ? lock_acquire+0x13c/0x160 [ 11.299038][ T188] console_flush_one_record+0x46f/0x710 [ 11.299043][ T188] ? console_emit_next_record+0x4c0/0x4c0 [ 11.299045][ T188] ? __lock_acquire+0x518/0xc20 [ 11.299051][ T188] console_unlock+0xee/0x1f0 [ 11.299054][ T188] ? console_flush_one_record+0x710/0x710 [ 11.299056][ T188] ? rcu_is_watching+0x16/0xd0 [ 11.299059][ T188] ? lock_acquire+0x60/0x160 [ 11.299063][ T188] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.299064][ T188] ? vprintk_emit+0x320/0x3e0 [ 11.299068][ T188] vprintk_emit+0x37c/0x3e0 [ 11.299075][ T188] ? wake_up_klogd_work_func+0x90/0x90 [ 11.299078][ T188] ? __lock_acquire+0x518/0xc20 [ 11.299082][ T188] _printk+0xc7/0x100 [ 11.299086][ T188] ? snapshot_read.cold+0x21/0x21 [ 11.299089][ T188] ? do_raw_spin_lock+0x131/0x280 [ 11.299092][ T188] ? __rwlock_init+0x150/0x150 [ 11.299097][ T188] ? do_raw_spin_lock+0x131/0x280 [ 11.299099][ T188] do_exit.cold+0x82/0x9c [ 11.299103][ T188] ? exit_notify+0x890/0x890 [ 11.299105][ T188] ? __lock_release.isra.0+0x69/0x1a0 [ 11.299108][ T188] ? rcu_is_watching+0x16/0xd0 [ 11.299113][ T188] do_group_exit+0xb8/0x370 [ 11.299116][ T188] __x64_sys_exit_group+0x3c/0x50 [ 11.299118][ T188] x64_sys_call+0x1567/0x1570 [ 11.299120][ T188] do_syscall_64+0xff/0x530 [ 11.299123][ T188] ? exc_page_fault+0xee/0x100 [ 11.299126][ T188] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.299128][ T188] RIP: 0033:0x7f384fc531b8 [ 11.299131][ T188] Code: Unable to access opcode bytes at 0x7f384fc5318e. [ 11.299132][ T188] RSP: 002b:00007ffdf4ef3e58 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 11.299135][ T188] RAX: ffffffffffffffda RBX: 00007f384fd83f88 RCX: 00007f384fc531b8 [ 11.299136][ T188] RDX: 00007f384f99dfc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 11.299137][ T188] RBP: 00007ffdf4ef3eb0 R08: 0000000000000000 R09: 0000000000008010 [ 11.299138][ T188] R10: 00007ffdf4ef3c70 R11: 0000000000000246 R12: 0000000000000001 [ 11.299139][ T188] R13: 0000000000000000 R14: 00007f384fd82680 R15: 00007f384fd83fa0 [ 11.299147][ T188] [ 11.420786][ T193] modprobe (193) used greatest stack depth: 24432 bytes left [ 11.475237][ T195] ip (195) used greatest stack depth: 24048 bytes left [ 12.364018][ T246] 8021q: 802.1Q VLAN Support v1.8 [ 12.364038][ T246] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.364040][ T246] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 246, name: modprobe [ 12.364042][ T246] preempt_count: 1, expected: 0 [ 12.364043][ T246] RCU nest depth: 0, expected: 0 [ 12.364044][ T246] locks held by modprobe/246: 4, last CPU#2: [ 12.364046][ T246] #0: ffffffff94769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.364059][ T246] #1: ffffffff94769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.364063][ T246] #2: ffffffff94689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.364067][ T246] #3: ffffffff94689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.364071][ T246] irq event stamp: 23448 [ 12.364072][ T246] hardirqs last enabled at (23447): [] __down_trylock_console_sem+0x86/0xa0 [ 12.364076][ T246] hardirqs last disabled at (23448): [] console_emit_next_record+0x3d4/0x4c0 [ 12.364078][ T246] softirqs last enabled at (20464): [] handle_softirqs+0x67c/0x900 [ 12.364081][ T246] softirqs last disabled at (20457): [] __irq_exit_rcu+0x145/0x1c0 [ 12.364084][ T246] Preemption disabled at: [ 12.364085][ T246] [] vprintk_emit+0x31b/0x3e0 [ 12.364091][ T246] CPU: 2 UID: 0 PID: 246 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.364094][ T246] Tainted: [W]=WARN [ 12.364095][ T246] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.364097][ T246] Call Trace: [ 12.364098][ T246] [ 12.364100][ T246] dump_stack_lvl+0x6f/0xa0 [ 12.364106][ T246] ? vprintk_emit+0x31b/0x3e0 [ 12.364108][ T246] __might_resched.cold+0x1fe/0x2c1 [ 12.364113][ T246] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.364117][ T246] ? __kmalloc_noprof+0xdb/0x760 [ 12.364122][ T246] __kmalloc_noprof+0x443/0x760 [ 12.364124][ T246] ? alloc_buf.isra.0+0x4b/0x260 [ 12.364129][ T246] ? do_raw_spin_unlock+0x59/0x250 [ 12.364132][ T246] alloc_buf.isra.0+0x4b/0x260 [ 12.364136][ T246] put_chars+0x1e1/0x2f0 [ 12.364138][ T246] ? __send_to_port+0x420/0x420 [ 12.364140][ T246] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.364145][ T246] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.364147][ T246] ? validate_chain+0x38b/0xc20 [ 12.364152][ T246] hvc_console_print+0x292/0x780 [ 12.364154][ T246] ? __lock_acquire+0x518/0xc20 [ 12.364159][ T246] ? hvc_write+0x3a0/0x3a0 [ 12.364162][ T246] ? rcu_is_watching+0x16/0xd0 [ 12.364167][ T246] console_emit_next_record+0x22f/0x4c0 [ 12.364170][ T246] ? devkmsg_read+0x4b0/0x4b0 [ 12.364172][ T246] ? console_flush_one_record+0x106/0x710 [ 12.364175][ T246] ? rcu_is_watching+0x16/0xd0 [ 12.364178][ T246] ? lock_acquire+0x13c/0x160 [ 12.364181][ T246] console_flush_one_record+0x46f/0x710 [ 12.364185][ T246] ? console_emit_next_record+0x4c0/0x4c0 [ 12.364187][ T246] ? __lock_acquire+0x518/0xc20 [ 12.364192][ T246] console_unlock+0xee/0x1f0 [ 12.364195][ T246] ? console_flush_one_record+0x710/0x710 [ 12.364197][ T246] ? rcu_is_watching+0x16/0xd0 [ 12.364199][ T246] ? lock_acquire+0x60/0x160 [ 12.364202][ T246] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.364204][ T246] ? vprintk_emit+0x320/0x3e0 [ 12.364207][ T246] vprintk_emit+0x37c/0x3e0 [ 12.364211][ T246] ? wake_up_klogd_work_func+0x90/0x90 [ 12.364217][ T246] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 12.364220][ T246] _printk+0xc7/0x100 [ 12.364224][ T246] ? snapshot_read.cold+0x21/0x21 [ 12.364230][ T246] ? do_one_initcall+0x113/0x4f0 [ 12.364233][ T246] vlan_proto_init+0x24/0x90 [8021q] [ 12.364236][ T246] do_one_initcall+0x124/0x4f0 [ 12.364239][ T246] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 12.364243][ T246] ? do_init_module+0xae/0x8a0 [ 12.364246][ T246] ? kasan_unpoison+0x44/0x70 [ 12.364251][ T246] do_init_module+0x2ad/0x8a0 [ 12.364255][ T246] ? lockdep_hardirqs_on+0x91/0x130 [ 12.364259][ T246] ? free_module+0x470/0x470 [ 12.364262][ T246] ? kfree+0x123/0x590 [ 12.364266][ T246] load_module+0x1424/0x1bb0 [ 12.364273][ T246] ? layout_and_allocate.isra.0+0x680/0x680 [ 12.364276][ T246] ? __ia32_sys_fsconfig+0x180/0x180 [ 12.364279][ T246] ? ovl_real_file+0x172/0x1e0 [ 12.364283][ T246] ? find_held_lock+0x2b/0x80 [ 12.364285][ T246] ? backing_file_read_iter+0x541/0x790 [ 12.364288][ T246] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.364292][ T246] init_module_from_file+0x11f/0x1a0 [ 12.364295][ T246] ? __do_sys_init_module+0x220/0x220 [ 12.364303][ T246] ? __rwlock_init+0x150/0x150 [ 12.364306][ T246] ? do_raw_spin_unlock+0x59/0x250 [ 12.364310][ T246] idempotent_init_module+0x37b/0x7c0 [ 12.364313][ T246] ? init_module_from_file+0x1a0/0x1a0 [ 12.364319][ T246] ? rcu_is_watching+0x16/0xd0 [ 12.364321][ T246] ? cap_capable+0x1d7/0x3d0 [ 12.364327][ T246] __x64_sys_finit_module+0xdf/0x190 [ 12.364329][ T246] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.364333][ T246] do_syscall_64+0xff/0x530 [ 12.364334][ T246] ? exc_page_fault+0xee/0x100 [ 12.364337][ T246] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.364340][ T246] RIP: 0033:0x7ff337f9c37d [ 12.364343][ T246] 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 [ 12.364345][ T246] RSP: 002b:00007fff0e991d78 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 12.364348][ T246] RAX: ffffffffffffffda RBX: 0000557edeb03810 RCX: 00007ff337f9c37d [ 12.364349][ T246] RDX: 0000000000000000 RSI: 0000557ea25d3ffd RDI: 0000000000000000 [ 12.364350][ T246] RBP: 00007fff0e991e10 R08: 0000000000000000 R09: 0000000000000000 [ 12.364351][ T246] R10: 0000000000000000 R11: 0000000000000246 R12: 0000557ea25d3ffd [ 12.364352][ T246] R13: 0000557edeb03960 R14: 0000000000040000 R15: 0000000000000000 [ 12.364358][ T246] [ 13.692252][ T317] GACT probability NOT on [ 13.692271][ T317] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.692274][ T317] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 317, name: modprobe [ 13.692276][ T317] preempt_count: 1, expected: 0 [ 13.692277][ T317] RCU nest depth: 0, expected: 0 [ 13.692278][ T317] locks held by modprobe/317: 4, last CPU#0: [ 13.692281][ T317] #0: ffffffff94769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.692294][ T317] #1: ffffffff94769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.692299][ T317] #2: ffffffff94689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.692304][ T317] #3: ffffffff94689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.692308][ T317] irq event stamp: 18158 [ 13.692309][ T317] hardirqs last enabled at (18157): [] __down_trylock_console_sem+0x86/0xa0 [ 13.692311][ T317] hardirqs last disabled at (18158): [] console_emit_next_record+0x3d4/0x4c0 [ 13.692313][ T317] softirqs last enabled at (17456): [] handle_softirqs+0x67c/0x900 [ 13.692316][ T317] softirqs last disabled at (17449): [] __irq_exit_rcu+0x145/0x1c0 [ 13.692319][ T317] Preemption disabled at: [ 13.692320][ T317] [] vprintk_emit+0x31b/0x3e0 [ 13.692326][ T317] CPU: 0 UID: 0 PID: 317 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.692329][ T317] Tainted: [W]=WARN [ 13.692330][ T317] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.692332][ T317] Call Trace: [ 13.692334][ T317] [ 13.692335][ T317] dump_stack_lvl+0x6f/0xa0 [ 13.692341][ T317] ? vprintk_emit+0x31b/0x3e0 [ 13.692343][ T317] __might_resched.cold+0x1fe/0x2c1 [ 13.692348][ T317] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.692352][ T317] ? __kmalloc_noprof+0xdb/0x760 [ 13.692357][ T317] __kmalloc_noprof+0x443/0x760 [ 13.692359][ T317] ? alloc_buf.isra.0+0x4b/0x260 [ 13.692365][ T317] ? do_raw_spin_unlock+0x59/0x250 [ 13.692367][ T317] alloc_buf.isra.0+0x4b/0x260 [ 13.692371][ T317] put_chars+0x1e1/0x2f0 [ 13.692373][ T317] ? desc_read_finalized_seq+0x79/0x120 [ 13.692375][ T317] ? __send_to_port+0x420/0x420 [ 13.692377][ T317] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.692381][ T317] ? validate_chain+0x38b/0xc20 [ 13.692385][ T317] hvc_console_print+0x292/0x780 [ 13.692388][ T317] ? __lock_acquire+0x518/0xc20 [ 13.692389][ T317] ? __lock_acquire+0x518/0xc20 [ 13.692394][ T317] ? hvc_write+0x3a0/0x3a0 [ 13.692395][ T317] ? console_emit_next_record+0x1df/0x4c0 [ 13.692398][ T317] ? rcu_is_watching+0x16/0xd0 [ 13.692401][ T317] ? lock_acquire+0x13c/0x160 [ 13.692405][ T317] console_emit_next_record+0x22f/0x4c0 [ 13.692409][ T317] ? devkmsg_read+0x4b0/0x4b0 [ 13.692411][ T317] ? console_flush_one_record+0x106/0x710 [ 13.692414][ T317] ? rcu_is_watching+0x16/0xd0 [ 13.692416][ T317] ? lock_acquire+0x13c/0x160 [ 13.692420][ T317] console_flush_one_record+0x46f/0x710 [ 13.692424][ T317] ? console_emit_next_record+0x4c0/0x4c0 [ 13.692426][ T317] ? __lock_acquire+0x518/0xc20 [ 13.692431][ T317] console_unlock+0xee/0x1f0 [ 13.692434][ T317] ? console_flush_one_record+0x710/0x710 [ 13.692436][ T317] ? rcu_is_watching+0x16/0xd0 [ 13.692438][ T317] ? lock_acquire+0x60/0x160 [ 13.692442][ T317] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.692443][ T317] ? vprintk_emit+0x320/0x3e0 [ 13.692447][ T317] vprintk_emit+0x37c/0x3e0 [ 13.692451][ T317] ? wake_up_klogd_work_func+0x90/0x90 [ 13.692456][ T317] ? gact_cleanup_module+0xf0/0xf0 [act_gact] [ 13.692459][ T317] _printk+0xc7/0x100 [ 13.692463][ T317] ? snapshot_read.cold+0x21/0x21 [ 13.692469][ T317] ? do_one_initcall+0x113/0x4f0 [ 13.692472][ T317] gact_init_module+0x15/0x1000 [act_gact] [ 13.692474][ T317] do_one_initcall+0x124/0x4f0 [ 13.692477][ T317] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 13.692482][ T317] ? do_init_module+0xae/0x8a0 [ 13.692485][ T317] ? kasan_unpoison+0x44/0x70 [ 13.692490][ T317] do_init_module+0x2ad/0x8a0 [ 13.692493][ T317] ? lockdep_hardirqs_on+0x91/0x130 [ 13.692497][ T317] ? free_module+0x470/0x470 [ 13.692500][ T317] ? kfree+0x123/0x590 [ 13.692504][ T317] load_module+0x1424/0x1bb0 [ 13.692512][ T317] ? layout_and_allocate.isra.0+0x680/0x680 [ 13.692516][ T317] ? __ia32_sys_fsconfig+0x180/0x180 [ 13.692518][ T317] ? ovl_real_file+0x172/0x1e0 [ 13.692522][ T317] ? find_held_lock+0x2b/0x80 [ 13.692524][ T317] ? backing_file_read_iter+0x541/0x790 [ 13.692527][ T317] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.692531][ T317] init_module_from_file+0x11f/0x1a0 [ 13.692534][ T317] ? __do_sys_init_module+0x220/0x220 [ 13.692542][ T317] ? __rwlock_init+0x150/0x150 [ 13.692545][ T317] ? do_raw_spin_unlock+0x59/0x250 [ 13.692548][ T317] idempotent_init_module+0x37b/0x7c0 [ 13.692552][ T317] ? init_module_from_file+0x1a0/0x1a0 [ 13.692558][ T317] ? rcu_is_watching+0x16/0xd0 [ 13.692561][ T317] ? cap_capable+0x1d7/0x3d0 [ 13.692566][ T317] __x64_sys_finit_module+0xdf/0x190 [ 13.692569][ T317] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.692572][ T317] do_syscall_64+0xff/0x530 [ 13.692574][ T317] ? exc_page_fault+0xee/0x100 [ 13.692577][ T317] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.692579][ T317] RIP: 0033:0x7f8ef53db37d [ 13.692583][ T317] 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 [ 13.692585][ T317] RSP: 002b:00007ffc43496268 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 13.692587][ T317] RAX: ffffffffffffffda RBX: 00005566797e6810 RCX: 00007f8ef53db37d [ 13.692589][ T317] RDX: 0000000000000000 RSI: 000055665a085ffd RDI: 0000000000000000 [ 13.692590][ T317] RBP: 00007ffc43496300 R08: 0000000000000000 R09: 0000000000000000 [ 13.692590][ T317] R10: 0000000000000000 R11: 0000000000000246 R12: 000055665a085ffd [ 13.692591][ T317] R13: 00005566797e6960 R14: 0000000000040000 R15: 0000000000000000 [ 13.692598][ T317] [ 14.273830][ T353] br10: port 1(veth1.10) entered blocking state [ 14.274660][ T353] br10: port 1(veth1.10) entered disabled state [ 14.275013][ T353] veth1.10: entered allmulticast mode [ 14.275260][ T353] veth1: entered allmulticast mode [ 14.277003][ T353] veth1.10: entered promiscuous mode [ 14.277292][ T353] veth1: entered promiscuous mode [ 14.477805][ T369] br11: port 1(veth1.11) entered blocking state [ 14.478403][ T369] br11: port 1(veth1.11) entered disabled state [ 14.478954][ T369] veth1.11: entered allmulticast mode [ 14.482673][ T369] veth1.11: entered promiscuous mode [ 14.877715][ T401] br10: port 2(veth2.10) entered blocking state [ 14.877735][ T401] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.877737][ T401] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 401, name: ip [ 14.877739][ T401] preempt_count: 1, expected: 0 [ 14.877740][ T401] RCU nest depth: 0, expected: 0 [ 14.877741][ T401] locks held by ip/401: 5, last CPU#3: [ 14.877743][ T401] #0: ffffffff94ed2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 14.877755][ T401] #1: ffffffff94769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 14.877762][ T401] #2: ffffffff94769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 14.877766][ T401] #3: ffffffff94689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 14.877770][ T401] #4: ffffffff94689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 14.877775][ T401] irq event stamp: 11628 [ 14.877776][ T401] hardirqs last enabled at (11627): [] __down_trylock_console_sem+0x86/0xa0 [ 14.877778][ T401] hardirqs last disabled at (11628): [] console_emit_next_record+0x3d4/0x4c0 [ 14.877780][ T401] softirqs last enabled at (11570): [] __alloc_skb+0x4c2/0x5f0 [ 14.877784][ T401] softirqs last disabled at (11568): [] __alloc_skb+0x4c2/0x5f0 [ 14.877786][ T401] Preemption disabled at: [ 14.877787][ T401] [] vprintk_emit+0x31b/0x3e0 [ 14.877793][ T401] CPU: 3 UID: 0 PID: 401 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.877796][ T401] Tainted: [W]=WARN [ 14.877797][ T401] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.877799][ T401] Call Trace: [ 14.877801][ T401] [ 14.877803][ T401] dump_stack_lvl+0x6f/0xa0 [ 14.877808][ T401] ? vprintk_emit+0x31b/0x3e0 [ 14.877811][ T401] __might_resched.cold+0x1fe/0x2c1 [ 14.877815][ T401] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.877825][ T401] ? __kmalloc_noprof+0xdb/0x760 [ 14.877830][ T401] __kmalloc_noprof+0x443/0x760 [ 14.877833][ T401] ? alloc_buf.isra.0+0x4b/0x260 [ 14.877838][ T401] ? do_raw_spin_unlock+0x59/0x250 [ 14.877841][ T401] alloc_buf.isra.0+0x4b/0x260 [ 14.877845][ T401] put_chars+0x1e1/0x2f0 [ 14.877847][ T401] ? prb_final_commit+0x50/0x50 [ 14.877849][ T401] ? __send_to_port+0x420/0x420 [ 14.877852][ T401] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.877856][ T401] ? rcu_read_lock_any_held+0x3c/0x90 [ 14.877859][ T401] ? validate_chain+0x38b/0xc20 [ 14.877862][ T401] hvc_console_print+0x292/0x780 [ 14.877865][ T401] ? mark_usage+0x61/0x170 [ 14.877867][ T401] ? __lock_acquire+0x518/0xc20 [ 14.877869][ T401] ? __lock_acquire+0x518/0xc20 [ 14.877873][ T401] ? hvc_write+0x3a0/0x3a0 [ 14.877875][ T401] ? console_emit_next_record+0x1df/0x4c0 [ 14.877878][ T401] ? rcu_is_watching+0x16/0xd0 [ 14.877880][ T401] ? lock_acquire+0x13c/0x160 [ 14.877884][ T401] console_emit_next_record+0x22f/0x4c0 [ 14.877888][ T401] ? devkmsg_read+0x4b0/0x4b0 [ 14.877890][ T401] ? console_flush_one_record+0x106/0x710 [ 14.877893][ T401] ? rcu_is_watching+0x16/0xd0 [ 14.877896][ T401] ? lock_acquire+0x13c/0x160 [ 14.877900][ T401] console_flush_one_record+0x46f/0x710 [ 14.877904][ T401] ? console_emit_next_record+0x4c0/0x4c0 [ 14.877906][ T401] ? __lock_acquire+0x518/0xc20 [ 14.877911][ T401] console_unlock+0xee/0x1f0 [ 14.877914][ T401] ? console_flush_one_record+0x710/0x710 [ 14.877916][ T401] ? rcu_is_watching+0x16/0xd0 [ 14.877919][ T401] ? lock_acquire+0x60/0x160 [ 14.877922][ T401] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.877924][ T401] ? vprintk_emit+0x320/0x3e0 [ 14.877928][ T401] vprintk_emit+0x37c/0x3e0 [ 14.877932][ T401] ? wake_up_klogd_work_func+0x90/0x90 [ 14.877934][ T401] ? __lock_release.isra.0+0x69/0x1a0 [ 14.877940][ T401] _printk+0xc7/0x100 [ 14.877943][ T401] ? snapshot_read.cold+0x21/0x21 [ 14.877947][ T401] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 14.877961][ T401] ? do_setlink.isra.0+0xa31/0x2750 [ 14.877962][ T401] ? rtnl_newlink+0x9f1/0x11c0 [ 14.877964][ T401] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 14.877969][ T401] br_set_state+0x22f/0x430 [bridge] [ 14.877980][ T401] br_init_port+0xc4/0x200 [bridge] [ 14.877989][ T401] new_nbp+0x39c/0x580 [bridge] [ 14.877999][ T401] br_add_if+0x212/0x1320 [bridge] [ 14.878006][ T401] ? is_bpf_text_address+0x72/0x110 [ 14.878010][ T401] ? kernel_text_address+0x149/0x170 [ 14.878014][ T401] ? __kernel_text_address+0x12/0x30 [ 14.878018][ T401] do_set_master+0x357/0x580 [ 14.878023][ T401] do_setlink.isra.0+0xa31/0x2750 [ 14.878026][ T401] ? stack_trace_save+0x93/0xc0 [ 14.878029][ T401] ? rtnl_link_get_size+0x350/0x350 [ 14.878031][ T401] ? rcu_read_lock_any_held+0x66/0x90 [ 14.878033][ T401] ? stack_depot_save_flags+0x38e/0x790 [ 14.878036][ T401] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.878039][ T401] ? rcu_read_lock_any_held+0x3c/0x90 [ 14.878040][ T401] ? validate_chain+0x38b/0xc20 [ 14.878043][ T401] ? kasan_save_stack+0x3d/0x50 [ 14.878046][ T401] ? kasan_save_stack+0x2f/0x50 [ 14.878048][ T401] ? kasan_save_track+0x14/0x30 [ 14.878050][ T401] ? __lock_acquire+0x518/0xc20 [ 14.878052][ T401] ? netlink_seq_next+0x4e/0x60 [ 14.878055][ T401] ? ___sys_sendmsg+0xb0/0x1d0 [ 14.878060][ T401] ? lock_acquire.part.0+0xd4/0x280 [ 14.878062][ T401] ? rtnl_newlink+0x9a8/0x11c0 [ 14.878065][ T401] ? rcu_is_watching+0x16/0xd0 [ 14.878067][ T401] ? lock_acquire+0x13c/0x160 [ 14.878069][ T401] ? rcu_is_watching+0x16/0xd0 [ 14.878071][ T401] ? rcu_is_watching+0x16/0xd0 [ 14.878076][ T401] ? trace_contention_end+0xb3/0x180 [ 14.878080][ T401] ? __mutex_lock+0x1db/0x1ea0 [ 14.878083][ T401] ? __mutex_lock+0x9a3/0x1ea0 [ 14.878086][ T401] ? rtnl_newlink+0x9a8/0x11c0 [ 14.878089][ T401] ? ww_mutex_lock+0x160/0x160 [ 14.878091][ T401] ? nla_get_range_signed+0x3d0/0x3d0 [ 14.878096][ T401] ? __rtnl_newlink+0x3fa/0xa50 [ 14.878101][ T401] rtnl_newlink+0x9f1/0x11c0 [ 14.878107][ T401] ? rtnl_bridge_getlink+0x850/0x850 [ 14.878109][ T401] ? __lock_acquire+0x518/0xc20 [ 14.878114][ T401] ? lock_acquire.part.0+0xd4/0x280 [ 14.878116][ T401] ? find_held_lock+0x2b/0x80 [ 14.878118][ T401] ? rtnl_bridge_getlink+0x850/0x850 [ 14.878120][ T401] ? __lock_release.isra.0+0x69/0x1a0 [ 14.878123][ T401] ? rtnl_bridge_getlink+0x850/0x850 [ 14.878125][ T401] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 14.878129][ T401] ? rtnl_link_fill+0x920/0x920 [ 14.878130][ T401] ? __lock_acquire+0x518/0xc20 [ 14.878135][ T401] ? lock_acquire.part.0+0xd4/0x280 [ 14.878137][ T401] ? find_held_lock+0x2b/0x80 [ 14.878140][ T401] netlink_rcv_skb+0x14e/0x3a0 [ 14.878142][ T401] ? rtnl_link_fill+0x920/0x920 [ 14.878145][ T401] ? netlink_ack+0xcf0/0xcf0 [ 14.878151][ T401] ? netlink_deliver_tap+0xc5/0x330 [ 14.878153][ T401] ? netlink_deliver_tap+0x13c/0x330 [ 14.878157][ T401] netlink_unicast+0x486/0x750 [ 14.878161][ T401] ? netlink_attachskb+0x810/0x810 [ 14.878164][ T401] ? __lock_acquire+0x518/0xc20 [ 14.878169][ T401] netlink_sendmsg+0x735/0xc60 [ 14.878173][ T401] ? netlink_unicast+0x750/0x750 [ 14.878178][ T401] ? __might_fault+0x97/0x140 [ 14.878183][ T401] ____sys_sendmsg+0x415/0x880 [ 14.878185][ T401] ? copy_msghdr_from_user+0x279/0x420 [ 14.878188][ T401] ? get_timestamp.constprop.0+0x390/0x390 [ 14.878190][ T401] ? move_addr_to_kernel+0x40/0x40 [ 14.878197][ T401] ___sys_sendmsg+0x14e/0x1d0 [ 14.878200][ T401] ? copy_msghdr_from_user+0x420/0x420 [ 14.878217][ T401] __sys_sendmsg+0x12c/0x1d0 [ 14.878219][ T401] ? __sys_sendmsg_sock+0x20/0x20 [ 14.878226][ T401] ? rcu_is_watching+0x16/0xd0 [ 14.878230][ T401] do_syscall_64+0xff/0x530 [ 14.878232][ T401] ? exc_page_fault+0xee/0x100 [ 14.878235][ T401] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.878238][ T401] RIP: 0033:0x7fa16141654e [ 14.878241][ T401] 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.878243][ T401] RSP: 002b:00007ffc0082dd00 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 14.878246][ T401] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fa16141654e [ 14.878248][ T401] RDX: 0000000000000000 RSI: 00007ffc0082ddb0 RDI: 0000000000000005 [ 14.878248][ T401] RBP: 00007ffc0082dd10 R08: 0000000000000000 R09: 0000000000000000 [ 14.878249][ T401] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90dab4 [ 14.878250][ T401] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc0082e470 [ 14.878257][ T401] [ 14.922922][ T401] br10: port 2(veth2.10) entered disabled state [ 14.923256][ T401] veth2.10: entered allmulticast mode [ 14.923559][ T401] veth2: entered allmulticast mode [ 14.925633][ T401] veth2.10: entered promiscuous mode [ 14.925913][ T401] veth2: entered promiscuous mode [ 14.946878][ T401] ip (401) used greatest stack depth: 23336 bytes left [ 15.153433][ T418] br11: port 2(veth2.11) entered blocking state [ 15.153778][ T418] br11: port 2(veth2.11) entered disabled state [ 15.154123][ T418] veth2.11: entered allmulticast mode [ 15.155705][ T418] veth2.11: entered promiscuous mode [ 15.366573][ T430] br10: port 2(veth2.10) entered blocking state [ 15.367294][ T430] br10: port 2(veth2.10) entered forwarding state [ 15.367869][ T430] br10: port 1(veth1.10) entered blocking state [ 15.368197][ T430] br10: port 1(veth1.10) entered forwarding state [ 15.450600][ T435] br11: port 2(veth2.11) entered blocking state [ 15.451167][ T435] br11: port 2(veth2.11) entered forwarding state [ 15.452262][ T435] br11: port 1(veth1.11) entered blocking state [ 15.452746][ T435] br11: port 1(veth1.11) entered forwarding state [ 30.577169][ C0] [ 30.577189][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 30.577192][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/0 [ 30.577194][ C0] preempt_count: 104, expected: 0 [ 30.577196][ C0] RCU nest depth: 0, expected: 0 [ 30.577197][ C0] INFO: lockdep is turned off. [ 30.577199][ C0] irq event stamp: 1247320 [ 30.577200][ C0] hardirqs last enabled at (1247320): [] _raw_spin_unlock_irq+0x28/0x50 [ 30.577210][ C0] hardirqs last disabled at (1247319): [] _raw_spin_lock_irq+0x4a/0x50 [ 30.577213][ C0] softirqs last enabled at (1247310): [] handle_softirqs+0x67c/0x900 [ 30.577218][ C0] softirqs last disabled at (1247317): [] __irq_exit_rcu+0x145/0x1c0 [ 30.577220][ C0] Preemption disabled at: [ 30.577221][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 30.577230][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 30.577234][ C0] Tainted: [W]=WARN [ 30.577236][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 30.577238][ C0] Call Trace: [ 30.577241][ C0] [ 30.577243][ C0] dump_stack_lvl+0x6f/0xa0 [ 30.577249][ C0] ? schedule_preempt_disabled+0x22/0x30 [ 30.577252][ C0] __might_resched.cold+0x1fe/0x2c1 [ 30.577256][ C0] ? validate_chain+0x737/0xc20 [ 30.577260][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 30.577264][ C0] ? __asan_memcpy+0x3c/0x60 [ 30.577267][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.577272][ C0] __kmalloc_noprof+0x443/0x760 [ 30.577276][ C0] ? __rwlock_init+0x150/0x150 [ 30.577278][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 30.577283][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 30.577286][ C0] alloc_buf.isra.0+0x4b/0x260 [ 30.577289][ C0] put_chars+0x1e1/0x2f0 [ 30.577291][ C0] ? __send_to_port+0x420/0x420 [ 30.577294][ C0] ? console_prepend_replay+0x20/0x20 [ 30.577299][ C0] hvc_console_print+0x292/0x780 [ 30.577304][ C0] ? hvc_write+0x3a0/0x3a0 [ 30.577306][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.577308][ C0] ? lock_acquire+0x13c/0x160 [ 30.577311][ C0] console_emit_next_record+0x22f/0x4c0 [ 30.577315][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 30.577318][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.577320][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.577323][ C0] ? lock_acquire+0x13c/0x160 [ 30.577326][ C0] ? console_flush_one_record+0x111/0x710 [ 30.577329][ C0] console_flush_one_record+0x46f/0x710 [ 30.577332][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 30.577336][ C0] console_unlock+0xee/0x1f0 [ 30.577339][ C0] ? lock_acquire+0x13c/0x160 [ 30.577341][ C0] ? console_flush_one_record+0x710/0x710 [ 30.577343][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.577345][ C0] ? lock_release+0x184/0x1f0 [ 30.577348][ C0] ? lock_acquire+0x60/0x160 [ 30.577351][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 30.577353][ C0] ? vprintk_emit+0x320/0x3e0 [ 30.577356][ C0] vprintk_emit+0x37c/0x3e0 [ 30.577359][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 30.577362][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.577364][ C0] ? lock_release+0x184/0x1f0 [ 30.577367][ C0] ? x86_64_start_kernel+0xe0/0x130 [ 30.577372][ C0] _printk+0xc7/0x100 [ 30.577376][ C0] ? snapshot_read.cold+0x21/0x21 [ 30.577379][ C0] ? arch_stack_walk+0xd7/0x130 [ 30.577384][ C0] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 30.577387][ C0] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 30.577390][ C0] print_irq_inversion_bug.part.0+0x32/0xc0 [ 30.577393][ C0] mark_lock_irq+0x989/0x9c0 [ 30.577398][ C0] mark_lock+0x1d7/0xa00 [ 30.577401][ C0] mark_usage+0x42/0x170 [ 30.577403][ C0] __lock_acquire+0x388/0xc20 [ 30.577407][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.577410][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 30.577428][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.577431][ C0] ? lock_acquire+0x13c/0x160 [ 30.577434][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 30.577446][ C0] _raw_spin_lock+0x33/0x40 [ 30.577448][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 30.577460][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 30.577472][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 30.577483][ C0] call_timer_fn+0x160/0x4d0 [ 30.577488][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 30.577491][ C0] ? debug_object_active_state+0x430/0x430 [ 30.577495][ C0] ? find_held_lock+0x2b/0x80 [ 30.577498][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 30.577501][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.577504][ C0] __run_timers+0x68f/0xaa0 [ 30.577507][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 30.577520][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 30.577522][ C0] ? __lock_acquire+0x518/0xc20 [ 30.577527][ C0] ? __rwlock_init+0x150/0x150 [ 30.577531][ C0] run_timer_softirq+0xf0/0x160 [ 30.577534][ C0] ? __run_timers+0xaa0/0xaa0 [ 30.577536][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 30.577539][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.577542][ C0] handle_softirqs+0x1d3/0x900 [ 30.577545][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 30.577548][ C0] ? _local_bh_enable+0xc0/0xc0 [ 30.577551][ C0] __irq_exit_rcu+0x145/0x1c0 [ 30.577553][ C0] irq_exit_rcu+0xe/0x30 [ 30.577555][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 30.577559][ C0] [ 30.577560][ C0] [ 30.577561][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 30.577563][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 30.577567][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 30.577571][ C0] Code: 48 8b 3d 94 f2 f5 01 e8 1f 00 00 00 48 2b 05 58 b3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 30.577574][ C0] RSP: 0018:ffffffff94407cf8 EFLAGS: 00000296 [ 30.577578][ C0] RAX: 0000000000130853 RBX: ffffffff9441c600 RCX: ffffffff914f0307 [ 30.577580][ C0] RDX: ffffffff9441c600 RSI: ffffffff94238b1c RDI: ffffffff93c8d8e0 [ 30.577581][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 30.577583][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff2880fa2 [ 30.577584][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 30.577587][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 30.577591][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 30.577594][ C0] default_idle+0x9/0x10 [ 30.577596][ C0] default_idle_call+0x6e/0xb0 [ 30.577599][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 30.577601][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 30.577604][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 30.577607][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.577610][ C0] do_idle+0xd8/0x190 [ 30.577613][ C0] cpu_startup_entry+0x53/0x70 [ 30.577615][ C0] rest_init+0x279/0x280 [ 30.577618][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 30.577622][ C0] ? rest_init+0x280/0x280 [ 30.577625][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 30.577629][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 30.577633][ C0] ? acpi_enable+0x1e4/0x330 [ 30.577636][ C0] start_kernel+0x3af/0x3b0 [ 30.577639][ C0] x86_64_start_reservations+0x24/0x30 [ 30.577642][ C0] x86_64_start_kernel+0x12b/0x130 [ 30.577645][ C0] common_startup_64+0x13e/0x148 [ 30.577651][ C0] [ 30.619376][ C0] ======================================================== [ 30.619802][ C0] WARNING: possible irq lock inversion dependency detected [ 30.620233][ C0] 7.2.0-virtme #1 Tainted: G W [ 30.620518][ C0] -------------------------------------------------------- [ 30.620950][ C0] swapper/0/0 just changed the state of lock: [ 30.621324][ C0] ff1100000f87ae58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 30.621898][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 30.622233][ C0] (fs_reclaim){+.+.}-{0:0} [ 30.622239][ C0] [ 30.622239][ C0] [ 30.622239][ C0] and interrupts could create inverse lock ordering between them. [ 30.622239][ C0] [ 30.623242][ C0] [ 30.623242][ C0] other info that might help us debug this: [ 30.623668][ C0] Chain exists of: [ 30.623668][ C0] &br->lock --> console_owner --> fs_reclaim [ 30.623668][ C0] [ 30.624276][ C0] Possible interrupt unsafe locking scenario: [ 30.624276][ C0] [ 30.624708][ C0] CPU0 CPU1 [ 30.624945][ C0] ---- ---- [ 30.625259][ C0] lock(fs_reclaim); [ 30.625433][ C0] local_irq_disable(); [ 30.625806][ C0] lock(&br->lock); [ 30.626101][ C0] lock(console_owner); [ 30.626471][ C0] [ 30.626643][ C0] lock(&br->lock); [ 30.626930][ C0] [ 30.626930][ C0] *** DEADLOCK *** [ 30.626930][ C0] [ 30.627350][ C0] locks held by swapper/0/0: 1, last CPU#0: [ 30.627635][ C0] #0: ffa0000000007c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 30.628197][ C0] [ 30.628197][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 30.628675][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 30.629001][ C0] HARDIRQ-ON-W at: [ 30.629181][ C0] __lock_acquire+0x388/0xc20 [ 30.629564][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.629854][ C0] fs_reclaim_acquire+0xd5/0x120 [ 30.630234][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 30.630658][ C0] kthread_create_worker_on_node+0xea/0x210 [ 30.631004][ C0] workqueue_init+0x2a/0x680 [ 30.631379][ C0] kernel_init_freeable+0x2fe/0x630 [ 30.631809][ C0] kernel_init+0x21/0x150 [ 30.632103][ C0] ret_from_fork+0x474/0x6b0 [ 30.632483][ C0] ret_from_fork_asm+0x11/0x20 [ 30.632833][ C0] SOFTIRQ-ON-W at: [ 30.632994][ C0] __lock_acquire+0x388/0xc20 [ 30.633367][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.633656][ C0] fs_reclaim_acquire+0xd5/0x120 [ 30.634035][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 30.634471][ C0] kthread_create_worker_on_node+0xea/0x210 [ 30.634822][ C0] workqueue_init+0x2a/0x680 [ 30.635193][ C0] kernel_init_freeable+0x2fe/0x630 [ 30.635629][ C0] kernel_init+0x21/0x150 [ 30.635924][ C0] ret_from_fork+0x474/0x6b0 [ 30.636304][ C0] ret_from_fork_asm+0x11/0x20 [ 30.636680][ C0] INITIAL USE at: [ 30.636864][ C0] __lock_acquire+0x388/0xc20 [ 30.637246][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.637533][ C0] fs_reclaim_acquire+0xd5/0x120 [ 30.637921][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 30.638356][ C0] kthread_create_worker_on_node+0xea/0x210 [ 30.638700][ C0] workqueue_init+0x2a/0x680 [ 30.639084][ C0] kernel_init_freeable+0x2fe/0x630 [ 30.639457][ C0] kernel_init+0x21/0x150 [ 30.639751][ C0] ret_from_fork+0x474/0x6b0 [ 30.640138][ C0] ret_from_fork_asm+0x11/0x20 [ 30.640426][ C0] } [ 30.640633][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 30.640978][ C0] ... acquired at: [ 30.641244][ C0] __lock_acquire+0x518/0xc20 [ 30.641479][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.641796][ C0] fs_reclaim_acquire+0xd5/0x120 [ 30.642031][ C0] __kmalloc_noprof+0xd3/0x760 [ 30.642349][ C0] alloc_buf.isra.0+0x4b/0x260 [ 30.642578][ C0] put_chars+0x1e1/0x2f0 [ 30.642899][ C0] hvc_console_print+0x292/0x780 [ 30.643127][ C0] console_emit_next_record+0x22f/0x4c0 [ 30.643446][ C0] console_flush_one_record+0x46f/0x710 [ 30.643674][ C0] console_unlock+0xee/0x1f0 [ 30.643998][ C0] vprintk_emit+0x37c/0x3e0 [ 30.644226][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 30.644548][ C0] dev_printk_emit+0xb9/0xee [ 30.644773][ C0] _dev_info+0xe2/0x116 [ 30.645039][ C0] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 30.645322][ C0] cmos_do_probe+0x73b/0x98a [ 30.645649][ C0] platform_probe+0xfe/0x1f0 [ 30.645882][ C0] call_driver_probe+0x61/0x1c0 [ 30.646204][ C0] really_probe+0x199/0x760 [ 30.646434][ C0] __driver_probe_device+0x24f/0x440 [ 30.646755][ C0] driver_probe_device+0x4a/0xf0 [ 30.646989][ C0] __driver_attach+0x1b8/0x540 [ 30.647303][ C0] bus_for_each_dev+0x130/0x1e0 [ 30.647532][ C0] bus_add_driver+0x2c8/0x530 [ 30.647861][ C0] driver_register+0x1a3/0x390 [ 30.648088][ C0] __platform_driver_probe+0x13f/0x270 [ 30.648400][ C0] cmos_init+0x31/0x40 [ 30.648576][ C0] do_one_initcall+0x124/0x4f0 [ 30.648906][ C0] kernel_init_freeable+0x596/0x630 [ 30.649102][ C0] kernel_init+0x21/0x150 [ 30.649376][ C0] ret_from_fork+0x474/0x6b0 [ 30.649603][ C0] ret_from_fork_asm+0x11/0x20 [ 30.649933][ C0] [ 30.650051][ C0] -> (console_owner){....}-{0:0} { [ 30.650287][ C0] INITIAL USE at: [ 30.650552][ C0] } [ 30.650669][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 30.651103][ C0] ... acquired at: [ 30.651274][ C0] __lock_acquire+0x518/0xc20 [ 30.651594][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.651830][ C0] console_lock_spinning_enable+0x5c/0x60 [ 30.652210][ C0] console_emit_next_record+0x1d1/0x4c0 [ 30.652434][ C0] console_flush_one_record+0x46f/0x710 [ 30.652741][ C0] console_unlock+0xee/0x1f0 [ 30.652969][ C0] vprintk_emit+0x37c/0x3e0 [ 30.653275][ C0] _printk+0xc7/0x100 [ 30.653449][ C0] br_set_state+0x22f/0x430 [bridge] [ 30.653773][ C0] br_init_port+0xc4/0x200 [bridge] [ 30.654010][ C0] br_stp_enable_bridge+0x1fc/0x340 [bridge] [ 30.654405][ C0] br_dev_open+0x94/0x120 [bridge] [ 30.654622][ C0] __dev_open+0x2f3/0x610 [ 30.654943][ C0] __dev_change_flags+0x4a4/0x660 [ 30.655166][ C0] netif_change_flags+0x87/0x190 [ 30.655482][ C0] do_setlink.isra.0+0x1cc3/0x2750 [ 30.655706][ C0] rtnl_newlink+0x9f1/0x11c0 [ 30.656026][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 30.656246][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 30.656562][ C0] netlink_unicast+0x486/0x750 [ 30.656790][ C0] netlink_sendmsg+0x735/0xc60 [ 30.657109][ C0] ____sys_sendmsg+0x415/0x880 [ 30.657343][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 30.657659][ C0] __sys_sendmsg+0x12c/0x1d0 [ 30.657890][ C0] do_syscall_64+0xff/0x530 [ 30.658201][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.658483][ C0] [ 30.658687][ C0] -> (&br->lock){+.-.}-{3:3} { [ 30.658927][ C0] HARDIRQ-ON-W at: [ 30.659189][ C0] __lock_acquire+0x388/0xc20 [ 30.659481][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.659848][ C0] _raw_spin_lock_bh+0x38/0x50 [ 30.660137][ C0] br_add_if+0x8c1/0x1320 [bridge] [ 30.660528][ C0] do_set_master+0x357/0x580 [ 30.660920][ C0] do_setlink.isra.0+0xa31/0x2750 [ 30.661206][ C0] rtnl_newlink+0x9f1/0x11c0 [ 30.661568][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 30.661953][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 30.662247][ C0] netlink_unicast+0x486/0x750 [ 30.662629][ C0] netlink_sendmsg+0x735/0xc60 [ 30.662923][ C0] ____sys_sendmsg+0x415/0x880 [ 30.663313][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 30.663686][ C0] __sys_sendmsg+0x12c/0x1d0 [ 30.663982][ C0] do_syscall_64+0xff/0x530 [ 30.664354][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.664796][ C0] IN-SOFTIRQ-W at: [ 30.664977][ C0] __lock_acquire+0x388/0xc20 [ 30.665367][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.665665][ C0] _raw_spin_lock+0x33/0x40 [ 30.666055][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 30.666508][ C0] call_timer_fn+0x160/0x4d0 [ 30.666800][ C0] __run_timers+0x68f/0xaa0 [ 30.667185][ C0] run_timer_softirq+0xf0/0x160 [ 30.667568][ C0] handle_softirqs+0x1d3/0x900 [ 30.667871][ C0] __irq_exit_rcu+0x145/0x1c0 [ 30.668237][ C0] irq_exit_rcu+0xe/0x30 [ 30.668526][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 30.668973][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 30.669413][ C0] pv_native_safe_halt+0xf/0x10 [ 30.669798][ C0] default_idle+0x9/0x10 [ 30.670097][ C0] default_idle_call+0x6e/0xb0 [ 30.670475][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 30.670922][ C0] do_idle+0xd8/0x190 [ 30.671182][ C0] cpu_startup_entry+0x53/0x70 [ 30.671561][ C0] rest_init+0x279/0x280 [ 30.671847][ C0] start_kernel+0x3af/0x3b0 [ 30.672221][ C0] x86_64_start_reservations+0x24/0x30 [ 30.672597][ C0] x86_64_start_kernel+0x12b/0x130 [ 30.672895][ C0] common_startup_64+0x13e/0x148 [ 30.673278][ C0] INITIAL USE at: [ 30.673454][ C0] __lock_acquire+0x388/0xc20 [ 30.673838][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.674128][ C0] _raw_spin_lock_bh+0x38/0x50 [ 30.674514][ C0] br_add_if+0x8c1/0x1320 [bridge] [ 30.674915][ C0] do_set_master+0x357/0x580 [ 30.675207][ C0] do_setlink.isra.0+0xa31/0x2750 [ 30.675599][ C0] rtnl_newlink+0x9f1/0x11c0 [ 30.675989][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 30.676285][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 30.676672][ C0] netlink_unicast+0x486/0x750 [ 30.676970][ C0] netlink_sendmsg+0x735/0xc60 [ 30.677354][ C0] ____sys_sendmsg+0x415/0x880 [ 30.677751][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 30.678047][ C0] __sys_sendmsg+0x12c/0x1d0 [ 30.678433][ C0] do_syscall_64+0xff/0x530 [ 30.678823][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.679178][ C0] } [ 30.679389][ C0] ... key at: [] __key.7+0x0/0x40 [bridge] [ 30.679753][ C0] ... acquired at: [ 30.680029][ C0] mark_lock+0x1d7/0xa00 [ 30.680265][ C0] mark_usage+0x42/0x170 [ 30.680588][ C0] __lock_acquire+0x388/0xc20 [ 30.680824][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.681153][ C0] _raw_spin_lock+0x33/0x40 [ 30.681384][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 30.681773][ C0] call_timer_fn+0x160/0x4d0 [ 30.682009][ C0] __run_timers+0x68f/0xaa0 [ 30.682335][ C0] run_timer_softirq+0xf0/0x160 [ 30.682564][ C0] handle_softirqs+0x1d3/0x900 [ 30.682886][ C0] __irq_exit_rcu+0x145/0x1c0 [ 30.683117][ C0] irq_exit_rcu+0xe/0x30 [ 30.683442][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 30.683730][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 30.684121][ C0] pv_native_safe_halt+0xf/0x10 [ 30.684476][ C0] default_idle+0x9/0x10 [ 30.684716][ C0] default_idle_call+0x6e/0xb0 [ 30.685043][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 30.685339][ C0] do_idle+0xd8/0x190 [ 30.685608][ C0] cpu_startup_entry+0x53/0x70 [ 30.685852][ C0] rest_init+0x279/0x280 [ 30.686086][ C0] start_kernel+0x3af/0x3b0 [ 30.686326][ C0] x86_64_start_reservations+0x24/0x30 [ 30.686650][ C0] x86_64_start_kernel+0x12b/0x130 [ 30.686891][ C0] common_startup_64+0x13e/0x148 [ 30.687209][ C0] [ 30.687318][ C0] [ 30.687318][ C0] stack backtrace: [ 30.687612][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 30.687617][ C0] Tainted: [W]=WARN [ 30.687618][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 30.687620][ C0] Call Trace: [ 30.687622][ C0] [ 30.687624][ C0] dump_stack_lvl+0x6f/0xa0 [ 30.687630][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 30.687635][ C0] mark_lock_irq+0x989/0x9c0 [ 30.687640][ C0] mark_lock+0x1d7/0xa00 [ 30.687644][ C0] mark_usage+0x42/0x170 [ 30.687646][ C0] __lock_acquire+0x388/0xc20 [ 30.687650][ C0] lock_acquire.part.0+0xd4/0x280 [ 30.687653][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 30.687670][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.687675][ C0] ? lock_acquire+0x13c/0x160 [ 30.687678][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 30.687691][ C0] _raw_spin_lock+0x33/0x40 [ 30.687694][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 30.687707][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 30.687719][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 30.687731][ C0] call_timer_fn+0x160/0x4d0 [ 30.687736][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 30.687739][ C0] ? debug_object_active_state+0x430/0x430 [ 30.687744][ C0] ? find_held_lock+0x2b/0x80 [ 30.687747][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 30.687750][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.687754][ C0] __run_timers+0x68f/0xaa0 [ 30.687756][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 30.687770][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 30.687773][ C0] ? __lock_acquire+0x518/0xc20 [ 30.687777][ C0] ? __rwlock_init+0x150/0x150 [ 30.687781][ C0] run_timer_softirq+0xf0/0x160 [ 30.687785][ C0] ? __run_timers+0xaa0/0xaa0 [ 30.687787][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 30.687790][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.687793][ C0] handle_softirqs+0x1d3/0x900 [ 30.687797][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 30.687799][ C0] ? _local_bh_enable+0xc0/0xc0 [ 30.687803][ C0] __irq_exit_rcu+0x145/0x1c0 [ 30.687805][ C0] irq_exit_rcu+0xe/0x30 [ 30.687808][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 30.687811][ C0] [ 30.687812][ C0] [ 30.687813][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 30.687821][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 30.687824][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 30.687827][ C0] Code: 48 8b 3d 94 f2 f5 01 e8 1f 00 00 00 48 2b 05 58 b3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 30.687830][ C0] RSP: 0018:ffffffff94407cf8 EFLAGS: 00000296 [ 30.687834][ C0] RAX: 0000000000130853 RBX: ffffffff9441c600 RCX: ffffffff914f0307 [ 30.687836][ C0] RDX: ffffffff9441c600 RSI: ffffffff94238b1c RDI: ffffffff93c8d8e0 [ 30.687837][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 30.687839][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff2880fa2 [ 30.687840][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 30.687843][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 30.687847][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 30.687849][ C0] default_idle+0x9/0x10 [ 30.687852][ C0] default_idle_call+0x6e/0xb0 [ 30.687854][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 30.687857][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 30.687860][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 30.687863][ C0] ? rcu_is_watching+0x16/0xd0 [ 30.687866][ C0] do_idle+0xd8/0x190 [ 30.687869][ C0] cpu_startup_entry+0x53/0x70 [ 30.687871][ C0] rest_init+0x279/0x280 [ 30.687874][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 30.687879][ C0] ? rest_init+0x280/0x280 [ 30.687882][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 30.687887][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 30.687891][ C0] ? acpi_enable+0x1e4/0x330 [ 30.687894][ C0] start_kernel+0x3af/0x3b0 [ 30.687897][ C0] x86_64_start_reservations+0x24/0x30 [ 30.687900][ C0] x86_64_start_kernel+0x12b/0x130 [ 30.687903][ C0] common_startup_64+0x13e/0x148 [ 30.687909][ C0] [ 39.687222][ T565] br11: port 2(veth2.11) entered disabled state [ 39.687241][ T565] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 39.687243][ T565] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 565, name: ip [ 39.687245][ T565] preempt_count: 202, expected: 0 [ 39.687246][ T565] RCU nest depth: 0, expected: 0 [ 39.687247][ T565] INFO: lockdep is turned off. [ 39.687248][ T565] irq event stamp: 0 [ 39.687249][ T565] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 39.687254][ T565] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 39.687260][ T565] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 39.687262][ T565] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 39.687263][ T565] Preemption disabled at: [ 39.687264][ T565] [<0000000000000000>] 0x0 [ 39.687270][ T565] CPU: 3 UID: 0 PID: 565 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 39.687273][ T565] Tainted: [W]=WARN [ 39.687274][ T565] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 39.687275][ T565] Call Trace: [ 39.687277][ T565] [ 39.687278][ T565] dump_stack_lvl+0x6f/0xa0 [ 39.687284][ T565] __might_resched.cold+0x1fe/0x2c1 [ 39.687288][ T565] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 39.687291][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687295][ T565] __kmalloc_noprof+0x443/0x760 [ 39.687299][ T565] ? __rwlock_init+0x150/0x150 [ 39.687301][ T565] ? alloc_buf.isra.0+0x4b/0x260 [ 39.687305][ T565] ? do_raw_spin_unlock+0x59/0x250 [ 39.687307][ T565] alloc_buf.isra.0+0x4b/0x260 [ 39.687309][ T565] put_chars+0x1e1/0x2f0 [ 39.687311][ T565] ? desc_read_finalized_seq+0x79/0x120 [ 39.687313][ T565] ? __send_to_port+0x420/0x420 [ 39.687315][ T565] ? console_prepend_replay+0x20/0x20 [ 39.687318][ T565] hvc_console_print+0x292/0x780 [ 39.687321][ T565] ? hvc_write+0x3a0/0x3a0 [ 39.687322][ T565] ? do_raw_spin_lock+0x131/0x280 [ 39.687324][ T565] ? __rwlock_init+0x150/0x150 [ 39.687325][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687327][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687328][ T565] ? lock_acquire+0x13c/0x160 [ 39.687331][ T565] console_emit_next_record+0x22f/0x4c0 [ 39.687333][ T565] ? devkmsg_read+0x4b0/0x4b0 [ 39.687335][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687337][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687338][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687340][ T565] ? lock_acquire+0x13c/0x160 [ 39.687342][ T565] ? console_flush_one_record+0x111/0x710 [ 39.687344][ T565] console_flush_one_record+0x46f/0x710 [ 39.687346][ T565] ? console_emit_next_record+0x4c0/0x4c0 [ 39.687349][ T565] console_unlock+0xee/0x1f0 [ 39.687350][ T565] ? lock_acquire+0x13c/0x160 [ 39.687352][ T565] ? console_flush_one_record+0x710/0x710 [ 39.687354][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687355][ T565] ? lock_release+0x184/0x1f0 [ 39.687357][ T565] ? lock_acquire+0x60/0x160 [ 39.687358][ T565] ? __rcu_read_lock+0x30/0x70 [ 39.687360][ T565] ? __down_trylock_console_sem+0x5e/0xa0 [ 39.687362][ T565] ? vprintk_emit+0x320/0x3e0 [ 39.687364][ T565] vprintk_emit+0x37c/0x3e0 [ 39.687369][ T565] ? wake_up_klogd_work_func+0x90/0x90 [ 39.687370][ T565] ? debug_object_assert_init+0x1d9/0x360 [ 39.687374][ T565] ? debug_object_activate+0x4a0/0x4a0 [ 39.687376][ T565] _printk+0xc7/0x100 [ 39.687379][ T565] ? snapshot_read.cold+0x21/0x21 [ 39.687381][ T565] ? __rwlock_init+0x150/0x150 [ 39.687383][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687385][ T565] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.687388][ T565] br_set_state+0x22f/0x430 [bridge] [ 39.687401][ T565] br_stp_disable_port+0x11f/0x390 [bridge] [ 39.687409][ T565] br_stp_disable_bridge+0xb9/0x180 [bridge] [ 39.687416][ T565] br_dev_stop+0x28/0x1a0 [bridge] [ 39.687424][ T565] ? rtnl_is_locked+0x15/0x20 [ 39.687428][ T565] __dev_close_many+0x1c8/0x530 [ 39.687432][ T565] ? netif_open+0x120/0x120 [ 39.687433][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687435][ T565] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.687437][ T565] __dev_change_flags+0x288/0x660 [ 39.687439][ T565] ? netif_set_allmulti+0x250/0x250 [ 39.687441][ T565] ? __kernel_text_address+0x12/0x30 [ 39.687443][ T565] ? write_profile+0xf0/0xf0 [ 39.687446][ T565] ? unwind_get_return_address+0x67/0xd0 [ 39.687449][ T565] netif_change_flags+0x87/0x190 [ 39.687451][ T565] do_setlink.isra.0+0x1cc3/0x2750 [ 39.687453][ T565] ? stack_trace_save+0x93/0xc0 [ 39.687454][ T565] ? rtnl_link_get_size+0x350/0x350 [ 39.687456][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687457][ T565] ? stack_depot_save_flags+0x1bc/0x790 [ 39.687461][ T565] ? kasan_save_stack+0x3d/0x50 [ 39.687464][ T565] ? kasan_save_stack+0x2f/0x50 [ 39.687465][ T565] ? kasan_save_track+0x14/0x30 [ 39.687467][ T565] ? __kasan_kmalloc+0x7b/0x90 [ 39.687468][ T565] ? __kmalloc_cache_noprof+0x29a/0x620 [ 39.687470][ T565] ? rtnl_newlink+0x124/0x11c0 [ 39.687471][ T565] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 39.687472][ T565] ? netlink_rcv_skb+0x14e/0x3a0 [ 39.687475][ T565] ? netlink_unicast+0x486/0x750 [ 39.687476][ T565] ? netlink_sendmsg+0x735/0xc60 [ 39.687477][ T565] ? ____sys_sendmsg+0x415/0x880 [ 39.687480][ T565] ? ___sys_sendmsg+0x14e/0x1d0 [ 39.687481][ T565] ? __sys_sendmsg+0x12c/0x1d0 [ 39.687483][ T565] ? do_syscall_64+0xff/0x530 [ 39.687486][ T565] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 39.687488][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687490][ T565] ? lock_acquire+0x13c/0x160 [ 39.687491][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687493][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687495][ T565] ? trace_contention_end+0xb3/0x180 [ 39.687498][ T565] ? __mutex_lock+0x1db/0x1ea0 [ 39.687500][ T565] ? __mutex_lock+0x9a3/0x1ea0 [ 39.687501][ T565] ? rtnl_newlink+0x9a8/0x11c0 [ 39.687503][ T565] ? ww_mutex_lock+0x160/0x160 [ 39.687505][ T565] ? __rtnl_newlink+0x3fa/0xa50 [ 39.687507][ T565] rtnl_newlink+0x9f1/0x11c0 [ 39.687509][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687511][ T565] ? rtnl_bridge_getlink+0x850/0x850 [ 39.687512][ T565] ? lock_acquire+0x13c/0x160 [ 39.687514][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687516][ T565] ? is_bpf_text_address+0x3e/0x110 [ 39.687519][ T565] ? is_bpf_text_address+0x72/0x110 [ 39.687520][ T565] ? kernel_text_address+0x149/0x170 [ 39.687522][ T565] ? __kernel_text_address+0x12/0x30 [ 39.687523][ T565] ? write_profile+0xf0/0xf0 [ 39.687524][ T565] ? unwind_get_return_address+0x67/0xd0 [ 39.687526][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687527][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687529][ T565] ? cap_capable+0x1d7/0x3d0 [ 39.687532][ T565] ? lock_acquire+0x13c/0x160 [ 39.687534][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687536][ T565] ? rtnl_bridge_getlink+0x850/0x850 [ 39.687537][ T565] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 39.687539][ T565] ? rtnl_link_fill+0x920/0x920 [ 39.687540][ T565] ? filter_irq_stacks+0xd0/0xd0 [ 39.687541][ T565] ? stack_depot_save_flags+0x1bc/0x790 [ 39.687544][ T565] netlink_rcv_skb+0x14e/0x3a0 [ 39.687545][ T565] ? rtnl_link_fill+0x920/0x920 [ 39.687547][ T565] ? lock_release+0x184/0x1f0 [ 39.687548][ T565] ? netlink_ack+0xcf0/0xcf0 [ 39.687549][ T565] ? __netlink_lookup+0xb9/0x6b0 [ 39.687552][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687554][ T565] ? lock_release+0x184/0x1f0 [ 39.687556][ T565] netlink_unicast+0x486/0x750 [ 39.687557][ T565] ? netlink_attachskb+0x810/0x810 [ 39.687559][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687561][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687562][ T565] ? lock_acquire+0x13c/0x160 [ 39.687564][ T565] netlink_sendmsg+0x735/0xc60 [ 39.687566][ T565] ? netlink_unicast+0x750/0x750 [ 39.687568][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687570][ T565] ? lock_release+0x184/0x1f0 [ 39.687572][ T565] ____sys_sendmsg+0x415/0x880 [ 39.687573][ T565] ? copy_msghdr_from_user+0x279/0x420 [ 39.687575][ T565] ? get_timestamp.constprop.0+0x390/0x390 [ 39.687576][ T565] ? move_addr_to_kernel+0x40/0x40 [ 39.687578][ T565] ? filter_irq_stacks+0xd0/0xd0 [ 39.687580][ T565] ___sys_sendmsg+0x14e/0x1d0 [ 39.687582][ T565] ? copy_msghdr_from_user+0x420/0x420 [ 39.687587][ T565] __sys_sendmsg+0x12c/0x1d0 [ 39.687589][ T565] ? __sys_sendmsg_sock+0x20/0x20 [ 39.687592][ T565] ? rcu_is_watching+0x16/0xd0 [ 39.687594][ T565] do_syscall_64+0xff/0x530 [ 39.687595][ T565] ? exc_page_fault+0xee/0x100 [ 39.687597][ T565] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 39.687599][ T565] RIP: 0033:0x7f6f697c154e [ 39.687601][ T565] 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 [ 39.687603][ T565] RSP: 002b:00007ffec16da060 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 39.687607][ T565] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f6f697c154e [ 39.687608][ T565] RDX: 0000000000000000 RSI: 00007ffec16da110 RDI: 0000000000000005 [ 39.687609][ T565] RBP: 00007ffec16da070 R08: 0000000000000000 R09: 0000000000000000 [ 39.687610][ T565] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90dacd [ 39.687610][ T565] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffec16da7d0 [ 39.687613][ T565] [ 39.716146][ T565] br11: port 1(veth1.11) entered disabled state [ 39.725055][ T565] ip (565) used greatest stack depth: 23144 bytes left [ 39.743055][ T567] br10: port 2(veth2.10) entered disabled state [ 39.743511][ T567] br10: port 1(veth1.10) entered disabled state [ 39.795670][ T571] veth2.11: left allmulticast mode [ 39.795896][ T571] veth2.11: left promiscuous mode [ 39.796274][ T571] br11: port 2(veth2.11) entered disabled state [ 39.887484][ T577] veth2.10: left allmulticast mode [ 39.887702][ T577] veth2: left allmulticast mode [ 39.887922][ T577] veth2.10: left promiscuous mode [ 39.889116][ T577] veth2: left promiscuous mode [ 39.889602][ T577] br10: port 2(veth2.10) entered disabled state [ 40.026757][ T590] veth1.11: left allmulticast mode [ 40.026985][ T590] veth1.11: left promiscuous mode [ 40.027350][ T590] br11: port 1(veth1.11) entered disabled state [ 40.115984][ T596] veth1.10: left allmulticast mode [ 40.116650][ T596] veth1: left allmulticast mode [ 40.116874][ T596] veth1.10: left promiscuous mode [ 40.117080][ T596] veth1: left promiscuous mode [ 40.117438][ T596] br10: port 1(veth1.10) entered disabled state