[ 490.645855][T10610] gre: GRE over IPv4 demultiplexer driver [ 490.662815][T10610] ip_gre: GRE over IPv4 tunneling driver [ 490.980336][T10625] ip6_gre: GRE over IPv6 tunneling driver [ 491.050867][ T9] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 491.086306][ T9] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 491.224210][ T70] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 491.303970][T10638] br1: port 1(veth1) entered blocking state [ 491.304183][T10638] br1: port 1(veth1) entered disabled state [ 491.304397][T10638] veth1: entered allmulticast mode [ 491.305864][T10638] veth1: entered promiscuous mode [ 491.332505][ T36] br1: port 1(veth1) entered blocking state [ 491.332722][ T36] br1: port 1(veth1) entered forwarding state [ 491.366985][T10640] br1: port 2(veth2) entered blocking state [ 491.367190][T10640] br1: port 2(veth2) entered disabled state [ 491.367375][T10640] veth2: entered allmulticast mode [ 491.368816][T10640] veth2: entered promiscuous mode [ 491.393744][ T36] br1: port 2(veth2) entered blocking state [ 491.393940][ T36] br1: port 2(veth2) entered forwarding state [ 491.400159][ T9] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 491.552210][ T53] ip6_tunnel: gt6 xmit: Local address not yet configured! [ 491.912246][T10663] br1: port 3(veth4) entered blocking state [ 491.912511][T10663] br1: port 3(veth4) entered disabled state [ 491.912772][T10663] veth4: entered allmulticast mode [ 491.914808][T10663] veth4: entered promiscuous mode [ 491.915423][T10663] br1: port 3(veth4) entered blocking state [ 491.915650][T10663] br1: port 3(veth4) entered forwarding state [ 491.993175][ T53] ip6_tunnel: gt6 xmit: Local address not yet configured! [ 492.256304][ T70] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 492.256868][ T70] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 492.449424][ T70] ip6_tunnel: gt6 xmit: Local address not yet configured! [ 492.481162][ T258] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 496.992786][ C1] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 497.316272][T10694] Mirror/redirect action on [ 505.696317][ C1] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 505.889101][ C1] [ 505.889191][ C1] ================================ [ 505.889294][ C1] WARNING: inconsistent lock state [ 505.889390][ C1] 7.1.0-rc5-virtme #1 Not tainted [ 505.889496][ C1] -------------------------------- [ 505.889595][ C1] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 505.889711][ C1] tc/10748 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 505.889808][ C1] ffffffffc03237b8 (mirred_list_lock){+.?.}-{3:3}, at: tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 505.890003][ C1] {SOFTIRQ-ON-W} state was registered at: [ 505.890109][ C1] __lock_acquire+0x378/0xc10 [ 505.890209][ C1] lock_acquire.part.0+0xbc/0x260 [ 505.890304][ C1] _raw_spin_lock+0x33/0x40 [ 505.890401][ C1] tcf_mirred_init+0x844/0xd70 [act_mirred] [ 505.890541][ C1] tcf_action_init_1+0x428/0x6b0 [ 505.890636][ C1] tcf_action_init+0x3cf/0x890 [ 505.890729][ C1] tcf_exts_validate_ex+0x411/0x670 [ 505.890824][ C1] mall_change+0x3cd/0xe9b [cls_matchall] [ 505.890950][ C1] tc_new_tfilter+0x875/0x21e0 [ 505.891051][ C1] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 505.891158][ C1] netlink_rcv_skb+0x14e/0x3a0 [ 505.891255][ C1] netlink_unicast+0x486/0x750 [ 505.891349][ C1] netlink_sendmsg+0x735/0xc60 [ 505.891447][ C1] ____sys_sendmsg+0x419/0x850 [ 505.891545][ C1] ___sys_sendmsg+0x14e/0x1d0 [ 505.891640][ C1] __sys_sendmsg+0x145/0x1f0 [ 505.891737][ C1] do_syscall_64+0x117/0x590 [ 505.891833][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 505.891950][ C1] irq event stamp: 7358 [ 505.892021][ C1] hardirqs last enabled at (7358): [] _raw_spin_unlock_irqrestore+0x53/0x80 [ 505.892213][ C1] hardirqs last disabled at (7357): [] _raw_spin_lock_irqsave+0x50/0x60 [ 505.892379][ C1] softirqs last enabled at (6800): [] handle_softirqs+0x611/0x940 [ 505.892545][ C1] softirqs last disabled at (7305): [] __irq_exit_rcu+0x103/0x1c0 [ 505.892707][ C1] [ 505.892707][ C1] other info that might help us debug this: [ 505.892845][ C1] Possible unsafe locking scenario: [ 505.892845][ C1] [ 505.892990][ C1] CPU0 [ 505.893062][ C1] ---- [ 505.893138][ C1] lock(mirred_list_lock); [ 505.893240][ C1] [ 505.893313][ C1] lock(mirred_list_lock); [ 505.893406][ C1] [ 505.893406][ C1] *** DEADLOCK *** [ 505.893406][ C1] [ 505.893547][ C1] 1 lock held by tc/10748: [ 505.893642][ C1] #0: ffffffff9b777c00 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x389/0x1020 [ 505.893813][ C1] [ 505.893813][ C1] stack backtrace: [ 505.893930][ C1] CPU: 1 UID: 0 PID: 10748 Comm: tc Not tainted 7.1.0-rc5-virtme #1 PREEMPT(full) [ 505.893933][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 505.893935][ C1] Call Trace: [ 505.893936][ C1] [ 505.893938][ C1] dump_stack_lvl+0x6f/0xa0 [ 505.893943][ C1] print_usage_bug.part.0.cold+0xa9/0xb7 [ 505.893945][ C1] ? filter_irq_stacks+0xd0/0xd0 [ 505.893949][ C1] mark_lock_irq+0x4e3/0x9c0 [ 505.893951][ C1] ? sysvec_apic_timer_interrupt+0x9d/0xe0 [ 505.893953][ C1] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 505.893955][ C1] ? save_trace+0x68/0x280 [ 505.893956][ C1] ? execmem_alloc+0x330/0x340 [ 505.893961][ C1] mark_lock+0x1d7/0xa00 [ 505.893962][ C1] mark_usage+0x42/0x170 [ 505.893964][ C1] __lock_acquire+0x378/0xc10 [ 505.893965][ C1] ? rcu_is_watching+0x15/0xd0 [ 505.893967][ C1] ? trace_irq_enable.constprop.0+0x9b/0x180 [ 505.893971][ C1] lock_acquire.part.0+0xbc/0x260 [ 505.893973][ C1] ? tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 505.893975][ C1] ? rcu_is_watching+0x15/0xd0 [ 505.893977][ C1] ? lock_acquire+0x134/0x160 [ 505.893978][ C1] _raw_spin_lock+0x33/0x40 [ 505.893980][ C1] ? tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 505.893982][ C1] tcf_mirred_release+0x1d/0x2e0 [act_mirred] [ 505.893984][ C1] tcf_action_rcu_free+0x74/0x1a0 [ 505.893985][ C1] ? rcu_do_batch+0x2b4/0x1020 [ 505.893987][ C1] rcu_do_batch+0x2b6/0x1020 [ 505.893989][ C1] ? rcu_is_watching+0x15/0xd0 [ 505.893991][ C1] ? sched_balance_softirq+0x260/0x320 [ 505.893994][ C1] ? trace_rcu_batch_end+0x330/0x330 [ 505.893996][ C1] ? sched_balance_domains+0xcd0/0xcd0 [ 505.893998][ C1] ? rcu_is_watching+0x15/0xd0 [ 505.893999][ C1] ? trace_irq_enable.constprop.0+0x9b/0x180 [ 505.894001][ C1] ? trace_irq_disable.constprop.0+0x9b/0x180 [ 505.894002][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 505.894004][ C1] ? lockdep_hardirqs_on+0x8c/0x130 [ 505.894006][ C1] rcu_core+0x2bf/0x640 [ 505.894008][ C1] handle_softirqs+0x1d8/0x940 [ 505.894009][ C1] ? find_held_lock+0x2b/0x80 [ 505.894012][ C1] ? __lock_release.isra.0+0x6b/0x1a0 [ 505.894014][ C1] ? _local_bh_enable+0xd0/0xd0 [ 505.894016][ C1] __irq_exit_rcu+0x103/0x1c0 [ 505.894017][ C1] irq_exit_rcu+0xe/0x30 [ 505.894019][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 505.894021][ C1] [ 505.894021][ C1] [ 505.894022][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 505.894024][ C1] RIP: 0010:debug_lockdep_rcu_enabled+0x26/0x30 [ 505.894026][ C1] Code: 00 0f 1f 00 f3 0f 1e fa 8b 05 b2 60 7d 01 85 c0 74 20 8b 05 c0 71 7d 01 85 c0 74 16 65 48 8b 05 10 87 00 02 8b 80 ec 0a 00 00 <85> c0 0f 94 c0 0f b6 c0 c3 90 0f 1f 40 d6 f6 87 88 00 00 00 03 75 [ 505.894028][ C1] RSP: 0018:ffa000000078f810 EFLAGS: 00000202 [ 505.894030][ C1] RAX: 0000000000000000 RBX: 1ff40000000f1f04 RCX: 0000000000000000 [ 505.894032][ C1] RDX: 0000000000000000 RSI: 0000000000000143 RDI: ffffffff9b1fef31 [ 505.894033][ C1] RBP: 0000000000000000 R08: ffffffff9b1fef31 R09: 0000000000000143 [ 505.894033][ C1] R10: 0000000000000001 R11: 0000000000000001 R12: 0000000000000400 [ 505.894034][ C1] R13: ff1100001664c640 R14: ffffffff9b1fef31 R15: 0000000000000143 [ 505.894037][ C1] __might_resched+0x6b/0x390 [ 505.894040][ C1] ? perf_trace_sched_switch+0x7d0/0x7d0 [ 505.894042][ C1] ? kmem_cache_alloc_noprof+0x3f/0x5f0 [ 505.894046][ C1] ? __alloc_object+0x30/0x250 [ 505.894048][ C1] kmem_cache_alloc_noprof+0x314/0x5f0 [ 505.894050][ C1] __alloc_object+0x30/0x250 [ 505.894052][ C1] __create_object+0x30/0x110 [ 505.894054][ C1] __kmalloc_cache_noprof+0x463/0x620 [ 505.894056][ C1] ovl_open+0x1ef/0x2f0 [ 505.894060][ C1] ? ovl_llseek+0x2e0/0x2e0 [ 505.894062][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 505.894064][ C1] ? ovl_llseek+0x2e0/0x2e0 [ 505.894065][ C1] do_dentry_open+0x408/0x1310 [ 505.894068][ C1] vfs_open+0x7a/0x440 [ 505.894070][ C1] ? may_open+0xe6/0x330 [ 505.894073][ C1] ? lookup_open.isra.0+0xea0/0xea0 [ 505.894075][ C1] do_open+0x671/0xda0 [ 505.894082][ C1] ? init_file.isra.0+0x30a/0x3e0 [ 505.894085][ C1] path_openat+0x1d0/0x3b0 [ 505.894087][ C1] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 505.894089][ C1] ? kernel_tmpfile_open+0x70/0x70 [ 505.894090][ C1] ? validate_chain+0x38b/0xc20 [ 505.894092][ C1] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 505.894094][ C1] do_file_open+0x209/0x480 [ 505.894096][ C1] ? path_openat+0x3b0/0x3b0 [ 505.894099][ C1] ? page_get_link_raw+0x70/0x70 [ 505.894101][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 505.894103][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 505.894105][ C1] ? alloc_fd+0x24a/0x450 [ 505.894108][ C1] do_sys_openat2+0xde/0x170 [ 505.894110][ C1] ? build_open_flags+0x620/0x620 [ 505.894112][ C1] ? find_held_lock+0x2b/0x80 [ 505.894114][ C1] __x64_sys_openat+0x10e/0x210 [ 505.894116][ C1] ? exc_page_fault+0x87/0x100 [ 505.894118][ C1] ? __ia32_sys_open+0x1b0/0x1b0 [ 505.894120][ C1] ? rcu_is_watching+0x15/0xd0 [ 505.894122][ C1] ? rcu_is_watching+0x15/0xd0 [ 505.894123][ C1] ? trace_irq_enable.constprop.0+0x9b/0x180 [ 505.894125][ C1] do_syscall_64+0x117/0x590 [ 505.894127][ C1] ? trace_hardirqs_off+0xd/0x30 [ 505.894128][ C1] ? exc_page_fault+0xee/0x100 [ 505.894130][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 505.894132][ C1] RIP: 0033:0x7fc3e5519625 [ 505.894134][ C1] Code: 48 89 e5 48 89 55 e0 41 83 e2 40 75 28 89 f2 f7 d2 81 e2 00 00 41 00 74 1c 89 f2 bf 9c ff ff ff 48 89 c6 b8 01 01 00 00 0f 05 <48> 3d 00 f0 ff ff 77 23 5d c3 90 48 8d 4d 10 c7 45 b8 10 00 00 00 [ 505.894135][ C1] RSP: 002b:00007ffd0903a970 EFLAGS: 00000206 ORIG_RAX: 0000000000000101 [ 505.894136][ C1] RAX: ffffffffffffffda RBX: 00007ffd0903ac00 RCX: 00007fc3e5519625 [ 505.894137][ C1] RDX: 0000000000080000 RSI: 00007ffd0903a9f0 RDI: 00000000ffffff9c [ 505.894138][ C1] RBP: 00007ffd0903a970 R08: 00007ffd0903abe7 R09: 0000000000000000 [ 505.894139][ C1] R10: 0000000000000000 R11: 0000000000000206 R12: 00007ffd0903a9f0 [ 505.894140][ C1] R13: 00007ffd0903a9f0 R14: 00007fc3e54eb000 R15: 0000000000000000 [ 505.894142][ C1] [ 523.616154][ C1] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 562.529353][ C1] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 632.160177][ C1] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! [ 668.713921][T11716] br1: port 3(veth4) entered disabled state [ 672.981999][T11738] br1: port 3(veth4) entered forwarding state [ 680.561966][T11795] br1: port 3(veth4) entered disabled state [ 684.838480][T11817] br1: port 3(veth4) entered forwarding state [ 689.161975][T11847] veth2: left allmulticast mode [ 689.162566][T11847] veth2: left promiscuous mode [ 689.162724][T11847] br1: port 2(veth2) entered disabled state [ 689.178110][T11848] veth4: left allmulticast mode [ 689.178224][T11848] veth4: left promiscuous mode [ 689.178370][T11848] br1: port 3(veth4) entered disabled state [ 689.368647][T11859] br1: port 1(veth1) entered disabled state [ 689.401011][T11861] veth1: left allmulticast mode [ 689.401206][T11861] veth1: left promiscuous mode [ 689.401359][T11861] br1: port 1(veth1) entered disabled state