We failed to run a vm with internal engine error.Hi,We have a failed test on ovirt-hosted-engine-setup basic suite.Link and headline of suspected patches:
Add engine fqdn to inventory and allow dynamic inventory scripts - https://gerrit.ovirt.org/#/c/88622/ Link to Job:
http://jenkins.ovirt.org/job/ovirt-4.2_change-queue-tester/ 1064/ Link to all logs:
http://jenkins.ovirt.org/job/ovirt-4.2_change-queue-tester/ 1064/artifact/ (Relevant) error snippet from the log:
<error>
2018-03-07 17:03:38,374-05 INFO [org.ovirt.engine.core.bll.RunVmOnceCommand] (default task-21) [a514da44-d44f-46b9-8bdf- 08ba2d513929] Running command: RunVmOnceCommand internal: false. Entities affected : ID: 634c6a46-d057-4509-be3b-710
716cbd56d Type: VMAction group RUN_VM with role type USER, ID: 634c6a46-d057-4509-be3b-710716cbd56d Type: VMAction group EDIT_ADMIN_VM_PROPERTIES with role type ADMIN
2018-03-07 17:03:38,379-05 DEBUG [org.ovirt.engine.core.common.di.interceptor. DebugLoggingInterceptor] (default task-21) [a514da44-d44f-46b9-8bdf- 08ba2d513929] method: getVmManager, params: [634c6a46-d057-4509-be3b- 710716cbd56d], timeElap
sed: 5ms
2018-03-07 17:03:38,391-05 DEBUG [org.ovirt.engine.core.common.di.interceptor. DebugLoggingInterceptor] (default task-21) [a514da44-d44f-46b9-8bdf- 08ba2d513929] method: getAllForClusterWithStatus, params: [14cad400-49a0-44e0-ab15- 9da778f08
082, Up], timeElapsed: 7ms
2018-03-07 17:03:38,408-05 DEBUG [org.ovirt.engine.core.common.di.interceptor. DebugLoggingInterceptor] (default task-21) [a514da44-d44f-46b9-8bdf- 08ba2d513929] method: getVdsManager, params: [8ef2f490-1b76-46e0-b9fe- f3412a36e03b], timeEla
psed: 0ms
2018-03-07 17:03:38,419-05 DEBUG [org.ovirt.engine.core.dal.dbbroker. CustomSQLErrorCodeSQLException Translator] (default task-21) [a514da44-d44f-46b9-8bdf- 08ba2d513929] Translating SQLException with SQL state '23505', error code '0', messa
ge [ERROR: duplicate key value violates unique constraint "name_server_pkey"
Detail: Key (dns_resolver_configuration_id, address)=(8a941b6a-83aa-44de- 9800-2a1ea6e8e029, 192.168.200.1) already exists.
Where: SQL statement "INSERT INTO
name_server(
address,
position,
dns_resolver_configuration_id)
VALUES (
v_address,
v_position,
v_dns_resolver_configuration_id)"
PL/pgSQL function insertnameserver(uuid,character varying,smallint) line 3 at SQL statement]; SQL was [{call insertnameserver(?, ?, ?)}] for task [CallableStatementCallback]
2018-03-07 17:03:38,420-05 ERROR [org.ovirt.engine.core.bll.RunVmOnceCommand] (default task-21) [a514da44-d44f-46b9-8bdf- 08ba2d513929] Command 'org.ovirt.engine.core.bll. RunVmOnceCommand' failed: CallableStatementCallback; SQL [{call inse
rtnameserver(?, ?, ?)}]; ERROR: duplicate key value violates unique constraint "name_server_pkey"
Detail: Key (dns_resolver_configuration_id, address)=(8a941b6a-83aa-44de- 9800-2a1ea6e8e029, 192.168.200.1) already exists.
Where: SQL statement "INSERT INTO
name_server(
address,
position,
dns_resolver_configuration_id)
VALUES (
v_address,
v_position,
v_dns_resolver_configuration_id)"
PL/pgSQL function insertnameserver(uuid,character varying,smallint) line 3 at SQL statement; nested exception is org.postgresql.util. PSQLException: ERROR: duplicate key value violates unique constraint "name_server_pkey"
Detail: Key (dns_resolver_configuration_id, address)=(8a941b6a-83aa-44de- 9800-2a1ea6e8e029, 192.168.200.1) already exists.
Where: SQL statement "INSERT INTO
name_server(
address,
position,
dns_resolver_configuration_id)
VALUES (
v_address,
v_position,
v_dns_resolver_configuration_id)"
PL/pgSQL function insertnameserver(uuid,character varying,smallint) line 3 at SQL statement
2018-03-07 17:03:38,420-05 ERROR [org.ovirt.engine.core.bll.RunVmOnceCommand] (default task-21) [a514da44-d44f-46b9-8bdf- 08ba2d513929] Exception: org.springframework.dao. DuplicateKeyException: CallableStatementCallback; SQL [{call insertn
ameserver(?, ?, ?)}]; ERROR: duplicate key value violates unique constraint "name_server_pkey"
Detail: Key (dns_resolver_configuration_id, address)=(8a941b6a-83aa-44de- 9800-2a1ea6e8e029, 192.168.200.1) already exists.
Where: SQL statement "INSERT INTO
name_server(
address,
position,
dns_resolver_configuration_id)
VALUES (
:
v_address,
v_position,
v_dns_resolver_configuration_id)"
PL/pgSQL function insertnameserver(uuid,character varying,smallint) line 3 at SQL statement; nested exception is org.postgresql.util. PSQLException: ERROR: duplicate key value violates unique constraint "name_server_pkey"
Detail: Key (dns_resolver_configuration_id, address)=(8a941b6a-83aa-44de- 9800-2a1ea6e8e029, 192.168.200.1) already exists.
Where: SQL statement "INSERT INTO
name_server(
address,
position,
dns_resolver_configuration_id)
VALUES (
v_address,
v_position,
v_dns_resolver_configuration_id)"
PL/pgSQL function insertnameserver(uuid,character varying,smallint) line 3 at SQL statement
at org.springframework.jdbc.support. SQLErrorCodeSQLExceptionTransl ator.doTranslate( SQLErrorCodeSQLExceptionTransl ator.java:239) [spring-jdbc.jar:4.3.9. RELEASE]
at org.springframework.jdbc.support. AbstractFallbackSQLExceptionTr anslator.translate( AbstractFallbackSQLExceptionTr anslator.java:73) [spring-jdbc.jar:4.3.9. RELEASE]
at org.springframework.jdbc.core.JdbcTemplate.execute( JdbcTemplate.java:1099) [spring-jdbc.jar:4.3.9. RELEASE]
at org.springframework.jdbc.core.JdbcTemplate.call( JdbcTemplate.java:1135) [spring-jdbc.jar:4.3.9. RELEASE]
at org.springframework.jdbc.core.simple.AbstractJdbcCall. executeCallInternal( AbstractJdbcCall.java:405) [spring-jdbc.jar:4.3.9. RELEASE]
at org.springframework.jdbc.core.simple.AbstractJdbcCall. doExecute(AbstractJdbcCall. java:365) [spring-jdbc.jar:4.3.9. RELEASE]
at org.springframework.jdbc.core.simple.SimpleJdbcCall.execute( SimpleJdbcCall.java:198) [spring-jdbc.jar:4.3.9. RELEASE]
at org.ovirt.engine.core.dal.dbbroker. SimpleJdbcCallsHandler. executeImpl( SimpleJdbcCallsHandler.java: 135) [dal.jar:]
at org.ovirt.engine.core.dal.dbbroker. SimpleJdbcCallsHandler. executeImpl( SimpleJdbcCallsHandler.java: 130) [dal.jar:]
at org.ovirt.engine.core.dal.dbbroker. SimpleJdbcCallsHandler. executeModification( SimpleJdbcCallsHandler.java: 76) [dal.jar:]
at org.ovirt.engine.core.dao.network. DnsResolverConfigurationDaoImp l. saveNameServersByDnsResolverCo nfigurationId( DnsResolverConfigurationDaoImp l.java:66) [dal.jar:]
at org.ovirt.engine.core.dao.network. DnsResolverConfigurationDaoImp l.update( DnsResolverConfigurationDaoImp l.java:110) [dal.jar:]
at org.ovirt.engine.core.dao.network. DnsResolverConfigurationDaoImp l.update( DnsResolverConfigurationDaoImp l.java:15) [dal.jar:]
at org.ovirt.engine.core.dao.VdsDynamicDaoImpl. updateDnsResolverConfiguration (VdsDynamicDaoImpl.java:156) [dal.jar:]
at org.ovirt.engine.core.dao.VdsDynamicDaoImpl.update( VdsDynamicDaoImpl.java:145) [dal.jar:]
at org.ovirt.engine.core.dao.VdsDynamicDaoImpl. updateIfNeeded( VdsDynamicDaoImpl.java:343) [dal.jar:]
at org.ovirt.engine.core.dao.VdsDynamicDaoImpl. updateIfNeeded( VdsDynamicDaoImpl.java:35) [dal.jar:]
at org.ovirt.engine.core.vdsbroker.VdsManager. updateDynamicData(VdsManager. java:473) [vdsbroker.jar:]
at org.ovirt.engine.core.vdsbroker.VdsManager. updatePendingData(VdsManager. java:511) [vdsbroker.jar:]
at org.ovirt.engine.core.bll.scheduling.pending. PendingResourceManager. notifyHostManagers( PendingResourceManager.java: 227) [bll.jar:]
at org.ovirt.engine.core.bll.scheduling.SchedulingManager. schedule(SchedulingManager. java:361) [bll.jar:]
at org.ovirt.engine.core.bll.RunVmCommand.getVdsToRunOn( RunVmCommand.java:853) [bll.jar:]
at org.ovirt.engine.core.bll.RunVmCommand.runVm( RunVmCommand.java:256) [bll.jar:]
at org.ovirt.engine.core.bll.RunVmCommand.perform( RunVmCommand.java:430) [bll.jar:]
at org.ovirt.engine.core.bll.RunVmCommand.executeVmCommand( RunVmCommand.java:355) [bll.jar:]
at org.ovirt.engine.core.bll.VmCommand.executeCommand( VmCommand.java:161) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase. executeWithoutTransaction( CommandBase.java:1133) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase. executeActionInTransactionScop e(CommandBase.java:1285) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.runInTransaction( CommandBase.java:1934) [bll.jar:]
at org.ovirt.engine.core.utils.transaction. TransactionSupport. executeInSuppressed( TransactionSupport.java:164) [utils.jar:]
at org.ovirt.engine.core.utils.transaction. TransactionSupport. executeInScope( TransactionSupport.java:103) [utils.jar:]
at org.ovirt.engine.core.bll.CommandBase.execute( CommandBase.java:1345) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.executeAction( CommandBase.java:400) [bll.jar:]
at org.ovirt.engine.core.bll.executor. DefaultBackendActionExecutor. execute( DefaultBackendActionExecutor. java:13) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runAction(Backend. java:468) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend. java:450) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runAction(Backend. java:403) [bll.jar:]
at sun.reflect.GeneratedMethodAccessor134. invoke(Unknown Source) [:1.8.0_161]
at sun.reflect.DelegatingMethodAccessorImpl. invoke( DelegatingMethodAccessorImpl. java:43) [rt.jar:1.8.0_161]
at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_161]
at org.jboss.as.ee.component.ManagedReferenceMethodIntercep tor.processInvocation( ManagedReferenceMethodIntercep tor.java:52)
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.invocation.InterceptorContext$Invocation. proceed(InterceptorContext. java:509)
at org.jboss.as.weld.ejb.DelegatingInterceptorInvocatio nContext.proceed( DelegatingInterceptorInvocatio nContext.java:92) [wildfly-weld-ejb-11.0.0. Final.jar:11.0.0.Final]
at org.jboss.weld.interceptor.proxy.WeldInvocationContext. interceptorChainCompleted( WeldInvocationContext.java:98) [weld-core-impl-2.4.3.Final. jar:2.4.3.Final]
at org.jboss.weld.interceptor.proxy.WeldInvocationContext. proceed(WeldInvocationContext. java:117) [weld-core-impl-2.4.3.Final. jar:2.4.3.Final]
at org.ovirt.engine.core.common.di.interceptor. LoggingInterceptor.apply( LoggingInterceptor.java:12) [common.jar:]
at sun.reflect.GeneratedMethodAccessor69. invoke(Unknown Source) [:1.8.0_161]
at sun.reflect.DelegatingMethodAccessorImpl. invoke( DelegatingMethodAccessorImpl. java:43) [rt.jar:1.8.0_161]
at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_161]
at org.jboss.weld.interceptor.reader. SimpleInterceptorInvocation$ SimpleMethodInvocation.invoke( SimpleInterceptorInvocation. java:73) [weld-core-impl-2.4.3.Final. jar:2.4.3.Final]
at org.jboss.weld.interceptor.proxy.WeldInvocationContext. invokeNext( WeldInvocationContext.java:83) [weld-core-impl-2.4.3.Final. jar:2.4.3.Final]
at org.jboss.weld.interceptor.proxy.WeldInvocationContext. proceed(WeldInvocationContext. java:115) [weld-core-impl-2.4.3.Final. jar:2.4.3.Final]
at org.jboss.weld.bean.InterceptorImpl.intercept( InterceptorImpl.java:108) [weld-core-impl-2.4.3.Final. jar:2.4.3.Final]
at org.jboss.as.weld.ejb.DelegatingInterceptorInvocatio nContext.proceed( DelegatingInterceptorInvocatio nContext.java:82) [wildfly-weld-ejb-11.0.0. Final.jar:11.0.0.Final]
at org.jboss.as.weld.interceptors. EjbComponentInterceptorSupport .delegateInterception( EjbComponentInterceptorSupport .java:60)
at org.jboss.as.weld.interceptors. Jsr299BindingsInterceptor. delegateInterception( Jsr299BindingsInterceptor. java:76)
at org.jboss.as.weld.interceptors. Jsr299BindingsInterceptor. doMethodInterception( Jsr299BindingsInterceptor. java:88)
at org.jboss.as.weld.interceptors. Jsr299BindingsInterceptor. processInvocation( Jsr299BindingsInterceptor. java:101)
at org.jboss.as.ee.component.interceptors. UserInterceptorFactory$1. processInvocation( UserInterceptorFactory.java: 63)
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.invocation.InterceptorContext$Invocation. proceed(InterceptorContext. java:509)
at org.ovirt.engine.core.bll.interceptors. CorrelationIdTrackerIntercepto r.aroundInvoke(