[OVSDB-340] Looping INFO messages for UNSUPPORTED AutoAttach OVS Created: 23/May/16  Updated: 19/Oct/17  Resolved: 03/Jun/16

Status: Resolved
Project: ovsdb
Component/s: Southbound.Open_vSwitch
Affects Version/s: unspecified
Fix Version/s: None

Type: Bug
Reporter: Eric Multanen Assignee: Unassigned
Resolution: Done Votes: 0
Labels: None
Remaining Estimate: Not Specified
Time Spent: Not Specified
Original Estimate: Not Specified
Environment:

Operating System: All
Platform: All

External issue ID: 5944

 Description   

After connecting to an OVS Host, INFO messages informing "AutoAttach not supported on this OVS" continue to log every 5 seconds.

Example log output:

2016-05-23 08:41:06,490 | INFO | on-dispatcher-48 | OvsdbDataTreeChangeListener | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Connecting on key KeyedInstanceIdentifier

{targetType=interface org.opendaylight.yang.gen.v1.urn.tbd.params.xml.ns.yang.network.topology.rev131021.network.topology.topology.Node, path=[org.opendaylight.yang.gen.v1.urn.tbd.params.xml.ns.yang.network.topology.rev131021.NetworkTopology, org.opendaylight.yang.gen.v1.urn.tbd.params.xml.ns.yang.network.topology.rev131021.network.topology.Topology[key=TopologyKey [_topologyId=Uri [_value=ovsdb:1]]], org.opendaylight.yang.gen.v1.urn.tbd.params.xml.ns.yang.network.topology.rev131021.network.topology.topology.Node[key=NodeKey [_nodeId=Uri [_value=ovsdb:HOST1]]]]}

