[NETCONF-416] karaf 4 odl-restconf feature fails to install for second time Created: 03/May/17  Updated: 15/Mar/19  Resolved: 09/May/17

Status: Verified
Project: netconf
Component/s: restconf-nb
Affects Version/s: None
Fix Version/s: None

Type: Bug
Reporter: Luis Gomez Assignee: Andrej Mak
Resolution: Done Votes: 0
Labels: None
Remaining Estimate: Not Specified
Time Spent: Not Specified
Original Estimate: Not Specified
Environment:

Operating System: All
Platform: All

Issue Links:
Blocks
is blocked by AAA-126 Unable to start blueprint container f... Verified
External issue ID: 8364

 Description   

To reproduce just grab karaf 4 distro here:

install odl-restconf feature:

feature:install odl-restconf

install a second time:

feature:install odl-restconf

Now you get the following:

2017-05-03 11:09:10,281 | ERROR | nfig-blank-txn-0 | ConfigTransactionControllerImpl | 183 - org.opendaylight.controller.config-manager - 0.6.0.SNAPSHOT | Commit failed on ModuleIdentifier

{factoryName='rest-connector-impl', instanceName='rest-connector-default-impl'} in transaction TransactionIdentifier{name='ConfigTransaction-46-47'}
java.lang.NullPointerException
at org.osgi.util.tracker.ServiceTracker.<init>(ServiceTracker.java:184)[org.osgi.core-6.0.0.jar:]
at org.osgi.util.tracker.ServiceTracker.<init>(ServiceTracker.java:247)[org.osgi.core-6.0.0.jar:]
at org.opendaylight.controller.config.api.osgi.WaitingServiceTracker.create(WaitingServiceTracker.java:67)
at org.opendaylight.controller.config.yang.md.sal.rest.connector.RestConnectorModule.createInstance(RestConnectorModule.java:40)
at org.opendaylight.controller.config.spi.AbstractModule.getInstance(AbstractModule.java:87)
at sun.reflect.GeneratedMethodAccessor53.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)[:1.8.0_91]
at java.lang.reflect.Method.invoke(Method.java:498)[:1.8.0_91]
at org.opendaylight.controller.config.manager.impl.dependencyresolver.DependencyResolverManager$ModuleInvocationHandler.handleInvocation(DependencyResolverManager.java:148)
at com.google.common.reflect.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:87)
at com.sun.proxy.$Proxy89.getInstance(Unknown Source)
at org.opendaylight.controller.config.manager.impl.ConfigTransactionControllerImpl.secondPhaseCommit(ConfigTransactionControllerImpl.java:439)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.secondPhaseCommit(ConfigRegistryImpl.java:347)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.commitConfigSafe(ConfigRegistryImpl.java:288)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.commitConfig(ConfigRegistryImpl.java:253)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.osgi.BlankTransactionServiceTracker.lambda$new$0(BlankTransactionServiceTracker.java:42)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.osgi.BlankTransactionServiceTracker.blankTransactionSync(BlankTransactionServiceTracker.java:75)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_91]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_91]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_91]
2017-05-03 11:09:10,307 | ERROR | nfig-blank-txn-0 | ConfigRegistryImpl | 183 - org.opendaylight.controller.config-manager - 0.6.0.SNAPSHOT | Configuration Transaction failed on 2PC, server is unhealthy
java.lang.IllegalStateException: Error - getInstance() failed for ModuleIdentifier{factoryName='rest-connector-impl', instanceName='rest-connector-default-impl'}

in transaction TransactionIdentifier

{name='ConfigTransaction-46-47'}

