Loading...

Type: Bug
Resolution: Done
Priority: Highest
Fix Version/s: Nitrogen
Affects Version/s: None
Component/s: General
Labels:
None

ODL doesn't establish the thrift connection with qbgp which causes ODL can't be configured as BGP server and not able proceed with BGP peer with Quagga VM and datapath testing.

Version: ppa:odl-team/nitrogen

Here are the error logs:

karaf log:

java.lang.InterruptedException: sleep interrupted

at java.lang.Thread.sleep(Native Method)[:1.8.0_151]

at org.opendaylight.netvirt.bgpmanager.RetryOnException.waitUntilNextTry(RetryOnException.java:74)[295:org.opendaylight.netvirt.bgpmanager-impl:0.5.0]

at org.opendaylight.netvirt.bgpmanager.RetryOnException.errorOccured(RetryOnException.java:47)[295:org.opendaylight.netvirt.bgpmanager-impl:0.5.0]

at org.opendaylight.netvirt.bgpmanager.thrift.client.BgpRouter.connect(BgpRouter.java:162)[295:org.opendaylight.netvirt.bgpmanager-impl:0.5.0]

at org.opendaylight.netvirt.bgpmanager.BgpConfigurationManager.lambda$bgpRestarted$2(BgpConfigurationManager.java:1585)[295:org.opendaylight.netvirt.bgpmanager-impl:0.5.0]

at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)[:1.8.0_151]

at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_151]

at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)[:1.8.0_151]

at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)[:1.8.0_151]

at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)[:1.8.0_151]

at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)[:1.8.0_151]

at java.lang.Thread.run(Thread.java:748)[:1.8.0_151]

2018-01-29 11:16:52,835 | ERROR | eChangeHandler-0 | BgpConfigurationManager | 295 - org.opendaylight.netvirt.bgpmanager-impl - 0.5.0 | received bgp add asid AsId{getLocalAs=100, getRouterId=IpAddress [_ipv4Address=Ipv4Address [_value=172.29.239.65]], getStalepathTime=0, isAnnounceFbit=false, augmentations={}}

2018-01-29 11:17:58,015 | INFO | eChangeHandler-0 | IdManager | 229 - org.opendaylight.genius.idmanager-impl - 0.3.0 | Got pool IdLocalPool [poolName=elan.ids.pool.2130706689, availableIds=AvailableIdHolder [low=5000, high=5499, cur=5000], releasedIds=ReleasedIdHolder [availableIdCount=0, timeDelaySec=30, delayedEntries=[]]]

further info:

root@controller00-neutron-server-container-e75c1444:~# netstat -a | grep 7644

tcp 0 0 :7644 *: LISTEN

root@controller00-neutron-server-container-e75c1444:~# cat /opt/quagga/etc/bgpd.conf

hostname bgpd

password sdncbgpc

service advanced-vty

log stdout

line vty

exec-timeout 0 0

debug bgp

debug bgp updates

debug bgp events

root@controller00-neutron-server-container-e75c1444:/opt/quagga/var/log/quagga# cat zrpcd.init.log

2018/01/29 11:16:34 ZRPC: Can't fopen pid lock file /opt/quagga/var/run/quagga/bgpd.pid (2), continuing

2018/01/29 11:16:34 ZRPC: bgpUpdater check connection with 0.0.0.0:6644 OK

2018/01/29 11:16:34 ZRPC: zrpcd starting: zrpc@<all>:7644 pid 7920

2018/01/29 11:16:34 ZRPC: zrpc_accept : new connection (fd 11) from 127.0.0.1:39310

- (process:7920): WARNING **: error reading start of message: failed to read 4 bytes - Resource temporarily unavailable

2018/01/29 11:16:36 ZRPC: zrpcd_read_packet: close connection (fd 11)

2018/01/29 11:16:36 ZRPC: zrpc_accept : new connection (fd 11) from 127.0.0.1:39318

2018/01/29 11:16:45 ZRPC: zrpc_accept : new connection (fd 12) from 127.0.0.1:39366

