RP/0/RP0/CPU0:R5#show ospf trace spf_ext Sun Sep 13 16:12:20.982 UTC Traces for OSPF 1 (Thu Jan 1 00:00:00) Traces returned/requested/available: 0/256/0 Trace buffer: spf_ext No trace entries are available RP/0/RP0/CPU0:R5#show ospf trace adj_cycle Sun Sep 13 16:12:21.726 UTC Traces for OSPF 1 (Sun Sep 13 16:12:22) Traces returned/requested/available: 101/8192/101 Trace buffer: adj_cycle 1 Sep 13 14:58:11.276 ospf_send_dbd: to 3.3.3.3(10.2.35.3) intf Gi0/0/0/0 seq 0x64749b1a 2 Sep 13 14:58:11.288 ospf_rcv_dbd: from 3.3.3.3(10.2.35.3) intf Gi0/0/0/0 seq 0x4d4d2fa 3 Sep 13 14:58:11.288 ospf_rcv_dbd: from 3.3.3.3(10.2.35.3) intf Gi0/0/0/0 seq 0x64749b1a 4 Sep 13 14:58:11.288 ospf_send_dbd: to 3.3.3.3(10.2.35.3) intf Gi0/0/0/0 seq 0x64749b1b 5 Sep 13 14:58:11.294 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 3 paksize 126 6 Sep 13 14:58:11.295 ospf_output: LSA pkt, src 10.2.35.5 dest 10.2.35.3 area 0.0.0.2 intf Gi0/0/0/0 7 Sep 13 14:58:11.295 ospf_rcv_dbd: from 3.3.3.3(10.2.35.3) intf Gi0/0/0/0 seq 0x64749b1b 8 Sep 13 14:58:11.295 ospf_output: LSA pkt, src 10.2.35.5 dest 10.2.35.3 area 0.0.0.2 intf Gi0/0/0/0 9 Sep 13 14:58:11.295 ospf_send_req: LS REQ pkt, nbr 3.3.3.3/10.2.35.3 cnt 5 unsent 0 10 Sep 13 14:58:11.302 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 4 paksize 266 11 Sep 13 14:58:11.374 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 12 Sep 13 14:58:11.375 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 4 paksize 166 13 Sep 13 14:58:11.583 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 4 paksize 202 14 Sep 13 14:58:12.878 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 4 paksize 146 15 Sep 13 14:58:13.302 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 134 16 Sep 13 14:58:13.306 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 17 Sep 13 14:58:16.693 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 4 paksize 146 18 Sep 13 14:58:18.693 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 19 Sep 13 14:58:45.976 ospf_send_dbd: to 6.6.6.6(10.2.0.6) intf Gi0/0/0/1 seq 0x9ad4330 20 Sep 13 14:58:50.771 ospf_send_dbd: to 6.6.6.6(10.2.0.6) intf Gi0/0/0/1 seq 0x9ad4330 21 Sep 13 14:58:51.320 ospf_rcv_dbd: from 6.6.6.6(10.2.0.6) intf Gi0/0/0/1 seq 0x22886327 22 Sep 13 14:58:51.320 ospf_send_dbd: to 6.6.6.6(10.2.0.6) intf Gi0/0/0/1 seq 0x22886327 23 Sep 13 14:58:51.327 ospf_rcv_dbd: from 6.6.6.6(10.2.0.6) intf Gi0/0/0/1 seq 0x22886328 24 Sep 13 14:58:51.327 ospf_output: LSA pkt, src 10.2.0.5 dest 10.2.0.6 area 0.0.0.2 intf Gi0/0/0/1 25 Sep 13 14:58:51.327 ospf_send_req: LS REQ pkt, nbr 6.6.6.6/10.2.0.6 cnt 12 unsent 0 26 Sep 13 14:58:51.327 ospf_send_dbd: to 6.6.6.6(10.2.0.6) intf Gi0/0/0/1 seq 0x22886328 27 Sep 13 14:58:51.333 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 526 28 Sep 13 14:58:51.333 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 3 paksize 246 29 Sep 13 14:58:51.333 ospf_output: LSA pkt, src 10.2.0.5 dest 10.2.0.6 area 0.0.0.2 intf Gi0/0/0/1 30 Sep 13 14:58:51.335 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 31 Sep 13 14:58:51.341 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 150 32 Sep 13 14:58:51.369 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 33 Sep 13 14:58:51.375 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 190 34 Sep 13 14:58:51.386 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.6 area 0.0.0.2 intf Gi0/0/0/1 35 Sep 13 14:58:51.402 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 36 Sep 13 14:58:53.334 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.6 area 0.0.0.2 intf Gi0/0/0/1 37 Sep 13 14:58:53.340 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 5 paksize 334 38 Sep 13 14:58:53.342 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 394 39 Sep 13 14:58:56.143 ospf_output: LSA pkt, src 10.2.35.5 dest 10.2.35.3 area 0.0.0.2 intf Gi0/0/0/0 40 Sep 13 14:58:56.349 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 4 paksize 174 41 Sep 13 14:58:56.352 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.6 area 0.0.0.2 intf Gi0/0/0/1 42 Sep 13 14:58:56.515 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 174 43 Sep 13 14:58:56.518 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 44 Sep 13 14:58:58.152 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 174 45 Sep 13 14:58:58.350 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 46 Sep 13 14:58:58.358 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 5 paksize 154 47 Sep 13 14:58:58.516 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.6 area 0.0.0.2 intf Gi0/0/0/1 48 Sep 13 15:31:15.868 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 222 49 Sep 13 15:31:15.871 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 50 Sep 13 15:31:15.967 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 154 51 Sep 13 15:31:15.969 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 52 Sep 13 15:31:17.663 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 166 53 Sep 13 15:31:17.666 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 54 Sep 13 15:31:17.812 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 314 55 Sep 13 15:31:17.815 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 56 Sep 13 15:31:17.869 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 57 Sep 13 15:31:17.930 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 334 58 Sep 13 15:31:44.468 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 4 paksize 166 59 Sep 13 15:31:44.470 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 60 Sep 13 15:31:44.602 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 4 paksize 314 61 Sep 13 15:31:44.604 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 62 Sep 13 15:31:46.468 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 63 Sep 13 15:31:46.507 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 5 paksize 274 64 Sep 13 15:32:10.420 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 65 Sep 13 15:32:10.420 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 66 Sep 13 15:32:12.429 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 5 paksize 134 67 Sep 13 15:32:12.430 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 134 68 Sep 13 15:51:32.407 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 190 69 Sep 13 15:51:32.410 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 70 Sep 13 15:51:32.533 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 154 71 Sep 13 15:51:32.536 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 72 Sep 13 15:51:34.408 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 73 Sep 13 15:51:34.416 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 154 74 Sep 13 15:58:23.109 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 226 75 Sep 13 15:58:23.112 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 76 Sep 13 15:58:25.110 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 77 Sep 13 15:58:25.118 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 154 78 Sep 13 16:03:35.724 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 79 Sep 13 16:03:35.724 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 80 Sep 13 16:03:37.733 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 134 81 Sep 13 16:03:37.733 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 5 paksize 134 82 Sep 13 16:04:51.099 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 150 83 Sep 13 16:04:51.102 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 84 Sep 13 16:04:53.100 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 85 Sep 13 16:04:53.109 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 134 86 Sep 13 16:05:00.063 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 166 87 Sep 13 16:05:00.065 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 88 Sep 13 16:05:00.205 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 4 paksize 314 89 Sep 13 16:05:00.208 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 90 Sep 13 16:05:02.063 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 91 Sep 13 16:05:02.071 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 274 92 Sep 13 16:05:36.085 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 4 paksize 166 93 Sep 13 16:05:36.087 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 94 Sep 13 16:05:36.175 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 4 paksize 314 95 Sep 13 16:05:36.177 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 96 Sep 13 16:05:38.085 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 97 Sep 13 16:05:38.105 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 5 paksize 274 98 Sep 13 16:06:04.084 ospf_output: LSA pkt, src 10.2.35.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/0 99 Sep 13 16:06:04.084 ospf_output: LSA pkt, src 10.2.0.5 dest 224.0.0.5 area 0.0.0.2 intf Gi0/0/0/1 100 Sep 13 16:06:06.092 ospf_do_hello_packets: LSA pkt, src 10.2.0.6 intf Gi0/0/0/1 type 5 paksize 134 101 Sep 13 16:06:06.133 ospf_do_hello_packets: LSA pkt, src 10.2.35.3 intf Gi0/0/0/0 type 5 paksize 134 RP/0/RP0/CPU0:R5#show ospf trace events Sun Sep 13 16:12:22.500 UTC Traces for OSPF 1 (Sun Sep 13 16:12:23) Traces returned/requested/available: 116/4096/116 Trace buffer: events 1 Sep 13 14:57:48.690 ospf_nsr_event_manager_create: Created channel, ISSU-role 0, HA-role 0 2 Sep 13 14:57:49.892 ospf_if_issu_map_complete_cb: IM issu if mapping complete cb: mapping_complete 0x1 3 Sep 13 14:57:49.892 ospf_get_instance_by_name: : Name unknown in inst AVL name tree 4 Sep 13 14:57:49.892 ospf_create_instance: : instance alloc ptr 0x5c9f8bc39730 5 Sep 13 14:57:49.892 ospf_create_instance: : AVL instance insert ptr 0x5c9f8bc39730 6 Sep 13 14:57:49.893 ospf_create_instance: lock instance 0x0 ptr 0x5c9f8bc39730 refcount 1 7 Sep 13 14:57:50.175 ospf_ds_init: op_issu_id 0 8 Sep 13 14:57:51.394 ospf_create_area: : area 0.0.0.0 (0x5c9f8bcd3e20) dummy 1 9 Sep 13 14:57:51.576 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 10 Sep 13 14:57:51.576 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 11 Sep 13 14:57:51.576 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 12 Sep 13 14:57:51.576 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 13 Sep 13 14:57:51.576 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 14 Sep 13 14:57:51.576 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 15 Sep 13 14:57:51.576 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 16 Sep 13 14:57:51.576 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 17 Sep 13 14:57:51.576 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 18 Sep 13 14:57:51.576 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 19 Sep 13 14:57:51.791 ospf_register_end_of_cfg: Attempt to register for end of config notification 20 Sep 13 14:57:51.878 ospf_cfgmgr_end_of_cfg_reg_cb: Received registration callback 21 Sep 13 14:57:51.878 ospf_cfgmgr_end_of_cfg_reg_cb: Registered for end of config 22 Sep 13 14:57:51.878 ospf_register_end_of_cfg: Registration accepted 23 Sep 13 14:57:51.982 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 24 Sep 13 14:57:51.982 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 25 Sep 13 14:57:51.988 ospf_ds_connect_cb: DS Connected 26 Sep 13 14:57:51.988 ospf_publish_ncd_ds_endp: Proc role not yet known 27 Sep 13 14:57:51.988 ospf_register_ncd_ds_service: Proc role not yet known 28 Sep 13 14:57:51.992 ospf_publish_ncd_ds_endp: Proc role not yet known 29 Sep 13 14:57:51.992 ospf_register_ncd_ds_service: Proc role not yet known 30 Sep 13 14:57:51.996 ospf_update_sckt_vrf_opt: vrf opts update OK for vrfid 0x60000000 31 Sep 13 14:57:51.997 ospf_publish_ncd_ds_endp: DS NCD service successfully published, ISSU role 1, HA role 1, 32 Sep 13 14:57:51.997 ospf_register_ncd_ds_service: Successfully registered for NCD DS notification 33 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 34 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 35 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 36 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 37 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 38 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 39 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 40 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 41 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 42 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 43 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 44 Sep 13 14:57:51.997 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 45 Sep 13 14:57:51.998 ospf_nsr_msg_chan_update: Update channel, ISSU-role 1, HA-role 1 46 Sep 13 14:57:52.178 ospf_bfd_connect: Attempt to connect to BFD server 47 Sep 13 14:57:52.182 ospf_rtrid_set_configured: new_rtr_id 5.5.5.5 48 Sep 13 14:57:52.182 ospf_rtrid_set_configured: rtrid config by value, op_conf_rtr_id 5.5.5.5 vrfid 60000000 49 Sep 13 14:57:52.182 ospf_ds_publish_service_cb: DS NCD service publised succesfully 50 Sep 13 14:57:52.185 ospf_service_redist_delete: Deleting old redist routes, instance 0x60000000 51 Sep 13 14:57:52.185 ospf_ds_register_cb: DS NCD service registered succesfully, reg-handle 0x1 52 Sep 13 14:57:52.186 ospf_soft_reset: start 53 Sep 13 14:57:52.186 ospf_flush_type5: flush external links 54 Sep 13 14:57:52.186 ospf_flush_type11: flush opaque AS links 55 Sep 13 14:57:52.191 ospf_soft_reset_up: inst 0x5c9f8bc39730 vrfid 0x60000000 delete rid tuple, alloc new rid 56 Sep 13 14:57:52.191 ospf_rtrid_allocate: checking for old rtrid 0x60000000 57 Sep 13 14:57:52.191 ospf_rtrid_allocate: checking for rtrid config 58 Sep 13 14:57:52.191 ospf_rtrid_allocate: rtrid for vrf 0x60000000 set by numeric config: 5.5.5.5 59 Sep 13 14:57:52.195 ospf_soft_reset_up: rtrid: new 5.5.5.5 old 0.0.0.0 60 Sep 13 14:57:52.195 ospf_soft_reset_up: rtrid changed, check vlink for reconfig 61 Sep 13 14:57:52.195 ospf_ds_notify_service_cb: Number of EPs 1 62 Sep 13 14:57:52.195 ospf_ds_notify_service_cb: Setting new DS endp rev 1, number of EPs - 1 63 Sep 13 14:57:52.195 ospf_ncd_ds_endp_update: DS NCD endp, HA-role 1, ISSU-role 1 op_ospf_role 6 64 Sep 13 14:57:52.195 ospf_ncd_ds_endp_update: op_issu_id 0 issu_id 0 65 Sep 13 14:57:52.195 ospf_ncd_ds_endp_update: Ignore DS endp on V1A, ha-role 1, issu-role 1 66 Sep 13 14:57:52.195 ospf_ncd_ds_endp_clean_stale: Cleaning stale NCD endpoints 67 Sep 13 14:57:52.195 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 68 Sep 13 14:57:52.195 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 69 Sep 13 14:57:52.275 ospf_apply_area: instance ptr 0x5c9f8bc39730 70 Sep 13 14:57:52.275 ospf_create_area: : area 0.0.0.2 (0x5c9f8bdb5840) dummy 0 71 Sep 13 14:57:52.280 ospf_bfd_bind_callback: Bind to BFD server - success 72 Sep 13 14:57:52.280 ospf_bfd_conn_callback: Connection to BFD established 73 Sep 13 14:57:52.280 ospf_bfd_send_create_batch: Batch size 0 74 Sep 13 14:57:52.280 ospf_bfd_end_of_replay: Sending EoR to BFD 75 Sep 13 14:57:52.387 ospf_activate_area_ptr: inactive area, area 0.0.0.2 (0x5c9f8bdb5840) op_area_count 1 76 Sep 13 14:57:52.387 ospf_activate_area: active area, area 0.0.0.2 77 Sep 13 14:57:52.388 ospf_activate_area: active area, area 0.0.0.2 78 Sep 13 14:57:52.388 ospf_service_area_nssa_default: nssa_default, ar_id 0.0.0.2 forw_addr 0.0.0.0 metric 16777215 79 Sep 13 14:57:53.186 ospf_service_redist_summary: Start redist-scanning 80 Sep 13 14:58:00.475 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 81 Sep 13 14:58:00.475 ospf_service_area_nssa_default: nssa_default, ar_id 0.0.0.2 forw_addr 0.0.0.0 metric 16777215 82 Sep 13 14:58:00.488 ospf_if_rtr_id_callback: Router-id sent by IPARM: 5.5.5.5 83 Sep 13 14:58:01.989 ospf_cfgmgr_end_of_cfg_cb: Received end of config callback 84 Sep 13 14:58:01.989 ospf_cfgmgr_end_of_cfg_cb: Success 85 Sep 13 14:58:01.989 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 1 -> 1, rev 1 86 Sep 13 14:58:01.989 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 87 Sep 13 14:58:01.989 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 1 88 Sep 13 14:58:01.989 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 89 Sep 13 14:58:01.989 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 1 -> 1, rev 1 90 Sep 13 14:58:01.989 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 91 Sep 13 14:58:01.989 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 1 92 Sep 13 14:58:01.989 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 93 Sep 13 14:58:03.186 ospf_service_redist_summary: Start redist-scanning 94 Sep 13 14:58:05.880 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 95 Sep 13 14:58:05.977 ospf_service_area_nssa_default: nssa_default, ar_id 0.0.0.2 forw_addr 0.0.0.0 metric 16777215 96 Sep 13 14:58:11.303 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 97 Sep 13 14:58:13.186 ospf_service_redist_summary: Start redist-scanning 98 Sep 13 14:58:45.976 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 99 Sep 13 14:58:51.333 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 100 Sep 13 14:58:57.350 ospf_service_maxage: delete MAXAGE lsa, queue size 4 101 Sep 13 14:58:57.350 ospf_service_maxage: processed 4 LSAs from MAXAGE queue, requeued 4, current size 4 102 Sep 13 14:58:58.350 ospf_service_maxage: delete MAXAGE lsa, queue size 4 103 Sep 13 14:58:58.350 ospf_service_maxage: processed 4 LSAs from MAXAGE queue, requeued 4, current size 4 104 Sep 13 14:58:59.351 ospf_service_maxage: delete MAXAGE lsa, queue size 2 105 Sep 13 14:58:59.351 ospf_service_maxage: processed 2 LSAs from MAXAGE queue, requeued 0, current size 0 106 Sep 13 14:58:59.455 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 107 Sep 13 14:59:51.998 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 108 Sep 13 14:59:51.998 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 109 Sep 13 14:59:51.998 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 110 Sep 13 14:59:51.998 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 111 Sep 13 15:51:33.534 ospf_service_maxage: delete MAXAGE lsa, queue size 1 112 Sep 13 15:51:33.534 ospf_service_maxage: processed 1 LSAs from MAXAGE queue, requeued 1, current size 1 113 Sep 13 16:03:35.631 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 114 Sep 13 16:03:35.694 ospf_sham_link_check: ext_rt: 192.168.99.0/24 met: 0 ribhdl: 5 115 Sep 13 16:03:36.632 ospf_service_redist_summary: Start redist-scanning 116 Sep 13 16:03:36.632 ospf_sham_link_check: ext_rt: 192.168.99.0/24 met: 0 ribhdl: 5 RP/0/RP0/CPU0:R5#show ospf trace adj Sun Sep 13 16:12:23.312 UTC Traces for OSPF 1 (Sun Sep 13 16:12:24) Traces returned/requested/available: 76/8192/76 Trace buffer: adj 1 Sep 13 14:57:49.892 ospf_create_instance: Instance 0x0 quiesce_time INIT 2 Sep 13 14:57:51.394 ospf_create_area: Area 0.0.0.0 quiesce_time INIT 3 Sep 13 14:57:52.185 ospf_build_ex_lsa: no rtrid to build external LSA 4 Sep 13 14:57:52.275 ospf_create_area: Area 0.0.0.2 quiesce_time INIT 5 Sep 13 14:57:53.186 ospf_service_redist_summary: end scanning, elapsed time 000000000.000029703 6 Sep 13 14:58:00.477 ospf_build_rtr_lsa: area 0.0.0.2 rtrid 5.5.5.5 seq 0x80000001 vrfid 0x60000000 7 Sep 13 14:58:03.186 ospf_service_redist_summary: scan for redist 8 Sep 13 14:58:03.186 ospf_service_redist_summary: end scanning, elapsed time 000000000.000034613 9 Sep 13 14:58:06.027 ospf_build_rtr_lsa: area 0.0.0.2 rtrid 5.5.5.5 seq 0x80000002 vrfid 0x60000000 10 Sep 13 14:58:11.276 ospf_if_inc_nbr_cnt: Gi0/0/0/0 - count in inst 1 (ex_load 0), on idb 1 11 Sep 13 14:58:11.276 ospf_inc_nbr_form_cnt: Instance 0x60000000 quiesce_time INIT 12 Sep 13 14:58:11.276 ospf_inc_nbr_form_cnt: Area 0.0.0.2 quiesce_time INIT 13 Sep 13 14:58:11.276 ospf_inc_nbr_form_cnt: nbr 3.3.3.3 forming Gi0/0/0/0, area 0.0.0.2 14 Sep 13 14:58:11.276 ospf_inc_nbr_form_cnt: #Nbrs: (ar: 1, inst: 1) forming, 0 full, area 0.0.0.2 15 Sep 13 14:58:11.276 ospf_log_adj_chg: nbr 3.3.3.3/10.2.35.3 changes from 0 to 2 16 Sep 13 14:58:11.276 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 17 Sep 13 14:58:11.276 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.2, vrfid 0x60000000 18 Sep 13 14:58:11.276 ospf_log_adj_chg: nbr 3.3.3.3/10.2.35.3 changes from 2 to 3 19 Sep 13 14:58:11.276 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 20 Sep 13 14:58:11.276 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.2, vrfid 0x60000000 21 Sep 13 14:58:11.276 ospf_log_adj_chg: nbr 3.3.3.3/10.2.35.3 changes from 3 to 4 22 Sep 13 14:58:11.276 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 23 Sep 13 14:58:11.276 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.2, vrfid 0x60000000 24 Sep 13 14:58:11.288 ospf_rcv_dbd: first DBD and we are not SLAVE 25 Sep 13 14:58:11.288 ospf_log_adj_chg: nbr 3.3.3.3/10.2.35.3 changes from 4 to 5 26 Sep 13 14:58:11.288 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 27 Sep 13 14:58:11.288 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.2, vrfid 0x60000000 28 Sep 13 14:58:11.288 ospf_nbr_inc_ex_load_count: Inst: 1 neighbors in ex_load Gi0/0/0/0, area 0.0.0.2, instance quiesce_time updated 29 Sep 13 14:58:11.288 ospf_nbr_inc_ex_load_count: Area: 1 neighbors in ex_load Gi0/0/0/0, area 0.0.0.2, area quiesce_time updated 30 Sep 13 14:58:11.288 build_dbd_sum: took 0 ms for nbr 3.3.3.3 count 1 vrf 0x60000000 31 Sep 13 14:58:11.295 ospf_log_adj_chg: nbr 3.3.3.3/10.2.35.3 changes from 5 to 6 32 Sep 13 14:58:11.295 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 33 Sep 13 14:58:11.295 ospf_log_adj_chg: DBD Rcv: 2 pkts 5 LSAs, area 0.0.0.2, vrfid 0x60000000 34 Sep 13 14:58:11.302 ospf_log_adj_chg: nbr 3.3.3.3/10.2.35.3 changes from 6 to 7 35 Sep 13 14:58:11.302 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 1 pkts 5 LSAs, LSA-Upd Rcv: 1 pkts 5 LSAs 36 Sep 13 14:58:11.302 ospf_log_adj_chg: DBD Rcv: 2 pkts 5 LSAs, area 0.0.0.2, vrfid 0x60000000 37 Sep 13 14:58:11.303 ospf_if_inc_nbr_full_cnt: Gi0/0/0/0 - full count in inst 1, on idb 1, area fullcnt 1 38 Sep 13 14:58:11.303 ospf_dec_nbr_form_cnt: nbr 3.3.3.3 forming Gi0/0/0/0, area 0.0.0.2 39 Sep 13 14:58:11.303 ospf_dec_nbr_form_cnt: #Nbrs: (ar: 0, inst: 0) forming, 1 full, area 0.0.0.2 40 Sep 13 14:58:11.315 ospf_if_inc_nbr_cnt: Gi0/0/0/1 - count in inst 2 (ex_load 0), on idb 1 41 Sep 13 14:58:11.315 ospf_inc_nbr_form_cnt: nbr 6.6.6.6 forming Gi0/0/0/1, area 0.0.0.2 42 Sep 13 14:58:11.315 ospf_inc_nbr_form_cnt: #Nbrs: (ar: 1, inst: 1) forming, 1 full, area 0.0.0.2 43 Sep 13 14:58:11.315 ospf_log_adj_chg: nbr 6.6.6.6/10.2.0.6 changes from 0 to 2 44 Sep 13 14:58:11.315 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 45 Sep 13 14:58:11.315 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.2, vrfid 0x60000000 46 Sep 13 14:58:11.374 ospf_build_rtr_lsa: area 0.0.0.2 rtrid 5.5.5.5 seq 0x80000003 vrfid 0x60000000 47 Sep 13 14:58:13.186 ospf_service_redist_summary: scan for redist 48 Sep 13 14:58:13.186 ospf_service_redist_summary: end scanning, elapsed time 000000000.000015389 49 Sep 13 14:58:21.217 ospf_log_adj_chg: nbr 6.6.6.6/10.2.0.6 changes from 2 to 3 50 Sep 13 14:58:21.217 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 51 Sep 13 14:58:21.217 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.2, vrfid 0x60000000 52 Sep 13 14:58:45.976 ospf_log_adj_chg: nbr 6.6.6.6/10.2.0.6 changes from 3 to 4 53 Sep 13 14:58:45.976 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 54 Sep 13 14:58:45.976 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.2, vrfid 0x60000000 55 Sep 13 14:58:51.320 ospf_log_adj_chg: nbr 6.6.6.6/10.2.0.6 changes from 4 to 5 56 Sep 13 14:58:51.320 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 57 Sep 13 14:58:51.320 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.2, vrfid 0x60000000 58 Sep 13 14:58:51.320 ospf_nbr_inc_ex_load_count: Inst: 1 neighbors in ex_load Gi0/0/0/1, area 0.0.0.2, instance quiesce_time updated 59 Sep 13 14:58:51.320 ospf_nbr_inc_ex_load_count: Area: 1 neighbors in ex_load Gi0/0/0/1, area 0.0.0.2, area quiesce_time updated 60 Sep 13 14:58:51.320 build_dbd_sum: took 0 ms for nbr 6.6.6.6 count 11 vrf 0x60000000 61 Sep 13 14:58:51.327 ospf_log_adj_chg: nbr 6.6.6.6/10.2.0.6 changes from 5 to 6 62 Sep 13 14:58:51.327 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 63 Sep 13 14:58:51.327 ospf_log_adj_chg: DBD Rcv: 2 pkts 12 LSAs, area 0.0.0.2, vrfid 0x60000000 64 Sep 13 14:58:51.333 ospf_log_adj_chg: nbr 6.6.6.6/10.2.0.6 changes from 6 to 7 65 Sep 13 14:58:51.333 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 1 pkts 12 LSAs, LSA-Upd Rcv: 1 pkts 12 LSAs 66 Sep 13 14:58:51.333 ospf_log_adj_chg: DBD Rcv: 2 pkts 12 LSAs, area 0.0.0.2, vrfid 0x60000000 67 Sep 13 14:58:51.333 ospf_if_inc_nbr_full_cnt: Gi0/0/0/1 - full count in inst 2, on idb 1, area fullcnt 2 68 Sep 13 14:58:51.333 ospf_dec_nbr_form_cnt: nbr 6.6.6.6 forming Gi0/0/0/1, area 0.0.0.2 69 Sep 13 14:58:51.333 ospf_dec_nbr_form_cnt: #Nbrs: (ar: 0, inst: 0) forming, 2 full, area 0.0.0.2 70 Sep 13 14:58:51.386 ospf_build_rtr_lsa: area 0.0.0.2 rtrid 5.5.5.5 seq 0x80000004 vrfid 0x60000000 71 Sep 13 14:59:31.327 ospf_nbr_hold_dbd: Timer expired (nbr_hold_dbd): nbr_id 6.6.6.6 72 Sep 13 15:32:10.420 ospf_build_rtr_lsa: area 0.0.0.2 rtrid 5.5.5.5 seq 0x80000005 vrfid 0x60000000 73 Sep 13 16:03:35.724 ospf_build_rtr_lsa: area 0.0.0.2 rtrid 5.5.5.5 seq 0x80000006 vrfid 0x60000000 74 Sep 13 16:03:36.632 ospf_service_redist_summary: scan for redist 75 Sep 13 16:03:36.632 ospf_service_redist_summary: end scanning, elapsed time 000000000.000060510 76 Sep 13 16:06:04.084 ospf_build_rtr_lsa: area 0.0.0.2 rtrid 5.5.5.5 seq 0x80000007 vrfid 0x60000000