[Xorp-users] bouncing interface kills OSPF - known behavior?

Mark Winter mark.winter@clearwire.com
Fri, 24 Mar 2006 10:13:46 -0800


Is there a way to HUP the OSPF process when an interface that is defined 
in OSPF  toggles between up/down?  Once this happens I have to restart 
the XORP process and then the neighbor will go back into the 'full' 
state.  Currently running xorp 1.2.

So with the config below tun5 goes down for about 30 seconds and then 
when it's brought back up is when I have the problem.

root@marklaptop.localdomain> show ospf4 neighbor
  Address         Interface             State      ID              Pri  Dead
172.25.3.1       tun5/tun5              Down      11.10.10.10        0     0

-------config file------------
 interfaces {
        interface tun5 {
            default-system-config
            description: "Openvpn-test-interface"
        }
        interface "eth0.100" {
            default-system-config {
            }
            description: "Test interface"
        }
    }
    fea {
        unicast-forwarding4 {
        }
    }
    policy {
        policy-statement connected {
            term export {
                from {
                    protocol: "connected"
                }
            }
        }
        policy-statement static {
            term export {
                from {
                    protocol: "static"
                }
            }
        }
    }
  protocols {
        ospf4 {
            router-id: 10.10.10.10
            area 0.0.0.0 {
                interface "eth0.100" {
                    vif "eth0.100" {
                        address 1.1.1.1 {
                            passive: true
                        }
                    }
                }
                interface tun5 {
                    vif tun5 {
                        address 172.25.3.4 {
                            authentication {
                                md5 1 {
                                    password: "id10t"
                                }
                            }
                        }
                    }
                }
            }
            traceoptions {
                flag {
                    all {
                    }
                }
            }
        }
    }

---- LOG FILE-------
[ 2006/03/24 10:00:27  INFO xorp_rtrmgr:28544 RTRMGR +240 
master_conf_tree.cc execute ] Changed modules: interfaces, fea, rib, 
policy, ospf4
[ 2006/03/24 10:00:27  INFO xorp_rtrmgr:28544 RTRMGR +99 
module_manager.cc execute ] Executing module: interfaces (fea/xorp_fea)
[ 2006/03/24 10:00:28 INFO xorp_fea MFEA ] MFEA enabled
[ 2006/03/24 10:00:28 INFO xorp_fea MFEA ] CLI enabled
[ 2006/03/24 10:00:28 INFO xorp_fea MFEA ] CLI started
[ 2006/03/24 10:00:28 INFO xorp_fea MFEA ] MFEA enabled
[ 2006/03/24 10:00:28 INFO xorp_fea MFEA ] CLI enabled
[ 2006/03/24 10:00:28 INFO xorp_fea MFEA ] CLI started
[ 2006/03/24 10:00:29  INFO xorp_rtrmgr:28544 RTRMGR +99 
module_manager.cc execute ] Executing module: fea (fea/xorp_fea)
[ 2006/03/24 10:00:35  INFO xorp_rtrmgr:28544 RTRMGR +99 
module_manager.cc execute ] Executing module: rib (rib/xorp_rib)
[ 2006/03/24 10:00:37  INFO xorp_rtrmgr:28544 RTRMGR +99 
module_manager.cc execute ] Executing module: policy (policy/xorp_policy)
[ 2006/03/24 10:00:39  INFO xorp_rtrmgr:28544 RTRMGR +99 
module_manager.cc execute ] Executing module: ospf4 (ospf/xorp_ospfv2)
[ 2006/03/24 10:00:41 TRACE xorp_ospfv2 OSPF ] Event(LoopInd) 
Interface(eth0.100/eth0.100) State(Down)
[ 2006/03/24 10:00:41 TRACE xorp_ospfv2 OSPF ] Event(InterfaceUp) 
Interface(tun5/tun5) State(Down)
[ 2006/03/24 10:00:41  INFO xorp_rtrmgr:28544 RTRMGR +2228 task.cc 
run_task ] No more tasks to run
[ 2006/03/24 10:00:42 TRACE xorp_ospfv2 OSPF ] Event(HelloReceived) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Init)
[ 2006/03/24 10:00:42 TRACE xorp_ospfv2 OSPF ] Event(2-WayReceived) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Init)
[ 2006/03/24 10:00:42 TRACE xorp_ospfv2 OSPF ] Event(BackupSeen) 
Interface(tun5/tun5) State(Waiting)
[ 2006/03/24 10:00:42 TRACE xorp_ospfv2 OSPF ] Event(AdjOK?) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(TwoWay)
[ 2006/03/24 10:00:51 TRACE xorp_ospfv2 OSPF ] 
Event(DataDescriptionReceived-pseudo-event) Interface(tun5/tun5) 
Neighbour(172.25.3.1) State(ExStart)
[ 2006/03/24 10:00:51 TRACE xorp_ospfv2 OSPF ] Event(NegotiationDone) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(ExStart)
[ 2006/03/24 10:00:51 TRACE xorp_ospfv2 OSPF ] 
Event(DataDescriptionReceived-pseudo-event) Interface(tun5/tun5) 
Neighbour(172.25.3.1) State(Exchange)
[ 2006/03/24 10:00:51 TRACE xorp_ospfv2 OSPF ] Event(ExchangeDone) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Exchange)
[ 2006/03/24 10:00:52 TRACE xorp_ospfv2 OSPF ] Event(HelloReceived) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Loading)
[ 2006/03/24 10:00:52 TRACE xorp_ospfv2 OSPF ] Event(2-WayReceived) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Loading)
[ 2006/03/24 10:00:52 TRACE xorp_ospfv2 OSPF ] Event(NeighborChange) 
Interface(tun5/tun5) State(Backup)
[ 2006/03/24 10:00:56 TRACE xorp_ospfv2 OSPF ] 
Event(LinkStateUpdateReceived-pseudo-event) Interface(tun5/tun5) 
Neighbour(172.25.3.1) State(Loading)
[ 2006/03/24 10:00:56 TRACE xorp_ospfv2 OSPF ] Event(LoadingDone) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Loading)
[ 2006/03/24 10:00:56 TRACE xorp_ospfv2 OSPF ] 
Event(LinkStateRequestReceived-pseudo-event) Interface(tun5/tun5) 
Neighbour(172.25.3.1) State(Full)
[ 2006/03/24 10:00:56 TRACE xorp_ospfv2 OSPF ] 
Event(LinkStateAcknowledgementReceived-pseudo-event) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Full)
[ 2006/03/24 10:00:56 TRACE xorp_ospfv2 OSPF ] 
Event(LinkStateUpdateReceived-pseudo-event) Interface(tun5/tun5) 
Neighbour(172.25.3.1) State(Full)
[ 2006/03/24 10:00:56 TRACE xorp_ospfv2 OSPF ] 
Event(LinkStateAcknowledgementReceived-pseudo-event) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Full)
[ 2006/03/24 10:00:56 TRACE xorp_ospfv2 OSPF ] Ack for LSA not in 
retransmission list.
LS age    1 Options  0x2 DC: 0 EA: 0 N/P: 0 MC: 0 E: 1 LS type 0x1 Link 
State ID 10.10.10.10 Advertising Router 10.10.10.10 LS sequence number 
0x80000001 LS checksum 0x1246 length 48
Link State Acknowledgement Packet:
        Version 2
        Type 5
        Router ID 11.10.10.10
        Area ID 0.0.0.0
        Auth Type 2

        LS age    1 Options  0x2 DC: 0 EA: 0 N/P: 0 MC: 0 E: 1 LS type 
