Uploaded image for project: 'netconf'
  1. netconf
  2. NETCONF-324

Carbon clustered topology fails in -all- jobs

    XMLWordPrintable

Details

    • Bug
    • Status: Resolved
    • Resolution: Done
    • None
    • None
    • netconf
    • None

    • Operating System: All
      Platform: All

    • 7255

    Description

      Cluster netconf jobs are configuring a connection towards a testtool device.
      While only jobs are passing [0] when checking whether device has been connected to; in recent Carbon snapshot all jobs, the same check fails [1].
      "Mount point already exists" is printed to karaf.log but a previous test case [2] has not seen the device connected.

      Here is the segment of karaf.log related to the failing test case:

      2016-11-26 02:01:30,891 | INFO | h for user karaf | command | 46 - org.apache.karaf.log.command - 3.0.8 | ROBOT MESSAGE: Starting test Wait_For_Device_To_Become_Visible_For_Configurer
      2016-11-26 02:01:31,633 | INFO | sing-executor-12 | NetconfDevice | 345 - org.opendaylight.netconf.sal-netconf-connector - 1.5.0.SNAPSHOT | RemoteDevice

      {netconf-test-device}: Netconf connector initialized successfully
      2016-11-26 02:01:31,856 | INFO | ult-dispatcher-6 | NetconfTopologyContext | 526 - org.opendaylight.netconf.topology-singleton - 1.2.0.SNAPSHOT | Master was selected: IpAddress [_ipv4Address=Ipv4Address [_value=10.29.13.13]]
      2016-11-26 02:01:31,858 | INFO | ult-dispatcher-6 | RemoteDeviceConnectorImpl | 526 - org.opendaylight.netconf.topology-singleton - 1.2.0.SNAPSHOT | RemoteDevice{netconf-test-device}

      : Concurrent rpc limit is smaller than 1, no limit will be enforced.
      2016-11-26 02:01:31,862 | INFO | 5]-nio2-thread-2 | ClientSessionImpl | 30 - org.apache.sshd.core - 0.14.0 | Client session created
      2016-11-26 02:01:31,864 | INFO | 5]-nio2-thread-2 | ClientSessionImpl | 30 - org.apache.sshd.core - 0.14.0 | Start flagging packets as pending until key exchange is done
      2016-11-26 02:01:31,864 | INFO | 5]-nio2-thread-2 | ClientSessionImpl | 30 - org.apache.sshd.core - 0.14.0 | Server version string: SSH-2.0-SSHD-CORE-0.14.0
      2016-11-26 02:01:31,914 | WARN | 5]-nio2-thread-8 | AcceptAllServerKeyVerifier | 30 - org.apache.sshd.core - 0.14.0 | Server at /10.29.13.13:17830 presented unverified DSA key: ec:32:46:a5:df:86:59:84:d9:21:14:b2:55:a1:21:f3
      2016-11-26 02:01:31,916 | INFO | 5]-nio2-thread-1 | ClientSessionImpl | 30 - org.apache.sshd.core - 0.14.0 | Dequeing pending packets
      2016-11-26 02:01:31,917 | INFO | 5]-nio2-thread-3 | ClientUserAuthServiceNew | 30 - org.apache.sshd.core - 0.14.0 | Received SSH_MSG_USERAUTH_FAILURE
      2016-11-26 02:01:31,918 | INFO | 5]-nio2-thread-5 | UserAuthKeyboardInteractive | 30 - org.apache.sshd.core - 0.14.0 | Received Password authentication en-US
      2016-11-26 02:01:31,919 | INFO | 5]-nio2-thread-7 | ClientUserAuthServiceNew | 30 - org.apache.sshd.core - 0.14.0 | Received SSH_MSG_USERAUTH_SUCCESS
      2016-11-26 02:01:32,143 | INFO | ssing-executor-6 | MasterSalFacade | 526 - org.opendaylight.netconf.topology-singleton - 1.2.0.SNAPSHOT | RemoteDevice

      {netconf-test-device}: Creating master data broker for device
      2016-11-26 02:01:32,143 | ERROR | ssing-executor-6 | NetconfDevice | 345 - org.opendaylight.netconf.sal-netconf-connector - 1.5.0.SNAPSHOT | RemoteDevice{netconf-test-device}

      : Initialization in sal failed, disconnecting from device
      java.lang.IllegalStateException: Mount point already exists
      at com.google.common.base.Preconditions.checkState(Preconditions.java:173)[65:com.google.guava:18.0.0]
      at org.opendaylight.controller.md.sal.dom.broker.impl.mount.DOMMountPointServiceImpl.createMountPoint(DOMMountPointServiceImpl.java:41)[167:org.opendaylight.controller.sal-broker-impl:1.5.0.SNAPSHOT]
      at Proxyb755215f_d895_4b8e_a8f1_449a5deeba4f.createMountPoint(Unknown Source)[:]
      at org.opendaylight.controller.sal.dom.broker.osgi.DOMMountPointServiceProxy.createMountPoint(DOMMountPointServiceProxy.java:33)[167:org.opendaylight.controller.sal-broker-impl:1.5.0.SNAPSHOT]
      at org.opendaylight.netconf.sal.connect.netconf.sal.NetconfDeviceSalProvider$MountInstance.onTopologyDeviceConnected(NetconfDeviceSalProvider.java:140)[345:org.opendaylight.netconf.sal-netconf-connector:1.5.0.SNAPSHOT]
      at org.opendaylight.netconf.topology.singleton.impl.MasterSalFacade.registerMasterMountPoint(MasterSalFacade.java:141)[526:org.opendaylight.netconf.topology-singleton:1.2.0.SNAPSHOT]
      at org.opendaylight.netconf.topology.singleton.impl.MasterSalFacade.onDeviceConnected(MasterSalFacade.java:87)[526:org.opendaylight.netconf.topology-singleton:1.2.0.SNAPSHOT]
      at org.opendaylight.netconf.topology.singleton.impl.MasterSalFacade.onDeviceConnected(MasterSalFacade.java:43)[526:org.opendaylight.netconf.topology-singleton:1.2.0.SNAPSHOT]
      at org.opendaylight.netconf.sal.connect.netconf.NetconfDevice.handleSalInitializationSuccess(NetconfDevice.java:217)[345:org.opendaylight.netconf.sal-netconf-connector:1.5.0.SNAPSHOT]
      at org.opendaylight.netconf.sal.connect.netconf.NetconfDevice$SchemaSetup.setUpSchema(NetconfDevice.java:465)[345:org.opendaylight.netconf.sal-netconf-connector:1.5.0.SNAPSHOT]
      at org.opendaylight.netconf.sal.connect.netconf.NetconfDevice$SchemaSetup.run(NetconfDevice.java:430)[345:org.opendaylight.netconf.sal-netconf-connector:1.5.0.SNAPSHOT]
      at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)[:1.8.0_111]
      at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_111]
      at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)[:1.8.0_111]
      at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_111]
      at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)[:1.8.0_111]
      at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)[:1.8.0_111]
      at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_111]
      at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_111]
      at java.lang.Thread.run(Thread.java:745)[:1.8.0_111]
      2016-11-26 02:01:32,144 | WARN | ssing-executor-6 | NetconfDeviceCommunicator | 345 - org.opendaylight.netconf.sal-netconf-connector - 1.5.0.SNAPSHOT | RemoteDevice

      {netconf-test-device}

      : Session terminated Session closed
      2016-11-26 02:01:41,776 | INFO | h for user karaf | command | 46 - org.apache.karaf.log.command - 3.0.8 | ROBOT MESSAGE: Starting test Wait_For_Device_To_Become_Visible_For_Checker

      [0] https://logs.opendaylight.org/releng/jenkins092/netconf-csit-3node-clustering-only-carbon/279/archives/log.html.gz#s1-s2-t5-k2-k1-k2-k2
      [1] https://logs.opendaylight.org/releng/jenkins092/netconf-csit-3node-clustering-all-carbon/106/archives/log.html.gz#s1-s2-t5-k2-k1-k1-k2
      [2] https://logs.opendaylight.org/releng/jenkins092/netconf-csit-3node-clustering-all-carbon/106/archives/log.html.gz#s1-s2-t2-k2-k1-k1-k1-k4-k1

      Attachments

        Issue Links

          is duplicated by

          Bug - A problem which impairs or prevents the functions of the product. NETCONF-326 NPE when accessing a mount point from a different node

          • Resolved
          No reviews matched the request. Check your Options in the drop-down menu of this sections header.

          Activity

            People

              Unassigned Unassigned
              vrpolak Vratko Polak
              Votes:
              0 Vote for this issue
              Watchers:
              2 Start watching this issue

              Dates

                Created:
                Updated:
                Resolved: