[ 9.560877][ T187] ip (187) used greatest stack depth: 23792 bytes left [ 9.560892][ T187] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.560894][ T187] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 187, name: ip [ 9.560896][ T187] preempt_count: 2, expected: 0 [ 9.560897][ T187] RCU nest depth: 0, expected: 0 [ 9.560897][ T187] locks held by ip/187: 5, last CPU#0: [ 9.560900][ T187] #0: ffffffffb16027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.560912][ T187] #1: ffffffffb1769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.560918][ T187] #2: ffffffffb1769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.560922][ T187] #3: ffffffffb1689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.560926][ T187] #4: ffffffffb1689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.560930][ T187] irq event stamp: 37824 [ 9.560931][ T187] hardirqs last enabled at (37823): [] __down_trylock_console_sem+0x86/0xa0 [ 9.560934][ T187] hardirqs last disabled at (37824): [] console_emit_next_record+0x3d4/0x4c0 [ 9.560936][ T187] softirqs last enabled at (37818): [] handle_softirqs+0x67c/0x900 [ 9.560938][ T187] softirqs last disabled at (37807): [] __irq_exit_rcu+0x145/0x1c0 [ 9.560940][ T187] Preemption disabled at: [ 9.560941][ T187] [<0000000000000000>] 0x0 [ 9.560947][ T187] CPU: 0 UID: 0 PID: 187 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.560951][ T187] Tainted: [W]=WARN [ 9.560952][ T187] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.560953][ T187] Call Trace: [ 9.560955][ T187] [ 9.560956][ T187] dump_stack_lvl+0x6f/0xa0 [ 9.560963][ T187] __might_resched.cold+0x1fe/0x2c1 [ 9.560968][ T187] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.560972][ T187] ? __kmalloc_noprof+0xdb/0x760 [ 9.560977][ T187] __kmalloc_noprof+0x443/0x760 [ 9.560979][ T187] ? alloc_buf.isra.0+0x4b/0x260 [ 9.560985][ T187] ? do_raw_spin_unlock+0x59/0x250 [ 9.560988][ T187] alloc_buf.isra.0+0x4b/0x260 [ 9.560991][ T187] put_chars+0x1e1/0x2f0 [ 9.560994][ T187] ? __send_to_port+0x420/0x420 [ 9.560995][ T187] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.561000][ T187] ? validate_chain+0x38b/0xc20 [ 9.561005][ T187] hvc_console_print+0x292/0x780 [ 9.561011][ T187] ? hvc_write+0x3a0/0x3a0 [ 9.561013][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.561016][ T187] ? lock_acquire+0x13c/0x160 [ 9.561020][ T187] console_emit_next_record+0x22f/0x4c0 [ 9.561023][ T187] ? devkmsg_read+0x4b0/0x4b0 [ 9.561025][ T187] ? console_flush_one_record+0x106/0x710 [ 9.561028][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.561031][ T187] ? lock_acquire+0x13c/0x160 [ 9.561035][ T187] console_flush_one_record+0x46f/0x710 [ 9.561039][ T187] ? console_emit_next_record+0x4c0/0x4c0 [ 9.561040][ T187] ? __lock_acquire+0x518/0xc20 [ 9.561046][ T187] console_unlock+0xee/0x1f0 [ 9.561048][ T187] ? console_flush_one_record+0x710/0x710 [ 9.561050][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.561052][ T187] ? lock_acquire+0x60/0x160 [ 9.561056][ T187] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.561058][ T187] ? vprintk_emit+0x320/0x3e0 [ 9.561061][ T187] vprintk_emit+0x37c/0x3e0 [ 9.561065][ T187] ? wake_up_klogd_work_func+0x90/0x90 [ 9.561068][ T187] ? __lock_acquire+0x518/0xc20 [ 9.561072][ T187] _printk+0xc7/0x100 [ 9.561076][ T187] ? snapshot_read.cold+0x21/0x21 [ 9.561079][ T187] ? do_raw_spin_lock+0x131/0x280 [ 9.561081][ T187] ? __rwlock_init+0x150/0x150 [ 9.561085][ T187] ? do_raw_spin_lock+0x131/0x280 [ 9.561088][ T187] do_exit.cold+0x82/0x9c [ 9.561091][ T187] ? exit_notify+0x890/0x890 [ 9.561093][ T187] ? __lock_release.isra.0+0x69/0x1a0 [ 9.561096][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.561100][ T187] do_group_exit+0xb8/0x370 [ 9.561103][ T187] __x64_sys_exit_group+0x3c/0x50 [ 9.561105][ T187] x64_sys_call+0x1567/0x1570 [ 9.561107][ T187] do_syscall_64+0xff/0x530 [ 9.561110][ T187] ? exc_page_fault+0xee/0x100 [ 9.561113][ T187] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.561115][ T187] RIP: 0033:0x7f9d323901b8 [ 9.561117][ T187] Code: Unable to access opcode bytes at 0x7f9d3239018e. [ 9.561119][ T187] RSP: 002b:00007ffc1df70488 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.561121][ T187] RAX: ffffffffffffffda RBX: 00007f9d324c0f88 RCX: 00007f9d323901b8 [ 9.561122][ T187] RDX: 00007f9d320dafc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.561123][ T187] RBP: 00007ffc1df704e0 R08: 0000000000000000 R09: 0000000000008010 [ 9.561124][ T187] R10: 00007ffc1df702a0 R11: 0000000000000246 R12: 0000000000000001 [ 9.561125][ T187] R13: 0000000000000000 R14: 00007f9d324bf680 R15: 00007f9d324c0fa0 [ 9.561132][ T187] [ 10.452736][ T240] 8021q: 802.1Q VLAN Support v1.8 [ 12.343224][ T370] br10: port 1(veth1.10) entered blocking state [ 12.343342][ T370] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.343344][ T370] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 370, name: ip [ 12.343345][ T370] preempt_count: 1, expected: 0 [ 12.343346][ T370] RCU nest depth: 0, expected: 0 [ 12.343347][ T370] locks held by ip/370: 5, last CPU#2: [ 12.343350][ T370] #0: ffffffffb1ed2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 12.343362][ T370] #1: ffffffffb1769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.343368][ T370] #2: ffffffffb1769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.343372][ T370] #3: ffffffffb1689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.343376][ T370] #4: ffffffffb1689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.343379][ T370] irq event stamp: 14144 [ 12.343380][ T370] hardirqs last enabled at (14143): [] __down_trylock_console_sem+0x86/0xa0 [ 12.343383][ T370] hardirqs last disabled at (14144): [] console_emit_next_record+0x3d4/0x4c0 [ 12.343385][ T370] softirqs last enabled at (14056): [] __alloc_skb+0x4c2/0x5f0 [ 12.343388][ T370] softirqs last disabled at (14054): [] __alloc_skb+0x4c2/0x5f0 [ 12.343390][ T370] Preemption disabled at: [ 12.343391][ T370] [] vprintk_emit+0x31b/0x3e0 [ 12.343397][ T370] CPU: 2 UID: 0 PID: 370 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.343401][ T370] Tainted: [W]=WARN [ 12.343402][ T370] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.343404][ T370] Call Trace: [ 12.343406][ T370] [ 12.343408][ T370] dump_stack_lvl+0x6f/0xa0 [ 12.343414][ T370] ? vprintk_emit+0x31b/0x3e0 [ 12.343416][ T370] __might_resched.cold+0x1fe/0x2c1 [ 12.343421][ T370] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.343425][ T370] ? __kmalloc_noprof+0xdb/0x760 [ 12.343430][ T370] __kmalloc_noprof+0x443/0x760 [ 12.343432][ T370] ? alloc_buf.isra.0+0x4b/0x260 [ 12.343437][ T370] ? do_raw_spin_unlock+0x59/0x250 [ 12.343440][ T370] alloc_buf.isra.0+0x4b/0x260 [ 12.343443][ T370] put_chars+0x1e1/0x2f0 [ 12.343446][ T370] ? __send_to_port+0x420/0x420 [ 12.343450][ T370] ? validate_chain+0x34a/0xc20 [ 12.343453][ T370] hvc_console_print+0x292/0x780 [ 12.343456][ T370] ? mark_usage+0x61/0x170 [ 12.343458][ T370] ? __lock_acquire+0x518/0xc20 [ 12.343459][ T370] ? __lock_acquire+0x518/0xc20 [ 12.343463][ T370] ? hvc_write+0x3a0/0x3a0 [ 12.343465][ T370] ? console_emit_next_record+0x1df/0x4c0 [ 12.343468][ T370] ? rcu_is_watching+0x16/0xd0 [ 12.343472][ T370] ? lock_acquire+0x13c/0x160 [ 12.343476][ T370] console_emit_next_record+0x22f/0x4c0 [ 12.343479][ T370] ? devkmsg_read+0x4b0/0x4b0 [ 12.343481][ T370] ? console_flush_one_record+0x106/0x710 [ 12.343484][ T370] ? rcu_is_watching+0x16/0xd0 [ 12.343486][ T370] ? lock_acquire+0x13c/0x160 [ 12.343490][ T370] console_flush_one_record+0x46f/0x710 [ 12.343494][ T370] ? console_emit_next_record+0x4c0/0x4c0 [ 12.343495][ T370] ? __lock_acquire+0x518/0xc20 [ 12.343500][ T370] console_unlock+0xee/0x1f0 [ 12.343503][ T370] ? console_flush_one_record+0x710/0x710 [ 12.343505][ T370] ? rcu_is_watching+0x16/0xd0 [ 12.343507][ T370] ? lock_acquire+0x60/0x160 [ 12.343510][ T370] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.343512][ T370] ? vprintk_emit+0x320/0x3e0 [ 12.343515][ T370] vprintk_emit+0x37c/0x3e0 [ 12.343520][ T370] ? wake_up_klogd_work_func+0x90/0x90 [ 12.343523][ T370] ? __lock_release.isra.0+0x69/0x1a0 [ 12.343524][ T370] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.343530][ T370] _printk+0xc7/0x100 [ 12.343534][ T370] ? snapshot_read.cold+0x21/0x21 [ 12.343537][ T370] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 12.343550][ T370] ? do_setlink.isra.0+0xa31/0x2750 [ 12.343551][ T370] ? rtnl_newlink+0x9f1/0x11c0 [ 12.343552][ T370] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.343556][ T370] br_set_state+0x22f/0x430 [bridge] [ 12.343566][ T370] br_init_port+0xc4/0x200 [bridge] [ 12.343574][ T370] new_nbp+0x39c/0x580 [bridge] [ 12.343582][ T370] br_add_if+0x212/0x1320 [bridge] [ 12.343589][ T370] ? is_bpf_text_address+0x72/0x110 [ 12.343593][ T370] ? kernel_text_address+0x149/0x170 [ 12.343596][ T370] ? __kernel_text_address+0x12/0x30 [ 12.343600][ T370] do_set_master+0x357/0x580 [ 12.343604][ T370] do_setlink.isra.0+0xa31/0x2750 [ 12.343607][ T370] ? stack_trace_save+0x93/0xc0 [ 12.343610][ T370] ? rtnl_link_get_size+0x350/0x350 [ 12.343611][ T370] ? rcu_read_lock_any_held+0x66/0x90 [ 12.343614][ T370] ? stack_depot_save_flags+0x38e/0x790 [ 12.343617][ T370] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.343620][ T370] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.343622][ T370] ? validate_chain+0x38b/0xc20 [ 12.343624][ T370] ? kasan_save_stack+0x3d/0x50 [ 12.343627][ T370] ? kasan_save_stack+0x2f/0x50 [ 12.343628][ T370] ? kasan_save_track+0x14/0x30 [ 12.343631][ T370] ? __lock_acquire+0x518/0xc20 [ 12.343633][ T370] ? netlink_seq_next+0x4e/0x60 [ 12.343636][ T370] ? ___sys_sendmsg+0xb0/0x1d0 [ 12.343640][ T370] ? lock_acquire.part.0+0xd4/0x280 [ 12.343642][ T370] ? rtnl_newlink+0x9a8/0x11c0 [ 12.343644][ T370] ? rcu_is_watching+0x16/0xd0 [ 12.343647][ T370] ? lock_acquire+0x13c/0x160 [ 12.343648][ T370] ? rcu_is_watching+0x16/0xd0 [ 12.343650][ T370] ? rcu_is_watching+0x16/0xd0 [ 12.343652][ T370] ? trace_contention_end+0xb3/0x180 [ 12.343656][ T370] ? __mutex_lock+0x1db/0x1ea0 [ 12.343658][ T370] ? __mutex_lock+0x9a3/0x1ea0 [ 12.343660][ T370] ? rtnl_newlink+0x9a8/0x11c0 [ 12.343663][ T370] ? ww_mutex_lock+0x160/0x160 [ 12.343664][ T370] ? nla_get_range_signed+0x3d0/0x3d0 [ 12.343669][ T370] ? __rtnl_newlink+0x3fa/0xa50 [ 12.343674][ T370] rtnl_newlink+0x9f1/0x11c0 [ 12.343679][ T370] ? rtnl_bridge_getlink+0x850/0x850 [ 12.343681][ T370] ? __lock_acquire+0x518/0xc20 [ 12.343685][ T370] ? lock_acquire.part.0+0xd4/0x280 [ 12.343687][ T370] ? find_held_lock+0x2b/0x80 [ 12.343689][ T370] ? rtnl_bridge_getlink+0x850/0x850 [ 12.343691][ T370] ? __lock_release.isra.0+0x69/0x1a0 [ 12.343694][ T370] ? rtnl_bridge_getlink+0x850/0x850 [ 12.343696][ T370] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.343699][ T370] ? rtnl_link_fill+0x920/0x920 [ 12.343700][ T370] ? __lock_acquire+0x518/0xc20 [ 12.343704][ T370] ? lock_acquire.part.0+0xd4/0x280 [ 12.343706][ T370] ? find_held_lock+0x2b/0x80 [ 12.343709][ T370] netlink_rcv_skb+0x14e/0x3a0 [ 12.343711][ T370] ? rtnl_link_fill+0x920/0x920 [ 12.343714][ T370] ? netlink_ack+0xcf0/0xcf0 [ 12.343720][ T370] ? netlink_deliver_tap+0xc5/0x330 [ 12.343721][ T370] ? netlink_deliver_tap+0x13c/0x330 [ 12.343725][ T370] netlink_unicast+0x486/0x750 [ 12.343729][ T370] ? netlink_attachskb+0x810/0x810 [ 12.343731][ T370] ? __lock_acquire+0x518/0xc20 [ 12.343735][ T370] netlink_sendmsg+0x735/0xc60 [ 12.343739][ T370] ? netlink_unicast+0x750/0x750 [ 12.343742][ T370] ? __might_fault+0x97/0x140 [ 12.343747][ T370] ____sys_sendmsg+0x415/0x880 [ 12.343749][ T370] ? copy_msghdr_from_user+0x279/0x420 [ 12.343751][ T370] ? get_timestamp.constprop.0+0x390/0x390 [ 12.343753][ T370] ? move_addr_to_kernel+0x40/0x40 [ 12.343760][ T370] ___sys_sendmsg+0x14e/0x1d0 [ 12.343763][ T370] ? copy_msghdr_from_user+0x420/0x420 [ 12.343777][ T370] __sys_sendmsg+0x12c/0x1d0 [ 12.343780][ T370] ? __sys_sendmsg_sock+0x20/0x20 [ 12.343786][ T370] ? rcu_is_watching+0x16/0xd0 [ 12.343789][ T370] do_syscall_64+0xff/0x530 [ 12.343792][ T370] ? exc_page_fault+0xee/0x100 [ 12.343795][ T370] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.343797][ T370] RIP: 0033:0x7f3a7350054e [ 12.343800][ T370] 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.343802][ T370] RSP: 002b:00007ffdd3fa5aa0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 12.343805][ T370] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f3a7350054e [ 12.343806][ T370] RDX: 0000000000000000 RSI: 00007ffdd3fa5b50 RDI: 0000000000000005 [ 12.343807][ T370] RBP: 00007ffdd3fa5ab0 R08: 0000000000000000 R09: 0000000000000000 [ 12.343808][ T370] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9125b0 [ 12.343809][ T370] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffdd3fa6210 [ 12.343815][ T370] [ 12.397217][ T370] br10: port 1(veth1.10) entered disabled state [ 12.397559][ T370] veth1.10: entered allmulticast mode [ 12.397770][ T370] veth1: entered allmulticast mode [ 12.405802][ T370] veth1.10: entered promiscuous mode [ 12.406186][ T370] veth1: entered promiscuous mode [ 12.418209][ T370] ip (370) used greatest stack depth: 23336 bytes left [ 12.452501][ T376] br10: port 2(veth2.10) entered blocking state [ 12.452800][ T376] br10: port 2(veth2.10) entered disabled state [ 12.453096][ T376] veth2.10: entered allmulticast mode [ 12.453309][ T376] veth2: entered allmulticast mode [ 12.454864][ T376] veth2.10: entered promiscuous mode [ 12.455093][ T376] veth2: entered promiscuous mode [ 12.504523][ T381] br10: port 2(veth2.10) entered blocking state [ 12.505101][ T381] br10: port 2(veth2.10) entered forwarding state [ 12.505628][ T381] br10: port 1(veth1.10) entered blocking state [ 12.505922][ T381] br10: port 1(veth1.10) entered forwarding state [ 12.914334][ T418] br11: port 1(veth1.11) entered blocking state [ 12.914655][ T418] br11: port 1(veth1.11) entered disabled state [ 12.914966][ T418] veth1.11: entered allmulticast mode [ 12.916478][ T418] veth1.11: entered promiscuous mode [ 12.967665][ T424] br11: port 2(veth2.11) entered blocking state [ 12.968016][ T424] br11: port 2(veth2.11) entered disabled state [ 12.968366][ T424] veth2.11: entered allmulticast mode [ 12.970700][ T424] veth2.11: entered promiscuous mode [ 13.015070][ T429] br11: port 2(veth2.11) entered blocking state [ 13.015396][ T429] br11: port 2(veth2.11) entered forwarding state [ 13.015810][ T429] br11: port 1(veth1.11) entered blocking state [ 13.016101][ T429] br11: port 1(veth1.11) entered forwarding state [ 13.420804][ T465] br12: port 1(veth1.12) entered blocking state [ 13.420821][ T465] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.420823][ T465] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 465, name: ip [ 13.420824][ T465] preempt_count: 1, expected: 0 [ 13.420825][ T465] RCU nest depth: 0, expected: 0 [ 13.420826][ T465] locks held by ip/465: 5, last CPU#2: [ 13.420828][ T465] #0: ffffffffb1ed2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 13.420843][ T465] #1: ffffffffb1769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.420849][ T465] #2: ffffffffb1769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.420853][ T465] #3: ffffffffb1689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.420856][ T465] #4: ffffffffb1689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.420860][ T465] irq event stamp: 11402 [ 13.420861][ T465] hardirqs last enabled at (11401): [] __down_trylock_console_sem+0x86/0xa0 [ 13.420864][ T465] hardirqs last disabled at (11402): [] console_emit_next_record+0x3d4/0x4c0 [ 13.420866][ T465] softirqs last enabled at (11342): [] __alloc_skb+0x4c2/0x5f0 [ 13.420869][ T465] softirqs last disabled at (11340): [] __alloc_skb+0x4c2/0x5f0 [ 13.420871][ T465] Preemption disabled at: [ 13.420872][ T465] [] vprintk_emit+0x31b/0x3e0 [ 13.420877][ T465] CPU: 2 UID: 0 PID: 465 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.420881][ T465] Tainted: [W]=WARN [ 13.420882][ T465] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.420883][ T465] Call Trace: [ 13.420885][ T465] [ 13.420887][ T465] dump_stack_lvl+0x6f/0xa0 [ 13.420892][ T465] ? vprintk_emit+0x31b/0x3e0 [ 13.420895][ T465] __might_resched.cold+0x1fe/0x2c1 [ 13.420899][ T465] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.420903][ T465] ? __kmalloc_noprof+0xdb/0x760 [ 13.420908][ T465] __kmalloc_noprof+0x443/0x760 [ 13.420910][ T465] ? alloc_buf.isra.0+0x4b/0x260 [ 13.420916][ T465] ? do_raw_spin_unlock+0x59/0x250 [ 13.420919][ T465] alloc_buf.isra.0+0x4b/0x260 [ 13.420922][ T465] put_chars+0x1e1/0x2f0 [ 13.420924][ T465] ? prb_final_commit+0x50/0x50 [ 13.420926][ T465] ? __send_to_port+0x420/0x420 [ 13.420929][ T465] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.420933][ T465] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.420935][ T465] ? validate_chain+0x38b/0xc20 [ 13.420939][ T465] hvc_console_print+0x292/0x780 [ 13.420942][ T465] ? mark_usage+0x61/0x170 [ 13.420943][ T465] ? __lock_acquire+0x518/0xc20 [ 13.420945][ T465] ? __lock_acquire+0x518/0xc20 [ 13.420949][ T465] ? hvc_write+0x3a0/0x3a0 [ 13.420951][ T465] ? console_emit_next_record+0x1df/0x4c0 [ 13.420954][ T465] ? rcu_is_watching+0x16/0xd0 [ 13.420956][ T465] ? lock_acquire+0x13c/0x160 [ 13.420960][ T465] console_emit_next_record+0x22f/0x4c0 [ 13.420964][ T465] ? devkmsg_read+0x4b0/0x4b0 [ 13.420965][ T465] ? console_flush_one_record+0x106/0x710 [ 13.420968][ T465] ? rcu_is_watching+0x16/0xd0 [ 13.420971][ T465] ? lock_acquire+0x13c/0x160 [ 13.420975][ T465] console_flush_one_record+0x46f/0x710 [ 13.420979][ T465] ? console_emit_next_record+0x4c0/0x4c0 [ 13.420980][ T465] ? __lock_acquire+0x518/0xc20 [ 13.420986][ T465] console_unlock+0xee/0x1f0 [ 13.420988][ T465] ? console_flush_one_record+0x710/0x710 [ 13.420990][ T465] ? rcu_is_watching+0x16/0xd0 [ 13.420992][ T465] ? lock_acquire+0x60/0x160 [ 13.420996][ T465] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.420998][ T465] ? vprintk_emit+0x320/0x3e0 [ 13.421001][ T465] vprintk_emit+0x37c/0x3e0 [ 13.421005][ T465] ? wake_up_klogd_work_func+0x90/0x90 [ 13.421007][ T465] ? __lock_release.isra.0+0x69/0x1a0 [ 13.421012][ T465] _printk+0xc7/0x100 [ 13.421016][ T465] ? snapshot_read.cold+0x21/0x21 [ 13.421019][ T465] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 13.421032][ T465] ? do_setlink.isra.0+0xa31/0x2750 [ 13.421033][ T465] ? rtnl_newlink+0x9f1/0x11c0 [ 13.421034][ T465] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 13.421039][ T465] br_set_state+0x22f/0x430 [bridge] [ 13.421048][ T465] br_init_port+0xc4/0x200 [bridge] [ 13.421057][ T465] new_nbp+0x39c/0x580 [bridge] [ 13.421065][ T465] br_add_if+0x212/0x1320 [bridge] [ 13.421072][ T465] ? is_bpf_text_address+0x72/0x110 [ 13.421076][ T465] ? kernel_text_address+0x149/0x170 [ 13.421079][ T465] ? __kernel_text_address+0x12/0x30 [ 13.421082][ T465] do_set_master+0x357/0x580 [ 13.421087][ T465] do_setlink.isra.0+0xa31/0x2750 [ 13.421090][ T465] ? stack_trace_save+0x93/0xc0 [ 13.421093][ T465] ? rtnl_link_get_size+0x350/0x350 [ 13.421094][ T465] ? rcu_read_lock_any_held+0x66/0x90 [ 13.421096][ T465] ? stack_depot_save_flags+0x38e/0x790 [ 13.421100][ T465] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.421102][ T465] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.421104][ T465] ? validate_chain+0x38b/0xc20 [ 13.421106][ T465] ? kasan_save_stack+0x3d/0x50 [ 13.421109][ T465] ? kasan_save_stack+0x2f/0x50 [ 13.421111][ T465] ? kasan_save_track+0x14/0x30 [ 13.421113][ T465] ? __lock_acquire+0x518/0xc20 [ 13.421115][ T465] ? netlink_seq_next+0x4e/0x60 [ 13.421118][ T465] ? ___sys_sendmsg+0xb0/0x1d0 [ 13.421122][ T465] ? lock_acquire.part.0+0xd4/0x280 [ 13.421124][ T465] ? rtnl_newlink+0x9a8/0x11c0 [ 13.421126][ T465] ? rcu_is_watching+0x16/0xd0 [ 13.421129][ T465] ? lock_acquire+0x13c/0x160 [ 13.421130][ T465] ? rcu_is_watching+0x16/0xd0 [ 13.421132][ T465] ? rcu_is_watching+0x16/0xd0 [ 13.421134][ T465] ? trace_contention_end+0xb3/0x180 [ 13.421138][ T465] ? __mutex_lock+0x1db/0x1ea0 [ 13.421141][ T465] ? __mutex_lock+0x9a3/0x1ea0 [ 13.421143][ T465] ? rtnl_newlink+0x9a8/0x11c0 [ 13.421146][ T465] ? ww_mutex_lock+0x160/0x160 [ 13.421148][ T465] ? nla_get_range_signed+0x3d0/0x3d0 [ 13.421153][ T465] ? __rtnl_newlink+0x3fa/0xa50 [ 13.421158][ T465] rtnl_newlink+0x9f1/0x11c0 [ 13.421163][ T465] ? rtnl_bridge_getlink+0x850/0x850 [ 13.421165][ T465] ? __lock_acquire+0x518/0xc20 [ 13.421169][ T465] ? lock_acquire.part.0+0xd4/0x280 [ 13.421175][ T465] ? find_held_lock+0x2b/0x80 [ 13.421178][ T465] ? rtnl_bridge_getlink+0x850/0x850 [ 13.421180][ T465] ? __lock_release.isra.0+0x69/0x1a0 [ 13.421183][ T465] ? rtnl_bridge_getlink+0x850/0x850 [ 13.421185][ T465] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 13.421188][ T465] ? rtnl_link_fill+0x920/0x920 [ 13.421189][ T465] ? __lock_acquire+0x518/0xc20 [ 13.421193][ T465] ? lock_acquire.part.0+0xd4/0x280 [ 13.421195][ T465] ? find_held_lock+0x2b/0x80 [ 13.421199][ T465] netlink_rcv_skb+0x14e/0x3a0 [ 13.421200][ T465] ? rtnl_link_fill+0x920/0x920 [ 13.421203][ T465] ? netlink_ack+0xcf0/0xcf0 [ 13.421209][ T465] ? netlink_deliver_tap+0xc5/0x330 [ 13.421210][ T465] ? netlink_deliver_tap+0x13c/0x330 [ 13.421214][ T465] netlink_unicast+0x486/0x750 [ 13.421218][ T465] ? netlink_attachskb+0x810/0x810 [ 13.421220][ T465] ? __lock_acquire+0x518/0xc20 [ 13.421224][ T465] netlink_sendmsg+0x735/0xc60 [ 13.421228][ T465] ? netlink_unicast+0x750/0x750 [ 13.421232][ T465] ? __might_fault+0x97/0x140 [ 13.421237][ T465] ____sys_sendmsg+0x415/0x880 [ 13.421239][ T465] ? copy_msghdr_from_user+0x279/0x420 [ 13.421241][ T465] ? get_timestamp.constprop.0+0x390/0x390 [ 13.421243][ T465] ? move_addr_to_kernel+0x40/0x40 [ 13.421250][ T465] ___sys_sendmsg+0x14e/0x1d0 [ 13.421252][ T465] ? copy_msghdr_from_user+0x420/0x420 [ 13.421267][ T465] __sys_sendmsg+0x12c/0x1d0 [ 13.421270][ T465] ? __sys_sendmsg_sock+0x20/0x20 [ 13.421276][ T465] ? rcu_is_watching+0x16/0xd0 [ 13.421279][ T465] do_syscall_64+0xff/0x530 [ 13.421282][ T465] ? exc_page_fault+0xee/0x100 [ 13.421284][ T465] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.421287][ T465] RIP: 0033:0x7f1d7764f54e [ 13.421290][ T465] 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.421292][ T465] RSP: 002b:00007ffc91a06390 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 13.421295][ T465] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f1d7764f54e [ 13.421296][ T465] RDX: 0000000000000000 RSI: 00007ffc91a06440 RDI: 0000000000000005 [ 13.421297][ T465] RBP: 00007ffc91a063a0 R08: 0000000000000000 R09: 0000000000000000 [ 13.421298][ T465] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9125b1 [ 13.421299][ T465] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc91a06b00 [ 13.421305][ T465] [ 13.482097][ T465] br12: port 1(veth1.12) entered disabled state [ 13.482439][ T465] veth1.12: entered allmulticast mode [ 13.483984][ T465] veth1.12: entered promiscuous mode [ 13.530298][ T470] br12: port 2(veth2.12) entered blocking state [ 13.530715][ T470] br12: port 2(veth2.12) entered disabled state [ 13.531836][ T470] veth2.12: entered allmulticast mode [ 13.533695][ T470] veth2.12: entered promiscuous mode [ 13.592405][ T475] br12: port 2(veth2.12) entered blocking state [ 13.592802][ T475] br12: port 2(veth2.12) entered forwarding state [ 13.593293][ T475] br12: port 1(veth1.12) entered blocking state [ 13.593657][ T475] br12: port 1(veth1.12) entered forwarding state [ 28.009339][ C0] [ 28.009355][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 28.009358][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 583, name: mausezahn [ 28.009359][ C0] preempt_count: 104, expected: 0 [ 28.009360][ C0] RCU nest depth: 0, expected: 0 [ 28.009361][ C0] INFO: lockdep is turned off. [ 28.009362][ C0] irq event stamp: 5521878 [ 28.009363][ C0] hardirqs last enabled at (5521878): [] _raw_spin_unlock_irq+0x28/0x50 [ 28.009372][ C0] hardirqs last disabled at (5521877): [] _raw_spin_lock_irq+0x4a/0x50 [ 28.009374][ C0] softirqs last enabled at (5521490): [] handle_softirqs+0x67c/0x900 [ 28.009378][ C0] softirqs last disabled at (5521773): [] __irq_exit_rcu+0x145/0x1c0 [ 28.009379][ C0] Preemption disabled at: [ 28.009380][ C0] [<0000000000000000>] 0x0 [ 28.009387][ C0] CPU: 0 UID: 0 PID: 583 Comm: mausezahn Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.009391][ C0] Tainted: [W]=WARN [ 28.009391][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.009393][ C0] Call Trace: [ 28.009395][ C0] [ 28.009397][ C0] dump_stack_lvl+0x6f/0xa0 [ 28.009404][ C0] __might_resched.cold+0x1fe/0x2c1 [ 28.009408][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 28.009412][ C0] ? __asan_memcpy+0x3c/0x60 [ 28.009414][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.009418][ C0] __kmalloc_noprof+0x443/0x760 [ 28.009421][ C0] ? __rwlock_init+0x150/0x150 [ 28.009424][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 28.009428][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 28.009430][ C0] alloc_buf.isra.0+0x4b/0x260 [ 28.009432][ C0] put_chars+0x1e1/0x2f0 [ 28.009434][ C0] ? __send_to_port+0x420/0x420 [ 28.009436][ C0] ? console_prepend_replay+0x20/0x20 [ 28.009439][ C0] hvc_console_print+0x292/0x780 [ 28.009443][ C0] ? hvc_write+0x3a0/0x3a0 [ 28.009444][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.009446][ C0] ? lock_acquire+0x13c/0x160 [ 28.009448][ C0] console_emit_next_record+0x22f/0x4c0 [ 28.009450][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 28.009452][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.009454][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.009456][ C0] ? lock_acquire+0x13c/0x160 [ 28.009458][ C0] ? console_flush_one_record+0x111/0x710 [ 28.009460][ C0] console_flush_one_record+0x46f/0x710 [ 28.009462][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 28.009465][ C0] console_unlock+0xee/0x1f0 [ 28.009466][ C0] ? lock_acquire+0x13c/0x160 [ 28.009468][ C0] ? console_flush_one_record+0x710/0x710 [ 28.009470][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.009471][ C0] ? lock_release+0x184/0x1f0 [ 28.009473][ C0] ? lock_acquire+0x60/0x160 [ 28.009475][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 28.009477][ C0] ? vprintk_emit+0x320/0x3e0 [ 28.009479][ C0] vprintk_emit+0x37c/0x3e0 [ 28.009481][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 28.009483][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.009485][ C0] ? lock_release+0x184/0x1f0 [ 28.009487][ C0] _printk+0xc7/0x100 [ 28.009490][ C0] ? snapshot_read.cold+0x21/0x21 [ 28.009492][ C0] ? arch_stack_walk+0xed/0x130 [ 28.009496][ C0] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 28.009498][ C0] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 28.009500][ C0] print_irq_inversion_bug.part.0+0x32/0xc0 [ 28.009502][ C0] mark_lock_irq+0x989/0x9c0 [ 28.009505][ C0] mark_lock+0x1d7/0xa00 [ 28.009507][ C0] mark_usage+0x42/0x170 [ 28.009509][ C0] __lock_acquire+0x388/0xc20 [ 28.009511][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.009513][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.009525][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.009527][ C0] ? lock_acquire+0x13c/0x160 [ 28.009529][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.009535][ C0] _raw_spin_lock+0x33/0x40 [ 28.009537][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.009543][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.009550][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.009556][ C0] call_timer_fn+0x160/0x4d0 [ 28.009560][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 28.009561][ C0] ? debug_object_active_state+0x430/0x430 [ 28.009565][ C0] ? find_held_lock+0x2b/0x80 [ 28.009567][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 28.009569][ C0] ? mark_held_locks+0x40/0x70 [ 28.009571][ C0] __run_timers+0x68f/0xaa0 [ 28.009573][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.009579][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 28.009581][ C0] ? __lock_acquire+0x518/0xc20 [ 28.009584][ C0] ? __rwlock_init+0x150/0x150 [ 28.009586][ C0] run_timer_softirq+0xf0/0x160 [ 28.009588][ C0] ? __run_timers+0xaa0/0xaa0 [ 28.009590][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.009592][ C0] handle_softirqs+0x1d3/0x900 [ 28.009594][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 28.009596][ C0] ? _local_bh_enable+0xc0/0xc0 [ 28.009598][ C0] __irq_exit_rcu+0x145/0x1c0 [ 28.009599][ C0] irq_exit_rcu+0xe/0x30 [ 28.009601][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.009603][ C0] [ 28.009604][ C0] [ 28.009605][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.009608][ C0] RIP: 0010:_raw_spin_unlock_irqrestore+0x36/0x80 [ 28.009610][ C0] Code: f5 53 48 8b 74 24 10 48 89 fb 48 83 c7 18 e8 c1 af ba fd 48 89 df e8 c9 05 bb fd f7 c5 00 02 00 00 75 1f 9c 58 f6 c4 02 75 2f 01 00 00 00 e8 70 cf ac fd 65 48 83 3d af 0b f3 01 00 74 12 5b [ 28.009612][ C0] RSP: 0018:ffa00000004d7938 EFLAGS: 00000246 [ 28.009616][ C0] RAX: 0000000000000096 RBX: ff11000001f96680 RCX: ffffffffb09a8483 [ 28.009617][ C0] RDX: ff11000008e2c6c0 RSI: ffffffffb1238b01 RDI: ffffffffb0c8d8e0 [ 28.009618][ C0] RBP: 0000000000000286 R08: 0000000000000000 R09: 0000000000000000 [ 28.009619][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: ff11000002636ac0 [ 28.009620][ C0] R13: 0000000000000000 R14: ffa00000004d7980 R15: 0000000000000cc0 [ 28.009621][ C0] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 28.009624][ C0] qlist_free_all+0x5c/0x110 [ 28.009626][ C0] kasan_quarantine_reduce+0x196/0x240 [ 28.009627][ C0] __kasan_slab_alloc+0x4b/0x70 [ 28.009630][ C0] kmem_cache_alloc_node_noprof+0x25c/0x660 [ 28.009632][ C0] ? __alloc_skb+0xde/0x5f0 [ 28.009636][ C0] __alloc_skb+0xde/0x5f0 [ 28.009638][ C0] ? __alloc_skb+0x4c2/0x5f0 [ 28.009640][ C0] ? napi_skb_cache_get+0x830/0x830 [ 28.009641][ C0] ? mark_usage+0x61/0x170 [ 28.009643][ C0] ? ref_tracker_alloc+0x2e7/0x430 [ 28.009646][ C0] ? ref_tracker_dir_print+0x100/0x100 [ 28.009647][ C0] alloc_skb_with_frags+0xcc/0x6c0 [ 28.009650][ C0] ? find_held_lock+0x2b/0x80 [ 28.009651][ C0] sock_alloc_send_pskb+0x327/0x3f0 [ 28.009654][ C0] packet_snd+0x5dd/0x1840 [ 28.009658][ C0] ? tpacket_snd+0x1990/0x1990 [ 28.009661][ C0] ? __might_fault+0x97/0x140 [ 28.009664][ C0] ? __might_fault+0x97/0x140 [ 28.009666][ C0] __sys_sendto+0x2aa/0x400 [ 28.009669][ C0] ? __ia32_sys_getpeername+0xd0/0xd0 [ 28.009672][ C0] ? sock_ioctl+0x3cb/0x5f0 [ 28.009675][ C0] ? xfd_validate_state+0x2a/0x140 [ 28.009678][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 28.009679][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.009682][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 28.009683][ C0] ? do_syscall_64+0xa6/0x530 [ 28.009685][ C0] do_syscall_64+0xff/0x530 [ 28.009686][ C0] ? irq_exit_rcu+0x1a/0x30 [ 28.009688][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.009689][ C0] RIP: 0033:0x7fc526f5554e [ 28.009691][ C0] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 28.009692][ C0] RSP: 002b:00007fff080b7c80 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 28.009694][ C0] RAX: ffffffffffffffda RBX: 0000559bd164c5e2 RCX: 00007fc526f5554e [ 28.009695][ C0] RDX: 0000000000001f6a RSI: 0000559bd164c5e2 RDI: 0000000000000005 [ 28.009696][ C0] RBP: 00007fff080b7c90 R08: 00007fff080b7ce0 R09: 0000000000000014 [ 28.009697][ C0] R10: 0000000000000000 R11: 0000000000000202 R12: 0000559bd1649830 [ 28.009697][ C0] R13: 0000000000001f6a R14: 0000000000000005 R15: 0000559bd1649830 [ 28.009700][ C0] [ 28.033504][ C0] ======================================================== [ 28.033723][ C0] WARNING: possible irq lock inversion dependency detected [ 28.033945][ C0] 7.2.0-virtme #1 Tainted: G W [ 28.034132][ C0] -------------------------------------------------------- [ 28.034354][ C0] mausezahn/583 just changed the state of lock: [ 28.034542][ C0] ff11000002722e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.034850][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 28.035071][ C0] (fs_reclaim){+.+.}-{0:0} [ 28.035074][ C0] [ 28.035074][ C0] [ 28.035074][ C0] and interrupts could create inverse lock ordering between them. [ 28.035074][ C0] [ 28.035627][ C0] [ 28.035627][ C0] other info that might help us debug this: [ 28.035846][ C0] Chain exists of: [ 28.035846][ C0] &br->lock --> console_owner --> fs_reclaim [ 28.035846][ C0] [ 28.036185][ C0] Possible interrupt unsafe locking scenario: [ 28.036185][ C0] [ 28.036414][ C0] CPU0 CPU1 [ 28.036567][ C0] ---- ---- [ 28.036716][ C0] lock(fs_reclaim); [ 28.036830][ C0] local_irq_disable(); [ 28.037019][ C0] lock(&br->lock); [ 28.037208][ C0] lock(console_owner); [ 28.037399][ C0] [ 28.037517][ C0] lock(&br->lock); [ 28.037631][ C0] [ 28.037631][ C0] *** DEADLOCK *** [ 28.037631][ C0] [ 28.037855][ C0] locks held by mausezahn/583: 2, last CPU#0: [ 28.038042][ C0] #0: ffffffffb19ae1b8 (remove_cache_srcu){.+.+}-{0:0}, at: kasan_quarantine_reduce+0x84/0x240 [ 28.038348][ C0] #1: ffa0000000007c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 28.038648][ C0] [ 28.038648][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 28.038911][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 28.039066][ C0] HARDIRQ-ON-W at: [ 28.039182][ C0] __lock_acquire+0x388/0xc20 [ 28.039379][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.039570][ C0] fs_reclaim_acquire+0xd5/0x120 [ 28.039757][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 28.039983][ C0] kthread_create_worker_on_node+0xea/0x210 [ 28.040208][ C0] workqueue_init+0x2a/0x680 [ 28.040404][ C0] kernel_init_freeable+0x2fe/0x630 [ 28.040629][ C0] kernel_init+0x21/0x150 [ 28.040821][ C0] ret_from_fork+0x474/0x6b0 [ 28.041010][ C0] ret_from_fork_asm+0x11/0x20 [ 28.041197][ C0] SOFTIRQ-ON-W at: [ 28.041313][ C0] __lock_acquire+0x388/0xc20 [ 28.041504][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.041690][ C0] fs_reclaim_acquire+0xd5/0x120 [ 28.041876][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 28.042103][ C0] kthread_create_worker_on_node+0xea/0x210 [ 28.042330][ C0] workqueue_init+0x2a/0x680 [ 28.042517][ C0] kernel_init_freeable+0x2fe/0x630 [ 28.042742][ C0] kernel_init+0x21/0x150 [ 28.042928][ C0] ret_from_fork+0x474/0x6b0 [ 28.043115][ C0] ret_from_fork_asm+0x11/0x20 [ 28.043306][ C0] INITIAL USE at: [ 28.043418][ C0] __lock_acquire+0x388/0xc20 [ 28.043605][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.043791][ C0] fs_reclaim_acquire+0xd5/0x120 [ 28.043979][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 28.044201][ C0] kthread_create_worker_on_node+0xea/0x210 [ 28.044432][ C0] workqueue_init+0x2a/0x680 [ 28.044617][ C0] kernel_init_freeable+0x2fe/0x630 [ 28.044802][ C0] kernel_init+0x21/0x150 [ 28.044992][ C0] ret_from_fork+0x474/0x6b0 [ 28.045178][ C0] ret_from_fork_asm+0x11/0x20 [ 28.045369][ C0] } [ 28.045449][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 28.045675][ C0] ... acquired at: [ 28.045788][ C0] __lock_acquire+0x518/0xc20 [ 28.045940][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.046093][ C0] fs_reclaim_acquire+0xd5/0x120 [ 28.046244][ C0] __kmalloc_noprof+0xd3/0x760 [ 28.046400][ C0] alloc_buf.isra.0+0x4b/0x260 [ 28.046552][ C0] put_chars+0x1e1/0x2f0 [ 28.046702][ C0] hvc_console_print+0x292/0x780 [ 28.046854][ C0] console_emit_next_record+0x22f/0x4c0 [ 28.047005][ C0] console_flush_one_record+0x46f/0x710 [ 28.047155][ C0] console_unlock+0xee/0x1f0 [ 28.047309][ C0] vprintk_emit+0x37c/0x3e0 [ 28.047462][ C0] _printk+0xc7/0x100 [ 28.047579][ C0] dm_interface_init+0x50/0x60 [ 28.047732][ C0] dm_init+0x51/0xd0 [ 28.047846][ C0] do_one_initcall+0x124/0x4f0 [ 28.047998][ C0] kernel_init_freeable+0x596/0x630 [ 28.048148][ C0] kernel_init+0x21/0x150 [ 28.048301][ C0] ret_from_fork+0x474/0x6b0 [ 28.048452][ C0] ret_from_fork_asm+0x11/0x20 [ 28.048605][ C0] [ 28.048683][ C0] -> (console_owner){....}-{0:0} { [ 28.048835][ C0] INITIAL USE at: [ 28.048949][ C0] } [ 28.049025][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 28.049252][ C0] ... acquired at: [ 28.049367][ C0] __lock_acquire+0x518/0xc20 [ 28.049522][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.049673][ C0] console_lock_spinning_enable+0x5c/0x60 [ 28.049862][ C0] console_emit_next_record+0x1d1/0x4c0 [ 28.050012][ C0] console_flush_one_record+0x46f/0x710 [ 28.050163][ C0] console_unlock+0xee/0x1f0 [ 28.050318][ C0] vprintk_emit+0x37c/0x3e0 [ 28.050475][ C0] _printk+0xc7/0x100 [ 28.050589][ C0] br_set_state+0x22f/0x430 [bridge] [ 28.050746][ C0] br_init_port+0xc4/0x200 [bridge] [ 28.050903][ C0] br_stp_enable_bridge+0x1fc/0x340 [bridge] [ 28.051096][ C0] br_dev_open+0x94/0x120 [bridge] [ 28.051253][ C0] __dev_open+0x2f3/0x610 [ 28.051414][ C0] __dev_change_flags+0x4a4/0x660 [ 28.051566][ C0] netif_change_flags+0x87/0x190 [ 28.051718][ C0] do_setlink.isra.0+0x1cc3/0x2750 [ 28.051869][ C0] rtnl_newlink+0x9f1/0x11c0 [ 28.052022][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.052171][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 28.052331][ C0] netlink_unicast+0x486/0x750 [ 28.052487][ C0] netlink_sendmsg+0x735/0xc60 [ 28.052639][ C0] ____sys_sendmsg+0x415/0x880 [ 28.052791][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 28.052943][ C0] __sys_sendmsg+0x12c/0x1d0 [ 28.053093][ C0] do_syscall_64+0xff/0x530 [ 28.053243][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.053439][ C0] [ 28.053516][ C0] -> (&br->lock){+.-.}-{3:3} { [ 28.053669][ C0] HARDIRQ-ON-W at: [ 28.053781][ C0] __lock_acquire+0x388/0xc20 [ 28.053972][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.054178][ C0] _raw_spin_lock_bh+0x38/0x50 [ 28.054429][ C0] br_add_if+0x8c1/0x1320 [bridge] [ 28.054627][ C0] do_set_master+0x357/0x580 [ 28.054820][ C0] do_setlink.isra.0+0xa31/0x2750 [ 28.055009][ C0] rtnl_newlink+0x9f1/0x11c0 [ 28.055199][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.055393][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 28.055586][ C0] netlink_unicast+0x486/0x750 [ 28.055775][ C0] netlink_sendmsg+0x735/0xc60 [ 28.055965][ C0] ____sys_sendmsg+0x415/0x880 [ 28.056156][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 28.056351][ C0] __sys_sendmsg+0x12c/0x1d0 [ 28.056544][ C0] do_syscall_64+0xff/0x530 [ 28.056735][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.056961][ C0] IN-SOFTIRQ-W at: [ 28.057076][ C0] __lock_acquire+0x388/0xc20 [ 28.057266][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.057462][ C0] _raw_spin_lock+0x33/0x40 [ 28.057651][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.057885][ C0] call_timer_fn+0x160/0x4d0 [ 28.058075][ C0] __run_timers+0x68f/0xaa0 [ 28.058265][ C0] run_timer_softirq+0xf0/0x160 [ 28.058462][ C0] handle_softirqs+0x1d3/0x900 [ 28.058654][ C0] __irq_exit_rcu+0x145/0x1c0 [ 28.058843][ C0] irq_exit_rcu+0xe/0x30 [ 28.059032][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.059260][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.059497][ C0] _raw_spin_unlock_irqrestore+0x36/0x80 [ 28.059724][ C0] qlist_free_all+0x5c/0x110 [ 28.059913][ C0] kasan_quarantine_reduce+0x196/0x240 [ 28.060102][ C0] __kasan_slab_alloc+0x4b/0x70 [ 28.060294][ C0] kmem_cache_alloc_node_noprof+0x25c/0x660 [ 28.060527][ C0] __alloc_skb+0xde/0x5f0 [ 28.060717][ C0] alloc_skb_with_frags+0xcc/0x6c0 [ 28.060908][ C0] sock_alloc_send_pskb+0x327/0x3f0 [ 28.061098][ C0] packet_snd+0x5dd/0x1840 [ 28.061622][ C0] __sys_sendto+0x2aa/0x400 [ 28.061811][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 28.062003][ C0] do_syscall_64+0xff/0x530 [ 28.062244][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.062533][ C0] INITIAL USE at: [ 28.062647][ C0] __lock_acquire+0x388/0xc20 [ 28.062942][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.063131][ C0] _raw_spin_lock_bh+0x38/0x50 [ 28.063378][ C0] br_add_if+0x8c1/0x1320 [bridge] [ 28.063575][ C0] do_set_master+0x357/0x580 [ 28.063821][ C0] do_setlink.isra.0+0xa31/0x2750 [ 28.064118][ C0] rtnl_newlink+0x9f1/0x11c0 [ 28.064315][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.064563][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 28.064805][ C0] netlink_unicast+0x486/0x750 [ 28.064995][ C0] netlink_sendmsg+0x735/0xc60 [ 28.065294][ C0] ____sys_sendmsg+0x415/0x880 [ 28.065487][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 28.065733][ C0] __sys_sendmsg+0x12c/0x1d0 [ 28.065923][ C0] do_syscall_64+0xff/0x530 [ 28.066113][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.066459][ C0] } [ 28.066536][ C0] ... key at: [] __key.7+0x0/0x40 [bridge] [ 28.066815][ C0] ... acquired at: [ 28.066926][ C0] mark_lock+0x1d7/0xa00 [ 28.067133][ C0] mark_usage+0x42/0x170 [ 28.067287][ C0] __lock_acquire+0x388/0xc20 [ 28.067547][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.067700][ C0] _raw_spin_lock+0x33/0x40 [ 28.067905][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.068149][ C0] call_timer_fn+0x160/0x4d0 [ 28.068342][ C0] __run_timers+0x68f/0xaa0 [ 28.068598][ C0] run_timer_softirq+0xf0/0x160 [ 28.068757][ C0] handle_softirqs+0x1d3/0x900 [ 28.068908][ C0] __irq_exit_rcu+0x145/0x1c0 [ 28.069057][ C0] irq_exit_rcu+0xe/0x30 [ 28.069207][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.069409][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.069599][ C0] _raw_spin_unlock_irqrestore+0x36/0x80 [ 28.069787][ C0] qlist_free_all+0x5c/0x110 [ 28.069943][ C0] kasan_quarantine_reduce+0x196/0x240 [ 28.070093][ C0] __kasan_slab_alloc+0x4b/0x70 [ 28.070243][ C0] kmem_cache_alloc_node_noprof+0x25c/0x660 [ 28.070441][ C0] __alloc_skb+0xde/0x5f0 [ 28.070594][ C0] alloc_skb_with_frags+0xcc/0x6c0 [ 28.070744][ C0] sock_alloc_send_pskb+0x327/0x3f0 [ 28.070893][ C0] packet_snd+0x5dd/0x1840 [ 28.071047][ C0] __sys_sendto+0x2aa/0x400 [ 28.071201][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 28.071354][ C0] do_syscall_64+0xff/0x530 [ 28.071507][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.071704][ C0] [ 28.071780][ C0] [ 28.071780][ C0] stack backtrace: [ 28.071970][ C0] CPU: 0 UID: 0 PID: 583 Comm: mausezahn Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.071974][ C0] Tainted: [W]=WARN [ 28.071976][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.071977][ C0] Call Trace: [ 28.071979][ C0] [ 28.071980][ C0] dump_stack_lvl+0x6f/0xa0 [ 28.071985][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 28.071989][ C0] mark_lock_irq+0x989/0x9c0 [ 28.071992][ C0] mark_lock+0x1d7/0xa00 [ 28.071994][ C0] mark_usage+0x42/0x170 [ 28.071996][ C0] __lock_acquire+0x388/0xc20 [ 28.071998][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.072000][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.072012][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.072015][ C0] ? lock_acquire+0x13c/0x160 [ 28.072017][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.072024][ C0] _raw_spin_lock+0x33/0x40 [ 28.072026][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.072033][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.072040][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.072048][ C0] call_timer_fn+0x160/0x4d0 [ 28.072050][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 28.072052][ C0] ? debug_object_active_state+0x430/0x430 [ 28.072055][ C0] ? find_held_lock+0x2b/0x80 [ 28.072058][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 28.072059][ C0] ? mark_held_locks+0x40/0x70 [ 28.072061][ C0] __run_timers+0x68f/0xaa0 [ 28.072063][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.072074][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 28.072077][ C0] ? __lock_acquire+0x518/0xc20 [ 28.072081][ C0] ? __rwlock_init+0x150/0x150 [ 28.072085][ C0] run_timer_softirq+0xf0/0x160 [ 28.072088][ C0] ? __run_timers+0xaa0/0xaa0 [ 28.072091][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.072093][ C0] handle_softirqs+0x1d3/0x900 [ 28.072095][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 28.072096][ C0] ? _local_bh_enable+0xc0/0xc0 [ 28.072099][ C0] __irq_exit_rcu+0x145/0x1c0 [ 28.072100][ C0] irq_exit_rcu+0xe/0x30 [ 28.072101][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.072103][ C0] [ 28.072104][ C0] [ 28.072105][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.072107][ C0] RIP: 0010:_raw_spin_unlock_irqrestore+0x36/0x80 [ 28.072109][ C0] Code: f5 53 48 8b 74 24 10 48 89 fb 48 83 c7 18 e8 c1 af ba fd 48 89 df e8 c9 05 bb fd f7 c5 00 02 00 00 75 1f 9c 58 f6 c4 02 75 2f 01 00 00 00 e8 70 cf ac fd 65 48 83 3d af 0b f3 01 00 74 12 5b [ 28.072110][ C0] RSP: 0018:ffa00000004d7938 EFLAGS: 00000246 [ 28.072113][ C0] RAX: 0000000000000096 RBX: ff11000001f96680 RCX: ffffffffb09a8483 [ 28.072114][ C0] RDX: ff11000008e2c6c0 RSI: ffffffffb1238b01 RDI: ffffffffb0c8d8e0 [ 28.072115][ C0] RBP: 0000000000000286 R08: 0000000000000000 R09: 0000000000000000 [ 28.072116][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: ff11000002636ac0 [ 28.072117][ C0] R13: 0000000000000000 R14: ffa00000004d7980 R15: 0000000000000cc0 [ 28.072118][ C0] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 28.072121][ C0] qlist_free_all+0x5c/0x110 [ 28.072123][ C0] kasan_quarantine_reduce+0x196/0x240 [ 28.072124][ C0] __kasan_slab_alloc+0x4b/0x70 [ 28.072126][ C0] kmem_cache_alloc_node_noprof+0x25c/0x660 [ 28.072128][ C0] ? __alloc_skb+0xde/0x5f0 [ 28.072131][ C0] __alloc_skb+0xde/0x5f0 [ 28.072132][ C0] ? __alloc_skb+0x4c2/0x5f0 [ 28.072134][ C0] ? napi_skb_cache_get+0x830/0x830 [ 28.072136][ C0] ? mark_usage+0x61/0x170 [ 28.072138][ C0] ? ref_tracker_alloc+0x2e7/0x430 [ 28.072140][ C0] ? ref_tracker_dir_print+0x100/0x100 [ 28.072142][ C0] alloc_skb_with_frags+0xcc/0x6c0 [ 28.072144][ C0] ? find_held_lock+0x2b/0x80 [ 28.072146][ C0] sock_alloc_send_pskb+0x327/0x3f0 [ 28.072148][ C0] packet_snd+0x5dd/0x1840 [ 28.072152][ C0] ? tpacket_snd+0x1990/0x1990 [ 28.072154][ C0] ? __might_fault+0x97/0x140 [ 28.072158][ C0] ? __might_fault+0x97/0x140 [ 28.072160][ C0] __sys_sendto+0x2aa/0x400 [ 28.072161][ C0] ? __ia32_sys_getpeername+0xd0/0xd0 [ 28.072164][ C0] ? sock_ioctl+0x3cb/0x5f0 [ 28.072167][ C0] ? xfd_validate_state+0x2a/0x140 [ 28.072171][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 28.072172][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.072175][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 28.072176][ C0] ? do_syscall_64+0xa6/0x530 [ 28.072178][ C0] do_syscall_64+0xff/0x530 [ 28.072179][ C0] ? irq_exit_rcu+0x1a/0x30 [ 28.072180][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.072182][ C0] RIP: 0033:0x7fc526f5554e [ 28.072184][ C0] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 28.072184][ C0] RSP: 002b:00007fff080b7c80 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 28.072186][ C0] RAX: ffffffffffffffda RBX: 0000559bd164c5e2 RCX: 00007fc526f5554e [ 28.072187][ C0] RDX: 0000000000001f6a RSI: 0000559bd164c5e2 RDI: 0000000000000005 [ 28.072188][ C0] RBP: 00007fff080b7c90 R08: 00007fff080b7ce0 R09: 0000000000000014 [ 28.072188][ C0] R10: 0000000000000000 R11: 0000000000000202 R12: 0000559bd1649830 [ 28.072189][ C0] R13: 0000000000001f6a R14: 0000000000000005 R15: 0000559bd1649830 [ 28.072191][ C0] [ 390.750897][ T1970] br12: port 2(veth2.12) entered disabled state [ 390.750913][ T1970] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 390.750916][ T1970] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1970, name: ip [ 390.750917][ T1970] preempt_count: 202, expected: 0 [ 390.750919][ T1970] RCU nest depth: 0, expected: 0 [ 390.750919][ T1970] INFO: lockdep is turned off. [ 390.750921][ T1970] irq event stamp: 0 [ 390.750921][ T1970] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 390.750926][ T1970] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 390.750932][ T1970] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 390.750934][ T1970] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 390.750935][ T1970] Preemption disabled at: [ 390.750936][ T1970] [<0000000000000000>] 0x0 [ 390.750941][ T1970] CPU: 3 UID: 0 PID: 1970 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 390.750945][ T1970] Tainted: [W]=WARN [ 390.750946][ T1970] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 390.750947][ T1970] Call Trace: [ 390.750949][ T1970] [ 390.750950][ T1970] dump_stack_lvl+0x6f/0xa0 [ 390.750956][ T1970] __might_resched.cold+0x1fe/0x2c1 [ 390.750960][ T1970] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 390.750963][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.750967][ T1970] __kmalloc_noprof+0x443/0x760 [ 390.750971][ T1970] ? __rwlock_init+0x150/0x150 [ 390.750974][ T1970] ? alloc_buf.isra.0+0x4b/0x260 [ 390.750977][ T1970] ? do_raw_spin_unlock+0x59/0x250 [ 390.750979][ T1970] alloc_buf.isra.0+0x4b/0x260 [ 390.750981][ T1970] put_chars+0x1e1/0x2f0 [ 390.750983][ T1970] ? __send_to_port+0x420/0x420 [ 390.750985][ T1970] ? printk_get_next_message+0x240/0x650 [ 390.750988][ T1970] hvc_console_print+0x292/0x780 [ 390.750991][ T1970] ? hvc_write+0x3a0/0x3a0 [ 390.750993][ T1970] ? __rwlock_init+0x150/0x150 [ 390.750995][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.750997][ T1970] ? lock_acquire+0x13c/0x160 [ 390.750999][ T1970] console_emit_next_record+0x22f/0x4c0 [ 390.751002][ T1970] ? devkmsg_read+0x4b0/0x4b0 [ 390.751004][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751005][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751007][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751009][ T1970] ? lock_acquire+0x13c/0x160 [ 390.751011][ T1970] ? console_flush_one_record+0x111/0x710 [ 390.751012][ T1970] console_flush_one_record+0x46f/0x710 [ 390.751015][ T1970] ? console_emit_next_record+0x4c0/0x4c0 [ 390.751017][ T1970] console_unlock+0xee/0x1f0 [ 390.751019][ T1970] ? lock_acquire+0x13c/0x160 [ 390.751021][ T1970] ? console_flush_one_record+0x710/0x710 [ 390.751022][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751024][ T1970] ? lock_release+0x184/0x1f0 [ 390.751025][ T1970] ? lock_acquire+0x60/0x160 [ 390.751027][ T1970] ? __rcu_read_lock+0x30/0x70 [ 390.751029][ T1970] ? __down_trylock_console_sem+0x5e/0xa0 [ 390.751031][ T1970] ? vprintk_emit+0x320/0x3e0 [ 390.751033][ T1970] vprintk_emit+0x37c/0x3e0 [ 390.751035][ T1970] ? wake_up_klogd_work_func+0x90/0x90 [ 390.751037][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751039][ T1970] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 390.751041][ T1970] ? trace_hardirqs_on+0x36/0x40 [ 390.751043][ T1970] _printk+0xc7/0x100 [ 390.751046][ T1970] ? snapshot_read.cold+0x21/0x21 [ 390.751048][ T1970] ? ipv6_mc_down+0x17e/0x2d0 [ 390.751053][ T1970] br_set_state+0x22f/0x430 [bridge] [ 390.751066][ T1970] br_stp_disable_port+0x11f/0x390 [bridge] [ 390.751074][ T1970] br_device_event+0x7b5/0x8f0 [bridge] [ 390.751083][ T1970] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 390.751086][ T1970] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 390.751089][ T1970] ? addrconf_notify+0x2c8/0xf30 [ 390.751092][ T1970] notifier_call_chain+0xae/0x300 [ 390.751095][ T1970] __dev_notify_flags+0x23c/0x3c0 [ 390.751099][ T1970] ? netif_change_name+0x8c0/0x8c0 [ 390.751102][ T1970] ? netif_set_allmulti+0x250/0x250 [ 390.751104][ T1970] ? __kernel_text_address+0x12/0x30 [ 390.751106][ T1970] ? write_profile+0xf0/0xf0 [ 390.751108][ T1970] ? unwind_get_return_address+0x67/0xd0 [ 390.751111][ T1970] netif_change_flags+0xfe/0x190 [ 390.751113][ T1970] do_setlink.isra.0+0x1cc3/0x2750 [ 390.751116][ T1970] ? stack_trace_save+0x93/0xc0 [ 390.751118][ T1970] ? rtnl_link_get_size+0x350/0x350 [ 390.751119][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751120][ T1970] ? stack_depot_save_flags+0x1bc/0x790 [ 390.751124][ T1970] ? kasan_save_stack+0x3d/0x50 [ 390.751127][ T1970] ? kasan_save_stack+0x2f/0x50 [ 390.751129][ T1970] ? kasan_save_track+0x14/0x30 [ 390.751130][ T1970] ? __kasan_kmalloc+0x7b/0x90 [ 390.751132][ T1970] ? __kmalloc_cache_noprof+0x29a/0x620 [ 390.751134][ T1970] ? rtnl_newlink+0x124/0x11c0 [ 390.751135][ T1970] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 390.751136][ T1970] ? netlink_rcv_skb+0x14e/0x3a0 [ 390.751139][ T1970] ? netlink_unicast+0x486/0x750 [ 390.751140][ T1970] ? netlink_sendmsg+0x735/0xc60 [ 390.751141][ T1970] ? ____sys_sendmsg+0x415/0x880 [ 390.751144][ T1970] ? ___sys_sendmsg+0x14e/0x1d0 [ 390.751145][ T1970] ? __sys_sendmsg+0x12c/0x1d0 [ 390.751147][ T1970] ? do_syscall_64+0xff/0x530 [ 390.751149][ T1970] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 390.751152][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751154][ T1970] ? lock_acquire+0x13c/0x160 [ 390.751155][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751157][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751159][ T1970] ? trace_contention_end+0xb3/0x180 [ 390.751162][ T1970] ? __mutex_lock+0x1db/0x1ea0 [ 390.751164][ T1970] ? __mutex_lock+0x9a3/0x1ea0 [ 390.751165][ T1970] ? rtnl_newlink+0x9a8/0x11c0 [ 390.751166][ T1970] ? ww_mutex_lock+0x160/0x160 [ 390.751169][ T1970] ? __rtnl_newlink+0x3fa/0xa50 [ 390.751171][ T1970] rtnl_newlink+0x9f1/0x11c0 [ 390.751173][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751174][ T1970] ? rtnl_bridge_getlink+0x850/0x850 [ 390.751175][ T1970] ? lock_acquire+0x13c/0x160 [ 390.751177][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751179][ T1970] ? is_bpf_text_address+0x3e/0x110 [ 390.751182][ T1970] ? is_bpf_text_address+0x72/0x110 [ 390.751184][ T1970] ? kernel_text_address+0x149/0x170 [ 390.751185][ T1970] ? __kernel_text_address+0x12/0x30 [ 390.751187][ T1970] ? write_profile+0xf0/0xf0 [ 390.751188][ T1970] ? unwind_get_return_address+0x67/0xd0 [ 390.751189][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751191][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751192][ T1970] ? cap_capable+0x1d7/0x3d0 [ 390.751196][ T1970] ? lock_acquire+0x13c/0x160 [ 390.751197][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751199][ T1970] ? rtnl_bridge_getlink+0x850/0x850 [ 390.751201][ T1970] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 390.751202][ T1970] ? rtnl_link_fill+0x920/0x920 [ 390.751204][ T1970] ? filter_irq_stacks+0xd0/0xd0 [ 390.751205][ T1970] ? stack_depot_save_flags+0x1bc/0x790 [ 390.751208][ T1970] netlink_rcv_skb+0x14e/0x3a0 [ 390.751209][ T1970] ? rtnl_link_fill+0x920/0x920 [ 390.751210][ T1970] ? lock_release+0x184/0x1f0 [ 390.751212][ T1970] ? netlink_ack+0xcf0/0xcf0 [ 390.751213][ T1970] ? __netlink_lookup+0xb9/0x6b0 [ 390.751216][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751217][ T1970] ? lock_release+0x184/0x1f0 [ 390.751219][ T1970] netlink_unicast+0x486/0x750 [ 390.751221][ T1970] ? netlink_attachskb+0x810/0x810 [ 390.751223][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751225][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751226][ T1970] ? lock_acquire+0x13c/0x160 [ 390.751228][ T1970] netlink_sendmsg+0x735/0xc60 [ 390.751230][ T1970] ? netlink_unicast+0x750/0x750 [ 390.751232][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751234][ T1970] ? lock_release+0x184/0x1f0 [ 390.751236][ T1970] ____sys_sendmsg+0x415/0x880 [ 390.751237][ T1970] ? copy_msghdr_from_user+0x279/0x420 [ 390.751239][ T1970] ? get_timestamp.constprop.0+0x390/0x390 [ 390.751241][ T1970] ? move_addr_to_kernel+0x40/0x40 [ 390.751242][ T1970] ? filter_irq_stacks+0xd0/0xd0 [ 390.751245][ T1970] ___sys_sendmsg+0x14e/0x1d0 [ 390.751247][ T1970] ? copy_msghdr_from_user+0x420/0x420 [ 390.751251][ T1970] __sys_sendmsg+0x12c/0x1d0 [ 390.751253][ T1970] ? __sys_sendmsg_sock+0x20/0x20 [ 390.751256][ T1970] ? rcu_is_watching+0x16/0xd0 [ 390.751258][ T1970] do_syscall_64+0xff/0x530 [ 390.751260][ T1970] ? exc_page_fault+0xee/0x100 [ 390.751262][ T1970] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 390.751263][ T1970] RIP: 0033:0x7f682d36c54e [ 390.751265][ T1970] 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.751267][ T1970] RSP: 002b:00007ffeb2e56590 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 390.751271][ T1970] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f682d36c54e [ 390.751272][ T1970] RDX: 0000000000000000 RSI: 00007ffeb2e56640 RDI: 0000000000000005 [ 390.751273][ T1970] RBP: 00007ffeb2e565a0 R08: 0000000000000000 R09: 0000000000000000 [ 390.751274][ T1970] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91272b [ 390.751275][ T1970] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffeb2e56d00 [ 390.751277][ T1970] [ 390.783084][ T1970] ip (1970) used greatest stack depth: 23016 bytes left [ 390.798077][ T1973] br12: port 1(veth1.12) entered disabled state [ 390.843173][ T1978] veth2.12: left allmulticast mode [ 390.843370][ T1978] veth2.12: left promiscuous mode [ 390.843678][ T1978] br12: port 2(veth2.12) entered disabled state [ 390.875044][ T1980] veth1.12: left allmulticast mode [ 390.875213][ T1980] veth1.12: left promiscuous mode [ 390.875500][ T1980] br12: port 1(veth1.12) entered disabled state [ 391.010887][ T1990] br11: port 2(veth2.11) entered disabled state [ 391.036439][ T1992] br11: port 1(veth1.11) entered disabled state [ 391.079408][ T1996] veth2.11: left allmulticast mode [ 391.079586][ T1996] veth2.11: left promiscuous mode [ 391.079888][ T1996] br11: port 2(veth2.11) entered disabled state [ 391.106678][ T1998] veth1.11: left allmulticast mode [ 391.106918][ T1998] veth1.11: left promiscuous mode [ 391.107273][ T1998] br11: port 1(veth1.11) entered disabled state [ 391.228344][ T2006] br10: port 2(veth2.10) entered disabled state [ 391.254477][ T2008] br10: port 1(veth1.10) entered disabled state [ 391.302286][ T2012] veth2.10: left allmulticast mode [ 391.302510][ T2012] veth2: left allmulticast mode [ 391.302708][ T2012] veth2.10: left promiscuous mode [ 391.303002][ T2012] veth2: left promiscuous mode [ 391.303345][ T2012] br10: port 2(veth2.10) entered disabled state [ 391.321836][ T2014] veth1.10: left allmulticast mode [ 391.322344][ T2014] veth1: left allmulticast mode [ 391.322495][ T2014] veth1.10: left promiscuous mode [ 391.322629][ T2014] veth1: left promiscuous mode [ 391.322935][ T2014] br10: port 1(veth1.10) entered disabled state