[quagga-dev 7310] VLANs and Timers bug ?

Milan Kocian milon at wq.cz
Wed Oct 28 20:34:48 GMT 2009


hello

I have simple config, where ospf is set on vlan device. But I see every minute 
this reconnection. Have you seen something similar?

Hello packets are received every 5 sec (seen via tcpdump). My ip 172.24.118.98, 
opposite ip 172.24.118.97 (id 172.24.114.2).

Here is log with 'debug ospf nsm' (one round):

Oct 28 20:38:47 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: Timer (Inactivity timer expire) 
Oct 28 20:38:47 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: Full (InactivityTimer) 
Oct 28 20:38:47 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: State change Full -> Deleted (InactivityTimer) 
Oct 28 20:38:47 172.24.118.98 ospfd[2769]: nsm_change_state(172.24.114.2, Full -> Deleted): scheduling new router-LSA origination 
Oct 28 20:38:47 172.24.118.98 ospfd[2769]: DR-Election[1st]: Backup 172.24.118.98 
Oct 28 20:38:47 172.24.118.98 ospfd[2769]: DR-Election[1st]: DR     172.24.118.98 
Oct 28 20:38:47 172.24.118.98 ospfd[2769]: DR-Election[2nd]: Backup 0.0.0.0 
Oct 28 20:38:47 172.24.118.98 ospfd[2769]: DR-Election[2nd]: DR     172.24.118.98 

Oct 28 20:38:48 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: Down (HelloReceived) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: State change Down -> Init (HelloReceived) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: Init (2-WayReceived) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: State change Init -> ExStart (2-WayReceived) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: DR-Election[1st]: Backup 0.0.0.0 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: DR-Election[1st]: DR     172.24.118.98 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: DR-Election[1st]: Backup 0.0.0.0 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: DR-Election[1st]: DR     172.24.118.97 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: DR-Election[2nd]: Backup 172.24.118.98 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: DR-Election[2nd]: DR     172.24.118.97 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: ExStart (AdjOK?) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: Packet[DD]: Neighbor 172.24.114.2: Initial DBD from Slave, ignoring. 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: Packet[DD]: Neighbor 172.24.114.2 Negotiation done (Master). 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: ExStart (NegotiationDone) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: State change ExStart -> Exchange (NegotiationDone) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: Exchange (ExchangeDone) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: State change Exchange -> Loading (ExchangeDone) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: Loading (LoadingDone) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: State change Loading -> Full (LoadingDone) 
Oct 28 20:38:49 172.24.118.98 ospfd[2769]: nsm_change_state(172.24.114.2, Loading -> Full): scheduling new router-LSA origination 
================================= Next round ============================
Oct 28 20:39:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: Timer (Inactivity timer expire) 
Oct 28 20:39:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: Full (InactivityTimer) 
Oct 28 20:39:49 172.24.118.98 ospfd[2769]: NSM[eth0.171:172.24.118.98:172.24.114.2]: State change Full -> Deleted (InactivityTimer) 
Oct 28 20:39:49 172.24.118.98 ospfd[2769]: nsm_change_state(172.24.114.2, Full -> Deleted): scheduling new router-LSA origination 

... And every minute next round
=======================================

Here is the config:

hostname ospfd
password aaa
enable password aaa
log syslog
!
!
!
interface eth0
!
interface eth0.171
 ip ospf authentication
 ip ospf authentication-key XXX
 ip ospf cost 10
 ip ospf hello-interval 5
 ip ospf dead-interval 60
!
interface lo
!
router ospf
 ospf router-id 172.24.118.98
 max-metric router-lsa on-shutdown 5
 redistribute static
 network 172.24.118.96/27 area 0.0.0.0
!
line vty
=======================

Interfaces:

1: lo: <LOOPBACK,UP,10000> mtu 16436 qdisc noqueue 
    link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
    inet 127.0.0.1/8 scope host lo
    inet6 ::1/128 scope host 
       valid_lft forever preferred_lft forever
2: eth0: <BROADCAST,MULTICAST,UP,10000> mtu 1500 qdisc htb qlen 1000
    link/ether 00:07:e9:1b:59:98 brd ff:ff:ff:ff:ff:ff
    inet6 fe80::207:e9ff:fe1b:5998/64 scope link 
       valid_lft forever preferred_lft forever
3: eth0.171 at eth0: <BROADCAST,MULTICAST,UP,10000> mtu 1500 qdisc noqueue 
    link/ether 00:07:e9:1b:59:98 brd ff:ff:ff:ff:ff:ff
    inet 172.24.118.98/27 brd 172.24.118.127 scope global eth0.171
    inet6 fe80::207:e9ff:fe1b:5998/64 scope link 
       valid_lft forever preferred_lft forever

Tested Quagga versions: 0.99.9, 0.99.15
Kernel (not so easy change): 2.6.23.10 (vanilla)
Network card: 00:0e.0 Ethernet controller: Intel Corporation 82545EM Gigabit Ethernet Controller (Copper) (rev 01)

Thanks for any answer.

Best regards,

-- 
Milan Kocian



More information about the Quagga-dev mailing list