make -C tools/testing/selftests TARGETS=net TEST_PROGS=test_bridge_backup__port.sh TEST_GEN_PROGS="" run_tests
make: Entering directory '/home/virtme/testing-3/tools/testing/selftests'
make[1]: Entering directory '/home/virtme/testing-3/tools/testing/selftests/net'
make[1]: Nothing to be done for 'all'.
make[1]: Leaving directory '/home/virtme/testing-3/tools/testing/selftests/net'
make[1]: Entering directory '/home/virtme/testing-3/tools/testing/selftests/net'
TAP version 13
1..1
# timeout set to 6000
# selftests: net: test_bridge_backup_port.sh
[ 25.017099][ T253] ip (253) used greatest stack depth: 23880 bytes left
[ 25.157676][ T258] veth0: renamed from veth1
[ 26.808261][ T275] br0: port 1(swp1) entered blocking state
[ 26.809097][ T275] br0: port 1(swp1) entered disabled state
[ 26.809467][ T275] swp1: entered allmulticast mode
[ 26.810854][ T275] swp1: entered promiscuous mode
[ 26.819923][ T275] br0: port 1(swp1) entered blocking state
[ 26.820315][ T275] br0: port 1(swp1) entered forwarding state
[ 27.417558][ T277] br0: port 2(vx0) entered blocking state
[ 27.417898][ T277] br0: port 2(vx0) entered disabled state
[ 27.418223][ T277] vx0: entered allmulticast mode
[ 27.419603][ T277] vx0: entered promiscuous mode
[ 27.420442][ T277] br0: port 2(vx0) entered blocking state
[ 27.420751][ T277] br0: port 2(vx0) entered forwarding state
[ 29.494259][ T292] br0: port 1(swp1) entered blocking state
[ 29.495354][ T292] br0: port 1(swp1) entered disabled state
[ 29.495783][ T292] swp1: entered allmulticast mode
[ 29.497131][ T292] swp1: entered promiscuous mode
[ 29.498971][ T292] br0: port 1(swp1) entered blocking state
[ 29.499303][ T292] br0: port 1(swp1) entered forwarding state
[ 29.837842][ T294] br0: port 2(vx0) entered blocking state
[ 29.838176][ T294] br0: port 2(vx0) entered disabled state
[ 29.838512][ T294] vx0: entered allmulticast mode
[ 29.839819][ T294] vx0: entered promiscuous mode
[ 29.840727][ T294] br0: port 2(vx0) entered blocking state
[ 29.841043][ T294] br0: port 2(vx0) entered forwarding state
#
# Backup port
# -----------
[ 36.298994][ T307] GACT probability NOT on
# TEST: Forwarding out of swp1 [ OK ]
# TEST: No forwarding out of vx0 [ OK ]
[ 38.249423][ T49] br0: port 1(swp1) entered disabled state
# TEST: swp1 carrier off [ OK ]
# TEST: No forwarding out of swp1 [ OK ]
# TEST: No forwarding out of vx0 [ OK ]
[ 39.530112][ T49] br0: port 1(swp1) entered blocking state
[ 39.530479][ T49] br0: port 1(swp1) entered forwarding state
# TEST: swp1 carrier on [ OK ]
# TEST: vx0 configured as backup port of swp1 [ OK ]
# TEST: Forwarding out of swp1 [ OK ]
# TEST: No forwarding out of vx0 [ OK ]
[ 41.133739][ T8] br0: port 1(swp1) entered disabled state
# TEST: swp1 carrier off [ OK ]
# TEST: No forwarding out of swp1 [ OK ]
# TEST: Forwarding out of vx0 [ OK ]
[ 42.371373][ T50] br0: port 1(swp1) entered blocking state
[ 42.371751][ T50] br0: port 1(swp1) entered forwarding state
# TEST: swp1 carrier on [ OK ]
# TEST: Forwarding out of swp1 [ OK ]
# TEST: No forwarding out of vx0 [ OK ]
# TEST: vx0 not configured as backup port of swp1 [ OK ]
# TEST: Forwarding out of swp1 [ OK ]
# TEST: No forwarding out of vx0 [ OK ]
[ 45.088845][ T8] br0: port 1(swp1) entered disabled state
# TEST: swp1 carrier off [ OK ]
# TEST: No forwarding out of swp1 [ OK ]
# TEST: No forwarding out of vx0 [ OK ]
[ 46.349554][ T71] vx0: left allmulticast mode
[ 46.349872][ T71] vx0: left promiscuous mode
[ 46.350304][ T71] br0: port 2(vx0) entered disabled state
[ 46.359584][ T71] swp1: left allmulticast mode
[ 46.359882][ T71] swp1: left promiscuous mode
[ 46.360308][ T71] br0: port 1(swp1) entered disabled state
[ 46.451133][ T71] ==================================================================
[ 46.451625][ T71] BUG: KASAN: use-after-free in vxlan_netdevice_event+0x32f/0x340 [vxlan]
[ 46.452133][ T71] Read of size 8 at addr ffff888006c28bf0 by task kworker/u8:1/71
[ 46.452570][ T71]
[ 46.452695][ T71] CPU: 1 PID: 71 Comm: kworker/u8:1 Not tainted 6.8.0-rc2-virtme #1
[ 46.453117][ T71] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 46.453799][ T71] Workqueue: netns cleanup_net
[ 46.454072][ T71] Call Trace:
[ 46.454254][ T71]
[ 46.454415][ T71] dump_stack_lvl+0x64/0xb0
[ 46.454656][ T71] print_address_description.constprop.0+0x2c/0x3b0
[ 46.455021][ T71] ? vxlan_netdevice_event+0x32f/0x340 [vxlan]
[ 46.455379][ T71] print_report+0xb5/0x270
[ 46.455634][ T71] ? kasan_addr_to_slab+0x4e/0x90
[ 46.455896][ T71] kasan_report+0xbe/0xf0
[ 46.456129][ T71] ? vxlan_netdevice_event+0x32f/0x340 [vxlan]
[ 46.456460][ T71] vxlan_netdevice_event+0x32f/0x340 [vxlan]
[ 46.456781][ T71] ? __pfx_vxlan_netdevice_event+0x10/0x10 [vxlan]
[ 46.457146][ T71] ? netconsole_netdev_event+0x1b4/0x300
[ 46.457441][ T71] notifier_call_chain+0x9a/0x290
[ 46.457716][ T71] unregister_netdevice_many_notify+0x55a/0x1180
[ 46.458045][ T71] ? mutex_is_locked+0x17/0x50
[ 46.458295][ T71] ? __pfx_unregister_netdevice_many_notify+0x10/0x10
[ 46.458641][ T71] ? __pfx_unregister_netdevice_queue+0x10/0x10
[ 46.458966][ T71] default_device_exit_batch+0x228/0x2c0
[ 46.459259][ T71] ? __pfx_default_device_exit_batch+0x10/0x10
[ 46.459577][ T71] ? mutex_is_locked+0x17/0x50
[ 46.459823][ T71] ? nexthop_net_exit_batch_rtnl+0x83/0x210
[ 46.460130][ T71] cleanup_net+0x4f3/0xb50
[ 46.460363][ T71] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 46.460653][ T71] ? __pfx_cleanup_net+0x10/0x10
[ 46.460910][ T71] ? lock_acquire+0x1c1/0x220
[ 46.461154][ T71] ? process_one_work+0x714/0x1310
[ 46.461422][ T71] process_one_work+0x78c/0x1310
[ 46.461679][ T71] ? hlock_class+0x4e/0x130
[ 46.461915][ T71] ? __pfx_process_one_work+0x10/0x10
[ 46.462196][ T71] ? assign_work+0x16c/0x240
[ 46.462458][ T71] worker_thread+0x73d/0x1010
[ 46.462718][ T71] ? lockdep_hardirqs_on_prepare.part.0+0x1b1/0x370
[ 46.463074][ T71] ? __pfx_worker_thread+0x10/0x10
[ 46.463368][ T71] ? __pfx_worker_thread+0x10/0x10
[ 46.463644][ T71] kthread+0x28f/0x360
[ 46.463863][ T71] ? __pfx_kthread+0x10/0x10
[ 46.464110][ T71] ret_from_fork+0x31/0x70
[ 46.464365][ T71] ? __pfx_kthread+0x10/0x10
[ 46.464604][ T71] ret_from_fork_asm+0x1b/0x30
[ 46.464887][ T71]
[ 46.465047][ T71]
[ 46.465189][ T71] The buggy address belongs to the physical page:
[ 46.465527][ T71] page:ffffea00001b0a00 refcount:0 mapcount:0 mapping:0000000000000000 index:0x0 pfn:0x6c28
[ 46.466081][ T71] flags: 0x80000000000000(node=0|zone=1)
[ 46.466381][ T71] page_type: 0xffffffff()
[ 46.466616][ T71] raw: 0080000000000000 ffffea0000207808 ffff888035801c38 0000000000000000
[ 46.467076][ T71] raw: 0000000000000000 0000000000000000 00000000ffffffff 0000000000000000
[ 46.467555][ T71] page dumped because: kasan: bad access detected
[ 46.467914][ T71]
[ 46.468039][ T71] Memory state around the buggy address:
[ 46.468350][ T71] ffff888006c28a80: ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
[ 46.468778][ T71] ffff888006c28b00: ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
[ 46.469230][ T71] >ffff888006c28b80: ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
[ 46.469670][ T71] ^
[ 46.470096][ T71] ffff888006c28c00: ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
[ 46.470529][ T71] ffff888006c28c80: ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
[ 46.470960][ T71] ==================================================================
[ 46.471421][ T71] Disabling lock debugging due to kernel taint
[ 46.753374][ T71] vx0: left allmulticast mode
[ 46.753645][ T71] vx0: left promiscuous mode
[ 46.754003][ T71] br0: port 2(vx0) entered disabled state
[ 46.768942][ T71] swp1: left allmulticast mode
[ 46.769204][ T71] swp1: left promiscuous mode
[ 46.769577][ T71] br0: port 1(swp1) entered disabled state
[ 50.360941][ T434] veth0: renamed from veth1
[ 51.673051][ T453] br0: port 1(swp1) entered blocking state
[ 51.673396][ T453] br0: port 1(swp1) entered disabled state
[ 51.673728][ T453] swp1: entered allmulticast mode
[ 51.674815][ T453] swp1: entered promiscuous mode
[ 51.676597][ T453] br0: port 1(swp1) entered blocking state
[ 51.676922][ T453] br0: port 1(swp1) entered forwarding state
[ 51.928892][ T455] br0: port 2(vx0) entered blocking state
[ 51.929244][ T455] br0: port 2(vx0) entered disabled state
[ 51.929589][ T455] vx0: entered allmulticast mode
[ 51.930667][ T455] vx0: entered promiscuous mode
[ 51.931278][ T455] br0: port 2(vx0) entered blocking state
[ 51.931593][ T455] br0: port 2(vx0) entered forwarding state
[ 53.602283][ T468] br0: port 1(swp1) entered blocking state
[ 53.602630][ T468] br0: port 1(swp1) entered disabled state
[ 53.602963][ T468] swp1: entered allmulticast mode
[ 53.604019][ T468] swp1: entered promiscuous mode
[ 53.605808][ T468] br0: port 1(swp1) entered blocking state
[ 53.606119][ T468] br0: port 1(swp1) entered forwarding state
[ 53.849871][ T470] br0: port 2(vx0) entered blocking state
[ 53.850199][ T470] br0: port 2(vx0) entered disabled state
[ 53.850975][ T470] vx0: entered allmulticast mode
[ 53.852001][ T470] vx0: entered promiscuous mode
[ 53.852578][ T470] br0: port 2(vx0) entered blocking state
[ 53.852876][ T470] br0: port 2(vx0) entered forwarding state
#
# Backup nexthop ID
# -----------------
# TEST: vx0 configured as backup port of swp1 [ OK ]
# TEST: Forwarding out of swp1 [ OK ]
# TEST: No forwarding out of vx0 [ OK ]
[ 62.507264][ T49] br0: port 1(swp1) entered disabled state
# TEST: swp1 carrier off [ OK ]
# TEST: No forwarding out of swp1 [ OK ]
# TEST: Forwarding out of vx0 [ OK ]
# TEST: No forwarding using backup nexthop ID [ OK ]
# TEST: Forwarding using VXLAN FDB entry [ OK ]
[ 64.191983][ T278] br0: port 1(swp1) entered blocking state
[ 64.192347][ T278] br0: port 1(swp1) entered forwarding state
# TEST: swp1 carrier on [ OK ]
# TEST: nexthop ID 10 configured as backup nexthop ID of swp1 [ OK ]
# TEST: Forwarding out of swp1 [ OK ]
# TEST: No forwarding out of vx0 [ OK ]
[ 65.553853][ T50] br0: port 1(swp1) entered disabled state
# TEST: swp1 carrier off [ OK ]
# TEST: No forwarding out of swp1 [ OK ]
# TEST: Forwarding out of vx0 [ OK ]
# TEST: Forwarding using backup nexthop ID [ OK ]
# TEST: No forwarding using VXLAN FDB entry [ OK ]
[ 67.389221][ T278] br0: port 1(swp1) entered blocking state
[ 67.389584][ T278] br0: port 1(swp1) entered forwarding state
# TEST: swp1 carrier on [ OK ]
# TEST: Forwarding out of swp1 [ OK ]
# TEST: No forwarding out of vx0 [ OK ]
# TEST: No forwarding using backup nexthop ID [ OK ]
# TEST: No forwarding using VXLAN FDB entry [ OK ]
# TEST: No backup nexthop ID configured for swp1 [ OK ]
# TEST: Forwarding out of swp1 [ OK ]
# TEST: No forwarding out of vx0 [ OK ]
# TEST: No forwarding using backup nexthop ID [ OK ]
# TEST: No forwarding using VXLAN FDB entry [ OK ]
[ 70.983524][ T430] br0: port 1(swp1) entered disabled state
# TEST: swp1 carrier off [ OK ]
# TEST: No forwarding out of swp1 [ OK ]
# TEST: Forwarding out of vx0 [ OK ]
# TEST: No forwarding using backup nexthop ID [ OK ]
# TEST: Forwarding using VXLAN FDB entry [ OK ]
[ 72.803435][ T71] vx0: left allmulticast mode
[ 72.803718][ T71] vx0: left promiscuous mode
[ 72.804076][ T71] br0: port 2(vx0) entered disabled state
[ 72.816933][ T71] swp1: left allmulticast mode
[ 72.817206][ T71] swp1: left promiscuous mode
[ 72.817572][ T71] br0: port 1(swp1) entered disabled state
[ 72.905255][ T71] general protection fault, probably for non-canonical address 0xed6d696d6d6d6d6d: 0000 [#1] PREEMPT SMP KASAN NOPTI
[ 72.905911][ T71] KASAN: maybe wild-memory-access in range [0x6b6b6b6b6b6b6b68-0x6b6b6b6b6b6b6b6f]
[ 72.906395][ T71] CPU: 2 PID: 71 Comm: kworker/u8:1 Tainted: G B 6.8.0-rc2-virtme #1
[ 72.906906][ T71] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 72.907686][ T71] Workqueue: netns cleanup_net
[ 72.907953][ T71] RIP: 0010:vxlan_netdevice_event+0x19e/0x340 [vxlan]
[ 72.908351][ T71] Code: 00 00 00 48 b9 00 00 00 00 00 fc ff df 49 89 c0 48 89 44 24 08 49 c1 e8 03 4d 8d 24 08 eb 2c 48 8d 53 30 48 89 d0 48 c1 e8 03 <80> 3c 08 00 0f 85 e0 00 00 00 48 8b 43 30 49 89 dd 48 83 e8 30 49
[ 72.909497][ T71] RSP: 0018:ffffc9000051f980 EFLAGS: 00010202
[ 72.909840][ T71] RAX: 0d6d6d6d6d6d6d6d RBX: 6b6b6b6b6b6b6b3b RCX: dffffc0000000000
[ 72.910297][ T71] RDX: 6b6b6b6b6b6b6b6b RSI: 0000000000000004 RDI: ffff888007770c44
[ 72.910724][ T71] RBP: 1ffff920000a3f33 R08: 1ffff11000d4f81a R09: ffffc9000051f9b8
[ 72.911133][ T71] R10: ffffffffaff50f57 R11: ffff888006a7c000 R12: ffffed1000d4f81a
[ 72.911546][ T71] R13: ffff888007770bc0 R14: ffff888006a74000 R15: ffff888006a7c000
[ 72.911952][ T71] FS: 0000000000000000(0000) GS:ffff888035a00000(0000) knlGS:0000000000000000
[ 72.912410][ T71] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 72.912756][ T71] CR2: 00007fb2f3420d40 CR3: 0000000011934001 CR4: 0000000000770ef0
[ 72.913209][ T71] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 72.913663][ T71] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[ 72.914116][ T71] PKRU: 55555554
[ 72.914303][ T71] Call Trace:
[ 72.914479][ T71]
[ 72.914639][ T71] ? die_addr+0x41/0xa0
[ 72.914858][ T71] ? exc_general_protection+0x149/0x220
[ 72.915155][ T71] ? asm_exc_general_protection+0x26/0x30
[ 72.915455][ T71] ? vxlan_netdevice_event+0x19e/0x340 [vxlan]
[ 72.915792][ T71] ? __pfx_vxlan_netdevice_event+0x10/0x10 [vxlan]
[ 72.916139][ T71] ? netconsole_netdev_event+0x1b4/0x300
[ 72.916436][ T71] ? addrconf_notify+0xd1/0xd40
[ 72.916697][ T71] notifier_call_chain+0x9a/0x290
[ 72.916977][ T71] unregister_netdevice_many_notify+0x55a/0x1180
[ 72.917309][ T71] ? mutex_is_locked+0x17/0x50
[ 72.917596][ T71] ? __pfx_unregister_netdevice_many_notify+0x10/0x10
[ 72.918003][ T71] ? __pfx_unregister_netdevice_queue+0x10/0x10
[ 72.918348][ T71] ? __wake_up+0x44/0x60
[ 72.918602][ T71] default_device_exit_batch+0x228/0x2c0
[ 72.918924][ T71] ? __pfx_default_device_exit_batch+0x10/0x10
[ 72.919280][ T71] ? nexthop_net_exit_batch_rtnl+0x128/0x210
[ 72.919635][ T71] cleanup_net+0x4f3/0xb50
[ 72.919883][ T71] ? lock_acquire+0x1c1/0x220
[ 72.920137][ T71] ? __pfx_cleanup_net+0x10/0x10
[ 72.920444][ T71] ? lock_acquire+0x1c1/0x220
[ 72.920741][ T71] ? process_one_work+0x714/0x1310
[ 72.921037][ T71] process_one_work+0x78c/0x1310
[ 72.921317][ T71] ? hlock_class+0x4e/0x130
[ 72.921556][ T71] ? __pfx_process_one_work+0x10/0x10
[ 72.921836][ T71] ? assign_work+0x16c/0x240
[ 72.922077][ T71] worker_thread+0x73d/0x1010
[ 72.922321][ T71] ? lockdep_hardirqs_on_prepare.part.0+0x1b1/0x370
[ 72.922664][ T71] ? __pfx_worker_thread+0x10/0x10
[ 72.922930][ T71] ? __pfx_worker_thread+0x10/0x10
[ 72.923196][ T71] kthread+0x28f/0x360
[ 72.923410][ T71] ? __pfx_kthread+0x10/0x10
[ 72.923651][ T71] ret_from_fork+0x31/0x70
[ 72.923918][ T71] ? __pfx_kthread+0x10/0x10
[ 72.924173][ T71] ret_from_fork_asm+0x1b/0x30
[ 72.924464][ T71]
[ 72.924645][ T71] Modules linked in: act_gact cls_flower sch_ingress vxlan ip6_udp_tunnel udp_tunnel
[ 72.925193][ T71] ---[ end trace 0000000000000000 ]---
[ 72.925780][ T71] RIP: 0010:vxlan_netdevice_event+0x19e/0x340 [vxlan]
[ 72.926182][ T71] Code: 00 00 00 48 b9 00 00 00 00 00 fc ff df 49 89 c0 48 89 44 24 08 49 c1 e8 03 4d 8d 24 08 eb 2c 48 8d 53 30 48 89 d0 48 c1 e8 03 <80> 3c 08 00 0f 85 e0 00 00 00 48 8b 43 30 49 89 dd 48 83 e8 30 49
[ 72.927261][ T71] RSP: 0018:ffffc9000051f980 EFLAGS: 00010202
[ 72.927582][ T71] RAX: 0d6d6d6d6d6d6d6d RBX: 6b6b6b6b6b6b6b3b RCX: dffffc0000000000
[ 72.927994][ T71] RDX: 6b6b6b6b6b6b6b6b RSI: 0000000000000004 RDI: ffff888007770c44
[ 72.928408][ T71] RBP: 1ffff920000a3f33 R08: 1ffff11000d4f81a R09: ffffc9000051f9b8
[ 72.928817][ T71] R10: ffffffffaff50f57 R11: ffff888006a7c000 R12: ffffed1000d4f81a
[ 72.929230][ T71] R13: ffff888007770bc0 R14: ffff888006a74000 R15: ffff888006a7c000
[ 72.929640][ T71] FS: 0000000000000000(0000) GS:ffff888035a00000(0000) knlGS:0000000000000000
[ 72.930096][ T71] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 72.930448][ T71] CR2: 00007fb2f3420d40 CR3: 0000000011934001 CR4: 0000000000770ef0
[ 72.930859][ T71] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 72.931272][ T71] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[ 72.931725][ T71] PKRU: 55555554
[ 72.931929][ T71] Kernel panic - not syncing: Fatal exception
[ 72.932355][ T71] Kernel Offset: 0x2a600000 from 0xffffffff81000000 (relocation range: 0xffffffff80000000-0xffffffffbfffffff)
[ 72.932946][ T71] ---[ end Kernel panic - not syncing: Fatal exception ]---
WAIT TIMEOUT stdout
Ctrl-C stdout
Ctrl-C stdout
WAIT TIMEOUT stdout