NE20E因链路质量导致BFD振荡

发布时间:  2016-06-22 浏览次数:  1084 下载次数:  0
问题描述

版本:NE20E-S8 V800R007C10SPC100

此NE20E设备通过mstp的组网方式连接到了各个地市的分支机构,并与分支之间运行bgp,通过bgp邻居动态的建立了bfd会话,bfd会话的参数min-tx和min-rx的时间均为50毫秒。之前版本为V800R005,前天晚上对设备进行升级操作到V800R007C10SPC100,补丁为V800R007SPH017,升级完毕后进行业务测试,设备状态、业务均正常。第二天早晨,接到客户的通知,说设备上频繁的弹出日志,提示BFD会话在up/down之间频繁切换.


告警信息
Jun  2 2016 09:12:39+08:00 ZZDC20WA02-A2 %%01BFD/4/hwBfdSessUp(t):VS=Admin-VS-CID=0x8074041c-OID=1.3.6.1.4.1.2011.5.25.38.3.2;Session changes to UP. (Index=16412, ConfigurationName=-, PeerIp=20.19.254.78, BindIfIndex=59, BindIfName=GigabitEthernet0/1/0.103, Diagnosis=0, BindVrfIndex=0, BindVpnName=_public_, SessionType=2, DefaultIp=1, BindType=4, StaticLspName=-, PwSecondary=3, NextHop=0.0.0.0, VcId=0, VsiName=-, VsiPeerAddress=0.0.0.0, DiscrAuto=2, PeerIpv6=::, Ipv6NextHop=::)
Jun  2 2016 09:14:10+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransNotification(t):VS=Admin-VS-CID=0x8013044b-OID=1.3.6.1.2.1.15.0.2;The BGP FSM moves from a higher numbered state to a lower numbered state. (BgpPeerRemoteAddr=20.19.254.98, BgpPeerLastError=69, BgpPeerState=1)
Jun  2 2016 09:14:10+08:00 ZZDC20WA02-A2 %%01BGP/6/PEER_STATE_CHG(l):VS=Admin-VS-CID=0x8013044b;The state of the peer changed after receiving an event. (PrevState=ESTABLISHED, CurrState=IDLE, InputEvent=AUTO_STOP, Peer=20.19.254.98, VpnInstance=_public_)
Jun  2 2016 09:14:10+08:00 ZZDC20WA02-A2 %%01BGP/6/NOTIFY_SEND(l):VS=Admin-VS-CID=0x8013044b;Sent a NOTIFICATION to the peer. (Peer=20.19.254.98, ErrorCode=6, SubErrorCode=9, NotifyInfo=CEASE/BFD Session Down,VpnInstance=_public_, ErrorData=NULL)
Jun  2 2016 09:14:10+08:00 ZZDC20WA02-A2 %%01BFD/4/STACHG_TODWN(l):VS=Admin-VS-CID=0x8074041c;BFD session changed to Down. (SlotNumber=9, Discriminator=16386, Diagnostic=NeighborDown, Applications=BGP, ProcessPST=False, BindInterfaceName=GigabitEthernet0/2/0.108, InterfacePhysicalState=Up, InterfaceProtocolState=Up, TunnelName=-)
Jun  2 2016 09:14:10+08:00 ZZDC20WA02-A2 %%01BFD/5/DELSESS(l):VS=Admin-VS-CID=0x8074041c;The BFD session was deleted. (Discriminator=16386, Result=successfully, Applications=BGP, BindIFName=GigabitEthernet0/2/0.108, SourceIp=20.19.254.97, PeerIp=20.19.254.98)
Jun  2 2016 09:14:10+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransition_active(l):VS=Admin-VS-CID=0x8013044b-alarmID=0x0879000f;The BGP FSM moves from a higher numbered state to a lower numbered state. (BgpPeerRemoteAddr=20.19.254.98, BgpPeerLastError=69, BgpPeerState=1, LocalIfName=-, Reason=BGP remote peer not reachable)
Jun  2 2016 09:14:31+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransNotification(t):VS=Admin-VS-CID=0x8013044b-OID=1.3.6.1.2.1.15.0.2;The BGP FSM moves from a higher numbered state to a lower numbered state. (BgpPeerRemoteAddr=20.19.254.106, BgpPeerLastError=69, BgpPeerState=1)
Jun  2 2016 09:14:31+08:00 ZZDC20WA02-A2 %%01BGP/6/NOTIFY_SEND(l):VS=Admin-VS-CID=0x8013044b;Sent a NOTIFICATION to the peer. (Peer=20.19.254.106, ErrorCode=6, SubErrorCode=9, NotifyInfo=CEASE/BFD Session Down,VpnInstance=_public_, ErrorData=NULL)
Jun  2 2016 09:14:32+08:00 ZZDC20WA02-A2 %%01BFD/4/STACHG_TODWN(l):VS=Admin-VS-CID=0x8074041c;BFD session changed to Down. (SlotNumber=9, Discriminator=16407, Diagnostic=NeighborDown, Applications=BGP, ProcessPST=False, BindInterfaceName=GigabitEthernet0/2/0.110, InterfacePhysicalState=Up, InterfaceProtocolState=Up, TunnelName=-)
Jun  2 2016 09:14:32+08:00 ZZDC20WA02-A2 %%01BFD/5/DELSESS(l):VS=Admin-VS-CID=0x8074041c;The BFD session was deleted. (Discriminator=16407, Result=successfully, Applications=BGP, BindIFName=GigabitEthernet0/2/0.110, SourceIp=20.19.254.105, PeerIp=20.19.254.106)
Jun  2 2016 09:14:31+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransition_active(l):VS=Admin-VS-CID=0x8013044b-alarmID=0x0879000f;The BGP FSM moves from a higher numbered state to a lower numbered state. (BgpPeerRemoteAddr=20.19.254.106, BgpPeerLastError=69, BgpPeerState=1, LocalIfName=-, Reason=BGP remote peer not reachable)
Jun  2 2016 09:14:42+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpEstablishedNotification(t):VS=Admin-VS-CID=0x8013044b-OID=1.3.6.1.2.1.15.0.1;The BGP FSM enters the Established state. (BgpPeerRemoteAddr=20.19.254.98, BgpPeerLastError=69, BgpPeerState=6)
Jun  2 2016 09:14:42+08:00 ZZDC20WA02-A2 %%01BFD/6/CRTSESS(l):VS=Admin-VS-CID=0x8074041c;The BFD session has been created successfully. (Discriminator=16413, ConfigurationName=-, Applications=BGP, PeerIp=20.19.254.98, SessionType=D_IP_IF, BindIFName=GigabitEthernet0/2/0.108, BindVpnName=_public_, SourceIp=20.19.254.97)
Jun  2 2016 09:14:42+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransition_clear(l):VS=Admin-VS-CID=0x8013044b-alarmID=0x0879000f-clearType=service_resume;The BGP FSM enters the Established state. (BgpPeerRemoteAddr=20.19.254.98, BgpPeerLastError=69, BgpPeerState=6, LocalIfName=-, Reason=Alarm clear)
Jun  2 2016 09:14:50+08:00 ZZDC20WA02-A2 %%01BFD/4/STACHG_TOUP(l):VS=Admin-VS-CID=0x8074041c;BFD session changed to Up. (SlotNumber=9, Discriminator=16413, FormerStatus=Down, Applications=BGP, BindInterfaceName=GigabitEthernet0/2/0.108, ProcessPST=False, TunnelName=-)
Jun  2 2016 09:15:03+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpEstablishedNotification(t):VS=Admin-VS-CID=0x8013044b-OID=1.3.6.1.2.1.15.0.1;The BGP FSM enters the Established state. (BgpPeerRemoteAddr=20.19.254.106, BgpPeerLastError=69, BgpPeerState=6)
Jun  2 2016 09:15:04+08:00 ZZDC20WA02-A2 %%01BFD/6/CRTSESS(l):VS=Admin-VS-CID=0x8074041c;The BFD session has been created successfully. (Discriminator=16414, ConfigurationName=-, Applications=BGP, PeerIp=20.19.254.106, SessionType=D_IP_IF, BindIFName=GigabitEthernet0/2/0.110, BindVpnName=_public_, SourceIp=20.19.254.105)
Jun  2 2016 09:15:03+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransition_clear(l):VS=Admin-VS-CID=0x8013044b-alarmID=0x0879000f-clearType=service_resume;The BGP FSM enters the Established state. (BgpPeerRemoteAddr=20.19.254.106, BgpPeerLastError=69, BgpPeerState=6, LocalIfName=-, Reason=Alarm clear)
Jun  2 2016 09:15:20+08:00 ZZDC20WA02-A2 %%01BFD/4/STACHG_TOUP(l):VS=Admin-VS-CID=0x8074041c;BFD session changed to Up. (SlotNumber=9, Discriminator=16414, FormerStatus=Down, Applications=BGP, BindInterfaceName=GigabitEthernet0/2/0.110, ProcessPST=False, TunnelName=-)
Jun  2 2016 09:16:39+08:00 ZZDC20WA02-A2 %%01BFD/4/hwBfdSessUp(t):VS=Admin-VS-CID=0x8074041c-OID=1.3.6.1.4.1.2011.5.25.38.3.2;Session changes to UP. (Index=16413, ConfigurationName=-, PeerIp=20.19.254.98, BindIfIndex=70, BindIfName=GigabitEthernet0/2/0.108, Diagnosis=0, BindVrfIndex=0, BindVpnName=_public_, SessionType=2, DefaultIp=1, BindType=4, StaticLspName=-, PwSecondary=3, NextHop=0.0.0.0, VcId=0, VsiName=-, VsiPeerAddress=0.0.0.0, DiscrAuto=2, PeerIpv6=::, Ipv6NextHop=::)
Jun  2 2016 09:16:39+08:00 ZZDC20WA02-A2 %%01BFD/4/hwBfdSessUp(t):VS=Admin-VS-CID=0x8074041c-OID=1.3.6.1.4.1.2011.5.25.38.3.2;Session changes to UP. (Index=16414, ConfigurationName=-, PeerIp=20.19.254.106, BindIfIndex=72, BindIfName=GigabitEthernet0/2/0.110, Diagnosis=0, BindVrfIndex=0, BindVpnName=_public_, SessionType=2, DefaultIp=1, BindType=4, StaticLspName=-, PwSecondary=3, NextHop=0.0.0.0, VcId=0, VsiName=-, VsiPeerAddress=0.0.0.0, DiscrAuto=2, PeerIpv6=::, Ipv6NextHop=::)
Jun  2 2016 09:20:36+08:00 ZZDC20WA02-A2 %%01BGP/6/NOTIFY_RECV(l):VS=Admin-VS-CID=0x8013048f-Slot=12;The router received a NOTIFICATION from the peer. (Peer=20.19.254.134, ErrorCode=6, SubErrorCode=0, NotifyInfo=Unknown ErrCode and ErrSubcode,VpnInstance=_public_, ErrorData=NULL)
Jun  2 2016 09:20:36+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransNotification(t):VS=Admin-VS-CID=0x8013044b-OID=1.3.6.1.2.1.15.0.2;The BGP FSM moves from a higher numbered state to a lower numbered state. (BgpPeerRemoteAddr=20.19.254.134, BgpPeerLastError=60, BgpPeerState=1)
Jun  2 2016 09:20:36+08:00 ZZDC20WA02-A2 %%01BGP/6/NOTIFY_RECV(l):VS=Admin-VS-CID=0x8013044b;The router received a NOTIFICATION from the peer. (Peer=20.19.254.134, ErrorCode=6, SubErrorCode=0, NotifyInfo=Unknown ErrCode and ErrSubcode,VpnInstance=_public_, ErrorData=NULL)
Jun  2 2016 09:20:37+08:00 ZZDC20WA02-A2 %%01BFD/5/DELSESS(l):VS=Admin-VS-CID=0x8074041c;The BFD session was deleted. (Discriminator=16400, Result=successfully, Applications=BGP, BindIFName=GigabitEthernet0/1/0.120, SourceIp=20.19.254.133, PeerIp=20.19.254.134)
Jun  2 2016 09:20:36+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransition_active(l):VS=Admin-VS-CID=0x8013044b-alarmID=0x0879000f;The BGP FSM moves from a higher numbered state to a lower numbered state. (BgpPeerRemoteAddr=20.19.254.134, BgpPeerLastError=60, BgpPeerState=1, LocalIfName=-, Reason=BGP receive notification)
Jun  2 2016 09:20:45+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpEstablishedNotification(t):VS=Admin-VS-CID=0x8013044b-OID=1.3.6.1.2.1.15.0.1;The BGP FSM enters the Established state. (BgpPeerRemoteAddr=20.19.254.134, BgpPeerLastError=60, BgpPeerState=6)
Jun  2 2016 09:20:45+08:00 ZZDC20WA02-A2 %%01BFD/6/CRTSESS(l):VS=Admin-VS-CID=0x8074041c;The BFD session has been created successfully. (Discriminator=16415, ConfigurationName=-, Applications=BGP, PeerIp=20.19.254.134, SessionType=D_IP_IF, BindIFName=GigabitEthernet0/1/0.120, BindVpnName=_public_, SourceIp=20.19.254.133)
Jun  2 2016 09:20:45+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransition_clear(l):VS=Admin-VS-CID=0x8013044b-alarmID=0x0879000f-clearType=service_resume;The BGP FSM enters the Established state. (BgpPeerRemoteAddr=20.19.254.134, BgpPeerLastError=60, BgpPeerState=6, LocalIfName=-, Reason=Alarm clear)
Jun  2 2016 09:21:06+08:00 ZZDC20WA02-A2 %%01BFD/4/STACHG_TOUP(l):VS=Admin-VS-CID=0x8074041c;BFD session changed to Up. (SlotNumber=9, Discriminator=16415, FormerStatus=Down, Applications=BGP, BindInterfaceName=GigabitEthernet0/1/0.120, ProcessPST=False, TunnelName=-)
Jun  2 2016 09:22:19+08:00 ZZDC20WA02-A2 %%01BGP/6/NOTIFY_RECV(l):VS=Admin-VS-CID=0x8013048f-Slot=12;The router received a NOTIFICATION from the peer. (Peer=20.19.254.90, ErrorCode=6, SubErrorCode=9, NotifyInfo=CEASE/BFD Session Down,VpnInstance=_public_, ErrorData=NULL)
Jun  2 2016 09:22:19+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransNotification(t):VS=Admin-VS-CID=0x8013044b-OID=1.3.6.1.2.1.15.0.2;The BGP FSM moves from a higher numbered state to a lower numbered state. (BgpPeerRemoteAddr=20.19.254.90, BgpPeerLastError=69, BgpPeerState=1)
Jun  2 2016 09:22:19+08:00 ZZDC20WA02-A2 %%01BGP/6/NOTIFY_SEND(l):VS=Admin-VS-CID=0x8013044b;Sent a NOTIFICATION to the peer. (Peer=20.19.254.90, ErrorCode=6, SubErrorCode=9, NotifyInfo=CEASE/BFD Session Down,VpnInstance=_public_, ErrorData=NULL)
Jun  2 2016 09:22:20+08:00 ZZDC20WA02-A2 %%01BFD/4/STACHG_TODWN(l):VS=Admin-VS-CID=0x8074041c;BFD session changed to Down. (SlotNumber=9, Discriminator=16411, Diagnostic=NeighborDown, Applications=BGP, ProcessPST=False, BindInterfaceName=GigabitEthernet0/1/0.106, InterfacePhysicalState=Up, InterfaceProtocolState=Up, TunnelName=-)
Jun  2 2016 09:22:20+08:00 ZZDC20WA02-A2 %%01BFD/5/DELSESS(l):VS=Admin-VS-CID=0x8074041c;The BFD session was deleted. (Discriminator=16411, Result=successfully, Applications=BGP, BindIFName=GigabitEthernet0/1/0.106, SourceIp=20.19.254.89, PeerIp=20.19.254.90)
Jun  2 2016 09:22:19+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransition_active(l):VS=Admin-VS-CID=0x8013044b-alarmID=0x0879000f;The BGP FSM moves from a higher numbered state to a lower numbered state. (BgpPeerRemoteAddr=20.19.254.90, BgpPeerLastError=69, BgpPeerState=1, LocalIfName=-, Reason=BGP remote peer not reachable)
Jun  2 2016 09:22:39+08:00 ZZDC20WA02-A2 %%01BFD/4/hwBfdSessUp(t):VS=Admin-VS-CID=0x8074041c-OID=1.3.6.1.4.1.2011.5.25.38.3.2;Session changes to UP. (Index=16415, ConfigurationName=-, PeerIp=20.19.254.134, BindIfIndex=109, BindIfName=GigabitEthernet0/1/0.120, Diagnosis=0, BindVrfIndex=0, BindVpnName=_public_, SessionType=2, DefaultIp=1, BindType=4, StaticLspName=-, PwSecondary=3, NextHop=0.0.0.0, VcId=0, VsiName=-, VsiPeerAddress=0.0.0.0, DiscrAuto=2, PeerIpv6=::, Ipv6NextHop=::)
Jun  2 2016 09:22:51+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpEstablishedNotification(t):VS=Admin-VS-CID=0x8013044b-OID=1.3.6.1.2.1.15.0.1;The BGP FSM enters the Established state. (BgpPeerRemoteAddr=20.19.254.90, BgpPeerLastError=69, BgpPeerState=6)
Jun  2 2016 09:22:51+08:00 ZZDC20WA02-A2 %%01BGP/6/NOTIFY_RECV(l):VS=Admin-VS-CID=0x8013048f-Slot=12;The router received a NOTIFICATION from the peer. (Peer=20.19.254.134, ErrorCode=6, SubErrorCode=0, NotifyInfo=Unknown ErrCode and ErrSubcode,VpnInstance=_public_, ErrorData=NULL)
Jun  2 2016 09:22:51+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransNotification(t):VS=Admin-VS-CID=0x8013044b-OID=1.3.6.1.2.1.15.0.2;The BGP FSM moves from a higher numbered state to a lower numbered state. (BgpPeerRemoteAddr=20.19.254.134, BgpPeerLastError=60, BgpPeerState=1)
Jun  2 2016 09:22:51+08:00 ZZDC20WA02-A2 %%01BGP/6/NOTIFY_RECV(l):VS=Admin-VS-CID=0x8013044b;The router received a NOTIFICATION from the peer. (Peer=20.19.254.134, ErrorCode=6, SubErrorCode=0, NotifyInfo=Unknown ErrCode and ErrSubcode,VpnInstance=_public_, ErrorData=NULL)
Jun  2 2016 09:22:52+08:00 ZZDC20WA02-A2 %%01BFD/6/CRTSESS(l):VS=Admin-VS-CID=0x8074041c;The BFD session has been created successfully. (Discriminator=16416, ConfigurationName=-, Applications=BGP, PeerIp=20.19.254.90, SessionType=D_IP_IF, BindIFName=GigabitEthernet0/1/0.106, BindVpnName=_public_, SourceIp=20.19.254.89)
Jun  2 2016 09:22:52+08:00 ZZDC20WA02-A2 %%01BFD/5/DELSESS(l):VS=Admin-VS-CID=0x8074041c;The BFD session was deleted. (Discriminator=16415, Result=successfully, Applications=BGP, BindIFName=GigabitEthernet0/1/0.120, SourceIp=20.19.254.133, PeerIp=20.19.254.134)
Jun  2 2016 09:22:51+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransition_active(l):VS=Admin-VS-CID=0x8013044b-alarmID=0x0879000f;The BGP FSM moves from a higher numbered state to a lower numbered state. (BgpPeerRemoteAddr=20.19.254.134, BgpPeerLastError=60, BgpPeerState=1, LocalIfName=-, Reason=BGP receive notification)
Jun  2 2016 09:22:51+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransition_clear(l):VS=Admin-VS-CID=0x8013044b-alarmID=0x0879000f-clearType=service_resume;The BGP FSM enters the Established state. (BgpPeerRemoteAddr=20.19.254.90, BgpPeerLastError=69, BgpPeerState=6, LocalIfName=-, Reason=Alarm clear)
Jun  2 2016 09:22:58+08:00 ZZDC20WA02-A2 %%01BFD/4/STACHG_TOUP(l):VS=Admin-VS-CID=0x8074041c;BFD session changed to Up. (SlotNumber=9, Discriminator=16416, FormerStatus=Down, Applications=BGP, BindInterfaceName=GigabitEthernet0/1/0.106, ProcessPST=False, TunnelName=-)
Jun  2 2016 09:23:02+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpEstablishedNotification(t):VS=Admin-VS-CID=0x8013044b-OID=1.3.6.1.2.1.15.0.1;The BGP FSM enters the Established state. (BgpPeerRemoteAddr=20.19.254.134, BgpPeerLastError=60, BgpPeerState=6)
Jun  2 2016 09:23:02+08:00 ZZDC20WA02-A2 %%01BFD/6/CRTSESS(l):VS=Admin-VS-CID=0x8074041c;The BFD session has been created successfully. (Discriminator=16417, ConfigurationName=-, Applications=BGP, PeerIp=20.19.254.134, SessionType=D_IP_IF, BindIFName=GigabitEthernet0/1/0.120, BindVpnName=_public_, SourceIp=20.19.254.133)
Jun  2 2016 09:23:02+08:00 ZZDC20WA02-A2 %%01BGP/2/bgpBackwardTransition_clear(l):VS=Admin-VS-CID=0x8013044b-alarmID=0x0879000f-clearType=service_resume;The BGP FSM enters the Established state. (BgpPeerRemoteAddr=20.19.254.134, BgpPeerLastError=60, BgpPeerState=6, LocalIfName=-, Reason=Alarm clear)
Jun  2 2016 09:23:16+08:00 ZZDC20WA02-A2 %%01BFD/4/STACHG_TOUP(l):VS=Admin-VS-CID=0x8074041c;BFD session changed to Up. (SlotNumber=9, Discriminator=16417, FormerStatus=Down, Applications=BGP, BindInterfaceName=GigabitEthernet0/1/0.120, ProcessPST=False, TunnelName=-)
Jun  2 2016 09:24:39+08:00 ZZDC20WA02-A2 %%01BFD/4/hwBfdSessUp(t):VS=Admin-VS-CID=0x8074041c-OID=1.3.6.1.4.1.2011.5.25.38.3.2;Session changes to UP. (Index=16416, ConfigurationName=-, PeerIp=20.19.254.90, BindIfIndex=62, BindIfName=GigabitEthernet0/1/0.106, Diagnosis=0, BindVrfIndex=0, BindVpnName=_public_, SessionType=2, DefaultIp=1, BindType=4, StaticLspName=-, PwSecondary=3, NextHop=0.0.0.0, VcId=0, VsiName=-, VsiPeerAddress=0.0.0.0, DiscrAuto=2, PeerIpv6=::, Ipv6NextHop=::)
Jun  2 2016 09:24:39+08:00 ZZDC20WA02-A2 %%01BFD/4/hwBfdSessUp(t):VS=Admin-VS-CID=0x8074041c-OID=1.3.6.1.4.1.2011.5.25.38.3.2;Session changes to UP. (Index=16417, ConfigurationName=-, PeerIp=20.19.254.134, BindIfIndex=109, BindIfName=GigabitEthernet0/1/0.120, Diagnosis=0, BindVrfIndex=0, BindVpnName=_public_, SessionType=2, DefaultIp=1, BindType=4, StaticLspName=-, PwSecondary=3, NextHop=0.0.0.0, VcId=0, VsiName=-, VsiPeerAddress=0.0.0.0, DiscrAuto=2, PeerIpv6=::, Ipv6NextHop=::)
Jun  2 2016 09:26:42+08:00 ZZDC20WA02-A2 %%01HAF/6/DBG_HEALTH(l):VS=Admin-VS-CID=0x80cc001c;Automatic record:
处理过程

