[ 143.206478][ T2330] lag2: Mode changed to "loadbalance" [ 143.264579][ T2334] lag2: Port device veth3 added [ 143.380525][ T2342] lag2: Port device veth5 added [ 143.453535][ T2347] 8021q: adding VLAN 0 to HW filter on device lag2 [ 143.476659][ T2348] 8021q: adding VLAN 0 to HW filter on device lag2 [ 144.056044][ T2377] lag1: Mode changed to "loadbalance" [ 144.114182][ T2381] lag1: Port device veth2 added [ 144.213075][ T2385] lag1: Port device veth4 added [ 144.310036][ T2387] 8021q: adding VLAN 0 to HW filter on device lag1 [ 149.740016][ T2418] Mirror/redirect action on [ 149.803058][ T2420] lag2: Port device veth5 removed [ 153.463675][ T2431] lag2: Port device veth3 removed [ 157.157996][ C0] [ 157.158082][ C0] ================================ [ 157.158182][ C0] WARNING: inconsistent lock state [ 157.158273][ C0] 7.1.0-rc5-virtme #1 Not tainted [ 157.158370][ C0] -------------------------------- [ 157.158463][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 157.158578][ C0] ip/2443 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 157.158676][ C0] ffffffffc05027b8 (mirred_list_lock){+.?.}-{3:3}, at: tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 157.158869][ C0] {SOFTIRQ-ON-W} state was registered at: [ 157.158961][ C0] __lock_acquire+0x378/0xc10 [ 157.159059][ C0] lock_acquire.part.0+0xbc/0x260 [ 157.159149][ C0] _raw_spin_lock+0x33/0x40 [ 157.159248][ C0] tcf_mirred_init+0x844/0xd70 [act_mirred] [ 157.159361][ C0] tcf_action_init_1+0x428/0x6b0 [ 157.159453][ C0] tcf_action_init+0x3cf/0x890 [ 157.159545][ C0] tcf_exts_validate_ex+0x411/0x670 [ 157.159642][ C0] fl_change+0xed4/0x4e77 [cls_flower] [ 157.159735][ C0] tc_new_tfilter+0x875/0x21e0 [ 157.159830][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 157.159923][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 157.160017][ C0] netlink_unicast+0x486/0x750 [ 157.160108][ C0] netlink_sendmsg+0x735/0xc60 [ 157.160199][ C0] ____sys_sendmsg+0x419/0x850 [ 157.160290][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 157.160380][ C0] __sys_sendmsg+0x145/0x1f0 [ 157.160470][ C0] do_syscall_64+0x117/0x590 [ 157.160561][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 157.160679][ C0] irq event stamp: 6586 [ 157.160749][ C0] hardirqs last enabled at (6586): [] _raw_spin_unlock_irqrestore+0x53/0x80 [ 157.160933][ C0] hardirqs last disabled at (6585): [] _raw_spin_lock_irqsave+0x50/0x60 [ 157.161091][ C0] softirqs last enabled at (2658): [] fpu_flush_thread+0x130/0x190 [ 157.161251][ C0] softirqs last disabled at (6467): [] __irq_exit_rcu+0x103/0x1c0 [ 157.161411][ C0] [ 157.161411][ C0] other info that might help us debug this: [ 157.161546][ C0] Possible unsafe locking scenario: [ 157.161546][ C0] [ 157.161683][ C0] CPU0 [ 157.161751][ C0] ---- [ 157.161823][ C0] lock(mirred_list_lock); [ 157.161916][ C0] [ 157.161986][ C0] lock(mirred_list_lock); [ 157.162077][ C0] [ 157.162077][ C0] *** DEADLOCK *** [ 157.162077][ C0] [ 157.162212][ C0] 3 locks held by ip/2443: [ 157.162303][ C0] #0: ff11000009073248 (vm_lock){++++}-{0:0}, at: lock_vma_under_rcu+0x12a/0x410 [ 157.162467][ C0] #1: ff11000002575778 (&mm->mmap_lock){++++}-{4:4}, at: __vmf_anon_prepare+0xce/0x2a0 [ 157.162631][ C0] #2: ffffffff9e377c00 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x389/0x1020 [ 157.162796][ C0] [ 157.162796][ C0] stack backtrace: [ 157.162909][ C0] CPU: 0 UID: 0 PID: 2443 Comm: ip Not tainted 7.1.0-rc5-virtme #1 PREEMPT(full) [ 157.162912][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 157.162914][ C0] Call Trace: [ 157.162915][ C0] [ 157.162917][ C0] dump_stack_lvl+0x6f/0xa0 [ 157.162922][ C0] print_usage_bug.part.0.cold+0xa9/0xb7 [ 157.162924][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 157.162928][ C0] mark_lock_irq+0x4e3/0x9c0 [ 157.162929][ C0] ? sysvec_apic_timer_interrupt+0x9d/0xe0 [ 157.162931][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 157.162933][ C0] ? save_trace+0x68/0x280 [ 157.162935][ C0] ? __access_remote_vm+0x50/0x720 [ 157.162937][ C0] mark_lock+0x1d7/0xa00 [ 157.162938][ C0] mark_usage+0x42/0x170 [ 157.162940][ C0] __lock_acquire+0x378/0xc10 [ 157.162941][ C0] ? mark_held_locks+0x40/0x70 [ 157.162944][ C0] lock_acquire.part.0+0xbc/0x260 [ 157.162945][ C0] ? tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 157.162947][ C0] ? rcu_is_watching+0x15/0xd0 [ 157.162949][ C0] ? lock_acquire+0x134/0x160 [ 157.162951][ C0] _raw_spin_lock+0x33/0x40 [ 157.162952][ C0] ? tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 157.162954][ C0] tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 157.162956][ C0] tcf_action_rcu_free+0x74/0x1a0 [ 157.162957][ C0] ? rcu_do_batch+0x2b4/0x1020 [ 157.162959][ C0] rcu_do_batch+0x2b6/0x1020 [ 157.162962][ C0] ? trace_rcu_batch_end+0x330/0x330 [ 157.162964][ C0] ? mark_held_locks+0x40/0x70 [ 157.162965][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 157.162967][ C0] ? lockdep_hardirqs_on+0x8c/0x130 [ 157.162969][ C0] rcu_core+0x2bf/0x640 [ 157.162970][ C0] handle_softirqs+0x1d8/0x940 [ 157.162972][ C0] ? find_held_lock+0x2b/0x80 [ 157.162975][ C0] ? __lock_release.isra.0+0x6b/0x1a0 [ 157.162977][ C0] ? _local_bh_enable+0xd0/0xd0 [ 157.162979][ C0] __irq_exit_rcu+0x103/0x1c0 [ 157.162980][ C0] irq_exit_rcu+0xe/0x30 [ 157.162982][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 157.162983][ C0] [ 157.162984][ C0] [ 157.162985][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 157.162986][ C0] RIP: 0010:_raw_spin_unlock_irqrestore+0x36/0x80 [ 157.162989][ C0] Code: f5 53 48 8b 74 24 10 48 89 fb 48 83 c7 18 e8 21 7e ca fd 48 89 df e8 a9 d4 ca fd f7 c5 00 02 00 00 75 1f 9c 58 f6 c4 02 75 2f 01 00 00 00 e8 30 62 bd fd 65 8b 05 29 0a fe 01 85 c0 74 12 5b [ 157.162991][ C0] RSP: 0000:ffa0000000657a58 EFLAGS: 00000246 [ 157.162993][ C0] RAX: 0000000000000096 RBX: ff11000001041440 RCX: ffffffff9d490613 [ 157.162994][ C0] RDX: ff11000011f82340 RSI: ffffffff9de01bcb RDI: ffffffff9d86f6c0 [ 157.162995][ C0] RBP: 0000000000000206 R08: 0000000000000000 R09: 0000000000000000 [ 157.162996][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: ff11000001041440 [ 157.162997][ C0] R13: ff1100000103fe40 R14: ff11000009a88d70 R15: ffd400000026a200 [ 157.162999][ C0] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 157.163001][ C0] get_from_partial_node+0x1fd/0x550 [ 157.163005][ C0] ? __lock_release.isra.0+0x6b/0x1a0 [ 157.163007][ C0] ___slab_alloc+0x82/0x300 [ 157.163009][ C0] ? __alloc_object+0x30/0x250 [ 157.163011][ C0] ? __pcs_replace_empty_main+0x40b/0x670 [ 157.163013][ C0] ? __alloc_object+0x30/0x250 [ 157.163014][ C0] kmem_cache_alloc_noprof+0x1df/0x5f0 [ 157.163017][ C0] __alloc_object+0x30/0x250 [ 157.163018][ C0] __create_object+0x30/0x110 [ 157.163020][ C0] ? kasan_save_track+0x14/0x30 [ 157.163023][ C0] kmem_cache_alloc_noprof+0x445/0x5f0 [ 157.163025][ C0] __anon_vma_prepare+0xa5/0x580 [ 157.163028][ C0] __vmf_anon_prepare+0xf7/0x2a0 [ 157.163030][ C0] ? __lock_release.isra.0+0x6b/0x1a0 [ 157.163031][ C0] do_anonymous_page+0x284/0xd30 [ 157.163033][ C0] ? rcu_read_unlock+0x1b/0x70 [ 157.163035][ C0] __handle_mm_fault+0x5ed/0x840 [ 157.163037][ C0] ? __pmd_alloc+0x840/0x840 [ 157.163038][ C0] ? lock_vma_under_rcu+0x159/0x410 [ 157.163040][ C0] ? __lock_release.isra.0+0xb3/0x1a0 [ 157.163043][ C0] handle_mm_fault+0x18b/0x4b0 [ 157.163045][ C0] ? rcu_is_watching+0x15/0xd0 [ 157.163047][ C0] do_user_addr_fault+0x472/0xe30 [ 157.163050][ C0] ? irqentry_enter+0x9f/0xd0 [ 157.163052][ C0] exc_page_fault+0x87/0x100 [ 157.163054][ C0] asm_exc_page_fault+0x26/0x30 [ 157.163055][ C0] RIP: 0033:0x7f76630a003d [ 157.163058][ C0] Code: 04 00 00 48 8d 40 01 48 89 45 b0 48 89 55 a8 be 01 00 00 00 ff 15 23 ba 02 00 49 89 c6 48 85 c0 0f 84 24 02 00 00 48 8b 55 a8 <48> 89 40 28 4c 89 ee 4c 8d 84 10 b8 04 00 00 48 8b 55 b0 4c 89 80 [ 157.163059][ C0] RSP: 002b:00007fff672a3290 EFLAGS: 00010206 [ 157.163060][ C0] RAX: 00007f7662fc0000 RBX: 0000000000000000 RCX: 00007f7662fc2000 [ 157.163061][ C0] RDX: 0000000000000000 RSI: 0000000000002000 RDI: 00007f7662fc0000 [ 157.163061][ C0] RBP: 00007fff672a32f0 R08: 00000000ffffffff R09: 0000000000000000 [ 157.163062][ C0] R10: 0000000000000022 R11: 0000000000000246 R12: 000000000000000b [ 157.163063][ C0] R13: 0000000000471f0f R14: 00007f7662fc0000 R15: 00007f76630cd2e0 [ 157.163065][ C0] [ 157.423632][ T2463] lag2: Mode changed to "loadbalance" [ 157.460591][ T2467] lag2: Port device veth3 added [ 157.539211][ T2471] lag2: Port device veth5 added [ 157.568792][ T2473] 8021q: adding VLAN 0 to HW filter on device lag2 [ 157.587532][ T2474] 8021q: adding VLAN 0 to HW filter on device lag2 [ 162.864669][ T2514] lag2: Port device veth3 removed [ 166.466551][ T2524] lag2: Port device veth5 removed [ 170.329189][ T2556] lag2: Mode changed to "loadbalance" [ 170.361082][ T2559] lag2: Port device veth3 added [ 170.448561][ T2562] lag2: Port device veth5 added [ 170.476945][ T2564] 8021q: adding VLAN 0 to HW filter on device lag2 [ 170.499293][ T2565] 8021q: adding VLAN 0 to HW filter on device lag2 [ 175.782148][ T2377] lag1: Port device veth4 removed [ 175.783982][ T2377] lag1: Port device veth2 removed [ 176.187427][ T2556] lag2: Port device veth5 removed [ 176.188547][ T2556] lag2: Port device veth3 removed