[ 11.208521][ T262] br1: port 1(veth1) entered blocking state [ 11.208639][ T262] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.208641][ T262] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 262, name: ip [ 11.208643][ T262] preempt_count: 1, expected: 0 [ 11.208644][ T262] RCU nest depth: 0, expected: 0 [ 11.208645][ T262] locks held by ip/262: 5, last CPU#2: [ 11.208650][ T262] #0: ffffffff90ed2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 11.208662][ T262] #1: ffffffff90769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.208673][ T262] #2: ffffffff90769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.208678][ T262] #3: ffffffff90689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.208681][ T262] #4: ffffffff90689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.208685][ T262] irq event stamp: 18320 [ 11.208686][ T262] hardirqs last enabled at (18319): [] __down_trylock_console_sem+0x86/0xa0 [ 11.208689][ T262] hardirqs last disabled at (18320): [] console_emit_next_record+0x3d4/0x4c0 [ 11.208691][ T262] softirqs last enabled at (18232): [] __alloc_skb+0x4c2/0x5f0 [ 11.208694][ T262] softirqs last disabled at (18230): [] __alloc_skb+0x4c2/0x5f0 [ 11.208697][ T262] Preemption disabled at: [ 11.208698][ T262] [] vprintk_emit+0x31b/0x3e0 [ 11.208704][ T262] CPU: 2 UID: 0 PID: 262 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.208708][ T262] Tainted: [W]=WARN [ 11.208708][ T262] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.208710][ T262] Call Trace: [ 11.208712][ T262] [ 11.208713][ T262] dump_stack_lvl+0x6f/0xa0 [ 11.208719][ T262] ? vprintk_emit+0x31b/0x3e0 [ 11.208722][ T262] __might_resched.cold+0x1fe/0x2c1 [ 11.208726][ T262] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.208730][ T262] ? __kmalloc_noprof+0xdb/0x760 [ 11.208736][ T262] __kmalloc_noprof+0x443/0x760 [ 11.208738][ T262] ? alloc_buf.isra.0+0x4b/0x260 [ 11.208744][ T262] ? do_raw_spin_unlock+0x59/0x250 [ 11.208747][ T262] alloc_buf.isra.0+0x4b/0x260 [ 11.208750][ T262] put_chars+0x1e1/0x2f0 [ 11.208753][ T262] ? __send_to_port+0x420/0x420 [ 11.208757][ T262] ? validate_chain+0x34a/0xc20 [ 11.208760][ T262] hvc_console_print+0x292/0x780 [ 11.208763][ T262] ? mark_usage+0x61/0x170 [ 11.208765][ T262] ? __lock_acquire+0x518/0xc20 [ 11.208767][ T262] ? __lock_acquire+0x518/0xc20 [ 11.208771][ T262] ? hvc_write+0x3a0/0x3a0 [ 11.208773][ T262] ? console_emit_next_record+0x1df/0x4c0 [ 11.208776][ T262] ? rcu_is_watching+0x16/0xd0 [ 11.208780][ T262] ? lock_acquire+0x13c/0x160 [ 11.208784][ T262] console_emit_next_record+0x22f/0x4c0 [ 11.208788][ T262] ? devkmsg_read+0x4b0/0x4b0 [ 11.208790][ T262] ? console_flush_one_record+0x106/0x710 [ 11.208793][ T262] ? rcu_is_watching+0x16/0xd0 [ 11.208795][ T262] ? lock_acquire+0x13c/0x160 [ 11.208799][ T262] console_flush_one_record+0x46f/0x710 [ 11.208803][ T262] ? console_emit_next_record+0x4c0/0x4c0 [ 11.208805][ T262] ? __lock_acquire+0x518/0xc20 [ 11.208810][ T262] console_unlock+0xee/0x1f0 [ 11.208813][ T262] ? console_flush_one_record+0x710/0x710 [ 11.208815][ T262] ? rcu_is_watching+0x16/0xd0 [ 11.208817][ T262] ? lock_acquire+0x60/0x160 [ 11.208821][ T262] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.208822][ T262] ? vprintk_emit+0x320/0x3e0 [ 11.208826][ T262] vprintk_emit+0x37c/0x3e0 [ 11.208829][ T262] ? wake_up_klogd_work_func+0x90/0x90 [ 11.208832][ T262] ? __lock_release.isra.0+0x69/0x1a0 [ 11.208834][ T262] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 11.208838][ T262] ? mark_held_locks+0x40/0x70 [ 11.208842][ T262] _printk+0xc7/0x100 [ 11.208845][ T262] ? snapshot_read.cold+0x21/0x21 [ 11.208849][ T262] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 11.208862][ T262] ? do_setlink.isra.0+0xa31/0x2750 [ 11.208863][ T262] ? rtnl_newlink+0x9f1/0x11c0 [ 11.208865][ T262] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.208869][ T262] br_set_state+0x22f/0x430 [bridge] [ 11.208879][ T262] br_init_port+0xc4/0x200 [bridge] [ 11.208888][ T262] new_nbp+0x39c/0x580 [bridge] [ 11.208897][ T262] br_add_if+0x212/0x1320 [bridge] [ 11.208904][ T262] ? is_bpf_text_address+0x72/0x110 [ 11.208909][ T262] ? kernel_text_address+0x149/0x170 [ 11.208912][ T262] ? __kernel_text_address+0x12/0x30 [ 11.208916][ T262] do_set_master+0x357/0x580 [ 11.208920][ T262] do_setlink.isra.0+0xa31/0x2750 [ 11.208923][ T262] ? stack_trace_save+0x93/0xc0 [ 11.208927][ T262] ? rtnl_link_get_size+0x350/0x350 [ 11.208928][ T262] ? rcu_read_lock_any_held+0x66/0x90 [ 11.208930][ T262] ? stack_depot_save_flags+0x38e/0x790 [ 11.208934][ T262] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.208937][ T262] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.208939][ T262] ? validate_chain+0x38b/0xc20 [ 11.208942][ T262] ? kasan_save_stack+0x3d/0x50 [ 11.208945][ T262] ? kasan_save_stack+0x2f/0x50 [ 11.208946][ T262] ? kasan_save_track+0x14/0x30 [ 11.208949][ T262] ? __lock_acquire+0x518/0xc20 [ 11.208951][ T262] ? netlink_seq_next+0x4e/0x60 [ 11.208954][ T262] ? ___sys_sendmsg+0xb0/0x1d0 [ 11.208959][ T262] ? lock_acquire.part.0+0xd4/0x280 [ 11.208960][ T262] ? rtnl_newlink+0x9a8/0x11c0 [ 11.208963][ T262] ? rcu_is_watching+0x16/0xd0 [ 11.208965][ T262] ? lock_acquire+0x13c/0x160 [ 11.208967][ T262] ? rcu_is_watching+0x16/0xd0 [ 11.208969][ T262] ? rcu_is_watching+0x16/0xd0 [ 11.208971][ T262] ? trace_contention_end+0xb3/0x180 [ 11.208975][ T262] ? __mutex_lock+0x1db/0x1ea0 [ 11.208977][ T262] ? __mutex_lock+0x9a3/0x1ea0 [ 11.208979][ T262] ? rtnl_newlink+0x9a8/0x11c0 [ 11.208982][ T262] ? ww_mutex_lock+0x160/0x160 [ 11.208984][ T262] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.208989][ T262] ? __rtnl_newlink+0x3fa/0xa50 [ 11.208994][ T262] rtnl_newlink+0x9f1/0x11c0 [ 11.208999][ T262] ? rtnl_bridge_getlink+0x850/0x850 [ 11.209001][ T262] ? __lock_acquire+0x518/0xc20 [ 11.209006][ T262] ? lock_acquire.part.0+0xd4/0x280 [ 11.209008][ T262] ? find_held_lock+0x2b/0x80 [ 11.209010][ T262] ? rtnl_bridge_getlink+0x850/0x850 [ 11.209012][ T262] ? __lock_release.isra.0+0x69/0x1a0 [ 11.209015][ T262] ? rtnl_bridge_getlink+0x850/0x850 [ 11.209017][ T262] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.209020][ T262] ? rtnl_link_fill+0x920/0x920 [ 11.209022][ T262] ? __lock_acquire+0x518/0xc20 [ 11.209026][ T262] ? lock_acquire.part.0+0xd4/0x280 [ 11.209028][ T262] ? find_held_lock+0x2b/0x80 [ 11.209031][ T262] netlink_rcv_skb+0x14e/0x3a0 [ 11.209033][ T262] ? rtnl_link_fill+0x920/0x920 [ 11.209036][ T262] ? netlink_ack+0xcf0/0xcf0 [ 11.209042][ T262] ? netlink_deliver_tap+0xc5/0x330 [ 11.209044][ T262] ? netlink_deliver_tap+0x13c/0x330 [ 11.209048][ T262] netlink_unicast+0x486/0x750 [ 11.209052][ T262] ? netlink_attachskb+0x810/0x810 [ 11.209054][ T262] ? __lock_acquire+0x518/0xc20 [ 11.209059][ T262] netlink_sendmsg+0x735/0xc60 [ 11.209062][ T262] ? netlink_unicast+0x750/0x750 [ 11.209066][ T262] ? __might_fault+0x97/0x140 [ 11.209071][ T262] ____sys_sendmsg+0x415/0x880 [ 11.209073][ T262] ? copy_msghdr_from_user+0x279/0x420 [ 11.209076][ T262] ? get_timestamp.constprop.0+0x390/0x390 [ 11.209077][ T262] ? move_addr_to_kernel+0x40/0x40 [ 11.209085][ T262] ___sys_sendmsg+0x14e/0x1d0 [ 11.209088][ T262] ? copy_msghdr_from_user+0x420/0x420 [ 11.209103][ T262] __sys_sendmsg+0x12c/0x1d0 [ 11.209106][ T262] ? __sys_sendmsg_sock+0x20/0x20 [ 11.209113][ T262] ? rcu_is_watching+0x16/0xd0 [ 11.209116][ T262] do_syscall_64+0xff/0x530 [ 11.209119][ T262] ? exc_page_fault+0xee/0x100 [ 11.209122][ T262] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.209124][ T262] RIP: 0033:0x7fab4c4a454e [ 11.209128][ T262] 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 [ 11.209130][ T262] RSP: 002b:00007ffc2da9c020 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.209132][ T262] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fab4c4a454e [ 11.209134][ T262] RDX: 0000000000000000 RSI: 00007ffc2da9c0d0 RDI: 0000000000000005 [ 11.209135][ T262] RBP: 00007ffc2da9c030 R08: 0000000000000000 R09: 0000000000000000 [ 11.209135][ T262] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9157d1 [ 11.209136][ T262] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc2da9c790 [ 11.209143][ T262] [ 11.256336][ T262] br1: port 1(veth1) entered disabled state [ 11.256825][ T262] veth1: entered allmulticast mode [ 11.258700][ T262] veth1: entered promiscuous mode [ 11.271214][ T262] ip (262) used greatest stack depth: 23336 bytes left [ 11.354772][ T38] br1: port 1(veth1) entered blocking state [ 11.355217][ T38] br1: port 1(veth1) entered forwarding state [ 11.401147][ T275] br1: port 2(veth2) entered blocking state [ 11.401485][ T275] br1: port 2(veth2) entered disabled state [ 11.401803][ T275] veth2: entered allmulticast mode [ 11.403482][ T275] veth2: entered promiscuous mode [ 11.489348][ T38] br1: port 2(veth2) entered blocking state [ 11.489836][ T38] br1: port 2(veth2) entered forwarding state [ 26.512714][ C2] [ 26.512728][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 26.512731][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 26.512732][ C2] preempt_count: 104, expected: 0 [ 26.512733][ C2] RCU nest depth: 0, expected: 0 [ 26.512734][ C2] INFO: lockdep is turned off. [ 26.512735][ C2] irq event stamp: 993092 [ 26.512736][ C2] hardirqs last enabled at (993092): [] _raw_spin_unlock_irq+0x28/0x50 [ 26.512750][ C2] hardirqs last disabled at (993091): [] _raw_spin_lock_irq+0x4a/0x50 [ 26.512752][ C2] softirqs last enabled at (993040): [] handle_softirqs+0x67c/0x900 [ 26.512756][ C2] softirqs last disabled at (993089): [] __irq_exit_rcu+0x145/0x1c0 [ 26.512758][ C2] Preemption disabled at: [ 26.512758][ C2] [<0000000000000000>] 0x0 [ 26.512765][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.512768][ C2] Tainted: [W]=WARN [ 26.512769][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.512771][ C2] Call Trace: [ 26.512773][ C2] [ 26.512775][ C2] dump_stack_lvl+0x6f/0xa0 [ 26.512780][ C2] __might_resched.cold+0x1fe/0x2c1 [ 26.512784][ C2] ? validate_chain+0x38b/0xc20 [ 26.512787][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 26.512790][ C2] ? __asan_memcpy+0x3c/0x60 [ 26.512793][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.512797][ C2] __kmalloc_noprof+0x443/0x760 [ 26.512800][ C2] ? __rwlock_init+0x150/0x150 [ 26.512802][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 26.512805][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 26.512807][ C2] alloc_buf.isra.0+0x4b/0x260 [ 26.512809][ C2] put_chars+0x1e1/0x2f0 [ 26.512811][ C2] ? __send_to_port+0x420/0x420 [ 26.512813][ C2] ? console_prepend_replay+0x20/0x20 [ 26.512816][ C2] hvc_console_print+0x292/0x780 [ 26.512819][ C2] ? hvc_write+0x3a0/0x3a0 [ 26.512821][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.512823][ C2] ? lock_acquire+0x13c/0x160 [ 26.512825][ C2] console_emit_next_record+0x22f/0x4c0 [ 26.512827][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 26.512829][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.512831][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.512833][ C2] ? lock_acquire+0x13c/0x160 [ 26.512834][ C2] ? console_flush_one_record+0x111/0x710 [ 26.512836][ C2] console_flush_one_record+0x46f/0x710 [ 26.512839][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 26.512841][ C2] console_unlock+0xee/0x1f0 [ 26.512843][ C2] ? lock_acquire+0x13c/0x160 [ 26.512844][ C2] ? console_flush_one_record+0x710/0x710 [ 26.512846][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.512848][ C2] ? lock_release+0x184/0x1f0 [ 26.512849][ C2] ? lock_acquire+0x60/0x160 [ 26.512851][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 26.512853][ C2] ? vprintk_emit+0x320/0x3e0 [ 26.512855][ C2] vprintk_emit+0x37c/0x3e0 [ 26.512857][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 26.512859][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.512871][ C2] ? lock_release+0x184/0x1f0 [ 26.512873][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.512879][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.512885][ C2] ? is_module_text_address+0x154/0x250 [ 26.512889][ C2] _printk+0xc7/0x100 [ 26.512892][ C2] ? snapshot_read.cold+0x21/0x21 [ 26.512894][ C2] ? arch_stack_walk+0xd7/0x130 [ 26.512898][ C2] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 26.512900][ C2] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 26.512902][ C2] print_irq_inversion_bug.part.0+0x32/0xc0 [ 26.512904][ C2] mark_lock_irq+0x989/0x9c0 [ 26.512907][ C2] mark_lock+0x1d7/0xa00 [ 26.512909][ C2] mark_usage+0x42/0x170 [ 26.512911][ C2] __lock_acquire+0x388/0xc20 [ 26.512913][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.512915][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.512921][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.512923][ C2] ? lock_acquire+0x13c/0x160 [ 26.512925][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.512931][ C2] _raw_spin_lock+0x33/0x40 [ 26.512932][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.512938][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.512945][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.512951][ C2] call_timer_fn+0x160/0x4d0 [ 26.512954][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 26.512956][ C2] ? debug_object_active_state+0x430/0x430 [ 26.512959][ C2] ? find_held_lock+0x2b/0x80 [ 26.512961][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 26.512963][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.512965][ C2] __run_timers+0x68f/0xaa0 [ 26.512967][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.512974][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 26.512976][ C2] ? __lock_acquire+0x518/0xc20 [ 26.512978][ C2] ? __rwlock_init+0x150/0x150 [ 26.512981][ C2] run_timer_softirq+0xf0/0x160 [ 26.512983][ C2] ? __run_timers+0xaa0/0xaa0 [ 26.512985][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.512987][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.512989][ C2] handle_softirqs+0x1d3/0x900 [ 26.512991][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 26.512992][ C2] ? _local_bh_enable+0xc0/0xc0 [ 26.512994][ C2] __irq_exit_rcu+0x145/0x1c0 [ 26.512996][ C2] irq_exit_rcu+0xe/0x30 [ 26.512997][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.513000][ C2] [ 26.513001][ C2] [ 26.513001][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 26.513003][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.513005][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 26.513008][ C2] Code: 48 8b 3d 94 e2 f5 01 e8 1f 00 00 00 48 2b 05 58 a3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 96 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 [ 26.513010][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 26.513013][ C2] RAX: 00000000000f273f RBX: ff11000001bec6c0 RCX: ffffffff8d4f0307 [ 26.513014][ C2] RDX: ff11000001bec6c0 RSI: ffffffff90238b01 RDI: ffffffff8fc8d8e0 [ 26.513015][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 26.513016][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 26.513016][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 26.513018][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.513021][ C2] default_idle+0x9/0x10 [ 26.513023][ C2] default_idle_call+0x6e/0xb0 [ 26.513025][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.513027][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 26.513028][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 26.513030][ C2] ? trace_sched_exit_tp+0x30/0x160 [ 26.513032][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.513034][ C2] do_idle+0xd8/0x190 [ 26.513036][ C2] cpu_startup_entry+0x53/0x70 [ 26.513037][ C2] start_secondary+0x204/0x2b0 [ 26.513039][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 26.513041][ C2] common_startup_64+0x13e/0x148 [ 26.513045][ C2] [ 26.535438][ C2] ======================================================== [ 26.535640][ C2] WARNING: possible irq lock inversion dependency detected [ 26.535851][ C2] 7.2.0-virtme #1 Tainted: G W [ 26.536073][ C2] -------------------------------------------------------- [ 26.536272][ C2] swapper/2/0 just changed the state of lock: [ 26.536485][ C2] ff1100000cfa2e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.536812][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 26.537062][ C2] (fs_reclaim){+.+.}-{0:0} [ 26.537064][ C2] [ 26.537064][ C2] [ 26.537064][ C2] and interrupts could create inverse lock ordering between them. [ 26.537064][ C2] [ 26.537652][ C2] [ 26.537652][ C2] other info that might help us debug this: [ 26.537860][ C2] Chain exists of: [ 26.537860][ C2] &br->lock --> console_owner --> fs_reclaim [ 26.537860][ C2] [ 26.538262][ C2] Possible interrupt unsafe locking scenario: [ 26.538262][ C2] [ 26.538462][ C2] CPU0 CPU1 [ 26.538645][ C2] ---- ---- [ 26.538785][ C2] lock(fs_reclaim); [ 26.538937][ C2] local_irq_disable(); [ 26.539109][ C2] lock(&br->lock); [ 26.539328][ C2] lock(console_owner); [ 26.539545][ C2] [ 26.539650][ C2] lock(&br->lock); [ 26.539757][ C2] [ 26.539757][ C2] *** DEADLOCK *** [ 26.539757][ C2] [ 26.540007][ C2] locks held by swapper/2/0: 1, last CPU#2: [ 26.540228][ C2] #0: ffa0000000228c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 26.540552][ C2] [ 26.540552][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 26.540838][ C2] -> (fs_reclaim){+.+.}-{0:0} { [ 26.540977][ C2] HARDIRQ-ON-W at: [ 26.541086][ C2] __lock_acquire+0x388/0xc20 [ 26.541309][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.541526][ C2] fs_reclaim_acquire+0xd5/0x120 [ 26.541698][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 26.541957][ C2] kthread_create_worker_on_node+0xea/0x210 [ 26.542210][ C2] workqueue_init+0x2a/0x680 [ 26.542384][ C2] kernel_init_freeable+0x2fe/0x630 [ 26.542637][ C2] kernel_init+0x21/0x150 [ 26.542865][ C2] ret_from_fork+0x474/0x6b0 [ 26.543041][ C2] ret_from_fork_asm+0x11/0x20 [ 26.543308][ C2] SOFTIRQ-ON-W at: [ 26.543409][ C2] __lock_acquire+0x388/0xc20 [ 26.543628][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.543854][ C2] fs_reclaim_acquire+0xd5/0x120 [ 26.544024][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 26.544279][ C2] kthread_create_worker_on_node+0xea/0x210 [ 26.544531][ C2] workqueue_init+0x2a/0x680 [ 26.544703][ C2] kernel_init_freeable+0x2fe/0x630 [ 26.544965][ C2] kernel_init+0x21/0x150 [ 26.545186][ C2] ret_from_fork+0x474/0x6b0 [ 26.545357][ C2] ret_from_fork_asm+0x11/0x20 [ 26.545574][ C2] INITIAL USE at: [ 26.545678][ C2] __lock_acquire+0x388/0xc20 [ 26.545904][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.546122][ C2] fs_reclaim_acquire+0xd5/0x120 [ 26.546290][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 26.546546][ C2] kthread_create_worker_on_node+0xea/0x210 [ 26.546756][ C2] workqueue_init+0x2a/0x680 [ 26.546931][ C2] kernel_init_freeable+0x2fe/0x630 [ 26.547150][ C2] kernel_init+0x21/0x150 [ 26.547368][ C2] ret_from_fork+0x474/0x6b0 [ 26.547538][ C2] ret_from_fork_asm+0x11/0x20 [ 26.547768][ C2] } [ 26.547841][ C2] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 26.548094][ C2] ... acquired at: [ 26.548197][ C2] __lock_acquire+0x518/0xc20 [ 26.548387][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.548522][ C2] fs_reclaim_acquire+0xd5/0x120 [ 26.548705][ C2] __kmalloc_noprof+0xd3/0x760 [ 26.548849][ C2] alloc_buf.isra.0+0x4b/0x260 [ 26.549038][ C2] put_chars+0x1e1/0x2f0 [ 26.549171][ C2] hvc_console_print+0x292/0x780 [ 26.549354][ C2] console_emit_next_record+0x22f/0x4c0 [ 26.549488][ C2] console_flush_one_record+0x46f/0x710 [ 26.549673][ C2] console_unlock+0xee/0x1f0 [ 26.549812][ C2] vprintk_emit+0x37c/0x3e0 [ 26.549995][ C2] dev_vprintk_emit+0x27f/0x2c0 [ 26.550133][ C2] dev_printk_emit+0xb9/0xee [ 26.550315][ C2] _dev_info+0xe2/0x116 [ 26.550417][ C2] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 26.550633][ C2] cmos_do_probe+0x73b/0x98a [ 26.550776][ C2] platform_probe+0xfe/0x1f0 [ 26.550964][ C2] call_driver_probe+0x61/0x1c0 [ 26.551100][ C2] really_probe+0x199/0x760 [ 26.551283][ C2] __driver_probe_device+0x24f/0x440 [ 26.551419][ C2] driver_probe_device+0x4a/0xf0 [ 26.551604][ C2] __driver_attach+0x1b8/0x540 [ 26.551739][ C2] bus_for_each_dev+0x130/0x1e0 [ 26.551928][ C2] bus_add_driver+0x2c8/0x530 [ 26.552064][ C2] driver_register+0x1a3/0x390 [ 26.552248][ C2] __platform_driver_probe+0x13f/0x270 [ 26.552381][ C2] cmos_init+0x31/0x40 [ 26.552533][ C2] do_one_initcall+0x124/0x4f0 [ 26.552668][ C2] kernel_init_freeable+0x596/0x630 [ 26.552855][ C2] kernel_init+0x21/0x150 [ 26.552991][ C2] ret_from_fork+0x474/0x6b0 [ 26.553172][ C2] ret_from_fork_asm+0x11/0x20 [ 26.553311][ C2] [ 26.553383][ C2] -> (console_owner){....}-{0:0} { [ 26.553567][ C2] INITIAL USE at: [ 26.553670][ C2] } [ 26.553791][ C2] ... key at: [] console_owner_dep_map+0x0/0x60 [ 26.553991][ C2] ... acquired at: [ 26.554141][ C2] __lock_acquire+0x518/0xc20 [ 26.554277][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.554458][ C2] console_lock_spinning_enable+0x5c/0x60 [ 26.554626][ C2] console_emit_next_record+0x1d1/0x4c0 [ 26.554819][ C2] console_flush_one_record+0x46f/0x710 [ 26.554958][ C2] console_unlock+0xee/0x1f0 [ 26.555142][ C2] vprintk_emit+0x37c/0x3e0 [ 26.555279][ C2] _printk+0xc7/0x100 [ 26.555428][ C2] br_set_state+0x22f/0x430 [bridge] [ 26.555571][ C2] br_init_port+0xc4/0x200 [bridge] [ 26.555713][ C2] br_stp_enable_port+0x12/0x50 [bridge] [ 26.555891][ C2] br_port_carrier_check+0x220/0x430 [bridge] [ 26.556115][ C2] br_device_event+0x52d/0x8f0 [bridge] [ 26.556254][ C2] notifier_call_chain+0xae/0x300 [ 26.556435][ C2] netif_state_change+0x139/0x340 [ 26.556569][ C2] __linkwatch_run_queue+0x34c/0x750 [ 26.556755][ C2] linkwatch_event+0x7f/0xb0 [ 26.556890][ C2] process_one_work+0xe3e/0x1560 [ 26.557072][ C2] worker_thread+0x4f1/0xd60 [ 26.557209][ C2] kthread+0x367/0x460 [ 26.557359][ C2] ret_from_fork+0x474/0x6b0 [ 26.557494][ C2] ret_from_fork_asm+0x11/0x20 [ 26.557679][ C2] [ 26.557749][ C2] -> (&br->lock){+.-.}-{3:3} { [ 26.557939][ C2] HARDIRQ-ON-W at: [ 26.558042][ C2] __lock_acquire+0x388/0xc20 [ 26.558266][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.558437][ C2] _raw_spin_lock_bh+0x38/0x50 [ 26.558658][ C2] br_set_ageing_time+0x2d/0xf0 [bridge] [ 26.558922][ C2] br_changelink+0x240/0x16e0 [bridge] [ 26.559096][ C2] br_dev_newlink+0xeb/0x160 [bridge] [ 26.559320][ C2] rtnl_newlink_create+0x2d0/0x750 [ 26.559491][ C2] __rtnl_newlink+0x22b/0xa50 [ 26.559710][ C2] rtnl_newlink+0x9f1/0x11c0 [ 26.559935][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.560103][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 26.560329][ C2] netlink_unicast+0x486/0x750 [ 26.560552][ C2] netlink_sendmsg+0x735/0xc60 [ 26.560723][ C2] ____sys_sendmsg+0x415/0x880 [ 26.560950][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 26.561123][ C2] __sys_sendmsg+0x12c/0x1d0 [ 26.561344][ C2] do_syscall_64+0xff/0x530 [ 26.561563][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.561773][ C2] IN-SOFTIRQ-W at: [ 26.561920][ C2] __lock_acquire+0x388/0xc20 [ 26.562093][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.562312][ C2] _raw_spin_lock+0x33/0x40 [ 26.562529][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.562748][ C2] call_timer_fn+0x160/0x4d0 [ 26.562967][ C2] __run_timers+0x68f/0xaa0 [ 26.563188][ C2] run_timer_softirq+0xf0/0x160 [ 26.563359][ C2] handle_softirqs+0x1d3/0x900 [ 26.563581][ C2] __irq_exit_rcu+0x145/0x1c0 [ 26.563810][ C2] irq_exit_rcu+0xe/0x30 [ 26.563988][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.564246][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.564500][ C2] pv_native_safe_halt+0xf/0x10 [ 26.564671][ C2] default_idle+0x9/0x10 [ 26.564895][ C2] default_idle_call+0x6e/0xb0 [ 26.565115][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.565323][ C2] do_idle+0xd8/0x190 [ 26.565509][ C2] cpu_startup_entry+0x53/0x70 [ 26.565682][ C2] start_secondary+0x204/0x2b0 [ 26.565907][ C2] common_startup_64+0x13e/0x148 [ 26.566127][ C2] INITIAL USE at: [ 26.566230][ C2] __lock_acquire+0x388/0xc20 [ 26.566451][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.566621][ C2] _raw_spin_lock_bh+0x38/0x50 [ 26.566845][ C2] br_set_ageing_time+0x2d/0xf0 [bridge] [ 26.567107][ C2] br_changelink+0x240/0x16e0 [bridge] [ 26.567282][ C2] br_dev_newlink+0xeb/0x160 [bridge] [ 26.567506][ C2] rtnl_newlink_create+0x2d0/0x750 [ 26.567679][ C2] __rtnl_newlink+0x22b/0xa50 [ 26.567854][ C2] rtnl_newlink+0x9f1/0x11c0 [ 26.568076][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.568253][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 26.568475][ C2] netlink_unicast+0x486/0x750 [ 26.568698][ C2] netlink_sendmsg+0x735/0xc60 [ 26.568881][ C2] ____sys_sendmsg+0x415/0x880 [ 26.569103][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 26.569319][ C2] __sys_sendmsg+0x12c/0x1d0 [ 26.569490][ C2] do_syscall_64+0xff/0x530 [ 26.569713][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.569974][ C2] } [ 26.570043][ C2] ... key at: [] __key.7+0x0/0x40 [bridge] [ 26.570297][ C2] ... acquired at: [ 26.570396][ C2] mark_lock+0x1d7/0xa00 [ 26.570530][ C2] mark_usage+0x42/0x170 [ 26.570710][ C2] __lock_acquire+0x388/0xc20 [ 26.570850][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.571033][ C2] _raw_spin_lock+0x33/0x40 [ 26.571167][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.571385][ C2] call_timer_fn+0x160/0x4d0 [ 26.571571][ C2] __run_timers+0x68f/0xaa0 [ 26.571706][ C2] run_timer_softirq+0xf0/0x160 [ 26.571897][ C2] handle_softirqs+0x1d3/0x900 [ 26.572032][ C2] __irq_exit_rcu+0x145/0x1c0 [ 26.572210][ C2] irq_exit_rcu+0xe/0x30 [ 26.572344][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.572557][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.572724][ C2] pv_native_safe_halt+0xf/0x10 [ 26.572907][ C2] default_idle+0x9/0x10 [ 26.573040][ C2] default_idle_call+0x6e/0xb0 [ 26.573219][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.573385][ C2] do_idle+0xd8/0x190 [ 26.573535][ C2] cpu_startup_entry+0x53/0x70 [ 26.573668][ C2] start_secondary+0x204/0x2b0 [ 26.573850][ C2] common_startup_64+0x13e/0x148 [ 26.573982][ C2] [ 26.574097][ C2] [ 26.574097][ C2] stack backtrace: [ 26.574262][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.574265][ C2] Tainted: [W]=WARN [ 26.574265][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.574266][ C2] Call Trace: [ 26.574267][ C2] [ 26.574268][ C2] dump_stack_lvl+0x6f/0xa0 [ 26.574271][ C2] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 26.574274][ C2] mark_lock_irq+0x989/0x9c0 [ 26.574277][ C2] mark_lock+0x1d7/0xa00 [ 26.574278][ C2] mark_usage+0x42/0x170 [ 26.574280][ C2] __lock_acquire+0x388/0xc20 [ 26.574282][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.574284][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.574291][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.574293][ C2] ? lock_acquire+0x13c/0x160 [ 26.574295][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.574301][ C2] _raw_spin_lock+0x33/0x40 [ 26.574303][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.574309][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.574315][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.574321][ C2] call_timer_fn+0x160/0x4d0 [ 26.574323][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 26.574325][ C2] ? debug_object_active_state+0x430/0x430 [ 26.574327][ C2] ? find_held_lock+0x2b/0x80 [ 26.574329][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 26.574331][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.574333][ C2] __run_timers+0x68f/0xaa0 [ 26.574335][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.574341][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 26.574343][ C2] ? __lock_acquire+0x518/0xc20 [ 26.574346][ C2] ? __rwlock_init+0x150/0x150 [ 26.574348][ C2] run_timer_softirq+0xf0/0x160 [ 26.574350][ C2] ? __run_timers+0xaa0/0xaa0 [ 26.574352][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.574353][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.574355][ C2] handle_softirqs+0x1d3/0x900 [ 26.574357][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 26.574358][ C2] ? _local_bh_enable+0xc0/0xc0 [ 26.574360][ C2] __irq_exit_rcu+0x145/0x1c0 [ 26.574362][ C2] irq_exit_rcu+0xe/0x30 [ 26.574363][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.574365][ C2] [ 26.574366][ C2] [ 26.574366][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 26.574368][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.574369][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 26.574371][ C2] Code: 48 8b 3d 94 e2 f5 01 e8 1f 00 00 00 48 2b 05 58 a3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 96 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 [ 26.574372][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 26.574374][ C2] RAX: 00000000000f273f RBX: ff11000001bec6c0 RCX: ffffffff8d4f0307 [ 26.574375][ C2] RDX: ff11000001bec6c0 RSI: ffffffff90238b01 RDI: ffffffff8fc8d8e0 [ 26.574376][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 26.574377][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 26.574377][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 26.574379][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.574381][ C2] default_idle+0x9/0x10 [ 26.574383][ C2] default_idle_call+0x6e/0xb0 [ 26.574384][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.574386][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 26.574387][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 26.574389][ C2] ? trace_sched_exit_tp+0x30/0x160 [ 26.574390][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.574392][ C2] do_idle+0xd8/0x190 [ 26.574394][ C2] cpu_startup_entry+0x53/0x70 [ 26.574395][ C2] start_secondary+0x204/0x2b0 [ 26.574397][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 26.574398][ C2] common_startup_64+0x13e/0x148 [ 26.574401][ C2] [ 29.284257][ T729] br1: port 2(veth2) entered disabled state [ 29.284274][ T729] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 29.284276][ T729] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 729, name: ip [ 29.284278][ T729] preempt_count: 202, expected: 0 [ 29.284279][ T729] RCU nest depth: 0, expected: 0 [ 29.284280][ T729] INFO: lockdep is turned off. [ 29.284281][ T729] irq event stamp: 0 [ 29.284281][ T729] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 29.284286][ T729] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 29.284292][ T729] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 29.284294][ T729] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 29.284296][ T729] Preemption disabled at: [ 29.284296][ T729] [<0000000000000000>] 0x0 [ 29.284301][ T729] CPU: 2 UID: 0 PID: 729 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 29.284304][ T729] Tainted: [W]=WARN [ 29.284305][ T729] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 29.284307][ T729] Call Trace: [ 29.284309][ T729] [ 29.284310][ T729] dump_stack_lvl+0x6f/0xa0 [ 29.284316][ T729] __might_resched.cold+0x1fe/0x2c1 [ 29.284320][ T729] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 29.284323][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284327][ T729] __kmalloc_noprof+0x443/0x760 [ 29.284331][ T729] ? __rwlock_init+0x150/0x150 [ 29.284334][ T729] ? alloc_buf.isra.0+0x4b/0x260 [ 29.284338][ T729] ? do_raw_spin_unlock+0x59/0x250 [ 29.284339][ T729] alloc_buf.isra.0+0x4b/0x260 [ 29.284341][ T729] put_chars+0x1e1/0x2f0 [ 29.284343][ T729] ? __send_to_port+0x420/0x420 [ 29.284345][ T729] ? printk_get_next_message+0x240/0x650 [ 29.284348][ T729] hvc_console_print+0x292/0x780 [ 29.284351][ T729] ? hvc_write+0x3a0/0x3a0 [ 29.284354][ T729] ? __rwlock_init+0x150/0x150 [ 29.284355][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284357][ T729] ? lock_acquire+0x13c/0x160 [ 29.284359][ T729] console_emit_next_record+0x22f/0x4c0 [ 29.284362][ T729] ? devkmsg_read+0x4b0/0x4b0 [ 29.284364][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284365][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284367][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284368][ T729] ? lock_acquire+0x13c/0x160 [ 29.284370][ T729] ? console_flush_one_record+0x111/0x710 [ 29.284372][ T729] console_flush_one_record+0x46f/0x710 [ 29.284374][ T729] ? console_emit_next_record+0x4c0/0x4c0 [ 29.284377][ T729] console_unlock+0xee/0x1f0 [ 29.284378][ T729] ? lock_acquire+0x13c/0x160 [ 29.284380][ T729] ? console_flush_one_record+0x710/0x710 [ 29.284381][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284383][ T729] ? lock_release+0x184/0x1f0 [ 29.284384][ T729] ? lock_acquire+0x60/0x160 [ 29.284386][ T729] ? __rcu_read_lock+0x30/0x70 [ 29.284388][ T729] ? __down_trylock_console_sem+0x5e/0xa0 [ 29.284390][ T729] ? vprintk_emit+0x320/0x3e0 [ 29.284392][ T729] vprintk_emit+0x37c/0x3e0 [ 29.284394][ T729] ? wake_up_klogd_work_func+0x90/0x90 [ 29.284396][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284397][ T729] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 29.284400][ T729] ? trace_hardirqs_on+0x36/0x40 [ 29.284402][ T729] _printk+0xc7/0x100 [ 29.284405][ T729] ? snapshot_read.cold+0x21/0x21 [ 29.284407][ T729] ? ipv6_mc_down+0x17e/0x2d0 [ 29.284411][ T729] br_set_state+0x22f/0x430 [bridge] [ 29.284424][ T729] br_stp_disable_port+0x11f/0x390 [bridge] [ 29.284432][ T729] br_device_event+0x7b5/0x8f0 [bridge] [ 29.284440][ T729] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 29.284443][ T729] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 29.284445][ T729] ? addrconf_notify+0x2c8/0xf30 [ 29.284449][ T729] notifier_call_chain+0xae/0x300 [ 29.284451][ T729] __dev_notify_flags+0x23c/0x3c0 [ 29.284455][ T729] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 29.284457][ T729] ? netif_change_name+0x8c0/0x8c0 [ 29.284459][ T729] ? netif_set_allmulti+0x250/0x250 [ 29.284461][ T729] ? __kernel_text_address+0x12/0x30 [ 29.284463][ T729] ? write_profile+0xf0/0xf0 [ 29.284465][ T729] ? unwind_get_return_address+0x67/0xd0 [ 29.284468][ T729] netif_change_flags+0xfe/0x190 [ 29.284470][ T729] do_setlink.isra.0+0x1cc3/0x2750 [ 29.284473][ T729] ? stack_trace_save+0x93/0xc0 [ 29.284474][ T729] ? rtnl_link_get_size+0x350/0x350 [ 29.284476][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284477][ T729] ? stack_depot_save_flags+0x1bc/0x790 [ 29.284481][ T729] ? kasan_save_stack+0x3d/0x50 [ 29.284485][ T729] ? kasan_save_stack+0x2f/0x50 [ 29.284486][ T729] ? kasan_save_track+0x14/0x30 [ 29.284487][ T729] ? __kasan_kmalloc+0x7b/0x90 [ 29.284489][ T729] ? __kmalloc_cache_noprof+0x29a/0x620 [ 29.284491][ T729] ? rtnl_newlink+0x124/0x11c0 [ 29.284492][ T729] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 29.284493][ T729] ? netlink_rcv_skb+0x14e/0x3a0 [ 29.284495][ T729] ? netlink_unicast+0x486/0x750 [ 29.284497][ T729] ? netlink_sendmsg+0x735/0xc60 [ 29.284498][ T729] ? ____sys_sendmsg+0x415/0x880 [ 29.284500][ T729] ? ___sys_sendmsg+0x14e/0x1d0 [ 29.284502][ T729] ? __sys_sendmsg+0x12c/0x1d0 [ 29.284503][ T729] ? do_syscall_64+0xff/0x530 [ 29.284505][ T729] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 29.284508][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284509][ T729] ? lock_acquire+0x13c/0x160 [ 29.284511][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284512][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284514][ T729] ? trace_contention_end+0xb3/0x180 [ 29.284517][ T729] ? __mutex_lock+0x1db/0x1ea0 [ 29.284518][ T729] ? __mutex_lock+0x9a3/0x1ea0 [ 29.284520][ T729] ? rtnl_newlink+0x9a8/0x11c0 [ 29.284522][ T729] ? ww_mutex_lock+0x160/0x160 [ 29.284524][ T729] ? __rtnl_newlink+0x3fa/0xa50 [ 29.284526][ T729] rtnl_newlink+0x9f1/0x11c0 [ 29.284527][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284529][ T729] ? rtnl_bridge_getlink+0x850/0x850 [ 29.284530][ T729] ? lock_acquire+0x13c/0x160 [ 29.284532][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284534][ T729] ? is_bpf_text_address+0x3e/0x110 [ 29.284537][ T729] ? is_bpf_text_address+0x72/0x110 [ 29.284538][ T729] ? kernel_text_address+0x149/0x170 [ 29.284540][ T729] ? __kernel_text_address+0x12/0x30 [ 29.284541][ T729] ? write_profile+0xf0/0xf0 [ 29.284542][ T729] ? unwind_get_return_address+0x67/0xd0 [ 29.284543][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284545][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284547][ T729] ? cap_capable+0x1d7/0x3d0 [ 29.284550][ T729] ? lock_acquire+0x13c/0x160 [ 29.284552][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284553][ T729] ? rtnl_bridge_getlink+0x850/0x850 [ 29.284555][ T729] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 29.284556][ T729] ? rtnl_link_fill+0x920/0x920 [ 29.284557][ T729] ? filter_irq_stacks+0xd0/0xd0 [ 29.284559][ T729] ? stack_depot_save_flags+0x1bc/0x790 [ 29.284561][ T729] netlink_rcv_skb+0x14e/0x3a0 [ 29.284563][ T729] ? rtnl_link_fill+0x920/0x920 [ 29.284564][ T729] ? lock_release+0x184/0x1f0 [ 29.284565][ T729] ? netlink_ack+0xcf0/0xcf0 [ 29.284567][ T729] ? __netlink_lookup+0xb9/0x6b0 [ 29.284569][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284571][ T729] ? lock_release+0x184/0x1f0 [ 29.284573][ T729] netlink_unicast+0x486/0x750 [ 29.284575][ T729] ? netlink_attachskb+0x810/0x810 [ 29.284576][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284578][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284579][ T729] ? lock_acquire+0x13c/0x160 [ 29.284581][ T729] netlink_sendmsg+0x735/0xc60 [ 29.284583][ T729] ? netlink_unicast+0x750/0x750 [ 29.284585][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284586][ T729] ? lock_release+0x184/0x1f0 [ 29.284588][ T729] ____sys_sendmsg+0x415/0x880 [ 29.284590][ T729] ? copy_msghdr_from_user+0x279/0x420 [ 29.284591][ T729] ? get_timestamp.constprop.0+0x390/0x390 [ 29.284593][ T729] ? move_addr_to_kernel+0x40/0x40 [ 29.284594][ T729] ? filter_irq_stacks+0xd0/0xd0 [ 29.284597][ T729] ___sys_sendmsg+0x14e/0x1d0 [ 29.284598][ T729] ? copy_msghdr_from_user+0x420/0x420 [ 29.284603][ T729] __sys_sendmsg+0x12c/0x1d0 [ 29.284605][ T729] ? __sys_sendmsg_sock+0x20/0x20 [ 29.284608][ T729] ? rcu_is_watching+0x16/0xd0 [ 29.284610][ T729] do_syscall_64+0xff/0x530 [ 29.284611][ T729] ? exc_page_fault+0xee/0x100 [ 29.284613][ T729] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 29.284615][ T729] RIP: 0033:0x7f15ea63b54e [ 29.284616][ T729] 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 [ 29.284618][ T729] RSP: 002b:00007ffde7581a30 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 29.284622][ T729] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f15ea63b54e [ 29.284623][ T729] RDX: 0000000000000000 RSI: 00007ffde7581ae0 RDI: 0000000000000005 [ 29.284624][ T729] RBP: 00007ffde7581a40 R08: 0000000000000000 R09: 0000000000000000 [ 29.284625][ T729] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9157e3 [ 29.284625][ T729] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffde75821a0 [ 29.284628][ T729] [ 29.325545][ T729] ip (729) used greatest stack depth: 23016 bytes left [ 29.340558][ T731] veth2: left allmulticast mode [ 29.341449][ T731] veth2: left promiscuous mode [ 29.341713][ T731] br1: port 2(veth2) entered disabled state [ 29.365586][ T733] br1: port 1(veth1) entered disabled state [ 29.386843][ T735] veth1: left allmulticast mode [ 29.387032][ T735] veth1: left promiscuous mode [ 29.387287][ T735] br1: port 1(veth1) entered disabled state