at org.opendaylight.controller.config.manager.impl.ConfigTransactionControllerImpl.secondPhaseCommit(ConfigTransactionControllerImpl.java:446)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.secondPhaseCommit(ConfigRegistryImpl.java:347)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.commitConfigSafe(ConfigRegistryImpl.java:288)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.commitConfig(ConfigRegistryImpl.java:253)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.osgi.BlankTransactionServiceTracker.lambda$new$0(BlankTransactionServiceTracker.java:42)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.osgi.BlankTransactionServiceTracker.blankTransactionSync(BlankTransactionServiceTracker.java:75)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_91]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_91]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_91]
Caused by: java.lang.NullPointerException
at org.osgi.util.tracker.ServiceTracker.<init>(ServiceTracker.java:184)[org.osgi.core-6.0.0.jar:]
at org.osgi.util.tracker.ServiceTracker.<init>(ServiceTracker.java:247)[org.osgi.core-6.0.0.jar:]
at org.opendaylight.controller.config.api.osgi.WaitingServiceTracker.create(WaitingServiceTracker.java:67)
at org.opendaylight.controller.config.yang.md.sal.rest.connector.RestConnectorModule.createInstance(RestConnectorModule.java:40)
at org.opendaylight.controller.config.spi.AbstractModule.getInstance(AbstractModule.java:87)
at sun.reflect.GeneratedMethodAccessor53.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)[:1.8.0_91]
at java.lang.reflect.Method.invoke(Method.java:498)[:1.8.0_91]
at org.opendaylight.controller.config.manager.impl.dependencyresolver.DependencyResolverManager$ModuleInvocationHandler.handleInvocation(DependencyResolverManager.java:148)
at com.google.common.reflect.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:87)
at com.sun.proxy.$Proxy89.getInstance(Unknown Source)
at org.opendaylight.controller.config.manager.impl.ConfigTransactionControllerImpl.secondPhaseCommit(ConfigTransactionControllerImpl.java:439)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
... 8 more
2017-05-03 11:09:10,376 | ERROR | nfig-blank-txn-1 | ConfigTransactionControllerImpl | 183 - org.opendaylight.controller.config-manager - 0.6.0.SNAPSHOT | Commit failed on ModuleIdentifier

{factoryName='rest-connector-impl', instanceName='rest-connector-default-impl'} in transaction TransactionIdentifier{name='ConfigTransaction-46-48'}
java.lang.NullPointerException
at org.osgi.util.tracker.ServiceTracker.<init>(ServiceTracker.java:184)[org.osgi.core-6.0.0.jar:]
at org.osgi.util.tracker.ServiceTracker.<init>(ServiceTracker.java:247)[org.osgi.core-6.0.0.jar:]
at org.opendaylight.controller.config.api.osgi.WaitingServiceTracker.create(WaitingServiceTracker.java:67)
at org.opendaylight.controller.config.yang.md.sal.rest.connector.RestConnectorModule.createInstance(RestConnectorModule.java:40)
at org.opendaylight.controller.config.spi.AbstractModule.getInstance(AbstractModule.java:87)
at sun.reflect.GeneratedMethodAccessor53.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)[:1.8.0_91]
at java.lang.reflect.Method.invoke(Method.java:498)[:1.8.0_91]
at org.opendaylight.controller.config.manager.impl.dependencyresolver.DependencyResolverManager$ModuleInvocationHandler.handleInvocation(DependencyResolverManager.java:148)
at com.google.common.reflect.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:87)
at com.sun.proxy.$Proxy89.getInstance(Unknown Source)
at org.opendaylight.controller.config.manager.impl.ConfigTransactionControllerImpl.secondPhaseCommit(ConfigTransactionControllerImpl.java:439)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.secondPhaseCommit(ConfigRegistryImpl.java:347)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.commitConfigSafe(ConfigRegistryImpl.java:288)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.commitConfig(ConfigRegistryImpl.java:253)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.osgi.BlankTransactionServiceTracker.lambda$new$0(BlankTransactionServiceTracker.java:42)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.osgi.BlankTransactionServiceTracker.blankTransactionSync(BlankTransactionServiceTracker.java:75)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_91]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_91]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_91]
2017-05-03 11:09:10,385 | ERROR | nfig-blank-txn-1 | ConfigRegistryImpl | 183 - org.opendaylight.controller.config-manager - 0.6.0.SNAPSHOT | Configuration Transaction failed on 2PC, server is unhealthy
java.lang.IllegalStateException: Error - getInstance() failed for ModuleIdentifier{factoryName='rest-connector-impl', instanceName='rest-connector-default-impl'}

