RP/0/RP0/CPU0:P5#show mpls traffic-eng trace head-end Tue Sep 15 02:40:03.410 UTC 4 wrapping entries (264256 possible, 64 allocated, 0 filtered, 4 total) Sep 15 02:28:40.885 mpls_te/head-end 0/RP0/CPU0 t4600 [PCALC-ECMP] Max BWV Allocated: 20 Sep 15 02:28:40.885 mpls_te/head-end 0/RP0/CPU0 t4600 [PCALC-ECMP] Max BWVE Allocated: 15 Sep 15 02:28:43.762 mpls_te/head-end 0/RP0/CPU0 t4600 NOTFN OwnedResEnd Sep 15 02:28:45.465 mpls_te/head-end 0/RP0/CPU0 t4600 Validating ifindexes for all vifs RP/0/RP0/CPU0:P5#show mpls traffic-eng trace link Tue Sep 15 02:40:03.544 UTC 278 wrapping entries (67648 possible, 576 allocated, 0 filtered, 278 total) Sep 15 02:28:40.885 mpls_te/link 0/RP0/CPU0 t4600 DS-TE mode change: prev - 0, new - 1 Sep 15 02:28:40.885 mpls_te/link 0/RP0/CPU0 t4600 TE process restarting; aborting DS-TE mode change Sep 15 02:28:42.261 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:381: lm_iarm_control_cb_fn: connection to IARM established. Sep 15 02:28:44.066 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1534: mpls_lcac_ifrs_add: Added new IFRS entry Sep 15 02:28:44.066 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1128: rrr_lm_list_link: Inserted link GigabitEthernet0/0/0/0 (ifh 0x8) into db based on name and handle Sep 15 02:28:44.066 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/0 (ifh 0x8), flood 0, force 0, Nbr cnt 0 Sep 15 02:28:44.066 mpls_te/link 0/RP0/CPU0 t4600 RSI: Registering interface GigabitEthernet0/0/0/0 (ifhndl 0x8) (0x8) for SRLG Notification Sep 15 02:28:44.066 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2544: rrr_lm_create_link: link GigabitEthernet0/0/0/0 (ifh 0x8) Created [1 links total], enable 0 Sep 15 02:28:44.068 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_idb_capacity: link GigabitEthernet0/0/0/0 (ifh 0x8) BW attribute 0 kbps Sep 15 02:28:44.068 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_link_capacity: link GigabitEthernet0/0/0/0 (ifh 0x8) physical_bw 125000000 Bps Sep 15 02:28:44.072 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:44.072 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) pool1_bw 0 (Kbps) Sep 15 02:28:44.072 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/0 (ifh 0x8), max_res_bw 1000000 (Kbps), Old max_res_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.072 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/0 (ifh 0x8), Pool0* max_bw 1000000 (Kbps), Old max_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.072 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/0 (ifh 0x8), max_res_bw 1000000 (Kbps), Old max_res_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.072 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/0 (ifh 0x8), Pool0* max_bw 1000000 (Kbps), Old max_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.072 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:518: Bandwidth update handling ignored, link GigabitEthernet0/0/0/0 (ifh 0x8) state down Sep 15 02:28:44.075 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:741: lm_iarm_reg_ipv4_add: added IPv4 register(True) request for interface GigabitEthernet0/0/0/0 (ifh 0x8) to IARM batch Sep 15 02:28:44.075 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:756: lm_iarm_reg_ipv4_add: sent pulse (0) to flush IARM IPv4 registration batch. Sep 15 02:28:44.151 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1534: mpls_lcac_ifrs_add: Added new IFRS entry Sep 15 02:28:44.151 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1128: rrr_lm_list_link: Inserted link GigabitEthernet0/0/0/1 (ifh 0x10) into db based on name and handle Sep 15 02:28:44.151 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/1 (ifh 0x10), flood 0, force 0, Nbr cnt 0 Sep 15 02:28:44.151 mpls_te/link 0/RP0/CPU0 t4600 RSI: Registering interface GigabitEthernet0/0/0/1 (ifhndl 0x10) (0x10) for SRLG Notification Sep 15 02:28:44.151 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2544: rrr_lm_create_link: link GigabitEthernet0/0/0/1 (ifh 0x10) Created [2 links total], enable 0 Sep 15 02:28:44.152 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_idb_capacity: link GigabitEthernet0/0/0/1 (ifh 0x10) BW attribute 0 kbps Sep 15 02:28:44.152 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_link_capacity: link GigabitEthernet0/0/0/1 (ifh 0x10) physical_bw 125000000 Bps Sep 15 02:28:44.157 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:44.157 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) pool1_bw 0 (Kbps) Sep 15 02:28:44.157 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/1 (ifh 0x10), max_res_bw 1000000 (Kbps), Old max_res_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.157 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/1 (ifh 0x10), Pool0* max_bw 1000000 (Kbps), Old max_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.157 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/1 (ifh 0x10), max_res_bw 1000000 (Kbps), Old max_res_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.157 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/1 (ifh 0x10), Pool0* max_bw 1000000 (Kbps), Old max_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.157 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:518: Bandwidth update handling ignored, link GigabitEthernet0/0/0/1 (ifh 0x10) state down Sep 15 02:28:44.160 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:741: lm_iarm_reg_ipv4_add: added IPv4 register(True) request for interface GigabitEthernet0/0/0/1 (ifh 0x10) to IARM batch Sep 15 02:28:44.160 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1534: mpls_lcac_ifrs_add: Added new IFRS entry Sep 15 02:28:44.160 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1128: rrr_lm_list_link: Inserted link GigabitEthernet0/0/0/2 (ifh 0x18) into db based on name and handle Sep 15 02:28:44.160 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/2 (ifh 0x18), flood 0, force 0, Nbr cnt 0 Sep 15 02:28:44.160 mpls_te/link 0/RP0/CPU0 t4600 RSI: Registering interface GigabitEthernet0/0/0/2 (ifhndl 0x18) (0x18) for SRLG Notification Sep 15 02:28:44.160 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2544: rrr_lm_create_link: link GigabitEthernet0/0/0/2 (ifh 0x18) Created [3 links total], enable 0 Sep 15 02:28:44.161 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_idb_capacity: link GigabitEthernet0/0/0/2 (ifh 0x18) BW attribute 0 kbps Sep 15 02:28:44.161 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_link_capacity: link GigabitEthernet0/0/0/2 (ifh 0x18) physical_bw 125000000 Bps Sep 15 02:28:44.165 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:44.165 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) pool1_bw 0 (Kbps) Sep 15 02:28:44.165 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/2 (ifh 0x18), max_res_bw 1000000 (Kbps), Old max_res_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.165 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/2 (ifh 0x18), Pool0* max_bw 1000000 (Kbps), Old max_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.165 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/2 (ifh 0x18), max_res_bw 1000000 (Kbps), Old max_res_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.165 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_set_link_bandwidth(): link GigabitEthernet0/0/0/2 (ifh 0x18), Pool0* max_bw 1000000 (Kbps), Old max_bw 0 (Kbps), IP addr 0.0.0.0 Sep 15 02:28:44.165 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:518: Bandwidth update handling ignored, link GigabitEthernet0/0/0/2 (ifh 0x18) state down Sep 15 02:28:44.168 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:741: lm_iarm_reg_ipv4_add: added IPv4 register(True) request for interface GigabitEthernet0/0/0/2 (ifh 0x18) to IARM batch Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3722: lm_im_handler: link GigabitEthernet0/0/0/0 (ifh 0x8), state 17, proto 0, opcode 35 (CREATE/DEL) Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3727: lm_im_handler: link GigabitEthernet0/0/0/0 (ifh 0x8), intf_type 15, parent i/f None (ifh 0x0), caps 0 Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3808: lm_im_handler: IM_CREATE: link GigabitEthernet0/0/0/0 (ifh 0x8), state 17, proto 0, opcode 35 Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3881: lm_im_handler: Updating link GigabitEthernet0/0/0/0 (ifh 0x8), intf_type 15, data_parent i/f None (ifh 0x0) (IM_CREATE) Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_idb_capacity: link GigabitEthernet0/0/0/0 (ifh 0x8) BW attribute 0 kbps Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_link_capacity: link GigabitEthernet0/0/0/0 (ifh 0x8) physical_bw 125000000 Bps Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) pool1_bw 0 (Kbps) Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) max_bw 0 (Kbps), pool0_bw 0 (Kbps) Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) pool1_bw 0 (Kbps) Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5281: Flooding on link GigabitEthernet0/0/0/0 (ifh 0x8) suppressed, system not ready Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3722: lm_im_handler: link GigabitEthernet0/0/0/1 (ifh 0x10), state 17, proto 0, opcode 35 (CREATE/DEL) Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3727: lm_im_handler: link GigabitEthernet0/0/0/1 (ifh 0x10), intf_type 15, parent i/f None (ifh 0x0), caps 0 Sep 15 02:28:44.169 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3808: lm_im_handler: IM_CREATE: link GigabitEthernet0/0/0/1 (ifh 0x10), state 17, proto 0, opcode 35 Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3881: lm_im_handler: Updating link GigabitEthernet0/0/0/1 (ifh 0x10), intf_type 15, data_parent i/f None (ifh 0x0) (IM_CREATE) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_idb_capacity: link GigabitEthernet0/0/0/1 (ifh 0x10) BW attribute 0 kbps Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_link_capacity: link GigabitEthernet0/0/0/1 (ifh 0x10) physical_bw 125000000 Bps Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) pool1_bw 0 (Kbps) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) max_bw 0 (Kbps), pool0_bw 0 (Kbps) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) pool1_bw 0 (Kbps) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5281: Flooding on link GigabitEthernet0/0/0/1 (ifh 0x10) suppressed, system not ready Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3722: lm_im_handler: link GigabitEthernet0/0/0/2 (ifh 0x18), state 17, proto 0, opcode 35 (CREATE/DEL) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3727: lm_im_handler: link GigabitEthernet0/0/0/2 (ifh 0x18), intf_type 15, parent i/f None (ifh 0x0), caps 0 Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3808: lm_im_handler: IM_CREATE: link GigabitEthernet0/0/0/2 (ifh 0x18), state 17, proto 0, opcode 35 Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3881: lm_im_handler: Updating link GigabitEthernet0/0/0/2 (ifh 0x18), intf_type 15, data_parent i/f None (ifh 0x0) (IM_CREATE) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_idb_capacity: link GigabitEthernet0/0/0/2 (ifh 0x18) BW attribute 0 kbps Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_link_capacity: link GigabitEthernet0/0/0/2 (ifh 0x18) physical_bw 125000000 Bps Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) pool1_bw 0 (Kbps) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) max_bw 0 (Kbps), pool0_bw 0 (Kbps) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) pool1_bw 0 (Kbps) Sep 15 02:28:44.170 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5281: Flooding on link GigabitEthernet0/0/0/2 (ifh 0x18) suppressed, system not ready Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 RSI: Synchronous batch handler: 3 items Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 RSI: Event Update with 0 SRLG values for GigabitEthernet0/0/0/0 (ifhndl 0x8) (0x8) [change: NO, old count 0] Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 RSI: Event Update with 0 SRLG values for GigabitEthernet0/0/0/1 (ifhndl 0x10) (0x10) [change: NO, old count 0] Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 RSI: Event Update with 0 SRLG values for GigabitEthernet0/0/0/2 (ifhndl 0x18) (0x18) [change: NO, old count 0] Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 RSI: Sent registration for 3 interfaces (Success 3, failure 0) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_im_attr_capacity_handler: link GigabitEthernet0/0/0/0 (ifh 0x8),bw 1000000 (kbps), bw2 125000000 (Bps), event 0 Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_process_link_capacity(): capacity not changed link GigabitEthernet0/0/0/0 (ifh 0x8), current bw 125000000 (Kbps), new bw 125000000 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) pool1_bw 0 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) max_bw 0 (Kbps), pool0_bw 0 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) pool1_bw 0 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_im_attr_capacity_handler: link GigabitEthernet0/0/0/1 (ifh 0x10),bw 1000000 (kbps), bw2 125000000 (Bps), event 0 Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_process_link_capacity(): capacity not changed link GigabitEthernet0/0/0/1 (ifh 0x10), current bw 125000000 (Kbps), new bw 125000000 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) pool1_bw 0 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) max_bw 0 (Kbps), pool0_bw 0 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) pool1_bw 0 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_im_attr_capacity_handler: link GigabitEthernet0/0/0/2 (ifh 0x18),bw 1000000 (kbps), bw2 125000000 (Bps), event 0 Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_process_link_capacity(): capacity not changed link GigabitEthernet0/0/0/2 (ifh 0x18), current bw 125000000 (Kbps), new bw 125000000 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) pool1_bw 0 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) max_bw 0 (Kbps), pool0_bw 0 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) pool1_bw 0 (Kbps) Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_im_attr_capacity_handler: link GigabitEthernet0/0/0/3 (ifh 0x20),bw 1000000 (kbps), bw2 125000000 (Bps), event 0 Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_im_attr_capacity_handler: link MgmtEth0/RP0/CPU0/0 (ifh 0x28),bw 1000000 (kbps), bw2 125000000 (Bps), event 0 Sep 15 02:28:44.171 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:279: lm_iarm_handle_pulse: received pulse (0), flushing IARM IPv4 registration batch. Sep 15 02:28:44.172 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:623: lm_iarm_flush: sent 3 IPv4 (un)register requests to IARM. Sep 15 02:28:44.769 mpls_te/link 0/RP0/CPU0 t4600 SRLG-producer connected Sep 15 02:28:44.852 mpls_te/link 0/RP0/CPU0 t4600 RSI SRLG-producer registration done successfully Sep 15 02:28:44.852 mpls_te/link 0/RP0/CPU0 t4600 Replaying learned SRLGs on all links to RSI Sep 15 02:28:44.852 mpls_te/link 0/RP0/CPU0 t4600 Replaying learned SRLGs on all termination interfaces to RSI Sep 15 02:28:45.067 mpls_te/link 0/RP0/CPU0 t4600 Validating ifindexes for all links Sep 15 02:28:45.067 mpls_te/link 0/RP0/CPU0 t4600 Bulk ifindex lookup for 3 links Sep 15 02:28:45.155 mpls_te/link 0/RP0/CPU0 t4600 Link GigabitEthernet0/0/0/0 (ifhndl 0x8) (0x8) ifindex set to 3 Sep 15 02:28:45.155 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/0 (ifh 0x8), flood 0, force 1, Nbr cnt 0 Sep 15 02:28:45.156 mpls_te/link 0/RP0/CPU0 t4600 Link GigabitEthernet0/0/0/1 (ifhndl 0x10) (0x10) ifindex set to 4 Sep 15 02:28:45.156 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/1 (ifh 0x10), flood 0, force 1, Nbr cnt 0 Sep 15 02:28:45.156 mpls_te/link 0/RP0/CPU0 t4600 Link GigabitEthernet0/0/0/2 (ifhndl 0x18) (0x18) ifindex set to 5 Sep 15 02:28:45.156 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/2 (ifh 0x18), flood 0, force 1, Nbr cnt 0 Sep 15 02:28:46.251 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:119: Unable to process adj-change from IGP OSPFarea 0 on link Loopback0 (ifh 0x14) with handle 0x14, reverting to name Sep 15 02:28:46.251 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:145: Unable to process adj-change from IGP OSPF area 0 on link Loopback0 (ifh 0x14) (0 nbrs): link not found Sep 15 02:28:47.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2611: Handling area change: IGP OSPF area 0, is_up = 1, router-id 5.5.5.5 Sep 15 02:28:47.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/0 (ifh 0x8), flood 0, force 0, Nbr cnt 0 Sep 15 02:28:47.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/1 (ifh 0x10), flood 0, force 0, Nbr cnt 0 Sep 15 02:28:47.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/2 (ifh 0x18), flood 0, force 0, Nbr cnt 0 Sep 15 02:28:47.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5406: Periodic Flooding for igp-type: 2 area: 0 0 seconds Sep 15 02:28:47.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5214: System change: flooding to all links/areas: reason area state change Sep 15 02:28:49.554 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3722: lm_im_handler: link GigabitEthernet0/0/0/0 (ifh 0x8), state 17, proto 12, opcode 35 (CREATE/DEL) Sep 15 02:28:49.554 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3727: lm_im_handler: link GigabitEthernet0/0/0/0 (ifh 0x8), intf_type 15, parent i/f None (ifh 0x0), caps 26 Sep 15 02:28:49.554 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3808: lm_im_handler: IM_CREATE: link GigabitEthernet0/0/0/0 (ifh 0x8), state 17, proto 12, opcode 35 Sep 15 02:28:49.555 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:875: mpls_lcac_if_state_register: link GigabitEthernet0/0/0/0 (ifh 0x8), add True Sep 15 02:28:49.555 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:741: lm_iarm_reg_ipv4_add: added IPv4 register(True) request for interface GigabitEthernet0/0/0/0 (ifh 0x8) to IARM batch Sep 15 02:28:49.555 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:756: lm_iarm_reg_ipv4_add: sent pulse (0) to flush IARM IPv4 registration batch. Sep 15 02:28:49.555 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3881: lm_im_handler: Updating link GigabitEthernet0/0/0/0 (ifh 0x8), intf_type 15, data_parent i/f None (ifh 0x0) (IM_CREATE) Sep 15 02:28:49.555 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_idb_capacity: link GigabitEthernet0/0/0/0 (ifh 0x8) BW attribute 0 kbps Sep 15 02:28:49.555 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_link_capacity: link GigabitEthernet0/0/0/0 (ifh 0x8) physical_bw 125000000 Bps Sep 15 02:28:49.555 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:49.555 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) pool1_bw 0 (Kbps) Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) max_bw 0 (Kbps), pool0_bw 0 (Kbps) Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/0 (ifh 0x8) pool1_bw 0 (Kbps) Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5304: Flooding on link GigabitEthernet0/0/0/0 (ifh 0x8) suppressed, no change Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3722: lm_im_handler: link GigabitEthernet0/0/0/1 (ifh 0x10), state 17, proto 12, opcode 35 (CREATE/DEL) Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3727: lm_im_handler: link GigabitEthernet0/0/0/1 (ifh 0x10), intf_type 15, parent i/f None (ifh 0x0), caps 26 Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3808: lm_im_handler: IM_CREATE: link GigabitEthernet0/0/0/1 (ifh 0x10), state 17, proto 12, opcode 35 Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:875: mpls_lcac_if_state_register: link GigabitEthernet0/0/0/1 (ifh 0x10), add True Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:741: lm_iarm_reg_ipv4_add: added IPv4 register(True) request for interface GigabitEthernet0/0/0/1 (ifh 0x10) to IARM batch Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3881: lm_im_handler: Updating link GigabitEthernet0/0/0/1 (ifh 0x10), intf_type 15, data_parent i/f None (ifh 0x0) (IM_CREATE) Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_idb_capacity: link GigabitEthernet0/0/0/1 (ifh 0x10) BW attribute 0 kbps Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_link_capacity: link GigabitEthernet0/0/0/1 (ifh 0x10) physical_bw 125000000 Bps Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) pool1_bw 0 (Kbps) Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) max_bw 0 (Kbps), pool0_bw 0 (Kbps) Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/1 (ifh 0x10) pool1_bw 0 (Kbps) Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5304: Flooding on link GigabitEthernet0/0/0/1 (ifh 0x10) suppressed, no change Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3722: lm_im_handler: link GigabitEthernet0/0/0/2 (ifh 0x18), state 17, proto 12, opcode 35 (CREATE/DEL) Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3727: lm_im_handler: link GigabitEthernet0/0/0/2 (ifh 0x18), intf_type 15, parent i/f None (ifh 0x0), caps 26 Sep 15 02:28:49.556 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3808: lm_im_handler: IM_CREATE: link GigabitEthernet0/0/0/2 (ifh 0x18), state 17, proto 12, opcode 35 Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:875: mpls_lcac_if_state_register: link GigabitEthernet0/0/0/2 (ifh 0x18), add True Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:741: lm_iarm_reg_ipv4_add: added IPv4 register(True) request for interface GigabitEthernet0/0/0/2 (ifh 0x18) to IARM batch Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3881: lm_im_handler: Updating link GigabitEthernet0/0/0/2 (ifh 0x18), intf_type 15, data_parent i/f None (ifh 0x0) (IM_CREATE) Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_idb_capacity: link GigabitEthernet0/0/0/2 (ifh 0x18) BW attribute 0 kbps Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: rrr_lm_link_capacity: link GigabitEthernet0/0/0/2 (ifh 0x18) physical_bw 125000000 Bps Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) max_bw 1000000 (Kbps), pool0_bw 1000000 (Kbps) Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_rdm_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) pool1_bw 0 (Kbps) Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) max_bw 0 (Kbps), pool0_bw 0 (Kbps) Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK: mpls_lcac_cfg_int_bandwidth_mam_apply: link GigabitEthernet0/0/0/2 (ifh 0x18) pool1_bw 0 (Kbps) Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5304: Flooding on link GigabitEthernet0/0/0/2 (ifh 0x18) suppressed, no change Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3700: lm_im_handler: link GigabitEthernet0/0/0/0 (ifh 0x8), state 1, proto 12, caps 26, opcode=STATE_VALUE Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3765: lm_im_handler: IFSTATE_VAL: link GigabitEthernet0/0/0/0 (ifh 0x8), state 1, proto 12, opcode 37 Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3700: lm_im_handler: link GigabitEthernet0/0/0/1 (ifh 0x10), state 1, proto 12, caps 26, opcode=STATE_VALUE Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3765: lm_im_handler: IFSTATE_VAL: link GigabitEthernet0/0/0/1 (ifh 0x10), state 1, proto 12, opcode 37 Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3700: lm_im_handler: link GigabitEthernet0/0/0/2 (ifh 0x18), state 1, proto 12, caps 26, opcode=STATE_VALUE Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3765: lm_im_handler: IFSTATE_VAL: link GigabitEthernet0/0/0/2 (ifh 0x18), state 1, proto 12, opcode 37 Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:279: lm_iarm_handle_pulse: received pulse (0), flushing IARM IPv4 registration batch. Sep 15 02:28:49.557 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:623: lm_iarm_flush: sent 3 IPv4 (un)register requests to IARM. Sep 15 02:28:49.565 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:797: lm_ipv4_addr_callback: link GigabitEthernet0/0/0/0 (ifh 0x8), ct=0x0, ps=0x0, addr 10.4.5.5 Sep 15 02:28:49.565 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:797: lm_ipv4_addr_callback: link GigabitEthernet0/0/0/1 (ifh 0x10), ct=0x0, ps=0x0, addr 10.5.6.5 Sep 15 02:28:49.565 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:797: lm_ipv4_addr_callback: link GigabitEthernet0/0/0/2 (ifh 0x18), ct=0x0, ps=0x0, addr 10.2.5.5 Sep 15 02:28:49.966 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3700: lm_im_handler: link GigabitEthernet0/0/0/0 (ifh 0x8), state 2, proto 12, caps 26, opcode=STATE_VALUE Sep 15 02:28:49.966 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3765: lm_im_handler: IFSTATE_VAL: link GigabitEthernet0/0/0/0 (ifh 0x8), state 2, proto 12, opcode 37 Sep 15 02:28:49.966 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3700: lm_im_handler: link GigabitEthernet0/0/0/1 (ifh 0x10), state 2, proto 12, caps 26, opcode=STATE_VALUE Sep 15 02:28:49.966 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3765: lm_im_handler: IFSTATE_VAL: link GigabitEthernet0/0/0/1 (ifh 0x10), state 2, proto 12, opcode 37 Sep 15 02:28:49.966 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3700: lm_im_handler: link GigabitEthernet0/0/0/2 (ifh 0x18), state 2, proto 12, caps 26, opcode=STATE_VALUE Sep 15 02:28:49.966 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3765: lm_im_handler: IFSTATE_VAL: link GigabitEthernet0/0/0/2 (ifh 0x18), state 2, proto 12, opcode 37 Sep 15 02:28:50.264 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3700: lm_im_handler: link GigabitEthernet0/0/0/0 (ifh 0x8), state 3, proto 12, caps 26, opcode=STATE_VALUE Sep 15 02:28:50.264 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3765: lm_im_handler: IFSTATE_VAL: link GigabitEthernet0/0/0/0 (ifh 0x8), state 3, proto 12, opcode 37 Sep 15 02:28:50.264 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/0 (ifh 0x8), flood 0, force 0, Nbr cnt 0 Sep 15 02:28:50.264 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5494: Request link adjacencies for link GigabitEthernet0/0/0/0 (ifh 0x8), area 0, IGP OSPF Sep 15 02:28:50.356 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3700: lm_im_handler: link GigabitEthernet0/0/0/1 (ifh 0x10), state 3, proto 12, caps 26, opcode=STATE_VALUE Sep 15 02:28:50.356 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3765: lm_im_handler: IFSTATE_VAL: link GigabitEthernet0/0/0/1 (ifh 0x10), state 3, proto 12, opcode 37 Sep 15 02:28:50.356 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/1 (ifh 0x10), flood 0, force 0, Nbr cnt 0 Sep 15 02:28:50.356 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5494: Request link adjacencies for link GigabitEthernet0/0/0/1 (ifh 0x10), area 0, IGP OSPF Sep 15 02:28:50.359 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2565: Processing adj-change for link GigabitEthernet0/0/0/0 (ifh 0x8) (0 nbrs) in area 0, IGP OSPF Sep 15 02:28:50.359 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2451: rrr_lm_handle_igp_link_info_change: OSPF- link GigabitEthernet0/0/0/0 (ifh 0x8), tot_nbrs 0, subnet type 0, flags 0x2 Sep 15 02:28:50.359 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2471: rrr_lm_handle_igp_link_info_change: link GigabitEthernet0/0/0/0 (ifh 0x8) new igp admin weight 10, prev. isis wt 0, ospf wt 0 Sep 15 02:28:50.359 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:935: Link GigabitEthernet0/0/0/0 (ifh 0x8): Added area 0 IGP OSPF Sep 15 02:28:50.359 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1019: Link GigabitEthernet0/0/0/0 (ifh 0x8): Update nbrs for area 0 IGP OSPF Sep 15 02:28:50.359 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1345: setting IGP cost for link GigabitEthernet0/0/0/0 (ifh 0x8), area 0, protocol OSPF, weight 10 Sep 15 02:28:50.359 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2523: link GigabitEthernet0/0/0/0 (ifh 0x8), IGP OSPF area 0: no neighbor changes Sep 15 02:28:50.359 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5295: Flooding on link GigabitEthernet0/0/0/0 (ifh 0x8) data changed Sep 15 02:28:50.361 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3700: lm_im_handler: link GigabitEthernet0/0/0/2 (ifh 0x18), state 3, proto 12, caps 26, opcode=STATE_VALUE Sep 15 02:28:50.361 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:3765: lm_im_handler: IFSTATE_VAL: link GigabitEthernet0/0/0/2 (ifh 0x18), state 3, proto 12, opcode 37 Sep 15 02:28:50.361 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5569: rrr_lm_update_link_neighbors(): link GigabitEthernet0/0/0/2 (ifh 0x18), flood 0, force 0, Nbr cnt 0 Sep 15 02:28:50.361 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5494: Request link adjacencies for link GigabitEthernet0/0/0/2 (ifh 0x18), area 0, IGP OSPF Sep 15 02:28:50.364 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2565: Processing adj-change for link GigabitEthernet0/0/0/1 (ifh 0x10) (0 nbrs) in area 0, IGP OSPF Sep 15 02:28:50.364 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2451: rrr_lm_handle_igp_link_info_change: OSPF- link GigabitEthernet0/0/0/1 (ifh 0x10), tot_nbrs 0, subnet type 0, flags 0x2 Sep 15 02:28:50.364 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2471: rrr_lm_handle_igp_link_info_change: link GigabitEthernet0/0/0/1 (ifh 0x10) new igp admin weight 10, prev. isis wt 0, ospf wt 0 Sep 15 02:28:50.364 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:935: Link GigabitEthernet0/0/0/1 (ifh 0x10): Added area 0 IGP OSPF Sep 15 02:28:50.364 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1019: Link GigabitEthernet0/0/0/1 (ifh 0x10): Update nbrs for area 0 IGP OSPF Sep 15 02:28:50.364 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1345: setting IGP cost for link GigabitEthernet0/0/0/1 (ifh 0x10), area 0, protocol OSPF, weight 10 Sep 15 02:28:50.364 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2523: link GigabitEthernet0/0/0/1 (ifh 0x10), IGP OSPF area 0: no neighbor changes Sep 15 02:28:50.364 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5295: Flooding on link GigabitEthernet0/0/0/1 (ifh 0x10) data changed Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2565: Processing adj-change for link GigabitEthernet0/0/0/2 (ifh 0x18) (0 nbrs) in area 0, IGP OSPF Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2451: rrr_lm_handle_igp_link_info_change: OSPF- link GigabitEthernet0/0/0/2 (ifh 0x18), tot_nbrs 0, subnet type 0, flags 0x2 Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2471: rrr_lm_handle_igp_link_info_change: link GigabitEthernet0/0/0/2 (ifh 0x18) new igp admin weight 10, prev. isis wt 0, ospf wt 0 Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:935: Link GigabitEthernet0/0/0/2 (ifh 0x18): Added area 0 IGP OSPF Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1019: Link GigabitEthernet0/0/0/2 (ifh 0x18): Update nbrs for area 0 IGP OSPF Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1345: setting IGP cost for link GigabitEthernet0/0/0/2 (ifh 0x18), area 0, protocol OSPF, weight 10 Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2523: link GigabitEthernet0/0/0/2 (ifh 0x18), IGP OSPF area 0: no neighbor changes Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5295: Flooding on link GigabitEthernet0/0/0/2 (ifh 0x18) data changed Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2565: Processing adj-change for link GigabitEthernet0/0/0/0 (ifh 0x8) (0 nbrs) in area 0, IGP OSPF Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2451: rrr_lm_handle_igp_link_info_change: OSPF- link GigabitEthernet0/0/0/0 (ifh 0x8), tot_nbrs 0, subnet type 0, flags 0x2 Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2471: rrr_lm_handle_igp_link_info_change: link GigabitEthernet0/0/0/0 (ifh 0x8) new igp admin weight 10, prev. isis wt 0, ospf wt 0 Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2523: link GigabitEthernet0/0/0/0 (ifh 0x8), IGP OSPF area 0: no neighbor changes Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2565: Processing adj-change for link GigabitEthernet0/0/0/1 (ifh 0x10) (0 nbrs) in area 0, IGP OSPF Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2451: rrr_lm_handle_igp_link_info_change: OSPF- link GigabitEthernet0/0/0/1 (ifh 0x10), tot_nbrs 0, subnet type 0, flags 0x2 Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2471: rrr_lm_handle_igp_link_info_change: link GigabitEthernet0/0/0/1 (ifh 0x10) new igp admin weight 10, prev. isis wt 0, ospf wt 0 Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2523: link GigabitEthernet0/0/0/1 (ifh 0x10), IGP OSPF area 0: no neighbor changes Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2565: Processing adj-change for link GigabitEthernet0/0/0/2 (ifh 0x18) (0 nbrs) in area 0, IGP OSPF Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2451: rrr_lm_handle_igp_link_info_change: OSPF- link GigabitEthernet0/0/0/2 (ifh 0x18), tot_nbrs 0, subnet type 0, flags 0x2 Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2471: rrr_lm_handle_igp_link_info_change: link GigabitEthernet0/0/0/2 (ifh 0x18) new igp admin weight 10, prev. isis wt 0, ospf wt 0 Sep 15 02:28:50.456 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2523: link GigabitEthernet0/0/0/2 (ifh 0x18), IGP OSPF area 0: no neighbor changes Sep 15 02:28:50.565 mpls_te/link 0/RP0/CPU0 t4600 Validating ifindexes for all links Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2565: Processing adj-change for link GigabitEthernet0/0/0/0 (ifh 0x8) (0 nbrs) in area 0, IGP OSPF Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2451: rrr_lm_handle_igp_link_info_change: OSPF- link GigabitEthernet0/0/0/0 (ifh 0x8), tot_nbrs 0, subnet type 1, flags 0xb Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1019: Link GigabitEthernet0/0/0/0 (ifh 0x8): Update nbrs for area 0 IGP OSPF Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1515: setting subnet type for link GigabitEthernet0/0/0/0 (ifh 0x8), area 0, protocol 2, subnet type 1 Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2471: rrr_lm_handle_igp_link_info_change: link GigabitEthernet0/0/0/0 (ifh 0x8) new igp admin weight 10, prev. isis wt 0, ospf wt 0 Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2498: Link GigabitEthernet0/0/0/0 (ifh 0x8): update DB for 1 neighbors Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1559: Received neighbor 10.4.5.4 on link GigabitEthernet0/0/0/0 (ifh 0x8), IGP OSPF area 0 Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1578: Rcvd nbr node ID 4.4.4.4, state 1 Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1596: Matching existing neighbor found? False Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1714: Neighbor unknown: creating new one Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1286: link GigabitEthernet0/0/0/0 (ifh 0x8): setting IGP cost: 10, in area 0, protocol OSPF Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1429: link GigabitEthernet0/0/0/0 (ifh 0x8), IGP OSPF area 0: subnet type changed to 1 Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1825: Neighbor created link GigabitEthernet0/0/0/0 (ifh 0x8) nbr addr 10.4.5.4, count 1, nbr state 1 Sep 15 02:28:53.880 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5295: Flooding on link GigabitEthernet0/0/0/0 (ifh 0x8) data changed Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2565: Processing adj-change for link GigabitEthernet0/0/0/2 (ifh 0x18) (0 nbrs) in area 0, IGP OSPF Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2451: rrr_lm_handle_igp_link_info_change: OSPF- link GigabitEthernet0/0/0/2 (ifh 0x18), tot_nbrs 0, subnet type 1, flags 0xb Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1019: Link GigabitEthernet0/0/0/2 (ifh 0x18): Update nbrs for area 0 IGP OSPF Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1515: setting subnet type for link GigabitEthernet0/0/0/2 (ifh 0x18), area 0, protocol 2, subnet type 1 Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2471: rrr_lm_handle_igp_link_info_change: link GigabitEthernet0/0/0/2 (ifh 0x18) new igp admin weight 10, prev. isis wt 0, ospf wt 0 Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2498: Link GigabitEthernet0/0/0/2 (ifh 0x18): update DB for 1 neighbors Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1559: Received neighbor 10.2.5.2 on link GigabitEthernet0/0/0/2 (ifh 0x18), IGP OSPF area 0 Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1578: Rcvd nbr node ID 2.2.2.2, state 1 Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1596: Matching existing neighbor found? False Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1714: Neighbor unknown: creating new one Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1286: link GigabitEthernet0/0/0/2 (ifh 0x18): setting IGP cost: 10, in area 0, protocol OSPF Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1429: link GigabitEthernet0/0/0/2 (ifh 0x18), IGP OSPF area 0: subnet type changed to 1 Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1825: Neighbor created link GigabitEthernet0/0/0/2 (ifh 0x18) nbr addr 10.2.5.2, count 2, nbr state 1 Sep 15 02:28:57.871 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5295: Flooding on link GigabitEthernet0/0/0/2 (ifh 0x18) data changed Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2565: Processing adj-change for link GigabitEthernet0/0/0/1 (ifh 0x10) (0 nbrs) in area 0, IGP OSPF Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2451: rrr_lm_handle_igp_link_info_change: OSPF- link GigabitEthernet0/0/0/1 (ifh 0x10), tot_nbrs 0, subnet type 1, flags 0xb Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1019: Link GigabitEthernet0/0/0/1 (ifh 0x10): Update nbrs for area 0 IGP OSPF Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1515: setting subnet type for link GigabitEthernet0/0/0/1 (ifh 0x10), area 0, protocol 2, subnet type 1 Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2471: rrr_lm_handle_igp_link_info_change: link GigabitEthernet0/0/0/1 (ifh 0x10) new igp admin weight 10, prev. isis wt 0, ospf wt 0 Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:2498: Link GigabitEthernet0/0/0/1 (ifh 0x10): update DB for 1 neighbors Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1559: Received neighbor 10.5.6.6 on link GigabitEthernet0/0/0/1 (ifh 0x10), IGP OSPF area 0 Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1578: Rcvd nbr node ID 6.6.6.6, state 1 Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1596: Matching existing neighbor found? False Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1714: Neighbor unknown: creating new one Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1286: link GigabitEthernet0/0/0/1 (ifh 0x10): setting IGP cost: 10, in area 0, protocol OSPF Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1429: link GigabitEthernet0/0/0/1 (ifh 0x10), IGP OSPF area 0: subnet type changed to 1 Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:1825: Neighbor created link GigabitEthernet0/0/0/1 (ifh 0x10) nbr addr 10.5.6.6, count 3, nbr state 1 Sep 15 02:28:58.916 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5295: Flooding on link GigabitEthernet0/0/0/1 (ifh 0x10) data changed Sep 15 02:31:44.365 mpls_te/link 0/RP0/CPU0 t4600 LM_LINK:5471: Forced Flooding for IGP OSPF, area 0 RP/0/RP0/CPU0:P5#show mpls traffic-eng trace bselect Tue Sep 15 02:40:03.768 UTC 27 wrapping entries (67648 possible, 64 allocated, 0 filtered, 27 total) Sep 15 02:28:47.462 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.879 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.879 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.879 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.879 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.879 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.879 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.879 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.879 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.879 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.880 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.880 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.880 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.880 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.880 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.880 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.881 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.886 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:53.886 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:57.877 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:57.885 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:58.596 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:58.629 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:58.665 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:58.922 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:28:58.935 mpls_te/bselect 0/RP0/CPU0 t4600 FRR:7897: frr_plsp_promote_backup: cur promo timer 300, delay 10 sec, 0 ms Sep 15 02:31:09.765 mpls_te/bselect 0/RP0/CPU0 t4600 tebm_verify_bkup_db: Verifying existing bkup data RP/0/RP0/CPU0:P5#show rsvp trace signalling Tue Sep 15 02:40:03.997 UTC