RP/0/RP0/CPU0:XR3#show ospf trace events Sun Sep 20 09:52:44.024 UTC Traces for OSPF 1 (Sun Sep 20 09:52:44) Traces returned/requested/available: 136/4096/136 Trace buffer: events 1 Sep 20 09:44:18.033 ospf_nsr_event_manager_create: Created channel, ISSU-role 0, HA-role 0 2 Sep 20 09:44:18.527 ospf_if_issu_map_complete_cb: IM issu if mapping complete cb: mapping_complete 0x1 3 Sep 20 09:44:18.527 ospf_get_instance_by_name: : Name unknown in inst AVL name tree 4 Sep 20 09:44:18.527 ospf_create_instance: : instance alloc ptr 0x57043be23070 5 Sep 20 09:44:18.527 ospf_create_instance: : AVL instance insert ptr 0x57043be23070 6 Sep 20 09:44:18.527 ospf_create_instance: lock instance 0x0 ptr 0x57043be23070 refcount 1 7 Sep 20 09:44:18.628 ospf_ds_init: op_issu_id 0 8 Sep 20 09:44:19.116 ospf_create_area: : area 0.0.0.0 (0x57043bebd770) dummy 1 9 Sep 20 09:44:19.139 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 10 Sep 20 09:44:19.139 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 11 Sep 20 09:44:19.139 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 12 Sep 20 09:44:19.139 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 13 Sep 20 09:44:19.139 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 14 Sep 20 09:44:19.139 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 15 Sep 20 09:44:19.139 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 16 Sep 20 09:44:19.139 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 17 Sep 20 09:44:19.139 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 18 Sep 20 09:44:19.139 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 19 Sep 20 09:44:19.339 ospf_register_end_of_cfg: Attempt to register for end of config notification 20 Sep 20 09:44:19.350 ospf_cfgmgr_end_of_cfg_reg_cb: Received registration callback 21 Sep 20 09:44:19.350 ospf_cfgmgr_end_of_cfg_reg_cb: Registered for end of config 22 Sep 20 09:44:19.350 ospf_cfgmgr_end_of_cfg_cb: Received end of config callback 23 Sep 20 09:44:19.350 ospf_cfgmgr_end_of_cfg_cb: Success 24 Sep 20 09:44:19.350 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 0 -> 0, rev 0 25 Sep 20 09:44:19.350 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 26 Sep 20 09:44:19.350 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 1 -> 1, rev 0 27 Sep 20 09:44:19.350 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 28 Sep 20 09:44:19.350 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 29 Sep 20 09:44:19.350 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 30 Sep 20 09:44:19.413 ospf_register_end_of_cfg: Registration accepted 31 Sep 20 09:44:19.435 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 32 Sep 20 09:44:19.435 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 33 Sep 20 09:44:19.437 ospf_if_rtr_id_callback: Router-id sent by IPARM: 3.3.3.3 34 Sep 20 09:44:19.438 ospf_ds_connect_cb: DS Connected 35 Sep 20 09:44:19.438 ospf_publish_ncd_ds_endp: Proc role not yet known 36 Sep 20 09:44:19.438 ospf_register_ncd_ds_service: Proc role not yet known 37 Sep 20 09:44:19.440 ospf_publish_ncd_ds_endp: Proc role not yet known 38 Sep 20 09:44:19.440 ospf_register_ncd_ds_service: Proc role not yet known 39 Sep 20 09:44:19.444 ospf_update_sckt_vrf_opt: vrf opts update OK for vrfid 0x60000000 40 Sep 20 09:44:19.445 ospf_rtrid_set_configured: new_rtr_id 3.3.3.3 41 Sep 20 09:44:19.445 ospf_rtrid_set_configured: rtrid config by value, op_conf_rtr_id 3.3.3.3 vrfid 60000000 42 Sep 20 09:44:19.445 ospf_publish_ncd_ds_endp: DS NCD service successfully published, ISSU role 1, HA role 1, 43 Sep 20 09:44:19.445 ospf_register_ncd_ds_service: Successfully registered for NCD DS notification 44 Sep 20 09:44:19.445 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 45 Sep 20 09:44:19.445 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 46 Sep 20 09:44:19.445 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 47 Sep 20 09:44:19.445 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 48 Sep 20 09:44:19.445 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 49 Sep 20 09:44:19.445 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 50 Sep 20 09:44:19.445 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 51 Sep 20 09:44:19.445 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 52 Sep 20 09:44:19.445 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 53 Sep 20 09:44:19.445 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 54 Sep 20 09:44:19.446 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 55 Sep 20 09:44:19.446 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 56 Sep 20 09:44:19.447 ospf_nsr_msg_chan_update: Update channel, ISSU-role 1, HA-role 1 57 Sep 20 09:44:19.520 ospf_rtrid_allocate: checking for old rtrid 0x60000000 58 Sep 20 09:44:19.520 ospf_rtrid_allocate: checking for rtrid config 59 Sep 20 09:44:19.520 ospf_rtrid_allocate: rtrid for vrf 0x60000000 set by numeric config: 3.3.3.3 60 Sep 20 09:44:19.537 ospf_bfd_connect: Attempt to connect to BFD server 61 Sep 20 09:44:19.540 ospf_ds_publish_service_cb: DS NCD service publised succesfully 62 Sep 20 09:44:19.610 ospf_service_redist_delete: Deleting old redist routes, instance 0x60000000 63 Sep 20 09:44:19.610 ospf_ds_register_cb: DS NCD service registered succesfully, reg-handle 0x1 64 Sep 20 09:44:19.611 ospf_apply_area: instance ptr 0x57043be23070 65 Sep 20 09:44:19.611 ospf_create_area: : area 0.0.0.0 (0x57043bf6c330) dummy 0 66 Sep 20 09:44:19.611 ospf_apply_area: instance ptr 0x57043be23070 67 Sep 20 09:44:19.611 ospf_create_area: : area 0.0.0.1 (0x57043bf6e960) dummy 0 68 Sep 20 09:44:19.611 ospf_apply_area: instance ptr 0x57043be23070 69 Sep 20 09:44:19.611 ospf_create_area: : area 0.0.0.2 (0x57043bf71080) dummy 0 70 Sep 20 09:44:19.612 ospf_ds_notify_service_cb: Number of EPs 1 71 Sep 20 09:44:19.612 ospf_ds_notify_service_cb: Setting new DS endp rev 1, number of EPs - 1 72 Sep 20 09:44:19.612 ospf_ncd_ds_endp_update: DS NCD endp, HA-role 1, ISSU-role 1 op_ospf_role 6 73 Sep 20 09:44:19.612 ospf_ncd_ds_endp_update: op_issu_id 0 issu_id 0 74 Sep 20 09:44:19.612 ospf_ncd_ds_endp_update: Ignore DS endp on V1A, ha-role 1, issu-role 1 75 Sep 20 09:44:19.612 ospf_ncd_ds_endp_clean_stale: Cleaning stale NCD endpoints 76 Sep 20 09:44:19.612 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 77 Sep 20 09:44:19.612 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 78 Sep 20 09:44:19.622 ospf_bfd_bind_callback: Bind to BFD server - success 79 Sep 20 09:44:19.622 ospf_bfd_conn_callback: Connection to BFD established 80 Sep 20 09:44:19.622 ospf_bfd_send_create_batch: Batch size 0 81 Sep 20 09:44:19.622 ospf_bfd_end_of_replay: Sending EoR to BFD 82 Sep 20 09:44:19.633 ospf_activate_area_ptr: inactive area, area 0.0.0.0 (0x57043bf6c330) op_area_count 1 83 Sep 20 09:44:19.633 ospf_activate_area: active area, area 0.0.0.0 84 Sep 20 09:44:19.633 ospf_activate_area_ptr: inactive area, area 0.0.0.1 (0x57043bf6e960) op_area_count 2 85 Sep 20 09:44:19.633 ospf_activate_area_ptr: inactive area, area 0.0.0.2 (0x57043bf71080) op_area_count 3 86 Sep 20 09:44:19.634 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 87 Sep 20 09:44:19.634 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.1 88 Sep 20 09:44:19.634 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 89 Sep 20 09:44:19.634 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:19.634 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:19.714 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 92 Sep 20 09:44:19.733 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.1 93 Sep 20 09:44:19.738 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 94 Sep 20 09:44:19.738 start_sum_brtr: becoming an ABR 95 Sep 20 09:44:19.738 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:19.738 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:19.738 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:19.740 ospf_activate_area_ptr: inactive area, area 0.0.0.0 (0x57043bf6c330) op_area_count 3 99 Sep 20 09:44:20.611 ospf_service_redist_summary: Start redist-scanning 100 Sep 20 09:44:59.727 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 101 Sep 20 09:44:59.733 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.1 102 Sep 20 09:44:59.738 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 103 Sep 20 09:44:59.753 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 104 Sep 20 09:45:00.753 ospf_service_redist_summary: Start redist-scanning 105 Sep 20 09:45:10.854 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.1 106 Sep 20 09:45:11.855 ospf_service_redist_summary: Start redist-scanning 107 Sep 20 09:45:12.234 ospf_service_maxage: delete MAXAGE lsa, queue size 3 108 Sep 20 09:45:12.234 ospf_service_maxage: processed 3 LSAs from MAXAGE queue, requeued 3, current size 3 109 Sep 20 09:45:13.064 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 110 Sep 20 09:45:13.234 ospf_service_maxage: delete MAXAGE lsa, queue size 2 111 Sep 20 09:45:13.234 ospf_service_maxage: processed 2 LSAs from MAXAGE queue, requeued 0, current size 0 112 Sep 20 09:45:18.686 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.1 113 Sep 20 09:45:21.856 ospf_service_redist_summary: Start redist-scanning 114 Sep 20 09:45:22.653 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 115 Sep 20 09:45:24.070 ospf_service_maxage: delete MAXAGE lsa, queue size 2 116 Sep 20 09:45:24.070 ospf_service_maxage: processed 2 LSAs from MAXAGE queue, requeued 2, current size 2 117 Sep 20 09:45:25.070 ospf_service_maxage: delete MAXAGE lsa, queue size 1 118 Sep 20 09:45:25.070 ospf_service_maxage: processed 1 LSAs from MAXAGE queue, requeued 0, current size 0 119 Sep 20 09:45:29.228 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.2 120 Sep 20 09:45:31.856 ospf_service_redist_summary: Start redist-scanning 121 Sep 20 09:46:19.446 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 122 Sep 20 09:46:19.446 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 123 Sep 20 09:46:19.446 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 124 Sep 20 09:46:19.446 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 125 Sep 20 09:49:54.346 ospf_service_maxage: delete MAXAGE lsa, queue size 11 126 Sep 20 09:49:54.346 ospf_service_maxage: processed 11 LSAs from MAXAGE queue, requeued 11, current size 11 127 Sep 20 09:49:54.346 ospf_service_redist_summary: Start redist-scanning 128 Sep 20 09:49:55.346 ospf_service_maxage: delete MAXAGE lsa, queue size 11 129 Sep 20 09:49:55.346 ospf_service_maxage: processed 11 LSAs from MAXAGE queue, requeued 0, current size 0 130 Sep 20 09:50:01.242 ospf_apply_area: instance ptr 0x57043be23070 131 Sep 20 09:50:01.315 ospf_service_area_nssa_default: nssa_default, ar_id 0.0.0.2 forw_addr 0.0.0.0 metric 16777215 132 Sep 20 09:50:02.315 ospf_service_maxage: delete MAXAGE lsa, queue size 11 133 Sep 20 09:50:02.315 ospf_service_maxage: processed 11 LSAs from MAXAGE queue, requeued 11, current size 11 134 Sep 20 09:50:03.316 ospf_service_maxage: delete MAXAGE lsa, queue size 11 135 Sep 20 09:50:03.316 ospf_service_maxage: processed 11 LSAs from MAXAGE queue, requeued 11, current size 11 136 Sep 20 09:50:04.346 ospf_service_redist_summary: Start redist-scanning