[ 10.711226][ T183] ip (183) used greatest stack depth: 23744 bytes left [ 10.711248][ T183] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.711250][ T183] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 183, name: ip [ 10.711252][ T183] preempt_count: 2, expected: 0 [ 10.711253][ T183] RCU nest depth: 0, expected: 0 [ 10.711254][ T183] locks held by ip/183: 5, last CPU#3: [ 10.711256][ T183] #0: ffffffff9d2027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 10.711269][ T183] #1: ffffffff9d369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.711275][ T183] #2: ffffffff9d369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.711279][ T183] #3: ffffffff9d289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.711283][ T183] #4: ffffffff9d289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.711287][ T183] irq event stamp: 27344 [ 10.711288][ T183] hardirqs last enabled at (27343): [] __down_trylock_console_sem+0x86/0xa0 [ 10.711291][ T183] hardirqs last disabled at (27344): [] console_emit_next_record+0x3d4/0x4c0 [ 10.711293][ T183] softirqs last enabled at (26034): [] netlink_release+0x17b/0xcf0 [ 10.711297][ T183] softirqs last disabled at (26032): [] netlink_release+0xd2/0xcf0 [ 10.711302][ T183] Preemption disabled at: [ 10.711303][ T183] [<0000000000000000>] 0x0 [ 10.711311][ T183] CPU: 3 UID: 0 PID: 183 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.711314][ T183] Tainted: [W]=WARN [ 10.711315][ T183] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.711317][ T183] Call Trace: [ 10.711318][ T183] [ 10.711320][ T183] dump_stack_lvl+0x6f/0xa0 [ 10.711326][ T183] __might_resched.cold+0x1fe/0x2c1 [ 10.711331][ T183] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.711336][ T183] ? __kmalloc_noprof+0xdb/0x760 [ 10.711341][ T183] __kmalloc_noprof+0x443/0x760 [ 10.711343][ T183] ? alloc_buf.isra.0+0x4b/0x260 [ 10.711348][ T183] ? do_raw_spin_unlock+0x59/0x250 [ 10.711351][ T183] alloc_buf.isra.0+0x4b/0x260 [ 10.711354][ T183] put_chars+0x1e1/0x2f0 [ 10.711357][ T183] ? __send_to_port+0x420/0x420 [ 10.711358][ T183] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.711364][ T183] ? validate_chain+0x38b/0xc20 [ 10.711369][ T183] hvc_console_print+0x292/0x780 [ 10.711375][ T183] ? hvc_write+0x3a0/0x3a0 [ 10.711377][ T183] ? rcu_is_watching+0x16/0xd0 [ 10.711380][ T183] ? lock_acquire+0x13c/0x160 [ 10.711383][ T183] console_emit_next_record+0x22f/0x4c0 [ 10.711387][ T183] ? devkmsg_read+0x4b0/0x4b0 [ 10.711389][ T183] ? console_flush_one_record+0x106/0x710 [ 10.711392][ T183] ? rcu_is_watching+0x16/0xd0 [ 10.711395][ T183] ? lock_acquire+0x13c/0x160 [ 10.711398][ T183] console_flush_one_record+0x46f/0x710 [ 10.711403][ T183] ? console_emit_next_record+0x4c0/0x4c0 [ 10.711404][ T183] ? __lock_acquire+0x518/0xc20 [ 10.711409][ T183] console_unlock+0xee/0x1f0 [ 10.711412][ T183] ? console_flush_one_record+0x710/0x710 [ 10.711414][ T183] ? rcu_is_watching+0x16/0xd0 [ 10.711416][ T183] ? lock_acquire+0x60/0x160 [ 10.711420][ T183] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.711422][ T183] ? vprintk_emit+0x320/0x3e0 [ 10.711425][ T183] vprintk_emit+0x37c/0x3e0 [ 10.711429][ T183] ? wake_up_klogd_work_func+0x90/0x90 [ 10.711432][ T183] ? __lock_acquire+0x518/0xc20 [ 10.711436][ T183] _printk+0xc7/0x100 [ 10.711440][ T183] ? snapshot_read.cold+0x21/0x21 [ 10.711442][ T183] ? do_raw_spin_lock+0x131/0x280 [ 10.711445][ T183] ? __rwlock_init+0x150/0x150 [ 10.711449][ T183] ? do_raw_spin_lock+0x131/0x280 [ 10.711451][ T183] do_exit.cold+0x82/0x9c [ 10.711455][ T183] ? exit_notify+0x890/0x890 [ 10.711458][ T183] ? __lock_release.isra.0+0x69/0x1a0 [ 10.711462][ T183] ? rcu_is_watching+0x16/0xd0 [ 10.711466][ T183] do_group_exit+0xb8/0x370 [ 10.711469][ T183] __x64_sys_exit_group+0x3c/0x50 [ 10.711470][ T183] x64_sys_call+0x1567/0x1570 [ 10.711473][ T183] do_syscall_64+0xff/0x530 [ 10.711476][ T183] ? exc_page_fault+0xee/0x100 [ 10.711479][ T183] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.711482][ T183] RIP: 0033:0x7fafa815c1b8 [ 10.711484][ T183] Code: Unable to access opcode bytes at 0x7fafa815c18e. [ 10.711485][ T183] RSP: 002b:00007ffd15a07558 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 10.711488][ T183] RAX: ffffffffffffffda RBX: 00007fafa828cf88 RCX: 00007fafa815c1b8 [ 10.711489][ T183] RDX: 00007fafa7ea6fc8 RSI: fffffffffffffeb8 RDI: 0000000000000001 [ 10.711490][ T183] RBP: 00007ffd15a075b0 R08: 0000000000000000 R09: 0000000000000000 [ 10.711491][ T183] R10: 00007ffd15a07370 R11: 0000000000000246 R12: 0000000000000001 [ 10.711491][ T183] R13: 0000000000000001 R14: 00007fafa828b680 R15: 00007fafa828cfa0 [ 10.711498][ T183] [ 12.144588][ T236] br0: port 1(veth1) entered blocking state [ 12.144683][ T236] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.144686][ T236] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 236, name: ip [ 12.144688][ T236] preempt_count: 1, expected: 0 [ 12.144690][ T236] RCU nest depth: 0, expected: 0 [ 12.144691][ T236] locks held by ip/236: 5, last CPU#3: [ 12.144694][ T236] #0: ffffffff9dad2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 12.144710][ T236] #1: ffffffff9d369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.144719][ T236] #2: ffffffff9d369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.144725][ T236] #3: ffffffff9d289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.144731][ T236] #4: ffffffff9d289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.144737][ T236] irq event stamp: 20094 [ 12.144738][ T236] hardirqs last enabled at (20093): [] __down_trylock_console_sem+0x86/0xa0 [ 12.144742][ T236] hardirqs last disabled at (20094): [] console_emit_next_record+0x3d4/0x4c0 [ 12.144745][ T236] softirqs last enabled at (20000): [] __alloc_skb+0x4c2/0x5f0 [ 12.144750][ T236] softirqs last disabled at (19998): [] __alloc_skb+0x4c2/0x5f0 [ 12.144753][ T236] Preemption disabled at: [ 12.144754][ T236] [] vprintk_emit+0x31b/0x3e0 [ 12.144762][ T236] CPU: 3 UID: 0 PID: 236 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.144766][ T236] Tainted: [W]=WARN [ 12.144768][ T236] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.144770][ T236] Call Trace: [ 12.144772][ T236] [ 12.144774][ T236] dump_stack_lvl+0x6f/0xa0 [ 12.144782][ T236] ? vprintk_emit+0x31b/0x3e0 [ 12.144785][ T236] __might_resched.cold+0x1fe/0x2c1 [ 12.144792][ T236] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.144797][ T236] ? __kmalloc_noprof+0xdb/0x760 [ 12.144805][ T236] __kmalloc_noprof+0x443/0x760 [ 12.144808][ T236] ? alloc_buf.isra.0+0x4b/0x260 [ 12.144817][ T236] ? do_raw_spin_unlock+0x59/0x250 [ 12.144821][ T236] alloc_buf.isra.0+0x4b/0x260 [ 12.144826][ T236] put_chars+0x1e1/0x2f0 [ 12.144831][ T236] ? __send_to_port+0x420/0x420 [ 12.144839][ T236] ? validate_chain+0x34a/0xc20 [ 12.144845][ T236] hvc_console_print+0x292/0x780 [ 12.144849][ T236] ? mark_usage+0x61/0x170 [ 12.144852][ T236] ? __lock_acquire+0x518/0xc20 [ 12.144854][ T236] ? __lock_acquire+0x518/0xc20 [ 12.144861][ T236] ? hvc_write+0x3a0/0x3a0 [ 12.144865][ T236] ? console_emit_next_record+0x1df/0x4c0 [ 12.144870][ T236] ? rcu_is_watching+0x16/0xd0 [ 12.144876][ T236] ? lock_acquire+0x13c/0x160 [ 12.144883][ T236] console_emit_next_record+0x22f/0x4c0 [ 12.144889][ T236] ? devkmsg_read+0x4b0/0x4b0 [ 12.144891][ T236] ? console_flush_one_record+0x106/0x710 [ 12.144901][ T236] ? rcu_is_watching+0x16/0xd0 [ 12.144905][ T236] ? lock_acquire+0x13c/0x160 [ 12.144912][ T236] console_flush_one_record+0x46f/0x710 [ 12.144919][ T236] ? console_emit_next_record+0x4c0/0x4c0 [ 12.144921][ T236] ? __lock_acquire+0x518/0xc20 [ 12.144931][ T236] console_unlock+0xee/0x1f0 [ 12.144936][ T236] ? console_flush_one_record+0x710/0x710 [ 12.144938][ T236] ? rcu_is_watching+0x16/0xd0 [ 12.144942][ T236] ? lock_acquire+0x60/0x160 [ 12.144948][ T236] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.144951][ T236] ? vprintk_emit+0x320/0x3e0 [ 12.144957][ T236] vprintk_emit+0x37c/0x3e0 [ 12.144963][ T236] ? wake_up_klogd_work_func+0x90/0x90 [ 12.144967][ T236] ? __lock_release.isra.0+0x69/0x1a0 [ 12.144969][ T236] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.144975][ T236] ? mark_held_locks+0x40/0x70 [ 12.144982][ T236] _printk+0xc7/0x100 [ 12.144987][ T236] ? snapshot_read.cold+0x21/0x21 [ 12.144993][ T236] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 12.145012][ T236] ? do_setlink.isra.0+0xa31/0x2750 [ 12.145014][ T236] ? rtnl_newlink+0x9f1/0x11c0 [ 12.145016][ T236] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.145025][ T236] br_set_state+0x22f/0x430 [bridge] [ 12.145042][ T236] br_init_port+0xc4/0x200 [bridge] [ 12.145056][ T236] new_nbp+0x39c/0x580 [bridge] [ 12.145072][ T236] br_add_if+0x212/0x1320 [bridge] [ 12.145085][ T236] ? is_bpf_text_address+0x72/0x110 [ 12.145090][ T236] ? kernel_text_address+0x149/0x170 [ 12.145095][ T236] ? __kernel_text_address+0x12/0x30 [ 12.145102][ T236] do_set_master+0x357/0x580 [ 12.145110][ T236] do_setlink.isra.0+0xa31/0x2750 [ 12.145115][ T236] ? stack_trace_save+0x93/0xc0 [ 12.145120][ T236] ? rtnl_link_get_size+0x350/0x350 [ 12.145122][ T236] ? rcu_read_lock_any_held+0x66/0x90 [ 12.145126][ T236] ? stack_depot_save_flags+0x38e/0x790 [ 12.145130][ T236] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.145134][ T236] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.145137][ T236] ? validate_chain+0x38b/0xc20 [ 12.145142][ T236] ? kasan_save_stack+0x3d/0x50 [ 12.145146][ T236] ? kasan_save_stack+0x2f/0x50 [ 12.145148][ T236] ? kasan_save_track+0x14/0x30 [ 12.145153][ T236] ? __lock_acquire+0x518/0xc20 [ 12.145156][ T236] ? netlink_seq_next+0x4e/0x60 [ 12.145160][ T236] ? ___sys_sendmsg+0xb0/0x1d0 [ 12.145167][ T236] ? lock_acquire.part.0+0xd4/0x280 [ 12.145170][ T236] ? rtnl_newlink+0x9a8/0x11c0 [ 12.145175][ T236] ? rcu_is_watching+0x16/0xd0 [ 12.145178][ T236] ? lock_acquire+0x13c/0x160 [ 12.145181][ T236] ? rcu_is_watching+0x16/0xd0 [ 12.145183][ T236] ? rcu_is_watching+0x16/0xd0 [ 12.145187][ T236] ? trace_contention_end+0xb3/0x180 [ 12.145193][ T236] ? __mutex_lock+0x1db/0x1ea0 [ 12.145195][ T236] ? __mutex_lock+0x9a3/0x1ea0 [ 12.145199][ T236] ? rtnl_newlink+0x9a8/0x11c0 [ 12.145205][ T236] ? ww_mutex_lock+0x160/0x160 [ 12.145208][ T236] ? nla_get_range_signed+0x3d0/0x3d0 [ 12.145217][ T236] ? __rtnl_newlink+0x3fa/0xa50 [ 12.145227][ T236] rtnl_newlink+0x9f1/0x11c0 [ 12.145236][ T236] ? rtnl_bridge_getlink+0x850/0x850 [ 12.145239][ T236] ? __lock_acquire+0x518/0xc20 [ 12.145247][ T236] ? lock_acquire.part.0+0xd4/0x280 [ 12.145250][ T236] ? find_held_lock+0x2b/0x80 [ 12.145254][ T236] ? rtnl_bridge_getlink+0x850/0x850 [ 12.145257][ T236] ? __lock_release.isra.0+0x69/0x1a0 [ 12.145263][ T236] ? rtnl_bridge_getlink+0x850/0x850 [ 12.145267][ T236] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.145272][ T236] ? rtnl_link_fill+0x920/0x920 [ 12.145274][ T236] ? __lock_acquire+0x518/0xc20 [ 12.145282][ T236] ? lock_acquire.part.0+0xd4/0x280 [ 12.145285][ T236] ? find_held_lock+0x2b/0x80 [ 12.145291][ T236] netlink_rcv_skb+0x14e/0x3a0 [ 12.145294][ T236] ? rtnl_link_fill+0x920/0x920 [ 12.145299][ T236] ? netlink_ack+0xcf0/0xcf0 [ 12.145313][ T236] ? netlink_deliver_tap+0xc5/0x330 [ 12.145316][ T236] ? netlink_deliver_tap+0x13c/0x330 [ 12.145324][ T236] netlink_unicast+0x486/0x750 [ 12.145331][ T236] ? netlink_attachskb+0x810/0x810 [ 12.145335][ T236] ? __lock_acquire+0x518/0xc20 [ 12.145343][ T236] netlink_sendmsg+0x735/0xc60 [ 12.145349][ T236] ? netlink_unicast+0x750/0x750 [ 12.145356][ T236] ? __might_fault+0x97/0x140 [ 12.145365][ T236] ____sys_sendmsg+0x415/0x880 [ 12.145368][ T236] ? copy_msghdr_from_user+0x279/0x420 [ 12.145372][ T236] ? get_timestamp.constprop.0+0x390/0x390 [ 12.145375][ T236] ? move_addr_to_kernel+0x40/0x40 [ 12.145389][ T236] ___sys_sendmsg+0x14e/0x1d0 [ 12.145393][ T236] ? copy_msghdr_from_user+0x420/0x420 [ 12.145424][ T236] __sys_sendmsg+0x12c/0x1d0 [ 12.145429][ T236] ? __sys_sendmsg_sock+0x20/0x20 [ 12.145440][ T236] ? rcu_is_watching+0x16/0xd0 [ 12.145447][ T236] do_syscall_64+0xff/0x530 [ 12.145450][ T236] ? exc_page_fault+0xee/0x100 [ 12.145455][ T236] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.145460][ T236] RIP: 0033:0x7f545243f54e [ 12.145465][ T236] 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.145467][ T236] RSP: 002b:00007fff13548ab0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 12.145472][ T236] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f545243f54e [ 12.145474][ T236] RDX: 0000000000000000 RSI: 00007fff13548b60 RDI: 0000000000000005 [ 12.145476][ T236] RBP: 00007fff13548ac0 R08: 0000000000000000 R09: 0000000000000000 [ 12.145477][ T236] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90db4a [ 12.145478][ T236] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff13549220 [ 12.145492][ T236] [ 12.224432][ T236] br0: port 1(veth1) entered disabled state [ 12.225086][ T236] veth1: entered allmulticast mode [ 12.228347][ T236] veth1: entered promiscuous mode [ 12.238937][ T236] ip (236) used greatest stack depth: 23336 bytes left [ 12.256838][ T238] br0: port 2(veth2) entered blocking state [ 12.257147][ T238] br0: port 2(veth2) entered disabled state [ 12.258592][ T238] veth2: entered allmulticast mode [ 12.260087][ T238] veth2: entered promiscuous mode [ 12.343380][ T93] br0: port 1(veth1) entered blocking state [ 12.344079][ T93] br0: port 1(veth1) entered forwarding state [ 22.542190][ T46] br0: port 2(veth2) entered blocking state [ 22.542215][ T46] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 22.542218][ T46] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 46, name: kworker/u17:1 [ 22.542220][ T46] preempt_count: 202, expected: 0 [ 22.542221][ T46] RCU nest depth: 0, expected: 0 [ 22.542223][ T46] locks held by kworker/u17:1/46: 8, last CPU#0: [ 22.542225][ T46] #0: ff1100000114a940 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0xd9a/0x1560 [ 22.542241][ T46] #1: ffa000000032fd10 ((linkwatch_work).work){+.+.}-{0:0}, at: process_one_work+0xdfc/0x1560 [ 22.542246][ T46] #2: ffffffff9dad2c40 (rtnl_mutex){+.+.}-{4:4}, at: linkwatch_event+0x4e/0xb0 [ 22.542252][ T46] #3: ff1100000c602e58 (&br->lock){+...}-{3:3}, at: br_port_carrier_check+0x161/0x430 [bridge] [ 22.542272][ T46] #4: ffffffff9d369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 22.542278][ T46] #5: ffffffff9d369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 22.542283][ T46] #6: ffffffff9d289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 22.542288][ T46] #7: ffffffff9d289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 22.542293][ T46] irq event stamp: 51071 [ 22.542294][ T46] hardirqs last enabled at (51070): [] __down_trylock_console_sem+0x86/0xa0 [ 22.542298][ T46] hardirqs last disabled at (51071): [] console_emit_next_record+0x3d4/0x4c0 [ 22.542302][ T46] softirqs last enabled at (51032): [] inet6_fill_ifla6_attrs+0x1b3e/0x21e0 [ 22.542306][ T46] softirqs last disabled at (51066): [] br_port_carrier_check+0x161/0x430 [bridge] [ 22.542317][ T46] Preemption disabled at: [ 22.542318][ T46] [<0000000000000000>] 0x0 [ 22.542327][ T46] CPU: 0 UID: 0 PID: 46 Comm: kworker/u17:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 22.542331][ T46] Tainted: [W]=WARN [ 22.542332][ T46] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 22.542335][ T46] Workqueue: events_unbound linkwatch_event [ 22.542339][ T46] Call Trace: [ 22.542341][ T46] [ 22.542343][ T46] dump_stack_lvl+0x6f/0xa0 [ 22.542351][ T46] __might_resched.cold+0x1fe/0x2c1 [ 22.542357][ T46] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 22.542362][ T46] ? __kmalloc_noprof+0xdb/0x760 [ 22.542369][ T46] __kmalloc_noprof+0x443/0x760 [ 22.542372][ T46] ? alloc_buf.isra.0+0x4b/0x260 [ 22.542380][ T46] ? do_raw_spin_unlock+0x59/0x250 [ 22.542383][ T46] alloc_buf.isra.0+0x4b/0x260 [ 22.542388][ T46] put_chars+0x1e1/0x2f0 [ 22.542393][ T46] ? __send_to_port+0x420/0x420 [ 22.542398][ T46] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 22.542404][ T46] ? rcu_read_lock_any_held+0x3c/0x90 [ 22.542407][ T46] ? validate_chain+0x38b/0xc20 [ 22.542414][ T46] hvc_console_print+0x292/0x780 [ 22.542417][ T46] ? mark_usage+0x61/0x170 [ 22.542420][ T46] ? __lock_acquire+0x518/0xc20 [ 22.542422][ T46] ? __lock_acquire+0x518/0xc20 [ 22.542430][ T46] ? hvc_write+0x3a0/0x3a0 [ 22.542432][ T46] ? lock_acquire.part.0+0xd4/0x280 [ 22.542440][ T46] ? lock_acquire+0x13c/0x160 [ 22.542447][ T46] console_emit_next_record+0x22f/0x4c0 [ 22.542453][ T46] ? devkmsg_read+0x4b0/0x4b0 [ 22.542456][ T46] ? console_flush_one_record+0x106/0x710 [ 22.542462][ T46] ? rcu_is_watching+0x16/0xd0 [ 22.542465][ T46] ? lock_acquire+0x13c/0x160 [ 22.542472][ T46] console_flush_one_record+0x46f/0x710 [ 22.542480][ T46] ? console_emit_next_record+0x4c0/0x4c0 [ 22.542482][ T46] ? __lock_acquire+0x518/0xc20 [ 22.542492][ T46] console_unlock+0xee/0x1f0 [ 22.542496][ T46] ? console_flush_one_record+0x710/0x710 [ 22.542499][ T46] ? rcu_is_watching+0x16/0xd0 [ 22.542502][ T46] ? lock_acquire+0x60/0x160 [ 22.542509][ T46] ? __down_trylock_console_sem+0x5e/0xa0 [ 22.542511][ T46] ? vprintk_emit+0x320/0x3e0 [ 22.542517][ T46] vprintk_emit+0x37c/0x3e0 [ 22.542524][ T46] ? wake_up_klogd_work_func+0x90/0x90 [ 22.542528][ T46] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 22.542532][ T46] ? rcu_read_lock_any_held+0x3c/0x90 [ 22.542539][ T46] _printk+0xc7/0x100 [ 22.542544][ T46] ? snapshot_read.cold+0x21/0x21 [ 22.542553][ T46] ? lock_acquire.part.0+0xd4/0x280 [ 22.542560][ T46] br_set_state+0x22f/0x430 [bridge] [ 22.542577][ T46] br_init_port+0xc4/0x200 [bridge] [ 22.542590][ T46] br_stp_enable_port+0x12/0x50 [bridge] [ 22.542603][ T46] br_port_carrier_check+0x220/0x430 [bridge] [ 22.542617][ T46] br_device_event+0x52d/0x8f0 [bridge] [ 22.542632][ T46] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 22.542635][ T46] ? nlmsg_notify+0x62/0x250 [ 22.542646][ T46] notifier_call_chain+0xae/0x300 [ 22.542656][ T46] netif_state_change+0x139/0x340 [ 22.542663][ T46] ? call_netdevice_notifiers_info+0xd0/0xd0 [ 22.542672][ T46] ? linkwatch_do_dev+0xae/0xd0 [ 22.542675][ T46] __linkwatch_run_queue+0x34c/0x750 [ 22.542680][ T46] ? linkwatch_do_dev+0xd0/0xd0 [ 22.542685][ T46] ? lock_acquire.part.0+0xd4/0x280 [ 22.542692][ T46] linkwatch_event+0x7f/0xb0 [ 22.542696][ T46] ? __linkwatch_run_queue+0x750/0x750 [ 22.542702][ T46] process_one_work+0xe3e/0x1560 [ 22.542714][ T46] ? __queue_delayed_work+0x470/0x470 [ 22.542719][ T46] ? lock_acquire.part.0+0xd4/0x280 [ 22.542733][ T46] worker_thread+0x4f1/0xd60 [ 22.542745][ T46] ? rescuer_thread+0x1340/0x1340 [ 22.542749][ T46] kthread+0x367/0x460 [ 22.542752][ T46] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 22.542756][ T46] ? kthread_affine_preferred+0x4c0/0x4c0 [ 22.542760][ T46] ret_from_fork+0x474/0x6b0 [ 22.542766][ T46] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 22.542772][ T46] ? __switch_to+0x5a3/0xe00 [ 22.542776][ T46] ? kthread_affine_preferred+0x4c0/0x4c0 [ 22.542781][ T46] ret_from_fork_asm+0x11/0x20 [ 22.542796][ T46] [ 22.588485][ T46] br0: port 2(veth2) entered forwarding state [ 27.536368][ C3] [ 27.536386][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 27.536388][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 27.536390][ C3] preempt_count: 104, expected: 0 [ 27.536391][ C3] RCU nest depth: 0, expected: 0 [ 27.536392][ C3] INFO: lockdep is turned off. [ 27.536393][ C3] irq event stamp: 513336 [ 27.536394][ C3] hardirqs last enabled at (513336): [] asm_sysvec_call_function_single+0x1a/0x20 [ 27.536403][ C3] hardirqs last disabled at (513335): [] sysvec_call_function_single+0x12/0xe0 [ 27.536407][ C3] softirqs last enabled at (513324): [] handle_softirqs+0x67c/0x900 [ 27.536410][ C3] softirqs last disabled at (513331): [] __irq_exit_rcu+0x145/0x1c0 [ 27.536412][ C3] Preemption disabled at: [ 27.536413][ C3] [<0000000000000000>] 0x0 [ 27.536421][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.536425][ C3] Tainted: [W]=WARN [ 27.536425][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.536427][ C3] Call Trace: [ 27.536429][ C3] [ 27.536431][ C3] dump_stack_lvl+0x6f/0xa0 [ 27.536436][ C3] __might_resched.cold+0x1fe/0x2c1 [ 27.536440][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 27.536443][ C3] ? __asan_memcpy+0x3c/0x60 [ 27.536446][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.536450][ C3] __kmalloc_noprof+0x443/0x760 [ 27.536453][ C3] ? __rwlock_init+0x150/0x150 [ 27.536456][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 27.536460][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 27.536462][ C3] alloc_buf.isra.0+0x4b/0x260 [ 27.536464][ C3] put_chars+0x1e1/0x2f0 [ 27.536466][ C3] ? __send_to_port+0x420/0x420 [ 27.536468][ C3] ? console_prepend_replay+0x20/0x20 [ 27.536471][ C3] hvc_console_print+0x292/0x780 [ 27.536475][ C3] ? hvc_write+0x3a0/0x3a0 [ 27.536476][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.536478][ C3] ? lock_acquire+0x13c/0x160 [ 27.536480][ C3] console_emit_next_record+0x22f/0x4c0 [ 27.536482][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 27.536484][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.536486][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.536488][ C3] ? lock_acquire+0x13c/0x160 [ 27.536490][ C3] ? console_flush_one_record+0x111/0x710 [ 27.536491][ C3] console_flush_one_record+0x46f/0x710 [ 27.536494][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 27.536496][ C3] console_unlock+0xee/0x1f0 [ 27.536498][ C3] ? lock_acquire+0x13c/0x160 [ 27.536500][ C3] ? console_flush_one_record+0x710/0x710 [ 27.536501][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.536503][ C3] ? lock_release+0x184/0x1f0 [ 27.536504][ C3] ? lock_acquire+0x60/0x160 [ 27.536506][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 27.536508][ C3] ? vprintk_emit+0x320/0x3e0 [ 27.536510][ C3] vprintk_emit+0x37c/0x3e0 [ 27.536512][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 27.536514][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.536526][ C3] ? lock_release+0x184/0x1f0 [ 27.536527][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.536534][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.536539][ C3] ? is_module_text_address+0x154/0x250 [ 27.536543][ C3] _printk+0xc7/0x100 [ 27.536546][ C3] ? snapshot_read.cold+0x21/0x21 [ 27.536548][ C3] ? arch_stack_walk+0xd7/0x130 [ 27.536552][ C3] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 27.536554][ C3] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 27.536556][ C3] print_irq_inversion_bug.part.0+0x32/0xc0 [ 27.536558][ C3] mark_lock_irq+0x989/0x9c0 [ 27.536561][ C3] mark_lock+0x1d7/0xa00 [ 27.536563][ C3] mark_usage+0x42/0x170 [ 27.536564][ C3] __lock_acquire+0x388/0xc20 [ 27.536567][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.536568][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.536575][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.536577][ C3] ? lock_acquire+0x13c/0x160 [ 27.536578][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.536585][ C3] _raw_spin_lock+0x33/0x40 [ 27.536587][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.536594][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.536601][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.536607][ C3] call_timer_fn+0x160/0x4d0 [ 27.536610][ C3] ? sysvec_call_function_single+0x4c/0xe0 [ 27.536611][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 27.536614][ C3] ? _raw_spin_unlock_irq+0x28/0x50 [ 27.536616][ C3] __run_timers+0x68f/0xaa0 [ 27.536618][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.536625][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.536627][ C3] ? __lock_acquire+0x518/0xc20 [ 27.536630][ C3] ? __rwlock_init+0x150/0x150 [ 27.536632][ C3] run_timer_softirq+0xf0/0x160 [ 27.536634][ C3] ? __run_timers+0xaa0/0xaa0 [ 27.536636][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.536638][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.536640][ C3] handle_softirqs+0x1d3/0x900 [ 27.536641][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 27.536643][ C3] ? _local_bh_enable+0xc0/0xc0 [ 27.536645][ C3] __irq_exit_rcu+0x145/0x1c0 [ 27.536646][ C3] irq_exit_rcu+0xe/0x30 [ 27.536648][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.536650][ C3] [ 27.536650][ C3] [ 27.536651][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 27.536653][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.536655][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 27.536658][ C3] 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 [ 27.536659][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 27.536663][ C3] RAX: 000000000007d531 RBX: ff11000001c88040 RCX: ffffffff9a0f0307 [ 27.536664][ C3] RDX: ff11000001c88040 RSI: ffffffff9ce38b1c RDI: ffffffff9c88d8e0 [ 27.536665][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 27.536666][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 27.536667][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 27.536668][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.536672][ C3] default_idle+0x9/0x10 [ 27.536674][ C3] default_idle_call+0x6e/0xb0 [ 27.536676][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.536677][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 27.536679][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 27.536681][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.536683][ C3] do_idle+0xd8/0x190 [ 27.536685][ C3] cpu_startup_entry+0x53/0x70 [ 27.536686][ C3] start_secondary+0x204/0x2b0 [ 27.536688][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 27.536690][ C3] common_startup_64+0x13e/0x148 [ 27.536694][ C3] [ 27.564347][ C3] ======================================================== [ 27.564594][ C3] WARNING: possible irq lock inversion dependency detected [ 27.564836][ C3] 7.2.0-virtme #1 Tainted: G W [ 27.565013][ C3] -------------------------------------------------------- [ 27.565253][ C3] swapper/3/0 just changed the state of lock: [ 27.565478][ C3] ff1100000c602e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.565805][ C3] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 27.566006][ C3] (fs_reclaim){+.+.}-{0:0} [ 27.566008][ C3] [ 27.566008][ C3] [ 27.566008][ C3] and interrupts could create inverse lock ordering between them. [ 27.566008][ C3] [ 27.566610][ C3] [ 27.566610][ C3] other info that might help us debug this: [ 27.566849][ C3] Chain exists of: [ 27.566849][ C3] &br->lock --> console_owner --> fs_reclaim [ 27.566849][ C3] [ 27.567195][ C3] Possible interrupt unsafe locking scenario: [ 27.567195][ C3] [ 27.567443][ C3] CPU0 CPU1 [ 27.567581][ C3] ---- ---- [ 27.567768][ C3] lock(fs_reclaim); [ 27.567871][ C3] local_irq_disable(); [ 27.568084][ C3] lock(&br->lock); [ 27.568252][ C3] lock(console_owner); [ 27.568498][ C3] [ 27.568602][ C3] lock(&br->lock); [ 27.568753][ C3] [ 27.568753][ C3] *** DEADLOCK *** [ 27.568753][ C3] [ 27.569014][ C3] locks held by swapper/3/0: 1, last CPU#3: [ 27.569198][ C3] #0: ffa0000000280c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 27.569484][ C3] [ 27.569484][ C3] the shortest dependencies between 2nd lock and 1st lock: [ 27.569813][ C3] -> (fs_reclaim){+.+.}-{0:0} { [ 27.570039][ C3] HARDIRQ-ON-W at: [ 27.570171][ C3] __lock_acquire+0x388/0xc20 [ 27.570430][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.570636][ C3] fs_reclaim_acquire+0xd5/0x120 [ 27.570885][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 27.571142][ C3] kthread_create_worker_on_node+0xea/0x210 [ 27.571368][ C3] workqueue_init+0x2a/0x680 [ 27.571618][ C3] kernel_init_freeable+0x2fe/0x630 [ 27.571924][ C3] kernel_init+0x21/0x150 [ 27.572098][ C3] ret_from_fork+0x474/0x6b0 [ 27.572311][ C3] ret_from_fork_asm+0x11/0x20 [ 27.572530][ C3] SOFTIRQ-ON-W at: [ 27.572635][ C3] __lock_acquire+0x388/0xc20 [ 27.572847][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.573019][ C3] fs_reclaim_acquire+0xd5/0x120 [ 27.573232][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 27.573480][ C3] kthread_create_worker_on_node+0xea/0x210 [ 27.573684][ C3] workqueue_init+0x2a/0x680 [ 27.573897][ C3] kernel_init_freeable+0x2fe/0x630 [ 27.574139][ C3] kernel_init+0x21/0x150 [ 27.574310][ C3] ret_from_fork+0x474/0x6b0 [ 27.574533][ C3] ret_from_fork_asm+0x11/0x20 [ 27.574745][ C3] INITIAL USE at: [ 27.574845][ C3] __lock_acquire+0x388/0xc20 [ 27.575064][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.575229][ C3] fs_reclaim_acquire+0xd5/0x120 [ 27.575458][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 27.575758][ C3] kthread_create_worker_on_node+0xea/0x210 [ 27.576009][ C3] workqueue_init+0x2a/0x680 [ 27.576237][ C3] kernel_init_freeable+0x2fe/0x630 [ 27.576460][ C3] kernel_init+0x21/0x150 [ 27.576632][ C3] ret_from_fork+0x474/0x6b0 [ 27.576843][ C3] ret_from_fork_asm+0x11/0x20 [ 27.577019][ C3] } [ 27.577133][ C3] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 27.577337][ C3] ... acquired at: [ 27.577483][ C3] __lock_acquire+0x518/0xc20 [ 27.577622][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.577798][ C3] fs_reclaim_acquire+0xd5/0x120 [ 27.577940][ C3] __kmalloc_noprof+0xd3/0x760 [ 27.578117][ C3] alloc_buf.isra.0+0x4b/0x260 [ 27.578253][ C3] put_chars+0x1e1/0x2f0 [ 27.578468][ C3] hvc_console_print+0x292/0x780 [ 27.578615][ C3] console_emit_next_record+0x22f/0x4c0 [ 27.578790][ C3] console_flush_one_record+0x46f/0x710 [ 27.578945][ C3] console_unlock+0xee/0x1f0 [ 27.579157][ C3] vprintk_emit+0x37c/0x3e0 [ 27.579289][ C3] _printk+0xc7/0x100 [ 27.579434][ C3] sock_register+0x12d/0x290 [ 27.579568][ C3] inet6_init+0x1a6/0x3e0 [ 27.579746][ C3] do_one_initcall+0x124/0x4f0 [ 27.579879][ C3] kernel_init_freeable+0x596/0x630 [ 27.580061][ C3] kernel_init+0x21/0x150 [ 27.580192][ C3] ret_from_fork+0x474/0x6b0 [ 27.580372][ C3] ret_from_fork_asm+0x11/0x20 [ 27.580506][ C3] [ 27.580573][ C3] -> (console_owner){....}-{0:0} { [ 27.580775][ C3] INITIAL USE at: [ 27.580879][ C3] } [ 27.580995][ C3] ... key at: [] console_owner_dep_map+0x0/0x60 [ 27.581221][ C3] ... acquired at: [ 27.581369][ C3] __lock_acquire+0x518/0xc20 [ 27.581520][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.581724][ C3] console_lock_spinning_enable+0x5c/0x60 [ 27.581918][ C3] console_emit_next_record+0x1d1/0x4c0 [ 27.582128][ C3] console_flush_one_record+0x46f/0x710 [ 27.582308][ C3] console_unlock+0xee/0x1f0 [ 27.582507][ C3] vprintk_emit+0x37c/0x3e0 [ 27.582647][ C3] _printk+0xc7/0x100 [ 27.582797][ C3] br_set_state+0x22f/0x430 [bridge] [ 27.582969][ C3] br_init_port+0xc4/0x200 [bridge] [ 27.583160][ C3] br_stp_enable_port+0x12/0x50 [bridge] [ 27.583331][ C3] br_port_carrier_check+0x220/0x430 [bridge] [ 27.583591][ C3] br_device_event+0x52d/0x8f0 [bridge] [ 27.583761][ C3] notifier_call_chain+0xae/0x300 [ 27.583953][ C3] netif_state_change+0x139/0x340 [ 27.584104][ C3] __linkwatch_run_queue+0x34c/0x750 [ 27.584312][ C3] linkwatch_event+0x7f/0xb0 [ 27.584475][ C3] process_one_work+0xe3e/0x1560 [ 27.584693][ C3] worker_thread+0x4f1/0xd60 [ 27.584870][ C3] kthread+0x367/0x460 [ 27.585051][ C3] ret_from_fork+0x474/0x6b0 [ 27.585207][ C3] ret_from_fork_asm+0x11/0x20 [ 27.585419][ C3] [ 27.585503][ C3] -> (&br->lock){+.-.}-{3:3} { [ 27.585708][ C3] HARDIRQ-ON-W at: [ 27.585836][ C3] __lock_acquire+0x388/0xc20 [ 27.586103][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.586329][ C3] _raw_spin_lock_bh+0x38/0x50 [ 27.586595][ C3] br_add_if+0x8c1/0x1320 [bridge] [ 27.586802][ C3] do_set_master+0x357/0x580 [ 27.587048][ C3] do_setlink.isra.0+0xa31/0x2750 [ 27.587307][ C3] rtnl_newlink+0x9f1/0x11c0 [ 27.587500][ C3] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.587737][ C3] netlink_rcv_skb+0x14e/0x3a0 [ 27.588007][ C3] netlink_unicast+0x486/0x750 [ 27.588194][ C3] netlink_sendmsg+0x735/0xc60 [ 27.588443][ C3] ____sys_sendmsg+0x415/0x880 [ 27.588653][ C3] ___sys_sendmsg+0x14e/0x1d0 [ 27.588866][ C3] __sys_sendmsg+0x12c/0x1d0 [ 27.589145][ C3] do_syscall_64+0xff/0x530 [ 27.589353][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.589627][ C3] IN-SOFTIRQ-W at: [ 27.589747][ C3] __lock_acquire+0x388/0xc20 [ 27.589999][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.590213][ C3] _raw_spin_lock+0x33/0x40 [ 27.590428][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.590700][ C3] call_timer_fn+0x160/0x4d0 [ 27.590918][ C3] __run_timers+0x68f/0xaa0 [ 27.591119][ C3] run_timer_softirq+0xf0/0x160 [ 27.591331][ C3] handle_softirqs+0x1d3/0x900 [ 27.591565][ C3] __irq_exit_rcu+0x145/0x1c0 [ 27.591781][ C3] irq_exit_rcu+0xe/0x30 [ 27.592021][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.592294][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.592499][ C3] pv_native_safe_halt+0xf/0x10 [ 27.592710][ C3] default_idle+0x9/0x10 [ 27.592924][ C3] default_idle_call+0x6e/0xb0 [ 27.593089][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.593370][ C3] do_idle+0xd8/0x190 [ 27.593504][ C3] cpu_startup_entry+0x53/0x70 [ 27.593740][ C3] start_secondary+0x204/0x2b0 [ 27.593979][ C3] common_startup_64+0x13e/0x148 [ 27.594147][ C3] INITIAL USE at: [ 27.594293][ C3] __lock_acquire+0x388/0xc20 [ 27.594466][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.594682][ C3] _raw_spin_lock_bh+0x38/0x50 [ 27.594890][ C3] br_add_if+0x8c1/0x1320 [bridge] [ 27.595065][ C3] do_set_master+0x357/0x580 [ 27.595288][ C3] do_setlink.isra.0+0xa31/0x2750 [ 27.595456][ C3] rtnl_newlink+0x9f1/0x11c0 [ 27.595692][ C3] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.595918][ C3] netlink_rcv_skb+0x14e/0x3a0 [ 27.596091][ C3] netlink_unicast+0x486/0x750 [ 27.596325][ C3] netlink_sendmsg+0x735/0xc60 [ 27.596543][ C3] ____sys_sendmsg+0x415/0x880 [ 27.596728][ C3] ___sys_sendmsg+0x14e/0x1d0 [ 27.596974][ C3] __sys_sendmsg+0x12c/0x1d0 [ 27.597173][ C3] do_syscall_64+0xff/0x530 [ 27.597399][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.597643][ C3] } [ 27.597711][ C3] ... key at: [] __key.7+0x0/0x40 [bridge] [ 27.597967][ C3] ... acquired at: [ 27.598066][ C3] mark_lock+0x1d7/0xa00 [ 27.598246][ C3] mark_usage+0x42/0x170 [ 27.598378][ C3] __lock_acquire+0x388/0xc20 [ 27.598558][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.598688][ C3] _raw_spin_lock+0x33/0x40 [ 27.598863][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.599040][ C3] call_timer_fn+0x160/0x4d0 [ 27.599217][ C3] __run_timers+0x68f/0xaa0 [ 27.599348][ C3] run_timer_softirq+0xf0/0x160 [ 27.599526][ C3] handle_softirqs+0x1d3/0x900 [ 27.599661][ C3] __irq_exit_rcu+0x145/0x1c0 [ 27.599835][ C3] irq_exit_rcu+0xe/0x30 [ 27.599968][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.600176][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.600387][ C3] pv_native_safe_halt+0xf/0x10 [ 27.600520][ C3] default_idle+0x9/0x10 [ 27.600695][ C3] default_idle_call+0x6e/0xb0 [ 27.600826][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.601039][ C3] do_idle+0xd8/0x190 [ 27.601152][ C3] cpu_startup_entry+0x53/0x70 [ 27.601366][ C3] start_secondary+0x204/0x2b0 [ 27.601546][ C3] common_startup_64+0x13e/0x148 [ 27.601760][ C3] [ 27.601845][ C3] [ 27.601845][ C3] stack backtrace: [ 27.602043][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.602047][ C3] Tainted: [W]=WARN [ 27.602048][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.602049][ C3] Call Trace: [ 27.602050][ C3] [ 27.602052][ C3] dump_stack_lvl+0x6f/0xa0 [ 27.602056][ C3] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 27.602059][ C3] mark_lock_irq+0x989/0x9c0 [ 27.602062][ C3] mark_lock+0x1d7/0xa00 [ 27.602064][ C3] mark_usage+0x42/0x170 [ 27.602066][ C3] __lock_acquire+0x388/0xc20 [ 27.602068][ C3] lock_acquire.part.0+0xd4/0x280 [ 27.602069][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.602076][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.602079][ C3] ? lock_acquire+0x13c/0x160 [ 27.602081][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.602087][ C3] _raw_spin_lock+0x33/0x40 [ 27.602089][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.602095][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.602101][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.602108][ C3] call_timer_fn+0x160/0x4d0 [ 27.602109][ C3] ? sysvec_call_function_single+0x4c/0xe0 [ 27.602111][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 27.602114][ C3] ? _raw_spin_unlock_irq+0x28/0x50 [ 27.602116][ C3] __run_timers+0x68f/0xaa0 [ 27.602118][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.602124][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.602126][ C3] ? __lock_acquire+0x518/0xc20 [ 27.602129][ C3] ? __rwlock_init+0x150/0x150 [ 27.602131][ C3] run_timer_softirq+0xf0/0x160 [ 27.602133][ C3] ? __run_timers+0xaa0/0xaa0 [ 27.602134][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.602137][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.602139][ C3] handle_softirqs+0x1d3/0x900 [ 27.602141][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 27.602142][ C3] ? _local_bh_enable+0xc0/0xc0 [ 27.602144][ C3] __irq_exit_rcu+0x145/0x1c0 [ 27.602146][ C3] irq_exit_rcu+0xe/0x30 [ 27.602147][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.602149][ C3] [ 27.602149][ C3] [ 27.602150][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 27.602152][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.602153][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 27.602155][ C3] 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 [ 27.602157][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 27.602159][ C3] RAX: 000000000007d531 RBX: ff11000001c88040 RCX: ffffffff9a0f0307 [ 27.602160][ C3] RDX: ff11000001c88040 RSI: ffffffff9ce38b1c RDI: ffffffff9c88d8e0 [ 27.602161][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 27.602162][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 27.602163][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 27.602165][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.602167][ C3] default_idle+0x9/0x10 [ 27.602168][ C3] default_idle_call+0x6e/0xb0 [ 27.602170][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.602172][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 27.602173][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 27.602175][ C3] ? rcu_is_watching+0x16/0xd0 [ 27.602177][ C3] do_idle+0xd8/0x190 [ 27.602178][ C3] cpu_startup_entry+0x53/0x70 [ 27.602180][ C3] start_secondary+0x204/0x2b0 [ 27.602181][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 27.602183][ C3] common_startup_64+0x13e/0x148 [ 27.602186][ C3] [ 27.769884][ T257] GACT probability NOT on [ 28.909353][ T266] br0: port 2(veth2) entered disabled state [ 28.909373][ T266] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 28.909376][ T266] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 266, name: ip [ 28.909378][ T266] preempt_count: 202, expected: 0 [ 28.909379][ T266] RCU nest depth: 0, expected: 0 [ 28.909380][ T266] INFO: lockdep is turned off. [ 28.909382][ T266] irq event stamp: 0 [ 28.909383][ T266] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 28.909389][ T266] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 28.909397][ T266] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 28.909399][ T266] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 28.909401][ T266] Preemption disabled at: [ 28.909402][ T266] [<0000000000000000>] 0x0 [ 28.909409][ T266] CPU: 2 UID: 0 PID: 266 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.909413][ T266] Tainted: [W]=WARN [ 28.909414][ T266] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.909416][ T266] Call Trace: [ 28.909417][ T266] [ 28.909419][ T266] dump_stack_lvl+0x6f/0xa0 [ 28.909425][ T266] __might_resched.cold+0x1fe/0x2c1 [ 28.909430][ T266] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 28.909434][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909438][ T266] __kmalloc_noprof+0x443/0x760 [ 28.909442][ T266] ? __rwlock_init+0x150/0x150 [ 28.909445][ T266] ? alloc_buf.isra.0+0x4b/0x260 [ 28.909450][ T266] ? do_raw_spin_unlock+0x59/0x250 [ 28.909452][ T266] alloc_buf.isra.0+0x4b/0x260 [ 28.909455][ T266] put_chars+0x1e1/0x2f0 [ 28.909457][ T266] ? __send_to_port+0x420/0x420 [ 28.909460][ T266] ? printk_get_next_message+0x240/0x650 [ 28.909464][ T266] hvc_console_print+0x292/0x780 [ 28.909468][ T266] ? hvc_write+0x3a0/0x3a0 [ 28.909471][ T266] ? __rwlock_init+0x150/0x150 [ 28.909473][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909475][ T266] ? lock_acquire+0x13c/0x160 [ 28.909478][ T266] console_emit_next_record+0x22f/0x4c0 [ 28.909481][ T266] ? devkmsg_read+0x4b0/0x4b0 [ 28.909484][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909486][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909488][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909490][ T266] ? lock_acquire+0x13c/0x160 [ 28.909492][ T266] ? console_flush_one_record+0x111/0x710 [ 28.909494][ T266] console_flush_one_record+0x46f/0x710 [ 28.909497][ T266] ? console_emit_next_record+0x4c0/0x4c0 [ 28.909501][ T266] console_unlock+0xee/0x1f0 [ 28.909503][ T266] ? lock_acquire+0x13c/0x160 [ 28.909505][ T266] ? console_flush_one_record+0x710/0x710 [ 28.909507][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909509][ T266] ? lock_release+0x184/0x1f0 [ 28.909511][ T266] ? lock_acquire+0x60/0x160 [ 28.909512][ T266] ? __rcu_read_lock+0x30/0x70 [ 28.909515][ T266] ? __down_trylock_console_sem+0x5e/0xa0 [ 28.909517][ T266] ? vprintk_emit+0x320/0x3e0 [ 28.909520][ T266] vprintk_emit+0x37c/0x3e0 [ 28.909523][ T266] ? wake_up_klogd_work_func+0x90/0x90 [ 28.909525][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909527][ T266] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.909530][ T266] ? trace_hardirqs_on+0x36/0x40 [ 28.909533][ T266] _printk+0xc7/0x100 [ 28.909537][ T266] ? snapshot_read.cold+0x21/0x21 [ 28.909540][ T266] ? ipv6_mc_down+0x17e/0x2d0 [ 28.909545][ T266] br_set_state+0x22f/0x430 [bridge] [ 28.909562][ T266] br_stp_disable_port+0x11f/0x390 [bridge] [ 28.909573][ T266] br_device_event+0x7b5/0x8f0 [bridge] [ 28.909584][ T266] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 28.909588][ T266] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 28.909591][ T266] ? addrconf_notify+0x2c8/0xf30 [ 28.909595][ T266] notifier_call_chain+0xae/0x300 [ 28.909599][ T266] __dev_notify_flags+0x23c/0x3c0 [ 28.909603][ T266] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.909605][ T266] ? netif_change_name+0x8c0/0x8c0 [ 28.909608][ T266] ? netif_set_allmulti+0x250/0x250 [ 28.909610][ T266] ? __kernel_text_address+0x12/0x30 [ 28.909613][ T266] ? write_profile+0xf0/0xf0 [ 28.909615][ T266] ? unwind_get_return_address+0x67/0xd0 [ 28.909619][ T266] netif_change_flags+0xfe/0x190 [ 28.909622][ T266] do_setlink.isra.0+0x1cc3/0x2750 [ 28.909625][ T266] ? stack_trace_save+0x93/0xc0 [ 28.909627][ T266] ? rtnl_link_get_size+0x350/0x350 [ 28.909629][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909631][ T266] ? stack_depot_save_flags+0x1bc/0x790 [ 28.909635][ T266] ? kasan_save_stack+0x3d/0x50 [ 28.909638][ T266] ? kasan_save_stack+0x2f/0x50 [ 28.909640][ T266] ? kasan_save_track+0x14/0x30 [ 28.909642][ T266] ? __kasan_kmalloc+0x7b/0x90 [ 28.909644][ T266] ? __kmalloc_cache_noprof+0x29a/0x620 [ 28.909646][ T266] ? rtnl_newlink+0x124/0x11c0 [ 28.909647][ T266] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.909649][ T266] ? netlink_rcv_skb+0x14e/0x3a0 [ 28.909652][ T266] ? netlink_unicast+0x486/0x750 [ 28.909653][ T266] ? netlink_sendmsg+0x735/0xc60 [ 28.909655][ T266] ? ____sys_sendmsg+0x415/0x880 [ 28.909658][ T266] ? ___sys_sendmsg+0x14e/0x1d0 [ 28.909660][ T266] ? __sys_sendmsg+0x12c/0x1d0 [ 28.909662][ T266] ? do_syscall_64+0xff/0x530 [ 28.909664][ T266] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.909667][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909669][ T266] ? lock_acquire+0x13c/0x160 [ 28.909671][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909673][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909675][ T266] ? trace_contention_end+0xb3/0x180 [ 28.909679][ T266] ? __mutex_lock+0x1db/0x1ea0 [ 28.909680][ T266] ? __mutex_lock+0x9a3/0x1ea0 [ 28.909682][ T266] ? rtnl_newlink+0x9a8/0x11c0 [ 28.909684][ T266] ? ww_mutex_lock+0x160/0x160 [ 28.909687][ T266] ? __rtnl_newlink+0x3fa/0xa50 [ 28.909690][ T266] rtnl_newlink+0x9f1/0x11c0 [ 28.909693][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909695][ T266] ? rtnl_bridge_getlink+0x850/0x850 [ 28.909697][ T266] ? lock_acquire+0x13c/0x160 [ 28.909698][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909701][ T266] ? is_bpf_text_address+0x3e/0x110 [ 28.909705][ T266] ? is_bpf_text_address+0x72/0x110 [ 28.909707][ T266] ? kernel_text_address+0x149/0x170 [ 28.909709][ T266] ? __kernel_text_address+0x12/0x30 [ 28.909710][ T266] ? write_profile+0xf0/0xf0 [ 28.909712][ T266] ? unwind_get_return_address+0x67/0xd0 [ 28.909713][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909716][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909717][ T266] ? cap_capable+0x1d7/0x3d0 [ 28.909721][ T266] ? lock_acquire+0x13c/0x160 [ 28.909723][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909726][ T266] ? rtnl_bridge_getlink+0x850/0x850 [ 28.909727][ T266] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.909730][ T266] ? rtnl_link_fill+0x920/0x920 [ 28.909732][ T266] ? filter_irq_stacks+0xd0/0xd0 [ 28.909734][ T266] ? stack_depot_save_flags+0x1bc/0x790 [ 28.909737][ T266] netlink_rcv_skb+0x14e/0x3a0 [ 28.909739][ T266] ? rtnl_link_fill+0x920/0x920 [ 28.909741][ T266] ? lock_release+0x184/0x1f0 [ 28.909743][ T266] ? netlink_ack+0xcf0/0xcf0 [ 28.909744][ T266] ? __netlink_lookup+0xb9/0x6b0 [ 28.909748][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909750][ T266] ? lock_release+0x184/0x1f0 [ 28.909753][ T266] netlink_unicast+0x486/0x750 [ 28.909755][ T266] ? netlink_attachskb+0x810/0x810 [ 28.909758][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909760][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909762][ T266] ? lock_acquire+0x13c/0x160 [ 28.909764][ T266] netlink_sendmsg+0x735/0xc60 [ 28.909767][ T266] ? netlink_unicast+0x750/0x750 [ 28.909769][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909771][ T266] ? lock_release+0x184/0x1f0 [ 28.909774][ T266] ____sys_sendmsg+0x415/0x880 [ 28.909776][ T266] ? copy_msghdr_from_user+0x279/0x420 [ 28.909778][ T266] ? get_timestamp.constprop.0+0x390/0x390 [ 28.909780][ T266] ? move_addr_to_kernel+0x40/0x40 [ 28.909782][ T266] ? filter_irq_stacks+0xd0/0xd0 [ 28.909785][ T266] ___sys_sendmsg+0x14e/0x1d0 [ 28.909788][ T266] ? copy_msghdr_from_user+0x420/0x420 [ 28.909795][ T266] __sys_sendmsg+0x12c/0x1d0 [ 28.909797][ T266] ? __sys_sendmsg_sock+0x20/0x20 [ 28.909801][ T266] ? rcu_is_watching+0x16/0xd0 [ 28.909804][ T266] do_syscall_64+0xff/0x530 [ 28.909806][ T266] ? exc_page_fault+0xee/0x100 [ 28.909809][ T266] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.909811][ T266] RIP: 0033:0x7fb048eb454e [ 28.909813][ T266] 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.909815][ T266] RSP: 002b:00007fff56c444e0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 28.909819][ T266] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fb048eb454e [ 28.909821][ T266] RDX: 0000000000000000 RSI: 00007fff56c44590 RDI: 0000000000000005 [ 28.909822][ T266] RBP: 00007fff56c444f0 R08: 0000000000000000 R09: 0000000000000000 [ 28.909823][ T266] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90db5b [ 28.909824][ T266] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff56c44c50 [ 28.909827][ T266] [ 28.966275][ T266] ip (266) used greatest stack depth: 23016 bytes left [ 29.017339][ T39] br0: port 2(veth2) entered blocking state [ 29.017571][ T39] br0: port 2(veth2) entered forwarding state [ 35.257444][ T290] br0: port 1(veth1) entered disabled state [ 35.257462][ T290] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 35.257465][ T290] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 290, name: ip [ 35.257466][ T290] preempt_count: 202, expected: 0 [ 35.257467][ T290] RCU nest depth: 0, expected: 0 [ 35.257468][ T290] INFO: lockdep is turned off. [ 35.257469][ T290] irq event stamp: 0 [ 35.257470][ T290] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 35.257475][ T290] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 35.257481][ T290] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 35.257482][ T290] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 35.257484][ T290] Preemption disabled at: [ 35.257485][ T290] [<0000000000000000>] 0x0 [ 35.257490][ T290] CPU: 3 UID: 0 PID: 290 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 35.257494][ T290] Tainted: [W]=WARN [ 35.257494][ T290] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 35.257496][ T290] Call Trace: [ 35.257498][ T290] [ 35.257499][ T290] dump_stack_lvl+0x6f/0xa0 [ 35.257505][ T290] __might_resched.cold+0x1fe/0x2c1 [ 35.257508][ T290] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 35.257512][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257516][ T290] __kmalloc_noprof+0x443/0x760 [ 35.257519][ T290] ? __rwlock_init+0x150/0x150 [ 35.257522][ T290] ? alloc_buf.isra.0+0x4b/0x260 [ 35.257526][ T290] ? do_raw_spin_unlock+0x59/0x250 [ 35.257528][ T290] alloc_buf.isra.0+0x4b/0x260 [ 35.257530][ T290] put_chars+0x1e1/0x2f0 [ 35.257532][ T290] ? __send_to_port+0x420/0x420 [ 35.257533][ T290] ? printk_get_next_message+0x240/0x650 [ 35.257537][ T290] hvc_console_print+0x292/0x780 [ 35.257540][ T290] ? hvc_write+0x3a0/0x3a0 [ 35.257542][ T290] ? __rwlock_init+0x150/0x150 [ 35.257544][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257546][ T290] ? lock_acquire+0x13c/0x160 [ 35.257548][ T290] console_emit_next_record+0x22f/0x4c0 [ 35.257550][ T290] ? devkmsg_read+0x4b0/0x4b0 [ 35.257552][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257554][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257555][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257557][ T290] ? lock_acquire+0x13c/0x160 [ 35.257559][ T290] ? console_flush_one_record+0x111/0x710 [ 35.257560][ T290] console_flush_one_record+0x46f/0x710 [ 35.257563][ T290] ? console_emit_next_record+0x4c0/0x4c0 [ 35.257565][ T290] console_unlock+0xee/0x1f0 [ 35.257567][ T290] ? lock_acquire+0x13c/0x160 [ 35.257568][ T290] ? console_flush_one_record+0x710/0x710 [ 35.257570][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257572][ T290] ? lock_release+0x184/0x1f0 [ 35.257573][ T290] ? lock_acquire+0x60/0x160 [ 35.257575][ T290] ? __rcu_read_lock+0x30/0x70 [ 35.257577][ T290] ? __down_trylock_console_sem+0x5e/0xa0 [ 35.257579][ T290] ? vprintk_emit+0x320/0x3e0 [ 35.257581][ T290] vprintk_emit+0x37c/0x3e0 [ 35.257583][ T290] ? wake_up_klogd_work_func+0x90/0x90 [ 35.257585][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257586][ T290] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 35.257589][ T290] ? trace_hardirqs_on+0x36/0x40 [ 35.257591][ T290] _printk+0xc7/0x100 [ 35.257594][ T290] ? snapshot_read.cold+0x21/0x21 [ 35.257596][ T290] ? ipv6_mc_down+0x17e/0x2d0 [ 35.257600][ T290] br_set_state+0x22f/0x430 [bridge] [ 35.257614][ T290] br_stp_disable_port+0x11f/0x390 [bridge] [ 35.257622][ T290] br_device_event+0x7b5/0x8f0 [bridge] [ 35.257630][ T290] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 35.257634][ T290] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 35.257636][ T290] ? addrconf_notify+0x2c8/0xf30 [ 35.257639][ T290] notifier_call_chain+0xae/0x300 [ 35.257642][ T290] __dev_notify_flags+0x23c/0x3c0 [ 35.257646][ T290] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 35.257648][ T290] ? netif_change_name+0x8c0/0x8c0 [ 35.257650][ T290] ? netif_set_allmulti+0x250/0x250 [ 35.257652][ T290] ? __kernel_text_address+0x12/0x30 [ 35.257654][ T290] ? write_profile+0xf0/0xf0 [ 35.257656][ T290] ? unwind_get_return_address+0x67/0xd0 [ 35.257659][ T290] netif_change_flags+0xfe/0x190 [ 35.257661][ T290] do_setlink.isra.0+0x1cc3/0x2750 [ 35.257664][ T290] ? stack_trace_save+0x93/0xc0 [ 35.257665][ T290] ? rtnl_link_get_size+0x350/0x350 [ 35.257666][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257668][ T290] ? stack_depot_save_flags+0x1bc/0x790 [ 35.257672][ T290] ? kasan_save_stack+0x3d/0x50 [ 35.257674][ T290] ? kasan_save_stack+0x2f/0x50 [ 35.257676][ T290] ? kasan_save_track+0x14/0x30 [ 35.257677][ T290] ? __kasan_kmalloc+0x7b/0x90 [ 35.257679][ T290] ? __kmalloc_cache_noprof+0x29a/0x620 [ 35.257680][ T290] ? rtnl_newlink+0x124/0x11c0 [ 35.257681][ T290] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 35.257683][ T290] ? netlink_rcv_skb+0x14e/0x3a0 [ 35.257685][ T290] ? netlink_unicast+0x486/0x750 [ 35.257687][ T290] ? netlink_sendmsg+0x735/0xc60 [ 35.257688][ T290] ? ____sys_sendmsg+0x415/0x880 [ 35.257690][ T290] ? ___sys_sendmsg+0x14e/0x1d0 [ 35.257692][ T290] ? __sys_sendmsg+0x12c/0x1d0 [ 35.257693][ T290] ? do_syscall_64+0xff/0x530 [ 35.257695][ T290] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.257698][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257700][ T290] ? lock_acquire+0x13c/0x160 [ 35.257701][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257702][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257704][ T290] ? trace_contention_end+0xb3/0x180 [ 35.257707][ T290] ? __mutex_lock+0x1db/0x1ea0 [ 35.257709][ T290] ? __mutex_lock+0x9a3/0x1ea0 [ 35.257710][ T290] ? rtnl_newlink+0x9a8/0x11c0 [ 35.257712][ T290] ? ww_mutex_lock+0x160/0x160 [ 35.257714][ T290] ? __rtnl_newlink+0x3fa/0xa50 [ 35.257716][ T290] rtnl_newlink+0x9f1/0x11c0 [ 35.257718][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257719][ T290] ? rtnl_bridge_getlink+0x850/0x850 [ 35.257721][ T290] ? lock_acquire+0x13c/0x160 [ 35.257722][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257724][ T290] ? is_bpf_text_address+0x3e/0x110 [ 35.257727][ T290] ? is_bpf_text_address+0x72/0x110 [ 35.257729][ T290] ? kernel_text_address+0x149/0x170 [ 35.257730][ T290] ? __kernel_text_address+0x12/0x30 [ 35.257731][ T290] ? write_profile+0xf0/0xf0 [ 35.257733][ T290] ? unwind_get_return_address+0x67/0xd0 [ 35.257734][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257736][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257737][ T290] ? cap_capable+0x1d7/0x3d0 [ 35.257741][ T290] ? lock_acquire+0x13c/0x160 [ 35.257742][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257744][ T290] ? rtnl_bridge_getlink+0x850/0x850 [ 35.257745][ T290] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 35.257747][ T290] ? rtnl_link_fill+0x920/0x920 [ 35.257748][ T290] ? filter_irq_stacks+0xd0/0xd0 [ 35.257750][ T290] ? stack_depot_save_flags+0x1bc/0x790 [ 35.257752][ T290] netlink_rcv_skb+0x14e/0x3a0 [ 35.257754][ T290] ? rtnl_link_fill+0x920/0x920 [ 35.257755][ T290] ? lock_release+0x184/0x1f0 [ 35.257756][ T290] ? netlink_ack+0xcf0/0xcf0 [ 35.257758][ T290] ? __netlink_lookup+0xb9/0x6b0 [ 35.257760][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257762][ T290] ? lock_release+0x184/0x1f0 [ 35.257764][ T290] netlink_unicast+0x486/0x750 [ 35.257766][ T290] ? netlink_attachskb+0x810/0x810 [ 35.257767][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257769][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257771][ T290] ? lock_acquire+0x13c/0x160 [ 35.257773][ T290] netlink_sendmsg+0x735/0xc60 [ 35.257774][ T290] ? netlink_unicast+0x750/0x750 [ 35.257776][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257778][ T290] ? lock_release+0x184/0x1f0 [ 35.257780][ T290] ____sys_sendmsg+0x415/0x880 [ 35.257781][ T290] ? copy_msghdr_from_user+0x279/0x420 [ 35.257783][ T290] ? get_timestamp.constprop.0+0x390/0x390 [ 35.257784][ T290] ? move_addr_to_kernel+0x40/0x40 [ 35.257786][ T290] ? filter_irq_stacks+0xd0/0xd0 [ 35.257788][ T290] ___sys_sendmsg+0x14e/0x1d0 [ 35.257790][ T290] ? copy_msghdr_from_user+0x420/0x420 [ 35.257795][ T290] __sys_sendmsg+0x12c/0x1d0 [ 35.257797][ T290] ? __sys_sendmsg_sock+0x20/0x20 [ 35.257799][ T290] ? rcu_is_watching+0x16/0xd0 [ 35.257802][ T290] do_syscall_64+0xff/0x530 [ 35.257803][ T290] ? exc_page_fault+0xee/0x100 [ 35.257805][ T290] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.257807][ T290] RIP: 0033:0x7f190219254e [ 35.257808][ T290] 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 [ 35.257810][ T290] RSP: 002b:00007ffd0420b210 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 35.257814][ T290] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f190219254e [ 35.257815][ T290] RDX: 0000000000000000 RSI: 00007ffd0420b2c0 RDI: 0000000000000005 [ 35.257816][ T290] RBP: 00007ffd0420b220 R08: 0000000000000000 R09: 0000000000000000 [ 35.257817][ T290] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90db61 [ 35.257818][ T290] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffd0420b980 [ 35.257820][ T290] [ 35.312100][ T291] br0: port 2(veth2) entered disabled state [ 35.328506][ T292] veth2: left allmulticast mode [ 35.328679][ T292] veth2: left promiscuous mode [ 35.328885][ T292] br0: port 2(veth2) entered disabled state [ 35.330056][ T292] veth1: left allmulticast mode [ 35.330210][ T292] veth1: left promiscuous mode [ 35.330755][ T292] br0: port 1(veth1) entered disabled state