<div dir="ltr">Sorry for delay.<div><br></div><div>I think the problem is on the oVirt Engine, by the way, the files are attached.</div><div><br></div></div><div class="gmail_extra"><br clear="all"><div><div class="gmail_signature" data-smartmail="gmail_signature"><div dir="ltr">Atenciosamente,<br>Arthur Melo<br>Linux User #302250<br><br></div></div></div>
<br><div class="gmail_quote">2017-11-22 11:29 GMT-02:00 Benny Zlotnik <span dir="ltr">&lt;<a href="mailto:bzlotnik@redhat.com" target="_blank">bzlotnik@redhat.com</a>&gt;</span>:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div dir="ltr">I cannot see the error in the VDSM, please attach the full logs (you can compress them and attach a file)<br></div><div class="gmail_extra"><br><div class="gmail_quote">On Tue, Nov 21, 2017 at 2:36 PM, Arthur Melo <span dir="ltr">&lt;<a href="mailto:arthur@afabrica.net" target="_blank">arthur@afabrica.net</a>&gt;</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>I don&#39;t have vdsm.log at the engine machine.</div><div><br></div><div>vdsm.log (host03, where proxy03 is located on)</div><div><br></div><div><div>2017-11-21 10:32:48,340-0200 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:32:48,392-0200 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)</div><div>2017-11-21 10:32:53,725-0200 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.03 seconds (__init__:539)</div><div>2017-11-21 10:32:54,219-0200 INFO  (periodic/343) [vdsm.api] START repoStats(options=None) from=internal, task_id=a5c36747-92b8-4659-a64<wbr>c-5d3b14b7a5fd (api:46)</div><div>2017-11-21 10:32:54,219-0200 INFO  (periodic/343) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00043105&#39;, &#39;lastCheck&#39;: &#39;6.4&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00787006&#39;, &#39;lastCheck&#39;: &#39;6.5&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0169619&#39;, &#39;lastCheck&#39;: &#39;7.5&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00485451&#39;, &#39;lastCheck&#39;: &#39;6.5&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000404865&#39;, &#39;lastCheck&#39;: &#39;6.4&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000347603&#39;, &#39;lastCheck&#39;: &#39;3.0&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000443444&#39;, &#39;lastCheck&#39;: &#39;7.4&#39;, &#39;valid&#39;: True}} from=internal, task_id=a5c36747-92b8-4659-a64<wbr>c-5d3b14b7a5fd (api:52)</div><div>2017-11-21 10:33:01,181-0200 INFO  (monitor/0048460) [IOProcessClient] Closing client ioprocess-11887 (__init__:598)</div><div>2017-11-21 10:33:01,182-0200 INFO  (monitor/0048460) [IOProcessClient] Closing client ioprocess-11886 (__init__:598)</div><div>2017-11-21 10:33:01,867-0200 INFO  (jsonrpc/1) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=46b3675a, task_id=57a40d25-9994-4a9c-953<wbr>1-a3c2476516e1 (api:46)</div><div>2017-11-21 10:33:01,867-0200 INFO  (jsonrpc/1) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000399937&#39;, &#39;lastCheck&#39;: &#39;4.1&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00974892&#39;, &#39;lastCheck&#39;: &#39;4.2&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00352112&#39;, &#39;lastCheck&#39;: &#39;5.1&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000560259&#39;, &#39;lastCheck&#39;: &#39;4.1&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000447462&#39;, &#39;lastCheck&#39;: &#39;4.0&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000477881&#39;, &#39;lastCheck&#39;: &#39;0.7&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000480301&#39;, &#39;lastCheck&#39;: &#39;5.0&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=46b3675a, task_id=57a40d25-9994-4a9c-953<wbr>1-a3c2476516e1 (api:52)</div><div>2017-11-21 10:33:01,915-0200 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.05 seconds (__init__:539)</div><div>2017-11-21 10:33:03,421-0200 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.01 seconds (__init__:539)</div><div>2017-11-21 10:33:03,442-0200 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)</div><div>2017-11-21 10:33:08,805-0200 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.03 seconds (__init__:539)</div><div>2017-11-21 10:33:09,307-0200 INFO  (periodic/343) [vdsm.api] START repoStats(options=None) from=internal, task_id=c844a4cb-22df-4b0d-ad0<wbr>f-0b6edc48f048 (api:46)</div><div>2017-11-21 10:33:09,308-0200 INFO  (periodic/343) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000421227&#39;, &#39;lastCheck&#39;: &#39;1.5&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0113034&#39;, &#39;lastCheck&#39;: &#39;1.6&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0227581&#39;, &#39;lastCheck&#39;: &#39;2.6&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0142187&#39;, &#39;lastCheck&#39;: &#39;1.6&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000430952&#39;, &#39;lastCheck&#39;: &#39;1.5&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000477881&#39;, &#39;lastCheck&#39;: &#39;8.1&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000346374&#39;, &#39;lastCheck&#39;: &#39;2.4&#39;, &#39;valid&#39;: True}} from=internal, task_id=c844a4cb-22df-4b0d-ad0<wbr>f-0b6edc48f048 (api:52)</div><div>2017-11-21 10:33:16,108-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;aeee636<wbr>8-45bb-4a98-937b-587aab3daec3&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;046588d2-0d5d-4901-a<wbr>fb4-5902f3e9a7b1&#39;, volUUID=&#39;80ee1579-fa6c-4c8a-bb<wbr>e1-3ead1c8b28f9&#39;, options=None) from=internal, task_id=f7ce7918-fa47-45c3-8c2<wbr>6-30325d0a6dc9 (api:46)</div><div>2017-11-21 10:33:16,109-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;53687091200&#39;, &#39;apparentsize&#39;: &#39;53687091200&#39;} from=internal, task_id=f7ce7918-fa47-45c3-8c2<wbr>6-30325d0a6dc9 (api:52)</div><div>2017-11-21 10:33:16,111-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;0f7db06e-7f03-46a5-9<wbr>8c6-264106ad640a&#39;, volUUID=u&#39;dc8248bd-fa5d-4627-a<wbr>d93-d91b6d55090c&#39;, options=None) from=internal, task_id=8533e798-a80b-4334-a88<wbr>5-afdc4cc0ebc5 (api:46)</div><div>2017-11-21 10:33:16,111-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=8533e798-a80b-4334-a88<wbr>5-afdc4cc0ebc5 (api:52)</div><div>2017-11-21 10:33:16,113-0200 INFO  (periodic/343) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;12eddfe8-e706-4204-9<wbr>5ee-d3ff01bf0db5&#39;, volUUID=&#39;9b607027-7401-494f-9b<wbr>48-40d6a3e4abec&#39;, options=None) from=internal, task_id=580f8cae-e632-4297-8b0<wbr>f-0b917d8b3c72 (api:46)</div><div>2017-11-21 10:33:16,113-0200 INFO  (periodic/343) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=580f8cae-e632-4297-8b0<wbr>f-0b917d8b3c72 (api:52)</div><div>2017-11-21 10:33:16,114-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;562ca0c9-60b2-419d-a<wbr>aa2-df6ff10292f6&#39;, volUUID=&#39;9181c596-93b0-43df-8a<wbr>b1-b1ee4cb9721b&#39;, options=None) from=internal, task_id=e09822f1-8d61-42c7-bed<wbr>0-c9be3295996e (api:46)</div><div>2017-11-21 10:33:16,115-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;11811160064&#39;, &#39;apparentsize&#39;: &#39;11811160064&#39;} from=internal, task_id=e09822f1-8d61-42c7-bed<wbr>0-c9be3295996e (api:52)</div><div>2017-11-21 10:33:16,116-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;bd0c6749-538e-4299-8<wbr>91f-f35da6d8a4a3&#39;, volUUID=&#39;d95b1638-f829-4264-86<wbr>67-cd68f26783c0&#39;, options=None) from=internal, task_id=f4ecbc87-f805-42e3-a70<wbr>8-f7fdc7c0abff (api:46)</div><div>2017-11-21 10:33:16,117-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=f4ecbc87-f805-42e3-a70<wbr>8-f7fdc7c0abff (api:52)</div><div>2017-11-21 10:33:16,118-0200 INFO  (periodic/343) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;ca424d56-f294-48fb-a<wbr>627-72dac02ec315&#39;, volUUID=&#39;f241aba7-3ae4-432b-b5<wbr>5c-9ba95ce10e2c&#39;, options=None) from=internal, task_id=85313846-51a8-4c5f-ae6<wbr>4-ca3b923882d9 (api:46)</div><div>2017-11-21 10:33:16,118-0200 INFO  (periodic/343) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;35433480192&#39;, &#39;apparentsize&#39;: &#39;35433480192&#39;} from=internal, task_id=85313846-51a8-4c5f-ae6<wbr>4-ca3b923882d9 (api:52)</div><div>2017-11-21 10:33:16,120-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;c0327f75-15d3-4aa2-9<wbr>819-da48694183e2&#39;, volUUID=&#39;3b846bd2-6698-4cf9-87<wbr>1a-4c867a0fc30f&#39;, options=None) from=internal, task_id=3e704259-a21b-41bb-9a2<wbr>0-2c195ffb8751 (api:46)</div><div>2017-11-21 10:33:16,120-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;64424509440&#39;, &#39;apparentsize&#39;: &#39;64424509440&#39;} from=internal, task_id=3e704259-a21b-41bb-9a2<wbr>0-2c195ffb8751 (api:52)</div><div>2017-11-21 10:33:16,121-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;5c33574c-9b4b-432d-b<wbr>61e-62bac8c155fd&#39;, volUUID=&#39;1ddb9ebc-5c6b-4e73-bc<wbr>2a-3e9983cf9a73&#39;, options=None) from=internal, task_id=b014dfd6-2fc2-4b86-9d1<wbr>4-4d58213d3470 (api:46)</div><div>2017-11-21 10:33:16,122-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=b014dfd6-2fc2-4b86-9d1<wbr>4-4d58213d3470 (api:52)</div><div>2017-11-21 10:33:16,123-0200 INFO  (periodic/343) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;36bf11d9-5456-4f69-8<wbr>719-35ed6e0fb305&#39;, volUUID=&#39;083b0e95-6b45-4904-92<wbr>be-b1eba0af4289&#39;, options=None) from=internal, task_id=8c1aa585-ed1d-43d4-a70<wbr>7-1249c9d8ec2a (api:46)</div><div>2017-11-21 10:33:16,123-0200 INFO  (periodic/343) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;42949672960&#39;, &#39;apparentsize&#39;: &#39;42949672960&#39;} from=internal, task_id=8c1aa585-ed1d-43d4-a70<wbr>7-1249c9d8ec2a (api:52)</div><div>2017-11-21 10:33:16,124-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;d68942d0-2ee1-48f5-8<wbr>f14-580b917e835d&#39;, volUUID=&#39;5997ab7a-2be3-4790-a9<wbr>b4-5572da3eeb24&#39;, options=None) from=internal, task_id=815cf337-24d4-4d73-8a1<wbr>a-ad095547e711 (api:46)</div><div>2017-11-21 10:33:16,124-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=815cf337-24d4-4d73-8a1<wbr>a-ad095547e711 (api:52)</div><div>2017-11-21 10:33:16,125-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;4fd0ce51-815a-457d-b<wbr>fd9-1d2c0c2a3f0c&#39;, volUUID=&#39;e5415881-1bdd-40cc-b2<wbr>bb-447cfdffd762&#39;, options=None) from=internal, task_id=4b3a0d06-44c6-4f8d-ae6<wbr>6-d0c66d8e69cd (api:46)</div><div>2017-11-21 10:33:16,126-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=4b3a0d06-44c6-4f8d-ae6<wbr>6-d0c66d8e69cd (api:52)</div><div>2017-11-21 10:33:16,127-0200 INFO  (periodic/343) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;ae5b7335-0234-4d39-8<wbr>b0d-eaa57f3247be&#39;, volUUID=&#39;b118bb04-c580-49e8-b2<wbr>4d-864f3640fbca&#39;, options=None) from=internal, task_id=3600445f-7535-4e10-803<wbr>6-1d42ff8ada91 (api:46)</div><div>2017-11-21 10:33:16,127-0200 INFO  (periodic/343) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=3600445f-7535-4e10-803<wbr>6-1d42ff8ada91 (api:52)</div><div>2017-11-21 10:33:16,128-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;50e17b7b-3a86-4797-9<wbr>c42-8f4562fbf7a5&#39;, volUUID=&#39;902db022-3300-45d0-9b<wbr>dc-58c0a2ee7dbc&#39;, options=None) from=internal, task_id=012e4d7b-cab1-4a0e-85b<wbr>c-12e7cb4e8e24 (api:46)</div><div>2017-11-21 10:33:16,128-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=012e4d7b-cab1-4a0e-85b<wbr>c-12e7cb4e8e24 (api:52)</div><div>2017-11-21 10:33:16,129-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;a48e6b30-7d29-477e-8<wbr>b94-a2a4ecd83c98&#39;, volUUID=&#39;e4a1e27c-4dad-4735-86<wbr>1c-569cba9bc46f&#39;, options=None) from=internal, task_id=5544b693-031a-4f7a-897<wbr>2-37ea02623084 (api:46)</div><div>2017-11-21 10:33:16,129-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;39728447488&#39;, &#39;apparentsize&#39;: &#39;39728447488&#39;} from=internal, task_id=5544b693-031a-4f7a-897<wbr>2-37ea02623084 (api:52)</div><div>2017-11-21 10:33:16,130-0200 INFO  (periodic/343) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;d8d02bb5-be37-45f2-a<wbr>aaa-2f28e4fcca25&#39;, volUUID=&#39;c1c7bb81-6dae-4b1d-a5<wbr>14-4ec5de053994&#39;, options=None) from=internal, task_id=f274c966-dd29-4169-9df<wbr>e-5a05e82c5e01 (api:46)</div><div>2017-11-21 10:33:16,131-0200 INFO  (periodic/343) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;107374182400&#39;, &#39;apparentsize&#39;: &#39;107374182400&#39;} from=internal, task_id=f274c966-dd29-4169-9df<wbr>e-5a05e82c5e01 (api:52)</div><div>2017-11-21 10:33:16,132-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;f0886b2c-52d4-4f16-9<wbr>a90-2fdf96d0fb6b&#39;, volUUID=&#39;235b33f4-923c-4cad-91<wbr>aa-60e36cae15c3&#39;, options=None) from=internal, task_id=addf386d-3769-4bd5-bc3<wbr>1-acfbcd29c828 (api:46)</div><div>2017-11-21 10:33:16,133-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=addf386d-3769-4bd5-bc3<wbr>1-acfbcd29c828 (api:52)</div><div>2017-11-21 10:33:16,966-0200 INFO  (jsonrpc/3) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=19fb22c2, task_id=68319311-5407-4559-961<wbr>1-61f6277cfba1 (api:46)</div><div>2017-11-21 10:33:16,967-0200 INFO  (jsonrpc/3) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000421227&#39;, &#39;lastCheck&#39;: &#39;1.1&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0113034&#39;, &#39;lastCheck&#39;: &#39;1.1&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00619586&#39;, &#39;lastCheck&#39;: &#39;0.2&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0142187&#39;, &#39;lastCheck&#39;: &#39;1.0&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000430952&#39;, &#39;lastCheck&#39;: &#39;1.2&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00031821&#39;, &#39;lastCheck&#39;: &#39;5.8&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000494404&#39;, &#39;lastCheck&#39;: &#39;0.1&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=19fb22c2, task_id=68319311-5407-4559-961<wbr>1-61f6277cfba1 (api:52)</div><div>2017-11-21 10:33:17,009-0200 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.04 seconds (__init__:539)</div><div>2017-11-21 10:33:18,475-0200 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:33:18,524-0200 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.01 seconds (__init__:539)</div><div>2017-11-21 10:33:23,871-0200 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.01 seconds (__init__:539)</div><div>2017-11-21 10:33:24,402-0200 INFO  (periodic/342) [vdsm.api] START repoStats(options=None) from=internal, task_id=8dd40afb-b051-402d-a39<wbr>f-8b47eb3788a1 (api:46)</div><div>2017-11-21 10:33:24,402-0200 INFO  (periodic/342) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000538929&#39;, &#39;lastCheck&#39;: &#39;6.6&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.014852&#39;, &#39;lastCheck&#39;: &#39;6.7&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00619586&#39;, &#39;lastCheck&#39;: &#39;7.7&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00615694&#39;, &#39;lastCheck&#39;: &#39;6.7&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000408817&#39;, &#39;lastCheck&#39;: &#39;6.6&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000499266&#39;, &#39;lastCheck&#39;: &#39;3.2&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000494404&#39;, &#39;lastCheck&#39;: &#39;7.5&#39;, &#39;valid&#39;: True}} from=internal, task_id=8dd40afb-b051-402d-a39<wbr>f-8b47eb3788a1 (api:52)</div><div>2017-11-21 10:33:32,108-0200 INFO  (jsonrpc/1) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=5e2763e4, task_id=b06ce104-bb68-40dd-886<wbr>e-6bc0e27be511 (api:46)</div><div>2017-11-21 10:33:32,109-0200 INFO  (jsonrpc/1) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000436164&#39;, &#39;lastCheck&#39;: &#39;4.3&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0155751&#39;, &#39;lastCheck&#39;: &#39;4.4&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0195332&#39;, &#39;lastCheck&#39;: &#39;5.4&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00680802&#39;, &#39;lastCheck&#39;: &#39;4.3&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000406155&#39;, &#39;lastCheck&#39;: &#39;4.3&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000350002&#39;, &#39;lastCheck&#39;: &#39;0.9&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000463385&#39;, &#39;lastCheck&#39;: &#39;5.3&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=5e2763e4, task_id=b06ce104-bb68-40dd-886<wbr>e-6bc0e27be511 (api:52)</div><div>2017-11-21 10:33:32,166-0200 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.06 seconds (__init__:539)</div><div>2017-11-21 10:33:33,540-0200 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.01 seconds (__init__:539)</div><div>2017-11-21 10:33:33,561-0200 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)</div><div>2017-11-21 10:33:35,705-0200 INFO  (itmap/0) [IOProcessClient] Starting client ioprocess-11888 (__init__:330)</div><div>2017-11-21 10:33:35,729-0200 INFO  (itmap/1) [IOProcessClient] Starting client ioprocess-11889 (__init__:330)</div><div>2017-11-21 10:33:35,752-0200 INFO  (ioprocess/20559) [IOProcess] Starting ioprocess (__init__:452)</div><div>2017-11-21 10:33:35,757-0200 INFO  (ioprocess/20565) [IOProcess] Starting ioprocess (__init__:452)</div><div>2017-11-21 10:33:35,765-0200 INFO  (monitor/133d2fb) [storage.StorageDomain] Resource namespace 01_img_133d2fbd-b905-45f8-860a<wbr>-cd3e72f3f49d already registered (sd:727)</div><div>2017-11-21 10:33:35,765-0200 INFO  (monitor/133d2fb) [storage.StorageDomain] Resource namespace 02_vol_133d2fbd-b905-45f8-860a<wbr>-cd3e72f3f49d already registered (sd:736)</div><div>2017-11-21 10:33:38,944-0200 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.03 seconds (__init__:539)</div><div>2017-11-21 10:33:39,535-0200 INFO  (periodic/344) [vdsm.api] START repoStats(options=None) from=internal, task_id=e82beb91-82d2-4d17-957<wbr>b-5e0887a0824d (api:46)</div><div>2017-11-21 10:33:39,535-0200 INFO  (periodic/344) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000450668&#39;, &#39;lastCheck&#39;: &#39;1.7&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000602672&#39;, &#39;lastCheck&#39;: &#39;1.8&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000958537&#39;, &#39;lastCheck&#39;: &#39;2.9&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000524798&#39;, &#39;lastCheck&#39;: &#39;1.8&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000431355&#39;, &#39;lastCheck&#39;: &#39;1.7&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000350002&#39;, &#39;lastCheck&#39;: &#39;8.3&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000406714&#39;, &#39;lastCheck&#39;: &#39;2.7&#39;, &#39;valid&#39;: True}} from=internal, task_id=e82beb91-82d2-4d17-957<wbr>b-5e0887a0824d (api:52)</div><div>2017-11-21 10:33:47,213-0200 INFO  (jsonrpc/3) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=4aaa55b3, task_id=0ccfc73e-4876-436a-8eb<wbr>7-4f32b4ea2dd7 (api:46)</div><div>2017-11-21 10:33:47,214-0200 INFO  (jsonrpc/3) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000450668&#39;, &#39;lastCheck&#39;: &#39;1.3&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000602672&#39;, &#39;lastCheck&#39;: &#39;1.3&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00734942&#39;, &#39;lastCheck&#39;: &#39;0.5&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000524798&#39;, &#39;lastCheck&#39;: &#39;1.2&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000431355&#39;, &#39;lastCheck&#39;: &#39;1.4&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00034744&#39;, &#39;lastCheck&#39;: &#39;6.0&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000485543&#39;, &#39;lastCheck&#39;: &#39;0.3&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=4aaa55b3, task_id=0ccfc73e-4876-436a-8eb<wbr>7-4f32b4ea2dd7 (api:52)</div><div>2017-11-21 10:33:47,255-0200 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.05 seconds (__init__:539)</div><div>2017-11-21 10:33:48,593-0200 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:33:48,633-0200 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.01 seconds (__init__:539)</div><div>2017-11-21 10:33:54,016-0200 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.03 seconds (__init__:539)</div><div>2017-11-21 10:33:54,650-0200 INFO  (periodic/341) [vdsm.api] START repoStats(options=None) from=internal, task_id=b22332d1-1cd2-417d-bf8<wbr>3-637a711ce467 (api:46)</div><div>2017-11-21 10:33:54,650-0200 INFO  (periodic/341) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00188248&#39;, &#39;lastCheck&#39;: &#39;6.8&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00292128&#39;, &#39;lastCheck&#39;: &#39;7.0&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00734942&#39;, &#39;lastCheck&#39;: &#39;8.0&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.005357&#39;, &#39;lastCheck&#39;: &#39;6.9&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000389392&#39;, &#39;lastCheck&#39;: &#39;6.8&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000338751&#39;, &#39;lastCheck&#39;: &#39;3.5&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000485543&#39;, &#39;lastCheck&#39;: &#39;7.8&#39;, &#39;valid&#39;: True}} from=internal, task_id=b22332d1-1cd2-417d-bf8<wbr>3-637a711ce467 (api:52)</div><div>2017-11-21 10:34:02,316-0200 INFO  (jsonrpc/1) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=fe4bc0a, task_id=a4eda238-199c-4346-a94<wbr>1-8f0a5f2e7133 (api:46)</div><div>2017-11-21 10:34:02,317-0200 INFO  (jsonrpc/1) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000481169&#39;, &#39;lastCheck&#39;: &#39;4.5&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00467249&#39;, &#39;lastCheck&#39;: &#39;4.6&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00584804&#39;, &#39;lastCheck&#39;: &#39;5.6&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00652665&#39;, &#39;lastCheck&#39;: &#39;4.6&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000449782&#39;, &#39;lastCheck&#39;: &#39;4.5&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000409327&#39;, &#39;lastCheck&#39;: &#39;1.1&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00046967&#39;, &#39;lastCheck&#39;: &#39;5.5&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=fe4bc0a, task_id=a4eda238-199c-4346-a94<wbr>1-8f0a5f2e7133 (api:52)</div><div>2017-11-21 10:34:02,377-0200 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.06 seconds (__init__:539)</div><div>2017-11-21 10:34:03,655-0200 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:34:03,675-0200 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)</div><div>2017-11-21 10:34:09,093-0200 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:34:09,733-0200 INFO  (periodic/344) [vdsm.api] START repoStats(options=None) from=internal, task_id=b79c478b-c40a-4e0e-8aa<wbr>d-d7bf7271a1ad (api:46)</div><div>2017-11-21 10:34:09,734-0200 INFO  (periodic/344) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000501576&#39;, &#39;lastCheck&#39;: &#39;1.9&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00316746&#39;, &#39;lastCheck&#39;: &#39;2.0&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00681892&#39;, &#39;lastCheck&#39;: &#39;3.0&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00840636&#39;, &#39;lastCheck&#39;: &#39;2.0&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000503123&#39;, &#39;lastCheck&#39;: &#39;1.9&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000342223&#39;, &#39;lastCheck&#39;: &#39;0.2&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000551599&#39;, &#39;lastCheck&#39;: &#39;2.9&#39;, &#39;valid&#39;: True}} from=internal, task_id=b79c478b-c40a-4e0e-8aa<wbr>d-d7bf7271a1ad (api:52)</div><div>2017-11-21 10:34:16,114-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;aeee636<wbr>8-45bb-4a98-937b-587aab3daec3&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;046588d2-0d5d-4901-a<wbr>fb4-5902f3e9a7b1&#39;, volUUID=&#39;80ee1579-fa6c-4c8a-bb<wbr>e1-3ead1c8b28f9&#39;, options=None) from=internal, task_id=09750ed6-c691-4c61-817<wbr>a-596b126d0e0a (api:46)</div><div>2017-11-21 10:34:16,115-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;53687091200&#39;, &#39;apparentsize&#39;: &#39;53687091200&#39;} from=internal, task_id=09750ed6-c691-4c61-817<wbr>a-596b126d0e0a (api:52)</div><div>2017-11-21 10:34:16,116-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;0f7db06e-7f03-46a5-9<wbr>8c6-264106ad640a&#39;, volUUID=u&#39;dc8248bd-fa5d-4627-a<wbr>d93-d91b6d55090c&#39;, options=None) from=internal, task_id=68c8aa9a-fb36-498e-bfe<wbr>b-acb58da56c9c (api:46)</div><div>2017-11-21 10:34:16,117-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=68c8aa9a-fb36-498e-bfe<wbr>b-acb58da56c9c (api:52)</div><div>2017-11-21 10:34:16,118-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;12eddfe8-e706-4204-9<wbr>5ee-d3ff01bf0db5&#39;, volUUID=&#39;9b607027-7401-494f-9b<wbr>48-40d6a3e4abec&#39;, options=None) from=internal, task_id=fafccdb4-06b8-4442-a01<wbr>f-46c87c04b696 (api:46)</div><div>2017-11-21 10:34:16,119-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=fafccdb4-06b8-4442-a01<wbr>f-46c87c04b696 (api:52)</div><div>2017-11-21 10:34:16,120-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;562ca0c9-60b2-419d-a<wbr>aa2-df6ff10292f6&#39;, volUUID=&#39;9181c596-93b0-43df-8a<wbr>b1-b1ee4cb9721b&#39;, options=None) from=internal, task_id=a8e36efd-c050-43aa-9e3<wbr>d-88fe42b2fb7a (api:46)</div><div>2017-11-21 10:34:16,120-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;11811160064&#39;, &#39;apparentsize&#39;: &#39;11811160064&#39;} from=internal, task_id=a8e36efd-c050-43aa-9e3<wbr>d-88fe42b2fb7a (api:52)</div><div>2017-11-21 10:34:16,121-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;bd0c6749-538e-4299-8<wbr>91f-f35da6d8a4a3&#39;, volUUID=&#39;d95b1638-f829-4264-86<wbr>67-cd68f26783c0&#39;, options=None) from=internal, task_id=2ec682b8-e99b-4383-b91<wbr>7-99e3651dc9d7 (api:46)</div><div>2017-11-21 10:34:16,122-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=2ec682b8-e99b-4383-b91<wbr>7-99e3651dc9d7 (api:52)</div><div>2017-11-21 10:34:16,122-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;ca424d56-f294-48fb-a<wbr>627-72dac02ec315&#39;, volUUID=&#39;f241aba7-3ae4-432b-b5<wbr>5c-9ba95ce10e2c&#39;, options=None) from=internal, task_id=78b3c805-a930-4b63-aca<wbr>d-99178112758a (api:46)</div><div>2017-11-21 10:34:16,123-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;35433480192&#39;, &#39;apparentsize&#39;: &#39;35433480192&#39;} from=internal, task_id=78b3c805-a930-4b63-aca<wbr>d-99178112758a (api:52)</div><div>2017-11-21 10:34:16,124-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;c0327f75-15d3-4aa2-9<wbr>819-da48694183e2&#39;, volUUID=&#39;3b846bd2-6698-4cf9-87<wbr>1a-4c867a0fc30f&#39;, options=None) from=internal, task_id=3a243657-8264-4c06-ae5<wbr>7-1023ac16bd07 (api:46)</div><div>2017-11-21 10:34:16,124-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;64424509440&#39;, &#39;apparentsize&#39;: &#39;64424509440&#39;} from=internal, task_id=3a243657-8264-4c06-ae5<wbr>7-1023ac16bd07 (api:52)</div><div>2017-11-21 10:34:16,125-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;5c33574c-9b4b-432d-b<wbr>61e-62bac8c155fd&#39;, volUUID=&#39;1ddb9ebc-5c6b-4e73-bc<wbr>2a-3e9983cf9a73&#39;, options=None) from=internal, task_id=c6993c71-d2d5-41bd-900<wbr>0-ccd5b6d4954c (api:46)</div><div>2017-11-21 10:34:16,125-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=c6993c71-d2d5-41bd-900<wbr>0-ccd5b6d4954c (api:52)</div><div>2017-11-21 10:34:16,126-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;36bf11d9-5456-4f69-8<wbr>719-35ed6e0fb305&#39;, volUUID=&#39;083b0e95-6b45-4904-92<wbr>be-b1eba0af4289&#39;, options=None) from=internal, task_id=5bd3e2e2-9410-4aa5-8ae<wbr>2-07b36b5f0ec2 (api:46)</div><div>2017-11-21 10:34:16,126-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;42949672960&#39;, &#39;apparentsize&#39;: &#39;42949672960&#39;} from=internal, task_id=5bd3e2e2-9410-4aa5-8ae<wbr>2-07b36b5f0ec2 (api:52)</div><div>2017-11-21 10:34:16,127-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;d68942d0-2ee1-48f5-8<wbr>f14-580b917e835d&#39;, volUUID=&#39;5997ab7a-2be3-4790-a9<wbr>b4-5572da3eeb24&#39;, options=None) from=internal, task_id=768ec546-bf3b-405a-992<wbr>d-0c7a0e3f1e7f (api:46)</div><div>2017-11-21 10:34:16,128-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=768ec546-bf3b-405a-992<wbr>d-0c7a0e3f1e7f (api:52)</div><div>2017-11-21 10:34:16,128-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;4fd0ce51-815a-457d-b<wbr>fd9-1d2c0c2a3f0c&#39;, volUUID=&#39;e5415881-1bdd-40cc-b2<wbr>bb-447cfdffd762&#39;, options=None) from=internal, task_id=b238b726-7bd7-4f3c-819<wbr>8-0139f96c7e16 (api:46)</div><div>2017-11-21 10:34:16,129-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=b238b726-7bd7-4f3c-819<wbr>8-0139f96c7e16 (api:52)</div><div>2017-11-21 10:34:16,130-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;ae5b7335-0234-4d39-8<wbr>b0d-eaa57f3247be&#39;, volUUID=&#39;b118bb04-c580-49e8-b2<wbr>4d-864f3640fbca&#39;, options=None) from=internal, task_id=734612f4-7e27-4533-872<wbr>6-313f79bf5c6d (api:46)</div><div>2017-11-21 10:34:16,130-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=734612f4-7e27-4533-872<wbr>6-313f79bf5c6d (api:52)</div><div>2017-11-21 10:34:16,131-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;50e17b7b-3a86-4797-9<wbr>c42-8f4562fbf7a5&#39;, volUUID=&#39;902db022-3300-45d0-9b<wbr>dc-58c0a2ee7dbc&#39;, options=None) from=internal, task_id=b412232b-1634-48b9-87c<wbr>8-486620f1da8a (api:46)</div><div>2017-11-21 10:34:16,131-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=b412232b-1634-48b9-87c<wbr>8-486620f1da8a (api:52)</div><div>2017-11-21 10:34:16,132-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;a48e6b30-7d29-477e-8<wbr>b94-a2a4ecd83c98&#39;, volUUID=&#39;e4a1e27c-4dad-4735-86<wbr>1c-569cba9bc46f&#39;, options=None) from=internal, task_id=fd3faa5c-db77-463d-82a<wbr>7-be811cbe40ea (api:46)</div><div>2017-11-21 10:34:16,132-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;39728447488&#39;, &#39;apparentsize&#39;: &#39;39728447488&#39;} from=internal, task_id=fd3faa5c-db77-463d-82a<wbr>7-be811cbe40ea (api:52)</div><div>2017-11-21 10:34:16,133-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;d8d02bb5-be37-45f2-a<wbr>aaa-2f28e4fcca25&#39;, volUUID=&#39;c1c7bb81-6dae-4b1d-a5<wbr>14-4ec5de053994&#39;, options=None) from=internal, task_id=54a8abaa-8a2b-454e-866<wbr>f-616c4c7a309b (api:46)</div><div>2017-11-21 10:34:16,133-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;107374182400&#39;, &#39;apparentsize&#39;: &#39;107374182400&#39;} from=internal, task_id=54a8abaa-8a2b-454e-866<wbr>f-616c4c7a309b (api:52)</div><div>2017-11-21 10:34:16,134-0200 INFO  (periodic/343) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;f0886b2c-52d4-4f16-9<wbr>a90-2fdf96d0fb6b&#39;, volUUID=&#39;235b33f4-923c-4cad-91<wbr>aa-60e36cae15c3&#39;, options=None) from=internal, task_id=d90dcc04-6ae8-4ca8-8ed<wbr>e-ca7dee49b6c1 (api:46)</div><div>2017-11-21 10:34:16,134-0200 INFO  (periodic/343) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=d90dcc04-6ae8-4ca8-8ed<wbr>e-ca7dee49b6c1 (api:52)</div><div>2017-11-21 10:34:17,427-0200 INFO  (jsonrpc/3) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=605ff78e, task_id=43ed860c-719e-4080-9b8<wbr>9-74ef683410ba (api:46)</div><div>2017-11-21 10:34:17,428-0200 INFO  (jsonrpc/3) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000501576&#39;, &#39;lastCheck&#39;: &#39;1.6&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00316746&#39;, &#39;lastCheck&#39;: &#39;1.5&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00385945&#39;, &#39;lastCheck&#39;: &#39;0.7&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00840636&#39;, &#39;lastCheck&#39;: &#39;1.4&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000503123&#39;, &#39;lastCheck&#39;: &#39;1.6&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000342223&#39;, &#39;lastCheck&#39;: &#39;6.2&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000397598&#39;, &#39;lastCheck&#39;: &#39;0.5&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=605ff78e, task_id=43ed860c-719e-4080-9b8<wbr>9-74ef683410ba (api:52)</div><div>2017-11-21 10:34:17,477-0200 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.05 seconds (__init__:539)</div><div>2017-11-21 10:34:18,715-0200 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.03 seconds (__init__:539)</div><div>2017-11-21 10:34:18,755-0200 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)</div><div>2017-11-21 10:34:24,164-0200 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.03 seconds (__init__:539)</div><div>2017-11-21 10:34:24,823-0200 INFO  (periodic/342) [vdsm.api] START repoStats(options=None) from=internal, task_id=3d7a53d1-917a-40df-8ca<wbr>9-ef671f6ab5be (api:46)</div><div>2017-11-21 10:34:24,824-0200 INFO  (periodic/342) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000426529&#39;, &#39;lastCheck&#39;: &#39;7.0&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00331356&#39;, &#39;lastCheck&#39;: &#39;7.1&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00385945&#39;, &#39;lastCheck&#39;: &#39;8.1&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00477843&#39;, &#39;lastCheck&#39;: &#39;7.1&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000409132&#39;, &#39;lastCheck&#39;: &#39;7.0&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000449765&#39;, &#39;lastCheck&#39;: &#39;3.6&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000397598&#39;, &#39;lastCheck&#39;: &#39;7.9&#39;, &#39;valid&#39;: True}} from=internal, task_id=3d7a53d1-917a-40df-8ca<wbr>9-ef671f6ab5be (api:52)</div><div>2017-11-21 10:34:33,526-0200 INFO  (jsonrpc/1) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=3d48c75f, task_id=cbeb394d-1682-464f-a9e<wbr>1-a2c41434faca (api:46)</div><div>2017-11-21 10:34:33,527-0200 INFO  (jsonrpc/1) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000506374&#39;, &#39;lastCheck&#39;: &#39;5.7&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00589212&#39;, &#39;lastCheck&#39;: &#39;5.8&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00830664&#39;, &#39;lastCheck&#39;: &#39;6.8&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00458526&#39;, &#39;lastCheck&#39;: &#39;5.8&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000474598&#39;, &#39;lastCheck&#39;: &#39;5.7&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000422617&#39;, &#39;lastCheck&#39;: &#39;2.3&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000489315&#39;, &#39;lastCheck&#39;: &#39;6.6&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=3d48c75f, task_id=cbeb394d-1682-464f-a9e<wbr>1-a2c41434faca (api:52)</div><div>2017-11-21 10:34:33,568-0200 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.04 seconds (__init__:539)</div><div>2017-11-21 10:34:33,776-0200 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.03 seconds (__init__:539)</div><div>2017-11-21 10:34:33,823-0200 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.01 seconds (__init__:539)</div><div>2017-11-21 10:34:35,782-0200 INFO  (monitor/133d2fb) [IOProcessClient] Closing client ioprocess-11889 (__init__:598)</div><div>2017-11-21 10:34:35,783-0200 INFO  (monitor/133d2fb) [IOProcessClient] Closing client ioprocess-11888 (__init__:598)</div><div>2017-11-21 10:34:39,234-0200 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:34:39,935-0200 INFO  (periodic/342) [vdsm.api] START repoStats(options=None) from=internal, task_id=07f599c7-11c2-4b9a-923<wbr>e-03d8fc0c8ad2 (api:46)</div><div>2017-11-21 10:34:39,935-0200 INFO  (periodic/342) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000465809&#39;, &#39;lastCheck&#39;: &#39;2.1&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000473767&#39;, &#39;lastCheck&#39;: &#39;2.3&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0133196&#39;, &#39;lastCheck&#39;: &#39;3.2&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0043482&#39;, &#39;lastCheck&#39;: &#39;2.2&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000369036&#39;, &#39;lastCheck&#39;: &#39;2.1&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000354937&#39;, &#39;lastCheck&#39;: &#39;0.4&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000524776&#39;, &#39;lastCheck&#39;: &#39;3.0&#39;, &#39;valid&#39;: True}} from=internal, task_id=07f599c7-11c2-4b9a-923<wbr>e-03d8fc0c8ad2 (api:52)</div><div>2017-11-21 10:34:48,856-0200 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.03 seconds (__init__:539)</div><div>2017-11-21 10:34:48,901-0200 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)</div><div>2017-11-21 10:34:49,617-0200 INFO  (jsonrpc/0) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=116b15b9, task_id=ed8ead0d-f585-4a1f-b7c<wbr>c-c06f03678fa6 (api:46)</div><div>2017-11-21 10:34:49,618-0200 INFO  (jsonrpc/0) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000454267&#39;, &#39;lastCheck&#39;: &#39;1.8&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000485221&#39;, &#39;lastCheck&#39;: &#39;1.9&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00717925&#39;, &#39;lastCheck&#39;: &#39;2.9&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00925524&#39;, &#39;lastCheck&#39;: &#39;1.9&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00040099&#39;, &#39;lastCheck&#39;: &#39;1.8&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000347874&#39;, &#39;lastCheck&#39;: &#39;0.1&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00063195&#39;, &#39;lastCheck&#39;: &#39;2.7&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=116b15b9, task_id=ed8ead0d-f585-4a1f-b7c<wbr>c-c06f03678fa6 (api:52)</div><div>2017-11-21 10:34:49,657-0200 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.04 seconds (__init__:539)</div><div>2017-11-21 10:34:54,308-0200 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:34:55,034-0200 INFO  (periodic/341) [vdsm.api] START repoStats(options=None) from=internal, task_id=8723cedd-907e-40dc-928<wbr>9-403b0dcb0408 (api:46)</div><div>2017-11-21 10:34:55,035-0200 INFO  (periodic/341) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000454267&#39;, &#39;lastCheck&#39;: &#39;7.2&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000485221&#39;, &#39;lastCheck&#39;: &#39;7.3&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00717925&#39;, &#39;lastCheck&#39;: &#39;8.3&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00925524&#39;, &#39;lastCheck&#39;: &#39;7.3&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00040099&#39;, &#39;lastCheck&#39;: &#39;7.2&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000347874&#39;, &#39;lastCheck&#39;: &#39;3.8&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00063195&#39;, &#39;lastCheck&#39;: &#39;8.1&#39;, &#39;valid&#39;: True}} from=internal, task_id=8723cedd-907e-40dc-928<wbr>9-403b0dcb0408 (api:52)</div><div>2017-11-21 10:35:03,918-0200 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:35:03,942-0200 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)</div><div>2017-11-21 10:35:05,232-0200 INFO  (jsonrpc/6) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=5a64ac79, task_id=78bdb2f2-c3ac-48c2-978<wbr>2-79c3338761df (api:46)</div><div>2017-11-21 10:35:05,233-0200 INFO  (jsonrpc/6) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000441852&#39;, &#39;lastCheck&#39;: &#39;7.4&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0104569&#39;, &#39;lastCheck&#39;: &#39;7.5&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00748768&#39;, &#39;lastCheck&#39;: &#39;8.5&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0045552&#39;, &#39;lastCheck&#39;: &#39;7.5&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000487076&#39;, &#39;lastCheck&#39;: &#39;7.4&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000418393&#39;, &#39;lastCheck&#39;: &#39;4.0&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00045539&#39;, &#39;lastCheck&#39;: &#39;8.4&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=5a64ac79, task_id=78bdb2f2-c3ac-48c2-978<wbr>2-79c3338761df (api:52)</div><div>2017-11-21 10:35:05,276-0200 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.05 seconds (__init__:539)</div><div>2017-11-21 10:35:05,830-0200 INFO  (monitor/6e71472) [storage.LVM] Refreshing lvs: vg=6e71472a-cb5d-478c-a05f-2db<wbr>afbf6ffaa lvs=[&#39;metadata&#39;] (lvm:1291)</div><div>2017-11-21 10:35:05,831-0200 INFO  (monitor/6e71472) [storage.LVM] Refreshing LVs (vg=6e71472a-cb5d-478c-a05f-2d<wbr>bafbf6ffaa, lvs=[&#39;metadata&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:05,875-0200 INFO  (monitor/75c38dd) [storage.LVM] Refreshing lvs: vg=75c38dd5-92ad-4b88-93be-4d5<wbr>2489db6e3 lvs=[&#39;metadata&#39;] (lvm:1291)</div><div>2017-11-21 10:35:05,875-0200 INFO  (monitor/75c38dd) [storage.LVM] Refreshing LVs (vg=75c38dd5-92ad-4b88-93be-4d<wbr>52489db6e3, lvs=[&#39;metadata&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:05,914-0200 INFO  (monitor/aeee636) [storage.LVM] Refreshing lvs: vg=aeee6368-45bb-4a98-937b-587<wbr>aab3daec3 lvs=[&#39;metadata&#39;] (lvm:1291)</div><div>2017-11-21 10:35:05,915-0200 INFO  (monitor/aeee636) [storage.LVM] Refreshing LVs (vg=aeee6368-45bb-4a98-937b-58<wbr>7aab3daec3, lvs=[&#39;metadata&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:05,983-0200 INFO  (monitor/5f0f31c) [storage.LVM] Refreshing lvs: vg=5f0f31cc-bd1d-4a17-b99f-65e<wbr>08007ac83 lvs=[&#39;metadata&#39;] (lvm:1291)</div><div>2017-11-21 10:35:05,983-0200 INFO  (monitor/5f0f31c) [storage.LVM] Refreshing LVs (vg=5f0f31cc-bd1d-4a17-b99f-65<wbr>e08007ac83, lvs=[&#39;metadata&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,368-0200 INFO  (monitor/75c38dd) [storage.LVM] Refreshing lvs: vg=75c38dd5-92ad-4b88-93be-4d5<wbr>2489db6e3 lvs=[&#39;ids&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,368-0200 INFO  (monitor/75c38dd) [storage.LVM] Refreshing LVs (vg=75c38dd5-92ad-4b88-93be-4d<wbr>52489db6e3, lvs=[&#39;ids&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,398-0200 INFO  (monitor/6e71472) [storage.LVM] Refreshing lvs: vg=6e71472a-cb5d-478c-a05f-2db<wbr>afbf6ffaa lvs=[&#39;ids&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,398-0200 INFO  (monitor/6e71472) [storage.LVM] Refreshing LVs (vg=6e71472a-cb5d-478c-a05f-2d<wbr>bafbf6ffaa, lvs=[&#39;ids&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,417-0200 INFO  (monitor/425606b) [storage.LVM] Refreshing lvs: vg=425606b4-5aa0-4548-8b3f-61a<wbr>8d0852bf4 lvs=[&#39;metadata&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,418-0200 INFO  (monitor/425606b) [storage.LVM] Refreshing LVs (vg=425606b4-5aa0-4548-8b3f-61<wbr>a8d0852bf4, lvs=[&#39;metadata&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,439-0200 INFO  (monitor/aeee636) [storage.LVM] Refreshing lvs: vg=aeee6368-45bb-4a98-937b-587<wbr>aab3daec3 lvs=[&#39;ids&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,440-0200 INFO  (monitor/aeee636) [storage.LVM] Refreshing LVs (vg=aeee6368-45bb-4a98-937b-58<wbr>7aab3daec3, lvs=[&#39;ids&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,491-0200 INFO  (monitor/5f0f31c) [storage.LVM] Refreshing lvs: vg=5f0f31cc-bd1d-4a17-b99f-65e<wbr>08007ac83 lvs=[&#39;ids&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,492-0200 INFO  (monitor/5f0f31c) [storage.LVM] Refreshing LVs (vg=5f0f31cc-bd1d-4a17-b99f-65<wbr>e08007ac83, lvs=[&#39;ids&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,624-0200 INFO  (monitor/6e71472) [storage.LVM] Refreshing lvs: vg=6e71472a-cb5d-478c-a05f-2db<wbr>afbf6ffaa lvs=[&#39;leases&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,625-0200 INFO  (monitor/6e71472) [storage.LVM] Refreshing LVs (vg=6e71472a-cb5d-478c-a05f-2d<wbr>bafbf6ffaa, lvs=[&#39;leases&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,646-0200 INFO  (monitor/75c38dd) [storage.LVM] Refreshing lvs: vg=75c38dd5-92ad-4b88-93be-4d5<wbr>2489db6e3 lvs=[&#39;leases&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,646-0200 INFO  (monitor/75c38dd) [storage.LVM] Refreshing LVs (vg=75c38dd5-92ad-4b88-93be-4d<wbr>52489db6e3, lvs=[&#39;leases&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,680-0200 INFO  (monitor/aeee636) [storage.LVM] Refreshing lvs: vg=aeee6368-45bb-4a98-937b-587<wbr>aab3daec3 lvs=[&#39;leases&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,680-0200 INFO  (monitor/aeee636) [storage.LVM] Refreshing LVs (vg=aeee6368-45bb-4a98-937b-58<wbr>7aab3daec3, lvs=[&#39;leases&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,700-0200 INFO  (monitor/5f0f31c) [storage.LVM] Refreshing lvs: vg=5f0f31cc-bd1d-4a17-b99f-65e<wbr>08007ac83 lvs=[&#39;leases&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,701-0200 INFO  (monitor/5f0f31c) [storage.LVM] Refreshing LVs (vg=5f0f31cc-bd1d-4a17-b99f-65<wbr>e08007ac83, lvs=[&#39;leases&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,881-0200 INFO  (monitor/6e71472) [storage.LVM] Refreshing lvs: vg=6e71472a-cb5d-478c-a05f-2db<wbr>afbf6ffaa lvs=[&#39;metadata&#39;, &#39;leases&#39;, &#39;ids&#39;, &#39;inbox&#39;, &#39;outbox&#39;, &#39;xleases&#39;, &#39;master&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,882-0200 INFO  (monitor/6e71472) [storage.LVM] Refreshing LVs (vg=6e71472a-cb5d-478c-a05f-2d<wbr>bafbf6ffaa, lvs=[&#39;metadata&#39;, &#39;leases&#39;, &#39;ids&#39;, &#39;inbox&#39;, &#39;outbox&#39;, &#39;xleases&#39;, &#39;master&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,923-0200 INFO  (monitor/aeee636) [storage.LVM] Refreshing lvs: vg=aeee6368-45bb-4a98-937b-587<wbr>aab3daec3 lvs=[&#39;metadata&#39;, &#39;leases&#39;, &#39;ids&#39;, &#39;inbox&#39;, &#39;outbox&#39;, &#39;xleases&#39;, &#39;master&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,924-0200 INFO  (monitor/aeee636) [storage.LVM] Refreshing LVs (vg=aeee6368-45bb-4a98-937b-58<wbr>7aab3daec3, lvs=[&#39;metadata&#39;, &#39;leases&#39;, &#39;ids&#39;, &#39;inbox&#39;, &#39;outbox&#39;, &#39;xleases&#39;, &#39;master&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,946-0200 INFO  (monitor/75c38dd) [storage.LVM] Refreshing lvs: vg=75c38dd5-92ad-4b88-93be-4d5<wbr>2489db6e3 lvs=[&#39;metadata&#39;, &#39;leases&#39;, &#39;ids&#39;, &#39;inbox&#39;, &#39;outbox&#39;, &#39;xleases&#39;, &#39;master&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,947-0200 INFO  (monitor/75c38dd) [storage.LVM] Refreshing LVs (vg=75c38dd5-92ad-4b88-93be-4d<wbr>52489db6e3, lvs=[&#39;metadata&#39;, &#39;leases&#39;, &#39;ids&#39;, &#39;inbox&#39;, &#39;outbox&#39;, &#39;xleases&#39;, &#39;master&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:06,973-0200 INFO  (monitor/5f0f31c) [storage.LVM] Refreshing lvs: vg=5f0f31cc-bd1d-4a17-b99f-65e<wbr>08007ac83 lvs=[&#39;metadata&#39;, &#39;leases&#39;, &#39;ids&#39;, &#39;inbox&#39;, &#39;outbox&#39;, &#39;xleases&#39;, &#39;master&#39;] (lvm:1291)</div><div>2017-11-21 10:35:06,974-0200 INFO  (monitor/5f0f31c) [storage.LVM] Refreshing LVs (vg=5f0f31cc-bd1d-4a17-b99f-65<wbr>e08007ac83, lvs=[&#39;metadata&#39;, &#39;leases&#39;, &#39;ids&#39;, &#39;inbox&#39;, &#39;outbox&#39;, &#39;xleases&#39;, &#39;master&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:07,000-0200 INFO  (monitor/425606b) [storage.LVM] Refreshing lvs: vg=425606b4-5aa0-4548-8b3f-61a<wbr>8d0852bf4 lvs=[&#39;ids&#39;] (lvm:1291)</div><div>2017-11-21 10:35:07,001-0200 INFO  (monitor/425606b) [storage.LVM] Refreshing LVs (vg=425606b4-5aa0-4548-8b3f-61<wbr>a8d0852bf4, lvs=[&#39;ids&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:07,201-0200 INFO  (monitor/425606b) [storage.LVM] Refreshing lvs: vg=425606b4-5aa0-4548-8b3f-61a<wbr>8d0852bf4 lvs=[&#39;leases&#39;] (lvm:1291)</div><div>2017-11-21 10:35:07,202-0200 INFO  (monitor/425606b) [storage.LVM] Refreshing LVs (vg=425606b4-5aa0-4548-8b3f-61<wbr>a8d0852bf4, lvs=[&#39;leases&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:07,228-0200 INFO  (monitor/aeee636) [storage.StorageDomain] Resource namespace 01_img_aeee6368-45bb-4a98-937b<wbr>-587aab3daec3 already registered (sd:727)</div><div>2017-11-21 10:35:07,228-0200 INFO  (monitor/aeee636) [storage.StorageDomain] Resource namespace 02_vol_aeee6368-45bb-4a98-937b<wbr>-587aab3daec3 already registered (sd:736)</div><div>2017-11-21 10:35:07,229-0200 INFO  (monitor/aeee636) [storage.StorageDomain] Resource namespace 03_lvm_aeee6368-45bb-4a98-937b<wbr>-587aab3daec3 already registered (blockSD:989)</div><div>2017-11-21 10:35:07,256-0200 INFO  (monitor/5f0f31c) [storage.StorageDomain] Resource namespace 01_img_5f0f31cc-bd1d-4a17-b99f<wbr>-65e08007ac83 already registered (sd:727)</div><div>2017-11-21 10:35:07,257-0200 INFO  (monitor/5f0f31c) [storage.StorageDomain] Resource namespace 02_vol_5f0f31cc-bd1d-4a17-b99f<wbr>-65e08007ac83 already registered (sd:736)</div><div>2017-11-21 10:35:07,257-0200 INFO  (monitor/5f0f31c) [storage.StorageDomain] Resource namespace 03_lvm_5f0f31cc-bd1d-4a17-b99f<wbr>-65e08007ac83 already registered (blockSD:989)</div><div>2017-11-21 10:35:07,286-0200 INFO  (monitor/75c38dd) [storage.StorageDomain] Resource namespace 01_img_75c38dd5-92ad-4b88-93be<wbr>-4d52489db6e3 already registered (sd:727)</div><div>2017-11-21 10:35:07,287-0200 INFO  (monitor/75c38dd) [storage.StorageDomain] Resource namespace 02_vol_75c38dd5-92ad-4b88-93be<wbr>-4d52489db6e3 already registered (sd:736)</div><div>2017-11-21 10:35:07,288-0200 INFO  (monitor/75c38dd) [storage.StorageDomain] Resource namespace 03_lvm_75c38dd5-92ad-4b88-93be<wbr>-4d52489db6e3 already registered (blockSD:989)</div><div>2017-11-21 10:35:07,315-0200 INFO  (monitor/6e71472) [storage.StorageDomain] Resource namespace 01_img_6e71472a-cb5d-478c-a05f<wbr>-2dbafbf6ffaa already registered (sd:727)</div><div>2017-11-21 10:35:07,315-0200 INFO  (monitor/6e71472) [storage.StorageDomain] Resource namespace 02_vol_6e71472a-cb5d-478c-a05f<wbr>-2dbafbf6ffaa already registered (sd:736)</div><div>2017-11-21 10:35:07,316-0200 INFO  (monitor/6e71472) [storage.StorageDomain] Resource namespace 03_lvm_6e71472a-cb5d-478c-a05f<wbr>-2dbafbf6ffaa already registered (blockSD:989)</div><div>2017-11-21 10:35:07,397-0200 INFO  (monitor/425606b) [storage.LVM] Refreshing lvs: vg=425606b4-5aa0-4548-8b3f-61a<wbr>8d0852bf4 lvs=[&#39;metadata&#39;, &#39;leases&#39;, &#39;ids&#39;, &#39;inbox&#39;, &#39;outbox&#39;, &#39;xleases&#39;, &#39;master&#39;] (lvm:1291)</div><div>2017-11-21 10:35:07,398-0200 INFO  (monitor/425606b) [storage.LVM] Refreshing LVs (vg=425606b4-5aa0-4548-8b3f-61<wbr>a8d0852bf4, lvs=[&#39;metadata&#39;, &#39;leases&#39;, &#39;ids&#39;, &#39;inbox&#39;, &#39;outbox&#39;, &#39;xleases&#39;, &#39;master&#39;]) (lvm:1319)</div><div>2017-11-21 10:35:07,611-0200 INFO  (monitor/425606b) [storage.StorageDomain] Resource namespace 01_img_425606b4-5aa0-4548-8b3f<wbr>-61a8d0852bf4 already registered (sd:727)</div><div>2017-11-21 10:35:07,612-0200 INFO  (monitor/425606b) [storage.StorageDomain] Resource namespace 02_vol_425606b4-5aa0-4548-8b3f<wbr>-61a8d0852bf4 already registered (sd:736)</div><div>2017-11-21 10:35:07,612-0200 INFO  (monitor/425606b) [storage.StorageDomain] Resource namespace 03_lvm_425606b4-5aa0-4548-8b3f<wbr>-61a8d0852bf4 already registered (blockSD:989)</div><div>2017-11-21 10:35:09,382-0200 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:35:10,118-0200 INFO  (periodic/342) [vdsm.api] START repoStats(options=None) from=internal, task_id=5ff4e723-4b55-4043-af6<wbr>c-36b126c1bf47 (api:46)</div><div>2017-11-21 10:35:10,119-0200 INFO  (periodic/342) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000463751&#39;, &#39;lastCheck&#39;: &#39;2.3&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000490637&#39;, &#39;lastCheck&#39;: &#39;2.4&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000496188&#39;, &#39;lastCheck&#39;: &#39;2.4&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000647866&#39;, &#39;lastCheck&#39;: &#39;2.4&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000485272&#39;, &#39;lastCheck&#39;: &#39;2.3&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000350738&#39;, &#39;lastCheck&#39;: &#39;0.6&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000478362&#39;, &#39;lastCheck&#39;: &#39;3.1&#39;, &#39;valid&#39;: True}} from=internal, task_id=5ff4e723-4b55-4043-af6<wbr>c-36b126c1bf47 (api:52)</div><div>2017-11-21 10:35:16,105-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;aeee636<wbr>8-45bb-4a98-937b-587aab3daec3&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;046588d2-0d5d-4901-a<wbr>fb4-5902f3e9a7b1&#39;, volUUID=&#39;80ee1579-fa6c-4c8a-bb<wbr>e1-3ead1c8b28f9&#39;, options=None) from=internal, task_id=812c98fb-55fa-4390-bea<wbr>9-11ef2343cfaf (api:46)</div><div>2017-11-21 10:35:16,106-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;53687091200&#39;, &#39;apparentsize&#39;: &#39;53687091200&#39;} from=internal, task_id=812c98fb-55fa-4390-bea<wbr>9-11ef2343cfaf (api:52)</div><div>2017-11-21 10:35:16,107-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;0f7db06e-7f03-46a5-9<wbr>8c6-264106ad640a&#39;, volUUID=u&#39;dc8248bd-fa5d-4627-a<wbr>d93-d91b6d55090c&#39;, options=None) from=internal, task_id=982fa714-367a-4874-8b0<wbr>8-68b2bedfb00d (api:46)</div><div>2017-11-21 10:35:16,108-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=982fa714-367a-4874-8b0<wbr>8-68b2bedfb00d (api:52)</div><div>2017-11-21 10:35:16,109-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;12eddfe8-e706-4204-9<wbr>5ee-d3ff01bf0db5&#39;, volUUID=&#39;9b607027-7401-494f-9b<wbr>48-40d6a3e4abec&#39;, options=None) from=internal, task_id=4b59c0d4-d62b-481b-9e9<wbr>a-d67d147d2dac (api:46)</div><div>2017-11-21 10:35:16,110-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=4b59c0d4-d62b-481b-9e9<wbr>a-d67d147d2dac (api:52)</div><div>2017-11-21 10:35:16,111-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;562ca0c9-60b2-419d-a<wbr>aa2-df6ff10292f6&#39;, volUUID=&#39;9181c596-93b0-43df-8a<wbr>b1-b1ee4cb9721b&#39;, options=None) from=internal, task_id=916e3f3c-710b-45f5-bd1<wbr>b-de7a794a3342 (api:46)</div><div>2017-11-21 10:35:16,112-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;11811160064&#39;, &#39;apparentsize&#39;: &#39;11811160064&#39;} from=internal, task_id=916e3f3c-710b-45f5-bd1<wbr>b-de7a794a3342 (api:52)</div><div>2017-11-21 10:35:16,113-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;bd0c6749-538e-4299-8<wbr>91f-f35da6d8a4a3&#39;, volUUID=&#39;d95b1638-f829-4264-86<wbr>67-cd68f26783c0&#39;, options=None) from=internal, task_id=c7f40832-eab1-4636-955<wbr>9-950ec97340b3 (api:46)</div><div>2017-11-21 10:35:16,113-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=c7f40832-eab1-4636-955<wbr>9-950ec97340b3 (api:52)</div><div>2017-11-21 10:35:16,114-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;ca424d56-f294-48fb-a<wbr>627-72dac02ec315&#39;, volUUID=&#39;f241aba7-3ae4-432b-b5<wbr>5c-9ba95ce10e2c&#39;, options=None) from=internal, task_id=b4e1683c-ae76-4af5-a2b<wbr>a-d9aedaba15ec (api:46)</div><div>2017-11-21 10:35:16,114-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;35433480192&#39;, &#39;apparentsize&#39;: &#39;35433480192&#39;} from=internal, task_id=b4e1683c-ae76-4af5-a2b<wbr>a-d9aedaba15ec (api:52)</div><div>2017-11-21 10:35:16,115-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;c0327f75-15d3-4aa2-9<wbr>819-da48694183e2&#39;, volUUID=&#39;3b846bd2-6698-4cf9-87<wbr>1a-4c867a0fc30f&#39;, options=None) from=internal, task_id=1d43b194-c24a-45c1-9a2<wbr>2-7bb1335f532e (api:46)</div><div>2017-11-21 10:35:16,116-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;64424509440&#39;, &#39;apparentsize&#39;: &#39;64424509440&#39;} from=internal, task_id=1d43b194-c24a-45c1-9a2<wbr>2-7bb1335f532e (api:52)</div><div>2017-11-21 10:35:16,117-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;5c33574c-9b4b-432d-b<wbr>61e-62bac8c155fd&#39;, volUUID=&#39;1ddb9ebc-5c6b-4e73-bc<wbr>2a-3e9983cf9a73&#39;, options=None) from=internal, task_id=e16285b2-139b-4563-ae1<wbr>9-f6b3af867526 (api:46)</div><div>2017-11-21 10:35:16,118-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=e16285b2-139b-4563-ae1<wbr>9-f6b3af867526 (api:52)</div><div>2017-11-21 10:35:16,119-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;36bf11d9-5456-4f69-8<wbr>719-35ed6e0fb305&#39;, volUUID=&#39;083b0e95-6b45-4904-92<wbr>be-b1eba0af4289&#39;, options=None) from=internal, task_id=0d75f8e1-8e1f-45c1-87d<wbr>b-31e9483ccc7c (api:46)</div><div>2017-11-21 10:35:16,120-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;42949672960&#39;, &#39;apparentsize&#39;: &#39;42949672960&#39;} from=internal, task_id=0d75f8e1-8e1f-45c1-87d<wbr>b-31e9483ccc7c (api:52)</div><div>2017-11-21 10:35:16,121-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;d68942d0-2ee1-48f5-8<wbr>f14-580b917e835d&#39;, volUUID=&#39;5997ab7a-2be3-4790-a9<wbr>b4-5572da3eeb24&#39;, options=None) from=internal, task_id=38ce3a1d-1de6-41fb-99a<wbr>f-44f7cd5f18d4 (api:46)</div><div>2017-11-21 10:35:16,122-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=38ce3a1d-1de6-41fb-99a<wbr>f-44f7cd5f18d4 (api:52)</div><div>2017-11-21 10:35:16,123-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;4fd0ce51-815a-457d-b<wbr>fd9-1d2c0c2a3f0c&#39;, volUUID=&#39;e5415881-1bdd-40cc-b2<wbr>bb-447cfdffd762&#39;, options=None) from=internal, task_id=c393da25-6b94-4bda-b5a<wbr>0-4b8825ec175c (api:46)</div><div>2017-11-21 10:35:16,123-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=c393da25-6b94-4bda-b5a<wbr>0-4b8825ec175c (api:52)</div><div>2017-11-21 10:35:16,125-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;ae5b7335-0234-4d39-8<wbr>b0d-eaa57f3247be&#39;, volUUID=&#39;b118bb04-c580-49e8-b2<wbr>4d-864f3640fbca&#39;, options=None) from=internal, task_id=0702d492-bd44-4954-a09<wbr>f-de83dc6600f9 (api:46)</div><div>2017-11-21 10:35:16,125-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=0702d492-bd44-4954-a09<wbr>f-de83dc6600f9 (api:52)</div><div>2017-11-21 10:35:16,126-0200 INFO  (periodic/344) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;50e17b7b-3a86-4797-9<wbr>c42-8f4562fbf7a5&#39;, volUUID=&#39;902db022-3300-45d0-9b<wbr>dc-58c0a2ee7dbc&#39;, options=None) from=internal, task_id=9932fcbf-c5e9-4929-9b1<wbr>7-479cff9d64a1 (api:46)</div><div>2017-11-21 10:35:16,127-0200 INFO  (periodic/344) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=9932fcbf-c5e9-4929-9b1<wbr>7-479cff9d64a1 (api:52)</div><div>2017-11-21 10:35:16,128-0200 INFO  (periodic/341) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;a48e6b30-7d29-477e-8<wbr>b94-a2a4ecd83c98&#39;, volUUID=&#39;e4a1e27c-4dad-4735-86<wbr>1c-569cba9bc46f&#39;, options=None) from=internal, task_id=b4f6d023-31c3-40e6-b97<wbr>7-effd64d83938 (api:46)</div><div>2017-11-21 10:35:16,129-0200 INFO  (periodic/341) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;39728447488&#39;, &#39;apparentsize&#39;: &#39;39728447488&#39;} from=internal, task_id=b4f6d023-31c3-40e6-b97<wbr>7-effd64d83938 (api:52)</div><div>2017-11-21 10:35:16,130-0200 INFO  (periodic/342) [vdsm.api] START getVolumeSize(sdUUID=u&#39;5f0f31c<wbr>c-bd1d-4a17-b99f-65e08007ac83&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;d8d02bb5-be37-45f2-a<wbr>aaa-2f28e4fcca25&#39;, volUUID=&#39;c1c7bb81-6dae-4b1d-a5<wbr>14-4ec5de053994&#39;, options=None) from=internal, task_id=eac2b508-c553-48a0-adb<wbr>9-c8e59dabc6bd (api:46)</div><div>2017-11-21 10:35:16,130-0200 INFO  (periodic/342) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;107374182400&#39;, &#39;apparentsize&#39;: &#39;107374182400&#39;} from=internal, task_id=eac2b508-c553-48a0-adb<wbr>9-c8e59dabc6bd (api:52)</div><div>2017-11-21 10:35:16,131-0200 INFO  (periodic/343) [vdsm.api] START getVolumeSize(sdUUID=u&#39;425606b<wbr>4-5aa0-4548-8b3f-61a8d0852bf4&#39;<wbr>, spUUID=u&#39;59e6568b-02cd-03ad-01<wbr>2a-000000000038&#39;, imgUUID=u&#39;f0886b2c-52d4-4f16-9<wbr>a90-2fdf96d0fb6b&#39;, volUUID=&#39;235b33f4-923c-4cad-91<wbr>aa-60e36cae15c3&#39;, options=None) from=internal, task_id=eea7dad4-75e2-48ad-b84<wbr>e-457d59057332 (api:46)</div><div>2017-11-21 10:35:16,132-0200 INFO  (periodic/343) [vdsm.api] FINISH getVolumeSize return={&#39;truesize&#39;: &#39;10737418240&#39;, &#39;apparentsize&#39;: &#39;10737418240&#39;} from=internal, task_id=eea7dad4-75e2-48ad-b84<wbr>e-457d59057332 (api:52)</div><div>2017-11-21 10:35:18,968-0200 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:35:18,992-0200 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)</div><div>2017-11-21 10:35:20,334-0200 INFO  (jsonrpc/0) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=d08b563, task_id=18b273c7-bd84-4c07-9c9<wbr>a-1dd57ad06f75 (api:46)</div><div>2017-11-21 10:35:20,334-0200 INFO  (jsonrpc/0) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000446587&#39;, &#39;lastCheck&#39;: &#39;2.5&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00675086&#39;, &#39;lastCheck&#39;: &#39;2.7&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00947756&#39;, &#39;lastCheck&#39;: &#39;2.6&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00622928&#39;, &#39;lastCheck&#39;: &#39;2.6&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000379158&#39;, &#39;lastCheck&#39;: &#39;2.5&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000417515&#39;, &#39;lastCheck&#39;: &#39;0.8&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000524652&#39;, &#39;lastCheck&#39;: &#39;3.4&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=d08b563, task_id=18b273c7-bd84-4c07-9c9<wbr>a-1dd57ad06f75 (api:52)</div><div>2017-11-21 10:35:20,377-0200 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.05 seconds (__init__:539)</div><div>2017-11-21 10:35:24,451-0200 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:35:25,220-0200 INFO  (periodic/342) [vdsm.api] START repoStats(options=None) from=internal, task_id=2c55d8e7-8b6a-4056-885<wbr>5-e142ad434837 (api:46)</div><div>2017-11-21 10:35:25,221-0200 INFO  (periodic/342) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000446587&#39;, &#39;lastCheck&#39;: &#39;7.4&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00675086&#39;, &#39;lastCheck&#39;: &#39;7.5&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00947756&#39;, &#39;lastCheck&#39;: &#39;7.5&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00622928&#39;, &#39;lastCheck&#39;: &#39;7.5&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000379158&#39;, &#39;lastCheck&#39;: &#39;7.4&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000417515&#39;, &#39;lastCheck&#39;: &#39;4.0&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000524652&#39;, &#39;lastCheck&#39;: &#39;8.3&#39;, &#39;valid&#39;: True}} from=internal, task_id=2c55d8e7-8b6a-4056-885<wbr>5-e142ad434837 (api:52)</div><div>2017-11-21 10:35:34,023-0200 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.02 seconds (__init__:539)</div><div>2017-11-21 10:35:34,075-0200 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)</div><div>2017-11-21 10:35:35,424-0200 INFO  (jsonrpc/6) [vdsm.api] START repoStats(options=None) from=::ffff:192.168.254.80,503<wbr>14, flow_id=2d6c655b, task_id=d3853c42-2d16-408a-941<wbr>1-d2a84fcad926 (api:46)</div><div>2017-11-21 10:35:35,425-0200 INFO  (jsonrpc/6) [vdsm.api] FINISH repoStats return={u&#39;75c38dd5-92ad-4b88-9<wbr>3be-4d52489db6e3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000436053&#39;, &#39;lastCheck&#39;: &#39;7.6&#39;, &#39;valid&#39;: True}, u&#39;aeee6368-45bb-4a98-937b-587a<wbr>ab3daec3&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.00633629&#39;, &#39;lastCheck&#39;: &#39;7.7&#39;, &#39;valid&#39;: True}, u&#39;425606b4-5aa0-4548-8b3f-61a8<wbr>d0852bf4&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.0142374&#39;, &#39;lastCheck&#39;: &#39;7.7&#39;, &#39;valid&#39;: True}, u&#39;5f0f31cc-bd1d-4a17-b99f-65e0<wbr>8007ac83&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000593453&#39;, &#39;lastCheck&#39;: &#39;7.7&#39;, &#39;valid&#39;: True}, u&#39;6e71472a-cb5d-478c-a05f-2dba<wbr>fbf6ffaa&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 4, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000385028&#39;, &#39;lastCheck&#39;: &#39;7.6&#39;, &#39;valid&#39;: True}, u&#39;0048460a-9fc0-45c8-851d-86b1<wbr>7f872827&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000419577&#39;, &#39;lastCheck&#39;: &#39;4.2&#39;, &#39;valid&#39;: True}, u&#39;133d2fbd-b905-45f8-860a-cd3e<wbr>72f3f49d&#39;: {&#39;code&#39;: 0, &#39;actual&#39;: True, &#39;version&#39;: 0, &#39;acquired&#39;: True, &#39;delay&#39;: &#39;0.000364547&#39;, &#39;lastCheck&#39;: &#39;8.6&#39;, &#39;valid&#39;: True}} from=::ffff:192.168.254.80,503<wbr>14, flow_id=2d6c655b, task_id=d3853c42-2d16-408a-941<wbr>1-d2a84fcad926 (api:52)</div><div>2017-11-21 10:35:35,486-0200 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.07 seconds (__init__:539)</div></div><div><br></div><div><br></div><div>----</div><div><br></div><div>engine.log</div><div><br></div><div><div>2017-11-21 10:29:15,674-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] -- executeIrsBrokerCommand: calling &#39;setVolumeDescription&#39;, parameters:</div><div>2017-11-21 10:29:15,674-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ spUUID=59e6568b-02cd-03ad-012a<wbr>-000000000038</div><div>2017-11-21 10:29:15,674-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ sdUUID=425606b4-5aa0-4548-8b3f<wbr>-61a8d0852bf4</div><div>2017-11-21 10:29:15,674-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ imageGroupGUID=808b9847-c42c-4<wbr>0d8-959d-5faff30cbaff</div><div>2017-11-21 10:29:15,674-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ volUUID=f9d2654b-9f27-4e60-af2<wbr>2-d210fabfc8ce</div><div>2017-11-21 10:29:15,674-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ description={&quot;Updated&quot;:false,&quot;<wbr>Last Updated&quot;:&quot;Fri Nov 17 18:28:47 BRST 2017&quot;,&quot;Storage Domains&quot;:[{&quot;uuid&quot;:&quot;425606b4-5a<wbr>a0-4548-8b3f-61a8d0852bf4&quot;}],&quot;<wbr>Disk Description&quot;:&quot;OVF_STORE&quot;}</div><div>2017-11-21 10:29:16,693-02 ERROR [org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand] (DefaultQuartzScheduler6) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Ending command &#39;org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand&#39; with failure.</div><div>2017-11-21 10:29:16,696-02 INFO  [org.ovirt.engine.core.utils.t<wbr>ransaction.TransactionSupport] (DefaultQuartzScheduler6) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] transaction rolled back</div><div>2017-11-21 10:29:16,708-02 ERROR [org.ovirt.engine.core.dal.dbb<wbr>roker.auditloghandling.AuditLo<wbr>gDirector] (DefaultQuartzScheduler6) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] EVENT_ID: USER_REMOVE_SNAPSHOT_FINISHED_<wbr>FAILURE(357), Correlation ID: 70cc2ffa-2414-4a00-9e24-6b6378<wbr>408a9d, Job ID: ec197072-7c38-42b6-9aef-99635d<wbr>4ee135, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: Failed to delete snapshot &#39;&lt;UNKNOWN&gt;&#39; for VM &#39;proxy03&#39;.</div><div>2017-11-21 10:29:16,709-02 ERROR [org.ovirt.engine.core.bll.tas<wbr>ks.CommandCallbacksPoller] (DefaultQuartzScheduler6) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Failed invoking callback end method &#39;onFailed&#39; for command &#39;a84519fe-6b23-4084-84a2-b7964<wbr>cbcde26&#39; with exception &#39;null&#39;, the callback is marked for end method retries</div><div>2017-11-21 10:29:16,838-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] FINISH, SetVolumeDescriptionVDSCommand<wbr>, log id: 2bfd570</div><div>2017-11-21 10:29:16,862-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.UploadStreamComm<wbr>and] (DefaultQuartzScheduler2) [58f0924f] Lock Acquired to object &#39;EngineLock:{exclusiveLocks=&#39;&#39;<wbr>, sharedLocks=&#39;[5386322c-bf91-4b<wbr>f5-8507-128f7473aa8d=VDS_EXECU<wbr>TION]&#39;}&#39;</div><div>2017-11-21 10:29:16,897-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.UploadStreamComm<wbr>and] (DefaultQuartzScheduler2) [58f0924f] Running command: UploadStreamCommand internal: true. Entities affected :  ID: 425606b4-5aa0-4548-8b3f-61a8d0<wbr>852bf4 Type: Storage</div><div>2017-11-21 10:29:16,897-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] START, UploadStreamVDSCommand(HostNam<wbr>e = host01-dc1, UploadStreamVDSCommandParamete<wbr>rs:{runAsync=&#39;true&#39;, hostId=&#39;5386322c-bf91-4bf5-850<wbr>7-128f7473aa8d&#39;}), log id: 78526132</div><div>2017-11-21 10:29:16,897-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] -- executeVdsBrokerCommand, parameters:</div><div>2017-11-21 10:29:16,897-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] ++ spUUID=59e6568b-02cd-03ad-012a<wbr>-000000000038</div><div>2017-11-21 10:29:16,898-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] ++ sdUUID=425606b4-5aa0-4548-8b3f<wbr>-61a8d0852bf4</div><div>2017-11-21 10:29:16,898-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] ++ imageGUID=808b9847-c42c-40d8-9<wbr>59d-5faff30cbaff</div><div>2017-11-21 10:29:16,898-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] ++ volUUID=f9d2654b-9f27-4e60-af2<wbr>2-d210fabfc8ce</div><div>2017-11-21 10:29:16,898-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] ++ size=235520</div><div>2017-11-21 10:29:20,138-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] FINISH, UploadStreamVDSCommand, log id: 78526132</div><div>2017-11-21 10:29:20,163-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (DefaultQuartzScheduler2) [58f0924f] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command &#39;d73dc4e7-e0b8-4a19-a672-5ef67<wbr>8f64a08&#39;</div><div>2017-11-21 10:29:20,163-02 INFO  [<a href="http://org.ovirt.engine.core.bll.Com">org.ovirt.engine.core.bll.Com</a><wbr>mandMultiAsyncTasks] (DefaultQuartzScheduler2) [58f0924f] CommandMultiAsyncTasks::attach<wbr>Task: Attaching task &#39;5fe5e889-1065-4e77-834b-71620<wbr>e2f23e5&#39; to command &#39;d73dc4e7-e0b8-4a19-a672-5ef67<wbr>8f64a08&#39;.</div><div>2017-11-21 10:29:20,186-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.AsyncTaskManager] (DefaultQuartzScheduler2) [58f0924f] Adding task &#39;5fe5e889-1065-4e77-834b-71620<wbr>e2f23e5&#39; (Parent Command &#39;UploadStream&#39;, Parameters Type &#39;org.ovirt.engine.core.common.<wbr>asynctasks.AsyncTaskParameters<wbr>&#39;), polling hasn&#39;t started yet..</div><div>2017-11-21 10:29:20,197-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (DefaultQuartzScheduler2) [58f0924f] BaseAsyncTask::startPollingTas<wbr>k: Starting to poll task &#39;5fe5e889-1065-4e77-834b-71620<wbr>e2f23e5&#39;.</div><div>2017-11-21 10:29:20,205-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.UploadStreamComm<wbr>and] (DefaultQuartzScheduler2) [58f0924f] Lock freed to object &#39;EngineLock:{exclusiveLocks=&#39;&#39;<wbr>, sharedLocks=&#39;[5386322c-bf91-4b<wbr>f5-8507-128f7473aa8d=VDS_EXECU<wbr>TION]&#39;}&#39;</div><div>2017-11-21 10:29:20,209-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] START, SetVolumeDescriptionVDSCommand<wbr>( SetVolumeDescriptionVDSCommand<wbr>Parameters:{runAsync=&#39;true&#39;, storagePoolId=&#39;59e6568b-02cd-0<wbr>3ad-012a-000000000038&#39;, ignoreFailoverLimit=&#39;false&#39;, storageDomainId=&#39;425606b4-5aa0<wbr>-4548-8b3f-61a8d0852bf4&#39;, imageGroupId=&#39;808b9847-c42c-40<wbr>d8-959d-5faff30cbaff&#39;, imageId=&#39;f9d2654b-9f27-4e60-af<wbr>22-d210fabfc8ce&#39;}), log id: 111fc33a</div><div>2017-11-21 10:29:20,209-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] -- executeIrsBrokerCommand: calling &#39;setVolumeDescription&#39;, parameters:</div><div>2017-11-21 10:29:20,209-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ spUUID=59e6568b-02cd-03ad-012a<wbr>-000000000038</div><div>2017-11-21 10:29:20,209-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ sdUUID=425606b4-5aa0-4548-8b3f<wbr>-61a8d0852bf4</div><div>2017-11-21 10:29:20,209-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ imageGroupGUID=808b9847-c42c-4<wbr>0d8-959d-5faff30cbaff</div><div>2017-11-21 10:29:20,209-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ volUUID=f9d2654b-9f27-4e60-af2<wbr>2-d210fabfc8ce</div><div>2017-11-21 10:29:20,209-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ description={&quot;Updated&quot;:true,&quot;S<wbr>ize&quot;:235520,&quot;Last Updated&quot;:&quot;Tue Nov 21 10:29:15 BRST 2017&quot;,&quot;Storage Domains&quot;:[{&quot;uuid&quot;:&quot;425606b4-5a<wbr>a0-4548-8b3f-61a8d0852bf4&quot;}],&quot;<wbr>Disk Description&quot;:&quot;OVF_STORE&quot;}</div><div>2017-11-21 10:29:20,566-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.AsyncTaskManager] (DefaultQuartzScheduler7) [5dee72f] Polling and updating Async Tasks: 1 tasks, 1 tasks to poll now</div><div>2017-11-21 10:29:21,540-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] FINISH, SetVolumeDescriptionVDSCommand<wbr>, log id: 111fc33a</div><div>2017-11-21 10:29:21,545-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] START, SetVolumeDescriptionVDSCommand<wbr>( SetVolumeDescriptionVDSCommand<wbr>Parameters:{runAsync=&#39;true&#39;, storagePoolId=&#39;59e6568b-02cd-0<wbr>3ad-012a-000000000038&#39;, ignoreFailoverLimit=&#39;false&#39;, storageDomainId=&#39;425606b4-5aa0<wbr>-4548-8b3f-61a8d0852bf4&#39;, imageGroupId=&#39;5919ccc4-b9ad-42<wbr>13-810b-4f8df08efdf5&#39;, imageId=&#39;85a0eb12-2d70-4ae1-8c<wbr>11-20ef30bbf839&#39;}), log id: 7cc59230</div><div>2017-11-21 10:29:22,496-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (DefaultQuartzScheduler7) [5dee72f] SPMAsyncTask::PollTask: Polling task &#39;5fe5e889-1065-4e77-834b-71620<wbr>e2f23e5&#39; (Parent Command &#39;UploadStream&#39;, Parameters Type &#39;org.ovirt.engine.core.common.<wbr>asynctasks.AsyncTaskParameters<wbr>&#39;) returned status &#39;finished&#39;, result &#39;success&#39;.</div><div>2017-11-21 10:29:22,496-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] -- executeIrsBrokerCommand: calling &#39;setVolumeDescription&#39;, parameters:</div><div>2017-11-21 10:29:22,496-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ spUUID=59e6568b-02cd-03ad-012a<wbr>-000000000038</div><div>2017-11-21 10:29:22,496-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ sdUUID=425606b4-5aa0-4548-8b3f<wbr>-61a8d0852bf4</div><div>2017-11-21 10:29:22,496-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (DefaultQuartzScheduler7) [5dee72f] BaseAsyncTask::onTaskEndSucces<wbr>s: Task &#39;5fe5e889-1065-4e77-834b-71620<wbr>e2f23e5&#39; (Parent Command &#39;UploadStream&#39;, Parameters Type &#39;org.ovirt.engine.core.common.<wbr>asynctasks.AsyncTaskParameters<wbr>&#39;) ended successfully.</div><div>2017-11-21 10:29:22,496-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ imageGroupGUID=5919ccc4-b9ad-4<wbr>213-810b-4f8df08efdf5</div><div>2017-11-21 10:29:22,496-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ volUUID=85a0eb12-2d70-4ae1-8c1<wbr>1-20ef30bbf839</div><div>2017-11-21 10:29:22,496-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ description={&quot;Updated&quot;:false,&quot;<wbr>Last Updated&quot;:&quot;Fri Nov 17 18:28:47 BRST 2017&quot;,&quot;Storage Domains&quot;:[{&quot;uuid&quot;:&quot;425606b4-5a<wbr>a0-4548-8b3f-61a8d0852bf4&quot;}],&quot;<wbr>Disk Description&quot;:&quot;OVF_STORE&quot;}</div><div>2017-11-21 10:29:22,498-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (DefaultQuartzScheduler7) [5dee72f] CommandAsyncTask::endActionIfN<wbr>ecessary: All tasks of command &#39;d73dc4e7-e0b8-4a19-a672-5ef67<wbr>8f64a08&#39; has ended -&gt; executing &#39;endAction&#39;</div><div>2017-11-21 10:29:22,498-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (DefaultQuartzScheduler7) [5dee72f] CommandAsyncTask::endAction: Ending action for &#39;1&#39; tasks (command ID: &#39;d73dc4e7-e0b8-4a19-a672-5ef67<wbr>8f64a08&#39;): calling endAction &#39;.</div><div>2017-11-21 10:29:22,498-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-2) [5dee72f] CommandAsyncTask::endCommandAc<wbr>tion [within thread] context: Attempting to endAction &#39;UploadStream&#39;,</div><div>2017-11-21 10:29:22,505-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.UploadStreamComm<wbr>and] (org.ovirt.thread.pool-6-threa<wbr>d-2) [58f0924f] Ending command &#39;org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.UploadStreamComm<wbr>and&#39; successfully.</div><div>2017-11-21 10:29:22,511-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-2) [58f0924f] CommandAsyncTask::HandleEndAct<wbr>ionResult [within thread]: endAction for action type &#39;UploadStream&#39; completed, handling the result.</div><div>2017-11-21 10:29:22,511-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-2) [58f0924f] CommandAsyncTask::HandleEndAct<wbr>ionResult [within thread]: endAction for action type &#39;UploadStream&#39; succeeded, clearing tasks.</div><div>2017-11-21 10:29:22,511-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-2) [58f0924f] SPMAsyncTask::ClearAsyncTask: Attempting to clear task &#39;5fe5e889-1065-4e77-834b-71620<wbr>e2f23e5&#39;</div><div>2017-11-21 10:29:22,512-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SPMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-2) [58f0924f] START, SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParam<wbr>eters:{runAsync=&#39;true&#39;, storagePoolId=&#39;59e6568b-02cd-0<wbr>3ad-012a-000000000038&#39;, ignoreFailoverLimit=&#39;false&#39;, taskId=&#39;5fe5e889-1065-4e77-834<wbr>b-71620e2f23e5&#39;}), log id: 4a85156f</div><div>2017-11-21 10:29:23,873-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] FINISH, SetVolumeDescriptionVDSCommand<wbr>, log id: 7cc59230</div><div>2017-11-21 10:29:23,874-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.vdsbroker.HSMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-2) [58f0924f] START, HSMClearTaskVDSCommand(HostNam<wbr>e = host01-dc1, HSMTaskGuidBaseVDSCommandParam<wbr>eters:{runAsync=&#39;true&#39;, hostId=&#39;5386322c-bf91-4bf5-850<wbr>7-128f7473aa8d&#39;, taskId=&#39;5fe5e889-1065-4e77-834<wbr>b-71620e2f23e5&#39;}), log id: 7920c7e6</div><div>2017-11-21 10:29:23,889-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.UploadStreamComm<wbr>and] (DefaultQuartzScheduler2) [58f0924f] Lock Acquired to object &#39;EngineLock:{exclusiveLocks=&#39;&#39;<wbr>, sharedLocks=&#39;[5386322c-bf91-4b<wbr>f5-8507-128f7473aa8d=VDS_EXECU<wbr>TION]&#39;}&#39;</div><div>2017-11-21 10:29:23,915-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.UploadStreamComm<wbr>and] (DefaultQuartzScheduler2) [58f0924f] Running command: UploadStreamCommand internal: true. Entities affected :  ID: 425606b4-5aa0-4548-8b3f-61a8d0<wbr>852bf4 Type: Storage</div><div>2017-11-21 10:29:23,916-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] START, UploadStreamVDSCommand(HostNam<wbr>e = host01-dc1, UploadStreamVDSCommandParamete<wbr>rs:{runAsync=&#39;true&#39;, hostId=&#39;5386322c-bf91-4bf5-850<wbr>7-128f7473aa8d&#39;}), log id: 2fc55e39</div><div>2017-11-21 10:29:23,916-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] -- executeVdsBrokerCommand, parameters:</div><div>2017-11-21 10:29:23,916-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] ++ spUUID=59e6568b-02cd-03ad-012a<wbr>-000000000038</div><div>2017-11-21 10:29:23,916-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] ++ sdUUID=425606b4-5aa0-4548-8b3f<wbr>-61a8d0852bf4</div><div>2017-11-21 10:29:23,916-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] ++ imageGUID=5919ccc4-b9ad-4213-8<wbr>10b-4f8df08efdf5</div><div>2017-11-21 10:29:23,916-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] ++ volUUID=85a0eb12-2d70-4ae1-8c1<wbr>1-20ef30bbf839</div><div>2017-11-21 10:29:23,916-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] ++ size=235520</div><div>2017-11-21 10:29:24,856-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.vdsbroker.HSMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-2) [58f0924f] FINISH, HSMClearTaskVDSCommand, log id: 7920c7e6</div><div>2017-11-21 10:29:24,856-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SPMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-2) [58f0924f] FINISH, SPMClearTaskVDSCommand, log id: 4a85156f</div><div>2017-11-21 10:29:24,861-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-2) [58f0924f] BaseAsyncTask::removeTaskFromD<wbr>B: Removed task &#39;5fe5e889-1065-4e77-834b-71620<wbr>e2f23e5&#39; from DataBase</div><div>2017-11-21 10:29:24,861-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-2) [58f0924f] CommandAsyncTask::HandleEndAct<wbr>ionResult [within thread]: Removing CommandMultiAsyncTasks object for entity &#39;d73dc4e7-e0b8-4a19-a672-5ef67<wbr>8f64a08&#39;</div><div>2017-11-21 10:29:26,721-02 ERROR [org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand] (DefaultQuartzScheduler8) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Ending command &#39;org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand&#39; with failure.</div><div>2017-11-21 10:29:26,725-02 INFO  [org.ovirt.engine.core.utils.t<wbr>ransaction.TransactionSupport] (DefaultQuartzScheduler8) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] transaction rolled back</div><div>2017-11-21 10:29:26,737-02 ERROR [org.ovirt.engine.core.dal.dbb<wbr>roker.auditloghandling.AuditLo<wbr>gDirector] (DefaultQuartzScheduler8) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] EVENT_ID: USER_REMOVE_SNAPSHOT_FINISHED_<wbr>FAILURE(357), Correlation ID: 70cc2ffa-2414-4a00-9e24-6b6378<wbr>408a9d, Job ID: ec197072-7c38-42b6-9aef-99635d<wbr>4ee135, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: Failed to delete snapshot &#39;&lt;UNKNOWN&gt;&#39; for VM &#39;proxy03&#39;.</div><div>2017-11-21 10:29:26,738-02 ERROR [org.ovirt.engine.core.bll.tas<wbr>ks.CommandCallbacksPoller] (DefaultQuartzScheduler8) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Failed invoking callback end method &#39;onFailed&#39; for command &#39;a84519fe-6b23-4084-84a2-b7964<wbr>cbcde26&#39; with exception &#39;null&#39;, the callback is marked for end method retries</div><div>2017-11-21 10:29:26,898-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.UploadStreamVDSCo<wbr>mmand] (DefaultQuartzScheduler2) [58f0924f] FINISH, UploadStreamVDSCommand, log id: 2fc55e39</div><div>2017-11-21 10:29:26,922-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (DefaultQuartzScheduler2) [58f0924f] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command &#39;874fc31b-f30d-44da-9c85-083fc<wbr>4a5c1b8&#39;</div><div>2017-11-21 10:29:26,922-02 INFO  [<a href="http://org.ovirt.engine.core.bll.Com">org.ovirt.engine.core.bll.Com</a><wbr>mandMultiAsyncTasks] (DefaultQuartzScheduler2) [58f0924f] CommandMultiAsyncTasks::attach<wbr>Task: Attaching task &#39;e9424be5-5fa9-45fd-9d1d-db952<wbr>733670c&#39; to command &#39;874fc31b-f30d-44da-9c85-083fc<wbr>4a5c1b8&#39;.</div><div>2017-11-21 10:29:26,945-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.AsyncTaskManager] (DefaultQuartzScheduler2) [58f0924f] Adding task &#39;e9424be5-5fa9-45fd-9d1d-db952<wbr>733670c&#39; (Parent Command &#39;UploadStream&#39;, Parameters Type &#39;org.ovirt.engine.core.common.<wbr>asynctasks.AsyncTaskParameters<wbr>&#39;), polling hasn&#39;t started yet..</div><div>2017-11-21 10:29:26,956-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (DefaultQuartzScheduler2) [58f0924f] BaseAsyncTask::startPollingTas<wbr>k: Starting to poll task &#39;e9424be5-5fa9-45fd-9d1d-db952<wbr>733670c&#39;.</div><div>2017-11-21 10:29:26,964-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.UploadStreamComm<wbr>and] (DefaultQuartzScheduler2) [58f0924f] Lock freed to object &#39;EngineLock:{exclusiveLocks=&#39;&#39;<wbr>, sharedLocks=&#39;[5386322c-bf91-4b<wbr>f5-8507-128f7473aa8d=VDS_EXECU<wbr>TION]&#39;}&#39;</div><div>2017-11-21 10:29:26,966-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] START, SetVolumeDescriptionVDSCommand<wbr>( SetVolumeDescriptionVDSCommand<wbr>Parameters:{runAsync=&#39;true&#39;, storagePoolId=&#39;59e6568b-02cd-0<wbr>3ad-012a-000000000038&#39;, ignoreFailoverLimit=&#39;false&#39;, storageDomainId=&#39;425606b4-5aa0<wbr>-4548-8b3f-61a8d0852bf4&#39;, imageGroupId=&#39;5919ccc4-b9ad-42<wbr>13-810b-4f8df08efdf5&#39;, imageId=&#39;85a0eb12-2d70-4ae1-8c<wbr>11-20ef30bbf839&#39;}), log id: 3e073336</div><div>2017-11-21 10:29:26,966-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] -- executeIrsBrokerCommand: calling &#39;setVolumeDescription&#39;, parameters:</div><div>2017-11-21 10:29:26,966-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ spUUID=59e6568b-02cd-03ad-012a<wbr>-000000000038</div><div>2017-11-21 10:29:26,966-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ sdUUID=425606b4-5aa0-4548-8b3f<wbr>-61a8d0852bf4</div><div>2017-11-21 10:29:26,966-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ imageGroupGUID=5919ccc4-b9ad-4<wbr>213-810b-4f8df08efdf5</div><div>2017-11-21 10:29:26,966-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ volUUID=85a0eb12-2d70-4ae1-8c1<wbr>1-20ef30bbf839</div><div>2017-11-21 10:29:26,966-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] ++ description={&quot;Updated&quot;:true,&quot;S<wbr>ize&quot;:235520,&quot;Last Updated&quot;:&quot;Tue Nov 21 10:29:15 BRST 2017&quot;,&quot;Storage Domains&quot;:[{&quot;uuid&quot;:&quot;425606b4-5a<wbr>a0-4548-8b3f-61a8d0852bf4&quot;}],&quot;<wbr>Disk Description&quot;:&quot;OVF_STORE&quot;}</div><div>2017-11-21 10:29:28,223-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SetVolumeDescript<wbr>ionVDSCommand] (DefaultQuartzScheduler2) [58f0924f] FINISH, SetVolumeDescriptionVDSCommand<wbr>, log id: 3e073336</div><div>2017-11-21 10:29:28,237-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.ProcessOvfUpdate<wbr>ForStorageDomainCommand] (DefaultQuartzScheduler2) [58f0924f] Lock freed to object &#39;EngineLock:{exclusiveLocks=&#39;[<wbr>425606b4-5aa0-4548-8b3f-61a8d0<wbr>852bf4=STORAGE]&#39;, sharedLocks=&#39;[59e6568b-02cd-03<wbr>ad-012a-000000000038=OVF_UPDAT<wbr>E]&#39;}&#39;</div><div>2017-11-21 10:29:29,784-02 INFO  [org.ovirt.engine.core.bll.Ser<wbr>ialChildCommandsExecutionCallb<wbr>ack] (DefaultQuartzScheduler9) [58f0924f] Command &#39;ProcessOvfUpdateForStorageDom<wbr>ain&#39; (id: &#39;10a201e9-d1b4-45f0-99a0-74d61<wbr>14ac8b5&#39;) waiting on child command id: &#39;874fc31b-f30d-44da-9c85-083fc<wbr>4a5c1b8&#39; type:&#39;UploadStream&#39; to complete</div><div>2017-11-21 10:29:31,780-02 INFO  [org.ovirt.engine.core.bll.Rem<wbr>oveVmCommand] (default task-200) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] Lock Acquired to object &#39;EngineLock:{exclusiveLocks=&#39;[<wbr>5cb5e5c4-253b-4ab5-a93f-3661e6<wbr>ab54ac=VM]&#39;, sharedLocks=&#39;&#39;}&#39;</div><div>2017-11-21 10:29:31,868-02 INFO  [org.ovirt.engine.core.bll.Rem<wbr>oveVmCommand] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] Running command: RemoveVmCommand internal: false. Entities affected :  ID: 5cb5e5c4-253b-4ab5-a93f-3661e6<wbr>ab54ac Type: VMAction group DELETE_VM with role type USER</div><div>2017-11-21 10:29:31,869-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.SetVmStatusVDSCommand] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] START, SetVmStatusVDSCommand( SetVmStatusVDSCommandParameter<wbr>s:{runAsync=&#39;true&#39;, vmId=&#39;5cb5e5c4-253b-4ab5-a93f-<wbr>3661e6ab54ac&#39;, status=&#39;ImageLocked&#39;, exitStatus=&#39;Normal&#39;}), log id: 10a18186</div><div>2017-11-21 10:29:31,872-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.SetVmStatusVDSCommand] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] FINISH, SetVmStatusVDSCommand, log id: 10a18186</div><div>2017-11-21 10:29:31,875-02 INFO  [org.ovirt.engine.core.bll.Rem<wbr>oveVmCommand] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] Lock freed to object &#39;EngineLock:{exclusiveLocks=&#39;[<wbr>5cb5e5c4-253b-4ab5-a93f-3661e6<wbr>ab54ac=VM]&#39;, sharedLocks=&#39;&#39;}&#39;</div><div>2017-11-21 10:29:31,902-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.disk.image.RemoveAllVmIma<wbr>gesCommand] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] Running command: RemoveAllVmImagesCommand internal: true. Entities affected :  ID: 5cb5e5c4-253b-4ab5-a93f-3661e6<wbr>ab54ac Type: VM</div><div>2017-11-21 10:29:31,930-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.disk.image.RemoveImageCom<wbr>mand] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] Running command: RemoveImageCommand internal: true. Entities affected :  ID: 00000000-0000-0000-0000-000000<wbr>000000 Type: Storage</div><div>2017-11-21 10:29:32,002-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.DeleteImageGroupV<wbr>DSCommand] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] START, DeleteImageGroupVDSCommand( DeleteImageGroupVDSCommandPara<wbr>meters:{runAsync=&#39;true&#39;, storagePoolId=&#39;59e6568b-02cd-0<wbr>3ad-012a-000000000038&#39;, ignoreFailoverLimit=&#39;false&#39;, storageDomainId=&#39;425606b4-5aa0<wbr>-4548-8b3f-61a8d0852bf4&#39;, imageGroupId=&#39;fb163891-3a74-4a<wbr>bc-a576-444675d447e4&#39;, postZeros=&#39;false&#39;, discard=&#39;false&#39;, forceDelete=&#39;false&#39;}), log id: 4b43a62a</div><div>2017-11-21 10:29:32,498-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.AsyncTaskManager] (DefaultQuartzScheduler1) [6523c570] Polling and updating Async Tasks: 2 tasks, 1 tasks to poll now</div><div>2017-11-21 10:29:33,587-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.DeleteImageGroupV<wbr>DSCommand] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] FINISH, DeleteImageGroupVDSCommand, log id: 4b43a62a</div><div>2017-11-21 10:29:33,594-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command &#39;785b30c0-a425-4ad0-9a68-9740d<wbr>2c9dc1b&#39;</div><div>2017-11-21 10:29:33,594-02 INFO  [<a href="http://org.ovirt.engine.core.bll.Com">org.ovirt.engine.core.bll.Com</a><wbr>mandMultiAsyncTasks] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] CommandMultiAsyncTasks::attach<wbr>Task: Attaching task &#39;f585094e-d892-4840-af64-66357<wbr>1cfd35f&#39; to command &#39;785b30c0-a425-4ad0-9a68-9740d<wbr>2c9dc1b&#39;.</div><div>2017-11-21 10:29:33,633-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (DefaultQuartzScheduler1) [6523c570] SPMAsyncTask::PollTask: Polling task &#39;e9424be5-5fa9-45fd-9d1d-db952<wbr>733670c&#39; (Parent Command &#39;UploadStream&#39;, Parameters Type &#39;org.ovirt.engine.core.common.<wbr>asynctasks.AsyncTaskParameters<wbr>&#39;) returned status &#39;finished&#39;, result &#39;success&#39;.</div><div>2017-11-21 10:29:33,633-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (DefaultQuartzScheduler1) [6523c570] BaseAsyncTask::onTaskEndSucces<wbr>s: Task &#39;e9424be5-5fa9-45fd-9d1d-db952<wbr>733670c&#39; (Parent Command &#39;UploadStream&#39;, Parameters Type &#39;org.ovirt.engine.core.common.<wbr>asynctasks.AsyncTaskParameters<wbr>&#39;) ended successfully.</div><div>2017-11-21 10:29:33,634-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (DefaultQuartzScheduler1) [6523c570] CommandAsyncTask::endActionIfN<wbr>ecessary: All tasks of command &#39;874fc31b-f30d-44da-9c85-083fc<wbr>4a5c1b8&#39; has ended -&gt; executing &#39;endAction&#39;</div><div>2017-11-21 10:29:33,634-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (DefaultQuartzScheduler1) [6523c570] CommandAsyncTask::endAction: Ending action for &#39;1&#39; tasks (command ID: &#39;874fc31b-f30d-44da-9c85-083fc<wbr>4a5c1b8&#39;): calling endAction &#39;.</div><div>2017-11-21 10:29:33,634-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.AsyncTaskManager] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] Adding task &#39;f585094e-d892-4840-af64-66357<wbr>1cfd35f&#39; (Parent Command &#39;RemoveVm&#39;, Parameters Type &#39;org.ovirt.engine.core.common.<wbr>asynctasks.AsyncTaskParameters<wbr>&#39;), polling hasn&#39;t started yet..</div><div>2017-11-21 10:29:33,634-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-34) [6523c570] CommandAsyncTask::endCommandAc<wbr>tion [within thread] context: Attempting to endAction &#39;UploadStream&#39;,</div><div>2017-11-21 10:29:33,643-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.UploadStreamComm<wbr>and] (org.ovirt.thread.pool-6-threa<wbr>d-34) [58f0924f] Ending command &#39;org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.UploadStreamComm<wbr>and&#39; successfully.</div><div>2017-11-21 10:29:33,654-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-34) [58f0924f] CommandAsyncTask::HandleEndAct<wbr>ionResult [within thread]: endAction for action type &#39;UploadStream&#39; completed, handling the result.</div><div>2017-11-21 10:29:33,654-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-34) [58f0924f] CommandAsyncTask::HandleEndAct<wbr>ionResult [within thread]: endAction for action type &#39;UploadStream&#39; succeeded, clearing tasks.</div><div>2017-11-21 10:29:33,654-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-34) [58f0924f] SPMAsyncTask::ClearAsyncTask: Attempting to clear task &#39;e9424be5-5fa9-45fd-9d1d-db952<wbr>733670c&#39;</div><div>2017-11-21 10:29:33,655-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SPMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-34) [58f0924f] START, SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParam<wbr>eters:{runAsync=&#39;true&#39;, storagePoolId=&#39;59e6568b-02cd-0<wbr>3ad-012a-000000000038&#39;, ignoreFailoverLimit=&#39;false&#39;, taskId=&#39;e9424be5-5fa9-45fd-9d1<wbr>d-db952733670c&#39;}), log id: 76cd0e96</div><div>2017-11-21 10:29:33,656-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.vdsbroker.HSMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-34) [58f0924f] START, HSMClearTaskVDSCommand(HostNam<wbr>e = host01-dc1, HSMTaskGuidBaseVDSCommandParam<wbr>eters:{runAsync=&#39;true&#39;, hostId=&#39;5386322c-bf91-4bf5-850<wbr>7-128f7473aa8d&#39;, taskId=&#39;e9424be5-5fa9-45fd-9d1<wbr>d-db952733670c&#39;}), log id: 6bb3135e</div><div>2017-11-21 10:29:33,803-02 INFO  [org.ovirt.engine.core.dal.dbb<wbr>roker.auditloghandling.AuditLo<wbr>gDirector] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] EVENT_ID: USER_REMOVE_VM_FINISHED(113), Correlation ID: 6454d8f7-93e6-47ae-ba9b-a5a075<wbr>c1cfde, Job ID: 49662b64-2b05-4b32-acd7-412db9<wbr>71e99b, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: VM unifi-controller was successfully removed.</div><div>2017-11-21 10:29:33,804-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-27) [6454d8f7-93e6-47ae-ba9b-a5a07<wbr>5c1cfde] BaseAsyncTask::startPollingTas<wbr>k: Starting to poll task &#39;f585094e-d892-4840-af64-66357<wbr>1cfd35f&#39;.</div><div>2017-11-21 10:29:33,825-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.vdsbroker.HSMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-34) [58f0924f] FINISH, HSMClearTaskVDSCommand, log id: 6bb3135e</div><div>2017-11-21 10:29:33,825-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SPMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-34) [58f0924f] FINISH, SPMClearTaskVDSCommand, log id: 76cd0e96</div><div>2017-11-21 10:29:33,830-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-34) [58f0924f] BaseAsyncTask::removeTaskFromD<wbr>B: Removed task &#39;e9424be5-5fa9-45fd-9d1d-db952<wbr>733670c&#39; from DataBase</div><div>2017-11-21 10:29:33,830-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-34) [58f0924f] CommandAsyncTask::HandleEndAct<wbr>ionResult [within thread]: Removing CommandMultiAsyncTasks object for entity &#39;874fc31b-f30d-44da-9c85-083fc<wbr>4a5c1b8&#39;</div><div>2017-11-21 10:29:36,879-02 ERROR [org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand] (DefaultQuartzScheduler10) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Ending command &#39;org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand&#39; with failure.</div><div>2017-11-21 10:29:36,883-02 INFO  [org.ovirt.engine.core.utils.t<wbr>ransaction.TransactionSupport] (DefaultQuartzScheduler10) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] transaction rolled back</div><div>2017-11-21 10:29:36,895-02 ERROR [org.ovirt.engine.core.dal.dbb<wbr>roker.auditloghandling.AuditLo<wbr>gDirector] (DefaultQuartzScheduler10) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] EVENT_ID: USER_REMOVE_SNAPSHOT_FINISHED_<wbr>FAILURE(357), Correlation ID: 70cc2ffa-2414-4a00-9e24-6b6378<wbr>408a9d, Job ID: ec197072-7c38-42b6-9aef-99635d<wbr>4ee135, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: Failed to delete snapshot &#39;&lt;UNKNOWN&gt;&#39; for VM &#39;proxy03&#39;.</div><div>2017-11-21 10:29:36,895-02 ERROR [org.ovirt.engine.core.bll.tas<wbr>ks.CommandCallbacksPoller] (DefaultQuartzScheduler10) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Failed invoking callback end method &#39;onFailed&#39; for command &#39;a84519fe-6b23-4084-84a2-b7964<wbr>cbcde26&#39; with exception &#39;null&#39;, the callback is marked for end method retries</div><div>2017-11-21 10:29:39,937-02 INFO  [org.ovirt.engine.core.bll.Ser<wbr>ialChildCommandsExecutionCallb<wbr>ack] (DefaultQuartzScheduler8) [58f0924f] Command &#39;ProcessOvfUpdateForStorageDom<wbr>ain&#39; id: &#39;10a201e9-d1b4-45f0-99a0-74d61<wbr>14ac8b5&#39; child commands &#39;[d73dc4e7-e0b8-4a19-a672-5ef6<wbr>78f64a08, 874fc31b-f30d-44da-9c85-083fc4<wbr>a5c1b8]&#39; executions were completed, status &#39;SUCCEEDED&#39;</div><div>2017-11-21 10:29:40,974-02 INFO  [org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.ProcessOvfUpdate<wbr>ForStorageDomainCommand] (DefaultQuartzScheduler5) [58f0924f] Ending command &#39;org.ovirt.engine.core.bll.sto<wbr>rage.ovfstore.ProcessOvfUpdate<wbr>ForStorageDomainCommand&#39; successfully.</div><div>2017-11-21 10:29:43,634-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.AsyncTaskManager] (DefaultQuartzScheduler9) [7b755e5d] Polling and updating Async Tasks: 3 tasks, 1 tasks to poll now</div><div>2017-11-21 10:29:45,920-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (DefaultQuartzScheduler9) [7b755e5d] SPMAsyncTask::PollTask: Polling task &#39;f585094e-d892-4840-af64-66357<wbr>1cfd35f&#39; (Parent Command &#39;RemoveVm&#39;, Parameters Type &#39;org.ovirt.engine.core.common.<wbr>asynctasks.AsyncTaskParameters<wbr>&#39;) returned status &#39;finished&#39;, result &#39;success&#39;.</div><div>2017-11-21 10:29:45,925-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (DefaultQuartzScheduler9) [7b755e5d] BaseAsyncTask::onTaskEndSucces<wbr>s: Task &#39;f585094e-d892-4840-af64-66357<wbr>1cfd35f&#39; (Parent Command &#39;RemoveVm&#39;, Parameters Type &#39;org.ovirt.engine.core.common.<wbr>asynctasks.AsyncTaskParameters<wbr>&#39;) ended successfully.</div><div>2017-11-21 10:29:45,928-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (DefaultQuartzScheduler9) [7b755e5d] CommandAsyncTask::endActionIfN<wbr>ecessary: All tasks of command &#39;785b30c0-a425-4ad0-9a68-9740d<wbr>2c9dc1b&#39; has ended -&gt; executing &#39;endAction&#39;</div><div>2017-11-21 10:29:45,928-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (DefaultQuartzScheduler9) [7b755e5d] CommandAsyncTask::endAction: Ending action for &#39;1&#39; tasks (command ID: &#39;785b30c0-a425-4ad0-9a68-9740d<wbr>2c9dc1b&#39;): calling endAction &#39;.</div><div>2017-11-21 10:29:45,928-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] CommandAsyncTask::endCommandAc<wbr>tion [within thread] context: Attempting to endAction &#39;RemoveVm&#39;,</div><div>2017-11-21 10:29:45,941-02 INFO  [org.ovirt.engine.core.bll.Rem<wbr>oveVmCommand] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] Ending command &#39;org.ovirt.engine.core.bll.Rem<wbr>oveVmCommand&#39; successfully.</div><div>2017-11-21 10:29:45,946-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] CommandAsyncTask::HandleEndAct<wbr>ionResult [within thread]: endAction for action type &#39;RemoveVm&#39; completed, handling the result.</div><div>2017-11-21 10:29:45,946-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] CommandAsyncTask::HandleEndAct<wbr>ionResult [within thread]: endAction for action type &#39;RemoveVm&#39; succeeded, clearing tasks.</div><div>2017-11-21 10:29:45,946-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] SPMAsyncTask::ClearAsyncTask: Attempting to clear task &#39;f585094e-d892-4840-af64-66357<wbr>1cfd35f&#39;</div><div>2017-11-21 10:29:45,947-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SPMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] START, SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParam<wbr>eters:{runAsync=&#39;true&#39;, storagePoolId=&#39;59e6568b-02cd-0<wbr>3ad-012a-000000000038&#39;, ignoreFailoverLimit=&#39;false&#39;, taskId=&#39;f585094e-d892-4840-af6<wbr>4-663571cfd35f&#39;}), log id: 575b7d94</div><div>2017-11-21 10:29:45,947-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.vdsbroker.HSMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] START, HSMClearTaskVDSCommand(HostNam<wbr>e = host01-dc1, HSMTaskGuidBaseVDSCommandParam<wbr>eters:{runAsync=&#39;true&#39;, hostId=&#39;5386322c-bf91-4bf5-850<wbr>7-128f7473aa8d&#39;, taskId=&#39;f585094e-d892-4840-af6<wbr>4-663571cfd35f&#39;}), log id: 6164bf23</div><div>2017-11-21 10:29:46,288-02 INFO  [org.ovirt.engine.core.bll.aaa<wbr>.SessionDataContainer] (DefaultQuartzScheduler1) [6fd44373] Not removing session &#39;N8YCGRnduzKPm0RIBJIstocZIdkPA<wbr>ukaKCYDXwWncjWW/NhWw7X1/pSq07h<wbr>ifciMHWlan+xMcaQPka3gyX9tXQ==&#39;<wbr>, session has running commands for user &#39;admin@internal-authz&#39;.</div><div>2017-11-21 10:29:46,974-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.vdsbroker.HSMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] FINISH, HSMClearTaskVDSCommand, log id: 6164bf23</div><div>2017-11-21 10:29:46,974-02 INFO  [org.ovirt.engine.core.vdsbrok<wbr>er.irsbroker.SPMClearTaskVDSCo<wbr>mmand] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] FINISH, SPMClearTaskVDSCommand, log id: 575b7d94</div><div>2017-11-21 10:29:46,980-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.SPMAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] BaseAsyncTask::removeTaskFromD<wbr>B: Removed task &#39;f585094e-d892-4840-af64-66357<wbr>1cfd35f&#39; from DataBase</div><div>2017-11-21 10:29:46,980-02 INFO  [org.ovirt.engine.core.bll.tas<wbr>ks.CommandAsyncTask] (org.ovirt.thread.pool-6-threa<wbr>d-32) [7b755e5d] CommandAsyncTask::HandleEndAct<wbr>ionResult [within thread]: Removing CommandMultiAsyncTasks object for entity &#39;785b30c0-a425-4ad0-9a68-9740d<wbr>2c9dc1b&#39;</div><div>2017-11-21 10:29:47,002-02 ERROR [org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand] (DefaultQuartzScheduler6) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Ending command &#39;org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand&#39; with failure.</div><div>2017-11-21 10:29:47,005-02 INFO  [org.ovirt.engine.core.utils.t<wbr>ransaction.TransactionSupport] (DefaultQuartzScheduler6) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] transaction rolled back</div><div>2017-11-21 10:29:47,017-02 ERROR [org.ovirt.engine.core.dal.dbb<wbr>roker.auditloghandling.AuditLo<wbr>gDirector] (DefaultQuartzScheduler6) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] EVENT_ID: USER_REMOVE_SNAPSHOT_FINISHED_<wbr>FAILURE(357), Correlation ID: 70cc2ffa-2414-4a00-9e24-6b6378<wbr>408a9d, Job ID: ec197072-7c38-42b6-9aef-99635d<wbr>4ee135, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: Failed to delete snapshot &#39;&lt;UNKNOWN&gt;&#39; for VM &#39;proxy03&#39;.</div><div>2017-11-21 10:29:47,017-02 ERROR [org.ovirt.engine.core.bll.tas<wbr>ks.CommandCallbacksPoller] (DefaultQuartzScheduler6) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Failed invoking callback end method &#39;onFailed&#39; for command &#39;a84519fe-6b23-4084-84a2-b7964<wbr>cbcde26&#39; with exception &#39;null&#39;, the callback is marked for end method retries</div><div>[root@ovirt ovirt-engine]# </div></div><div><br></div><div><br></div><div>This is an automatic delete, it caused by some error on my backup script.</div><div><br></div><div>I am looking for the the Event ID on postgres to identify the error.</div><div><br></div></div><div class="gmail_extra"><br clear="all"><div><div class="m_-4339842616950681302m_1588541219267126746gmail_signature" data-smartmail="gmail_signature"><div dir="ltr">Atenciosamente,<br>Arthur Melo<br>Linux User #302250<br><br></div></div></div>
<br><div class="gmail_quote">2017-11-21 10:26 GMT-02:00 Benny Zlotnik <span dir="ltr">&lt;<a href="mailto:bzlotnik@redhat.com" target="_blank">bzlotnik@redhat.com</a>&gt;</span>:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div dir="ltr"><div>Please attach the full engine log (at least from the moment you attempted the to delete).<br></div>Do you have access to the host the VM is running on? The vdsm log is available at /var/log/vdsm/vdsm.log<br></div><div class="m_-4339842616950681302m_1588541219267126746HOEnZb"><div class="m_-4339842616950681302m_1588541219267126746h5"><div class="gmail_extra"><br><div class="gmail_quote">On Tue, Nov 21, 2017 at 2:17 PM, Arthur Melo <span dir="ltr">&lt;<a href="mailto:arthur@afabrica.net" target="_blank">arthur@afabrica.net</a>&gt;</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>engine.log</div><div>------------------</div><div>2017-11-21 10:15:02,536-02 ERROR [org.ovirt.engine.core.dal.dbb<wbr>roker.auditloghandling.AuditLo<wbr>gDirector] (DefaultQuartzScheduler2) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] EVENT_ID: USER_REMOVE_SNAPSHOT_FINISHED_<wbr>FAILURE(357), Correlation ID: 70cc2ffa-2414-4a00-9e24-6b6378<wbr>408a9d, Job ID: ec197072-7c38-42b6-9aef-99635d<wbr>4ee135, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: Failed to delete snapshot &#39;&lt;UNKNOWN&gt;&#39; for VM &#39;proxy03&#39;.</div><div>2017-11-21 10:15:02,537-02 ERROR [org.ovirt.engine.core.bll.tas<wbr>ks.CommandCallbacksPoller] (DefaultQuartzScheduler2) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Failed invoking callback end method &#39;onFailed&#39; for command &#39;a84519fe-6b23-4084-84a2-b7964<wbr>cbcde26&#39; with exception &#39;null&#39;, the callback is marked for end method retries</div><div>2017-11-21 10:15:12,551-02 ERROR [org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand] (DefaultQuartzScheduler5) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Ending command &#39;org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand&#39; with failure.</div><div>2017-11-21 10:15:12,555-02 INFO  [org.ovirt.engine.core.utils.t<wbr>ransaction.TransactionSupport] (DefaultQuartzScheduler5) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] transaction rolled back</div><div>2017-11-21 10:15:12,567-02 ERROR [org.ovirt.engine.core.dal.dbb<wbr>roker.auditloghandling.AuditLo<wbr>gDirector] (DefaultQuartzScheduler5) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] EVENT_ID: USER_REMOVE_SNAPSHOT_FINISHED_<wbr>FAILURE(357), Correlation ID: 70cc2ffa-2414-4a00-9e24-6b6378<wbr>408a9d, Job ID: ec197072-7c38-42b6-9aef-99635d<wbr>4ee135, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: Failed to delete snapshot &#39;&lt;UNKNOWN&gt;&#39; for VM &#39;proxy03&#39;.</div><div>2017-11-21 10:15:12,567-02 ERROR [org.ovirt.engine.core.bll.tas<wbr>ks.CommandCallbacksPoller] (DefaultQuartzScheduler5) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Failed invoking callback end method &#39;onFailed&#39; for command &#39;a84519fe-6b23-4084-84a2-b7964<wbr>cbcde26&#39; with exception &#39;null&#39;, the callback is marked for end method retries</div><div>2017-11-21 10:15:22,582-02 ERROR [org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand] (DefaultQuartzScheduler10) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Ending command &#39;org.ovirt.engine.core.bll.sna<wbr>pshots.RemoveSnapshotCommand&#39; with failure.</div><div>2017-11-21 10:15:22,585-02 INFO  [org.ovirt.engine.core.utils.t<wbr>ransaction.TransactionSupport] (DefaultQuartzScheduler10) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] transaction rolled back</div><div>2017-11-21 10:15:22,599-02 ERROR [org.ovirt.engine.core.dal.dbb<wbr>roker.auditloghandling.AuditLo<wbr>gDirector] (DefaultQuartzScheduler10) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] EVENT_ID: USER_REMOVE_SNAPSHOT_FINISHED_<wbr>FAILURE(357), Correlation ID: 70cc2ffa-2414-4a00-9e24-6b6378<wbr>408a9d, Job ID: ec197072-7c38-42b6-9aef-99635d<wbr>4ee135, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: Failed to delete snapshot &#39;&lt;UNKNOWN&gt;&#39; for VM &#39;proxy03&#39;.</div><div>2017-11-21 10:15:22,600-02 ERROR [org.ovirt.engine.core.bll.tas<wbr>ks.CommandCallbacksPoller] (DefaultQuartzScheduler10) [70cc2ffa-2414-4a00-9e24-6b637<wbr>8408a9d] Failed invoking callback end method &#39;onFailed&#39; for command &#39;a84519fe-6b23-4084-84a2-b7964<wbr>cbcde26&#39; with exception &#39;null&#39;, the callback is marked for end method retries</div><div>------------------</div><div><br></div><div>I don&#39;t have vdsm log. (I don&#39;t know why).</div></div><div class="gmail_extra"><span><br clear="all"><div><div class="m_-4339842616950681302m_1588541219267126746m_8620718557212035038m_87714269769197470gmail_signature" data-smartmail="gmail_signature"><div dir="ltr">Atenciosamente,<br>Arthur Melo<br>Linux User #302250<br><br></div></div></div>
<br></span><div><div class="m_-4339842616950681302m_1588541219267126746m_8620718557212035038h5"><div class="gmail_quote">2017-11-21 10:14 GMT-02:00 Benny Zlotnik <span dir="ltr">&lt;<a href="mailto:bzlotnik@redhat.com" target="_blank">bzlotnik@redhat.com</a>&gt;</span>:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div dir="ltr">Please attach engine and vdsm logs<br></div><div class="gmail_extra"><br><div class="gmail_quote"><div><div class="m_-4339842616950681302m_1588541219267126746m_8620718557212035038m_87714269769197470h5">On Tue, Nov 21, 2017 at 2:11 PM, Arthur Melo <span dir="ltr">&lt;<a href="mailto:arthur@afabrica.net" target="_blank">arthur@afabrica.net</a>&gt;</span> wrote:<br></div></div><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div><div class="m_-4339842616950681302m_1588541219267126746m_8620718557212035038m_87714269769197470h5"><div dir="ltr">Can someone help me with this error?<div><br></div><div><br></div><div>Failed to delete snapshot &#39;&lt;UNKNOWN&gt;&#39; for VM &#39;proxy03&#39;.</div><div><br></div><div><br></div><div><br clear="all"><div><div class="m_-4339842616950681302m_1588541219267126746m_8620718557212035038m_87714269769197470m_1194602540380064028m_3408560974843923183gmail_signature"><div dir="ltr">Atenciosamente,<br>Arthur Melo<br>Linux User #302250<br><br></div></div></div>
</div></div>
<br></div></div>______________________________<wbr>_________________<br>
Users mailing list<br>
<a href="mailto:Users@ovirt.org" target="_blank">Users@ovirt.org</a><br>
<a href="http://lists.ovirt.org/mailman/listinfo/users" rel="noreferrer" target="_blank">http://lists.ovirt.org/mailman<wbr>/listinfo/users</a><br>
<br></blockquote></div><br></div>
</blockquote></div><br></div></div></div>
</blockquote></div><br></div>
</div></div></blockquote></div><br></div>
</blockquote></div><br></div>
</blockquote></div><br></div>