You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@sling.apache.org by Lisa Davidson <ll...@redhat.com> on 2020/09/08 17:14:03 UTC

Deployment exception

Hi there,

We are not able to deploy successfully due to the following exceptions. Any
suggestions on how to fix this?

15:55:15.212 INFO [features-3-thread-1] Bundling of nodes enabled
15:55:15.321 INFO [features-3-thread-1] registerNodeStore: server time
difference: 26901ms (max allowed: 2000ms)
15:55:15.322 ERROR [features-3-thread-1] bundle
org.apache.jackrabbit.oak-store-document:1.26.0
(79)[org.apache.jackrabbit.oak.plugins.document.DocumentNodeStoreService(76)]
: The activate method has thrown an exception
java.lang.AssertionError: Server clock seems off (26901ms) by more than
configured amount (2000ms)
        at
org.apache.jackrabbit.oak.plugins.document.DocumentNodeStoreService.registerNodeStore(DocumentNodeStoreService.java:383)
~[?:?]
        at
org.apache.jackrabbit.oak.plugins.document.DocumentNodeStoreService.registerNodeStoreIfPossible(DocumentNodeStoreService.java:249)
~[?:?]
        at
org.apache.jackrabbit.oak.plugins.document.DocumentNodeStoreService.activate(DocumentNodeStoreService.java:233)
~[?:?]
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
~[?:1.8.0_262]
        at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
~[?:1.8.0_262]
        at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
~[?:1.8.0_262]
        at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_262]
        at
org.apache.felix.scr.impl.inject.methods.BaseMethod.invokeMethod(BaseMethod.java:228)
~[?:?]
        at
org.apache.felix.scr.impl.inject.methods.BaseMethod.access$500(BaseMethod.java:41)
~[?:?]
        at
org.apache.felix.scr.impl.inject.methods.BaseMethod$Resolved.invoke(BaseMethod.java:664)
~[?:?]
        at
org.apache.felix.scr.impl.inject.methods.BaseMethod.invoke(BaseMethod.java:510)
~[?:?]
        at
org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMethod.java:317)
~[?:?]
        at
org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMethod.java:307)
~[?:?]
        at
org.apache.felix.scr.impl.manager.SingleComponentManager.createImplementationObject(SingleComponentManager.java:340)
~[?:?]
        at
org.apache.felix.scr.impl.manager.SingleComponentManager.createComponent(SingleComponentManager.java:114)
~[?:?]
        at
org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleComponentManager.java:982)
~[?:?]
        at
org.apache.felix.scr.impl.manager.SingleComponentManager.getServiceInternal(SingleComponentManager.java:955)
~[?:?]
        at
org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(AbstractComponentManager.java:765)
~[?:?]
        at
org.apache.felix.scr.impl.manager.AbstractComponentManager.enableInternal(AbstractComponentManager.java:666)
~[?:?]
        at
org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractComponentManager.java:432)
~[?:?]
        at
org.apache.felix.scr.impl.manager.ConfigurableComponentHolder.enableComponents(ConfigurableComponentHolder.java:665)
~[?:?]
        at
org.apache.felix.scr.impl.BundleComponentActivator.initialEnable(BundleComponentActivator.java:338)
~[?:?]
        at
org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:382)
~[?:?]
        at
org.apache.felix.scr.impl.Activator.access$200(Activator.java:49) ~[?:?]
        at
org.apache.felix.scr.impl.Activator$ScrExtension.start(Activator.java:264)
~[?:?]
        at
org.apache.felix.scr.impl.AbstractExtender.createExtension(AbstractExtender.java:196)
~[?:?]
        at
org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.java:169)
~[?:?]
        at
org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.java:49)
~[?:?]
        at
org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:482)
~[osgi.core-6.0.0.jar:?]
        at
org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker.java:415)
~[osgi.core-6.0.0.jar:?]
        at
org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:232)
~[osgi.core-6.0.0.jar:?]
        at
org.osgi.util.tracker.BundleTracker$Tracked.bundleChanged(BundleTracker.java:444)
~[osgi.core-6.0.0.jar:?]
        at
org.apache.felix.framework.EventDispatcher.invokeBundleListenerCallback(EventDispatcher.java:915)
~[?:?]
        at
org.apache.felix.framework.EventDispatcher.fireEventImmediately(EventDispatcher.java:834)
~[?:?]
        at
org.apache.felix.framework.EventDispatcher.fireBundleEvent(EventDispatcher.java:516)
~[?:?]
        at
org.apache.felix.framework.Felix.fireBundleEvent(Felix.java:4579) ~[?:?]
        at org.apache.felix.framework.Felix.startBundle(Felix.java:2174)
