[ovirt-users] Upgrade to 4.0.1 failed with NPE on org.postgresql.jdbc.TypeInfoCache.getSQLType

Fabrice Bacchella fabrice.bacchella at icloud.com
Wed Aug 3 10:56:12 UTC 2016


Just a little investigation show :

# lsof -p <enginepid> | grep postgresql-jdbc.jar
java    2138 ovirt  mem       REG                8,2    486139 18729421 /usr/share/java/postgresql-jdbc.jar

rpm -qf /usr/share/java/postgresql-jdbc.jar
postgresql-jdbc-9.4.1208-1.rhel7.noarch

rpm -qi postgresql-jdbc-9.4.1208-1.rhel7.noarch
...
URL         : https://jdbc.postgresql.org/

And indeed I needed to install pgdg-94-centos.repo, my note says the package was needed by ovirt, I don't remember why. And indeed :
yum erase postgresql94-server
...
Removing:
 postgresql94-server                                                                  x86_64                                     9.4.8-1PGDG.rhel7                                                            @pgdg94                                         17 M
Removing for dependencies:
 ovirt-engine                                                                         noarch                                     4.0.1.1-1.el7.centos                                                         @ovirt-4.0                                     2.6 M
 ovirt-engine-backend                                                                 noarch                                     4.0.1.1-1.el7.centos                                                         @ovirt-4.0                                      13 M

So I tried:

yum downgrade postgresql-jdbc
...
---> Package postgresql-jdbc.noarch 0:9.2.1002-5.el7 will be a downgrade
...

And now it (almost) works. I have other not linked problems that needs more investigations.


