Uploaded image for project: 'ONOS'
  1. ONOS
  2. ONOS-653

Null Device Provider causes exceptions in multi-node configuration

    XMLWordPrintable

    Details

    • Type: Bug
    • Status: Closed (View Workflow)
    • Priority: Major
    • Resolution: Done
    • Affects Version/s: None
    • Fix Version/s: 1.1.0
    • Component/s: None
    • Labels:
      None

      Description

      occurs only with multi-node env.

      exceptions:

      2015-01-12 22:06:55,879 | INFO | event-dispatch-0 | MastershipManager | 154 - org.onosproject.onos-core-net - 1.1.0.SNAPSHOT | instance DefaultControllerNode

      {id=10.128.174.3, ip=10.128.174.3, tcpPort=9876}

      added/activated
      2015-01-12 22:06:56,147 | INFO | P_test.migration | InternalPartitionService | 52 - com.hazelcast - 3.3.2 | [10.128.174.1]:5701 [intentTP_test] [3.3.2] Re-partitioning cluster data... Migration queue size: 181
      2015-01-12 22:06:57,578 | INFO | P_test.migration | InternalPartitionService | 52 - com.hazelcast - 3.3.2 | [10.128.174.1]:5701 [intentTP_test] [3.3.2] All migration tasks have been completed, queues are empty.
      2015-01-12 22:07:33,591 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.2 | Installing feature onos-null 1.1.0-SNAPSHOT
      2015-01-12 22:07:33,591 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.2 | Installing feature onos-api 1.1.0-SNAPSHOT
      2015-01-12 22:07:33,591 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.2 | Installing feature scr 3.0.2
      2015-01-12 22:07:33,600 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.2 | Installing feature onos-thirdparty-base 1.1.0-SNAPSHOT
      2015-01-12 22:07:33,665 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.2 | Installing feature scr-condition-management_0_0_0 3.0.2
      2015-01-12 22:07:33,667 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.2 | Installing feature scr-condition-webconsole_0_0_0 3.0.2
      2015-01-12 22:07:33,669 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.2 | Installing feature webconsole-condition-scr_0_0_0 3.0.2
      2015-01-12 22:07:33,670 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.2 | Installing feature standard-condition-webconsole_0_0_0 3.0.2
      2015-01-12 22:07:33,694 | INFO | h for user karaf | InstancePlugin | 163 - org.apache.karaf.webconsole.instance - 3.0.2 | Instance plugin activated
      2015-01-12 22:07:33,699 | INFO | h for user karaf | HttpServiceFactoryImpl | 91 - org.ops4j.pax.web.pax-web-runtime - 3.1.2 | Binding bundle: [org.apache.karaf.webconsole.instance [163]] to http service
      2015-01-12 22:07:33,718 | INFO | h for user karaf | FeaturesPlugin | 164 - org.apache.karaf.webconsole.features - 3.0.2 | Features plugin activated
      2015-01-12 22:07:33,721 | INFO | h for user karaf | HttpServiceFactoryImpl | 91 - org.ops4j.pax.web.pax-web-runtime - 3.1.2 | Binding bundle: [org.apache.karaf.webconsole.features [164]] to http service
      2015-01-12 22:07:33,743 | INFO | h for user karaf | GogoPlugin | 165 - org.apache.karaf.webconsole.gogo - 3.0.2 | Gogo plugin activated
      2015-01-12 22:07:33,746 | INFO | h for user karaf | HttpServiceFactoryImpl | 91 - org.ops4j.pax.web.pax-web-runtime - 3.1.2 | Binding bundle: [org.apache.karaf.webconsole.gogo [165]] to http service
      2015-01-12 22:07:33,764 | INFO | h for user karaf | HttpPlugin | 166 - org.apache.karaf.webconsole.http - 3.0.2 | Http plugin activated
      2015-01-12 22:07:33,765 | WARN | h for user karaf | ServletTracker | 96 - org.ops4j.pax.web.pax-web-extender-whiteboard - 3.1.2 | Registered servlet [org.apache.karaf.webconsole.http.HttpPlugin@71ccf224] did not contain a valid alias or url patterns property
      2015-01-12 22:07:33,776 | INFO | h for user karaf | NullDeviceProvider | 158 - org.onosproject.onos-null-provider-device - 1.1.0.SNAPSHOT | Started
      2015-01-12 22:07:33,782 | INFO | l-device-creator | DeviceManager | 154 - org.onosproject.onos-core-net - 1.1.0.SNAPSHOT | Device null:0 connected
      2015-01-12 22:07:33,807 | INFO | event-dispatch-0 | DeviceClockManager | 155 - org.onosproject.onos-core-dist - 1.1.0.SNAPSHOT | adding term info null:0 10.128.174.1
      2015-01-12 22:07:33,813 | INFO | event-dispatch-0 | DeviceManager | 154 - org.onosproject.onos-core-net - 1.1.0.SNAPSHOT | Applying role MASTER to null:0
      2015-01-12 22:07:33,813 | WARN | event-dispatch-0 | LLDPLinkProvider | 129 - org.onosproject.onos-lldp-provider - 1.1.0.SNAPSHOT | Device null:0 doesn't exist, or isn't there yet
      2015-01-12 22:07:33,824 | INFO | l-device-creator | DeviceManager | 154 - org.onosproject.onos-core-net - 1.1.0.SNAPSHOT | Role of this node is MASTER for null:0
      2015-01-12 22:07:33,824 | INFO | l-device-creator | DeviceClockManager | 155 - org.onosproject.onos-core-dist - 1.1.0.SNAPSHOT | adding term info null:0 10.128.174.1
      2015-01-12 22:07:33,829 | INFO | l-device-creator | GossipDeviceStore | 155 - org.onosproject.onos-core-dist - 1.1.0.SNAPSHOT | Notifying peers of a device update topology event for providerId: ProviderId

      {scheme=null, id=org.onosproject.provider.nil, ancillary=false} and deviceId: null:0
      2015-01-12 22:07:33,833 | INFO | l-device-creator | GossipDeviceStore | 155 - org.onosproject.onos-core-dist - 1.1.0.SNAPSHOT | Notifying peers of a ports update topology event for providerId: ProviderId{scheme=null, id=org.onosproject.provider.nil, ancillary=false}

      and deviceId: null:0
      2015-01-12 22:07:33,840 | INFO | l-device-creator | DeviceManager | 154 - org.onosproject.onos-core-net - 1.1.0.SNAPSHOT | Device null:1 connected
      2015-01-12 22:07:33,883 | INFO | topo-build-1 | TopologyManager | 154 - org.onosproject.onos-core-net - 1.1.0.SNAPSHOT | Topology DefaultTopology

      {time=531158982230066, computeCost=424775, clusters=1, devices=1, links=0, pathCount=0}

      changed
      2015-01-12 22:07:33,918 | WARN | event-dispatch-0 | AbstractListenerRegistry | 71 - org.onosproject.onos-api - 1.1.0.SNAPSHOT | Exception encountered while processing event DeviceEvent{time=2015-01-12T22:07:33.829, type=DEVICE_ADDED, subject=DefaultDevice{id=null:0, type=SWITCH, manufacturer=ON.Lab, hwVersion=0.0.1, swVersion=0.0.1, serialNumber=1234}}
      java.lang.NullPointerException
      at org.onosproject.net.flow.impl.FlowRuleManager$InternalStoreDelegate.notify(FlowRuleManager.java:405)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.net.flow.impl.FlowRuleManager$InternalStoreDelegate.notify(FlowRuleManager.java:379)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.store.AbstractStore.notifyDelegate(AbstractStore.java:58)[71:org.onosproject.onos-api:1.1.0.SNAPSHOT]
      at org.onosproject.store.flow.impl.DistributedFlowRuleStore.storeBatchInternal(DistributedFlowRuleStore.java:447)[155:org.onosproject.onos-core-dist:1.1.0.SNAPSHOT]
      at org.onosproject.store.flow.impl.DistributedFlowRuleStore.storeBatch(DistributedFlowRuleStore.java:379)[155:org.onosproject.onos-core-dist:1.1.0.SNAPSHOT]
      at org.onosproject.net.flow.impl.FlowRuleManager.applyBatch(FlowRuleManager.java:196)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.net.flow.impl.FlowRuleManager.applyFlowRules(FlowRuleManager.java:138)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.net.proxyarp.impl.ProxyArpManager.pushRules(ProxyArpManager.java:448)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.net.proxyarp.impl.ProxyArpManager.access$200(ProxyArpManager.java:78)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.net.proxyarp.impl.ProxyArpManager$InternalDeviceListener.event(ProxyArpManager.java:495)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.net.proxyarp.impl.ProxyArpManager$InternalDeviceListener.event(ProxyArpManager.java:488)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.event.AbstractListenerRegistry.process(AbstractListenerRegistry.java:63)[71:org.onosproject.onos-api:1.1.0.SNAPSHOT]
      at org.onosproject.event.impl.CoreEventDispatcher$DispatchLoop.run(CoreEventDispatcher.java:95)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_25]
      at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_25]
      at java.lang.Thread.run(Thread.java:745)[:1.8.0_25]
      2015-01-12 22:07:34,049 | ERROR | entLoopGroup-3-4 | ClusterCommunicationManager | 155 - org.onosproject.onos-core-dist - 1.1.0.SNAPSHOT | Exception caught handling ClusterMessage{sender=10.128.174.3, subject=peer-forward-apply-batch, payload=byte[]{length=76, hash=677143330}}
      java.lang.NullPointerException
      at org.onosproject.net.flow.impl.FlowRuleManager$InternalStoreDelegate.notify(FlowRuleManager.java:405)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.net.flow.impl.FlowRuleManager$InternalStoreDelegate.notify(FlowRuleManager.java:379)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.store.AbstractStore.notifyDelegate(AbstractStore.java:58)[71:org.onosproject.onos-api:1.1.0.SNAPSHOT]
      at org.onosproject.store.flow.impl.DistributedFlowRuleStore.storeBatchInternal(DistributedFlowRuleStore.java:447)[155:org.onosproject.onos-core-dist:1.1.0.SNAPSHOT]
      at org.onosproject.store.flow.impl.DistributedFlowRuleStore.access$800(DistributedFlowRuleStore.java:109)[155:org.onosproject.onos-core-dist:1.1.0.SNAPSHOT]
      at org.onosproject.store.flow.impl.DistributedFlowRuleStore$OnStoreBatch.handle(DistributedFlowRuleStore.java:664)[155:org.onosproject.onos-core-dist:1.1.0.SNAPSHOT]
      at org.onosproject.store.cluster.messaging.impl.ClusterCommunicationManager$InternalClusterMessageHandler.handle(ClusterCommunicationManager.java:202)[155:org.onosproject.onos-core-dist:1.1.0.SNAPSHOT]
      at org.onlab.netty.NettyMessagingService$InboundMessageDispatcher.channelRead0(NettyMessagingService.java:315)[157:org.onosproject.onlab-netty:1.1.0.SNAPSHOT]
      at org.onlab.netty.NettyMessagingService$InboundMessageDispatcher.channelRead0(NettyMessagingService.java:291)[157:org.onosproject.onlab-netty:1.1.0.SNAPSHOT]
      at io.netty.channel.SimpleChannelInboundHandler.channelRead(SimpleChannelInboundHandler.java:105)[46:io.netty.transport:4.0.23.Final]
      at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:333)[46:io.netty.transport:4.0.23.Final]
      at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:319)[46:io.netty.transport:4.0.23.Final]
      at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:163)[48:io.netty.codec:4.0.23.Final]
      at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:333)[46:io.netty.transport:4.0.23.Final]
      at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:319)[46:io.netty.transport:4.0.23.Final]
      at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:787)[46:io.netty.transport:4.0.23.Final]
      at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:130)[46:io.netty.transport:4.0.23.Final]
      at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:511)[46:io.netty.transport:4.0.23.Final]
      at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:468)[46:io.netty.transport:4.0.23.Final]
      at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:382)[46:io.netty.transport:4.0.23.Final]
      at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:354)[46:io.netty.transport:4.0.23.Final]
      at io.netty.util.concurrent.SingleThreadEventExecutor$2.run(SingleThreadEventExecutor.java:116)[44:io.netty.common:4.0.23.Final]
      at io.netty.util.concurrent.DefaultThreadFactory$DefaultRunnableDecorator.run(DefaultThreadFactory.java:137)[44:io.netty.common:4.0.23.Final]
      at java.lang.Thread.run(Thread.java:745)[:1.8.0_25]
      2015-01-12 22:07:34,049 | ERROR | entLoopGroup-3-3 | ClusterCommunicationManager | 155 - org.onosproject.onos-core-dist - 1.1.0.SNAPSHOT | Exception caught handling ClusterMessage{sender=10.128.174.2, subject=peer-forward-apply-batch, payload=byte[]{length=76, hash=131759615}}
      java.lang.NullPointerException
      at org.onosproject.net.flow.impl.FlowRuleManager$InternalStoreDelegate.notify(FlowRuleManager.java:405)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.net.flow.impl.FlowRuleManager$InternalStoreDelegate.notify(FlowRuleManager.java:379)[154:org.onosproject.onos-core-net:1.1.0.SNAPSHOT]
      at org.onosproject.store.AbstractStore.notifyDelegate(AbstractStore.java:58)[71:org.onosproject.onos-api:1.1.0.SNAPSHOT]
      at org.onosproject.store.flow.impl.DistributedFlowRuleStore.storeBatchInternal(DistributedFlowRuleStore.java:447)[155:org.onosproject.onos-core-dist:1.1.0.SNAPSHOT]

        Attachments

        No reviews matched the request. Check your Options in the drop-down menu of this sections header.

          Activity

            People

            Assignee:
            ash ash
            Reporter:
            suibin suibin
            Votes:
            0 Vote for this issue
            Watchers:
            1 Start watching this issue

              Dates

              Created:
              Updated:
              Resolved: