BPG邻居建立、拆除到最后删除路由的debugging信息

设备信息:H3C模拟器

组网情况:
 
R5-S0/6/3-10.1.2.1---------------------10.1.2.2--S0/6/3---R1---…………
 
R1和R5间建立IBGP邻居关系
 
设备开启了debugging bgp all
<R5>
<R5>
*Jan 30 15:17:37:922 2013 R5 RM/6/RMDEBUG:
 BGP_TIMER: CR Timer Expired for Peer 10.1.2.2 
 
*Jan 30 15:17:37:922 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is CRTimerExpired.
 
*Jan 30 15:17:37:922 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is Start.
 
*Jan 30 15:17:37:922 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from IDLE to CONNECT.         收到一个启动事件,BGP初始化资源,从IDEL 进入CONNECT状态
 
*Jan 30 15:17:37:922 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is TransConnOpenFailed.
 
*Jan 30 15:17:37:922 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from CONNECT to ACTIVE.
 
<R5>
<R5>
<R5>
<R5>
<R5>
<R5>
<R5>
<R5>
<R5>
<R5>R1启用
*Jan 30 15:18:00:765 2013 R5 RM/6/RMDEBUG:
 BGP_TIMER: CR Timer Expired for Peer 10.1.2.2 
 
*Jan 30 15:18:00:765 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is CRTimerExpired.
 
*Jan 30 15:18:00:765 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from ACTIVE to CONNECT.
 
*Jan 30 15:18:00:765 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is TransConnOpenFailed.
 
*Jan 30 15:18:00:765 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from CONNECT to ACTIVE.         connect 状态,BGP发起第一个TCP连接,如果TCP连接成功就进入opensent,如果连接失败,则进入active
端口
    ^
 % Unrecognized command found at '^' position.
<R5>
<R5>
%Jan 30 15:18:20:453 2013 R5 IFNET/4/UPDOWN:
 Line protocol on the interface Serial0/6/3 is UP 
%Jan 30 15:18:20:453 2013 R5 IFNET/4/UPDOWN:
 Protocol PPP IPCP on the interface Serial0/6/3 is UP 
<R5>
<R5>
*Jan 30 15:18:22:922 2013 R5 RM/6/RMDEBUG:
        BGP.: 10.1.2.2 Send OPEN, Version: 4
        Local AS: 100, HoldTime: 180, Router ID: 10.1.1.1
 
        OPT Type:   2 (Capability)    
        CAP Type:   1 (Multiprotocol)  CAP Len: 4
                                       IPv4-UNC (1/1)
        CAP Type:   2 (RouteRefresh)   CAP Len: 0
 
        Total CAPB Len    : 8
        Total OPT Len     : 10 
        Total Message Len : 39 
 
 
*Jan 30 15:18:22:922 2013 R5 RM/6/RMDEBUG:
        BGP: Sent to 10.1.2.2 (AS Number: 100)
        Message Type: Open, Total number of bytes: 39
 
        (Displaying bytes from 1 to 39)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 27 01 04 00 64 00 B4 0A 01 01 01 0A 02 08 01 
        04 00 01 00 01 02 00 
 
*Jan 30 15:18:22:922 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from ACTIVE to OPENSENT.        TCP连接成功后,已经发出了第一个OPEN报文
 
*Jan 30 15:18:22:922 2013 R5 RM/6/RMDEBUG:
        BGP: Received from 10.1.2.2 (AS Number: 100)
        Message Type: Open, Total number of bytes: 39
 
        (Displaying bytes from 1 to 39)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 27 01 04 00 64 00 B4 0A 01 03 01 0A 02 08 01 
        04 00 01 00 01 02 00 
 
*Jan 30 15:18:22:922 2013 R5 RM/6/RMDEBUG:
*Jan 30 15:18:22:922 2013 R5 RM/6/RMDEBUG:
        BGP.: 10.1.2.2 Recv OPEN Length: 39
        Version: 4, Local AS: 100, HoldTime : 180,
        BGP ID: 10.1.3.1, TotOptLen: 10 
 
        OPT Type:   2 (Capability)     OPT Len: 8
        CAP Type:   1 (Multiprotocol)  CAP Len: 4
                                       IPv4-UNC (1/1)
        CAP Type:   2 (RouteRefresh)   CAP Len: 0
 
