[OPNFLWPLUG-148] OSGi errors after connecting mininet to the controller Created: 02/May/14 Updated: 27/Sep/21 Due: 24/Oct/14 Resolved: 08/Sep/14 |
|
| Status: | Resolved |
| Project: | OpenFlowPlugin |
| Component/s: | General |
| Affects Version/s: | None |
| Fix Version/s: | None |
| Type: | Bug | ||
| Reporter: | Madhusudhan Ananderi | Assignee: | Luis Gomez |
| Resolution: | Done | Votes: | 0 |
| Labels: | None | ||
| Remaining Estimate: | Not Specified | ||
| Time Spent: | Not Specified | ||
| Original Estimate: | Not Specified | ||
| Environment: |
Operating System: Windows |
||
| External issue ID: | 947 |
| Description |
|
1. Download the latest controller base edition: 2. Run the controller - ./run.sh -of13 -Xms1G 3. Start the mininet (of10): sudo mn --topo tree,2 --controller 'remote,ip=127.0.0.1,port=6633' --switch ovsk,protocols=OpenFlow10 2014-05-02 13:58:56.209 PDT [pool-13-thread-1] WARN o.o.c.m.s.manager.StatisticsProvider - Attempted to start already-existing handler for Uri [_value=openflow:1], very strange ]}] -------------------------------------------------------------------------------- 1. Download the latest controller base edition: 2. Run the controller - ./run.sh -of13 -Xms1G 3. Start the mininet (of10): sudo mn --topo tree,2 --controller 'remote,ip=127.0.0.1,port=6633' [Note: This can be reproduced one time after you start the fresh controller and mininet(of10). If you restart the mininet(of10) again without shutting the controller, the error cannot be seen] 2014-05-02 12:06:01.452 PDT [nioEventLoopGroup-12-4] INFO o.o.o.p.i.c.PublishingChannelInitializer - Incoming connection accepted - building pipeline |
| Comments |
| Comment by Luis Gomez [ 03/May/14 ] |
|
The second ERROR I always see the first time you start mininet after controller startup. It is happening for both of10 and of13 simulation: sudo mn --topo tree,2 --controller 'remote,ip=127.0.0.1,port=6633' sudo mn --topo tree,2 --controller 'remote,ip=127.0.0.1,port=6633' --switch ovsk,protocols=OpenFlow13 |
| Comment by Michal Rehak [ 05/May/14 ] |
| Comment by Luis Gomez [ 07/May/14 ] |
|
Today, it is not that is not fixed, it gives even more errors: osgi> 2014-05-06 04:22:24.171 PDT [nioEventLoopGroup-11-1] INFO o.o.o.p.i.c.PublishingChannelInitializer - Incoming connection from (remote address): /127.0.0.1:38005 --> :6633 ] failed for Tx:DOM-31 ] failed for Tx:DOM-35 |
| Comment by Michal Rehak [ 13/May/14 ] |
|
please verify |
| Comment by Luis Gomez [ 13/May/14 ] |
|
I am still getting a lot of warnings and errors when starting mininet OF13 simulation. Using latest build for base edition: 1) After controller starts, first time I do: sudo mn --controller 'remote,ip=127.0.0.1,port=6633' --topo tree,2 --switch ovsk,protocols=OpenFlow13 osgi> 2014-05-10 21:27:35.020 PDT [nioEventLoopGroup-10-1] INFO o.o.o.p.i.c.PublishingChannelInitializer - Incoming connection from (remote address): /127.0.0.1:43093 --> :6633 ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)software ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)software ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)software ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)table[ {(urn:opendaylight:flow:inventory?revision=2013-08-19)id=72}]/(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics ]/AugmentationIdentifier {childNames=[(urn:opendaylight:flow:inventory?revision=2013-08-19)description, (urn:opendaylight:flow:inventory?revision=2013-08-19)group, (urn:opendaylight:flow:inventory?revision=2013-08-19)hardware, (urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer, (urn:opendaylight:flow:inventory?revision=2013-08-19)meter, (urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number, (urn:opendaylight:flow:inventory?revision=2013-08-19)software, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-instructions, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-match-types, (urn:opendaylight:flow:inventory?revision=2013-08-19)switch-features, (urn:opendaylight:flow:inventory?revision=2013-08-19)table]}/(urn:opendaylight:flow:inventory?revision=2013-08-19)table/(urn:opendaylight:flow:inventory?revision=2013-08-19)table[ {(urn:opendaylight:flow:inventory?revision=2013-08-19)id=72}]/(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics=ImmutableContainerNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics, value=[ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)active-flows, value=0, attributes={}}, ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)packets-matched, value=0, attributes={}}, ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)packets-looked-up, value=0, attributes={}}], attributes={}}, omitting it 2) Next time I do: sudo mn --controller 'remote,ip=127.0.0.1,port=6633' --topo tree,2 --switch ovsk,protocols=OpenFlow13 osgi> 2014-05-10 21:30:46.986 PDT [nioEventLoopGroup-10-5] INFO o.o.o.p.i.c.PublishingChannelInitializer - Incoming connection from (remote address): /127.0.0.1:43120 --> :6633 ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)software ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)software ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)software ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions |
| Comment by Luis Gomez [ 13/May/14 ] |
|
And even more errors when starting OF10 mininet simulation: 1) After restart first time I do: sudo mn --controller 'remote,ip=127.0.0.1,port=6633' --topo tree,2 osgi> 2014-05-10 21:39:15.118 PDT [nioEventLoopGroup-12-1] INFO o.o.o.p.i.c.PublishingChannelInitializer - Incoming connection from (remote address): /127.0.0.1:43168 --> :6633 ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)software ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-instructions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-match-types ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)software ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-instructions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-match-types ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)software ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-instructions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-match-types ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)table[ {(urn:opendaylight:flow:inventory?revision=2013-08-19)id=3}]/(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics ]/AugmentationIdentifier {childNames=[(urn:opendaylight:flow:inventory?revision=2013-08-19)description, (urn:opendaylight:flow:inventory?revision=2013-08-19)group, (urn:opendaylight:flow:inventory?revision=2013-08-19)hardware, (urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer, (urn:opendaylight:flow:inventory?revision=2013-08-19)meter, (urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number, (urn:opendaylight:flow:inventory?revision=2013-08-19)software, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-instructions, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-match-types, (urn:opendaylight:flow:inventory?revision=2013-08-19)switch-features, (urn:opendaylight:flow:inventory?revision=2013-08-19)table]}/(urn:opendaylight:flow:inventory?revision=2013-08-19)table/(urn:opendaylight:flow:inventory?revision=2013-08-19)table[ {(urn:opendaylight:flow:inventory?revision=2013-08-19)id=3}]/(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics=ImmutableContainerNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics, value=[ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)active-flows, value=0, attributes={}}, ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)packets-matched, value=0, attributes={}}, ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)packets-looked-up, value=0, attributes={}}], attributes={}}, omitting it 2) Next time I do: sudo mn --controller 'remote,ip=127.0.0.1,port=6633' --topo tree,2 osgi> 2014-05-10 21:45:24.076 PDT [nioEventLoopGroup-12-5] INFO o.o.o.p.i.c.PublishingChannelInitializer - Incoming connection from (remote address): /127.0.0.1:43208 --> :6633 ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)software ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-instructions ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)supported-match-types ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)description ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)hardware ]/... |
| Comment by Abhijit Kumbhare [ 14/May/14 ] |
|
Michal's fix has been merged yesterday: https://git.opendaylight.org/gerrit/#/c/6725/ Please verify again. |
| Comment by Luis Gomez [ 15/May/14 ] |
|
This is not fixed yet, I still get many warnings and errors when I connect mininet. Users do not like to see errors when they try our controller even if these errors are not impacting the functionality. BR/Luis |
| Comment by Michal Rehak [ 20/May/14 ] |
|
Please retest. The last exception referring to InterruptedException was fixed in BUG-995. |
| Comment by Luis Gomez [ 30/May/14 ] |
|
This is the latest and yes, I do not see InterruptException anymore: osgi> 2014-05-30 01:11:07.419 PDT [nioEventLoopGroup-9-1] INFO o.o.o.p.i.c.PublishingChannelInitializer - Incoming connection from (remote address): /127.0.0.1:42578 --> :6633 ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)table[ {(urn:opendaylight:flow:inventory?revision=2013-08-19)id=242}]/(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics ]/AugmentationIdentifier {childNames=[(urn:opendaylight:flow:inventory?revision=2013-08-19)description, (urn:opendaylight:flow:inventory?revision=2013-08-19)group, (urn:opendaylight:flow:inventory?revision=2013-08-19)hardware, (urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer, (urn:opendaylight:flow:inventory?revision=2013-08-19)meter, (urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number, (urn:opendaylight:flow:inventory?revision=2013-08-19)software, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-instructions, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-match-types, (urn:opendaylight:flow:inventory?revision=2013-08-19)switch-features, (urn:opendaylight:flow:inventory?revision=2013-08-19)table]}/(urn:opendaylight:flow:inventory?revision=2013-08-19)table/(urn:opendaylight:flow:inventory?revision=2013-08-19)table[ {(urn:opendaylight:flow:inventory?revision=2013-08-19)id=242}]/AugmentationIdentifier {childNames=[(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics]}=ImmutableAugmentationNode{nodeIdentifier=AugmentationIdentifier {childNames=[(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics]}, value=[ImmutableContainerNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics, value=[ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)active-flows, value=0, attributes={}}, ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)packets-matched, value=0, attributes={}}, ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)packets-looked-up, value=0, attributes={}}], attributes={}}]}, omitting it ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)table[ {(urn:opendaylight:flow:inventory?revision=2013-08-19)id=41}]/(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics ]/AugmentationIdentifier {childNames=[(urn:opendaylight:flow:inventory?revision=2013-08-19)description, (urn:opendaylight:flow:inventory?revision=2013-08-19)group, (urn:opendaylight:flow:inventory?revision=2013-08-19)hardware, (urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer, (urn:opendaylight:flow:inventory?revision=2013-08-19)meter, (urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number, (urn:opendaylight:flow:inventory?revision=2013-08-19)software, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-instructions, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-match-types, (urn:opendaylight:flow:inventory?revision=2013-08-19)switch-features, (urn:opendaylight:flow:inventory?revision=2013-08-19)table]}/(urn:opendaylight:flow:inventory?revision=2013-08-19)table/(urn:opendaylight:flow:inventory?revision=2013-08-19)table[ {(urn:opendaylight:flow:inventory?revision=2013-08-19)id=41}]/AugmentationIdentifier {childNames=[(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics]}=ImmutableAugmentationNode{nodeIdentifier=AugmentationIdentifier {childNames=[(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics]}, value=[ImmutableContainerNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics, value=[ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)active-flows, value=0, attributes={}}, ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)packets-matched, value=0, attributes={}}, ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)packets-looked-up, value=0, attributes={}}], attributes={}}]}, omitting it ]/(urn:opendaylight:flow:inventory?revision=2013-08-19)table[ {(urn:opendaylight:flow:inventory?revision=2013-08-19)id=46}]/(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics ]/AugmentationIdentifier {childNames=[(urn:opendaylight:flow:inventory?revision=2013-08-19)description, (urn:opendaylight:flow:inventory?revision=2013-08-19)group, (urn:opendaylight:flow:inventory?revision=2013-08-19)hardware, (urn:opendaylight:flow:inventory?revision=2013-08-19)manufacturer, (urn:opendaylight:flow:inventory?revision=2013-08-19)meter, (urn:opendaylight:flow:inventory?revision=2013-08-19)serial-number, (urn:opendaylight:flow:inventory?revision=2013-08-19)software, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-actions, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-instructions, (urn:opendaylight:flow:inventory?revision=2013-08-19)supported-match-types, (urn:opendaylight:flow:inventory?revision=2013-08-19)switch-features, (urn:opendaylight:flow:inventory?revision=2013-08-19)table]}/(urn:opendaylight:flow:inventory?revision=2013-08-19)table/(urn:opendaylight:flow:inventory?revision=2013-08-19)table[ {(urn:opendaylight:flow:inventory?revision=2013-08-19)id=46}]/AugmentationIdentifier {childNames=[(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics]}=ImmutableAugmentationNode{nodeIdentifier=AugmentationIdentifier {childNames=[(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics]}, value=[ImmutableContainerNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)flow-table-statistics, value=[ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)active-flows, value=0, attributes={}}, ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)packets-matched, value=0, attributes={}}, ImmutableLeafNode{nodeIdentifier=(urn:opendaylight:flow:table:statistics?revision=2013-12-15)packets-looked-up, value=0, attributes={}}], attributes={}}]}, omitting it |
| Comment by Abhijit Kumbhare [ 12/Aug/14 ] |
|
Luis, Changed the bug title to be more general "OSGI errors" rather than the earlier more specific "Two different OSGI errors" - as a catch-all. If you do not like this bug title - you can close this bug about specific errors - and create one for general console errors which prevent the user from understanding what's happening. I am adding a Trello action item under "To do - day to day actions". For now assigning it to Michal - but we can talk during the meeting and reassign it. Abhijit |
| Comment by Luis Gomez [ 13/Aug/14 ] |
|
This one has already improved a lot, I only see one RPC error in the beginning: osgi> 2014-08-08 09:02:05.862 PDT [nioEventLoopGroup-12-1] INFO o.o.o.p.i.c.PublishingChannelInitializer - Incoming connection from (remote address): /127.0.0.1:38531 --> :6633 |
| Comment by Michal Rehak [ 25/Aug/14 ] |
|
The rpc related exception has been changed to warning with explanation that sending hello during handshake failed because of disconnection. Could you retest, please? |
| Comment by Luis Gomez [ 08/Sep/14 ] |
|
Yes, this is much better now. I can close this bug. |