Operating System: All
Platform: All

Attachment karaf.log has been added with description: Karaf log of install

jstack while odl-netconf-connector-ssh install is in progress.

Attachment jstack0.txt has been added with description: First jstack

jstack while odl-netconf-connector-ssh install is in progress.

Attachment jstack1.txt has been added with description: Second jstack

Specifically, this thread reveals the culprit:

java.lang.Thread.State: BLOCKED (on object monitor)
at sun.security.provider.NativePRNG$RandomIO.implGenerateSeed(NativePRNG.java:218)
waiting to lock <0x00000006c2e081a8> (a java.lang.Object)
at sun.security.provider.NativePRNG$RandomIO.access$300(NativePRNG.java:125)
at sun.security.provider.NativePRNG.engineGenerateSeed(NativePRNG.java:119)
at java.security.SecureRandom.generateSeed(SecureRandom.java:517)
at org.apache.sshd.common.random.BouncyCastleRandom.<init>(BouncyCastleRandom.java:57)
at org.apache.sshd.common.random.BouncyCastleRandom$Factory.create(BouncyCastleRandom.java:48)
at org.apache.sshd.common.random.BouncyCastleRandom$Factory.create(BouncyCastleRandom.java:41)
at org.apache.sshd.common.random.SingletonRandomFactory.<init>(SingletonRandomFactory.java:37)
at org.apache.sshd.SshBuilder$BaseBuilder.fillWithDefaultValues(SshBuilder.java:117)
at org.apache.sshd.SshBuilder$ServerBuilder.fillWithDefaultValues(SshBuilder.java:365)
at org.apache.sshd.SshBuilder$ServerBuilder.fillWithDefaultValues(SshBuilder.java:361)
at org.apache.sshd.SshBuilder$BaseBuilder.build(SshBuilder.java:234)
at org.apache.sshd.SshBuilder$BaseBuilder.build(SshBuilder.java:254)
at org.apache.sshd.SshServer.setUpDefaultServer(SshServer.java:366)
at org.opendaylight.controller.netconf.ssh.SshProxyServer.<init>(SshProxyServer.java:58)
at org.opendaylight.controller.netconf.ssh.osgi.NetconfSSHActivator.startSSHServer(NetconfSSHActivator.java:104)
at org.opendaylight.controller.netconf.ssh.osgi.NetconfSSHActivator.start(NetconfSSHActivator.java:58)
at org.eclipse.osgi.framework.internal.core.BundleContextImpl$1.run(BundleContextImpl.java:711)

NetconfSSHActivator is the activator for the netconf-ssh bundle. It is blocked trying to seed the native random number generator.

This can cause a timeout for the 01-netconf config in the ConfigPusher waiting for the odl-netconfig-client-cfg capability b/c activation of the netconf-config-dispatcher bundle is delayed.

We have experienced this only with the netconf testtool in a VM (it uses the same ssh proxy server). We have found a workaround, by disabling the Bouncycastle security provider (the default JDK one does not cause this issue) :

https://wiki.opendaylight.org/view/OpenDaylight_Controller:Netconf:Testtool#Slow_creation_of_devices_on_virtual_machines

Could you try disabling BC provider according to the link above and also removing lib/ext/bcprov-jdk15on-1.52.jar in your distribution ? Then just try again.

Can you provide the more detailed information for your environment ? Java version, OS, VM or Native etc.

(In reply to Maros Marsalek from comment #4)

The setup is a VM on OpenStack running Ubuntu 14.4.

> uname -a
Linux ssaxena-dev 3.13.0-46-generic #79-Ubuntu SMP Tue Mar 10 20:06:50 UTC 2015 x86_64 x86_64 x86_64 GNU/Linux

> lsb_release -a
No LSB modules are available.
Distributor ID: Ubuntu
Description: Ubuntu 14.04.2 LTS
Release: 14.04
Codename: trusty

> java -version
java version "1.7.0_79"
OpenJDK Runtime Environment (IcedTea 2.5.5) (7u79-2.5.5-0ubuntu0.14.04.2)
OpenJDK 64-Bit Server VM (build 24.79-b02, mixed mode)

After following the procedure you outlined, the install went much faster.

Glad to hear that the workaround helped.

Now we need to find out whats wrong with BouncyCastle, whether it affects only OpenJDK and if its linked somehow to using Ubuntu/VM.

Move to NETCONFI project.

ShaleenS is this still relevant?

Probably not. We can close this issue.

This is a very old issue. The release is no longer supported.