2214979 – [ovs bond]change bond-primary didn't effect original traffic

Bug 2214979 - [ovs bond]change bond-primary didn't effect original traffic

Summary: [ovs bond]change bond-primary didn't effect original traffic

Keywords:
Status:	ASSIGNED
Alias:	None
Product:	Red Hat Enterprise Linux Fast Datapath
Classification:	Red Hat
Component:	openvswitch
Sub Component:
Version:	RHEL 9.0
Hardware:	x86_64
OS:	Linux
Priority:	unspecified
Severity:	high
Target Milestone:	---
Target Release:	---
Assignee:	Mike Pattrick
QA Contact:	mhou
Docs Contact:
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+	depends on / blocked

Reported:	2023-06-14 10:28 UTC by mhou
Modified:	2023-08-10 03:54 UTC (History)
CC List:	5 users (show)
Fixed In Version:
Doc Type:	If docs needed, set a value
Doc Text:
Clone Of:
Environment:
Last Closed:
Target Upstream Version:
Embargoed:

Attachments	(Terms of Use)

Links
System	ID	Private	Priority	Status	Summary	Last Updated
Red Hat Issue Tracker	FD-2946	0	None	None	None	2023-06-14 10:29:57 UTC

Description mhou 2023-06-14 10:28:32 UTC

Description of problem:
create a active-backup and set bond-primary to a slave interface, then use a guest to ping peer side. In this time, change bond-primary to other slave port. check the ping traffic still load on original port.

Version-Release number of selected component (if applicable):
kernel version: 5.14.0-318.el9.x86_64
ovs version: openvswitch3.1-3.1.0-24.el9fdp.x86_64

nic info:
# ethtool -i ens4f0
driver: i40e
version: 5.14.0-318.el9.x86_64
firmware-version: 9.20 0x8000d89c 1.3353.0
expansion-rom-version: 
bus-info: 0000:af:00.0
supports-statistics: yes
supports-test: yes
supports-eeprom-access: yes
supports-register-dump: yes
supports-priv-flags: yes

How reproducible:100%


Steps to Reproduce:
1. create kernel pf bond port on ovs bridge
systemctl restart openvswitch
ovs-appctl vlog/set console:lacp:dbg syslog:lacp:dbg file:lacp:dbg
ovs-appctl vlog/set console:bond:dbg syslog:bond:dbg file:bond:dbg
ovs-appctl vlog/set console:ovs_rcu:dbg syslog:ovs_rcu:dbg file:ovs_rcu:dbg
ovs-appctl vlog/set console:memory:dbg syslog:memory:dbg file:memory:dbg
ovs-vsctl set Open_vSwitch . other_config={}
ovs-vsctl --if-exists del-br bondbridge
ovs-vsctl --may-exist add-br bondbridge
ovs-vsctl set int bondbridge mtu_request=9000
ovs-ofctl mod-port bondbridge bondbridge up
ovs-vsctl add-bond bondbridge active-backup ens4f0 ens4f1 lacp=passive bond_mode=active-backup  \
-- set Interface ens4f0 mtu_request=9000  \
-- set Interface ens4f1 mtu_request=9000  \
-- set Port active-backup  bond-downdelay=10000 bond-updelay=10000 other_config:bond-primary=ens4f0
ovs-ofctl mod-port bondbridge ens4f0 up
ovs-ofctl mod-port bondbridge ens4f1 up
# ovs-vsctl show
217c7fca-7324-40cc-8815-e44ab4c01bb3
    Bridge bondbridge
        Port active-backup
            Interface ens4f1
            Interface ens4f0
        Port patchbond
            Interface patchbond
                type: patch
                options: {peer=patchguest}
        Port bondbridge
            Interface bondbridge
                type: internal
# ovs-appctl bond/show
---- active-backup ----
bond_mode: active-backup
bond may use recirculation: no, Recirc-ID : -1
bond-hash-basis: 0
lb_output action: disabled, bond-id: -1
updelay: 0 ms
downdelay: 0 ms
lacp_status: off
lacp_fallback_ab: false
active-backup primary: ens4f0
active member mac: 3c:fd:fe:bd:1c:a4(ens4f0)

member ens4f0: enabled
  active member
  may_enable: true

member ens4f1: enabled
  may_enable: true


