Site not starting during Hippo 13 upgrade deployment

Experience Manager (PaaS/OnPrem)
1

Hi team!

I’m facing an issue trying to achieve the upgrade to version 13. Project is working locally and on TST env but is not working on ACC (env similar to production). CMS and console are working but site gives the following error:

15.05.2020 16:23:07 [http-nio-8080-exec-25] ERROR [org.hippoecm.hst.container.HstFilter.doFilter():47] The HST Container Services are not initialized yet.
15.05.2020 16:23:07 [http-nio-8080-exec-43] ERROR [org.hippoecm.hst.container.HstFilter.doFilter():47] The HST Container Services are not initialized yet.

image

site.war is failing to start:

15.05.2020 16:08:50 [localhost-startStop-1] ERROR [org.hippoecm.hst.site.container.DefaultHstSiteConfigurer.initializeComponentManager():264] HstSiteConfigurer: ComponentManager initialization failed.
org.hippoecm.hst.platform.model.ModelRegistrationException: Cannot create HstModelRegistryImpl
	at org.hippoecm.hst.platform.model.HstModelRegistryImpl.registerHstModel(HstModelRegistryImpl.java:141) ~[?:?]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_222]
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_222]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_222]
	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_222]
	at org.onehippo.cms7.services.ProxiedServiceHolder.lambda$new$0(ProxiedServiceHolder.java:68) ~[hippo-services-13.4.2.jar:13.4.2]
	at com.sun.proxy.$Proxy108.registerHstModel(Unknown Source) ~[?:?]
	at org.hippoecm.hst.site.container.DefaultHstSiteConfigurer.initializeComponentManager(DefaultHstSiteConfigurer.java:258) [hst-core-13.4.2.jar:13.4.2]
	at org.hippoecm.hst.site.container.DefaultHstSiteConfigurer.initialize(DefaultHstSiteConfigurer.java:208) [hst-core-13.4.2.jar:13.4.2]
	at org.hippoecm.hst.site.container.HstContextLoaderListener.configureHstSite(HstContextLoaderListener.java:105) [hst-core-13.4.2.jar:13.4.2]
	at org.hippoecm.hst.site.container.HstContextLoaderListener$1.serviceRegistered(HstContextLoaderListener.java:82) [hst-core-13.4.2.jar:13.4.2]
	at org.onehippo.cms7.services.HippoServiceRegistry.addTracker(HippoServiceRegistry.java:223) [hippo-services-13.4.2.jar:13.4.2]
	at org.hippoecm.hst.site.container.HstContextLoaderListener.initialize(HstContextLoaderListener.java:90) [hst-core-13.4.2.jar:13.4.2]
	at org.hippoecm.hst.site.container.HstContextLoaderListener.contextInitialized(HstContextLoaderListener.java:63) [hst-core-13.4.2.jar:13.4.2]
	at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4745) [catalina.jar:8.5.24]
	at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5207) [catalina.jar:8.5.24]
	at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150) [catalina.jar:8.5.24]
	at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:752) [catalina.jar:8.5.24]
	at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:728) [catalina.jar:8.5.24]
	at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:734) [catalina.jar:8.5.24]
	at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:986) [catalina.jar:8.5.24]
	at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1857) [catalina.jar:8.5.24]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_222]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_222]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_222]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_222]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_222]