*Jan 30 15:18:22:922 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is ReceiveOpenMessage.
 
*Jan 30 15:18:22:922 2013 R5 RM/6/RMDEBUG:
        BGP: Sent to 10.1.2.2 (AS Number: 100)
        Message Type: KeepAlive, Total number of bytes: 19
 
        (Displaying bytes from 1 to 19)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 13 04 
 
*Jan 30 15:18:22:922 2013 R5 RM/6/RMDEBUG:
        BGP.: 10.1.2.2 Send KEEPALIVE 
        Length 19 
*Jan 30 15:18:22:922 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from OPENSENT to OPENCONFIRM.             对收到的OPEN消息进行确认并发现无误后发送keepalive
 
%Jan 30 15:18:23:15 2013 R5 RM/3/RMLOG:
 BGP.: 10.1.2.2 State is changed from OPENCONFIRM to ESTABLISHED. 已经收到了一个keepalive报文  转入established
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
        BGP: Received from 10.1.2.2 (AS Number: 100)
        Message Type: KeepAlive, Total number of bytes: 19
 
        (Displaying bytes from 1 to 19)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 13 04 
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
        BGP.: 10.1.2.2 Recv KEEPALIVE 
        Length: 19  
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is RecvKeepAliveMessage.
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from OPENCONFIRM to ESTABLISHED.
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
        BGP.: Send UPDATE to peer 10.1.2.2 for following destinations :   收到UPDATE消息
 
        BGP: Sent to 10.1.2.2 (AS Number: 100)
        Message Type: Update, Total number of bytes: 55
 
        (Displaying bytes from 1 to 55)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 37 02 00 00 00 1C 40 01 01 00 40 02 00 40 03 
        04 0A 01 02 01 80 04 04 00 00 00 00 40 05 04 00 
        00 00 64 18 0A 01 02 
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
        Origin       : IGP 
        AS Path      :  
        Next Hop     : 10.1.2.1 
        Local Pref   : 100
        MED          : 0
        10.1.2.0/24, 
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
        BGP: Received from 10.1.2.2 (AS Number: 100)
        Message Type: Update, Total number of bytes: 169
 
        (Displaying bytes from 1 to 160)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 37 02 00 00 00 1C 40 01 01 00 40 02 00 40 03 
        04 0A 01 02 02 80 04 04 00 00 00 00 40 05 04 00 
        00 00 64 18 0A 01 03 FF FF FF FF FF FF FF FF FF 
        FF FF FF FF FF FF FF 00 37 02 00 00 00 1C 40 01 
        01 00 40 02 00 40 03 04 0A 01 02 02 80 04 04 00 
        00 00 00 40 05 04 00 00 00 64 18 0A 01 02 FF FF 
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF 00 3B 
        02 00 00 00 20 40 01 01 00 40 02 04 02 01 00 C8 
        40 03 04 0A 01 03 02 80 04 04 00 00 00 00 40 05 
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
 
        (Displaying bytes from 161 to 169)
        04 00 00 00 64 18 0A 01 04 
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
 BGP: (AddNew) Add 10.1.3.0/24, from Peer: 10.1.2.2 
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
        BGP.: Recv UPDATE from peer 10.1.2.2 with following destinations :收到UPDATE消息
        Update message length : 55
        Local Pref   : 100
        MED          : 0
        Origin       : IGP 
        AS Path      :  
        Next Hop     : 10.1.2.2 
        10.1.3.0/24, 
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is RecvUpdateMessage.
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
 BGP: (AddNew) Add 10.1.2.0/24, from Peer: 10.1.2.2 
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
        BGP.: Recv UPDATE from peer 10.1.2.2 with following destinations :收到UPDATE消息
        Update message length : 55
        Local Pref   : 100
        MED          : 0
        Origin       : IGP 
        AS Path      :  
        Next Hop     : 10.1.2.2 
        10.1.2.0/24, 
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is RecvUpdateMessage.
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
 BGP: (AddNew) Add 10.1.4.0/24, from Peer: 10.1.2.2 
 
