-
Type:
Bug
-
Status: Closed (View Workflow)
-
Priority:
Major
-
Resolution: Done
-
Affects Version/s: None
-
Fix Version/s: 1.3.0
-
Component/s: None
-
Labels:
-
Epic Link:
Not sure if this will fall under Core or NB. Setting this to Core for now.
**********************************************
Logging in as karaf
398 [sshd-SshClient[55a1c291]-nio2-thread-2] WARN org.apache.sshd.client.keyverifier.AcceptAllServerKeyVerifier - Server at [localhost/127.0.0.1:8101, DSA, 24:4f:43:d0:3c:49:e8:35:5d:2d:50:87:bf:70:bc:07] presented unverified {} key: {}
Welcome to Open Network Operating System (ONOS)!
____ _ ______ ____
/ __ \/ |/ / __ \/ __/
/ // / / // /\ \
___//|/__/__/
Hit '<tab>' for a list of available commands
and '[cmd] --help' for help on a specific command.
Hit '<ctrl-d>' or type 'system:shutdown' or 'logout' to shutdown ONOS.
onos>
onos>
onos> masters
10.128.20.11: 0 devices
10.128.20.12: 0 devices
10.128.20.13: 2 devices
of:0000000000000003
of:0000000000000004
onos>
onos> ^C
onos> ^D
sdn@suibin-test-dev-onos01:~$
sdn@suibin-test-dev-onos01:~$ exit
logout
There are stopped jobs.
sdn@suibin-test-dev-onos01:~$ exit
logout
Connection to 10.128.20.11 closed.
haris-mbp-2:~ harikrishna$ ssh sdn@10.128.20.13
Welcome to Ubuntu 14.04.1 LTS (GNU/Linux 2.6.32-39-pve x86_64)
- Documentation: https://help.ubuntu.com/
Last login: Thu Sep 10 16:39:22 2015 from 10.128.10.11
sdn@Suibin-TestDevOnos3:~$
sdn@Suibin-TestDevOnos3:~$ /opt/onos/bin/onos
Logging in as karaf
384 [sshd-SshClient[55a1c291]-nio2-thread-2] WARN org.apache.sshd.client.keyverifier.AcceptAllServerKeyVerifier - Server at [localhost/127.0.0.1:8101, DSA, 35:1d:f4:9e:93:e7:ba:17:5a:ea:9b:78:d2:ab:46:67] presented unverified {} key: {}
Welcome to Open Network Operating System (ONOS)!
____ _ ______ ____
/ __ \/ |/ / __ \/ __/
/ // / / // /\ \
___//|/__/__/
Hit '<tab>' for a list of available commands
and '[cmd] --help' for help on a specific command.
Hit '<ctrl-d>' or type 'system:shutdown' or 'logout' to shutdown ONOS.
onos>
onos> summary
node=10.128.20.13, version=1.3.0.admin~2015/09/10@13:38
nodes=3, devices=2, links=2, hosts=0, SCC(s)=1, flows=6, intents=0
onos> app activate org.onosproject.
org.onosproject.aaa org.onosproject.acl org.onosproject.bgprouter
org.onosproject.cip org.onosproject.config org.onosproject.cordfabric
org.onosproject.demo org.onosproject.dhcp org.onosproject.distributedprimitives
org.onosproject.election org.onosproject.flowanalyzer org.onosproject.fwd
org.onosproject.intentperf org.onosproject.messagingperf org.onosproject.metrics
org.onosproject.netconf org.onosproject.null org.onosproject.olt
org.onosproject.optical org.onosproject.ovsdb org.onosproject.pcep
org.onosproject.reactive.routing org.onosproject.sdnip org.onosproject.segmentrouting
org.onosproject.virtualbng org.onosproject.vtn org.onosproject.vtnrsc
org.onosproject.vtnweb org.onosproject.xosintegration
onos> app activate org.onosproject.fwd
onos> app activate org.onosproject.dhcp
onos> summary
node=10.128.20.13, version=1.3.0.admin~2015/09/10@13:38
nodes=3, devices=2, links=2, hosts=0, SCC(s)=1, flows=12, intents=0
onos>
onos>
onos> flows
deviceId=of:0000000000000003, flowRuleCount=6
id=200004643c1d4, state=ADDED, bytes=4212, packets=52, duration=160, priority=40000, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE
treatment=DefaultTrafficTreatment{immediate=[OUTPUT{port=CONTROLLER}], deferred=[], transition=None, cleared=false, metadata=null}
id=200004643d01e, state=ADDED, bytes=4212, packets=52, duration=160, priority=40000, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE{ethType=bddp}]
treatment=DefaultTrafficTreatment{immediate=[OUTPUT{port=CONTROLLER}], deferred=[], transition=None, cleared=false, metadata=null}
id=2000046532920, state=ADDED, bytes=0, packets=0, duration=5, priority=5, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE{ethType=ipv4}]
treatment=DefaultTrafficTreatment{immediate=[OUTPUT{port=CONTROLLER}], deferred=[], transition=None, cleared=false, metadata=null}
id=20000465329da, state=ADDED, bytes=0, packets=0, duration=5, priority=5, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE{ethType=arp}]
treatment=DefaultTrafficTreatment{immediate=[OUTPUT{port=CONTROLLER}], deferred=[], transition=None, cleared=false, metadata=null}
id=20000465329da, state=ADDED, bytes=0, packets=0, duration=1, priority=40000, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE{ethType=arp}]
treatment=DefaultTrafficTreatment{immediate=[OUTPUT{port=CONTROLLER}], deferred=[], transition=None, cleared=false, metadata=null}
id=200004655328e, state=ADDED, bytes=0, packets=0, duration=1, priority=40000, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE{ethType=ipv4}, IP_PROTO{protocol=17}, UDP_DST{udpPort=67}, UDP_SRC{udpPort=68}]
treatment=DefaultTrafficTreatment{immediate=[OUTPUT{port=CONTROLLER}], deferred=[], transition=None, cleared=false, metadata=null}
deviceId=of:0000000000000004, flowRuleCount=6
id=2000046443633, state=ADDED, bytes=4212, packets=52, duration=160, priority=40000, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE{ethType=lldp}
]
treatment=DefaultTrafficTreatment{immediate=[OUTPUT
id=200004644447d, state=ADDED, bytes=4212, packets=52, duration=160, priority=40000, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE{ethType=bddp}]
treatment=DefaultTrafficTreatment{immediate=[OUTPUT{port=CONTROLLER}
], deferred=[], transition=None, cleared=false, metadata=null}
id=2000046539d7f, state=ADDED, bytes=0, packets=0, duration=5, priority=5, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE
treatment=DefaultTrafficTreatment{immediate=[OUTPUT{port=CONTROLLER}], deferred=[], transition=None, cleared=false, metadata=null}
id=2000046539e39, state=ADDED, bytes=0, packets=0, duration=5, priority=5, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE{ethType=arp}]
treatment=DefaultTrafficTreatment{immediate=[OUTPUT{port=CONTROLLER}], deferred=[], transition=None, cleared=false, metadata=null}
id=2000046539e39, state=ADDED, bytes=0, packets=0, duration=1, priority=40000, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE{ethType=arp}]
treatment=DefaultTrafficTreatment{immediate=[OUTPUT{port=CONTROLLER}], deferred=[], transition=None, cleared=false, metadata=null}
id=200004655a6ed, state=ADDED, bytes=0, packets=0, duration=1, priority=40000, tableId=0 appId=org.onosproject.core, payLoad=null
selector=[ETH_TYPE{ethType=ipv4}
, IP_PROTO
{protocol=17}, UDP_DST
{udpPort=67}, UDP_SRC
{udpPort=68}]
treatment=DefaultTrafficTreatment{immediate=[OUTPUT
], deferred=[], transition=None, cleared=false, metadata=null}
onos>
onos> nodes
id=10.128.20.11, address=10.128.20.11:9876, state=ACTIVE, updated=3m ago
id=10.128.20.12, address=10.128.20.12:9876, state=ACTIVE, updated=3m ago
id=10.128.20.13, address=10.128.20.13:9876, state=ACTIVE, updated=3m ago *
onos> masters
10.128.20.11: 0 devices
10.128.20.12: 0 devices
10.128.20.13: 2 devices
of:0000000000000003
of:0000000000000004
onos>
onos> roles
of:0000000000000003: master=10.128.20.13, standbys=[ 10.128.20.11 10.128.20.12 ]
of:0000000000000004: master=10.128.20.13, standbys=[ 10.128.20.12 10.128.20.11 ]
onos>
onos> devices
id=of:0000000000000003, available=true, role=MASTER, type=SWITCH, mfr=Nicira, Inc., hw=Open vSwitch, sw=2.3.0, serial=None, protocol=OF_13, channelId=10.128.10.11:40308
id=of:0000000000000004, available=true, role=MASTER, type=SWITCH, mfr=Nicira, Inc., hw=Open vSwitch, sw=2.3.0, serial=None, protocol=OF_13, channelId=10.128.10.11:40311
onos> log:exception-display
onos>
onos>
onos> log:exception-display
java.lang.NullPointerException: IP Address must be specified
at com.google.common.base.Preconditions.checkNotNull(Preconditions.java:226)
at org.onosproject.dhcp.IpAssignment$Builder.validateInputs(IpAssignment.java:191)
at org.onosproject.dhcp.IpAssignment$Builder.build(IpAssignment.java:163)
at org.onosproject.dhcp.impl.DistributedDhcpStore.suggestIP(DistributedDhcpStore.java:164)
at org.onosproject.dhcp.impl.DhcpManager$DHCPPacketProcessor.processDHCPPacket(DhcpManager.java:445)
at org.onosproject.dhcp.impl.DhcpManager$DHCPPacketProcessor.process(DhcpManager.java:560)
at org.onosproject.net.packet.impl.PacketManager$InternalPacketProviderService.processPacket(PacketManager.java:284)
at org.onosproject.provider.of.packet.impl.OpenFlowPacketProvider$InternalPacketProvider.handlePacket(OpenFlowPacketProvider.java:170)
at org.onosproject.openflow.controller.impl.OpenFlowControllerImpl.processPacket(OpenFlowControllerImpl.java:282)
at org.onosproject.openflow.controller.impl.OpenFlowControllerImpl$OpenFlowSwitchAgent.processMessage(OpenFlowControllerImpl.java:606)
at org.onosproject.openflow.controller.driver.AbstractOpenFlowSwitch.handleMessage(AbstractOpenFlowSwitch.java:203)
at org.onosproject.openflow.controller.impl.OFChannelHandler.dispatchMessage(OFChannelHandler.java:1185)
at org.onosproject.openflow.controller.impl.OFChannelHandler.access$1800(OFChannelHandler.java:81)
at org.onosproject.openflow.controller.impl.OFChannelHandler$ChannelState$8.processOFPacketIn(OFChannelHandler.java:636)
at org.onosproject.openflow.controller.impl.OFChannelHandler$ChannelState.processOFMessage(OFChannelHandler.java:884)
at org.onosproject.openflow.controller.impl.OFChannelHandler.messageReceived(OFChannelHandler.java:1166)
at org.jboss.netty.handler.timeout.IdleStateAwareChannelHandler.handleUpstream(IdleStateAwareChannelHandler.java:36)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.handler.timeout.ReadTimeoutHandler.messageReceived(ReadTimeoutHandler.java:184)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.handler.timeout.IdleStateHandler.messageReceived(IdleStateHandler.java:294)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:296)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.handler.codec.frame.FrameDecoder.unfoldAndFireMessageReceived(FrameDecoder.java:462)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.handler.codec.frame.FrameDecoder.callDecode(FrameDecoder.java:443)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.handler.codec.frame.FrameDecoder.messageReceived(FrameDecoder.java:303)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:268)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:255)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.socket.nio.NioWorker.read(NioWorker.java:88)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.socket.nio.AbstractNioWorker.process(AbstractNioWorker.java:108)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:318)
at org.jboss.netty.channel.socket.nio.AbstractNioWorker.run(AbstractNioWorker.java:89)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.socket.nio.NioWorker.run(NioWorker.java:178)[45:org.jboss.netty:3.9.2.Final]
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]
onos> masters
10.128.20.11: 1 devices
of:0000000000000003
10.128.20.12: 0 devices
10.128.20.13: 1 devices
of:0000000000000004
onos> summary
node=10.128.20.13, version=1.3.0.admin~2015/09/10@13:38
nodes=3, devices=2, links=2, hosts=0, SCC(s)=1, flows=12, intents=0
onos> log:display
2015-09-10 16:38:49,827 | INFO | event-dispatch-0 | CoreEventDispatcher | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Dispatch loop initiated
2015-09-10 16:38:49,828 | INFO | FelixStartLevel | CoreEventDispatcher | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:38:49,938 | INFO | FelixStartLevel | CodecManager | 78 - org.onosproject.onos-core-common - 1.3.0.SNAPSHOT | Started
2015-09-10 16:38:50,205 | INFO | FelixStartLevel | ClusterDefinitionManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:38:50,228 | INFO | FelixStartLevel | NettyMessagingManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | enableNettyTLS = false
2015-09-10 16:38:50,322 | INFO | FelixStartLevel | NettyMessagingManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:38:50,326 | INFO | entLoopGroup-4-1 | NettyMessagingManager | 81 - org.onosproject.onlab-netty - 1.3.0.SNAPSHOT | 10.128.20.13 accepting incoming connections on port 9876
2015-09-10 16:38:50,539 | INFO | FelixStartLevel | DistributedClusterStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:38:50,971 | INFO | FelixStartLevel | ApiDocManager | 140 - org.onosproject.onos-rest - 1.3.0.SNAPSHOT | Started
2015-09-10 16:38:51,139 | INFO | FelixStartLevel | HttpServiceFactoryImpl | 115 - org.ops4j.pax.web.pax-web-runtime - 3.1.4 | Binding bundle: [org.onosproject.onos-rest [140]] to http service
2015-09-10 16:38:51,363 | INFO | FelixStartLevel | HttpServiceFactoryImpl | 115 - org.ops4j.pax.web.pax-web-runtime - 3.1.4 | Binding bundle: [org.onosproject.onos-gui [158]] to http service
2015-09-10 16:38:51,515 | INFO | pool-8-thread-1 | WebApplicationImpl | 134 - com.sun.jersey.jersey-server - 1.19.0 | Initiating Jersey application, version 'Jersey: 1.19 02/11/2015 03:25 AM'
2015-09-10 16:38:51,517 | INFO | rint Extender: 2 | BlueprintContainerImpl | 15 - org.apache.aries.blueprint.core - 1.4.2 | Bundle org.apache.karaf.kar.command is waiting for dependencies [(objectClass=org.apache.karaf.kar.KarService)]
2015-09-10 16:38:51,519 | INFO | pool-8-thread-2 | WebApplicationImpl | 134 - com.sun.jersey.jersey-server - 1.19.0 | Initiating Jersey application, version 'Jersey: 1.19 02/11/2015 03:25 AM'
2015-09-10 16:38:51,951 | INFO | FelixStartLevel | ClusterManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:38:51,954 | INFO | FelixStartLevel | ClusterCommunicationManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:38:51,970 | INFO | FelixStartLevel | DatabaseManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Loading database definition: /opt/onos/apache-karaf-3.0.3/../config/tablets.json
2015-09-10 16:38:52,659 | INFO | ycat-coordinator | RaftContext | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Transitioning to FOLLOWER
2015-09-10 16:38:52,698 | INFO | pool-8-thread-2 | WebApplicationImpl | 134 - com.sun.jersey.jersey-server - 1.19.0 | Initiating Jersey application, version 'Jersey: 1.19 02/11/2015 03:25 AM'
2015-09-10 16:38:52,755 | WARN | pool-8-thread-1 | Errors | 133 - com.sun.jersey.core - 1.19.0 | The following warnings have been detected with resource and/or provider classes:
WARNING: A sub-resource method, public javax.ws.rs.core.Response org.onosproject.rest.resources.ApiDocResource.getDefault() throws java.io.IOException,java.net.URISyntaxException, with URI template, "/", is treated as a resource method
2015-09-10 16:38:52,924 | INFO | pool-8-thread-2 | WebApplicationImpl | 134 - com.sun.jersey.jersey-server - 1.19.0 | Initiating Jersey application, version 'Jersey: 1.19 02/11/2015 03:25 AM'
2015-09-10 16:38:53,066 | INFO | pool-8-thread-2 | WebApplicationImpl | 134 - com.sun.jersey.jersey-server - 1.19.0 | Initiating Jersey application, version 'Jersey: 1.19 02/11/2015 03:25 AM'
2015-09-10 16:38:53,208 | INFO | pool-8-thread-2 | WebApplicationImpl | 134 - com.sun.jersey.jersey-server - 1.19.0 | Initiating Jersey application, version 'Jersey: 1.19 02/11/2015 03:25 AM'
2015-09-10 16:38:56,946 | INFO | copycat-p0-1 | RaftContext | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Transitioning to FOLLOWER
2015-09-10 16:39:01,198 | INFO | copycat-p1-1 | RaftContext | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Transitioning to FOLLOWER
2015-09-10 16:39:06,082 | INFO | copycat-p1-1 | FollowerState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Heartbeat timed out in 4884 milliseconds
2015-09-10 16:39:06,084 | INFO | copycat-p1-1 | FollowerState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Polling members [onos://10.128.20.12:9876, onos://10.128.20.11:9876, onos://10.128.20.13:9876]
2015-09-10 16:39:06,100 | INFO | copycat-p1-1 | FollowerState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Received accepted poll from onos://10.128.20.13:9876
2015-09-10 16:39:06,106 | INFO | copycat-p1-1 | FollowerState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Received accepted poll from onos://10.128.20.12:9876
2015-09-10 16:39:06,106 | INFO | copycat-p1-1 | RaftContext | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Transitioning to CANDIDATE
2015-09-10 16:39:06,109 | INFO | copycat-p1-1 | CandidateState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Starting election
2015-09-10 16:39:06,112 | INFO | copycat-p1-1 | CandidateState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Requesting votes from [onos://10.128.20.12:9876, onos://10.128.20.11:9876, onos://10.128.20.13:9876]
2015-09-10 16:39:06,116 | INFO | copycat-p1-1 | CandidateState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Received successful vote from onos://10.128.20.13:9876
2015-09-10 16:39:06,116 | INFO | copycat-p1-1 | CandidateState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Received successful vote from onos://10.128.20.12:9876
2015-09-10 16:39:06,116 | INFO | copycat-p1-1 | RaftContext | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Transitioning to LEADER
2015-09-10 16:39:06,126 | INFO | copycat-p2-1 | RaftContext | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Transitioning to FOLLOWER
2015-09-10 16:39:09,202 | INFO | copycat-p3-1 | RaftContext | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Transitioning to FOLLOWER
2015-09-10 16:39:14,250 | INFO | copycat-p3-1 | FollowerState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Heartbeat timed out in 5048 milliseconds
2015-09-10 16:39:14,251 | INFO | copycat-p3-1 | FollowerState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Polling members [onos://10.128.20.12:9876, onos://10.128.20.11:9876, onos://10.128.20.13:9876]
2015-09-10 16:39:14,260 | INFO | copycat-p3-1 | FollowerState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Received accepted poll from onos://10.128.20.13:9876
2015-09-10 16:39:14,270 | INFO | copycat-p3-1 | FollowerState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Received accepted poll from onos://10.128.20.12:9876
2015-09-10 16:39:14,270 | INFO | copycat-p3-1 | RaftContext | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Transitioning to CANDIDATE
2015-09-10 16:39:14,270 | INFO | copycat-p3-1 | CandidateState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Starting election
2015-09-10 16:39:14,271 | INFO | copycat-p3-1 | CandidateState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Requesting votes from [onos://10.128.20.12:9876, onos://10.128.20.11:9876, onos://10.128.20.13:9876]
2015-09-10 16:39:14,271 | INFO | copycat-p3-1 | CandidateState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Received successful vote from onos://10.128.20.13:9876
2015-09-10 16:39:14,272 | INFO | copycat-p3-1 | CandidateState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Received successful vote from onos://10.128.20.12:9876
2015-09-10 16:39:14,272 | INFO | copycat-p3-1 | RaftContext | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Transitioning to LEADER
2015-09-10 16:39:14,273 | INFO | at-coordinator-1 | DatabaseManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Successfully initialized database.
2015-09-10 16:39:14,300 | INFO | FelixStartLevel | DatabaseManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,303 | INFO | FelixStartLevel | LogicalClockManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,340 | INFO | FelixStartLevel | ConsistentApplicationIdStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,346 | INFO | FelixStartLevel | DistributedFlowObjectiveStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,385 | INFO | FelixStartLevel | DistributedNetworkConfigStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,387 | INFO | FelixStartLevel | NetworkConfigManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,391 | INFO | FelixStartLevel | ExtraNetworkConfigs | 82 - org.onosproject.onos-incubator-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,404 | INFO | FelixStartLevel | InterfaceManager | 82 - org.onosproject.onos-incubator-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,437 | INFO | FelixStartLevel | GossipComponentConfigStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,439 | INFO | FelixStartLevel | ComponentConfigManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,455 | INFO | FelixStartLevel | ECHostStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,461 | INFO | FelixStartLevel | ConsistentIdBlockStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,820 | WARN | copycat-p0-1 | FollowerState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Rejected AppendRequest[term=1, leader=onos://10.128.20.11:9876, logIndex=1, logTerm=1, entries=[0], firstIndex=false, commitIndex=null]: Previous index (1) is greater than the local log's last index (null)
2015-09-10 16:39:14,923 | INFO | FelixStartLevel | IntentDomainManager | 82 - org.onosproject.onos-incubator-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,929 | INFO | FelixStartLevel | BasicNetworkConfigs | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:14,975 | INFO | FelixStartLevel | GossipApplicationStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:15,370 | INFO | -app-states-fg-0 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.mobility has been installed
2015-09-10 16:39:15,382 | INFO | FelixStartLevel | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-app-mobility 1.3.0-SNAPSHOT
2015-09-10 16:39:15,382 | INFO | FelixStartLevel | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-api 1.3.0-SNAPSHOT
2015-09-10 16:39:15,382 | INFO | FelixStartLevel | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr 3.0.3
2015-09-10 16:39:15,399 | INFO | FelixStartLevel | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-thirdparty-base 1.3.0-SNAPSHOT
2015-09-10 16:39:15,527 | INFO | FelixStartLevel | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-management_0_0_0 3.0.3
2015-09-10 16:39:15,529 | INFO | FelixStartLevel | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:39:15,531 | INFO | FelixStartLevel | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature webconsole-condition-scr_0_0_0 3.0.3
2015-09-10 16:39:15,533 | INFO | FelixStartLevel | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature standard-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:39:15,577 | INFO | FelixStartLevel | InstancePlugin | 160 - org.apache.karaf.webconsole.instance - 3.0.3 | Instance plugin activated
2015-09-10 16:39:15,584 | INFO | FelixStartLevel | HttpServiceFactoryImpl | 115 - org.ops4j.pax.web.pax-web-runtime - 3.1.4 | Binding bundle: [org.apache.karaf.webconsole.instance [160]] to http service
2015-09-10 16:39:15,606 | INFO | FelixStartLevel | FeaturesPlugin | 161 - org.apache.karaf.webconsole.features - 3.0.3 | Features plugin activated
2015-09-10 16:39:15,610 | INFO | FelixStartLevel | HttpServiceFactoryImpl | 115 - org.ops4j.pax.web.pax-web-runtime - 3.1.4 | Binding bundle: [org.apache.karaf.webconsole.features [161]] to http service
2015-09-10 16:39:15,639 | INFO | FelixStartLevel | GogoPlugin | 162 - org.apache.karaf.webconsole.gogo - 3.0.3 | Gogo plugin activated
2015-09-10 16:39:15,643 | INFO | FelixStartLevel | HttpServiceFactoryImpl | 115 - org.ops4j.pax.web.pax-web-runtime - 3.1.4 | Binding bundle: [org.apache.karaf.webconsole.gogo [162]] to http service
2015-09-10 16:39:15,663 | INFO | FelixStartLevel | HttpPlugin | 163 - org.apache.karaf.webconsole.http - 3.0.3 | Http plugin activated
2015-09-10 16:39:15,665 | WARN | FelixStartLevel | ServletTracker | 120 - org.ops4j.pax.web.pax-web-extender-whiteboard - 3.1.4 | Registered servlet [org.apache.karaf.webconsole.http.HttpPlugin@81b4158] did not contain a valid alias or url patterns property
2015-09-10 16:39:15,679 | INFO | FelixStartLevel | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.mobility has been activated
2015-09-10 16:39:15,692 | INFO | -app-states-fg-7 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.xosintegration has been installed
2015-09-10 16:39:15,694 | INFO | -app-states-fg-1 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.vtn has been installed
2015-09-10 16:39:15,704 | INFO | -app-states-fg-1 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.distributedprimitives has been installed
2015-09-10 16:39:15,710 | INFO | -app-states-fg-6 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.messagingperf has been installed
2015-09-10 16:39:15,718 | INFO | -app-states-fg-7 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.vtnrsc has been installed
2015-09-10 16:39:15,779 | INFO | -app-states-fg-2 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.proxyarp has been installed
2015-09-10 16:39:15,780 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-app-proxyarp 1.3.0-SNAPSHOT
2015-09-10 16:39:15,780 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-api 1.3.0-SNAPSHOT
2015-09-10 16:39:15,780 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr 3.0.3
2015-09-10 16:39:15,784 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-thirdparty-base 1.3.0-SNAPSHOT
2015-09-10 16:39:15,840 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-management_0_0_0 3.0.3
2015-09-10 16:39:15,842 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:39:15,843 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature webconsole-condition-scr_0_0_0 3.0.3
2015-09-10 16:39:15,845 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature standard-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:39:15,853 | INFO | -app-states-fg-0 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.proxyarp has been activated
2015-09-10 16:39:15,940 | INFO | -app-states-fg-2 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.election has been installed
2015-09-10 16:39:15,988 | INFO | -app-states-fg-1 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.bgprouter has been installed
2015-09-10 16:39:16,059 | INFO | -app-states-fg-7 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.fwd has been installed
2015-09-10 16:39:16,107 | INFO | -app-states-fg-1 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.dhcp has been installed
2015-09-10 16:39:16,143 | INFO | -app-states-fg-5 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.virtualbng has been installed
2015-09-10 16:39:16,199 | INFO | -app-states-fg-6 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.intentperf has been installed
2015-09-10 16:39:16,260 | INFO | -app-states-fg-0 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.ovsdb has been installed
2015-09-10 16:39:16,339 | INFO | -app-states-fg-3 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.drivers has been installed
2015-09-10 16:39:16,341 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-drivers 1.3.0-SNAPSHOT
2015-09-10 16:39:16,341 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-api 1.3.0-SNAPSHOT
2015-09-10 16:39:16,341 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr 3.0.3
2015-09-10 16:39:16,346 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-thirdparty-base 1.3.0-SNAPSHOT
2015-09-10 16:39:16,468 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-management_0_0_0 3.0.3
2015-09-10 16:39:16,470 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:39:16,471 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature webconsole-condition-scr_0_0_0 3.0.3
2015-09-10 16:39:16,473 | INFO | -app-states-fg-0 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature standard-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:39:16,481 | INFO | -app-states-fg-0 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.drivers has been activated
2015-09-10 16:39:16,653 | INFO | -app-states-fg-6 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.optical has been installed
2015-09-10 16:39:16,716 | INFO | -app-states-fg-4 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.flowanalyzer has been installed
2015-09-10 16:39:16,762 | INFO | -app-states-fg-2 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.vtnweb has been installed
2015-09-10 16:39:16,809 | INFO | -app-states-fg-6 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.cip has been installed
2015-09-10 16:39:16,839 | INFO | -app-states-fg-4 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.acl has been installed
2015-09-10 16:39:16,878 | INFO | -app-states-fg-3 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.olt has been installed
2015-09-10 16:39:16,943 | INFO | -app-states-fg-2 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.sdnip has been installed
2015-09-10 16:39:16,964 | INFO | -app-states-fg-7 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.openflow has been installed
2015-09-10 16:39:16,972 | INFO | -app-states-fg-1 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-openflow 1.3.0-SNAPSHOT
2015-09-10 16:39:16,972 | INFO | -app-states-fg-1 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-api 1.3.0-SNAPSHOT
2015-09-10 16:39:16,972 | INFO | -app-states-fg-1 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr 3.0.3
2015-09-10 16:39:16,984 | INFO | -app-states-fg-1 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-thirdparty-base 1.3.0-SNAPSHOT
2015-09-10 16:39:17,077 | INFO | -app-states-fg-1 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-management_0_0_0 3.0.3
2015-09-10 16:39:17,079 | INFO | -app-states-fg-1 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:39:17,081 | INFO | -app-states-fg-1 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature webconsole-condition-scr_0_0_0 3.0.3
2015-09-10 16:39:17,082 | INFO | -app-states-fg-1 | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature standard-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:39:17,091 | INFO | -app-states-fg-1 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.openflow has been activated
2015-09-10 16:39:17,214 | INFO | -app-states-fg-5 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.metrics has been installed
2015-09-10 16:39:17,270 | INFO | -app-states-fg-3 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.config has been installed
2015-09-10 16:39:17,277 | INFO | -app-states-fg-0 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.reactive.routing has been installed
2015-09-10 16:39:17,330 | INFO | -app-states-fg-6 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.cordfabric has been installed
2015-09-10 16:39:17,345 | INFO | -app-states-fg-2 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.null has been installed
2015-09-10 16:39:17,384 | INFO | -app-states-fg-1 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.pcep has been installed
2015-09-10 16:39:17,424 | INFO | -app-states-fg-5 | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.demo has been installed
2015-09-10 16:39:17,609 | INFO | FelixStartLevel | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.segmentrouting has been installed
2015-09-10 16:39:17,698 | INFO | FelixStartLevel | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.netconf has been installed
2015-09-10 16:39:17,744 | INFO | FelixStartLevel | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.aaa has been installed
2015-09-10 16:39:17,769 | INFO | FelixStartLevel | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:17,795 | INFO | FelixStartLevel | DistributedLeadershipManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:17,810 | INFO | FelixStartLevel | ConsistentDeviceMastershipStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,020 | INFO | FelixStartLevel | GossipIntentStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,035 | INFO | FelixStartLevel | MastershipManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,050 | INFO | FelixStartLevel | DistributedTopologyStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,052 | INFO | FelixStartLevel | TopologyManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,056 | INFO | FelixStartLevel | ReplicaInfoManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,083 | INFO | FelixStartLevel | DistributedGroupStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,093 | INFO | FelixStartLevel | DeviceClockManager | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,129 | INFO | FelixStartLevel | GossipDeviceStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,150 | INFO | FelixStartLevel | ECLinkStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,162 | INFO | FelixStartLevel | DistributedStatisticStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,180 | INFO | FelixStartLevel | DistributedPacketStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,187 | INFO | FelixStartLevel | UiExtensionManager | 158 - org.onosproject.onos-gui - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,196 | INFO | FelixStartLevel | DeviceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,197 | INFO | FelixStartLevel | PortStatisticsManager | 82 - org.onosproject.onos-incubator-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,222 | INFO | FelixStartLevel | NewDistributedFlowRuleStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started with msgHandlerPoolSize = 8; backupEnabled = true, backupPeriod = 2000
2015-09-10 16:39:18,236 | INFO | FelixStartLevel | ConsistentDeviceResourceStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,236 | INFO | FelixStartLevel | DeviceResourceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,249 | INFO | FelixStartLevel | FlowRuleManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,250 | INFO | FelixStartLevel | StatisticManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,263 | INFO | FelixStartLevel | LinkManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,271 | INFO | FelixStartLevel | ConsistentLinkResourceStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,272 | INFO | FelixStartLevel | LinkResourceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,281 | INFO | FelixStartLevel | DefaultTopologyProvider | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Configured with maxEvents = 1000; maxBatchMs = 50; maxIdleMs = 10; accumulator=true
2015-09-10 16:39:18,282 | INFO | FelixStartLevel | DefaultTopologyProvider | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,288 | INFO | FelixStartLevel | GroupManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,292 | INFO | FelixStartLevel | DriverManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,303 | INFO | nos-topo-build-0 | TopologyManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Topology DefaultTopology
changed
2015-09-10 16:39:18,311 | INFO | FelixStartLevel | DistributedMeterStore | 83 - org.onosproject.onos-incubator-store - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,313 | INFO | FelixStartLevel | MeterManager | 82 - org.onosproject.onos-incubator-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,358 | INFO | FelixStartLevel | DistributedTunnelStore | 83 - org.onosproject.onos-incubator-store - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,360 | INFO | FelixStartLevel | TunnelManager | 82 - org.onosproject.onos-incubator-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,384 | INFO | FelixStartLevel | DistributedLabelResourceStore | 83 - org.onosproject.onos-incubator-store - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,385 | INFO | FelixStartLevel | LabelResourceManager | 82 - org.onosproject.onos-incubator-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,630 | INFO | FelixStartLevel | DefaultDrivers | 165 - org.onosproject.onos-drivers - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,636 | INFO | FelixStartLevel | FlowObjectiveManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,637 | INFO | FelixStartLevel | PacketManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,639 | INFO | FelixStartLevel | EdgeManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,642 | INFO | -karaf-3.0.3/etc | fileinstall | 7 - org.apache.felix.fileinstall - 3.4.2 | Started bundle: wrap:jardir:/opt/onos/apache-karaf-3.0.3/etc/samples$Bundle-SymbolicName=samples&Bundle-Version=0.0.0
2015-09-10 16:39:18,656 | INFO | FelixStartLevel | HostManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,667 | INFO | FelixStartLevel | DistributedProxyArpStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,674 | INFO | FelixStartLevel | PathManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,688 | INFO | FelixStartLevel | ObjectiveTracker | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,691 | INFO | FelixStartLevel | IntentManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,722 | INFO | FelixStartLevel | IntentCleanup | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,733 | INFO | FelixStartLevel | ProxyArpManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,736 | INFO | FelixStartLevel | ProxyArp | 164 - org.onosproject.onos-app-proxyarp - 1.3.0.SNAPSHOT | IPv6 Neighbor Discovery is not configured, using current value of false
2015-09-10 16:39:18,771 | INFO | FelixStartLevel | ProxyArp | 164 - org.onosproject.onos-app-proxyarp - 1.3.0.SNAPSHOT | Started with Application ID 11
2015-09-10 16:39:18,774 | INFO | FelixStartLevel | HostMobility | 159 - org.onosproject.onos-app-mobility - 1.3.0.SNAPSHOT | Started with Application ID 5
2015-09-10 16:39:18,858 | INFO | FelixStartLevel | Controller | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Starting OpenFlow IO
2015-09-10 16:39:18,899 | INFO | FelixStartLevel | Controller | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Listening for switch connections on 0.0.0.0/0.0.0.0:6633
2015-09-10 16:39:18,922 | INFO | FelixStartLevel | LLDPLinkProvider | 170 - org.onosproject.onos-lldp-provider - 1.3.0.SNAPSHOT | Reading suppression rules from ../config/lldp_suppression.json
2015-09-10 16:39:18,922 | INFO | FelixStartLevel | LLDPLinkProvider | 170 - org.onosproject.onos-lldp-provider - 1.3.0.SNAPSHOT | Failed to load ../config/lldp_suppression.json, using built-in rules
2015-09-10 16:39:18,925 | INFO | FelixStartLevel | LLDPLinkProvider | 170 - org.onosproject.onos-lldp-provider - 1.3.0.SNAPSHOT | Settings: enabled=true, useBDDP=true, probeRate=3000, staleLinkAge=10000, lldpSuppression=../config/lldp_suppression.json
2015-09-10 16:39:18,925 | INFO | FelixStartLevel | LLDPLinkProvider | 170 - org.onosproject.onos-lldp-provider - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,944 | INFO | FelixStartLevel | HostLocationProvider | 171 - org.onosproject.onos-host-provider - 1.3.0.SNAPSHOT | Host removal on port/device down events is not configured, using current value of true
2015-09-10 16:39:18,944 | INFO | FelixStartLevel | HostLocationProvider | 171 - org.onosproject.onos-host-provider - 1.3.0.SNAPSHOT | Using IPv6 Neighbor Discovery is not configured, using current value of false
2015-09-10 16:39:18,947 | INFO | FelixStartLevel | HostLocationProvider | 171 - org.onosproject.onos-host-provider - 1.3.0.SNAPSHOT | Started with Application ID 38
2015-09-10 16:39:18,962 | INFO | FelixStartLevel | OpenFlowDeviceProvider | 172 - org.onosproject.onos-of-provider-device - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,970 | INFO | FelixStartLevel | OpenFlowPacketProvider | 173 - org.onosproject.onos-of-provider-packet - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:18,991 | INFO | FelixStartLevel | OpenFlowRuleProvider | 174 - org.onosproject.onos-of-provider-flow - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:19,000 | INFO | FelixStartLevel | OpenFlowGroupProvider | 175 - org.onosproject.onos-of-provider-group - 1.3.0.SNAPSHOT | Started
2015-09-10 16:39:24,928 | INFO | ew I/O worker #1 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | New switch connection from /10.128.10.11:42016
2015-09-10 16:39:24,929 | INFO | ew I/O worker #2 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | New switch connection from /10.128.10.11:42019
2015-09-10 16:39:24,946 | INFO | ew I/O worker #2 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Sending OF_13 Hello to /10.128.10.11:42019
2015-09-10 16:39:24,946 | INFO | ew I/O worker #1 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Sending OF_13 Hello to /10.128.10.11:42016
2015-09-10 16:39:24,967 | INFO | ew I/O worker #2 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Received port desc reply for switch at [/10.128.10.11:42019 DPID[00:00:00:00:00:00:00:04]]
2015-09-10 16:39:24,967 | INFO | ew I/O worker #1 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Received port desc reply for switch at [/10.128.10.11:42016 DPID[00:00:00:00:00:00:00:03]]
2015-09-10 16:39:24,982 | INFO | ew I/O worker #2 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Received switch description reply OFDescStatsReplyVer13(xid=4294967289, flags=[], mfrDesc=Nicira, Inc., hwDesc=Open vSwitch, swDesc=2.3.0, serialNum=None, dpDesc=None) from switch at /10.128.10.11:42019
2015-09-10 16:39:24,982 | INFO | ew I/O worker #1 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Received switch description reply OFDescStatsReplyVer13(xid=4294967289, flags=[], mfrDesc=Nicira, Inc., hwDesc=Open vSwitch, swDesc=2.3.0, serialNum=None, dpDesc=None) from switch at /10.128.10.11:42016
2015-09-10 16:39:24,988 | INFO | ew I/O worker #2 | Controller | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | OpenFlow handshaker found for device 4: org.onosproject.driver.handshaker.NiciraSwitchHandshaker [? DPID[00:00:00:00:00:00:00:04]]
2015-09-10 16:39:24,989 | INFO | ew I/O worker #2 | ntrollerImpl$OpenFlowSwitchAgent | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Added switch 00:00:00:00:00:00:00:04
2015-09-10 16:39:24,989 | INFO | ew I/O worker #1 | Controller | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | OpenFlow handshaker found for device 3: org.onosproject.driver.handshaker.NiciraSwitchHandshaker [? DPID[00:00:00:00:00:00:00:03]]
2015-09-10 16:39:24,989 | INFO | ew I/O worker #1 | ntrollerImpl$OpenFlowSwitchAgent | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Added switch 00:00:00:00:00:00:00:03
2015-09-10 16:39:25,019 | INFO | ew I/O worker #1 | DeviceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Local role is MASTER for of:0000000000000003
2015-09-10 16:39:25,022 | INFO | ew I/O worker #2 | DeviceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Local role is MASTER for of:0000000000000004
2015-09-10 16:39:25,031 | INFO | ew I/O worker #1 | DeviceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Device of:0000000000000003 connected
2015-09-10 16:39:25,032 | INFO | ew I/O worker #2 | DeviceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Device of:0000000000000004 connected
2015-09-10 16:39:25,033 | INFO | event-dispatch-0 | FlowObjectiveManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Driver ovs bound to device of:0000000000000003 ... initializing driver
2015-09-10 16:39:25,042 | INFO | ew I/O worker #2 | PortStatsCollector | 172 - org.onosproject.onos-of-provider-device - 1.3.0.SNAPSHOT | Starting Port Stats collection thread for 00:00:00:00:00:00:00:04
2015-09-10 16:39:25,042 | INFO | ew I/O worker #1 | PortStatsCollector | 172 - org.onosproject.onos-of-provider-device - 1.3.0.SNAPSHOT | Starting Port Stats collection thread for 00:00:00:00:00:00:00:03
2015-09-10 16:39:25,060 | INFO | ew I/O worker #2 | GroupStatsCollector | 175 - org.onosproject.onos-of-provider-group - 1.3.0.SNAPSHOT | Starting Group Stats collection thread for 00:00:00:00:00:00:00:04
2015-09-10 16:39:25,061 | INFO | ew I/O worker #1 | GroupStatsCollector | 175 - org.onosproject.onos-of-provider-group - 1.3.0.SNAPSHOT | Starting Group Stats collection thread for 00:00:00:00:00:00:00:03
2015-09-10 16:39:25,065 | INFO | ew I/O worker #2 | MeterStatsCollector | 176 - org.onosproject.onos-of-provider-meter - 1.3.0.SNAPSHOT | Starting Meter Stats collection thread for 00:00:00:00:00:00:00:04
2015-09-10 16:39:25,065 | INFO | ew I/O worker #2 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Processing 0 pending port status messages for 00:00:00:00:00:00:00:04
2015-09-10 16:39:25,066 | INFO | ew I/O worker #1 | MeterStatsCollector | 176 - org.onosproject.onos-of-provider-meter - 1.3.0.SNAPSHOT | Starting Meter Stats collection thread for 00:00:00:00:00:00:00:03
2015-09-10 16:39:25,066 | INFO | ew I/O worker #1 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Processing 0 pending port status messages for 00:00:00:00:00:00:00:03
2015-09-10 16:39:25,067 | INFO | event-dispatch-0 | LinkDiscovery | 170 - org.onosproject.onos-lldp-provider - 1.3.0.SNAPSHOT | Using BDDP to discover network
2015-09-10 16:39:25,072 | INFO | ew I/O worker #1 | ntrollerImpl$OpenFlowSwitchAgent | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Transitioned switch 00:00:00:00:00:00:00:03 to MASTER
2015-09-10 16:39:25,072 | INFO | event-dispatch-0 | FlowObjectiveManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Driver ovs bound to device of:0000000000000004 ... initializing driver
2015-09-10 16:39:25,072 | INFO | ew I/O worker #2 | ntrollerImpl$OpenFlowSwitchAgent | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Transitioned switch 00:00:00:00:00:00:00:04 to MASTER
2015-09-10 16:39:25,073 | INFO | event-dispatch-0 | LinkDiscovery | 170 - org.onosproject.onos-lldp-provider - 1.3.0.SNAPSHOT | Using BDDP to discover network
2015-09-10 16:39:25,091 | INFO | nos-topo-build-1 | TopologyManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Topology DefaultTopology
changed
2015-09-10 16:39:25,095 | INFO | nos-topo-build-2 | TopologyManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Topology DefaultTopology
changed
2015-09-10 16:39:25,096 | WARN | copycat-p2-1 | FollowerState | 71 - org.onosproject.onlab-thirdparty - 1.3.0.SNAPSHOT | onos://10.128.20.13:9876 - Rejected AppendRequest[term=1, leader=onos://10.128.20.12:9876, logIndex=1, logTerm=1, entries=[0], firstIndex=false, commitIndex=null]: Previous index (1) is greater than the local log's last index (null)
2015-09-10 16:39:28,293 | INFO | nos-topo-build-3 | DistributedTopologyStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Cluster rooted at of:0000000000000003 has 2 broadcast-points; #-489164262
2015-09-10 16:39:28,298 | INFO | nos-topo-build-3 | TopologyManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Topology DefaultTopology
changed
2015-09-10 16:42:00,461 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-app-fwd 1.3.0-SNAPSHOT
2015-09-10 16:42:00,461 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-api 1.3.0-SNAPSHOT
2015-09-10 16:42:00,461 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr 3.0.3
2015-09-10 16:42:00,466 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-thirdparty-base 1.3.0-SNAPSHOT
2015-09-10 16:42:00,513 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-management_0_0_0 3.0.3
2015-09-10 16:42:00,515 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:42:00,518 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature webconsole-condition-scr_0_0_0 3.0.3
2015-09-10 16:42:00,520 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature standard-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:42:00,550 | INFO | h for user karaf | ReactiveForwarding | 177 - org.onosproject.onos-app-fwd - 1.3.0.SNAPSHOT | Flow Timeout is not configured, default value is 10
2015-09-10 16:42:00,550 | INFO | h for user karaf | ReactiveForwarding | 177 - org.onosproject.onos-app-fwd - 1.3.0.SNAPSHOT | Flow Priority is not configured, default value is 10
2015-09-10 16:42:00,558 | INFO | h for user karaf | ReactiveForwarding | 177 - org.onosproject.onos-app-fwd - 1.3.0.SNAPSHOT | Started
2015-09-10 16:42:00,559 | INFO | h for user karaf | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.fwd has been activated
2015-09-10 16:42:03,964 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-app-dhcp 1.3.0-SNAPSHOT
2015-09-10 16:42:03,964 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-api 1.3.0-SNAPSHOT
2015-09-10 16:42:03,964 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr 3.0.3
2015-09-10 16:42:03,969 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature onos-thirdparty-base 1.3.0-SNAPSHOT
2015-09-10 16:42:04,033 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-management_0_0_0 3.0.3
2015-09-10 16:42:04,036 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature scr-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:42:04,038 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature webconsole-condition-scr_0_0_0 3.0.3
2015-09-10 16:42:04,039 | INFO | h for user karaf | FeaturesServiceImpl | 20 - org.apache.karaf.features.core - 3.0.3 | Installing feature standard-condition-webconsole_0_0_0 3.0.3
2015-09-10 16:42:04,124 | INFO | h for user karaf | DistributedDhcpStore | 178 - org.onosproject.onos-app-dhcp - 1.3.0.SNAPSHOT | Started
2015-09-10 16:42:04,136 | INFO | h for user karaf | DhcpManager | 178 - org.onosproject.onos-app-dhcp - 1.3.0.SNAPSHOT | Started
2015-09-10 16:42:04,142 | INFO | h for user karaf | DhcpUi | 178 - org.onosproject.onos-app-dhcp - 1.3.0.SNAPSHOT | Started
2015-09-10 16:42:04,388 | INFO | h for user karaf | HttpServiceFactoryImpl | 115 - org.ops4j.pax.web.pax-web-runtime - 3.1.4 | Binding bundle: [org.onosproject.onos-app-dhcp [178]] to http service
2015-09-10 16:42:04,392 | INFO | h for user karaf | ApplicationManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Application org.onosproject.dhcp has been activated
2015-09-10 16:42:04,408 | INFO | pool-8-thread-1 | WebApplicationImpl | 134 - com.sun.jersey.jersey-server - 1.19.0 | Initiating Jersey application, version 'Jersey: 1.19 02/11/2015 03:25 AM'
2015-09-10 16:42:47,968 | ERROR | ew I/O worker #1 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Error while processing message from switch org.onosproject.driver.handshaker.NiciraSwitchHandshaker [/10.128.10.11:42016 DPID[00:00:00:00:00:00:00:03]]state ACTIVE
java.lang.NullPointerException: IP Address must be specified
at com.google.common.base.Preconditions.checkNotNull(Preconditions.java:226)
at org.onosproject.dhcp.IpAssignment$Builder.validateInputs(IpAssignment.java:191)
at org.onosproject.dhcp.IpAssignment$Builder.build(IpAssignment.java:163)
at org.onosproject.dhcp.impl.DistributedDhcpStore.suggestIP(DistributedDhcpStore.java:164)
at org.onosproject.dhcp.impl.DhcpManager$DHCPPacketProcessor.processDHCPPacket(DhcpManager.java:445)
at org.onosproject.dhcp.impl.DhcpManager$DHCPPacketProcessor.process(DhcpManager.java:560)
at org.onosproject.net.packet.impl.PacketManager$InternalPacketProviderService.processPacket(PacketManager.java:284)
at org.onosproject.provider.of.packet.impl.OpenFlowPacketProvider$InternalPacketProvider.handlePacket(OpenFlowPacketProvider.java:170)
at org.onosproject.openflow.controller.impl.OpenFlowControllerImpl.processPacket(OpenFlowControllerImpl.java:282)
at org.onosproject.openflow.controller.impl.OpenFlowControllerImpl$OpenFlowSwitchAgent.processMessage(OpenFlowControllerImpl.java:606)
at org.onosproject.openflow.controller.driver.AbstractOpenFlowSwitch.handleMessage(AbstractOpenFlowSwitch.java:203)
at org.onosproject.openflow.controller.impl.OFChannelHandler.dispatchMessage(OFChannelHandler.java:1185)
at org.onosproject.openflow.controller.impl.OFChannelHandler.access$1800(OFChannelHandler.java:81)
at org.onosproject.openflow.controller.impl.OFChannelHandler$ChannelState$8.processOFPacketIn(OFChannelHandler.java:636)
at org.onosproject.openflow.controller.impl.OFChannelHandler$ChannelState.processOFMessage(OFChannelHandler.java:884)
at org.onosproject.openflow.controller.impl.OFChannelHandler.messageReceived(OFChannelHandler.java:1166)
at org.jboss.netty.handler.timeout.IdleStateAwareChannelHandler.handleUpstream(IdleStateAwareChannelHandler.java:36)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.handler.timeout.ReadTimeoutHandler.messageReceived(ReadTimeoutHandler.java:184)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.handler.timeout.IdleStateHandler.messageReceived(IdleStateHandler.java:294)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:296)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.handler.codec.frame.FrameDecoder.unfoldAndFireMessageReceived(FrameDecoder.java:462)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.handler.codec.frame.FrameDecoder.callDecode(FrameDecoder.java:443)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.handler.codec.frame.FrameDecoder.messageReceived(FrameDecoder.java:303)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:268)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:255)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.socket.nio.NioWorker.read(NioWorker.java:88)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.socket.nio.AbstractNioWorker.process(AbstractNioWorker.java:108)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:318)
at org.jboss.netty.channel.socket.nio.AbstractNioWorker.run(AbstractNioWorker.java:89)[45:org.jboss.netty:3.9.2.Final]
at org.jboss.netty.channel.socket.nio.NioWorker.run(NioWorker.java:178)[45:org.jboss.netty:3.9.2.Final]
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-09-10 16:42:47,981 | INFO | ew I/O worker #1 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Switch disconnected callback for sw:org.onosproject.driver.handshaker.NiciraSwitchHandshaker [/10.128.10.11:42016 DPID[00:00:00:00:00:00:00:03]]. Cleaning up ...
2015-09-10 16:42:47,981 | INFO | ew I/O worker #1 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | org.onosproject.driver.handshaker.NiciraSwitchHandshaker [/10.128.10.11:42016 DPID[00:00:00:00:00:00:00:03]]:removal called
2015-09-10 16:42:47,981 | INFO | ew I/O worker #1 | DeviceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Device of:0000000000000003 disconnected from this node
2015-09-10 16:42:47,999 | INFO | ew I/O worker #1 | PortStatsCollector | 172 - org.onosproject.onos-of-provider-device - 1.3.0.SNAPSHOT | Stopping Port Stats collection thread for 00:00:00:00:00:00:00:03
2015-09-10 16:42:47,999 | INFO | ew I/O worker #1 | GroupStatsCollector | 175 - org.onosproject.onos-of-provider-group - 1.3.0.SNAPSHOT | Stopping Group Stats collection thread for 00:00:00:00:00:00:00:03
2015-09-10 16:42:47,999 | INFO | ew I/O worker #1 | MeterStatsCollector | 176 - org.onosproject.onos-of-provider-meter - 1.3.0.SNAPSHOT | Stopping Meter Stats collection thread for 00:00:00:00:00:00:00:03
2015-09-10 16:42:48,013 | WARN | nager-background | DeviceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Node was instructed to be STANDBY role for of:0000000000000003, but this node cannot reach the device. Relinquishing role.
2015-09-10 16:42:48,018 | WARN | nager-background | DeviceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Node was instructed to be STANDBY role for of:0000000000000003, but this node cannot reach the device. Relinquishing role.
2015-09-10 16:42:48,021 | INFO | nos-topo-build-4 | TopologyManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Topology DefaultTopology
changed
2015-09-10 16:42:48,032 | INFO | nos-topo-build-5 | TopologyManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Topology DefaultTopology
changed
2015-09-10 16:42:48,911 | INFO | ew I/O worker #3 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | New switch connection from /10.128.10.11:42020
2015-09-10 16:42:48,911 | INFO | ew I/O worker #3 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Sending OF_13 Hello to /10.128.10.11:42020
2015-09-10 16:42:48,912 | INFO | ew I/O worker #3 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Received port desc reply for switch at [/10.128.10.11:42020 DPID[00:00:00:00:00:00:00:03]]
2015-09-10 16:42:48,913 | INFO | ew I/O worker #3 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Received switch description reply OFDescStatsReplyVer13(xid=4294967289, flags=[], mfrDesc=Nicira, Inc., hwDesc=Open vSwitch, swDesc=2.3.0, serialNum=None, dpDesc=None) from switch at /10.128.10.11:42020
2015-09-10 16:42:48,914 | INFO | ew I/O worker #3 | Controller | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | OpenFlow handshaker found for device 3: org.onosproject.driver.handshaker.NiciraSwitchHandshaker [? DPID[00:00:00:00:00:00:00:03]]
2015-09-10 16:42:48,914 | INFO | ew I/O worker #3 | ntrollerImpl$OpenFlowSwitchAgent | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Added switch 00:00:00:00:00:00:00:03
2015-09-10 16:42:50,058 | INFO | lection-thread-0 | DeviceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Local role is STANDBY for of:0000000000000003
2015-09-10 16:42:50,060 | INFO | ew I/O worker #3 | DeviceManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Device of:0000000000000003 connected
2015-09-10 16:42:50,060 | INFO | ew I/O worker #3 | PortStatsCollector | 172 - org.onosproject.onos-of-provider-device - 1.3.0.SNAPSHOT | Starting Port Stats collection thread for 00:00:00:00:00:00:00:03
2015-09-10 16:42:50,060 | INFO | ew I/O worker #3 | GroupStatsCollector | 175 - org.onosproject.onos-of-provider-group - 1.3.0.SNAPSHOT | Starting Group Stats collection thread for 00:00:00:00:00:00:00:03
2015-09-10 16:42:50,060 | INFO | ew I/O worker #3 | MeterStatsCollector | 176 - org.onosproject.onos-of-provider-meter - 1.3.0.SNAPSHOT | Starting Meter Stats collection thread for 00:00:00:00:00:00:00:03
2015-09-10 16:42:50,061 | INFO | ew I/O worker #3 | OFChannelHandler | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Processing 0 pending port status messages for 00:00:00:00:00:00:00:03
2015-09-10 16:42:50,062 | INFO | ew I/O worker #3 | ntrollerImpl$OpenFlowSwitchAgent | 169 - org.onosproject.onos-of-ctl - 1.3.0.SNAPSHOT | Transitioned switch 00:00:00:00:00:00:00:03 to EQUAL
2015-09-10 16:42:50,066 | INFO | event-dispatch-0 | FlowObjectiveManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Driver ovs bound to device of:0000000000000003 ... initializing driver
2015-09-10 16:42:50,089 | INFO | nos-topo-build-6 | TopologyManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Topology DefaultTopology
changed
2015-09-10 16:42:50,190 | INFO | nos-topo-build-7 | TopologyManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Topology DefaultTopology
changed
2015-09-10 16:42:52,894 | INFO | dcast-trees-fg-2 | DistributedTopologyStore | 79 - org.onosproject.onos-core-dist - 1.3.0.SNAPSHOT | Cluster rooted at of:0000000000000003 has 2 broadcast-points; #-489164262
2015-09-10 16:42:52,897 | INFO | nos-topo-build-0 | TopologyManager | 77 - org.onosproject.onos-core-net - 1.3.0.SNAPSHOT | Topology DefaultTopology
changed
onos>