in transaction TransactionIdentifier

{name='ConfigTransaction-46-48'}

at org.opendaylight.controller.config.manager.impl.ConfigTransactionControllerImpl.secondPhaseCommit(ConfigTransactionControllerImpl.java:446)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.secondPhaseCommit(ConfigRegistryImpl.java:347)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.commitConfigSafe(ConfigRegistryImpl.java:288)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.ConfigRegistryImpl.commitConfig(ConfigRegistryImpl.java:253)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.osgi.BlankTransactionServiceTracker.lambda$new$0(BlankTransactionServiceTracker.java:42)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at org.opendaylight.controller.config.manager.impl.osgi.BlankTransactionServiceTracker.blankTransactionSync(BlankTransactionServiceTracker.java:75)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_91]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_91]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_91]
Caused by: java.lang.NullPointerException
at org.osgi.util.tracker.ServiceTracker.<init>(ServiceTracker.java:184)[org.osgi.core-6.0.0.jar:]
at org.osgi.util.tracker.ServiceTracker.<init>(ServiceTracker.java:247)[org.osgi.core-6.0.0.jar:]
at org.opendaylight.controller.config.api.osgi.WaitingServiceTracker.create(WaitingServiceTracker.java:67)
at org.opendaylight.controller.config.yang.md.sal.rest.connector.RestConnectorModule.createInstance(RestConnectorModule.java:40)
at org.opendaylight.controller.config.spi.AbstractModule.getInstance(AbstractModule.java:87)
at sun.reflect.GeneratedMethodAccessor53.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)[:1.8.0_91]
at java.lang.reflect.Method.invoke(Method.java:498)[:1.8.0_91]
at org.opendaylight.controller.config.manager.impl.dependencyresolver.DependencyResolverManager$ModuleInvocationHandler.handleInvocation(DependencyResolverManager.java:148)
at com.google.common.reflect.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:87)
at com.sun.proxy.$Proxy89.getInstance(Unknown Source)
at org.opendaylight.controller.config.manager.impl.ConfigTransactionControllerImpl.secondPhaseCommit(ConfigTransactionControllerImpl.java:439)[183:org.opendaylight.controller.config-manager:0.6.0.SNAPSHOT]
... 8 more

 Comments   
Comment by Luis Gomez [ 03/May/17 ]

forgot to add link for karaf 4 distro:

https://nexus.opendaylight.org/content/repositories/opendaylight.snapshot/org/opendaylight/integration/karaf/0.6.0-SNAPSHOT/

Comment by Ivan Hrasko [ 04/May/17 ]

second installation probably cause to fail aaa:

2017-05-04 14:13:27,606 | ERROR | rint Extender: 3 | BlueprintContainerImpl | 11 - org.apache.aries.blueprint.core - 1.7.1 | Unable to start blueprint container for bundle org.opendaylight.aaa.idmlight/0.5.0.SNAPSHOT due to unresolved dependencies [(objectClass=org.opendaylight.aaa.api.IIDMStore)]
java.util.concurrent.TimeoutException
at org.apache.aries.blueprint.container.BlueprintContainerImpl$1.run(BlueprintContainerImpl.java:371)[11:org.apache.aries.blueprint.core:1.7.1]
at org.apache.aries.blueprint.utils.threading.impl.DiscardableRunnable.run(DiscardableRunnable.java:48)[11:org.apache.aries.blueprint.core:1.7.1]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)[:1.8.0_121]
at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_121]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)[:1.8.0_121]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)[:1.8.0_121]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_121]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_121]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]

Comment by Ivan Hrasko [ 04/May/17 ]

Blocked by 8373

Comment by Ivan Hrasko [ 05/May/17 ]

patch:
https://git.opendaylight.org/gerrit/#/c/56582/

Comment by Ivan Hrasko [ 09/May/17 ]

I have verified that problem was fixed.

Comment by Luis Gomez [ 09/May/17 ]

Thanks for fixing this.

Generated at Wed Feb 07 20:14:58 UTC 2024 using Jira 8.20.10#820010-sha1:ace47f9899e9ee25d7157d59aa17ab06aee30d3d.