On Tue, Dec 12, 2017 at 10:11 PM, Yaniv Kaul <ykaul(a)redhat.com> wrote:
I suspect you've missed the relevant exception:
{"jsonrpc": "2.0", "id":
"05aaf760-b3b7-47b5-8bd7-034e899b7400", "error":
{"message": "General Exception:
(\"'portMirroring'\",)", "code": 100}}�
2017-12-12 13:27:48,142-05 DEBUG [org.ovirt.vdsm.jsonrpc.client.internal.ResponseWorker]
(ResponseWorker) [] Message received: {"jsonrpc": "2.0",
"id":
"05aaf760-b3b7-47b5-8bd7-034e899b7400", "error":
{"message": "General
Exception: (\"'portMirroring'\",)", "code": 100}}
2017-12-12 13:27:48,142-05 ERROR [org.ovirt.engine.core.
vdsbroker.vdsbroker.HotUnplugNicVDSCommand] (default task-12) [4c4b50dc]
Failed in 'HotUnplugNicVDS' method
2017-12-12 13:27:48,150-05 ERROR [org.ovirt.engine.core.dal.
dbbroker.auditloghandling.AuditLogDirector] (default task-12) [4c4b50dc]
EVENT_ID: VDS_BROKER_COMMAND_FAILURE(10,802), VDSM
lago-basic-suite-master-host-0 command HotUnplugNicVDS failed: General
Exception: ("'portMirroring'",)
2017-12-12 13:27:48,150-05 INFO [org.ovirt.engine.core.
vdsbroker.vdsbroker.HotUnplugNicVDSCommand] (default task-12) [4c4b50dc]
Command 'org.ovirt.engine.core.vdsbroker.vdsbroker.HotUnplugNicVDSCommand'
return value 'StatusOnlyReturn [status=Status [code=100, message=General
Exception: ("'portMirroring'",)]]'
2017-12-12 13:27:48,150-05 INFO [org.ovirt.engine.core.
vdsbroker.vdsbroker.HotUnplugNicVDSCommand] (default task-12) [4c4b50dc]
HostName = lago-basic-suite-master-host-0
2017-12-12 13:27:48,150-05 ERROR [org.ovirt.engine.core.
vdsbroker.vdsbroker.HotUnplugNicVDSCommand] (default task-12) [4c4b50dc]
Command 'HotUnplugNicVDSCommand(HostName = lago-basic-suite-master-host-0,
VmNicDeviceVDSParameters:{hostId='cf1d46b2-4594-4076-9d24-6f75220f0c97',
vm.vm_name='vm0',
nic='VmNic:{id='4487559e-7e47-4ab7-a6fe-1ae32fb34336',
vnicProfileId='623c894e-234c-4f1b-899e-275be6864f75', speed='1000',
type='3', macAddress='00:1a:4a:16:01:03', linked='true',
vmId='90124564-04f7-4607-a222-503c42262844', vmTemplateId='null'}',
vmDevice='VmDevice:{id='VmDeviceId:{deviceId='4487559e-7e47-4ab7-a6fe-1ae32fb34336',
vmId='90124564-04f7-4607-a222-503c42262844'}', device='bridge',
type='INTERFACE', specParams='[inbound={}, outbound={}]',
address='{slot=0x0a, bus=0x00, domain=0x0000, type=pci, function=0x0}',
managed='true', plugged='true', readOnly='false',
deviceAlias='net2',
customProperties='[]', snapshotId='null', logicalName='null',
hostDevice='null'}'})' execution failed: VDSGenericException:
VDSErrorException: Failed to HotUnplugNicVDS, error = General Exception:
("'portMirroring'",), code = 100
2017-12-12 13:27:48,150-05 DEBUG [org.ovirt.engine.core.
vdsbroker.vdsbroker.HotUnplugNicVDSCommand] (default task-12) [4c4b50dc]
Exception: org.ovirt.engine.core.vdsbroker.vdsbroker.VDSErrorException:
VDSGenericException: VDSErrorException: Failed to HotUnplugNicVDS, error =
General Exception: ("'portMirroring'",), code = 100
at org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.
createDefaultConcreteException(VdsBrokerCommand.java:81) [vdsbroker.jar:]
at org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase.
createException(BrokerCommandBase.java:224) [vdsbroker.jar:]
at org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase.
proceedProxyReturnValue(BrokerCommandBase.java:194) [vdsbroker.jar:]
at org.ovirt.engine.core.vdsbroker.vdsbroker.HotUnplugNicVDSCommand.
executeVdsBrokerCommand(HotUnplugNicVDSCommand.java:14) [vdsbroker.jar:]
at org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.
executeVDSCommand(VdsBrokerCommand.java:112) [vdsbroker.jar:]
at org.ovirt.engine.core.vdsbroker.VDSCommandBase.
executeCommand(VDSCommandBase.java:73) [vdsbroker.jar:]
...
(I did not look into the VDSM log to see what failed there)
And now that I did[1]:
2017-12-12 13:27:48,137-0500 INFO (jsonrpc/0) [api.virt] START
hotunplugNic(params={u'nic': {u'nicModel': u'pv',
u'macAddr':
u'00:1a:4a:16:01:03', u'linkActive': u'true', u'network':
u'network_1',
u'filterParameters': [], u'filter': u'vdsm-no-mac-spoofing',
u'specParams':
{u'inbound': {}, u'outbound': {}}, u'deviceId':
u'4487559e-7e47-4ab7-a6fe-1ae32fb34336', u'address': {u'function':
u'0x0',
u'bus': u'0x00', u'domain': u'0x0000', u'type':
u'pci', u'slot': u'0x0a'},
u'device': u'bridge', u'type': u'interface'},
u'vmId':
u'90124564-04f7-4607-a222-503c42262844'}) from=::ffff:192.168.202.4,47014,
flow_id=4c4b50dc (api:46)
2017-12-12 13:27:48,137-0500 ERROR (jsonrpc/0) [api] FINISH hotunplugNic
error='portMirroring' (api:127)
Traceback (most recent call last):
File "/usr/lib/python2.7/site-packages/vdsm/common/api.py", line 117, in
method
ret = func(*args, **kwargs)
File "/usr/lib/python2.7/site-packages/vdsm/API.py", line 394, in
hotunplugNic
return self.vm.hotunplugNic(params)
File "<string>", line 2, in hotunplugNic
File "/usr/lib/python2.7/site-packages/vdsm/common/api.py", line 94, in
method
return func(*args, **kwargs)
File "/usr/lib/python2.7/site-packages/vdsm/virt/vm.py", line 3157, in
hotunplugNic
port_mirroring = nicParams['portMirroring']
KeyError: 'portMirroring'
2017-12-12 13:27:48,141-0500 INFO (jsonrpc/0) [api.virt] FINISH
hotunplugNic return={'status': {'message': 'General Exception:
("\'portMirroring\'",)', 'code': 100}}
from=::ffff:192.168.202.4,47014,
flow_id=4c4b50dc (api:52)
Y.
[1]
http://jenkins.ovirt.org/job/ovirt-master_change-queue-tester/4371/artifa...
Y.
On Tue, Dec 12, 2017 at 9:51 PM, Dafna Ron <dron(a)redhat.com> wrote:
> Hi,
>
> We have a failure on test 098_ovirt_provider_ovn.use_ovn_provider but I
> am not sure how the reported patch is related to the failure.
>
> *Link and headline of suspected patches: *
> *
https://gerrit.ovirt.org/#/c/85147/
> <
https://gerrit.ovirt.org/#/c/85147/> - virt: Fix flipped condition in
> hotunplugNic*
>
> *Link to Job:*
> *http://jenkins.ovirt.org/job/ovirt-master_change-queue-tester/4371
> <
http://jenkins.ovirt.org/job/ovirt-master_change-queue-tester/4371>*
>
>
> *Link to all logs:*
> *
>
http://jenkins.ovirt.org/job/ovirt-master_change-queue-tester/4371/artifact
> <
http://jenkins.ovirt.org/job/ovirt-master_change-queue-tester/4371/artifa...
>
>
> *(Relevant) error snippet from the log: *
>
>
>
> * <error> from junit: *
>
>
> File "/usr/lib64/python2.7/unittest/case.py", line 369, in run
> testMethod()
> File "/usr/lib/python2.7/site-packages/nose/case.py", line 197, in
runTest
> self.test(*self.arg)
> File "/usr/lib/python2.7/site-packages/ovirtlago/testlib.py", line 129,
in wrapped_test
> test()
> File "/usr/lib/python2.7/site-packages/ovirtlago/testlib.py", line 59, in
wrapper
> return func(get_test_prefix(), *args, **kwargs)
> File "/usr/lib/python2.7/site-packages/ovirtlago/testlib.py", line 78, in
wrapper
> prefix.virt_env.engine_vm().get_api(api_ver=4), *args, **kwargs
> File "/usr/lib/python2.7/site-packages/ovirtlago/testlib.py", line 59, in
wrapper
> return func(get_test_prefix(), *args, **kwargs)
> File
"/home/jenkins/workspace/ovirt-master_change-queue-tester/ovirt-system-tests/basic-suite-master/test-scenarios/098_ovirt_provider_ovn.py",
line 435, in use_ovn_provider
> _remove_iface_from_vm(api, VM0_NAME, IFACE_NAME)
> File
"/home/jenkins/workspace/ovirt-master_change-queue-tester/ovirt-system-tests/basic-suite-master/test-scenarios/098_ovirt_provider_ovn.py",
line 388, in _remove_iface_from_vm
> nic_service.deactivate()
> File "/usr/lib64/python2.7/site-packages/ovirtsdk4/services.py", line
29110, in deactivate
> return self._internal_action(action, 'deactivate', None, headers, query,
wait)
> File "/usr/lib64/python2.7/site-packages/ovirtsdk4/service.py", line 299,
in _internal_action
> return future.wait() if wait else future
> File "/usr/lib64/python2.7/site-packages/ovirtsdk4/service.py", line 55,
in wait
> return self._code(response)
> File "/usr/lib64/python2.7/site-packages/ovirtsdk4/service.py", line 296,
in callback
> self._check_fault(response)
> File "/usr/lib64/python2.7/site-packages/ovirtsdk4/service.py", line 132,
in _check_fault
> self._raise_error(response, body)
> File "/usr/lib64/python2.7/site-packages/ovirtsdk4/service.py", line 118,
in _raise_error
> raise error
> 'Fault reason is "Operation Failed". Fault detail is "[General
Exception]". HTTP response code is 400.\n-------------------- >> begin captured
logging << --------------------\nrequests.packages.urllib3.connectionpool: INFO:
* Starting new HTTPS connection (1): 192.168.202.4\npy.warnings: WARNING: * Unverified
HTTPS request is being made. Adding certificate verification is strongly advised. See:
https://urllib3.readthedocs.org/en/latest/security.html\nrequests.package...:
<
https://urllib3.readthedocs.org/en/latest/security.html/nrequests.package...
DEBUG: "POST /v2.0/tokens/ HTTP/1.1" 200
None\nrequests.packages.urllib3.connectionpool: INFO: * Starting new HTTPS connection
(1): 192.168.202.4\nrequests.packages.urllib3.connectionpool: DEBUG: "GET
/v2.0/networks/ HTTP/1.1" 200 None\nrequests.packages.urllib3.connectionpool: INFO:
* Starting new HTTPS connection (1):
192.168.202.4\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /v2.0/ports/
HTTP/1.1" 200 None\nrequests.packages.urllib3.connectionpool: INFO: * Starting
new HTTPS connection (1): 192.168.202.4\nrequests.packages.urllib3.connectionpool: DEBUG:
"GET /v2.0/subnets/ HTTP/1.1" 200
None\nrequests.packages.urllib3.connectionpool: INFO: * Starting new HTTPS connection
(1): 192.168.202.4\nrequests.packages.urllib3.connectionpool: DEBUG: "POST
/v2.0/networks/ HTTP/1.1" 201 None\nrequests.packages.urllib3.connectionpool: INFO:
* Starting new HTTPS connection (1):
192.168.202.4\nrequests.packages.urllib3.connectionpool: DEBUG: "POST /v2.0/subnets/
HTTP/1.1" 201 None\nrequests.packages.urllib3.connectionpool: INFO: * Starting
new HTTPS connection (1): 192.168.202.4\nrequests.packages.urllib3.connectionpool: DEBUG:
"POST /v2.0/ports/ HTTP/1.1" 201 None\nrequests.packages.urllib3.connectionpool:
INFO: * Starting new HTTPS connection (1):
192.168.202.4\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /v2.0/networks/
HTTP/1.1" 200 None\nrequests.packages.urllib3.connectionpool: INFO: * Starting
new HTTPS connection (1): 192.168.202.4\nrequests.packages.urllib3.connectionpool: DEBUG:
"GET /v2.0/ports/ HTTP/1.1" 200 None\nrequests.packages.urllib3.connectionpool:
INFO: * Starting new HTTPS connection (1):
192.168.202.4\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /v2.0/subnets/
HTTP/1.1" 200 None\n--------------------- >> end captured logging <<
---------------------'
>
> From engine:
>
> 2017-12-12 13:00:57,490-05 DEBUG
[org.ovirt.engine.core.aaa.filters.SsoRestApiNegotiationFilter] (default task-6) []
SsoRestApiNegotiationFilter Not performing Negotiate Auth
> 2017-12-12 13:00:57,548-05 DEBUG
[org.ovirt.engine.core.common.di.interceptor.DebugLoggingInterceptor] (default task-6)
[cdcdc9bf-0da4-4d64-953a-2c8e59587e2b] method: runQuery, params: [Search,
SearchParameters:{refresh='false', filtered='false',
searchType='Provider', searchPattern='Providers: type=OPENSTACK_NETWORK',
caseSensitive='false', from='0', max='2147483647
<(214)%20748-3647>'}], timeElapsed: 44ms
> 2017-12-12 13:00:57,586-05 DEBUG [org.ovirt.engine.core.dal.dbbroker.DbFacadeUtils]
(default task-6) [cdcdc9bf-0da4-4d64-953a-2c8e59587e2b] Failed to decrypt password:
javax.crypto.BadPaddingException: Decryption error
> at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380) [rt.jar:1.8.0_151]
> at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291) [rt.jar:1.8.0_151]
> at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:363)
[sunjce_provider.jar:1.8.0_151]
> at com.sun.crypto.provider.RSACipher.engineDoFinal(RSACipher.java:389)
[sunjce_provider.jar:1.8.0_151]
> at javax.crypto.Cipher.doFinal(Cipher.java:2165) [jce.jar:1.8.0_151]
> at
org.ovirt.engine.core.utils.crypt.EngineEncryptionUtils.decrypt(EngineEncryptionUtils.java:179)
[utils.jar:]
> at
org.ovirt.engine.core.dal.dbbroker.DbFacadeUtils.decryptPassword(DbFacadeUtils.java:35)
[dal.jar:]
> at
org.ovirt.engine.core.dao.provider.ProviderDaoImpl$ProviderRowMapper.mapRow(ProviderDaoImpl.java:137)
[dal.jar:]
> at
org.ovirt.engine.core.dao.provider.ProviderDaoImpl$ProviderRowMapper.mapRow(ProviderDaoImpl.java:119)
[dal.jar:]
> at
org.springframework.jdbc.core.RowMapperResultSetExtractor.extractData(RowMapperResultSetExtractor.java:93)
[spring-jdbc.jar:4.3.9.RELEASE]
> at
org.springframework.jdbc.core.RowMapperResultSetExtractor.extractData(RowMapperResultSetExtractor.java:60)
[spring-jdbc.jar:4.3.9.RELEASE]
> at
org.springframework.jdbc.core.JdbcTemplate$1QueryStatementCallback.doInStatement(JdbcTemplate.java:463)
[spring-jdbc.jar:4.3.9.RELEASE]
> at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:408)
[spring-jdbc.jar:4.3.9.RELEASE]
> at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:474)
[spring-jdbc.jar:4.3.9.RELEASE]
> at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:484)
[spring-jdbc.jar:4.3.9.RELEASE]
> at
org.ovirt.engine.core.dao.provider.ProviderDaoImpl.getAllWithQuery(ProviderDaoImpl.java:189)
[dal.jar:]
> at org.ovirt.engine.core.bll.SearchQuery.genericSearch(SearchQuery.java:343)
[bll.jar:]
> at org.ovirt.engine.core.bll.SearchQuery.searchProviders(SearchQuery.java:414)
[bll.jar:]
> at org.ovirt.engine.core.bll.SearchQuery.executeQueryCommand(SearchQuery.java:219)
[bll.jar:]
> at
org.ovirt.engine.core.bll.QueriesCommandBase.executeCommand(QueriesCommandBase.java:106)
[bll.jar:]
> at org.ovirt.engine.core.dal.VdcCommandBase.execute(VdcCommandBase.java:33)
[dal.jar:]
> at
org.ovirt.engine.core.bll.executor.DefaultBackendQueryExecutor.execute(DefaultBackendQueryExecutor.java:14)
[bll.jar:]
> at org.ovirt.engine.core.bll.Backend.runQueryImpl(Backend.java:579) [bll.jar:]
> at org.ovirt.engine.core.bll.Backend.runQuery(Backend.java:548) [bll.jar:]
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_151]
> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[rt.jar:1.8.0_151]
> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[rt.jar:1.8.0_151]
> at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_151]
> at
org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.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.DelegatingInterceptorInvocationContext.proceed(DelegatingInterceptorInvocationContext.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_151]
> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[rt.jar:1.8.0_151]
> at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_151]
> 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.DelegatingInterceptorInvocationContext.proceed(DelegatingInterceptorInvocationContext.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.CorrelationIdTrackerInterceptor.aroundInvoke(CorrelationIdTrackerInterceptor.java:13)
[bll.jar:]
> at sun.reflect.GeneratedMethodAccessor66.invoke(Unknown Source) [:1.8.0_151]
> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[rt.jar:1.8.0_151]
> at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_151]
> at
org.jboss.as.ee.component.ManagedReferenceLifecycleMethodInterceptor.processInvocation(ManagedReferenceLifecycleMethodInterceptor.java:89)
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.as.ejb3.component.invocationmetrics.ExecutionTimeInterceptor.processInvocation(ExecutionTimeInterceptor.java:43)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.as.ee.concurrent.ConcurrentContextInterceptor.processInvocation(ConcurrentContextInterceptor.java:45)
[wildfly-ee-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:40)
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:53)
> at
org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:52)
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:264)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:379)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at
org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:244)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:509)
> at
org.jboss.weld.ejb.AbstractEJBRequestScopeActivationInterceptor.aroundInvoke(AbstractEJBRequestScopeActivationInterceptor.java:73)
[weld-core-impl-2.4.3.Final.jar:2.4.3.Final]
> at
org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:89)
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.as.ejb3.component.invocationmetrics.WaitTimeInterceptor.processInvocation(WaitTimeInterceptor.java:47)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.as.ejb3.security.SecurityContextInterceptor.processInvocation(SecurityContextInterceptor.java:100)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.as.ejb3.deployment.processors.StartupAwaitInterceptor.processInvocation(StartupAwaitInterceptor.java:22)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.as.ejb3.component.interceptors.ShutDownInterceptorFactory$1.processInvocation(ShutDownInterceptorFactory.java:64)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:67)
[wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50)
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.invocation.ContextClassLoaderInterceptor.processInvocation(ContextClassLoaderInterceptor.java:60)
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at org.jboss.invocation.InterceptorContext.run(InterceptorContext.java:438)
> at
org.wildfly.security.manager.WildFlySecurityManager.doChecked(WildFlySecurityManager.java:609)
> at
org.jboss.invocation.AccessCheckingInterceptor.processInvocation(AccessCheckingInterceptor.java:57)
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
> at
org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:53)
> at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:198)
> at
org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:185)
> at
org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:81)
> at org.ovirt.engine.core.common.interfaces.BackendLocal$$$view2.runQuery(Unknown
Source) [common.jar:]
> at
org.ovirt.engine.api.restapi.resource.BackendResource.runQuery(BackendResource.java:82)
> at
org.ovirt.engine.api.restapi.resource.BackendResource.getBackendCollection(BackendResource.java:152)
> at
org.ovirt.engine.api.restapi.resource.AbstractBackendCollectionResource.getBackendCollection(AbstractBackendCollectionResource.java:48)
> at
org.ovirt.engine.api.restapi.resource.openstack.BackendOpenStackNetworkProvidersResource.getBackendCollection(BackendOpenStackNetworkProvidersResource.java:70)
> at
org.ovirt.engine.api.restapi.resource.openstack.BackendOpenStackNetworkProvidersResource.list(BackendOpenStackNetworkProvidersResource.java:50)
> at
org.ovirt.engine.api.resource.openstack.OpenstackNetworkProvidersResource.doList(OpenstackNetworkProvidersResource.java:52)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_151]
> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[rt.jar:1.8.0_151]
> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[rt.jar:1.8.0_151]
> at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_151]
> at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:140)
[resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final]
> at
org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTarget(ResourceMethodInvoker.java:295)
[resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final]
> at
org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:249)
[resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final]
> at
org.jboss.resteasy.core.ResourceLocatorInvoker.invokeOnTargetObject(ResourceLocatorInvoker.java:138)
[resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final]
> at
org.jboss.resteasy.core.ResourceLocatorInvoker.invoke(ResourceLocatorInvoker.java:101)
[resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final]
> at
org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:406)
[resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final]
> at
org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:213)
[resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final]
> at
org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:228)
[resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final]
> at
org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56)
[resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final]
> at
org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51)
[resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final]
> at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
[jboss-servlet-api_3.1_spec-1.0.0.Final.jar:1.0.0.Final]
> at
io.undertow.servlet.handlers.ServletHandler.handleRequest(ServletHandler.java:85)
> at io.undertow.servlet.handlers.FilterHandler.handleRequest(FilterHandler.java:81)
> at
io.undertow.servlet.handlers.security.ServletSecurityRoleHandler.handleRequest(ServletSecurityRoleHandler.java:62)
> at
io.undertow.servlet.handlers.ServletDispatchingHandler.handleRequest(ServletDispatchingHandler.java:36)
> at
io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
> at
io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
> at
io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
> at
io.undertow.servlet.handlers.ServletInitialHandler.dispatchRequest(ServletInitialHandler.java:274)
> at
io.undertow.servlet.handlers.ServletInitialHandler.dispatchToPath(ServletInitialHandler.java:209)
> at
io.undertow.servlet.spec.RequestDispatcherImpl.forwardImpl(RequestDispatcherImpl.java:221)
> at
io.undertow.servlet.spec.RequestDispatcherImpl.forwardImplSetup(RequestDispatcherImpl.java:147)
> at
io.undertow.servlet.spec.RequestDispatcherImpl.forward(RequestDispatcherImpl.java:111)
> at
org.ovirt.engine.api.restapi.invocation.VersionFilter.doFilter(VersionFilter.java:180)
> at
org.ovirt.engine.api.restapi.invocation.VersionFilter.doFilter(VersionFilter.java:98)
> at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61)
> at
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131)
> at
org.ovirt.engine.api.restapi.invocation.CurrentFilter.doFilter(CurrentFilter.java:117)
> at
org.ovirt.engine.api.restapi.invocation.CurrentFilter.doFilter(CurrentFilter.java:72)
> at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61)
> at
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131)
> at
org.ovirt.engine.core.aaa.filters.RestApiSessionMgmtFilter.doFilter(RestApiSessionMgmtFilter.java:78)
[aaa.jar:]
> at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61)
> at
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131)
> at
org.ovirt.engine.core.aaa.filters.EnforceAuthFilter.doFilter(EnforceAuthFilter.java:42)
[aaa.jar:]
> at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61)
> at
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131)
> at
org.ovirt.engine.core.aaa.filters.SsoRestApiNegotiationFilter.doFilter(SsoRestApiNegotiationFilter.java:84)
[aaa.jar:]
> at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61)
> at
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131)
> at
org.ovirt.engine.core.aaa.filters.SsoRestApiAuthFilter.doFilter(SsoRestApiAuthFilter.java:47)
[aaa.jar:]
> at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61)
> at
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131)
> at
org.ovirt.engine.core.aaa.filters.SessionValidationFilter.doFilter(SessionValidationFilter.java:59)
[aaa.jar:]
> at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61)
> at
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131)
> at
org.ovirt.engine.core.aaa.filters.RestApiSessionValidationFilter.doFilter(RestApiSessionValidationFilter.java:35)
[aaa.jar:]
> at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61)
> at
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131)
> at
org.ovirt.engine.api.restapi.security.CSRFProtectionFilter.doFilter(CSRFProtectionFilter.java:111)
> at
org.ovirt.engine.api.restapi.security.CSRFProtectionFilter.doFilter(CSRFProtectionFilter.java:102)
> at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61)
> at
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131)
> at
org.ovirt.engine.core.utils.servlet.CORSSupportFilter.doFilter(CORSSupportFilter.java:284)
[utils.jar:]
> at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61)
> at
io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131)
> at io.undertow.servlet.handlers.FilterHandler.handleRequest(FilterHandler.java:84)
> at
io.undertow.servlet.handlers.security.ServletSecurityRoleHandler.handleRequest(ServletSecurityRoleHandler.java:62)
> at
io.undertow.servlet.handlers.ServletDispatchingHandler.handleRequest(ServletDispatchingHandler.java:36)
> at
org.wildfly.extension.undertow.security.SecurityContextAssociationHandler.handleRequest(SecurityContextAssociationHandler.java:78)
> at
io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
> at
io.undertow.servlet.handlers.security.SSLInformationAssociationHandler.handleRequest(SSLInformationAssociationHandler.java:131)
> at
io.undertow.servlet.handlers.security.ServletAuthenticationCallHandler.handleRequest(ServletAuthenticationCallHandler.java:57)
> at
io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
> at
io.undertow.security.handlers.AuthenticationConstraintHandler.handleRequest(AuthenticationConstraintHandler.java:53)
> at
io.undertow.security.handlers.AbstractConfidentialityHandler.handleRequest(AbstractConfidentialityHandler.java:46)
> at
io.undertow.servlet.handlers.security.ServletConfidentialityConstraintHandler.handleRequest(ServletConfidentialityConstraintHandler.java:64)
> at
io.undertow.servlet.handlers.security.ServletSecurityConstraintHandler.handleRequest(ServletSecurityConstraintHandler.java:59)
> at
io.undertow.security.handlers.AuthenticationMechanismsHandler.handleRequest(AuthenticationMechanismsHandler.java:60)
> at
io.undertow.servlet.handlers.security.CachedAuthenticatedSessionHandler.handleRequest(CachedAuthenticatedSessionHandler.java:77)
> at
io.undertow.security.handlers.NotificationReceiverHandler.handleRequest(NotificationReceiverHandler.java:50)
> at
io.undertow.security.handlers.AbstractSecurityContextAssociationHandler.handleRequest(AbstractSecurityContextAssociationHandler.java:43)
> at
io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
> at
org.wildfly.extension.undertow.security.jacc.JACCContextIdHandler.handleRequest(JACCContextIdHandler.java:61)
> at
io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
> at
io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43)
> at
io.undertow.servlet.handlers.ServletInitialHandler.handleFirstRequest(ServletInitialHandler.java:292)
> at
io.undertow.servlet.handlers.ServletInitialHandler.access$100(ServletInitialHandler.java:81)
> at
io.undertow.servlet.handlers.ServletInitialHandler$2.call(ServletInitialHandler.java:138)
> at
io.undertow.servlet.handlers.ServletInitialHandler$2.call(ServletInitialHandler.java:135)
> at
io.undertow.servlet.core.ServletRequestContextThreadSetupAction$1.call(ServletRequestContextThreadSetupAction.java:48)
> at
io.undertow.servlet.core.ContextClassLoaderSetupAction$1.call(ContextClassLoaderSetupAction.java:43)
> at
org.wildfly.extension.undertow.security.SecurityContextThreadSetupAction.lambda$create$0(SecurityContextThreadSetupAction.java:105)
> at
org.wildfly.extension.undertow.deployment.UndertowDeploymentInfoService$UndertowThreadSetupAction.lambda$create$0(UndertowDeploymentInfoService.java:1508)
> at
org.wildfly.extension.undertow.deployment.UndertowDeploymentInfoService$UndertowThreadSetupAction.lambda$create$0(UndertowDeploymentInfoService.java:1508)
> at
org.wildfly.extension.undertow.deployment.UndertowDeploymentInfoService$UndertowThreadSetupAction.lambda$create$0(UndertowDeploymentInfoService.java:1508)
> at
io.undertow.servlet.handlers.ServletInitialHandler.dispatchRequest(ServletInitialHandler.java:272)
> at
io.undertow.servlet.handlers.ServletInitialHandler.access$000(ServletInitialHandler.java:81)
> at
io.undertow.servlet.handlers.ServletInitialHandler$1.handleRequest(ServletInitialHandler.java:104)
> at io.undertow.server.Connectors.executeRootHandler(Connectors.java:326)
> at io.undertow.server.HttpServerExchange$1.run(HttpServerExchange.java:812)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[rt.jar:1.8.0_151]
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[rt.jar:1.8.0_151]
> at java.lang.Thread.run(Thread.java:748) [rt.jar:1.8.0_151]
>
> 2017-12-12 13:00:57,599-05 DEBUG
[org.ovirt.engine.core.common.di.interceptor.DebugLoggingInterceptor] (default task-6)
[cdcdc9bf-0da4-4d64-953a-2c8e59587e2b] method: runQuery, params: [Search,
SearchParameters:{refresh='false', filtered='false',
searchType='Provider', searchPattern='Providers: type=EXTERNAL_NETWORK',
caseSensitive='false', from='0', max='2147483647
<(214)%20748-3647>'}], timeElapsed: 51ms
> 2017-12-12 13:00:57,604-05 DEBUG
[org.ovirt.engine.core.aaa.filters.SsoRestApiAuthFilter] (default task-7) [] Entered
SsoRestApiAuthFilter
> 2017-12-12 13:00:57,605-05 DEBUG
[org.ovirt.engine.core.aaa.filters.SsoRestApiAuthFilter] (default task-7) []
SsoRestApiAuthFilter authenticating with sso
> 2017-12-12 13:00:57,605-05 DEBUG
[org.ovirt.engine.core.aaa.filters.SsoRestApiAuthFilter] (default task-7) []
SsoRestApiAuthFilter authenticating using BEARER header
> 2017-12-12 13:00:57,607-05 DEBUG
[org.ovirt.engine.core.aaa.filters.SsoRestApiAuthFilter] (default task-7) []
SsoRestApiAuthFilter successfully authenticated using BEARER header
> 2017-12-12 13:00:57,607-05 DEBUG
[org.ovirt.engine.core.aaa.filters.SsoRestApiNegotiationFilter] (default task-7) []
Entered SsoRestApiNegotiationFilter
> 2017-12-12 13:00:57,610-05 DEBUG
[org.ovirt.engine.core.aaa.filters.SsoRestApiNegotiationFilter] (default task-7) []
SsoRestApiNegotiationFilter Not performing Negotiate Auth
>
> *</error>*
>
>
> _______________________________________________
> Devel mailing list
> Devel(a)ovirt.org
>
http://lists.ovirt.org/mailman/listinfo/devel
>