RP/0/RP0/CPU0:XR2#show ospf trace events Sun Sep 20 09:52:01.602 UTC Traces for OSPF 1 (Sun Sep 20 09:52:02) Traces returned/requested/available: 139/4096/139 Trace buffer: events 1 Sep 20 09:44:06.917 ospf_nsr_event_manager_create: Created channel, ISSU-role 0, HA-role 0 2 Sep 20 09:44:07.332 ospf_if_issu_map_complete_cb: IM issu if mapping complete cb: mapping_complete 0x1 3 Sep 20 09:44:07.332 ospf_get_instance_by_name: : Name unknown in inst AVL name tree 4 Sep 20 09:44:07.332 ospf_create_instance: : instance alloc ptr 0x63e6585a6ac0 5 Sep 20 09:44:07.332 ospf_create_instance: : AVL instance insert ptr 0x63e6585a6ac0 6 Sep 20 09:44:07.333 ospf_create_instance: lock instance 0x0 ptr 0x63e6585a6ac0 refcount 1 7 Sep 20 09:44:07.434 ospf_ds_init: op_issu_id 0 8 Sep 20 09:44:07.925 ospf_create_area: : area 0.0.0.0 (0x63e6586411d0) dummy 1 9 Sep 20 09:44:08.015 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 10 Sep 20 09:44:08.015 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 11 Sep 20 09:44:08.015 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 12 Sep 20 09:44:08.015 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 13 Sep 20 09:44:08.015 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 14 Sep 20 09:44:08.015 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 15 Sep 20 09:44:08.015 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 16 Sep 20 09:44:08.015 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 17 Sep 20 09:44:08.015 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 18 Sep 20 09:44:08.015 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 19 Sep 20 09:44:08.213 ospf_register_end_of_cfg: Attempt to register for end of config notification 20 Sep 20 09:44:08.222 ospf_cfgmgr_end_of_cfg_reg_cb: Received registration callback 21 Sep 20 09:44:08.222 ospf_cfgmgr_end_of_cfg_reg_cb: Registered for end of config 22 Sep 20 09:44:08.222 ospf_cfgmgr_end_of_cfg_cb: Received end of config callback 23 Sep 20 09:44:08.222 ospf_cfgmgr_end_of_cfg_cb: Success 24 Sep 20 09:44:08.223 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 0 -> 0, rev 0 25 Sep 20 09:44:08.223 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 26 Sep 20 09:44:08.223 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 1 -> 1, rev 0 27 Sep 20 09:44:08.223 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 28 Sep 20 09:44:08.223 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 29 Sep 20 09:44:08.223 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 30 Sep 20 09:44:08.227 ospf_register_end_of_cfg: Registration accepted 31 Sep 20 09:44:08.312 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 32 Sep 20 09:44:08.312 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 33 Sep 20 09:44:08.316 ospf_if_rtr_id_callback: Router-id sent by IPARM: 2.2.2.2 34 Sep 20 09:44:08.316 ospf_ds_connect_cb: DS Connected 35 Sep 20 09:44:08.316 ospf_publish_ncd_ds_endp: Proc role not yet known 36 Sep 20 09:44:08.316 ospf_register_ncd_ds_service: Proc role not yet known 37 Sep 20 09:44:08.319 ospf_publish_ncd_ds_endp: Proc role not yet known 38 Sep 20 09:44:08.319 ospf_register_ncd_ds_service: Proc role not yet known 39 Sep 20 09:44:08.323 ospf_update_sckt_vrf_opt: vrf opts update OK for vrfid 0x60000000 40 Sep 20 09:44:08.324 ospf_rtrid_set_configured: new_rtr_id 2.2.2.2 41 Sep 20 09:44:08.324 ospf_rtrid_set_configured: rtrid config by value, op_conf_rtr_id 2.2.2.2 vrfid 60000000 42 Sep 20 09:44:08.325 ospf_publish_ncd_ds_endp: DS NCD service successfully published, ISSU role 1, HA role 1, 43 Sep 20 09:44:08.325 ospf_register_ncd_ds_service: Successfully registered for NCD DS notification 44 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 45 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 46 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 47 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 48 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 49 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 50 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 51 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 52 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 53 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 54 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 55 Sep 20 09:44:08.325 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 56 Sep 20 09:44:08.326 ospf_nsr_msg_chan_update: Update channel, ISSU-role 1, HA-role 1 57 Sep 20 09:44:08.411 ospf_rtrid_allocate: checking for old rtrid 0x60000000 58 Sep 20 09:44:08.411 ospf_rtrid_allocate: checking for rtrid config 59 Sep 20 09:44:08.411 ospf_rtrid_allocate: rtrid for vrf 0x60000000 set by numeric config: 2.2.2.2 60 Sep 20 09:44:08.429 ospf_bfd_connect: Attempt to connect to BFD server 61 Sep 20 09:44:08.432 ospf_ds_publish_service_cb: DS NCD service publised succesfully 62 Sep 20 09:44:08.434 ospf_ds_register_cb: DS NCD service registered succesfully, reg-handle 0x1 63 Sep 20 09:44:08.501 ospf_service_redist_delete: Deleting old redist routes, instance 0x60000000 64 Sep 20 09:44:08.501 ospf_ds_notify_service_cb: Number of EPs 1 65 Sep 20 09:44:08.501 ospf_ds_notify_service_cb: Setting new DS endp rev 1, number of EPs - 1 66 Sep 20 09:44:08.501 ospf_ncd_ds_endp_update: DS NCD endp, HA-role 1, ISSU-role 1 op_ospf_role 6 67 Sep 20 09:44:08.501 ospf_ncd_ds_endp_update: op_issu_id 0 issu_id 0 68 Sep 20 09:44:08.501 ospf_ncd_ds_endp_update: Ignore DS endp on V1A, ha-role 1, issu-role 1 69 Sep 20 09:44:08.501 ospf_ncd_ds_endp_clean_stale: Cleaning stale NCD endpoints 70 Sep 20 09:44:08.501 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 71 Sep 20 09:44:08.501 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 72 Sep 20 09:44:08.502 ospf_apply_area: instance ptr 0x63e6585a6ac0 73 Sep 20 09:44:08.502 ospf_create_area: : area 0.0.0.0 (0x63e6586f1f90) dummy 0 74 Sep 20 09:44:08.503 ospf_apply_area: instance ptr 0x63e6585a6ac0 75 Sep 20 09:44:08.503 ospf_create_area: : area 0.0.0.1 (0x63e6586f4660) dummy 0 76 Sep 20 09:44:08.503 ospf_apply_area: instance ptr 0x63e6585a6ac0 77 Sep 20 09:44:08.503 ospf_create_area: : area 0.0.0.2 (0x63e6586f6d80) dummy 0 78 Sep 20 09:44:08.512 ospf_bfd_bind_callback: Bind to BFD server - success 79 Sep 20 09:44:08.512 ospf_bfd_conn_callback: Connection to BFD established 80 Sep 20 09:44:08.512 ospf_bfd_send_create_batch: Batch size 0 81 Sep 20 09:44:08.512 ospf_bfd_end_of_replay: Sending EoR to BFD 82 Sep 20 09:44:08.522 ospf_activate_area_ptr: inactive area, area 0.0.0.0 (0x63e6586f1f90) op_area_count 1 83 Sep 20 09:44:08.522 ospf_activate_area: active area, area 0.0.0.0 84 Sep 20 09:44:08.522 ospf_activate_area_ptr: inactive area, area 0.0.0.1 (0x63e6586f4660) op_area_count 2 85 Sep 20 09:44:08.522 ospf_activate_area_ptr: inactive area, area 0.0.0.2 (0x63e6586f6d80) op_area_count 3 86 Sep 20 09:44:08.523 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 87 Sep 20 09:44:08.523 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.1 88 Sep 20 09:44:08.523 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 89 Sep 20 09:44:08.523 ospf_service_area_nssa_default: nssa_default, ar_id 0.0.0.1 forw_addr 0.0.0.0 metric 16777215 90 Sep 20 09:44:08.523 ospf_service_area_nssa_default: nssa_default, ar_id 0.0.0.2 forw_addr 0.0.0.0 metric 16777215 91 Sep 20 09:44:08.604 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 92 Sep 20 09:44:08.621 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.1 93 Sep 20 09:44:08.626 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 94 Sep 20 09:44:08.628 start_sum_brtr: becoming an ABR 95 Sep 20 09:44:08.628 ospf_service_area_nssa_default: nssa_default, ar_id 0.0.0.0 forw_addr 0.0.0.0 metric 16777215 96 Sep 20 09:44:08.628 ospf_service_area_nssa_default: nssa_default, ar_id 0.0.0.1 forw_addr 0.0.0.0 metric 1 97 Sep 20 09:44:08.628 ospf_service_area_nssa_default: nssa_default, ar_id 0.0.0.2 forw_addr 0.0.0.0 metric 1 98 Sep 20 09:44:08.632 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 99 Sep 20 09:44:08.698 ospf_activate_area_ptr: inactive area, area 0.0.0.0 (0x63e6586f1f90) op_area_count 3 100 Sep 20 09:44:09.501 ospf_service_redist_summary: Start redist-scanning 101 Sep 20 09:44:48.617 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 102 Sep 20 09:44:48.621 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.1 103 Sep 20 09:44:48.626 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 104 Sep 20 09:44:48.643 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 105 Sep 20 09:44:49.644 ospf_service_redist_summary: Start redist-scanning 106 Sep 20 09:44:52.349 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 107 Sep 20 09:45:00.756 ospf_service_redist_summary: Start redist-scanning 108 Sep 20 09:45:04.229 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 109 Sep 20 09:45:10.756 ospf_service_redist_summary: Start redist-scanning 110 Sep 20 09:45:10.851 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.1 111 Sep 20 09:45:12.222 ospf_service_maxage: delete MAXAGE lsa, queue size 3 112 Sep 20 09:45:12.222 ospf_service_maxage: processed 3 LSAs from MAXAGE queue, requeued 3, current size 3 113 Sep 20 09:45:13.222 ospf_service_maxage: delete MAXAGE lsa, queue size 1 114 Sep 20 09:45:13.222 ospf_service_maxage: processed 1 LSAs from MAXAGE queue, requeued 0, current size 0 115 Sep 20 09:45:18.358 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.1 116 Sep 20 09:45:20.756 ospf_service_redist_summary: Start redist-scanning 117 Sep 20 09:45:22.650 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 118 Sep 20 09:45:24.058 ospf_service_maxage: delete MAXAGE lsa, queue size 2 119 Sep 20 09:45:24.058 ospf_service_maxage: processed 2 LSAs from MAXAGE queue, requeued 2, current size 2 120 Sep 20 09:45:25.058 ospf_service_maxage: delete MAXAGE lsa, queue size 1 121 Sep 20 09:45:25.058 ospf_service_maxage: processed 1 LSAs from MAXAGE queue, requeued 0, current size 0 122 Sep 20 09:45:30.757 ospf_service_redist_summary: Start redist-scanning 123 Sep 20 09:45:31.114 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 124 Sep 20 09:46:08.325 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 125 Sep 20 09:46:08.325 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 126 Sep 20 09:46:08.325 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 127 Sep 20 09:46:08.325 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 128 Sep 20 09:49:53.324 ospf_apply_area: instance ptr 0x63e6585a6ac0 129 Sep 20 09:49:53.333 ospf_service_area_nssa_default: nssa_default, ar_id 0.0.0.2 forw_addr 0.0.0.0 metric 16777215 130 Sep 20 09:49:54.333 ospf_service_maxage: delete MAXAGE lsa, queue size 11 131 Sep 20 09:49:54.333 ospf_service_maxage: processed 11 LSAs from MAXAGE queue, requeued 11, current size 11 132 Sep 20 09:49:54.333 ospf_service_redist_summary: Start redist-scanning 133 Sep 20 09:49:55.333 ospf_service_maxage: delete MAXAGE lsa, queue size 11 134 Sep 20 09:49:55.333 ospf_service_maxage: processed 11 LSAs from MAXAGE queue, requeued 11, current size 11 135 Sep 20 09:50:02.329 ospf_service_maxage: delete MAXAGE lsa, queue size 11 136 Sep 20 09:50:02.329 ospf_service_maxage: processed 11 LSAs from MAXAGE queue, requeued 11, current size 11 137 Sep 20 09:50:03.329 ospf_service_maxage: delete MAXAGE lsa, queue size 11 138 Sep 20 09:50:03.329 ospf_service_maxage: processed 11 LSAs from MAXAGE queue, requeued 0, current size 0 139 Sep 20 09:50:04.333 ospf_service_redist_summary: Start redist-scanning