2. add three guest on ovs bridge
# ovs-vsctl show
217c7fca-7324-40cc-8815-e44ab4c01bb3
    Bridge bondbridge
        Port active-backup
            Interface ens4f1
            Interface ens4f0
        Port patchbond
            Interface patchbond
                type: patch
                options: {peer=patchguest}
        Port bondbridge
            Interface bondbridge
                type: internal
    Bridge guestbridge
        Port c115425c08134_l
            Interface c115425c08134_l
        Port "58060b49b0834_l"
            Interface "58060b49b0834_l"
        Port guestbridge
            Interface guestbridge
                type: internal
        Port patchguest
            Interface patchguest
                type: patch
                options: {peer=patchbond}
        Port d7135be5934c4_l
            Interface d7135be5934c4_l
    ovs_version: "3.1.2"

3. select one guest to ping peer side
# podman exec g1 ping 172.31.150.1
PING 172.31.150.1 (172.31.150.1) 56(84) bytes of data.
64 bytes from 172.31.150.1: icmp_seq=1 ttl=64 time=0.039 ms
64 bytes from 172.31.150.1: icmp_seq=2 ttl=64 time=0.050 ms
64 bytes from 172.31.150.1: icmp_seq=3 ttl=64 time=0.045 ms

4. check current traffic host on ens4f0
# ovs-appctl dpctl/dump-flows -m
ufid:86b9c011-06c0-4085-a0ea-057d06f57241, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(ens4f0),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=40:a6:b7:3e:a5:60,dst=00:de:ad:96:02:02),eth_type(0x0800),ipv4(src=0.0.0.0/0.0.0.0,dst=0.0.0.0/0.0.0.0,proto=0/0,tos=0/0,ttl=0/0,frag=no), packets:433, bytes:42434, used:0.227s, dp:ovs, actions:58060b49b0834_l
ufid:6bee556a-5661-4e5f-8ba2-6ed9d04a3b07, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(58060b49b0834_l),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:02,dst=40:a6:b7:3e:a5:60),eth_type(0x0800),ipv4(src=0.0.0.0/0.0.0.0,dst=0.0.0.0/0.0.0.0,proto=0/0,tos=0/0,ttl=0/0,frag=no), packets:433, bytes:42434, used:0.227s, dp:ovs, actions:ens4f0

5. change primary interface from ens4f0 to ens4f1
# ovs-vsctl set port active-backup other_config:bond-primary=ens4f1
# ovs-appctl bond/show
---- active-backup ----
bond_mode: active-backup
bond may use recirculation: no, Recirc-ID : -1
bond-hash-basis: 0
lb_output action: disabled, bond-id: -1
updelay: 0 ms
downdelay: 0 ms
lacp_status: off
lacp_fallback_ab: false
active-backup primary: ens4f1
active member mac: 3c:fd:fe:bd:1c:a5(ens4f1)

member ens4f0: enabled
  may_enable: true

member ens4f1: enabled
  active member
  may_enable: true

6. check traffic
# ovs-appctl dpctl/dump-flows -m
ufid:905c51ee-4eef-4ebc-98a2-b83206835fd7, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(ens4f1),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=40:a6:b7:3e:a5:60,dst=00:de:ad:96:02:02),eth_type(0x0800),ipv4(src=0.0.0.0/0.0.0.0,dst=0.0.0.0/0.0.0.0,proto=0/0,tos=0/0,ttl=0/0,frag=no), packets:8, bytes:784, used:9.566s, dp:ovs, actions:58060b49b0834_l
ufid:86b9c011-06c0-4085-a0ea-057d06f57241, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(ens4f0),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=40:a6:b7:3e:a5:60,dst=00:de:ad:96:02:02),eth_type(0x0800),ipv4(src=0.0.0.0/0.0.0.0,dst=0.0.0.0/0.0.0.0,proto=0/0,tos=0/0,ttl=0/0,frag=no), packets:582, bytes:57036, used:0.350s, dp:ovs, actions:58060b49b0834_l
ufid:45ad2f2f-07ec-454a-b7a0-dc35cb734a34, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(58060b49b0834_l),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:02,dst=ff:ff:ff:ff:ff:ff),eth_type(0x0806),arp(sip=172.31.150.42,tip=172.31.150.1,op=1/0xff,sha=00:00:00:00:00:00/00:00:00:00:00:00,tha=00:00:00:00:00:00/00:00:00:00:00:00), packets:1, bytes:42, used:9.566s, dp:ovs, actions:guestbridge,bondbridge,ens4f1,c115425c08134_l,d7135be5934c4_l
ufid:6446e2bc-6e09-448a-991f-dd4b91eb3ebf, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(ens4f0),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:02,dst=ff:ff:ff:ff:ff:ff),eth_type(0x0806),arp(sip=0.0.0.0/0.0.0.0,tip=0.0.0.0/0.0.0.0,op=0/0,sha=00:00:00:00:00:00/00:00:00:00:00:00,tha=00:00:00:00:00:00/00:00:00:00:00:00), packets:1, bytes:60, used:9.566s, dp:ovs, actions:drop
ufid:65fb5498-c20a-4b87-9c8f-74c1c94cb3ec, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(ens4f1),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=40:a6:b7:3e:a5:60,dst=00:de:ad:96:02:02),eth_type(0x0806),arp(sip=0.0.0.0/0.0.0.0,tip=0.0.0.0/0.0.0.0,op=0/0,sha=00:00:00:00:00:00/00:00:00:00:00:00,tha=00:00:00:00:00:00/00:00:00:00:00:00), packets:0, bytes:0, used:never, dp:ovs, actions:58060b49b0834_l
ufid:6bee556a-5661-4e5f-8ba2-6ed9d04a3b07, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(58060b49b0834_l),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:02,dst=40:a6:b7:3e:a5:60),eth_type(0x0800),ipv4(src=0.0.0.0/0.0.0.0,dst=0.0.0.0/0.0.0.0,proto=0/0,tos=0/0,ttl=0/0,frag=no), packets:591, bytes:57918, used:0.350s, dp:ovs, actions:ens4f0