0x1 Link State ID 10.10.10.10 Advertising Router 10.10.10.10 LS sequence 
number 0x80000001 LS checksum 0x1246 length 48
[ 2006/03/24 10:00:57 TRACE xorp_ospfv2 OSPF ] Node: OSPFv2 Router 
11.10.10.10(0xb0a0a0a) 0.0.0.0(0) not reachable
[ 2006/03/24 10:00:57 TRACE xorp_ospfv2 OSPF ] Node: OSPFv2 Network 
172.25.3.255(0xac1903ff) 0.0.0.0(0) not reachable
[ 2006/03/24 10:00:57 TRACE xorp_ospfv2 OSPF ] Node: OSPFv2 Network 
172.25.100.10(0xac19640a) 0.0.0.0(0) not reachable
[ 2006/03/24 10:00:57 TRACE xorp_ospfv2 OSPF ] Node: OSPFv2 Router 
255.255.255.255(0xffffffff) 0.0.0.0(0) not reachable
[ 2006/03/24 10:01:01 TRACE xorp_ospfv2 OSPF ] 
Event(LinkStateUpdateReceived-pseudo-event) Interface(tun5/tun5) 
Neighbour(172.25.3.1) State(Full)
[ 2006/03/24 10:01:02 TRACE xorp_ospfv2 OSPF ] Event(HelloReceived) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Full)
[ 2006/03/24 10:01:02 TRACE xorp_ospfv2 OSPF ] Event(2-WayReceived) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Full)
[ 2006/03/24 10:01:02 TRACE xorp_ospfv2 OSPF ] Checking for virtual 
links Router-LSA:
LS age    1 Options  0x2 DC: 0 EA: 0 N/P: 0 MC: 0 E: 1 LS type 0x1 Link 
State ID 11.10.10.10 Advertising Router 11.10.10.10 LS sequence number 
0x80000005 LS checksum 0xb346 length 48
        Nt-bit false
        V-bit false
        E-bit false
        B-bit false
        Type 2 Transit network IP address of Designated router 
172.25.100.10 Routers interface address 172.25.100.1 Metric 1
        Type 2 Transit network IP address of Designated router 