2018/01/29 11:16:45 ZRPC: zrpc_accept : a new connection from same src IP. Ignoring it (fd 11)

- (process:7920): WARNING **: error reading start of message: failed to read 4 bytes - Resource temporarily unavailable

2018/01/29 11:16:45 ZRPC: zrpcd_read_packet: close connection (fd 12)

- (process:7920): WARNING **: error reading start of message: failed to read 4 bytes - Resource temporarily unavailable

2018/01/29 11:16:51 ZRPC: zrpcd_read_packet: close connection (fd 11)

root@controller00-neutron-server-container-e75c1444:/opt/quagga/var/log/quagga# curl -s -u admin:admin -X GET http://172.29.236.11:8180/restconf/config/ebgp:bgp

{"bgp":{"config-server":

{"host":"127.0.0.1","port":7644}

,"as-id":{"announce-fbit":false,"router-id":"172.29.239.65","local-as":100,"stalepath-time":0}}}root@controller00-neutron-server-container-e75c1444:/opt/quagga/var/log/quagga#

root@controller00-neutron-server-container-e75c1444:/opt/quagga/var/log/quagga# ssh karaf@localhost -p8101

Password authentication

Password:

_______ ________ . . ._ __

____ \ ______ ____ ____ _____ \ ____ ___..| | || ____ | |_/ |

     /   |
____ _/ __ \ /    \ |    |
__ \<   | || | | |/ ___| | \   __\

/ | \ |> > ___/| | | ` \/ __
___ || || / /_/ > Y \ |

______ / __/ _ >_| /_____ (__ / ____||__/_ /|_| /_|

\/|_| \/ \/ \/ \/\/ /____/ \/

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 OpenDaylight.

opendaylight-user@root>display-bgp-config --debug

is ODL Connected to Q-BGP: FALSE

ODL BGP Router transport is open: FALSE

Last ODL connection attempt TS: Mon Jan 29 11:16:51 UTC 2018

Last Successful connection TS: Mon Jan 29 11:16:36 UTC 2018

Last ODL started BGP at: Thu Jan 01 00:00:00 UTC 1970

Last Quagga BGP, sent reSync at: Mon Jan 29 11:16:34 UTC 2018

Time taken to create stale fib : 0 ms

Time taken to create replay configuration : 0 ms

Time taken for Stale FIB cleanup : 0 ms

Total stale entries created 0

Total stale entries cleared 0

Mon Jan 29 11:15:05 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=bgp}] amIOwner:false hasOwner:false

Mon Jan 29 11:15:05 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=bgp}] amIOwner:true hasOwner:true

Mon Jan 29 11:15:08 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=interface_config}] amIOwner:false hasOwner:false

Mon Jan 29 11:15:08 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=interface_config}] amIOwner:true hasOwner:true

Mon Jan 29 11:15:08 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=interface_service_binding}] amIOwner:true hasOwner:true

Mon Jan 29 11:15:09 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=netvirt-acl}] amIOwner:false hasOwner:false

Mon Jan 29 11:15:09 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=netvirt-acl}] amIOwner:true hasOwner:true

Mon Jan 29 11:15:09 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=elan}] amIOwner:false hasOwner:false

Mon Jan 29 11:15:09 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=elan}] amIOwner:true hasOwner:true

Mon Jan 29 11:15:11 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=arpmonitoring}] amIOwner:false hasOwner:false

Mon Jan 29 11:15:11 UTC 2018 entity : /(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)entity/entity[\{(urn:opendaylight:params:xml:ns:yang:controller:md:sal:core:general-entity?revision=2015-08-20)name=arpmonitoring}] amIOwner:true hasOwner:true

Configuration Server

Host 127.0.0.1

Port 7644

BGP Router

AS-Number 100

Router-ID 172.29.239.65

Stale-Path-Time default

F-bit ON

opendaylight-user@root>

Details

Description

Attachments

Activity

People

Dates