frr icon indicating copy to clipboard operation
frr copied to clipboard

Published 20 hours ago • verified publisher icon FRRouting

BFD Multihop sessions take a little longer to go down in frr 8.3

Open rera1712 opened this issue 2 years ago • 0 comments

FRR Version : 8.3

[root@9032c1782338 /]# uname -a Linux 9032c1782338 5.11.22-100.fc32.x86_64 #1 SMP Wed May 19 18:58:25 UTC 2021 x86_64 x86_64 x86_64 GNU/Linux

Configuration router 1 ----------- router 2--------------- router 3

bfd sessions are configured between router 1 and router 3

router 1:

[root@9032c1782338 /]# vtysh

Hello, this is FRRouting (version 8.3). Copyright 1996-2005 Kunihiro Ishiguro, et al.

9032c1782338# show running-config Building configuration...

Current configuration: ! frr version 8.3 frr defaults traditional hostname 9032c1782338 log file /var/log/frr/frr.log log timestamp precision 3 ! debug bfd peer debug bfd zebra debug bfd network ! password frrpass enable password frrpass ! ip route 10.0.13.0/30 10.0.12.1 ipv6 route 3000::/64 2000::1 ! interface sw1p0 ip address 10.0.12.2/30 ipv6 address 2000::2/64 exit ! bfd peer 10.0.13.2 multihop local-address 10.0.12.2 detect-multiplier 6 transmit-interval 260 receive-interval 260 exit ! peer 3000::2 multihop local-address 2000::2 detect-multiplier 6 transmit-interval 260 receive-interval 260 exit ! exit ! end

router 2: a6957cb1a638# show running-config Building configuration...

Current configuration: ! frr version 8.3 frr defaults traditional hostname a6957cb1a638 log file /var/log/frr/frr.log log timestamp precision 3 ! password frrpass enable password frrpass ! interface sw1p0 ip address 10.0.12.1/30 ipv6 address 2000::1/64 exit ! interface sw1p1 ip address 10.0.13.1/30 ipv6 address 3000::1/64 exit ! end

router 3: 1dd40fc74ab6# show running-config Building configuration...

Current configuration: ! frr version 8.3 frr defaults traditional hostname 1dd40fc74ab6 log file /var/log/frr/frr.log log timestamp precision 3 ! password frrpass enable password frrpass ! ip route 10.0.12.0/30 10.0.13.1 ipv6 route 2000::/64 3000::1 ! interface sw1p0 ip address 10.0.13.2/30 ipv6 address 3000::2/64 exit ! bfd peer 10.0.12.2 multihop local-address 10.0.13.2 transmit-interval 150 receive-interval 150 exit ! peer 2000::2 multihop local-address 3000::2 transmit-interval 150 receive-interval 150 exit ! exit ! end

  1. All BFD peers are up in router 1 and router 2

1dd40fc74ab6# show bfd peers BFD Peers: peer 2000::2 multihop local-address 3000::2 vrf default ID: 3219602076 Remote ID: 1787455683 Active mode Minimum TTL: 254 Status: up Uptime: 1 minute(s), 26 second(s) Diagnostics: ok Remote diagnostics: ok Peer Type: configured Local timers: Detect-multiplier: 3 Receive interval: 150ms Transmission interval: 150ms Echo receive interval: 50ms Echo transmission interval: disabled Remote timers: Detect-multiplier: 6 Receive interval: 260ms Transmission interval: 260ms Echo receive interval: 50ms

peer 10.0.12.2 multihop local-address 10.0.13.2 vrf default
	ID: 3124944712
	Remote ID: 3498136215
	Active mode
	Minimum TTL: 254
	Status: up
	Uptime: 1 minute(s), 28 second(s)
	Diagnostics: ok
	Remote diagnostics: ok
	Peer Type: configured
	Local timers:
		Detect-multiplier: 3
		Receive interval: 150ms
		Transmission interval: 150ms
		Echo receive interval: 50ms
		Echo transmission interval: disabled
	Remote timers:
		Detect-multiplier: 6
		Receive interval: 260ms
		Transmission interval: 260ms
		Echo receive interval: 50ms

1dd40fc74ab6# exit

2.Remove the ip address on router 2 connected to router 3

a6957cb1a638(config)# interface sw1p1 a6957cb1a638(config-if)# no ip address 10.0.13.1/30 a6957cb1a638(config-if)# no ipv6 address 3000::1/64 a6957cb1a638(config-if)# exit a6957cb1a638(config)# exit

3.BFD sessions are expected to come down in router 1 in 1560milliseconds (6 * 260ms), but it took close to 1900mseconds as seen from frr logs

