-
Type:
Bug
-
Status: Closed (View Workflow)
-
Priority:
Minor
-
Resolution: Won't Do
-
Affects Version/s: 1.11.0
-
Fix Version/s: None
-
Component/s: None
-
Labels:
-
Story Points:5
-
Epic Link:
I see this issue when loading VPLS configuration from file (specifically: /onos/tools/tests/topos/vpls.json).
This is inconsistent; however, I was able to catch one instance of this and attached the .log files:
- In onos-log.log, jump to timestamp: 2017-08-14 16:35:24,266
- This is at the exception occurrence.
2017-08-14 16:35:24,266 | WARN | ps-vpls-worker-0 | VplsOperationManager | 172 | Error when executing VPLS operation VplsOperation{vplsData=VplsData{name=VPLS2, interfaces=[Interface{name=h3, connectPoint=of:0000000000000003/1, ipAddresses=[], macAddress=A4:23:05:00:00:00, vlan=300, vlanUntagged=None, vlanTagged=[], vlanNative=None}, Interface{name=h4, connectPoint=of:0000000000000004/1, ipAddresses=[], macAddress=A4:23:05:00:00:00, vlan=400, vlanUntagged=None, vlanTagged=[], vlanNative=None}], encap type=VLAN, state=UPDATING}, op=ADD}, error: java.util.concurrent.ExecutionException: org.onosproject.net.intent.IntentException: MultiPointToSinglePointIntent{id=0x7, key=VPLS2-uni-of:0000000000000004-1-00:00:00:00:00:04, appId=DefaultApplicationId{id=168, name=org.onosproject.vpls}, priority=1200, resources=[], selector=DefaultTrafficSelector{criteria=[ETH_DST:00:00:00:00:00:04]}, treatment=DefaultTrafficTreatment{immediate=[NOACTION], deferred=[], transition=None, meter=None, cleared=false, metadata=null}, ingress=[of:0000000000000003/1], egress=of:0000000000000004/1, filteredIngressCPs=[FilteredConnectPoint{connectPoint=of:0000000000000003/1, trafficSelector=DefaultTrafficSelector{criteria=[VLAN_VID:300]}}], filteredEgressCP=FilteredConnectPoint{connectPoint=of:0000000000000004/1, trafficSelector=DefaultTrafficSelector{criteria=[VLAN_VID:400]}}, constraints=[PartialFailureConstraint, EncapsulationConstraint{encapType=VLAN}], resourceGroup=0xd8e799515b4ba3eb} 2017-08-14 16:35:24,454 | WARN | -intent-worker-0 | LabelAllocator | 127 | No labels for LinkKey{src=of:0000000000000003/3, dst=of:0000000000000004/2} 2017-08-14 16:35:24,458 | WARN | -intent-worker-1 | LabelAllocator | 127 | No labels for LinkKey{src=of:0000000000000004/2, dst=of:0000000000000003/3} 2017-08-14 16:35:24,462 | WARN | -intent-worker-0 | Compiling | 127 | Unable to compile intent SinglePointToMultiPointIntent{id=0x0, key=VPLS2-brc-of:0000000000000003-1-FF:FF:FF:FF:FF:FF, appId=DefaultApplicationId{id=168, name=org.onosproject.vpls}, priority=1100, resources=[], selector=DefaultTrafficSelector{criteria=[ETH_DST:FF:FF:FF:FF:FF:FF]}, treatment=DefaultTrafficTreatment{immediate=[NOACTION], deferred=[], transition=None, meter=None, cleared=false, metadata=null}, ingress=FilteredConnectPoint{connectPoint=of:0000000000000003/1, trafficSelector=DefaultTrafficSelector{criteria=[VLAN_VID:300]}}, egress=[FilteredConnectPoint{connectPoint=of:0000000000000004/1, trafficSelector=DefaultTrafficSelector{criteria=[VLAN_VID:400]}}], filteredIngressCPs=FilteredConnectPoint{connectPoint=of:0000000000000003/1, trafficSelector=DefaultTrafficSelector{criteria=[VLAN_VID:300]}}, filteredEgressCP=[FilteredConnectPoint{connectPoint=of:0000000000000004/1, trafficSelector=DefaultTrafficSelector{criteria=[VLAN_VID:400]}}], constraints=[PartialFailureConstraint, EncapsulationConstraint{encapType=VLAN}], resourceGroup=0xd8e799515b4ba3eb} due to: org.onosproject.net.intent.IntentCompilationException: No available label for of:0000000000000003/3 at org.onosproject.net.intent.impl.compiler.LinkCollectionCompiler.manageOutputPorts(LinkCollectionCompiler.java:321)[127:org.onosproject.onos-core-net:1.11.0.SNAPSHOT] at org.onosproject.net.intent.impl.compiler.LinkCollectionCompiler.manageEncapAtIngress(LinkCollectionCompiler.java:780)[127:org.onosproject.onos-core-net:1.11.0.SNAPSHOT] at org.onosproject.net.intent.impl.compiler.LinkCollectionCompiler.createForwardingInstructions(LinkCollectionCompiler.java:876)[127:org.onosproject.onos-core-net:1.11.0.SNAPSHOT] at org.onosproject.net.intent.impl.compiler.LinkCollectionCompiler.createForwardingInstruction(LinkCollectionCompiler.java:267)[127:org.onosproject.onos-core-net:1.11.0.SNAPSHOT] at org.onosproject.net.intent.impl.compiler.LinkCollectionIntentCompiler.lambda$createRules$0(LinkCollectionIntentCompiler.java:163)[127:org.onosproject.onos-core-net:1.11.0.SNAPSHOT] at java.lang.Iterable.forEach(Iterable.java:75)[:1.8.0_101] at org.onosproject.net.intent.impl.compiler.LinkCollectionIntentCompiler.createRules(LinkCollectionIntentCompiler.java:161)[127:org.onosproject.onos-core-net:1.11.0.SNAPSHOT] at org.onosproject.net.intent.impl.compiler.LinkCollectionIntentCompiler.compile(LinkCollectionIntentCompiler.java:126)[127:org.onosproject.onos-core-net:1.11.0.SNAPSHOT] at org.onosproject.net.intent.impl.compiler.LinkCollectionIntentCompiler.compile(LinkCollectionIntentCompiler.java:63)[127:org.onosproject.onos-core-net:1.11.0.SNAPSHOT] at org.onosproject.net.intent.impl.CompilerRegistry.compile(CompilerRegistry.java:91) at org.onosproject.net.intent.impl.IntentManager$InternalIntentProcessor.compile(IntentManager.java:579) at org.onosproject.net.intent.impl.phase.Compiling.execute(Compiling.java:57) at org.onosproject.net.intent.impl.phase.IntentProcessPhase.process(IntentProcessPhase.java:67) at java.util.concurrent.CompletableFuture.uniApply(CompletableFuture.java:602)[:1.8.0_101] at java.util.concurrent.CompletableFuture$UniApply.tryFire(CompletableFuture.java:577)[:1.8.0_101] at java.util.concurrent.CompletableFuture$Completion.run(CompletableFuture.java:442)[:1.8.0_101] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_101] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_101] at java.lang.Thread.run(Thread.java:745)[:1.8.0_101]
- In TestON log: VPLSBasic_14_Aug_2017_16_32_53.log, jump to timestamp: 2017-08-14 16:35:21.245027
- This is when VPLS configuration is loaded.
- Timestamp: 2017-08-14 16:35:33.488656 returns connectivity issues (note h3 <-> h4)
[2017-08-14 16:35:21.245027] [VPLSBasic] [STEP] 2.2: Load VPLS configurations 2017-08-14 16:35:21,246 - VPLSBasic - INFO - Sending: onos-netcfg 10.128.11.141 ~/onos/tools/test/topos/vpls.json 2017-08-14 16:35:21,700 - VPLSBasic - INFO - Verifying the Expected is equal to the actual or not using assert_equal 2017-08-14 16:35:21,701 - VPLSBasic - INFO - Loaded vpls configuration. 2017-08-14 16:35:21,701 - VPLSBasic - INFO - Assertion Passed 2017-08-14 16:35:31,712 - VPLSBasic - INFO - Verifying the Expected is equal to the actual or not using assert_equal 2017-08-14 16:35:31,712 - VPLSBasic - INFO - Loaded vpls configuration 2017-08-14 16:35:31,712 - VPLSBasic - INFO - Assertion Passed
...
[2017-08-14 16:35:33.488656] [VPLSBasic] [STEP] 2.6: Check connectivity ... 2017-08-14 16:35:41,292 - VPLSBasic - INFO - Sending: h3 ping h4 -c 1 -i 1 -W 1 [93m2017-08-14 16:35:42,434 - VPLSBasic - WARNING - Mininet1: PACKET LOST, HOST IS NOT REACHABLE[0m [91m2017-08-14 16:35:42,434 - VPLSBasic - ERROR - h3 <-> h4: 0; Expected: 1[0m