> Le 3 août 2016 à 12:39, Martin Perina <mperina at redhat.com> a écrit :
> 
> Hi,
> 
> what is the version of postgresql-jdbc package are you using? I saw this error only with latest postgresql-jdbc drivers 9.4-1209, but those are not packaged in RPMs AFAIK.
> 
> Thanks
> 
> Martin Perina
> 
> 
> On Wed, Aug 3, 2016 at 12:31 PM, Fabrice Bacchella <fabrice.bacchella at icloud.com <mailto:fabrice.bacchella at icloud.com>> wrote:
> I'm running on Centos 7, just upgraded to ovirt 4.01 using the procedure given in the release notes.
> 
> But now I'm getting that in /var/log/ovirt-engine/engine.log:
> 
> 2016-08-03 12:04:39,751 ERROR [org.ovirt.engine.core.bll.Backend] (ServerService Thread Pool -- 54) [] Error during initialization: org.jboss.weld.exceptions.WeldException: WELD-000049: Unable to invoke private void org.ovirt.engine.core.vds
> broker.ResourceManager.init() on org.ovirt.engine.core.vdsbroker.ResourceManager at 28b87a8e
>        at org.jboss.weld.injection.producer.DefaultLifecycleCallbackInvoker.invokeMethods(DefaultLifecycleCallbackInvoker.java:100) [weld-core-impl-2.3.2.Final.jar:2.3.2.Final]
>        at org.jboss.weld.injection.producer.DefaultLifecycleCallbackInvoker.postConstruct(DefaultLifecycleCallbackInvoker.java:81) [weld-core-impl-2.3.2.Final.jar:2.3.2.Final]
>        at org.jboss.weld.injection.producer.BasicInjectionTarget.postConstruct(BasicInjectionTarget.java:126) [weld-core-impl-2.3.2.Final.jar:2.3.2.Final]
>        at org.jboss.weld.bean.ManagedBean.create(ManagedBean.java:162) [weld-core-impl-2.3.2.Final.jar:2.3.2.Final]
>        at org.jboss.weld.context.AbstractContext.get(AbstractContext.java:96) [weld-core-impl-2.3.2.Final.jar:2.3.2.Final]
>        at org.jboss.weld.bean.ContextualInstanceStrategy$DefaultContextualInstanceStrategy.get(ContextualInstanceStrategy.java:101) [weld-core-impl-2.3.2.Final.jar:2.3.2.Final]
>        at org.jboss.weld.bean.ContextualInstanceStrategy$ApplicationScopedContextualInstanceStrategy.get(ContextualInstanceStrategy.java:141) [weld-core-impl-2.3.2.Final.jar:2.3.2.Final]
>        at org.jboss.weld.bean.ContextualInstance.get(ContextualInstance.java:50) [weld-core-impl-2.3.2.Final.jar:2.3.2.Final]
>        at org.jboss.weld.manager.BeanManagerImpl.getReference(BeanManagerImpl.java:742) [weld-core-impl-2.3.2.Final.jar:2.3.2.Final]
> ...
> Caused by: java.lang.reflect.InvocationTargetException
>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_92]
>        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_92]
>        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_92]
>        at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_92]
>        at org.jboss.weld.injection.producer.DefaultLifecycleCallbackInvoker.invokeMethods(DefaultLifecycleCallbackInvoker.java:98) [weld-core-impl-2.3.2.Final.jar:2.3.2.Final]
>        ... 82 more
> Caused by: java.lang.NullPointerException
>        at org.postgresql.jdbc.TypeInfoCache.getSQLType(TypeInfoCache.java:182)
>        at org.postgresql.jdbc.TypeInfoCache.getSQLType(TypeInfoCache.java:178)
>        at org.postgresql.jdbc.PgDatabaseMetaData.getProcedureColumns(PgDatabaseMetaData.java:1259)
>        at org.postgresql.jdbc.PgDatabaseMetaData.getProcedureColumns(PgDatabaseMetaData.java:1040)
>        at org.springframework.jdbc.core.metadata.GenericCallMetaDataProvider.processProcedureColumns(GenericCallMetaDataProvider.java:353) [spring-jdbc.jar:4.2.4.RELEASE]
>        at org.springframework.jdbc.core.metadata.GenericCallMetaDataProvider.initializeWithProcedureColumnMetaData(GenericCallMetaDataProvider.java:112) [spring-jdbc.jar:4.2.4.RELEASE]
>        at org.springframework.jdbc.core.metadata.CallMetaDataProviderFactory$1.processMetaData(CallMetaDataProviderFactory.java:133) [spring-jdbc.jar:4.2.4.RELEASE]
>        at org.springframework.jdbc.support.JdbcUtils.extractDatabaseMetaData(JdbcUtils.java:299) [spring-jdbc.jar:4.2.4.RELEASE]
>        at org.springframework.jdbc.core.metadata.CallMetaDataProviderFactory.createMetaDataProvider(CallMetaDataProviderFactory.java:73) [spring-jdbc.jar:4.2.4.RELEASE]
>        at org.springframework.jdbc.core.metadata.CallMetaDataContext.initializeMetaData(CallMetaDataContext.java:286) [spring-jdbc.jar:4.2.4.RELEASE]
>        at org.springframework.jdbc.core.simple.AbstractJdbcCall.compileInternal(AbstractJdbcCall.java:303) [spring-jdbc.jar:4.2.4.RELEASE]
>        at org.ovirt.engine.core.dal.dbbroker.PostgresDbEngineDialect$PostgresSimpleJdbcCall.compileInternal(PostgresDbEngineDialect.java:108) [dal.jar:]
>        at org.springframework.jdbc.core.simple.AbstractJdbcCall.compile(AbstractJdbcCall.java:288) [spring-jdbc.jar:4.2.4.RELEASE]
>        at org.ovirt.engine.core.dal.dbbroker.SimpleJdbcCallsHandler.getCall(SimpleJdbcCallsHandler.java:169) [dal.jar:]
>        at org.ovirt.engine.core.dal.dbbroker.SimpleJdbcCallsHandler.executeImpl(SimpleJdbcCallsHandler.java:146) [dal.jar:]
>        at org.ovirt.engine.core.dal.dbbroker.SimpleJdbcCallsHandler.executeReadList(SimpleJdbcCallsHandler.java:109) [dal.jar:]
>        at org.ovirt.engine.core.dal.dbbroker.SimpleJdbcCallsHandler.executeRead(SimpleJdbcCallsHandler.java:101) [dal.jar:]
>        at org.ovirt.engine.core.dao.VdsDynamicDaoImpl.get(VdsDynamicDaoImpl.java:129) [dal.jar:]
>        at org.ovirt.engine.core.dao.VdsDynamicDaoImpl.updateIfNeeded(VdsDynamicDaoImpl.java:296) [dal.jar:]
>        at org.ovirt.engine.core.dao.VdsDynamicDaoImpl.updateIfNeeded(VdsDynamicDaoImpl.java:34) [dal.jar:]
>        at org.ovirt.engine.core.vdsbroker.VdsManager.updateDynamicData(VdsManager.java:421) [vdsbroker.jar:]
>        at org.ovirt.engine.core.vdsbroker.ResourceManager.addVds(ResourceManager.java:237) [vdsbroker.jar:]
>        at org.ovirt.engine.core.vdsbroker.ResourceManager.init(ResourceManager.java:134) [vdsbroker.jar:]
>        ... 87 more
> 
> And in server.log:
> 2016-08-03 12:04:39,758 ERROR [org.jboss.msc.service.fail] (ServerService Thread Pool -- 54) MSC000001: Failed to start service jboss.deployment.subunit."engine.ear"."bll.jar".component.Backend.START: org.jboss.msc.service.StartException in service jboss.deployment.subunit."engine.ear"."bll.jar".component.Backend.START: java.lang.IllegalStateException: WFLYEE0042: Failed to construct component instance
>        at org.jboss.as.ee.component.ComponentStartService$1.run(ComponentStartService.java:57) [wildfly-ee-10.0.0.Final.jar:10.0.0.Final]
>        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [rt.jar:1.8.0_92]
>        at java.util.concurrent.FutureTask.run(FutureTask.java:266) [rt.jar:1.8.0_92]
>        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_92]
>        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_92]
>        at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_92]
>        at org.jboss.threads.JBossThread.run(JBossThread.java:320)
> Caused by: java.lang.IllegalStateException: WFLYEE0042: Failed to construct component instance
>        at org.jboss.as.ee.component.BasicComponent.constructComponentInstance(BasicComponent.java:163) [wildfly-ee-10.0.0.Final.jar:10.0.0.Final]
>        at org.jboss.as.ee.component.BasicComponent.constructComponentInstance(BasicComponent.java:134) [wildfly-ee-10.0.0.Final.jar:10.0.0.Final]
>        at org.jboss.as.ee.component.BasicComponent.createInstance(BasicComponent.java:88) [wildfly-ee-10.0.0.Final.jar:10.0.0.Final]
>        at org.jboss.as.ejb3.component.singleton.SingletonComponent.getComponentInstance(SingletonComponent.java:124)
>        at org.jboss.as.ejb3.component.singleton.SingletonComponent.start(SingletonComponent.java:138)
>        at org.jboss.as.ee.component.ComponentStartService$1.run(ComponentStartService.java:54) [wildfly-ee-10.0.0.Final.jar:10.0.0.Final]
>        ... 6 more
> Caused by: javax.ejb.EJBException: org.jboss.weld.exceptions.WeldException: WELD-000049: Unable to invoke private void org.ovirt.engine.core.vdsbroker.ResourceManager.init() on org.ovirt.engine.core.vdsbroker.ResourceManager at 28b87a8e
>        at org.jboss.as.ejb3.tx.CMTTxInterceptor.handleExceptionInNoTx(CMTTxInterceptor.java:213)
>        at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:265)
>        at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:374)
>        at org.jboss.as.ejb3.tx.LifecycleCMTTxInterceptor.processInvocation(LifecycleCMTTxInterceptor.java:68)
>        at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) [jboss-invocation-1.4.1.Final.jar:1.4.1.Final]
>        at org.jboss.as.weld.injection.WeldInjectionContextInterceptor.processInvocation(WeldInjectionContextInterceptor.java:43)
>        at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) [jboss-invocation-1.4.1.Final.jar:1.4.1.Final]
>        at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41)
>        at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) [jboss-invocation-1.4.1.Final.jar:1.4.1.Final]
>        at org.jboss.as.ee.concurrent.ConcurrentContextInterceptor.processInvocation(ConcurrentContextInterceptor.java:45) [wildfly-ee-10.0.0.Final.jar:10.0.0.Final]
>        at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) [jboss-invocation-1.4.1.Final.jar:1.4.1.Final]
>        at org.jboss.invocation.ContextClassLoaderInterceptor.processInvocation(ContextClassLoaderInterceptor.java:64) [jboss-invocation-1.4.1.Final.jar:1.4.1.Final]
>        at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) [jboss-invocation-1.4.1.Final.jar:1.4.1.Final]
>        at org.jboss.invocation.InterceptorContext.run(InterceptorContext.java:356) [jboss-invocation-1.4.1.Final.jar:1.4.1.Final]
>        at org.jboss.invocation.PrivilegedWithCombinerInterceptor.processInvocation(PrivilegedWithCombinerInterceptor.java:80) [jboss-invocation-1.4.1.Final.jar:1.4.1.Final]
>        at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) [jboss-invocation-1.4.1.Final.jar:1.4.1.Final]
>        at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.4.1.Final.jar:1.4.1.Final]
>        at org.jboss.as.ee.component.BasicComponent.constructComponentInstance(BasicComponent.java:161) [wildfly-ee-10.0.0.Final.jar:10.0.0.Final]
>        ... 11 more
> Caused by: org.jboss.weld.exceptions.WeldException: WELD-000049: Unable to invoke private void org.ovirt.engine.core.vdsbroker.ResourceManager.init() on org.ovirt.engine.core.vdsbroker.ResourceManager at 28b87a8e
> ...
> 2016-08-03 12:04:40,311 ERROR [org.jboss.as.controller.management-operation] (Controller Boot Thread) WFLYCTL0013: Operation ("deploy") failed - address: ([("deployment" => "engine.ear")]) - failure description: {"WFLYCTL0080: Failed services" => {"jboss.deployment.subunit.\"engine.ear\".\"bll.jar\".component.Backend.START" => "org.jboss.msc.service.StartException in service jboss.deployment.subunit.\"engine.ear\".\"bll.jar\".component.Backend.START: java.lang.IllegalStateException: WFLYEE0042: Failed to construct component instance
>    Caused by: java.lang.IllegalStateException: WFLYEE0042: Failed to construct component instance
>    Caused by: javax.ejb.EJBException: org.jboss.weld.exceptions.WeldException: WELD-000049: Unable to invoke private void org.ovirt.engine.core.vdsbroker.ResourceManager.init() on org.ovirt.engine.core.vdsbroker.ResourceManager at 28b87a8e
>    Caused by: org.jboss.weld.exceptions.WeldException: WELD-000049: Unable to invoke private void org.ovirt.engine.core.vdsbroker.ResourceManager.init() on org.ovirt.engine.core.vdsbroker.ResourceManager at 28b87a8e
>    Caused by: java.lang.reflect.InvocationTargetException
>    Caused by: java.lang.NullPointerException"}}
> ...
> 2016-08-03 12:04:40,916 ERROR [org.jboss.as <http://org.jboss.as/>] (Controller Boot Thread) WFLYSRV0026: WildFly Full 10.0.0.Final (WildFly Core 2.0.10.Final) started (with errors) in 29114ms - Started 1320 of 1633 services (5 services failed or missing dependencies, 438 services are lazy, passive or on-demand)
> 2016-08-03 12:04:41,011 INFO  [org.wildfly.extension.undertow] (ServerService Thread Pool -- 14) WFLYUT0022: Unregistered web context: /ovirt-engine/services
> 2016-08-03 12:04:41,012 INFO  [org.wildfly.extension.undertow] (ServerService Thread Pool -- 15) WFLYUT0022: Unregistered web context: /ovirt-engine/webadmin
> 2016-08-03 12:04:41,015 INFO  [org.wildfly.extension.undertow] (ServerService Thread Pool -- 4) WFLYUT0022: Unregistered web context: /ovirt-engine/api
> 2016-08-03 12:04:41,022 INFO  [org.wildfly.extension.undertow] (ServerService Thread Pool -- 13) WFLYUT0022: Unregistered web context: /ovirt-engine/docs
> 2016-08-03 12:04:41,022 INFO  [org.wildfly.extension.undertow] (ServerService Thread Pool -- 11) WFLYUT0022: Unregistered web context: /ovirt-engine/sso
> 2016-08-03 12:04:41,022 INFO  [org.wildfly.extension.undertow] (ServerService Thread Pool -- 18) WFLYUT0022: Unregistered web context: /ovirt-engine/userportal
> 2016-08-03 12:04:41,019 INFO  [org.wildfly.extension.undertow] (ServerService Thread Pool -- 20) WFLYUT0022: Unregistered web context: /ovirt-engine
> 2016-08-03 12:04:41,013 INFO  [org.wildfly.extension.undertow] (ServerService Thread Pool -- 7) WFLYUT0022: Unregistered web context: /
> 
> I see no other error message. Any hint about that ?
> _______________________________________________
> Users mailing list
> Users at ovirt.org <mailto:Users at ovirt.org>
> http://lists.ovirt.org/mailman/listinfo/users <http://lists.ovirt.org/mailman/listinfo/users>
> 

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.ovirt.org/pipermail/users/attachments/20160803/0b9f185d/attachment-0001.html>


More information about the Users mailing list