[ 818.878591][T21614] lag: Mode changed to "loadbalance" [ 818.946814][T21617] lag: Port device veth2 added [ 819.070066][T21627] lag: Port device veth4 added [ 819.124323][T21629] 8021q: adding VLAN 0 to HW filter on device lag [ 819.146780][T21630] br1: port 1(lag) entered blocking state [ 819.146934][T21630] br1: port 1(lag) entered disabled state [ 819.147080][T21630] lag: entered allmulticast mode [ 819.147199][T21630] veth2: entered allmulticast mode [ 819.147319][T21630] veth4: entered allmulticast mode [ 819.149262][T21630] veth2: entered promiscuous mode [ 819.149417][T21630] veth4: entered promiscuous mode [ 819.175601][T21631] br1: port 1(lag) entered blocking state [ 819.175762][T21631] br1: port 1(lag) entered forwarding state [ 819.341853][T21639] tc (21639) used greatest stack depth: 24000 bytes left [ 824.814506][T21671] Mirror/redirect action on [ 838.664747][T15783] br1: port 1(lag) entered disabled state [ 843.983120][ T100] br1: port 1(lag) entered blocking state [ 843.983330][ T100] br1: port 1(lag) entered forwarding state [ 844.055340][ C2] [ 844.055429][ C2] ================================ [ 844.055503][ C2] WARNING: inconsistent lock state [ 844.055573][ C2] 7.1.0-rc5-virtme #1 Not tainted [ 844.055640][ C2] -------------------------------- [ 844.055710][ C2] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 844.055793][ C2] ksoftirqd/2/28 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 844.055878][ C2] ffffffffc065b7b8 (mirred_list_lock){+.?.}-{3:3}, at: tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 844.056014][ C2] {SOFTIRQ-ON-W} state was registered at: [ 844.056078][ C2] __lock_acquire+0x378/0xc10 [ 844.056149][ C2] lock_acquire.part.0+0xbc/0x260 [ 844.056214][ C2] _raw_spin_lock+0x33/0x40 [ 844.056280][ C2] tcf_mirred_init+0x844/0xd70 [act_mirred] [ 844.056362][ C2] tcf_action_init_1+0x428/0x6b0 [ 844.056428][ C2] tcf_action_init+0x3cf/0x890 [ 844.056493][ C2] tcf_exts_validate_ex+0x411/0x670 [ 844.056558][ C2] fl_change+0xed4/0x4e77 [cls_flower] [ 844.056624][ C2] tc_new_tfilter+0x875/0x21e0 [ 844.056694][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 844.056760][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 844.056826][ C2] netlink_unicast+0x486/0x750 [ 844.056894][ C2] netlink_sendmsg+0x735/0xc60 [ 844.056959][ C2] ____sys_sendmsg+0x419/0x850 [ 844.057026][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 844.057092][ C2] __sys_sendmsg+0x145/0x1f0 [ 844.057156][ C2] do_syscall_64+0x117/0x590 [ 844.057221][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 844.057304][ C2] irq event stamp: 17161352 [ 844.057371][ C2] hardirqs last enabled at (17161352): [] _raw_spin_unlock_irqrestore+0x53/0x80 [ 844.057506][ C2] hardirqs last disabled at (17161351): [] _raw_spin_lock_irqsave+0x50/0x60 [ 844.057642][ C2] softirqs last enabled at (17160950): [] handle_softirqs+0x611/0x940 [ 844.057769][ C2] softirqs last disabled at (17160955): [] run_ksoftirqd+0x39/0x60 [ 844.057888][ C2] [ 844.057888][ C2] other info that might help us debug this: [ 844.057986][ C2] Possible unsafe locking scenario: [ 844.057986][ C2] [ 844.058084][ C2] CPU0 [ 844.058143][ C2] ---- [ 844.058193][ C2] lock(mirred_list_lock); [ 844.058260][ C2] [ 844.058318][ C2] lock(mirred_list_lock); [ 844.058386][ C2] [ 844.058386][ C2] *** DEADLOCK *** [ 844.058386][ C2] [ 844.058489][ C2] 1 lock held by ksoftirqd/2/28: [ 844.058559][ C2] #0: ffffffff87f77c00 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x389/0x1020 [ 844.058685][ C2] [ 844.058685][ C2] stack backtrace: [ 844.058775][ C2] CPU: 2 UID: 0 PID: 28 Comm: ksoftirqd/2 Not tainted 7.1.0-rc5-virtme #1 PREEMPT(full) [ 844.058778][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 844.058780][ C2] Call Trace: [ 844.058782][ C2] [ 844.058783][ C2] dump_stack_lvl+0x6f/0xa0 [ 844.058789][ C2] print_usage_bug.part.0.cold+0xa9/0xb7 [ 844.058792][ C2] mark_lock_irq+0x4e3/0x9c0 [ 844.058794][ C2] ? kthread+0x367/0x460 [ 844.058797][ C2] ? save_trace+0x68/0x280 [ 844.058799][ C2] ? __lock_acquire+0x508/0xc10 [ 844.058801][ C2] mark_lock+0x1d7/0xa00 [ 844.058802][ C2] mark_usage+0x42/0x170 [ 844.058804][ C2] __lock_acquire+0x378/0xc10 [ 844.058805][ C2] ? rcu_is_watching+0x15/0xd0 [ 844.058808][ C2] lock_acquire.part.0+0xbc/0x260 [ 844.058809][ C2] ? tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 844.058811][ C2] ? rcu_is_watching+0x15/0xd0 [ 844.058813][ C2] ? lock_acquire+0x134/0x160 [ 844.058815][ C2] _raw_spin_lock+0x33/0x40 [ 844.058816][ C2] ? tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 844.058818][ C2] tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 844.058820][ C2] tcf_action_rcu_free+0x74/0x1a0 [ 844.058821][ C2] ? rcu_do_batch+0x2b4/0x1020 [ 844.058823][ C2] rcu_do_batch+0x2b6/0x1020 [ 844.058825][ C2] ? rcu_start_this_gp+0x270/0x490 [ 844.058827][ C2] ? trace_rcu_batch_end+0x330/0x330 [ 844.058829][ C2] ? rcu_is_watching+0x15/0xd0 [ 844.058831][ C2] ? trace_irq_enable.constprop.0+0x9b/0x180 [ 844.058834][ C2] ? trace_irq_disable.constprop.0+0x9b/0x180 [ 844.058836][ C2] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 844.058837][ C2] ? lockdep_hardirqs_on+0x8c/0x130 [ 844.058840][ C2] rcu_core+0x2bf/0x640 [ 844.058842][ C2] handle_softirqs+0x1d8/0x940 [ 844.058843][ C2] ? find_held_lock+0x2b/0x80 [ 844.058846][ C2] ? _local_bh_enable+0xd0/0xd0 [ 844.058848][ C2] ? rcu_is_watching+0x15/0xd0 [ 844.058850][ C2] run_ksoftirqd+0x39/0x60 [ 844.058851][ C2] smpboot_thread_fn+0x2fb/0x9b0 [ 844.058854][ C2] ? sort_range+0x20/0x20 [ 844.058855][ C2] kthread+0x367/0x460 [ 844.058857][ C2] ? trace_irq_enable.constprop.0+0x9b/0x180 [ 844.058858][ C2] ? kthread_affine_node+0x330/0x330 [ 844.058860][ C2] ret_from_fork+0x474/0x6b0 [ 844.058863][ C2] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 844.058865][ C2] ? __switch_to+0x5a3/0xe00 [ 844.058868][ C2] ? kthread_affine_node+0x330/0x330 [ 844.058869][ C2] ret_from_fork_asm+0x11/0x20 [ 844.058873][ C2] [ 857.856619][ T39] br1: port 1(lag) entered disabled state [ 863.075587][ T46] br1: port 1(lag) entered blocking state [ 863.075744][ T46] br1: port 1(lag) entered forwarding state [ 863.211593][T21779] lag: left allmulticast mode [ 863.211705][T21779] veth2: left allmulticast mode [ 863.211779][T21779] veth4: left allmulticast mode [ 863.211897][T21779] br1: port 1(lag) entered disabled state [ 863.212732][T21779] veth2: left promiscuous mode [ 863.212808][T21779] veth4: left promiscuous mode [ 863.233929][T21614] lag: Port device veth4 removed [ 863.235101][T21614] lag: Port device veth2 removed