[ 1978.089005][ C1]
[ 1978.089203][ C1] =============================
[ 1978.089355][ C1] WARNING: suspicious RCU usage
[ 1978.089499][ C1] 7.2.0-rc2-virtme #1 Not tainted
[ 1978.089641][ C1] -----------------------------
[ 1978.089923][ C1] drivers/net/vxlan/vxlan_core.c:872 suspicious rcu_dereference_protected() usage!
[ 1978.090244][ C1]
[ 1978.090244][ C1] other info that might help us debug this:
[ 1978.090244][ C1]
[ 1978.090540][ C1]
[ 1978.090540][ C1] rcu_scheduler_active = 2, debug_locks = 1
[ 1978.090758][ C1] 8 locks held by kworker/1:0/8363:
[ 1978.090903][ C1] #0: ff11000009070340 ((wq_completion)mld){+.+.}-{0:0}, at: process_one_work+0xd55/0x1410
[ 1978.091198][ C1] #1: ffa00000020c7d10 ((work_completion)(&(&idev->mc_ifc_work)->work)){+.+.}-{0:0}, at: process_one_work+0xdb7/0x1410
[ 1978.091523][ C1] #2: ff11000019fded30 (&idev->mc_lock){+.+.}-{4:4}, at: mld_ifc_work+0x2e/0x190
[ 1978.091782][ C1] #3: ffffffffa6b91dc0 (rcu_read_lock){....}-{1:3}, at: mld_sendpack+0x1c9/0xec0
[ 1978.092033][ C1] #4: ffffffffa6b91dc0 (rcu_read_lock){....}-{1:3}, at: ip6_output+0x11d/0x7f0
[ 1978.092284][ C1] #5: ffffffffa6b91dc0 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x561/0x1490
[ 1978.092541][ C1] #6: ffffffffa6b91dc0 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610
[ 1978.092831][ C1] #7: ff1100001a8bafa8 (&vxlan->hash_lock){+.-.}-{3:3}, at: vxlan_snoop+0x5dc/0x9a0 [vxlan]
[ 1978.093121][ C1]
[ 1978.093121][ C1] stack backtrace:
[ 1978.093299][ C1] CPU: 1 UID: 0 PID: 8363 Comm: kworker/1:0 Not tainted 7.2.0-rc2-virtme #1 PREEMPT(full)
[ 1978.093301][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 1978.093303][ C1] Workqueue: mld mld_ifc_work
[ 1978.093306][ C1] Call Trace:
[ 1978.093308][ C1]
[ 1978.093310][ C1] dump_stack_lvl+0x6f/0xa0
[ 1978.093315][ C1] lockdep_rcu_suspicious.cold+0x37/0x89
[ 1978.093320][ C1] vxlan_fdb_create+0xe1b/0x1a70 [vxlan]
[ 1978.093326][ C1] ? vxlan_find_mac_rcu+0x578/0x6b0 [vxlan]
[ 1978.093332][ C1] ? lock_acquire.part.0+0xbc/0x260
[ 1978.093335][ C1] ? find_held_lock+0x2b/0x80
[ 1978.093341][ C1] ? vxlan_open+0x340/0x340 [vxlan]
[ 1978.093345][ C1] ? __lock_release.isra.0+0x6b/0x1a0
[ 1978.093350][ C1] vxlan_fdb_update+0x208/0x3e0 [vxlan]
[ 1978.093357][ C1] ? vxlan_fdb_create+0x1a70/0x1a70 [vxlan]
[ 1978.093360][ C1] ? lock_acquire.part.0+0xbc/0x260
[ 1978.093363][ C1] ? do_raw_spin_lock+0x131/0x280
[ 1978.093367][ C1] vxlan_snoop+0x6ba/0x9a0 [vxlan]
[ 1978.093373][ C1] ? __iptunnel_pull_header+0x33b/0x730
[ 1978.093377][ C1] vxlan_rcv+0x172e/0x2c20 [vxlan]
[ 1978.093385][ C1] ? encap_bypass_if_local+0x290/0x290 [vxlan]
[ 1978.093390][ C1] ? udp_lib_lport_inuse2+0x3d0/0x3d0
[ 1978.093395][ C1] ? __udp4_lib_lookup+0x5f1/0x820
[ 1978.093399][ C1] ? encap_bypass_if_local+0x290/0x290 [vxlan]
[ 1978.093402][ C1] ? udp_queue_rcv_one_skb+0x645/0xb00
[ 1978.093404][ C1] udp_queue_rcv_one_skb+0x645/0xb00
[ 1978.093406][ C1] ? lock_acquire.part.0+0xbc/0x260
[ 1978.093408][ C1] ? down_read_killable_nested+0x3c2/0x600
[ 1978.093410][ C1] udp_unicast_rcv_skb+0x366/0x450
[ 1978.093413][ C1] ? udp_rcv+0xce3/0x1e30
[ 1978.093415][ C1] udp_rcv+0xd01/0x1e30
[ 1978.093420][ C1] ? udp_sk_rx_dst_set+0x90/0x90
[ 1978.093423][ C1] ? lock_acquire.part.0+0xbc/0x260
[ 1978.093425][ C1] ? ip_local_deliver_finish+0x2ba/0x610
[ 1978.093429][ C1] ip_protocol_deliver_rcu+0x82/0x350
[ 1978.093432][ C1] ? process_backlog+0x561/0x1490
[ 1978.093434][ C1] ip_local_deliver_finish+0x36f/0x610
[ 1978.093436][ C1] ? __lock_release.isra.0+0x6b/0x1a0
[ 1978.093438][ C1] ip_local_deliver+0x184/0x4c0
[ 1978.093440][ C1] ? ip_local_deliver_finish+0x610/0x610
[ 1978.093443][ C1] ? ip_rcv_finish_core+0x553/0x14c0
[ 1978.093448][ C1] ? process_backlog+0x561/0x1490
[ 1978.093450][ C1] ip_rcv+0xdc/0x3d0
[ 1978.093452][ C1] ? ip_local_deliver+0x4c0/0x4c0
[ 1978.093454][ C1] ? validate_chain+0x38b/0xc20
[ 1978.093457][ C1] ? mark_usage+0x61/0x170
[ 1978.093460][ C1] ? __lock_acquire+0x518/0xc20
[ 1978.093462][ C1] ? nbcon_context_try_acquire+0x3f7/0x600
[ 1978.093466][ C1] __netif_receive_skb_one_core+0xfc/0x180
[ 1978.093468][ C1] ? lock_acquire.part.0+0xbc/0x260
[ 1978.093471][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0
[ 1978.093473][ C1] ? rcu_is_watching+0x15/0xd0
[ 1978.093479][ C1] process_backlog+0x2bc/0x1490
[ 1978.093483][ C1] __napi_poll+0xa7/0x3b0
[ 1978.093486][ C1] net_rx_action+0x513/0xf50
[ 1978.093491][ C1] ? __napi_poll+0x3b0/0x3b0
[ 1978.093492][ C1] ? validate_chain+0x38b/0xc20
[ 1978.093501][ C1] ? __rwlock_init+0x150/0x150
[ 1978.093503][ C1] ? mark_held_locks+0x40/0x70
[ 1978.093506][ C1] handle_softirqs+0x1d8/0x8f0
[ 1978.093511][ C1] ? _local_bh_enable+0xd0/0xd0
[ 1978.093513][ C1] ? do_raw_spin_unlock+0x59/0x250
[ 1978.093515][ C1] ? _raw_spin_unlock+0x2d/0x50
[ 1978.093518][ C1] ? __dev_queue_xmit+0x974/0x1b90
[ 1978.093521][ C1] do_softirq+0xa9/0xe0
[ 1978.093523][ C1]
[ 1978.093524][ C1]
[ 1978.093525][ C1] __local_bh_enable_ip+0x113/0x140
[ 1978.093527][ C1] __dev_queue_xmit+0x989/0x1b90
[ 1978.093530][ C1] ? __lock_acquire+0x518/0xc20
[ 1978.093534][ C1] ? find_held_lock+0x2b/0x80
[ 1978.093536][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0
[ 1978.093539][ C1] ? __asan_memcpy+0x3c/0x60
[ 1978.093543][ C1] ? eth_header+0x14c/0x180
[ 1978.093547][ C1] ? neigh_resolve_output.part.0+0x344/0x740
[ 1978.093553][ C1] ip6_finish_output2+0x488/0x1310
[ 1978.093556][ C1] ? ip6_xmit+0x2000/0x2000
[ 1978.093558][ C1] ? find_held_lock+0x2b/0x80
[ 1978.093560][ C1] ? __lock_release.isra.0+0x6b/0x1a0
[ 1978.093563][ C1] ? ip6_mtu+0x174/0x410
[ 1978.093568][ C1] ip6_finish_output+0x701/0xe80
[ 1978.093571][ C1] ip6_output+0x23f/0x7f0
[ 1978.093574][ C1] ? ip6_finish_output+0xe80/0xe80
[ 1978.093575][ C1] ? __lock_release.isra.0+0x6b/0x1a0
[ 1978.093577][ C1] ? xfrm_bundle_lookup.constprop.0+0xba0/0xba0
[ 1978.093580][ C1] ? mark_held_locks+0x40/0x70
[ 1978.093583][ C1] ? __local_bh_enable_ip+0xa5/0x140
[ 1978.093585][ C1] ? __local_bh_enable_ip+0xa5/0x140
[ 1978.093587][ C1] ? icmp6_dst_alloc+0x317/0x4d0
[ 1978.093591][ C1] mld_sendpack+0x9d6/0xec0
[ 1978.093595][ C1] ? mld_dad_start_work+0x240/0x240
[ 1978.093600][ C1] ? mld_send_cr+0x50f/0x820
[ 1978.093604][ C1] mld_ifc_work+0x36/0x190
[ 1978.093606][ C1] ? process_one_work+0xdb7/0x1410
[ 1978.093607][ C1] process_one_work+0xdf8/0x1410
[ 1978.093613][ C1] ? pwq_dec_nr_in_flight+0x710/0x710
[ 1978.093614][ C1] ? lock_acquire.part.0+0xbc/0x260
[ 1978.093621][ C1] worker_thread+0x4f1/0xd60
[ 1978.093624][ C1] ? rescuer_thread+0x1320/0x1320
[ 1978.093626][ C1] ? __kthread_parkme+0xbd/0x210
[ 1978.093629][ C1] ? rescuer_thread+0x1320/0x1320
[ 1978.093631][ C1] ? rescuer_thread+0x1320/0x1320
[ 1978.093633][ C1] kthread+0x367/0x460
[ 1978.093634][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160
[ 1978.093637][ C1] ? kthread_affine_node+0x330/0x330
[ 1978.093639][ C1] ret_from_fork+0x474/0x6b0
[ 1978.093644][ C1] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120
[ 1978.093647][ C1] ? __switch_to+0x5a3/0xe00
[ 1978.093649][ C1] ? kthread_affine_node+0x330/0x330
[ 1978.093651][ C1] ret_from_fork_asm+0x11/0x20
[ 1978.093659][ C1]
[ 1982.287650][T29602] br0: port 1(veth1) entered blocking state
[ 1982.288148][T29602] br0: port 1(veth1) entered disabled state
[ 1982.288309][T29602] veth1: entered allmulticast mode
[ 1982.289161][T29602] veth1: entered promiscuous mode
[ 1982.473397][T29607] br0: port 2(veth_segment) entered blocking state
[ 1982.473565][T29607] br0: port 2(veth_segment) entered disabled state
[ 1982.473727][T29607] veth_segment: entered allmulticast mode
[ 1982.474574][T29607] veth_segment: entered promiscuous mode
[ 1982.500487][T29608] br0: port 2(veth_segment) entered blocking state
[ 1982.500663][T29608] br0: port 2(veth_segment) entered forwarding state
[ 1982.501197][T29608] br0: port 1(veth1) entered blocking state
[ 1982.501346][T29608] br0: port 1(veth1) entered forwarding state
[ 1984.918608][T29624] iperf3 (29624) used greatest stack depth: 22352 bytes left
[ 1985.038028][ T12] br0: port 1(veth1) entered disabled state
[ 1985.048069][ T12] veth1 (unregistering): left allmulticast mode
[ 1985.048234][ T12] veth1 (unregistering): left promiscuous mode
[ 1985.048380][ T12] br0: port 1(veth1) entered disabled state
[ 1985.077436][ T12] veth_segment: left allmulticast mode
[ 1985.077668][ T12] veth_segment: left promiscuous mode
[ 1985.078005][ T12] br0: port 2(veth_segment) entered disabled state
[ 2001.019022][T30036] br0: port 1(veth1) entered blocking state
[ 2001.019245][T30036] br0: port 1(veth1) entered disabled state
[ 2001.019461][T30036] veth1: entered allmulticast mode
[ 2001.020387][T30036] veth1: entered promiscuous mode
[ 2001.195598][T30041] br0: port 2(veth_segment) entered blocking state
[ 2001.195808][T30041] br0: port 2(veth_segment) entered disabled state
[ 2001.196019][T30041] veth_segment: entered allmulticast mode
[ 2001.196908][T30041] veth_segment: entered promiscuous mode
[ 2001.223415][T30042] br0: port 2(veth_segment) entered blocking state
[ 2001.223586][T30042] br0: port 2(veth_segment) entered forwarding state
[ 2001.223863][T30042] br0: port 1(veth1) entered blocking state
[ 2001.224014][T30042] br0: port 1(veth1) entered forwarding state
[ 2003.482966][T30055] iperf3 (30055) used greatest stack depth: 21248 bytes left
[ 2003.614277][ T12] br0: port 1(veth1) entered disabled state
[ 2003.626090][ T12] veth1 (unregistering): left allmulticast mode
[ 2003.626262][ T12] veth1 (unregistering): left promiscuous mode
[ 2003.626407][ T12] br0: port 1(veth1) entered disabled state
[ 2003.653245][ T12] veth_segment: left allmulticast mode
[ 2003.653380][ T12] veth_segment: left promiscuous mode
[ 2003.653574][ T12] br0: port 2(veth_segment) entered disabled state