- Users - oVirt List Archives

[Users] Putting a Gluster host into an ISCSI DC
by Gianluca Cecchi 05 Feb '14

05 Feb '14

Hello, in a test infra I would to temporarily put a Host that is part of Gluster DC and has gluster volumes active into an ISCSI DC. I put Gluster DC in maintenance, stop glustervolume and put both hosts in maintenance. Then I try to edit host and put into the ISCSI DC. But I receive error Error while executing action: node02: Cannot Edit host. Server having Gluster volume Is there any basic check so that I cannot do this at all? Any tip? Thanks, Gianluca

3 3

[Users] My first wiki page
by Juan Pablo Lorier 05 Feb '14

05 Feb '14

This is an OpenPGP/MIME signed message (RFC 4880 and 3156) --deoiLO4vfFDeGT8PRV00k91A9xPxiS603 Content-Type: text/plain; charset=ISO-8859-1 Content-Transfer-Encoding: quoted-printable Hi, I've created my first wiki page and I'd like someone to review it and tell me if there's something that need to be changed (besides it does not have any style yet) The URL is http://www.ovirt.org/oVirt_Wiki:How_to_change_Gluster%27s_network_interfa= ce Regards, --deoiLO4vfFDeGT8PRV00k91A9xPxiS603 Content-Type: application/pgp-signature; name="signature.asc" Content-Description: OpenPGP digital signature Content-Disposition: attachment; filename="signature.asc" -----BEGIN PGP SIGNATURE----- Version: GnuPG v1 Comment: Using GnuPG with Thunderbird - http://www.enigmail.net/ iQEcBAEBAgAGBQJS754aAAoJEC5KDDg2+NMMAnMIAKRXKtYFHfo/PSqEJOaacWom B8L1px+Vy2HpL9m71ofaaGhl1fvGP8hGYGFuAwTDT2zXxheE5BQlnM6sh0Dc2KS9 f4sNwylw9axbMdTmhr/6rGfsTSuv/616FRumOHJ+lUoxg0q4xd4kIMfN56o+E2TQ MC5x/ZMtSimaTZeoP8ZZsXFSBwVoX3Y3PSI0FJ6PbsMz9/v/XPDoYSdLP/ZhSptj NV9PVUqyVEj0A/8T0HPY2Uja9AXmWZL0Z1DYTms0uBkk7jwvzbGOYbJ/9WXckaxn uOTxrMrkfa1qsyzsun26Qxi6mTj04Kp03bnwnFgXDXt4ey4EZ+mfWh6U5ezYGQY= =GZ12 -----END PGP SIGNATURE----- --deoiLO4vfFDeGT8PRV00k91A9xPxiS603--

4 4

[Users] Networking. Hosted Setup. All in One Host. Hetzner
by Peter Styk 05 Feb '14

05 Feb '14

Greetings, I'm writing here as to share some of my findings about hosting with Hetzner. All in one setups on single remote host can be tricky. Provider mounted an extra /29 subnet to the main host but none is routed by default and host has to become router itself. At the same time single mistake in bridging configuration and lost access results in need for re-bootstrap. It's still tempting to try and with many trials I eventually got to see guests talking to the net. Scenario 1: Working. Package bridge-utils, oVirt engine, setup bridge, VDSM, add host to engine, add routing to host routing table. Networking by trial and error. Still something is not right. Occasionally on ping out I'm getting "Redirect Host (New nexthop" messages. http://styk.tv/wp-content/uploads/2014/01/oVirtHosted1_almost_working.png Scenario 2: Dreaming. Private network with private router/dhcp/nat. Private 10.0.0.0/24 network. No problems with routing as gateway 10.0.0.1 would be on the same subnet. Thought of using pfSense but can't seem to bring up an instance with two network cards on two different networks. I thought this would be easy. Go to Networks, click create new network, type private, save ok. then go to new instance. point at iso, attach two network cards. save ok. Launch "Host did not satisfy internal filter Network" No idea what that is. Maybe I don't understand how this works. I even tried removing ovirtmgmt network and leaving private network by itself. Tried with all 3 network card types (rtl8139/e1000/VirtIO) http://styk.tv/wp-content/uploads/2014/01/oVirtHosted2_preferred.png Either way if you have a minute or two please take a look at both attached diagrams. Deliberately making it difficult by forcing all elements on single box in hosted environment. Maybe there is a way to have this all installed with Neutron or vSwitch on the same box or is that pushing it? Regards, Peter

3 3

[Users] Engine-setup Fail
by Kevin Tibi 05 Feb '14

05 Feb '14

Hi all, i try to update my ovirt-engine. I use nightly repo. For moment, i am on 3.4. When i try to up 3.5 i have a fail when it download the package: [ INFO ] Yum Downloading: (7/7): ovirt-engine-webadmin-portal-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm 48 M(47%) [ ERROR ] Yum [u'Des erreurs ont \xe9t\xe9 rencontr\xe9e durant le t\xe9l\xe9chargement des paquets.', u'ovirt-engine-dbscripts-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-dbscripts-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-dbscripts-3.5.…: [Errno 14] HTTP Error 416 - Requested Range Not Satisfiable', u'ovirt-engine-restapi-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-restapi-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-restapi-3.5.0-…: [Errno 14] HTTP Error 416 - Requested Range Not Satisfiable', u'ovirt-engine-tools-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-tools-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-tools-3.5.0-0.…: [Errno 14] HTTP Error 416 - Requested Range Not Satisfiable', u'ovirt-engine-webadmin-portal-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-webadmin-portal-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-webadmin-porta…: [Errno 14] curl#18 - "transfer closed with 54679208 bytes remaining to read"', u'ovirt-engine-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-3.5.0-0.0.mast…: [Errno 14] HTTP Error 416 - Requested Range Not Satisfiable', u'ovirt-engine-backend-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-backend-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-backend-3.5.0-…: [Errno 14] HTTP Error 416 - Requested Range Not Satisfiable'] [ ERROR ] Failed to execute stage 'Package installation': [u'Des erreurs ont \xe9t\xe9 rencontr\xe9e durant le t\xe9l\xe9chargement des paquets.', u'ovirt-engine-dbscripts-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-dbscripts-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-dbscripts-3.5.…: [Errno 14] HTTP Error 416 - Requested Range Not Satisfiable', u'ovirt-engine-restapi-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-restapi-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-restapi-3.5.0-…: [Errno 14] HTTP Error 416 - Requested Range Not Satisfiable', u'ovirt-engine-tools-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-tools-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-tools-3.5.0-0.…: [Errno 14] HTTP Error 416 - Requested Range Not Satisfiable', u'ovirt-engine-webadmin-portal-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-webadmin-portal-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-webadmin-porta…: [Errno 14] curl#18 - "transfer closed with 54679208 bytes remaining to read"', u'ovirt-engine-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-3.5.0-0.0.mast…: [Errno 14] HTTP Error 416 - Requested Range Not Satisfiable', u'ovirt-engine-backend-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch: failure: noarch/ovirt-engine-backend-3.5.0-0.0.master.20140130171441.git9257b30.fc19.noarch.rpm from ovirt-nightly: [Errno 256] No more mirrors to try.\nhttp:// ovirt.org/releases/nightly/rpm/Fedora/19/noarch/ovirt-engine-backend-3.5.0-…: [Errno 14] HTTP Error 416 - Requested Range Not Satisfiable'] [ INFO ] Stage: Clean up Log file is located at /var/log/ovirt-engine/setup/ovirt-engine-setup-20140204133303.log [ INFO ] Stage: Pre-termination [ INFO ] Stage: Termination [ ERROR ] Execution of setup failed I try to manual download, its work. I add the package in cache of yum and it's dont work. Thx for your help ;) Kevin.

