RP/0/RP0/CPU0:PE1#show mpls ldp trace binding Sat Sep 12 02:57:00.696 UTC 122 wrapping entries (1027456 possible, 3456 allocated, 615 filtered, 737 total) Sep 12 01:59:55.167 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:106: VRF(0x60000000): Peer(3.3.3.3:0): Advertise address 2.2.2.2 Sep 12 01:59:55.167 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:106: VRF(0x60000000): Peer(3.3.3.3:0): Advertise address 2.2.2.2 Sep 12 01:59:55.167 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:106: VRF(0x60000000): Peer(3.3.3.3:0): Advertise address 10.2.3.2 Sep 12 01:59:55.167 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:106: VRF(0x60000000): Peer(3.3.3.3:0): Advertise address 10.2.3.2 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:136: VRF(0x60000000): Peer(3.3.3.3:0): Bind address 3.3.3.3 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:136: VRF(0x60000000): Peer(3.3.3.3:0): Bind address 10.2.3.3 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:136: VRF(0x60000000): Peer(3.3.3.3:0): Bind address 10.3.4.3 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:161: VRF(0x60000000): Prefix(3.3.3.3/32): Created, reason 2 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(3.3.3.3/32): Add label 3 from peer 3.3.3.3:0 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:161: VRF(0x60000000): Prefix(10.2.3.0/24): Created, reason 2 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.2.3.0/24): Add label 3 from peer 3.3.3.3:0 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:161: VRF(0x60000000): Prefix(10.3.4.0/24): Created, reason 2 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.3.4.0/24): Add label 3 from peer 3.3.3.3:0 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:161: VRF(0x60000000): Prefix(4.4.4.4/32): Created, reason 2 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(4.4.4.4/32): Add label 24000 from peer 3.3.3.3:0 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:161: VRF(0x60000000): Prefix(10.4.5.0/24): Created, reason 2 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.4.5.0/24): Add label 24001 from peer 3.3.3.3:0 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:161: VRF(0x60000000): Prefix(2.2.2.2/32): Created, reason 2 Sep 12 01:59:55.171 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(2.2.2.2/32): Add label 24002 from peer 3.3.3.3:0 Sep 12 01:59:55.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:2362: tc_enqueue_peer_update_all_work; AF=IPv4 Sep 12 01:59:57.128 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:221: VRF(0x60000000): Prefix(2.2.2.2/32): label 3 (rev#7) assigned Sep 12 01:59:57.129 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:221: VRF(0x60000000): Prefix(10.2.3.0/24): label 3 (rev#8) assigned Sep 12 01:59:57.129 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:221: VRF(0x60000000): Prefix(3.3.3.3/32): label 24000 (rev#9) assigned Sep 12 01:59:57.130 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:221: VRF(0x60000000): Prefix(4.4.4.4/32): label 24001 (rev#10) assigned Sep 12 01:59:57.130 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:221: VRF(0x60000000): Prefix(10.3.4.0/24): label 24002 (rev#11) assigned Sep 12 01:59:57.130 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:221: VRF(0x60000000): Prefix(10.4.5.0/24): label 24003 (rev#12) assigned Sep 12 02:00:05.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:2362: tc_enqueue_peer_update_all_work; AF=IPv4 Sep 12 02:00:05.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 3 (rev#7) Sep 12 02:00:05.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 3 (rev#8) Sep 12 02:00:05.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24000 (rev#9) Sep 12 02:00:05.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24001 (rev#10) Sep 12 02:00:05.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24002 (rev#11) Sep 12 02:00:05.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24003 (rev#12) Sep 12 02:03:03.392 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:161: VRF(0x60000000): Prefix(5.5.5.5/32): Created, reason 3 Sep 12 02:03:03.393 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:221: VRF(0x60000000): Prefix(5.5.5.5/32): label 24005 (rev#14) assigned Sep 12 02:03:05.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(5.5.5.5/32): Add label 24003 from peer 3.3.3.3:0 Sep 12 02:03:05.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:2362: tc_enqueue_peer_update_all_work; AF=IPv4 Sep 12 02:03:05.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24005 (rev#14) Sep 12 02:19:35.500 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.2.3.0/24): Remove label 3 from peer 3.3.3.3:0 Sep 12 02:19:35.500 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.3.4.0/24): Remove label 3 from peer 3.3.3.3:0 Sep 12 02:19:35.500 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.4.5.0/24): Remove label 24001 from peer 3.3.3.3:0 Sep 12 02:20:25.500 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.2.3.0/24): Add label 3 from peer 3.3.3.3:0 Sep 12 02:20:25.500 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.3.4.0/24): Add label 3 from peer 3.3.3.3:0 Sep 12 02:20:25.500 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.4.5.0/24): Add label 24001 from peer 3.3.3.3:0 Sep 12 02:21:25.964 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:6717: apply 1 ACL to all TIB entries(entries permitted 4, denied 3) Sep 12 02:21:25.965 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:6717: apply 1 ACL to all TIB entries(entries permitted 4, denied 0) Sep 12 02:21:25.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:2362: tc_enqueue_peer_update_all_work; AF=IPv4 Sep 12 02:21:25.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:81: VRF(0x60000000): Peer(3.3.3.3:0): Withdraw label 3 (rev#15) Sep 12 02:21:25.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:81: VRF(0x60000000): Peer(3.3.3.3:0): Withdraw label 24002 (rev#16) Sep 12 02:21:25.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:81: VRF(0x60000000): Peer(3.3.3.3:0): Withdraw label 24003 (rev#17) Sep 12 02:21:35.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.2.3.0/24): Remove label 3 from peer 3.3.3.3:0 Sep 12 02:21:35.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.3.4.0/24): Remove label 3 from peer 3.3.3.3:0 Sep 12 02:21:35.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.4.5.0/24): Remove label 24001 from peer 3.3.3.3:0 Sep 12 02:21:35.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:180: VRF(0x60000000): Prefix(10.2.3.0/24): Removed Sep 12 02:21:35.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:199: VRF(0x60000000): Prefix(10.2.3.0/24): Deleted Sep 12 02:21:35.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:180: VRF(0x60000000): Prefix(10.3.4.0/24): Removed Sep 12 02:21:35.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:199: VRF(0x60000000): Prefix(10.3.4.0/24): Deleted Sep 12 02:21:35.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:180: VRF(0x60000000): Prefix(10.4.5.0/24): Removed Sep 12 02:21:35.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:199: VRF(0x60000000): Prefix(10.4.5.0/24): Deleted Sep 12 02:28:55.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(3.3.3.3/32): Remove label 3 from peer 3.3.3.3:0 Sep 12 02:28:55.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(4.4.4.4/32): Remove label 24000 from peer 3.3.3.3:0 Sep 12 02:28:55.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(2.2.2.2/32): Remove label 24002 from peer 3.3.3.3:0 Sep 12 02:31:25.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:161: VRF(0x60000000): Prefix(10.2.3.0/24): Created, reason 2 Sep 12 02:31:25.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.2.3.0/24): Add label 3 from peer 3.3.3.3:0 Sep 12 02:31:25.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:161: VRF(0x60000000): Prefix(10.3.4.0/24): Created, reason 2 Sep 12 02:31:25.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.3.4.0/24): Add label 3 from peer 3.3.3.3:0 Sep 12 02:31:25.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:161: VRF(0x60000000): Prefix(10.4.5.0/24): Created, reason 2 Sep 12 02:31:25.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.4.5.0/24): Add label 24001 from peer 3.3.3.3:0 Sep 12 02:31:25.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:2362: tc_enqueue_peer_update_all_work; AF=IPv4 Sep 12 02:31:30.510 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:6717: apply 0 ACL to all TIB entries(entries permitted 0, denied 0) Sep 12 02:31:30.594 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:6717: apply 0 ACL to all TIB entries(entries permitted 0, denied 0) Sep 12 02:31:30.600 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:221: VRF(0x60000000): Prefix(10.2.3.0/24): label 3 (rev#21) assigned Sep 12 02:31:30.601 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:221: VRF(0x60000000): Prefix(10.3.4.0/24): label 24002 (rev#22) assigned Sep 12 02:31:30.601 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:221: VRF(0x60000000): Prefix(10.4.5.0/24): label 24003 (rev#23) assigned Sep 12 02:31:35.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:2362: tc_enqueue_peer_update_all_work; AF=IPv4 Sep 12 02:31:35.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 3 (rev#21) Sep 12 02:31:35.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24002 (rev#22) Sep 12 02:31:35.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24003 (rev#23) Sep 12 02:35:13.615 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(5.5.5.5/32): Remove label 24003 from peer 3.3.3.3:0 Sep 12 02:35:13.615 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.2.3.0/24): Remove label 3 from peer 3.3.3.3:0 Sep 12 02:35:13.615 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.3.4.0/24): Remove label 3 from peer 3.3.3.3:0 Sep 12 02:35:13.615 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.4.5.0/24): Remove label 24001 from peer 3.3.3.3:0 Sep 12 02:35:13.615 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:367: VRF(0x60000000): Peer(3.3.3.3:0): af=IPv4; tc_unbind_alladdrs_from_tdp_ident Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:106: VRF(0x60000000): Peer(3.3.3.3:0): Advertise address 2.2.2.2 Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:106: VRF(0x60000000): Peer(3.3.3.3:0): Advertise address 2.2.2.2 Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:106: VRF(0x60000000): Peer(3.3.3.3:0): Advertise address 10.2.3.2 Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:106: VRF(0x60000000): Peer(3.3.3.3:0): Advertise address 10.2.3.2 Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 3 (rev#7) Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24000 (rev#9) Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24001 (rev#10) Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24005 (rev#14) Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 3 (rev#21) Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24002 (rev#22) Sep 12 02:35:15.208 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:76: VRF(0x60000000): Peer(3.3.3.3:0): Advertise label 24003 (rev#23) Sep 12 02:35:15.213 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:136: VRF(0x60000000): Peer(3.3.3.3:0): Bind address 3.3.3.3 Sep 12 02:35:15.213 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:136: VRF(0x60000000): Peer(3.3.3.3:0): Bind address 10.2.3.3 Sep 12 02:35:15.213 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:136: VRF(0x60000000): Peer(3.3.3.3:0): Bind address 10.3.4.3 Sep 12 02:35:15.213 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(3.3.3.3/32): Add label 3 from peer 3.3.3.3:0 Sep 12 02:35:15.213 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(4.4.4.4/32): Add label 24000 from peer 3.3.3.3:0 Sep 12 02:35:15.213 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(2.2.2.2/32): Add label 24002 from peer 3.3.3.3:0 Sep 12 02:35:15.213 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(5.5.5.5/32): Add label 24003 from peer 3.3.3.3:0 Sep 12 02:35:15.213 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.2.3.0/24): Add label 3 from peer 3.3.3.3:0 Sep 12 02:35:15.213 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.3.4.0/24): Add label 3 from peer 3.3.3.3:0 Sep 12 02:35:15.213 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:279: VRF(0x60000000): Prefix(10.4.5.0/24): Add label 24001 from peer 3.3.3.3:0 Sep 12 02:43:45.004 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:6717: apply 1 ACL to all TIB entries(entries permitted 4, denied 3) Sep 12 02:43:45.005 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:6717: apply 1 ACL to all TIB entries(entries permitted 4, denied 0) Sep 12 02:43:45.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:2362: tc_enqueue_peer_update_all_work; AF=IPv4 Sep 12 02:43:45.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:81: VRF(0x60000000): Peer(3.3.3.3:0): Withdraw label 3 (rev#24) Sep 12 02:43:45.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:81: VRF(0x60000000): Peer(3.3.3.3:0): Withdraw label 24002 (rev#25) Sep 12 02:43:45.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:81: VRF(0x60000000): Peer(3.3.3.3:0): Withdraw label 24003 (rev#26) Sep 12 02:43:55.499 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.2.3.0/24): Remove label 3 from peer 3.3.3.3:0 Sep 12 02:43:55.499 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.3.4.0/24): Remove label 3 from peer 3.3.3.3:0 Sep 12 02:43:55.499 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(10.4.5.0/24): Remove label 24001 from peer 3.3.3.3:0 Sep 12 02:43:55.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:180: VRF(0x60000000): Prefix(10.2.3.0/24): Removed Sep 12 02:43:55.997 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:199: VRF(0x60000000): Prefix(10.2.3.0/24): Deleted Sep 12 02:43:55.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:180: VRF(0x60000000): Prefix(10.3.4.0/24): Removed Sep 12 02:43:55.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:199: VRF(0x60000000): Prefix(10.3.4.0/24): Deleted Sep 12 02:43:55.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:180: VRF(0x60000000): Prefix(10.4.5.0/24): Removed Sep 12 02:43:55.998 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:199: VRF(0x60000000): Prefix(10.4.5.0/24): Deleted Sep 12 02:50:45.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(3.3.3.3/32): Remove label 3 from peer 3.3.3.3:0 Sep 12 02:50:45.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(4.4.4.4/32): Remove label 24000 from peer 3.3.3.3:0 Sep 12 02:50:45.498 mpls/ldp/bndg 0/RP0/CPU0 t4131 [BNDG]:339: VRF(0x60000000): Prefix(2.2.2.2/32): Remove label 24002 from peer 3.3.3.3:0 RP/0/RP0/CPU0:PE1#show mpls ldp trace peer Sat Sep 12 02:57:00.806 UTC 3 wrapping entries (1027456 possible, 3456 allocated, 734 filtered, 737 total) Sep 12 02:35:12.614 mpls/ldp/str 0/RP0/CPU0 t4131 [PEER]:595: VRF(0x60000000): Peer(3.3.3.3:0): DOWN - reason 'User cleared session manually' Sep 12 02:35:12.615 mpls/ldp/peer 0/RP0/CPU0 t4131 [PEER]:509: VRF(0x60000000): Peer(3.3.3.3:0): Peer FSM: Stepped, pp=0xfbe9a160, event=0, state 0 -> 1 Sep 12 02:35:13.615 mpls/ldp/str 0/RP0/CPU0 t4131 [PEER]:3328: VRF(0x60000000): Release Peer(3.3.3.3:0): rsn 'User cleared session manually' ('Success') RP/0/RP0/CPU0:PE1#show mpls ldp trace discovery Sat Sep 12 02:57:01.000 UTC 2 wrapping entries (1027456 possible, 3456 allocated, 735 filtered, 737 total) Sep 12 01:59:48.900 mpls/ldp/adj 0/RP0/CPU0 t4131 [DISC]:347: VRF(0x60000000): Peer(3.3.3.3): Actv/pasv new_role=2, old_role=0, ldpid_arb=1, chg_cnt=1 Sep 12 01:59:48.904 mpls/ldp/adj 0/RP0/CPU0 t4131 [DISC]:709: VRF(0x60000000): Adj(10.2.3.3): Create; link, intf GigabitEthernet0/0/0/1 (ifh 0x10), xport_addr 3.3.3.3, ldp_id 3.3.3.3:0 RP/0/RP0/CPU0:PE1#show mpls ldp trace route Sat Sep 12 02:57:01.196 UTC 121 wrapping entries (1027456 possible, 3456 allocated, 616 filtered, 737 total) Sep 12 01:59:37.294 mpls/ldp/err 0/RP0/CPU0 t4131 [ERR][ROUTE]:389: SKIP msg (type 1) to RIB thread - thread not up Sep 12 01:59:37.294 mpls/ldp/err 0/RP0/CPU0 t4131 [ERR][ROUTE]:554: SKIP msg (type 8) to RIB thread - thread not up Sep 12 01:59:37.496 mpls/ldp/rout 0/RP0/CPU0 t4131 [ROUTE]:2112: RIB init: af=IPv4 Sep 12 01:59:37.497 mpls/ldp/rout 0/RP0/CPU0 t4131 [ROUTE]:2112: RIB init: af=IPv6 Sep 12 01:59:37.497 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:144: ldp_rib_route_upd_disable_set: disable 0, af=IPv4 Sep 12 01:59:37.497 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:144: ldp_rib_route_upd_disable_set: disable 0, af=IPv6 Sep 12 01:59:37.497 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1897: RIB enable: af=IPv4 Sep 12 01:59:38.499 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1869: Bound to active RIB, fd=273, co-located=1, af=IPv4 Sep 12 01:59:38.702 mpls/ldp/err 0/RP0/CPU0 t4131 [ERR][ROUTE]:185: SKIP msg (type 7) from RIB thread Sep 12 01:59:57.097 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:144: ldp_rib_route_upd_disable_set: disable 0, af=IPv4 Sep 12 01:59:57.097 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:144: ldp_rib_route_upd_disable_set: disable 0, af=IPv6 Sep 12 01:59:57.097 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1543: IBGP alloc lbl notif reg (1); af=IPv4 Sep 12 01:59:57.107 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1660: Tbl(0xe0000000): RIB proto notif reg, af=IPv4 Sep 12 01:59:57.123 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:674: Tbl(0xe0000000): RIB proto nfn: reg 1 - proto 0x0, af IPv4 Sep 12 01:59:57.123 mpls/ldp/str 0/RP0/CPU0 t4549 [ROUTE]:622: Tbl(0xe0000000): ip_rib_protocol_redist2: flags 0x1: af 1 - proto id 0x0 ('local' instance '') Sep 12 01:59:57.123 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:623: Tbl(0xe0000000): ip_rib_protocol_redist2: flags 0x1: af 1 - proto id 0x0 Sep 12 01:59:57.123 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:674: Tbl(0xe0000000): RIB proto nfn: reg 1 - proto 0x1, af IPv4 Sep 12 01:59:57.124 mpls/ldp/str 0/RP0/CPU0 t4549 [ROUTE]:622: Tbl(0xe0000000): ip_rib_protocol_redist2: flags 0x1: af 1 - proto id 0x1 ('connected' instance '') Sep 12 01:59:57.124 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:623: Tbl(0xe0000000): ip_rib_protocol_redist2: flags 0x1: af 1 - proto id 0x1 Sep 12 01:59:57.124 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:674: Tbl(0xe0000000): RIB proto nfn: reg 1 - proto 0x2, af IPv4 Sep 12 01:59:57.125 mpls/ldp/str 0/RP0/CPU0 t4549 [ROUTE]:622: Tbl(0xe0000000): ip_rib_protocol_redist2: flags 0x1: af 1 - proto id 0x2 ('application' instance 'fib_mgr') Sep 12 01:59:57.125 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:623: Tbl(0xe0000000): ip_rib_protocol_redist2: flags 0x1: af 1 - proto id 0x2 Sep 12 01:59:57.125 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:674: Tbl(0xe0000000): RIB proto nfn: reg 1 - proto 0x3, af IPv4 Sep 12 01:59:57.125 mpls/ldp/str 0/RP0/CPU0 t4549 [ROUTE]:622: Tbl(0xe0000000): ip_rib_protocol_redist2: flags 0x29: af 1 - proto id 0x3 ('ospf' instance '1') Sep 12 01:59:57.125 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:623: Tbl(0xe0000000): ip_rib_protocol_redist2: flags 0x29: af 1 - proto id 0x3 Sep 12 01:59:57.125 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:674: Tbl(0xe0000000): RIB proto nfn: reg 1 - proto 0x4, af IPv4 Sep 12 01:59:57.125 mpls/ldp/str 0/RP0/CPU0 t4549 [ROUTE]:622: Tbl(0xe0000000): ip_rib_protocol_redist2: flags 0x1: af 1 - proto id 0x4 ('dagr' instance '') Sep 12 01:59:57.125 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:623: Tbl(0xe0000000): ip_rib_protocol_redist2: flags 0x1: af 1 - proto id 0x4 Sep 12 01:59:57.125 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1689: Tbl(0xe0000000): RIB proto notif reg done, hndl=0x71ecc8003220, af=IPv4 Sep 12 01:59:57.126 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1022: Tbl(0xe0000000): RIB redist RCMD enable, af=IPv4 Sep 12 01:59:57.126 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1138: *** RIB FETCH [ 2 buffers ]; af=IPv4: START Sep 12 01:59:57.128 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 01:59:57.128 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 01:59:57.128 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(10.2.3.0/24) -- metric 0, src/type 0x00010001, flags 0x1082, prio/paths 0x0401 Sep 12 01:59:57.128 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 01:59:57.128 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(10.2.3.0/24) -- metric 0, src/type 0x00010001, flags 0x1082, prio/paths 0x0401 Sep 12 01:59:57.128 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 01:59:57.128 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(4.4.4.4/32) -- metric 3, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 01:59:57.129 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(10.3.4.0/24) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0b01 Sep 12 01:59:57.129 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(10.4.5.0/24) -- metric 3, src/type 0x00030002, flags 0x4000000, prio/paths 0x0b01 Sep 12 01:59:57.129 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:887: Tbl(0xe0000000): *** RIB CONVERGED: af=IPv4 Sep 12 01:59:57.129 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1186: *** RIB FETCH: END [ 10 routes (10/0 up/down), 1 filtered (1/0 up/down) ] Sep 12 01:59:57.129 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1191: RIB FETCH: Non-filtered/UP [ 0 protected routes, 9/0/0 tot/bkup/protected paths ] Sep 12 02:01:01.610 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1138: *** RIB FETCH [ 2 buffers ]; af=IPv4: START Sep 12 02:01:01.611 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:887: Tbl(0xe0000000): *** RIB CONVERGED: af=IPv4 Sep 12 02:01:01.611 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1186: *** RIB FETCH: END [ 0 routes (0/0 up/down), 0 filtered (0/0 up/down) ] Sep 12 02:01:01.611 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1191: RIB FETCH: Non-filtered/UP [ 0 protected routes, 0/0/0 tot/bkup/protected paths ] Sep 12 02:03:03.383 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1138: *** RIB FETCH [ 2 buffers ]; af=IPv4: START Sep 12 02:03:03.392 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(5.5.5.5/32) -- metric 4, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:03:03.392 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:887: Tbl(0xe0000000): *** RIB CONVERGED: af=IPv4 Sep 12 02:03:03.392 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1186: *** RIB FETCH: END [ 1 routes (1/0 up/down), 0 filtered (0/0 up/down) ] Sep 12 02:03:03.392 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1191: RIB FETCH: Non-filtered/UP [ 0 protected routes, 1/0/0 tot/bkup/protected paths ] Sep 12 02:03:03.394 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1138: *** RIB FETCH [ 2 buffers ]; af=IPv4: START Sep 12 02:03:03.395 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:887: Tbl(0xe0000000): *** RIB CONVERGED: af=IPv4 Sep 12 02:03:03.395 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1186: *** RIB FETCH: END [ 0 routes (0/0 up/down), 0 filtered (0/0 up/down) ] Sep 12 02:03:03.395 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1191: RIB FETCH: Non-filtered/UP [ 0 protected routes, 0/0/0 tot/bkup/protected paths ] Sep 12 02:14:54.956 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:14:55.104 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:21:25.964 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:178: ldp_rib_route_filter_set: cfged 1, filter 2, af IPv4 Sep 12 02:21:25.964 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:268: RIB Event: set acl configuration done(notify tib 1), af=IPv4 Sep 12 02:21:25.965 mpls/ldp/rout 0/RP0/CPU0 t4131 [ROUTE]:267: RIB Event: notify TIB acl configuration done1 acl_added, af=IPv4 Sep 12 02:21:25.966 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1699: Tbl(0xe0000000): RIB redist reset, af=IPv4 Sep 12 02:21:25.966 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1720: Tbl(0xe0000000): RIB redist reset done, af=IPv4 Sep 12 02:21:25.966 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1699: Tbl(0xe0000000): RIB redist reset, af=IPv4 Sep 12 02:21:25.967 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1720: Tbl(0xe0000000): RIB redist reset done, af=IPv4 Sep 12 02:21:25.969 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1138: *** RIB FETCH [ 2 buffers ]; af=IPv4: START Sep 12 02:21:25.992 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 02:21:25.992 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 02:21:25.992 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 02:21:25.992 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:21:25.992 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(4.4.4.4/32) -- metric 3, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:21:25.992 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(5.5.5.5/32) -- metric 4, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:21:25.992 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:887: Tbl(0xe0000000): *** RIB CONVERGED: af=IPv4 Sep 12 02:21:25.992 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1186: *** RIB FETCH: END [ 11 routes (11/0 up/down), 5 filtered (5/0 up/down) ] Sep 12 02:21:25.992 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1191: RIB FETCH: Non-filtered/UP [ 0 protected routes, 6/0/0 tot/bkup/protected paths ] Sep 12 02:24:45.022 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:24:45.237 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:31:30.594 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:178: ldp_rib_route_filter_set: cfged 0, filter 0, af IPv4 Sep 12 02:31:30.594 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:268: RIB Event: set acl configuration done(notify tib 1), af=IPv4 Sep 12 02:31:30.594 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1699: Tbl(0xe0000000): RIB redist reset, af=IPv4 Sep 12 02:31:30.594 mpls/ldp/rout 0/RP0/CPU0 t4131 [ROUTE]:267: RIB Event: notify TIB acl configuration done0 acl_added, af=IPv4 Sep 12 02:31:30.595 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1720: Tbl(0xe0000000): RIB redist reset done, af=IPv4 Sep 12 02:31:30.596 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1699: Tbl(0xe0000000): RIB redist reset, af=IPv4 Sep 12 02:31:30.596 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1720: Tbl(0xe0000000): RIB redist reset done, af=IPv4 Sep 12 02:31:30.597 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1138: *** RIB FETCH [ 2 buffers ]; af=IPv4: START Sep 12 02:31:30.598 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 02:31:30.598 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(10.2.3.0/24) -- metric 0, src/type 0x00010001, flags 0x1082, prio/paths 0x0401 Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(10.2.3.0/24) -- metric 0, src/type 0x00010001, flags 0x1082, prio/paths 0x0401 Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(4.4.4.4/32) -- metric 3, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(10.3.4.0/24) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0b01 Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(10.4.5.0/24) -- metric 3, src/type 0x00030002, flags 0x4000000, prio/paths 0x0b01 Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(5.5.5.5/32) -- metric 4, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:887: Tbl(0xe0000000): *** RIB CONVERGED: af=IPv4 Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1186: *** RIB FETCH: END [ 11 routes (11/0 up/down), 1 filtered (1/0 up/down) ] Sep 12 02:31:30.599 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1191: RIB FETCH: Non-filtered/UP [ 0 protected routes, 10/0/0 tot/bkup/protected paths ] Sep 12 02:39:47.397 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:39:47.601 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:43:45.004 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:178: ldp_rib_route_filter_set: cfged 1, filter 2, af IPv4 Sep 12 02:43:45.004 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:268: RIB Event: set acl configuration done(notify tib 1), af=IPv4 Sep 12 02:43:45.005 mpls/ldp/rout 0/RP0/CPU0 t4131 [ROUTE]:267: RIB Event: notify TIB acl configuration done1 acl_added, af=IPv4 Sep 12 02:43:45.005 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1699: Tbl(0xe0000000): RIB redist reset, af=IPv4 Sep 12 02:43:45.006 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1720: Tbl(0xe0000000): RIB redist reset done, af=IPv4 Sep 12 02:43:45.006 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1699: Tbl(0xe0000000): RIB redist reset, af=IPv4 Sep 12 02:43:45.007 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1720: Tbl(0xe0000000): RIB redist reset done, af=IPv4 Sep 12 02:43:45.008 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1138: *** RIB FETCH [ 2 buffers ]; af=IPv4: START Sep 12 02:43:45.010 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 02:43:45.010 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 02:43:45.010 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(2.2.2.2/32) -- metric 0, src/type 0x00000001, flags 0x1081, prio/paths 0x0301 Sep 12 02:43:45.010 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:43:45.010 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(4.4.4.4/32) -- metric 3, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:43:45.010 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(5.5.5.5/32) -- metric 4, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:43:45.010 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:887: Tbl(0xe0000000): *** RIB CONVERGED: af=IPv4 Sep 12 02:43:45.010 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1186: *** RIB FETCH: END [ 11 routes (11/0 up/down), 5 filtered (5/0 up/down) ] Sep 12 02:43:45.010 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:1191: RIB FETCH: Non-filtered/UP [ 0 protected routes, 6/0/0 tot/bkup/protected paths ] Sep 12 02:47:01.738 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:47:01.907 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:53:33.010 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 Sep 12 02:53:33.195 mpls/ldp/rout 0/RP0/CPU0 t4549 [ROUTE]:209: Tbl(0xe0000000): Route UPDATE: Prefix(3.3.3.3/32) -- metric 2, src/type 0x00030002, flags 0x4000000, prio/paths 0x0901 RP/0/RP0/CPU0:PE1#show mpls ldp trace forwarding Sat Sep 12 02:57:01.343 UTC 178 wrapping entries (1027456 possible, 3456 allocated, 559 filtered, 737 total) Sep 12 01:59:37.497 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2276: lsd_c_init Sep 12 01:59:38.501 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1641: lsd bind Sep 12 01:59:47.091 mpls/ldp/str 0/RP0/CPU0 t4551 [FWDG]:1429: lsd_c_notify event: connect Sep 12 01:59:47.092 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1482: lsd_c_app_reg2: flags=0x1, recov_time=15 sec Sep 12 01:59:57.096 mpls/ldp/str 0/RP0/CPU0 t4551 [FWDG]:1496: lsd_c_notify event: app_reg Sep 12 01:59:57.097 mpls/ldp/str 0/RP0/CPU0 t4551 [FWDG]:1571: lsd_c_notify event: entropy_lbl_disable Sep 12 01:59:57.097 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:573: LSD Intf-Enable: GigabitEthernet0/0/0/1 (ifh 0x10), ftype=1 Sep 12 01:59:57.097 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 01:59:57.097 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:3316: MFI Label Alloc OOR cleared (timed_out 0 lsd_restart 1) at af=IPv4 Sep 12 01:59:57.097 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 1 items to mfi queue - queue now contains 1 items Sep 12 01:59:57.097 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (1 items: 0 ctrl, 1 intf, 0 lbl, 0 rw) - last bulk-id=1 Sep 12 01:59:57.098 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 1 reply_cnt 1 Sep 12 01:59:57.099 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (1 items: 0 ctrl, 1 intf, 0 lbl, 0 rw) - last bulk-id=1 Sep 12 01:59:57.099 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 1 items from mfi queue - queue now contains 0 items Sep 12 01:59:57.129 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 01:59:57.129 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 12 01:59:57.129 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 01:59:57.129 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:347: LSD Ctrl-Op: Rsrc-Complete Sep 12 01:59:57.129 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 3 items to mfi queue - queue now contains 5 items Sep 12 01:59:57.129 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 2 lbl, 0 rw) - last bulk-id=3 Sep 12 01:59:57.129 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 01:59:57.129 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (3 items: 1 ctrl, 0 intf, 2 lbl, 0 rw) - last bulk-id=6 Sep 12 01:59:57.129 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 3.3.3.3/32, lcl_lbl 24000 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #7 LSD Lbl-RW-Create: FEC 3.3.3.3/32 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #7 LSD RW-Create: lcl_lbl 24000 -- 1/1 lbl paths Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 4.4.4.4/32, lcl_lbl 24001 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #8 LSD Lbl-RW-Create: FEC 4.4.4.4/32 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #8 LSD RW-Create: lcl_lbl 24001 -- 1/1 lbl paths Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 2 lbl, 0 rw) - last bulk-id=3 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 3 items Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 5 items Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 3 reply_cnt 3 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 10.3.4.0/24, lcl_lbl 24002 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=8 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #9 LSD Lbl-RW-Create: FEC 10.3.4.0/24 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #9 LSD RW-Create: lcl_lbl 24002 -- 1/1 lbl paths Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 10.4.5.0/24, lcl_lbl 24003 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #10 LSD Lbl-RW-Create: FEC 10.4.5.0/24 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #10 LSD RW-Create: lcl_lbl 24003 -- 1/1 lbl paths Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (3 items: 1 ctrl, 0 intf, 2 lbl, 0 rw) - last bulk-id=6 Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 3 items from mfi queue - queue now contains 2 items Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 4 items Sep 12 01:59:57.130 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 01:59:57.131 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=10 Sep 12 01:59:57.131 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=8 Sep 12 01:59:57.131 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 2 items Sep 12 01:59:57.131 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 01:59:57.131 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=10 Sep 12 01:59:57.131 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 12 02:03:03.392 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:03:03.392 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 1 items to mfi queue - queue now contains 1 items Sep 12 02:03:03.392 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (1 items: 0 ctrl, 0 intf, 1 lbl, 0 rw) - last bulk-id=11 Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 1 reply_cnt 1 Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 5.5.5.5/32, lcl_lbl 24005 Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #12 LSD Lbl-RW-Create: FEC 5.5.5.5/32 Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #12 LSD RW-Create: lcl_lbl 24005 -- 0/1 lbl paths Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (1 items: 0 ctrl, 0 intf, 1 lbl, 0 rw) - last bulk-id=11 Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 1 items from mfi queue - queue now contains 0 items Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 1 items to mfi queue - queue now contains 1 items Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (1 items: 0 ctrl, 0 intf, 0 lbl, 1 rw) - last bulk-id=12 Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 1 reply_cnt 1 Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (1 items: 0 ctrl, 0 intf, 0 lbl, 1 rw) - last bulk-id=12 Sep 12 02:03:03.393 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 1 items from mfi queue - queue now contains 0 items Sep 12 02:03:05.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #13 LSD Lbl-RW-Create: FEC 5.5.5.5/32 Sep 12 02:03:05.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #13 LSD RW-Create: lcl_lbl 24005 -- 1/1 lbl paths Sep 12 02:03:05.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:03:05.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 1 items to mfi queue - queue now contains 1 items Sep 12 02:03:05.498 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (1 items: 0 ctrl, 0 intf, 0 lbl, 1 rw) - last bulk-id=13 Sep 12 02:03:05.499 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 1 reply_cnt 1 Sep 12 02:03:05.499 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (1 items: 0 ctrl, 0 intf, 0 lbl, 1 rw) - last bulk-id=13 Sep 12 02:03:05.499 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 1 items from mfi queue - queue now contains 0 items Sep 12 02:19:35.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #14 LSD Lbl-RW-Create: FEC 10.3.4.0/24 Sep 12 02:19:35.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #14 LSD RW-Create: lcl_lbl 24002 -- 0/1 lbl paths Sep 12 02:19:35.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:19:35.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #15 LSD Lbl-RW-Create: FEC 10.4.5.0/24 Sep 12 02:19:35.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #15 LSD RW-Create: lcl_lbl 24003 -- 0/1 lbl paths Sep 12 02:19:35.501 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 12 02:19:35.501 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=15 Sep 12 02:19:35.502 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 02:19:35.502 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=15 Sep 12 02:19:35.502 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 12 02:20:25.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #16 LSD Lbl-RW-Create: FEC 10.3.4.0/24 Sep 12 02:20:25.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #16 LSD RW-Create: lcl_lbl 24002 -- 1/1 lbl paths Sep 12 02:20:25.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:20:25.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #17 LSD Lbl-RW-Create: FEC 10.4.5.0/24 Sep 12 02:20:25.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #17 LSD RW-Create: lcl_lbl 24003 -- 1/1 lbl paths Sep 12 02:20:25.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 12 02:20:25.500 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=17 Sep 12 02:20:25.501 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 02:20:25.501 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=17 Sep 12 02:20:25.501 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 12 02:21:35.998 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1937: Tbl(0xe0000000): LSD Lbl-RW-Delete: FEC 10.3.4.0/24, lcl_lbl 24002 Sep 12 02:21:35.998 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:21:35.998 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1937: Tbl(0xe0000000): LSD Lbl-RW-Delete: FEC 10.4.5.0/24, lcl_lbl 24003 Sep 12 02:21:35.998 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 12 02:21:35.998 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=19 Sep 12 02:21:35.999 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 02:21:35.999 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=19 Sep 12 02:21:35.999 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 12 02:28:55.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #20 LSD Lbl-RW-Create: FEC 3.3.3.3/32 Sep 12 02:28:55.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #20 LSD RW-Create: lcl_lbl 24000 -- 0/1 lbl paths Sep 12 02:28:55.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:28:55.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #21 LSD Lbl-RW-Create: FEC 4.4.4.4/32 Sep 12 02:28:55.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #21 LSD RW-Create: lcl_lbl 24001 -- 0/1 lbl paths Sep 12 02:28:55.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 12 02:28:55.499 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=21 Sep 12 02:28:55.499 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 02:28:55.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=21 Sep 12 02:28:55.500 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 12 02:31:30.600 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:31:30.600 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 12 02:31:30.600 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 2 lbl, 0 rw) - last bulk-id=23 Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 10.3.4.0/24, lcl_lbl 24002 Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #24 LSD Lbl-RW-Create: FEC 10.3.4.0/24 Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #24 LSD RW-Create: lcl_lbl 24002 -- 1/1 lbl paths Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:804: Tbl(0xe0000000): LSD Lbl-Alloc (response): FEC 10.4.5.0/24, lcl_lbl 24003 Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #25 LSD Lbl-RW-Create: FEC 10.4.5.0/24 Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #25 LSD RW-Create: lcl_lbl 24003 -- 1/1 lbl paths Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 2 lbl, 0 rw) - last bulk-id=23 Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 12 02:31:30.601 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 12 02:31:30.602 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=25 Sep 12 02:31:30.602 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 02:31:30.602 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=25 Sep 12 02:31:30.602 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 12 02:35:13.615 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #26 LSD Lbl-RW-Create: FEC 5.5.5.5/32 Sep 12 02:35:13.615 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #26 LSD RW-Create: lcl_lbl 24005 -- 0/1 lbl paths Sep 12 02:35:13.615 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:35:13.615 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #27 LSD Lbl-RW-Create: FEC 10.3.4.0/24 Sep 12 02:35:13.615 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #27 LSD RW-Create: lcl_lbl 24002 -- 0/1 lbl paths Sep 12 02:35:13.615 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #28 LSD Lbl-RW-Create: FEC 10.4.5.0/24 Sep 12 02:35:13.615 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #28 LSD RW-Create: lcl_lbl 24003 -- 0/1 lbl paths Sep 12 02:35:13.615 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 3 items to mfi queue - queue now contains 3 items Sep 12 02:35:13.616 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (3 items: 0 ctrl, 0 intf, 0 lbl, 3 rw) - last bulk-id=28 Sep 12 02:35:13.616 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 3 reply_cnt 3 Sep 12 02:35:13.616 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (3 items: 0 ctrl, 0 intf, 0 lbl, 3 rw) - last bulk-id=28 Sep 12 02:35:13.616 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 3 items from mfi queue - queue now contains 0 items Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #29 LSD Lbl-RW-Create: FEC 3.3.3.3/32 Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #29 LSD RW-Create: lcl_lbl 24000 -- 1/1 lbl paths Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #30 LSD Lbl-RW-Create: FEC 4.4.4.4/32 Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #30 LSD RW-Create: lcl_lbl 24001 -- 1/1 lbl paths Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #31 LSD Lbl-RW-Create: FEC 5.5.5.5/32 Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #31 LSD RW-Create: lcl_lbl 24005 -- 1/1 lbl paths Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #32 LSD Lbl-RW-Create: FEC 10.3.4.0/24 Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #32 LSD RW-Create: lcl_lbl 24002 -- 1/1 lbl paths Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #33 LSD Lbl-RW-Create: FEC 10.4.5.0/24 Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #33 LSD RW-Create: lcl_lbl 24003 -- 1/1 lbl paths Sep 12 02:35:15.213 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 5 items to mfi queue - queue now contains 5 items Sep 12 02:35:15.214 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (5 items: 0 ctrl, 0 intf, 0 lbl, 5 rw) - last bulk-id=33 Sep 12 02:35:15.214 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 5 reply_cnt 5 Sep 12 02:35:15.214 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (5 items: 0 ctrl, 0 intf, 0 lbl, 5 rw) - last bulk-id=33 Sep 12 02:35:15.214 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 5 items from mfi queue - queue now contains 0 items Sep 12 02:35:32.298 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:6560: *** START: MPLS fwd 'populate' for GigabitEthernet0/0/0/1 (ifh 0x10) (adj_ldp_id 3.3.3.3:0) Sep 12 02:35:32.298 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:6589: *** END: MPLS fwd 'populate' Sep 12 02:43:55.998 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1937: Tbl(0xe0000000): LSD Lbl-RW-Delete: FEC 10.3.4.0/24, lcl_lbl 24002 Sep 12 02:43:55.998 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:43:55.998 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1937: Tbl(0xe0000000): LSD Lbl-RW-Delete: FEC 10.4.5.0/24, lcl_lbl 24003 Sep 12 02:43:55.998 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 12 02:43:55.998 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=35 Sep 12 02:43:55.999 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 02:43:55.999 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=35 Sep 12 02:43:55.999 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items Sep 12 02:50:45.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #36 LSD Lbl-RW-Create: FEC 3.3.3.3/32 Sep 12 02:50:45.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #36 LSD RW-Create: lcl_lbl 24000 -- 0/1 lbl paths Sep 12 02:50:45.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:199: *** LSD req bulk START Sep 12 02:50:45.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1665: Tbl(0xe0000000): #37 LSD Lbl-RW-Create: FEC 4.4.4.4/32 Sep 12 02:50:45.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:1721: Tbl(0xe0000000): #37 LSD RW-Create: lcl_lbl 24001 -- 0/1 lbl paths Sep 12 02:50:45.498 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:28: Added 2 items to mfi queue - queue now contains 2 items Sep 12 02:50:45.498 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:982: *** LSD req bulk SENT (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=37 Sep 12 02:50:45.499 mpls/ldp/fwdg 0/RP0/CPU0 t4551 [FWDG]:1385: LSD Bulk reply processed: op_cnt 2 reply_cnt 2 Sep 12 02:50:45.499 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:2195: LSD bulk op response: (2 items: 0 ctrl, 0 intf, 0 lbl, 2 rw) - last bulk-id=37 Sep 12 02:50:45.499 mpls/ldp/fwdg 0/RP0/CPU0 t4131 [FWDG]:54: Processed 2 items from mfi queue - queue now contains 0 items RP/0/RP0/CPU0:PE1#show mpls lsd trace Sat Sep 12 02:57:01.490 UTC 305 wrapping entries (224896 possible, 1664 allocated, 0 filtered, 305 total) Sep 12 01:57:53.294 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:431: ************ MPLS-LSD started ********** Sep 12 01:57:53.294 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:446: Successfully initialized module 'base' Sep 12 01:57:53.294 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:446: Successfully initialized module 'app_mgr' Sep 12 01:57:53.294 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:446: Successfully initialized module 'bcdl2' Sep 12 01:57:53.294 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:446: Successfully initialized module 'im' Sep 12 01:57:53.295 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:446: Successfully initialized module 'rw mgr' Sep 12 01:57:53.295 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:446: Successfully initialized module 'lbl_mgr' Sep 12 01:57:53.295 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:446: Successfully initialized module 'ul_mgr' Sep 12 01:57:53.295 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:446: Successfully initialized module 'edm_fwd' Sep 12 01:57:53.295 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:446: Successfully initialized module 'lsr_mib_edm' Sep 12 01:57:53.392 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:399: Node mem init:state='Normal', 255626332K phy, 233010460K free Sep 12 01:57:53.392 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:527: Successfully initialized module 'oom init' Sep 12 01:57:53.393 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:527: Successfully initialized module 'base preinit' Sep 12 01:57:55.892 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:527: Successfully initialized module 'dbg init' Sep 12 01:57:55.892 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:527: Successfully initialized module 'im preinit' Sep 12 01:57:55.892 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:527: Successfully initialized module 'lbl mgr preinit' Sep 12 01:57:56.197 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:967: Registered chkpt table (App) Sep 12 01:57:56.197 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:982: Registered chkpt table (chkpt-register) Sep 12 01:57:56.197 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:995: Registered chkpt table (Lbl) Sep 12 01:57:56.292 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:1019: Registered chkpt table (SRLB Range) Sep 12 01:57:56.292 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:527: Successfully initialized module 'chkpt' Sep 12 01:57:57.097 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:527: Successfully initialized module 'sysdb' Sep 12 01:57:57.097 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:527: Successfully initialized module 'ul mgr preinit' Sep 12 01:57:57.097 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:527: Successfully initialized module 'edm rsi preinit' Sep 12 01:57:57.695 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:527: Successfully initialized module 'rcmd init' Sep 12 01:57:57.695 mpls/lsd/rare 0/RP0/CPU0 t2232 PROC:87: SYSMGR role change nfn. New LSD Node role = 1 Sep 12 01:57:57.696 mpls/lsd/proc 0/RP0/CPU0 t1994 PROC:221: Successful lsd_pm_init exit Sep 12 01:57:57.793 mpls/lsd/proc 0/RP0/CPU0 t1994 PROC:94: Successful lsd_pm_conn_cb exit Sep 12 01:57:57.793 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:129: Entered lsd_pm_notify_register_internal: old_issu_role=0 new_issu_role=0 reg_type=7 Sep 12 01:57:57.793 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:129: Entered lsd_pm_notify_register_internal: old_issu_role=0 new_issu_role=1 reg_type=7 Sep 12 01:57:57.797 mpls/lsd/common 0/RP0/CPU0 t2232 AIPC:343: ipc_init successfully Sep 12 01:57:57.995 mpls/lsd/rare 0/RP0/CPU0 t2232 PROC:883: GO ACTIVE Sep 12 01:57:57.997 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:891: sysmgr available sent Sep 12 01:57:58.496 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:719: Successfully initialized module 'agent mgr' Sep 12 01:57:58.698 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:719: Successfully initialized module 'im init' Sep 12 01:58:02.602 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:719: Successfully initialized module 'sysdb' Sep 12 01:58:02.602 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:719: Successfully initialized module 'cc mgr' Sep 12 01:58:02.602 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:719: Successfully initialized module 'app mgr' Sep 12 01:58:03.194 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1791: BCDL-init: BCDL2 created. name:bcdls_ipv4_lsd, bcdlid=4 Sep 12 01:58:03.793 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1791: BCDL-init: BCDL2 created. name:bcdls_ipv6_lsd, bcdlid=5 Sep 12 01:58:03.793 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:719: Successfully initialized module 'bcdl2 int' Sep 12 01:58:03.794 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:719: Successfully initialized module 'encap ID int' Sep 12 01:58:03.794 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:719: Successfully initialized module 'lbl mgr' Sep 12 01:58:03.897 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:719: Successfully initialized module 'lsr mib' Sep 12 01:58:03.897 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:719: Successfully initialized module 'rcc init' Sep 12 01:58:03.897 mpls/lsd/common 0/RP0/CPU0 t2232 CHKPT:908: Chkpt successfully gone active Sep 12 01:58:04.692 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:465: Successfully initialized module 'mpls_rlb_sysdb' Sep 12 01:58:04.692 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:592: Role change[2]:Successfully (un)initialized module: mpls_rlb_sysdb init Sep 12 01:58:04.692 mpls/lsd/rare 0/RP0/CPU0 t2232 CHKPT:825: Entering lsd_chkpt_app_initial_load Sep 12 01:58:04.692 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:845: Done recovery (App), rec_cnt=0, altered=0 Sep 12 01:58:04.692 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:3863: Initial app reg/dnld bitset=0x0 Sep 12 01:58:04.693 mpls/lsd/rare 0/RP0/CPU0 t2232 CHKPT:211: Entering lsd_chkpt_lbl_initial_load Sep 12 01:58:04.693 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:245: Done recovery (Lbl), rec_cnt=0, altered=0 Sep 12 01:58:04.693 mpls/lsd/rare 0/RP0/CPU0 t2232 CHKPT:400: Chkpt label recovery: recovered 0 labels Sep 12 01:58:04.693 mpls/lsd/rare 0/RP0/CPU0 t2232 CHKPT:626: Entering lsd_chkpt_srlb_range_initial_load Sep 12 01:58:04.693 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:643: Done recovery (SRLB Range), rec_cnt=0, altered=0 Sep 12 01:58:04.693 mpls/lsd/id_lib 0/RP0/CPU0 t2232 ID_LIB:462: id lib alloc: id_max=1024576, flags=0 Sep 12 01:58:05.402 mpls/lsd/rare 0/RP0/CPU0 t2232 PROC:965: sysdb scan complete Sep 12 01:58:05.402 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:4116: Starting APP-reg tmr=600s, APP-dnld tmr=1800s Sep 12 01:58:05.402 mpls/lsd/rare 0/RP0/CPU0 t2232 PROC:1005: GO ACTIVE Complete Sep 12 01:58:05.402 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:180: Successful lsd_pm_notify_register_internal exit Sep 12 01:58:05.495 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:151: DS connect cb, status = 0. Sep 12 01:58:05.495 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:115: Encap ID manager initialized Sep 12 01:58:05.495 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1452: LSDv4 - new UG create: UG = 1, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 12 01:58:05.495 mpls/lsd/rcc 0/RP0/CPU0 t2232 RCC:1217: RCC range UG (index = 0, ug_id = 1, bcdls_id = 4) is created Sep 12 01:58:05.495 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1393: LSDv4 - UG 1 created, flags:0x0 Sep 12 01:58:05.495 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1452: LSDv4 - new UG create: UG = 2, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 12 01:58:05.495 mpls/lsd/rcc 0/RP0/CPU0 t2232 RCC:1213: RCC backgound UG (index = 1, ug_id = 2, bcdls_id = 4) is created Sep 12 01:58:05.495 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1393: LSDv4 - UG 2 created, flags:0x0 Sep 12 01:58:05.495 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1452: LSDv6 - new UG create: UG = 1, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 12 01:58:05.495 mpls/lsd/rcc 0/RP0/CPU0 t2232 RCC:1217: RCC range UG (index = 2, ug_id = 1, bcdls_id = 5) is created Sep 12 01:58:05.495 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1393: LSDv6 - UG 1 created, flags:0x0 Sep 12 01:58:05.495 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1452: LSDv6 - new UG create: UG = 2, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 12 01:58:05.495 mpls/lsd/rcc 0/RP0/CPU0 t2232 RCC:1213: RCC backgound UG (index = 3, ug_id = 2, bcdls_id = 5) is created Sep 12 01:58:05.495 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1393: LSDv6 - UG 2 created, flags:0x0 Sep 12 01:58:29.493 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1452: LSDv6 - new UG create: UG = 0, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 12 01:58:29.493 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1393: LSDv6 - UG 0 created, flags:0x0 Sep 12 01:58:29.493 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1452: LSDv4 - new UG create: UG = 0, Parent UG = -2, UG type:1, flags:0x0, bcdlc_id:0 Sep 12 01:58:29.493 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:1393: LSDv4 - UG 0 created, flags:0x0 Sep 12 01:58:29.592 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/1] Label FPI (BCDL Pri:0) - Incoming Label:2, ELC:0, rw_flags:0x40000 Sep 12 01:58:29.592 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2710: Poplkup-v6 MOI - Table ID:0xe08fffff, path_flags:0x0 Sep 12 01:58:29.593 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv6 - For UG 0 Downloaded 1 RWs with BCDL priority 0 Sep 12 01:58:29.593 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv6 - Send RW successful for UG 0, updates=1, size=80, total_downloads=1, EOD=1 Sep 12 01:58:29.593 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv6 - EOD sent to FIB for UG 0, all apps converged Sep 12 01:58:29.593 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv6 - Send RW successful for UG 0, updates=1, size=52, total_downloads=2, EOD=1 Sep 12 01:58:29.593 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/1] Label FPI (BCDL Pri:0) - Incoming Label:0, ELC:0, rw_flags:0x0 Sep 12 01:58:29.593 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2708: Poplkup-v4 MOI - Table ID:0xe00fffff, path_flags:0x0 Sep 12 01:58:29.593 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/1] Label FPI (BCDL Pri:0) - Incoming Label:1, ELC:0, rw_flags:0x1 Sep 12 01:58:29.593 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2708: Poplkup-v4 MOI - Table ID:0x0, path_flags:0x0 Sep 12 01:58:29.593 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/1] Label FPI (BCDL Pri:0) - Incoming Label:13, ELC:0, rw_flags:0x1 Sep 12 01:58:29.593 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2708: Poplkup-v4 MOI - Table ID:0xe0000000, path_flags:0x0 Sep 12 01:58:29.593 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 3 RWs with BCDL priority 0 Sep 12 01:58:29.593 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=3, size=132, total_downloads=1, EOD=1 Sep 12 01:58:29.593 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 01:58:29.593 mpls/lsd/rare 0/RP0/CPU0 t2232 RW:528: encap id EOD sent Sep 12 01:58:29.593 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=3, size=52, total_downloads=2, EOD=1 Sep 12 01:58:30.192 mpls/lsd/common 0/RP0/CPU0 t2232 AGENT:503: Rx-ed trig msg from agent, nodeid=0x0 Sep 12 01:58:30.193 mpls/lsd/rare 0/RP0/CPU0 t2232 AGENT:550: wrote 0 intfs to node=0x0, len=60 Sep 12 01:59:46.802 mpls/lsd/common 0/RP0/CPU0 t2232 AIPC:254: ipc_bind_v2 successfully Sep 12 01:59:46.802 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:565: Publish DS service successfully for endp LSD_DS. Sep 12 01:59:46.803 mpls/lsd/client 0/RP0/CPU0 t3394 :204: client(pid:2682) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 12 01:59:46.803 mpls/lsd/client 0/RP0/CPU0 t4412 :204: client(pid:4384) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 12 01:59:46.803 mpls/lsd/client 0/RP0/CPU0 t4551 :204: client(pid:4131) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 12 01:59:46.803 mpls/lsd/client 0/RP0/CPU0 t4278 :204: client(pid:4124) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 12 01:59:46.803 mpls/lsd/client 0/RP0/CPU0 t3666 :204: client(pid:2583) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 12 01:59:46.803 mpls/lsd/client 0/RP0/CPU0 t4659 :204: client(pid:4597) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 12 01:59:46.803 mpls/lsd/client 0/RP0/CPU0 t3468 :204: client(pid:2582) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 12 01:59:46.803 mpls/lsd/client 0/RP0/CPU0 t3559 :204: client(pid:2601) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 12 01:59:47.007 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:213: DS publish service cb, return_code:0, status:0. Sep 12 01:59:47.007 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:420: Start 120 secs high priority apps reg timer Sep 12 01:59:47.010 mpls/lsd/client 0/RP0/CPU0 t4659 :884: client(pid:4597) lib event: Connect to act Sep 12 01:59:47.011 mpls/lsd/client 0/RP0/CPU0 t4412 :884: client(pid:4384) lib event: Connect to act Sep 12 01:59:47.012 mpls/lsd/client 0/RP0/CPU0 t4278 :884: client(pid:4124) lib event: Connect to act Sep 12 01:59:47.013 mpls/lsd/client 0/RP0/CPU0 t3468 :884: client(pid:2582) lib event: Connect to act Sep 12 01:59:47.091 mpls/lsd/client 0/RP0/CPU0 t4551 :884: client(pid:4131) lib event: Connect to act Sep 12 01:59:47.093 mpls/lsd/client 0/RP0/CPU0 t3559 :884: client(pid:2601) lib event: Connect to act Sep 12 01:59:47.094 mpls/lsd/client 0/RP0/CPU0 t3666 :884: client(pid:2583) lib event: Connect to act Sep 12 01:59:47.095 mpls/lsd/client 0/RP0/CPU0 t3394 :884: client(pid:2682) lib event: Connect to act Sep 12 01:59:48.596 mpls/lsd/client 0/RP0/CPU0 t3394 :997: client(Static::active) lib event: Reg with act Sep 12 01:59:48.596 mpls/lsd/common 0/RP0/CPU0 t2232 AGENT:110: ens_write EOK type=7, len=28 Sep 12 01:59:48.596 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:3900: Clearing APP-reg tmr, Last App registered, bitmask=0x0 Sep 12 01:59:48.596 mpls/lsd/str 0/RP0/CPU0 t2232 APP:1266: App created, app=Static::active, flag:0x0, app_idx:1 Sep 12 01:59:48.596 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:782: Chkpt_save: app, app_idx=1, app_type=3, app_instance:, app_role:1 Sep 12 01:59:56.600 mpls/lsd/rare 0/RP0/CPU0 t2232 APP:1877: App RSRC-COMPLETE, app=Static::active, flag:0x41 Sep 12 01:59:56.600 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:3689: update_list: All apps converged Sep 12 01:59:56.601 mpls/lsd/proc 0/RP0/CPU0 t2232 PROC:403: Start to allow other apps reg, reason: last high prio app rsc complete Sep 12 01:59:56.603 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 01:59:56.603 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=0, size=52, total_downloads=3, EOD=1 Sep 12 01:59:56.603 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv6 - EOD sent to FIB for UG 0, all apps converged Sep 12 01:59:56.603 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv6 - Send RW successful for UG 0, updates=0, size=52, total_downloads=3, EOD=1 Sep 12 01:59:57.096 mpls/lsd/client 0/RP0/CPU0 t4551 :997: client(LDP::active) lib event: Reg with act Sep 12 01:59:57.096 mpls/lsd/str 0/RP0/CPU0 t2232 APP:1266: App created, app=LDP::active, flag:0x20, app_idx:2 Sep 12 01:59:57.096 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:782: Chkpt_save: app, app_idx=2, app_type=4, app_instance:, app_role:1 Sep 12 01:59:57.096 mpls/lsd/rare 0/RP0/CPU0 t2232 AIPC:1928: Notifying app:LDP::active, flag:0x61, event:1. Sep 12 01:59:57.097 mpls/lsd/client 0/RP0/CPU0 t4551 :237: client(LDP::active) active LSD notify event:1, flag:0 Sep 12 01:59:57.097 mpls/lsd/wrap 0/RP0/CPU0 t2232 IM:523: Enabling intf (0x10), app=LDP::active, flag:0x61, ftypes:0x1 Sep 12 01:59:57.129 mpls/lsd/id_lib 0/RP0/CPU0 t2232 ID_LIB:285: mark_used_in_summary_tree (LSD free ctr 8):id=0, lvl=0, idx=0 bitmap=0x80000000 Sep 12 01:59:57.129 mpls/lsd/id_lib 0/RP0/CPU0 t2232 ID_LIB:260: mark_free_in_summary_tree (LSD free ctr 7):id=0, lvl=3, idx=0 bitmap=0xffffffff Sep 12 01:59:57.130 mpls/lsd/rare 0/RP0/CPU0 t2232 APP:1877: App RSRC-COMPLETE, app=LDP::active, flag:0x61 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:3.3.3.3/32, Route flags:0x4000000 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24000, ELC:0, rw_flags:0x0 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:3, path_flags:0x0 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:4.4.4.4/32, Route flags:0x4000000 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24001, ELC:0, rw_flags:0x0 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:24000, path_flags:0x0 Sep 12 01:59:57.133 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 1 Sep 12 01:59:57.133 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=156, total_downloads=4, EOD=0 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.3.4.0/24, Route flags:0x4000000 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24002, ELC:0, rw_flags:0x0 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:3, path_flags:0x0 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.4.5.0/24, Route flags:0x4000000 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24003, ELC:0, rw_flags:0x0 Sep 12 01:59:57.133 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:24001, path_flags:0x0 Sep 12 01:59:57.133 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 3 Sep 12 01:59:57.133 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=156, total_downloads=5, EOD=1 Sep 12 01:59:57.133 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 01:59:57.133 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=6, EOD=1 Sep 12 01:59:57.606 mpls/lsd/client 0/RP0/CPU0 t4412 :997: client(Static:ipv4_static:active) lib event: Reg with act Sep 12 01:59:57.606 mpls/lsd/str 0/RP0/CPU0 t2232 APP:1266: App created, app=Static:ipv4_static:active, flag:0x20, app_idx:3 Sep 12 01:59:57.606 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:782: Chkpt_save: app, app_idx=3, app_type=3, app_instance:ipv4_static, app_role:1 Sep 12 01:59:58.115 mpls/lsd/common 0/RP0/CPU0 t2232 AGENT:110: ens_write EOK type=7, len=28 Sep 12 01:59:58.115 mpls/lsd/str 0/RP0/CPU0 t2232 APP:1266: App created, app=BGP-VPNv4:bgp-default:active, flag:0x20, app_idx:4 Sep 12 01:59:58.115 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:782: Chkpt_save: app, app_idx=4, app_type=8, app_instance:bgp-default, app_role:1 Sep 12 01:59:58.115 mpls/lsd/client 0/RP0/CPU0 t4659 :997: client(BGP-VPNv4:bgp-default:active) lib event: Reg with act Sep 12 01:59:58.996 mpls/lsd/str 0/RP0/CPU0 t2232 APP:1266: App created, app=PIM6:pim6:active, flag:0x20, app_idx:5 Sep 12 01:59:58.997 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:782: Chkpt_save: app, app_idx=5, app_type=14, app_instance:pim6, app_role:1 Sep 12 01:59:58.997 mpls/lsd/client 0/RP0/CPU0 t3468 :997: client(PIM6:pim6:active) lib event: Reg with act Sep 12 01:59:59.504 mpls/lsd/str 0/RP0/CPU0 t2232 APP:1266: App created, app=PIM:pim:active, flag:0x20, app_idx:6 Sep 12 01:59:59.504 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:782: Chkpt_save: app, app_idx=6, app_type=12, app_instance:pim, app_role:1 Sep 12 01:59:59.504 mpls/lsd/client 0/RP0/CPU0 t3559 :997: client(PIM:pim:active) lib event: Reg with act Sep 12 02:00:00.413 mpls/lsd/common 0/RP0/CPU0 t2232 AGENT:110: ens_write EOK type=7, len=28 Sep 12 02:00:00.413 mpls/lsd/str 0/RP0/CPU0 t2232 APP:1266: App created, app=Application-Controller:XTC:active, flag:0x20, app_idx:7 Sep 12 02:00:00.413 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:782: Chkpt_save: app, app_idx=7, app_type=6, app_instance:XTC, app_role:1 Sep 12 02:00:00.413 mpls/lsd/client 0/RP0/CPU0 t4278 :997: client(Application-Controller:XTC:active) lib event: Reg with act Sep 12 02:00:00.496 mpls/lsd/str 0/RP0/CPU0 t2232 APP:1266: App created, app=BFD::active, flag:0x20, app_idx:8 Sep 12 02:00:00.496 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:782: Chkpt_save: app, app_idx=8, app_type=11, app_instance:, app_role:1 Sep 12 02:00:00.496 mpls/lsd/client 0/RP0/CPU0 t3666 :997: client(BFD::active) lib event: Reg with act Sep 12 02:00:22.410 mpls/lsd/rare 0/RP0/CPU0 t2232 APP:1877: App RSRC-COMPLETE, app=Application-Controller:XTC:active, flag:0x61 Sep 12 02:00:29.607 mpls/lsd/rare 0/RP0/CPU0 t2232 APP:1877: App RSRC-COMPLETE, app=Static:ipv4_static:active, flag:0x61 Sep 12 02:00:47.725 mpls/lsd/client 0/RP0/CPU0 t4730 :204: client(pid:4128) DS endpt, svc: LSD_DS, ha role: 1, issu id: 0, local issu_id: 0, endpt valid: 1 Sep 12 02:00:47.729 mpls/lsd/client 0/RP0/CPU0 t4730 :884: client(pid:4128) lib event: Connect to act Sep 12 02:00:48.728 mpls/lsd/str 0/RP0/CPU0 t2232 APP:1266: App created, app=L2VPN::active, flag:0x20, app_idx:9 Sep 12 02:00:48.729 mpls/lsd/str 0/RP0/CPU0 t2232 CHKPT:782: Chkpt_save: app, app_idx=9, app_type=9, app_instance:, app_role:1 Sep 12 02:00:48.729 mpls/lsd/client 0/RP0/CPU0 t4730 :997: client(L2VPN::active) lib event: Reg with act Sep 12 02:00:50.496 mpls/lsd/rare 0/RP0/CPU0 t2232 APP:1877: App RSRC-COMPLETE, app=BFD::active, flag:0x61 Sep 12 02:00:54.734 mpls/lsd/rare 0/RP0/CPU0 t2232 APP:1877: App RSRC-COMPLETE, app=L2VPN::active, flag:0x61 Sep 12 02:01:49.194 mpls/lsd/rare 0/RP0/CPU0 t2232 APP:1877: App RSRC-COMPLETE, app=PIM6:pim6:active, flag:0x61 Sep 12 02:01:49.693 mpls/lsd/rare 0/RP0/CPU0 t2232 APP:1877: App RSRC-COMPLETE, app=PIM:pim:active, flag:0x61 Sep 12 02:01:51.200 mpls/lsd/rare 0/RP0/CPU0 t2232 APP:1877: App RSRC-COMPLETE, app=BGP-VPNv4:bgp-default:active, flag:0x61 Sep 12 02:03:03.395 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:5.5.5.5/32, Route flags:0x4000000 Sep 12 02:03:03.395 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24005, ELC:0, rw_flags:0x0 Sep 12 02:03:03.395 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:None, path_flags:0x0 Sep 12 02:03:03.395 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 1 RWs with BCDL priority 1 Sep 12 02:03:03.395 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=1, size=100, total_downloads=7, EOD=1 Sep 12 02:03:03.395 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:03:03.395 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=1, size=52, total_downloads=8, EOD=1 Sep 12 02:03:05.501 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:5.5.5.5/32, Route flags:0x4000000 Sep 12 02:03:05.501 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24005, ELC:0, rw_flags:0x80000 Sep 12 02:03:05.501 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:24003, path_flags:0x0 Sep 12 02:03:05.501 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 1 RWs with BCDL priority 1 Sep 12 02:03:05.501 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=1, size=104, total_downloads=9, EOD=1 Sep 12 02:03:05.501 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:03:05.501 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=1, size=52, total_downloads=10, EOD=1 Sep 12 02:19:35.504 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.3.4.0/24, Route flags:0x4000000 Sep 12 02:19:35.504 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24002, ELC:0, rw_flags:0x80000 Sep 12 02:19:35.504 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:None, path_flags:0x0 Sep 12 02:19:35.504 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.4.5.0/24, Route flags:0x4000000 Sep 12 02:19:35.505 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24003, ELC:0, rw_flags:0x80000 Sep 12 02:19:35.505 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:None, path_flags:0x0 Sep 12 02:19:35.505 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 3 Sep 12 02:19:35.505 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=148, total_downloads=11, EOD=1 Sep 12 02:19:35.505 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:19:35.505 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=12, EOD=1 Sep 12 02:20:25.503 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.3.4.0/24, Route flags:0x4000000 Sep 12 02:20:25.503 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24002, ELC:0, rw_flags:0x80000 Sep 12 02:20:25.503 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:3, path_flags:0x0 Sep 12 02:20:25.503 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.4.5.0/24, Route flags:0x4000000 Sep 12 02:20:25.503 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24003, ELC:0, rw_flags:0x80000 Sep 12 02:20:25.503 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:24001, path_flags:0x0 Sep 12 02:20:25.503 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 3 Sep 12 02:20:25.503 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=156, total_downloads=13, EOD=1 Sep 12 02:20:25.503 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:20:25.503 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=14, EOD=1 Sep 12 02:21:36.001 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1887: RW Delete [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.3.4.0/24, Route flags:0x4000000 Sep 12 02:21:36.001 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1805: RW Delete [0/2] Label FPI (BCDL Pri:3) - IncomingLabel:24002, ELC:0, rw_flags:0x80000 Sep 12 02:21:36.001 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1887: RW Delete [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.4.5.0/24, Route flags:0x4000000 Sep 12 02:21:36.001 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1805: RW Delete [0/2] Label FPI (BCDL Pri:3) - IncomingLabel:24003, ELC:0, rw_flags:0x80000 Sep 12 02:21:36.001 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 3 Sep 12 02:21:36.001 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=104, total_downloads=15, EOD=1 Sep 12 02:21:36.001 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:21:36.001 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=16, EOD=1 Sep 12 02:28:55.502 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:3.3.3.3/32, Route flags:0x4000000 Sep 12 02:28:55.502 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24000, ELC:0, rw_flags:0x80000 Sep 12 02:28:55.502 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:None, path_flags:0x0 Sep 12 02:28:55.502 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:4.4.4.4/32, Route flags:0x4000000 Sep 12 02:28:55.502 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24001, ELC:0, rw_flags:0x80000 Sep 12 02:28:55.502 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:None, path_flags:0x0 Sep 12 02:28:55.502 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 1 Sep 12 02:28:55.502 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=148, total_downloads=17, EOD=1 Sep 12 02:28:55.502 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:28:55.502 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=18, EOD=1 Sep 12 02:31:30.604 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.3.4.0/24, Route flags:0x4000000 Sep 12 02:31:30.604 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24002, ELC:0, rw_flags:0x0 Sep 12 02:31:30.604 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:3, path_flags:0x0 Sep 12 02:31:30.604 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.4.5.0/24, Route flags:0x4000000 Sep 12 02:31:30.604 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24003, ELC:0, rw_flags:0x0 Sep 12 02:31:30.604 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:24001, path_flags:0x0 Sep 12 02:31:30.604 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 3 Sep 12 02:31:30.605 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=156, total_downloads=19, EOD=1 Sep 12 02:31:30.605 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:31:30.605 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=20, EOD=1 Sep 12 02:35:13.620 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:5.5.5.5/32, Route flags:0x4000000 Sep 12 02:35:13.620 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24005, ELC:0, rw_flags:0x80000 Sep 12 02:35:13.620 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:None, path_flags:0x0 Sep 12 02:35:13.620 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 1 RWs with BCDL priority 1 Sep 12 02:35:13.620 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=1, size=100, total_downloads=21, EOD=0 Sep 12 02:35:13.620 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.3.4.0/24, Route flags:0x4000000 Sep 12 02:35:13.620 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24002, ELC:0, rw_flags:0x80000 Sep 12 02:35:13.620 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:None, path_flags:0x0 Sep 12 02:35:13.620 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.4.5.0/24, Route flags:0x4000000 Sep 12 02:35:13.620 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24003, ELC:0, rw_flags:0x80000 Sep 12 02:35:13.620 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:None, path_flags:0x0 Sep 12 02:35:13.620 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 3 Sep 12 02:35:13.620 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=148, total_downloads=22, EOD=1 Sep 12 02:35:13.620 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:35:13.620 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=23, EOD=1 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:3.3.3.3/32, Route flags:0x4000000 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24000, ELC:0, rw_flags:0x80000 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:3, path_flags:0x0 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:4.4.4.4/32, Route flags:0x4000000 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24001, ELC:0, rw_flags:0x80000 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:24000, path_flags:0x0 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:5.5.5.5/32, Route flags:0x4000000 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24005, ELC:0, rw_flags:0x80000 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:24003, path_flags:0x0 Sep 12 02:35:15.216 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 3 RWs with BCDL priority 1 Sep 12 02:35:15.216 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=3, size=208, total_downloads=24, EOD=0 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.3.4.0/24, Route flags:0x4000000 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24002, ELC:0, rw_flags:0x80000 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:3, path_flags:0x0 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.4.5.0/24, Route flags:0x4000000 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:3) - Incoming Label:24003, ELC:0, rw_flags:0x80000 Sep 12 02:35:15.216 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:24001, path_flags:0x0 Sep 12 02:35:15.216 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 3 Sep 12 02:35:15.216 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=156, total_downloads=25, EOD=1 Sep 12 02:35:15.216 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:35:15.216 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=26, EOD=1 Sep 12 02:43:56.001 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1887: RW Delete [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.3.4.0/24, Route flags:0x4000000 Sep 12 02:43:56.001 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1805: RW Delete [0/2] Label FPI (BCDL Pri:3) - IncomingLabel:24002, ELC:0, rw_flags:0x80000 Sep 12 02:43:56.001 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1887: RW Delete [0/2] IPv4 FPI (BCDL Pri:3) - Prefix:10.4.5.0/24, Route flags:0x4000000 Sep 12 02:43:56.001 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1805: RW Delete [0/2] Label FPI (BCDL Pri:3) - IncomingLabel:24003, ELC:0, rw_flags:0x80000 Sep 12 02:43:56.001 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 3 Sep 12 02:43:56.001 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=104, total_downloads=27, EOD=1 Sep 12 02:43:56.001 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:43:56.001 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=28, EOD=1 Sep 12 02:50:45.501 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:3.3.3.3/32, Route flags:0x4000000 Sep 12 02:50:45.501 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24000, ELC:0, rw_flags:0x80000 Sep 12 02:50:45.501 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:None, path_flags:0x0 Sep 12 02:50:45.501 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1899: RW Update [0/2] IPv4 FPI (BCDL Pri:1) - Prefix:4.4.4.4/32, Route flags:0x4000000 Sep 12 02:50:45.501 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:1823: RW Update [0/2] Label FPI (BCDL Pri:1) - Incoming Label:24001, ELC:0, rw_flags:0x80000 Sep 12 02:50:45.501 mpls/lsd/rw 0/RP0/CPU0 t2232 RW:2794: LFA IPv4-Stack MOI (depth=1) - NH:10.2.3.3, IF:GigabitEthernet0/0/0/1 (ifh 0x10), NHID:0x3, Lbl:None, path_flags:0x0 Sep 12 02:50:45.501 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:721: LSDv4 - For UG 0 Downloaded 2 RWs with BCDL priority 1 Sep 12 02:50:45.501 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:790: LSDv4 - Send RW successful for UG 0, updates=2, size=148, total_downloads=29, EOD=1 Sep 12 02:50:45.501 mpls/lsd/bcdl 0/RP0/CPU0 t2232 BCDL:892: LSDv4 - EOD sent to FIB for UG 0, all apps converged Sep 12 02:50:45.501 mpls/lsd/wrap 0/RP0/CPU0 t2232 BCDL:941: LSDv4 - Send RW successful for UG 0, updates=2, size=52, total_downloads=30, EOD=1