~[?:?]
        at org.apache.felix.framework.BundleImpl.start(BundleImpl.java:998)
~[?:?]
        at org.apache.felix.framework.BundleImpl.start(BundleImpl.java:984)
~[?:?]
        at
org.apache.karaf.features.internal.service.BundleInstallSupportImpl.startBundle(BundleInstallSupportImpl.java:165)
~[?:?]
        at
org.apache.karaf.features.internal.service.FeaturesServiceImpl.startBundle(FeaturesServiceImpl.java:1153)
~[?:?]
        at
org.apache.karaf.features.internal.service.Deployer.deploy(Deployer.java:1036)
~[?:?]
        at
org.apache.karaf.features.internal.service.FeaturesServiceImpl.doProvision(FeaturesServiceImpl.java:1062)
~[?:?]
        at
org.apache.karaf.features.internal.service.FeaturesServiceImpl.lambda$doProvisionInThread$13(FeaturesServiceImpl.java:998)
~[?:?]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[?:1.8.0_262]
        at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[?:1.8.0_262]
        at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[?:1.8.0_262]
        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_262]


-- 
Lisa Davidson, RHCE
Sr. Software Engineer
Red Hat, Inc.

Re: Deployment exception

Posted by Bertrand Delacretaz <bd...@apache.org>.
Hi,

On Tue, Sep 8, 2020 at 7:14 PM Lisa Davidson <ll...@redhat.com> wrote:
> ...15:55:15.321 INFO [features-3-thread-1] registerNodeStore: server time
> difference: 26901ms (max allowed: 2000ms) ...

FWIW, https://issues.apache.org/jira/browse/OAK-2682 explains the need
to check those time differences.

The tolerance can be set using
-Doak.documentMK.maxServerTimeDiffMillis and a value of -1 apparently
disables the check.

The corresponding Oak source code is at
https://github.com/apache/jackrabbit-oak/blob/trunk/oak-store-document/src/main/java/org/apache/jackrabbit/oak/plugins/document/DocumentNodeStoreService.java

-Bertrand

Re: Deployment exception

Posted by Oliver Lietz <ap...@oliverlietz.de>.
On Tuesday, September 8, 2020 7:14:03 PM CEST Lisa Davidson wrote:
> Hi there,

Hi Lisa,

> We are not able to deploy successfully due to the following exceptions. Any
> suggestions on how to fix this?
> 
> 15:55:15.212 INFO [features-3-thread-1] Bundling of nodes enabled
> 15:55:15.321 INFO [features-3-thread-1] registerNodeStore: server time
> difference: 26901ms (max allowed: 2000ms)

Use ntpd¹ or chronyd² to fix your systems' time.

Regards,
O.

1) https://www.freebsd.org/doc/handbook/network-ntp.html
2) https://chrony.tuxfamily.org/


