RP/0/RP0/CPU0:PE1#show mpls ldp trace binding | include "6.6.6.6/32" Sun Sep 20 12:48:44.252 UTC Sep 20 12:04:53.111 mpls/ldp/bndg 0/RP0/CPU0 t4177 [BNDG]:161: VRF(0x60000000): Prefix(6.6.6.6/32): Created, reason 3 Sep 20 12:04:53.112 mpls/ldp/bndg 0/RP0/CPU0 t4177 [BNDG]:221: VRF(0x60000000): Prefix(6.6.6.6/32): label 24006 (rev#20) assigned Sep 20 12:04:57.719 mpls/ldp/bndg 0/RP0/CPU0 t4177 [BNDG]:279: VRF(0x60000000): Prefix(6.6.6.6/32): Add label 24005 from peer 3.3.3.3:0 RP/0/RP0/CPU0:PE1#show mpls ldp trace peer Sun Sep 20 12:48:44.355 UTC RP/0/RP0/CPU0:PE1#show mpls ldp trace discovery Sun Sep 20 12:48:44.458 UTC 2 wrapping entries (1027456 possible, 2688 allocated, 475 filtered, 477 total) Sep 20 12:04:11.167 mpls/ldp/adj 0/RP0/CPU0 t4177 [DISC]:347: VRF(0x60000000): Peer(3.3.3.3): Actv/pasv new_role=2, old_role=0, ldpid_arb=1, chg_cnt=1 Sep 20 12:04:11.171 mpls/ldp/adj 0/RP0/CPU0 t4177 [DISC]:709: VRF(0x60000000): Adj(10.2.3.3): Create; link, intf GigabitEthernet0/0/0/1 (ifh 0x20), xport_addr 3.3.3.3, ldp_id 3.3.3.3:0 RP/0/RP0/CPU0:PE1#show mpls ldp trace forwarding Sun Sep 20 12:48:44.567 UTC 102 wrapping entries (1027456 possible, 2688 allocated, 375 filtered, 477 total) Sep 20 12:04:01.371 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2276: lsd_c_init Sep 20 12:04:02.377 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1641: lsd bind Sep 20 12:04:08.987 mpls/ldp/str 0/RP0/CPU0 t4599 [FWDG]:1429: lsd_c_notify event: connect Sep 20 12:04:09.064 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1482: lsd_c_app_reg2: flags=0x1, recov_time=15 sec Sep 20 12:04:34.072 mpls/ldp/str 0/RP0/CPU0 t4599 [FWDG]:1496: lsd_c_notify event: app_reg Sep 20 12:04:34.072 mpls/ldp/str 0/RP0/CPU0 t4599 [FWDG]:1571: lsd_c_notify event: entropy_lbl_disable Sep 20 12:04:34.072 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:573: LSD Intf-Enable: GigabitEthernet0/0/0/1 (ifh 0x20), ftype=1 Sep 20 12:04:34.072 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:34.072 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:3316: MFI Label Alloc OOR cleared (timed_out 0 lsd_restart 1) at af=IPv4 Sep 20 12:04:34.072 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 1 items to mfi queue - queue now contains 1 items Sep 20 12:04:34.072 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (1 items: 0 ctrl, 1 intf, 0 lbl, 0 rw) - last bulk-id=1 Sep 20 12:04:34.073 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 1 reply_cnt 1 Sep 20 12:04:34.074 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (1 items: 0 ctrl, 1 intf, 0 lbl, 0 rw) - last bulk-id=1 Sep 20 12:04:34.074 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 1 items from mfi queue - queue now contains 0 items Sep 20 12:04:34.107 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:34.107 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 1 items to mfi queue - queue now contains 1 items Sep 20 12:04:34.107 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:34.107 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:347: LSD Ctrl-Op: Rsrc-Complete Sep 20 12:04:34.107 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 4 items to mfi queue - queue now contains 5 items Sep 20 12:04:34.107 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (1 items: 0 ctrl, 0 intf, 1 lbl, 0 rw) - last bulk-id=2 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 1 reply_cnt 1 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (4 items: 1 ctrl, 0 intf, 3 lbl, 0 rw) - last bulk-id=6 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 3.3.3.3/32, lcl_lbl 24000 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1665: Tbl(0xe0000000): #7 LSD Lbl-RW-Create: FEC 3.3.3.3/32 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1721: Tbl(0xe0000000): #7 LSD RW-Create: lcl_lbl 24000 -- 1/1 lbl paths Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (1 items: 0 ctrl, 0 intf, 1 lbl, 0 rw) - last bulk-id=2 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 1 items from mfi queue - queue now contains 4 items Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 1 items to mfi queue - queue now contains 5 items Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 4 reply_cnt 4 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 10.3.4.0/24, lcl_lbl 24001 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1665: Tbl(0xe0000000): #8 LSD Lbl-RW-Create: FEC 10.3.4.0/24 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1721: Tbl(0xe0000000): #8 LSD RW-Create: lcl_lbl 24001 -- 1/1 lbl paths Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (1 items: 0 ctrl, 0 intf, 0 lbl, 1 rw) - last bulk-id=7 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 4.4.4.4/32, lcl_lbl 24002 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1665: Tbl(0xe0000000): #9 LSD Lbl-RW-Create: FEC 4.4.4.4/32 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1721: Tbl(0xe0000000): #9 LSD RW-Create: lcl_lbl 24002 -- 1/1 lbl paths Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 10.4.5.0/24, lcl_lbl 24003 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 1 reply_cnt 1 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1665: Tbl(0xe0000000): #10 LSD Lbl-RW-Create: FEC 10.4.5.0/24 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1721: Tbl(0xe0000000): #10 LSD RW-Create: lcl_lbl 24003 -- 1/1 lbl paths Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (4 items: 1 ctrl, 0 intf, 3 lbl, 0 rw) - last bulk-id=6 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 4 items from mfi queue - queue now contains 1 items Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (1 items: 0 ctrl, 0 intf, 0 lbl, 1 rw) - last bulk-id=7 Sep 20 12:04:34.108 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 1 items from mfi queue - queue now contains 0 items Sep 20 12:04:34.109 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 3 items to mfi queue - queue now contains 3 items Sep 20 12:04:34.109 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (3 items: 0 ctrl, 0 intf, 0 lbl, 3 rw) - last bulk-id=10 Sep 20 12:04:34.109 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 3 reply_cnt 3 Sep 20 12:04:34.109 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (3 items: 0 ctrl, 0 intf, 0 lbl, 3 rw) - last bulk-id=10 Sep 20 12:04:34.109 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 3 items from mfi queue - queue now contains 0 items Sep 20 12:04:43.709 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:43.709 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 20 12:04:43.709 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 2 lbl, 0 rw) - last bulk-id=12 Sep 20 12:04:43.709 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 5.5.5.5/32, lcl_lbl 24004 Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1665: Tbl(0xe0000000): #13 LSD Lbl-RW-Create: FEC 5.5.5.5/32 Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1721: Tbl(0xe0000000): #13 LSD RW-Create: lcl_lbl 24004 -- 0/1 lbl paths Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 10.5.6.0/24, lcl_lbl 24005 Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1665: Tbl(0xe0000000): #14 LSD Lbl-RW-Create: FEC 10.5.6.0/24 Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1721: Tbl(0xe0000000): #14 LSD RW-Create: lcl_lbl 24005 -- 0/1 lbl paths Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 2 lbl, 0 rw) - last bulk-id=12 Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=14 Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=14 Sep 20 12:04:43.710 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 20 12:04:47.719 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1665: Tbl(0xe0000000): #15 LSD Lbl-RW-Create: FEC 5.5.5.5/32 Sep 20 12:04:47.719 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1721: Tbl(0xe0000000): #15 LSD RW-Create: lcl_lbl 24004 -- 1/1 lbl paths Sep 20 12:04:47.719 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:47.719 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1665: Tbl(0xe0000000): #16 LSD Lbl-RW-Create: FEC 10.5.6.0/24 Sep 20 12:04:47.719 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1721: Tbl(0xe0000000): #16 LSD RW-Create: lcl_lbl 24005 -- 1/1 lbl paths Sep 20 12:04:47.719 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 20 12:04:47.719 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=16 Sep 20 12:04:47.720 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 20 12:04:47.720 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=16 Sep 20 12:04:47.720 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 20 12:04:53.111 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:53.111 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 1 items to mfi queue - queue now contains 1 items Sep 20 12:04:53.111 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (1 items: 0 ctrl, 0 intf, 1 lbl, 0 rw) - last bulk-id=17 Sep 20 12:04:53.111 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 1 reply_cnt 1 Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 6.6.6.6/32, lcl_lbl 24006 Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1665: Tbl(0xe0000000): #18 LSD Lbl-RW-Create: FEC 6.6.6.6/32 Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1721: Tbl(0xe0000000): #18 LSD RW-Create: lcl_lbl 24006 -- 0/1 lbl paths Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (1 items: 0 ctrl, 0 intf, 1 lbl, 0 rw) - last bulk-id=17 Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 1 items from mfi queue - queue now contains 0 items Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 1 items to mfi queue - queue now contains 1 items Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (1 items: 0 ctrl, 0 intf, 0 lbl, 1 rw) - last bulk-id=18 Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 1 reply_cnt 1 Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (1 items: 0 ctrl, 0 intf, 0 lbl, 1 rw) - last bulk-id=18 Sep 20 12:04:53.112 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 1 items from mfi queue - queue now contains 0 items Sep 20 12:04:57.719 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1665: Tbl(0xe0000000): #19 LSD Lbl-RW-Create: FEC 6.6.6.6/32 Sep 20 12:04:57.719 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:1721: Tbl(0xe0000000): #19 LSD RW-Create: lcl_lbl 24006 -- 1/1 lbl paths Sep 20 12:04:57.719 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:199: *** LSD req bulk START Sep 20 12:04:57.720 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:28: Added 1 items to mfi queue - queue now contains 1 items Sep 20 12:04:57.720 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:982: *** LSD req bulk SENT (1 items: 0 ctrl, 0 intf, 0 lbl, 1 rw) - last bulk-id=19 Sep 20 12:04:57.720 mpls/ldp/fwdg 0/RP0/CPU0 t4599 [FWDG]:1385: LSD Bulk reply processed: op_cnt 1 reply_cnt 1 Sep 20 12:04:57.720 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:2195: LSD bulk op response: (1 items: 0 ctrl, 0 intf, 0 lbl, 1 rw) - last bulk-id=19 Sep 20 12:04:57.720 mpls/ldp/fwdg 0/RP0/CPU0 t4177 [FWDG]:54: Processed 1 items from mfi queue - queue now contains 0 items RP/0/RP0/CPU0:PE1#show mpls lsd trace Sun Sep 20 12:48:44.725 UTC 232 wrapping entries (224896 possible, 1152 allocated, 0 filtered, 232 total) Sep 20 12:01:59.868 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:431: ************ MPLS-LSD started ********** Sep 20 12:01:59.868 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:446: Successfully initialized module 'base' Sep 20 12:01:59.868 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:446: Successfully initialized module 'app_mgr' Sep 20 12:01:59.868 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:446: Successfully initialized module 'bcdl2' Sep 20 12:01:59.868 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:446: Successfully initialized module 'im' Sep 20 12:01:59.870 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:446: Successfully initialized module 'rw mgr' Sep 20 12:01:59.871 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:446: Successfully initialized module 'lbl_mgr' Sep 20 12:01:59.871 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:446: Successfully initialized module 'ul_mgr' Sep 20 12:01:59.871 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:446: Successfully initialized module 'edm_fwd' Sep 20 12:01:59.871 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:446: Successfully initialized module 'lsr_mib_edm' Sep 20 12:01:59.967 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:399: Node mem init:state='Normal', 255626332K phy, 245177324K free Sep 20 12:01:59.967 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:527: Successfully initialized module 'oom init' Sep 20 12:01:59.967 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:527: Successfully initialized module 'base preinit' Sep 20 12:02:01.868 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:527: Successfully initialized module 'dbg init' Sep 20 12:02:01.868 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:527: Successfully initialized module 'im preinit' Sep 20 12:02:01.868 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:527: Successfully initialized module 'lbl mgr preinit' Sep 20 12:02:02.166 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:967: Registered chkpt table (App) Sep 20 12:02:02.166 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:982: Registered chkpt table (chkpt-register) Sep 20 12:02:02.166 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:995: Registered chkpt table (Lbl) Sep 20 12:02:02.166 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:1019: Registered chkpt table (SRLB Range) Sep 20 12:02:02.166 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:527: Successfully initialized module 'chkpt' Sep 20 12:02:03.374 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:527: Successfully initialized module 'sysdb' Sep 20 12:02:03.374 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:527: Successfully initialized module 'ul mgr preinit' Sep 20 12:02:03.374 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:527: Successfully initialized module 'edm rsi preinit' Sep 20 12:02:04.470 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:527: Successfully initialized module 'rcmd init' Sep 20 12:02:04.470 mpls/lsd/rare 0/RP0/CPU0 t2186 PROC:87: SYSMGR role change nfn. New LSD Node role = 1 Sep 20 12:02:04.471 mpls/lsd/proc 0/RP0/CPU0 t1964 PROC:221: Successful lsd_pm_init exit Sep 20 12:02:04.565 mpls/lsd/proc 0/RP0/CPU0 t1964 PROC:94: Successful lsd_pm_conn_cb exit Sep 20 12:02:04.565 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:129: Entered lsd_pm_notify_register_internal: old_issu_role=0 new_issu_role=0 reg_type=7 Sep 20 12:02:04.565 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:129: Entered lsd_pm_notify_register_internal: old_issu_role=0 new_issu_role=1 reg_type=7 Sep 20 12:02:04.568 mpls/lsd/common 0/RP0/CPU0 t2186 AIPC:343: ipc_init successfully Sep 20 12:02:04.669 mpls/lsd/rare 0/RP0/CPU0 t2186 PROC:883: GO ACTIVE Sep 20 12:02:04.766 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:891: sysmgr available sent Sep 20 12:02:05.469 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:719: Successfully initialized module 'agent mgr' Sep 20 12:02:06.364 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:719: Successfully initialized module 'im init' Sep 20 12:02:10.473 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:719: Successfully initialized module 'sysdb' Sep 20 12:02:10.473 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:719: Successfully initialized module 'cc mgr' Sep 20 12:02:10.473 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:719: Successfully initialized module 'app mgr' Sep 20 12:02:11.271 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1791: BCDL-init: BCDL2 created. name:bcdls_ipv4_lsd, bcdlid=4 Sep 20 12:02:11.765 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1791: BCDL-init: BCDL2 created. name:bcdls_ipv6_lsd, bcdlid=5 Sep 20 12:02:11.765 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:719: Successfully initialized module 'bcdl2 int' Sep 20 12:02:11.766 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:719: Successfully initialized module 'encap ID int' Sep 20 12:02:11.766 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:719: Successfully initialized module 'lbl mgr' Sep 20 12:02:11.870 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:719: Successfully initialized module 'lsr mib' Sep 20 12:02:11.871 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:719: Successfully initialized module 'rcc init' Sep 20 12:02:11.871 mpls/lsd/common 0/RP0/CPU0 t2186 CHKPT:908: Chkpt successfully gone active Sep 20 12:02:12.568 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:465: Successfully initialized module 'mpls_rlb_sysdb' Sep 20 12:02:12.568 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:592: Role change[2]:Successfully (un)initialized module: mpls_rlb_sysdb init Sep 20 12:02:12.568 mpls/lsd/rare 0/RP0/CPU0 t2186 CHKPT:825: Entering lsd_chkpt_app_initial_load Sep 20 12:02:12.568 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:845: Done recovery (App), rec_cnt=0, altered=0 Sep 20 12:02:12.568 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:3863: Initial app reg/dnld bitset=0x0 Sep 20 12:02:12.568 mpls/lsd/rare 0/RP0/CPU0 t2186 CHKPT:211: Entering lsd_chkpt_lbl_initial_load Sep 20 12:02:12.568 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:245: Done recovery (Lbl), rec_cnt=0, altered=0 Sep 20 12:02:12.568 mpls/lsd/rare 0/RP0/CPU0 t2186 CHKPT:400: Chkpt label recovery: recovered 0 labels Sep 20 12:02:12.568 mpls/lsd/rare 0/RP0/CPU0 t2186 CHKPT:626: Entering lsd_chkpt_srlb_range_initial_load Sep 20 12:02:12.568 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:643: Done recovery (SRLB Range), rec_cnt=0, altered=0 Sep 20 12:02:12.569 mpls/lsd/id_lib 0/RP0/CPU0 t2186 ID_LIB:462: id lib alloc: id_max=1024576, flags=0 Sep 20 12:02:13.168 mpls/lsd/rare 0/RP0/CPU0 t2186 PROC:965: sysdb scan complete Sep 20 12:02:13.168 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:4116: Starting APP-reg tmr=600s, APP-dnld tmr=1800s Sep 20 12:02:13.168 mpls/lsd/rare 0/RP0/CPU0 t2186 PROC:1005: GO ACTIVE Complete Sep 20 12:02:13.168 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:180: Successful lsd_pm_notify_register_internal exit Sep 20 12:02:13.272 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:151: DS connect cb, status = 0. Sep 20 12:02:13.272 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:115: Encap ID manager initialized Sep 20 12:02:13.272 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1452: LSDv4 - new UG create: UG = 1, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 20 12:02:13.272 mpls/lsd/rcc 0/RP0/CPU0 t2186 RCC:1217: RCC range UG (index = 0, ug_id = 1, bcdls_id = 4) is created Sep 20 12:02:13.272 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1393: LSDv4 - UG 1 created, flags:0x0 Sep 20 12:02:13.272 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1452: LSDv4 - new UG create: UG = 2, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 20 12:02:13.272 mpls/lsd/rcc 0/RP0/CPU0 t2186 RCC:1213: RCC backgound UG (index = 1, ug_id = 2, bcdls_id = 4) is created Sep 20 12:02:13.272 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1393: LSDv4 - UG 2 created, flags:0x0 Sep 20 12:02:13.364 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1452: LSDv6 - new UG create: UG = 1, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 20 12:02:13.364 mpls/lsd/rcc 0/RP0/CPU0 t2186 RCC:1217: RCC range UG (index = 2, ug_id = 1, bcdls_id = 5) is created Sep 20 12:02:13.364 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1393: LSDv6 - UG 1 created, flags:0x0 Sep 20 12:02:13.365 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1452: LSDv6 - new UG create: UG = 2, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 20 12:02:13.365 mpls/lsd/rcc 0/RP0/CPU0 t2186 RCC:1213: RCC backgound UG (index = 3, ug_id = 2, bcdls_id = 5) is created Sep 20 12:02:13.365 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1393: LSDv6 - UG 2 created, flags:0x0 Sep 20 12:02:32.767 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1452: LSDv4 - new UG create: UG = 0, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 20 12:02:32.767 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1393: LSDv4 - UG 0 created, flags:0x0 Sep 20 12:02:32.770 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/1] Label FPI (BCDL Pri:0) - Incoming Label:0, ELC:0, rw_flags:0x0 Sep 20 12:02:32.770 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2708: Poplkup-v4 MOI - Table ID:0xe00fffff, path_flags:0x0 Sep 20 12:02:32.770 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/1] Label FPI (BCDL Pri:0) - Incoming Label:1, ELC:0, rw_flags:0x1 Sep 20 12:02:32.770 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2708: Poplkup-v4 MOI - Table ID:0x0, path_flags:0x0 Sep 20 12:02:32.770 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/1] Label FPI (BCDL Pri:0) - Incoming Label:13, ELC:0, rw_flags:0x1 Sep 20 12:02:32.770 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2708: Poplkup-v4 MOI - Table ID:0xe0000000, path_flags:0x0 Sep 20 12:02:32.770 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:721: LSDv4 - For UG 0 Downloaded 3 RWs with BCDL priority 0 Sep 20 12:02:32.864 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=3, size=132, total_downloads=1, EOD=1 Sep 20 12:02:32.864 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 20 12:02:32.864 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=3, size=52, total_downloads=2, EOD=1 Sep 20 12:02:32.866 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1452: LSDv6 - new UG create: UG = 0, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 20 12:02:32.866 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:1393: LSDv6 - UG 0 created, flags:0x0 Sep 20 12:02:32.965 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/1] Label FPI (BCDL Pri:0) - Incoming Label:2, ELC:0, rw_flags:0x40000 Sep 20 12:02:32.965 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2710: Poplkup-v6 MOI - Table ID:0xe08fffff, path_flags:0x0 Sep 20 12:02:32.965 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:721: LSDv6 - For UG 0 Downloaded 1 RWs with BCDL priority 0 Sep 20 12:02:32.965 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:790: LSDv6 - Send RW successful for UG 0, updates=1, size=80, total_downloads=1, EOD=1 Sep 20 12:02:32.965 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:892: LSDv6 - EOD sent to FIB for UG 0, all apps converged Sep 20 12:02:32.965 mpls/lsd/rare 0/RP0/CPU0 t2186 RW:528: encap id EOD sent Sep 20 12:02:32.965 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:941: LSDv6 - Send RW successful for UG 0, updates=1, size=52, total_downloads=2, EOD=1 Sep 20 12:02:50.567 mpls/lsd/common 0/RP0/CPU0 t2186 AGENT:503: Rx-ed trig msg from agent, nodeid=0x0 Sep 20 12:02:50.571 mpls/lsd/rare 0/RP0/CPU0 t2186 AGENT:550: wrote 0 intfs to node=0x0, len=60 Sep 20 12:03:49.675 mpls/lsd/common 0/RP0/CPU0 t2186 AGENT:110: ens_write EOK type=8, len=12 Sep 20 12:04:08.780 mpls/lsd/client 0/RP0/CPU0 t4461 :204: client(pid:4423) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 20 12:04:08.780 mpls/lsd/common 0/RP0/CPU0 t2186 AIPC:254: ipc_bind_v2 successfully Sep 20 12:04:08.780 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:565: Publish DS service successfully for endp LSD_DS. Sep 20 12:04:08.780 mpls/lsd/client 0/RP0/CPU0 t4599 :204: client(pid:4177) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 20 12:04:08.780 mpls/lsd/client 0/RP0/CPU0 t4318 :204: client(pid:4168) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 20 12:04:08.780 mpls/lsd/client 0/RP0/CPU0 t4678 :204: client(pid:4642) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 20 12:04:08.780 mpls/lsd/client 0/RP0/CPU0 t3628 :204: client(pid:2603) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 20 12:04:08.780 mpls/lsd/client 0/RP0/CPU0 t3515 :204: client(pid:2592) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 20 12:04:08.781 mpls/lsd/client 0/RP0/CPU0 t3372 :204: client(pid:2658) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 20 12:04:08.781 mpls/lsd/client 0/RP0/CPU0 t3487 :204: client(pid:2595) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 20 12:04:08.983 mpls/lsd/client 0/RP0/CPU0 t4678 :884: client(pid:4642) lib event: Connect to act Sep 20 12:04:08.984 mpls/lsd/client 0/RP0/CPU0 t4318 :884: client(pid:4168) lib event: Connect to act Sep 20 12:04:08.985 mpls/lsd/client 0/RP0/CPU0 t3628 :884: client(pid:2603) lib event: Connect to act Sep 20 12:04:08.986 mpls/lsd/client 0/RP0/CPU0 t3515 :884: client(pid:2592) lib event: Connect to act Sep 20 12:04:08.987 mpls/lsd/client 0/RP0/CPU0 t4599 :884: client(pid:4177) lib event: Connect to act Sep 20 12:04:09.065 mpls/lsd/client 0/RP0/CPU0 t3487 :884: client(pid:2595) lib event: Connect to act Sep 20 12:04:09.066 mpls/lsd/client 0/RP0/CPU0 t3372 :884: client(pid:2658) lib event: Connect to act Sep 20 12:04:09.067 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:213: DS publish service cb, return_code:0, status:0. Sep 20 12:04:09.067 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:420: Start 120 secs high priority apps reg timer Sep 20 12:04:09.068 mpls/lsd/client 0/RP0/CPU0 t4461 :884: client(pid:4423) lib event: Connect to act Sep 20 12:04:14.976 mpls/lsd/common 0/RP0/CPU0 t2186 AGENT:110: ens_write EOK type=7, len=28 Sep 20 12:04:14.976 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:3900: Clearing APP-reg tmr, Last App registered, bitmask=0x0 Sep 20 12:04:14.976 mpls/lsd/str 0/RP0/CPU0 t2186 APP:1266: App created, app=Static::active, flag:0x0, app_idx:1 Sep 20 12:04:14.977 mpls/lsd/client 0/RP0/CPU0 t3372 :997: client(Static::active) lib event: Reg with act Sep 20 12:04:14.977 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:782: Chkpt_save: app, app_idx=1, app_type=3, app_instance:, app_role:1 Sep 20 12:04:30.984 mpls/lsd/rare 0/RP0/CPU0 t2186 APP:1877: App RSRC-COMPLETE, app=Static::active, flag:0x41 Sep 20 12:04:30.984 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:3689: update_list: All apps converged Sep 20 12:04:30.984 mpls/lsd/proc 0/RP0/CPU0 t2186 PROC:403: Start to allow other apps reg, reason: last high prio app rsc complete Sep 20 12:04:30.988 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 20 12:04:30.988 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=0, size=52, total_downloads=3, EOD=1 Sep 20 12:04:30.988 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:892: LSDv6 - EOD sent to FIB for UG 0, all apps converged Sep 20 12:04:30.988 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:941: LSDv6 - Send RW successful for UG 0, updates=0, size=52, total_downloads=3, EOD=1 Sep 20 12:04:31.480 mpls/lsd/client 0/RP0/CPU0 t4461 :997: client(Static:ipv4_static:active) lib event: Reg with act Sep 20 12:04:31.480 mpls/lsd/str 0/RP0/CPU0 t2186 APP:1266: App created, app=Static:ipv4_static:active, flag:0x20, app_idx:2 Sep 20 12:04:31.480 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:782: Chkpt_save: app, app_idx=2, app_type=3, app_instance:ipv4_static, app_role:1 Sep 20 12:04:32.971 mpls/lsd/common 0/RP0/CPU0 t2186 AGENT:110: ens_write EOK type=7, len=28 Sep 20 12:04:32.971 mpls/lsd/str 0/RP0/CPU0 t2186 APP:1266: App created, app=BGP-VPNv4:bgp-default:active, flag:0x20, app_idx:3 Sep 20 12:04:32.971 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:782: Chkpt_save: app, app_idx=3, app_type=8, app_instance:bgp-default, app_role:1 Sep 20 12:04:32.972 mpls/lsd/client 0/RP0/CPU0 t4678 :997: client(BGP-VPNv4:bgp-default:active) lib event: Reg with act Sep 20 12:04:33.681 mpls/lsd/common 0/RP0/CPU0 t2186 AGENT:110: ens_write EOK type=7, len=28 Sep 20 12:04:33.681 mpls/lsd/str 0/RP0/CPU0 t2186 APP:1266: App created, app=Application-Controller:XTC:active, flag:0x20, app_idx:4 Sep 20 12:04:33.681 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:782: Chkpt_save: app, app_idx=4, app_type=6, app_instance:XTC, app_role:1 Sep 20 12:04:33.682 mpls/lsd/client 0/RP0/CPU0 t4318 :997: client(Application-Controller:XTC:active) lib event: Reg with act Sep 20 12:04:34.071 mpls/lsd/str 0/RP0/CPU0 t2186 APP:1266: App created, app=LDP::active, flag:0x20, app_idx:5 Sep 20 12:04:34.071 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:782: Chkpt_save: app, app_idx=5, app_type=4, app_instance:, app_role:1 Sep 20 12:04:34.071 mpls/lsd/rare 0/RP0/CPU0 t2186 AIPC:1928: Notifying app:LDP::active, flag:0x61, event:1. Sep 20 12:04:34.072 mpls/lsd/client 0/RP0/CPU0 t4599 :997: client(LDP::active) lib event: Reg with act Sep 20 12:04:34.072 mpls/lsd/client 0/RP0/CPU0 t4599 :237: client(LDP::active) active LSD notify event:1, flag:0 Sep 20 12:04:34.072 mpls/lsd/wrap 0/RP0/CPU0 t2186 IM:523: Enabling intf (0x20), app=LDP::active, flag:0x61, ftypes:0x1 Sep 20 12:04:34.107 mpls/lsd/id_lib 0/RP0/CPU0 t2186 ID_LIB:285: mark_used_in_summary_tree (LSD free ctr 8):id=0, lvl=0, idx=0 bitmap=0x80000000 Sep 20 12:04:34.107 mpls/lsd/id_lib 0/RP0/CPU0 t2186 ID_LIB:260: mark_free_in_summary_tree (LSD free ctr 7):id=0, lvl=3, idx=0 bitmap=0xffffffff Sep 20 12:04:34.108 mpls/lsd/rare 0/RP0/CPU0 t2186 APP:1877: App RSRC-COMPLETE, app=LDP::active, flag:0x61 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:3.3.3.3/32, Route flags:0x4000000 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24000, ELC:0, rw_flags:0x0 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x20), NHID:0x4, Lbl:3, path_flags:0x0 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:4.4.4.4/32, Route flags:0x4000000 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24002, ELC:0, rw_flags:0x0 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x20), NHID:0x4, Lbl:24001, path_flags:0x0 Sep 20 12:04:34.111 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 1 Sep 20 12:04:34.111 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=156, total_downloads=4, EOD=0 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.3.4.0/24, Route flags:0x4000000 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24001, ELC:0, rw_flags:0x0 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x20), NHID:0x4, Lbl:3, path_flags:0x0 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.4.5.0/24, Route flags:0x4000000 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24003, ELC:0, rw_flags:0x0 Sep 20 12:04:34.111 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x20), NHID:0x4, Lbl:24002, path_flags:0x0 Sep 20 12:04:34.111 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 3 Sep 20 12:04:34.111 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=156, total_downloads=5, EOD=1 Sep 20 12:04:34.111 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 20 12:04:34.111 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=6, EOD=1 Sep 20 12:04:34.973 mpls/lsd/str 0/RP0/CPU0 t2186 APP:1266: App created, app=PIM:pim:active, flag:0x20, app_idx:6 Sep 20 12:04:34.973 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:782: Chkpt_save: app, app_idx=6, app_type=12, app_instance:pim, app_role:1 Sep 20 12:04:34.973 mpls/lsd/client 0/RP0/CPU0 t3628 :997: client(PIM:pim:active) lib event: Reg with act Sep 20 12:04:43.712 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:5.5.5.5/32, Route flags:0x4000000 Sep 20 12:04:43.712 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24004, ELC:0, rw_flags:0x0 Sep 20 12:04:43.712 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x20), NHID:0x4, Lbl:None, path_flags:0x0 Sep 20 12:04:43.712 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:721: LSDv4 - For UG 0 Downloaded 1 RWs with BCDL priority 1 Sep 20 12:04:43.712 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=1, size=100, total_downloads=7, EOD=0 Sep 20 12:04:43.712 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.5.6.0/24, Route flags:0x4000000 Sep 20 12:04:43.712 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24005, ELC:0, rw_flags:0x0 Sep 20 12:04:43.712 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x20), NHID:0x4, Lbl:None, path_flags:0x0 Sep 20 12:04:43.712 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:721: LSDv4 - For UG 0 Downloaded 1 RWs with BCDL priority 3 Sep 20 12:04:43.712 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=1, size=100, total_downloads=8, EOD=1 Sep 20 12:04:43.712 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 20 12:04:43.712 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=1, size=52, total_downloads=9, EOD=1 Sep 20 12:04:45.680 mpls/lsd/rare 0/RP0/CPU0 t2186 APP:1877: App RSRC-COMPLETE, app=Application-Controller:XTC:active, flag:0x61 Sep 20 12:04:47.722 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:5.5.5.5/32, Route flags:0x4000000 Sep 20 12:04:47.722 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24004, ELC:0, rw_flags:0x80000 Sep 20 12:04:47.722 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x20), NHID:0x4, Lbl:24003, path_flags:0x0 Sep 20 12:04:47.722 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:721: LSDv4 - For UG 0 Downloaded 1 RWs with BCDL priority 1 Sep 20 12:04:47.722 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=1, size=104, total_downloads=10, EOD=0 Sep 20 12:04:47.722 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.5.6.0/24, Route flags:0x4000000 Sep 20 12:04:47.722 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24005, ELC:0, rw_flags:0x80000 Sep 20 12:04:47.722 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x20), NHID:0x4, Lbl:24004, path_flags:0x0 Sep 20 12:04:47.722 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:721: LSDv4 - For UG 0 Downloaded 1 RWs with BCDL priority 3 Sep 20 12:04:47.722 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=1, size=104, total_downloads=11, EOD=1 Sep 20 12:04:47.722 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 20 12:04:47.722 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=1, size=52, total_downloads=12, EOD=1 Sep 20 12:04:53.114 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:6.6.6.6/32, Route flags:0x4000000 Sep 20 12:04:53.114 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24006, ELC:0, rw_flags:0x0 Sep 20 12:04:53.114 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x20), NHID:0x4, Lbl:None, path_flags:0x0 Sep 20 12:04:53.114 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:721: LSDv4 - For UG 0 Downloaded 1 RWs with BCDL priority 1 Sep 20 12:04:53.114 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=1, size=100, total_downloads=13, EOD=1 Sep 20 12:04:53.114 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 20 12:04:53.114 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=1, size=52, total_downloads=14, EOD=1 Sep 20 12:04:53.480 mpls/lsd/rare 0/RP0/CPU0 t2186 APP:1877: App RSRC-COMPLETE, app=Static:ipv4_static:active, flag:0x61 Sep 20 12:04:57.722 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:6.6.6.6/32, Route flags:0x4000000 Sep 20 12:04:57.722 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24006, ELC:0, rw_flags:0x80000 Sep 20 12:04:57.722 mpls/lsd/rw 0/RP0/CPU0 t2186 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x20), NHID:0x4, Lbl:24005, path_flags:0x0 Sep 20 12:04:57.722 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:721: LSDv4 - For UG 0 Downloaded 1 RWs with BCDL priority 1 Sep 20 12:04:57.722 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=1, size=104, total_downloads=15, EOD=1 Sep 20 12:04:57.722 mpls/lsd/bcdl 0/RP0/CPU0 t2186 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 20 12:04:57.722 mpls/lsd/wrap 0/RP0/CPU0 t2186 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=1, size=52, total_downloads=16, EOD=1 Sep 20 12:05:06.475 mpls/lsd/client 0/RP0/CPU0 t3487 :997: client(BFD::active) lib event: Reg with act Sep 20 12:05:06.475 mpls/lsd/str 0/RP0/CPU0 t2186 APP:1266: App created, app=BFD::active, flag:0x20, app_idx:7 Sep 20 12:05:06.475 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:782: Chkpt_save: app, app_idx=7, app_type=11, app_instance:, app_role:1 Sep 20 12:05:08.271 mpls/lsd/str 0/RP0/CPU0 t2186 APP:1266: App created, app=PIM6:pim6:active, flag:0x20, app_idx:8 Sep 20 12:05:08.271 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:782: Chkpt_save: app, app_idx=8, app_type=14, app_instance:pim6, app_role:1 Sep 20 12:05:08.272 mpls/lsd/client 0/RP0/CPU0 t3515 :997: client(PIM6:pim6:active) lib event: Reg with act Sep 20 12:05:09.604 mpls/lsd/client 0/RP0/CPU0 t4776 :204: client(pid:4171) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 20 12:05:09.606 mpls/lsd/client 0/RP0/CPU0 t4776 :884: client(pid:4171) lib event: Connect to act Sep 20 12:05:10.610 mpls/lsd/str 0/RP0/CPU0 t2186 APP:1266: App created, app=L2VPN::active, flag:0x20, app_idx:9 Sep 20 12:05:10.610 mpls/lsd/str 0/RP0/CPU0 t2186 CHKPT:782: Chkpt_save: app, app_idx=9, app_type=9, app_instance:, app_role:1 Sep 20 12:05:10.610 mpls/lsd/client 0/RP0/CPU0 t4776 :997: client(L2VPN::active) lib event: Reg with act Sep 20 12:05:16.619 mpls/lsd/rare 0/RP0/CPU0 t2186 APP:1877: App RSRC-COMPLETE, app=L2VPN::active, flag:0x61 Sep 20 12:05:55.996 mpls/lsd/rare 0/RP0/CPU0 t2186 APP:1877: App RSRC-COMPLETE, app=BGP-VPNv4:bgp-default:active, flag:0x61 Sep 20 12:06:06.477 mpls/lsd/rare 0/RP0/CPU0 t2186 APP:1877: App RSRC-COMPLETE, app=BFD::active, flag:0x61 Sep 20 12:06:10.267 mpls/lsd/rare 0/RP0/CPU0 t2186 APP:1877: App RSRC-COMPLETE, app=PIM:pim:active, flag:0x61 Sep 20 12:07:08.568 mpls/lsd/rare 0/RP0/CPU0 t2186 APP:1877: App RSRC-COMPLETE, app=PIM6:pim6:active, flag:0x61 Sep 20 12:29:44.707 mpls/lsd/common 0/RP0/CPU0 t2186 AGENT:110: ens_write EOK type=5, len=8 Sep 20 12:35:31.370 mpls/lsd/common 0/RP0/CPU0 t2186 AGENT:110: ens_write EOK type=5, len=8 Sep 20 12:41:20.576 mpls/lsd/common 0/RP0/CPU0 t2186 AGENT:110: ens_write EOK type=5, len=8 Sep 20 12:47:07.535 mpls/lsd/common 0/RP0/CPU0 t2186 AGENT:110: ens_write EOK type=5, len=8