to OvsdbNodeAugmentation{getConnectionInfo=ConnectionInfo{getRemoteIp=IpAddress [_ipv4Address=Ipv4Address [_value=10.11.21.8], _value=[1, 0, ., 1, 1, ., 2, 1, ., 8]], getRemotePort=PortNumber [_value=6640], augmentations={}}}
2016-05-23 08:41:06,491 | INFO | on-dispatcher-48 | OvsdbConnectionManager | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Connecting to 10.11.21.8:6640
2016-05-23 08:41:07,181 | INFO | on-dispatcher-48 | OvsdbConnectionManager | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | OVSDB Connection from /10.11.21.8:6640
2016-05-23 08:41:07,188 | INFO | on-dispatcher-48 | StringValueObjectFactory | 48 - org.opendaylight.mdsal.yang-binding - 0.9.0.SNAPSHOT | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.inet.types.rev100924.Ipv4Address
2016-05-23 08:41:07,189 | INFO | on-dispatcher-48 | StringValueObjectFactory | 48 - org.opendaylight.mdsal.yang-binding - 0.9.0.SNAPSHOT | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.inet.types.rev100924.Ipv4Prefix
2016-05-23 08:41:07,189 | INFO | on-dispatcher-48 | StringValueObjectFactory | 48 - org.opendaylight.mdsal.yang-binding - 0.9.0.SNAPSHOT | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.inet.types.rev100924.Ipv6Address
2016-05-23 08:41:07,190 | INFO | on-dispatcher-48 | StringValueObjectFactory | 48 - org.opendaylight.mdsal.yang-binding - 0.9.0.SNAPSHOT | Instantiated factory for class org.opendaylight.yang.gen.v1.urn.ietf.params.xml.ns.yang.ietf.inet.types.rev100924.Ipv6Prefix
2016-05-23 08:41:07,349 | INFO | on-dispatcher-48 | OvsdbConnectionManager | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | OVSDB entity Entity{type='ovsdb', id=/(urn:TBD:params:xml:ns:yang:network-topology?revision=2013-10-21)network-topology/topology/topology[

{(urn:TBD:params:xml:ns:yang:network-topology?revision=2013-10-21)topology-id=ovsdb:1}

]/node/node[

{(urn:TBD:params:xml:ns:yang:network-topology?revision=2013-10-21)node-id=ovsdb:HOST1}

]} is registered for ownership.
2016-05-23 08:41:07,355 | INFO | ult-dispatcher-4 | OvsdbConnectionManager | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | handleOwnershipChanged: this southbound plugin instance is an OWNER of the device ConnectionInfo [Remote-address=10.11.21.8, Remote-port=6640, Local-address10.11.21.7, Local-port=60626, type=ACTIVE]
2016-05-23 08:41:07,383 | INFO | on-dispatcher-48 | ControllerUpdateCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | execute: controllers: {} — bridges: {}
2016-05-23 08:41:07,383 | INFO | on-dispatcher-48 | ControllerUpdateCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | execute: transaction: []
2016-05-23 08:41:07,420 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Monitoring database: Open_vSwitch
2016-05-23 08:41:07,421 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table IPFIX in Open_vSwitch
2016-05-23 08:41:07,424 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table Open_vSwitch in Open_vSwitch
2016-05-23 08:41:07,424 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table Port in Open_vSwitch
2016-05-23 08:41:07,424 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table NetFlow in Open_vSwitch
2016-05-23 08:41:07,424 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table Manager in Open_vSwitch
2016-05-23 08:41:07,424 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table Controller in Open_vSwitch
2016-05-23 08:41:07,425 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table SSL in Open_vSwitch
2016-05-23 08:41:07,425 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table QoS in Open_vSwitch
2016-05-23 08:41:07,425 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table sFlow in Open_vSwitch
2016-05-23 08:41:07,425 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table Flow_Table in Open_vSwitch
2016-05-23 08:41:07,425 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table Flow_Sample_Collector_Set in Open_vSwitch
2016-05-23 08:41:07,426 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table Queue in Open_vSwitch
2016-05-23 08:41:07,426 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table Mirror in Open_vSwitch
2016-05-23 08:41:07,426 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table Bridge in Open_vSwitch
2016-05-23 08:41:07,426 | INFO | ult-dispatcher-4 | OvsdbConnectionInstance | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | Southbound monitoring table Interface in Open_vSwitch
2016-05-23 08:41:07,462 | INFO | ult-dispatcher-4 | OvsdbAutoAttachUpdateCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:07,463 | INFO | ult-dispatcher-4 | OvsdbAutoAttachRemovedCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:10,260 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachUpdateCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:10,261 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachRemovedCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:15,261 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachUpdateCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:15,262 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachRemovedCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:20,263 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachUpdateCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:20,263 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachRemovedCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:25,266 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachUpdateCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:25,266 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachRemovedCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:30,262 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachUpdateCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:30,262 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachRemovedCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:35,264 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachUpdateCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:35,264 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachRemovedCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS
2016-05-23 08:41:40,274 | INFO | entLoopGroup-8-1 | OvsdbAutoAttachUpdateCommand | 166 - org.opendaylight.ovsdb.southbound-impl - 1.3.0.SNAPSHOT | UNSUPPORTED FUNCTIONALITY: AutoAttach not supported on this OVS

etc...

 Comments   
Comment by Eric Multanen [ 01/Jun/16 ]

ovs version (came from a devstack install a while back)...

$ ovs-vswitchd --version
ovs-vswitchd (Open vSwitch) 2.3.1-git4750c96
Compiled Mar 28 2015 03:08:38

OpenFlow versions 0x1:0x1
$ ovsdb-server --version
ovsdb-server (Open vSwitch) 2.3.1-git4750c96
Compiled Mar 28 2015 03:08:19

$ sudo ovs-vsctl show
...
ovs_version: "2.3.1-git4750c96"

Comment by Rashmi Pujar [ 02/Jun/16 ]

The bug is addressed by gerrit patch : https://git.opendaylight.org/gerrit/#/c/39770,edit/

Solution details:

  • Avoid instantiating OvsdbAutoAttachUpdateCommand and OvsdbAutoAttachRemovedCommand from the OVSDB operational aggregator class for dbSchema versions that do not support the AutoAttach table.
  • Log as DEBUG and not INFO to avoid unnecessary logging
  • Remove the code to throw IllegalArgumentException in the transaction classes for AutoAttach since they will only be created for a supported version of OVSDB schema
Comment by Anil Vishnoi [ 03/Jun/16 ]

master: https://git.opendaylight.org/gerrit/39770
stable/beryllium:https://git.opendaylight.org/gerrit/39802

Generated at Wed Feb 07 20:36:08 UTC 2024 using Jira 8.20.10#820010-sha1:ace47f9899e9ee25d7157d59aa17ab06aee30d3d.