> 15:55:15.322 ERROR [features-3-thread-1] bundle
> org.apache.jackrabbit.oak-store-document:1.26.0
> (79)[org.apache.jackrabbit.oak.plugins.document.DocumentNodeStoreService(76)
> ]
> : The activate method has thrown an exception
> 
> java.lang.AssertionError: Server clock seems off (26901ms) by more than
> configured amount (2000ms)
>         at
> org.apache.jackrabbit.oak.plugins.document.DocumentNodeStoreService.register
> NodeStore(DocumentNodeStoreService.java:383) ~[?:?]
>         at
> org.apache.jackrabbit.oak.plugins.document.DocumentNodeStoreService.register
> NodeStoreIfPossible(DocumentNodeStoreService.java:249) ~[?:?]
>         at
> org.apache.jackrabbit.oak.plugins.document.DocumentNodeStoreService.activate
> (DocumentNodeStoreService.java:233) ~[?:?]
>         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> ~[?:1.8.0_262]
>         at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62
> ) ~[?:1.8.0_262]
>         at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl
> .java:43) ~[?:1.8.0_262]
>         at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_262]
>         at
> org.apache.felix.scr.impl.inject.methods.BaseMethod.invokeMethod(BaseMethod.
> java:228) ~[?:?]
>         at
> org.apache.felix.scr.impl.inject.methods.BaseMethod.access$500(BaseMethod.ja
> va:41) ~[?:?]
>         at
> org.apache.felix.scr.impl.inject.methods.BaseMethod$Resolved.invoke(BaseMeth
> od.java:664) ~[?:?]
>         at
> org.apache.felix.scr.impl.inject.methods.BaseMethod.invoke(BaseMethod.java:5
> 10) ~[?:?]
>         at
> org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMetho
> d.java:317) ~[?:?]
>         at
> org.apache.felix.scr.impl.inject.methods.ActivateMethod.invoke(ActivateMetho
> d.java:307) ~[?:?]
>         at
> org.apache.felix.scr.impl.manager.SingleComponentManager.createImplementatio
> nObject(SingleComponentManager.java:340) ~[?:?]
>         at
> org.apache.felix.scr.impl.manager.SingleComponentManager.createComponent(Sin
> gleComponentManager.java:114) ~[?:?]
>         at
> org.apache.felix.scr.impl.manager.SingleComponentManager.getService(SingleCo
> mponentManager.java:982) ~[?:?]
>         at
> org.apache.felix.scr.impl.manager.SingleComponentManager.getServiceInternal(
> SingleComponentManager.java:955) ~[?:?]
>         at
> org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInternal(
> AbstractComponentManager.java:765) ~[?:?]
>         at
> org.apache.felix.scr.impl.manager.AbstractComponentManager.enableInternal(Ab
> stractComponentManager.java:666) ~[?:?]
>         at
> org.apache.felix.scr.impl.manager.AbstractComponentManager.enable(AbstractCo
> mponentManager.java:432) ~[?:?]
>         at
> org.apache.felix.scr.impl.manager.ConfigurableComponentHolder.enableComponen
> ts(ConfigurableComponentHolder.java:665) ~[?:?]
>         at
> org.apache.felix.scr.impl.BundleComponentActivator.initialEnable(BundleCompo
> nentActivator.java:338) ~[?:?]
>         at
> org.apache.felix.scr.impl.Activator.loadComponents(Activator.java:382)
> ~[?:?]
>         at
> org.apache.felix.scr.impl.Activator.access$200(Activator.java:49) ~[?:?]
>         at
> org.apache.felix.scr.impl.Activator$ScrExtension.start(Activator.java:264)
> ~[?:?]
>         at
> org.apache.felix.scr.impl.AbstractExtender.createExtension(AbstractExtender.
> java:196) ~[?:?]
>         at
> org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.j
> ava:169) ~[?:?]
>         at
> org.apache.felix.scr.impl.AbstractExtender.modifiedBundle(AbstractExtender.j
> ava:49) ~[?:?]
>         at
> org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker
> .java:482) ~[osgi.core-6.0.0.jar:?]
>         at
> org.osgi.util.tracker.BundleTracker$Tracked.customizerModified(BundleTracker
> .java:415) ~[osgi.core-6.0.0.jar:?]
>         at
> org.osgi.util.tracker.AbstractTracked.track(AbstractTracked.java:232)
> ~[osgi.core-6.0.0.jar:?]
>         at
> org.osgi.util.tracker.BundleTracker$Tracked.bundleChanged(BundleTracker.java
> :444) ~[osgi.core-6.0.0.jar:?]
>         at
> org.apache.felix.framework.EventDispatcher.invokeBundleListenerCallback(Even
> tDispatcher.java:915) ~[?:?]
>         at
> org.apache.felix.framework.EventDispatcher.fireEventImmediately(EventDispatc
> her.java:834) ~[?:?]
>         at
> org.apache.felix.framework.EventDispatcher.fireBundleEvent(EventDispatcher.j
> ava:516) ~[?:?]
>         at
> org.apache.felix.framework.Felix.fireBundleEvent(Felix.java:4579) ~[?:?]
>         at org.apache.felix.framework.Felix.startBundle(Felix.java:2174)
> ~[?:?]
>         at org.apache.felix.framework.BundleImpl.start(BundleImpl.java:998)
> ~[?:?]
>         at org.apache.felix.framework.BundleImpl.start(BundleImpl.java:984)
> ~[?:?]
>         at
> org.apache.karaf.features.internal.service.BundleInstallSupportImpl.startBun
> dle(BundleInstallSupportImpl.java:165) ~[?:?]
>         at
> org.apache.karaf.features.internal.service.FeaturesServiceImpl.startBundle(F
> eaturesServiceImpl.java:1153) ~[?:?]
>         at
> org.apache.karaf.features.internal.service.Deployer.deploy(Deployer.java:103
> 6) ~[?:?]
>         at
> org.apache.karaf.features.internal.service.FeaturesServiceImpl.doProvision(F
> eaturesServiceImpl.java:1062) ~[?:?]
>         at
> org.apache.karaf.features.internal.service.FeaturesServiceImpl.lambda$doProv
> isionInThread$13(FeaturesServiceImpl.java:998) ~[?:?]
>         at java.util.concurrent.FutureTask.run(FutureTask.java:266)
> [?:1.8.0_262]
>         at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:11
> 49) [?:1.8.0_262]
>         at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:6
> 24) [?:1.8.0_262]
>         at java.lang.Thread.run(Thread.java:748) [?:1.8.0_262]