*Jan 30 15:18:23:15 2013 R5 RM/6/RMDEBUG:
        BGP.: Recv UPDATE from peer 10.1.2.2 with following destinations : 收到UPDATE消息
        Update message length : 59
        Local Pref   : 100
        MED          : 0
        Origin       : IGP 
        AS Path      : 200 
        Next Hop     : 10.1.3.2 
        10.1.4.0/24, 
 
*Jan 30 15:18:23:31 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is RecvUpdateMessage.
 
<R5>
<R5>
<R5>
<R5>
<R5>dis bgp peer
 
 BGP local router ID : 10.1.1.1
 Local AS number : 100
 Total number of peers : 1                Peers in established state : 1
 
  Peer            V    AS  MsgRcvd  MsgSent  OutQ PrefRcv Up/Down  State
 
  10.1.2.2        4   100        5        3     0       3 00:00:46 Established
<R5>
<R5>
<R5>
*Jan 30 15:19:00:437 2013 R5 RM/6/RMDEBUG:
        BGP: Received from 10.1.2.2 (AS Number: 100)
        Message Type: KeepAlive, Total number of bytes: 19
 
        (Displaying bytes from 1 to 19)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 13 04 
 
*Jan 30 15:19:00:437 2013 R5 RM/6/RMDEBUG:
        BGP.: 10.1.2.2 Recv KEEPALIVE 
        Length: 19  
*Jan 30 15:19:00:437 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is RecvKeepAliveMessage.
 
%Jan 30 15:19:02:953 2013 R5 IFNET/4/UPDOWN:
 Line protocol on the interface Serial0/6/3 is DOWN 
%Jan 30 15:19:02:953 2013 R5 IFNET/4/UPDOWN:
 Protocol PPP IPCP on the interface Serial0/6/3 is DOWN 
*Jan 30 15:19:02:953 2013 R5 RM/6/RMDEBUG:
        BGP.: Send UPDATE(Withdraw) to peer 10.1.2.2 for destinations :
 
        BGP: Sent to 10.1.2.2 (AS Number: 100)
        Message Type: Update, Total number of bytes: 27
 
        (Displaying bytes from 1 to 27)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 1B 02 00 04 18 0A 01 02 00 00 
 
*Jan 30 15:19:02:953 2013 R5 RM/6/RMDEBUG:
        10.1.2.0/24, 
 
*Jan 30 15:19:05:187 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is KATimerExpired.
 
*Jan 30 15:19:05:187 2013 R5 RM/6/RMDEBUG:
        BGP: Sent to 10.1.2.2 (AS Number: 100)
        Message Type: KeepAlive, Total number of bytes: 19
 
        (Displaying bytes from 1 to 19)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 13 04 
 
*Jan 30 15:19:05:187 2013 R5 RM/6/RMDEBUG:
        BGP.: 10.1.2.2 Send KEEPALIVE 
        Length 19 
<R5>
<R5>
<R5>
<R5>
<R5>
已 经把对端的端口down 了
    ^
 % Unrecognized command found at '^' position.
<R5>
*Jan 30 15:19:47:265 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is KATimerExpired.
 
*Jan 30 15:19:47:265 2013 R5 RM/6/RMDEBUG:
        BGP: Sent to 10.1.2.2 (AS Number: 100)
        Message Type: KeepAlive, Total number of bytes: 19
 
        (Displaying bytes from 1 to 19)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 13 04 
 
*Jan 30 15:19:47:265 2013 R5 RM/6/RMDEBUG:
        BGP.: 10.1.2.2 Send KEEPALIVE 
        Length 19 
<R5> dis bgp peer
    ^
 % Unrecognized command found at '^' position.
<R5>dis bpg pe 
        ^
 % Unrecognized command found at '^' position.