客户反馈说升级前的确每天也会有几个bfd会话up/down的日志,故判断是由于运营商链路质量问题导致BFD会话频繁振荡

在设备上长ping如下地址,看看ping测是否有丢包

Ping –a 20.19.254.85 –si GigabitEthernet0/1/0.105 –c 1000000  -m  200 20.19.254.86

Ping –a 20.19.254.81 –si GigabitEthernet0/1/0.104  –c 1000000  -m  200  20.19.254.82


如果ping测试有丢包可以配置流统查看一下报文收发情况:

Acl  3987
Rule 5 permit icmp source 20.19.254.86  0  destination 20.19.254.85 0
Rule 10 perm icmp source 20.19.254.85  0  destination 20.19.254.86 0
Rule 15 permit icmp source 20.19.254.81  0  destination 20.19.254.82 0
Rule 20 perm icmp source 20.19.254.82  0  destination 20.19.254.81 0

#
traffic classifier 3987 operator or
if-match acl 3987
#
traffic behavior 3987
#
traffic policy 3987
undo share-mode
statistics enable
classifier 3987 behavior 3987

interface GigabitEthernet0/1/0.104
traffic-policy 3987 inbound
traffic-policy 3987 outbound 

interface GigabitEthernet0/1/0.105
traffic-policy 3987 inbound
traffic-policy 3987 outbound 


