[ 9.285396][ T187] ip (187) used greatest stack depth: 24096 bytes left [ 9.285413][ T187] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.285415][ T187] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 187, name: ip [ 9.285416][ T187] preempt_count: 2, expected: 0 [ 9.285417][ T187] RCU nest depth: 0, expected: 0 [ 9.285418][ T187] locks held by ip/187: 5, last CPU#0: [ 9.285421][ T187] #0: ffffffffa4c027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.285435][ T187] #1: ffffffffa4d69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.285441][ T187] #2: ffffffffa4d69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.285444][ T187] #3: ffffffffa4c89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.285448][ T187] #4: ffffffffa4c89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.285452][ T187] irq event stamp: 32738 [ 9.285453][ T187] hardirqs last enabled at (32737): [] __down_trylock_console_sem+0x86/0xa0 [ 9.285456][ T187] hardirqs last disabled at (32738): [] console_emit_next_record+0x3d4/0x4c0 [ 9.285458][ T187] softirqs last enabled at (31456): [] netlink_release+0x17b/0xcf0 [ 9.285462][ T187] softirqs last disabled at (31454): [] netlink_release+0xd2/0xcf0 [ 9.285464][ T187] Preemption disabled at: [ 9.285465][ T187] [<0000000000000000>] 0x0 [ 9.285471][ T187] CPU: 0 UID: 0 PID: 187 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.285475][ T187] Tainted: [W]=WARN [ 9.285476][ T187] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.285478][ T187] Call Trace: [ 9.285479][ T187] [ 9.285481][ T187] dump_stack_lvl+0x6f/0xa0 [ 9.285487][ T187] __might_resched.cold+0x1fe/0x2c1 [ 9.285492][ T187] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.285496][ T187] ? __kmalloc_noprof+0xdb/0x760 [ 9.285501][ T187] __kmalloc_noprof+0x443/0x760 [ 9.285503][ T187] ? alloc_buf.isra.0+0x4b/0x260 [ 9.285509][ T187] ? do_raw_spin_unlock+0x59/0x250 [ 9.285512][ T187] alloc_buf.isra.0+0x4b/0x260 [ 9.285515][ T187] put_chars+0x1e1/0x2f0 [ 9.285518][ T187] ? __send_to_port+0x420/0x420 [ 9.285519][ T187] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.285524][ T187] ? validate_chain+0x38b/0xc20 [ 9.285529][ T187] hvc_console_print+0x292/0x780 [ 9.285535][ T187] ? hvc_write+0x3a0/0x3a0 [ 9.285537][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.285540][ T187] ? lock_acquire+0x13c/0x160 [ 9.285544][ T187] console_emit_next_record+0x22f/0x4c0 [ 9.285548][ T187] ? devkmsg_read+0x4b0/0x4b0 [ 9.285550][ T187] ? console_flush_one_record+0x106/0x710 [ 9.285553][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.285555][ T187] ? lock_acquire+0x13c/0x160 [ 9.285559][ T187] console_flush_one_record+0x46f/0x710 [ 9.285563][ T187] ? console_emit_next_record+0x4c0/0x4c0 [ 9.285565][ T187] ? __lock_acquire+0x518/0xc20 [ 9.285570][ T187] console_unlock+0xee/0x1f0 [ 9.285573][ T187] ? console_flush_one_record+0x710/0x710 [ 9.285575][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.285577][ T187] ? lock_acquire+0x60/0x160 [ 9.285581][ T187] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.285583][ T187] ? vprintk_emit+0x320/0x3e0 [ 9.285586][ T187] vprintk_emit+0x37c/0x3e0 [ 9.285590][ T187] ? wake_up_klogd_work_func+0x90/0x90 [ 9.285593][ T187] ? __lock_acquire+0x518/0xc20 [ 9.285597][ T187] _printk+0xc7/0x100 [ 9.285601][ T187] ? snapshot_read.cold+0x21/0x21 [ 9.285603][ T187] ? do_raw_spin_lock+0x131/0x280 [ 9.285606][ T187] ? __rwlock_init+0x150/0x150 [ 9.285610][ T187] ? do_raw_spin_lock+0x131/0x280 [ 9.285612][ T187] do_exit.cold+0x82/0x9c [ 9.285616][ T187] ? exit_notify+0x890/0x890 [ 9.285622][ T187] ? __lock_release.isra.0+0x69/0x1a0 [ 9.285625][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.285629][ T187] do_group_exit+0xb8/0x370 [ 9.285632][ T187] __x64_sys_exit_group+0x3c/0x50 [ 9.285634][ T187] x64_sys_call+0x1567/0x1570 [ 9.285636][ T187] do_syscall_64+0xff/0x530 [ 9.285639][ T187] ? exc_page_fault+0xee/0x100 [ 9.285642][ T187] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.285645][ T187] RIP: 0033:0x7f5c323aa1b8 [ 9.285647][ T187] Code: Unable to access opcode bytes at 0x7f5c323aa18e. [ 9.285648][ T187] RSP: 002b:00007ffd0313e0c8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.285651][ T187] RAX: ffffffffffffffda RBX: 00007f5c324daf88 RCX: 00007f5c323aa1b8 [ 9.285652][ T187] RDX: 00007f5c320f4fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.285653][ T187] RBP: 00007ffd0313e120 R08: 0000000000000000 R09: 0000000000008010 [ 9.285654][ T187] R10: 00007ffd0313dee0 R11: 0000000000000246 R12: 0000000000000001 [ 9.285655][ T187] R13: 0000000000000000 R14: 00007f5c324d9680 R15: 00007f5c324dafa0 [ 9.285661][ T187] [ 9.671534][ T206] ip (206) used greatest stack depth: 23968 bytes left [ 10.286200][ T240] 8021q: 802.1Q VLAN Support v1.8 [ 10.286219][ T240] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.286221][ T240] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 240, name: modprobe [ 10.286223][ T240] preempt_count: 1, expected: 0 [ 10.286224][ T240] RCU nest depth: 0, expected: 0 [ 10.286225][ T240] locks held by modprobe/240: 4, last CPU#0: [ 10.286227][ T240] #0: ffffffffa4d69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.286239][ T240] #1: ffffffffa4d69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.286243][ T240] #2: ffffffffa4c89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.286247][ T240] #3: ffffffffa4c89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.286252][ T240] irq event stamp: 29560 [ 10.286252][ T240] hardirqs last enabled at (29559): [] __down_trylock_console_sem+0x86/0xa0 [ 10.286255][ T240] hardirqs last disabled at (29560): [] console_emit_next_record+0x3d4/0x4c0 [ 10.286257][ T240] softirqs last enabled at (26612): [] handle_softirqs+0x67c/0x900 [ 10.286260][ T240] softirqs last disabled at (26605): [] __irq_exit_rcu+0x145/0x1c0 [ 10.286262][ T240] Preemption disabled at: [ 10.286263][ T240] [] vprintk_emit+0x31b/0x3e0 [ 10.286268][ T240] CPU: 0 UID: 0 PID: 240 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.286272][ T240] Tainted: [W]=WARN [ 10.286273][ T240] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.286274][ T240] Call Trace: [ 10.286276][ T240] [ 10.286277][ T240] dump_stack_lvl+0x6f/0xa0 [ 10.286283][ T240] ? vprintk_emit+0x31b/0x3e0 [ 10.286285][ T240] __might_resched.cold+0x1fe/0x2c1 [ 10.286290][ T240] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.286294][ T240] ? __kmalloc_noprof+0xdb/0x760 [ 10.286299][ T240] __kmalloc_noprof+0x443/0x760 [ 10.286301][ T240] ? alloc_buf.isra.0+0x4b/0x260 [ 10.286307][ T240] ? do_raw_spin_unlock+0x59/0x250 [ 10.286309][ T240] alloc_buf.isra.0+0x4b/0x260 [ 10.286313][ T240] put_chars+0x1e1/0x2f0 [ 10.286315][ T240] ? __send_to_port+0x420/0x420 [ 10.286317][ T240] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.286322][ T240] ? rcu_read_lock_any_held+0x3c/0x90 [ 10.286324][ T240] ? validate_chain+0x38b/0xc20 [ 10.286328][ T240] hvc_console_print+0x292/0x780 [ 10.286331][ T240] ? __lock_acquire+0x518/0xc20 [ 10.286336][ T240] ? hvc_write+0x3a0/0x3a0 [ 10.286338][ T240] ? rcu_is_watching+0x16/0xd0 [ 10.286343][ T240] console_emit_next_record+0x22f/0x4c0 [ 10.286347][ T240] ? devkmsg_read+0x4b0/0x4b0 [ 10.286349][ T240] ? console_flush_one_record+0x106/0x710 [ 10.286352][ T240] ? rcu_is_watching+0x16/0xd0 [ 10.286354][ T240] ? lock_acquire+0x13c/0x160 [ 10.286358][ T240] console_flush_one_record+0x46f/0x710 [ 10.286362][ T240] ? console_emit_next_record+0x4c0/0x4c0 [ 10.286364][ T240] ? __lock_acquire+0x518/0xc20 [ 10.286369][ T240] console_unlock+0xee/0x1f0 [ 10.286372][ T240] ? console_flush_one_record+0x710/0x710 [ 10.286373][ T240] ? rcu_is_watching+0x16/0xd0 [ 10.286376][ T240] ? lock_acquire+0x60/0x160 [ 10.286379][ T240] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.286381][ T240] ? vprintk_emit+0x320/0x3e0 [ 10.286384][ T240] vprintk_emit+0x37c/0x3e0 [ 10.286388][ T240] ? wake_up_klogd_work_func+0x90/0x90 [ 10.286393][ T240] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 10.286397][ T240] _printk+0xc7/0x100 [ 10.286401][ T240] ? snapshot_read.cold+0x21/0x21 [ 10.286407][ T240] ? do_one_initcall+0x113/0x4f0 [ 10.286410][ T240] vlan_proto_init+0x24/0x90 [8021q] [ 10.286413][ T240] do_one_initcall+0x124/0x4f0 [ 10.286416][ T240] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 10.286421][ T240] ? do_init_module+0xae/0x8a0 [ 10.286426][ T240] ? kasan_unpoison+0x44/0x70 [ 10.286431][ T240] do_init_module+0x2ad/0x8a0 [ 10.286434][ T240] ? lockdep_hardirqs_on+0x91/0x130 [ 10.286438][ T240] ? free_module+0x470/0x470 [ 10.286441][ T240] ? kfree+0x123/0x590 [ 10.286445][ T240] load_module+0x1424/0x1bb0 [ 10.286452][ T240] ? layout_and_allocate.isra.0+0x680/0x680 [ 10.286456][ T240] ? __ia32_sys_fsconfig+0x180/0x180 [ 10.286459][ T240] ? ovl_real_file+0x172/0x1e0 [ 10.286463][ T240] ? backing_file_read_iter+0x541/0x790 [ 10.286465][ T240] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.286469][ T240] init_module_from_file+0x11f/0x1a0 [ 10.286472][ T240] ? __do_sys_init_module+0x220/0x220 [ 10.286480][ T240] ? __rwlock_init+0x150/0x150 [ 10.286483][ T240] ? do_raw_spin_unlock+0x59/0x250 [ 10.286486][ T240] idempotent_init_module+0x37b/0x7c0 [ 10.286490][ T240] ? init_module_from_file+0x1a0/0x1a0 [ 10.286496][ T240] ? rcu_is_watching+0x16/0xd0 [ 10.286498][ T240] ? cap_capable+0x1d7/0x3d0 [ 10.286504][ T240] __x64_sys_finit_module+0xdf/0x190 [ 10.286506][ T240] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.286509][ T240] do_syscall_64+0xff/0x530 [ 10.286511][ T240] ? exc_page_fault+0xee/0x100 [ 10.286514][ T240] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.286516][ T240] RIP: 0033:0x7f90bc67e37d [ 10.286519][ T240] 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 [ 10.286521][ T240] RSP: 002b:00007ffffe2e8588 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.286523][ T240] RAX: ffffffffffffffda RBX: 000055eae5da5810 RCX: 00007f90bc67e37d [ 10.286525][ T240] RDX: 0000000000000000 RSI: 000055eac6d5bffd RDI: 0000000000000000 [ 10.286526][ T240] RBP: 00007ffffe2e8620 R08: 0000000000000000 R09: 0000000000000000 [ 10.286526][ T240] R10: 0000000000000000 R11: 0000000000000246 R12: 000055eac6d5bffd [ 10.286527][ T240] R13: 000055eae5da5960 R14: 0000000000040000 R15: 0000000000000000 [ 10.286534][ T240] [ 12.365544][ T369] br10: port 1(veth1.10) entered blocking state [ 12.365662][ T369] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.365665][ T369] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 369, name: ip [ 12.365666][ T369] preempt_count: 1, expected: 0 [ 12.365667][ T369] RCU nest depth: 0, expected: 0 [ 12.365668][ T369] locks held by ip/369: 5, last CPU#1: [ 12.365670][ T369] #0: ffffffffa54d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 12.365682][ T369] #1: ffffffffa4d69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.365689][ T369] #2: ffffffffa4d69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.365693][ T369] #3: ffffffffa4c89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.365697][ T369] #4: ffffffffa4c89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.365701][ T369] irq event stamp: 25688 [ 12.365702][ T369] hardirqs last enabled at (25687): [] __down_trylock_console_sem+0x86/0xa0 [ 12.365704][ T369] hardirqs last disabled at (25688): [] console_emit_next_record+0x3d4/0x4c0 [ 12.365707][ T369] softirqs last enabled at (25596): [] __alloc_skb+0x4c2/0x5f0 [ 12.365710][ T369] softirqs last disabled at (25594): [] __alloc_skb+0x4c2/0x5f0 [ 12.365712][ T369] Preemption disabled at: [ 12.365713][ T369] [] vprintk_emit+0x31b/0x3e0 [ 12.365719][ T369] CPU: 1 UID: 0 PID: 369 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.365722][ T369] Tainted: [W]=WARN [ 12.365723][ T369] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.365725][ T369] Call Trace: [ 12.365726][ T369] [ 12.365728][ T369] dump_stack_lvl+0x6f/0xa0 [ 12.365733][ T369] ? vprintk_emit+0x31b/0x3e0 [ 12.365736][ T369] __might_resched.cold+0x1fe/0x2c1 [ 12.365740][ T369] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.365745][ T369] ? __kmalloc_noprof+0xdb/0x760 [ 12.365749][ T369] __kmalloc_noprof+0x443/0x760 [ 12.365752][ T369] ? alloc_buf.isra.0+0x4b/0x260 [ 12.365757][ T369] ? do_raw_spin_unlock+0x59/0x250 [ 12.365760][ T369] alloc_buf.isra.0+0x4b/0x260 [ 12.365763][ T369] put_chars+0x1e1/0x2f0 [ 12.365766][ T369] ? __send_to_port+0x420/0x420 [ 12.365770][ T369] ? validate_chain+0x34a/0xc20 [ 12.365774][ T369] hvc_console_print+0x292/0x780 [ 12.365777][ T369] ? mark_usage+0x61/0x170 [ 12.365778][ T369] ? __lock_acquire+0x518/0xc20 [ 12.365780][ T369] ? __lock_acquire+0x518/0xc20 [ 12.365784][ T369] ? hvc_write+0x3a0/0x3a0 [ 12.365786][ T369] ? console_emit_next_record+0x1df/0x4c0 [ 12.365789][ T369] ? rcu_is_watching+0x16/0xd0 [ 12.365793][ T369] ? lock_acquire+0x13c/0x160 [ 12.365797][ T369] console_emit_next_record+0x22f/0x4c0 [ 12.365801][ T369] ? devkmsg_read+0x4b0/0x4b0 [ 12.365802][ T369] ? console_flush_one_record+0x106/0x710 [ 12.365806][ T369] ? rcu_is_watching+0x16/0xd0 [ 12.365808][ T369] ? lock_acquire+0x13c/0x160 [ 12.365812][ T369] console_flush_one_record+0x46f/0x710 [ 12.365816][ T369] ? console_emit_next_record+0x4c0/0x4c0 [ 12.365818][ T369] ? __lock_acquire+0x518/0xc20 [ 12.365823][ T369] console_unlock+0xee/0x1f0 [ 12.365826][ T369] ? console_flush_one_record+0x710/0x710 [ 12.365827][ T369] ? rcu_is_watching+0x16/0xd0 [ 12.365830][ T369] ? lock_acquire+0x60/0x160 [ 12.365833][ T369] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.365835][ T369] ? vprintk_emit+0x320/0x3e0 [ 12.365838][ T369] vprintk_emit+0x37c/0x3e0 [ 12.365842][ T369] ? wake_up_klogd_work_func+0x90/0x90 [ 12.365845][ T369] ? __lock_release.isra.0+0x69/0x1a0 [ 12.365846][ T369] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.365853][ T369] _printk+0xc7/0x100 [ 12.365856][ T369] ? snapshot_read.cold+0x21/0x21 [ 12.365860][ T369] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 12.365873][ T369] ? do_setlink.isra.0+0xa31/0x2750 [ 12.365874][ T369] ? rtnl_newlink+0x9f1/0x11c0 [ 12.365875][ T369] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.365880][ T369] br_set_state+0x22f/0x430 [bridge] [ 12.365890][ T369] br_init_port+0xc4/0x200 [bridge] [ 12.365898][ T369] new_nbp+0x39c/0x580 [bridge] [ 12.365907][ T369] br_add_if+0x212/0x1320 [bridge] [ 12.365914][ T369] ? is_bpf_text_address+0x72/0x110 [ 12.365919][ T369] ? kernel_text_address+0x149/0x170 [ 12.365921][ T369] ? __kernel_text_address+0x12/0x30 [ 12.365925][ T369] do_set_master+0x357/0x580 [ 12.365930][ T369] do_setlink.isra.0+0xa31/0x2750 [ 12.365933][ T369] ? stack_trace_save+0x93/0xc0 [ 12.365937][ T369] ? rtnl_link_get_size+0x350/0x350 [ 12.365938][ T369] ? rcu_read_lock_any_held+0x66/0x90 [ 12.365940][ T369] ? stack_depot_save_flags+0x38e/0x790 [ 12.365944][ T369] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.365947][ T369] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.365948][ T369] ? validate_chain+0x38b/0xc20 [ 12.365951][ T369] ? kasan_save_stack+0x3d/0x50 [ 12.365954][ T369] ? kasan_save_stack+0x2f/0x50 [ 12.365956][ T369] ? kasan_save_track+0x14/0x30 [ 12.365958][ T369] ? __lock_acquire+0x518/0xc20 [ 12.365960][ T369] ? netlink_seq_next+0x4e/0x60 [ 12.365963][ T369] ? ___sys_sendmsg+0xb0/0x1d0 [ 12.365967][ T369] ? lock_acquire.part.0+0xd4/0x280 [ 12.365969][ T369] ? rtnl_newlink+0x9a8/0x11c0 [ 12.365972][ T369] ? rcu_is_watching+0x16/0xd0 [ 12.365974][ T369] ? lock_acquire+0x13c/0x160 [ 12.365976][ T369] ? rcu_is_watching+0x16/0xd0 [ 12.365978][ T369] ? rcu_is_watching+0x16/0xd0 [ 12.365980][ T369] ? trace_contention_end+0xb3/0x180 [ 12.365984][ T369] ? __mutex_lock+0x1db/0x1ea0 [ 12.365985][ T369] ? __mutex_lock+0x9a3/0x1ea0 [ 12.365987][ T369] ? rtnl_newlink+0x9a8/0x11c0 [ 12.365991][ T369] ? ww_mutex_lock+0x160/0x160 [ 12.365992][ T369] ? nla_get_range_signed+0x3d0/0x3d0 [ 12.365997][ T369] ? __rtnl_newlink+0x3fa/0xa50 [ 12.366002][ T369] rtnl_newlink+0x9f1/0x11c0 [ 12.366008][ T369] ? rtnl_bridge_getlink+0x850/0x850 [ 12.366010][ T369] ? __lock_acquire+0x518/0xc20 [ 12.366014][ T369] ? lock_acquire.part.0+0xd4/0x280 [ 12.366016][ T369] ? find_held_lock+0x2b/0x80 [ 12.366018][ T369] ? rtnl_bridge_getlink+0x850/0x850 [ 12.366020][ T369] ? __lock_release.isra.0+0x69/0x1a0 [ 12.366024][ T369] ? rtnl_bridge_getlink+0x850/0x850 [ 12.366026][ T369] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.366029][ T369] ? rtnl_link_fill+0x920/0x920 [ 12.366030][ T369] ? __lock_acquire+0x518/0xc20 [ 12.366035][ T369] ? lock_acquire.part.0+0xd4/0x280 [ 12.366036][ T369] ? find_held_lock+0x2b/0x80 [ 12.366040][ T369] netlink_rcv_skb+0x14e/0x3a0 [ 12.366042][ T369] ? rtnl_link_fill+0x920/0x920 [ 12.366045][ T369] ? netlink_ack+0xcf0/0xcf0 [ 12.366051][ T369] ? netlink_deliver_tap+0xc5/0x330 [ 12.366052][ T369] ? netlink_deliver_tap+0x13c/0x330 [ 12.366056][ T369] netlink_unicast+0x486/0x750 [ 12.366060][ T369] ? netlink_attachskb+0x810/0x810 [ 12.366063][ T369] ? __lock_acquire+0x518/0xc20 [ 12.366067][ T369] netlink_sendmsg+0x735/0xc60 [ 12.366071][ T369] ? netlink_unicast+0x750/0x750 [ 12.366075][ T369] ? __might_fault+0x97/0x140 [ 12.366080][ T369] ____sys_sendmsg+0x415/0x880 [ 12.366082][ T369] ? copy_msghdr_from_user+0x279/0x420 [ 12.366084][ T369] ? get_timestamp.constprop.0+0x390/0x390 [ 12.366086][ T369] ? move_addr_to_kernel+0x40/0x40 [ 12.366093][ T369] ___sys_sendmsg+0x14e/0x1d0 [ 12.366096][ T369] ? copy_msghdr_from_user+0x420/0x420 [ 12.366112][ T369] __sys_sendmsg+0x12c/0x1d0 [ 12.366115][ T369] ? __sys_sendmsg_sock+0x20/0x20 [ 12.366121][ T369] ? rcu_is_watching+0x16/0xd0 [ 12.366125][ T369] do_syscall_64+0xff/0x530 [ 12.366127][ T369] ? exc_page_fault+0xee/0x100 [ 12.366130][ T369] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.366132][ T369] RIP: 0033:0x7f910718854e [ 12.366136][ T369] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 12.366137][ T369] RSP: 002b:00007fffca3e3f00 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 12.366140][ T369] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f910718854e [ 12.366141][ T369] RDX: 0000000000000000 RSI: 00007fffca3e3fb0 RDI: 0000000000000005 [ 12.366142][ T369] RBP: 00007fffca3e3f10 R08: 0000000000000000 R09: 0000000000000000 [ 12.366143][ T369] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90ded1 [ 12.366144][ T369] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fffca3e4670 [ 12.366151][ T369] [ 12.410578][ T369] br10: port 1(veth1.10) entered disabled state [ 12.410968][ T369] veth1.10: entered allmulticast mode [ 12.411181][ T369] veth1: entered allmulticast mode [ 12.412839][ T369] veth1.10: entered promiscuous mode [ 12.413171][ T369] veth1: entered promiscuous mode [ 12.423391][ T369] ip (369) used greatest stack depth: 23336 bytes left [ 12.470367][ T376] br10: port 2(veth2.10) entered blocking state [ 12.471360][ T376] br10: port 2(veth2.10) entered disabled state [ 12.471732][ T376] veth2.10: entered allmulticast mode [ 12.471998][ T376] veth2: entered allmulticast mode [ 12.473653][ T376] veth2.10: entered promiscuous mode [ 12.473928][ T376] veth2: entered promiscuous mode [ 12.525713][ T381] br10: port 2(veth2.10) entered blocking state [ 12.526203][ T381] br10: port 2(veth2.10) entered forwarding state [ 12.526917][ T381] br10: port 1(veth1.10) entered blocking state [ 12.527274][ T381] br10: port 1(veth1.10) entered forwarding state [ 12.951559][ T417] br11: port 1(veth1.11) entered blocking state [ 12.951941][ T417] br11: port 1(veth1.11) entered disabled state [ 12.952297][ T417] veth1.11: entered allmulticast mode [ 12.954369][ T417] veth1.11: entered promiscuous mode [ 13.012713][ T423] br11: port 2(veth2.11) entered blocking state [ 13.013081][ T423] br11: port 2(veth2.11) entered disabled state [ 13.013395][ T423] veth2.11: entered allmulticast mode [ 13.014996][ T423] veth2.11: entered promiscuous mode [ 13.062233][ T429] br11: port 2(veth2.11) entered blocking state [ 13.062650][ T429] br11: port 2(veth2.11) entered forwarding state [ 13.063120][ T429] br11: port 1(veth1.11) entered blocking state [ 13.063461][ T429] br11: port 1(veth1.11) entered forwarding state [ 13.492590][ T464] br12: port 1(veth1.12) entered blocking state [ 13.492607][ T464] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.492609][ T464] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 464, name: ip [ 13.492611][ T464] preempt_count: 1, expected: 0 [ 13.492612][ T464] RCU nest depth: 0, expected: 0 [ 13.492612][ T464] locks held by ip/464: 5, last CPU#2: [ 13.492615][ T464] #0: ffffffffa54d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 13.492634][ T464] #1: ffffffffa4d69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.492640][ T464] #2: ffffffffa4d69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.492644][ T464] #3: ffffffffa4c89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.492648][ T464] #4: ffffffffa4c89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.492652][ T464] irq event stamp: 21154 [ 13.492653][ T464] hardirqs last enabled at (21153): [] __down_trylock_console_sem+0x86/0xa0 [ 13.492655][ T464] hardirqs last disabled at (21154): [] console_emit_next_record+0x3d4/0x4c0 [ 13.492657][ T464] softirqs last enabled at (21096): [] __alloc_skb+0x4c2/0x5f0 [ 13.492661][ T464] softirqs last disabled at (21094): [] __alloc_skb+0x4c2/0x5f0 [ 13.492663][ T464] Preemption disabled at: [ 13.492664][ T464] [] vprintk_emit+0x31b/0x3e0 [ 13.492669][ T464] CPU: 2 UID: 0 PID: 464 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.492673][ T464] Tainted: [W]=WARN [ 13.492673][ T464] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.492675][ T464] Call Trace: [ 13.492677][ T464] [ 13.492678][ T464] dump_stack_lvl+0x6f/0xa0 [ 13.492684][ T464] ? vprintk_emit+0x31b/0x3e0 [ 13.492686][ T464] __might_resched.cold+0x1fe/0x2c1 [ 13.492691][ T464] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.492695][ T464] ? __kmalloc_noprof+0xdb/0x760 [ 13.492700][ T464] __kmalloc_noprof+0x443/0x760 [ 13.492702][ T464] ? alloc_buf.isra.0+0x4b/0x260 [ 13.492708][ T464] ? do_raw_spin_unlock+0x59/0x250 [ 13.492710][ T464] alloc_buf.isra.0+0x4b/0x260 [ 13.492714][ T464] put_chars+0x1e1/0x2f0 [ 13.492716][ T464] ? prb_final_commit+0x50/0x50 [ 13.492718][ T464] ? __send_to_port+0x420/0x420 [ 13.492721][ T464] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.492725][ T464] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.492728][ T464] ? validate_chain+0x38b/0xc20 [ 13.492732][ T464] hvc_console_print+0x292/0x780 [ 13.492734][ T464] ? mark_usage+0x61/0x170 [ 13.492736][ T464] ? __lock_acquire+0x518/0xc20 [ 13.492738][ T464] ? __lock_acquire+0x518/0xc20 [ 13.492741][ T464] ? hvc_write+0x3a0/0x3a0 [ 13.492743][ T464] ? console_emit_next_record+0x1df/0x4c0 [ 13.492747][ T464] ? rcu_is_watching+0x16/0xd0 [ 13.492749][ T464] ? lock_acquire+0x13c/0x160 [ 13.492753][ T464] console_emit_next_record+0x22f/0x4c0 [ 13.492756][ T464] ? devkmsg_read+0x4b0/0x4b0 [ 13.492758][ T464] ? console_flush_one_record+0x106/0x710 [ 13.492761][ T464] ? rcu_is_watching+0x16/0xd0 [ 13.492764][ T464] ? lock_acquire+0x13c/0x160 [ 13.492767][ T464] console_flush_one_record+0x46f/0x710 [ 13.492772][ T464] ? console_emit_next_record+0x4c0/0x4c0 [ 13.492773][ T464] ? __lock_acquire+0x518/0xc20 [ 13.492778][ T464] console_unlock+0xee/0x1f0 [ 13.492781][ T464] ? console_flush_one_record+0x710/0x710 [ 13.492783][ T464] ? rcu_is_watching+0x16/0xd0 [ 13.492785][ T464] ? lock_acquire+0x60/0x160 [ 13.492789][ T464] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.492790][ T464] ? vprintk_emit+0x320/0x3e0 [ 13.492794][ T464] vprintk_emit+0x37c/0x3e0 [ 13.492798][ T464] ? wake_up_klogd_work_func+0x90/0x90 [ 13.492800][ T464] ? __lock_release.isra.0+0x69/0x1a0 [ 13.492805][ T464] _printk+0xc7/0x100 [ 13.492809][ T464] ? snapshot_read.cold+0x21/0x21 [ 13.492812][ T464] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 13.492825][ T464] ? do_setlink.isra.0+0xa31/0x2750 [ 13.492826][ T464] ? rtnl_newlink+0x9f1/0x11c0 [ 13.492828][ T464] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 13.492832][ T464] br_set_state+0x22f/0x430 [bridge] [ 13.492842][ T464] br_init_port+0xc4/0x200 [bridge] [ 13.492850][ T464] new_nbp+0x39c/0x580 [bridge] [ 13.492859][ T464] br_add_if+0x212/0x1320 [bridge] [ 13.492866][ T464] ? is_bpf_text_address+0x72/0x110 [ 13.492870][ T464] ? kernel_text_address+0x149/0x170 [ 13.492873][ T464] ? __kernel_text_address+0x12/0x30 [ 13.492877][ T464] do_set_master+0x357/0x580 [ 13.492881][ T464] do_setlink.isra.0+0xa31/0x2750 [ 13.492884][ T464] ? stack_trace_save+0x93/0xc0 [ 13.492887][ T464] ? rtnl_link_get_size+0x350/0x350 [ 13.492889][ T464] ? rcu_read_lock_any_held+0x66/0x90 [ 13.492890][ T464] ? stack_depot_save_flags+0x38e/0x790 [ 13.492894][ T464] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.492896][ T464] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.492898][ T464] ? validate_chain+0x38b/0xc20 [ 13.492901][ T464] ? kasan_save_stack+0x3d/0x50 [ 13.492904][ T464] ? kasan_save_stack+0x2f/0x50 [ 13.492905][ T464] ? kasan_save_track+0x14/0x30 [ 13.492908][ T464] ? __lock_acquire+0x518/0xc20 [ 13.492910][ T464] ? netlink_seq_next+0x4e/0x60 [ 13.492913][ T464] ? ___sys_sendmsg+0xb0/0x1d0 [ 13.492918][ T464] ? lock_acquire.part.0+0xd4/0x280 [ 13.492920][ T464] ? rtnl_newlink+0x9a8/0x11c0 [ 13.492922][ T464] ? rcu_is_watching+0x16/0xd0 [ 13.492924][ T464] ? lock_acquire+0x13c/0x160 [ 13.492926][ T464] ? rcu_is_watching+0x16/0xd0 [ 13.492928][ T464] ? rcu_is_watching+0x16/0xd0 [ 13.492930][ T464] ? trace_contention_end+0xb3/0x180 [ 13.492934][ T464] ? __mutex_lock+0x1db/0x1ea0 [ 13.492937][ T464] ? __mutex_lock+0x9a3/0x1ea0 [ 13.492939][ T464] ? rtnl_newlink+0x9a8/0x11c0 [ 13.492942][ T464] ? ww_mutex_lock+0x160/0x160 [ 13.492944][ T464] ? nla_get_range_signed+0x3d0/0x3d0 [ 13.492948][ T464] ? __rtnl_newlink+0x3fa/0xa50 [ 13.492953][ T464] rtnl_newlink+0x9f1/0x11c0 [ 13.492958][ T464] ? rtnl_bridge_getlink+0x850/0x850 [ 13.492960][ T464] ? __lock_acquire+0x518/0xc20 [ 13.492965][ T464] ? lock_acquire.part.0+0xd4/0x280 [ 13.492966][ T464] ? find_held_lock+0x2b/0x80 [ 13.492968][ T464] ? rtnl_bridge_getlink+0x850/0x850 [ 13.492970][ T464] ? __lock_release.isra.0+0x69/0x1a0 [ 13.492974][ T464] ? rtnl_bridge_getlink+0x850/0x850 [ 13.492976][ T464] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 13.492979][ T464] ? rtnl_link_fill+0x920/0x920 [ 13.492980][ T464] ? __lock_acquire+0x518/0xc20 [ 13.492984][ T464] ? lock_acquire.part.0+0xd4/0x280 [ 13.492986][ T464] ? find_held_lock+0x2b/0x80 [ 13.492990][ T464] netlink_rcv_skb+0x14e/0x3a0 [ 13.492991][ T464] ? rtnl_link_fill+0x920/0x920 [ 13.492994][ T464] ? netlink_ack+0xcf0/0xcf0 [ 13.493000][ T464] ? netlink_deliver_tap+0xc5/0x330 [ 13.493002][ T464] ? netlink_deliver_tap+0x13c/0x330 [ 13.493006][ T464] netlink_unicast+0x486/0x750 [ 13.493009][ T464] ? netlink_attachskb+0x810/0x810 [ 13.493012][ T464] ? __lock_acquire+0x518/0xc20 [ 13.493016][ T464] netlink_sendmsg+0x735/0xc60 [ 13.493020][ T464] ? netlink_unicast+0x750/0x750 [ 13.493023][ T464] ? __might_fault+0x97/0x140 [ 13.493029][ T464] ____sys_sendmsg+0x415/0x880 [ 13.493031][ T464] ? copy_msghdr_from_user+0x279/0x420 [ 13.493033][ T464] ? get_timestamp.constprop.0+0x390/0x390 [ 13.493035][ T464] ? move_addr_to_kernel+0x40/0x40 [ 13.493042][ T464] ___sys_sendmsg+0x14e/0x1d0 [ 13.493045][ T464] ? copy_msghdr_from_user+0x420/0x420 [ 13.493060][ T464] __sys_sendmsg+0x12c/0x1d0 [ 13.493063][ T464] ? __sys_sendmsg_sock+0x20/0x20 [ 13.493069][ T464] ? rcu_is_watching+0x16/0xd0 [ 13.493072][ T464] do_syscall_64+0xff/0x530 [ 13.493075][ T464] ? exc_page_fault+0xee/0x100 [ 13.493078][ T464] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.493080][ T464] RIP: 0033:0x7f0b1a19c54e [ 13.493083][ T464] 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 [ 13.493085][ T464] RSP: 002b:00007ffc3f3ab510 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 13.493088][ T464] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f0b1a19c54e [ 13.493089][ T464] RDX: 0000000000000000 RSI: 00007ffc3f3ab5c0 RDI: 0000000000000005 [ 13.493090][ T464] RBP: 00007ffc3f3ab520 R08: 0000000000000000 R09: 0000000000000000 [ 13.493091][ T464] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90ded2 [ 13.493092][ T464] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc3f3abc80 [ 13.493099][ T464] [ 13.546353][ T464] br12: port 1(veth1.12) entered disabled state [ 13.546845][ T464] veth1.12: entered allmulticast mode [ 13.548660][ T464] veth1.12: entered promiscuous mode [ 13.610302][ T470] br12: port 2(veth2.12) entered blocking state [ 13.610766][ T470] br12: port 2(veth2.12) entered disabled state [ 13.611124][ T470] veth2.12: entered allmulticast mode [ 13.612758][ T470] veth2.12: entered promiscuous mode [ 13.655525][ T475] br12: port 2(veth2.12) entered blocking state [ 13.655879][ T475] br12: port 2(veth2.12) entered forwarding state [ 13.656348][ T475] br12: port 1(veth1.12) entered blocking state [ 13.656704][ T475] br12: port 1(veth1.12) entered forwarding state [ 28.018510][ C2] [ 28.018530][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 28.018533][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 28.018535][ C2] preempt_count: 104, expected: 0 [ 28.018536][ C2] RCU nest depth: 0, expected: 0 [ 28.018538][ C2] INFO: lockdep is turned off. [ 28.018539][ C2] irq event stamp: 947746 [ 28.018541][ C2] hardirqs last enabled at (947746): [] _raw_spin_unlock_irq+0x28/0x50 [ 28.018551][ C2] hardirqs last disabled at (947745): [] _raw_spin_lock_irq+0x4a/0x50 [ 28.018554][ C2] softirqs last enabled at (947712): [] handle_softirqs+0x67c/0x900 [ 28.018559][ C2] softirqs last disabled at (947743): [] __irq_exit_rcu+0x145/0x1c0 [ 28.018562][ C2] Preemption disabled at: [ 28.018563][ C2] [<0000000000000000>] 0x0 [ 28.018571][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.018576][ C2] Tainted: [W]=WARN [ 28.018577][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.018580][ C2] Call Trace: [ 28.018582][ C2] [ 28.018585][ C2] dump_stack_lvl+0x6f/0xa0 [ 28.018591][ C2] __might_resched.cold+0x1fe/0x2c1 [ 28.018596][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 28.018600][ C2] ? __asan_memcpy+0x3c/0x60 [ 28.018604][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.018608][ C2] __kmalloc_noprof+0x443/0x760 [ 28.018613][ C2] ? __rwlock_init+0x150/0x150 [ 28.018616][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 28.018621][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 28.018623][ C2] alloc_buf.isra.0+0x4b/0x260 [ 28.018626][ C2] put_chars+0x1e1/0x2f0 [ 28.018629][ C2] ? __send_to_port+0x420/0x420 [ 28.018632][ C2] ? console_prepend_replay+0x20/0x20 [ 28.018636][ C2] hvc_console_print+0x292/0x780 [ 28.018641][ C2] ? hvc_write+0x3a0/0x3a0 [ 28.018643][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.018646][ C2] ? lock_acquire+0x13c/0x160 [ 28.018649][ C2] console_emit_next_record+0x22f/0x4c0 [ 28.018658][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 28.018661][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.018664][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.018666][ C2] ? lock_acquire+0x13c/0x160 [ 28.018669][ C2] ? console_flush_one_record+0x111/0x710 [ 28.018671][ C2] console_flush_one_record+0x46f/0x710 [ 28.018675][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 28.018679][ C2] console_unlock+0xee/0x1f0 [ 28.018682][ C2] ? lock_acquire+0x13c/0x160 [ 28.018684][ C2] ? console_flush_one_record+0x710/0x710 [ 28.018686][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.018688][ C2] ? lock_release+0x184/0x1f0 [ 28.018690][ C2] ? lock_acquire+0x60/0x160 [ 28.018693][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 28.018696][ C2] ? vprintk_emit+0x320/0x3e0 [ 28.018699][ C2] vprintk_emit+0x37c/0x3e0 [ 28.018703][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 28.018706][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.018723][ C2] ? lock_release+0x184/0x1f0 [ 28.018725][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.018736][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.018747][ C2] ? is_module_text_address+0x154/0x250 [ 28.018751][ C2] _printk+0xc7/0x100 [ 28.018755][ C2] ? snapshot_read.cold+0x21/0x21 [ 28.018758][ C2] ? arch_stack_walk+0xd7/0x130 [ 28.018762][ C2] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 28.018766][ C2] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 28.018768][ C2] print_irq_inversion_bug.part.0+0x32/0xc0 [ 28.018771][ C2] mark_lock_irq+0x989/0x9c0 [ 28.018776][ C2] mark_lock+0x1d7/0xa00 [ 28.018779][ C2] mark_usage+0x42/0x170 [ 28.018781][ C2] __lock_acquire+0x388/0xc20 [ 28.018784][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.018787][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.018798][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.018801][ C2] ? lock_acquire+0x13c/0x160 [ 28.018803][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.018814][ C2] _raw_spin_lock+0x33/0x40 [ 28.018817][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.018827][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.018839][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.018850][ C2] call_timer_fn+0x160/0x4d0 [ 28.018853][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 28.018856][ C2] ? debug_object_active_state+0x430/0x430 [ 28.018860][ C2] ? find_held_lock+0x2b/0x80 [ 28.018863][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 28.018865][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.018869][ C2] __run_timers+0x68f/0xaa0 [ 28.018871][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.018883][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 28.018886][ C2] ? __lock_acquire+0x518/0xc20 [ 28.018890][ C2] ? __rwlock_init+0x150/0x150 [ 28.018894][ C2] run_timer_softirq+0xf0/0x160 [ 28.018897][ C2] ? __run_timers+0xaa0/0xaa0 [ 28.018899][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.018902][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.018905][ C2] handle_softirqs+0x1d3/0x900 [ 28.018908][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 28.018911][ C2] ? _local_bh_enable+0xc0/0xc0 [ 28.018914][ C2] __irq_exit_rcu+0x145/0x1c0 [ 28.018916][ C2] irq_exit_rcu+0xe/0x30 [ 28.018918][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.018922][ C2] [ 28.018923][ C2] [ 28.018924][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 28.018926][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.018929][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 28.018933][ C2] 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 [ 28.018935][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 28.018939][ C2] RAX: 00000000000e761d RBX: ff11000001bec6c0 RCX: ffffffffa1af0307 [ 28.018941][ C2] RDX: ff11000001bec6c0 RSI: ffffffffa4838b1c RDI: ffffffffa428d8e0 [ 28.018943][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 28.018944][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 28.018945][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 28.018948][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.018952][ C2] default_idle+0x9/0x10 [ 28.018954][ C2] default_idle_call+0x6e/0xb0 [ 28.018957][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.018959][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 28.018962][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 28.018965][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.018967][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.018970][ C2] do_idle+0xd8/0x190 [ 28.018972][ C2] cpu_startup_entry+0x53/0x70 [ 28.018974][ C2] start_secondary+0x204/0x2b0 [ 28.018977][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 28.018980][ C2] common_startup_64+0x13e/0x148 [ 28.018986][ C2] [ 28.046433][ C2] ======================================================== [ 28.046905][ C2] WARNING: possible irq lock inversion dependency detected [ 28.047293][ C2] 7.2.0-virtme #1 Tainted: G W [ 28.047636][ C2] -------------------------------------------------------- [ 28.048025][ C2] swapper/2/0 just changed the state of lock: [ 28.048506][ C2] ff1100000fd42e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.049249][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 28.049620][ C2] (fs_reclaim){+.+.}-{0:0} [ 28.049625][ C2] [ 28.049625][ C2] [ 28.049625][ C2] and interrupts could create inverse lock ordering between them. [ 28.049625][ C2] [ 28.050526][ C2] [ 28.050526][ C2] other info that might help us debug this: [ 28.050825][ C2] Chain exists of: [ 28.050825][ C2] &br->lock --> console_owner --> fs_reclaim [ 28.050825][ C2] [ 28.051591][ C2] Possible interrupt unsafe locking scenario: [ 28.051591][ C2] [ 28.052004][ C2] CPU0 CPU1 [ 28.052220][ C2] ---- ---- [ 28.052430][ C2] lock(fs_reclaim); [ 28.052586][ C2] local_irq_disable(); [ 28.052869][ C2] lock(&br->lock); [ 28.053135][ C2] lock(console_owner); [ 28.053400][ C2] [ 28.053639][ C2] lock(&br->lock); [ 28.053806][ C2] [ 28.053806][ C2] *** DEADLOCK *** [ 28.053806][ C2] [ 28.054253][ C2] locks held by swapper/2/0: 1, last CPU#2: [ 28.054811][ C2] #0: ffa0000000228c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 28.055233][ C2] [ 28.055233][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 28.055592][ C2] -> (fs_reclaim){+.+.}-{0:0} { [ 28.055805][ C2] HARDIRQ-ON-W at: [ 28.056039][ C2] __lock_acquire+0x388/0xc20 [ 28.056315][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.056667][ C2] fs_reclaim_acquire+0xd5/0x120 [ 28.056936][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 28.057251][ C2] kthread_create_worker_on_node+0xea/0x210 [ 28.057729][ C2] workqueue_init+0x2a/0x680 [ 28.057997][ C2] kernel_init_freeable+0x2fe/0x630 [ 28.058315][ C2] kernel_init+0x21/0x150 [ 28.058670][ C2] ret_from_fork+0x474/0x6b0 [ 28.059011][ C2] ret_from_fork_asm+0x11/0x20 [ 28.059275][ C2] SOFTIRQ-ON-W at: [ 28.059432][ C2] __lock_acquire+0x388/0xc20 [ 28.059782][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.065394][ C2] fs_reclaim_acquire+0xd5/0x120 [ 28.065909][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 28.066235][ C2] kthread_create_worker_on_node+0xea/0x210 [ 28.066554][ C2] workqueue_init+0x2a/0x680 [ 28.066823][ C2] kernel_init_freeable+0x2fe/0x630 [ 28.067546][ C2] kernel_init+0x21/0x150 [ 28.067908][ C2] ret_from_fork+0x474/0x6b0 [ 28.068175][ C2] ret_from_fork_asm+0x11/0x20 [ 28.068442][ C2] INITIAL USE at: [ 28.068595][ C2] __lock_acquire+0x388/0xc20 [ 28.068942][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.069209][ C2] fs_reclaim_acquire+0xd5/0x120 [ 28.069469][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 28.069798][ C2] kthread_create_worker_on_node+0xea/0x210 [ 28.070282][ C2] workqueue_init+0x2a/0x680 [ 28.070546][ C2] kernel_init_freeable+0x2fe/0x630 [ 28.070815][ C2] kernel_init+0x21/0x150 [ 28.071085][ C2] ret_from_fork+0x474/0x6b0 [ 28.071417][ C2] ret_from_fork_asm+0x11/0x20 [ 28.071685][ C2] } [ 28.071874][ C2] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 28.072503][ C2] ... acquired at: [ 28.072669][ C2] __lock_acquire+0x518/0xc20 [ 28.072872][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.073076][ C2] fs_reclaim_acquire+0xd5/0x120 [ 28.073371][ C2] __kmalloc_noprof+0xd3/0x760 [ 28.073583][ C2] alloc_buf.isra.0+0x4b/0x260 [ 28.073879][ C2] put_chars+0x1e1/0x2f0 [ 28.074088][ C2] hvc_console_print+0x292/0x780 [ 28.074528][ C2] console_emit_next_record+0x22f/0x4c0 [ 28.074727][ C2] console_flush_one_record+0x46f/0x710 [ 28.075067][ C2] console_unlock+0xee/0x1f0 [ 28.075275][ C2] vprintk_emit+0x37c/0x3e0 [ 28.075483][ C2] _printk+0xc7/0x100 [ 28.075726][ C2] dm_interface_init+0x50/0x60 [ 28.075935][ C2] dm_init+0x51/0xd0 [ 28.076088][ C2] do_one_initcall+0x124/0x4f0 [ 28.076600][ C2] kernel_init_freeable+0x596/0x630 [ 28.076829][ C2] kernel_init+0x21/0x150 [ 28.077200][ C2] ret_from_fork+0x474/0x6b0 [ 28.077414][ C2] ret_from_fork_asm+0x11/0x20 [ 28.077944][ C2] [ 28.078053][ C2] -> (console_owner){....}-{0:0} { [ 28.078347][ C2] INITIAL USE at: [ 28.078585][ C2] } [ 28.078701][ C2] ... key at: [] console_owner_dep_map+0x0/0x60 [ 28.079084][ C2] ... acquired at: [ 28.079238][ C2] __lock_acquire+0x518/0xc20 [ 28.079525][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.079740][ C2] console_lock_spinning_enable+0x5c/0x60 [ 28.080000][ C2] console_emit_next_record+0x1d1/0x4c0 [ 28.080267][ C2] console_flush_one_record+0x46f/0x710 [ 28.080528][ C2] console_unlock+0xee/0x1f0 [ 28.080725][ C2] vprintk_emit+0x37c/0x3e0 [ 28.080919][ C2] _printk+0xc7/0x100 [ 28.081068][ C2] br_set_state+0x22f/0x430 [bridge] [ 28.081272][ C2] br_init_port+0xc4/0x200 [bridge] [ 28.081473][ C2] br_stp_enable_bridge+0x1fc/0x340 [bridge] [ 28.086597][ C2] br_dev_open+0x94/0x120 [bridge] [ 28.086818][ C2] __dev_open+0x2f3/0x610 [ 28.087019][ C2] __dev_change_flags+0x4a4/0x660 [ 28.087286][ C2] netif_change_flags+0x87/0x190 [ 28.087489][ C2] do_setlink.isra.0+0x1cc3/0x2750 [ 28.087691][ C2] rtnl_newlink+0x9f1/0x11c0 [ 28.088098][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.088293][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 28.088493][ C2] netlink_unicast+0x486/0x750 [ 28.088974][ C2] netlink_sendmsg+0x735/0xc60 [ 28.089237][ C2] ____sys_sendmsg+0x415/0x880 [ 28.089504][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 28.089774][ C2] __sys_sendmsg+0x12c/0x1d0 [ 28.089965][ C2] do_syscall_64+0xff/0x530 [ 28.090228][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.090472][ C2] [ 28.090573][ C2] -> (&br->lock){+.-.}-{3:3} { [ 28.090847][ C2] HARDIRQ-ON-W at: [ 28.090995][ C2] __lock_acquire+0x388/0xc20 [ 28.091316][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.091563][ C2] _raw_spin_lock_bh+0x38/0x50 [ 28.091811][ C2] br_add_if+0x8c1/0x1320 [bridge] [ 28.092067][ C2] do_set_master+0x357/0x580 [ 28.092309][ C2] do_setlink.isra.0+0xa31/0x2750 [ 28.092540][ C2] rtnl_newlink+0x9f1/0x11c0 [ 28.092966][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.093193][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 28.093457][ C2] netlink_unicast+0x486/0x750 [ 28.093854][ C2] netlink_sendmsg+0x735/0xc60 [ 28.094112][ C2] ____sys_sendmsg+0x415/0x880 [ 28.094377][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 28.094719][ C2] __sys_sendmsg+0x12c/0x1d0 [ 28.094975][ C2] do_syscall_64+0xff/0x530 [ 28.095240][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.095717][ C2] IN-SOFTIRQ-W at: [ 28.095878][ C2] __lock_acquire+0x388/0xc20 [ 28.096145][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.096564][ C2] _raw_spin_lock+0x33/0x40 [ 28.096833][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.097156][ C2] call_timer_fn+0x160/0x4d0 [ 28.097419][ C2] __run_timers+0x68f/0xaa0 [ 28.097682][ C2] run_timer_softirq+0xf0/0x160 [ 28.097943][ C2] handle_softirqs+0x1d3/0x900 [ 28.098285][ C2] __irq_exit_rcu+0x145/0x1c0 [ 28.098549][ C2] irq_exit_rcu+0xe/0x30 [ 28.098816][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.099215][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.099530][ C2] pv_native_safe_halt+0xf/0x10 [ 28.099796][ C2] default_idle+0x9/0x10 [ 28.100059][ C2] default_idle_call+0x6e/0xb0 [ 28.100319][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.100714][ C2] do_idle+0xd8/0x190 [ 28.100997][ C2] cpu_startup_entry+0x53/0x70 [ 28.101254][ C2] start_secondary+0x204/0x2b0 [ 28.101515][ C2] common_startup_64+0x13e/0x148 [ 28.101783][ C2] INITIAL USE at: [ 28.102017][ C2] __lock_acquire+0x388/0xc20 [ 28.102283][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.102856][ C2] _raw_spin_lock_bh+0x38/0x50 [ 28.103203][ C2] br_add_if+0x8c1/0x1320 [bridge] [ 28.103555][ C2] do_set_master+0x357/0x580 [ 28.103827][ C2] do_setlink.isra.0+0xa31/0x2750 [ 28.104091][ C2] rtnl_newlink+0x9f1/0x11c0 [ 28.104544][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.104802][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 28.105094][ C2] netlink_unicast+0x486/0x750 [ 28.105409][ C2] netlink_sendmsg+0x735/0xc60 [ 28.105823][ C2] ____sys_sendmsg+0x415/0x880 [ 28.106166][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 28.106485][ C2] __sys_sendmsg+0x12c/0x1d0 [ 28.106734][ C2] do_syscall_64+0xff/0x530 [ 28.107110][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.107473][ C2] } [ 28.107579][ C2] ... key at: [] __key.7+0x0/0x40 [bridge] [ 28.108082][ C2] ... acquired at: [ 28.108239][ C2] mark_lock+0x1d7/0xa00 [ 28.108513][ C2] mark_usage+0x42/0x170 [ 28.108927][ C2] __lock_acquire+0x388/0xc20 [ 28.109131][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.109398][ C2] _raw_spin_lock+0x33/0x40 [ 28.109665][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.110115][ C2] call_timer_fn+0x160/0x4d0 [ 28.110309][ C2] __run_timers+0x68f/0xaa0 [ 28.110508][ C2] run_timer_softirq+0xf0/0x160 [ 28.110709][ C2] handle_softirqs+0x1d3/0x900 [ 28.110902][ C2] __irq_exit_rcu+0x145/0x1c0 [ 28.111158][ C2] irq_exit_rcu+0xe/0x30 [ 28.111430][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.111681][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.112065][ C2] pv_native_safe_halt+0xf/0x10 [ 28.112469][ C2] default_idle+0x9/0x10 [ 28.112675][ C2] default_idle_call+0x6e/0xb0 [ 28.112867][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.113107][ C2] do_idle+0xd8/0x190 [ 28.113263][ C2] cpu_startup_entry+0x53/0x70 [ 28.113536][ C2] start_secondary+0x204/0x2b0 [ 28.113741][ C2] common_startup_64+0x13e/0x148 [ 28.113962][ C2] [ 28.114061][ C2] [ 28.114061][ C2] stack backtrace: [ 28.114310][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.114315][ C2] Tainted: [W]=WARN [ 28.114316][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.114317][ C2] Call Trace: [ 28.114319][ C2] [ 28.114321][ C2] dump_stack_lvl+0x6f/0xa0 [ 28.114328][ C2] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 28.114332][ C2] mark_lock_irq+0x989/0x9c0 [ 28.114337][ C2] mark_lock+0x1d7/0xa00 [ 28.114340][ C2] mark_usage+0x42/0x170 [ 28.114342][ C2] __lock_acquire+0x388/0xc20 [ 28.114345][ C2] lock_acquire.part.0+0xd4/0x280 [ 28.114348][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.114360][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.114364][ C2] ? lock_acquire+0x13c/0x160 [ 28.114367][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.114378][ C2] _raw_spin_lock+0x33/0x40 [ 28.114381][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.114392][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.114404][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.114415][ C2] call_timer_fn+0x160/0x4d0 [ 28.114419][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 28.114421][ C2] ? debug_object_active_state+0x430/0x430 [ 28.114426][ C2] ? find_held_lock+0x2b/0x80 [ 28.114429][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 28.114431][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.114435][ C2] __run_timers+0x68f/0xaa0 [ 28.114437][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.114449][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 28.114451][ C2] ? __lock_acquire+0x518/0xc20 [ 28.114456][ C2] ? __rwlock_init+0x150/0x150 [ 28.114460][ C2] run_timer_softirq+0xf0/0x160 [ 28.114463][ C2] ? __run_timers+0xaa0/0xaa0 [ 28.114465][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.114468][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.114471][ C2] handle_softirqs+0x1d3/0x900 [ 28.114475][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 28.114477][ C2] ? _local_bh_enable+0xc0/0xc0 [ 28.114480][ C2] __irq_exit_rcu+0x145/0x1c0 [ 28.114482][ C2] irq_exit_rcu+0xe/0x30 [ 28.114484][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.114487][ C2] [ 28.114488][ C2] [ 28.114489][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 28.114491][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.114494][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 28.114497][ C2] 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 [ 28.114499][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 28.114502][ C2] RAX: 00000000000e761d RBX: ff11000001bec6c0 RCX: ffffffffa1af0307 [ 28.114504][ C2] RDX: ff11000001bec6c0 RSI: ffffffffa4838b1c RDI: ffffffffa428d8e0 [ 28.114505][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 28.114506][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 28.114508][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 28.114510][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.114514][ C2] default_idle+0x9/0x10 [ 28.114516][ C2] default_idle_call+0x6e/0xb0 [ 28.114519][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.114521][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 28.114523][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 28.114526][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.114528][ C2] ? rcu_is_watching+0x16/0xd0 [ 28.114531][ C2] do_idle+0xd8/0x190 [ 28.114533][ C2] cpu_startup_entry+0x53/0x70 [ 28.114535][ C2] start_secondary+0x204/0x2b0 [ 28.114538][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 28.114541][ C2] common_startup_64+0x13e/0x148 [ 28.114546][ C2] [ 390.858307][ T1971] br12: port 2(veth2.12) entered disabled state [ 390.858323][ T1971] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 390.858325][ T1971] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1971, name: ip [ 390.858327][ T1971] preempt_count: 202, expected: 0 [ 390.858328][ T1971] RCU nest depth: 0, expected: 0 [ 390.858329][ T1971] INFO: lockdep is turned off. [ 390.858330][ T1971] irq event stamp: 0 [ 390.858331][ T1971] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 390.858336][ T1971] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 390.858343][ T1971] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 390.858344][ T1971] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 390.858346][ T1971] Preemption disabled at: [ 390.858347][ T1971] [<0000000000000000>] 0x0 [ 390.858351][ T1971] CPU: 3 UID: 0 PID: 1971 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 390.858355][ T1971] Tainted: [W]=WARN [ 390.858356][ T1971] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 390.858358][ T1971] Call Trace: [ 390.858359][ T1971] [ 390.858360][ T1971] dump_stack_lvl+0x6f/0xa0 [ 390.858366][ T1971] __might_resched.cold+0x1fe/0x2c1 [ 390.858369][ T1971] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 390.858373][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858377][ T1971] __kmalloc_noprof+0x443/0x760 [ 390.858380][ T1971] ? __rwlock_init+0x150/0x150 [ 390.858383][ T1971] ? alloc_buf.isra.0+0x4b/0x260 [ 390.858387][ T1971] ? do_raw_spin_unlock+0x59/0x250 [ 390.858388][ T1971] alloc_buf.isra.0+0x4b/0x260 [ 390.858390][ T1971] put_chars+0x1e1/0x2f0 [ 390.858392][ T1971] ? __send_to_port+0x420/0x420 [ 390.858394][ T1971] ? printk_get_next_message+0x240/0x650 [ 390.858397][ T1971] hvc_console_print+0x292/0x780 [ 390.858400][ T1971] ? hvc_write+0x3a0/0x3a0 [ 390.858403][ T1971] ? __rwlock_init+0x150/0x150 [ 390.858404][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858406][ T1971] ? lock_acquire+0x13c/0x160 [ 390.858408][ T1971] console_emit_next_record+0x22f/0x4c0 [ 390.858410][ T1971] ? devkmsg_read+0x4b0/0x4b0 [ 390.858412][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858414][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858415][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858417][ T1971] ? lock_acquire+0x13c/0x160 [ 390.858419][ T1971] ? console_flush_one_record+0x111/0x710 [ 390.858421][ T1971] console_flush_one_record+0x46f/0x710 [ 390.858425][ T1971] ? console_emit_next_record+0x4c0/0x4c0 [ 390.858427][ T1971] console_unlock+0xee/0x1f0 [ 390.858429][ T1971] ? lock_acquire+0x13c/0x160 [ 390.858431][ T1971] ? console_flush_one_record+0x710/0x710 [ 390.858432][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858434][ T1971] ? lock_release+0x184/0x1f0 [ 390.858435][ T1971] ? lock_acquire+0x60/0x160 [ 390.858437][ T1971] ? __rcu_read_lock+0x30/0x70 [ 390.858439][ T1971] ? __down_trylock_console_sem+0x5e/0xa0 [ 390.858441][ T1971] ? vprintk_emit+0x320/0x3e0 [ 390.858443][ T1971] vprintk_emit+0x37c/0x3e0 [ 390.858445][ T1971] ? wake_up_klogd_work_func+0x90/0x90 [ 390.858447][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858448][ T1971] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 390.858451][ T1971] ? trace_hardirqs_on+0x36/0x40 [ 390.858452][ T1971] _printk+0xc7/0x100 [ 390.858455][ T1971] ? snapshot_read.cold+0x21/0x21 [ 390.858458][ T1971] ? ipv6_mc_down+0x17e/0x2d0 [ 390.858462][ T1971] br_set_state+0x22f/0x430 [bridge] [ 390.858475][ T1971] br_stp_disable_port+0x11f/0x390 [bridge] [ 390.858483][ T1971] br_device_event+0x7b5/0x8f0 [bridge] [ 390.858491][ T1971] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 390.858494][ T1971] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 390.858496][ T1971] ? addrconf_notify+0x2c8/0xf30 [ 390.858500][ T1971] notifier_call_chain+0xae/0x300 [ 390.858503][ T1971] __dev_notify_flags+0x23c/0x3c0 [ 390.858507][ T1971] ? netif_change_name+0x8c0/0x8c0 [ 390.858509][ T1971] ? netif_set_allmulti+0x250/0x250 [ 390.858511][ T1971] ? __kernel_text_address+0x12/0x30 [ 390.858513][ T1971] ? write_profile+0xf0/0xf0 [ 390.858515][ T1971] ? unwind_get_return_address+0x67/0xd0 [ 390.858518][ T1971] netif_change_flags+0xfe/0x190 [ 390.858520][ T1971] do_setlink.isra.0+0x1cc3/0x2750 [ 390.858523][ T1971] ? stack_trace_save+0x93/0xc0 [ 390.858524][ T1971] ? rtnl_link_get_size+0x350/0x350 [ 390.858525][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858527][ T1971] ? stack_depot_save_flags+0x1bc/0x790 [ 390.858531][ T1971] ? kasan_save_stack+0x3d/0x50 [ 390.858533][ T1971] ? kasan_save_stack+0x2f/0x50 [ 390.858535][ T1971] ? kasan_save_track+0x14/0x30 [ 390.858537][ T1971] ? __kasan_kmalloc+0x7b/0x90 [ 390.858538][ T1971] ? __kmalloc_cache_noprof+0x29a/0x620 [ 390.858540][ T1971] ? rtnl_newlink+0x124/0x11c0 [ 390.858541][ T1971] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 390.858542][ T1971] ? netlink_rcv_skb+0x14e/0x3a0 [ 390.858544][ T1971] ? netlink_unicast+0x486/0x750 [ 390.858546][ T1971] ? netlink_sendmsg+0x735/0xc60 [ 390.858547][ T1971] ? ____sys_sendmsg+0x415/0x880 [ 390.858549][ T1971] ? ___sys_sendmsg+0x14e/0x1d0 [ 390.858551][ T1971] ? __sys_sendmsg+0x12c/0x1d0 [ 390.858553][ T1971] ? do_syscall_64+0xff/0x530 [ 390.858554][ T1971] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 390.858557][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858559][ T1971] ? lock_acquire+0x13c/0x160 [ 390.858560][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858562][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858563][ T1971] ? trace_contention_end+0xb3/0x180 [ 390.858566][ T1971] ? __mutex_lock+0x1db/0x1ea0 [ 390.858568][ T1971] ? __mutex_lock+0x9a3/0x1ea0 [ 390.858569][ T1971] ? rtnl_newlink+0x9a8/0x11c0 [ 390.858571][ T1971] ? ww_mutex_lock+0x160/0x160 [ 390.858573][ T1971] ? __rtnl_newlink+0x3fa/0xa50 [ 390.858575][ T1971] rtnl_newlink+0x9f1/0x11c0 [ 390.858576][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858578][ T1971] ? rtnl_bridge_getlink+0x850/0x850 [ 390.858579][ T1971] ? lock_acquire+0x13c/0x160 [ 390.858581][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858582][ T1971] ? is_bpf_text_address+0x3e/0x110 [ 390.858586][ T1971] ? is_bpf_text_address+0x72/0x110 [ 390.858587][ T1971] ? kernel_text_address+0x149/0x170 [ 390.858589][ T1971] ? __kernel_text_address+0x12/0x30 [ 390.858590][ T1971] ? write_profile+0xf0/0xf0 [ 390.858591][ T1971] ? unwind_get_return_address+0x67/0xd0 [ 390.858592][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858594][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858595][ T1971] ? cap_capable+0x1d7/0x3d0 [ 390.858599][ T1971] ? lock_acquire+0x13c/0x160 [ 390.858600][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858602][ T1971] ? rtnl_bridge_getlink+0x850/0x850 [ 390.858603][ T1971] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 390.858605][ T1971] ? rtnl_link_fill+0x920/0x920 [ 390.858606][ T1971] ? filter_irq_stacks+0xd0/0xd0 [ 390.858607][ T1971] ? stack_depot_save_flags+0x1bc/0x790 [ 390.858610][ T1971] netlink_rcv_skb+0x14e/0x3a0 [ 390.858611][ T1971] ? rtnl_link_fill+0x920/0x920 [ 390.858612][ T1971] ? lock_release+0x184/0x1f0 [ 390.858614][ T1971] ? netlink_ack+0xcf0/0xcf0 [ 390.858615][ T1971] ? __netlink_lookup+0xb9/0x6b0 [ 390.858617][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858619][ T1971] ? lock_release+0x184/0x1f0 [ 390.858621][ T1971] netlink_unicast+0x486/0x750 [ 390.858623][ T1971] ? netlink_attachskb+0x810/0x810 [ 390.858624][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858626][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858628][ T1971] ? lock_acquire+0x13c/0x160 [ 390.858629][ T1971] netlink_sendmsg+0x735/0xc60 [ 390.858631][ T1971] ? netlink_unicast+0x750/0x750 [ 390.858633][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858635][ T1971] ? lock_release+0x184/0x1f0 [ 390.858636][ T1971] ____sys_sendmsg+0x415/0x880 [ 390.858638][ T1971] ? copy_msghdr_from_user+0x279/0x420 [ 390.858640][ T1971] ? get_timestamp.constprop.0+0x390/0x390 [ 390.858641][ T1971] ? move_addr_to_kernel+0x40/0x40 [ 390.858642][ T1971] ? filter_irq_stacks+0xd0/0xd0 [ 390.858645][ T1971] ___sys_sendmsg+0x14e/0x1d0 [ 390.858646][ T1971] ? copy_msghdr_from_user+0x420/0x420 [ 390.858651][ T1971] __sys_sendmsg+0x12c/0x1d0 [ 390.858653][ T1971] ? __sys_sendmsg_sock+0x20/0x20 [ 390.858656][ T1971] ? rcu_is_watching+0x16/0xd0 [ 390.858658][ T1971] do_syscall_64+0xff/0x530 [ 390.858659][ T1971] ? exc_page_fault+0xee/0x100 [ 390.858661][ T1971] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 390.858662][ T1971] RIP: 0033:0x7fed5fe8c54e [ 390.858664][ T1971] 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 [ 390.858666][ T1971] RSP: 002b:00007ffd25d6a810 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 390.858670][ T1971] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fed5fe8c54e [ 390.858671][ T1971] RDX: 0000000000000000 RSI: 00007ffd25d6a8c0 RDI: 0000000000000005 [ 390.858672][ T1971] RBP: 00007ffd25d6a820 R08: 0000000000000000 R09: 0000000000000000 [ 390.858673][ T1971] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90e04c [ 390.858674][ T1971] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffd25d6af80 [ 390.858676][ T1971] [ 390.890646][ T1971] ip (1971) used greatest stack depth: 23016 bytes left [ 390.905936][ T1973] br12: port 1(veth1.12) entered disabled state [ 390.950827][ T1978] veth2.12: left allmulticast mode [ 390.951022][ T1978] veth2.12: left promiscuous mode [ 390.951374][ T1978] br12: port 2(veth2.12) entered disabled state [ 390.980437][ T1980] veth1.12: left allmulticast mode [ 390.980600][ T1980] veth1.12: left promiscuous mode [ 390.980891][ T1980] br12: port 1(veth1.12) entered disabled state [ 391.127388][ T1991] br11: port 2(veth2.11) entered disabled state [ 391.148396][ T1993] br11: port 1(veth1.11) entered disabled state [ 391.196529][ T1997] veth2.11: left allmulticast mode [ 391.196704][ T1997] veth2.11: left promiscuous mode [ 391.197005][ T1997] br11: port 2(veth2.11) entered disabled state [ 391.221948][ T1999] veth1.11: left allmulticast mode [ 391.222430][ T1999] veth1.11: left promiscuous mode [ 391.222716][ T1999] br11: port 1(veth1.11) entered disabled state [ 391.352068][ T2007] br10: port 2(veth2.10) entered disabled state [ 391.369905][ T2009] br10: port 1(veth1.10) entered disabled state [ 391.414591][ T2013] veth2.10: left allmulticast mode [ 391.414750][ T2013] veth2: left allmulticast mode [ 391.414893][ T2013] veth2.10: left promiscuous mode [ 391.415028][ T2013] veth2: left promiscuous mode [ 391.415324][ T2013] br10: port 2(veth2.10) entered disabled state [ 391.436493][ T2015] veth1.10: left allmulticast mode [ 391.436657][ T2015] veth1: left allmulticast mode [ 391.436804][ T2015] veth1.10: left promiscuous mode [ 391.436939][ T2015] veth1: left promiscuous mode [ 391.437231][ T2015] br10: port 1(veth1.10) entered disabled state