<R5>dis bgp peer
 
 BGP local router ID : 10.1.1.1
 Local AS number : 100
 Total number of peers : 1                Peers in established state : 1
 
  Peer            V    AS  MsgRcvd  MsgSent  OutQ PrefRcv Up/Down  State
 
  10.1.2.2        4   100        6        6     0       3 00:02:20 Established  
         把对端端口shutdown了 发现邻居还在建立着

  BGP邻居超时时间很长,通常是180秒。当应用环回地址建立邻居时,即便链路中断,只要备份链路能够及时发布切换环回地址路由,邻居可以保持建立,不引起振荡。
<R5>
<R5>
<R5>
<R5>
<R5>
<R5>
*Jan 30 15:20:29:375 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is KATimerExpired.
 
*Jan 30 15:20:29:375 2013 R5 RM/6/RMDEBUG:
        BGP: Sent to 10.1.2.2 (AS Number: 100)
        Message Type: KeepAlive, Total number of bytes: 19
 
        (Displaying bytes from 1 to 19)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 13 04 
 
*Jan 30 15:20:29:375 2013 R5 RM/6/RMDEBUG:
        BGP.: 10.1.2.2 Send KEEPALIVE 
        Length 19 
%Jan 30 15:21:04:750 2013 R5 RM/3/RMLOG:
 BGP.: 10.1.2.2 State is changed from ESTABLISHED to IDLE.
 
*Jan 30 15:21:04:750 2013 R5 RM/6/RMDEBUG:
 BGP_TIMER: HOLD Timer Expired for Peer 10.1.2.2 
 
*Jan 30 15:21:04:750 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is HoldTimerExpired.
 
*Jan 30 15:21:04:750 2013 R5 RM/6/RMDEBUG:
        BGP: Sent to 10.1.2.2 (AS Number: 100)
        Message Type: Notification, Total number of bytes: 21
 
        (Displaying bytes from 1 to 21)
        FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF 
        00 15 03 04 00 
 
*Jan 30 15:21:04:750 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Send NOTIFICATION 
 Err/SubErr: 4/0 (Hold Timer Expired)
 Error data NULL.
 
*Jan 30 15:21:04:750 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from ESTABLISHED to IDLE.
 
*Jan 30 15:21:04:750 2013 R5 RM/6/RMDEBUG:
 BGP: (DelRt) Mark Delete 10.1.3.0/24, from Peer: 10.1.2.2                      删除路由条目
 
*Jan 30 15:21:04:750 2013 R5 RM/6/RMDEBUG:
 BGP: (DelRt) Mark Delete 10.1.2.0/24, from Peer: 10.1.2.2 
 
*Jan 30 15:21:04:750 2013 R5 RM/6/RMDEBUG:
 BGP: (DelRt) Mark Delete 10.1.4.0/24, from Peer: 10.1.2.2 
 
*Jan 30 15:21:28:359 2013 R5 RM/6/RMDEBUG:
 BGP_TIMER: CR Timer Expired for Peer 10.1.2.2 
 
*Jan 30 15:21:28:359 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is CRTimerExpired.
 
*Jan 30 15:21:28:359 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is Start.
 
*Jan 30 15:21:28:359 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from IDLE to CONNECT.                         本端又开始建立邻居
 
*Jan 30 15:21:28:359 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is TransConnOpenFailed.
 
*Jan 30 15:21:28:359 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from CONNECT to ACTIVE.
 
<R5>
<R5>
<R5>
<R5>
*Jan 30 15:21:46:62 2013 R5 RM/6/RMDEBUG:
 BGP_TIMER: CR Timer Expired for Peer 10.1.2.2 
 
*Jan 30 15:21:46:62 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is CRTimerExpired.
 
*Jan 30 15:21:46:62 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from ACTIVE to CONNECT.
 
*Jan 30 15:21:46:62 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 Current event is TransConnOpenFailed.
 
*Jan 30 15:21:46:62 2013 R5 RM/6/RMDEBUG:
 BGP.: 10.1.2.2 State is changed from CONNECT to ACTIVE.