RP/0/RP0/CPU0:R2#show ospf trace events Tue Sep 22 00:46:42.600 UTC Traces for OSPF 1 (Tue Sep 22 00:46:43) Traces returned/requested/available: 151/4096/151 Trace buffer: events 1 Sep 21 22:28:36.906 ospf_nsr_event_manager_create: Created channel, ISSU-role 0, HA-role 0 2 Sep 21 22:28:38.108 ospf_if_issu_map_complete_cb: IM issu if mapping complete cb: mapping_complete 0x1 3 Sep 21 22:28:38.108 ospf_get_instance_by_name: : Name unknown in inst AVL name tree 4 Sep 21 22:28:38.108 ospf_create_instance: : instance alloc ptr 0x598e29e47730 5 Sep 21 22:28:38.108 ospf_create_instance: : AVL instance insert ptr 0x598e29e47730 6 Sep 21 22:28:38.108 ospf_create_instance: lock instance 0x0 ptr 0x598e29e47730 refcount 1 7 Sep 21 22:28:38.315 ospf_ds_init: op_issu_id 0 8 Sep 21 22:28:39.710 ospf_create_area: : area 0.0.0.0 (0x598e29ee1e20) dummy 1 9 Sep 21 22:28:39.909 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 10 Sep 21 22:28:39.909 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 11 Sep 21 22:28:39.909 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 12 Sep 21 22:28:39.909 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 13 Sep 21 22:28:39.909 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 14 Sep 21 22:28:39.909 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 15 Sep 21 22:28:39.909 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 16 Sep 21 22:28:39.909 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 17 Sep 21 22:28:39.909 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 18 Sep 21 22:28:39.909 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 19 Sep 21 22:28:40.207 ospf_register_end_of_cfg: Attempt to register for end of config notification 20 Sep 21 22:28:40.218 ospf_cfgmgr_end_of_cfg_reg_cb: Received registration callback 21 Sep 21 22:28:40.218 ospf_cfgmgr_end_of_cfg_reg_cb: Registered for end of config 22 Sep 21 22:28:40.219 ospf_register_end_of_cfg: Registration accepted 23 Sep 21 22:28:40.407 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 24 Sep 21 22:28:40.407 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 25 Sep 21 22:28:40.411 ospf_ds_connect_cb: DS Connected 26 Sep 21 22:28:40.411 ospf_publish_ncd_ds_endp: Proc role not yet known 27 Sep 21 22:28:40.411 ospf_register_ncd_ds_service: Proc role not yet known 28 Sep 21 22:28:40.414 ospf_publish_ncd_ds_endp: Proc role not yet known 29 Sep 21 22:28:40.414 ospf_register_ncd_ds_service: Proc role not yet known 30 Sep 21 22:28:40.502 ospf_update_sckt_vrf_opt: vrf opts update OK for vrfid 0x60000000 31 Sep 21 22:28:40.503 ospf_rtrid_set_configured: new_rtr_id 2.2.2.2 32 Sep 21 22:28:40.503 ospf_rtrid_set_configured: rtrid config by value, op_conf_rtr_id 2.2.2.2 vrfid 60000000 33 Sep 21 22:28:40.504 ospf_publish_ncd_ds_endp: DS NCD service successfully published, ISSU role 1, HA role 1, 34 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 35 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 36 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 37 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 38 Sep 21 22:28:40.504 ospf_register_ncd_ds_service: Successfully registered for NCD DS notification 39 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 40 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 41 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 42 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 43 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 44 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 45 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 46 Sep 21 22:28:40.504 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 47 Sep 21 22:28:40.505 ospf_nsr_msg_chan_update: Update channel, ISSU-role 1, HA-role 1 48 Sep 21 22:28:40.604 ospf_rtrid_allocate: checking for old rtrid 0x60000000 49 Sep 21 22:28:40.604 ospf_rtrid_allocate: checking for rtrid config 50 Sep 21 22:28:40.604 ospf_rtrid_allocate: rtrid for vrf 0x60000000 set by numeric config: 2.2.2.2 51 Sep 21 22:28:40.702 ospf_bfd_connect: Attempt to connect to BFD server 52 Sep 21 22:28:40.705 ospf_ds_publish_service_cb: DS NCD service publised succesfully 53 Sep 21 22:28:40.708 ospf_ds_register_cb: DS NCD service registered succesfully, reg-handle 0x1 54 Sep 21 22:28:40.709 ospf_service_redist_delete: Deleting old redist routes, instance 0x60000000 55 Sep 21 22:28:40.710 ospf_ds_notify_service_cb: Number of EPs 1 56 Sep 21 22:28:40.710 ospf_ds_notify_service_cb: Setting new DS endp rev 1, number of EPs - 1 57 Sep 21 22:28:40.710 ospf_ncd_ds_endp_update: DS NCD endp, HA-role 1, ISSU-role 1 op_ospf_role 6 58 Sep 21 22:28:40.710 ospf_ncd_ds_endp_update: op_issu_id 0 issu_id 0 59 Sep 21 22:28:40.710 ospf_ncd_ds_endp_update: Ignore DS endp on V1A, ha-role 1, issu-role 1 60 Sep 21 22:28:40.710 ospf_ncd_ds_endp_clean_stale: Cleaning stale NCD endpoints 61 Sep 21 22:28:40.710 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 62 Sep 21 22:28:40.710 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 63 Sep 21 22:28:40.713 ospf_apply_area: instance ptr 0x598e29e47730 64 Sep 21 22:28:40.713 ospf_create_area: : area 0.0.0.0 (0x598e29f99170) dummy 0 65 Sep 21 22:28:40.721 ospf_bfd_bind_callback: Bind to BFD server - success 66 Sep 21 22:28:40.721 ospf_bfd_conn_callback: Connection to BFD established 67 Sep 21 22:28:40.721 ospf_bfd_send_create_batch: Batch size 0 68 Sep 21 22:28:40.721 ospf_bfd_end_of_replay: Sending EoR to BFD 69 Sep 21 22:28:40.803 ospf_activate_area_ptr: inactive area, area 0.0.0.0 (0x598e29f99170) op_area_count 1 70 Sep 21 22:28:40.803 ospf_activate_area: active area, area 0.0.0.0 71 Sep 21 22:28:40.803 ospf_activate_area: active area, area 0.0.0.0 72 Sep 21 22:28:41.710 ospf_service_redist_summary: Start redist-scanning 73 Sep 21 22:28:50.304 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 74 Sep 21 22:28:50.412 ospf_if_rtr_id_callback: Router-id sent by IPARM: 2.2.2.2 75 Sep 21 22:28:51.710 ospf_service_redist_summary: Start redist-scanning 76 Sep 21 22:28:52.201 ospf_cfgmgr_end_of_cfg_cb: Received end of config callback 77 Sep 21 22:28:52.201 ospf_cfgmgr_end_of_cfg_cb: Success 78 Sep 21 22:28:52.201 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 1 -> 1, rev 1 79 Sep 21 22:28:52.201 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 80 Sep 21 22:28:52.201 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 1 81 Sep 21 22:28:52.201 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 82 Sep 21 22:28:52.201 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 1 -> 1, rev 1 83 Sep 21 22:28:52.201 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 84 Sep 21 22:28:52.201 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 1 85 Sep 21 22:28:52.201 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 86 Sep 21 22:28:55.507 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 87 Sep 21 22:29:01.710 ospf_service_redist_summary: Start redist-scanning 88 Sep 21 22:29:01.964 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 89 Sep 21 22:29:05.456 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 90 Sep 21 22:30:40.505 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 91 Sep 21 22:30:40.505 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 92 Sep 21 22:30:40.505 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 93 Sep 21 22:30:40.505 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 94 Sep 21 22:38:01.227 ospf_clear_stats_instance: 95 Sep 21 22:38:01.227 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 96 Sep 21 22:38:01.227 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.12.1 97 Sep 21 22:38:01.227 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 98 Sep 21 22:38:01.227 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 3.3.3.3/10.0.23.3 99 Sep 21 22:38:01.227 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 100 Sep 21 22:59:48.004 ospf_clear_stats_instance: 101 Sep 21 22:59:48.004 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 102 Sep 21 22:59:48.004 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.12.1 103 Sep 21 22:59:48.004 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 104 Sep 21 22:59:48.004 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 3.3.3.3/10.0.23.3 105 Sep 21 22:59:48.004 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 106 Sep 21 23:33:48.347 ospf_clear_stats_instance: 107 Sep 21 23:33:48.347 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 108 Sep 21 23:33:48.347 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.12.1 109 Sep 21 23:33:48.347 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 110 Sep 21 23:33:48.347 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 3.3.3.3/10.0.23.3 111 Sep 21 23:33:48.347 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 112 Sep 22 00:09:45.390 ospf_clear_stats_instance: 113 Sep 22 00:09:45.390 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 114 Sep 22 00:09:45.390 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.12.1 115 Sep 22 00:09:45.390 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 116 Sep 22 00:09:45.390 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 3.3.3.3/10.0.23.3 117 Sep 22 00:09:45.390 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 118 Sep 22 00:14:20.900 ospf_service_maxage: delete MAXAGE lsa, queue size 60 119 Sep 22 00:14:20.900 ospf_service_maxage: processed 60 LSAs from MAXAGE queue, requeued 60, current size 60 120 Sep 22 00:16:34.646 ospf_clear_stats_instance: 121 Sep 22 00:16:34.646 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 122 Sep 22 00:16:34.646 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.12.1 123 Sep 22 00:16:34.646 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 124 Sep 22 00:16:34.646 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 3.3.3.3/10.0.23.3 125 Sep 22 00:16:34.646 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 126 Sep 22 00:23:40.629 ospf_clear_stats_instance: 127 Sep 22 00:23:40.629 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 128 Sep 22 00:23:40.629 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.12.1 129 Sep 22 00:23:40.629 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 130 Sep 22 00:23:40.629 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 3.3.3.3/10.0.23.3 131 Sep 22 00:23:40.629 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 132 Sep 22 00:28:17.791 ospf_service_maxage: delete MAXAGE lsa, queue size 60 133 Sep 22 00:28:17.791 ospf_service_maxage: processed 60 LSAs from MAXAGE queue, requeued 60, current size 60 134 Sep 22 00:30:30.623 ospf_clear_stats_instance: 135 Sep 22 00:30:30.623 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 136 Sep 22 00:30:30.623 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.12.1 137 Sep 22 00:30:30.623 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 138 Sep 22 00:30:30.623 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 3.3.3.3/10.0.23.3 139 Sep 22 00:30:30.623 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 140 Sep 22 00:37:30.086 ospf_clear_stats_instance: 141 Sep 22 00:37:30.086 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 142 Sep 22 00:37:30.086 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.12.1 143 Sep 22 00:37:30.086 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 144 Sep 22 00:37:30.086 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 3.3.3.3/10.0.23.3 145 Sep 22 00:37:30.086 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 146 Sep 22 00:44:25.111 ospf_clear_stats_instance: 147 Sep 22 00:44:25.111 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 148 Sep 22 00:44:25.111 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.12.1 149 Sep 22 00:44:25.111 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 150 Sep 22 00:44:25.111 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 3.3.3.3/10.0.23.3 151 Sep 22 00:44:25.111 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 RP/0/RP0/CPU0:R2#show ospf trace errors Tue Sep 22 00:46:43.619 UTC Traces for OSPF 1 (Tue Sep 22 00:46:44) Traces returned/requested/available: 3/8192/3 Trace buffer: errors 1 Sep 21 22:28:40.413 ospf_nsr_ev_free: Cannot free event 0x10a89fc0: flags 0x0,work 0x598e29f55450, handler 0x598e0f23302e 2 Sep 21 22:28:40.413 ospf_nsr_ev_free: inst 0x0, nsr_info 0x0, next 0x0 3 Sep 21 22:28:40.512 ospf_is_config_startup_done: Reading config startup done tuple failed [errno 0x40818600: 'sysdb' detected the 'warning' condition 'A SysDB client tried to access a nonexistent item or list an empty directory'] RP/0/RP0/CPU0:R2#show ospf trace all | include refresh Tue Sep 22 00:46:44.808 UTC RP/0/RP0/CPU0:R2#show ospf trace all | include pacing Tue Sep 22 00:47:03.413 UTC RP/0/RP0/CPU0:R2#show ospf trace all | include flood Tue Sep 22 00:47:21.349 UTC