<div dir="ltr"><div>I forgot to add the polling after the second snapshot as well, it was added in this patch: <a href="https://gerrit.ovirt.org/#/c/89577/">https://gerrit.ovirt.org/#/c/89577/</a><br><br></div>Sorry for the inconvenience<br></div><div class="gmail_extra"><br><div class="gmail_quote">On Thu, Mar 29, 2018 at 1:46 PM, Yedidyah Bar David <span dir="ltr">&lt;<a href="mailto:didi@redhat.com" target="_blank">didi@redhat.com</a>&gt;</span> wrote:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><span class="">On Wed, Mar 28, 2018 at 4:19 PM, Gal Ben Haim &lt;<a href="mailto:gbenhaim@redhat.com">gbenhaim@redhat.com</a>&gt; wrote:<br>
&gt;<br>
&gt;<br>
&gt; On Wed, Mar 28, 2018 at 2:48 PM, Benny Zlotnik &lt;<a href="mailto:bzlotnik@redhat.com">bzlotnik@redhat.com</a>&gt; wrote:<br>
&gt;&gt;<br>
&gt;&gt; <a href="https://gerrit.ovirt.org/#/c/89534/" rel="noreferrer" target="_blank">https://gerrit.ovirt.org/#/c/<wbr>89534/</a><br>
&gt;&gt; <a href="https://gerrit.ovirt.org/#/c/89537/" rel="noreferrer" target="_blank">https://gerrit.ovirt.org/#/c/<wbr>89537/</a><br>
&gt;<br>
&gt;<br>
&gt; Merged.<br>
<br>
</span>Seems like it failed again similarly:<br>
<br>
08:05:07     vm1_snapshots_service.<wbr>snapshot_service(<a href="http://snapshot.id" rel="noreferrer" target="_blank">snapshot.id</a>).<wbr>remove()<br>
08:05:07   File<br>
&quot;/usr/lib64/python2.7/site-<wbr>packages/ovirtsdk4/services.<wbr>py&quot;, line<br>
20230, in remove<br>
08:05:07     self._internal_remove(headers, query, wait)<br>
08:05:07   File<br>
&quot;/usr/lib64/python2.7/site-<wbr>packages/ovirtsdk4/service.py&quot;<wbr>, line 271,<br>
in _internal_remove<br>
08:05:07     return future.wait() if wait else future<br>
08:05:07   File<br>
&quot;/usr/lib64/python2.7/site-<wbr>packages/ovirtsdk4/service.py&quot;<wbr>, line 55, in<br>
wait<br>
08:05:07     return self._code(response)<br>
08:05:07   File<br>
&quot;/usr/lib64/python2.7/site-<wbr>packages/ovirtsdk4/service.py&quot;<wbr>, line 268,<br>
in callback<br>
08:05:07     self._check_fault(response)<br>
08:05:07   File<br>
&quot;/usr/lib64/python2.7/site-<wbr>packages/ovirtsdk4/service.py&quot;<wbr>, line 132,<br>
in _check_fault<br>
08:05:07     self._raise_error(response, body)<br>
08:05:07   File<br>
&quot;/usr/lib64/python2.7/site-<wbr>packages/ovirtsdk4/service.py&quot;<wbr>, line 118,<br>
in _raise_error<br>
08:05:07     raise error<br>
08:05:07 Error: Fault reason is &quot;Operation Failed&quot;. Fault detail is<br>
&quot;[Cannot remove Snapshot. Snapshot is currently being created for VM<br>
vm1.]&quot;. HTTP response code is 409.<br>
<br>
<a href="http://jenkins.ovirt.org/job/ovirt-system-tests_master_check-patch-el7-x86_64/4770/consoleFull" rel="noreferrer" target="_blank">http://jenkins.ovirt.org/job/<wbr>ovirt-system-tests_master_<wbr>check-patch-el7-x86_64/4770/<wbr>consoleFull</a><br>
<br>
Can you please check? Thanks.<br>
<div><div class="h5"><br>
&gt;&gt;<br>
&gt;&gt;<br>
&gt;&gt;<br>
&gt;&gt; On Wed, Mar 28, 2018 at 12:01 PM, Dafna Ron &lt;<a href="mailto:dron@redhat.com">dron@redhat.com</a>&gt; wrote:<br>
&gt;&gt;&gt;<br>
&gt;&gt;&gt; Thanks Beni.<br>
&gt;&gt;&gt;<br>
&gt;&gt;&gt; can you please paste the fix that you submit to the mail?<br>
&gt;&gt;&gt;<br>
&gt;&gt;&gt; Thanks,<br>
&gt;&gt;&gt; Dafna<br>
&gt;&gt;&gt;<br>
&gt;&gt;&gt;<br>
&gt;&gt;&gt; On Wed, Mar 28, 2018 at 9:13 AM, Benny Zlotnik &lt;<a href="mailto:bzlotnik@redhat.com">bzlotnik@redhat.com</a>&gt;<br>
&gt;&gt;&gt; wrote:<br>
&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt; This issue looks like it&#39;s caused by the DB lock being released before<br>
&gt;&gt;&gt;&gt; the engine memory lock, there was a similar race with the LSM test a few<br>
&gt;&gt;&gt;&gt; months back. I&#39;ll apply the same fix for the snapshot_cold_merge.<br>
&gt;&gt;&gt;&gt; .<br>
&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt; On Tue, Mar 27, 2018 at 10:03 PM, Benny Zlotnik &lt;<a href="mailto:bzlotnik@redhat.com">bzlotnik@redhat.com</a>&gt;<br>
&gt;&gt;&gt;&gt; wrote:<br>
&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt; Looking into this<br>
&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt; On Tue, Mar 27, 2018 at 6:45 PM, Dafna Ron &lt;<a href="mailto:dron@redhat.com">dron@redhat.com</a>&gt; wrote:<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; Hi,<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; We have a failure on 004_basic_sanity.disk_<wbr>operations. the reported<br>
&gt;&gt;&gt;&gt;&gt;&gt; change seems to me to be connected to the failure.<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; Link and headline of suspected patches:<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; core: introduce CreateSnapshotForVm -<br>
&gt;&gt;&gt;&gt;&gt;&gt; <a href="https://gerrit.ovirt.org/#/c/87671/" rel="noreferrer" target="_blank">https://gerrit.ovirt.org/#/c/<wbr>87671/</a><br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; Link to Job:<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; <a href="http://jenkins.ovirt.org/job/ovirt-master_change-queue-tester/6564/" rel="noreferrer" target="_blank">http://jenkins.ovirt.org/job/<wbr>ovirt-master_change-queue-<wbr>tester/6564/</a><br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; Link to all logs:<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; <a href="http://jenkins.ovirt.org/job/ovirt-master_change-queue-tester/6564/artifact/exported-artifacts/basic-suit-master-el7/test_logs/basic-suite-master/post-004_basic_sanity.py/" rel="noreferrer" target="_blank">http://jenkins.ovirt.org/job/<wbr>ovirt-master_change-queue-<wbr>tester/6564/artifact/exported-<wbr>artifacts/basic-suit-master-<wbr>el7/test_logs/basic-suite-<wbr>master/post-004_basic_sanity.<wbr>py/</a><br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; (Relevant) error snippet from the log:<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; &lt;error&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; 2018-03-27 11:30:16,167-04 WARN<br>
&gt;&gt;&gt;&gt;&gt;&gt; [org.ovirt.engine.core.bll.<wbr>snapshots.<wbr>CreateSnapshotForVmCommand] (default<br>
&gt;&gt;&gt;&gt;&gt;&gt; task-11) [9f713a3d-82a9-4db8-8207-<wbr>bb69a0a2c550] Validation of action<br>
&gt;&gt;&gt;&gt;&gt;&gt; &#39;CreateSnapshotForVm&#39; failed for user admin@internal-authz. Re<br>
&gt;&gt;&gt;&gt;&gt;&gt; asons:<br>
&gt;&gt;&gt;&gt;&gt;&gt; VAR__ACTION__CREATE,VAR__TYPE_<wbr>_SNAPSHOT,ACTION_TYPE_FAILED_<wbr>SNAPSHOT_IS_BEING_TAKEN_FOR_<wbr>VM,$VmName<br>
&gt;&gt;&gt;&gt;&gt;&gt; vm1<br>
&gt;&gt;&gt;&gt;&gt;&gt; 2018-03-27 11:30:16,176-04 DEBUG<br>
&gt;&gt;&gt;&gt;&gt;&gt; [org.ovirt.engine.core.common.<wbr>di.interceptor.<wbr>DebugLoggingInterceptor]<br>
&gt;&gt;&gt;&gt;&gt;&gt; (default task-11) [9f713a3d-82a9-4db8-8207-<wbr>bb69a0a2c550] method: runAction,<br>
&gt;&gt;&gt;&gt;&gt;&gt; params: [CreateSnapshotForVm, CreateSnapshotForVmParameters<br>
&gt;&gt;&gt;&gt;&gt;&gt; :{commandId=&#39;d8bfdb0e-5ae4-<wbr>4fed-8852-a0b29e377708&#39;, user=&#39;null&#39;,<br>
&gt;&gt;&gt;&gt;&gt;&gt; commandType=&#39;Unknown&#39;, vmId=&#39;65e7fea5-8b7d-4281-bd0d-<wbr>6a84de207a00&#39;}],<br>
&gt;&gt;&gt;&gt;&gt;&gt; timeElapsed: 57ms<br>
&gt;&gt;&gt;&gt;&gt;&gt; 2018-03-27 11:30:16,186-04 ERROR<br>
&gt;&gt;&gt;&gt;&gt;&gt; [org.ovirt.engine.api.restapi.<wbr>resource.<wbr>AbstractBackendResource] (default<br>
&gt;&gt;&gt;&gt;&gt;&gt; task-11) [] Operation Failed: [Cannot create Snapshot. Snapshot is currently<br>
&gt;&gt;&gt;&gt;&gt;&gt; being created for VM vm1.]<br>
&gt;&gt;&gt;&gt;&gt;&gt; 2018-03-27 11:30:16,820-04 INFO<br>
&gt;&gt;&gt;&gt;&gt;&gt; [org.ovirt.engine.core.bll.<wbr>SerialChildCommandsExecutionCa<wbr>llback]<br>
&gt;&gt;&gt;&gt;&gt;&gt; (EE-ManagedThreadFactory-<wbr>engineScheduled-Thread-100)<br>
&gt;&gt;&gt;&gt;&gt;&gt; [16c08ce6-9a73-489f-a1f2-<wbr>56e21699f14a] Command &#39;CopyImageGroupVolumesData&#39;<br>
&gt;&gt;&gt;&gt;&gt;&gt; (id: &#39;4c4023<br>
&gt;&gt;&gt;&gt;&gt;&gt; b4-21e8-4a98-8ac3-<wbr>aba51967d160&#39;) waiting on child command id:<br>
&gt;&gt;&gt;&gt;&gt;&gt; &#39;3d96b933-6e3b-4838-94bc-<wbr>db3ff0cadcdc&#39; type:&#39;CopyData&#39; to complete<br>
&gt;&gt;&gt;&gt;&gt;&gt; 2018-03-27 11:30:16,833-04 DEBUG<br>
&gt;&gt;&gt;&gt;&gt;&gt; [org.ovirt.engine.core.common.<wbr>di.interceptor.<wbr>DebugLoggingInterceptor]<br>
&gt;&gt;&gt;&gt;&gt;&gt; (EE-ManagedThreadFactory-<wbr>engineScheduled-Thread-100)<br>
&gt;&gt;&gt;&gt;&gt;&gt; [16c08ce6-9a73-489f-a1f2-<wbr>56e21699f14a] method: get, params:<br>
&gt;&gt;&gt;&gt;&gt;&gt; [a85992e9-40b8-4c80-9c<br>
&gt;&gt;&gt;&gt;&gt;&gt; 93-3bf767f6efa4], timeElapsed: 8ms<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt; &lt;/error&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;&gt;<br>
&gt;&gt;&gt;<br>
&gt;&gt;<br>
&gt;&gt;<br>
&gt;&gt; ______________________________<wbr>_________________<br>
&gt;&gt; Infra mailing list<br>
&gt;&gt; <a href="mailto:Infra@ovirt.org">Infra@ovirt.org</a><br>
&gt;&gt; <a href="http://lists.ovirt.org/mailman/listinfo/infra" rel="noreferrer" target="_blank">http://lists.ovirt.org/<wbr>mailman/listinfo/infra</a><br>
&gt;&gt;<br>
&gt;<br>
&gt;<br>
&gt;<br>
&gt; --<br>
&gt; GAL bEN HAIM<br>
&gt; RHV DEVOPS<br>
&gt;<br>
&gt; ______________________________<wbr>_________________<br>
&gt; Infra mailing list<br>
&gt; <a href="mailto:Infra@ovirt.org">Infra@ovirt.org</a><br>
&gt; <a href="http://lists.ovirt.org/mailman/listinfo/infra" rel="noreferrer" target="_blank">http://lists.ovirt.org/<wbr>mailman/listinfo/infra</a><br>
&gt;<br>
<br>
<br>
<br>
--<br>
</div></div>Didi<br>
</blockquote></div><br></div>