BFD flap

  • 0
  • 1
  • Problem
  • Updated 1 year ago
  • Not a Problem
Switch X670. BDF flapping on all peers. We enable log debug-mode for bfd. (In this log problem start at 1:50). And we can't find trigger for this behaviour.
 sh version
Switch      :  Rev 12.0 BootROM: 2.0.2.1    IMG: 16.2.2.4




Jun 29 00:08:08 0/0 2017-06-29 00:04:31.60 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionCreateCB@bfd_clientut...:599) OSPF:VR-Default: BFD session 5440072 state is now UP
Jun 29 00:08:09 0/0 2017-06-29 00:04:32.06 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.16.248.17 dstIP=10.16.248.18 in VR=VR-Default state is now UP
Jun 29 00:08:09 0/0 2017-06-29 00:04:32.06 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionStatusCB@bfd_clientut...:708) OSPF:VR-Default: BFD session 5022560 state is now UP
Jun 29 00:08:09 0/0 2017-06-29 00:04:32.31 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.16.248.9 dstIP=10.16.248.10 in VR=VR-Default state is now UP
Jun 29 00:08:09 0/0 2017-06-29 00:04:32.31 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionStatusCB@bfd_clientut...:708) OSPF:VR-Default: BFD session 5437944 state is now UP
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.16 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.6 dstIP=10.17.248.5 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.16 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:16 client:8195 rc:0 Params:13, 1, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.16 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.16 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.6 dstIP=10.17.248.5 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.16 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:19 client:8193 rc:0 Params:13, 1, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.16 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.16 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.16.248.17 dstIP=10.16.248.18 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.16 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:19 client:8193 rc:0 Params:2, 1, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.16 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.2 dstIP=10.17.248.1 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:19 client:8193 rc:0 Params:9, 1, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.2 dstIP=10.17.248.1 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:16 client:8195 rc:0 Params:9, 1, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionStatusCB@bfd_clientut...:716) OSPF:VR-Default: BFD session 5440072 state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Noti:BFD.Client.SigPathDown> (bfdClientSessionStatusCB@bfd_clientut...:740) OSPF:VR-Default: Signal the path to dest IP 10.17.248.5 is 'down' according to BFD session state
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 20 bytes from peerId 19
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 7 length 16
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1138) Received message from peer:19 clientId:8193 msgType:DELETE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 20
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.SendSrvrMsg> (bfdPerformActualSessionDelete@bfd_ser...:743) Sending DELETE RESPONSE to Peer:19 client:8193 rc:0 Params:13, 0, 0
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.DebugVerbose> (bfdProcessSessionDelete@bfd_server.c:689) bfdProcessSessionDelete: PeerId: 19, ClientId: 8193, sessionID: 13
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionStatusCB@bfd_clientut...:716) OSPF:VR-Default: BFD session 5022560 state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Noti:BFD.Client.SigPathDown> (bfdClientSessionStatusCB@bfd_clientut...:740) OSPF:VR-Default: Signal the path to dest IP 10.16.248.18 is 'down' according to BFD session state
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 20 bytes from peerId 19
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 7 length 16
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1138) Received message from peer:19 clientId:8193 msgType:DELETE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.16.248.17 dstIP=10.16.248.18 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:19 client:8193 rc:0 Params:2, 2, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.18 switch <Verb:BFD.DebugVerbose> (bfdProcessSessionDelete@bfd_server.c:689) bfdProcessSessionDelete: PeerId: 19, ClientId: 8193, sessionID: 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.19 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionStatusCB@bfd_clientut...:716) OSPF:VR-Default: BFD session 5335352 state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.19 switch <Noti:BFD.Client.SigPathDown> (bfdClientSessionStatusCB@bfd_clientut...:740) OSPF:VR-Default: Signal the path to dest IP 10.17.248.1 is 'down' according to BFD session state
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.19 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 20 bytes from peerId 19
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.19 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 7 length 16
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.19 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1138) Received message from peer:19 clientId:8193 msgType:DELETE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.19 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 20
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.19 switch <Verb:BFD.SendSrvrMsg> (bfdPerformActualSessionDelete@bfd_ser...:743) Sending DELETE RESPONSE to Peer:19 client:8193 rc:0 Params:9, 0, 0
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.19 switch <Verb:BFD.DebugVerbose> (bfdProcessSessionDelete@bfd_server.c:689) bfdProcessSessionDelete: PeerId: 19, ClientId: 8193, sessionID: 9
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.16.248.9 dstIP=10.16.248.10 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:19 client:8193 rc:0 Params:3, 1, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 20 bytes from peerId 16
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 7 length 16
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1138) Received message from peer:16 clientId:8195 msgType:DELETE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.6 dstIP=10.17.248.5 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:16 client:8195 rc:0 Params:13, 2, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdProcessSessionDelete@bfd_server.c:689) bfdProcessSessionDelete: PeerId: 16, ClientId: 8195, sessionID: 13
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 20 bytes from peerId 16
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 7 length 16
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1138) Received message from peer:16 clientId:8195 msgType:DELETE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.2 dstIP=10.17.248.1 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:16 client:8195 rc:0 Params:9, 2, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdProcessSessionDelete@bfd_server.c:689) bfdProcessSessionDelete: PeerId: 16, ClientId: 8195, sessionID: 9
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionStatusCB@bfd_clientut...:716) OSPF:VR-Default: BFD session 5437944 state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Noti:BFD.Client.SigPathDown> (bfdClientSessionStatusCB@bfd_clientut...:740) OSPF:VR-Default: Signal the path to dest IP 10.16.248.10 is 'down' according to BFD session state
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 20 bytes from peerId 19
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 7 length 16
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1138) Received message from peer:19 clientId:8193 msgType:DELETE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.16.248.9 dstIP=10.16.248.10 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:19 client:8193 rc:0 Params:3, 2, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.21 switch <Verb:BFD.DebugVerbose> (bfdProcessSessionDelete@bfd_server.c:689) bfdProcessSessionDelete: PeerId: 19, ClientId: 8193, sessionID: 3
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.24 switch <Verb:BFD.DebugVerbose> (bfdStartCtrlHelloTimer@bfd_session.c:180) bfdStartCtrlHelloTimer: sendPktTillDtimerB4SessDel--
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.24 switch <Verb:BFD.DebugVerbose> (bfdStartCtrlHelloTimer@bfd_session.c:180) bfdStartCtrlHelloTimer: sendPktTillDtimerB4SessDel--
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.24 switch <Verb:BFD.DebugVerbose> (bfdStartCtrlHelloTimer@bfd_session.c:180) bfdStartCtrlHelloTimer: sendPktTillDtimerB4SessDel--
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.25 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.6 dstIP=10.17.248.5 in VR=VR-Default state is now DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.25 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:16 client:8195 rc:0 Params:13, 2, 2
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.25 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.25 switch <Verb:BFD.DebugVerbose> (bfdStartCtrlHelloTimer@bfd_session.c:180) bfdStartCtrlHelloTimer: sendPktTillDtimerB4SessDel--
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.31 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 120 bytes from peerId 16
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.31 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 5 length 116
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.31 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1118) Received message from peer:16 clientId:8195 msgType:CREATE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.31 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 20
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.31 switch <Verb:BFD.SendSrvrMsg> (bfdPerformActualSessionDelete@bfd_ser...:743) Sending DELETE RESPONSE to Peer:16 client:8195 rc:0 Params:13, 0, 0
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.31 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.6 dstIP=10.17.248.5 in VR=VR-Default state is now INIT_DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.31 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:16 client:8195 rc:0 Params:13, 2, 3
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.31 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.31 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x474a4c, Data 0x474a78, size 120
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.31 switch <Verb:BFD.SendSrvrMsg> (bfdProcessSessionCreate@bfd_server.c:859) Sending CREATE RESPONSE to Peer:16 client:8195 rc:0 Params:13, 2, 3
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.32 switch <Verb:BFD.DebugVerbose> (bfdStartCtrlHelloTimer@bfd_session.c:180) bfdStartCtrlHelloTimer: sendPktTillDtimerB4SessDel--
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.33 switch <Verb:BFD.DebugVerbose> (bfdStartCtrlHelloTimer@bfd_session.c:180) bfdStartCtrlHelloTimer: sendPktTillDtimerB4SessDel--
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.37 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.6 dstIP=10.17.248.5 in VR=VR-Default state is now INIT_DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.37 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:16 client:8195 rc:0 Params:13, 1, 3
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.37 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.40 switch <Verb:BFD.DebugVerbose> (bfdStartCtrlHelloTimer@bfd_session.c:180) bfdStartCtrlHelloTimer: sendPktTillDtimerB4SessDel--
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.40 switch <Verb:BFD.DebugVerbose> (bfdCtrlHelloTimerExpired@bfd_session.c:236) bfdCtrlHelloTimerExpired: Calling delete session
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.40 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 20
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.40 switch <Verb:BFD.SendSrvrMsg> (bfdPerformActualSessionDelete@bfd_ser...:743) Sending DELETE RESPONSE to Peer:19 client:8193 rc:0 Params:2, 0, 0
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.41 switch <Verb:BFD.DebugVerbose> (bfdStartCtrlHelloTimer@bfd_session.c:180) bfdStartCtrlHelloTimer: sendPktTillDtimerB4SessDel--
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.41 switch <Verb:BFD.DebugVerbose> (bfdCtrlHelloTimerExpired@bfd_session.c:236) bfdCtrlHelloTimerExpired: Calling delete session
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.41 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 20
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.41 switch <Verb:BFD.SendSrvrMsg> (bfdPerformActualSessionDelete@bfd_ser...:743) Sending DELETE RESPONSE to Peer:16 client:8195 rc:0 Params:9, 0, 0
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.46 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.6 dstIP=10.17.248.5 in VR=VR-Default state is now UP
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.46 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:16 client:8195 rc:0 Params:13, 1, 1
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.46 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.49 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 120 bytes from peerId 19
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.49 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 5 length 116
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.49 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1118) Received message from peer:19 clientId:8193 msgType:CREATE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.49 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 20
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.49 switch <Verb:BFD.SendSrvrMsg> (bfdPerformActualSessionDelete@bfd_ser...:743) Sending DELETE RESPONSE to Peer:19 client:8193 rc:0 Params:3, 0, 0
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.49 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.16.248.9 dstIP=10.16.248.10 in VR=VR-Default state is now INIT_DOWN
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.49 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:19 client:8193 rc:0 Params:3, 1, 3
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.49 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.49 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x474a4c, Data 0x474a78, size 120
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.49 switch <Verb:BFD.SendSrvrMsg> (bfdProcessSessionCreate@bfd_server.c:859) Sending CREATE RESPONSE to Peer:19 client:8193 rc:0 Params:3, 1, 3
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.90 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 120 bytes from peerId 19
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.90 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 5 length 116
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.90 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1118) Received message from peer:19 clientId:8193 msgType:CREATE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.90 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x474a4c, Data 0x474a78, size 120
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.90 switch <Verb:BFD.SendSrvrMsg> (bfdProcessSessionCreate@bfd_server.c:859) Sending CREATE RESPONSE to Peer:19 client:8193 rc:0 Params:13, 1, 1
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.90 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionCreateCB@bfd_clientut...:599) OSPF:VR-Default: BFD session 5437408 state is now UP
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.91 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 120 bytes from peerId 19
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.91 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 5 length 116
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.91 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1118) Received message from peer:19 clientId:8193 msgType:CREATE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.91 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x474a4c, Data 0x474a78, size 120
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.91 switch <Verb:BFD.SendSrvrMsg> (bfdProcessSessionCreate@bfd_server.c:859) Sending CREATE RESPONSE to Peer:19 client:8193 rc:0 Params:2, 1, 3
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.91 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 120 bytes from peerId 19
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.91 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 5 length 116
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.91 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1118) Received message from peer:19 clientId:8193 msgType:CREATE SESSION REQUEST
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.92 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x474a4c, Data 0x474a78, size 120
Jun 29 01:50:23 0/0 2017-06-29 01:46:46.92 switch <Verb:BFD.SendSrvrMsg> (bfdProcessSessionCreate@bfd_server.c:859) Sending CREATE RESPONSE to Peer:19 client:8193 rc:0 Params:9, 1, 3
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.05 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.17.248.2 dstIP=10.17.248.1 in VR=VR-Default state is now UP
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.05 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:19 client:8193 rc:0 Params:9, 1, 1
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.05 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.05 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionStatusCB@bfd_clientut...:708) OSPF:VR-Default: BFD session 5334760 state is now UP
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.09 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.16.248.17 dstIP=10.16.248.18 in VR=VR-Default state is now UP
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.09 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:19 client:8193 rc:0 Params:2, 1, 1
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.09 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.09 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionStatusCB@bfd_clientut...:708) OSPF:VR-Default: BFD session 5437536 state is now UP
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.41 switch <Info:BFD.SessnStateChg> (bfdSendSessionStatusChangeToClie@bfd_...:950) BFD Session with srcIP=10.16.248.9 dstIP=10.16.248.10 in VR=VR-Default state is now UP
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.41 switch <Verb:BFD.SendSrvrMsg> (bfdSendSessionStatusChangeToClie@bfd_...:963) Sending STATUS UPDATE to Peer:19 client:8193 rc:0 Params:3, 1, 1
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.41 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 28
Jun 29 01:50:24 0/0 2017-06-29 01:46:47.41 switch <Noti:BFD.Client.SessnUpdt> (bfdClientSessionStatusCB@bfd_clientut...:708) OSPF:VR-Default: BFD session 5437944 state is now UP
Jun 29 01:50:25 0/0 2017-06-29 01:46:48.60 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 120 bytes from peerId 16
Jun 29 01:50:25 0/0 2017-06-29 01:46:48.60 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 5 length 116
Jun 29 01:50:25 0/0 2017-06-29 01:46:48.60 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1118) Received message from peer:16 clientId:8195 msgType:CREATE SESSION REQUEST
Jun 29 01:50:25 0/0 2017-06-29 01:46:48.60 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x494f94, Data 0x494fc0, size 120
Jun 29 01:50:25 0/0 2017-06-29 01:46:48.60 switch <Verb:BFD.SendSrvrMsg> (bfdProcessSessionCreate@bfd_server.c:859) Sending CREATE RESPONSE to Peer:16 client:8195 rc:0 Params:9, 1, 1
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.15 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 20 bytes from peerId 16
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.15 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 7 length 16
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.15 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1138) Received message from peer:16 clientId:8195 msgType:DELETE SESSION REQUEST
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.15 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 20
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.15 switch <Verb:BFD.SendSrvrMsg> (bfdPerformActualSessionDelete@bfd_ser...:743) Sending DELETE RESPONSE to Peer:16 client:8195 rc:0 Params:9, 0, 0
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.15 switch <Verb:BFD.DebugVerbose> (bfdProcessSessionDelete@bfd_server.c:689) bfdProcessSessionDelete: PeerId: 16, ClientId: 8195, sessionID: 9
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.16 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 20 bytes from peerId 16
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.16 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 7 length 16
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.16 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1138) Received message from peer:16 clientId:8195 msgType:DELETE SESSION REQUEST
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.16 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x49ff5c, Data 0x49ff88, size 20
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.17 switch <Verb:BFD.SendSrvrMsg> (bfdPerformActualSessionDelete@bfd_ser...:743) Sending DELETE RESPONSE to Peer:16 client:8195 rc:0 Params:13, 0, 0
Jun 29 01:50:26 0/0 2017-06-29 01:46:49.17 switch <Verb:BFD.DebugVerbose> (bfdProcessSessionDelete@bfd_server.c:689) bfdProcessSessionDelete: PeerId: 16, ClientId: 8195, sessionID: 13
Jun 29 01:50:40 0/0 2017-06-29 01:47:03.49 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 120 bytes from peerId 16
Jun 29 01:50:40 0/0 2017-06-29 01:47:03.49 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 5 length 116
Jun 29 01:50:40 0/0 2017-06-29 01:47:03.49 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1118) Received message from peer:16 clientId:8195 msgType:CREATE SESSION REQUEST
Jun 29 01:50:40 0/0 2017-06-29 01:47:03.49 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x494f94, Data 0x494fc0, size 120
Jun 29 01:50:40 0/0 2017-06-29 01:47:03.49 switch <Verb:BFD.SendSrvrMsg> (bfdProcessSessionCreate@bfd_server.c:859) Sending CREATE RESPONSE to Peer:16 client:8195 rc:0 Params:9, 1, 1
Jun 29 01:50:40 0/0 2017-06-29 01:47:03.49 switch <Verb:BFD.DebugVerbose> (bfdServRecv@bfd_server.c:229) bfdServRecv: received 120 bytes from peerId 16
Jun 29 01:50:40 0/0 2017-06-29 01:47:03.49 switch <Verb:BFD.DebugVerbose> (bfdServerProcRxMsg@bfd_server.c:1096) bfdServerProcRxMsg: BFD SERVER Packet Rcvd type: 5 length 116
Jun 29 01:50:40 0/0 2017-06-29 01:47:03.49 switch <Verb:BFD.RecvSrvrMsg> (bfdServerProcRxMsg@bfd_server.c:1118) Received message from peer:16 clientId:8195 msgType:CREATE SESSION REQUEST
Jun 29 01:50:40 0/0 2017-06-29 01:47:03.50 switch <Verb:BFD.DebugVerbose> (bfdSendMsgToClient@bfd_server.c:1190) bfdSendMsgToClient: pPkt User 0x494f94, Data 0x494fc0, size 120
Jun 29 01:50:40 0/0 2017-06-29 01:47:03.50 switch <Verb:BFD.SendSrvrMsg> (bfdProcessSessionCreate@bfd_server.c:859) Sending CREATE RESPONSE to Peer:16 client:8195 rc:0 Params:13, 1, 1
Photo of Sergey Vekli

Sergey Vekli

  • 506 Points 500 badge 2x thumb

Posted 1 year ago

  • 0
  • 1
Photo of Erik Auerswald

Erik Auerswald, Embassador

  • 13,772 Points 10k badge 2x thumb
Photo of Sergey Vekli

Sergey Vekli

  • 506 Points 500 badge 2x thumb
I don't think it caused by link detection. All peers is down in same time and no LACP in our case, we use single links.