router 2 logs: 2022/08/08 15:23:23.820 ZEBRA: [XN0NB-2NSYE] MESSAGE: ZEBRA_INTERFACE_ADDRESS_DELETE 10.0.13.1/30 on sw1p1 vrf default(0) 2022/08/08 15:23:23.820 ZEBRA: [QQWTF-ZKJDD] rib_update: Scheduled VRF (ALL), event RIB_UPDATE_KERNEL 2022/08/08 15:23:23.820 ZEBRA: [M8JMF-J6PZV] rib_update_handle_vrf_all: Handling VRF (ALL) event RIB_UPDATE_KERNEL 2022/08/08 15:23:23.820 ZEBRA: [QR5K4-A1079] rib_update_table: IPv4 VRF kaloom-k8s-vrf Table 252 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:23.820 ZEBRA: [QR5K4-A1079] rib_update_table: IPv4 VRF kaloom-k8s-vrf Table 252 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:23.820 ZEBRA: [QR5K4-A1079] rib_update_table: IPv6 VRF kaloom-k8s-vrf Table 252 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:23.820 ZEBRA: [QR5K4-A1079] rib_update_table: IPv6 VRF kaloom-k8s-vrf Table 252 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:23.820 ZEBRA: [QR5K4-A1079] rib_update_table: IPv4 VRF default Table 254 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:23.820 ZEBRA: [QR5K4-A1079] rib_update_table: IPv4 VRF default Table 254 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:23.820 ZEBRA: [QR5K4-A1079] rib_update_table: IPv6 VRF default Table 254 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:23.820 ZEBRA: [QR5K4-A1079] rib_update_table: IPv6 VRF default Table 254 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:26.812 ZEBRA: [XN0NB-2NSYE] MESSAGE: ZEBRA_INTERFACE_ADDRESS_DELETE 3000::1/64 on sw1p1 vrf default(0) 2022/08/08 15:23:26.813 ZEBRA: [QQWTF-ZKJDD] rib_update: Scheduled VRF (ALL), event RIB_UPDATE_KERNEL 2022/08/08 15:23:26.813 ZEBRA: [M8JMF-J6PZV] rib_update_handle_vrf_all: Handling VRF (ALL) event RIB_UPDATE_KERNEL 2022/08/08 15:23:26.813 ZEBRA: [QR5K4-A1079] rib_update_table: IPv4 VRF kaloom-k8s-vrf Table 252 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:26.813 ZEBRA: [QR5K4-A1079] rib_update_table: IPv4 VRF kaloom-k8s-vrf Table 252 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:26.813 ZEBRA: [QR5K4-A1079] rib_update_table: IPv6 VRF kaloom-k8s-vrf Table 252 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:26.813 ZEBRA: [QR5K4-A1079] rib_update_table: IPv6 VRF kaloom-k8s-vrf Table 252 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:26.813 ZEBRA: [QR5K4-A1079] rib_update_table: IPv4 VRF default Table 254 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:26.813 ZEBRA: [QR5K4-A1079] rib_update_table: IPv4 VRF default Table 254 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:26.813 ZEBRA: [QR5K4-A1079] rib_update_table: IPv6 VRF default Table 254 event RIB_UPDATE_KERNEL Route type: wildcard 2022/08/08 15:23:26.813 ZEBRA: [QR5K4-A1079] rib_update_table: IPv6 VRF default Table 254 event RIB_UPDATE_KERNEL Route type: wildcard

router 1 logs:

2022/08/08 15:19:40.893 BFD: [TTQ3T-DZJWA] ipv6-new: failed to bind port: Cannot assign requested address 2022/08/08 15:23:25.147 BFD: [YA0Q5-C0BPV] control-packet: 'remote discriminator' is zero, not overridden [mhop:yes peer:10.0.13.2 local:10.0.12.2 port:2] 2022/08/08 15:23:25.188 BFD: [YA0Q5-C0BPV] control-packet: 'remote discriminator' is zero, not overridden [mhop:yes peer:10.0.13.2 local:10.0.12.2 port:2] 2022/08/08 15:23:25.721 BFD: [SEY1D-NT8EQ] state-change: [mhop:yes peer:10.0.13.2 local:10.0.12.2 vrf:default] up -> down reason:control-expired 2022/08/08 15:23:25.722 BGP: [Q4BCV-6FHZ5] zclient_bfd_session_update: 10.0.12.2/32 -> 10.0.13.2/32 VRF default(0) (CPI bit no): Down 2022/08/08 15:23:25.722 BGP: [QFMSE-NPSNN] zclient_bfd_session_update: sessions updated: 0 2022/08/08 15:23:27.038 BFD: [YA0Q5-C0BPV] control-packet: 'remote discriminator' is zero, not overridden [mhop:yes peer:10.0.13.2 local:10.0.12.2 port:2] 2022/08/08 15:23:28.038 BFD: [YA0Q5-C0BPV] control-packet: 'remote discriminator' is zero, not overridden [mhop:yes peer:10.0.13.2 local:10.0.12.2 port:2] 2022/08/08 15:23:28.307 BFD: [YA0Q5-C0BPV] control-packet: 'remote discriminator' is zero, not overridden [mhop:yes peer:3000::2 local:2000::2 port:2] 2022/08/08 15:23:28.324 BFD: [YA0Q5-C0BPV] control-packet: 'remote discriminator' is zero, not overridden [mhop:yes peer:3000::2 local:2000::2 port:2] 2022/08/08 15:23:28.849 BFD: [SEY1D-NT8EQ] state-change: [mhop:yes peer:3000::2 local:2000::2 vrf:default] up -> down reason:control-expired 2022/08/08 15:23:28.849 BGP: [Q4BCV-6FHZ5] zclient_bfd_session_update: 2000::2/128 -> 3000::2/128 VRF default(0) (CPI bit no): Down 2022/08/08 15:23:28.852 BGP: [QFMSE-NPSNN] zclient_bfd_session_update: sessions updated: 0

ip removed in router 2 at timestamp : 2022/08/08 15:23:23.820 bfd session came down in router 1: 2022/08/08 15:23:25.721

seeing the following errors before that, could the below errors be reason for the delay ? 2022/08/08 15:23:25.147 BFD: [YA0Q5-C0BPV] control-packet: 'remote discriminator' is zero, not overridden [mhop:yes peer:10.0.13.2 local:10.0.12.2 port:2] 2022/08/08 15:23:25.188 BFD: [YA0Q5-C0BPV] control-packet: 'remote discriminator' is zero, not overridden [mhop:yes peer:10.0.13.2 local:10.0.12.2 port:2]

rera1712 avatar Aug 08 '22 15:08 rera1712