# ovs-appctl dpctl/dump-flows -m
ufid:86b9c011-06c0-4085-a0ea-057d06f57241, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(ens4f0),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=40:a6:b7:3e:a5:60,dst=00:de:ad:96:02:02),eth_type(0x0800),ipv4(src=0.0.0.0/0.0.0.0,dst=0.0.0.0/0.0.0.0,proto=0/0,tos=0/0,ttl=0/0,frag=no), packets:634, bytes:62132, used:0.501s, dp:ovs, actions:58060b49b0834_l
ufid:6bee556a-5661-4e5f-8ba2-6ed9d04a3b07, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(58060b49b0834_l),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:02,dst=40:a6:b7:3e:a5:60),eth_type(0x0800),ipv4(src=0.0.0.0/0.0.0.0,dst=0.0.0.0/0.0.0.0,proto=0/0,tos=0/0,ttl=0/0,frag=no), packets:643, bytes:63014, used:0.501s, dp:ovs, actions:ens4f0

7 check change primary port in ovs-vswitchd.log
# tail -f /var/log/openvswitch/ovs-vswitchd.log 
2023-06-14T10:14:52.317Z|00049|bridge|INFO|bridge guestbridge: added interface patchguest on port 1
2023-06-14T10:14:53.122Z|00050|bridge|INFO|bridge guestbridge: added interface 58060b49b0834_l on port 2
2023-06-14T10:14:53.374Z|00051|bridge|INFO|bridge guestbridge: added interface c115425c08134_l on port 3
2023-06-14T10:14:53.638Z|00052|bridge|INFO|bridge guestbridge: added interface d7135be5934c4_l on port 4
2023-06-14T10:14:54.418Z|00053|connmgr|INFO|guestbridge<->unix#49: 1 flow_mods in the last 0 s (1 deletes)
2023-06-14T10:14:54.462Z|00054|connmgr|INFO|guestbridge<->unix#52: 1 flow_mods in the last 0 s (1 adds)
2023-06-14T10:15:00.464Z|00055|memory|INFO|172252 kB peak resident set size after 10.0 seconds
2023-06-14T10:15:00.464Z|00056|memory|INFO|handlers:3 idl-cells-Open_vSwitch:552 ports:9 revalidators:1 rules:10 udpif keys:45
2023-06-14T10:15:52.966Z|00002|bond(handler3)|DBG|Dropped 189 log messages in last 61 seconds (most recently, 3 seconds ago) due to excessive rate
2023-06-14T10:15:52.966Z|00003|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:16:54.918Z|00004|bond(handler3)|DBG|Dropped 4 log messages in last 59 seconds (most recently, 49 seconds ago) due to excessive rate
2023-06-14T10:16:54.918Z|00005|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:18:57.798Z|00006|bond(handler3)|DBG|Dropped 4 log messages in last 123 seconds (most recently, 95 seconds ago) due to excessive rate
2023-06-14T10:18:57.798Z|00007|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:19:05.990Z|00008|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:19:52.700Z|00005|bond(revalidator2)|DBG|Dropped 23 log messages in last 35 seconds (most recently, 2 seconds ago) due to excessive rate
2023-06-14T10:19:52.700Z|00006|bond(revalidator2)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:23:07.654Z|00009|bond(handler3)|DBG|Dropped 39 log messages in last 194 seconds (most recently, 193 seconds ago) due to excessive rate
2023-06-14T10:23:07.654Z|00010|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:23:32.230Z|00011|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:24:04.998Z|00012|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:24:37.766Z|00013|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:24:47.112Z|00057|bond|INFO|bond active-backup: active member is now ens4f1
2023-06-14T10:24:52.892Z|00014|bond(handler3)|DBG|Dropped 25 log messages in last 15 seconds (most recently, 6 seconds ago) due to excessive rate
2023-06-14T10:24:52.892Z|00015|bond(handler3)|DBG|bond active-backup: member ens4f0: active-backup bond received packet on backup member destined for 00:de:ad:96:02:02
2023-06-14T10:26:24.774Z|00016|bond(handler3)|DBG|Dropped 13 log messages in last 92 seconds (most recently, 36 seconds ago) due to excessive rate
2023-06-14T10:26:24.774Z|00017|bond(handler3)|DBG|bond active-backup: member ens4f0: active-backup bond received packet on backup member destined for 00:de:ad:96:02:02