3 10

[Users] ovirt engine and vdsm on same node
by Hans Emmanuel 05 Feb '14

05 Feb '14

Can we install ovirt engine and vdsm on same node ? If so any down side ? -- *Hans Emmanuel* *NOthing to FEAR but something to FEEL......*

3 3

[Users] Storage server
by Koen Vanoppen 05 Feb '14

05 Feb '14

Dear All, At work, the network guys have come to a discovery that they have made a mistake in their network configuration... The Storage server that we use as ISCSI target in oVirt, is in the wrong VLAN, so the wrong IP address... What is the best way to make sure that all of our vms (40) that are using this scsi storage will come up again after the storage server has changed his ip? What are the best steps to be taken...? We are using oVirt Engine Version: 3.3.1-2.el6 Kind Regards, Koen

3 5

[Users] Limit bandwidths for VM
by Hans Emmanuel 05 Feb '14

05 Feb '14

Hi all, I was thinking whether it is possible to limit bandwidth used by a particular vm ? So that we can make sure that its not eating up bw for other vms also. -- *Hans Emmanuel*

2 2

[Users] Problems with migration on a VM and not detected by gui
by Gianluca Cecchi 05 Feb '14

05 Feb '14

Hello, passing from 3.3.3rc to 3.3.3 final on fedora 19 based infra. Two hosts and one engine. Gluster DC. I have 3 VMs: CentOS 5.10, 6.5, Fedora 20 Main steps: 1) update engine with usual procedure 2) all VMs are on one node; I put into maintenance the other one and update it and reboot 3) activate the new node and migrate all VMs to it. >From webadmin gui point of view it seems all ok. Only "strange" thing is that the CentOS 6.5 VM has no ip shown, when usually it has becuse of ovrt-guest-agent installed on it So I try to connect to its console (configured as VNC). But I get error (the other two are ok and they are spice) Also, I cannot ping or ssh into the VM so there is indeed some problem. I didn't connect since 30th January so I don't knw if any probem arised before today. >From the original host /var/log/libvirt/qemu/c6s.log I see: 2014-01-30 11:21:37.561+0000: shutting down 2014-01-30 11:22:14.595+0000: starting up LC_ALL=C PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin QEMU_AUDIO_DRV=none /usr/bin/qemu-kvm -name c6s -S -machine pc-1.0,accel=kvm,usb=off -cpu Opteron_G2 -m 1024 -smp 1,sockets=1,cores=1,threads=1 -uuid 4147e0d3-19a7-447b-9d88-2ff19365bec0 -smbios type=1,manufacturer=oVirt,product=oVirt Node,version=19-5,serial=34353439-3036-435A-4A38-303330393338,uuid=4147e0d3-19a7-447b-9d88-2ff19365bec0 -no-user-config -nodefaults -chardev socket,id=charmonitor,path=/var/lib/libvirt/qemu/c6s.monitor,server,nowait -mon chardev=charmonitor,id=monitor,mode=control -rtc base=2014-01-23T11:42:26,driftfix=slew -no-shutdown -device piix3-usb-uhci,id=usb,bus=pci.0,addr=0x1.0x2 -device virtio-scsi-pci,id=scsi0,bus=pci.0,addr=0x4 -device virtio-serial-pci,id=virtio-serial0,bus=pci.0,addr=0x6 -drive if=none,id=drive-ide0-1-0,readonly=on,format=raw,serial= -device ide-cd,bus=ide.1,unit=0,drive=drive-ide0-1-0,id=ide0-1-0 -drive file=/rhev/data-center/mnt/glusterSD/f18ovn01.ceda.polimi.it:gvdata/d0b96d4a-62aa-4e9f-b50e-f7a0cb5be291/images/a5e4f67b-50b5-4740-9990-39deb8812445/53408cb0-bcd4-40de-bc69-89d59b7b5bc2,if=none,id=drive-virtio-disk0,format=raw,serial=a5e4f67b-50b5-4740-9990-39deb8812445,cache=none,werror=stop,rerror=stop,aio=threads -device virtio-blk-pci,scsi=off,bus=pci.0,addr=0x5,drive=drive-virtio-disk0,id=virtio-disk0,bootindex=1 -drive file=/rhev/data-center/mnt/glusterSD/f18ovn01.ceda.polimi.it:gvdata/d0b96d4a-62aa-4e9f-b50e-f7a0cb5be291/images/c1477133-6b06-480d-a233-1dae08daf8b3/c2a82c64-9dee-42bb-acf2-65b8081f2edf,if=none,id=drive-scsi0-0-0-0,format=raw,serial=c1477133-6b06-480d-a233-1dae08daf8b3,cache=none,werror=stop,rerror=stop,aio=threads -device scsi-hd,bus=scsi0.0,channel=0,scsi-id=0,lun=0,drive=drive-scsi0-0-0-0,id=scsi0-0-0-0 -netdev tap,fd=27,id=hostnet0,vhost=on,vhostfd=28 -device virtio-net-pci,netdev=hostnet0,id=net0,mac=00:1a:4a:8f:04:f8,bus=pci.0,addr=0x3 -chardev socket,id=charchannel0,path=/var/lib/libvirt/qemu/channels/4147e0d3-19a7-447b-9d88-2ff19365bec0.com.redhat.rhevm.vdsm,server,nowait -device virtserialport,bus=virtio-serial0.0,nr=1,chardev=charchannel0,id=channel0,name=com.redhat.rhevm.vdsm -chardev socket,id=charchannel1,path=/var/lib/libvirt/qemu/channels/4147e0d3-19a7-447b-9d88-2ff19365bec0.org.qemu.guest_agent.0,server,nowait -device virtserialport,bus=virtio-serial0.0,nr=2,chardev=charchannel1,id=channel1,name=org.qemu.guest_agent.0 -chardev pty,id=charconsole0 -device virtconsole,chardev=charconsole0,id=console0 -device usb-tablet,id=input0 -vnc 0:0,password -k en-us -vga cirrus -device virtio-balloon-pci,id=balloon0,bus=pci.0,addr=0x7 char device redirected to /dev/pts/0 (label charconsole0) 2014-02-04 12:48:01.855+0000: shutting down qemu: terminating on signal 15 from pid 1021 >From the updated host where I apparently migrated it I see: 2014-02-04 12:47:54.674+0000: starting up LC_ALL=C PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin QEMU_AUDIO_DRV=none /usr/bin/qemu-kvm -name c6s -S -machine pc-1.0,accel=kvm,usb=off -cpu Opteron_G2 -m 1024 -smp 1,sockets=1,cores=1,threads=1 -uuid 4147e0d3-19a7-447b-9d88-2ff19365bec0 -smbios type=1,manufacturer=oVirt,product=oVirt Node,version=19-5,serial=34353439-3036-435A-4A38-303330393338,uuid=4147e0d3-19a7-447b-9d88-2ff19365bec0 -no-user-config -nodefaults -chardev socket,id=charmonitor,path=/var/lib/libvirt/qemu/c6s.monitor,server,nowait -mon chardev=charmonitor,id=monitor,mode=control -rtc base=2014-01-28T13:08:06,driftfix=slew -no-shutdown -device piix3-usb-uhci,id=usb,bus=pci.0,addr=0x1.0x2 -device virtio-scsi-pci,id=scsi0,bus=pci.0,addr=0x4 -device virtio-serial-pci,id=virtio-serial0,bus=pci.0,addr=0x6 -drive if=none,id=drive-ide0-1-0,readonly=on,format=raw,serial= -device ide-cd,bus=ide.1,unit=0,drive=drive-ide0-1-0,id=ide0-1-0 -drive file=/rhev/data-center/mnt/glusterSD/f18ovn01.ceda.polimi.it:gvdata/d0b96d4a-62aa-4e9f-b50e-f7a0cb5be291/images/a5e4f67b-50b5-4740-9990-39deb8812445/53408cb0-bcd4-40de-bc69-89d59b7b5bc2,if=none,id=drive-virtio-disk0,format=raw,serial=a5e4f67b-50b5-4740-9990-39deb8812445,cache=none,werror=stop,rerror=stop,aio=threads -device virtio-blk-pci,scsi=off,bus=pci.0,addr=0x5,drive=drive-virtio-disk0,id=virtio-disk0,bootindex=1 -drive file=/rhev/data-center/mnt/glusterSD/f18ovn01.ceda.polimi.it:gvdata/d0b96d4a-62aa-4e9f-b50e-f7a0cb5be291/images/c1477133-6b06-480d-a233-1dae08daf8b3/c2a82c64-9dee-42bb-acf2-65b8081f2edf,if=none,id=drive-scsi0-0-0-0,format=raw,serial=c1477133-6b06-480d-a233-1dae08daf8b3,cache=none,werror=stop,rerror=stop,aio=threads -device scsi-hd,bus=scsi0.0,channel=0,scsi-id=0,lun=0,drive=drive-scsi0-0-0-0,id=scsi0-0-0-0 -netdev tap,fd=30,id=hostnet0,vhost=on,vhostfd=31 -device virtio-net-pci,netdev=hostnet0,id=net0,mac=00:1a:4a:8f:04:f8,bus=pci.0,addr=0x3 -chardev socket,id=charchannel0,path=/var/lib/libvirt/qemu/channels/4147e0d3-19a7-447b-9d88-2ff19365bec0.com.redhat.rhevm.vdsm,server,nowait -device virtserialport,bus=virtio-serial0.0,nr=1,chardev=charchannel0,id=channel0,name=com.redhat.rhevm.vdsm -chardev socket,id=charchannel1,path=/var/lib/libvirt/qemu/channels/4147e0d3-19a7-447b-9d88-2ff19365bec0.org.qemu.guest_agent.0,server,nowait -device virtserialport,bus=virtio-serial0.0,nr=2,chardev=charchannel1,id=channel1,name=org.qemu.guest_agent.0 -chardev pty,id=charconsole0 -device virtconsole,chardev=charconsole0,id=console0 -device usb-tablet,id=input0 -vnc 0:0,password -k en-us -vga cirrus -incoming tcp:[::]:51152 -device virtio-balloon-pci,id=balloon0,bus=pci.0,addr=0x7 char device redirected to /dev/pts/1 (label charconsole0) engine log https://drive.google.com/file/d/0BwoPbcrMv8mvZWpqOHNqc0dnenc/edit?usp=shari… source vdsm log: https://drive.google.com/file/d/0BwoPbcrMv8mvYlluMDh1Y19jdEU/edit?usp=shari… dest vdsm log https://drive.google.com/file/d/0BwoPbcrMv8mvT1JxcmdKWlloOFU/edit?usp=shari… First error I see in source host log: Thread-728830::ERROR::2014-02-04 13:42:59,735::BindingXMLRPC::984::vds::(wrapper) unexpected error Traceback (most recent call last): File "/usr/share/vdsm/BindingXMLRPC.py", line 970, in wrapper res = f(*args, **kwargs) File "/usr/share/vdsm/gluster/api.py", line 53, in wrapper rv = func(*args, **kwargs) File "/usr/share/vdsm/gluster/api.py", line 206, in volumeStatus statusOption) File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in glusterVolumeStatus File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) KeyError: 'path' Thread-728831::ERROR::2014-02-04 13:42:59,805::BindingXMLRPC::984::vds::(wrapper) unexpected error Traceback (most recent call last): File "/usr/share/vdsm/BindingXMLRPC.py", line 970, in wrapper res = f(*args, **kwargs) File "/usr/share/vdsm/gluster/api.py", line 53, in wrapper rv = func(*args, **kwargs) File "/usr/share/vdsm/gluster/api.py", line 206, in volumeStatus statusOption) File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in glusterVolumeStatus File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) KeyError: 'path' Thread-323::INFO::2014-02-04 13:43:05,765::logUtils::44::dispatcher::(wrapper) Run and protect: getVolumeSize(sdUUID='d0b96d4a-62aa-4e9f-b50e-f7a0cb5be291', spUUID='eb679feb-4da2-4fd0-a185-abbe459ffa70', imgUUID='a3d332c0-c302-4f28-9ed3-e2e83566343f', volUUID='701eca86-df87-4b16-ac6d-e9f51e7ac171', options=None) Apart the problem itself, another one is in my opinion the engine that doesn't know about it at all.... For this VM, in its event tab I can see only: 2014-Feb-04, 13:57 user admin@internal initiated console session for VM c6s 1b78630c oVirt 2014-Feb-04, 13:51 user admin@internal initiated console session for VM c6s 1d77f16a oVirt 2014-Feb-04, 13:48 Migration completed (VM: c6s, Source: f18ovn03, Destination: f18ovn01, Duration: 8 sec). 17c547cc oVirt 2014-Feb-04, 13:47 Migration started (VM: c6s, Source: f18ovn03, Destination: f18ovn01, User: admin@internal). 17c547cc oVirt 2014-Jan-30, 12:30 user admin@internal initiated console session for VM c6s 5536edb8 oVirt 2014-Jan-30, 12:23 VM c6s started on Host f18ovn03 45209312 oVirt 2014-Jan-30, 12:22 user admin@internal initiated console session for VM c6s 19c766c8 oVirt 2014-Jan-30, 12:22 user admin@internal initiated console session for VM c6s 79815897 oVirt 2014-Jan-30, 12:22 VM c6s was started by admin@internal (Host: f18ovn03). 45209312 oVirt 2014-Jan-30, 12:22 VM c6s configuration was updated by admin@internal. 76cbc53 oVirt 2014-Jan-30, 12:21 VM c6s is down. Exit message: User shut down oVirt 2014-Jan-30, 12:20 VM shutdown initiated by admin@internal on VM c6s (Host: f18ovn03). 213c3a55 oVirt Gianluca

