RP/0/RP0/CPU0:PE1#show bgp trace | utility tail -n 150 Thu Oct 15 12:56:07.015 UTC Oct 15 12:50:14.989 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13195: UPDGEN_UPD4: prefixstats={total=4, adv=4, wdn=0, skp=0, sup=0, bestext=0} Oct 15 12:50:14.989 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13197: UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0} Oct 15 12:50:14.989 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4101: UPDGEN_FG_APPEND: AFI=4, UG=2, FG=1, walktype=0, targetver=15: msgcount=4 Oct 15 12:50:14.989 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4104: UPDGEN_FG_APPEND2: fg-prefixstats={adv=4, wdn=0, sup=0, skp=0} Oct 15 12:50:14.989 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4101: UPDGEN_FG_APPEND: AFI=4, UG=2, FG=1, walktype=0, targetver=15: msgcount=1 Oct 15 12:50:14.989 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4104: UPDGEN_FG_APPEND2: fg-prefixstats={adv=4, wdn=0, sup=0, skp=0} Oct 15 12:50:14.989 default-bgp/spkr-tr2-nbr 0/RP0/CPU0 t4662 [NBR]:12181: table 'TBL:default (1/128)' EoR sent to sub-grp 0.1 upd-grp 2 Oct 15 12:50:29.920 default-bgp/spkr-tr2-table 0/RP0/CPU0 t4660 [TABLE]:2883: state change rdinfo: 0x7e99e9147e00, old flags:0x2, new flags:0x2 rd_state:1 Oct 15 12:50:29.920 default-bgp/spkr-tr2-nbr 0/RP0/CPU0 t4660 [NBR]:1431: TBL:default (1/128), EOR rx-ed from vrf 0x60000000 nbr '2.2.2.2', afi:4, accepted prefix count:2, explicit:1 Oct 15 12:50:29.920 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6748: Import walk: import ver 15 -> 17: 0 nets processed (0 paths updated) afi 4 forced/ms 0 Oct 15 12:50:29.920 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:4366: Config release label mode for table 0xe0000002 (mode:6, 6, 6) flags:0x201, 0x0 Oct 15 12:50:29.920 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:4366: Config release label mode for table 0xe0000003 (mode:6, 6, 6) flags:0x201, 0x0 Oct 15 12:50:29.921 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:9001: label walk afi:VPNv4 Unicast, lbl ver 15 -> 17, be 0, skp 0 upd 0 Oct 15 12:50:29.921 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:9006: label walk afi:VPNv4 Unicast, lbl ver 15 -> 17, be 0, skp 0 upd 1 Oct 15 12:50:29.921 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:18929: RIB walk for afi VPNv4 Unicast: target version 15, min_fwdtable_version 15, import_version 15, label_version 17, table_version 17 Oct 15 12:50:29.921 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6777: Import walk: import ver 15 -> 17: 2 nets processed (2 paths updated) afi 4 forced/ms 0 Oct 15 12:50:29.921 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6748: Import walk: import ver 17 -> 19: 0 nets processed (0 paths updated) afi 4 forced/ms 0 Oct 15 12:50:29.921 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6777: Import walk: import ver 17 -> 19: 2 nets processed (0 paths updated) afi 4 forced/ms 0 Oct 15 12:50:29.921 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:18929: RIB walk for afi VPNv4 Unicast: target version 17, min_fwdtable_version 15, import_version 19, label_version 17, table_version 19 Oct 15 12:50:29.921 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:18965: RIBUPD_START: parentafi=4{rtrstate=6}, walkversion=[15 - 17]: tblver=19, labelver=17 Oct 15 12:50:29.921 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:4366: Config release label mode for table 0xe0000002 (mode:6, 6, 6) flags:0x201, 0x0 Oct 15 12:50:29.921 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:4366: Config release label mode for table 0xe0000003 (mode:6, 6, 6) flags:0x201, 0x0 Oct 15 12:50:29.921 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:9001: label walk afi:VPNv4 Unicast, lbl ver 17 -> 19, be 0, skp 0 upd 0 Oct 15 12:50:29.921 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:9006: label walk afi:VPNv4 Unicast, lbl ver 17 -> 19, be 0, skp 0 upd 1 Oct 15 12:50:29.922 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:19031: RIBUPD_END: parentafi=4{rtrstate=6}, walkversion=[15 - 17]: minfwdtblver=17(acked=17) Oct 15 12:50:29.922 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:19038: RIBUPD_END2: parentafi=4, prefixstats={install=0, skip=0, mod=0, wdr=0}, updtrigger=1 Oct 15 12:50:29.923 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:18929: RIB walk for afi VPNv4 Unicast: target version 19, min_fwdtable_version 17, import_version 19, label_version 19, table_version 19 Oct 15 12:50:29.923 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:18965: RIBUPD_START: parentafi=4{rtrstate=6}, walkversion=[17 - 19]: tblver=19, labelver=19 Oct 15 12:50:29.923 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:16216: send converge to RIB, afi VPNv4 Unicast, tableid 0xe0000002, converged 1, send_version 2, last_recv_version 2 Oct 15 12:50:29.924 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:17459: RIB :time_rib_batch tot_pfx = 2, rib_calls = 1, total_time = 1 ms, rib_api_time = 1 ms, avg_rib_api_time = 1 ms, max_rib_api_time = 1 ms Oct 15 12:50:29.924 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:17487: RIB(CUST-A-HUBIN:Vv4u): ver 17 -> 19 :pfx inst/upd/skip/rem 2/0/0/0 Oct 15 12:50:29.924 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:19031: RIBUPD_END: parentafi=4{rtrstate=6}, walkversion=[17 - 19]: minfwdtblver=19(acked=19) Oct 15 12:50:29.924 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:19038: RIBUPD_END2: parentafi=4, prefixstats={install=2, skip=0, mod=0, wdr=0}, updtrigger=1 Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13186: UPDGEN_UPD: table="TBL:default (1/128)", parentafi=4, afi=4, updgrp=0.2, subgrp=0.1 Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13190: UPDGEN_UPD2: table=0x00000000, subgrp=0.1, walktype=0(Regular), inputtargetver=19, pureRR=0 Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13193: UPDGEN_UPD3: walkversion=[15 - 19]: resumedver=0, advdisabled=0, completed=1, msgcount=0 Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13195: UPDGEN_UPD4: prefixstats={total=4, adv=0, wdn=0, skp=4, sup=0, bestext=0} Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13197: UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0} Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:default (1/128)) subgrp:(1) UG:(2) end 19 Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13186: UPDGEN_UPD: table="TBL:CUST-A-HUBIN (1/1)", parentafi=4, afi=0, updgrp=0.2, subgrp=0.1 Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13190: UPDGEN_UPD2: table=0xe0000002, subgrp=0.1, walktype=0(Regular), inputtargetver=19, pureRR=0 Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13193: UPDGEN_UPD3: walkversion=[15 - 19]: resumedver=0, advdisabled=0, completed=1, msgcount=2 Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13195: UPDGEN_UPD4: prefixstats={total=2, adv=2, wdn=0, skp=0, sup=0, bestext=0} Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13197: UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0} Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4101: UPDGEN_FG_APPEND: AFI=0, UG=2, FG=1, walktype=0, targetver=19: msgcount=2 Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4104: UPDGEN_FG_APPEND2: fg-prefixstats={adv=2, wdn=0, sup=0, skp=0} Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4101: UPDGEN_FG_APPEND: AFI=0, UG=2, FG=1, walktype=0, targetver=19: msgcount=1 Oct 15 12:50:29.948 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4104: UPDGEN_FG_APPEND2: fg-prefixstats={adv=2, wdn=0, sup=0, skp=0} Oct 15 12:50:29.948 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4659 [COMMON]:857: vrf 0x60000002 nbr 0x7e99eaace4c0, set peer ack version to 15, afi 0, loc 2 Oct 15 12:50:29.951 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13186: UPDGEN_UPD: table="TBL:CUST-A-HUBOUT (1/1)", parentafi=4, afi=0, updgrp=0.2, subgrp=0.1 Oct 15 12:50:29.951 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13190: UPDGEN_UPD2: table=0xe0000003, subgrp=0.1, walktype=0(Regular), inputtargetver=19, pureRR=0 Oct 15 12:50:29.951 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13193: UPDGEN_UPD3: walkversion=[15 - 19]: resumedver=0, advdisabled=0, completed=1, msgcount=0 Oct 15 12:50:29.951 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13195: UPDGEN_UPD4: prefixstats={total=0, adv=0, wdn=0, skp=0, sup=0, bestext=0} Oct 15 12:50:29.951 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13197: UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0} Oct 15 12:50:29.951 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:CUST-A-HUBOUT (1/1)) subgrp:(1) UG:(2) end 19 Oct 15 12:50:57.681 default-bgp/spkr-tr2-nbr 0/RP0/CPU0 t4660 [NBR]:1431: TBL:default (1/128), EOR rx-ed from vrf 0x60000000 nbr '4.4.4.4', afi:4, accepted prefix count:1, explicit:1 Oct 15 12:50:57.681 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6748: Import walk: import ver 19 -> 20: 0 nets processed (0 paths updated) afi 4 forced/ms 0 Oct 15 12:50:57.681 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6777: Import walk: import ver 19 -> 20: 1 nets processed (1 paths updated) afi 4 forced/ms 0 Oct 15 12:50:57.681 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6748: Import walk: import ver 20 -> 21: 0 nets processed (0 paths updated) afi 4 forced/ms 0 Oct 15 12:50:57.681 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6777: Import walk: import ver 20 -> 21: 1 nets processed (0 paths updated) afi 4 forced/ms 0 Oct 15 12:50:57.681 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:4366: Config release label mode for table 0xe0000002 (mode:6, 6, 6) flags:0x201, 0x0 Oct 15 12:50:57.681 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:18929: RIB walk for afi VPNv4 Unicast: target version 19, min_fwdtable_version 19, import_version 21, label_version 19, table_version 21 Oct 15 12:50:57.681 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:4366: Config release label mode for table 0xe0000003 (mode:6, 6, 6) flags:0x201, 0x0 Oct 15 12:50:57.681 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:9001: label walk afi:VPNv4 Unicast, lbl ver 19 -> 21, be 0, skp 0 upd 0 Oct 15 12:50:57.681 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:9006: label walk afi:VPNv4 Unicast, lbl ver 19 -> 21, be 0, skp 0 upd 1 Oct 15 12:50:57.682 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:18929: RIB walk for afi VPNv4 Unicast: target version 21, min_fwdtable_version 19, import_version 21, label_version 21, table_version 21 Oct 15 12:50:57.682 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:18965: RIBUPD_START: parentafi=4{rtrstate=6}, walkversion=[19 - 21]: tblver=21, labelver=21 Oct 15 12:50:57.682 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:16216: send converge to RIB, afi VPNv4 Unicast, tableid 0xe0000002, converged 1, send_version 2, last_recv_version 2 Oct 15 12:50:57.683 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:17459: RIB :time_rib_batch tot_pfx = 1, rib_calls = 1, total_time = 0 ms, rib_api_time = 0 ms, avg_rib_api_time = 0 ms, max_rib_api_time = 0 ms Oct 15 12:50:57.683 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:17487: RIB(CUST-A-HUBIN:Vv4u): ver 19 -> 21 :pfx inst/upd/skip/rem 1/0/0/0 Oct 15 12:50:57.683 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:19031: RIBUPD_END: parentafi=4{rtrstate=6}, walkversion=[19 - 21]: minfwdtblver=21(acked=21) Oct 15 12:50:57.683 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:19038: RIBUPD_END2: parentafi=4, prefixstats={install=1, skip=0, mod=0, wdr=0}, updtrigger=1 Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13186: UPDGEN_UPD: table="TBL:default (1/128)", parentafi=4, afi=4, updgrp=0.2, subgrp=0.1 Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13190: UPDGEN_UPD2: table=0x00000000, subgrp=0.1, walktype=0(Regular), inputtargetver=21, pureRR=0 Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13193: UPDGEN_UPD3: walkversion=[19 - 21]: resumedver=0, advdisabled=0, completed=1, msgcount=0 Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13195: UPDGEN_UPD4: prefixstats={total=2, adv=0, wdn=0, skp=2, sup=0, bestext=0} Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13197: UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0} Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:default (1/128)) subgrp:(1) UG:(2) end 21 Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13186: UPDGEN_UPD: table="TBL:CUST-A-HUBOUT (1/1)", parentafi=4, afi=0, updgrp=0.2, subgrp=0.1 Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13190: UPDGEN_UPD2: table=0xe0000003, subgrp=0.1, walktype=0(Regular), inputtargetver=21, pureRR=0 Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13193: UPDGEN_UPD3: walkversion=[19 - 21]: resumedver=0, advdisabled=0, completed=1, msgcount=0 Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13195: UPDGEN_UPD4: prefixstats={total=0, adv=0, wdn=0, skp=0, sup=0, bestext=0} Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13197: UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0} Oct 15 12:50:57.710 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:CUST-A-HUBOUT (1/1)) subgrp:(1) UG:(2) end 21 Oct 15 12:50:57.712 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13186: UPDGEN_UPD: table="TBL:CUST-A-HUBIN (1/1)", parentafi=4, afi=0, updgrp=0.2, subgrp=0.1 Oct 15 12:50:57.712 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13190: UPDGEN_UPD2: table=0xe0000002, subgrp=0.1, walktype=0(Regular), inputtargetver=21, pureRR=0 Oct 15 12:50:57.712 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13193: UPDGEN_UPD3: walkversion=[19 - 21]: resumedver=0, advdisabled=0, completed=1, msgcount=1 Oct 15 12:50:57.712 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13195: UPDGEN_UPD4: prefixstats={total=1, adv=1, wdn=0, skp=0, sup=0, bestext=0} Oct 15 12:50:57.712 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13197: UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0} Oct 15 12:50:57.712 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4101: UPDGEN_FG_APPEND: AFI=0, UG=2, FG=1, walktype=0, targetver=21: msgcount=1 Oct 15 12:50:57.712 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4104: UPDGEN_FG_APPEND2: fg-prefixstats={adv=1, wdn=0, sup=0, skp=0} Oct 15 12:50:57.713 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4659 [COMMON]:857: vrf 0x60000002 nbr 0x7e99eaace4c0, set peer ack version to 19, afi 0, loc 2 Oct 15 12:50:57.891 default-bgp/spkr-tr2-nbr 0/RP0/CPU0 t4658 [NBR]:1431: TBL:default (1/128), EOR rx-ed from vrf 0x60000000 nbr '4.4.4.4', afi:4, accepted prefix count:1, explicit:0 Oct 15 12:50:57.891 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6748: Import walk: import ver 21 -> 22: 0 nets processed (0 paths updated) afi 4 forced/ms 0 Oct 15 12:50:57.892 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:4366: Config release label mode for table 0xe0000002 (mode:6, 6, 6) flags:0x201, 0x0 Oct 15 12:50:57.892 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:4366: Config release label mode for table 0xe0000003 (mode:6, 6, 6) flags:0x201, 0x0 Oct 15 12:50:57.892 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:9001: label walk afi:VPNv4 Unicast, lbl ver 21 -> 22, be 0, skp 0 upd 0 Oct 15 12:50:57.892 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:9006: label walk afi:VPNv4 Unicast, lbl ver 21 -> 22, be 0, skp 0 upd 1 Oct 15 12:50:57.892 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6777: Import walk: import ver 21 -> 22: 1 nets processed (1 paths updated) afi 4 forced/ms 0 Oct 15 12:50:57.892 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6748: Import walk: import ver 22 -> 23: 0 nets processed (0 paths updated) afi 4 forced/ms 0 Oct 15 12:50:57.892 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:4366: Config release label mode for table 0xe0000002 (mode:6, 6, 6) flags:0x201, 0x0 Oct 15 12:50:57.892 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:4366: Config release label mode for table 0xe0000003 (mode:6, 6, 6) flags:0x201, 0x0 Oct 15 12:50:57.892 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:9001: label walk afi:VPNv4 Unicast, lbl ver 22 -> 23, be 0, skp 0 upd 0 Oct 15 12:50:57.892 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4645 [LABEL]:9006: label walk afi:VPNv4 Unicast, lbl ver 22 -> 23, be 0, skp 0 upd 1 Oct 15 12:50:57.892 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4661 [IMPORT]:6777: Import walk: import ver 22 -> 23: 1 nets processed (0 paths updated) afi 4 forced/ms 0 Oct 15 12:50:57.892 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:18929: RIB walk for afi VPNv4 Unicast: target version 23, min_fwdtable_version 21, import_version 23, label_version 23, table_version 23 Oct 15 12:50:57.892 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:18965: RIBUPD_START: parentafi=4{rtrstate=6}, walkversion=[21 - 23]: tblver=23, labelver=23 Oct 15 12:50:57.892 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:16216: send converge to RIB, afi VPNv4 Unicast, tableid 0xe0000002, converged 1, send_version 2, last_recv_version 2 Oct 15 12:50:57.893 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:17459: RIB :time_rib_batch tot_pfx = 1, rib_calls = 1, total_time = 1 ms, rib_api_time = 1 ms, avg_rib_api_time = 1 ms, max_rib_api_time = 1 ms Oct 15 12:50:57.893 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:17487: RIB(CUST-A-HUBIN:Vv4u): ver 21 -> 23 :pfx inst/upd/skip/rem 1/0/0/0 Oct 15 12:50:57.894 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:19031: RIBUPD_END: parentafi=4{rtrstate=6}, walkversion=[21 - 23]: minfwdtblver=23(acked=23) Oct 15 12:50:57.894 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4651 [RIB]:19038: RIBUPD_END2: parentafi=4, prefixstats={install=1, skip=0, mod=0, wdr=0}, updtrigger=1 Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13186: UPDGEN_UPD: table="TBL:default (1/128)", parentafi=4, afi=4, updgrp=0.2, subgrp=0.1 Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13190: UPDGEN_UPD2: table=0x00000000, subgrp=0.1, walktype=0(Regular), inputtargetver=23, pureRR=0 Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13193: UPDGEN_UPD3: walkversion=[21 - 23]: resumedver=0, advdisabled=0, completed=1, msgcount=0 Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13195: UPDGEN_UPD4: prefixstats={total=2, adv=0, wdn=0, skp=2, sup=0, bestext=0} Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13197: UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0} Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:default (1/128)) subgrp:(1) UG:(2) end 23 Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13186: UPDGEN_UPD: table="TBL:CUST-A-HUBIN (1/1)", parentafi=4, afi=0, updgrp=0.2, subgrp=0.1 Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13190: UPDGEN_UPD2: table=0xe0000002, subgrp=0.1, walktype=0(Regular), inputtargetver=23, pureRR=0 Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13193: UPDGEN_UPD3: walkversion=[21 - 23]: resumedver=0, advdisabled=0, completed=1, msgcount=1 Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13195: UPDGEN_UPD4: prefixstats={total=1, adv=1, wdn=0, skp=0, sup=0, bestext=0} Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13197: UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0} Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4101: UPDGEN_FG_APPEND: AFI=0, UG=2, FG=1, walktype=0, targetver=23: msgcount=1 Oct 15 12:50:57.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:4104: UPDGEN_FG_APPEND2: fg-prefixstats={adv=1, wdn=0, sup=0, skp=0} Oct 15 12:50:57.921 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4659 [COMMON]:857: vrf 0x60000002 nbr 0x7e99eaace4c0, set peer ack version to 21, afi 0, loc 2 Oct 15 12:50:57.923 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13186: UPDGEN_UPD: table="TBL:CUST-A-HUBOUT (1/1)", parentafi=4, afi=0, updgrp=0.2, subgrp=0.1 Oct 15 12:50:57.923 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13190: UPDGEN_UPD2: table=0xe0000003, subgrp=0.1, walktype=0(Regular), inputtargetver=23, pureRR=0 Oct 15 12:50:57.923 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13193: UPDGEN_UPD3: walkversion=[21 - 23]: resumedver=0, advdisabled=0, completed=1, msgcount=0 Oct 15 12:50:57.923 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13195: UPDGEN_UPD4: prefixstats={total=0, adv=0, wdn=0, skp=0, sup=0, bestext=0} Oct 15 12:50:57.923 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13197: UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0} Oct 15 12:50:57.923 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4662 [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:CUST-A-HUBOUT (1/1)) subgrp:(1) UG:(2) end 23 Oct 15 12:51:27.774 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4659 [COMMON]:857: vrf 0x60000003 nbr 0x7e99eaacc980, set peer ack version to 15, afi 0, loc 2 Oct 15 12:51:27.774 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4659 [COMMON]:1000: vrf 0x60000003 nbr 0x7e99eaacc980, set peer ack version to 23, afi 0, loc 3 Oct 15 12:51:27.774 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4659 [COMMON]:857: vrf 0x60000000 nbr 0x7e99eaad1b40, set peer ack version to 15, afi 4, loc 2 Oct 15 12:51:27.774 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4659 [COMMON]:1000: vrf 0x60000000 nbr 0x7e99eaad1b40, set peer ack version to 23, afi 4, loc 3 Oct 15 12:51:27.774 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4659 [COMMON]:857: vrf 0x60000000 nbr 0x7e99eaad0000, set peer ack version to 15, afi 4, loc 2 Oct 15 12:51:27.774 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4659 [COMMON]:1000: vrf 0x60000000 nbr 0x7e99eaad0000, set peer ack version to 23, afi 4, loc 3 Oct 15 12:52:12.776 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4659 [COMMON]:857: vrf 0x60000002 nbr 0x7e99eaace4c0, set peer ack version to 23, afi 0, loc 2 Oct 15 12:52:15.964 default-bgp/spkr-tr2-sync 0/RP0/CPU0 t4665 [SYNC]:2280: reached initsync version 13 for afi VPNv4 Unicast, min_nbr_ack version 23, scanner_runs 3 Oct 15 12:52:15.964 default-bgp/spkr-tr2-sync 0/RP0/CPU0 t4665 [SYNC]:1792: NSR event: 'End of Convergence' on active Oct 15 12:52:15.964 default-bgp/spkr-tr2-sync 0/RP0/CPU0 t4665 [SYNC]:1792: NSR event: 'End of Convergence' on active Oct 15 12:52:15.964 default-bgp/spkr-tr2-sync 0/RP0/CPU0 t4663 [SYNC]:6368: active NSR state transition for 'Standby Sync-group', event 'End of Convergence', 'Active Ready' -> 'Active Ready', mask 0x12 Oct 15 12:52:15.964 default-bgp/spkr-tr2-sync 0/RP0/CPU0 t4663 [SYNC]:6368: active NSR state transition for 'ISSU Sync-group', event 'End of Convergence', 'None' -> 'None', mask 0x10 Oct 15 12:52:15.964 default-bgp/spkr-tr2-issu 0/RP0/CPU0 t4663 [ISSU]:541: ISM: ISSU Not enabled Oct 15 12:52:15.964 default-bgp/spkr-tr2-sync 0/RP0/CPU0 t4663 [SYNC]:6460: send active up msg to 'ISSU Sync-group' 'Unknown', after NSR restart or tcp restart Oct 15 12:52:15.964 default-bgp/spkr-tr2-sync 0/RP0/CPU0 t4663 [SYNC]:5241: scoped sync: trigger forced cleanup, batch state 0, count 0 Oct 15 12:52:15.965 default-bgp/spkr-tr2-sync 0/RP0/CPU0 t4619 [SYNC]:4950: scoped sync: forced cleanup, batch state 0 Oct 15 12:52:15.965 default-bgp/spkr-tr2-sync 0/RP0/CPU0 t4619 [SYNC]:4952: scoped sync: batch state change from 0 to 0 Oct 15 12:52:15.965 default-bgp/spkr-tr2-sync 0/RP0/CPU0 t4663 [SYNC]:8714: scoped sync: skip sending table update done, global NSR not ready