[ 12.117249][ T261] br1: port 1(veth1) entered blocking state [ 12.117432][ T261] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.117435][ T261] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 261, name: ip [ 12.117436][ T261] preempt_count: 1, expected: 0 [ 12.117437][ T261] RCU nest depth: 0, expected: 0 [ 12.117438][ T261] locks held by ip/261: 5, last CPU#3: [ 12.117441][ T261] #0: ffffffff9d4d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 12.117453][ T261] #1: ffffffff9cd69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.117459][ T261] #2: ffffffff9cd69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.117463][ T261] #3: ffffffff9cc89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.117467][ T261] #4: ffffffff9cc89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.117471][ T261] irq event stamp: 16222 [ 12.117472][ T261] hardirqs last enabled at (16221): [] __down_trylock_console_sem+0x86/0xa0 [ 12.117474][ T261] hardirqs last disabled at (16222): [] console_emit_next_record+0x3d4/0x4c0 [ 12.117476][ T261] softirqs last enabled at (16134): [] __alloc_skb+0x4c2/0x5f0 [ 12.117479][ T261] softirqs last disabled at (16132): [] __alloc_skb+0x4c2/0x5f0 [ 12.117482][ T261] Preemption disabled at: [ 12.117483][ T261] [] vprintk_emit+0x31b/0x3e0 [ 12.117488][ T261] CPU: 3 UID: 0 PID: 261 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.117492][ T261] Tainted: [W]=WARN [ 12.117493][ T261] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.117495][ T261] Call Trace: [ 12.117496][ T261] [ 12.117498][ T261] dump_stack_lvl+0x6f/0xa0 [ 12.117504][ T261] ? vprintk_emit+0x31b/0x3e0 [ 12.117506][ T261] __might_resched.cold+0x1fe/0x2c1 [ 12.117510][ T261] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.117514][ T261] ? __kmalloc_noprof+0xdb/0x760 [ 12.117519][ T261] __kmalloc_noprof+0x443/0x760 [ 12.117522][ T261] ? alloc_buf.isra.0+0x4b/0x260 [ 12.117527][ T261] ? do_raw_spin_unlock+0x59/0x250 [ 12.117530][ T261] alloc_buf.isra.0+0x4b/0x260 [ 12.117533][ T261] put_chars+0x1e1/0x2f0 [ 12.117536][ T261] ? __send_to_port+0x420/0x420 [ 12.117540][ T261] ? validate_chain+0x34a/0xc20 [ 12.117544][ T261] hvc_console_print+0x292/0x780 [ 12.117547][ T261] ? mark_usage+0x61/0x170 [ 12.117548][ T261] ? __lock_acquire+0x518/0xc20 [ 12.117550][ T261] ? __lock_acquire+0x518/0xc20 [ 12.117554][ T261] ? hvc_write+0x3a0/0x3a0 [ 12.117556][ T261] ? console_emit_next_record+0x1df/0x4c0 [ 12.117559][ T261] ? rcu_is_watching+0x16/0xd0 [ 12.117563][ T261] ? lock_acquire+0x13c/0x160 [ 12.117567][ T261] console_emit_next_record+0x22f/0x4c0 [ 12.117570][ T261] ? devkmsg_read+0x4b0/0x4b0 [ 12.117572][ T261] ? console_flush_one_record+0x106/0x710 [ 12.117575][ T261] ? rcu_is_watching+0x16/0xd0 [ 12.117578][ T261] ? lock_acquire+0x13c/0x160 [ 12.117582][ T261] console_flush_one_record+0x46f/0x710 [ 12.117585][ T261] ? console_emit_next_record+0x4c0/0x4c0 [ 12.117587][ T261] ? __lock_acquire+0x518/0xc20 [ 12.117592][ T261] console_unlock+0xee/0x1f0 [ 12.117595][ T261] ? console_flush_one_record+0x710/0x710 [ 12.117597][ T261] ? rcu_is_watching+0x16/0xd0 [ 12.117599][ T261] ? lock_acquire+0x60/0x160 [ 12.117603][ T261] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.117604][ T261] ? vprintk_emit+0x320/0x3e0 [ 12.117608][ T261] vprintk_emit+0x37c/0x3e0 [ 12.117612][ T261] ? wake_up_klogd_work_func+0x90/0x90 [ 12.117614][ T261] ? __lock_release.isra.0+0x69/0x1a0 [ 12.117616][ T261] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.117620][ T261] ? mark_held_locks+0x40/0x70 [ 12.117623][ T261] _printk+0xc7/0x100 [ 12.117627][ T261] ? snapshot_read.cold+0x21/0x21 [ 12.117631][ T261] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 12.117644][ T261] ? do_setlink.isra.0+0xa31/0x2750 [ 12.117645][ T261] ? rtnl_newlink+0x9f1/0x11c0 [ 12.117646][ T261] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.117651][ T261] br_set_state+0x22f/0x430 [bridge] [ 12.117661][ T261] br_init_port+0xc4/0x200 [bridge] [ 12.117670][ T261] new_nbp+0x39c/0x580 [bridge] [ 12.117679][ T261] br_add_if+0x212/0x1320 [bridge] [ 12.117686][ T261] ? is_bpf_text_address+0x72/0x110 [ 12.117691][ T261] ? kernel_text_address+0x149/0x170 [ 12.117693][ T261] ? __kernel_text_address+0x12/0x30 [ 12.117697][ T261] do_set_master+0x357/0x580 [ 12.117702][ T261] do_setlink.isra.0+0xa31/0x2750 [ 12.117705][ T261] ? stack_trace_save+0x93/0xc0 [ 12.117708][ T261] ? rtnl_link_get_size+0x350/0x350 [ 12.117709][ T261] ? rcu_read_lock_any_held+0x66/0x90 [ 12.117712][ T261] ? stack_depot_save_flags+0x38e/0x790 [ 12.117715][ T261] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.117718][ T261] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.117720][ T261] ? validate_chain+0x38b/0xc20 [ 12.117722][ T261] ? kasan_save_stack+0x3d/0x50 [ 12.117725][ T261] ? kasan_save_stack+0x2f/0x50 [ 12.117727][ T261] ? kasan_save_track+0x14/0x30 [ 12.117729][ T261] ? __lock_acquire+0x518/0xc20 [ 12.117731][ T261] ? netlink_seq_next+0x4e/0x60 [ 12.117735][ T261] ? ___sys_sendmsg+0xb0/0x1d0 [ 12.117739][ T261] ? lock_acquire.part.0+0xd4/0x280 [ 12.117741][ T261] ? rtnl_newlink+0x9a8/0x11c0 [ 12.117744][ T261] ? rcu_is_watching+0x16/0xd0 [ 12.117746][ T261] ? lock_acquire+0x13c/0x160 [ 12.117747][ T261] ? rcu_is_watching+0x16/0xd0 [ 12.117749][ T261] ? rcu_is_watching+0x16/0xd0 [ 12.117752][ T261] ? trace_contention_end+0xb3/0x180 [ 12.117755][ T261] ? __mutex_lock+0x1db/0x1ea0 [ 12.117757][ T261] ? __mutex_lock+0x9a3/0x1ea0 [ 12.117759][ T261] ? rtnl_newlink+0x9a8/0x11c0 [ 12.117762][ T261] ? ww_mutex_lock+0x160/0x160 [ 12.117764][ T261] ? nla_get_range_signed+0x3d0/0x3d0 [ 12.117769][ T261] ? __rtnl_newlink+0x3fa/0xa50 [ 12.117774][ T261] rtnl_newlink+0x9f1/0x11c0 [ 12.117779][ T261] ? rtnl_bridge_getlink+0x850/0x850 [ 12.117781][ T261] ? __lock_acquire+0x518/0xc20 [ 12.117785][ T261] ? lock_acquire.part.0+0xd4/0x280 [ 12.117787][ T261] ? find_held_lock+0x2b/0x80 [ 12.117789][ T261] ? rtnl_bridge_getlink+0x850/0x850 [ 12.117791][ T261] ? __lock_release.isra.0+0x69/0x1a0 [ 12.117795][ T261] ? rtnl_bridge_getlink+0x850/0x850 [ 12.117797][ T261] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.117800][ T261] ? rtnl_link_fill+0x920/0x920 [ 12.117801][ T261] ? __lock_acquire+0x518/0xc20 [ 12.117805][ T261] ? lock_acquire.part.0+0xd4/0x280 [ 12.117807][ T261] ? find_held_lock+0x2b/0x80 [ 12.117811][ T261] netlink_rcv_skb+0x14e/0x3a0 [ 12.117813][ T261] ? rtnl_link_fill+0x920/0x920 [ 12.117815][ T261] ? netlink_ack+0xcf0/0xcf0 [ 12.117821][ T261] ? netlink_deliver_tap+0xc5/0x330 [ 12.117823][ T261] ? netlink_deliver_tap+0x13c/0x330 [ 12.117827][ T261] netlink_unicast+0x486/0x750 [ 12.117831][ T261] ? netlink_attachskb+0x810/0x810 [ 12.117834][ T261] ? __lock_acquire+0x518/0xc20 [ 12.117838][ T261] netlink_sendmsg+0x735/0xc60 [ 12.117841][ T261] ? netlink_unicast+0x750/0x750 [ 12.117845][ T261] ? __might_fault+0x97/0x140 [ 12.117850][ T261] ____sys_sendmsg+0x415/0x880 [ 12.117853][ T261] ? copy_msghdr_from_user+0x279/0x420 [ 12.117855][ T261] ? get_timestamp.constprop.0+0x390/0x390 [ 12.117856][ T261] ? move_addr_to_kernel+0x40/0x40 [ 12.117864][ T261] ___sys_sendmsg+0x14e/0x1d0 [ 12.117866][ T261] ? copy_msghdr_from_user+0x420/0x420 [ 12.117882][ T261] __sys_sendmsg+0x12c/0x1d0 [ 12.117885][ T261] ? __sys_sendmsg_sock+0x20/0x20 [ 12.117891][ T261] ? rcu_is_watching+0x16/0xd0 [ 12.117894][ T261] do_syscall_64+0xff/0x530 [ 12.117897][ T261] ? exc_page_fault+0xee/0x100 [ 12.117900][ T261] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.117902][ T261] RIP: 0033:0x7f830d63b54e [ 12.117905][ T261] 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.117907][ T261] RSP: 002b:00007ffc384406d0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 12.117910][ T261] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f830d63b54e [ 12.117911][ T261] RDX: 0000000000000000 RSI: 00007ffc38440780 RDI: 0000000000000005 [ 12.117912][ T261] RBP: 00007ffc384406e0 R08: 0000000000000000 R09: 0000000000000000 [ 12.117913][ T261] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9161bf [ 12.117914][ T261] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc38440e40 [ 12.117920][ T261] [ 12.157213][ T261] br1: port 1(veth1) entered disabled state [ 12.157644][ T261] veth1: entered allmulticast mode [ 12.159626][ T261] veth1: entered promiscuous mode [ 12.191196][ T261] ip (261) used greatest stack depth: 23336 bytes left [ 12.288255][ T46] br1: port 1(veth1) entered blocking state [ 12.288767][ T46] br1: port 1(veth1) entered forwarding state [ 12.351423][ T274] br1: port 2(veth2) entered blocking state [ 12.351800][ T274] br1: port 2(veth2) entered disabled state [ 12.352129][ T274] veth2: entered allmulticast mode [ 12.354166][ T274] veth2: entered promiscuous mode [ 12.455758][ T46] br1: port 2(veth2) entered blocking state [ 12.456121][ T46] br1: port 2(veth2) entered forwarding state [ 27.583647][ C0] [ 27.583666][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 27.583668][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/0 [ 27.583670][ C0] preempt_count: 104, expected: 0 [ 27.583671][ C0] RCU nest depth: 0, expected: 0 [ 27.583672][ C0] INFO: lockdep is turned off. [ 27.583673][ C0] irq event stamp: 988442 [ 27.583674][ C0] hardirqs last enabled at (988442): [] _raw_spin_unlock_irq+0x28/0x50 [ 27.583683][ C0] hardirqs last disabled at (988441): [] _raw_spin_lock_irq+0x4a/0x50 [ 27.583685][ C0] softirqs last enabled at (988338): [] handle_softirqs+0x67c/0x900 [ 27.583688][ C0] softirqs last disabled at (988369): [] __irq_exit_rcu+0x145/0x1c0 [ 27.583690][ C0] Preemption disabled at: [ 27.583691][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 27.583698][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.583701][ C0] Tainted: [W]=WARN [ 27.583702][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.583704][ C0] Call Trace: [ 27.583706][ C0] [ 27.583708][ C0] dump_stack_lvl+0x6f/0xa0 [ 27.583713][ C0] ? schedule_preempt_disabled+0x22/0x30 [ 27.583715][ C0] __might_resched.cold+0x1fe/0x2c1 [ 27.583718][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 27.583722][ C0] ? __asan_memcpy+0x3c/0x60 [ 27.583725][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.583729][ C0] __kmalloc_noprof+0x443/0x760 [ 27.583732][ C0] ? __rwlock_init+0x150/0x150 [ 27.583735][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 27.583738][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 27.583740][ C0] alloc_buf.isra.0+0x4b/0x260 [ 27.583742][ C0] put_chars+0x1e1/0x2f0 [ 27.583744][ C0] ? __send_to_port+0x420/0x420 [ 27.583746][ C0] ? console_prepend_replay+0x20/0x20 [ 27.583749][ C0] hvc_console_print+0x292/0x780 [ 27.583753][ C0] ? hvc_write+0x3a0/0x3a0 [ 27.583754][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.583756][ C0] ? lock_acquire+0x13c/0x160 [ 27.583758][ C0] console_emit_next_record+0x22f/0x4c0 [ 27.583760][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 27.583762][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.583764][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.583765][ C0] ? lock_acquire+0x13c/0x160 [ 27.583767][ C0] ? console_flush_one_record+0x111/0x710 [ 27.583769][ C0] console_flush_one_record+0x46f/0x710 [ 27.583771][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 27.583774][ C0] console_unlock+0xee/0x1f0 [ 27.583776][ C0] ? lock_acquire+0x13c/0x160 [ 27.583777][ C0] ? console_flush_one_record+0x710/0x710 [ 27.583779][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.583780][ C0] ? lock_release+0x184/0x1f0 [ 27.583782][ C0] ? lock_acquire+0x60/0x160 [ 27.583783][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 27.583786][ C0] ? vprintk_emit+0x320/0x3e0 [ 27.583787][ C0] vprintk_emit+0x37c/0x3e0 [ 27.583790][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 27.583791][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.583793][ C0] ? lock_release+0x184/0x1f0 [ 27.583795][ C0] ? x86_64_start_kernel+0xe0/0x130 [ 27.583799][ C0] _printk+0xc7/0x100 [ 27.583802][ C0] ? snapshot_read.cold+0x21/0x21 [ 27.583804][ C0] ? arch_stack_walk+0xd7/0x130 [ 27.583808][ C0] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 27.583810][ C0] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 27.583812][ C0] print_irq_inversion_bug.part.0+0x32/0xc0 [ 27.583814][ C0] mark_lock_irq+0x989/0x9c0 [ 27.583817][ C0] mark_lock+0x1d7/0xa00 [ 27.583819][ C0] mark_usage+0x42/0x170 [ 27.583821][ C0] __lock_acquire+0x388/0xc20 [ 27.583823][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.583824][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.583837][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.583839][ C0] ? lock_acquire+0x13c/0x160 [ 27.583841][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.583847][ C0] _raw_spin_lock+0x33/0x40 [ 27.583849][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.583855][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.583861][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.583867][ C0] call_timer_fn+0x160/0x4d0 [ 27.583870][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 27.583872][ C0] ? debug_object_active_state+0x430/0x430 [ 27.583876][ C0] ? find_held_lock+0x2b/0x80 [ 27.583878][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 27.583879][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.583882][ C0] __run_timers+0x68f/0xaa0 [ 27.583883][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.583890][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.583891][ C0] ? __lock_acquire+0x518/0xc20 [ 27.583894][ C0] ? __rwlock_init+0x150/0x150 [ 27.583896][ C0] run_timer_softirq+0xf0/0x160 [ 27.583898][ C0] ? __run_timers+0xaa0/0xaa0 [ 27.583900][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.583902][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.583904][ C0] handle_softirqs+0x1d3/0x900 [ 27.583906][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 27.583908][ C0] ? _local_bh_enable+0xc0/0xc0 [ 27.583910][ C0] __irq_exit_rcu+0x145/0x1c0 [ 27.583911][ C0] irq_exit_rcu+0xe/0x30 [ 27.583912][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.583915][ C0] [ 27.583916][ C0] [ 27.583917][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 27.583918][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.583921][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 27.583923][ C0] 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 [ 27.583926][ C0] RSP: 0018:ffffffff9ca07cf8 EFLAGS: 00000296 [ 27.583929][ C0] RAX: 00000000000f14cf RBX: ffffffff9ca1c600 RCX: ffffffff99af0307 [ 27.583931][ C0] RDX: ffffffff9ca1c600 RSI: ffffffff9c838b01 RDI: ffffffff9c28d8e0 [ 27.583931][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 27.583933][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff3940fa2 [ 27.583933][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 27.583935][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.583938][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 27.583939][ C0] default_idle+0x9/0x10 [ 27.583941][ C0] default_idle_call+0x6e/0xb0 [ 27.583943][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.583944][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 27.583946][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 27.583948][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.583950][ C0] do_idle+0xd8/0x190 [ 27.583952][ C0] cpu_startup_entry+0x53/0x70 [ 27.583953][ C0] rest_init+0x279/0x280 [ 27.583955][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 27.583958][ C0] ? rest_init+0x280/0x280 [ 27.583960][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 27.583963][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 27.583965][ C0] ? acpi_enable+0x1e4/0x330 [ 27.583968][ C0] start_kernel+0x3af/0x3b0 [ 27.583970][ C0] x86_64_start_reservations+0x24/0x30 [ 27.583972][ C0] x86_64_start_kernel+0x12b/0x130 [ 27.583973][ C0] common_startup_64+0x13e/0x148 [ 27.583978][ C0] [ 27.611861][ C0] ======================================================== [ 27.612140][ C0] WARNING: possible irq lock inversion dependency detected [ 27.612361][ C0] 7.2.0-virtme #1 Tainted: G W [ 27.612554][ C0] -------------------------------------------------------- [ 27.612839][ C0] swapper/0/0 just changed the state of lock: [ 27.613026][ C0] ff1100000b792e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.613395][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 27.613673][ C0] (fs_reclaim){+.+.}-{0:0} [ 27.613675][ C0] [ 27.613675][ C0] [ 27.613675][ C0] and interrupts could create inverse lock ordering between them. [ 27.613675][ C0] [ 27.614328][ C0] [ 27.614328][ C0] other info that might help us debug this: [ 27.614609][ C0] Chain exists of: [ 27.614609][ C0] &br->lock --> console_owner --> fs_reclaim [ 27.614609][ C0] [ 27.614995][ C0] Possible interrupt unsafe locking scenario: [ 27.614995][ C0] [ 27.615270][ C0] CPU0 CPU1 [ 27.615419][ C0] ---- ---- [ 27.615625][ C0] lock(fs_reclaim); [ 27.615743][ C0] local_irq_disable(); [ 27.615978][ C0] lock(&br->lock); [ 27.616164][ C0] lock(console_owner); [ 27.616404][ C0] [ 27.616519][ C0] lock(&br->lock); [ 27.616686][ C0] [ 27.616686][ C0] *** DEADLOCK *** [ 27.616686][ C0] [ 27.616908][ C0] locks held by swapper/0/0: 1, last CPU#0: [ 27.617145][ C0] #0: ffa0000000007c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 27.617499][ C0] [ 27.617499][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 27.617812][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 27.617964][ C0] HARDIRQ-ON-W at: [ 27.618135][ C0] __lock_acquire+0x388/0xc20 [ 27.618328][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.618570][ C0] fs_reclaim_acquire+0xd5/0x120 [ 27.618808][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 27.619032][ C0] kthread_create_worker_on_node+0xea/0x210 [ 27.619307][ C0] workqueue_init+0x2a/0x680 [ 27.619496][ C0] kernel_init_freeable+0x2fe/0x630 [ 27.619771][ C0] kernel_init+0x21/0x150 [ 27.619960][ C0] ret_from_fork+0x474/0x6b0 [ 27.620197][ C0] ret_from_fork_asm+0x11/0x20 [ 27.620389][ C0] SOFTIRQ-ON-W at: [ 27.620556][ C0] __lock_acquire+0x388/0xc20 [ 27.620737][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.620970][ C0] fs_reclaim_acquire+0xd5/0x120 [ 27.621207][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 27.621427][ C0] kthread_create_worker_on_node+0xea/0x210 [ 27.621711][ C0] workqueue_init+0x2a/0x680 [ 27.621945][ C0] kernel_init_freeable+0x2fe/0x630 [ 27.622215][ C0] kernel_init+0x21/0x150 [ 27.622399][ C0] ret_from_fork+0x474/0x6b0 [ 27.622636][ C0] ret_from_fork_asm+0x11/0x20 [ 27.622819][ C0] INITIAL USE at: [ 27.622977][ C0] __lock_acquire+0x388/0xc20 [ 27.623159][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.623394][ C0] fs_reclaim_acquire+0xd5/0x120 [ 27.623628][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 27.623860][ C0] kthread_create_worker_on_node+0xea/0x210 [ 27.624131][ C0] workqueue_init+0x2a/0x680 [ 27.624361][ C0] kernel_init_freeable+0x2fe/0x630 [ 27.624549][ C0] kernel_init+0x21/0x150 [ 27.624782][ C0] ret_from_fork+0x474/0x6b0 [ 27.625016][ C0] ret_from_fork_asm+0x11/0x20 [ 27.625199][ C0] } [ 27.625329][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 27.625555][ C0] ... acquired at: [ 27.625717][ C0] __lock_acquire+0x518/0xc20 [ 27.625867][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.626068][ C0] fs_reclaim_acquire+0xd5/0x120 [ 27.626214][ C0] __kmalloc_noprof+0xd3/0x760 [ 27.626412][ C0] alloc_buf.isra.0+0x4b/0x260 [ 27.626568][ C0] put_chars+0x1e1/0x2f0 [ 27.626765][ C0] hvc_console_print+0x292/0x780 [ 27.626908][ C0] console_emit_next_record+0x22f/0x4c0 [ 27.627108][ C0] console_flush_one_record+0x46f/0x710 [ 27.627256][ C0] console_unlock+0xee/0x1f0 [ 27.627457][ C0] vprintk_emit+0x37c/0x3e0 [ 27.627603][ C0] _printk+0xc7/0x100 [ 27.627766][ C0] dm_interface_init+0x50/0x60 [ 27.627911][ C0] dm_init+0x51/0xd0 [ 27.628022][ C0] do_one_initcall+0x124/0x4f0 [ 27.628217][ C0] kernel_init_freeable+0x596/0x630 [ 27.628361][ C0] kernel_init+0x21/0x150 [ 27.628512][ C0] ret_from_fork+0x474/0x6b0 [ 27.628660][ C0] ret_from_fork_asm+0x11/0x20 [ 27.628856][ C0] [ 27.628931][ C0] -> (console_owner){....}-{0:0} { [ 27.629130][ C0] INITIAL USE at: [ 27.629238][ C0] } [ 27.629311][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 27.629582][ C0] ... acquired at: [ 27.629692][ C0] __lock_acquire+0x518/0xc20 [ 27.629886][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.630033][ C0] console_lock_spinning_enable+0x5c/0x60 [ 27.630265][ C0] console_emit_next_record+0x1d1/0x4c0 [ 27.630410][ C0] console_flush_one_record+0x46f/0x710 [ 27.630562][ C0] console_unlock+0xee/0x1f0 [ 27.630764][ C0] vprintk_emit+0x37c/0x3e0 [ 27.630911][ C0] _printk+0xc7/0x100 [ 27.631021][ C0] br_set_state+0x22f/0x430 [bridge] [ 27.631225][ C0] br_init_port+0xc4/0x200 [bridge] [ 27.631378][ C0] br_stp_enable_port+0x12/0x50 [bridge] [ 27.631568][ C0] br_port_carrier_check+0x220/0x430 [bridge] [ 27.631810][ C0] br_device_event+0x52d/0x8f0 [bridge] [ 27.631961][ C0] notifier_call_chain+0xae/0x300 [ 27.632163][ C0] netif_state_change+0x139/0x340 [ 27.632311][ C0] __linkwatch_run_queue+0x34c/0x750 [ 27.632464][ C0] linkwatch_event+0x7f/0xb0 [ 27.632635][ C0] process_one_work+0xe3e/0x1560 [ 27.632837][ C0] worker_thread+0x4f1/0xd60 [ 27.632983][ C0] kthread+0x367/0x460 [ 27.633144][ C0] ret_from_fork+0x474/0x6b0 [ 27.633291][ C0] ret_from_fork_asm+0x11/0x20 [ 27.633493][ C0] [ 27.633566][ C0] -> (&br->lock){+.-.}-{3:3} { [ 27.633713][ C0] HARDIRQ-ON-W at: [ 27.633875][ C0] __lock_acquire+0x388/0xc20 [ 27.634060][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.634295][ C0] _raw_spin_lock_bh+0x38/0x50 [ 27.634540][ C0] br_set_ageing_time+0x2d/0xf0 [bridge] [ 27.634768][ C0] br_changelink+0x240/0x16e0 [bridge] [ 27.635007][ C0] br_dev_newlink+0xeb/0x160 [bridge] [ 27.635244][ C0] rtnl_newlink_create+0x2d0/0x750 [ 27.635426][ C0] __rtnl_newlink+0x22b/0xa50 [ 27.635668][ C0] rtnl_newlink+0x9f1/0x11c0 [ 27.635855][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.636087][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 27.636329][ C0] netlink_unicast+0x486/0x750 [ 27.636516][ C0] netlink_sendmsg+0x735/0xc60 [ 27.636749][ C0] ____sys_sendmsg+0x415/0x880 [ 27.636986][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 27.637169][ C0] __sys_sendmsg+0x12c/0x1d0 [ 27.637400][ C0] do_syscall_64+0xff/0x530 [ 27.637591][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.637865][ C0] IN-SOFTIRQ-W at: [ 27.638027][ C0] __lock_acquire+0x388/0xc20 [ 27.638211][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.638451][ C0] _raw_spin_lock+0x33/0x40 [ 27.638632][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.638907][ C0] call_timer_fn+0x160/0x4d0 [ 27.639143][ C0] __run_timers+0x68f/0xaa0 [ 27.639325][ C0] run_timer_softirq+0xf0/0x160 [ 27.639567][ C0] handle_softirqs+0x1d3/0x900 [ 27.639802][ C0] __irq_exit_rcu+0x145/0x1c0 [ 27.639980][ C0] irq_exit_rcu+0xe/0x30 [ 27.640214][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.640441][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.640661][ C0] pv_native_safe_halt+0xf/0x10 [ 27.640897][ C0] default_idle+0x9/0x10 [ 27.641139][ C0] default_idle_call+0x6e/0xb0 [ 27.641322][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.641544][ C0] do_idle+0xd8/0x190 [ 27.641742][ C0] cpu_startup_entry+0x53/0x70 [ 27.641924][ C0] rest_init+0x279/0x280 [ 27.642161][ C0] start_kernel+0x3af/0x3b0 [ 27.642341][ C0] x86_64_start_reservations+0x24/0x30 [ 27.642579][ C0] x86_64_start_kernel+0x12b/0x130 [ 27.642813][ C0] common_startup_64+0x13e/0x148 [ 27.643000][ C0] INITIAL USE at: [ 27.643160][ C0] __lock_acquire+0x388/0xc20 [ 27.643344][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.643529][ C0] _raw_spin_lock_bh+0x38/0x50 [ 27.643762][ C0] br_set_ageing_time+0x2d/0xf0 [bridge] [ 27.643987][ C0] br_changelink+0x240/0x16e0 [bridge] [ 27.644225][ C0] br_dev_newlink+0xeb/0x160 [bridge] [ 27.644411][ C0] rtnl_newlink_create+0x2d0/0x750 [ 27.644598][ C0] __rtnl_newlink+0x22b/0xa50 [ 27.644833][ C0] rtnl_newlink+0x9f1/0x11c0 [ 27.645016][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.645251][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 27.645444][ C0] netlink_unicast+0x486/0x750 [ 27.645631][ C0] netlink_sendmsg+0x735/0xc60 [ 27.645862][ C0] ____sys_sendmsg+0x415/0x880 [ 27.646096][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 27.646276][ C0] __sys_sendmsg+0x12c/0x1d0 [ 27.646517][ C0] do_syscall_64+0xff/0x530 [ 27.646698][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.646971][ C0] } [ 27.647044][ C0] ... key at: [] __key.7+0x0/0x40 [bridge] [ 27.647315][ C0] ... acquired at: [ 27.647479][ C0] mark_lock+0x1d7/0xa00 [ 27.647628][ C0] mark_usage+0x42/0x170 [ 27.647826][ C0] __lock_acquire+0x388/0xc20 [ 27.647970][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.648168][ C0] _raw_spin_lock+0x33/0x40 [ 27.648314][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.648557][ C0] call_timer_fn+0x160/0x4d0 [ 27.648702][ C0] __run_timers+0x68f/0xaa0 [ 27.648897][ C0] run_timer_softirq+0xf0/0x160 [ 27.649049][ C0] handle_softirqs+0x1d3/0x900 [ 27.649245][ C0] __irq_exit_rcu+0x145/0x1c0 [ 27.649389][ C0] irq_exit_rcu+0xe/0x30 [ 27.649591][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.649773][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.650002][ C0] pv_native_safe_halt+0xf/0x10 [ 27.650147][ C0] default_idle+0x9/0x10 [ 27.650345][ C0] default_idle_call+0x6e/0xb0 [ 27.650501][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.650743][ C0] do_idle+0xd8/0x190 [ 27.650853][ C0] cpu_startup_entry+0x53/0x70 [ 27.651049][ C0] rest_init+0x279/0x280 [ 27.651196][ C0] start_kernel+0x3af/0x3b0 [ 27.651395][ C0] x86_64_start_reservations+0x24/0x30 [ 27.651545][ C0] x86_64_start_kernel+0x12b/0x130 [ 27.651741][ C0] common_startup_64+0x13e/0x148 [ 27.651904][ C0] [ 27.652032][ C0] [ 27.652032][ C0] stack backtrace: [ 27.652215][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.652219][ C0] Tainted: [W]=WARN [ 27.652220][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.652221][ C0] Call Trace: [ 27.652223][ C0] [ 27.652224][ C0] dump_stack_lvl+0x6f/0xa0 [ 27.652229][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 27.652232][ C0] mark_lock_irq+0x989/0x9c0 [ 27.652234][ C0] mark_lock+0x1d7/0xa00 [ 27.652236][ C0] mark_usage+0x42/0x170 [ 27.652238][ C0] __lock_acquire+0x388/0xc20 [ 27.652240][ C0] lock_acquire.part.0+0xd4/0x280 [ 27.652242][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.652250][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.652254][ C0] ? lock_acquire+0x13c/0x160 [ 27.652255][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.652261][ C0] _raw_spin_lock+0x33/0x40 [ 27.652263][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.652269][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.652275][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.652281][ C0] call_timer_fn+0x160/0x4d0 [ 27.652283][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 27.652285][ C0] ? debug_object_active_state+0x430/0x430 [ 27.652288][ C0] ? find_held_lock+0x2b/0x80 [ 27.652290][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 27.652292][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.652294][ C0] __run_timers+0x68f/0xaa0 [ 27.652296][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.652302][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.652304][ C0] ? __lock_acquire+0x518/0xc20 [ 27.652307][ C0] ? __rwlock_init+0x150/0x150 [ 27.652309][ C0] run_timer_softirq+0xf0/0x160 [ 27.652311][ C0] ? __run_timers+0xaa0/0xaa0 [ 27.652312][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.652315][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.652316][ C0] handle_softirqs+0x1d3/0x900 [ 27.652318][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 27.652320][ C0] ? _local_bh_enable+0xc0/0xc0 [ 27.652322][ C0] __irq_exit_rcu+0x145/0x1c0 [ 27.652323][ C0] irq_exit_rcu+0xe/0x30 [ 27.652324][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.652326][ C0] [ 27.652327][ C0] [ 27.652327][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 27.652329][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.652331][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 27.652333][ C0] 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 [ 27.652335][ C0] RSP: 0018:ffffffff9ca07cf8 EFLAGS: 00000296 [ 27.652337][ C0] RAX: 00000000000f14cf RBX: ffffffff9ca1c600 RCX: ffffffff99af0307 [ 27.652338][ C0] RDX: ffffffff9ca1c600 RSI: ffffffff9c838b01 RDI: ffffffff9c28d8e0 [ 27.652339][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 27.652340][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff3940fa2 [ 27.652341][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 27.652342][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.652344][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 27.652346][ C0] default_idle+0x9/0x10 [ 27.652347][ C0] default_idle_call+0x6e/0xb0 [ 27.652349][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.652351][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 27.652352][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 27.652354][ C0] ? rcu_is_watching+0x16/0xd0 [ 27.652356][ C0] do_idle+0xd8/0x190 [ 27.652358][ C0] cpu_startup_entry+0x53/0x70 [ 27.652359][ C0] rest_init+0x279/0x280 [ 27.652361][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 27.652363][ C0] ? rest_init+0x280/0x280 [ 27.652365][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 27.652369][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 27.652371][ C0] ? acpi_enable+0x1e4/0x330 [ 27.652374][ C0] start_kernel+0x3af/0x3b0 [ 27.652375][ C0] x86_64_start_reservations+0x24/0x30 [ 27.652377][ C0] x86_64_start_kernel+0x12b/0x130 [ 27.652379][ C0] common_startup_64+0x13e/0x148 [ 27.652382][ C0] [ 30.384027][ T716] br1: port 2(veth2) entered disabled state [ 30.384046][ T716] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 30.384048][ T716] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 716, name: ip [ 30.384050][ T716] preempt_count: 202, expected: 0 [ 30.384051][ T716] RCU nest depth: 0, expected: 0 [ 30.384052][ T716] INFO: lockdep is turned off. [ 30.384053][ T716] irq event stamp: 0 [ 30.384054][ T716] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 30.384059][ T716] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 30.384065][ T716] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 30.384067][ T716] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 30.384068][ T716] Preemption disabled at: [ 30.384069][ T716] [<0000000000000000>] 0x0 [ 30.384074][ T716] CPU: 2 UID: 0 PID: 716 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 30.384077][ T716] Tainted: [W]=WARN [ 30.384078][ T716] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 30.384080][ T716] Call Trace: [ 30.384082][ T716] [ 30.384083][ T716] dump_stack_lvl+0x6f/0xa0 [ 30.384089][ T716] __might_resched.cold+0x1fe/0x2c1 [ 30.384093][ T716] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 30.384097][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384101][ T716] __kmalloc_noprof+0x443/0x760 [ 30.384105][ T716] ? __rwlock_init+0x150/0x150 [ 30.384108][ T716] ? alloc_buf.isra.0+0x4b/0x260 [ 30.384112][ T716] ? do_raw_spin_unlock+0x59/0x250 [ 30.384113][ T716] alloc_buf.isra.0+0x4b/0x260 [ 30.384116][ T716] put_chars+0x1e1/0x2f0 [ 30.384117][ T716] ? __send_to_port+0x420/0x420 [ 30.384119][ T716] ? printk_get_next_message+0x240/0x650 [ 30.384123][ T716] hvc_console_print+0x292/0x780 [ 30.384126][ T716] ? hvc_write+0x3a0/0x3a0 [ 30.384128][ T716] ? __rwlock_init+0x150/0x150 [ 30.384130][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384131][ T716] ? lock_acquire+0x13c/0x160 [ 30.384134][ T716] console_emit_next_record+0x22f/0x4c0 [ 30.384136][ T716] ? devkmsg_read+0x4b0/0x4b0 [ 30.384138][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384140][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384141][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384143][ T716] ? lock_acquire+0x13c/0x160 [ 30.384145][ T716] ? console_flush_one_record+0x111/0x710 [ 30.384147][ T716] console_flush_one_record+0x46f/0x710 [ 30.384149][ T716] ? console_emit_next_record+0x4c0/0x4c0 [ 30.384152][ T716] console_unlock+0xee/0x1f0 [ 30.384153][ T716] ? lock_acquire+0x13c/0x160 [ 30.384155][ T716] ? console_flush_one_record+0x710/0x710 [ 30.384157][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384158][ T716] ? lock_release+0x184/0x1f0 [ 30.384160][ T716] ? lock_acquire+0x60/0x160 [ 30.384161][ T716] ? __rcu_read_lock+0x30/0x70 [ 30.384163][ T716] ? __down_trylock_console_sem+0x5e/0xa0 [ 30.384165][ T716] ? vprintk_emit+0x320/0x3e0 [ 30.384167][ T716] vprintk_emit+0x37c/0x3e0 [ 30.384169][ T716] ? wake_up_klogd_work_func+0x90/0x90 [ 30.384171][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384173][ T716] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 30.384176][ T716] ? trace_hardirqs_on+0x36/0x40 [ 30.384177][ T716] _printk+0xc7/0x100 [ 30.384180][ T716] ? snapshot_read.cold+0x21/0x21 [ 30.384183][ T716] ? ipv6_mc_down+0x17e/0x2d0 [ 30.384187][ T716] br_set_state+0x22f/0x430 [bridge] [ 30.384201][ T716] br_stp_disable_port+0x11f/0x390 [bridge] [ 30.384210][ T716] br_device_event+0x7b5/0x8f0 [bridge] [ 30.384218][ T716] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 30.384222][ T716] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 30.384224][ T716] ? addrconf_notify+0x2c8/0xf30 [ 30.384227][ T716] notifier_call_chain+0xae/0x300 [ 30.384230][ T716] __dev_notify_flags+0x23c/0x3c0 [ 30.384234][ T716] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 30.384236][ T716] ? netif_change_name+0x8c0/0x8c0 [ 30.384238][ T716] ? netif_set_allmulti+0x250/0x250 [ 30.384240][ T716] ? __kernel_text_address+0x12/0x30 [ 30.384242][ T716] ? write_profile+0xf0/0xf0 [ 30.384244][ T716] ? unwind_get_return_address+0x67/0xd0 [ 30.384247][ T716] netif_change_flags+0xfe/0x190 [ 30.384249][ T716] do_setlink.isra.0+0x1cc3/0x2750 [ 30.384252][ T716] ? stack_trace_save+0x93/0xc0 [ 30.384253][ T716] ? rtnl_link_get_size+0x350/0x350 [ 30.384255][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384256][ T716] ? stack_depot_save_flags+0x1bc/0x790 [ 30.384260][ T716] ? kasan_save_stack+0x3d/0x50 [ 30.384263][ T716] ? kasan_save_stack+0x2f/0x50 [ 30.384265][ T716] ? kasan_save_track+0x14/0x30 [ 30.384266][ T716] ? __kasan_kmalloc+0x7b/0x90 [ 30.384268][ T716] ? __kmalloc_cache_noprof+0x29a/0x620 [ 30.384269][ T716] ? rtnl_newlink+0x124/0x11c0 [ 30.384270][ T716] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 30.384271][ T716] ? netlink_rcv_skb+0x14e/0x3a0 [ 30.384274][ T716] ? netlink_unicast+0x486/0x750 [ 30.384276][ T716] ? netlink_sendmsg+0x735/0xc60 [ 30.384277][ T716] ? ____sys_sendmsg+0x415/0x880 [ 30.384279][ T716] ? ___sys_sendmsg+0x14e/0x1d0 [ 30.384281][ T716] ? __sys_sendmsg+0x12c/0x1d0 [ 30.384282][ T716] ? do_syscall_64+0xff/0x530 [ 30.384284][ T716] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.384287][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384289][ T716] ? lock_acquire+0x13c/0x160 [ 30.384290][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384292][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384293][ T716] ? trace_contention_end+0xb3/0x180 [ 30.384297][ T716] ? __mutex_lock+0x1db/0x1ea0 [ 30.384298][ T716] ? __mutex_lock+0x9a3/0x1ea0 [ 30.384299][ T716] ? rtnl_newlink+0x9a8/0x11c0 [ 30.384301][ T716] ? ww_mutex_lock+0x160/0x160 [ 30.384303][ T716] ? __rtnl_newlink+0x3fa/0xa50 [ 30.384305][ T716] rtnl_newlink+0x9f1/0x11c0 [ 30.384307][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384309][ T716] ? rtnl_bridge_getlink+0x850/0x850 [ 30.384310][ T716] ? lock_acquire+0x13c/0x160 [ 30.384311][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384314][ T716] ? is_bpf_text_address+0x3e/0x110 [ 30.384317][ T716] ? is_bpf_text_address+0x72/0x110 [ 30.384319][ T716] ? kernel_text_address+0x149/0x170 [ 30.384320][ T716] ? __kernel_text_address+0x12/0x30 [ 30.384321][ T716] ? write_profile+0xf0/0xf0 [ 30.384323][ T716] ? unwind_get_return_address+0x67/0xd0 [ 30.384324][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384326][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384327][ T716] ? cap_capable+0x1d7/0x3d0 [ 30.384331][ T716] ? lock_acquire+0x13c/0x160 [ 30.384332][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384334][ T716] ? rtnl_bridge_getlink+0x850/0x850 [ 30.384336][ T716] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 30.384337][ T716] ? rtnl_link_fill+0x920/0x920 [ 30.384338][ T716] ? filter_irq_stacks+0xd0/0xd0 [ 30.384340][ T716] ? stack_depot_save_flags+0x1bc/0x790 [ 30.384342][ T716] netlink_rcv_skb+0x14e/0x3a0 [ 30.384344][ T716] ? rtnl_link_fill+0x920/0x920 [ 30.384345][ T716] ? lock_release+0x184/0x1f0 [ 30.384347][ T716] ? netlink_ack+0xcf0/0xcf0 [ 30.384348][ T716] ? __netlink_lookup+0xb9/0x6b0 [ 30.384350][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384352][ T716] ? lock_release+0x184/0x1f0 [ 30.384354][ T716] netlink_unicast+0x486/0x750 [ 30.384356][ T716] ? netlink_attachskb+0x810/0x810 [ 30.384357][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384359][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384361][ T716] ? lock_acquire+0x13c/0x160 [ 30.384363][ T716] netlink_sendmsg+0x735/0xc60 [ 30.384364][ T716] ? netlink_unicast+0x750/0x750 [ 30.384366][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384368][ T716] ? lock_release+0x184/0x1f0 [ 30.384370][ T716] ____sys_sendmsg+0x415/0x880 [ 30.384372][ T716] ? copy_msghdr_from_user+0x279/0x420 [ 30.384373][ T716] ? get_timestamp.constprop.0+0x390/0x390 [ 30.384375][ T716] ? move_addr_to_kernel+0x40/0x40 [ 30.384376][ T716] ? filter_irq_stacks+0xd0/0xd0 [ 30.384381][ T716] ___sys_sendmsg+0x14e/0x1d0 [ 30.384383][ T716] ? copy_msghdr_from_user+0x420/0x420 [ 30.384388][ T716] __sys_sendmsg+0x12c/0x1d0 [ 30.384390][ T716] ? __sys_sendmsg_sock+0x20/0x20 [ 30.384393][ T716] ? rcu_is_watching+0x16/0xd0 [ 30.384395][ T716] do_syscall_64+0xff/0x530 [ 30.384396][ T716] ? exc_page_fault+0xee/0x100 [ 30.384398][ T716] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.384400][ T716] RIP: 0033:0x7effc751f54e [ 30.384402][ T716] 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 [ 30.384404][ T716] RSP: 002b:00007fff5cfeab00 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 30.384407][ T716] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007effc751f54e [ 30.384409][ T716] RDX: 0000000000000000 RSI: 00007fff5cfeabb0 RDI: 0000000000000005 [ 30.384410][ T716] RBP: 00007fff5cfeab10 R08: 0000000000000000 R09: 0000000000000000 [ 30.384410][ T716] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9161d1 [ 30.384411][ T716] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff5cfeb270 [ 30.384414][ T716] [ 30.425812][ T716] ip (716) used greatest stack depth: 23016 bytes left [ 30.442105][ T719] veth2: left allmulticast mode [ 30.442298][ T719] veth2: left promiscuous mode [ 30.443529][ T719] br1: port 2(veth2) entered disabled state [ 30.476142][ T721] br1: port 1(veth1) entered disabled state [ 30.494981][ T723] veth1: left allmulticast mode [ 30.495155][ T723] veth1: left promiscuous mode [ 30.495364][ T723] br1: port 1(veth1) entered disabled state