4 6

[Users] VM install failures on a stateless node
by David Li 04 Feb '14

04 Feb '14

Hi, I have been trying to install my first VM on a stateless node. so far I have failed twice with the node ending up in the "Non-responsive" mode. I had to reboot to recover and it took a while to reconfigure everything since this is stateless. I can still get into the node via the console. It's not dead. But the ovirtmgmt interface seems to be dead. The other iSCSI interface is running ok. Can anyone recommend ways how to debug this problem? Thanks. David

2 5

[Users] Ovirt 3.3.2 Cannot attach POSIX (gluster) storage domain
by Steve Dainard 04 Feb '14

04 Feb '14

I can successfully create a POSIX storage domain backed by gluster, but at the end of creation I get an error message "failed to acquire host id". Note that I have successfully created/activated NFS DC/SD on the same ovirt/hosts. I have some logs when I tried to attach to the DC after failure: *engine.log* 2014-02-04 09:54:04,324 INFO [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (ajp--127.0.0.1-8702-3) [1dd40406] Lock Acquired to object EngineLock [ex clusiveLocks= key: 8c4e8898-c91a-4d49-98e8-b6467791a9cc value: POOL , sharedLocks= ] 2014-02-04 09:54:04,473 INFO [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (pool-6-thread-42) [1dd40406] Running command: AddStoragePoolWithStorages Command internal: false. Entities affected : ID: 8c4e8898-c91a-4d49-98e8-b6467791a9cc Type: StoragePool 2014-02-04 09:54:04,673 INFO [org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand] (pool-6-thread-42) [3f86c31b] Running command: ConnectStorageToVdsCommand intern al: true. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: System 2014-02-04 09:54:04,682 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (pool-6-thread-42) [3f86c31b] START, ConnectStorageServerVDSCommand( HostName = ovirt001, HostId = 48f13d47-8346-4ff6-81ca-4f4324069db3, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = POSIXFS, connectionList = [{ id: 87f9 ff74-93c4-4fe5-9a56-ed5338290af9, connection: 10.0.10.3:/rep2, iqn: null, vfsType: glusterfs, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), lo g id: 332ff091 2014-02-04 09:54:05,089 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (pool-6-thread-42) [3f86c31b] FINISH, ConnectStorageServerVDSCommand , return: {87f9ff74-93c4-4fe5-9a56-ed5338290af9=0}, log id: 332ff091 2014-02-04 09:54:05,093 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand] (pool-6-thread-42) [3f86c31b] START, CreateStoragePoolVDSCommand(HostNa me = ovirt001, HostId = 48f13d47-8346-4ff6-81ca-4f4324069db3, storagePoolId=8c4e8898-c91a-4d49-98e8-b6467791a9cc, storageType=POSIXFS, storagePoolName=IT, masterDomainId=471 487ed-2946-4dfc-8ec3-96546006be12, domainsIdList=[471487ed-2946-4dfc-8ec3-96546006be12], masterVersion=3), log id: 1be84579 2014-02-04 09:54:08,833 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStorag ePoolVDSCommand] (pool-6-thread-42) [3f86c31b] Failed in CreateStoragePoolVDS method 2014-02-04 09:54:08,834 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand] (pool-6-thread-42) [3f86c31b] Error code AcquireHostIdFailure and error message VDSGenericException: VDSErrorException: Failed to CreateStoragePoolVDS, error = Cannot acquire host id: ('471487ed-2946-4dfc-8ec3-96546006be12', SanlockException(22, 'Sanlock lockspace add failure', 'Invalid argument')) 2014-02-04 09:54:08,835 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand] (pool-6-thread-42) [3f86c31b] Command org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand return value StatusOnlyReturnForXmlRpc [mStatus=StatusForXmlRpc [mCode=661, mMessage=Cannot acquire host id: ('471487ed-2946-4dfc-8ec3-96546006be12', SanlockException(22, 'Sanlock lockspace add failure', 'Invalid argument'))]] 2014-02-04 09:54:08,836 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand] (pool-6-thread-42) [3f86c31b] HostName = ovirt001 2014-02-04 09:54:08,840 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand] (pool-6-thread-42) [3f86c31b] Command CreateStoragePoolVDS execution failed. Exception: VDSErrorException: VDSGenericException: VDSErrorException: Failed to CreateStoragePoolVDS, error = Cannot acquire host id: ('471487ed-2946-4dfc-8ec3-96546006be12', SanlockException(22, 'Sanlock lockspace add failure', 'Invalid argument')) 2014-02-04 09:54:08,840 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand] (pool-6-thread-42) [3f86c31b] FINISH, CreateStoragePoolVDSCommand, log id: 1be84579 2014-02-04 09:54:08,841 ERROR [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (pool-6-thread-42) [3f86c31b] Command org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand throw Vdc Bll exception. With error message VdcBLLException: org.ovirt.engine.core.vdsbroker.vdsbroker.VDSErrorException: VDSGenericException: VDSErrorException: Failed to CreateStoragePoolVDS, error = Cannot acquire host id: ('471487ed-2946-4dfc-8ec3-96546006be12', SanlockException(22, 'Sanlock lockspace add failure', 'Invalid argument')) (Failed with error AcquireHostIdFailure and code 661) 2014-02-04 09:54:08,867 INFO [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (pool-6-thread-42) [3f86c31b] Command [id=373987cb-b54d-4174-b4a9-195be631f0d7]: Compensating CHANGED_ENTITY of org.ovirt.engine.core.common.businessentities.StoragePool; snapshot: id=8c4e8898-c91a-4d49-98e8-b6467791a9cc. 2014-02-04 09:54:08,871 INFO [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (pool-6-thread-42) [3f86c31b] Command [id=373987cb-b54d-4174-b4a9-195be631f0d7]: Compensating NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.StoragePoolIsoMap; snapshot: storagePoolId = 8c4e8898-c91a-4d49-98e8-b6467791a9cc, storageId = 471487ed-2946-4dfc-8ec3-96546006be12. 2014-02-04 09:54:08,879 INFO [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (pool-6-thread-42) [3f86c31b] Command [id=373987cb-b54d-4174-b4a9-195be631f0d7]: Compensating CHANGED_ENTITY of org.ovirt.engine.core.common.businessentities.StorageDomainStatic; snapshot: id=471487ed-2946-4dfc-8ec3-96546006be12. 2014-02-04 09:54:08,951 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (pool-6-thread-42) [3f86c31b] Correlation ID: 1dd40406, Job ID: 07003dff-9e0e-42ae-8f88-6b055b45f797, Call Stack: null, Custom Event ID: -1, Message: Failed to attach Storage Domains to Data Center IT. (User: admin@internal) 2014-02-04 09:54:08,975 INFO [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (pool-6-thread-42) [3f86c31b] Lock freed to object EngineLock [exclusiveLocks= key: 8c4e8898-c91a-4d49-98e8-b6467791a9cc value: POOL , sharedLocks= ] *vdsm.log* Thread-30::DEBUG::2014-02-04 09:54:04,692::BindingXMLRPC::167::vds::(wrapper) client [10.0.10.2] flowID [3f86c31b] Thread-30::DEBUG::2014-02-04 09:54:04,692::task::579::TaskManager.Task::(_updateState) Task=`218dcde9-bbc7-4d5a-ad53-0bab556c6261`::moving from state init -> state preparing Thread-30::INFO::2014-02-04 09:54:04,693::logUtils::44::dispatcher::(wrapper) Run and protect: connectStorageServer(domType=6, spUUID='00000000-0000-0000-0000-000000000000', conList=[{'port': '', 'connection': '10.0.10.3:/rep2', 'iqn': '', 'portal': '', 'user': '', 'vfs_type': 'glusterfs', 'password': '******', 'id': '87f9ff74-93c4-4fe5-9a56-ed5338290af9'}], options=None) Thread-30::DEBUG::2014-02-04 09:54:04,698::mount::226::Storage.Misc.excCmd::(_runcmd) '/usr/bin/sudo -n /bin/mount -t glusterfs 10.0.10.3:/rep2 /rhev/data-center/mnt/10.0.10.3:_rep2' (cwd None) Thread-30::DEBUG::2014-02-04 09:54:05,067::hsm::2315::Storage.HSM::(__prefetchDomains) posix local path: /rhev/data-center/mnt/10.0.10.3:_rep2 Thread-30::DEBUG::2014-02-04 09:54:05,078::hsm::2333::Storage.HSM::(__prefetchDomains) Found SD uuids: ('471487ed-2946-4dfc-8ec3-96546006be12',) Thread-30::DEBUG::2014-02-04 09:54:05,078::hsm::2389::Storage.HSM::(connectStorageServer) knownSDs: {471487ed-2946-4dfc-8ec3-96546006be12: storage.nfsSD.findDomain} Thread-30::INFO::2014-02-04 09:54:05,078::logUtils::47::dispatcher::(wrapper) Run and protect: connectStorageServer, Return response: {'statuslist': [{'status': 0, 'id': '87f9ff74-93c4-4fe5-9a56-ed5338290af9'}]} Thread-30::DEBUG::2014-02-04 09:54:05,079::task::1168::TaskManager.Task::(prepare) Task=`218dcde9-bbc7-4d5a-ad53-0bab556c6261`::finished: {'statuslist': [{'status': 0, 'id': '87f9ff74-93c4-4fe5-9a56-ed5338290af9'}]} Thread-30::DEBUG::2014-02-04 09:54:05,079::task::579::TaskManager.Task::(_updateState) Task=`218dcde9-bbc7-4d5a-ad53-0bab556c6261`::moving from state preparing -> state finished Thread-30::DEBUG::2014-02-04 09:54:05,079::resourceManager::939::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {} Thread-30::DEBUG::2014-02-04 09:54:05,079::resourceManager::976::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-30::DEBUG::2014-02-04 09:54:05,079::task::974::TaskManager.Task::(_decref) Task=`218dcde9-bbc7-4d5a-ad53-0bab556c6261`::ref 0 aborting False Thread-31::DEBUG::2014-02-04 09:54:05,098::BindingXMLRPC::167::vds::(wrapper) client [10.0.10.2] flowID [3f86c31b] Thread-31::DEBUG::2014-02-04 09:54:05,099::task::579::TaskManager.Task::(_updateState) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::moving from state init -> state preparing Thread-31::INFO::2014-02-04 09:54:05,099::logUtils::44::dispatcher::(wrapper) Run and protect: createStoragePool(poolType=None, spUUID='8c4e8898-c91a-4d49-98e8-b6467791a9cc', poolName='IT', masterDom='471487ed-2946-4dfc-8ec3-96546006be12', domList=['471487ed-2946-4dfc-8ec3-96546006be12'], masterVersion=3, lockPolicy=None, lockRenewalIntervalSec=5, leaseTimeSec=60, ioOpTimeoutSec=10, leaseRetries=3, options=None) Thread-31::DEBUG::2014-02-04 09:54:05,099::misc::809::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage) Thread-31::DEBUG::2014-02-04 09:54:05,100::misc::811::SamplingMethod::(__call__) Got in to sampling method Thread-31::DEBUG::2014-02-04 09:54:05,100::misc::809::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan) Thread-31::DEBUG::2014-02-04 09:54:05,100::misc::811::SamplingMethod::(__call__) Got in to sampling method Thread-31::DEBUG::2014-02-04 09:54:05,100::iscsiadm::91::Storage.Misc.excCmd::(_runCmd) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None) Thread-31::DEBUG::2014-02-04 09:54:05,114::iscsiadm::91::Storage.Misc.excCmd::(_runCmd) FAILED: <err> = 'iscsiadm: No session found.\n'; <rc> = 21 Thread-31::DEBUG::2014-02-04 09:54:05,115::misc::819::SamplingMethod::(__call__) Returning last result Thread-31::DEBUG::2014-02-04 09:54:07,144::multipath::112::Storage.Misc.excCmd::(rescan) '/usr/bin/sudo -n /sbin/multipath -r' (cwd None) Thread-31::DEBUG::2014-02-04 09:54:07,331::multipath::112::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0 Thread-31::DEBUG::2014-02-04 09:54:07,332::lvm::510::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex Thread-31::DEBUG::2014-02-04 09:54:07,333::lvm::512::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex Thread-31::DEBUG::2014-02-04 09:54:07,333::lvm::521::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex Thread-31::DEBUG::2014-02-04 09:54:07,333::lvm::523::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex Thread-31::DEBUG::2014-02-04 09:54:07,333::lvm::541::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex Thread-31::DEBUG::2014-02-04 09:54:07,334::lvm::543::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex Thread-31::DEBUG::2014-02-04 09:54:07,334::misc::819::SamplingMethod::(__call__) Returning last result Thread-31::DEBUG::2014-02-04 09:54:07,499::fileSD::137::Storage.StorageDomain::(__init__) Reading domain in path /rhev/data-center/mnt/10.0.10.3: _rep2/471487ed-2946-4dfc-8ec3-96546006be12 Thread-31::DEBUG::2014-02-04 09:54:07,605::persistentDict::192::Storage.PersistentDict::(__init__) Created a persistent dict with FileMetadataRW backend Thread-31::DEBUG::2014-02-04 09:54:07,647::persistentDict::234::Storage.PersistentDict::(refresh) read lines (FileMetadataRW)=['CLASS=Data', 'DESCRIPTION=gluster-store-rep2', 'IOOPTIMEOUTSEC=10', 'LEASERETRIES=3', 'LEASETIMESEC=60', 'LOCKPOLICY=', 'LOCKRENEWALINTERVALSEC=5', 'POOL_UUID=', 'REMOTE_PATH=10.0.10.3:/rep2', 'ROLE=Regular', 'SDUUID=471487ed-2946-4dfc-8ec3-96546006be12', 'TYPE=POSIXFS', 'VERSION=3', '_SHA_CKSUM=469191aac3fb8ef504b6a4d301b6d8be6fffece1'] Thread-31::DEBUG::2014-02-04 09:54:07,683::fileSD::558::Storage.StorageDomain::(imageGarbageCollector) Removing remnants of deleted images [] Thread-31::DEBUG::2014-02-04 09:54:07,684::resourceManager::420::ResourceManager::(registerNamespace) Registering namespace '471487ed-2946-4dfc-8ec3-96546006be12_imageNS' Thread-31::DEBUG::2014-02-04 09:54:07,684::resourceManager::420::ResourceManager::(registerNamespace) Registering namespace '471487ed-2946-4dfc-8ec3-96546006be12_volumeNS' Thread-31::INFO::2014-02-04 09:54:07,684::fileSD::299::Storage.StorageDomain::(validate) sdUUID=471487ed-2946-4dfc-8ec3-96546006be12 Thread-31::DEBUG::2014-02-04 09:54:07,692::persistentDict::234::Storage.PersistentDict::(refresh) read lines (FileMetadataRW)=['CLASS=Data', 'DESCRIPTION=gluster-store-rep2', 'IOOPTIMEOUTSEC=10', 'LEASERETRIES=3', 'LEASETIMESEC=60', 'LOCKPOLICY=', 'LOCKRENEWALINTERVALSEC=5', 'POOL_UUID=', 'REMOTE_PATH=10.0.10.3:/rep2', 'ROLE=Regular', 'SDUUID=471487ed-2946-4dfc-8ec3-96546006be12', 'TYPE=POSIXFS', 'VERSION=3', '_SHA_CKSUM=469191aac3fb8ef504b6a4d301b6d8be6fffece1'] Thread-31::DEBUG::2014-02-04 09:54:07,693::resourceManager::197::ResourceManager.Request::(__init__) ResName=`Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc`ReqID=`e0a3d477-b953-49d9-ab78-67695a6bc6d5`::Request was made in '/usr/share/vdsm/storage/hsm.py' line '971' at 'createStoragePool' Thread-31::DEBUG::2014-02-04 09:54:07,693::resourceManager::541::ResourceManager::(registerResource) Trying to register resource 'Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc' for lock type 'exclusive' Thread-31::DEBUG::2014-02-04 09:54:07,693::resourceManager::600::ResourceManager::(registerResource) Resource 'Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc' is free. Now locking as 'exclusive' (1 active user) Thread-31::DEBUG::2014-02-04 09:54:07,693::resourceManager::237::ResourceManager.Request::(grant) ResName=`Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc`ReqID=`e0a3d477-b953-49d9-ab78-67695a6bc6d5`::Granted request Thread-31::DEBUG::2014-02-04 09:54:07,694::task::811::TaskManager.Task::(resourceAcquired) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::_resourcesAcquired: Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc (exclusive) Thread-31::DEBUG::2014-02-04 09:54:07,694::task::974::TaskManager.Task::(_decref) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::ref 1 aborting False Thread-31::DEBUG::2014-02-04 09:54:07,694::resourceManager::197::ResourceManager.Request::(__init__) ResName=`Storage.471487ed-2946-4dfc-8ec3-96546006be12`ReqID=`bc20dd7e-d351-47c5-8ed3-78b1b11d703a`::Request was made in '/usr/share/vdsm/storage/hsm.py' line '973' at 'createStoragePool' Thread-31::DEBUG::2014-02-04 09:54:07,694::resourceManager::541::ResourceManager::(registerResource) Trying to register resource 'Storage.471487ed-2946-4dfc-8ec3-96546006be12' for lock type 'exclusive' Thread-31::DEBUG::2014-02-04 09:54:07,695::resourceManager::600::ResourceManager::(registerResource) Resource 'Storage.471487ed-2946-4dfc-8ec3-96546006be12' is free. Now locking as 'exclusive' (1 active user) Thread-31::DEBUG::2014-02-04 09:54:07,695::resourceManager::237::ResourceManager.Request::(grant) ResName=`Storage.471487ed-2946-4dfc-8ec3-96546006be12`ReqID=`bc20dd7e-d351-47c5-8ed3-78b1b11d703a`::Granted request Thread-31::DEBUG::2014-02-04 09:54:07,695::task::811::TaskManager.Task::(resourceAcquired) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::_resourcesAcquired: Storage.471487ed-2946-4dfc-8ec3-96546006be12 (exclusive) Thread-31::DEBUG::2014-02-04 09:54:07,695::task::974::TaskManager.Task::(_decref) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::ref 1 aborting False Thread-31::INFO::2014-02-04 09:54:07,696::sp::593::Storage.StoragePool::(create) spUUID=8c4e8898-c91a-4d49-98e8-b6467791a9cc poolName=IT master_sd=471487ed-2946-4dfc-8ec3-96546006be12 domList=['471487ed-2946-4dfc-8ec3-96546006be12'] masterVersion=3 {'LEASETIMESEC': 60, 'IOOPTIMEOUTSEC': 10, 'LEASERETRIES': 3, 'LOCKRENEWALINTERVALSEC': 5} Thread-31::INFO::2014-02-04 09:54:07,696::fileSD::299::Storage.StorageDomain::(validate) sdUUID=471487ed-2946-4dfc-8ec3-96546006be12 Thread-31::DEBUG::2014-02-04 09:54:07,703::persistentDict::234::Storage.PersistentDict::(refresh) read lines (FileMetadataRW)=['CLASS=Data', 'DESCRIPTION=gluster-store-rep2', 'IOOPTIMEOUTSEC=10', 'LEASERETRIES=3', 'LEASETIMESEC=60', 'LOCKPOLICY=', 'LOCKRENEWALINTERVALSEC=5', 'POOL_UUID=', 'REMOTE_PATH=10.0.10.3:/rep2', 'ROLE=Regular', 'SDUUID=471487ed-2946-4dfc-8ec3-96546006be12', 'TYPE=POSIXFS', 'VERSION=3', '_SHA_CKSUM=469191aac3fb8ef504b6a4d301b6d8be6fffece1'] Thread-31::DEBUG::2014-02-04 09:54:07,710::persistentDict::234::Storage.PersistentDict::(refresh) read lines (FileMetadataRW)=['CLASS=Data', 'DESCRIPTION=gluster-store-rep2', 'IOOPTIMEOUTSEC=10', 'LEASERETRIES=3', 'LEASETIMESEC=60', 'LOCKPOLICY=', 'LOCKRENEWALINTERVALSEC=5', 'POOL_UUID=', 'REMOTE_PATH=10.0.10.3:/rep2', 'ROLE=Regular', 'SDUUID=471487ed-2946-4dfc-8ec3-96546006be12', 'TYPE=POSIXFS', 'VERSION=3', '_SHA_CKSUM=469191aac3fb8ef504b6a4d301b6d8be6fffece1'] Thread-31::DEBUG::2014-02-04 09:54:07,711::persistentDict::167::Storage.PersistentDict::(transaction) Starting transaction Thread-31::DEBUG::2014-02-04 09:54:07,711::persistentDict::175::Storage.PersistentDict::(transaction) Finished transaction Thread-31::INFO::2014-02-04 09:54:07,711::clusterlock::174::SANLock::(acquireHostId) Acquiring host id for domain 471487ed-2946-4dfc-8ec3-96546006be12 (id: 250) Thread-31::ERROR::2014-02-04 09:54:08,722::task::850::TaskManager.Task::(_setError) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::Unexpected error Traceback (most recent call last): File "/usr/share/vdsm/storage/task.py", line 857, in _run return fn(*args, **kargs) File "/usr/share/vdsm/logUtils.py", line 45, in wrapper res = f(*args, **kwargs) File "/usr/share/vdsm/storage/hsm.py", line 977, in createStoragePool masterVersion, leaseParams) File "/usr/share/vdsm/storage/sp.py", line 618, in create self._acquireTemporaryClusterLock(msdUUID, leaseParams) File "/usr/share/vdsm/storage/sp.py", line 560, in _acquireTemporaryClusterLock msd.acquireHostId(self.id) File "/usr/share/vdsm/storage/sd.py", line 458, in acquireHostId self._clusterLock.acquireHostId(hostId, async) File "/usr/share/vdsm/storage/clusterlock.py", line 189, in acquireHostId raise se.AcquireHostIdFailure(self._sdUUID, e) AcquireHostIdFailure: Cannot acquire host id: ('471487ed-2946-4dfc-8ec3-96546006be12', SanlockException(22, 'Sanlock lockspace add failure', 'Invalid argument')) Thread-31::DEBUG::2014-02-04 09:54:08,826::task::869::TaskManager.Task::(_run) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::Task._run: 66924dbf-5a1c-473e-a158-d038aae38dc3 (None, '8c4e8898-c91a-4d49-98e8-b6467791a9cc', 'IT', '471487ed-2946-4dfc-8ec3-96546006be12', ['471487ed-2946-4dfc-8ec3-96546006be12'], 3, None, 5, 60, 10, 3) {} failed - stopping task Thread-31::DEBUG::2014-02-04 09:54:08,826::task::1194::TaskManager.Task::(stop) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::stopping in state preparing (force False) Thread-31::DEBUG::2014-02-04 09:54:08,826::task::974::TaskManager.Task::(_decref) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::ref 1 aborting True Thread-31::INFO::2014-02-04 09:54:08,826::task::1151::TaskManager.Task::(prepare) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::aborting: Task is aborted: 'Cannot acquire host id' - code 661 Thread-31::DEBUG::2014-02-04 09:54:08,826::task::1156::TaskManager.Task::(prepare) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::Prepare: aborted: Cannot acquire host id Thread-31::DEBUG::2014-02-04 09:54:08,827::task::974::TaskManager.Task::(_decref) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::ref 0 aborting True Thread-31::DEBUG::2014-02-04 09:54:08,827::task::909::TaskManager.Task::(_doAbort) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::Task._doAbort: force False Thread-31::DEBUG::2014-02-04 09:54:08,827::resourceManager::976::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-31::DEBUG::2014-02-04 09:54:08,827::task::579::TaskManager.Task::(_updateState) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::moving from state preparing -> state aborting Thread-31::DEBUG::2014-02-04 09:54:08,827::task::534::TaskManager.Task::(__state_aborting) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::_aborting: recover policy none Thread-31::DEBUG::2014-02-04 09:54:08,827::task::579::TaskManager.Task::(_updateState) Task=`66924dbf-5a1c-473e-a158-d038aae38dc3`::moving from state aborting -> state failed Thread-31::DEBUG::2014-02-04 09:54:08,827::resourceManager::939::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {'Storage.471487ed-2946-4dfc-8ec3-96546006be12': < ResourceRef 'Storage.471487ed-2946-4dfc-8ec3-96546006be12', isValid: 'True' obj: 'None'>, 'Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc': < ResourceRef 'Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc', isValid: 'True' obj: 'None'>} Thread-31::DEBUG::2014-02-04 09:54:08,828::resourceManager::976::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-31::DEBUG::2014-02-04 09:54:08,828::resourceManager::615::ResourceManager::(releaseResource) Trying to release resource 'Storage.471487ed-2946-4dfc-8ec3-96546006be12' Thread-31::DEBUG::2014-02-04 09:54:08,828::resourceManager::634::ResourceManager::(releaseResource) Released resource 'Storage.471487ed-2946-4dfc-8ec3-96546006be12' (0 active users) Thread-31::DEBUG::2014-02-04 09:54:08,828::resourceManager::640::ResourceManager::(releaseResource) Resource 'Storage.471487ed-2946-4dfc-8ec3-96546006be12' is free, finding out if anyone is waiting for it. Thread-31::DEBUG::2014-02-04 09:54:08,828::resourceManager::648::ResourceManager::(releaseResource) No one is waiting for resource 'Storage.471487ed-2946-4dfc-8ec3-96546006be12', Clearing records. Thread-31::DEBUG::2014-02-04 09:54:08,828::resourceManager::615::ResourceManager::(releaseResource) Trying to release resource 'Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc' Thread-31::DEBUG::2014-02-04 09:54:08,829::resourceManager::634::ResourceManager::(releaseResource) Released resource 'Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc' (0 active users) Thread-31::DEBUG::2014-02-04 09:54:08,829::resourceManager::640::ResourceManager::(releaseResource) Resource 'Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc' is free, finding out if anyone is waiting for it. Thread-31::DEBUG::2014-02-04 09:54:08,829::resourceManager::648::ResourceManager::(releaseResource) No one is waiting for resource 'Storage.8c4e8898-c91a-4d49-98e8-b6467791a9cc', Clearing records. Thread-31::ERROR::2014-02-04 09:54:08,829::dispatcher::67::Storage.Dispatcher.Protect::(run) {'status': {'message': "Cannot acquire host id: ('471487ed-2946-4dfc-8ec3-96546006be12', SanlockException(22, 'Sanlock lockspace add failure', 'Invalid argument'))", 'code': 661}} *Storage domain metadata file:* CLASS=Data DESCRIPTION=gluster-store-rep2 IOOPTIMEOUTSEC=10 LEASERETRIES=3 LEASETIMESEC=60 LOCKPOLICY= LOCKRENEWALINTERVALSEC=5 POOL_UUID= REMOTE_PATH=10.0.10.3:/rep2 ROLE=Regular SDUUID=471487ed-2946-4dfc-8ec3-96546006be12 TYPE=POSIXFS VERSION=3 _SHA_CKSUM=469191aac3fb8ef504b6a4d301b6d8be6fffece1 *Steve Dainard * IT Infrastructure Manager Miovision <http://miovision.com/> | *Rethink Traffic* 519-513-2407 ex.250 877-646-8476 (toll-free) *Blog <http://miovision.com/blog> | **LinkedIn <https://www.linkedin.com/company/miovision-technologies> | Twitter <https://twitter.com/miovision> | Facebook <https://www.facebook.com/miovision>* ------------------------------ Miovision Technologies Inc. | 148 Manitou Drive, Suite 101, Kitchener, ON, Canada | N2C 1L3 This e-mail may contain information that is privileged or confidential. If you are not the intended recipient, please delete the e-mail and any attachments and notify us immediately.

3 4