2020-12-11 22:07:37,160-0300 INFO (jsonrpc/2) [api.virt] START create(vmParams={'vmId': 'd7ce9bfe-0415-4a23-a3d2-0337b9e593c2', 'xml': 'TEMPLATE-OPN207d7ce9bfe-0415-4a23-a3d2-0337b9e593c24194304419430411677721616oVirtOS-NAME:OS-VERSION:oVirtHOST-SERIAL:d7ce9bfe-0415-4a23-a3d2-0337b9e593c2Haswell-noTSX
0b81e3e9-9848-4590-92de-c5e4326ebe37
hvm40964.4002a9450-3772-11eb-8e09-00163e04451233caa5d5-b1c2-48f8-9f69-33cb32cbdeb40b81e3e9-9848-4590-92de-c5e4326ebe37a4b00178-9ae1-443b-85db-468a8374ac69falseauto_resume
'}) from=::ffff:10.250.0.150,40186, flow_id=9d060a52-bbfb-465b-8004-1ea1fd82d136, vmId=d7ce9bfe-0415-4a23-a3d2-0337b9e593c2 (api:48) 2020-12-11 22:07:37,164-0300 INFO (jsonrpc/2) [virt.vm] (vmId='d7ce9bfe-0415-4a23-a3d2-0337b9e593c2') using a computed convergence schedule for a legacy migration: {'init': [{'params': ['101'], 'name': 'setDowntime'}], 'stalling': [{'action': {'params': ['104'], 'name': 'setDowntime'}, 'limit': 1}, {'action': {'params': ['120'], 'name': 'setDowntime'}, 'limit': 2}, {'action': {'params': ['189'], 'name': 'setDowntime'}, 'limit': 3}, {'action': {'params': ['500'], 'name': 'setDowntime'}, 'limit': 4}, {'action': {'params': ['500'], 'name': 'setDowntime'}, 'limit': 42}, {'action': {'params': [], 'name': 'abort'}, 'limit': -1}]} (migration:159) 2020-12-11 22:07:37,165-0300 INFO (vm/d7ce9bfe) [virt.vm] (vmId='d7ce9bfe-0415-4a23-a3d2-0337b9e593c2') VM wrapper has started (vm:2568) 2020-12-11 22:07:37,165-0300 INFO (jsonrpc/2) [api.virt] FINISH create return={'vmList': {'vmId': 'd7ce9bfe-0415-4a23-a3d2-0337b9e593c2', 'status': 'WaitForLaunch', 'statusTime': '2441342925', 'xml': 'TEMPLATE-OPN207d7ce9bfe-0415-4a23-a3d2-0337b9e593c24194304419430411677721616oVirtOS-NAME:OS-VERSION:oVirtHOST-SERIAL:d7ce9bfe-0415-4a23-a3d2-0337b9e593c2Haswell-noTSX
0b81e3e9-9848-4590-92de-c5e4326ebe37
hvm40964.4002a9450-3772-11eb-8e09-00163e04451233caa5d5-b1c2-48f8-9f69-33cb32cbdeb40b81e3e9-9848-4590-92de-c5e4326ebe37a4b00178-9ae1-443b-85db-468a8374ac69falseauto_resume
'}, 'status': {'code': 0, 'message': 'Done'}} from=::ffff:10.250.0.150,40186, flow_id=9d060a52-bbfb-465b-8004-1ea1fd82d136, vmId=d7ce9bfe-0415-4a23-a3d2-0337b9e593c2 (api:54) 2020-12-11 22:07:37,217-0300 INFO (vm/d7ce9bfe) [vdsm.api] START getVolumeSize(sdUUID='a4b00178-9ae1-443b-85db-468a8374ac69', spUUID='002a9450-3772-11eb-8e09-00163e044512', imgUUID='0b81e3e9-9848-4590-92de-c5e4326ebe37', volUUID='33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4', options=None) from=internal, task_id=306781b6-05e1-4f9e-8178-43bf43c52362 (api:48) 2020-12-11 22:07:37,337-0300 INFO (vm/d7ce9bfe) [vdsm.api] FINISH getVolumeSize return={'apparentsize': '4697620480', 'truesize': '4697620480'} from=internal, task_id=306781b6-05e1-4f9e-8178-43bf43c52362 (api:54) 2020-12-11 22:07:37,338-0300 INFO (vm/d7ce9bfe) [vds] prepared volume path: (clientIF:513) 2020-12-11 22:07:37,338-0300 INFO (vm/d7ce9bfe) [vdsm.api] START prepareImage(sdUUID='a4b00178-9ae1-443b-85db-468a8374ac69', spUUID='002a9450-3772-11eb-8e09-00163e044512', imgUUID='0b81e3e9-9848-4590-92de-c5e4326ebe37', leafUUID='33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4', allowIllegal=False) from=internal, task_id=af9044c6-0bc1-4787-8867-7c4a31973165 (api:48) 2020-12-11 22:07:37,481-0300 INFO (vm/d7ce9bfe) [storage.LVM] Activating lvs: vg=a4b00178-9ae1-443b-85db-468a8374ac69 lvs=['33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4'] (lvm:1738) 2020-12-11 22:07:37,636-0300 INFO (vm/d7ce9bfe) [storage.StorageDomain] Creating image run directory '/run/vdsm/storage/a4b00178-9ae1-443b-85db-468a8374ac69/0b81e3e9-9848-4590-92de-c5e4326ebe37' (blockSD:1344) 2020-12-11 22:07:37,637-0300 INFO (vm/d7ce9bfe) [storage.fileUtils] Creating directory: /run/vdsm/storage/a4b00178-9ae1-443b-85db-468a8374ac69/0b81e3e9-9848-4590-92de-c5e4326ebe37 mode: None (fileUtils:198) 2020-12-11 22:07:37,637-0300 INFO (vm/d7ce9bfe) [storage.StorageDomain] Creating symlink from /dev/a4b00178-9ae1-443b-85db-468a8374ac69/33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4 to /run/vdsm/storage/a4b00178-9ae1-443b-85db-468a8374ac69/0b81e3e9-9848-4590-92de-c5e4326ebe37/33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4 (blockSD:1349) 2020-12-11 22:07:37,805-0300 INFO (vm/d7ce9bfe) [storage.StorageDomain] Creating symlink from /run/vdsm/storage/a4b00178-9ae1-443b-85db-468a8374ac69/0b81e3e9-9848-4590-92de-c5e4326ebe37 to /rhev/data-center/mnt/blockSD/a4b00178-9ae1-443b-85db-468a8374ac69/images/0b81e3e9-9848-4590-92de-c5e4326ebe37 (blockSD:1314) 2020-12-11 22:07:37,806-0300 INFO (vm/d7ce9bfe) [vdsm.api] FINISH prepareImage return={'path': '/rhev/data-center/mnt/blockSD/a4b00178-9ae1-443b-85db-468a8374ac69/images/0b81e3e9-9848-4590-92de-c5e4326ebe37/33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4', 'info': {'type': 'block', 'path': '/rhev/data-center/mnt/blockSD/a4b00178-9ae1-443b-85db-468a8374ac69/images/0b81e3e9-9848-4590-92de-c5e4326ebe37/33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4'}, 'imgVolumesInfo': [{'domainID': 'a4b00178-9ae1-443b-85db-468a8374ac69', 'imageID': '0b81e3e9-9848-4590-92de-c5e4326ebe37', 'volumeID': '33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4', 'path': '/rhev/data-center/mnt/blockSD/a4b00178-9ae1-443b-85db-468a8374ac69/images/0b81e3e9-9848-4590-92de-c5e4326ebe37/33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4', 'leasePath': '/dev/a4b00178-9ae1-443b-85db-468a8374ac69/leases', 'leaseOffset': 110100480}]} from=internal, task_id=af9044c6-0bc1-4787-8867-7c4a31973165 (api:54) 2020-12-11 22:07:37,806-0300 INFO (vm/d7ce9bfe) [vds] prepared volume path: /rhev/data-center/mnt/blockSD/a4b00178-9ae1-443b-85db-468a8374ac69/images/0b81e3e9-9848-4590-92de-c5e4326ebe37/33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4 (clientIF:513) 2020-12-11 22:07:37,807-0300 INFO (vm/d7ce9bfe) [virt.vm] (vmId='d7ce9bfe-0415-4a23-a3d2-0337b9e593c2') Enabling drive monitoring (drivemonitor:59) 2020-12-11 22:07:37,850-0300 INFO (vm/d7ce9bfe) [virt.vm] (vmId='d7ce9bfe-0415-4a23-a3d2-0337b9e593c2') drive 'sdc' path: 'file=' -> '*file=' (storagexml:340) 2020-12-11 22:07:37,851-0300 INFO (vm/d7ce9bfe) [virt.vm] (vmId='d7ce9bfe-0415-4a23-a3d2-0337b9e593c2') drive 'sda' path: 'dev=/rhev/data-center/mnt/blockSD/a4b00178-9ae1-443b-85db-468a8374ac69/images/0b81e3e9-9848-4590-92de-c5e4326ebe37/33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4' -> '*dev=/rhev/data-center/mnt/blockSD/a4b00178-9ae1-443b-85db-468a8374ac69/images/0b81e3e9-9848-4590-92de-c5e4326ebe37/33caa5d5-b1c2-48f8-9f69-33cb32cbdeb4' (storagexml:340) 2020-12-11 22:07:37,956-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_device_create/10_ovirt_provider_ovn_hook: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:38,060-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_device_create/20_ovirt_provider_ovn_vhostuser_hook: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:38,474-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_device_create/50_openstacknet: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:38,605-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_device_create/50_vmfex: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:39,010-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_device_create/openstacknet_utils.py: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:39,116-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_device_create/10_ovirt_provider_ovn_hook: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:39,217-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_device_create/20_ovirt_provider_ovn_vhostuser_hook: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:39,634-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_device_create/50_openstacknet: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:39,762-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_device_create/50_vmfex: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:40,169-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_device_create/openstacknet_utils.py: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:40,291-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_vm_start/50_hostedengine: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:40,400-0300 INFO (vm/d7ce9bfe) [root] /usr/libexec/vdsm/hooks/before_vm_start/50_vhostmd: rc=0 err=b'' (hooks:122) 2020-12-11 22:07:40,402-0300 INFO (vm/d7ce9bfe) [virt.vm] (vmId='d7ce9bfe-0415-4a23-a3d2-0337b9e593c2') TEMPLATE-OPN207 d7ce9bfe-0415-4a23-a3d2-0337b9e593c2 4194304 4194304 1 16777216 16 oVirt RHEL 8-2.2004.0.2.el8 oVirt 00000000-0000-0000-0000-0cc47ad29034 d7ce9bfe-0415-4a23-a3d2-0337b9e593c2 Haswell-noTSX