
<div style=3D"margin: 0px;"> = <entry = name=3D"uuid">c2aff4cc-0de6-4342-a565-669b1825838c</entry></div><=
--Apple-Mail=_877DC8BA-BA64-4899-AC8F-C9588B685A8B Content-Transfer-Encoding: quoted-printable Content-Type: text/plain; charset=windows-1252 So twice now under oVirt 3.3.2 I have added 2 virtio-scsi devices to a = single virtual host. =20 After doing so, the VM would fail to boot due to duplicate disk ID. The = first time I thought it a fluke, second time=92s a bug? Fortunately they were empty data disks and I was able to get around the = problem by deleting one and recreating it. VDSM log: Thread-32154::INFO::2014-01-08 = 11:54:39,717::clientIF::350::vds::(prepareVolumePath) prepared volume = path: = /rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/imag= es/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6de= a2 Thread-32154::DEBUG::2014-01-08 11:54:39,740::vm::2984::vm.Vm::(_run) = vmId=3D`c2aff4cc-0de6-4342-a565-669b1825838c`::<?xml version=3D"1.0" = encoding=3D"utf-8"?> <domain type=3D"kvm"> <name>cobra</name> <uuid>c2aff4cc-0de6-4342-a565-669b1825838c</uuid> <memory>4194304</memory> <currentMemory>4194304</currentMemory> <vcpu>3</vcpu> <memtune> <min_guarantee>4194304</min_guarantee> </memtune> <devices> <channel type=3D"unix"> <target name=3D"com.redhat.rhevm.vdsm" = type=3D"virtio"/> <source mode=3D"bind" = path=3D"/var/lib/libvirt/qemu/channels/c2aff4cc-0de6-4342-a565-669b1825838= c.com.redhat.rhevm.vdsm"/> </channel> <channel type=3D"unix"> <target name=3D"org.qemu.guest_agent.0" = type=3D"virtio"/> <source mode=3D"bind" = path=3D"/var/lib/libvirt/qemu/channels/c2aff4cc-0de6-4342-a565-669b1825838= c.org.qemu.guest_agent.0"/> </channel> <input bus=3D"ps2" type=3D"mouse"/> <channel type=3D"spicevmc"> <target name=3D"com.redhat.spice.0" = type=3D"virtio"/> </channel> <graphics autoport=3D"yes" keymap=3D"en-us" listen=3D"0" = passwd=3D"*****" passwdValidTo=3D"1970-01-01T00:00:01" port=3D"-1" = tlsPort=3D"-1" type=3D"spice"> <channel mode=3D"secure" name=3D"main"/> <channel mode=3D"secure" name=3D"inputs"/> <channel mode=3D"secure" name=3D"cursor"/> <channel mode=3D"secure" name=3D"playback"/> <channel mode=3D"secure" name=3D"record"/> <channel mode=3D"secure" name=3D"display"/> <channel mode=3D"secure" name=3D"usbredir"/> <channel mode=3D"secure" name=3D"display"/> <channel mode=3D"secure" name=3D"usbredir"/> <channel mode=3D"secure" name=3D"smartcard"/> </graphics> <controller model=3D"virtio-scsi" type=3D"scsi"> <address bus=3D"0x00" domain=3D"0x0000" = function=3D"0x0" slot=3D"0x05" type=3D"pci"/> </controller> <video> <address bus=3D"0x00" domain=3D"0x0000" = function=3D"0x0" slot=3D"0x02" type=3D"pci"/> <model heads=3D"1" type=3D"qxl" vram=3D"32768"/> </video> <interface type=3D"bridge"> <address bus=3D"0x00" domain=3D"0x0000" = function=3D"0x0" slot=3D"0x03" type=3D"pci"/> <mac address=3D"00:1a:4a:5b:9f:02"/> <model type=3D"virtio"/> <source bridge=3D"ovirtmgmt"/> <filterref filter=3D"vdsm-no-mac-spoofing"/> <link state=3D"up"/> </interface> <disk device=3D"cdrom" snapshot=3D"no" type=3D"file"> <address bus=3D"1" controller=3D"0" target=3D"0" = type=3D"drive" unit=3D"0"/> <source file=3D"" startupPolicy=3D"optional"/> <target bus=3D"ide" dev=3D"hdc"/> <readonly/> <serial/> </disk> <disk device=3D"disk" snapshot=3D"no" type=3D"file"> <source = file=3D"/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c= 97a/images/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29= ea36d5fa4a"/> <target bus=3D"scsi" dev=3D"sda"/> = <serial>94a298cb-87a5-48cd-b78f-770582b50639</serial> <boot order=3D"1"/> <driver cache=3D"none" error_policy=3D"stop" = io=3D"threads" name=3D"qemu" type=3D"raw"/> </disk> <disk device=3D"disk" snapshot=3D"no" type=3D"file"> <address bus=3D"0x00" domain=3D"0x0000" = function=3D"0x0" slot=3D"0x07" type=3D"pci"/> <source = file=3D"/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c= 97a/images/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6e= aa2ca4d40d"/> <target bus=3D"virtio" dev=3D"vda"/> = <serial>8df43d38-c4c7-4711-bc87-55f35d1550e5</serial> <driver cache=3D"none" error_policy=3D"stop" = io=3D"threads" name=3D"qemu" type=3D"raw"/> </disk> <disk device=3D"disk" snapshot=3D"no" type=3D"file"> <address bus=3D"0" controller=3D"0" target=3D"0" = type=3D"drive" unit=3D"0"/> <source = file=3D"/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c= 97a/images/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28= f05cf6dea2"/> <target bus=3D"scsi" dev=3D"sdb"/> = <serial>e1886286-3d81-47d0-ae8d-77454e464078</serial> <driver cache=3D"none" error_policy=3D"stop" = io=3D"threads" name=3D"qemu" type=3D"raw"/> </disk> <sound model=3D"ich6"> <address bus=3D"0x00" domain=3D"0x0000" = function=3D"0x0" slot=3D"0x04" type=3D"pci"/> </sound> <memballoon model=3D"virtio"/> </devices> <os> <type arch=3D"x86_64" machine=3D"pc-1.0">hvm</type> <smbios mode=3D"sysinfo"/> </os> <sysinfo type=3D"smbios"> <system> <entry name=3D"manufacturer">oVirt</entry> <entry name=3D"product">oVirt Node</entry> <entry name=3D"version">19-5</entry> <entry = name=3D"serial">2061001F-C600-0006-E1BC-BCAEC518BA45</entry> <entry = name=3D"uuid">c2aff4cc-0de6-4342-a565-669b1825838c</entry> </system> </sysinfo> <clock adjustment=3D"-21600" offset=3D"variable"> <timer name=3D"rtc" tickpolicy=3D"catchup"/> </clock> <features> <acpi/> </features> <cpu match=3D"exact"> <model>Nehalem</model> <topology cores=3D"1" sockets=3D"3" threads=3D"1"/> </cpu> </domain> Thread-32154::DEBUG::2014-01-08 = 11:54:40,218::libvirtconnection::108::libvirtconnection::(wrapper) = Unknown libvirterror: ecode: 1 edom: 10 level: 2 message: internal error = process exited while connecting to monitor: qemu-system-x86_64: -drive = file=3D/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c9= 7a/images/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f= 05cf6dea2,if=3Dnone,id=3Ddrive-scsi0-0-0-0,format=3Draw,serial=3De1886286-= 3d81-47d0-ae8d-77454e464078,cache=3Dnone,werror=3Dstop,rerror=3Dstop,aio=3D= threads: Duplicate ID 'drive-scsi0-0-0-0' for drive Thread-32154::DEBUG::2014-01-08 = 11:54:40,218::vm::2109::vm.Vm::(_startUnderlyingVm) = vmId=3D`c2aff4cc-0de6-4342-a565-669b1825838c`::_ongoingCreations = released Thread-32154::ERROR::2014-01-08 = 11:54:40,218::vm::2135::vm.Vm::(_startUnderlyingVm) = vmId=3D`c2aff4cc-0de6-4342-a565-669b1825838c`::The vm start process = failed Traceback (most recent call last): File "/usr/share/vdsm/vm.py", line 2095, in _startUnderlyingVm self._run() File "/usr/share/vdsm/vm.py", line 3018, in _run self._connection.createXML(domxml, flags), File "/usr/lib64/python2.7/site-packages/vdsm/libvirtconnection.py", = line 76, in wrapper ret =3D f(*args, **kwargs) File "/usr/lib64/python2.7/site-packages/libvirt.py", line 2805, in = createXML if ret is None:raise libvirtError('virDomainCreateXML() failed', = conn=3Dself) libvirtError: internal error process exited while connecting to monitor: = qemu-system-x86_64: -drive = file=3D/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c9= 7a/images/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f= 05cf6dea2,if=3Dnone,id=3Ddrive-scsi0-0-0-0,format=3Draw,serial=3De1886286-= 3d81-47d0-ae8d-77454e464078,cache=3Dnone,werror=3Dstop,rerror=3Dstop,aio=3D= threads: Duplicate ID 'drive-scsi0-0-0-0' for drive Thread-32154::DEBUG::2014-01-08 = 11:54:40,223::vm::2577::vm.Vm::(setDownStatus) = vmId=3D`c2aff4cc-0de6-4342-a565-669b1825838c`::Changed state to Down: = internal error process exited while connecting to monitor: = qemu-system-x86_64: -drive = file=3D/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c9= 7a/images/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f= 05cf6dea2,if=3Dnone,id=3Ddrive-scsi0-0-0-0,format=3Draw,serial=3De1886286-= 3d81-47d0-ae8d-77454e464078,cache=3Dnone,werror=3Dstop,rerror=3Dstop,aio=3D= threads: Duplicate ID 'drive-scsi0-0-0-0' for drive Thread-32158::WARNING::2014-01-08 = 11:54:42,185::clientIF::362::vds::(teardownVolumePath) Drive is not a = vdsm image: VOLWM_CHUNK_MB:1024 VOLWM_CHUNK_REPLICATE_MULT:2 = VOLWM_FREE_PCT:50 _blockDev:False _checkIoTuneCategories:<bound method = Drive._checkIoTuneCategories of <vm.Drive object at 0x7f1150113a90>> = _customize:<bound method Drive._customize of <vm.Drive object at = 0x7f1150113a90>> _deviceXML:<disk device=3D"cdrom" snapshot=3D"no" = type=3D"file"><address bus=3D"1" controller=3D"0" target=3D"0" = type=3D"drive" unit=3D"0"/><source file=3D"" = startupPolicy=3D"optional"/><target bus=3D"ide" = dev=3D"hdc"/><readonly/><serial></serial></disk> _makeName:<bound method = Drive._makeName of <vm.Drive object at 0x7f1150113a90>> = _setExtSharedState:<bound method Drive._setExtSharedState of <vm.Drive = object at 0x7f1150113a90>> _validateIoTuneParams:<bound method = Drive._validateIoTuneParams of <vm.Drive object at 0x7f1150113a90>> = address:{' controller': '0', ' target': '0', 'unit': '0', ' bus': '1', ' = type': 'drive'} apparentsize:0 blockDev:False cache:none conf:{'status': = 'Down', 'acpiEnable': 'true', 'emulatedMachine': 'pc-1.0', 'vmId': = 'c2aff4cc-0de6-4342-a565-669b1825838c', 'pid': '0', 'memGuaranteedSize': = 4096, 'timeOffset': '-21600', 'keyboardLayout': 'en-us', 'displayPort': = '-1', 'displaySecurePort': '-1', 'spiceSslCipherSuite': 'DEFAULT', = 'cpuType': 'Nehalem', 'custom': = {'device_142f948d-f916-4f42-bd28-cb4f0b8ebb40device_615c1466-850e-4362-a4f= b-60df1aaee1e8device_861eb290-19bc-4ace-b2cb-85cbb2e0eb5adevice_94db7fa0-0= 71d-4181-bac6-826ecfca3dd8device_a2e6354f-4ad6-475f-bd18-754fcedf505f': = 'VmDevice {vmId=3Dc2aff4cc-0de6-4342-a565-669b1825838c, = deviceId=3Da2e6354f-4ad6-475f-bd18-754fcedf505f, device=3Dunix, = type=3DCHANNEL, bootOrder=3D0, specParams=3D{}, address=3D{port=3D2, = bus=3D0, controller=3D0, type=3Dvirtio-serial}, managed=3Dfalse, = plugged=3Dtrue, readOnly=3Dfalse, deviceAlias=3Dchannel1, = customProperties=3D{}, snapshotId=3Dnull}', = 'device_142f948d-f916-4f42-bd28-cb4f0b8ebb40': 'VmDevice = {vmId=3Dc2aff4cc-0de6-4342-a565-669b1825838c, = deviceId=3D142f948d-f916-4f42-bd28-cb4f0b8ebb40, device=3Dvirtio-serial, = type=3DCONTROLLER, bootOrder=3D0, specParams=3D{}, address=3D{bus=3D0x00, = domain=3D0x0000, type=3Dpci, slot=3D0x06, function=3D0x0}, = managed=3Dfalse, plugged=3Dtrue, readOnly=3Dfalse, = deviceAlias=3Dvirtio-serial0, customProperties=3D{}, snapshotId=3Dnull}', = 'device_142f948d-f916-4f42-bd28-cb4f0b8ebb40device_615c1466-850e-4362-a4fb= -60df1aaee1e8device_861eb290-19bc-4ace-b2cb-85cbb2e0eb5a': 'VmDevice = {vmId=3Dc2aff4cc-0de6-4342-a565-669b1825838c, = deviceId=3D861eb290-19bc-4ace-b2cb-85cbb2e0eb5a, device=3Dide, = type=3DCONTROLLER, bootOrder=3D0, specParams=3D{}, address=3D{bus=3D0x00, = domain=3D0x0000, type=3Dpci, slot=3D0x01, function=3D0x1}, = managed=3Dfalse, plugged=3Dtrue, readOnly=3Dfalse, deviceAlias=3Dide0, = customProperties=3D{}, snapshotId=3Dnull}', = 'device_142f948d-f916-4f42-bd28-cb4f0b8ebb40device_615c1466-850e-4362-a4fb= -60df1aaee1e8device_861eb290-19bc-4ace-b2cb-85cbb2e0eb5adevice_94db7fa0-07= 1d-4181-bac6-826ecfca3dd8': 'VmDevice = {vmId=3Dc2aff4cc-0de6-4342-a565-669b1825838c, = deviceId=3D94db7fa0-071d-4181-bac6-826ecfca3dd8, device=3Dunix, = type=3DCHANNEL, bootOrder=3D0, specParams=3D{}, address=3D{port=3D1, = bus=3D0, controller=3D0, type=3Dvirtio-serial}, managed=3Dfalse, = plugged=3Dtrue, readOnly=3Dfalse, deviceAlias=3Dchannel0, = customProperties=3D{}, snapshotId=3Dnull}', = 'device_142f948d-f916-4f42-bd28-cb4f0b8ebb40device_615c1466-850e-4362-a4fb= -60df1aaee1e8': 'VmDevice {vmId=3Dc2aff4cc-0de6-4342-a565-669b1825838c, = deviceId=3D615c1466-850e-4362-a4fb-60df1aaee1e8, device=3Dspicevmc, = type=3DCHANNEL, bootOrder=3D0, specParams=3D{}, address=3D{port=3D3, = bus=3D0, controller=3D0, type=3Dvirtio-serial}, managed=3Dfalse, = plugged=3Dtrue, readOnly=3Dfalse, deviceAlias=3Dchannel2, = customProperties=3D{}, snapshotId=3Dnull}'}, 'clientIp': '', 'exitCode': = 1, 'nicModel': 'rtl8139,pv', 'smartcardEnable': 'false', 'kvmEnable': = 'true', 'exitMessage': "internal error process exited while connecting = to monitor: qemu-system-x86_64: -drive = file=3D/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c9= 7a/images/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f= 05cf6dea2,if=3Dnone,id=3Ddrive-scsi0-0-0-0,format=3Draw,serial=3De1886286-= 3d81-47d0-ae8d-77454e464078,cache=3Dnone,werror=3Dstop,rerror=3Dstop,aio=3D= threads: Duplicate ID 'drive-scsi0-0-0-0' for drive\n", = 'transparentHugePages': 'true', 'devices': [{'specParams': {}, = 'deviceId': 'db6166cb-e977-485e-8c82-fa48ca75e709', 'address': {'bus': = '0x00', ' slot': '0x05', ' domain': '0x0000', ' type': 'pci', ' = function': '0x0'}, 'device': 'scsi', 'model': 'virtio-scsi', 'type': = 'controller'}, {'device': 'qxl', 'specParams': {'vram': '32768', = 'heads': '1'}, 'type': 'video', 'deviceId': = '8b0e3dbc-27c6-4eae-ba6b-201c3e1736aa', 'address': {'bus': '0x00', ' = slot': '0x02', ' domain': '0x0000', ' type': 'pci', ' function': = '0x0'}}, {'nicModel': 'pv', 'macAddr': '00:1a:4a:5b:9f:02', = 'linkActive': 'true', 'network': 'ovirtmgmt', 'filter': = 'vdsm-no-mac-spoofing', 'specParams': {}, 'deviceId': = '738c8ebe-b014-4d65-8c78-942aaf12bfb5', 'address': {'bus': '0x00', ' = slot': '0x03', ' domain': '0x0000', ' type': 'pci', ' function': '0x0'}, = 'device': 'bridge', 'type': 'interface'}, {'index': '2', 'iface': 'ide', = 'address': {' controller': '0', ' target': '0', 'unit': '0', ' bus': = '1', ' type': 'drive'}, 'specParams': {'path': ''}, 'readonly': 'true', = 'deviceId': '5611019a-948e-41b3-8ffd-75790ebcdf84', 'path': '', = 'device': 'cdrom', 'shared': 'false', 'type': 'disk'}, {'volumeInfo': = {'domainID': 'f14f471e-0cce-414d-af57-779eeb88c97a', 'volType': 'path', = 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29ea36d5f= a4a', 'volumeID': 'c4864816-7384-4d0e-927e-29ea36d5fa4a', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29ea36d5f= a4a.lease', 'imageID': '94a298cb-87a5-48cd-b78f-770582b50639'}, 'index': = 0, 'iface': 'scsi', 'apparentsize': '162135015424', 'imageID': = '94a298cb-87a5-48cd-b78f-770582b50639', 'readonly': 'false', 'shared': = 'false', 'truesize': '107119386624', 'type': 'disk', 'domainID': = 'f14f471e-0cce-414d-af57-779eeb88c97a', 'reqsize': '0', 'format': 'raw', = 'deviceId': '94a298cb-87a5-48cd-b78f-770582b50639', 'poolID': = '18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', 'device': 'disk', 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29ea36d5f= a4a', 'propagateErrors': 'off', 'optional': 'false', 'bootOrder': '1', = 'volumeID': 'c4864816-7384-4d0e-927e-29ea36d5fa4a', 'specParams': {}, = 'volumeChain': [{'domainID': 'f14f471e-0cce-414d-af57-779eeb88c97a', = 'volType': 'path', 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29ea36d5f= a4a', 'volumeID': 'c4864816-7384-4d0e-927e-29ea36d5fa4a', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29ea36d5f= a4a.lease', 'imageID': '94a298cb-87a5-48cd-b78f-770582b50639'}]}, = {'address': {'bus': '0x00', ' slot': '0x07', ' domain': '0x0000', ' = type': 'pci', ' function': '0x0'}, 'volumeInfo': {'domainID': = 'f14f471e-0cce-414d-af57-779eeb88c97a', 'volType': 'path', = 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6eaa2ca4d= 40d', 'volumeID': '42786233-04c0-4a9f-b731-6eaa2ca4d40d', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6eaa2ca4d= 40d.lease', 'imageID': '8df43d38-c4c7-4711-bc87-55f35d1550e5'}, 'index': = '0', 'iface': 'virtio', 'apparentsize': '1073741824', 'imageID': = '8df43d38-c4c7-4711-bc87-55f35d1550e5', 'readonly': 'false', 'shared': = 'false', 'truesize': '0', 'type': 'disk', 'domainID': = 'f14f471e-0cce-414d-af57-779eeb88c97a', 'reqsize': '0', 'format': 'raw', = 'deviceId': '8df43d38-c4c7-4711-bc87-55f35d1550e5', 'poolID': = '18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', 'device': 'disk', 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6eaa2ca4d= 40d', 'propagateErrors': 'off', 'optional': 'false', 'volumeID': = '42786233-04c0-4a9f-b731-6eaa2ca4d40d', 'specParams': {}, 'volumeChain': = [{'domainID': 'f14f471e-0cce-414d-af57-779eeb88c97a', 'volType': 'path', = 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6eaa2ca4d= 40d', 'volumeID': '42786233-04c0-4a9f-b731-6eaa2ca4d40d', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6eaa2ca4d= 40d.lease', 'imageID': '8df43d38-c4c7-4711-bc87-55f35d1550e5'}]}, = {'address': {' controller': '0', ' target': '0', 'unit': '0', ' bus': = '0', ' type': 'drive'}, 'volumeInfo': {'domainID': = 'f14f471e-0cce-414d-af57-779eeb88c97a', 'volType': 'path', = 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6d= ea2', 'volumeID': '1ef64ebd-6415-43d1-a34f-28f05cf6dea2', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6d= ea2.lease', 'imageID': 'e1886286-3d81-47d0-ae8d-77454e464078'}, 'index': = '1', 'iface': 'scsi', 'apparentsize': '1073741824', 'imageID': = 'e1886286-3d81-47d0-ae8d-77454e464078', 'readonly': 'false', 'shared': = 'false', 'truesize': '0', 'type': 'disk', 'domainID': = 'f14f471e-0cce-414d-af57-779eeb88c97a', 'reqsize': '0', 'format': 'raw', = 'deviceId': 'e1886286-3d81-47d0-ae8d-77454e464078', 'poolID': = '18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', 'device': 'disk', 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6d= ea2', 'propagateErrors': 'off', 'optional': 'false', 'volumeID': = '1ef64ebd-6415-43d1-a34f-28f05cf6dea2', 'specParams': {}, 'volumeChain': = [{'domainID': 'f14f471e-0cce-414d-af57-779eeb88c97a', 'volType': 'path', = 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6d= ea2', 'volumeID': '1ef64ebd-6415-43d1-a34f-28f05cf6dea2', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6d= ea2.lease', 'imageID': 'e1886286-3d81-47d0-ae8d-77454e464078'}]}, = {'device': 'ich6', 'specParams': {}, 'type': 'sound', 'deviceId': = 'a1e596e9-218f-46ba-9f32-b9c966e11d73', 'address': {'bus': '0x00', ' = slot': '0x04', ' domain': '0x0000', ' type': 'pci', ' function': = '0x0'}}, {'device': 'memballoon', 'specParams': {'model': 'virtio'}, = 'type': 'balloon', 'deviceId': '5c04fd7e-7249-4e3a-b8eb-91cce72d5b60', = 'target': 4194304}], 'smp': '3', 'vmType': 'kvm', 'memSize': 4096, = 'displayIp': '0', 'spiceSecureChannels': = 'smain,sinputs,scursor,splayback,srecord,sdisplay,susbredir,ssmartcard', = 'smpCoresPerSocket': '1', 'vmName': 'cobra', 'display': 'qxl', 'nice': = '0'} createXmlElem:<bound method Drive.createXmlElem of <vm.Drive object = at 0x7f1150113a90>> device:cdrom = deviceId:5611019a-948e-41b3-8ffd-75790ebcdf84 extSharedState:none = getLeasesXML:<bound method Drive.getLeasesXML of <vm.Drive object at = 0x7f1150113a90>> getNextVolumeSize:<bound method Drive.getNextVolumeSize = of <vm.Drive object at 0x7f1150113a90>> getXML:<bound method = Drive.getXML of <vm.Drive object at 0x7f1150113a90>> = hasVolumeLeases:False iface:ide index:2 = isDiskReplicationInProgress:<bound method = Drive.isDiskReplicationInProgress of <vm.Drive object at = 0x7f1150113a90>> isVdsmImage:<bound method Drive.isVdsmImage of = <vm.Drive object at 0x7f1150113a90>> log:<logUtils.SimpleLogAdapter = object at 0x7f111838af90> name:hdc networkDev:False path: readonly:true = reqsize:0 serial: shared:false specParams:{'path': ''} truesize:0 = type:disk volExtensionChunk:1024 watermarkLimit:536870912 Traceback (most recent call last): File "/usr/share/vdsm/clientIF.py", line 356, in teardownVolumePath res =3D self.irs.teardownImage(drive['domainID'], File "/usr/share/vdsm/vm.py", line 1389, in __getitem__ raise KeyError(key) KeyError: 'domainID' Thread-32158::DEBUG::2014-01-08 = 11:54:42,186::task::579::TaskManager.Task::(_updateState) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::moving from state init -> = state preparing Thread-32158::INFO::2014-01-08 = 11:54:42,187::logUtils::44::dispatcher::(wrapper) Run and protect: = teardownImage(sdUUID=3D'f14f471e-0cce-414d-af57-779eeb88c97a', = spUUID=3D'18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', = imgUUID=3D'94a298cb-87a5-48cd-b78f-770582b50639', volUUID=3DNone) Thread-32158::DEBUG::2014-01-08 = 11:54:42,187::resourceManager::197::ResourceManager.Request::(__init__) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`533f2699-= 0684-4247-9d5f-a858ffe96fe9`::Request was made in = '/usr/share/vdsm/storage/hsm.py' line '3283' at 'teardownImage' Thread-32158::DEBUG::2014-01-08 = 11:54:42,187::resourceManager::541::ResourceManager::(registerResource) = Trying to register resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' for lock type 'shared' Thread-32158::DEBUG::2014-01-08 = 11:54:42,187::resourceManager::600::ResourceManager::(registerResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free. Now = locking as 'shared' (1 active user) Thread-32158::DEBUG::2014-01-08 = 11:54:42,187::resourceManager::237::ResourceManager.Request::(grant) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`533f2699-= 0684-4247-9d5f-a858ffe96fe9`::Granted request Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::task::811::TaskManager.Task::(resourceAcquired) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::_resourcesAcquired: = Storage.f14f471e-0cce-414d-af57-779eeb88c97a (shared) Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::task::974::TaskManager.Task::(_decref) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::ref 1 aborting False Thread-32158::INFO::2014-01-08 = 11:54:42,188::logUtils::47::dispatcher::(wrapper) Run and protect: = teardownImage, Return response: None Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::task::1168::TaskManager.Task::(prepare) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::finished: None Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::task::579::TaskManager.Task::(_updateState) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::moving from state = preparing -> state finished Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::resourceManager::939::ResourceManager.Owner::(releaseAll) = Owner.releaseAll requests {} resources = {'Storage.f14f471e-0cce-414d-af57-779eeb88c97a': < ResourceRef = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a', isValid: 'True' obj: = 'None'>} Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::resourceManager::976::ResourceManager.Owner::(cancelAll) = Owner.cancelAll requests {} Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::resourceManager::615::ResourceManager::(releaseResource) = Trying to release resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::resourceManager::634::ResourceManager::(releaseResource) = Released resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' (0 = active users) Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::resourceManager::640::ResourceManager::(releaseResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free, finding = out if anyone is waiting for it. Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::resourceManager::648::ResourceManager::(releaseResource) = No one is waiting for resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a', Clearing records. Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::task::974::TaskManager.Task::(_decref) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::ref 0 aborting False Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::task::579::TaskManager.Task::(_updateState) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::moving from state init -> = state preparing Thread-32158::INFO::2014-01-08 = 11:54:42,190::logUtils::44::dispatcher::(wrapper) Run and protect: = teardownImage(sdUUID=3D'f14f471e-0cce-414d-af57-779eeb88c97a', = spUUID=3D'18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', = imgUUID=3D'8df43d38-c4c7-4711-bc87-55f35d1550e5', volUUID=3DNone) Thread-32158::DEBUG::2014-01-08 = 11:54:42,190::resourceManager::197::ResourceManager.Request::(__init__) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`0907e117-= ba60-4c9f-a190-ebb7e027b4c2`::Request was made in = '/usr/share/vdsm/storage/hsm.py' line '3283' at 'teardownImage' Thread-32158::DEBUG::2014-01-08 = 11:54:42,190::resourceManager::541::ResourceManager::(registerResource) = Trying to register resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' for lock type 'shared' Thread-32158::DEBUG::2014-01-08 = 11:54:42,190::resourceManager::600::ResourceManager::(registerResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free. Now = locking as 'shared' (1 active user) Thread-32158::DEBUG::2014-01-08 = 11:54:42,190::resourceManager::237::ResourceManager.Request::(grant) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`0907e117-= ba60-4c9f-a190-ebb7e027b4c2`::Granted request Thread-32158::DEBUG::2014-01-08 = 11:54:42,190::task::811::TaskManager.Task::(resourceAcquired) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::_resourcesAcquired: = Storage.f14f471e-0cce-414d-af57-779eeb88c97a (shared) Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::task::974::TaskManager.Task::(_decref) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::ref 1 aborting False Thread-32158::INFO::2014-01-08 = 11:54:42,191::logUtils::47::dispatcher::(wrapper) Run and protect: = teardownImage, Return response: None Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::task::1168::TaskManager.Task::(prepare) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::finished: None Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::task::579::TaskManager.Task::(_updateState) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::moving from state = preparing -> state finished Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::resourceManager::939::ResourceManager.Owner::(releaseAll) = Owner.releaseAll requests {} resources = {'Storage.f14f471e-0cce-414d-af57-779eeb88c97a': < ResourceRef = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a', isValid: 'True' obj: = 'None'>} Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::resourceManager::976::ResourceManager.Owner::(cancelAll) = Owner.cancelAll requests {} Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::resourceManager::615::ResourceManager::(releaseResource) = Trying to release resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' Thread-32158::DEBUG::2014-01-08 = 11:54:42,192::resourceManager::634::ResourceManager::(releaseResource) = Released resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' (0 = active users) Thread-32158::DEBUG::2014-01-08 = 11:54:42,192::resourceManager::640::ResourceManager::(releaseResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free, finding = out if anyone is waiting for it. Thread-32158::DEBUG::2014-01-08 = 11:54:42,192::resourceManager::648::ResourceManager::(releaseResource) = No one is waiting for resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a', Clearing records. Thread-32158::DEBUG::2014-01-08 = 11:54:42,192::task::974::TaskManager.Task::(_decref) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::ref 0 aborting False Thread-32158::DEBUG::2014-01-08 = 11:54:42,192::task::579::TaskManager.Task::(_updateState) = Task=3D`75d1051f-b118-4af8-b9f1-504fcd1802c2`::moving from state init -> = state preparing Thread-32158::INFO::2014-01-08 = 11:54:42,192::logUtils::44::dispatcher::(wrapper) Run and protect: = teardownImage(sdUUID=3D'f14f471e-0cce-414d-af57-779eeb88c97a', = spUUID=3D'18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', = imgUUID=3D'e1886286-3d81-47d0-ae8d-77454e464078', volUUID=3DNone) Thread-32158::DEBUG::2014-01-08 = 11:54:42,193::resourceManager::197::ResourceManager.Request::(__init__) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`8908ad39-= 2555-4ef5-a6ae-49e8504de015`::Request was made in = '/usr/share/vdsm/storage/hsm.py' line '3283' at 'teardownImage' Thread-32158::DEBUG::2014-01-08 = 11:54:42,193::resourceManager::541::ResourceManager::(registerResource) = Trying to register resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' for lock type 'shared' Thread-32158::DEBUG::2014-01-08 = 11:54:42,196::resourceManager::600::ResourceManager::(registerResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free. Now = locking as 'shared' (1 active user) Thread-32158::DEBUG::2014-01-08 = 11:54:42,196::resourceManager::237::ResourceManager.Request::(grant) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`8908ad39-= 2555-4ef5-a6ae-49e8504de015`::Granted request Thread-32158::DEBUG::2014-01-08 = 11:54:42,196::task::811::TaskManager.Task::(resourceAcquired) = Task=3D`75d1051f-b118-4af8-b9f1-504fcd1802c2`::_resourcesAcquired: = Storage.f14f471e-0cce-414d-af57-779eeb88c97a (shared) Thread-32158::DEBUG::2014-01-08 = 11:54:42,196::task::974::TaskManager.Task::(_decref) = Task=3D`75d1051f-b118-4af8-b9f1-504fcd1802c2`::ref 1 aborting False Thread-32158::INFO::2014-01-08 = 11:54:42,196::logUtils::47::dispatcher::(wrapper) Run and protect: = teardownImage, Return response: None Thread-32158::DEBUG::2014-01-08 = 11:54:42,196::task::1168::TaskManager.Task::(prepare) = Task=3D`75d1051f-b118-4af8-b9f1-504fcd1802c2`::finished: None Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::task::579::TaskManager.Task::(_updateState) = Task=3D`75d1051f-b118-4af8-b9f1-504fcd1802c2`::moving from state = preparing -> state finished Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::resourceManager::939::ResourceManager.Owner::(releaseAll) = Owner.releaseAll requests {} resources = {'Storage.f14f471e-0cce-414d-af57-779eeb88c97a': < ResourceRef = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a', isValid: 'True' obj: = 'None'>} Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::resourceManager::976::ResourceManager.Owner::(cancelAll) = Owner.cancelAll requests {} Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::resourceManager::615::ResourceManager::(releaseResource) = Trying to release resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::resourceManager::634::ResourceManager::(releaseResource) = Released resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' (0 = active users) Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::resourceManager::640::ResourceManager::(releaseResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free, finding = out if anyone is waiting for it. --Apple-Mail=_877DC8BA-BA64-4899-AC8F-C9588B685A8B Content-Transfer-Encoding: quoted-printable Content-Type: text/html; charset=windows-1252 <html><head><meta http-equiv=3D"Content-Type" content=3D"text/html = charset=3Dwindows-1252"></head><body style=3D"word-wrap: break-word; = -webkit-nbsp-mode: space; -webkit-line-break: after-white-space;">So = twice now under oVirt 3.3.2 I have added 2 virtio-scsi devices to a = single virtual host. <div><br></div><div>After doing so, the VM = would fail to boot due to duplicate disk ID. The first time I = thought it a fluke, second time=92s a = bug?</div><div><br></div><div>Fortunately they were empty data disks and = I was able to get around the problem by deleting one and recreating = it.</div><div><br></div><div>VDSM log:</div><div><br></div><div><div = style=3D"margin: 0px; font-size: 11px; font-family: = Menlo;">Thread-32154::INFO::2014-01-08 = 11:54:39,717::clientIF::350::vds::(prepareVolumePath) prepared volume = path: = /rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/imag= es/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6de= a2</div><div style=3D"margin: 0px; font-size: 11px; font-family: = Menlo;">Thread-32154::DEBUG::2014-01-08 = 11:54:39,740::vm::2984::vm.Vm::(_run) = vmId=3D`c2aff4cc-0de6-4342-a565-669b1825838c`::<?xml version=3D"1.0" = encoding=3D"utf-8"?></div><div style=3D"margin: 0px; font-size: 11px; = font-family: Menlo;"><domain type=3D"kvm"></div><div = style=3D"margin: 0px; font-size: 11px; font-family: Menlo;"> = <name>cobra</name></div><div = style=3D"margin: 0px; font-size: 11px; font-family: Menlo;"> = = <uuid>c2aff4cc-0de6-4342-a565-669b1825838c</uuid></div><div = style=3D"margin: 0px; font-size: 11px; font-family: Menlo;"> = <memory>4194304</memory></div><div = style=3D"margin: 0px; font-size: 11px; font-family: Menlo;"> = = <currentMemory>4194304</currentMemory></div><div = style=3D"margin: 0px; font-size: 11px; font-family: Menlo;"> = <vcpu>3</vcpu></div><div style=3D"margin:= 0px; font-size: 11px; font-family: Menlo;"> = <memtune></div><div style=3D"margin: 0px; font-size: 11px; = font-family: Menlo;"> = <min_guarantee>4194304</min_guarantee></div><div = style=3D"margin: 0px; font-size: 11px; font-family: Menlo;"> = </memtune></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <devices></div><div style=3D"margin: 0px; font-size: 11px; = font-family: Menlo;"> = <channel type=3D"unix"></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <target = name=3D"com.redhat.rhevm.vdsm" type=3D"virtio"/></div><div = style=3D"margin: 0px; font-size: 11px; font-family: Menlo;"> = = <source mode=3D"bind" = path=3D"/var/lib/libvirt/qemu/channels/c2aff4cc-0de6-4342-a565-669b1825838= c.com.redhat.rhevm.vdsm"/></div><div style=3D"margin: 0px; font-size: = 11px; font-family: Menlo;"> = </channel></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <channel type=3D"unix"></div><div = style=3D"margin: 0px; font-size: 11px; font-family: Menlo;"> = = <target name=3D"org.qemu.guest_agent.0" = type=3D"virtio"/></div><div style=3D"margin: 0px; font-size: 11px; = font-family: Menlo;"> = <source mode=3D"bind" = path=3D"/var/lib/libvirt/qemu/channels/c2aff4cc-0de6-4342-a565-669b1825838= c.org.qemu.guest_agent.0"/></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = </channel></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <input bus=3D"ps2" type=3D"mouse"/></div><div = style=3D"margin: 0px; font-size: 11px; font-family: Menlo;"> = <channel = type=3D"spicevmc"></div><div style=3D"margin: 0px; font-size: 11px; = font-family: Menlo;"> = <target name=3D"com.redhat.spice.0" = type=3D"virtio"/></div><div style=3D"margin: 0px; font-size: 11px; = font-family: Menlo;"> = </channel></div><div style=3D"margin: 0px; font-size: 11px; = font-family: Menlo;"> = <graphics autoport=3D"yes" keymap=3D"en-us" listen=3D"0" = passwd=3D"*****" passwdValidTo=3D"1970-01-01T00:00:01" port=3D"-1" = tlsPort=3D"-1" type=3D"spice"></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <channel = mode=3D"secure" name=3D"main"/></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <channel = mode=3D"secure" name=3D"inputs"/></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <channel = mode=3D"secure" name=3D"cursor"/></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <channel = mode=3D"secure" name=3D"playback"/></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <channel = mode=3D"secure" name=3D"record"/></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <channel = mode=3D"secure" name=3D"display"/></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo;"> = <channel = mode=3D"secure" name=3D"usbredir"/></div><div style=3D"margin: 0px; = font-size: 11px; font-family: Menlo; min-height: = 13px;"><br></div></div><div style=3D"margin: 0px; font-size: 11px; = font-family: Menlo; min-height: 13px;"><div style=3D"margin: = 0px;"> = <channel mode=3D"secure" = name=3D"display"/></div><div style=3D"margin: 0px;"> = = <channel mode=3D"secure" name=3D"usbredir"/></div><div = style=3D"margin: 0px;"> = <channel mode=3D"secure" = name=3D"smartcard"/></div><div style=3D"margin: 0px;"> = </graphics></div><div = style=3D"margin: 0px;"> = <controller model=3D"virtio-scsi" type=3D"scsi"></div><div = style=3D"margin: 0px;"> = <address bus=3D"0x00" = domain=3D"0x0000" function=3D"0x0" slot=3D"0x05" = type=3D"pci"/></div><div style=3D"margin: 0px;"> = </controller></div><div = style=3D"margin: 0px;"> = <video></div><div style=3D"margin: 0px;"> = = <address bus=3D"0x00" domain=3D"0x0000" function=3D"0x0" slot=3D"0x02" = type=3D"pci"/></div><div style=3D"margin: 0px;"> = <model = heads=3D"1" type=3D"qxl" vram=3D"32768"/></div><div style=3D"margin: = 0px;"> = </video></div><div style=3D"margin: 0px;"> = <interface = type=3D"bridge"></div><div style=3D"margin: 0px;"> = = <address bus=3D"0x00" domain=3D"0x0000" function=3D"0x0" slot=3D"0x03" = type=3D"pci"/></div><div style=3D"margin: 0px;"> = <mac = address=3D"00:1a:4a:5b:9f:02"/></div><div style=3D"margin: = 0px;"> = <model type=3D"virtio"/></div><div = style=3D"margin: 0px;"> = <source = bridge=3D"ovirtmgmt"/></div><div style=3D"margin: 0px;"> = = <filterref filter=3D"vdsm-no-mac-spoofing"/></div><div = style=3D"margin: 0px;"> = <link state=3D"up"/></div><div = style=3D"margin: 0px;"> = </interface></div><div style=3D"margin: 0px;"> = <disk device=3D"cdrom" = snapshot=3D"no" type=3D"file"></div><div style=3D"margin: = 0px;"> = <address bus=3D"1" controller=3D"0" target=3D"0" = type=3D"drive" unit=3D"0"/></div><div style=3D"margin: 0px;"> = = <source file=3D"" startupPolicy=3D"optional"/></div><div = style=3D"margin: 0px;"> = <target bus=3D"ide" = dev=3D"hdc"/></div><div style=3D"margin: 0px;"> = = <readonly/></div><div style=3D"margin: 0px;"> = = <serial/></div><div style=3D"margin: 0px;"> = </disk></div><div = style=3D"margin: 0px;"> = <disk device=3D"disk" snapshot=3D"no" = type=3D"file"></div><div style=3D"margin: 0px;"> = = <source = file=3D"/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c= 97a/images/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29= ea36d5fa4a"/></div><div style=3D"margin: 0px;"> = = <target bus=3D"scsi" dev=3D"sda"/></div><div style=3D"margin: = 0px;"> = = <serial>94a298cb-87a5-48cd-b78f-770582b50639</serial></div><di= v style=3D"margin: 0px;"> = <boot = order=3D"1"/></div><div style=3D"margin: 0px;"> = = <driver cache=3D"none" error_policy=3D"stop" io=3D"threads" = name=3D"qemu" type=3D"raw"/></div><div style=3D"margin: 0px;"> = </disk></div><div = style=3D"margin: 0px;"> = <disk device=3D"disk" snapshot=3D"no" = type=3D"file"></div><div style=3D"margin: 0px;"> = = <address bus=3D"0x00" domain=3D"0x0000" function=3D"0x0" slot=3D"0x07" = type=3D"pci"/></div><div style=3D"margin: 0px;"> = = <source = file=3D"/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c= 97a/images/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6e= aa2ca4d40d"/></div><div style=3D"margin: 0px;"> = = <target bus=3D"virtio" dev=3D"vda"/></div><div style=3D"margin: = 0px;"> = = <serial>8df43d38-c4c7-4711-bc87-55f35d1550e5</serial></div><di= v style=3D"margin: 0px;"> = <driver cache=3D"none" = error_policy=3D"stop" io=3D"threads" name=3D"qemu" = type=3D"raw"/></div><div style=3D"margin: 0px;"> = </disk></div><div = style=3D"margin: 0px;"> = <disk device=3D"disk" snapshot=3D"no" = type=3D"file"></div><div><br></div><div><div style=3D"margin: = 0px;"> = <address bus=3D"0" controller=3D"0" = target=3D"0" type=3D"drive" unit=3D"0"/></div><div style=3D"margin: = 0px;"> = <source = file=3D"/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c= 97a/images/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28= f05cf6dea2"/></div><div style=3D"margin: 0px;"> = = <target bus=3D"scsi" dev=3D"sdb"/></div><div style=3D"margin: = 0px;"> = = <serial>e1886286-3d81-47d0-ae8d-77454e464078</serial></div><di= v style=3D"margin: 0px;"> = <driver cache=3D"none" = error_policy=3D"stop" io=3D"threads" name=3D"qemu" = type=3D"raw"/></div><div style=3D"margin: 0px;"> = </disk></div><div = style=3D"margin: 0px;"> = <sound model=3D"ich6"></div><div style=3D"margin: = 0px;"> = <address bus=3D"0x00" domain=3D"0x0000" = function=3D"0x0" slot=3D"0x04" type=3D"pci"/></div><div = style=3D"margin: 0px;"> = </sound></div><div style=3D"margin: 0px;"> = <memballoon = model=3D"virtio"/></div><div style=3D"margin: 0px;"> = </devices></div><div style=3D"margin: 0px;"> = <os></div><div style=3D"margin: 0px;"> = <type arch=3D"x86_64" = machine=3D"pc-1.0">hvm</type></div><div style=3D"margin: = 0px;"> <smbios = mode=3D"sysinfo"/></div><div style=3D"margin: 0px;"> = </os></div><div style=3D"margin: 0px;"> = <sysinfo type=3D"smbios"></div><div style=3D"margin: = 0px;"> = <system></div><div style=3D"margin: 0px;"> = <entry = name=3D"manufacturer">oVirt</entry></div><div style=3D"margin: = 0px;"> = <entry name=3D"product">oVirt = Node</entry></div><div style=3D"margin: 0px;"> = <entry = name=3D"version">19-5</entry></div><div style=3D"margin: = 0px;"> = <entry = name=3D"serial">2061001F-C600-0006-E1BC-BCAEC518BA45</entry></div= div style=3D"margin: 0px;"> = </system></div><div style=3D"margin: 0px;"> = </sysinfo></div><div style=3D"margin: = 0px;"> <clock adjustment=3D"-21600" = offset=3D"variable"></div><div style=3D"margin: 0px;"> = <timer name=3D"rtc" = tickpolicy=3D"catchup"/></div><div style=3D"margin: 0px;"> = </clock></div><div style=3D"margin: = 0px;"> <features></div><div = style=3D"margin: 0px;"> = <acpi/></div><div style=3D"margin: 0px;"> = </features></div><div style=3D"margin: 0px;"> = <cpu match=3D"exact"></div><div = style=3D"margin: 0px;"> = <model>Nehalem</model></div><div style=3D"margin: = 0px;"> = <topology cores=3D"1" sockets=3D"3" threads=3D"1"/></div><div = style=3D"margin: 0px;"> = </cpu></div><div style=3D"margin: = 0px;"></domain></div></div><div style=3D"margin: 0px;"><div = style=3D"margin: 0px;">Thread-32154::DEBUG::2014-01-08 = 11:54:40,218::libvirtconnection::108::libvirtconnection::(wrapper) = Unknown libvirterror: ecode: 1 edom: 10 level: 2 message: internal error = process exited while connecting to monitor: qemu-system-x86_64: -drive = file=3D/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c9= 7a/images/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f= 05cf6dea2,if=3Dnone,id=3Ddrive-scsi0-0-0-0,format=3Draw,serial=3De1886286-= 3d81-47d0-ae8d-77454e464078,cache=3Dnone,werror=3Dstop,rerror=3Dstop,aio=3D= threads: Duplicate ID 'drive-scsi0-0-0-0' for drive</div><div = style=3D"margin: 0px; min-height: 13px;"><br></div><div style=3D"margin: = 0px;">Thread-32154::DEBUG::2014-01-08 = 11:54:40,218::vm::2109::vm.Vm::(_startUnderlyingVm) = vmId=3D`c2aff4cc-0de6-4342-a565-669b1825838c`::_ongoingCreations = released</div><div style=3D"margin: = 0px;">Thread-32154::ERROR::2014-01-08 = 11:54:40,218::vm::2135::vm.Vm::(_startUnderlyingVm) = vmId=3D`c2aff4cc-0de6-4342-a565-669b1825838c`::The vm start process = failed</div><div style=3D"margin: 0px;">Traceback (most recent call = last):</div><div style=3D"margin: 0px;"> File = "/usr/share/vdsm/vm.py", line 2095, in _startUnderlyingVm</div><div = style=3D"margin: 0px;"> self._run()</div><div = style=3D"margin: 0px;"> File "/usr/share/vdsm/vm.py", line 3018, = in _run</div><div style=3D"margin: 0px;"> = self._connection.createXML(domxml, flags),</div><div style=3D"margin: = 0px;"> File = "/usr/lib64/python2.7/site-packages/vdsm/libvirtconnection.py", line 76, = in wrapper</div><div style=3D"margin: 0px;"> ret =3D = f(*args, **kwargs)</div><div style=3D"margin: 0px;"> File = "/usr/lib64/python2.7/site-packages/libvirt.py", line 2805, in = createXML</div><div style=3D"margin: 0px;"> if ret is = None:raise libvirtError('virDomainCreateXML() failed', = conn=3Dself)</div><div style=3D"margin: 0px;">libvirtError: internal = error process exited while connecting to monitor: qemu-system-x86_64: = -drive = file=3D/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c9= 7a/images/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f= 05cf6dea2,if=3Dnone,id=3Ddrive-scsi0-0-0-0,format=3Draw,serial=3De1886286-= 3d81-47d0-ae8d-77454e464078,cache=3Dnone,werror=3Dstop,rerror=3Dstop,aio=3D= threads: Duplicate ID 'drive-scsi0-0-0-0' for drive</div><div = style=3D"margin: 0px; min-height: 13px;"><br></div><div style=3D"margin: = 0px;">Thread-32154::DEBUG::2014-01-08 = 11:54:40,223::vm::2577::vm.Vm::(setDownStatus) = vmId=3D`c2aff4cc-0de6-4342-a565-669b1825838c`::Changed state to Down: = internal error process exited while connecting to monitor: = qemu-system-x86_64: -drive = file=3D/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c9= 7a/images/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f= 05cf6dea2,if=3Dnone,id=3Ddrive-scsi0-0-0-0,format=3Draw,serial=3De1886286-= 3d81-47d0-ae8d-77454e464078,cache=3Dnone,werror=3Dstop,rerror=3Dstop,aio=3D= threads: Duplicate ID 'drive-scsi0-0-0-0' for drive</div><div = style=3D"margin: 0px; min-height: 13px;"><br></div><div style=3D"margin: = 0px;"><div style=3D"margin: 0px;">Thread-32158::WARNING::2014-01-08 = 11:54:42,185::clientIF::362::vds::(teardownVolumePath) Drive is not a = vdsm image: VOLWM_CHUNK_MB:1024 VOLWM_CHUNK_REPLICATE_MULT:2 = VOLWM_FREE_PCT:50 _blockDev:False _checkIoTuneCategories:<bound = method Drive._checkIoTuneCategories of <vm.Drive object at = 0x7f1150113a90>> _customize:<bound method Drive._customize of = <vm.Drive object at 0x7f1150113a90>> _deviceXML:<disk = device=3D"cdrom" snapshot=3D"no" type=3D"file"><address = bus=3D"1" controller=3D"0" target=3D"0" type=3D"drive" = unit=3D"0"/><source file=3D"" = startupPolicy=3D"optional"/><target bus=3D"ide" = dev=3D"hdc"/><readonly/><serial></serial></disk>= ; _makeName:<bound method Drive._makeName of <vm.Drive object at = 0x7f1150113a90>> _setExtSharedState:<bound method = Drive._setExtSharedState of <vm.Drive object at = 0x7f1150113a90>> _validateIoTuneParams:<bound method = Drive._validateIoTuneParams of <vm.Drive object at = 0x7f1150113a90>> address:{' controller': '0', ' target': '0', = 'unit': '0', ' bus': '1', ' type': 'drive'} apparentsize:0 = blockDev:False cache:none conf:{'status': 'Down', 'acpiEnable': 'true', = 'emulatedMachine': 'pc-1.0', 'vmId': = 'c2aff4cc-0de6-4342-a565-669b1825838c', 'pid': '0', 'memGuaranteedSize': = 4096, 'timeOffset': '-21600', 'keyboardLayout': 'en-us', 'displayPort': = '-1', 'displaySecurePort': '-1', 'spiceSslCipherSuite': 'DEFAULT', = 'cpuType': 'Nehalem', 'custom': = {'device_142f948d-f916-4f42-bd28-cb4f0b8ebb40device_615c1466-850e-4362-a4f= b-60df1aaee1e8device_861eb290-19bc-4ace-b2cb-85cbb2e0eb5adevice_94db7fa0-0= 71d-4181-bac6-826ecfca3dd8device_a2e6354f-4ad6-475f-bd18-754fcedf505f': = 'VmDevice {vmId=3Dc2aff4cc-0de6-4342-a565-669b1825838c, = deviceId=3Da2e6354f-4ad6-475f-bd18-754fcedf505f, device=3Dunix, = type=3DCHANNEL, bootOrder=3D0, specParams=3D{}, address=3D{port=3D2, = bus=3D0, controller=3D0, type=3Dvirtio-serial}, managed=3Dfalse, = plugged=3Dtrue, readOnly=3Dfalse, deviceAlias=3Dchannel1, = customProperties=3D{}, snapshotId=3Dnull}', = 'device_142f948d-f916-4f42-bd28-cb4f0b8ebb40': 'VmDevice = {vmId=3Dc2aff4cc-0de6-4342-a565-669b1825838c, = deviceId=3D142f948d-f916-4f42-bd28-cb4f0b8ebb40, device=3Dvirtio-serial, = type=3DCONTROLLER, bootOrder=3D0, specParams=3D{}, address=3D{bus=3D0x00, = domain=3D0x0000, type=3Dpci, slot=3D0x06, function=3D0x0}, = managed=3Dfalse, plugged=3Dtrue, readOnly=3Dfalse, = deviceAlias=3Dvirtio-serial0, customProperties=3D{}, snapshotId=3Dnull}', = 'device_142f948d-f916-4f42-bd28-cb4f0b8ebb40device_615c1466-850e-4362-a4fb= -60df1aaee1e8device_861eb290-19bc-4ace-b2cb-85cbb2e0eb5a': 'VmDevice = {vmId=3Dc2aff4cc-0de6-4342-a565-669b1825838c, = deviceId=3D861eb290-19bc-4ace-b2cb-85cbb2e0eb5a, device=3Dide, = type=3DCONTROLLER, bootOrder=3D0, specParams=3D{}, address=3D{bus=3D0x00, = domain=3D0x0000, type=3Dpci, slot=3D0x01, function=3D0x1}, = managed=3Dfalse, plugged=3Dtrue, readOnly=3Dfalse, deviceAlias=3Dide0, = customProperties=3D{}, snapshotId=3Dnull}', = 'device_142f948d-f916-4f42-bd28-cb4f0b8ebb40device_615c1466-850e-4362-a4fb= -60df1aaee1e8device_861eb290-19bc-4ace-b2cb-85cbb2e0eb5adevice_94db7fa0-07= 1d-4181-bac6-826ecfca3dd8': 'VmDevice = {vmId=3Dc2aff4cc-0de6-4342-a565-669b1825838c, = deviceId=3D94db7fa0-071d-4181-bac6-826ecfca3dd8, device=3Dunix, = type=3DCHANNEL, bootOrder=3D0, specParams=3D{}, address=3D{port=3D1, = bus=3D0, controller=3D0, type=3Dvirtio-serial}, managed=3Dfalse, = plugged=3Dtrue, readOnly=3Dfalse, deviceAlias=3Dchannel0, = customProperties=3D{}, snapshotId=3Dnull}', = 'device_142f948d-f916-4f42-bd28-cb4f0b8ebb40device_615c1466-850e-4362-a4fb= -60df1aaee1e8': 'VmDevice {vmId=3Dc2aff4cc-0de6-4342-a565-669b1825838c, = deviceId=3D615c1466-850e-4362-a4fb-60df1aaee1e8, device=3Dspicevmc, = type=3DCHANNEL, bootOrder=3D0, specParams=3D{}, address=3D{port=3D3, = bus=3D0, controller=3D0, type=3Dvirtio-serial}, managed=3Dfalse, = plugged=3Dtrue, readOnly=3Dfalse, deviceAlias=3Dchannel2, = customProperties=3D{}, snapshotId=3Dnull}'}, 'clientIp': '', 'exitCode': = 1, 'nicModel': 'rtl8139,pv', 'smartcardEnable': 'false', 'kvmEnable': = 'true', 'exitMessage': "internal error process exited while connecting = to monitor: qemu-system-x86_64: -drive = file=3D/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c9= 7a/images/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f= 05cf6dea2,if=3Dnone,id=3Ddrive-scsi0-0-0-0,format=3Draw,serial=3De1886286-= 3d81-47d0-ae8d-77454e464078,cache=3Dnone,werror=3Dstop,rerror=3Dstop,aio=3D= threads: Duplicate ID 'drive-scsi0-0-0-0' for drive\n", = 'transparentHugePages': 'true', 'devices': [{'specParams': {}, = 'deviceId': 'db6166cb-e977-485e-8c82-fa48ca75e709', 'address': {'bus': = '0x00', ' slot': '0x05', ' domain': '0x0000', ' type': 'pci', ' = function': '0x0'}, 'device': 'scsi', 'model': 'virtio-scsi', 'type': = 'controller'}, {'device': 'qxl', 'specParams': {'vram': '32768', = 'heads': '1'}, 'type': 'video', 'deviceId': = '8b0e3dbc-27c6-4eae-ba6b-201c3e1736aa', 'address': {'bus': '0x00', ' = slot': '0x02', ' domain': '0x0000', ' type': 'pci', ' function': = '0x0'}}, {'nicModel': 'pv', 'macAddr': '00:1a:4a:5b:9f:02', = 'linkActive': 'true', 'network': 'ovirtmgmt', 'filter': = 'vdsm-no-mac-spoofing', 'specParams': {}, 'deviceId': = '738c8ebe-b014-4d65-8c78-942aaf12bfb5', 'address': {'bus': '0x00', ' = slot': '0x03', ' domain': '0x0000', ' type': 'pci', ' function': '0x0'}, = 'device': 'bridge', 'type': 'interface'}, {'index': '2', 'iface': 'ide', = 'address': {' controller': '0', ' target': '0', 'unit': '0', ' bus': = '1', ' type': 'drive'}, 'specParams': {'path': ''}, 'readonly': 'true', = 'deviceId': '5611019a-948e-41b3-8ffd-75790ebcdf84', 'path': '', = 'device': 'cdrom', 'shared': 'false', 'type': 'disk'}, {'volumeInfo': = {'domainID': 'f14f471e-0cce-414d-af57-779eeb88c97a', 'volType': 'path', = 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29ea36d5f= a4a', 'volumeID': 'c4864816-7384-4d0e-927e-29ea36d5fa4a', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29ea36d5f= a4a.lease', 'imageID': '94a298cb-87a5-48cd-b78f-770582b50639'}, 'index': = 0, 'iface': 'scsi', 'apparentsize': '162135015424', 'imageID': = '94a298cb-87a5-48cd-b78f-770582b50639', 'readonly': 'false', 'shared': = 'false', 'truesize': '107119386624', 'type': 'disk', 'domainID': = 'f14f471e-0cce-414d-af57-779eeb88c97a', 'reqsize': '0', 'format': 'raw', = 'deviceId': '94a298cb-87a5-48cd-b78f-770582b50639', 'poolID': = '18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', 'device': 'disk', 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29ea36d5f= a4a', 'propagateErrors': 'off', 'optional': 'false', 'bootOrder': '1', = 'volumeID': 'c4864816-7384-4d0e-927e-29ea36d5fa4a', 'specParams': {}, = 'volumeChain': [{'domainID': 'f14f471e-0cce-414d-af57-779eeb88c97a', = 'volType': 'path', 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29ea36d5f= a4a', 'volumeID': 'c4864816-7384-4d0e-927e-29ea36d5fa4a', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/94a298cb-87a5-48cd-b78f-770582b50639/c4864816-7384-4d0e-927e-29ea36d5f= a4a.lease', 'imageID': '94a298cb-87a5-48cd-b78f-770582b50639'}]}, = {'address': {'bus': '0x00', ' slot': '0x07', ' domain': '0x0000', ' = type': 'pci', ' function': '0x0'}, 'volumeInfo': {'domainID': = 'f14f471e-0cce-414d-af57-779eeb88c97a', 'volType': 'path', = 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6eaa2ca4d= 40d', 'volumeID': '42786233-04c0-4a9f-b731-6eaa2ca4d40d', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6eaa2ca4d= 40d.lease', 'imageID': '8df43d38-c4c7-4711-bc87-55f35d1550e5'}, 'index': = '0', 'iface': 'virtio', 'apparentsize': '1073741824', 'imageID': = '8df43d38-c4c7-4711-bc87-55f35d1550e5', 'readonly': 'false', 'shared': = 'false', 'truesize': '0', 'type': 'disk', 'domainID': = 'f14f471e-0cce-414d-af57-779eeb88c97a', 'reqsize': '0', 'format': 'raw', = 'deviceId': '8df43d38-c4c7-4711-bc87-55f35d1550e5', 'poolID': = '18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', 'device': 'disk', 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6eaa2ca4d= 40d', 'propagateErrors': 'off', 'optional': 'false', 'volumeID': = '42786233-04c0-4a9f-b731-6eaa2ca4d40d', 'specParams': {}, 'volumeChain': = [{'domainID': 'f14f471e-0cce-414d-af57-779eeb88c97a', 'volType': 'path', = 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6eaa2ca4d= 40d', 'volumeID': '42786233-04c0-4a9f-b731-6eaa2ca4d40d', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/8df43d38-c4c7-4711-bc87-55f35d1550e5/42786233-04c0-4a9f-b731-6eaa2ca4d= 40d.lease', 'imageID': '8df43d38-c4c7-4711-bc87-55f35d1550e5'}]}, = {'address': {' controller': '0', ' target': '0', 'unit': '0', ' bus': = '0', ' type': 'drive'}, 'volumeInfo': {'domainID': = 'f14f471e-0cce-414d-af57-779eeb88c97a', 'volType': 'path', = 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6d= ea2', 'volumeID': '1ef64ebd-6415-43d1-a34f-28f05cf6dea2', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6d= ea2.lease', 'imageID': 'e1886286-3d81-47d0-ae8d-77454e464078'}, 'index': = '1', 'iface': 'scsi', 'apparentsize': '1073741824', 'imageID': = 'e1886286-3d81-47d0-ae8d-77454e464078', 'readonly': 'false', 'shared': = 'false', 'truesize': '0', 'type': 'disk', 'domainID': = 'f14f471e-0cce-414d-af57-779eeb88c97a', 'reqsize': '0', 'format': 'raw', = 'deviceId': 'e1886286-3d81-47d0-ae8d-77454e464078', 'poolID': = '18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', 'device': 'disk', 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6d= ea2', 'propagateErrors': 'off', 'optional': 'false', 'volumeID': = '1ef64ebd-6415-43d1-a34f-28f05cf6dea2', 'specParams': {}, 'volumeChain': = [{'domainID': 'f14f471e-0cce-414d-af57-779eeb88c97a', 'volType': 'path', = 'leaseOffset': 0, 'path': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6d= ea2', 'volumeID': '1ef64ebd-6415-43d1-a34f-28f05cf6dea2', 'leasePath': = '/rhev/data-center/mnt/_disk01_vm/f14f471e-0cce-414d-af57-779eeb88c97a/ima= ges/e1886286-3d81-47d0-ae8d-77454e464078/1ef64ebd-6415-43d1-a34f-28f05cf6d= ea2.lease', 'imageID': 'e1886286-3d81-47d0-ae8d-77454e464078'}]}, = {'device': 'ich6', 'specParams': {}, 'type': 'sound', 'deviceId': = 'a1e596e9-218f-46ba-9f32-b9c966e11d73', 'address': {'bus': '0x00', ' = slot': '0x04', ' domain': '0x0000', ' type': 'pci', ' function': = '0x0'}}, {'device': 'memballoon', 'specParams': {'model': 'virtio'}, = 'type': 'balloon', 'deviceId': '5c04fd7e-7249-4e3a-b8eb-91cce72d5b60', = 'target': 4194304}], 'smp': '3', 'vmType': 'kvm', 'memSize': 4096, = 'displayIp': '0', 'spiceSecureChannels': = 'smain,sinputs,scursor,splayback,srecord,sdisplay,susbredir,ssmartcard', = 'smpCoresPerSocket': '1', 'vmName': 'cobra', 'display': 'qxl', 'nice': = '0'} createXmlElem:<bound method Drive.createXmlElem of <vm.Drive = object at 0x7f1150113a90>> device:cdrom = deviceId:5611019a-948e-41b3-8ffd-75790ebcdf84 extSharedState:none = getLeasesXML:<bound method Drive.getLeasesXML of <vm.Drive object = at 0x7f1150113a90>> getNextVolumeSize:<bound method = Drive.getNextVolumeSize of <vm.Drive object at 0x7f1150113a90>> = getXML:<bound method Drive.getXML of <vm.Drive object at = 0x7f1150113a90>> hasVolumeLeases:False iface:ide index:2 = isDiskReplicationInProgress:<bound method = Drive.isDiskReplicationInProgress of <vm.Drive object at = 0x7f1150113a90>> isVdsmImage:<bound method Drive.isVdsmImage of = <vm.Drive object at 0x7f1150113a90>> = log:<logUtils.SimpleLogAdapter object at 0x7f111838af90> name:hdc = networkDev:False path: readonly:true reqsize:0 serial: shared:false = specParams:{'path': ''} truesize:0 type:disk volExtensionChunk:1024 = watermarkLimit:536870912</div><div style=3D"margin: 0px;">Traceback = (most recent call last):</div><div style=3D"margin: 0px;"> File = "/usr/share/vdsm/clientIF.py", line 356, in teardownVolumePath</div><div = style=3D"margin: 0px;"> res =3D = self.irs.teardownImage(drive['domainID'],</div><div style=3D"margin: = 0px;"> File "/usr/share/vdsm/vm.py", line 1389, in = __getitem__</div><div style=3D"margin: 0px;"> raise = KeyError(key)</div><div style=3D"margin: 0px;">KeyError: = 'domainID'</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,186::task::579::TaskManager.Task::(_updateState) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::moving from state init = -> state preparing</div><div><div style=3D"margin: = 0px;">Thread-32158::INFO::2014-01-08 = 11:54:42,187::logUtils::44::dispatcher::(wrapper) Run and protect: = teardownImage(sdUUID=3D'f14f471e-0cce-414d-af57-779eeb88c97a', = spUUID=3D'18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', = imgUUID=3D'94a298cb-87a5-48cd-b78f-770582b50639', = volUUID=3DNone)</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,187::resourceManager::197::ResourceManager.Request::(__init__) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`533f2699-= 0684-4247-9d5f-a858ffe96fe9`::Request was made in = '/usr/share/vdsm/storage/hsm.py' line '3283' at = 'teardownImage'</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,187::resourceManager::541::ResourceManager::(registerResource) = Trying to register resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' for lock type = 'shared'</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,187::resourceManager::600::ResourceManager::(registerResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free. Now = locking as 'shared' (1 active user)</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,187::resourceManager::237::ResourceManager.Request::(grant) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`533f2699-= 0684-4247-9d5f-a858ffe96fe9`::Granted request</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::task::811::TaskManager.Task::(resourceAcquired) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::_resourcesAcquired: = Storage.f14f471e-0cce-414d-af57-779eeb88c97a (shared)</div><div = style=3D"margin: 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::task::974::TaskManager.Task::(_decref) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::ref 1 aborting = False</div><div style=3D"margin: 0px;">Thread-32158::INFO::2014-01-08 = 11:54:42,188::logUtils::47::dispatcher::(wrapper) Run and protect: = teardownImage, Return response: None</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::task::1168::TaskManager.Task::(prepare) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::finished: None</div><div = style=3D"margin: 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::task::579::TaskManager.Task::(_updateState) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::moving from state = preparing -> state finished</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::resourceManager::939::ResourceManager.Owner::(releaseAll) = Owner.releaseAll requests {} resources = {'Storage.f14f471e-0cce-414d-af57-779eeb88c97a': < ResourceRef = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a', isValid: 'True' obj: = 'None'>}</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,188::resourceManager::976::ResourceManager.Owner::(cancelAll) = Owner.cancelAll requests {}</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::resourceManager::615::ResourceManager::(releaseResource) = Trying to release resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a'</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::resourceManager::634::ResourceManager::(releaseResource) = Released resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' (0 = active users)</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::resourceManager::640::ResourceManager::(releaseResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free, finding = out if anyone is waiting for it.</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::resourceManager::648::ResourceManager::(releaseResource) = No one is waiting for resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a', Clearing = records.</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::task::974::TaskManager.Task::(_decref) = Task=3D`30d76cca-4645-4893-8d68-5cc68ba42dc3`::ref 0 aborting = False</div><div style=3D"margin: 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,189::task::579::TaskManager.Task::(_updateState) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::moving from state init = -> state preparing</div><div style=3D"margin: = 0px;">Thread-32158::INFO::2014-01-08 = 11:54:42,190::logUtils::44::dispatcher::(wrapper) Run and protect: = teardownImage(sdUUID=3D'f14f471e-0cce-414d-af57-779eeb88c97a', = spUUID=3D'18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', = imgUUID=3D'8df43d38-c4c7-4711-bc87-55f35d1550e5', = volUUID=3DNone)</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,190::resourceManager::197::ResourceManager.Request::(__init__) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`0907e117-= ba60-4c9f-a190-ebb7e027b4c2`::Request was made in = '/usr/share/vdsm/storage/hsm.py' line '3283' at = 'teardownImage'</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,190::resourceManager::541::ResourceManager::(registerResource) = Trying to register resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' for lock type = 'shared'</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,190::resourceManager::600::ResourceManager::(registerResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free. Now = locking as 'shared' (1 active user)</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,190::resourceManager::237::ResourceManager.Request::(grant) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`0907e117-= ba60-4c9f-a190-ebb7e027b4c2`::Granted request</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,190::task::811::TaskManager.Task::(resourceAcquired) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::_resourcesAcquired: = Storage.f14f471e-0cce-414d-af57-779eeb88c97a (shared)</div><div = style=3D"margin: 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::task::974::TaskManager.Task::(_decref) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::ref 1 aborting = False</div><div style=3D"margin: 0px;">Thread-32158::INFO::2014-01-08 = 11:54:42,191::logUtils::47::dispatcher::(wrapper) Run and protect: = teardownImage, Return response: None</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::task::1168::TaskManager.Task::(prepare) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::finished: None</div><div = style=3D"margin: 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::task::579::TaskManager.Task::(_updateState) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::moving from state = preparing -> state finished</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::resourceManager::939::ResourceManager.Owner::(releaseAll) = Owner.releaseAll requests {} resources = {'Storage.f14f471e-0cce-414d-af57-779eeb88c97a': < ResourceRef = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a', isValid: 'True' obj: = 'None'>}</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::resourceManager::976::ResourceManager.Owner::(cancelAll) = Owner.cancelAll requests {}</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,191::resourceManager::615::ResourceManager::(releaseResource) = Trying to release resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a'</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,192::resourceManager::634::ResourceManager::(releaseResource) = Released resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' (0 = active users)</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,192::resourceManager::640::ResourceManager::(releaseResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free, finding = out if anyone is waiting for it.</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,192::resourceManager::648::ResourceManager::(releaseResource) = No one is waiting for resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a', Clearing = records.</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,192::task::974::TaskManager.Task::(_decref) = Task=3D`4b2bde05-78f2-42b2-a5be-171377c6905e`::ref 0 aborting = False</div><div style=3D"margin: 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,192::task::579::TaskManager.Task::(_updateState) = Task=3D`75d1051f-b118-4af8-b9f1-504fcd1802c2`::moving from state init = -> state preparing</div><div style=3D"margin: = 0px;">Thread-32158::INFO::2014-01-08 = 11:54:42,192::logUtils::44::dispatcher::(wrapper) Run and protect: = teardownImage(sdUUID=3D'f14f471e-0cce-414d-af57-779eeb88c97a', = spUUID=3D'18f6234c-a9de-4fdf-bd9a-2bd90b9f33f9', = imgUUID=3D'e1886286-3d81-47d0-ae8d-77454e464078', = volUUID=3DNone)</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,193::resourceManager::197::ResourceManager.Request::(__init__) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`8908ad39-= 2555-4ef5-a6ae-49e8504de015`::Request was made in = '/usr/share/vdsm/storage/hsm.py' line '3283' at = 'teardownImage'</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,193::resourceManager::541::ResourceManager::(registerResource) = Trying to register resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' for lock type = 'shared'</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,196::resourceManager::600::ResourceManager::(registerResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free. Now = locking as 'shared' (1 active user)</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,196::resourceManager::237::ResourceManager.Request::(grant) = ResName=3D`Storage.f14f471e-0cce-414d-af57-779eeb88c97a`ReqID=3D`8908ad39-= 2555-4ef5-a6ae-49e8504de015`::Granted request</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,196::task::811::TaskManager.Task::(resourceAcquired) = Task=3D`75d1051f-b118-4af8-b9f1-504fcd1802c2`::_resourcesAcquired: = Storage.f14f471e-0cce-414d-af57-779eeb88c97a (shared)</div><div = style=3D"margin: 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,196::task::974::TaskManager.Task::(_decref) = Task=3D`75d1051f-b118-4af8-b9f1-504fcd1802c2`::ref 1 aborting = False</div><div style=3D"margin: 0px;">Thread-32158::INFO::2014-01-08 = 11:54:42,196::logUtils::47::dispatcher::(wrapper) Run and protect: = teardownImage, Return response: None</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,196::task::1168::TaskManager.Task::(prepare) = Task=3D`75d1051f-b118-4af8-b9f1-504fcd1802c2`::finished: None</div><div = style=3D"margin: 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::task::579::TaskManager.Task::(_updateState) = Task=3D`75d1051f-b118-4af8-b9f1-504fcd1802c2`::moving from state = preparing -> state finished</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::resourceManager::939::ResourceManager.Owner::(releaseAll) = Owner.releaseAll requests {} resources = {'Storage.f14f471e-0cce-414d-af57-779eeb88c97a': < ResourceRef = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a', isValid: 'True' obj: = 'None'>}</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::resourceManager::976::ResourceManager.Owner::(cancelAll) = Owner.cancelAll requests {}</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::resourceManager::615::ResourceManager::(releaseResource) = Trying to release resource = 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a'</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::resourceManager::634::ResourceManager::(releaseResource) = Released resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' (0 = active users)</div><div style=3D"margin: = 0px;">Thread-32158::DEBUG::2014-01-08 = 11:54:42,197::resourceManager::640::ResourceManager::(releaseResource) = Resource 'Storage.f14f471e-0cce-414d-af57-779eeb88c97a' is free, finding = out if anyone is waiting for it.</div></div><div style=3D"margin: = 0px;"><br></div></div><div style=3D"margin: 0px;"><div style=3D"margin: = 0px;"><br></div></div></div><div><br></div></div></body></html>= --Apple-Mail=_877DC8BA-BA64-4899-AC8F-C9588B685A8B--