<div dir="ltr"><div>In any case the VM fails to run, can someone from virt team check the log ?<br><a href="http://jenkins.ovirt.org/job/test-repo_ovirt_experimental_4.1/37/artifact/exported-artifacts/basic_suite_4.1.sh-el7/exported-artifacts/test_logs/basic-suite-4.1/post-004_basic_sanity.py/lago-basic-suite-4-1-engine/_var_log_ovirt-engine/engine.log" target="_blank">http://jenkins.ovirt.org/job/<wbr>test-repo_ovirt_experimental_<wbr>4.1/37/artifact/exported-<wbr>artifacts/basic_suite_4.1.sh-<wbr>el7/exported-artifacts/test_<wbr>logs/basic-suite-4.1/post-004_<wbr>basic_sanity.py/lago-basic-<wbr>suite-4-1-engine/_var_log_<wbr>ovirt-engine/engine.log</a><br><br></div>Here a snippet :<br><pre>2016-12-22 08:43:37,134-05 DEBUG [org.ovirt.vdsm.jsonrpc.client.reactors.stomp.impl.Message] (SSL Stomp Reactor) [188ab77c] MESSAGE<br>content-length:743<br>destination:jms.queue.events<br>content-type:application/json<br>subscription:db78fa50-cfb9-462e-860f-871ea935d645<br><br>{"params": {"notify_time": 4295938370, "09f862a9-9531-4c4c-b846-0d95d374f29c": {"status": "Down", "timeOffset": "0", "exitReason": 1, "exitMessage": "internal error: qemu unexpectedly closed the monitor: 2016-12-22T13:43:35.791590Z qemu-kvm: warning: CPU(s) not present in any NUMA nodes: 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15\n2016-12-22T13:43:35.791854Z qemu-kvm: warning: All CPU(s) up to maxcpus should be described in NUMA config\n2016-12-22T13:43:35.840363Z qemu-kvm: -device usb-ccid,id=ccid0,bus=usb.0,port=1: Warning: speed mismatch trying to attach usb device \"QEMU USB CCID\" (full speed) to bus \"usb.0\", port \"1\" (high speed)", "exitCode": 1}}, "jsonrpc": "2.0", "method": "|virt|VM_status|09f862a9-9531-4c4c-b846-0d95d374f29c"}�<br>2016-12-22 08:43:37,134-05 DEBUG [org.ovirt.vdsm.jsonrpc.client.internal.ResponseWorker] (ResponseWorker) [] Message received: {"params": {"notify_time": 4295938370, "09f862a9-9531-4c4c-b846-0d95d374f29c": {"status": "Down", "timeOffset": "0", "exitReason": 1, "exitMessage": "internal error: qemu unexpectedly closed the monitor: 2016-12-22T13:43:35.791590Z qemu-kvm: warning: CPU(s) not present in any NUMA nodes: 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15\n2016-12-22T13:43:35.791854Z qemu-kvm: warning: All CPU(s) up to maxcpus should be described in NUMA config\n2016-12-22T13:43:35.840363Z qemu-kvm: -device usb-ccid,id=ccid0,bus=usb.0,port=1: Warning: speed mismatch trying to attach usb device \"QEMU USB CCID\" (full speed) to bus \"usb.0\", port \"1\" (high speed)", "exitCode": 1}}, "jsonrpc": "2.0", "method": "|virt|VM_status|09f862a9-9531-4c4c-b846-0d95d374f29c"}<br>2016-12-22 08:43:37,136-05 DEBUG [org.ovirt.vdsm.jsonrpc.client.internal.ResponseWorker] (ResponseWorker) [] Event arrived from 192.168.201.4 containing {"notify_time":4295938370,"09f862a9-9531-4c4c-b846-0d95d374f29c":{"status":"Down","timeOffset":"0","exitReason":1,"exitMessage":"internal error: qemu unexpectedly closed the monitor: 2016-12-22T13:43:35.791590Z qemu-kvm: warning: CPU(s) not present in any NUMA nodes: 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15\n2016-12-22T13:43:35.791854Z qemu-kvm: warning: All CPU(s) up to maxcpus should be described in NUMA config\n2016-12-22T13:43:35.840363Z qemu-kvm: -device usb-ccid,id=ccid0,bus=usb.0,port=1: Warning: speed mismatch trying to attach usb device \"QEMU USB CCID\" (full speed) to bus \"usb.0\", port \"1\" (high speed)","exitCode":1}}<br>2016-12-22 08:43:37,140-05 DEBUG [org.ovirt.engine.core.vdsbroker.monitoring.EventVmStatsRefresher] (ForkJoinPool-1-worker-4) [] processing event for host lago-basic-suite-4-1-host0 data:<br>notify_time = 4295938370<br>09f862a9-9531-4c4c-b846-0d95d374f29c:<br>status = Down<br>timeOffset = 0<br>exitReason = 1<br>exitMessage = internal error: qemu unexpectedly closed the monitor: 2016-12-22T13:43:35.791590Z qemu-kvm: warning: CPU(s) not present in any NUMA nodes: 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15<br>2016-12-22T13:43:35.791854Z qemu-kvm: warning: All CPU(s) up to maxcpus should be described in NUMA config<br>2016-12-22T13:43:35.840363Z qemu-kvm: -device usb-ccid,id=ccid0,bus=usb.0,port=1: Warning: speed mismatch trying to attach usb device "QEMU USB CCID" (full speed) to bus "usb.0", port "1" (high speed)<br>exitCode = 1<br><br><br>2016-12-22 08:43:37,143-05 DEBUG [org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerObjectsBuilder] (ForkJoinPool-1-worker-4) [] graphics data missing in XML.<br>2016-12-22 08:43:37,149-05 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-4) [] VM '09f862a9-9531-4c4c-b846-0d95d374f29c' was reported as Down on VDS '6337f989-31cd-4462-b4f6-448237c05cab'(lago-basic-suite-4-1-host0)<br>2016-12-22 0<br><br><br><br></pre><br></div><div class="gmail_extra"><br><div class="gmail_quote">On Thu, Dec 22, 2016 at 4:17 PM, Fred Rolland <span dir="ltr"><<a href="mailto:frolland@redhat.com" target="_blank">frolland@redhat.com</a>></span> wrote:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div dir="ltr"><div><div><a href="http://jenkins.ovirt.org/job/test-repo_ovirt_experimental_4.1/37/artifact/exported-artifacts/basic_suite_4.1.sh-el7/exported-artifacts/test_logs/basic-suite-4.1/post-004_basic_sanity.py/lago-basic-suite-4-1-engine/_var_log_ovirt-engine/engine.log" target="_blank">http://jenkins.ovirt.org/job/<wbr>test-repo_ovirt_experimental_<wbr>4.1/37/artifact/exported-<wbr>artifacts/basic_suite_4.1.sh-<wbr>el7/exported-artifacts/test_<wbr>logs/basic-suite-4.1/post-004_<wbr>basic_sanity.py/lago-basic-<wbr>suite-4-1-engine/_var_log_<wbr>ovirt-engine/engine.log</a><br><br></div>The "Duplicate Key" does not appear in the last log.<br></div></div><div class="HOEnZb"><div class="h5"><div class="gmail_extra"><br><div class="gmail_quote">On Thu, Dec 22, 2016 at 11:59 AM, Michal Skrivanek <span dir="ltr"><<a href="mailto:mskrivan@redhat.com" target="_blank">mskrivan@redhat.com</a>></span> wrote:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div style="word-wrap:break-word"><br><div><div><div class="m_429607003121544341h5"><blockquote type="cite"><div>On 22 Dec 2016, at 10:46, Michal Skrivanek <<a href="mailto:michal.skrivanek@redhat.com" target="_blank">michal.skrivanek@redhat.com</a>> wrote:</div><br class="m_429607003121544341m_6667473356216223790Apple-interchange-newline"><div><div style="font-family:Helvetica;font-size:12px;font-style:normal;font-variant-caps:normal;font-weight:normal;letter-spacing:normal;text-align:start;text-indent:0px;text-transform:none;white-space:normal;word-spacing:0px"><blockquote type="cite"><div><br class="m_429607003121544341m_6667473356216223790Apple-interchange-newline">On 22 Dec 2016, at 08:57, Doron Fediuck <<a href="mailto:dfediuck@redhat.com" target="_blank">dfediuck@redhat.com</a>> wrote:</div><br class="m_429607003121544341m_6667473356216223790Apple-interchange-newline"><div><div dir="ltr"><br><div class="gmail_extra"><br><div class="gmail_quote">On Thu, Dec 22, 2016 at 9:48 AM, Michal Skrivanek<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><span dir="ltr"><<a href="mailto:michal.skrivanek@redhat.com" target="_blank">michal.skrivanek@re<wbr>dhat.com</a>></span><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span>wrote:<br><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left-width:1px;border-left-style:solid;border-left-color:rgb(204,204,204);padding-left:1ex"><div style="word-wrap:break-word"><br><div><span class="m_429607003121544341m_6667473356216223790gmail-"><blockquote type="cite"><div>On 21 Dec 2016, at 20:52, Eyal Edri <<a href="mailto:eedri@redhat.com" target="_blank">eedri@redhat.com</a>> wrote:</div><br class="m_429607003121544341m_6667473356216223790gmail-m_-6974087903737897314Apple-interchange-newline"><div><div dir="auto">Not as easy at it sounds, the current flow of ost is much more complicated than just build artifacts. I'm not saving we won't do it, but it won't be ready tomorrow and we designed lago exactly for being independent of any ci system so anyone can run it on their laptop. </div></div></blockquote><div><br></div></span>+1</div><div>we just need to improve a little bit to make it possible for everyone. Almost there.</div><div><span class="m_429607003121544341m_6667473356216223790gmail-"><br><blockquote type="cite"><div><div dir="auto"><div dir="auto"> So maybe using Jenkins might be simpler but people shouldn't skip verification just because such a job doesn't exist yet. </div></div><div class="gmail_extra"><br><div class="gmail_quote">On Dec 21, 2016 9:02 PM, "Oved Ourfali" <<a href="mailto:oourfali@redhat.com" target="_blank">oourfali@redhat.com</a>> wrote:<br type="attribution"><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left-width:1px;border-left-style:solid;border-left-color:rgb(204,204,204);padding-left:1ex"><p dir="ltr">Why not run it via Jenkins for patches?<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><br>Like, if you add a comment saying "run: ost" it will run it?<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><br></p></blockquote></div></div></div></blockquote><div><br></div></span>please don’t add more. Even the Rerun-hooks thing is hard to remember. Even after years I always keep asking is it "Re-run hooks” or “Rerun-Hooks” or “rerun hooks”, does case matter…..bleh</div><div>Either add the button or maybe add it as a link in the automated comments (that would actually work good enough)</div><div><br></div><div>Thanks,</div><div>michal<div><div class="m_429607003121544341m_6667473356216223790gmail-h5"><br><blockquote type="cite"><div><div class="gmail_extra"><div class="gmail_quote"><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left-width:1px;border-left-style:solid;border-left-color:rgb(204,204,204);padding-left:1ex"><p dir="ltr">It do it automatically based on another thing?<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><br></p><p dir="ltr">On Dec 21, 2016 17:42, "Eyal Edri" <<a href="mailto:eedri@redhat.com" target="_blank">eedri@redhat.com</a>> wrote:<br>><br>><br>><br>> On Wed, Dec 21, 2016 at 5:36 PM, Michal Skrivanek <<a href="mailto:michal.skrivanek@redhat.com" target="_blank">michal.skrivanek@redhat.com</a>> wrote:<br>>><br>>><br>>>> On 21 Dec 2016, at 16:25, Yaniv Kaul <<a href="mailto:ykaul@redhat.com" target="_blank">ykaul@redhat.com</a>> wrote:<br>>>><br>>>><br>>>><br>>>> On Wed, Dec 21, 2016 at 5:19 PM, Michal Skrivanek <<a href="mailto:michal.skrivanek@redhat.com" target="_blank">michal.skrivanek@redhat.com</a>> wrote:<br>>>>><br>>>>><br>>>>>> On 21 Dec 2016, at 14:56, Michal Skrivanek <<a href="mailto:michal.skrivanek@redhat.com" target="_blank">michal.skrivanek@redhat.com</a>> wrote:<br>>>>>><br>>>>>><br>>>>>>> On 21 Dec 2016, at 12:19, Eyal Edri <<a href="mailto:eedri@redhat.com" target="_blank">eedri@redhat.com</a>> wrote:<br>>>>>>><br>>>>>>><br>>>>>>><br>>>>>>> On Wed, Dec 21, 2016 at 12:56 PM, Vinzenz Feenstra <<a href="mailto:vfeenstr@redhat.com" target="_blank">vfeenstr@redhat.com</a>> wrote:<br>>>>>>>><br>>>>>>>><br>>>>>>>>> On Dec 21, 2016, at 11:17 AM, Barak Korren <<a href="mailto:bkorren@redhat.com" target="_blank">bkorren@redhat.com</a>> wrote:<br>>>>>>>>><br>>>>>>>>> The test for running VMs had been failing since yesterday.<br>>>>>>>>><br>>>>>>>>> The patch merged before the failures started was:<br>>>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="https://gerrit.ovirt.org/#/c/68826/" target="_blank">https://gerrit.ovirt.<wbr>org/#/c/68826/</a><br>>>>>>>><br>>>>>>>><br>>>>>>>><br>>>>>>>><br>>>>>>>>><br>>>>>>>>> The error we`re seeing is a time-out (after two minutes) while running<br>>>>>>>>> this API call:<br>>>>>>>>><br>>>>>>>>> api.vms.get(VM0_NAME).status.s<wbr>tate == ‘up'<br>>>>>>>><br>>>>>>>><br>>>>>>>> This is a REST API call, the patch above is Frontend. So this is unrelated.<br>>>>>>>><br>>>>>>>> However on Host 0 I can see this:<br>>>>>>>><br>>>>>>>> 2016-12-20 16:54:43,544 ERROR (vm/d299ab29) [virt.vm] (vmId='d299ab29-284a-435c-a50f<wbr>-183a6e54def2') The vm start process failed (vm:615) Traceback (most recent call last): File "/usr/share/vdsm/virt/vm.py", line 551, in _startUnderlyingVm self._run() File "/usr/share/vdsm/virt/vm.py", line 1991, in _run self._connection.createXML(dom<wbr>xml, flags), File "/usr/lib/python2.7/site-packa<wbr>ges/vdsm/libvirtconnection.py"<wbr>, line 123, in wrapper ret = f(*args, **kwargs) File "/usr/lib/python2.7/site-packa<wbr>ges/vdsm/utils.py", line 941, in wrapper return func(inst, *args, **kwargs) File "/usr/lib64/python2.7/site-pac<wbr>kages/libvirt.py", line 3782, in createXML if ret is None:raise libvirtError('virDomainCreateX<wbr>ML() failed', conn=self) libvirtError: internal error: process exited while connecting to monitor: 2016-12-20T21:54:43.044971Z qemu-kvm: warning: CPU(s) not present in any NUMA nodes: 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 2016-12-20T21:54:43.045164Z qemu-kvm: warning: All CPU(s) up to maxcpus should be described in NUMA config 2016-12-20T21:54:43.101886Z qemu-kvm: -device usb-ccid,id=ccid0,bus=usb.0,po<wbr>rt=1: Warning: speed mismatch trying to attach usb device "QEMU USB CCID" (full speed) to bus "usb.0", port "1" (high speed)<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><br>>>>>><br>>>>>><br>>>>>> it is likely related to the recent USB patches <br>>>>>> investigating<br>>>>><br>>>>><br>>>>> hm, there are multiple problems (features/bugs depending on prefferred point of view:)<br>>>>> but there is an easy “fix” taking care of this particular problem, so we can start with that and figure out the proper approach later<br>>>>> arik will push that and merge it soon, likely today<br>>>><br>>>><br>>>> Thanks - if there is a quicker way to resolve this by reverting, I think it's a better option.<br>>><br>>><br>>> I really need to talk you out of this approach:-)<br>>> It does sound tempting and logical, but with our development model of large patch series combined with late detection it really is quite risky. Here it wouldn’t help much…and figuring out the right revert patch is more complicated then fixing it.<br>><br>><br>> Can we start asking developers run OST before they merge so it will be early detection and not late detection? <br>> We have video sessions on how to use OST, so it shouldn't be any issues in running it on a patch.<br>> <br>>><br>>> I believe the best is to identify it early and notify the maintainer who merged that patch ASAP, as that person is in the best position to asses if revert is safe or if there is a simple follow up patch he can push right away<br>>><br>>> We can surely improve on reporting, so Barak, how/why did you point to that particular patch in your email? It should start failing on 16c2ec236184b3152f1df8e874b431<wbr>15f78d0989 (CommitDate: Fri Dec 16 01:56:07 2016 -0500)<br>>> Even though it may be that it was hidden because of c46f653a7846c3c2a76507b8dcf<wbr>5bc0391ec5709 (CommitDate: Mon Dec 19 15:16:40 2016 -0500)<br>>><br>>> (fix is ready, waiting on CI now)<br>>><br>>> Thanks,<br>>> michal<br>>><br>>>> Y.<br>>>> <br>>>>><br>>>>><br>>>>>>>> 2016-12-20 16:54:43,550 INFO (vm/d299ab29) [virt.vm] (vmId='d299ab29-284a-435c-a50f<wbr>-183a6e54def2') Changed state to Down: internal error: process exited while connecting to monitor: 2016-12-20T21:54:43.044971Z qemu-kvm: warning: CPU(s) not present in any NUMA nodes: 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 2016-12-20T21:54:43.045164Z qemu-kvm: warning: All CPU(s) up to maxcpus should be described in NUMA config 2016-12-20T21:54:43.101886Z qemu-kvm: -device usb-ccid,id=ccid0,bus=usb.0,po<wbr>rt=1: Warning: speed mismatch trying to attach usb device "QEMU USB CCID" (full speed) to bus "usb.0", port "1" (high speed) (code=1) (vm:1197) 2016-12-20 16:54:43,550 INFO (vm/d299ab29) [virt.vm] (vmId='d299ab29-284a-435c-a50f<wbr>-183a6e54def2') Stopping connection (guestagent:430)<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><br>>>>>>>><br>>>>>>>><br>>>>>>>><br>>>>>>>> And on The engine loads of these:<br>>>>>>>><br>>>>>>>> 2016-12-20 16:53:57,844-05 ERROR [org.ovirt.engine.core.vdsbrok<wbr>er.vdsbroker.PollVDSCommand] (default task-17) [5ecd5a55-2b7a-4dd6-b42b-cc49b<wbr>bfb3962] Command 'PollVDSCommand(HostName = lago-basic-suite-4-1-host0, VdsIdVDSCommandParametersBase:<wbr>{runAsync='true', hostId='994b5d79-605f-4415-94f<wbr>2-02c79cfa246e'})' execution failed: VDSGenericException: VDSNetworkException: Timeout during rpc call 2016-12-20 16:53:57,849-05 DEBUG [org.ovirt.vdsm.jsonrpc.client<wbr>.reactors.stomp.impl.Message] (SSL Stomp Reactor) [7971dfb4] MESSAGE content-length:80 destination:jms.topic.vdsm_res<wbr>ponses content-type:application/json subscription:5b6494d5-d5a0-477<wbr>1-941c-a8be70f72450 {"jsonrpc": "2.0", "id": "3c95fdb0-5b77-4927-9f6e-adc73<wbr>95c122d", "result": true}� 2016-12-20 16:53:57,850-05 DEBUG [org.ovirt.vdsm.jsonrpc.client<wbr>.internal.ResponseWorker] (ResponseWorker) [] Message received: {"jsonrpc": "2.0", "id": "3c95fdb0-5b77-4927-9f6e-adc73<wbr>95c122d", "result": true} 2016-12-20 16:53:57,850-05 ERROR [org.ovirt.vdsm.jsonrpc.client<wbr>.JsonRpcClient] (ResponseWorker) [] Not able to update response for "3c95fdb0-5b77-4927-9f6e-adc73<wbr>95c122d" 2016-12-20 16:53:57,844-05 DEBUG [org.ovirt.engine.core.vdsbrok<wbr>er.vdsbroker.PollVDSCommand] (default task-17) [5ecd5a55-2b7a-4dd6-b42b-cc49b<wbr>bfb3962] Exception: org.ovirt.engine.core.vdsbroke<wbr>r.vdsbroker.VDSNetworkExceptio<wbr>n: VDSGenericException: VDSNetworkException: Timeout during rpc call at org.ovirt.engine.core.vdsbroke<wbr>r.vdsbroker.FutureVDSCommand.g<wbr>et(FutureVDSCommand.java:73) [vdsbroker.jar:] at org.ovirt.engine.core.bll.netw<wbr>ork.host.HostSetupNetworkPolle<wbr>r.getValue(HostSetupNetworkPol<wbr>ler.java:56) [bll.jar:] at org.ovirt.engine.core.bll.netw<wbr>ork.host.HostSetupNetworkPolle<wbr>r.poll(HostSetupNetworkPoller.<wbr>java:41) [bll.jar:] at org.ovirt.engine.core.bll.netw<wbr>ork.host.HostSetupNetworksComm<wbr>and.invokeSetupNetworksCommand<wbr>(HostSetupNetworksCommand.java<wbr>:426) [bll.jar:] at org.ovirt.engine.core.bll.netw<wbr>ork.host.HostSetupNetworksComm<wbr>and.executeCommand(HostSetupNe<wbr>tworksCommand.java:287) [bll.jar:] at org.ovirt.engine.core.bll.Comm<wbr>andBase.executeWithoutTransact<wbr>ion(CommandBase.java:1249) [bll.jar:] at org.ovirt.engine.core.bll.Comm<wbr>andBase.executeActionInTransac<wbr>tionScope(CommandBase.java:138<wbr>9) [bll.jar:] at org.ovirt.engine.core.bll.Comm<wbr>andBase.runInTransaction(Comma<wbr>ndBase.java:2053) [bll.jar:] at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://org.ovirt.engine.core.utils.tr/" target="_blank">org.ovirt.engine.core.utils<wbr>.tr</a>ansaction.TransactionSuppor<wbr>t.executeInSuppressed(<wbr>TransactionSupport.java:164) [utils.jar:] at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://org.ovirt.engine.core.utils.tr/" target="_blank">org.ovirt.engine.core.utils<wbr>.tr</a>ansaction.TransactionSuppor<wbr>t.executeInScope(<wbr>TransactionSupport.java:103) [utils.jar:] at org.ovirt.engine.core.bll.Comm<wbr>andBase.execute(CommandBase.ja<wbr>va:1449) [bll.jar:] at org.ovirt.engine.core.bll.Comm<wbr>andBase.executeAction(CommandB<wbr>ase.java:395) [bll.jar:] at org.ovirt.engine.core.bll.exec<wbr>utor.DefaultBackendActionExecu<wbr>tor.execute(DefaultBackendActi<wbr>onExecutor.java:13) [bll.jar:] at org.ovirt.engine.core.bll.Back<wbr>end.runAction(Backend.java:511<wbr>) [bll.jar:] at org.ovirt.engine.core.bll.Back<wbr>end.runActionImpl(Backend.java<wbr>:493) [bll.jar:] at org.ovirt.engine.core.bll.Back<wbr>end.runAction(Backend.java:446<wbr>) [bll.jar:] at sun.reflect.GeneratedMethodAcc<wbr>essor232.invoke(Unknown Source) [:1.8.0_111] at sun.reflect.DelegatingMethodAc<wbr>cessorImpl.invoke(DelegatingMe<wbr>thodAccessorImpl.java:43) [rt.jar:1.8.0_111] at java.lang.reflect.Method.invok<wbr>e(Method.java:498) [rt.jar:1.8.0_111] at org.jboss.as.ee.component.Mana<wbr>gedReferenceMethodInterceptor.<wbr>processInvocation(ManagedRefer<wbr>enceMethodInterceptor.java:52) at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.invocation.Intercept<wbr>orContext$Invocation.proceed(I<wbr>nterceptorContext.java:437) at org.jboss.as.weld.ejb.Jsr299Bi<wbr>ndingsInterceptor.delegateInte<wbr>rception(Jsr299BindingsInterce<wbr>ptor.java:70) [wildfly-weld-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.as.weld.ejb.Jsr299Bi<wbr>ndingsInterceptor.doMethodInte<wbr>rception(Jsr299BindingsInterce<wbr>ptor.java:80) [wildfly-weld-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.as.weld.ejb.Jsr299Bi<wbr>ndingsInterceptor.processInvoc<wbr>ation(Jsr299BindingsIntercepto<wbr>r.java:93) [wildfly-weld-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.as.ee.component.inte<wbr>rceptors.UserInterceptorFactor<wbr>y$1.processInvocation(UserInte<wbr>rceptorFactory.java:63) at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.invocation.Intercept<wbr>orContext$Invocation.proceed(I<wbr>nterceptorContext.java:437) at org.ovirt.engine.core.bll.inte<wbr>rceptors.CorrelationIdTrackerI<wbr>nterceptor.aroundInvoke(Correl<wbr>ationIdTrackerInterceptor.java<wbr>:13) [bll.jar:] at sun.reflect.GeneratedMethodAcc<wbr>essor64.invoke(Unknown Source) [:1.8.0_111] at sun.reflect.DelegatingMethodAc<wbr>cessorImpl.invoke(DelegatingMe<wbr>thodAccessorImpl.java:43) [rt.jar:1.8.0_111] at java.lang.reflect.Method.invok<wbr>e(Method.java:498) [rt.jar:1.8.0_111] at org.jboss.as.ee.component.Mana<wbr>gedReferenceLifecycleMethodInt<wbr>erceptor.processInvocation(Man<wbr>agedReferenceLifecycleMethodIn<wbr>terceptor.java:89) at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://org.jboss.as.ejb3.component.in/" target="_blank">org.jboss.as.ejb3.component<wbr>.in</a>vocationmetrics.ExecutionTi<wbr>meInterceptor.processInvocatio<wbr>n(ExecutionTimeInterceptor.<wbr>java:43) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.invocation.Intercept<wbr>orContext$Invocation.proceed(I<wbr>nterceptorContext.java:437) at org.jboss.weld.ejb.AbstractEJB<wbr>RequestScopeActivationIntercep<wbr>tor.aroundInvoke(AbstractEJBRe<wbr>questScopeActivationIntercepto<wbr>r.java:73) [weld-core-impl-2.3.5.Final.ja<wbr>r:2.3.5.Final] at org.jboss.as.weld.ejb.EjbReque<wbr>stScopeActivationInterceptor.p<wbr>rocessInvocation(EjbRequestSco<wbr>peActivationInterceptor.java:8<wbr>3) [wildfly-weld-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.as.ee.concurrent.Con<wbr>currentContextInterceptor.proc<wbr>essInvocation(ConcurrentContex<wbr>tInterceptor.java:45) [wildfly-ee-10.1.0.Final.jar:1<wbr>0.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.invocation.InitialIn<wbr>terceptor.processInvocation(In<wbr>itialInterceptor.java:21) at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.invocation.ChainedIn<wbr>terceptor.processInvocation(Ch<wbr>ainedInterceptor.java:61) at org.jboss.as.ee.component.inte<wbr>rceptors.ComponentDispatcherIn<wbr>terceptor.processInvocation(Co<wbr>mponentDispatcherInterceptor.j<wbr>ava:52) at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://org.jboss.as.ejb3.component.si/" target="_blank">org.jboss.as.ejb3.component<wbr>.si</a>ngleton.SingletonComponentI<wbr>nstanceAssociationInterceptor.<wbr>processInvocation(<wbr>SingletonComponentInstanceAsso<wbr>ciationInterceptor.java:53) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.as.ejb3.tx.CMTTxInte<wbr>rceptor.invokeInNoTx(CMTTxInte<wbr>rceptor.java:263) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.as.ejb3.tx.CMTTxInte<wbr>rceptor.supports(CMTTxIntercep<wbr>tor.java:374) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.as.ejb3.tx.CMTTxInte<wbr>rceptor.processInvocation(CMTT<wbr>xInterceptor.java:243) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://org.jboss.as.ejb3.component.in/" target="_blank">org.jboss.as.ejb3.component<wbr>.in</a>terceptors.CurrentInvocatio<wbr>nContextInterceptor.<wbr>processInvocation(CurrentInvoc<wbr>ationContextInterceptor.java:<wbr>41) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://org.jboss.as.ejb3.component.in/" target="_blank">org.jboss.as.ejb3.component<wbr>.in</a>vocationmetrics.WaitTimeInt<wbr>erceptor.processInvocation(<wbr>WaitTimeInterceptor.java:47) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.as.ejb3.security.Sec<wbr>urityContextInterceptor.proces<wbr>sInvocation(SecurityContextInt<wbr>erceptor.java:100) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.as.ejb3.deployment.p<wbr>rocessors.StartupAwaitIntercep<wbr>tor.processInvocation(StartupA<wbr>waitInterceptor.java:22) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://org.jboss.as.ejb3.component.in/" target="_blank">org.jboss.as.ejb3.component<wbr>.in</a>terceptors.ShutDownIntercep<wbr>torFactory$1.processInvocation<wbr>(ShutDownInterceptorFactory.<wbr>java:64) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://org.jboss.as.ejb3.component.in/" target="_blank">org.jboss.as.ejb3.component<wbr>.in</a>terceptors.LoggingIntercept<wbr>or.processInvocation(<wbr>LoggingInterceptor.java:67) [wildfly-ejb3-10.1.0.Final.jar<wbr>:10.1.0.Final] at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://org.jboss.as.ee.component.name/" target="_blank">org.jboss.as.ee.component.N<wbr>ame</a>spaceContextInterceptor.pro<wbr>cessInvocation(NamespaceContex<wbr>tInterceptor.java:50) at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.invocation.ContextCl<wbr>assLoaderInterceptor.processIn<wbr>vocation(ContextClassLoaderInt<wbr>erceptor.java:64) at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.invocation.Intercept<wbr>orContext.run(InterceptorConte<wbr>xt.java:356) at org.wildfly.security.manager.W<wbr>ildFlySecurityManager.doChecke<wbr>d(WildFlySecurityManager.java:<wbr>636) at org.jboss.invocation.AccessChe<wbr>ckingInterceptor.processInvoca<wbr>tion(AccessCheckingInterceptor<wbr>.java:61) at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.invocation.Intercept<wbr>orContext.run(InterceptorConte<wbr>xt.java:356) at org.jboss.invocation.Privilege<wbr>dWithCombinerInterceptor.proce<wbr>ssInvocation(PrivilegedWithCom<wbr>binerInterceptor.java:80) at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.invocation.ChainedIn<wbr>terceptor.processInvocation(Ch<wbr>ainedInterceptor.java:61) at org.jboss.as.ee.component.View<wbr>Service$View.invoke(ViewServic<wbr>e.java:198) at org.jboss.as.ee.component.View<wbr>Description$1.processInvocatio<wbr>n(ViewDescription.java:185) at org.jboss.invocation.Intercept<wbr>orContext.proceed(InterceptorC<wbr>ontext.java:340) at org.jboss.invocation.ChainedIn<wbr>terceptor.processInvocation(Ch<wbr>ainedInterceptor.java:61) at org.jboss.as.ee.component.Prox<wbr>yInvocationHandler.invoke(Prox<wbr>yInvocationHandler.java:73) at org.ovirt.engine.core.common.i<wbr>nterfaces.BackendLocal$$$view4<wbr>.runAction(Unknown Source) [common.jar:] at org.ovirt.engine.api.restapi.r<wbr>esource.BackendResource.doActi<wbr>on(BackendResource.java:250) at org.ovirt.engine.api.restapi.r<wbr>esource.BackendResource.perfor<wbr>mAction(BackendResource.java:1<wbr>82) at org.ovirt.engine.api.restapi.r<wbr>esource.BackendResource.perfor<wbr>mAction(BackendResource.java:1<wbr>70) at org.ovirt.engine.api.restapi.r<a href="http://esource.backendhostresource.se/" target="_blank"><wbr>esource.BackendHostResource.se</a><wbr>tupNetworks(BackendHostResourc<wbr>e.java:212) at org.ovirt.engine.api.v3.V3Serv<wbr>er.adaptAction(V3Server.java:2<wbr>16) at org.ovirt.engine.api.v3.server<wbr>s.V3HostServer.setupNetworks(V<wbr>3HostServer.java:182) at sun.reflect.NativeMethodAccess<wbr>orImpl.invoke0(Native Method) [rt.jar:1.8.0_111] at sun.reflect.NativeMethodAccess<wbr>orImpl.invoke(NativeMethodAcce<wbr>ssorImpl.java:62) [rt.jar:1.8.0_111] at sun.reflect.DelegatingMethodAc<wbr>cessorImpl.invoke(DelegatingMe<wbr>thodAccessorImpl.java:43) [rt.jar:1.8.0_111] at java.lang.reflect.Method.invok<wbr>e(Method.java:498) [rt.jar:1.8.0_111] at org.jboss.resteasy.core.Method<wbr>InjectorImpl.invoke(MethodInje<wbr>ctorImpl.java:139) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.core.Resour<wbr>ceMethodInvoker.invokeOnTarget<wbr>(ResourceMethodInvoker.java:29<wbr>5) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.core.Resour<wbr>ceMethodInvoker.invoke(Resourc<wbr>eMethodInvoker.java:249) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.core.Resour<wbr>ceLocatorInvoker.invokeOnTarge<wbr>tObject(ResourceLocatorInvoker<wbr>.java:138) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.core.Resour<wbr>ceLocatorInvoker.invoke(Resour<wbr>ceLocatorInvoker.java:107) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.core.Resour<wbr>ceLocatorInvoker.invokeOnTarge<wbr>tObject(ResourceLocatorInvoker<wbr>.java:133) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.core.Resour<wbr>ceLocatorInvoker.invoke(Resour<wbr>ceLocatorInvoker.java:101) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.core.Synchr<wbr>onousDispatcher.invoke(Synchro<wbr>nousDispatcher.java:402) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.core.Synchr<wbr>onousDispatcher.invoke(Synchro<wbr>nousDispatcher.java:209) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.plugins.ser<wbr>ver.servlet.ServletContainerDi<wbr>spatcher.service(ServletContai<wbr>nerDispatcher.java:221) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.plugins.ser<wbr>ver.servlet.HttpServletDispatc<wbr>her.service(HttpServletDispatc<wbr>her.java:56) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at org.jboss.resteasy.plugins.ser<wbr>ver.servlet.HttpServletDispatc<wbr>her.service(HttpServletDispatc<wbr>her.java:51) [resteasy-jaxrs-3.0.19.Final.j<wbr>ar:3.0.19.Final] at javax.servlet.http.HttpServlet<wbr>.service(HttpServlet.java:790) [jboss-servlet-api_3.1_spec-1.<wbr>0.0.Final.jar:1.0.0.Final] at io.undertow.servlet.handlers.S<wbr>ervletHandler.handleRequest(Se<wbr>rvletHandler.java:85) at io.undertow.servlet.handlers.F<wbr>ilterHandler.handleRequest(Fil<wbr>terHandler.java:81) at io.undertow.servlet.handlers.s<wbr>ecurity.ServletSecurityRoleHan<wbr>dler.handleRequest(ServletSecu<wbr>rityRoleHandler.java:62) at io.undertow.servlet.handlers.S<wbr>ervletDispatchingHandler.handl<wbr>eRequest(ServletDispatchingHan<wbr>dler.java:36) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://io.undertow.server.handlers.pr/" target="_blank">io.undertow.server.handlers<wbr>.Pr</a>edicateHandler.handleReques<wbr>t(PredicateHandler.java:43) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://io.undertow.server.handlers.pr/" target="_blank">io.undertow.server.handlers<wbr>.Pr</a>edicateHandler.handleReques<wbr>t(PredicateHandler.java:43) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://io.undertow.server.handlers.pr/" target="_blank">io.undertow.server.handlers<wbr>.Pr</a>edicateHandler.handleReques<wbr>t(PredicateHandler.java:43) at io.undertow.servlet.handlers.S<wbr>ervletInitialHandler.dispatchR<wbr>equest(ServletInitialHandler.j<wbr>ava:274) at io.undertow.servlet.handlers.S<wbr>ervletInitialHandler.dispatchT<wbr>oPath(ServletInitialHandler.ja<wbr>va:209) at io.undertow.servlet.spec.Reque<wbr>stDispatcherImpl.forwardImpl(R<wbr>equestDispatcherImpl.java:221) at io.undertow.servlet.spec.Reque<wbr>stDispatcherImpl.forwardImplSe<wbr>tup(RequestDispatcherImpl.java<wbr>:147) at io.undertow.servlet.spec.Reque<wbr>stDispatcherImpl.forward(Reque<wbr>stDispatcherImpl.java:111) at org.ovirt.engine.api.restapi.i<wbr>nvocation.VersionFilter.doFilt<wbr>er(VersionFilter.java:139) at org.ovirt.engine.api.restapi.i<wbr>nvocation.VersionFilter.doFilt<wbr>er(VersionFilter.java:68) at io.undertow.servlet.core.Manag<wbr>edFilter.doFilter(ManagedFilte<wbr>r.java:61) at io.undertow.servlet.handlers.F<wbr>ilterHandler$FilterChainImpl.d<wbr>oFilter(FilterHandler.java:131<wbr>) at org.ovirt.engine.api.restapi.i<wbr>nvocation.CurrentFilter.doFilt<wbr>er(CurrentFilter.java:116) at org.ovirt.engine.api.restapi.i<wbr>nvocation.CurrentFilter.doFilt<wbr>er(CurrentFilter.java:71) at io.undertow.servlet.core.Manag<wbr>edFilter.doFilter(ManagedFilte<wbr>r.java:61) at io.undertow.servlet.handlers.F<wbr>ilterHandler$FilterChainImpl.d<wbr>oFilter(FilterHandler.java:131<wbr>) at org.ovirt.engine.core.aaa.filt<wbr>ers.RestApiSessionMgmtFilter.d<wbr>oFilter(RestApiSessionMgmtFilt<wbr>er.java:78) [aaa.jar:] at io.undertow.servlet.core.Manag<wbr>edFilter.doFilter(ManagedFilte<wbr>r.java:61) at io.undertow.servlet.handlers.F<wbr>ilterHandler$FilterChainImpl.d<wbr>oFilter(FilterHandler.java:131<wbr>) at org.ovirt.engine.core.aaa.filt<wbr>ers.EnforceAuthFilter.doFilter<wbr>(EnforceAuthFilter.java:39) [aaa.jar:] at io.undertow.servlet.core.Manag<wbr>edFilter.doFilter(ManagedFilte<wbr>r.java:61) at io.undertow.servlet.handlers.F<wbr>ilterHandler$FilterChainImpl.d<wbr>oFilter(FilterHandler.java:131<wbr>) at org.ovirt.engine.core.aaa.filt<wbr>ers.SsoRestApiNegotiationFilte<wbr>r.doFilter(SsoRestApiNegotiati<wbr>onFilter.java:91) [aaa.jar:] at io.undertow.servlet.core.Manag<wbr>edFilter.doFilter(ManagedFilte<wbr>r.java:61) at io.undertow.servlet.handlers.F<wbr>ilterHandler$FilterChainImpl.d<wbr>oFilter(FilterHandler.java:131<wbr>) at org.ovirt.engine.core.aaa.filt<wbr>ers.SsoRestApiAuthFilter.doFil<wbr>ter(SsoRestApiAuthFilter.java:<wbr>47) [aaa.jar:] at io.undertow.servlet.core.Manag<wbr>edFilter.doFilter(ManagedFilte<wbr>r.java:61) at io.undertow.servlet.handlers.F<wbr>ilterHandler$FilterChainImpl.d<wbr>oFilter(FilterHandler.java:131<wbr>) at org.ovirt.engine.core.aaa.filt<a href="http://ers.sessionvalidationfilter.do/" target="_blank"><wbr>ers.SessionValidationFilter.do</a><wbr>Filter(SessionValidationFilter<wbr>.java:59) [aaa.jar:] at io.undertow.servlet.core.Manag<wbr>edFilter.doFilter(ManagedFilte<wbr>r.java:61) at io.undertow.servlet.handlers.F<wbr>ilterHandler$FilterChainImpl.d<wbr>oFilter(FilterHandler.java:131<wbr>) at org.ovirt.engine.core.aaa.filt<wbr>ers.RestApiSessionValidationFi<wbr>lter.doFilter(RestApiSessionVa<wbr>lidationFilter.java:35) [aaa.jar:] at io.undertow.servlet.core.Manag<wbr>edFilter.doFilter(ManagedFilte<wbr>r.java:61) at io.undertow.servlet.handlers.F<wbr>ilterHandler$FilterChainImpl.d<wbr>oFilter(FilterHandler.java:131<wbr>) at org.ovirt.engine.api.restapi.s<wbr>ecurity.CSRFProtectionFilter.d<wbr>oFilter(CSRFProtectionFilter.j<wbr>ava:111) at org.ovirt.engine.api.restapi.s<wbr>ecurity.CSRFProtectionFilter.d<wbr>oFilter(CSRFProtectionFilter.j<wbr>ava:102) at io.undertow.servlet.core.Manag<wbr>edFilter.doFilter(ManagedFilte<wbr>r.java:61) at io.undertow.servlet.handlers.F<wbr>ilterHandler$FilterChainImpl.d<wbr>oFilter(FilterHandler.java:131<wbr>) at org.ovirt.engine.api.restapi.s<wbr>ecurity.CORSSupportFilter.doFi<wbr>lter(CORSSupportFilter.java:18<wbr>3) at io.undertow.servlet.core.Manag<wbr>edFilter.doFilter(ManagedFilte<wbr>r.java:61) at io.undertow.servlet.handlers.F<wbr>ilterHandler$FilterChainImpl.d<wbr>oFilter(FilterHandler.java:131<wbr>) at io.undertow.servlet.handlers.F<wbr>ilterHandler.handleRequest(Fil<wbr>terHandler.java:84) at io.undertow.servlet.handlers.s<wbr>ecurity.ServletSecurityRoleHan<wbr>dler.handleRequest(ServletSecu<wbr>rityRoleHandler.java:62) at io.undertow.servlet.handlers.S<wbr>ervletDispatchingHandler.handl<wbr>eRequest(ServletDispatchingHan<wbr>dler.java:36) at org.wildfly.extension.undertow<wbr>.security.SecurityContextAssoc<wbr>iationHandler.handleRequest(Se<wbr>curityContextAssociationHandle<wbr>r.java:78) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://io.undertow.server.handlers.pr/" target="_blank">io.undertow.server.handlers<wbr>.Pr</a>edicateHandler.handleReques<wbr>t(PredicateHandler.java:43) at io.undertow.servlet.handlers.s<wbr>ecurity.SSLInformationAssociat<wbr>ionHandler.handleRequest(SSLIn<wbr>formationAssociationHandler.ja<wbr>va:131) at io.undertow.servlet.handlers.s<wbr>ecurity.ServletAuthenticationC<wbr>allHandler.handleRequest(Servl<wbr>etAuthenticationCallHandler.ja<wbr>va:57) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://io.undertow.server.handlers.pr/" target="_blank">io.undertow.server.handlers<wbr>.Pr</a>edicateHandler.handleReques<wbr>t(PredicateHandler.java:43) at io.undertow.security.handlers.<wbr>AuthenticationConstraintHandle<wbr>r.handleRequest(Authentication<wbr>ConstraintHandler.java:53) at io.undertow.security.handlers.<wbr>AbstractConfidentialityHandler<wbr>.handleRequest(AbstractConfide<wbr>ntialityHandler.java:46) at io.undertow.servlet.handlers.s<wbr>ecurity.ServletConfidentiality<wbr>ConstraintHandler.handleReques<wbr>t(ServletConfidentialityConstr<wbr>aintHandler.java:64) at io.undertow.servlet.handlers.s<wbr>ecurity.ServletSecurityConstra<wbr>intHandler.handleRequest(Servl<wbr>etSecurityConstraintHandler.ja<wbr>va:59) at io.undertow.security.handlers.<wbr>AuthenticationMechanismsHandle<wbr>r.handleRequest(Authentication<wbr>MechanismsHandler.java:60) at io.undertow.servlet.handlers.s<wbr>ecurity.CachedAuthenticatedSes<wbr>sionHandler.handleRequest(Cach<wbr>edAuthenticatedSessionHandler.<wbr>java:77) at io.undertow.security.handlers.<wbr>NotificationReceiverHandler.ha<wbr>ndleRequest(NotificationReceiv<wbr>erHandler.java:50) at io.undertow.security.handlers.<wbr>AbstractSecurityContextAssocia<wbr>tionHandler.handleRequest(Abst<wbr>ractSecurityContextAssociation<wbr>Handler.java:43) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://io.undertow.server.handlers.pr/" target="_blank">io.undertow.server.handlers<wbr>.Pr</a>edicateHandler.handleReques<wbr>t(PredicateHandler.java:43) at org.wildfly.extension.undertow<wbr>.security.jacc.JACCContextIdHa<wbr>ndler.handleRequest(JACCContex<wbr>tIdHandler.java:61) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://io.undertow.server.handlers.pr/" target="_blank">io.undertow.server.handlers<wbr>.Pr</a>edicateHandler.handleReques<wbr>t(PredicateHandler.java:43) at<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://io.undertow.server.handlers.pr/" target="_blank">io.undertow.server.handlers<wbr>.Pr</a>edicateHandler.handleReques<wbr>t(PredicateHandler.java:43) at io.undertow.servlet.handlers.S<wbr>ervletInitialHandler.handleFir<wbr>stRequest(ServletInitialHandle<wbr>r.java:292) at io.undertow.servlet.handlers.S<wbr>ervletInitialHandler.access$10<wbr>0(ServletInitialHandler.java:8<wbr>1) at io.undertow.servlet.handlers.S<wbr>ervletInitialHandler$2.call(Se<wbr>rvletInitialHandler.java:138) at io.undertow.servlet.handlers.S<wbr>ervletInitialHandler$2.call(Se<wbr>rvletInitialHandler.java:135) at io.undertow.servlet.core.Servl<wbr>etRequestContextThreadSetupAct<wbr>ion$1.call(ServletRequestConte<wbr>xtThreadSetupAction.java:48) at io.undertow.servlet.core.Conte<wbr>xtClassLoaderSetupAction$1.cal<wbr>l(ContextClassLoaderSetupActio<wbr>n.java:43) at io.undertow.servlet.api.Legacy<wbr>ThreadSetupActionWrapper$1.cal<wbr>l(LegacyThreadSetupActionWrapp<wbr>er.java:44) at io.undertow.servlet.api.Legacy<wbr>ThreadSetupActionWrapper$1.cal<wbr>l(LegacyThreadSetupActionWrapp<wbr>er.java:44) at io.undertow.servlet.api.Legacy<wbr>ThreadSetupActionWrapper$1.cal<wbr>l(LegacyThreadSetupActionWrapp<wbr>er.java:44) at io.undertow.servlet.api.Legacy<wbr>ThreadSetupActionWrapper$1.cal<wbr>l(LegacyThreadSetupActionWrapp<wbr>er.java:44) at io.undertow.servlet.handlers.S<wbr>ervletInitialHandler.dispatchR<wbr>equest(ServletInitialHandler.j<wbr>ava:272) at io.undertow.servlet.handlers.S<wbr>ervletInitialHandler.access$00<wbr>0(ServletInitialHandler.java:8<wbr>1) at io.undertow.servlet.handlers.S<wbr>ervletInitialHandler$1.handleR<wbr>equest(ServletInitialHandler.j<wbr>ava:104) at io.undertow.server.Connectors.<wbr>executeRootHandler(Connectors.<wbr>java:202) at io.undertow.server.HttpServerE<wbr>xchange$1.run(HttpServerExchan<wbr>ge.java:805) at java.util.concurrent.ThreadPoo<wbr>lExecutor.runWorker(ThreadPool<wbr>Executor.java:1142) [rt.jar:1.8.0_111] at java.util.concurrent.ThreadPoo<wbr>lExecutor$Worker.run(ThreadPoo<wbr>lExecutor.java:617) [rt.jar:1.8.0_111] at java.lang.Thread.run(Thread.ja<wbr>va:745) [rt.jar:1.8.0_111] 2016-12-20 16:53:57,859-05 ERROR [org.ovirt.engine.core.vdsbrok<wbr>er.vdsbroker.PollVDSCommand] (default task-17) [5ecd5a55-2b7a-4dd6-b42b-cc49b<wbr>bfb3962] Timeout waiting for VDSM response: Internal timeout occured<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><br>>>>>>>><br>>>>>>>><br>>>>>>>> This is definitely not related to the patch linked above.<br>>>>>>>><br>>>>>>>> However I am also not quite sure what is the cause of this right now, it might be a breaking change in VDSM.<br>>>>>>>><br>>>>>>><br>>>>>>> The DC level is 4.0, is it possible that is the reason for the failure? <br>>>>>>><br>>>>>>> <br>>>>>>>><br>>>>>>>><br>>>>>>>>><br>>>>>>>>> Full test code can be seen here:<br>>>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="https://gerrit.ovirt.org/gitweb?p=ovirt-system-tests.git;a=blob;f=basic-suite-4.1/test-scenarios/004_basic_sanity.py;hb=refs/heads/master#l291" target="_blank">https://gerrit.ovirt.<wbr>org/gitweb?p=ovirt-system-test<wbr>s.git;a=blob;f=basic-suite-4.<wbr>1/test-scenarios/004_basic_<wbr>sanity.py;hb=refs/heads/master<wbr>#l291</a><br>>>>>>>>><br>>>>>>>>> Full test exception can be seen here:<br>>>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://jenkins.ovirt.org/job/test-repo_ovirt_experimental_4.1/13/testReport/junit/%28root%29/004_basic_sanity/vm_run/" target="_blank">http://jenkins.ovirt.<wbr>org/job/test-repo_ovirt_experi<wbr>mental_4.1/13/testReport/<wbr>junit/%28root%29/004_basic_<wbr>sanity/vm_run/</a><br>>>>>>>>><br>>>>>>>>> Further logs can be seen in Jenkins:<br>>>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://jenkins.ovirt.org/job/test-repo_ovirt_experimental_4.1/13/artifact/exported-artifacts/basic_suite_4.1.sh-el7/exported-artifacts/test_logs/basic-suite-4.1/post-004_basic_sanity.py/" target="_blank">http://jenkins.ovirt.<wbr>org/job/test-repo_ovirt_experi<wbr>mental_4.1/13/artifact/exporte<wbr>d-artifacts/basic_suite_4.1.<wbr>sh-el7/exported-artifacts/<wbr>test_logs/basic-suite-4.1/<wbr>post-004_basic_sanity.py/</a><br>>>>>>>>><br>>>>>>>>> --<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><br>>>>>>>>> Barak Korren<br>>>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="mailto:bkorren@redhat.com" target="_blank">bkorren@redhat.com</a><br>>>>>>>>> RHCE, RHCi, RHV-DevOps Team<br>>>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="https://ifireball.wordpress.com/" target="_blank">https://ifireball.wor<wbr>dpress.com/</a><br>>>>>>>>> ______________________________<wbr>_________________<br>>>>>>>>> Devel mailing list<br>>>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="mailto:Devel@ovirt.org" target="_blank">Devel@ovirt.org</a><br>>>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://lists.ovirt.org/mailman/listinfo/devel" target="_blank">http://lists.ovirt.or<wbr>g/mailman/listinfo/devel</a><br>>>>>>>><br>>>>>>>><br>>>>>>>><br>>>>>>>> ______________________________<wbr>_________________<br>>>>>>>> Devel mailing list<br>>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="mailto:Devel@ovirt.org" target="_blank">Devel@ovirt.org</a><br>>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://lists.ovirt.org/mailman/listinfo/devel" target="_blank">http://lists.ovirt.org<wbr>/mailman/listinfo/devel</a><br>>>>>>><br>>>>>>><br>>>>>>><br>>>>>>><br>>>>>>> --<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><br>>>>>>> Eyal Edri<br>>>>>>> Associate Manager<br>>>>>>> RHV DevOps<br>>>>>>> EMEA ENG Virtualization R&D<br>>>>>>> Red Hat Israel<br>>>>>>><br>>>>>>> phone:<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="tel:+972%209-769-2018" value="+97297692018" target="_blank">+972-9-7692018</a><br>>>>>>> irc: eedri (on #tlv #rhev-dev #rhev-integ)<br>>>>>>> ______________________________<wbr>_________________<br>>>>>>> Devel mailing list<br>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="mailto:Devel@ovirt.org" target="_blank">Devel@ovirt.org</a><br>>>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://lists.ovirt.org/mailman/listinfo/devel" target="_blank">http://lists.ovirt.org/<wbr>mailman/listinfo/devel</a><br>>>>>><br>>>>>><br>>>>><br>>>>><br>>>>> ______________________________<wbr>_________________<br>>>>> Devel mailing list<br>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="mailto:Devel@ovirt.org" target="_blank">Devel@ovirt.org</a><br>>>>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://lists.ovirt.org/mailman/listinfo/devel" target="_blank">http://lists.ovirt.org/ma<wbr>ilman/listinfo/devel</a><br>>>><br>>>><br>>><br>><br>><br>><br>> --<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><br>> Eyal Edri<br>> Associate Manager<br>> RHV DevOps<br>> EMEA ENG Virtualization R&D<br>> Red Hat Israel<br>><br>> phone:<span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="tel:+972%209-769-2018" value="+97297692018" target="_blank">+972-9-7692018</a><br>> irc: eedri (on #tlv #rhev-dev #rhev-integ)<br>><br>> ______________________________<wbr>_________________<br>> Devel mailing list<br>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="mailto:Devel@ovirt.org" target="_blank">Devel@ovirt.org</a><br>><span class="m_429607003121544341m_6667473356216223790Apple-converted-space"> </span><a href="http://lists.ovirt.org/mailman/listinfo/devel" target="_blank">http://lists.ovirt.org/mailm<wbr>an/listinfo/devel</a><br></p></blockquote></div></div></div></blockquote></div></div></div><br></div><br>______________________________<wbr>_________________<br>Devel mailing list<br><a href="mailto:Devel@ovirt.org" target="_blank">Devel@ovirt.org</a><br><a href="http://lists.ovirt.org/mailman/listinfo/devel" rel="noreferrer" target="_blank">http://lists.ovirt.org/mailman<wbr>/listinfo/devel</a><br></blockquote></div><br></div><div class="gmail_extra">Guys,</div><div class="gmail_extra">4.1 is broken for 11 hours now.</div><div class="gmail_extra">It seems that the issues are accumulating; looking into <a href="http://jenkins.ovirt.org/job/test-repo_ovirt_experimental_4.1/28/artifact/exported-artifacts/basic_suite_4.1.sh-el7/exported-artifacts/test_logs/basic-suite-4.1/post-004_basic_sanity.py/lago-basic-suite-4-1-engine/_var_log_ovirt-engine/engine.log" target="_blank">http://jenkins.ovirt.org/<wbr>job/test-repo_ovirt_experiment<wbr>al_4.1/28/artifact/exported-<wbr>artifacts/basic_suite_4.1.sh-<wbr>el7/exported-artifacts/test_<wbr>logs/basic-suite-4.1/post-004_<wbr>basic_sanity.py/lago-basic-<wbr>suite-4-1-engine/_var_log_<wbr>ovirt-engine/engine.log</a></div><div class="gmail_extra"><br></div><div class="gmail_extra">shows a duplicate entry in disk mapping:</div></div></div></blockquote><div><br></div>interesting error, Arik. Reruns should be added to lago</div><div style="font-family:Helvetica;font-size:12px;font-style:normal;font-variant-caps:normal;font-weight:normal;letter-spacing:normal;text-align:start;text-indent:0px;text-transform:none;white-space:normal;word-spacing:0px">The root cause is few lines above and the same as was fixed yesterday on master. It just needs a backport to 4.1 <br><blockquote type="cite"><div><div dir="ltr"><div class="gmail_extra"><pre>2016-12-21 10:52:51,436-05 ERROR [org.ovirt.engine.core.bll.Run<wbr>VmOnceCommand] (org.ovirt.thread.pool-6-threa<wbr>d-37) [] Error during ValidateFailure.: java.lang.IllegalStateExceptio<wbr>n: Duplicate key org.ovirt.engine.core.common.b<wbr>usinessentities.storage.DiskVm<wbr>Element@8f24f60b
at <a href="http://java.util.stream.Collectors.la">java.util.stream.Collectors.la</a><wbr>mbda$throwingMerger$0(Collecto<wbr>rs.java:133) [rt.jar:1.8.0_111]
at java.util.HashMap.merge(HashMa<wbr>p.java:1253) [rt.jar:1.8.0_111]
at <a href="http://java.util.stream.Collectors.la">java.util.stream.Collectors.la</a><wbr>mbda$toMap$58(Collectors.java:<wbr>1320) [rt.jar:1.8.0_111]
at java.util.stream.ReduceOps$3Re<wbr>ducingSink.accept(ReduceOps.<wbr>java:169) [rt.jar:1.8.0_111]
at java.util.ArrayList$ArrayListS<wbr>pliterator.forEachRemaining(<wbr>ArrayList.java:1374) [rt.jar:1.8.0_111]
at java.util.stream.AbstractPipel<wbr>ine.copyInto(AbstractPipeline.<wbr>java:481) [rt.jar:1.8.0_111]
at java.util.stream.AbstractPipel<wbr>ine.wrapAndCopyInto(AbstractPi<wbr>peline.java:471) [rt.jar:1.8.0_111]
at java.util.stream.ReduceOps$Red<wbr>uceOp.evaluateSequential(Reduc<wbr>eOps.java:708) [rt.jar:1.8.0_111]
at java.util.stream.AbstractPipel<wbr>ine.evaluate(AbstractPipeline.<wbr>java:234) [rt.jar:1.8.0_111]
at java.util.stream.ReferencePipe<wbr>line.collect(ReferencePipeline<wbr>.java:499) [rt.jar:1.8.0_111]
at org.ovirt.engine.core.bll.stor<wbr>age.disk.DiskHandler.getDiskTo<wbr>DiskVmElementMap(DiskHandler.<wbr>java:46) [bll.jar:]
at org.ovirt.engine.core.bll.vali<wbr>dator.RunVmValidator.validateD<wbr>isksPassDiscard(RunVmValidator<wbr>.java:318) [bll.jar:]
at org.ovirt.engine.core.bll.vali<wbr>dator.RunVmValidator.canRunVm(<wbr>RunVmValidator.java:146) [bll.jar:]
at org.ovirt.engine.core.bll.RunV<wbr>mCommand.validate(RunVmCommand<wbr>.java:920) [bll.jar:]
at org.ovirt.engine.core.bll.RunV<wbr>mOnceCommand.validate(RunVmOnc<wbr>eCommand.java:58) [bll.jar:]
at org.ovirt.engine.core.bll.Comm<wbr>andBase.internalValidate(Comma<wbr>ndBase.java:834) [bll.jar:]
at org.ovirt.engine.core.bll.Comm<wbr>andBase.executeAction(CommandB<wbr>ase.java:388) [bll.jar:]
at org.ovirt.engine.core.bll.RunV<wbr>mCommandBase.reexecuteCommand(<wbr>RunVmCommandBase.java:163) [bll.jar:]
at org.ovirt.engine.core.bll.RunV<wbr>mCommandBase.rerun(RunVmComman<wbr>dBase.java:138) [bll.jar:]
at org.ovirt.engine.core.bll.RunV<wbr>mCommand.rerun(RunVmCommand.<wbr>java:327) [bll.jar:]</pre></div></div></div></blockquote></div></div></blockquote><div><br></div></div></div>But as I understood from Arik this is indeed a separate problem in rerun, likely caused by recent storage code. Adding Tal<span><br><blockquote type="cite"><div><div style="font-family:Helvetica;font-size:12px;font-style:normal;font-variant-caps:normal;font-weight:normal;letter-spacing:normal;text-align:start;text-indent:0px;text-transform:none;white-space:normal;word-spacing:0px"><blockquote type="cite"><div><div dir="ltr"><div class="gmail_extra"><pre><br></pre><pre>I suggest we consider reverting to the last good state, and work out the issues from there.</pre></div></div></div></blockquote></div></div></blockquote></span></div><br></div><br>______________________________<wbr>_________________<br>
Devel mailing list<br>
<a href="mailto:Devel@ovirt.org" target="_blank">Devel@ovirt.org</a><br>
<a href="http://lists.ovirt.org/mailman/listinfo/devel" rel="noreferrer" target="_blank">http://lists.ovirt.org/mailman<wbr>/listinfo/devel</a><br></blockquote></div><br></div>
</div></div></blockquote></div><br></div>