Caused by: org.hippoecm.hst.core.jcr.RuntimeRepositoryException: javax.jcr.nodetype.ConstraintViolationException: no matching property definition found for {http://www.jcp.org/jcr/1.0}isCheckedOut
	at org.hippoecm.hst.provider.jcr.JCRValueProviderImpl.populate(JCRValueProviderImpl.java:633) ~[hst-content-beans-13.4.2.jar:13.4.2]
	at org.hippoecm.hst.provider.jcr.JCRValueProviderImpl.<init>(JCRValueProviderImpl.java:115) ~[hst-content-beans-13.4.2.jar:13.4.2]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeImpl.<init>(HstNodeImpl.java:76) ~[?:?]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeImpl.loadChildren(HstNodeImpl.java:92) ~[?:?]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeImpl.<init>(HstNodeImpl.java:78) ~[?:?]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeImpl.loadChildren(HstNodeImpl.java:92) ~[?:?]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeImpl.<init>(HstNodeImpl.java:78) ~[?:?]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeLoadingCache.getNode(HstNodeLoadingCache.java:92) ~[?:?]
	at org.hippoecm.hst.platform.model.HstModelRegistryImpl.loadHstConfigNodes(HstModelRegistryImpl.java:189) ~[?:?]
	at org.hippoecm.hst.platform.model.HstModelRegistryImpl.registerHstModel(HstModelRegistryImpl.java:126) ~[?:?]
	... 26 more
Caused by: javax.jcr.nodetype.ConstraintViolationException: no matching property definition found for {http://www.jcp.org/jcr/1.0}isCheckedOut
	at org.apache.jackrabbit.core.nodetype.EffectiveNodeType.getApplicablePropertyDef(EffectiveNodeType.java:782) ~[jackrabbit-core-2.18.3-h2.jar:2.18.3-h2]
	at org.apache.jackrabbit.core.NodeImpl.getApplicablePropertyDefinition(NodeImpl.java:843) ~[jackrabbit-core-2.18.3-h2.jar:2.18.3-h2]
	at org.apache.jackrabbit.core.ItemManager.getDefinition(ItemManager.java:255) ~[jackrabbit-core-2.18.3-h2.jar:2.18.3-h2]
	at org.apache.jackrabbit.core.ItemData.getDefinition(ItemData.java:103) ~[jackrabbit-core-2.18.3-h2.jar:2.18.3-h2]
	at org.apache.jackrabbit.core.PropertyData.getPropertyDefinition(PropertyData.java:55) ~[jackrabbit-core-2.18.3-h2.jar:2.18.3-h2]
	at org.apache.jackrabbit.core.PropertyImpl.getDefinition(PropertyImpl.java:857) ~[jackrabbit-core-2.18.3-h2.jar:2.18.3-h2]
	at org.hippoecm.repository.impl.PropertyDecorator.getDefinition(PropertyDecorator.java:145) ~[hippo-repository-engine-13.4.2.jar:13.4.2]
	at org.hippoecm.hst.provider.jcr.JCRValueProviderImpl.populate(JCRValueProviderImpl.java:629) ~[hst-content-beans-13.4.2.jar:13.4.2]
	at org.hippoecm.hst.provider.jcr.JCRValueProviderImpl.<init>(JCRValueProviderImpl.java:115) ~[hst-content-beans-13.4.2.jar:13.4.2]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeImpl.<init>(HstNodeImpl.java:76) ~[?:?]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeImpl.loadChildren(HstNodeImpl.java:92) ~[?:?]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeImpl.<init>(HstNodeImpl.java:78) ~[?:?]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeImpl.loadChildren(HstNodeImpl.java:92) ~[?:?]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeImpl.<init>(HstNodeImpl.java:78) ~[?:?]
	at org.hippoecm.hst.platform.configuration.cache.HstNodeLoadingCache.getNode(HstNodeLoadingCache.java:92) ~[?:?]
	at org.hippoecm.hst.platform.model.HstModelRegistryImpl.loadHstConfigNodes(HstModelRegistryImpl.java:189) ~[?:?]
	at org.hippoecm.hst.platform.model.HstModelRegistryImpl.registerHstModel(HstModelRegistryImpl.java:126) ~[?:?]
	... 26 more

Thanks in advance

2

Hi Alvaro,
We had contact earlier but also for others: this is about the presence of a property “jcr:isCheckedOut” on an HST configuration node, for which no definition exists.

When upgrading to 13, a migrator class runs, removing the mixin “mix:versionable” hence the property “jcrisCheckedOut” as well. It is paramount that the class runs on a single node so any cluster must be stopped beforehand, only then restarted for the upgrade.

You can follow the progress of the migrator class by setting INFO log level to class org.hippoecm.repository.MigrateToV13 in log4j2.xml before starting.

HTH
Jeroen

3

That was the problem!. We thought that it was, but we aren’t stopped properly all our nodes before deployment!

Thanks for you support!
Best regards.