Actual results:
1. after do step 5, traffic still host on ens4f0

Expected results:
1. after do step 5, traffic should transfer to ens4f1

Additional info:
wait more 60s and check the traffic transfer to correct port.
# ovs-appctl dpctl/dump-flows -m
ufid:905c51ee-4eef-4ebc-98a2-b83206835fd7, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(ens4f1),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=40:a6:b7:3e:a5:60,dst=00:de:ad:96:02:02),eth_type(0x0800),ipv4(src=0.0.0.0/0.0.0.0,dst=0.0.0.0/0.0.0.0,proto=0/0,tos=0/0,ttl=0/0,frag=no), packets:645, bytes:63210, used:0.106s, dp:ovs, actions:58060b49b0834_l
ufid:6bee556a-5661-4e5f-8ba2-6ed9d04a3b07, recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(58060b49b0834_l),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:02,dst=40:a6:b7:3e:a5:60),eth_type(0x0800),ipv4(src=0.0.0.0/0.0.0.0,dst=0.0.0.0/0.0.0.0,proto=0/0,tos=0/0,ttl=0/0,frag=no), packets:645, bytes:63210, used:0.106s, dp:ovs, actions:ens4f1


# tail -f /var/log/openvswitch/ovs-vswitchd.log 
2023-06-14T10:14:52.317Z|00049|bridge|INFO|bridge guestbridge: added interface patchguest on port 1
2023-06-14T10:14:53.122Z|00050|bridge|INFO|bridge guestbridge: added interface 58060b49b0834_l on port 2
2023-06-14T10:14:53.374Z|00051|bridge|INFO|bridge guestbridge: added interface c115425c08134_l on port 3
2023-06-14T10:14:53.638Z|00052|bridge|INFO|bridge guestbridge: added interface d7135be5934c4_l on port 4
2023-06-14T10:14:54.418Z|00053|connmgr|INFO|guestbridge<->unix#49: 1 flow_mods in the last 0 s (1 deletes)
2023-06-14T10:14:54.462Z|00054|connmgr|INFO|guestbridge<->unix#52: 1 flow_mods in the last 0 s (1 adds)
2023-06-14T10:15:00.464Z|00055|memory|INFO|172252 kB peak resident set size after 10.0 seconds
2023-06-14T10:15:00.464Z|00056|memory|INFO|handlers:3 idl-cells-Open_vSwitch:552 ports:9 revalidators:1 rules:10 udpif keys:45
2023-06-14T10:15:52.966Z|00002|bond(handler3)|DBG|Dropped 189 log messages in last 61 seconds (most recently, 3 seconds ago) due to excessive rate
2023-06-14T10:15:52.966Z|00003|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:16:54.918Z|00004|bond(handler3)|DBG|Dropped 4 log messages in last 59 seconds (most recently, 49 seconds ago) due to excessive rate
2023-06-14T10:16:54.918Z|00005|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:18:57.798Z|00006|bond(handler3)|DBG|Dropped 4 log messages in last 123 seconds (most recently, 95 seconds ago) due to excessive rate
2023-06-14T10:18:57.798Z|00007|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:19:05.990Z|00008|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:19:52.700Z|00005|bond(revalidator2)|DBG|Dropped 23 log messages in last 35 seconds (most recently, 2 seconds ago) due to excessive rate
2023-06-14T10:19:52.700Z|00006|bond(revalidator2)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:23:07.654Z|00009|bond(handler3)|DBG|Dropped 39 log messages in last 194 seconds (most recently, 193 seconds ago) due to excessive rate
2023-06-14T10:23:07.654Z|00010|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:23:32.230Z|00011|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:24:04.998Z|00012|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:24:37.766Z|00013|bond(handler3)|DBG|bond active-backup: member ens4f1: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:24:47.112Z|00057|bond|INFO|bond active-backup: active member is now ens4f1
2023-06-14T10:24:52.892Z|00014|bond(handler3)|DBG|Dropped 25 log messages in last 15 seconds (most recently, 6 seconds ago) due to excessive rate
2023-06-14T10:24:52.892Z|00015|bond(handler3)|DBG|bond active-backup: member ens4f0: active-backup bond received packet on backup member destined for 00:de:ad:96:02:02
2023-06-14T10:26:24.774Z|00016|bond(handler3)|DBG|Dropped 13 log messages in last 92 seconds (most recently, 36 seconds ago) due to excessive rate
2023-06-14T10:26:24.774Z|00017|bond(handler3)|DBG|bond active-backup: member ens4f0: active-backup bond received packet on backup member destined for 00:de:ad:96:02:02
2023-06-14T10:27:04.710Z|00018|bond(handler3)|DBG|Dropped 6 log messages in last 40 seconds (most recently, 30 seconds ago) due to excessive rate
2023-06-14T10:27:04.710Z|00019|bond(handler3)|DBG|bond active-backup: member ens4f0: active-backup bond received packet on backup member destined for 00:de:ad:96:02:02
2023-06-14T10:28:06.696Z|00007|bond(revalidator2)|DBG|Dropped 5 log messages in last 62 seconds (most recently, 58 seconds ago) due to excessive rate
2023-06-14T10:28:06.696Z|00008|bond(revalidator2)|DBG|bond active-backup: member ens4f0: active-backup bond received packet on backup member destined for 00:de:ad:96:02:02
2023-06-14T10:28:06.696Z|00009|dpif(revalidator2)|WARN|system@ovs-system: failed to put[modify] (No such file or directory) ufid:fcc1126b-110d-413d-8087-1621001bef21 recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(6),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:12,dst=33:33:00:00:00:02),eth_type(0x86dd),ipv6(src=fe80::c8ee:dfff:fe67:1dc6/::,dst=ff02::2/::,label=0/0,proto=58/0,tclass=0/0,hlimit=255/0,frag=no),icmpv6(type=133/0,code=0/0), actions:4,1,2,5,7
2023-06-14T10:28:06.696Z|00010|dpif(revalidator2)|WARN|system@ovs-system: failed to put[modify] (No such file or directory) ufid:9971dcf1-dc9a-41c2-bff8-d9a74b2c7c39 recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(7),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:22,dst=33:33:00:00:00:02),eth_type(0x86dd),ipv6(src=fe80::6c06:d8ff:fefe:fa37/::,dst=ff02::2/::,label=0/0,proto=58/0,tclass=0/0,hlimit=255/0,frag=no),icmpv6(type=133/0,code=0/0), actions:4,1,2,5,6
2023-06-14T10:28:06.696Z|00011|dpif(revalidator2)|WARN|system@ovs-system: failed to put[modify] (No such file or directory) ufid:16fd6174-3bc1-4ba9-b87c-769396fe9270 recirc_id(0),dp_hash(0/0),skb_priority(0x7/0),in_port(4),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=be:ef:35:dd:33:43,dst=33:33:00:00:00:16),eth_type(0x86dd),ipv6(src=::/::,dst=ff02::16/::,label=0/0,proto=58/0,tclass=0/0,hlimit=1/0,frag=no),icmpv6(type=143/0,code=0/0), actions:1,2,5,6,7
2023-06-14T10:28:06.696Z|00012|dpif(revalidator2)|WARN|system@ovs-system: failed to put[modify] (No such file or directory) ufid:66045200-04e3-40c7-950b-648b3340e9c3 recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(1),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=3c:fd:fe:bd:1c:a4,dst=33:33:00:00:00:02),eth_type(0x86dd),ipv6(src=fe80::a81e:2fff:fe26:ab44/::,dst=ff02::2/::,label=0/0,proto=58/0,tclass=0/0,hlimit=255/0,frag=no),icmpv6(type=133/0,code=0/0), actions:2,4,5,6,7
2023-06-14T10:28:06.696Z|00013|dpif(revalidator2)|WARN|system@ovs-system: failed to put[modify] (No such file or directory) ufid:4627553d-eccd-4edd-aa1a-34744adf1419 recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(2),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:22,dst=33:33:ff:00:00:62),eth_type(0x86dd),ipv6(src=::/::,dst=ff02::1:ff00:62/::,label=0/0,proto=58/0,tclass=0/0,hlimit=255/0,frag=no),icmpv6(type=135/0,code=0/0),nd(target=2001:db8:150::62/::,sll=00:00:00:00:00:00/00:00:00:00:00:00,tll=00:00:00:00:00:00/00:00:00:00:00:00), actions:1,4,5,6,7
2023-06-14T10:28:06.696Z|00014|dpif(revalidator2)|WARN|system@ovs-system: failed to put[modify] (No such file or directory) ufid:876c7ef1-827d-4e19-aeac-6912f8966422 recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(7),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:22,dst=33:33:00:00:00:16),eth_type(0x86dd),ipv6(src=::/::,dst=ff02::16/::,label=0/0,proto=58/0,tclass=0/0,hlimit=1/0,frag=no),icmpv6(type=143/0,code=0/0), actions:4,1,2,5,6
2023-06-14T10:28:06.696Z|00015|dpif(revalidator2)|WARN|system@ovs-system: failed to put[modify] (No such file or directory) ufid:c4bce7bb-ea26-4d78-9a01-4e656db3bcbd recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(6),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:12,dst=33:33:00:00:00:16),eth_type(0x86dd),ipv6(src=::/::,dst=ff02::16/::,label=0/0,proto=58/0,tclass=0/0,hlimit=1/0,frag=no),icmpv6(type=143/0,code=0/0), actions:4,1,2,5,7
2023-06-14T10:28:06.696Z|00016|dpif(revalidator2)|WARN|system@ovs-system: failed to put[modify] (No such file or directory) ufid:1443d644-9f4a-4bdc-b681-8a28496704ff recirc_id(0),dp_hash(0/0),skb_priority(0/0),in_port(2),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),eth(src=00:de:ad:96:02:12,dst=33:33:00:00:00:02),eth_type(0x86dd),ipv6(src=fe80::c8ee:dfff:fe67:1dc6/::,dst=ff02::2/::,label=0/0,proto=58/0,tclass=0/0,hlimit=255/0,frag=no),icmpv6(type=133/0,code=0/0), actions:1,4,5,6,7
2023-06-14T10:32:49.286Z|00020|bond(handler3)|DBG|Dropped 5 log messages in last 282 seconds (most recently, 257 seconds ago) due to excessive rate
2023-06-14T10:32:49.286Z|00021|bond(handler3)|DBG|bond active-backup: member ens4f0: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:32:49.286Z|00022|bond(handler3)|DBG|bond active-backup: member ens4f0: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:32:49.421Z|00017|bond(revalidator2)|DBG|bond active-backup: member ens4f0: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:32:49.421Z|00018|bond(revalidator2)|DBG|bond active-backup: member ens4f0: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:33:22.054Z|00023|bond(handler3)|DBG|bond active-backup: member ens4f0: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off
2023-06-14T10:33:54.822Z|00024|bond(handler3)|DBG|bond active-backup: member ens4f0: admissibility verdict is to drop pkt, active member: false, may_enable: true, enabled: true, LACP status: off

Comment 1 Mike Pattrick 2023-06-14 14:02:13 UTC

Set bond-primary changes the primary member, but not the member used to existing traffic.

In an active-backup bond, traffic received on non-active members is dropped. For this reason, if you want to change the active member after traffic has already begun, the best way is to turn that interface off and on again.

Set bond-primary is mainly useful during initial setup. We could probably modify the behavior to attempt to turn the interface off and on again, but this would require a RFE.

Comment 2 mhou 2023-06-15 06:36:53 UTC

Hello Mike

If there is no plan to modify the behavior of bond-pirmary, QE will modify the test code to prevent subsequent false positives.

Comment 3 mhou 2023-07-04 09:19:17 UTC

Hello Mike

Since no more explanation about disable/member and enable/member. Could you mind still open this bug?

Comment 4 Mike Pattrick 2023-08-10 03:54:24 UTC

I've submitted a patch upstream to address this issue.

Note You need to log in before you can comment on or make changes to this bug.