ping包后使用如下命令查看流统结果:

display  traffic  policy   statistics interface   GigabitEthernet   0/1/0.104  inbound   verbose  rule-based  
display  traffic  policy   statistics interface   GigabitEthernet  0/1/0.104  outbound   verbose  rule-based 
display  traffic  policy   statistics interface   GigabitEthernet   0/1/0.105  inbound   verbose  rule-based  
display  traffic  policy   statistics interface   GigabitEthernet  0/1/0.105  outbound   verbose  rule-based


查看bgp邻居状态发现,有的分支邻居状态一直处于建立状态,只是个别由于bfd的频繁切换,导致bgp邻居也不断的重新建立:
  Peer            V   AS     MsgRcvd  MsgSent  OutQ  Up/Down    State   PrefRcv
  10.19.252.9     4  65000   228155   228186     0 1794h45m Established     83
  20.19.254.66    4  65200   194403   227757     0 0354h53m Established      4
  20.19.254.70    4  65201   194383   227665     0 1676h31m Established      2
  20.19.254.74    4  65202   193953   227217     0 0267h52m Established      2
  20.19.254.78    4  65203   194371   227641     0 1676h31m Established      2
  20.19.254.82    4  65204   195743   229403     0 00:33:00 Established      2
  20.19.254.86    4  65205   194426   227695     0 00:23:21 Established      2
  20.19.254.90    4  65206   194432   227806     0 00:20:21 Established      2
  20.19.254.94    4  65207   193977   227150     0 0171h57m Established      4
  20.19.254.98    4  65208   194456   227821     0 0144h06m Established      2
  20.19.254.102   4  65209   194414   227719     0 1630h17m Established      2
  20.19.254.106   4  65210   194456   227772     0 1676h31m Established      2
  20.19.254.110   4  65211   194456   227810     0 00:33:21 Established      2
  20.19.254.114   4  65212   194488   227857     0 00:18:21 Established      2
  20.19.254.118   4  65100   194972   227811     0 1222h37m Established     19
  20.19.254.122   4  65101   194457   227650     0 1676h31m Established      6
  20.19.254.126   4  65214   194296   227608     0 1676h34m Established      2
  20.19.254.130   4  65213   213797   227654     0 1676h30m Established      2
  20.19.254.134   4  65102   217876   220502     0 0742h19m Established      2

根因

ping包的时候在设备上做的流统结果:

在G0/1/0.104下发送出去641个icmp报文,但是收到的应答报文只有637个。
在G0/1/0.105下发送出去2035个icmp报文,但是收到的应答报文只有2034个
这说明客户网络链路中存在丢包问题。


解决方案
由于在配置bfd for bgp的时候,设备使用默认的3倍hello时间。根据分析,确定是运营商链路的不稳定造成的,于是在bfd频繁振荡的接口对应的bgp邻居上,将bfd的超时时间改为10倍:
peer x.x.x.x bfd min-tx-interval 500 min-rx-interval 500 detect-multiplier 10
修改配置后,观察一段时间后发现,设备上没有出现BFD振荡的日志信息。
建议与总结
对于bfd会话,设备默认采用3倍于hello time的时间,对于一些运营商链路质量不是太好的端口上,建议将其超时时间手动更改为稍大的值,避免会话以及路由协议邻居关系的震荡。

END