[ 104.169379][ T876] lag: Mode changed to "loadbalance" [ 104.399990][ T879] [ 104.400215][ T879] ====================================================== [ 104.400436][ T879] WARNING: possible circular locking dependency detected [ 104.400649][ T879] 6.14.0-rc2-virtme #1 Not tainted [ 104.400878][ T879] ------------------------------------------------------ [ 104.401132][ T879] ip/879 is trying to acquire lock: [ 104.401297][ T879] ffff88800c01ccb0 (&dev->lock){+.+.}-{4:4}, at: __dev_open+0x57e/0x710 [ 104.401618][ T879] [ 104.401618][ T879] but task is already holding lock: [ 104.401881][ T879] ffff888005042d80 (team->team_lock_key){+.+.}-{4:4}, at: team_add_slave+0x33/0x80 [ 104.402224][ T879] [ 104.402224][ T879] which lock already depends on the new lock. [ 104.402224][ T879] [ 104.402628][ T879] [ 104.402628][ T879] the existing dependency chain (in reverse order) is: [ 104.402910][ T879] [ 104.402910][ T879] -> #1 (team->team_lock_key){+.+.}-{4:4}: [ 104.403171][ T879] __lock_acquire+0xb9a/0x1680 [ 104.403392][ T879] lock_acquire.part.0+0xeb/0x330 [ 104.403627][ T879] __mutex_lock+0x169/0xc40 [ 104.403797][ T879] team_set_mac_address+0x120/0x250 [ 104.403965][ T879] netif_set_mac_address+0x28a/0x410 [ 104.404168][ T879] do_setlink.constprop.0+0x1980/0x25f0 [ 104.404390][ T879] rtnl_setlink+0x2b5/0x5a0 [ 104.404598][ T879] rtnetlink_rcv_msg+0x712/0xc10 [ 104.404764][ T879] netlink_rcv_skb+0x130/0x360 [ 104.404934][ T879] netlink_unicast+0x44b/0x710 [ 104.405132][ T879] netlink_sendmsg+0x723/0xbe0 [ 104.405367][ T879] __sys_sendto+0x3c3/0x450 [ 104.405570][ T879] __x64_sys_sendto+0xe0/0x1c0 [ 104.405760][ T879] do_syscall_64+0xc1/0x1d0 [ 104.405922][ T879] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 104.406188][ T879] [ 104.406188][ T879] -> #0 (&dev->lock){+.+.}-{4:4}: [ 104.406485][ T879] check_prev_add+0x182/0xce0 [ 104.406695][ T879] validate_chain+0x7bd/0xae0 [ 104.406864][ T879] __lock_acquire+0xb9a/0x1680 [ 104.407055][ T879] lock_acquire.part.0+0xeb/0x330 [ 104.407225][ T879] __mutex_lock+0x169/0xc40 [ 104.407398][ T879] __dev_open+0x57e/0x710 [ 104.407569][ T879] netif_open+0xc9/0x130 [ 104.407728][ T879] dev_open+0x9f/0x1a0 [ 104.407889][ T879] team_port_add+0x90a/0x1ce0 [ 104.408050][ T879] team_add_slave+0x41/0x80 [ 104.408209][ T879] do_set_master+0x302/0x610 [ 104.408367][ T879] do_setlink.constprop.0+0x87b/0x25f0 [ 104.408566][ T879] rtnl_newlink+0x69c/0xa70 [ 104.408731][ T879] rtnetlink_rcv_msg+0x712/0xc10 [ 104.408891][ T879] netlink_rcv_skb+0x130/0x360 [ 104.409052][ T879] netlink_unicast+0x44b/0x710 [ 104.409215][ T879] netlink_sendmsg+0x723/0xbe0 [ 104.409373][ T879] ____sys_sendmsg+0x7ac/0xa10 [ 104.409535][ T879] ___sys_sendmsg+0xee/0x170 [ 104.409696][ T879] __sys_sendmsg+0x109/0x1a0 [ 104.409863][ T879] do_syscall_64+0xc1/0x1d0 [ 104.410021][ T879] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 104.410222][ T879] [ 104.410222][ T879] other info that might help us debug this: [ 104.410222][ T879] [ 104.410536][ T879] Possible unsafe locking scenario: [ 104.410536][ T879] [ 104.410773][ T879] CPU0 CPU1 [ 104.410937][ T879] ---- ---- [ 104.411094][ T879] lock(team->team_lock_key); [ 104.411256][ T879] lock(&dev->lock); [ 104.411454][ T879] lock(team->team_lock_key); [ 104.411691][ T879] lock(&dev->lock); [ 104.411815][ T879] [ 104.411815][ T879] *** DEADLOCK *** [ 104.411815][ T879] [ 104.412051][ T879] 2 locks held by ip/879: [ 104.412173][ T879] #0: ffffffff91beeb48 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x653/0xa70 [ 104.412457][ T879] #1: ffff888005042d80 (team->team_lock_key){+.+.}-{4:4}, at: team_add_slave+0x33/0x80 [ 104.412741][ T879] [ 104.412741][ T879] stack backtrace: [ 104.412934][ T879] CPU: 2 UID: 0 PID: 879 Comm: ip Not tainted 6.14.0-rc2-virtme #1 [ 104.412939][ T879] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 104.412941][ T879] Call Trace: [ 104.412943][ T879] [ 104.412945][ T879] dump_stack_lvl+0x82/0xd0 [ 104.412952][ T879] print_circular_bug+0x1b7/0x240 [ 104.412956][ T879] check_noncircular+0x2f9/0x3e0 [ 104.412959][ T879] ? find_held_lock+0x2c/0x110 [ 104.412964][ T879] ? __pfx_check_noncircular+0x10/0x10 [ 104.412967][ T879] ? stack_depot_save_flags+0x27e/0x440 [ 104.412973][ T879] ? __pfx___lock_release+0x10/0x10 [ 104.412977][ T879] ? alloc_chain_hlocks+0x4e0/0x720 [ 104.412981][ T879] check_prev_add+0x182/0xce0 [ 104.412985][ T879] ? validate_chain+0x1fe/0xae0 [ 104.412988][ T879] validate_chain+0x7bd/0xae0 [ 104.412993][ T879] ? mark_lock+0x38/0x3e0 [ 104.412996][ T879] ? __pfx_validate_chain+0x10/0x10 [ 104.412998][ T879] ? hlock_class+0x4e/0x130 [ 104.413001][ T879] ? mark_lock+0x38/0x3e0 [ 104.413005][ T879] __lock_acquire+0xb9a/0x1680 [ 104.413011][ T879] lock_acquire.part.0+0xeb/0x330 [ 104.413014][ T879] ? __dev_open+0x57e/0x710 [ 104.413017][ T879] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 104.413020][ T879] ? trace_lock_acquire+0x14c/0x1f0 [ 104.413024][ T879] ? lock_acquire+0x32/0xc0 [ 104.413026][ T879] ? __dev_open+0x57e/0x710 [ 104.413030][ T879] __mutex_lock+0x169/0xc40 [ 104.413032][ T879] ? __dev_open+0x57e/0x710 [ 104.413034][ T879] ? __lock_release+0x103/0x460 [ 104.413037][ T879] ? __pfx___lock_release+0x10/0x10 [ 104.413040][ T879] ? __dev_open+0x57e/0x710 [ 104.413042][ T879] ? hlock_class+0x4e/0x130 [ 104.413044][ T879] ? __pfx___mutex_lock+0x10/0x10 [ 104.413050][ T879] ? lockdep_hardirqs_on_prepare+0x275/0x410 [ 104.413056][ T879] ? __dev_open+0x57e/0x710 [ 104.413058][ T879] __dev_open+0x57e/0x710 [ 104.413060][ T879] ? mark_held_locks+0x9e/0xe0 [ 104.413063][ T879] ? __pfx___dev_open+0x10/0x10 [ 104.413065][ T879] ? trace_percpu_alloc_percpu+0x149/0x1d0 [ 104.413071][ T879] netif_open+0xc9/0x130 [ 104.413074][ T879] ? __pfx_netif_open+0x10/0x10 [ 104.413078][ T879] dev_open+0x9f/0x1a0 [ 104.413082][ T879] team_port_add+0x90a/0x1ce0 [ 104.413086][ T879] ? __pfx_team_port_add+0x10/0x10 [ 104.413090][ T879] ? rcu_read_lock_any_held+0x43/0xb0 [ 104.413095][ T879] ? validate_chain+0x1fe/0xae0 [ 104.413099][ T879] team_add_slave+0x41/0x80 [ 104.413103][ T879] do_set_master+0x302/0x610 [ 104.413108][ T879] do_setlink.constprop.0+0x87b/0x25f0 [ 104.413112][ T879] ? __pfx_do_setlink.constprop.0+0x10/0x10 [ 104.413116][ T879] ? lock_acquire.part.0+0xeb/0x330 [ 104.413119][ T879] ? rtnl_newlink+0x653/0xa70 [ 104.413122][ T879] ? rtnl_newlink+0xb9/0xa70 [ 104.413124][ T879] ? rtnetlink_rcv_msg+0x712/0xc10 [ 104.413128][ T879] ? __mutex_trylock_common+0xfa/0x260 [ 104.413132][ T879] ? __pfx___mutex_trylock_common+0x10/0x10 [ 104.413135][ T879] ? lock_acquire+0x32/0xc0 [ 104.413139][ T879] ? trace_contention_end+0xef/0x150 [ 104.413143][ T879] ? __mutex_lock+0x190/0xc40 [ 104.413146][ T879] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 104.413150][ T879] ? rtnl_newlink+0x653/0xa70 [ 104.413153][ T879] ? __pfx___mutex_lock+0x10/0x10 [ 104.413155][ T879] ? __pfx_validate_nla+0x10/0x10 [ 104.413160][ T879] ? trace_cap_capable+0x11e/0x1a0 [ 104.413165][ T879] ? __rtnl_newlink+0x3f2/0xa80 [ 104.413170][ T879] rtnl_newlink+0x69c/0xa70 [ 104.413175][ T879] ? __pfx_rtnl_newlink+0x10/0x10 [ 104.413177][ T879] ? find_held_lock+0x2c/0x110 [ 104.413182][ T879] ? __pfx___lock_release+0x10/0x10 [ 104.413185][ T879] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 104.413190][ T879] ? rtnetlink_rcv_msg+0x6ef/0xc10 [ 104.413193][ T879] ? __pfx_rtnl_newlink+0x10/0x10 [ 104.413196][ T879] rtnetlink_rcv_msg+0x712/0xc10 [ 104.413199][ T879] ? __pfx_rtnetlink_rcv_msg+0x10/0x10 [ 104.413202][ T879] ? hlock_class+0x4e/0x130 [ 104.413204][ T879] ? mark_lock+0x38/0x3e0 [ 104.413209][ T879] ? __lock_acquire+0xb9a/0x1680 [ 104.413212][ T879] netlink_rcv_skb+0x130/0x360 [ 104.413215][ T879] ? __pfx_rtnetlink_rcv_msg+0x10/0x10 [ 104.413219][ T879] ? __pfx_netlink_rcv_skb+0x10/0x10 [ 104.413226][ T879] ? netlink_deliver_tap+0x13e/0x340 [ 104.413230][ T879] ? netlink_deliver_tap+0xc3/0x340 [ 104.413234][ T879] netlink_unicast+0x44b/0x710 [ 104.413238][ T879] ? __pfx_netlink_unicast+0x10/0x10 [ 104.413241][ T879] ? find_held_lock+0x2c/0x110 [ 104.413246][ T879] netlink_sendmsg+0x723/0xbe0 [ 104.413250][ T879] ? __pfx_netlink_sendmsg+0x10/0x10 [ 104.413256][ T879] ____sys_sendmsg+0x7ac/0xa10 [ 104.413260][ T879] ? __pfx_____sys_sendmsg+0x10/0x10 [ 104.413262][ T879] ? __pfx_copy_msghdr_from_user+0x10/0x10 [ 104.413269][ T879] ___sys_sendmsg+0xee/0x170 [ 104.413273][ T879] ? __pfx____sys_sendmsg+0x10/0x10 [ 104.413277][ T879] ? kasan_save_stack+0x34/0x50 [ 104.413282][ T879] ? kasan_save_stack+0x24/0x50 [ 104.413284][ T879] ? kasan_record_aux_stack+0x8c/0xa0 [ 104.413288][ T879] ? __call_rcu_common.constprop.0+0xa1/0x5b0 [ 104.413292][ T879] ? __x64_sys_close+0x7c/0xd0 [ 104.413296][ T879] ? do_syscall_64+0xc1/0x1d0 [ 104.413298][ T879] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 104.413301][ T879] ? __lock_acquire+0xb9a/0x1680 [ 104.413304][ T879] ? lock_downgrade+0x52/0x110 [ 104.413308][ T879] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 104.413312][ T879] ? find_held_lock+0x2c/0x110 [ 104.413316][ T879] ? __lock_release+0x103/0x460 [ 104.413319][ T879] ? __virt_addr_valid+0x22b/0x430 [ 104.413324][ T879] ? __pfx___lock_release+0x10/0x10 [ 104.413327][ T879] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 104.413331][ T879] __sys_sendmsg+0x109/0x1a0 [ 104.413334][ T879] ? __pfx___sys_sendmsg+0x10/0x10 [ 104.413342][ T879] do_syscall_64+0xc1/0x1d0 [ 104.413345][ T879] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 104.413348][ T879] RIP: 0033:0x7f817b4a19a7 [ 104.413353][ T879] Code: 0a 00 f7 d8 64 89 02 48 c7 c0 ff ff ff ff eb b9 0f 1f 00 f3 0f 1e fa 64 8b 04 25 18 00 00 00 85 c0 75 10 b8 2e 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 51 c3 48 83 ec 28 89 54 24 1c 48 89 74 24 10 [ 104.413356][ T879] RSP: 002b:00007fff75fd4798 EFLAGS: 00000246 ORIG_RAX: 000000000000002e [ 104.413359][ T879] RAX: ffffffffffffffda RBX: 00007fff75fd4ec0 RCX: 00007f817b4a19a7 [ 104.413361][ T879] RDX: 0000000000000000 RSI: 00007fff75fd4800 RDI: 0000000000000005 [ 104.413363][ T879] RBP: 0000000000000004 R08: 0000000000000003 R09: 0000000000000000 [ 104.413365][ T879] R10: 00000000173df910 R11: 0000000000000246 R12: 0000000000000004 [ 104.413366][ T879] R13: 0000000067b30195 R14: 0000000000498600 R15: 0000000000000000 [ 104.413371][ T879] [ 104.441287][ T879] lag: Port device veth2 added [ 104.449585][ T879] ip (879) used greatest stack depth: 23544 bytes left [ 104.657619][ T889] lag: Port device veth4 added [ 104.786674][ T891] 8021q: adding VLAN 0 to HW filter on device lag [ 104.854326][ T892] br1: port 1(lag) entered blocking state [ 104.854704][ T892] br1: port 1(lag) entered disabled state [ 104.855000][ T892] lag: entered allmulticast mode [ 104.855257][ T892] veth2: entered allmulticast mode [ 104.855516][ T892] veth4: entered allmulticast mode [ 104.858366][ T892] veth2: entered promiscuous mode [ 104.858628][ T892] veth4: entered promiscuous mode [ 104.905920][ T893] br1: port 1(lag) entered blocking state [ 104.906149][ T893] br1: port 1(lag) entered forwarding state [ 111.500469][ T927] Mirror/redirect action on [ 125.862097][ T37] br1: port 1(lag) entered disabled state [ 131.691013][ T37] br1: port 1(lag) entered blocking state [ 131.691322][ T37] br1: port 1(lag) entered forwarding state [ 146.496961][ T449] br1: port 1(lag) entered disabled state [ 152.317521][ T37] br1: port 1(lag) entered blocking state [ 152.317779][ T37] br1: port 1(lag) entered forwarding state [ 152.915650][ T1031] lag: left allmulticast mode [ 152.915945][ T1031] veth2: left allmulticast mode [ 152.916151][ T1031] veth4: left allmulticast mode [ 152.916378][ T1031] veth2: left promiscuous mode [ 152.916550][ T1031] veth4: left promiscuous mode [ 152.916722][ T1031] br1: port 1(lag) entered disabled state [ 153.016751][ T876] lag: Port device veth4 removed [ 153.019870][ T876] lag: Port device veth2 removed