make -C tools/testing/selftests TARGETS=net/forwarding TEST_PROGS=dual_vxllan_bridge.sh TEST_GEN_PROGS="" run_tests
make: Entering directory '/home/virtme/testing-4/tools/testing/selftests'
make[1]: Entering directory '/home/virtme/testing-4/tools/testing/selftests/net/forwarding'
make[1]: Nothing to be done for 'all'.
make[1]: Leaving directory '/home/virtme/testing-4/tools/testing/selftests/net/forwarding'
make[1]: Entering directory '/home/virtme/testing-4/tools/testing/selftests/net/forwarding'
TAP version 13
1..1
# overriding timeout to 21600
# selftests: net/forwarding: dual_vxlan_bridge.sh
[ 27.316592][ T285] 8021q: 802.1Q VLAN Support v1.8
[ 32.671628][ T327] br1: port 1(vx100) entered blocking state
[ 32.672111][ T327] br1: port 1(vx100) entered disabled state
[ 32.672643][ T327] vx100: entered allmulticast mode
[ 32.674824][ T327] vx100: entered promiscuous mode
[ 32.675768][ T327] br1: port 1(vx100) entered blocking state
[ 32.676133][ T327] br1: port 1(vx100) entered forwarding state
[ 33.001832][ T329] br1: port 2(veth1) entered blocking state
[ 33.002186][ T329] br1: port 2(veth1) entered disabled state
[ 33.002568][ T329] veth1: entered allmulticast mode
[ 33.005646][ T329] veth1: entered promiscuous mode
[ 33.172475][ T23] br1: port 2(veth1) entered blocking state
[ 33.172888][ T23] br1: port 2(veth1) entered forwarding state
[ 33.363280][ C0] ------------[ cut here ]------------
[ 33.363865][ C0] UBSAN: invalid-load in ./include/linux/skbuff.h:4267:9
[ 33.364425][ C0] load of value 107 is not a valid value for type '_Bool'
[ 33.364960][ C0] CPU: 0 PID: 11 Comm: kworker/u8:0 Not tainted 6.8.0-rc4-virtme #1
[ 33.365587][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 33.366529][ C0] Workqueue: ipv6_addrconf addrconf_dad_work
[ 33.367018][ C0] Call Trace:
[ 33.367286][ C0]
[ 33.367510][ C0] dump_stack_lvl+0x92/0xb0
[ 33.367885][ C0] __ubsan_handle_load_invalid_value+0xa7/0xe0
[ 33.368379][ C0] br_forward_finish.cold+0xf/0x3c [bridge]
[ 33.368961][ C0] deliver_clone+0x52/0x90 [bridge]
[ 33.369450][ C0] br_handle_frame_finish+0xbdd/0x1ce0 [bridge]
[ 33.370024][ C0] ? __pfx_br_handle_frame_finish+0x10/0x10 [bridge]
[ 33.370678][ C0] br_handle_frame+0x612/0xe70
DETECTED CRASH, lowering timeout
[bridge]
[ 33.371176][ C0] ? __pfx_br_handle_frame+0x10/0x10 [bridge]
[ 33.371720][ C0] __netif_receive_skb_core.constprop.0+0x783/0x2dc0
[ 33.372258][ C0] ? mark_lock+0x38/0x3e0
[ 33.372623][ C0] ? __lock_acquire+0xb67/0x1610
[ 33.373020][ C0] ? __pfx___netif_receive_skb_core.constprop.0+0x10/0x10
[ 33.373586][ C0] ? lock_acquire.part.0+0xe5/0x330
[ 33.374008][ C0] ? process_backlog+0x1ed/0x5e0
[ 33.374410][ C0] __netif_receive_skb_one_core+0xaf/0x1b0
[ 33.374874][ C0] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 33.375381][ C0] ? lock_acquire+0x1c1/0x220
[ 33.375750][ C0] ? process_backlog+0x1ed/0x5e0
[ 33.376149][ C0] process_backlog+0xd3/0x5e0
[ 33.376535][ C0] __napi_poll.constprop.0+0xa2/0x460
[ 33.376950][ C0] net_rx_action+0x440/0xb40
[ 33.377311][ C0] ? _nohz_idle_balance.isra.0+0x44b/0x630
[ 33.377763][ C0] ? __pfx_net_rx_action+0x10/0x10
[ 33.378180][ C0] ? hlock_class+0x20/0x130
[ 33.378535][ C0] ? mark_held_locks+0xa5/0xf0
[ 33.378910][ C0] __do_softirq+0x1b9/0x7ff
[ 33.379290][ C0] ? __dev_queue_xmit+0x6cd/0x17e0
[ 33.379704][ C0] do_softirq+0x4d/0xa0
[ 33.380023][ C0]
[ 33.380248][ C0]
[ 33.380468][ C0] __local_bh_enable_ip+0xf6/0x120
[ 33.380845][ C0] ? __dev_queue_xmit+0x6cd/0x17e0
[ 33.381216][ C0] __dev_queue_xmit+0x6e2/0x17e0
[ 33.381592][ C0] ? mark_lock+0x38/0x3e0
[ 33.381952][ C0] ? mark_held_locks+0xa5/0xf0
[ 33.382305][ C0] ? eth_header+0x158/0x1a0
[ 33.382659][ C0] ? __pfx___dev_queue_xmit+0x10/0x10
[ 33.383078][ C0] ip6_finish_output2+0x4ab/0xf80
[ 33.383463][ C0] ip6_finish_output+0x4ed/0xd30
[ 33.383831][ C0] ? hlock_class+0x4e/0x130
[ 33.384179][ C0] ip6_output+0x1f3/0x770
[ 33.384509][ C0] ? __pfx_ip6_output+0x10/0x10
[ 33.384901][ C0] NF_HOOK.constprop.0+0xe2/0x680
[ 33.385300][ C0] ? __pfx_NF_HOOK.constprop.0+0x10/0x10
[ 33.385749][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 33.386192][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x1b1/0x370
[ 33.386715][ C0] ndisc_send_skb+0x8e0/0x1230
[ 33.387094][ C0] ? __pfx_ndisc_send_skb+0x10/0x10
[ 33.387528][ C0] ? hlock_class+0x4e/0x130
[ 33.387892][ C0] ? __lock_release+0x40f/0x880
[ 33.388277][ C0] ndisc_send_ns+0x9e/0x100
[ 33.388621][ C0] ? mark_lock+0x38/0x3e0
[ 33.388970][ C0] ? __pfx_ndisc_send_ns+0x10/0x10
[ 33.389367][ C0] ? mark_held_locks+0xa5/0xf0
[ 33.389759][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x1b1/0x370
[ 33.390274][ C0] addrconf_dad_work+0x7e2/0xab0
[ 33.390667][ C0] ? __pfx_addrconf_dad_work+0x10/0x10
[ 33.391100][ C0] ? lock_acquire+0x1c1/0x220
[ 33.391470][ C0] ? process_one_work+0x714/0x1310
[ 33.391892][ C0] process_one_work+0x78c/0x1310
[ 33.392292][ C0] ? hlock_class+0x4e/0x130
[ 33.392650][ C0] ? __pfx_process_one_work+0x10/0x10
[ 33.393089][ C0] ? assign_work+0x16c/0x240
[ 33.393466][ C0] worker_thread+0x73d/0x1010
[ 33.393874][ C0] ? __pfx_worker_thread+0x10/0x10
[ 33.394268][ C0] kthread+0x28f/0x360
[ 33.394592][ C0] ? __pfx_kthread+0x10/0x10
[ 33.394956][ C0] ret_from_fork+0x31/0x70
[ 33.395301][ C0] ? __pfx_kthread+0x10/0x10
[ 33.395669][ C0] ret_from_fork_asm+0x1b/0x30
[ 33.396078][ C0]
[ 33.396429][ C0] ---[ end trace ]---
[ 33.855019][ T335] br2: port 1(vx200) entered blocking state
[ 33.855384][ T335] br2: port 1(vx200) entered disabled state
[ 33.855744][ T335] vx200: entered allmulticast mode
[ 33.858905][ T335] vx200: entered promiscuous mode
[ 33.860172][ T335] br2: port 1(vx200) entered blocking state
[ 33.860502][ T335] br2: port 1(vx200) entered forwarding state
[ 34.300092][ T338] br2: port 2(veth2.20) entered blocking state
[ 34.300518][ T338] br2: port 2(veth2.20) entered disabled state
[ 34.300921][ T338] veth2.20: entered allmulticast mode
[ 34.303112][ T338] veth2.20: entered promiscuous mode
[ 34.482708][ T340] veth2: entered allmulticast mode
[ 34.483033][ T340] veth2: entered promiscuous mode
[ 34.484481][ T340] br2: port 2(veth2.20) entered blocking state
[ 34.484833][ T340] br2: port 2(veth2.20) entered forwarding state
[ 36.875278][ C3] ------------[ cut here ]------------
[ 36.875624][ C3] UBSAN: invalid-load in ./include/linux/skbuff.h:4267:9
[ 36.875987][ C3] load of value 107 is not a valid value for type '_Bool'
[ 36.876364][ C3] CPU: 3 PID: 0 Comm: swapper/3 Not tainted 6.8.0-rc4-virtme #1
[ 36.876770][ C3] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 36.877393][ C3] Call Trace:
[ 36.877568][ C3]
[ 36.877723][ C3] dump_stack_lvl+0x92/0xb0
[ 36.877968][ C3] __ubsan_handle_load_invalid_value+0xa7/0xe0
[ 36.878298][ C3] ip_forward_finish.cold+0x10/0x15
[ 36.878580][ C3] NF_HOOK.constprop.0+0x7e/0x320
[ 36.878879][ C3] ? __pfx_NF_HOOK.constprop.0+0x10/0x10
[ 36.879201][ C3] ? __netif_receive_skb_core.constprop.0+0x1707/0x2dc0
[ 36.879614][ C3] ? __xfrm_policy_check2.constprop.0+0x32/0x410
[ 36.879961][ C3] ? ip_forward+0x10e3/0x1a20
[ 36.880227][ C3] ? vrf_l3_rcv+0x3ee/0x520 [vrf]
[ 36.880530][ C3] ip_rcv+0x62f/0x740
[ 36.880743][ C3] ? __pfx_ip_rcv+0x10/0x10
[ 36.880987][ C3] ? lock_acquire.part.0+0xe5/0x330
[ 36.881261][ C3] ? process_backlog+0x1ed/0x5e0
[ 36.881523][ C3] ? __pfx_ip_rcv+0x10/0x10
[ 36.881760][ C3] __netif_receive_skb_one_core+0x166/0x1b0
[ 36.882105][ C3] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 36.882466][ C3] ? __pfx_do_raw_spin_trylock+0x10/0x10
[ 36.882796][ C3] ? lock_acquire+0x1c1/0x220
[ 36.883052][ C3] ? process_backlog+0x1ed/0x5e0
[ 36.883336][ C3] process_backlog+0xd3/0x5e0
[ 36.883616][ C3] __napi_poll.constprop.0+0xa2/0x460
[ 36.883943][ C3] net_rx_action+0x440/0xb40
[ 36.884215][ C3] ? __pfx_net_rx_action+0x10/0x10
[ 36.884501][ C3] __do_softirq+0x1b9/0x7ff
[ 36.884760][ C3] irq_exit_rcu+0x98/0xc0
[ 36.885024][ C3] sysvec_apic_timer_interrupt+0x75/0x80
[ 36.885317][ C3]
[ 36.885474][ C3]
[ 36.885631][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20
[ 36.885946][ C3] RIP: 0010:default_idle+0xf/0x20
[ 36.886234][ C3] Code: 4c 01 c7 4c 29 c2 e9 72 ff ff ff 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 f3 0f 1e fa 66 90 0f 00 2d 83 57 3f 00 fb f4 c3 cc cc cc cc 66 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90
[ 36.887278][ C3] RSP: 0018:ffffc9000015fdf8 EFLAGS: 00000242
[ 36.887626][ C3] RAX: 000000000007c479 RBX: 1ffff9200002bfc1 RCX: ffffffff83a6b532
[ 36.888094][ C3] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff81498376
[ 36.888519][ C3] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006bfeea4
[ 36.888937][ C3] R10: ffff888035ff7523 R11: ffff888035ffc348 R12: 0000000000000000
[ 36.889379][ C3] R13: ffff888001d1cc40 R14: dffffc0000000000 R15: 0000000000000000
[ 36.889794][ C3] ? ct_kernel_exit.constprop.0+0xc2/0xe0
[ 36.890113][ C3] ? cpuidle_idle_call+0x1f6/0x280
[ 36.890416][ C3] default_idle_call+0x69/0xa0
[ 36.890685][ C3] cpuidle_idle_call+0x1f6/0x280
[ 36.890944][ C3] ? __pfx_cpuidle_idle_call+0x10/0x10
[ 36.891237][ C3] ? tsc_verify_tsc_adjust+0x65/0x2b0
[ 36.891547][ C3] do_idle+0xfb/0x160
[ 36.891769][ C3] cpu_startup_entry+0x55/0x60
[ 36.892071][ C3] start_secondary+0x21c/0x2b0
[ 36.892336][ C3] ? __pfx_start_secondary+0x10/0x10
[ 36.892644][ C3] secondary_startup_64_no_verify+0x16d/0x17b
[ 36.893010][ C3]
[ 36.893185][ C3] ---[ end trace ]---
[ 38.922742][ C1] ------------[ cut here ]------------
[ 38.923157][ C1] UBSAN: invalid-load in ./include/linux/skbuff.h:4267:9
[ 38.923581][ C1] load of value 107 is not a valid value for type '_Bool'
[ 38.923977][ C1] CPU: 1 PID: 22 Comm: ksoftirqd/1 Not tainted 6.8.0-rc4-virtme #1
[ 38.924412][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 38.925083][ C1] Call Trace:
[ 38.925259][ C1]
[ 38.925425][ C1] dump_stack_lvl+0x92/0xb0
[ 38.925695][ C1] __ubsan_handle_load_invalid_value+0xa7/0xe0
[ 38.926052][ C1] skb_scrub_packet.cold+0x10/0x15
[ 38.926349][ C1] __dev_forward_skb2+0x332/0x650
[ 38.926621][ C1] veth_xmit+0x245/0x7c0 [veth]
[ 38.926888][ C1] ? __pfx_passthru_features_check+0x10/0x10
[ 38.927217][ C1] dev_hard_start_xmit+0x13d/0x570
[ 38.927496][ C1] __dev_queue_xmit+0xf6d/0x17e0
[ 38.927757][ C1] ? __pfx_do_raw_write_trylock+0x10/0x10
[ 38.928065][ C1] ? eth_header+0x158/0x1a0
[ 38.928306][ C1] ? __pfx___dev_queue_xmit+0x10/0x10
[ 38.928589][ C1] ? neigh_resolve_output+0x3ec/0x7a0
[ 38.928874][ C1] ? __neigh_update+0x5bc/0x2620
[ 38.929138][ C1] __neigh_update+0x6a6/0x2620
[ 38.929407][ C1] arp_process+0x7f2/0x2150
[ 38.929655][ C1] ? __pfx_arp_process+0x10/0x10
[ 38.929926][ C1] ? lock_acquire.part.0+0xe5/0x330
[ 38.930202][ C1] ? __pfx_arp_rcv+0x10/0x10
[ 38.930445][ C1] __netif_receive_skb_one_core+0x16b/0x1b0
[ 38.930754][ C1] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 38.931083][ C1] ? __pfx_do_raw_spin_trylock+0x10/0x10
[ 38.931381][ C1] ? lock_acquire+0x1c1/0x220
[ 38.931626][ C1] ? process_backlog+0x1ed/0x5e0
[ 38.931914][ C1] process_backlog+0xd3/0x5e0
[ 38.932204][ C1] __napi_poll.constprop.0+0xa2/0x460
[ 38.932518][ C1] net_rx_action+0x440/0xb40
[ 38.932801][ C1] ? __pfx_net_rx_action+0x10/0x10
[ 38.933096][ C1] ? __pfx___schedule+0x10/0x10
[ 38.933360][ C1] ? __pfx___lock_release+0x10/0x10
[ 38.933666][ C1] __do_softirq+0x1b9/0x7ff
[ 38.933936][ C1] ? __pfx_run_ksoftirqd+0x10/0x10
[ 38.934229][ C1] run_ksoftirqd+0x2e/0x60
[ 38.934478][ C1] smpboot_thread_fn+0x30b/0x840
[ 38.934747][ C1] ? __pfx_smpboot_thread_fn+0x10/0x10
[ 38.935050][ C1] ? __pfx_smpboot_thread_fn+0x10/0x10
[ 38.935362][ C1] kthread+0x28f/0x360
[ 38.935599][ C1] ? __pfx_kthread+0x10/0x10
[ 38.935854][ C1] ret_from_fork+0x31/0x70
[ 38.936109][ C1] ? __pfx_kthread+0x10/0x10
[ 38.936352][ C1] ret_from_fork_asm+0x1b/0x30
[ 38.936667][ C1]
[ 38.936856][ C1] ---[ end trace ]---
[ 39.674469][ T379] br3: port 1(w1) entered blocking state
[ 39.674811][ T379] br3: port 1(w1) entered disabled state
[ 39.675155][ T379] w1: entered allmulticast mode
[ 39.677266][ T379] w1: entered promiscuous mode
[ 40.666063][ T386] br3: port 2(vx100) entered blocking state
[ 40.666432][ T386] br3: port 2(vx100) entered disabled state
[ 40.666807][ T386] vx100: entered allmulticast mode
[ 40.670190][ T386] vx100: entered promiscuous mode
[ 40.671134][ T386] br3: port 2(vx100) entered blocking state
[ 40.671469][ T386] br3: port 2(vx100) entered forwarding state
[ 41.899425][ T23] br3: port 1(w1) entered blocking state
[ 41.900032][ T23] br3: port 1(w1) entered forwarding state
[ 46.162254][ T424] br3: port 1(w1) entered blocking state
[ 46.162629][ T424] br3: port 1(w1) entered disabled state
[ 46.162997][ T424] w1: entered allmulticast mode
[ 46.165170][ T424] w1: entered promiscuous mode
[ 47.113920][ T430] br3: port 2(vx200) entered blocking state
[ 47.114270][ T430] br3: port 2(vx200) entered disabled state
[ 47.114693][ T430] vx200: entered allmulticast mode
[ 47.116870][ T430] vx200: entered promiscuous mode
[ 47.118613][ T430] br3: port 2(vx200) entered blocking state
[ 47.118941][ T430] br3: port 2(vx200) entered forwarding state
[ 48.224765][ T28] br3: port 1(w1) entered blocking state
[ 48.225126][ T28] br3: port 1(w1) entered forwarding state
[ 51.165770][ T459] br3: port 3(w1.20) entered blocking state
[ 51.166123][ T459] br3: port 3(w1.20) entered disabled state
[ 51.166497][ T459] w1.20: entered allmulticast mode
[ 51.168571][ T459] w1.20: entered promiscuous mode
[ 52.099996][ T467] br3: port 3(w1.20) entered blocking state
[ 52.100364][ T467] br3: port 3(w1.20) entered forwarding state
# Running tests with UDP port 4789
# TEST: ping: local->remote 1 through VxLAN with an 802.1ad bridge [ OK ]
# TEST: ping: local->remote 2 through VxLAN with an 802.1d bridge [ OK ]
[ 64.161500][ T11] w1.20: left allmulticast mode
[ 64.161864][ T11] w1.20: left promiscuous mode
[ 64.162480][ T11] br3: port 3(w1.20) entered disabled state
[ 64.165657][ T11] vx200: left allmulticast mode
[ 64.165953][ T11] vx200: left promiscuous mode
[ 64.166439][ T11] br3: port 2(vx200) entered disabled state
[ 64.168932][ T11] w1: left allmulticast mode
[ 64.169272][ T11] w1: left promiscuous mode
[ 64.169696][ T11] br3: port 1(w1) entered disabled state
[ 64.634195][ T11] vx100: left allmulticast mode
[ 64.634565][ T11] vx100: left promiscuous mode
[ 64.635038][ T11] br3: port 2(vx100) entered disabled state
[ 64.638077][ T11] w1: left allmulticast mode
[ 64.638384][ T11] w1: left promiscuous mode
[ 64.638858][ T11] br3: port 1(w1) entered disabled state
[ 67.615551][ T546] vx200: left allmulticast mode
[ 67.615860][ T546] vx200: left promiscuous mode
[ 67.616273][ T546] br2: port 1(vx200) entered disabled state
[ 68.122738][ T549] veth2: left allmulticast mode
[ 68.123041][ T549] veth2: left promiscuous mode
[ 68.125144][ T549] br2: port 2(veth2.20) entered disabled state
[ 68.126820][ T549] veth2.20 (unregistering): left allmulticast mode
[ 68.127179][ T549] veth2.20 (unregistering): left promiscuous mode
[ 68.127536][ T549] br2: port 2(veth2.20) entered disabled state
[ 68.772123][ T553] br1: port 2(veth1) entered disabled state
[ 68.920037][ T554] veth1: left allmulticast mode
[ 68.920356][ T554] veth1: left promiscuous mode
[ 68.920753][ T554] br1: port 2(veth1) entered disabled state
[ 69.086810][ T555] vx100: left allmulticast mode
[ 69.087114][ T555] vx100: left promiscuous mode
[ 69.087528][ T555] br1: port 1(vx100) entered disabled state
ok 1 selftests: net/forwarding: dual_vxlan_bridge.sh
make[1]: Leaving directory '/home/virtme/testing-4/tools/testing/selftests/net/forwarding'
make: Leaving directory '/home/virtme/testing-4/tools/testing/selftests'
xx__-> echo $?
0
xx__->