RP/0/RP0/CPU0:PE3#show bgp trace | utility tail -n 150
Tue Oct 13 00:25:50.752 UTC
Oct 13 00:13:53.891 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:957: Updgen - Resending table to neighbor 2.2.2.2, afi VPNv4 Unicastrt-size 0,  parallel refresh 0, route-refresh 0
Oct 13 00:13:55.699 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4424  [COMMON]:2504: nbr soft-reconfig  'ptr: 0x70c9c29de000',afi: 4 af_flag: 0x011100a4 af3_flag: 0x00080000 loc: 1
Oct 13 00:13:55.699 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4424  [COMMON]:2571: soft-reconfig delayed bestpath: elapsed time(ms) 0, total run 0 , afi VPNv4 Unicast, count 1
Oct 13 00:13:55.891 default-bgp/spkr-tr2-postit 0/RP0/CPU0 t4424  [POSTIT]:7502: skip pending postit: nbr: 2.2.2.2, afi: 4, global nsr not ready
Oct 13 00:13:55.891 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2102: Filter-group op (Filter-group Rm Nbr) Tbl/Nbr(Afi:VPNv4 Unicast:Nbr:2.2.2.2) fgrp idx 0.2 subgrp idx 0.1 updgrp 0.2 rtset 0
Oct 13 00:13:55.891 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4424  [COMMON]:6095: nbr_ptr 0x70c9c29de000 resend updates, afi VPNv4 Unicast, versions: 0, 0 fl:0x4
Oct 13 00:13:55.891 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2244: Filter-group op (Filter-group Compute Nbr RT) Tbl/Nbr(2.2.2.2) fgrp idx 0.2 subgrp idx 0.1 updgrp 0.2 rtset 0
Oct 13 00:13:55.891 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1476: Filter-group op (Alloc) Tbl/Nbr(TBL:default (1/128)) fgrp idx 0.1 subgrp idx 0.2 updgrp 0.0 rtset 2
Oct 13 00:13:55.891 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2792: Filter-group op (Filter-group Add Nbr new) Tbl/Nbr(Afi:VPNv4 Unicast:Vrf:default:Nbr:2.2.2.2) fgrp idx 0.1 subgrp idx 0.2 updgrp 0.2 rtset 0
Oct 13 00:13:55.891 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2818: created filtergrp 1 for vrf 0x60000000 nbr 2.2.2.2, afi 4, subgrp version 0, refresh 0
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13186: UPDGEN_UPD: table="TBL:default (1/128)", parentafi=4, afi=4, updgrp=0.2, subgrp=0.2
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13190:   UPDGEN_UPD2: table=0x00000000, subgrp=0.2, walktype=0(Regular), inputtargetver=41, pureRR=0
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13193:   UPDGEN_UPD3: walkversion=[0 - 41]: resumedver=0, advdisabled=0, completed=1, msgcount=4
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13195:   UPDGEN_UPD4: prefixstats={total=11, adv=5, wdn=0, skp=6, sup=0, bestext=0}
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13197:   UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0}
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:4101:    UPDGEN_FG_APPEND: AFI=4, UG=2, FG=1, walktype=0, targetver=41: msgcount=4
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:4104:      UPDGEN_FG_APPEND2: fg-prefixstats={adv=5, wdn=0, sup=0, skp=6}
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:5482: Resync AF 'VPNv4 Unicast' upd-grp 0.2: Merged sub-grp 0.1 (1 nbrs) and sub-grp 0.2 (1 nbrs) into sub-grp 0.2 (2 nbrs)
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2951: Resynch VPNv4 Unicast Filter-group subgrp 0.2: merged f-group 0.2 (1 nbrs) and f-group 0.1 (1 nbrs) into 
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1566: Filter-group op (Delete) Tbl/Nbr(TBL:default (1/128)) fgrp idx 0.2 subgrp idx 0.1 updgrp 0.0 rtset 1
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1062: Update gen release-index bit operation TBL:default (1/128) fgrp idx/size 0
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1079: Update gen release-index for bit operation TBL:default (1/128) fgrp idx/size 2
Oct 13 00:13:55.920 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:3392: TBL:default (1/128) delete subgrp UG/SG:2/1 subgrp:0x70c96c016d60 caller 0x5b431b535576
Oct 13 00:14:52.440 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:3184: TBL:default (1/128) free subgrp SG:1 subgrp:0x70c96c016d60
Oct 13 00:14:52.440 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:3184: TBL:default (1/128) free subgrp SG:3 subgrp:0x70c96c017d40
Oct 13 00:14:52.941 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4418  [COMMON]:857: vrf 0x60000003 nbr 0x70c9c29da980, set peer ack version to 41, afi 0, loc 2
Oct 13 00:14:52.941 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4418  [COMMON]:857: vrf 0x60000000 nbr 0x70c9c29dfb40, set peer ack version to 41, afi 4, loc 2
Oct 13 00:15:07.941 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4418  [COMMON]:857: vrf 0x60000000 nbr 0x70c9c29de000, set peer ack version to 41, afi 4, loc 2
Oct 13 00:17:40.209 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4408  [LABEL]:3971:  Label RPF download LSD   | processed:    0 err: 0
Oct 13 00:20:34.733 default-bgp/spkr-tr2-ev 0/RP0/CPU0 t4389  [EV]:4308: VRF DB BGP SVD PROJECT
Oct 13 00:20:34.733 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4389  [IMPORT]:8590: Import Table Reset AFI:VPNv4 Unicast Imp_Res:1 Trigger:1
Oct 13 00:20:34.734 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4420  [IMPORT]:8753: Import Reset Trigger AFI:L2VPN EVPN
Oct 13 00:20:34.734 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4420  [IMPORT]:8756: Import Reset Trigger AFI:VPNv4 Unicast
Oct 13 00:20:34.734 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4420  [IMPORT]:7571: Import Table Reset Handler AFI:VPNv4 Unicast Imp_Res:1
Oct 13 00:20:39.734 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4420  [IMPORT]:8821: Import Reset Expiry AFI:VPNv4 Unicast
Oct 13 00:20:39.734 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4420  [IMPORT]:6748: Import walk: import ver 0 -> 41: 0 nets processed (0 paths updated) afi 4 forced/ms 1
Oct 13 00:20:39.734 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4420  [IMPORT]:6777: Import walk: import ver 0 -> 41: 11 nets processed (0 paths updated) afi 4 forced/ms 0
Oct 13 00:20:39.734 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4420  [IMPORT]:6748: Import walk: import ver 41 -> 43: 0 nets processed (0 paths updated) afi 4 forced/ms 0
Oct 13 00:20:39.734 default-bgp/spkr-tr2-imp 0/RP0/CPU0 t4420  [IMPORT]:6777: Import walk: import ver 41 -> 43: 2 nets processed (0 paths updated) afi 4 forced/ms 0
Oct 13 00:20:39.734 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4412  [RIB]:18929: RIB walk for afi VPNv4 Unicast: target version 41, min_fwdtable_version 41, import_version 43,  label_version 41, table_version 43
Oct 13 00:20:39.735 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4408  [LABEL]:4366: Config release label mode for table 0xe0000002 (mode:6, 6, 6) flags:0x201, 0x0
Oct 13 00:20:39.735 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4408  [LABEL]:4366: Config release label mode for table 0xe0000003 (mode:6, 6, 6) flags:0x201, 0x0
Oct 13 00:20:39.735 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4408  [LABEL]:9001: label walk afi:VPNv4 Unicast, lbl ver 41 -> 43, be 0, skp 0  upd 0
Oct 13 00:20:39.735 default-bgp/spkr-tr2-label 0/RP0/CPU0 t4408  [LABEL]:9006: label walk afi:VPNv4 Unicast, lbl ver 41 -> 43, be 0, skp 0  upd 1
Oct 13 00:20:39.735 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4412  [RIB]:18929: RIB walk for afi VPNv4 Unicast: target version 43, min_fwdtable_version 41, import_version 43,  label_version 43, table_version 43
Oct 13 00:20:39.735 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4412  [RIB]:18965: RIBUPD_START: parentafi=4{rtrstate=6}, walkversion=[41 - 43]: tblver=43, labelver=43
Oct 13 00:20:39.736 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4412  [RIB]:16216: send converge to RIB, afi VPNv4 Unicast, tableid 0xe0000003, converged 1, send_version 3, last_recv_version 3
Oct 13 00:20:39.737 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4412  [RIB]:17459: RIB :time_rib_batch tot_pfx = 2, 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 13 00:20:39.737 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4412  [RIB]:17487: RIB(CUST-B:Vv4u): ver 41 -> 43 :pfx inst/upd/skip/rem 0/0/0/2
Oct 13 00:20:39.737 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4412  [RIB]:19031: RIBUPD_END: parentafi=4{rtrstate=6}, walkversion=[41 - 43]: minfwdtblver=43(acked=43)
Oct 13 00:20:39.737 default-bgp/spkr-tr2-rib 0/RP0/CPU0 t4412  [RIB]:19038:   RIBUPD_END2: parentafi=4, prefixstats={install=0, skip=0, mod=0, wdr=2}, updtrigger=1
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13186: UPDGEN_UPD: table="TBL:CUST-A (1/1)", parentafi=4, afi=0, updgrp=0.2, subgrp=0.1
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13190:   UPDGEN_UPD2: table=0xe0000002, subgrp=0.1, walktype=1(Quick-withdraw), inputtargetver=43, pureRR=0
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13193:   UPDGEN_UPD3: walkversion=[41 - 43]: resumedver=0, advdisabled=0, completed=1, msgcount=0
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13195:   UPDGEN_UPD4: prefixstats={total=0, adv=0, wdn=0, skp=0, sup=0, bestext=0}
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13197:   UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0}
Oct 13 00:20:39.745 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4421  [COMMON]:3717: vrf 0x60000002 nbr 0x70c9c29dc4c0, set peer ack version to 41, afi 0, loc 4
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:CUST-A (1/1)) subgrp:(1) UG:(2) end 43
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13186: UPDGEN_UPD: table="TBL:CUST-B (1/1)", parentafi=4, afi=0, updgrp=0.2, subgrp=0.1
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13190:   UPDGEN_UPD2: table=0xe0000003, subgrp=0.1, walktype=1(Quick-withdraw), inputtargetver=43, pureRR=0
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13193:   UPDGEN_UPD3: walkversion=[41 - 43]: resumedver=0, advdisabled=0, completed=1, msgcount=1
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13195:   UPDGEN_UPD4: prefixstats={total=2, adv=0, wdn=2, skp=0, sup=0, bestext=0}
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13197:   UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0}
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:4101:    UPDGEN_FG_APPEND: AFI=0, UG=2, FG=1, walktype=1, targetver=43: msgcount=1
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:4104:      UPDGEN_FG_APPEND2: fg-prefixstats={adv=0, wdn=2, sup=0, skp=0}
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13186: UPDGEN_UPD: table="TBL:default (1/128)", parentafi=4, afi=4, updgrp=0.2, subgrp=0.2
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13190:   UPDGEN_UPD2: table=0x00000000, subgrp=0.2, walktype=1(Quick-withdraw), inputtargetver=43, pureRR=0
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13193:   UPDGEN_UPD3: walkversion=[41 - 43]: resumedver=0, advdisabled=0, completed=1, msgcount=0
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13195:   UPDGEN_UPD4: prefixstats={total=2, adv=0, wdn=0, skp=2, sup=0, bestext=0}
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13197:   UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0}
Oct 13 00:20:39.745 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4421  [COMMON]:3717: vrf 0x60000000 nbr 0x70c9c29dfb40, set peer ack version to 41, afi 4, loc 4
Oct 13 00:20:39.745 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4421  [COMMON]:3717: vrf 0x60000000 nbr 0x70c9c29de000, set peer ack version to 41, afi 4, loc 4
Oct 13 00:20:39.745 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:default (1/128)) subgrp:(2) UG:(2) end 43
Oct 13 00:20:39.761 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13186: UPDGEN_UPD: table="TBL:default (1/128)", parentafi=4, afi=4, updgrp=0.2, subgrp=0.2
Oct 13 00:20:39.761 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13190:   UPDGEN_UPD2: table=0x00000000, subgrp=0.2, walktype=0(Regular), inputtargetver=43, pureRR=0
Oct 13 00:20:39.761 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13193:   UPDGEN_UPD3: walkversion=[41 - 43]: resumedver=0, advdisabled=0, completed=1, msgcount=0
Oct 13 00:20:39.761 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13195:   UPDGEN_UPD4: prefixstats={total=0, adv=0, wdn=0, skp=0, sup=0, bestext=0}
Oct 13 00:20:39.761 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13197:   UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0}
Oct 13 00:20:39.761 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4421  [COMMON]:3717: vrf 0x60000000 nbr 0x70c9c29dfb40, set peer ack version to 43, afi 4, loc 4
Oct 13 00:20:39.761 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4421  [COMMON]:3717: vrf 0x60000000 nbr 0x70c9c29de000, set peer ack version to 43, afi 4, loc 4
Oct 13 00:20:39.761 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:default (1/128)) subgrp:(2) UG:(2) end 43
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13186: UPDGEN_UPD: table="TBL:CUST-B (1/1)", parentafi=4, afi=0, updgrp=0.2, subgrp=0.1
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13190:   UPDGEN_UPD2: table=0xe0000003, subgrp=0.1, walktype=0(Regular), inputtargetver=43, pureRR=0
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13193:   UPDGEN_UPD3: walkversion=[41 - 43]: resumedver=0, advdisabled=0, completed=1, msgcount=0
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13195:   UPDGEN_UPD4: prefixstats={total=0, adv=0, wdn=0, skp=0, sup=0, bestext=0}
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13197:   UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0}
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:CUST-B (1/1)) subgrp:(1) UG:(2) end 43
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13186: UPDGEN_UPD: table="TBL:CUST-A (1/1)", parentafi=4, afi=0, updgrp=0.2, subgrp=0.1
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13190:   UPDGEN_UPD2: table=0xe0000002, subgrp=0.1, walktype=0(Regular), inputtargetver=43, pureRR=0
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13193:   UPDGEN_UPD3: walkversion=[41 - 43]: resumedver=0, advdisabled=0, completed=1, msgcount=0
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13195:   UPDGEN_UPD4: prefixstats={total=0, adv=0, wdn=0, skp=0, sup=0, bestext=0}
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13197:   UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0}
Oct 13 00:20:39.764 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4421  [COMMON]:3717: vrf 0x60000002 nbr 0x70c9c29dc4c0, set peer ack version to 43, afi 0, loc 4
Oct 13 00:20:39.764 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13360: Updgen - Skip EoR for Tbl:(TBL:CUST-A (1/1)) subgrp:(1) UG:(2) end 43
Oct 13 00:20:47.120 default-bgp/spkr-tr2-postit 0/RP0/CPU0 t4389  [POSTIT]:5163: skip postit: 'Outbound user soft clear', nbr: 1.1.1.1, reason: 1
Oct 13 00:20:47.120 default-bgp/spkr-tr2-postit 0/RP0/CPU0 t4424  [POSTIT]:5163: skip postit: 'None', nbr: 1.1.1.1, reason: 1
Oct 13 00:20:47.120 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:957: Updgen - Resending table to neighbor 1.1.1.1, afi VPNv4 Unicastrt-size 0,  parallel refresh 0, route-refresh 0
Oct 13 00:20:48.837 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4424  [COMMON]:2504: nbr soft-reconfig  'ptr: 0x70c9c29dfb40',afi: 4 af_flag: 0x011100a4 af3_flag: 0x00080000 loc: 1
Oct 13 00:20:48.837 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4424  [COMMON]:2571: soft-reconfig delayed bestpath: elapsed time(ms) 0, total run 0 , afi VPNv4 Unicast, count 1
Oct 13 00:20:49.121 default-bgp/spkr-tr2-postit 0/RP0/CPU0 t4424  [POSTIT]:7502: skip pending postit: nbr: 1.1.1.1, afi: 4, global nsr not ready
Oct 13 00:20:49.121 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2102: Filter-group op (Filter-group Rm Nbr) Tbl/Nbr(Afi:VPNv4 Unicast:Nbr:1.1.1.1) fgrp idx 0.1 subgrp idx 0.2 updgrp 0.2 rtset 0
Oct 13 00:20:49.121 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4424  [COMMON]:6095: nbr_ptr 0x70c9c29dfb40 resend updates, afi VPNv4 Unicast, versions: 0, 0 fl:0x4
Oct 13 00:20:49.121 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2244: Filter-group op (Filter-group Compute Nbr RT) Tbl/Nbr(1.1.1.1) fgrp idx 0.1 subgrp idx 0.2 updgrp 0.2 rtset 0
Oct 13 00:20:49.121 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1476: Filter-group op (Alloc) Tbl/Nbr(TBL:default (1/128)) fgrp idx 0.2 subgrp idx 0.1 updgrp 0.0 rtset 2
Oct 13 00:20:49.121 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2792: Filter-group op (Filter-group Add Nbr new) Tbl/Nbr(Afi:VPNv4 Unicast:Vrf:default:Nbr:1.1.1.1) fgrp idx 0.2 subgrp idx 0.1 updgrp 0.2 rtset 0
Oct 13 00:20:49.121 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2818: created filtergrp 2 for vrf 0x60000000 nbr 1.1.1.1, afi 4, subgrp version 0, refresh 0
Oct 13 00:20:49.189 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13186: UPDGEN_UPD: table="TBL:default (1/128)", parentafi=4, afi=4, updgrp=0.2, subgrp=0.1
Oct 13 00:20:49.189 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13190:   UPDGEN_UPD2: table=0x00000000, subgrp=0.1, walktype=0(Regular), inputtargetver=43, pureRR=0
Oct 13 00:20:49.189 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13193:   UPDGEN_UPD3: walkversion=[0 - 43]: resumedver=0, advdisabled=0, completed=1, msgcount=4
Oct 13 00:20:49.189 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13195:   UPDGEN_UPD4: prefixstats={total=9, adv=5, wdn=0, skp=4, sup=0, bestext=0}
Oct 13 00:20:49.189 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13197:   UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0}
Oct 13 00:20:49.189 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:4101:    UPDGEN_FG_APPEND: AFI=4, UG=2, FG=2, walktype=0, targetver=43: msgcount=4
Oct 13 00:20:49.189 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:4104:      UPDGEN_FG_APPEND2: fg-prefixstats={adv=5, wdn=0, sup=0, skp=4}
Oct 13 00:20:49.190 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:5482: Resync AF 'VPNv4 Unicast' upd-grp 0.2: Merged sub-grp 0.2 (1 nbrs) and sub-grp 0.1 (1 nbrs) into sub-grp 0.1 (2 nbrs)
Oct 13 00:20:49.190 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2951: Resynch VPNv4 Unicast Filter-group subgrp 0.1: merged f-group 0.1 (1 nbrs) and f-group 0.2 (1 nbrs) into 
Oct 13 00:20:49.190 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1566: Filter-group op (Delete) Tbl/Nbr(TBL:default (1/128)) fgrp idx 0.1 subgrp idx 0.2 updgrp 0.0 rtset 1
Oct 13 00:20:49.190 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1062: Update gen release-index bit operation TBL:default (1/128) fgrp idx/size 0
Oct 13 00:20:49.190 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1079: Update gen release-index for bit operation TBL:default (1/128) fgrp idx/size 1
Oct 13 00:20:49.190 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:3392: TBL:default (1/128) delete subgrp UG/SG:2/2 subgrp:0x70c96c018430 caller 0x5b431b535576
Oct 13 00:20:50.690 default-bgp/spkr-tr2-postit 0/RP0/CPU0 t4389  [POSTIT]:5163: skip postit: 'Outbound user soft clear', nbr: 2.2.2.2, reason: 1
Oct 13 00:20:50.690 default-bgp/spkr-tr2-postit 0/RP0/CPU0 t4424  [POSTIT]:5163: skip postit: 'None', nbr: 2.2.2.2, reason: 1
Oct 13 00:20:50.690 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:957: Updgen - Resending table to neighbor 2.2.2.2, afi VPNv4 Unicastrt-size 0,  parallel refresh 0, route-refresh 0
Oct 13 00:20:52.338 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4424  [COMMON]:2504: nbr soft-reconfig  'ptr: 0x70c9c29de000',afi: 4 af_flag: 0x011100a4 af3_flag: 0x00080000 loc: 1
Oct 13 00:20:52.339 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4424  [COMMON]:2571: soft-reconfig delayed bestpath: elapsed time(ms) 1, total run 0 , afi VPNv4 Unicast, count 1
Oct 13 00:20:52.691 default-bgp/spkr-tr2-postit 0/RP0/CPU0 t4424  [POSTIT]:7502: skip pending postit: nbr: 2.2.2.2, afi: 4, global nsr not ready
Oct 13 00:20:52.691 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2102: Filter-group op (Filter-group Rm Nbr) Tbl/Nbr(Afi:VPNv4 Unicast:Nbr:2.2.2.2) fgrp idx 0.2 subgrp idx 0.1 updgrp 0.2 rtset 0
Oct 13 00:20:52.691 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4424  [COMMON]:6095: nbr_ptr 0x70c9c29de000 resend updates, afi VPNv4 Unicast, versions: 0, 0 fl:0x4
Oct 13 00:20:52.691 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2244: Filter-group op (Filter-group Compute Nbr RT) Tbl/Nbr(2.2.2.2) fgrp idx 0.2 subgrp idx 0.1 updgrp 0.2 rtset 0
Oct 13 00:20:52.691 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1476: Filter-group op (Alloc) Tbl/Nbr(TBL:default (1/128)) fgrp idx 0.1 subgrp idx 0.3 updgrp 0.0 rtset 2
Oct 13 00:20:52.691 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2792: Filter-group op (Filter-group Add Nbr new) Tbl/Nbr(Afi:VPNv4 Unicast:Vrf:default:Nbr:2.2.2.2) fgrp idx 0.1 subgrp idx 0.3 updgrp 0.2 rtset 0
Oct 13 00:20:52.691 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2818: created filtergrp 1 for vrf 0x60000000 nbr 2.2.2.2, afi 4, subgrp version 0, refresh 0
Oct 13 00:20:52.716 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13186: UPDGEN_UPD: table="TBL:default (1/128)", parentafi=4, afi=4, updgrp=0.2, subgrp=0.3
Oct 13 00:20:52.716 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13190:   UPDGEN_UPD2: table=0x00000000, subgrp=0.3, walktype=0(Regular), inputtargetver=43, pureRR=0
Oct 13 00:20:52.716 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13193:   UPDGEN_UPD3: walkversion=[0 - 43]: resumedver=0, advdisabled=0, completed=1, msgcount=4
Oct 13 00:20:52.716 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13195:   UPDGEN_UPD4: prefixstats={total=9, adv=5, wdn=0, skp=4, sup=0, bestext=0}
Oct 13 00:20:52.716 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:13197:   UPDGEN_UPD5: prefixstats={fg_wdn=0, fg_skp=0}
Oct 13 00:20:52.716 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:4101:    UPDGEN_FG_APPEND: AFI=4, UG=2, FG=1, walktype=0, targetver=43: msgcount=4
Oct 13 00:20:52.716 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:4104:      UPDGEN_FG_APPEND2: fg-prefixstats={adv=5, wdn=0, sup=0, skp=4}
Oct 13 00:20:52.717 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:5482: Resync AF 'VPNv4 Unicast' upd-grp 0.2: Merged sub-grp 0.1 (1 nbrs) and sub-grp 0.3 (1 nbrs) into sub-grp 0.3 (2 nbrs)
Oct 13 00:20:52.717 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:2951: Resynch VPNv4 Unicast Filter-group subgrp 0.3: merged f-group 0.2 (1 nbrs) and f-group 0.1 (1 nbrs) into 
Oct 13 00:20:52.717 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1566: Filter-group op (Delete) Tbl/Nbr(TBL:default (1/128)) fgrp idx 0.2 subgrp idx 0.1 updgrp 0.0 rtset 1
Oct 13 00:20:52.717 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1062: Update gen release-index bit operation TBL:default (1/128) fgrp idx/size 0
Oct 13 00:20:52.717 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:1079: Update gen release-index for bit operation TBL:default (1/128) fgrp idx/size 2
Oct 13 00:20:52.717 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4424  [UPD]:3392: TBL:default (1/128) delete subgrp UG/SG:2/1 subgrp:0x70c96c016d60 caller 0x5b431b535576
Oct 13 00:21:49.190 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:3184: TBL:default (1/128) free subgrp SG:1 subgrp:0x70c96c016d60
Oct 13 00:21:49.190 default-bgp/spkr-tr2-upd 0/RP0/CPU0 t4421  [UPD]:3184: TBL:default (1/128) free subgrp SG:2 subgrp:0x70c96c018430
Oct 13 00:21:52.951 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4418  [COMMON]:857: vrf 0x60000003 nbr 0x70c9c29da980, set peer ack version to 41, afi 0, loc 2
Oct 13 00:21:52.951 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4418  [COMMON]:1000: vrf 0x60000003 nbr 0x70c9c29da980, set peer ack version to 43, afi 0, loc 3
Oct 13 00:21:52.951 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4418  [COMMON]:857: vrf 0x60000000 nbr 0x70c9c29dfb40, set peer ack version to 43, afi 4, loc 2
Oct 13 00:21:52.951 default-bgp/spkr-tr2-common 0/RP0/CPU0 t4418  [COMMON]:857: vrf 0x60000000 nbr 0x70c9c29de000, set peer ack version to 43, afi 4, loc 2