RP/0/RP0/CPU0:R1#show ospf trace spf | include Begin SPF Wed Sep 16 11:35:13.275 UTC 22 Sep 16 11:21:35.460 ospf_run_spf: Begin SPF 53 Sep 16 11:21:44.716 ospf_run_spf: Begin SPF 84 Sep 16 11:21:49.567 ospf_run_spf: Begin SPF 116 Sep 16 11:21:59.187 ospf_run_spf: Begin SPF 145 Sep 16 11:21:59.388 ospf_run_spf: Begin SPF 176 Sep 16 11:22:05.490 ospf_run_spf: Begin SPF 207 Sep 16 11:22:10.203 ospf_run_spf: Begin SPF 238 Sep 16 11:33:21.575 ospf_run_spf: Begin SPF 269 Sep 16 11:33:23.576 ospf_run_spf: Begin SPF 300 Sep 16 11:33:25.377 ospf_run_spf: Begin SPF 331 Sep 16 11:33:27.178 ospf_run_spf: Begin SPF 362 Sep 16 11:33:28.951 ospf_run_spf: Begin SPF 393 Sep 16 11:33:32.153 ospf_run_spf: Begin SPF 424 Sep 16 11:33:37.154 ospf_run_spf: Begin SPF 455 Sep 16 11:33:42.155 ospf_run_spf: Begin SPF RP/0/RP0/CPU0:R1#show ospf trace adj_cycle Wed Sep 16 11:35:14.219 UTC Traces for OSPF 1 (Wed Sep 16 11:35:15) Traces returned/requested/available: 34/8192/34 Trace buffer: adj_cycle 1 Sep 16 11:21:59.120 ospf_rcv_dbd: from 2.2.2.2(10.0.12.2) intf Gi0/0/0/0 seq 0x2c6b5d9b 2 Sep 16 11:21:59.120 ospf_send_dbd: to 2.2.2.2(10.0.12.2) intf Gi0/0/0/0 seq 0x156cd2c1 3 Sep 16 11:21:59.120 ospf_send_dbd: to 2.2.2.2(10.0.12.2) intf Gi0/0/0/0 seq 0x2c6b5d9b 4 Sep 16 11:21:59.128 ospf_rcv_dbd: from 2.2.2.2(10.0.12.2) intf Gi0/0/0/0 seq 0x2c6b5d9c 5 Sep 16 11:21:59.128 ospf_output: LSA pkt, src 10.0.12.1 dest 10.0.12.2 area 0.0.0.0 intf Gi0/0/0/0 6 Sep 16 11:21:59.129 ospf_send_req: LS REQ pkt, nbr 2.2.2.2/10.0.12.2 cnt 1 unsent 0 7 Sep 16 11:21:59.129 ospf_send_dbd: to 2.2.2.2(10.0.12.2) intf Gi0/0/0/0 seq 0x2c6b5d9c 8 Sep 16 11:21:59.136 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 178 9 Sep 16 11:21:59.136 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 3 paksize 126 10 Sep 16 11:21:59.136 ospf_output: LSA pkt, src 10.0.12.1 dest 10.0.12.2 area 0.0.0.0 intf Gi0/0/0/0 11 Sep 16 11:21:59.189 ospf_output: LSA pkt, src 10.0.12.1 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 12 Sep 16 11:21:59.196 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 190 13 Sep 16 11:22:01.136 ospf_output: LSA pkt, src 10.0.12.1 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 14 Sep 16 11:22:01.144 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 5 paksize 134 15 Sep 16 11:22:05.438 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 166 16 Sep 16 11:22:05.488 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 202 17 Sep 16 11:22:05.522 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 178 18 Sep 16 11:22:07.439 ospf_output: LSA pkt, src 10.0.12.1 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 19 Sep 16 11:22:10.153 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 178 20 Sep 16 11:22:12.153 ospf_output: LSA pkt, src 10.0.12.1 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 21 Sep 16 11:33:21.525 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 202 22 Sep 16 11:33:23.525 ospf_output: LSA pkt, src 10.0.12.1 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 23 Sep 16 11:33:23.525 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 202 24 Sep 16 11:33:25.326 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 202 25 Sep 16 11:33:25.526 ospf_output: LSA pkt, src 10.0.12.1 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 26 Sep 16 11:33:27.127 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 202 27 Sep 16 11:33:28.900 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 202 28 Sep 16 11:33:29.128 ospf_output: LSA pkt, src 10.0.12.1 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 29 Sep 16 11:33:32.101 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 202 30 Sep 16 11:33:34.101 ospf_output: LSA pkt, src 10.0.12.1 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 31 Sep 16 11:33:37.100 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 202 32 Sep 16 11:33:39.101 ospf_output: LSA pkt, src 10.0.12.1 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 33 Sep 16 11:33:42.101 ospf_do_hello_packets: LSA pkt, src 10.0.12.2 intf Gi0/0/0/0 type 4 paksize 202 34 Sep 16 11:33:44.102 ospf_output: LSA pkt, src 10.0.12.1 dest 224.0.0.5 area 0.0.0.0 intf Gi0/0/0/0 RP/0/RP0/CPU0:R1#show ospf trace events | include lsa Wed Sep 16 11:35:15.473 UTC 78 Sep 16 11:21:44.663 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 91 Sep 16 11:21:49.465 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 93 Sep 16 11:21:59.136 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 RP/0/RP0/CPU0:R1#show ospf trace errors Wed Sep 16 11:35:16.273 UTC Traces for OSPF 1 (Wed Sep 16 11:35:17) Traces returned/requested/available: 3/8192/3 Trace buffer: errors 1 Sep 16 11:21:35.064 ospf_nsr_ev_free: Cannot free event 0x3fd93fc0: flags 0x0,work 0x615d9add39b0, handler 0x615d8261e02e 2 Sep 16 11:21:35.064 ospf_nsr_ev_free: inst 0x0, nsr_info 0x0, next 0x0 3 Sep 16 11:21:35.080 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:R1#show ospf trace all | include rtr Wed Sep 16 11:35:17.218 UTC 3 Sep 16 11:21:35.183 ospf_build_ex_lsa: no rtrid to build external LSA 6 Sep 16 11:21:44.664 ospf_build_rtr_lsa: area 0.0.0.0 rtrid 1.1.1.1 seq 0x80000001 vrfid 0x60000000 9 Sep 16 11:21:49.516 ospf_build_rtr_lsa: area 0.0.0.0 rtrid 1.1.1.1 seq 0x80000002 vrfid 0x60000000 41 Sep 16 11:21:59.188 ospf_build_rtr_lsa: area 0.0.0.0 rtrid 1.1.1.1 seq 0x80000003 vrfid 0x60000000 42 Sep 16 11:22:05.521 ospf_rcv_update: Min Arrival time check fail 3.3.3.3 type 1 Adv rtr 3.3.3.3 vrfid 0x60000000 5 Sep 16 11:21:35.182 ospf_apply_routerid: rtrid 1.1.1.1 6 Sep 16 11:21:35.182 ospf_apply_routerid: soft reset, op_rtr_id 0.0.0.0 new 1.1.1.1 48 Sep 16 11:21:35.182 ospf_rtrid_set_configured: new_rtr_id 1.1.1.1 49 Sep 16 11:21:35.182 ospf_rtrid_set_configured: rtrid config by value, op_conf_rtr_id 1.1.1.1 vrfid 60000000 56 Sep 16 11:21:35.262 ospf_rtrid_allocate: checking for old rtrid 0x60000000 57 Sep 16 11:21:35.262 ospf_rtrid_allocate: checking for rtrid config 58 Sep 16 11:21:35.262 ospf_rtrid_allocate: rtrid for vrf 0x60000000 set by numeric config: 1.1.1.1 59 Sep 16 11:21:35.266 ospf_soft_reset_up: rtrid: new 1.1.1.1 old 0.0.0.0 60 Sep 16 11:21:35.266 ospf_soft_reset_up: rtrid changed, check vlink for reconfig 78 Sep 16 11:21:44.663 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 79 Sep 16 11:21:44.764 ospf_if_rtr_id_callback: Router-id sent by IPARM: 1.1.1.1 91 Sep 16 11:21:49.465 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 93 Sep 16 11:21:59.136 ospf_schedule_rtr_lsa: scheduling rtr lsa for area 0.0.0.0 18 Sep 16 11:21:31.665 ospf_nsr_init: Init init-sync continue (rtr thd) timer 132 Sep 16 11:21:32.958 ospf_nsr_init_rtr_thd_timers: Init init-sync continue timer 133 Sep 16 11:21:32.958 ospf_nsr_init_rtr_thd_timers: Init LSA async batching timer 134 Sep 16 11:21:32.958 ospf_nsr_init_rtr_thd_timers: Init LSA sync batching timer 135 Sep 16 11:21:32.958 ospf_nsr_init_rtr_thd_timers: Init LSA batching timer 136 Sep 16 11:21:32.958 ospf_nsr_init_rtr_thd_timers: Init init-sync continue timer 137 Sep 16 11:21:32.958 ospf_nsr_init_rtr_thd_timers: Init LSA async batching timer 138 Sep 16 11:21:32.958 ospf_nsr_init_rtr_thd_timers: Init LSA sync batching timer 139 Sep 16 11:21:32.958 ospf_nsr_init_rtr_thd_timers: Init LSA batching timer 343 Sep 16 11:21:35.062 ospf_aux_rtr_thd_rsi_conn_up_handler: Rcv RSI connection UP in Router thread 346 Sep 16 11:21:35.064 ospf_nsr_rtr_thd_nsr_milestone_event: Received milestone event from NSR for milestone(6), event(1) 347 Sep 16 11:21:35.064 ospf_nsr_rtr_thd_nsr_milestone_event: Received milestone event from NSR for milestone(2), event(1) 348 Sep 16 11:21:35.064 ospf_nsr_rtr_thd_nsr_milestone_event: Received milestone event from NSR for milestone(1), event(1) 421 Sep 16 11:21:35.178 ospf_nsr_rtr_thd_nsr_milestone_event: Received milestone event from NSR for milestone(5), event(1) 456 Sep 16 11:21:46.561 ospf_nsr_rtr_thd_nsr_milestone_event: Received milestone event from NSR for milestone(4), event(1) 2 Sep 16 11:21:35.063 ospf_rsi_rtr_thd_if_rescan: Added 0 idbs to the router thread batch 23 Sep 16 11:21:35.463 ospf_aux_rtr_thd_srlg_callback_handler_per_idb: Handling SRLG callback for Gi0/0/0/0 area 0.0.0.0, event 0x0, SRLG handle 0x7d500c000e80 24 Sep 16 11:21:35.463 ospf_aux_rtr_thd_srlg_result_handler: Rcv SRLG result OK for Gi0/0/0/0, old SRLG handle 0x7d500c000e80, new SRLG handle 0x7d500c000e80 6 Sep 16 11:21:35.266 ospf_te_set_ospf_rtrid: TE system-id 1.1.1.1 4 Sep 16 11:21:44.665 ospf_build_rtr_lsa: FC: SCHED_SPF: ar 0.0.0.0 (vrf 0x60000000, seq 0x80000001) - Router LSA changed 8 Sep 16 11:21:49.467 ospf_build_rtr_lsa: FC: T_DELAY_RTR_LSA: ar 0.0.0.0, bucket: 11,35 type 2 9 Sep 16 11:21:49.517 ospf_build_rtr_lsa: FC: SCHED_SPF: ar 0.0.0.0 (vrf 0x60000000, seq 0x80000002) - Router LSA changed 12 Sep 16 11:21:59.136 db_install: FC: LSA_CHG: New Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000002 15 Sep 16 11:21:59.136 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 16 Sep 16 11:21:59.138 ospf_build_rtr_lsa: FC: T_DELAY_RTR_LSA: ar 0.0.0.0, bucket: 11,35 type 2 19 Sep 16 11:21:59.189 ospf_build_rtr_lsa: FC: SCHED_SPF: ar 0.0.0.0 (vrf 0x60000000, seq 0x80000003) - Router LSA changed 20 Sep 16 11:21:59.196 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000003 21 Sep 16 11:21:59.196 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 26 Sep 16 11:22:05.438 db_install: FC: LSA_CHG: New Rtr LSA: ar 0.0.0.0 lsid 3.3.3.3 advrtr 3.3.3.3 seq 0x80000002 27 Sep 16 11:22:05.438 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 3.3.3.3 advrtr 3.3.3.3 28 Sep 16 11:22:05.488 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000004 29 Sep 16 11:22:05.488 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 32 Sep 16 11:22:10.153 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 3.3.3.3 advrtr 3.3.3.3 seq 0x80000003 33 Sep 16 11:22:10.153 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 3.3.3.3 advrtr 3.3.3.3 43 Sep 16 11:33:21.525 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000005 44 Sep 16 11:33:21.525 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 49 Sep 16 11:33:23.525 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000006 50 Sep 16 11:33:23.525 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 55 Sep 16 11:33:25.326 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000007 56 Sep 16 11:33:25.326 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 61 Sep 16 11:33:27.127 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000008 62 Sep 16 11:33:27.127 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 67 Sep 16 11:33:28.900 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000009 68 Sep 16 11:33:28.900 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 73 Sep 16 11:33:32.101 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x8000000a 74 Sep 16 11:33:32.101 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 79 Sep 16 11:33:37.100 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x8000000b 80 Sep 16 11:33:37.100 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 85 Sep 16 11:33:42.101 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x8000000c 86 Sep 16 11:33:42.101 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 11 Sep 16 11:21:35.062 ospf_iparm_rtrid_cb: rtr ID current = 0.0.0.0 new = 0.0.0.0 18 Sep 16 11:21:35.067 ospf_aux_rtr_thd_vrf_callback_handler: VRF id 0x60000000 and table_id 0xe0000000 instance 0x615d9acc5c80 event 0 19 Sep 16 11:21:35.069 ospf_aux_rtr_thd_vrf_result_handler: Rcv VRF Registration result OK for instance 0x615d9acc5c80 vrf handle 0xc000e00 event 0x0 20 Sep 16 11:21:35.069 ospf_aux_rtr_thd_vrf_result_handler: update VRF result handle to valid instance 0x615d9acc5c80 122 Sep 16 11:21:44.764 ospf_iparm_rtrid_cb: rtr ID current = 0.0.0.0 new = 1.1.1.1 123 Sep 16 11:21:44.764 ospf_iparm_rtrid_cb: rtr ID current = 1.1.1.1 new = 1.1.1.1 RP/0/RP0/CPU0:R1#show ospf trace all | include db_install Wed Sep 16 11:35:33.597 UTC 12 Sep 16 11:21:59.136 db_install: FC: LSA_CHG: New Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000002 15 Sep 16 11:21:59.136 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 20 Sep 16 11:21:59.196 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000003 21 Sep 16 11:21:59.196 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 26 Sep 16 11:22:05.438 db_install: FC: LSA_CHG: New Rtr LSA: ar 0.0.0.0 lsid 3.3.3.3 advrtr 3.3.3.3 seq 0x80000002 27 Sep 16 11:22:05.438 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 3.3.3.3 advrtr 3.3.3.3 28 Sep 16 11:22:05.488 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000004 29 Sep 16 11:22:05.488 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 32 Sep 16 11:22:10.153 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 3.3.3.3 advrtr 3.3.3.3 seq 0x80000003 33 Sep 16 11:22:10.153 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 3.3.3.3 advrtr 3.3.3.3 43 Sep 16 11:33:21.525 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000005 44 Sep 16 11:33:21.525 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 49 Sep 16 11:33:23.525 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000006 50 Sep 16 11:33:23.525 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 55 Sep 16 11:33:25.326 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000007 56 Sep 16 11:33:25.326 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 61 Sep 16 11:33:27.127 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000008 62 Sep 16 11:33:27.127 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 67 Sep 16 11:33:28.900 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x80000009 68 Sep 16 11:33:28.900 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 73 Sep 16 11:33:32.101 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x8000000a 74 Sep 16 11:33:32.101 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 79 Sep 16 11:33:37.100 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x8000000b 80 Sep 16 11:33:37.100 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 85 Sep 16 11:33:42.101 db_install: FC: LSA_CHG: Changed Rtr LSA: ar 0.0.0.0 lsid 2.2.2.2 advrtr 2.2.2.2 seq 0x8000000c 86 Sep 16 11:33:42.101 db_install: FC: SCHED_SPF: ar 0.0.0.0 type 1 lsid 2.2.2.2 advrtr 2.2.2.2 RP/0/RP0/CPU0:R1#show ospf trace all | include arriv Wed Sep 16 11:35:49.686 UTC RP/0/RP0/CPU0:R1#show ospf trace spf Wed Sep 16 11:36:05.858 UTC Traces for OSPF 1 (Wed Sep 16 11:36:06) Traces returned/requested/available: 485/8192/485 Trace buffer: spf 1 Sep 16 11:21:35.173 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 2 Sep 16 11:21:35.173 ospf_rib_ipv4_update_done: running rt cnt 0 (inst 0x60000000) op_rib_conv 0x0 op_rib_conv_event 0x0 3 Sep 16 11:21:35.173 ospf_update_done_cb: SPF complete: Elapse time: 1013 ms. 4 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 5 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 6 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 7 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 8 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 9 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 10 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 11 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 12 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats : level 4: batches: 0 routes: 0 13 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 14 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 15 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 16 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats : level 6: batches: 0 routes: 0 17 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 18 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 19 Sep 16 11:21:35.173 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 20 Sep 16 11:21:35.258 ospf_force_spf: flag 0 21 Sep 16 11:21:35.363 ospf_force_spf: flag 0 22 Sep 16 11:21:35.459 ospf_run_spf: Begin SPF 23 Sep 16 11:21:35.459 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 24 Sep 16 11:21:35.459 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 25 Sep 16 11:21:35.459 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 26 Sep 16 11:21:35.459 delete_old_routes: area 0.0.0.0 27 Sep 16 11:21:35.459 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 28 Sep 16 11:21:35.459 ospf_run_spf: SPF Dijkstra TRUE 29 Sep 16 11:21:35.459 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 30 Sep 16 11:21:35.459 ospf_rib_ipv4_update_done: running rt cnt 0 (inst 0x60000000) op_rib_conv 0x0 op_rib_conv_event 0x1 31 Sep 16 11:21:35.459 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 32 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 33 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 34 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 35 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 36 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 37 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 38 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 39 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 40 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats : level 4: batches: 0 routes: 0 41 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 42 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 43 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 44 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats : level 6: batches: 0 routes: 0 45 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 46 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 47 Sep 16 11:21:35.459 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 48 Sep 16 11:21:35.459 ospf_run_spf: SPF Processing ends 49 Sep 16 11:21:35.459 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 50 Sep 16 11:21:35.459 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 51 Sep 16 11:21:35.459 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 52 Sep 16 11:21:35.459 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 53 Sep 16 11:21:44.715 ospf_run_spf: Begin SPF 54 Sep 16 11:21:44.715 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 55 Sep 16 11:21:44.715 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 56 Sep 16 11:21:44.715 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 57 Sep 16 11:21:44.715 delete_old_routes: area 0.0.0.0 58 Sep 16 11:21:44.715 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 59 Sep 16 11:21:44.715 ospf_run_spf: SPF Dijkstra TRUE 60 Sep 16 11:21:44.715 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 61 Sep 16 11:21:44.715 ospf_rib_ipv4_update_done: running rt cnt 0 (inst 0x60000000) op_rib_conv 0x0 op_rib_conv_event 0x1 62 Sep 16 11:21:44.715 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 63 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 64 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 65 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 66 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 67 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 68 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 69 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 70 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 71 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats : level 4: batches: 0 routes: 0 72 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 73 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 74 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 75 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats : level 6: batches: 0 routes: 0 76 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 77 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 78 Sep 16 11:21:44.715 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 79 Sep 16 11:21:44.715 ospf_run_spf: SPF Processing ends 80 Sep 16 11:21:44.715 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 81 Sep 16 11:21:44.715 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 82 Sep 16 11:21:44.715 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 83 Sep 16 11:21:44.715 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 84 Sep 16 11:21:49.566 ospf_run_spf: Begin SPF 85 Sep 16 11:21:49.566 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 86 Sep 16 11:21:49.566 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 87 Sep 16 11:21:49.566 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 88 Sep 16 11:21:49.567 delete_old_routes: area 0.0.0.0 89 Sep 16 11:21:49.567 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 90 Sep 16 11:21:49.567 ospf_run_spf: SPF Dijkstra TRUE 91 Sep 16 11:21:49.567 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 92 Sep 16 11:21:49.567 ospf_rib_ipv4_update_done: running rt cnt 0 (inst 0x60000000) op_rib_conv 0x0 op_rib_conv_event 0x1 93 Sep 16 11:21:49.567 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 94 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 95 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 96 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 97 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 98 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 99 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 100 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 101 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 102 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats : level 4: batches: 0 routes: 0 103 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 104 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 105 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 106 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats : level 6: batches: 0 routes: 0 107 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 108 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 109 Sep 16 11:21:49.567 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 110 Sep 16 11:21:49.567 ospf_run_spf: SPF Processing ends 111 Sep 16 11:21:49.567 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 112 Sep 16 11:21:49.567 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 113 Sep 16 11:21:49.567 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 114 Sep 16 11:21:49.567 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 115 Sep 16 11:21:59.135 ospf_force_spf: flag 0 116 Sep 16 11:21:59.186 ospf_run_spf: Begin SPF 117 Sep 16 11:21:59.186 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 118 Sep 16 11:21:59.186 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 119 Sep 16 11:21:59.186 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 120 Sep 16 11:21:59.186 delete_old_routes: area 0.0.0.0 121 Sep 16 11:21:59.186 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 122 Sep 16 11:21:59.186 ospf_run_spf: SPF Dijkstra TRUE 123 Sep 16 11:21:59.186 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 124 Sep 16 11:21:59.186 ospf_rib_ipv4_update_done: running rt cnt 0 (inst 0x60000000) op_rib_conv 0x0 op_rib_conv_event 0x1 125 Sep 16 11:21:59.186 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 126 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 127 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 128 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 129 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 130 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 131 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 132 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 133 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 134 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats : level 4: batches: 0 routes: 0 135 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 136 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 137 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 138 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats : level 6: batches: 0 routes: 0 139 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 140 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 141 Sep 16 11:21:59.186 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 142 Sep 16 11:21:59.186 ospf_run_spf: SPF Processing ends 143 Sep 16 11:21:59.186 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 144 Sep 16 11:21:59.186 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 145 Sep 16 11:21:59.387 ospf_run_spf: Begin SPF 146 Sep 16 11:21:59.387 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 147 Sep 16 11:21:59.387 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 148 Sep 16 11:21:59.387 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 149 Sep 16 11:21:59.387 delete_old_routes: area 0.0.0.0 150 Sep 16 11:21:59.387 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 151 Sep 16 11:21:59.387 ospf_run_spf: SPF Dijkstra TRUE 152 Sep 16 11:21:59.387 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 153 Sep 16 11:21:59.387 ospf_rib_ipv4_update_done: running rt cnt 2 (inst 0x60000000) op_rib_conv 0x0 op_rib_conv_event 0x1 154 Sep 16 11:21:59.387 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 155 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 156 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 157 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 158 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 159 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 160 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 161 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 162 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 163 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats : level 4: batches: 1 routes: 1 164 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats, paths: add 1 err 0, del 0 err 0 165 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 166 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 167 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats : level 6: batches: 1 routes: 1 168 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats, paths: add 1 err 0, del 0 err 0 169 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 170 Sep 16 11:21:59.387 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 171 Sep 16 11:21:59.387 ospf_run_spf: SPF Processing ends 172 Sep 16 11:21:59.387 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 173 Sep 16 11:21:59.387 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 174 Sep 16 11:21:59.387 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 175 Sep 16 11:21:59.387 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 176 Sep 16 11:22:05.489 ospf_run_spf: Begin SPF 177 Sep 16 11:22:05.489 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 178 Sep 16 11:22:05.489 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 179 Sep 16 11:22:05.489 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 180 Sep 16 11:22:05.489 delete_old_routes: area 0.0.0.0 181 Sep 16 11:22:05.489 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 182 Sep 16 11:22:05.489 ospf_run_spf: SPF Dijkstra TRUE 183 Sep 16 11:22:05.489 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 184 Sep 16 11:22:05.489 ospf_rib_ipv4_update_done: running rt cnt 0 (inst 0x60000000) op_rib_conv 0x0 op_rib_conv_event 0x1 185 Sep 16 11:22:05.489 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 186 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 187 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 188 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 189 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 190 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 191 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 192 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 193 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 194 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats : level 4: batches: 1 routes: 1 195 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats, paths: add 1 err 0, del 0 err 0 196 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 197 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 198 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats : level 6: batches: 1 routes: 1 199 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats, paths: add 1 err 0, del 0 err 0 200 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 201 Sep 16 11:22:05.489 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 202 Sep 16 11:22:05.489 ospf_run_spf: SPF Processing ends 203 Sep 16 11:22:05.489 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 204 Sep 16 11:22:05.489 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 205 Sep 16 11:22:05.489 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 206 Sep 16 11:22:05.489 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 207 Sep 16 11:22:10.202 ospf_run_spf: Begin SPF 208 Sep 16 11:22:10.202 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 209 Sep 16 11:22:10.202 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 210 Sep 16 11:22:10.202 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 211 Sep 16 11:22:10.203 delete_old_routes: area 0.0.0.0 212 Sep 16 11:22:10.203 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 213 Sep 16 11:22:10.203 ospf_run_spf: SPF Dijkstra TRUE 214 Sep 16 11:22:10.203 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 215 Sep 16 11:22:10.203 ospf_rib_ipv4_update_done: running rt cnt 1 (inst 0x60000000) op_rib_conv 0x0 op_rib_conv_event 0x1 216 Sep 16 11:22:10.203 ospf_update_done_cb: SPF complete: Elapse time: 1 ms. 217 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 218 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 219 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 220 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 221 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 222 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 223 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 224 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 225 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats : level 4: batches: 2 routes: 2 226 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats, paths: add 2 err 0, del 0 err 0 227 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 228 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 229 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats : level 6: batches: 2 routes: 1 230 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats, paths: add 1 err 0, del 0 err 0 231 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 232 Sep 16 11:22:10.203 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 233 Sep 16 11:22:10.203 ospf_run_spf: SPF Processing ends 234 Sep 16 11:22:10.203 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 235 Sep 16 11:22:10.203 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 236 Sep 16 11:22:10.203 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 237 Sep 16 11:22:10.203 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 238 Sep 16 11:33:21.574 ospf_run_spf: Begin SPF 239 Sep 16 11:33:21.574 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 240 Sep 16 11:33:21.574 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 241 Sep 16 11:33:21.574 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 242 Sep 16 11:33:21.575 delete_old_routes: area 0.0.0.0 243 Sep 16 11:33:21.575 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 244 Sep 16 11:33:21.575 ospf_run_spf: SPF Dijkstra TRUE 245 Sep 16 11:33:21.575 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 246 Sep 16 11:33:21.575 ospf_rib_ipv4_update_done: running rt cnt 2 (inst 0x60000000) op_rib_conv 0x1 op_rib_conv_event 0x1 247 Sep 16 11:33:21.575 ospf_update_done_cb: SPF complete: Elapse time: 1 ms. 248 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 249 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 250 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 251 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 252 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 253 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 254 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 255 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 256 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats : level 4: batches: 3 routes: 3 257 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats, paths: add 3 err 0, del 0 err 0 258 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 259 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 260 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats : level 6: batches: 4 routes: 2 261 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats, paths: add 2 err 0, del 0 err 0 262 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 263 Sep 16 11:33:21.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 264 Sep 16 11:33:21.575 ospf_run_spf: SPF Processing ends 265 Sep 16 11:33:21.575 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 266 Sep 16 11:33:21.575 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 267 Sep 16 11:33:21.575 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 268 Sep 16 11:33:21.575 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 269 Sep 16 11:33:23.575 ospf_run_spf: Begin SPF 270 Sep 16 11:33:23.575 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 271 Sep 16 11:33:23.575 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 272 Sep 16 11:33:23.575 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 273 Sep 16 11:33:23.575 delete_old_routes: area 0.0.0.0 274 Sep 16 11:33:23.575 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 275 Sep 16 11:33:23.575 ospf_run_spf: SPF Dijkstra TRUE 276 Sep 16 11:33:23.575 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 277 Sep 16 11:33:23.575 ospf_rib_ipv4_update_done: running rt cnt 2 (inst 0x60000000) op_rib_conv 0x1 op_rib_conv_event 0x1 278 Sep 16 11:33:23.575 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 279 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 280 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 281 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 282 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 283 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 284 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 285 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 286 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 287 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats : level 4: batches: 4 routes: 4 288 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats, paths: add 4 err 0, del 0 err 0 289 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 290 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 291 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats : level 6: batches: 5 routes: 3 292 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats, paths: add 3 err 0, del 0 err 0 293 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 294 Sep 16 11:33:23.575 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 295 Sep 16 11:33:23.575 ospf_run_spf: SPF Processing ends 296 Sep 16 11:33:23.575 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 297 Sep 16 11:33:23.575 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 298 Sep 16 11:33:23.575 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 299 Sep 16 11:33:23.575 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 300 Sep 16 11:33:25.376 ospf_run_spf: Begin SPF 301 Sep 16 11:33:25.376 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 302 Sep 16 11:33:25.376 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 303 Sep 16 11:33:25.376 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 304 Sep 16 11:33:25.377 delete_old_routes: area 0.0.0.0 305 Sep 16 11:33:25.377 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 306 Sep 16 11:33:25.377 ospf_run_spf: SPF Dijkstra TRUE 307 Sep 16 11:33:25.377 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 308 Sep 16 11:33:25.377 ospf_rib_ipv4_update_done: running rt cnt 2 (inst 0x60000000) op_rib_conv 0x1 op_rib_conv_event 0x1 309 Sep 16 11:33:25.377 ospf_update_done_cb: SPF complete: Elapse time: 1 ms. 310 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 311 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 312 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 313 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 314 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 315 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 316 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 317 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 318 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats : level 4: batches: 5 routes: 5 319 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats, paths: add 5 err 0, del 0 err 0 320 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 321 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 322 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats : level 6: batches: 6 routes: 4 323 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats, paths: add 4 err 0, del 0 err 0 324 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 325 Sep 16 11:33:25.377 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 326 Sep 16 11:33:25.377 ospf_run_spf: SPF Processing ends 327 Sep 16 11:33:25.377 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 328 Sep 16 11:33:25.377 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 329 Sep 16 11:33:25.377 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 330 Sep 16 11:33:25.377 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 331 Sep 16 11:33:27.177 ospf_run_spf: Begin SPF 332 Sep 16 11:33:27.177 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 333 Sep 16 11:33:27.177 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 334 Sep 16 11:33:27.177 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 335 Sep 16 11:33:27.177 delete_old_routes: area 0.0.0.0 336 Sep 16 11:33:27.177 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 337 Sep 16 11:33:27.177 ospf_run_spf: SPF Dijkstra TRUE 338 Sep 16 11:33:27.177 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 339 Sep 16 11:33:27.177 ospf_rib_ipv4_update_done: running rt cnt 2 (inst 0x60000000) op_rib_conv 0x1 op_rib_conv_event 0x1 340 Sep 16 11:33:27.177 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 341 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 342 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 343 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 344 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 345 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 346 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 347 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 348 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 349 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats : level 4: batches: 6 routes: 6 350 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats, paths: add 6 err 0, del 0 err 0 351 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 352 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 353 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats : level 6: batches: 7 routes: 5 354 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats, paths: add 5 err 0, del 0 err 0 355 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 356 Sep 16 11:33:27.177 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 357 Sep 16 11:33:27.177 ospf_run_spf: SPF Processing ends 358 Sep 16 11:33:27.177 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 359 Sep 16 11:33:27.177 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 360 Sep 16 11:33:27.177 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 361 Sep 16 11:33:27.177 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 362 Sep 16 11:33:28.950 ospf_run_spf: Begin SPF 363 Sep 16 11:33:28.950 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 364 Sep 16 11:33:28.950 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 365 Sep 16 11:33:28.950 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 366 Sep 16 11:33:28.951 delete_old_routes: area 0.0.0.0 367 Sep 16 11:33:28.951 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 368 Sep 16 11:33:28.951 ospf_run_spf: SPF Dijkstra TRUE 369 Sep 16 11:33:28.951 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 370 Sep 16 11:33:28.951 ospf_rib_ipv4_update_done: running rt cnt 2 (inst 0x60000000) op_rib_conv 0x1 op_rib_conv_event 0x1 371 Sep 16 11:33:28.951 ospf_update_done_cb: SPF complete: Elapse time: 1 ms. 372 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 373 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 374 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 375 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 376 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 377 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 378 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 379 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 380 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats : level 4: batches: 7 routes: 7 381 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats, paths: add 7 err 0, del 0 err 0 382 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 383 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 384 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats : level 6: batches: 8 routes: 6 385 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats, paths: add 6 err 0, del 0 err 0 386 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 387 Sep 16 11:33:28.951 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 388 Sep 16 11:33:28.951 ospf_run_spf: SPF Processing ends 389 Sep 16 11:33:28.951 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 390 Sep 16 11:33:28.951 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 391 Sep 16 11:33:28.951 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 392 Sep 16 11:33:28.951 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 393 Sep 16 11:33:32.152 ospf_run_spf: Begin SPF 394 Sep 16 11:33:32.152 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 395 Sep 16 11:33:32.152 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 396 Sep 16 11:33:32.152 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 397 Sep 16 11:33:32.153 delete_old_routes: area 0.0.0.0 398 Sep 16 11:33:32.153 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 399 Sep 16 11:33:32.153 ospf_run_spf: SPF Dijkstra TRUE 400 Sep 16 11:33:32.153 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 401 Sep 16 11:33:32.153 ospf_rib_ipv4_update_done: running rt cnt 2 (inst 0x60000000) op_rib_conv 0x1 op_rib_conv_event 0x1 402 Sep 16 11:33:32.153 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 403 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 404 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 405 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 406 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 407 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 408 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 409 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 410 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 411 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats : level 4: batches: 8 routes: 8 412 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats, paths: add 8 err 0, del 0 err 0 413 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 414 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 415 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats : level 6: batches: 9 routes: 7 416 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats, paths: add 7 err 0, del 0 err 0 417 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 418 Sep 16 11:33:32.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 419 Sep 16 11:33:32.153 ospf_run_spf: SPF Processing ends 420 Sep 16 11:33:32.153 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 421 Sep 16 11:33:32.153 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 422 Sep 16 11:33:32.153 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 423 Sep 16 11:33:32.153 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 424 Sep 16 11:33:37.153 ospf_run_spf: Begin SPF 425 Sep 16 11:33:37.153 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 426 Sep 16 11:33:37.153 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 427 Sep 16 11:33:37.153 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 428 Sep 16 11:33:37.153 delete_old_routes: area 0.0.0.0 429 Sep 16 11:33:37.153 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 430 Sep 16 11:33:37.153 ospf_run_spf: SPF Dijkstra TRUE 431 Sep 16 11:33:37.153 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 432 Sep 16 11:33:37.153 ospf_rib_ipv4_update_done: running rt cnt 2 (inst 0x60000000) op_rib_conv 0x1 op_rib_conv_event 0x1 433 Sep 16 11:33:37.153 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 434 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 435 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 436 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 437 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 438 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 439 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 440 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 441 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 442 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats : level 4: batches: 9 routes: 9 443 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats, paths: add 9 err 0, del 0 err 0 444 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 445 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 446 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats : level 6: batches: 10 routes: 8 447 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats, paths: add 8 err 0, del 0 err 0 448 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 449 Sep 16 11:33:37.153 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 450 Sep 16 11:33:37.153 ospf_run_spf: SPF Processing ends 451 Sep 16 11:33:37.153 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 452 Sep 16 11:33:37.153 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 453 Sep 16 11:33:37.153 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 454 Sep 16 11:33:37.153 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 455 Sep 16 11:33:42.154 ospf_run_spf: Begin SPF 456 Sep 16 11:33:42.154 ospf_wdsysmon_olc_start: Begin: Sending Start OLC to wdsysmon, vrf 0x60000000 457 Sep 16 11:33:42.154 ospf_wdsysmon_olc_start: End: Sending Start OLC to wdsysmon, vrf 0x60000000 458 Sep 16 11:33:42.154 spf_intra: area 0.0.0.0 vrf 0x60000000 abr 0 ribupdate 1 459 Sep 16 11:33:42.154 delete_old_routes: area 0.0.0.0 460 Sep 16 11:33:42.154 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 461 Sep 16 11:33:42.154 ospf_run_spf: SPF Dijkstra TRUE 462 Sep 16 11:33:42.154 ospf_rib_ipv4_update_done: for Q: 6 running rt cnt 1 lfa cnt 0 (inst 0x60000000) 463 Sep 16 11:33:42.154 ospf_rib_ipv4_update_done: running rt cnt 2 (inst 0x60000000) op_rib_conv 0x1 op_rib_conv_event 0x1 464 Sep 16 11:33:42.154 ospf_update_done_cb: SPF complete: Elapse time: 0 ms. 465 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats : level 0: batches: 0 routes: 0 466 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 467 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats : level 1: batches: 0 routes: 0 468 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 469 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats : level 2: batches: 0 routes: 0 470 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 471 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats : level 3: batches: 0 routes: 0 472 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 473 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats : level 4: batches: 10 routes: 10 474 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats, paths: add 10 err 0, del 0 err 0 475 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats : level 5: batches: 0 routes: 0 476 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 477 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats : level 6: batches: 11 routes: 9 478 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats, paths: add 9 err 0, del 0 err 0 479 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats : level 7: batches: 0 routes: 0 480 Sep 16 11:33:42.154 ospf_update_done_cb: batch stats, paths: add 0 err 0, del 0 err 0 481 Sep 16 11:33:42.154 ospf_run_spf: SPF Processing ends 482 Sep 16 11:33:42.154 ospf_wdsysmon_olc_stop: Begin: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 483 Sep 16 11:33:42.154 ospf_wdsysmon_olc_stop: End: Sending Stop OLC Throttle to wdsysmon, vrf 0x60000000 484 Sep 16 11:33:42.154 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000) 485 Sep 16 11:33:42.154 ospf_rib_ipv4_update_priority: for Q: 5 running rt cnt 0 lfa cnt 0 (inst 0x60000000)