RP/0/RP0/CPU0:R3#show ospf trace spf_ext Tue Sep 15 06:25:23.853 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:R3#show ospf trace adj_cycle Tue Sep 15 06:25:24.652 UTC Traces for OSPF 1 (Tue Sep 15 06:25:25) Traces returned/requested/available: 91/8192/91 Trace buffer: adj_cycle 1 Sep 15 05:41:18.723 ospf_send_dbd: to 1.1.1.1(10.0.13.1) intf Gi0/0/0/0 seq 0x6aebe187 2 Sep 15 05:41:18.735 ospf_rcv_dbd: from 1.1.1.1(10.0.13.1) intf Gi0/0/0/0 seq 0x336a311f 3 Sep 15 05:41:18.735 ospf_rcv_dbd: from 1.1.1.1(10.0.13.1) intf Gi0/0/0/0 seq 0x6aebe187 4 Sep 15 05:41:18.735 ospf_send_dbd: to 1.1.1.1(10.0.13.1) intf Gi0/0/0/0 seq 0x6aebe188 5 Sep 15 05:41:18.742 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 3 paksize 126 6 Sep 15 05:41:18.742 ospf_output: LSA pkt, src 10.0.13.3 dest 10.0.13.1 area 0.0.0.0 intf Gi0/0/0/0 7 Sep 15 05:41:18.742 ospf_rcv_dbd: from 1.1.1.1(10.0.13.1) intf Gi0/0/0/0 seq 0x6aebe188 8 Sep 15 05:41:18.742 ospf_output: LSA pkt, src 10.0.13.3 dest 10.0.13.1 area 0.0.0.0 intf Gi0/0/0/0 9 Sep 15 05:41:18.742 ospf_send_req: LS REQ pkt, nbr 1.1.1.1/10.0.13.1 cnt 1 unsent 0 10 Sep 15 05:41:18.748 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 4 paksize 166 11 Sep 15 05:41:18.803 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 12 Sep 15 05:41:18.822 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 4 paksize 178 13 Sep 15 05:41:20.749 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 14 Sep 15 05:41:20.752 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 5 paksize 134 15 Sep 15 05:41:22.117 ospf_rcv_dbd: from 4.4.4.4(10.0.34.4) intf Gi0/0/0/1 seq 0x7858e756 16 Sep 15 05:41:22.117 ospf_send_dbd: to 4.4.4.4(10.0.34.4) intf Gi0/0/0/1 seq 0x2ad5cbdf 17 Sep 15 05:41:22.118 ospf_send_dbd: to 4.4.4.4(10.0.34.4) intf Gi0/0/0/1 seq 0x7858e756 18 Sep 15 05:41:22.124 ospf_rcv_dbd: from 4.4.4.4(10.0.34.4) intf Gi0/0/0/1 seq 0x7858e757 19 Sep 15 05:41:22.124 ospf_output: LSA pkt, src 10.0.34.3 dest 10.0.34.4 area 0.0.0.0 intf Gi0/0/0/1 20 Sep 15 05:41:22.124 ospf_send_req: LS REQ pkt, nbr 4.4.4.4/10.0.34.4 cnt 1 unsent 0 21 Sep 15 05:41:22.124 ospf_send_dbd: to 4.4.4.4(10.0.34.4) intf Gi0/0/0/1 seq 0x7858e757 22 Sep 15 05:41:22.131 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 178 23 Sep 15 05:41:22.131 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 3 paksize 138 24 Sep 15 05:41:22.131 ospf_output: LSA pkt, src 10.0.34.3 dest 10.0.34.4 area 0.0.0.0 intf Gi0/0/0/1 25 Sep 15 05:41:22.133 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 26 Sep 15 05:41:22.184 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 27 Sep 15 05:41:22.184 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 28 Sep 15 05:41:22.190 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 190 29 Sep 15 05:41:22.217 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 30 Sep 15 05:41:24.131 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 31 Sep 15 05:41:24.138 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 5 paksize 154 32 Sep 15 05:41:24.140 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 5 paksize 154 33 Sep 15 05:41:26.743 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 166 34 Sep 15 05:41:26.746 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 35 Sep 15 05:41:26.795 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 202 36 Sep 15 05:41:26.797 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 37 Sep 15 05:41:26.828 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 178 38 Sep 15 05:41:28.744 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 39 Sep 15 05:41:28.753 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 5 paksize 154 40 Sep 15 05:41:31.792 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 178 41 Sep 15 05:41:31.794 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 42 Sep 15 05:41:33.792 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 43 Sep 15 05:41:33.802 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 5 paksize 134 44 Sep 15 05:52:03.628 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 4 paksize 154 45 Sep 15 05:52:03.630 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 46 Sep 15 05:52:03.723 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 4 paksize 178 47 Sep 15 05:52:03.726 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 48 Sep 15 05:52:05.628 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 49 Sep 15 05:52:05.638 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 5 paksize 154 50 Sep 15 05:56:39.524 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 4 paksize 154 51 Sep 15 05:56:39.527 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 52 Sep 15 05:56:41.525 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 53 Sep 15 05:56:41.542 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 5 paksize 134 54 Sep 15 06:02:59.059 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 4 paksize 154 55 Sep 15 06:02:59.070 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 56 Sep 15 06:03:01.060 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 57 Sep 15 06:03:01.082 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 5 paksize 134 58 Sep 15 06:13:49.314 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 154 59 Sep 15 06:13:49.316 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 60 Sep 15 06:13:49.362 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 178 61 Sep 15 06:13:49.365 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 62 Sep 15 06:13:51.314 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 63 Sep 15 06:13:51.323 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 5 paksize 154 64 Sep 15 06:14:10.559 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 178 65 Sep 15 06:14:10.561 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 66 Sep 15 06:14:12.559 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 67 Sep 15 06:14:12.568 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 5 paksize 134 68 Sep 15 06:14:40.836 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 69 Sep 15 06:14:40.836 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 70 Sep 15 06:14:42.845 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 5 paksize 134 71 Sep 15 06:14:42.845 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 5 paksize 134 72 Sep 15 06:15:01.202 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 202 73 Sep 15 06:15:01.205 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 74 Sep 15 06:15:03.203 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 75 Sep 15 06:15:03.224 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 5 paksize 134 76 Sep 15 06:18:25.835 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 4 paksize 154 77 Sep 15 06:18:25.837 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 78 Sep 15 06:18:27.836 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 79 Sep 15 06:18:27.845 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 5 paksize 134 80 Sep 15 06:22:56.057 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 4 paksize 178 81 Sep 15 06:22:56.059 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 82 Sep 15 06:22:58.057 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 83 Sep 15 06:22:58.067 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 5 paksize 134 84 Sep 15 06:23:02.430 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 4 paksize 154 85 Sep 15 06:23:02.433 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 86 Sep 15 06:23:04.431 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 87 Sep 15 06:23:04.441 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 5 paksize 134 88 Sep 15 06:23:09.422 ospf_do_hello_packets: LSA pkt, src 10.0.34.4 intf Gi0/0/0/1 type 4 paksize 154 89 Sep 15 06:23:09.424 ospf_output: LSA pkt, src 10.0.13.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 90 Sep 15 06:23:11.422 ospf_output: LSA pkt, src 10.0.34.3 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/1 91 Sep 15 06:23:11.432 ospf_do_hello_packets: LSA pkt, src 10.0.13.1 intf Gi0/0/0/0 type 5 paksize 134 RP/0/RP0/CPU0:R3#show ospf trace events Tue Sep 15 06:25:25.517 UTC Traces for OSPF 1 (Tue Sep 15 06:25:26) Traces returned/requested/available: 97/4096/97 Trace buffer: events 1 Sep 15 05:40:54.820 ospf_nsr_event_manager_create: Created channel, ISSU-role 0, HA-role 0 2 Sep 15 05:40:56.129 ospf_if_issu_map_complete_cb: IM issu if mapping complete cb: mapping_complete 0x1 3 Sep 15 05:40:56.130 ospf_get_instance_by_name: : Name unknown in inst AVL name tree 4 Sep 15 05:40:56.130 ospf_create_instance: : instance alloc ptr 0x57ca2be0a660 5 Sep 15 05:40:56.130 ospf_create_instance: : AVL instance insert ptr 0x57ca2be0a660 6 Sep 15 05:40:56.131 ospf_create_instance: lock instance 0x0 ptr 0x57ca2be0a660 refcount 1 7 Sep 15 05:40:56.426 ospf_ds_init: op_issu_id 0 8 Sep 15 05:40:57.824 ospf_create_area: : area 0.0.0.0 (0x57ca2bea4d50) dummy 1 9 Sep 15 05:40:58.025 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 10 Sep 15 05:40:58.025 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 11 Sep 15 05:40:58.025 ospf_nsr_fsm_dispatch_event: dispatching event 32, state 0 -> 0, rev 0 12 Sep 15 05:40:58.025 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 13 Sep 15 05:40:58.025 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 14 Sep 15 05:40:58.025 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 15 Sep 15 05:40:58.025 ospf_nsr_fsm_dispatch_event: dispatching event 14, state 0 -> 0, rev 0 16 Sep 15 05:40:58.025 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 17 Sep 15 05:40:58.025 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 18 Sep 15 05:40:58.025 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 19 Sep 15 05:40:58.236 ospf_register_end_of_cfg: Attempt to register for end of config notification 20 Sep 15 05:40:58.321 ospf_cfgmgr_end_of_cfg_reg_cb: Received registration callback 21 Sep 15 05:40:58.321 ospf_cfgmgr_end_of_cfg_reg_cb: Registered for end of config 22 Sep 15 05:40:58.322 ospf_register_end_of_cfg: Registration accepted 23 Sep 15 05:40:58.422 ospf_nsr_fsm_dispatch_event: dispatching event 20, state 0 -> 1, rev 0 24 Sep 15 05:40:58.422 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 25 Sep 15 05:40:58.427 ospf_ds_connect_cb: DS Connected 26 Sep 15 05:40:58.427 ospf_publish_ncd_ds_endp: Proc role not yet known 27 Sep 15 05:40:58.427 ospf_register_ncd_ds_service: Proc role not yet known 28 Sep 15 05:40:58.430 ospf_publish_ncd_ds_endp: Proc role not yet known 29 Sep 15 05:40:58.430 ospf_register_ncd_ds_service: Proc role not yet known 30 Sep 15 05:40:58.434 ospf_update_sckt_vrf_opt: vrf opts update OK for vrfid 0x60000000 31 Sep 15 05:40:58.435 ospf_rtrid_set_configured: new_rtr_id 3.3.3.3 32 Sep 15 05:40:58.435 ospf_rtrid_set_configured: rtrid config by value, op_conf_rtr_id 3.3.3.3 vrfid 60000000 33 Sep 15 05:40:58.517 ospf_publish_ncd_ds_endp: DS NCD service successfully published, ISSU role 1, HA role 1, 34 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 35 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 36 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 37 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 38 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: dispatching event 31, state 1 -> 1, rev 0 39 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 40 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 0 41 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 42 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 43 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 44 Sep 15 05:40:58.517 ospf_register_ncd_ds_service: Successfully registered for NCD DS notification 45 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: dispatching event 15, state 1 -> 1, rev 0 46 Sep 15 05:40:58.517 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 47 Sep 15 05:40:58.519 ospf_nsr_msg_chan_update: Update channel, ISSU-role 1, HA-role 1 48 Sep 15 05:40:58.537 ospf_rtrid_allocate: checking for old rtrid 0x60000000 49 Sep 15 05:40:58.537 ospf_rtrid_allocate: checking for rtrid config 50 Sep 15 05:40:58.537 ospf_rtrid_allocate: rtrid for vrf 0x60000000 set by numeric config: 3.3.3.3 51 Sep 15 05:40:58.630 ospf_bfd_connect: Attempt to connect to BFD server 52 Sep 15 05:40:58.633 ospf_ds_publish_service_cb: DS NCD service publised succesfully 53 Sep 15 05:40:58.635 ospf_ds_register_cb: DS NCD service registered succesfully, reg-handle 0x1 54 Sep 15 05:40:58.637 ospf_service_redist_delete: Deleting old redist routes, instance 0x60000000 55 Sep 15 05:40:58.637 ospf_ds_notify_service_cb: Number of EPs 1 56 Sep 15 05:40:58.637 ospf_ds_notify_service_cb: Setting new DS endp rev 1, number of EPs - 1 57 Sep 15 05:40:58.637 ospf_ncd_ds_endp_update: DS NCD endp, HA-role 1, ISSU-role 1 op_ospf_role 6 58 Sep 15 05:40:58.637 ospf_ncd_ds_endp_update: op_issu_id 0 issu_id 0 59 Sep 15 05:40:58.637 ospf_ncd_ds_endp_update: Ignore DS endp on V1A, ha-role 1, issu-role 1 60 Sep 15 05:40:58.637 ospf_ncd_ds_endp_clean_stale: Cleaning stale NCD endpoints 61 Sep 15 05:40:58.637 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 62 Sep 15 05:40:58.637 ospf_ncd_ds_endp_clean_stale: peer handle not set yet 63 Sep 15 05:40:58.719 ospf_apply_area: instance ptr 0x57ca2be0a660 64 Sep 15 05:40:58.719 ospf_create_area: : area 0.0.0.0 (0x57ca2bf86be0) dummy 0 65 Sep 15 05:40:58.725 ospf_bfd_bind_callback: Bind to BFD server - success 66 Sep 15 05:40:58.725 ospf_bfd_conn_callback: Connection to BFD established 67 Sep 15 05:40:58.725 ospf_bfd_send_create_batch: Batch size 0 68 Sep 15 05:40:58.725 ospf_bfd_end_of_replay: Sending EoR to BFD 69 Sep 15 05:40:58.729 ospf_activate_area_ptr: inactive area, area 0.0.0.0 (0x57ca2bf86be0) op_area_count 1 70 Sep 15 05:40:58.729 ospf_activate_area: active area, area 0.0.0.0 71 Sep 15 05:40:58.729 ospf_activate_area: active area, area 0.0.0.0 72 Sep 15 05:40:59.637 ospf_service_redist_summary: Start redist-scanning 73 Sep 15 05:41:06.433 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 74 Sep 15 05:41:06.530 ospf_if_rtr_id_callback: Router-id sent by IPARM: 3.3.3.3 75 Sep 15 05:41:08.126 ospf_cfgmgr_end_of_cfg_cb: Received end of config callback 76 Sep 15 05:41:08.126 ospf_cfgmgr_end_of_cfg_cb: Success 77 Sep 15 05:41:08.126 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 1 -> 1, rev 1 78 Sep 15 05:41:08.126 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 79 Sep 15 05:41:08.126 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 1 80 Sep 15 05:41:08.126 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 81 Sep 15 05:41:08.126 ospf_nsr_fsm_dispatch_event: dispatching event 30, state 1 -> 1, rev 1 82 Sep 15 05:41:08.126 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 83 Sep 15 05:41:08.126 ospf_nsr_fsm_dispatch_event: dispatching event 2, state 1 -> 1, rev 1 84 Sep 15 05:41:08.126 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 85 Sep 15 05:41:09.637 ospf_service_redist_summary: Start redist-scanning 86 Sep 15 05:41:12.324 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 87 Sep 15 05:41:18.749 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 88 Sep 15 05:41:19.638 ospf_service_redist_summary: Start redist-scanning 89 Sep 15 05:41:22.131 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 90 Sep 15 05:42:58.518 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 91 Sep 15 05:42:58.518 ospf_nsr_fsm_dispatch_event: NSR-index 0x0 92 Sep 15 05:42:58.518 ospf_nsr_fsm_dispatch_event: dispatching event 22, state 1 -> 1, rev 1 93 Sep 15 05:42:58.518 ospf_nsr_fsm_dispatch_event: NSR-index 0x1 94 Sep 15 05:56:40.525 ospf_service_maxage: delete MAXAGE lsa, queue size 1 95 Sep 15 05:56:40.525 ospf_service_maxage: processed 1 LSAs from MAXAGE queue, requeued 1, current size 1 96 Sep 15 05:56:41.525 ospf_service_maxage: delete MAXAGE lsa, queue size 1 97 Sep 15 05:56:41.525 ospf_service_maxage: processed 1 LSAs from MAXAGE queue, requeued 1, current size 1 RP/0/RP0/CPU0:R3#show ospf trace adj Tue Sep 15 06:25:26.491 UTC Traces for OSPF 1 (Tue Sep 15 06:25:27) Traces returned/requested/available: 72/8192/72 Trace buffer: adj 1 Sep 15 05:40:56.130 ospf_create_instance: Instance 0x0 quiesce_time INIT 2 Sep 15 05:40:57.824 ospf_create_area: Area 0.0.0.0 quiesce_time INIT 3 Sep 15 05:40:58.719 ospf_create_area: Area 0.0.0.0 quiesce_time INIT 4 Sep 15 05:40:59.637 ospf_service_redist_summary: end scanning, elapsed time 000000000.000045261 5 Sep 15 05:41:06.435 ospf_build_rtr_lsa: area 0.0.0.0 rtrid 3.3.3.3 seq 0x80000001 vrfid 0x60000000 6 Sep 15 05:41:09.637 ospf_service_redist_summary: scan for redist 7 Sep 15 05:41:09.637 ospf_service_redist_summary: end scanning, elapsed time 000000000.000036716 8 Sep 15 05:41:12.517 ospf_build_rtr_lsa: area 0.0.0.0 rtrid 3.3.3.3 seq 0x80000002 vrfid 0x60000000 9 Sep 15 05:41:17.542 ospf_if_inc_nbr_cnt: Gi0/0/0/1 - count in inst 1 (ex_load 0), on idb 1 10 Sep 15 05:41:17.542 ospf_inc_nbr_form_cnt: Instance 0x60000000 quiesce_time INIT 11 Sep 15 05:41:17.542 ospf_inc_nbr_form_cnt: Area 0.0.0.0 quiesce_time INIT 12 Sep 15 05:41:17.542 ospf_inc_nbr_form_cnt: nbr 4.4.4.4 forming Gi0/0/0/1, area 0.0.0.0 13 Sep 15 05:41:17.542 ospf_inc_nbr_form_cnt: #Nbrs: (ar: 1, inst: 1) forming, 0 full, area 0.0.0.0 14 Sep 15 05:41:17.542 ospf_log_adj_chg: nbr 4.4.4.4/10.0.34.4 changes from 0 to 2 15 Sep 15 05:41:17.542 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 16 Sep 15 05:41:17.542 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.0, vrfid 0x60000000 17 Sep 15 05:41:18.723 ospf_if_inc_nbr_cnt: Gi0/0/0/0 - count in inst 2 (ex_load 0), on idb 1 18 Sep 15 05:41:18.723 ospf_inc_nbr_form_cnt: nbr 1.1.1.1 forming Gi0/0/0/0, area 0.0.0.0 19 Sep 15 05:41:18.723 ospf_inc_nbr_form_cnt: #Nbrs: (ar: 2, inst: 2) forming, 0 full, area 0.0.0.0 20 Sep 15 05:41:18.723 ospf_log_adj_chg: nbr 1.1.1.1/10.0.13.1 changes from 0 to 2 21 Sep 15 05:41:18.723 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 22 Sep 15 05:41:18.723 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.0, vrfid 0x60000000 23 Sep 15 05:41:18.723 ospf_log_adj_chg: nbr 1.1.1.1/10.0.13.1 changes from 2 to 3 24 Sep 15 05:41:18.723 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 25 Sep 15 05:41:18.723 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.0, vrfid 0x60000000 26 Sep 15 05:41:18.723 ospf_log_adj_chg: nbr 1.1.1.1/10.0.13.1 changes from 3 to 4 27 Sep 15 05:41:18.723 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 28 Sep 15 05:41:18.723 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.0, vrfid 0x60000000 29 Sep 15 05:41:18.735 ospf_rcv_dbd: first DBD and we are not SLAVE 30 Sep 15 05:41:18.735 ospf_log_adj_chg: nbr 1.1.1.1/10.0.13.1 changes from 4 to 5 31 Sep 15 05:41:18.735 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 32 Sep 15 05:41:18.735 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.0, vrfid 0x60000000 33 Sep 15 05:41:18.735 ospf_nbr_inc_ex_load_count: Inst: 1 neighbors in ex_load Gi0/0/0/0, area 0.0.0.0, instance quiesce_time updated 34 Sep 15 05:41:18.735 ospf_nbr_inc_ex_load_count: Area: 1 neighbors in ex_load Gi0/0/0/0, area 0.0.0.0, area quiesce_time updated 35 Sep 15 05:41:18.735 build_dbd_sum: took 0 ms for nbr 1.1.1.1 count 1 vrf 0x60000000 36 Sep 15 05:41:18.742 ospf_log_adj_chg: nbr 1.1.1.1/10.0.13.1 changes from 5 to 6 37 Sep 15 05:41:18.742 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 38 Sep 15 05:41:18.742 ospf_log_adj_chg: DBD Rcv: 2 pkts 1 LSAs, area 0.0.0.0, vrfid 0x60000000 39 Sep 15 05:41:18.749 ospf_log_adj_chg: nbr 1.1.1.1/10.0.13.1 changes from 6 to 7 40 Sep 15 05:41:18.749 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 1 pkts 1 LSAs, LSA-Upd Rcv: 1 pkts 1 LSAs 41 Sep 15 05:41:18.749 ospf_log_adj_chg: DBD Rcv: 2 pkts 1 LSAs, area 0.0.0.0, vrfid 0x60000000 42 Sep 15 05:41:18.749 ospf_if_inc_nbr_full_cnt: Gi0/0/0/0 - full count in inst 1, on idb 1, area fullcnt 1 43 Sep 15 05:41:18.749 ospf_dec_nbr_form_cnt: nbr 1.1.1.1 forming Gi0/0/0/0, area 0.0.0.0 44 Sep 15 05:41:18.749 ospf_dec_nbr_form_cnt: #Nbrs: (ar: 1, inst: 1) forming, 1 full, area 0.0.0.0 45 Sep 15 05:41:18.803 ospf_build_rtr_lsa: area 0.0.0.0 rtrid 3.3.3.3 seq 0x80000003 vrfid 0x60000000 46 Sep 15 05:41:19.638 ospf_service_redist_summary: scan for redist 47 Sep 15 05:41:19.638 ospf_service_redist_summary: end scanning, elapsed time 000000000.000035467 48 Sep 15 05:41:22.117 ospf_log_adj_chg: nbr 4.4.4.4/10.0.34.4 changes from 2 to 3 49 Sep 15 05:41:22.117 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 50 Sep 15 05:41:22.117 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.0, vrfid 0x60000000 51 Sep 15 05:41:22.117 ospf_log_adj_chg: nbr 4.4.4.4/10.0.34.4 changes from 3 to 4 52 Sep 15 05:41:22.117 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 53 Sep 15 05:41:22.117 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.0, vrfid 0x60000000 54 Sep 15 05:41:22.118 ospf_log_adj_chg: nbr 4.4.4.4/10.0.34.4 changes from 4 to 5 55 Sep 15 05:41:22.118 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 56 Sep 15 05:41:22.118 ospf_log_adj_chg: DBD Rcv: 0 pkts 0 LSAs, area 0.0.0.0, vrfid 0x60000000 57 Sep 15 05:41:22.118 ospf_nbr_inc_ex_load_count: Inst: 1 neighbors in ex_load Gi0/0/0/1, area 0.0.0.0, instance quiesce_time updated 58 Sep 15 05:41:22.118 ospf_nbr_inc_ex_load_count: Area: 1 neighbors in ex_load Gi0/0/0/1, area 0.0.0.0, area quiesce_time updated 59 Sep 15 05:41:22.118 build_dbd_sum: took 0 ms for nbr 4.4.4.4 count 2 vrf 0x60000000 60 Sep 15 05:41:22.124 ospf_log_adj_chg: nbr 4.4.4.4/10.0.34.4 changes from 5 to 6 61 Sep 15 05:41:22.124 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 0 pkts 0 LSAs, LSA-Upd Rcv: 0 pkts 0 LSAs 62 Sep 15 05:41:22.124 ospf_log_adj_chg: DBD Rcv: 2 pkts 1 LSAs, area 0.0.0.0, vrfid 0x60000000 63 Sep 15 05:41:22.131 ospf_log_adj_chg: nbr 4.4.4.4/10.0.34.4 changes from 6 to 7 64 Sep 15 05:41:22.131 ospf_log_adj_chg: Flooding stats: LSA-Req sent: 1 pkts 1 LSAs, LSA-Upd Rcv: 1 pkts 1 LSAs 65 Sep 15 05:41:22.131 ospf_log_adj_chg: DBD Rcv: 2 pkts 1 LSAs, area 0.0.0.0, vrfid 0x60000000 66 Sep 15 05:41:22.131 ospf_if_inc_nbr_full_cnt: Gi0/0/0/1 - full count in inst 2, on idb 1, area fullcnt 2 67 Sep 15 05:41:22.131 ospf_dec_nbr_form_cnt: nbr 4.4.4.4 forming Gi0/0/0/1, area 0.0.0.0 68 Sep 15 05:41:22.131 ospf_dec_nbr_form_cnt: #Nbrs: (ar: 0, inst: 0) forming, 2 full, area 0.0.0.0 69 Sep 15 05:41:22.184 ospf_build_rtr_lsa: area 0.0.0.0 rtrid 3.3.3.3 seq 0x80000004 vrfid 0x60000000 70 Sep 15 05:41:26.828 ospf_rcv_update: Min Arrival time check fail 2.2.2.2 type 1 Adv rtr 2.2.2.2 vrfid 0x60000000 71 Sep 15 05:42:02.125 ospf_nbr_hold_dbd: Timer expired (nbr_hold_dbd): nbr_id 4.4.4.4 72 Sep 15 06:14:40.836 ospf_build_rtr_lsa: area 0.0.0.0 rtrid 3.3.3.3 seq 0x80000005 vrfid 0x60000000