172.25.3.1 Routers interface address 172.25.3.1 Metric 1
[ 2006/03/24 10:01:02 TRACE xorp_ospfv2 OSPF ] Checking for virtual 
links Router-LSA:
LS age 1505 Options 0x22 DC: 1 EA: 0 N/P: 0 MC: 0 E: 1 LS type 0x1 Link 
State ID 255.255.255.255 Advertising Router 255.255.255.255 LS sequence 
number 0x80000816 LS checksum 0x5558 length 36
        Nt-bit false
        V-bit false
        E-bit false
        B-bit false
        Type 2 Transit network IP address of Designated router 
172.25.100.10 Routers interface address 172.25.100.10 Metric 1
[ 2006/03/24 10:01:02 TRACE xorp_ospfv2 OSPF ] [OSPF] Running filter: 
Import on route: 172.25.100.0/24
[ 2006/03/24 10:01:02 TRACE xorp_ospfv2 OSPF ] [OSPF] Running filter: 
Export-SourceMatch on route: 172.25.100.0/24
[ 2006/03/24 10:01:02 TRACE xorp_ospfv2 OSPF ] Add route Net 
172.25.100.0/24 Nexthop 172.25.3.1 metric 2 equal false discard false policy
[ 2006/03/24 10:01:12 TRACE xorp_ospfv2 OSPF ] Event(HelloReceived) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Full)
[ 2006/03/24 10:01:12 TRACE xorp_ospfv2 OSPF ] Event(2-WayReceived) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Full)
[ 2006/03/24 10:01:21 WARNING xorp_fea XrlFeaTarget ] Handling method 
for raw_packet4/0.1/send failed: XrlCmdError 102 Command failed 
setsockopt(IP_MULTICAST_IF, 172.25.3.4) failed: Cannot assign requested 
address
[ 2006/03/24 10:01:21  ERROR xorp_ospfv2:28549 OSPF +181 xrl_io.cc 
send_cb ] Cannot send a packet on interface tun5 vif tun5: 102 Command 
failed setsockopt(IP_MULTICAST_IF, 172.25.3.4) failed: Cannot assign 
requested address
[ 2006/03/24 10:01:52 TRACE xorp_ospfv2 OSPF ] Event(InactivityTimer) 
Interface(tun5/tun5) Neighbour(172.25.3.1) State(Full)
[ 2006/03/24 10:01:52 TRACE xorp_ospfv2 OSPF ] Event(NeighborChange) 
Interface(tun5/tun5) State(Backup)
[ 2006/03/24 10:01:53 TRACE xorp_ospfv2 OSPF ] Node: OSPFv2 Router 
11.10.10.10(0xb0a0a0a) 0.0.0.0(0) not reachable
[ 2006/03/24 10:01:53 TRACE xorp_ospfv2 OSPF ] Node: OSPFv2 Network 
172.25.3.1(0xac190301) 0.0.0.0(0) not reachable
[ 2006/03/24 10:01:53 TRACE xorp_ospfv2 OSPF ] Node: OSPFv2 Network 
172.25.100.10(0xac19640a) 0.0.0.0(0) not reachable
[ 2006/03/24 10:01:53 TRACE xorp_ospfv2 OSPF ] Node: OSPFv2 Router 
255.255.255.255(0xffffffff) 0.0.0.0(0) not reachable
[ 2006/03/24 10:01:53 TRACE xorp_ospfv2 OSPF ] Delete route Net 
172.25.100.0/24
[ 2006/03/24 10:01:53  ERROR xorp_fea:28545 FEA +503 
fticonfig_entry_set_netlink.cc delete_entry ] Error checking netlink 
request: AF_NETLINK NLMSG_ERROR message: No such process
[ 2006/03/24 10:01:53  ERROR xorp_fea:28545 FEA +71 fti_transaction.cc 
operation_result ] FTI transaction commit failed on DeleteEntry4: net = 
172.25.100.0/24 nexthop = 0.0.0.0 ifname =  vifname =  metric = 0 
admin_distance = 0 xorp_route = false is_deleted = false is_unresolved = 
false is_connected_route = false
[ 2006/03/24 10:01:53 WARNING xorp_fea XrlFeaTarget ] Handling method 
for redist_transaction4/0.1/commit_transaction failed: XrlCmdError 102 
Command failed DeleteEntry4: net = 172.25.100.0/24 nexthop = 0.0.0.0 
ifname =  vifname =  metric = 0 admin_distance = 0 xorp_route = false 
is_deleted = false is_unresolved = false is_connected_route = false
[ 2006/03/24 10:01:53  ERROR xorp_rib:28547 RIB +914 redist_xrl.cc 
dispatch_complete ] Failed to commit transaction: 102 Command failed 
DeleteEntry4: net = 172.25.100.0/24 nexthop = 0.0.0.0 ifname =  vifname 
=  metric = 0 admin_distance = 0 xorp_route = false is_deleted = false 
is_unresolved = false is_connected_route = false