RP/0/RP0/CPU0:R4#show ospf trace events Mon Sep 28 03:15:07.246 UTC Traces for OSPF 1 (Mon Sep 28 03:15:07) Traces returned/requested/available: 135/4096/135 Trace buffer: events 1 Sep 28 02:37:49.539 ospf_nsr_event_manager_create: Created channel, ISSU-role 0, HA-role 0 2 Sep 28 02:37:50.640 ospf_if_issu_map_complete_cb: IM issu if mapping complete cb: mapping_complete 0x1 3 Sep 28 02:37:50.640 ospf_get_instance_by_name: : Name unknown in inst AVL name tree 4 Sep 28 02:37:50.640 ospf_create_instance: : instance alloc ptr 0x621688133ca0 5 Sep 28 02:37:50.640 ospf_create_instance: : AVL instance insert ptr 0x621688133ca0 6 Sep 28 02:37:50.641 ospf_create_instance: lock instance 0x0 ptr 0x621688133ca0 refcount 1 7 Sep 28 02:37:50.849 ospf_ds_init: op_issu_id 0 8 Sep 28 02:37:52.339 ospf_create_area: : area 0.0.0.0 (0x6216881ce3a0) dummy 1 9 Sep 28 02:37:52.452 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 10 Sep 28 02:37:52.452 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 11 Sep 28 02:37:52.452 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 12 Sep 28 02:37:52.452 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 13 Sep 28 02:37:52.452 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 14 Sep 28 02:37:52.452 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 15 Sep 28 02:37:52.452 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 16 Sep 28 02:37:52.452 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 17 Sep 28 02:37:52.452 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 18 Sep 28 02:37:52.452 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 19 Sep 28 02:37:52.740 ospf_register_end_of_cfg: Attempt to register for end of config notification 20 Sep 28 02:37:52.750 ospf_cfgmgr_end_of_cfg_reg_cb: Received registration callback 21 Sep 28 02:37:52.750 ospf_cfgmgr_end_of_cfg_reg_cb: Registered for end of config 22 Sep 28 02:37:52.751 ospf_register_end_of_cfg: Registration accepted 23 Sep 28 02:37:52.937 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 24 Sep 28 02:37:52.937 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 25 Sep 28 02:37:52.940 ospf_ds_connect_cb: DS Connected 26 Sep 28 02:37:52.940 ospf_publish_ncd_ds_endp: Proc role not yet known 27 Sep 28 02:37:52.940 ospf_register_ncd_ds_service: Proc role not yet known 28 Sep 28 02:37:52.944 ospf_publish_ncd_ds_endp: Proc role not yet known 29 Sep 28 02:37:52.944 ospf_register_ncd_ds_service: Proc role not yet known 30 Sep 28 02:37:52.948 ospf_update_sckt_vrf_opt: vrf opts update OK for vrfid 0x60000000 31 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 32 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 33 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 34 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 35 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 36 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 37 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 38 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 39 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 40 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 41 Sep 28 02:37:52.948 ospf_publish_ncd_ds_endp: DS NCD service successfully published, ISSU role 1, HA role 1, 42 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 43 Sep 28 02:37:52.948 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 44 Sep 28 02:37:52.948 ospf_register_ncd_ds_service: Successfully registered for NCD DS notification 45 Sep 28 02:37:52.949 ospf_nsr_msg_chan_update: Update channel, ISSU-role 1, HA-role 1 46 Sep 28 02:37:53.136 ospf_bfd_connect: Attempt to connect to BFD server 47 Sep 28 02:37:53.139 ospf_ds_publish_service_cb: DS NCD service publised succesfully 48 Sep 28 02:37:53.140 ospf_rtrid_set_configured: new_rtr_id 4.4.4.4 49 Sep 28 02:37:53.140 ospf_rtrid_set_configured: rtrid config by value, op_conf_rtr_id 4.4.4.4 vrfid 60000000 50 Sep 28 02:37:53.143 ospf_service_redist_delete: Deleting old redist routes, instance 0x60000000 51 Sep 28 02:37:53.143 ospf_ds_register_cb: DS NCD service registered succesfully, reg-handle 0x1 52 Sep 28 02:37:53.143 ospf_soft_reset: start 53 Sep 28 02:37:53.143 ospf_flush_type5: flush external links 54 Sep 28 02:37:53.143 ospf_flush_type11: flush opaque AS links 55 Sep 28 02:37:53.147 ospf_soft_reset_up: inst 0x621688133ca0 vrfid 0x60000000 delete rid tuple, alloc new rid 56 Sep 28 02:37:53.147 ospf_rtrid_allocate: checking for old rtrid 0x60000000 57 Sep 28 02:37:53.147 ospf_rtrid_allocate: checking for rtrid config 58 Sep 28 02:37:53.147 ospf_rtrid_allocate: rtrid for vrf 0x60000000 set by numeric config: 4.4.4.4 59 Sep 28 02:37:53.151 ospf_soft_reset_up: rtrid: new 4.4.4.4 old 0.0.0.0 60 Sep 28 02:37:53.151 ospf_soft_reset_up: rtrid changed, check vlink for reconfig 61 Sep 28 02:37:53.152 ospf_ds_notify_service_cb: Number of EPs 1 62 Sep 28 02:37:53.152 ospf_ds_notify_service_cb: Setting new DS endp rev 1, number of EPs - 1 63 Sep 28 02:37:53.152 ospf_ncd_ds_endp_update: DS NCD endp, HA-role 1, ISSU-role 1 op_ospf_role 6 64 Sep 28 02:37:53.152 ospf_ncd_ds_endp_update: op_issu_id 0 issu_id 0 65 Sep 28 02:37:53.152 ospf_ncd_ds_endp_update: Ignore DS endp on V1A, ha-role 1, issu-role 1 66 Sep 28 02:37:53.152 ospf_ncd_ds_endp_clean_stale: Cleaning stale NCD endpoints 67 Sep 28 02:37:53.152 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 68 Sep 28 02:37:53.152 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 69 Sep 28 02:37:53.156 ospf_apply_area: instance ptr 0x621688133ca0 70 Sep 28 02:37:53.156 ospf_create_area: : area 0.0.0.0 (0x6216882857b0) dummy 0 71 Sep 28 02:37:53.243 ospf_activate_area_ptr: inactive area, area 0.0.0.0 (0x6216882857b0) op_area_count 1 72 Sep 28 02:37:53.243 ospf_activate_area: active area, area 0.0.0.0 73 Sep 28 02:37:53.243 ospf_activate_area: active area, area 0.0.0.0 74 Sep 28 02:37:53.249 ospf_bfd_bind_callback: Bind to BFD server - success 75 Sep 28 02:37:53.249 ospf_bfd_conn_callback: Connection to BFD established 76 Sep 28 02:37:53.249 ospf_bfd_send_create_batch: Batch size 0 77 Sep 28 02:37:53.249 ospf_bfd_end_of_replay: Sending EoR to BFD 78 Sep 28 02:37:54.143 ospf_service_redist_summary: Start redist-scanning 79 Sep 28 02:38:01.541 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 80 Sep 28 02:38:01.638 ospf_if_rtr_id_callback: Router-id sent by IPARM: 4.4.4.4 81 Sep 28 02:38:03.148 ospf_cfgmgr_end_of_cfg_cb: Received end of config callback 82 Sep 28 02:38:03.148 ospf_cfgmgr_end_of_cfg_cb: Success 83 Sep 28 02:38:03.148 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 1 -> 1, rev 1 84 Sep 28 02:38:03.148 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 85 Sep 28 02:38:03.148 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 1 86 Sep 28 02:38:03.148 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 87 Sep 28 02:38:03.148 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 1 -> 1, rev 1 88 Sep 28 02:38:03.148 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 89 Sep 28 02:38:03.148 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 1 90 Sep 28 02:38:03.148 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 91 Sep 28 02:38:04.144 ospf_service_redist_summary: Start redist-scanning 92 Sep 28 02:38:07.540 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 93 Sep 28 02:38:08.762 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 94 Sep 28 02:38:14.144 ospf_service_redist_summary: Start redist-scanning 95 Sep 28 02:38:14.341 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 96 Sep 28 02:39:52.949 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 97 Sep 28 02:39:52.949 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 98 Sep 28 02:39:52.949 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 99 Sep 28 02:39:52.949 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 100 Sep 28 02:43:37.379 ospf_clear_stats_instance: 101 Sep 28 02:43:37.379 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 102 Sep 28 02:43:37.379 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.14.1 103 Sep 28 02:43:37.379 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 104 Sep 28 02:43:37.379 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 2.2.2.2/10.0.24.2 105 Sep 28 02:43:37.379 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 106 Sep 28 02:50:04.466 ospf_clear_stats_instance: 107 Sep 28 02:50:04.466 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 108 Sep 28 02:50:04.466 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.14.1 109 Sep 28 02:50:04.466 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 110 Sep 28 02:50:04.466 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 2.2.2.2/10.0.24.2 111 Sep 28 02:50:04.466 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 112 Sep 28 02:56:40.956 ospf_clear_stats_instance: 113 Sep 28 02:56:40.956 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 114 Sep 28 02:56:40.956 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.14.1 115 Sep 28 02:56:40.956 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 116 Sep 28 02:56:40.956 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 2.2.2.2/10.0.24.2 117 Sep 28 02:56:40.956 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 118 Sep 28 03:01:56.751 ospf_clear_stats_instance: 119 Sep 28 03:01:56.751 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 120 Sep 28 03:01:56.751 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.14.1 121 Sep 28 03:01:56.751 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 122 Sep 28 03:01:56.751 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 2.2.2.2/10.0.24.2 123 Sep 28 03:01:56.751 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 124 Sep 28 03:07:13.031 ospf_clear_stats_instance: 125 Sep 28 03:07:13.031 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 126 Sep 28 03:07:13.031 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.14.1 127 Sep 28 03:07:13.031 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 128 Sep 28 03:07:13.031 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 2.2.2.2/10.0.24.2 129 Sep 28 03:07:13.031 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 130 Sep 28 03:12:23.888 ospf_clear_stats_instance: 131 Sep 28 03:12:23.888 ospf_clear_interface_stats: clear counters intf Lo0 clear_madj 0 132 Sep 28 03:12:23.888 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 1.1.1.1/10.0.14.1 133 Sep 28 03:12:23.888 ospf_clear_interface_stats: clear counters intf Gi0/0/0/0 clear_madj 0 134 Sep 28 03:12:23.888 ospf_clear_neighbor_events: reset nbr_event_count [2], nbr 2.2.2.2/10.0.24.2 135 Sep 28 03:12:23.888 ospf_clear_interface_stats: clear counters intf Gi0/0/0/1 clear_madj 0 RP/0/RP0/CPU0:R4#show ospf trace errors Mon Sep 28 03:15:08.115 UTC Traces for OSPF 1 (Mon Sep 28 03:15:08) Traces returned/requested/available: 3/8192/3 Trace buffer: errors 1 Sep 28 02:37:52.943 ospf_nsr_ev_free: Cannot free event 0x83ef6fc0: flags 0x0,work 0x6216882419d0, handler 0x62167912302e 2 Sep 28 02:37:52.943 ospf_nsr_ev_free: inst 0x0, nsr_info 0x0, next 0x0 3 Sep 28 02:37:53.040 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']