
------=_Part_136909_782517491.1437895632232 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: quoted-printable Hi Jurri=C3=ABn,=20 Did you manage to reproduce this?=20 What's the status of you environment?=20 Thanks in advance,=20 Raz Tamir=20 ratamir@redhat.com=20 RedHat Israel=20 RHEV-M QE Storage team=20 ----- Original Message ----- From: "Raz Tamir" <ratamir@redhat.com>=20 To: "Jurri=C3=ABn Bloemen" <Jurrien.Bloemen@dmc.amcnetworks.com>=20 Cc: users@ovirt.org=20 Sent: Tuesday, July 21, 2015 1:43:30 PM=20 Subject: Re: [ovirt-users] Error creating a storage domain=20 Thanks.=20 I see this on newer vdsm version=20 vdsm-python-zombiereaper-4.16.21-1.el7ev.noarch=20 vdsm-4.16.21-1.el7ev.x86_64=20 vdsm-python-4.16.21-1.el7ev.noarch=20 vdsm-cli-4.16.21-1.el7ev.noarch=20 vdsm-yajsonrpc-4.16.21-1.el7ev.noarch=20 vdsm-hook-vhostmd-4.16.21-1.el7ev.noarch=20 vdsm-hook-ethtool-options-4.16.21-1.el7ev.noarch=20 ovirt-node-plugin-vdsm-0.2.0-25.el7ev.noarch=20 vdsm-xmlrpc-4.16.21-1.el7ev.noarch=20 vdsm-jsonrpc-4.16.21-1.el7ev.noarch=20 vdsm-reg-4.16.21-1.el7ev.noarch=20 you can can track for updates:=20 https://bugzilla.redhat.com/show_bug.cgi?id=3D1245147=20 Thanks in advance,=20 Raz Tamir=20 ratamir@redhat.com=20 RedHat Israel=20 RHEV-M QE Storage team=20 ----- Original Message ----- From: "Jurri=C3=ABn Bloemen" <Jurrien.Bloemen@dmc.amcnetworks.com>=20 To: "Raz Tamir" <ratamir@redhat.com>=20 Cc: users@ovirt.org=20 Sent: Tuesday, July 21, 2015 1:09:38 PM=20 Subject: Re: [ovirt-users] Error creating a storage domain=20 Hi Raz,=20 4.16.10-8=20 Kind regards,=20 Jurri=C3=ABn Bloemen=20 vdsm-cli-4.16.10-8.gitc937927.el7.noarch=20 vdsm-4.16.10-8.gitc937927.el7.x86_64=20 vdsm-python-zombiereaper-4.16.10-8.gitc937927.el7.noarch=20 vdsm-xmlrpc-4.16.10-8.gitc937927.el7.noarch=20 vdsm-jsonrpc-4.16.10-8.gitc937927.el7.noarch=20 vdsm-reg-4.16.10-8.gitc937927.el7.noarch=20 vdsm-hook-ethtool-options-4.16.10-8.gitc937927.el7.noarch=20 ovirt-node-plugin-vdsm-0.2.2-5.el7.noarch=20 vdsm-python-4.16.10-8.gitc937927.el7.noarch=20 vdsm-yajsonrpc-4.16.10-8.gitc937927.el7.noarch=20 vdsm-gluster-4.16.10-8.gitc937927.el7.noarch=20 On 21-07-15 12:02, Raz Tamir wrote:=20 Hi Jurri=C3=ABn,=20 What is the host vdsm version?=20 Thanks in advance,=20 Raz Tamir=20 ratamir@redhat.com=20 RedHat Israel=20 RHEV-M QE Storage team=20 ----- Original Message ----- From: "Jurri=C3=ABn Bloemen" <Jurrien.Bloemen@dmc.amcnetworks.com>=20 To: users@ovirt.org=20 Sent: Tuesday, July 21, 2015 10:57:10 AM=20 Subject: Re: [ovirt-users] Error creating a storage domain=20 Hi all,=20 I have to add that this is the latest 3.5 version. Adding the other gluster= fs storage was done by an older version of 3.5. I don't know if something h= as changed in between version?=20 Thanks,=20 Jurri=C3=ABn=20 ovirt-engine-websocket-proxy-3.5.3.1-1.el7.centos.noarch=20 ovirt-release35-004-1.noarch=20 ovirt-engine-backend-3.5.3.1-1.el7.centos.noarch=20 ovirt-host-deploy-1.3.1-1.el7.noarch=20 ovirt-engine-userportal-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-jboss-as-7.1.1-1.el7.x86_64=20 ovirt-engine-lib-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-setup-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-webadmin-portal-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-dbscripts-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-extensions-api-impl-3.5.3.1-1.el7.centos.noarch=20 ovirt-image-uploader-3.5.1-1.el7.centos.noarch=20 ovirt-engine-cli-3.5.0.5-1.el7.centos.noarch=20 ovirt-host-deploy-java-1.3.1-1.el7.noarch=20 ovirt-iso-uploader-3.5.2-1.el7.centos.noarch=20 ovirt-engine-setup-base-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-setup-plugin-ovirt-engine-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-setup-plugin-websocket-proxy-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-restapi-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-tools-3.5.3.1-1.el7.centos.noarch=20 ovirt-engine-sdk-python-3.5.2.1-1.el7.centos.noarch=20 ovirt-engine-setup-plugin-ovirt-engine-common-3.5.3.1-1.el7.centos.noarch= =20 On 20-07-15 18:30, Bloemen, Jurri=C3=ABn wrote:=20 <blockquote> Hi all,=20 I have some trouble with adding a gluster storage domain:=20 Error while executing action AddGlusterFsStorageDomain: Error creating a st= orage domain=20 I have mounted the gluster volume by hand and that works fine. Also checked= the rights and ownership and they are 755 and vdsm:kvm.=20 I also tried to reinstall the oVirtH node.=20 May worth of telling is that I already have one gluster mount running perfe= ctly but add a new one does not work.=20 Can somebody help me?=20 This is the engine.log of the oVirt manager:=20 2015-07-20 18:23:30,766 INFO [org.ovirt.engine.core.bll.storage.AddStorageS= erverConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Lock Acquired to= object EngineLock [exclusiveLocks=3D key: superstore001-stor.cs.example.co= m:/ovirtprd01 value: STORAGE_CONNECTION=20 , sharedLocks=3D ]=20 2015-07-20 18:23:30,791 INFO [org.ovirt.engine.core.bll.storage.AddStorageS= erverConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Running command:= AddStorageServerConnectionCommand internal: false. Entities affected : ID:= aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_STORA= GE_DOMAIN with role type ADMIN=20 2015-07-20 18:23:30,811 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Con= nectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [61712435] START, Conn= ectStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4= f4d-98a1-49e87443eddc, storagePoolId =3D 00000000-0000-0000-0000-0000000000= 00, storageType =3D GLUSTERFS, connectionList =3D [{ id: null, connection: = superstore001-stor.cs.example.com:/ovirtprd01, iqn: null, vfsType: glusterf= s, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null }= ;]), log id: 44c1a9f2=20 2015-07-20 18:23:31,074 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Con= nectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [61712435] FINISH, Con= nectStorageServerVDSCommand, return: {00000000-0000-0000-0000-000000000000= =3D0}, log id: 44c1a9f2=20 2015-07-20 18:23:31,085 INFO [org.ovirt.engine.core.bll.storage.AddStorageS= erverConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Lock freed to ob= ject EngineLock [exclusiveLocks=3D key: superstore001-stor.cs.example.com:/= ovirtprd01 value: STORAGE_CONNECTION=20 , sharedLocks=3D ]=20 2015-07-20 18:23:31,138 WARN [org.ovirt.engine.core.dal.job.ExecutionMessag= eDirector] (ajp--127.0.0.1-8702-3) [8d11fec] The message key AddGlusterFsSt= orageDomain is missing from bundles/ExecutionMessages=20 2015-07-20 18:23:31,156 INFO [org.ovirt.engine.core.bll.storage.AddGlusterF= sStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Running command: A= ddGlusterFsStorageDomainCommand internal: false. Entities affected : ID: aa= a00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_STORAGE_= DOMAIN with role type ADMIN=20 2015-07-20 18:23:31,183 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Con= nectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] START, Conne= ctStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4f= 4d-98a1-49e87443eddc, storagePoolId =3D 00000000-0000-0000-0000-00000000000= 0, storageType =3D GLUSTERFS, connectionList =3D [{ id: ece6ad42-be90-4980-= 98dd-d7ae12cc6709, connection: superstore001-stor.cs.example.com:/ovirtprd0= 1, iqn: null, vfsType: glusterfs, mountOptions: null, nfsVersion: null, nfs= Retrans: null, nfsTimeo: null };]), log id: 3bb1d8b0=20 2015-07-20 18:23:31,207 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Con= nectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] FINISH, Conn= ectStorageServerVDSCommand, return: {ece6ad42-be90-4980-98dd-d7ae12cc6709= =3D0}, log id: 3bb1d8b0=20 2015-07-20 18:23:31,223 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Cre= ateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] START, Create= StorageDomainVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4f4d= -98a1-49e87443eddc, storageDomain=3DStorageDomainStatic[ovirtprd01, d6df793= 0-342a-493a-b70b-fb1c52b0828c], args=3Dsuperstore001-stor.cs.example.com:/o= virtprd01), log id: 42df6467=20 2015-07-20 18:23:31,356 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.Cr= eateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Failed in Cr= eateStorageDomainVDS method=20 2015-07-20 18:23:31,358 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Cre= ateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command org.o= virt.engine.core.vdsbroker.vdsbroker.CreateStorageDomainVDSCommand return v= alue=20 StatusOnlyReturnForXmlRpc [mStatus=3DStatusForXmlRpc [mCode=3D351, mMessage= =3DError creating a storage domain: (u'storageType=3D7, sdUUID=3Dd6df7930-3= 42a-493a-b70b-fb1c52b0828c, domainName=3Dovirtprd01, domClass=3D1, typeSpec= ificArg=3Dsuperstore001-stor.cs.example.com:/ovirtprd01 domVersion=3D3',)]]= =20 2015-07-20 18:23:31,364 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Cre= ateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] HostName =3D = twin189=20 2015-07-20 18:23:31,366 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.Cr= eateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command Crea= teStorageDomainVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4f= 4d-98a1-49e87443eddc, storageDomain=3DStorageDomainStatic[ovirtprd01, d6df7= 930-342a-493a-b70b-fb1c52b0828c], args=3Dsuperstore001-stor.cs.example.com:= /ovirtprd01) execution failed. Exception: VDSErrorException: VDSGenericExce= ption: VDSErrorException: Failed to CreateStorageDomainVDS, error =3D Error= creating a storage domain: (u'storageType=3D7, sdUUID=3Dd6df7930-342a-493a= -b70b-fb1c52b0828c, domainName=3Dovirtprd01, domClass=3D1, typeSpecificArg= =3Dsuperstore001-stor.cs.example.com:/ovirtprd01 domVersion=3D3',), code = =3D 351=20 2015-07-20 18:23:31,375 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Cre= ateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] FINISH, Creat= eStorageDomainVDSCommand, log id: 42df6467=20 2015-07-20 18:23:31,377 ERROR [org.ovirt.engine.core.bll.storage.AddGluster= FsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command org.ovirt= .engine.core.bll.storage.AddGlusterFsStorageDomainCommand throw Vdc Bll exc= eption. With error message VdcBLLException: org.ovirt.engine.core.vdsbroker= .vdsbroker.VDSErrorException: VDSGenericException: VDSErrorException: Faile= d to CreateStorageDomainVDS, error =3D Error creating a storage domain: (u'= storageType=3D7, sdUUID=3Dd6df7930-342a-493a-b70b-fb1c52b0828c, domainName= =3Dovirtprd01, domClass=3D1, typeSpecificArg=3Dsuperstore001-stor.cs.exampl= e.com:/ovirtprd01 domVersion=3D3',), code =3D 351 (Failed with error Storag= eDomainCreationError and code 351)=20 2015-07-20 18:23:31,386 INFO [org.ovirt.engine.core.bll.storage.AddGlusterF= sStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command [id=3Db1e0= d0ec-526b-42e4-997f-ff55614e0797]: Compensating NEW_ENTITY_ID of org.ovirt.= engine.core.common.businessentities.StorageDomainDynamic; snapshot: d6df793= 0-342a-493a-b70b-fb1c52b0828c.=20 2015-07-20 18:23:31,390 INFO [org.ovirt.engine.core.bll.storage.AddGlusterF= sStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command [id=3Db1e0= d0ec-526b-42e4-997f-ff55614e0797]: Compensating NEW_ENTITY_ID of org.ovirt.= engine.core.common.businessentities.StorageDomainStatic; snapshot: d6df7930= -342a-493a-b70b-fb1c52b0828c.=20 2015-07-20 18:23:31,397 ERROR [org.ovirt.engine.core.bll.storage.AddGluster= FsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Transaction rolle= d-back for command: org.ovirt.engine.core.bll.storage.AddGlusterFsStorageDo= mainCommand.=20 2015-07-20 18:23:31,404 ERROR [org.ovirt.engine.core.dal.dbbroker.auditlogh= andling.AuditLogDirector] (ajp--127.0.0.1-8702-3) [8d11fec] Correlation ID:= 8d11fec, Job ID: 9c59789a-ab38-4171-96c5-3d8da688e2bb, Call Stack: null, C= ustom Event ID: -1, Message: Failed to add Storage Domain ovirtprd01. (User= : admin@internal)=20 2015-07-20 18:23:31,451 INFO [org.ovirt.engine.core.bll.storage.RemoveStora= geServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Lock Acquired= to object EngineLock [exclusiveLocks=3D key: ece6ad42-be90-4980-98dd-d7ae1= 2cc6709 value: STORAGE_CONNECTION=20 key: superstore001-stor.cs.example.com:/ovirtprd01 value: STORAGE_CONNECTIO= N=20 , sharedLocks=3D ]=20 2015-07-20 18:23:31,607 INFO [org.ovirt.engine.core.bll.storage.RemoveStora= geServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Running comma= nd: RemoveStorageServerConnectionCommand internal: false. Entities affected= : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE= _STORAGE_DOMAIN with role type ADMIN=20 2015-07-20 18:23:31,615 INFO [org.ovirt.engine.core.bll.storage.RemoveStora= geServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Removing conn= ection ece6ad42-be90-4980-98dd-d7ae12cc6709 from database=20 2015-07-20 18:23:31,631 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Dis= connectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [406a3269] START, D= isconnectStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-= 12b8-4f4d-98a1-49e87443eddc, storagePoolId =3D 00000000-0000-0000-0000-0000= 00000000, storageType =3D GLUSTERFS, connectionList =3D [{ id: ece6ad42-be9= 0-4980-98dd-d7ae12cc6709, connection: superstore001-stor.cs.example.com:/ov= irtprd01, iqn: null, vfsType: glusterfs, mountOptions: null, nfsVersion: nu= ll, nfsRetrans: null, nfsTimeo: null };]), log id: 372ee09d=20 2015-07-20 18:23:31,723 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Dis= connectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [406a3269] FINISH, = DisconnectStorageServerVDSCommand, return: {ece6ad42-be90-4980-98dd-d7ae12c= c6709=3D0}, log id: 372ee09d=20 2015-07-20 18:23:31,728 INFO [org.ovirt.engine.core.bll.storage.RemoveStora= geServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Lock freed to= object EngineLock [exclusiveLocks=3D key: ece6ad42-be90-4980-98dd-d7ae12cc= 6709 value: STORAGE_CONNECTION=20 key: superstore001-stor.cs.example.com:/ovirtprd01 value: STORAGE_CONNECTIO= N=20 , sharedLocks=3D ]=20 And this is de vdsm.log of the hypervisor:=20 JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:25,456::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'>=20 JsonRpcServer::DEBUG::2015-07-20 16:23:25,458::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request=20 Thread-199::DEBUG::2015-07-20 16:23:25,460::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response=20 JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:28,483::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'>=20 JsonRpcServer::DEBUG::2015-07-20 16:23:28,484::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request=20 Thread-200::DEBUG::2015-07-20 16:23:28,485::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response=20 JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,124::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'>=20 JsonRpcServer::DEBUG::2015-07-20 16:23:30,125::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request=20 Thread-201::DEBUG::2015-07-20 16:23:30,125::__init__::469::jsonrpc.JsonRpcS= erver::(_serveRequest) Calling 'StoragePool.connectStorageServer' in bridge= with {u'connectionParams': [{u'id': u'00000000-0000-0000-0000-000000000000= ', u'connection': u'superstore001-stor.cs.example.com:/ovirtprd01', u'iqn':= u'', u'user': u'', u'tpgt': u'1', u'vfs_type': u'glusterfs', u'password': = u'', u'port': u''}], u'storagepoolID': u'00000000-0000-0000-0000-0000000000= 00', u'domainType': 7}=20 Thread-201::DEBUG::2015-07-20 16:23:30,127::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`417462a8-3817-4e44-ac89-20ea4e3c8709`::moving = from state init -> state preparing=20 Thread-201:: INFO::2015-07-20 16:23:30,127::logUtils::44::dispatcher::(wrap= per) Run and protect: connectStorageServer(domType=3D7, spUUID=3Du'00000000= -0000-0000-0000-000000000000', conList=3D[{u'port': u'', u'connection': u's= uperstore001-stor.cs.example.com:/ovirtprd01', u'iqn': u'', u'user': u'', u= 'tpgt': u'1', u'vfs_type': u'glusterfs', u'password': '******', u'id': u'00= 000000-0000-0000-0000-000000000000'}], options=3DNone)=20 Thread-201::DEBUG::2015-07-20 16:23:30,137::fileUtils::142::Storage.fileUti= ls::(createdir) Creating directory: /rhev/data-center/mnt/glusterSD/superst= ore001-stor.cs.example.com:_ovirtprd01=20 Thread-201::DEBUG::2015-07-20 16:23:30,138::mount::227::Storage.Misc.excCmd= ::(_runcmd) /usr/bin/sudo -n /usr/bin/mount -t glusterfs superstore001-stor= .cs.example.com:/ovirtprd01 /rhev/data-center/mnt/glusterSD/superstore001-s= tor.cs.example.com:_ovirtprd01 (cwd None)=20 Thread-201::DEBUG::2015-07-20 16:23:30,371::hsm::2375::Storage.HSM::(__pref= etchDomains) glusterDomPath: glusterSD/*=20 Thread-201::DEBUG::2015-07-20 16:23:30,377::hsm::2387::Storage.HSM::(__pref= etchDomains) Found SD uuids: ()=20 Thread-201::DEBUG::2015-07-20 16:23:30,377::hsm::2443::Storage.HSM::(connec= tStorageServer) knownSDs: {}=20 Thread-201:: INFO::2015-07-20 16:23:30,377::logUtils::47::dispatcher::(wrap= per) Run and protect: connectStorageServer, Return response: {'statuslist':= [{'status': 0, 'id': u'00000000-0000-0000-0000-000000000000'}]}=20 Thread-201::DEBUG::2015-07-20 16:23:30,377::task::1191::Storage.TaskManager= .Task::(prepare) Task=3D`417462a8-3817-4e44-ac89-20ea4e3c8709`::finished: {= 'statuslist': [{'status': 0, 'id': u'00000000-0000-0000-0000-000000000000'}= ]}=20 Thread-201::DEBUG::2015-07-20 16:23:30,377::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`417462a8-3817-4e44-ac89-20ea4e3c8709`::moving = from state preparing -> state finished=20 Thread-201::DEBUG::2015-07-20 16:23:30,377::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= }=20 Thread-201::DEBUG::2015-07-20 16:23:30,378::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {}=20 Thread-201::DEBUG::2015-07-20 16:23:30,378::task::993::Storage.TaskManager.= Task::(_decref) Task=3D`417462a8-3817-4e44-ac89-20ea4e3c8709`::ref 0 aborti= ng False=20 Thread-201::DEBUG::2015-07-20 16:23:30,378::__init__::500::jsonrpc.JsonRpcS= erver::(_serveRequest) Return 'StoragePool.connectStorageServer' in bridge = with [{'status': 0, 'id': u'00000000-0000-0000-0000-000000000000'}]=20 Thread-201::DEBUG::2015-07-20 16:23:30,378::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response=20 JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,497::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'>=20 JsonRpcServer::DEBUG::2015-07-20 16:23:30,497::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request=20 Thread-203::DEBUG::2015-07-20 16:23:30,497::__init__::469::jsonrpc.JsonRpcS= erver::(_serveRequest) Calling 'StoragePool.connectStorageServer' in bridge= with {u'connectionParams': [{u'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709= ', u'connection': u'superstore001-stor.cs.example.com:/ovirtprd01', u'iqn':= u'', u'user': u'', u'tpgt': u'1', u'vfs_type': u'glusterfs', u'password': = u'', u'port': u''}], u'storagepoolID': u'00000000-0000-0000-0000-0000000000= 00', u'domainType': 7}=20 Thread-203::DEBUG::2015-07-20 16:23:30,498::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`627a1260-b231-493f-b0f1-14c0a8501f49`::moving = from state init -> state preparing=20 Thread-203:: INFO::2015-07-20 16:23:30,499::logUtils::44::dispatcher::(wrap= per) Run and protect: connectStorageServer(domType=3D7, spUUID=3Du'00000000= -0000-0000-0000-000000000000', conList=3D[{u'port': u'', u'connection': u's= uperstore001-stor.cs.example.com:/ovirtprd01', u'iqn': u'', u'user': u'', u= 'tpgt': u'1', u'vfs_type': u'glusterfs', u'password': '******', u'id': u'ec= e6ad42-be90-4980-98dd-d7ae12cc6709'}], options=3DNone)=20 Thread-203::DEBUG::2015-07-20 16:23:30,505::hsm::2375::Storage.HSM::(__pref= etchDomains) glusterDomPath: glusterSD/*=20 Thread-203::DEBUG::2015-07-20 16:23:30,511::hsm::2387::Storage.HSM::(__pref= etchDomains) Found SD uuids: ()=20 Thread-203::DEBUG::2015-07-20 16:23:30,511::hsm::2443::Storage.HSM::(connec= tStorageServer) knownSDs: {}=20 Thread-203:: INFO::2015-07-20 16:23:30,511::logUtils::47::dispatcher::(wrap= per) Run and protect: connectStorageServer, Return response: {'statuslist':= [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]}=20 Thread-203::DEBUG::2015-07-20 16:23:30,511::task::1191::Storage.TaskManager= .Task::(prepare) Task=3D`627a1260-b231-493f-b0f1-14c0a8501f49`::finished: {= 'statuslist': [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}= ]}=20 Thread-203::DEBUG::2015-07-20 16:23:30,511::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`627a1260-b231-493f-b0f1-14c0a8501f49`::moving = from state preparing -> state finished=20 Thread-203::DEBUG::2015-07-20 16:23:30,511::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= }=20 Thread-203::DEBUG::2015-07-20 16:23:30,511::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {}=20 Thread-203::DEBUG::2015-07-20 16:23:30,511::task::993::Storage.TaskManager.= Task::(_decref) Task=3D`627a1260-b231-493f-b0f1-14c0a8501f49`::ref 0 aborti= ng False=20 Thread-203::DEBUG::2015-07-20 16:23:30,511::__init__::500::jsonrpc.JsonRpcS= erver::(_serveRequest) Return 'StoragePool.connectStorageServer' in bridge = with [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]=20 Thread-203::DEBUG::2015-07-20 16:23:30,512::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response=20 JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,532::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'>=20 JsonRpcServer::DEBUG::2015-07-20 16:23:30,533::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request=20 Thread-205::DEBUG::2015-07-20 16:23:30,533::__init__::469::jsonrpc.JsonRpcS= erver::(_serveRequest) Calling 'StorageDomain.create' in bridge with {u'nam= e': u'ovirtprd01', u'domainType': 7, u'domainClass': 1, u'typeArgs': u'supe= rstore001-stor.cs.example.com:/ovirtprd01', u'version': u'3', u'storagedoma= inID': u'd6df7930-342a-493a-b70b-fb1c52b0828c'}=20 Thread-205::DEBUG::2015-07-20 16:23:30,534::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::moving = from state init -> state preparing=20 Thread-205:: INFO::2015-07-20 16:23:30,534::logUtils::44::dispatcher::(wrap= per) Run and protect: createStorageDomain(storageType=3D7, sdUUID=3Du'd6df7= 930-342a-493a-b70b-fb1c52b0828c', domainName=3Du'ovirtprd01', typeSpecificA= rg=3Du'superstore001-stor.cs.example.com:/ovirtprd01', domClass=3D1, domVer= sion=3Du'3', options=3DNone)=20 Thread-205::DEBUG::2015-07-20 16:23:30,534::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)= =20 Thread-205::DEBUG::2015-07-20 16:23:30,534::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method=20 Thread-205::DEBUG::2015-07-20 16:23:30,534::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.iscsi.rescan)=20 Thread-205::DEBUG::2015-07-20 16:23:30,535::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method=20 Thread-205::DEBUG::2015-07-20 16:23:30,535::iscsi::403::Storage.ISCSI::(res= can) Performing SCSI scan, this will take up to 30 seconds=20 Thread-205::DEBUG::2015-07-20 16:23:30,535::iscsiadm::92::Storage.Misc.excC= md::(_runCmd) /usr/bin/sudo -n /sbin/iscsiadm -m session -R (cwd None)=20 Thread-205::DEBUG::2015-07-20 16:23:30,545::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result=20 Thread-205::DEBUG::2015-07-20 16:23:30,545::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.hba.rescan)=20 Thread-205::DEBUG::2015-07-20 16:23:30,545::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method=20 Thread-205::DEBUG::2015-07-20 16:23:30,545::hba::53::Storage.HBA::(rescan) = Starting scan=20 Thread-205::DEBUG::2015-07-20 16:23:30,545::utils::739::Storage.HBA::(execC= md) /usr/bin/sudo -n /usr/libexec/vdsm/fc-scan (cwd None)=20 Thread-205::DEBUG::2015-07-20 16:23:30,565::hba::66::Storage.HBA::(rescan) = Scan finished=20 Thread-205::DEBUG::2015-07-20 16:23:30,565::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result=20 Thread-205::DEBUG::2015-07-20 16:23:30,565::multipath::128::Storage.Misc.ex= cCmd::(rescan) /usr/bin/sudo -n /sbin/multipath (cwd None)=20 Thread-205::DEBUG::2015-07-20 16:23:30,606::multipath::128::Storage.Misc.ex= cCmd::(rescan) SUCCESS: <err> =3D ''; <rc> =3D 0=20 Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::489::Storage.OperationMute= x::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operati= on mutex=20 Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::491::Storage.OperationMute= x::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the op= eration mutex=20 Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::500::Storage.OperationMute= x::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operati= on mutex=20 Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::502::Storage.OperationMute= x::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the op= eration mutex=20 Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::520::Storage.OperationMute= x::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operati= on mutex=20 Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::522::Storage.OperationMute= x::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the op= eration mutex=20 Thread-205::DEBUG::2015-07-20 16:23:30,608::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result=20 Thread-205::ERROR::2015-07-20 16:23:30,608::sdc::137::Storage.StorageDomain= Cache::(_findDomain) looking for unfetched domain d6df7930-342a-493a-b70b-f= b1c52b0828c=20 Thread-205::ERROR::2015-07-20 16:23:30,608::sdc::154::Storage.StorageDomain= Cache::(_findUnfetchedDomain) looking for domain d6df7930-342a-493a-b70b-fb= 1c52b0828c=20 Thread-205::DEBUG::2015-07-20 16:23:30,608::lvm::365::Storage.OperationMute= x::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex=20 Thread-205::DEBUG::2015-07-20 16:23:30,609::lvm::288::Storage.Misc.excCmd::= (cmd) /usr/bin/sudo -n /sbin/lvm vgs --config ' devices { preferred_names = =3D ["^/dev/mapper/"] ignore_suspended_devices=3D1 write_cache_state=3D0 di= sable_after_error_count=3D3 obtain_device_list_from_udev=3D0 filter =3D [ '= \''a|/dev/mapper/3600304801a8505001cd001f904750aa2|'\'', '\''r|.*|'\'' ] } = global { locking_type=3D1 prioritise_write_locks=3D1 wait_for_locks=3D1 use= _lvmetad=3D0 } backup { retain_min =3D 50 retain_days =3D 0 } ' --noheading= s --units b --nosuffix --separator '|' --ignoreskippedcluster -o uuid,name,= attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_= free,lv_count,pv_count,pv_name d6df7930-342a-493a-b70b-fb1c52b0828c (cwd No= ne)=20 Thread-205::DEBUG::2015-07-20 16:23:30,630::lvm::288::Storage.Misc.excCmd::= (cmd) FAILED: <err> =3D ' Volume group "d6df7930-342a-493a-b70b-fb1c52b0828= c" not found\n Skipping volume group d6df7930-342a-493a-b70b-fb1c52b0828c\n= '; <rc> =3D 5=20 Thread-205::WARNING::2015-07-20 16:23:30,631::lvm::370::Storage.LVM::(_relo= advgs) lvm vgs failed: 5 [] [' Volume group "d6df7930-342a-493a-b70b-fb1c52= b0828c" not found', ' Skipping volume group d6df7930-342a-493a-b70b-fb1c52b= 0828c']=20 Thread-205::DEBUG::2015-07-20 16:23:30,631::lvm::407::Storage.OperationMute= x::(_reloadvgs) Operation 'lvm reload operation' released the operation mut= ex=20 Thread-205::ERROR::2015-07-20 16:23:30,644::sdc::143::Storage.StorageDomain= Cache::(_findDomain) domain d6df7930-342a-493a-b70b-fb1c52b0828c not found= =20 Traceback (most recent call last):=20 File "/usr/share/vdsm/storage/sdc.py", line 141, in _findDomain=20 File "/usr/share/vdsm/storage/sdc.py", line 171, in _findUnfetchedDomain=20 StorageDomainDoesNotExist: Storage domain does not exist: (u'd6df7930-342a-= 493a-b70b-fb1c52b0828c',)=20 Thread-205:: INFO::2015-07-20 16:23:30,644::nfsSD::69::Storage.StorageDomai= n::(create) sdUUID=3Dd6df7930-342a-493a-b70b-fb1c52b0828c domainName=3Dovir= tprd01 remotePath=3Dsuperstore001-stor.cs.example.com:/ovirtprd01 domClass= =3D1=20 Thread-205::ERROR::2015-07-20 16:23:30,659::task::866::Storage.TaskManager.= Task::(_setError) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Unexpected= error=20 Traceback (most recent call last):=20 File "/usr/share/vdsm/storage/task.py", line 873, in _run=20 File "/usr/share/vdsm/logUtils.py", line 45, in wrapper=20 File "/usr/share/vdsm/storage/hsm.py", line 2670, in createStorageDomain=20 File "/usr/share/vdsm/storage/nfsSD.py", line 80, in create=20 File "/usr/share/vdsm/storage/nfsSD.py", line 49, in _preCreateValidation= =20 File "/usr/share/vdsm/storage/fileSD.py", line 88, in validateFileSystemFea= tures=20 File "/usr/share/vdsm/storage/outOfProcess.py", line 320, in directTouch=20 File "/usr/lib/python2.7/site-packages/ioprocess/__init__.py", line 507, in= touch=20 File "/usr/lib/python2.7/site-packages/ioprocess/__init__.py", line 391, in= _sendCommand=20 OSError: [Errno 2] No such file or directory=20 Thread-205::DEBUG::2015-07-20 16:23:30,659::task::885::Storage.TaskManager.= Task::(_run) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Task._run: 050e= 9378-ba78-4e6f-b986-0dda7bb09aa7 (7, u'd6df7930-342a-493a-b70b-fb1c52b0828c= ', u'ovirtprd01', u'superstore001-stor.cs.example.com:/ovirtprd01', 1, u'3'= ) {} failed - stopping task=20 Thread-205::DEBUG::2015-07-20 16:23:30,659::task::1217::Storage.TaskManager= .Task::(stop) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::stopping in st= ate preparing (force False)=20 Thread-205::DEBUG::2015-07-20 16:23:30,659::task::993::Storage.TaskManager.= Task::(_decref) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::ref 1 aborti= ng True=20 Thread-205:: INFO::2015-07-20 16:23:30,659::task::1171::Storage.TaskManager= .Task::(prepare) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::aborting: T= ask is aborted: u'[Errno 2] No such file or directory' - code 100=20 Thread-205::DEBUG::2015-07-20 16:23:30,659::task::1176::Storage.TaskManager= .Task::(prepare) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Prepare: ab= orted: [Errno 2] No such file or directory=20 Thread-205::DEBUG::2015-07-20 16:23:30,660::task::993::Storage.TaskManager.= Task::(_decref) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::ref 0 aborti= ng True=20 Thread-205::DEBUG::2015-07-20 16:23:30,660::task::928::Storage.TaskManager.= Task::(_doAbort) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Task._doAbo= rt: force False=20 Thread-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {}=20 Thread-205::DEBUG::2015-07-20 16:23:30,660::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::moving = from state preparing -> state aborting=20 Thread-205::DEBUG::2015-07-20 16:23:30,660::task::550::Storage.TaskManager.= Task::(__state_aborting) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::_ab= orting: recover policy none=20 Thread-205::DEBUG::2015-07-20 16:23:30,660::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::moving = from state aborting -> state failed=20 Thread-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= }=20 Thread-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {}=20 Thread-205::ERROR::2015-07-20 16:23:30,660::dispatcher::79::Storage.Dispatc= her::(wrapper) [Errno 2] No such file or directory=20 Traceback (most recent call last):=20 File "/usr/share/vdsm/storage/dispatcher.py", line 71, in wrapper=20 File "/usr/share/vdsm/storage/task.py", line 103, in wrapper=20 File "/usr/share/vdsm/storage/task.py", line 1179, in prepare=20 OSError: [Errno 2] No such file or directory=20 Thread-205::DEBUG::2015-07-20 16:23:30,660::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response=20 JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,945::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'>=20 JsonRpcServer::DEBUG::2015-07-20 16:23:30,945::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request=20 Thread-208::DEBUG::2015-07-20 16:23:30,945::__init__::469::jsonrpc.JsonRpcS= erver::(_serveRequest) Calling 'StoragePool.disconnectStorageServer' in bri= dge with {u'connectionParams': [{u'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6= 709', u'connection': u'superstore001-stor.cs.example.com:/ovirtprd01', u'iq= n': u'', u'user': u'', u'tpgt': u'1', u'vfs_type': u'glusterfs', u'password= ': u'', u'port': u''}], u'storagepoolID': u'00000000-0000-0000-0000-0000000= 00000', u'domainType': 7}=20 Thread-208::DEBUG::2015-07-20 16:23:30,946::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`9f38f64c-24e9-4f6b-9487-39384266bc71`::moving = from state init -> state preparing=20 Thread-208:: INFO::2015-07-20 16:23:30,947::logUtils::44::dispatcher::(wrap= per) Run and protect: disconnectStorageServer(domType=3D7, spUUID=3Du'00000= 000-0000-0000-0000-000000000000', conList=3D[{u'port': u'', u'connection': = u'superstore001-stor.cs.example.com:/ovirtprd01', u'iqn': u'', u'user': u''= , u'tpgt': u'1', u'vfs_type': u'glusterfs', u'password': '******', u'id': u= 'ece6ad42-be90-4980-98dd-d7ae12cc6709'}], options=3DNone)=20 Thread-208::DEBUG::2015-07-20 16:23:30,947::mount::227::Storage.Misc.excCmd= ::(_runcmd) /usr/bin/sudo -n /usr/bin/umount -f -l /rhev/data-center/mnt/gl= usterSD/superstore001-stor.cs.example.com:_ovirtprd01 (cwd None)=20 Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)= =20 Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method=20 Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.iscsi.rescan)=20 Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method=20 Thread-208::DEBUG::2015-07-20 16:23:30,958::iscsi::403::Storage.ISCSI::(res= can) Performing SCSI scan, this will take up to 30 seconds=20 Thread-208::DEBUG::2015-07-20 16:23:30,958::iscsiadm::92::Storage.Misc.excC= md::(_runCmd) /usr/bin/sudo -n /sbin/iscsiadm -m session -R (cwd None)=20 Thread-208::DEBUG::2015-07-20 16:23:30,971::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result=20 Thread-208::DEBUG::2015-07-20 16:23:30,971::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.hba.rescan)=20 Thread-208::DEBUG::2015-07-20 16:23:30,971::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method=20 Thread-208::DEBUG::2015-07-20 16:23:30,971::hba::53::Storage.HBA::(rescan) = Starting scan=20 Thread-208::DEBUG::2015-07-20 16:23:30,971::utils::739::Storage.HBA::(execC= md) /usr/bin/sudo -n /usr/libexec/vdsm/fc-scan (cwd None)=20 Thread-208::DEBUG::2015-07-20 16:23:30,989::hba::66::Storage.HBA::(rescan) = Scan finished=20 Thread-208::DEBUG::2015-07-20 16:23:30,989::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result=20 Thread-208::DEBUG::2015-07-20 16:23:30,989::multipath::128::Storage.Misc.ex= cCmd::(rescan) /usr/bin/sudo -n /sbin/multipath (cwd None)=20 Thread-208::DEBUG::2015-07-20 16:23:31,025::multipath::128::Storage.Misc.ex= cCmd::(rescan) SUCCESS: <err> =3D ''; <rc> =3D 0=20 Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::489::Storage.OperationMute= x::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operati= on mutex=20 Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::491::Storage.OperationMute= x::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the op= eration mutex=20 Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::500::Storage.OperationMute= x::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operati= on mutex=20 Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::502::Storage.OperationMute= x::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the op= eration mutex=20 Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::520::Storage.OperationMute= x::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operati= on mutex=20 Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::522::Storage.OperationMute= x::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the op= eration mutex=20 Thread-208::DEBUG::2015-07-20 16:23:31,026::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result=20 Thread-208:: INFO::2015-07-20 16:23:31,026::logUtils::47::dispatcher::(wrap= per) Run and protect: disconnectStorageServer, Return response: {'statuslis= t': [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]}=20 Thread-208::DEBUG::2015-07-20 16:23:31,026::task::1191::Storage.TaskManager= .Task::(prepare) Task=3D`9f38f64c-24e9-4f6b-9487-39384266bc71`::finished: {= 'statuslist': [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}= ]}=20 Thread-208::DEBUG::2015-07-20 16:23:31,027::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`9f38f64c-24e9-4f6b-9487-39384266bc71`::moving = from state preparing -> state finished=20 Thread-208::DEBUG::2015-07-20 16:23:31,027::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= }=20 Thread-208::DEBUG::2015-07-20 16:23:31,027::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {}=20 Thread-208::DEBUG::2015-07-20 16:23:31,027::task::993::Storage.TaskManager.= Task::(_decref) Task=3D`9f38f64c-24e9-4f6b-9487-39384266bc71`::ref 0 aborti= ng False=20 Thread-208::DEBUG::2015-07-20 16:23:31,027::__init__::500::jsonrpc.JsonRpcS= erver::(_serveRequest) Return 'StoragePool.disconnectStorageServer' in brid= ge with [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]=20 Thread-208::DEBUG::2015-07-20 16:23:31,027::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response=20 JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:31,505::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'>=20 JsonRpcServer::DEBUG::2015-07-20 16:23:31,506::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request=20 Thread-209::DEBUG::2015-07-20 16:23:31,507::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response=20 JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:34,537::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'>=20 JsonRpcServer::DEBUG::2015-07-20 16:23:34,537::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request=20 Thread-210::DEBUG::2015-07-20 16:23:34,538::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response=20 Thanks in advance,=20 Jurri=C3=ABn=20 This message (including any attachments) may contain information that is pr= ivileged or confidential. If you are not the intended recipient, please not= ify the sender and delete this email immediately from your systems and dest= roy all copies of it. You may not, directly or indirectly, use, disclose, d= istribute, print or copy this email or any part of it if you are not the in= tended recipient=20 _______________________________________________ Users mailing list Users@ovirt.org http://lists.ovirt.org/mailman/listinfo/= users=20 _______________________________________________=20 Users mailing list=20 Users@ovirt.org=20 http://lists.ovirt.org/mailman/listinfo/users=20 </blockquote> ------=_Part_136909_782517491.1437895632232 Content-Type: text/html; charset=utf-8 Content-Transfer-Encoding: quoted-printable <html><body><div style=3D"font-family: trebuchet ms,sans-serif; font-size: = 12pt; color: #000000"><div>Hi <span style=3D"font-family: Helvetica, A= rial, sans-serif; font-size: 16.3636360168457px;" data-mce-style=3D"font-fa= mily: Helvetica, Arial, sans-serif; font-size: 16.3636360168457px;">Jurri= =C3=ABn,</span></div><div><span style=3D"font-family: Helvetica, Arial, san= s-serif; font-size: 16.3636360168457px;" data-mce-style=3D"font-family: Hel= vetica, Arial, sans-serif; font-size: 16.3636360168457px;">Did you manage t= o reproduce this?</span></div><div><span style=3D"font-family: Helvetica, A= rial, sans-serif; font-size: 16.3636360168457px;" data-mce-style=3D"font-fa= mily: Helvetica, Arial, sans-serif; font-size: 16.3636360168457px;">What's = the status of you environment?</span></div><div><br></div><div><span name= =3D"x"></span><div><br></div><div><br></div><div><br>Thanks in advance,<br>= Raz Tamir<br>ratamir@redhat.com<br>RedHat Israel</div><div>RHEV-M QE Storag= e team<br></div><span name=3D"x"></span><br></div><hr id=3D"zwchr"><div sty= le=3D"color:#000;font-weight:normal;font-style:normal;text-decoration:none;= font-family:Helvetica,Arial,sans-serif;font-size:12pt;"><b>From: </b>"Raz T= amir" <ratamir@redhat.com><br><b>To: </b>"Jurri=C3=ABn Bloemen" <J= urrien.Bloemen@dmc.amcnetworks.com><br><b>Cc: </b>users@ovirt.org<br><b>= Sent: </b>Tuesday, July 21, 2015 1:43:30 PM<br><b>Subject: </b>Re: [ovirt-u= sers] Error creating a storage domain<br><div><br></div><div style=3D"font-= family: trebuchet ms,sans-serif; font-size: 12pt; color: #000000"><div>Than= ks.</div><div>I see this on newer vdsm version</div><div><br></div><div><p = style=3D"margin: 0px;">vdsm-python-zombiereaper-4.16.21-1.el7ev.noarch<br>v= dsm-4.16.21-1.el7ev.x86_64<br>vdsm-python-4.16.21-1.el7ev.noarch<br>vdsm-cl= i-4.16.21-1.el7ev.noarch<br>vdsm-yajsonrpc-4.16.21-1.el7ev.noarch<br>vdsm-h= ook-vhostmd-4.16.21-1.el7ev.noarch<br>vdsm-hook-ethtool-options-4.16.21-1.e= l7ev.noarch<br>ovirt-node-plugin-vdsm-0.2.0-25.el7ev.noarch<br>vdsm-xmlrpc-= 4.16.21-1.el7ev.noarch<br>vdsm-jsonrpc-4.16.21-1.el7ev.noarch<br>vdsm-reg-4= .16.21-1.el7ev.noarch</p><p style=3D"margin: 0px;"><br></p><p style=3D"marg= in: 0px;">you can can track for updates:</p><p style=3D"margin: 0px;"><a hr= ef=3D"https://bugzilla.redhat.com/show_bug.cgi?id=3D1245147" target=3D"_bla= nk">https://bugzilla.redhat.com/show_bug.cgi?id=3D1245147</a></p><p style= =3D"margin: 0px;"><br></p></div><div><br></div><div><span></span><div><br><= /div><div><br></div><div><br>Thanks in advance,<br>Raz Tamir<br>ratamir@red= hat.com<br>RedHat Israel</div><div>RHEV-M QE Storage team<br></div><span></= span><br></div><hr id=3D"zwchr"><div style=3D"color:#000;font-weight:normal= ;font-style:normal;text-decoration:none;font-family:Helvetica,Arial,sans-se= rif;font-size:12pt;"><b>From: </b>"Jurri=C3=ABn Bloemen" <Jurrien.Bloeme= n@dmc.amcnetworks.com><br><b>To: </b>"Raz Tamir" <ratamir@redhat.com&= gt;<br><b>Cc: </b>users@ovirt.org<br><b>Sent: </b>Tuesday, July 21, 2015 1:= 09:38 PM<br><b>Subject: </b>Re: [ovirt-users] Error creating a storage doma= in<br><div><br></div> <span style=3D"font-family: 'Liberation Sans';">Hi Raz,<br> <br> 4.16.10-8<br> <br> Kind regards,<br> <br> Jurri=C3=ABn Bloemen<br> <br> vdsm-cli-4.16.10-8.gitc937927.el7.noarch<br> vdsm-4.16.10-8.gitc937927.el7.x86_64<br> vdsm-python-zombiereaper-4.16.10-8.gitc937927.el7.noarch<br> vdsm-xmlrpc-4.16.10-8.gitc937927.el7.noarch<br> vdsm-jsonrpc-4.16.10-8.gitc937927.el7.noarch<br> vdsm-reg-4.16.10-8.gitc937927.el7.noarch<br> vdsm-hook-ethtool-options-4.16.10-8.gitc937927.el7.noarch<br> ovirt-node-plugin-vdsm-0.2.2-5.el7.noarch<br> vdsm-python-4.16.10-8.gitc937927.el7.noarch<br> vdsm-yajsonrpc-4.16.10-8.gitc937927.el7.noarch<br> vdsm-gluster-4.16.10-8.gitc937927.el7.noarch<br> <br> </span><br> <div class=3D"moz-cite-prefix">On 21-07-15 12:02, Raz Tamir wrote:<br> </div> <blockquote cite=3D"mid:77945646.1281398.1437472962009.JavaMail.zimbra@redh= at.com"> <div style=3D"font-family: trebuchet ms,sans-serif; font-size: 12pt; color: #000000"> <div>Hi <span style=3D"font-family: Helvetica, Arial, sans-serif; font-size: 16.3636360168457px;"> Jurri=C3=ABn,</span></div> <div>What is the host vdsm version?<br> </div> <div><br> </div> <div><span></span> <div><br> </div> <div><br> </div> <div><br> Thanks in advance,<br> Raz Tamir<br> <a class=3D"moz-txt-link-abbreviated" href=3D"mailto:ratamir@redhat.com" ta= rget=3D"_blank">ratamir@redhat.com</a><br> RedHat Israel</div> <div>RHEV-M QE Storage team<br> </div> <span></span><br> </div> <hr id=3D"zwchr"> <div style=3D"color:#000;font-weight:normal;font-style:normal;text-decorati= on:none;font-family:Helvetica,Arial,sans-serif;font-size:12pt;"> <b>From: </b>"Jurri=C3=ABn Bloemen" <a class=3D"moz-txt-link-rfc2396E" href= =3D"mailto:Jurrien.Bloemen@dmc.amcnetworks.com" target=3D"_blank"> <Jurrien.Bloemen@dmc.amcnetworks.com></a><br> <b>To: </b><a class=3D"moz-txt-link-abbreviated" href=3D"mailto:users@ovirt= .org" target=3D"_blank">users@ovirt.org</a><br> <b>Sent: </b>Tuesday, July 21, 2015 10:57:10 AM<br> <b>Subject: </b>Re: [ovirt-users] Error creating a storage domain<br> <div><br> </div> <small><span style=3D"font-family: 'Liberation Sans';">Hi all,<br> <br> </span><span style=3D"font-family: 'Liberation Sans';">I have to add that t= his is the latest 3.5 version. Adding the other glusterfs storage was done = by an older version of 3.5. I don't know if something has changed in between version?<br> <br> Thanks,<br> <br> Jurri=C3=ABn<br> </span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-websocket-proxy-3.5.3.1-1.el7.centos.noa= rch</span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-release35-004-1.noarch</span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-backend-3.5.3.1-1.el7.centos.noarch</spa= n><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-host-deploy-1.3.1-1.el7.noarch</span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-userportal-3.5.3.1-1.el7.centos.noarch</= span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-jboss-as-7.1.1-1.el7.x86_64</span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-lib-3.5.3.1-1.el7.centos.noarch</span><b= r> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-setup-3.5.3.1-1.el7.centos.noarch</span>= <br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-webadmin-portal-3.5.3.1-1.el7.centos.noa= rch</span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-dbscripts-3.5.3.1-1.el7.centos.noarch</s= pan><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-3.5.3.1-1.el7.centos.noarch</span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-extensions-api-impl-3.5.3.1-1.el7.centos= .noarch</span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-image-uploader-3.5.1-1.el7.centos.noarch</span>= <br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-cli-3.5.0.5-1.el7.centos.noarch</span><b= r> <span style=3D"font-family: 'Liberation Sans';">ovirt-host-deploy-java-1.3.1-1.el7.noarch</span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-iso-uploader-3.5.2-1.el7.centos.noarch</span><b= r> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-setup-base-3.5.3.1-1.el7.centos.noarch</= span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-setup-plugin-ovirt-engine-3.5.3.1-1.el7.= centos.noarch</span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-setup-plugin-websocket-proxy-3.5.3.1-1.e= l7.centos.noarch</span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-restapi-3.5.3.1-1.el7.centos.noarch</spa= n><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-tools-3.5.3.1-1.el7.centos.noarch</span>= <br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-sdk-python-3.5.2.1-1.el7.centos.noarch</= span><br> <span style=3D"font-family: 'Liberation Sans';">ovirt-engine-setup-plugin-ovirt-engine-common-3.5.3.1= -1.el7.centos.noarch</span></small><br> <span style=3D"font-family: 'Liberation Sans';"><br> <br> </span><br> <div class=3D"moz-cite-prefix">On 20-07-15 18:30, Bloemen, Jurri=C3=ABn wro= te:<br> </div> <blockquote cite=3D"mid:D1D2EEF5.56D0%25jurrien.bloemen@dmc.amcnetworks.com= "> <div style=3D"font-size: 14px;"> <p style=3D"margin: 0px; font-family: Calibri;">Hi all,</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> <p style=3D"margin: 0px; font-family: Calibri;">I have some trouble with ad= ding a gluster storage domain:</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> <p style=3D"margin: 0px; font-size: 11px; font-family: 'Arial Unicode MS';"> Error while executing action AddGlusterFsStorageDomain: Error creating a st= orage domain</p> <p style=3D"margin: 0px; font-size: 11px; font-family: 'Arial Unicode MS'; min-height: 15px;"> <br> </p> <p style=3D"margin: 0px; font-family: Calibri;">I have mounted the gluster = volume by hand and that works fine. Also checked the rights and ownership a= nd they are 755 and vdsm:kvm.</p> <p style=3D"margin: 0px; font-family: Calibri;">I also tried to reinstall t= he oVirtH node.</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> <p style=3D"margin: 0px; font-family: Calibri;">May worth of telling is tha= t I already have one gluster mount running perfectly but add a new one does= not work.</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> <p style=3D"margin: 0px; font-family: Calibri;">Can somebody help me?</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> <p style=3D"margin: 0px; font-family: Calibri;">This is the engine.log of t= he oVirt manager:</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:30,766 INFO [org.ovirt.engine.core.bll.storage.AddSt= orageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Lock Acqui= red to object EngineLock [exclusiveLocks=3D key: superstore001-stor.cs.exam= ple.com:/ovirtprd01 value: STORAGE_CONNECTION</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> , sharedLocks=3D ]</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:30,791 INFO [org.ovirt.engine.core.bll.storage.AddSt= orageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Running co= mmand: AddStorageServerConnectionCommand internal: false. Entities affected= : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_STORAGE_DOMAIN with role type ADMIN</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:30,811 INFO [org.ovirt.engine.core.vdsbroker.vdsbrok= er.ConnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [61712435] START= , ConnectStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-= 12b8-4f4d-98a1-49e87443eddc, storagePoolId =3D 00000000-0000-0000-0000-000000000000, storageType =3D GLUSTERFS, conne= ctionList =3D [{ id: null, connection: superstore001-stor.cs.example.com:/o= virtprd01, iqn: null, vfsType: glusterfs, mountOptions: null, nfsVersion: n= ull, nfsRetrans: null, nfsTimeo: null };]), log id: 44c1a9f2</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,074 INFO [org.ovirt.engine.core.vdsbroker.vdsbrok= er.ConnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [61712435] FINIS= H, ConnectStorageServerVDSCommand, return: {00000000-0000-0000-0000-0000000= 00000=3D0}, log id: 44c1a9f2</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,085 INFO [org.ovirt.engine.core.bll.storage.AddSt= orageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Lock freed= to object EngineLock [exclusiveLocks=3D key: superstore001-stor.cs.example= .com:/ovirtprd01 value: STORAGE_CONNECTION</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> , sharedLocks=3D ]</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,138 WARN [org.ovirt.engine.core.dal.job.Execution= MessageDirector] (ajp--127.0.0.1-8702-3) [8d11fec] The message key AddGlust= erFsStorageDomain is missing from bundles/ExecutionMessages</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,156 INFO [org.ovirt.engine.core.bll.storage.AddGl= usterFsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Running comm= and: AddGlusterFsStorageDomainCommand internal: false. Entities affected :&= nbsp; ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_STORAGE_DOMAIN with role type ADMIN</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,183 INFO [org.ovirt.engine.core.vdsbroker.vdsbrok= er.ConnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] START,= ConnectStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-1= 2b8-4f4d-98a1-49e87443eddc, storagePoolId =3D 00000000-0000-0000-0000-000000000000, storageType =3D GLUSTERFS, conne= ctionList =3D [{ id: ece6ad42-be90-4980-98dd-d7ae12cc6709, connection: supe= rstore001-stor.cs.example.com:/ovirtprd01, iqn: null, vfsType: glusterfs, m= ountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 3bb1d8b0</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,207 INFO [org.ovirt.engine.core.vdsbroker.vdsbrok= er.ConnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] FINISH= , ConnectStorageServerVDSCommand, return: {ece6ad42-be90-4980-98dd-d7ae12cc= 6709=3D0}, log id: 3bb1d8b0</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,223 INFO [org.ovirt.engine.core.vdsbroker.vdsbrok= er.CreateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] START, = CreateStorageDomainVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b= 8-4f4d-98a1-49e87443eddc, storageDomain=3DStorageDomainStatic[ovirtprd01, d6df7930-342a-493a-b70b-fb1c52b0828c], args=3Dsuperstore001-stor.cs.exampl= e.com:/ovirtprd01), log id: 42df6467</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,356 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.Cr= eateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Failed in Cr= eateStorageDomainVDS method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,358 INFO [org.ovirt.engine.core.vdsbroker.vdsbrok= er.CreateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command= org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStorageDomainVDSCommand re= turn value </p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> StatusOnlyReturnForXmlRpc [mStatus=3DStatusForXmlRpc [mCode=3D351, mM= essage=3DError creating a storage domain: (u'storageType=3D7, sdUUID=3Dd6df= 7930-342a-493a-b70b-fb1c52b0828c, domainName=3Dovirtprd01, domClass=3D1, ty= peSpecificArg=3Dsuperstore001-stor.cs.example.com:/ovirtprd01 domVersion=3D3',)]]</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,364 INFO [org.ovirt.engine.core.vdsbroker.vdsbrok= er.CreateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] HostNam= e =3D twin189</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,366 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.Cr= eateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command Crea= teStorageDomainVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4f= 4d-98a1-49e87443eddc, storageDomain=3DStorageDomainStatic[ovirtprd01, d6df7930-342a-493a-b70b-fb1c52b0828c], args=3Dsuperstore001-stor.cs.exampl= e.com:/ovirtprd01) execution failed. Exception: VDSErrorException: VDSGener= icException: VDSErrorException: Failed to CreateStorageDomainVDS, error =3D= Error creating a storage domain: (u'storageType=3D7, sdUUID=3Dd6df7930-342a-493a-b70b-fb1c52b0828c, domainName=3Dovirtprd01, do= mClass=3D1, typeSpecificArg=3Dsuperstore001-stor.cs.example.com:/ovirtprd01= domVersion=3D3',), code =3D 351</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,375 INFO [org.ovirt.engine.core.vdsbroker.vdsbrok= er.CreateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] FINISH,= CreateStorageDomainVDSCommand, log id: 42df6467</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,377 ERROR [org.ovirt.engine.core.bll.storage.AddGluster= FsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command org.ovirt= .engine.core.bll.storage.AddGlusterFsStorageDomainCommand throw Vdc Bll exc= eption. With error message VdcBLLException: org.ovirt.engine.core.vdsbroker.vdsbroker.VDSErrorException: VDSGenericExc= eption: VDSErrorException: Failed to CreateStorageDomainVDS, error =3D Erro= r creating a storage domain: (u'storageType=3D7, sdUUID=3Dd6df7930-342a-493= a-b70b-fb1c52b0828c, domainName=3Dovirtprd01, domClass=3D1, typeSpecificArg=3Dsuperstore001-stor.cs.example.com:/ovirtpr= d01 domVersion=3D3',), code =3D 351 (Failed with error StorageDomainCreatio= nError and code 351)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,386 INFO [org.ovirt.engine.core.bll.storage.AddGl= usterFsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command [id= =3Db1e0d0ec-526b-42e4-997f-ff55614e0797]: Compensating NEW_ENTITY_ID of org= .ovirt.engine.core.common.businessentities.StorageDomainDynamic; snapshot: d6df7930-342a-493a-b70b-fb1c52b0828c.</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,390 INFO [org.ovirt.engine.core.bll.storage.AddGl= usterFsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command [id= =3Db1e0d0ec-526b-42e4-997f-ff55614e0797]: Compensating NEW_ENTITY_ID of org= .ovirt.engine.core.common.businessentities.StorageDomainStatic; snapshot: d6df7930-342a-493a-b70b-fb1c52b0828c.</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,397 ERROR [org.ovirt.engine.core.bll.storage.AddGluster= FsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Transaction rolle= d-back for command: org.ovirt.engine.core.bll.storage.AddGlusterFsStorageDo= mainCommand.</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,404 ERROR [org.ovirt.engine.core.dal.dbbroker.auditlogh= andling.AuditLogDirector] (ajp--127.0.0.1-8702-3) [8d11fec] Correlation ID:= 8d11fec, Job ID: 9c59789a-ab38-4171-96c5-3d8da688e2bb, Call Stack: null, C= ustom Event ID: -1, Message: Failed to add Storage Domain ovirtprd01. (User: admin@internal)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,451 INFO [org.ovirt.engine.core.bll.storage.Remov= eStorageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Lock Ac= quired to object EngineLock [exclusiveLocks=3D key: ece6ad42-be90-4980-98dd= -d7ae12cc6709 value: STORAGE_CONNECTION</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> key: superstore001-stor.cs.example.com:/ovirtprd01 value: STORAGE_CONNECTIO= N</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> , sharedLocks=3D ]</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,607 INFO [org.ovirt.engine.core.bll.storage.Remov= eStorageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Running= command: RemoveStorageServerConnectionCommand internal: false. Entities af= fected : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_STORAGE_DOMAIN with role type ADMIN</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,615 INFO [org.ovirt.engine.core.bll.storage.Remov= eStorageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Removin= g connection ece6ad42-be90-4980-98dd-d7ae12cc6709 from database </p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,631 INFO [org.ovirt.engine.core.vdsbroker.vdsbrok= er.DisconnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [406a3269] ST= ART, DisconnectStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad3= 92b6d-12b8-4f4d-98a1-49e87443eddc, storagePoolId =3D 00000000-0000-0000-0000-000000000000, storageType =3D GLUSTERFS, conne= ctionList =3D [{ id: ece6ad42-be90-4980-98dd-d7ae12cc6709, connection: supe= rstore001-stor.cs.example.com:/ovirtprd01, iqn: null, vfsType: glusterfs, m= ountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 372ee09d</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,723 INFO [org.ovirt.engine.core.vdsbroker.vdsbrok= er.DisconnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [406a3269] FI= NISH, DisconnectStorageServerVDSCommand, return: {ece6ad42-be90-4980-98dd-d= 7ae12cc6709=3D0}, log id: 372ee09d</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> 2015-07-20 18:23:31,728 INFO [org.ovirt.engine.core.bll.storage.Remov= eStorageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Lock fr= eed to object EngineLock [exclusiveLocks=3D key: ece6ad42-be90-4980-98dd-d7= ae12cc6709 value: STORAGE_CONNECTION</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> key: superstore001-stor.cs.example.com:/ovirtprd01 value: STORAGE_CONNECTIO= N</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> , sharedLocks=3D ]</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> <p style=3D"margin: 0px; font-family: Calibri;">And this is de vdsm.log of = the hypervisor:</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:25,456::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command= =3D'SEND'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpcServer::DEBUG::2015-07-20 16:23:25,458::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-199::DEBUG::2015-07-20 16:23:25,460::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:28,483::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command= =3D'SEND'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpcServer::DEBUG::2015-07-20 16:23:28,484::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-200::DEBUG::2015-07-20 16:23:28,485::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,124::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command= =3D'SEND'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpcServer::DEBUG::2015-07-20 16:23:30,125::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,125::__init__::469::jsonrpc.JsonRpcS= erver::(_serveRequest) Calling 'StoragePool.connectStorageServer' in bridge= with {u'connectionParams': [{u'id': u'00000000-0000-0000-0000-000000000000= ', u'connection': u'superstore001-stor.cs.example.com:/ovirtprd01', u'iqn': u'', u'user': u'', u'tpgt': u'1', u'vfs_type': u'glusterfs', u'pas= sword': u'', u'port': u''}], u'storagepoolID': u'00000000-0000-0000-0000-00= 0000000000', u'domainType': 7}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,127::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`417462a8-3817-4e44-ac89-20ea4e3c8709`::moving = from state init -> state preparing</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::<a class=3D"moz-txt-link-freetext" href=3D"INFO::2015-07-20" ta= rget=3D"_blank">INFO::2015-07-20</a> 16:23:30,127::logUtils::44::dispatcher= ::(wrapper) Run and protect: connectStorageServer(domType=3D7, spUUID=3Du'0= 0000000-0000-0000-0000-000000000000', conList=3D[{u'port': u'', u'connection': u'superstore001-stor.cs.example.c= om:/ovirtprd01', u'iqn': u'', u'user': u'', u'tpgt': u'1', u'vfs_type': u'g= lusterfs', u'password': '******', u'id': u'00000000-0000-0000-0000-00000000= 0000'}], options=3DNone)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,137::fileUtils::142::Storage.fileUti= ls::(createdir) Creating directory: /rhev/data-center/mnt/glusterSD/superst= ore001-stor.cs.example.com:_ovirtprd01</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,138::mount::227::Storage.Misc.excCmd= ::(_runcmd) /usr/bin/sudo -n /usr/bin/mount -t glusterfs superstore001-stor= .cs.example.com:/ovirtprd01 /rhev/data-center/mnt/glusterSD/superstore001-s= tor.cs.example.com:_ovirtprd01 (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,371::hsm::2375::Storage.HSM::(__pref= etchDomains) glusterDomPath: glusterSD/*</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,377::hsm::2387::Storage.HSM::(__pref= etchDomains) Found SD uuids: ()</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,377::hsm::2443::Storage.HSM::(connec= tStorageServer) knownSDs: {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::<a class=3D"moz-txt-link-freetext" href=3D"INFO::2015-07-20" ta= rget=3D"_blank">INFO::2015-07-20</a> 16:23:30,377::logUtils::47::dispatcher= ::(wrapper) Run and protect: connectStorageServer, Return response: {'statu= slist': [{'status': 0, 'id': u'00000000-0000-0000-0000-000000000000'}]}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,377::task::1191::Storage.TaskManager= .Task::(prepare) Task=3D`417462a8-3817-4e44-ac89-20ea4e3c8709`::finished: {= 'statuslist': [{'status': 0, 'id': u'00000000-0000-0000-0000-000000000000'}= ]}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,377::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`417462a8-3817-4e44-ac89-20ea4e3c8709`::moving = from state preparing -> state finished</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,377::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= }</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,378::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,378::task::993::Storage.TaskManager.= Task::(_decref) Task=3D`417462a8-3817-4e44-ac89-20ea4e3c8709`::ref 0 aborti= ng False</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,378::__init__::500::jsonrpc.JsonRpcS= erver::(_serveRequest) Return 'StoragePool.connectStorageServer' in bridge = with [{'status': 0, 'id': u'00000000-0000-0000-0000-000000000000'}]</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-201::DEBUG::2015-07-20 16:23:30,378::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,497::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command= =3D'SEND'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpcServer::DEBUG::2015-07-20 16:23:30,497::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,497::__init__::469::jsonrpc.JsonRpcS= erver::(_serveRequest) Calling 'StoragePool.connectStorageServer' in bridge= with {u'connectionParams': [{u'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709= ', u'connection': u'superstore001-stor.cs.example.com:/ovirtprd01', u'iqn': u'', u'user': u'', u'tpgt': u'1', u'vfs_type': u'glusterfs', u'pas= sword': u'', u'port': u''}], u'storagepoolID': u'00000000-0000-0000-0000-00= 0000000000', u'domainType': 7}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,498::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`627a1260-b231-493f-b0f1-14c0a8501f49`::moving = from state init -> state preparing</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::<a class=3D"moz-txt-link-freetext" href=3D"INFO::2015-07-20" ta= rget=3D"_blank">INFO::2015-07-20</a> 16:23:30,499::logUtils::44::dispatcher= ::(wrapper) Run and protect: connectStorageServer(domType=3D7, spUUID=3Du'0= 0000000-0000-0000-0000-000000000000', conList=3D[{u'port': u'', u'connection': u'superstore001-stor.cs.example.c= om:/ovirtprd01', u'iqn': u'', u'user': u'', u'tpgt': u'1', u'vfs_type': u'g= lusterfs', u'password': '******', u'id': u'ece6ad42-be90-4980-98dd-d7ae12cc= 6709'}], options=3DNone)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,505::hsm::2375::Storage.HSM::(__pref= etchDomains) glusterDomPath: glusterSD/*</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,511::hsm::2387::Storage.HSM::(__pref= etchDomains) Found SD uuids: ()</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,511::hsm::2443::Storage.HSM::(connec= tStorageServer) knownSDs: {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::<a class=3D"moz-txt-link-freetext" href=3D"INFO::2015-07-20" ta= rget=3D"_blank">INFO::2015-07-20</a> 16:23:30,511::logUtils::47::dispatcher= ::(wrapper) Run and protect: connectStorageServer, Return response: {'statu= slist': [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,511::task::1191::Storage.TaskManager= .Task::(prepare) Task=3D`627a1260-b231-493f-b0f1-14c0a8501f49`::finished: {= 'statuslist': [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}= ]}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,511::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`627a1260-b231-493f-b0f1-14c0a8501f49`::moving = from state preparing -> state finished</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,511::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= }</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,511::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,511::task::993::Storage.TaskManager.= Task::(_decref) Task=3D`627a1260-b231-493f-b0f1-14c0a8501f49`::ref 0 aborti= ng False</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,511::__init__::500::jsonrpc.JsonRpcS= erver::(_serveRequest) Return 'StoragePool.connectStorageServer' in bridge = with [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-203::DEBUG::2015-07-20 16:23:30,512::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,532::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command= =3D'SEND'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpcServer::DEBUG::2015-07-20 16:23:30,533::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,533::__init__::469::jsonrpc.JsonRpcS= erver::(_serveRequest) Calling 'StorageDomain.create' in bridge with {u'nam= e': u'ovirtprd01', u'domainType': 7, u'domainClass': 1, u'typeArgs': u'supe= rstore001-stor.cs.example.com:/ovirtprd01', u'version': u'3', u'storagedomainID': u'd6df7930-342a-493a-b70b-fb1c52b082= 8c'}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,534::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::moving = from state init -> state preparing</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::<a class=3D"moz-txt-link-freetext" href=3D"INFO::2015-07-20" ta= rget=3D"_blank">INFO::2015-07-20</a> 16:23:30,534::logUtils::44::dispatcher= ::(wrapper) Run and protect: createStorageDomain(storageType=3D7, sdUUID=3D= u'd6df7930-342a-493a-b70b-fb1c52b0828c', domainName=3Du'ovirtprd01', typeSpecificArg=3Du'superstore001-stor.cs.exam= ple.com:/ovirtprd01', domClass=3D1, domVersion=3Du'3', options=3DNone)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,534::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)= </p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,534::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,534::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.iscsi.rescan)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,535::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,535::iscsi::403::Storage.ISCSI::(res= can) Performing SCSI scan, this will take up to 30 seconds</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,535::iscsiadm::92::Storage.Misc.excC= md::(_runCmd) /usr/bin/sudo -n /sbin/iscsiadm -m session -R (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,545::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,545::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.hba.rescan)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,545::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,545::hba::53::Storage.HBA::(rescan) = Starting scan</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,545::utils::739::Storage.HBA::(execC= md) /usr/bin/sudo -n /usr/libexec/vdsm/fc-scan (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,565::hba::66::Storage.HBA::(rescan) = Scan finished</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,565::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,565::multipath::128::Storage.Misc.ex= cCmd::(rescan) /usr/bin/sudo -n /sbin/multipath (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,606::multipath::128::Storage.Misc.ex= cCmd::(rescan) SUCCESS: <err> =3D ''; <rc> =3D 0</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::489::Storage.OperationMute= x::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operati= on mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::491::Storage.OperationMute= x::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the op= eration mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::500::Storage.OperationMute= x::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operati= on mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::502::Storage.OperationMute= x::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the op= eration mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::520::Storage.OperationMute= x::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operati= on mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,607::lvm::522::Storage.OperationMute= x::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the op= eration mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,608::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::ERROR::2015-07-20 16:23:30,608::sdc::137::Storage.StorageDomain= Cache::(_findDomain) looking for unfetched domain d6df7930-342a-493a-b70b-f= b1c52b0828c</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::ERROR::2015-07-20 16:23:30,608::sdc::154::Storage.StorageDomain= Cache::(_findUnfetchedDomain) looking for domain d6df7930-342a-493a-b70b-fb= 1c52b0828c</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,608::lvm::365::Storage.OperationMute= x::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex</p=
<p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,609::lvm::288::Storage.Misc.excCmd::= (cmd) /usr/bin/sudo -n /sbin/lvm vgs --config ' devices { preferred_names = =3D ["^/dev/mapper/"] ignore_suspended_devices=3D1 write_cache_state=3D0 di= sable_after_error_count=3D3 obtain_device_list_from_udev=3D0 filter =3D [ '\''a|/dev/mapper/3600304801a8505001cd001f904750aa2|'\'', '\'= 'r|.*|'\'' ] } global { locking_type=3D1 prioritise_write= _locks=3D1 wait_for_locks=3D1 use_lvmetad=3D0 } backup {&= nbsp; retain_min =3D 50 retain_days =3D 0 } ' --noheadings --units b = --nosuffix --separator '|' --ignoreskippedcluster -o uuid,name,attr,size,free,extent_= size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count= ,pv_name d6df7930-342a-493a-b70b-fb1c52b0828c (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,630::lvm::288::Storage.Misc.excCmd::= (cmd) FAILED: <err> =3D ' Volume group "d6df7930-342a-493a-b70b= -fb1c52b0828c" not found\n Skipping volume group d6df7930-342a-493a-b= 70b-fb1c52b0828c\n'; <rc> =3D 5</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::WARNING::2015-07-20 16:23:30,631::lvm::370::Storage.LVM::(_relo= advgs) lvm vgs failed: 5 [] [' Volume group "d6df7930-342a-493a-b70b-= fb1c52b0828c" not found', ' Skipping volume group d6df7930-342a-493a-= b70b-fb1c52b0828c']</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,631::lvm::407::Storage.OperationMute= x::(_reloadvgs) Operation 'lvm reload operation' released the operation mut= ex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::ERROR::2015-07-20 16:23:30,644::sdc::143::Storage.StorageDomain= Cache::(_findDomain) domain d6df7930-342a-493a-b70b-fb1c52b0828c not found<= /p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Traceback (most recent call last):</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/sdc.py", line 141, in _findDomain</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/sdc.py", line 171, in _findUnfetchedDo= main</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> StorageDomainDoesNotExist: Storage domain does not exist: (u'd6df7930-342a-= 493a-b70b-fb1c52b0828c',)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::<a class=3D"moz-txt-link-freetext" href=3D"INFO::2015-07-20" ta= rget=3D"_blank">INFO::2015-07-20</a> 16:23:30,644::nfsSD::69::Storage.Stora= geDomain::(create) sdUUID=3Dd6df7930-342a-493a-b70b-fb1c52b0828c domainName= =3Dovirtprd01 remotePath=3Dsuperstore001-stor.cs.example.com:/ovirtprd01 domClass=3D1</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::ERROR::2015-07-20 16:23:30,659::task::866::Storage.TaskManager.= Task::(_setError) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Unexpected= error</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Traceback (most recent call last):</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/task.py", line 873, in _run</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/logUtils.py", line 45, in wrapper</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/hsm.py", line 2670, in createStorageDo= main</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/nfsSD.py", line 80, in create</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/nfsSD.py", line 49, in _preCreateValid= ation</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/fileSD.py", line 88, in validateFileSy= stemFeatures</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/outOfProcess.py", line 320, in directT= ouch</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/lib/python2.7/site-packages/ioprocess/__init__.py", line = 507, in touch</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/lib/python2.7/site-packages/ioprocess/__init__.py", line = 391, in _sendCommand</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> OSError: [Errno 2] No such file or directory</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,659::task::885::Storage.TaskManager.= Task::(_run) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Task._run: 050e= 9378-ba78-4e6f-b986-0dda7bb09aa7 (7, u'd6df7930-342a-493a-b70b-fb1c52b0828c= ', u'ovirtprd01', u'superstore001-stor.cs.example.com:/ovirtprd01', 1, u'3') {} failed - stopping task</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,659::task::1217::Storage.TaskManager= .Task::(stop) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::stopping in st= ate preparing (force False)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,659::task::993::Storage.TaskManager.= Task::(_decref) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::ref 1 aborti= ng True</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::<a class=3D"moz-txt-link-freetext" href=3D"INFO::2015-07-20" ta= rget=3D"_blank">INFO::2015-07-20</a> 16:23:30,659::task::1171::Storage.Task= Manager.Task::(prepare) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::abor= ting: Task is aborted: u'[Errno 2] No such file or directory' - code 100</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,659::task::1176::Storage.TaskManager= .Task::(prepare) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Prepare: ab= orted: [Errno 2] No such file or directory</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,660::task::993::Storage.TaskManager.= Task::(_decref) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::ref 0 aborti= ng True</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,660::task::928::Storage.TaskManager.= Task::(_doAbort) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Task._doAbo= rt: force False</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,660::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::moving = from state preparing -> state aborting</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,660::task::550::Storage.TaskManager.= Task::(__state_aborting) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::_ab= orting: recover policy none</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,660::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::moving = from state aborting -> state failed</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= }</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::ERROR::2015-07-20 16:23:30,660::dispatcher::79::Storage.Dispatc= her::(wrapper) [Errno 2] No such file or directory</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Traceback (most recent call last):</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/dispatcher.py", line 71, in wrapper</p=
<p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/task.py", line 103, in wrapper</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> File "/usr/share/vdsm/storage/task.py", line 1179, in prepare</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> OSError: [Errno 2] No such file or directory</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-205::DEBUG::2015-07-20 16:23:30,660::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,945::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command= =3D'SEND'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpcServer::DEBUG::2015-07-20 16:23:30,945::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,945::__init__::469::jsonrpc.JsonRpcS= erver::(_serveRequest) Calling 'StoragePool.disconnectStorageServer' in bri= dge with {u'connectionParams': [{u'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6= 709', u'connection': u'superstore001-stor.cs.example.com:/ovirtprd01', u'iqn': u'', u'user': u'', u'tpgt': u'1', u'vfs_type': u'glusterfs', u'pas= sword': u'', u'port': u''}], u'storagepoolID': u'00000000-0000-0000-0000-00= 0000000000', u'domainType': 7}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,946::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`9f38f64c-24e9-4f6b-9487-39384266bc71`::moving = from state init -> state preparing</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::<a class=3D"moz-txt-link-freetext" href=3D"INFO::2015-07-20" ta= rget=3D"_blank">INFO::2015-07-20</a> 16:23:30,947::logUtils::44::dispatcher= ::(wrapper) Run and protect: disconnectStorageServer(domType=3D7, spUUID=3D= u'00000000-0000-0000-0000-000000000000', conList=3D[{u'port': u'', u'connection': u'superstore001-stor.cs.example.c= om:/ovirtprd01', u'iqn': u'', u'user': u'', u'tpgt': u'1', u'vfs_type': u'g= lusterfs', u'password': '******', u'id': u'ece6ad42-be90-4980-98dd-d7ae12cc= 6709'}], options=3DNone)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,947::mount::227::Storage.Misc.excCmd= ::(_runcmd) /usr/bin/sudo -n /usr/bin/umount -f -l /rhev/data-center/mnt/gl= usterSD/superstore001-stor.cs.example.com:_ovirtprd01 (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)= </p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.iscsi.rescan)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,958::iscsi::403::Storage.ISCSI::(res= can) Performing SCSI scan, this will take up to 30 seconds</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,958::iscsiadm::92::Storage.Misc.excC= md::(_runCmd) /usr/bin/sudo -n /sbin/iscsiadm -m session -R (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,971::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,971::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.hba.rescan)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,971::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,971::hba::53::Storage.HBA::(rescan) = Starting scan</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,971::utils::739::Storage.HBA::(execC= md) /usr/bin/sudo -n /usr/libexec/vdsm/fc-scan (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,989::hba::66::Storage.HBA::(rescan) = Scan finished</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,989::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:30,989::multipath::128::Storage.Misc.ex= cCmd::(rescan) /usr/bin/sudo -n /sbin/multipath (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,025::multipath::128::Storage.Misc.ex= cCmd::(rescan) SUCCESS: <err> =3D ''; <rc> =3D 0</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::489::Storage.OperationMute= x::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operati= on mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::491::Storage.OperationMute= x::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the op= eration mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::500::Storage.OperationMute= x::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operati= on mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::502::Storage.OperationMute= x::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the op= eration mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::520::Storage.OperationMute= x::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operati= on mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,026::lvm::522::Storage.OperationMute= x::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the op= eration mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,026::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::<a class=3D"moz-txt-link-freetext" href=3D"INFO::2015-07-20" ta= rget=3D"_blank">INFO::2015-07-20</a> 16:23:31,026::logUtils::47::dispatcher= ::(wrapper) Run and protect: disconnectStorageServer, Return response: {'st= atuslist': [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,026::task::1191::Storage.TaskManager= .Task::(prepare) Task=3D`9f38f64c-24e9-4f6b-9487-39384266bc71`::finished: {= 'statuslist': [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}= ]}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,027::task::595::Storage.TaskManager.= Task::(_updateState) Task=3D`9f38f64c-24e9-4f6b-9487-39384266bc71`::moving = from state preparing -> state finished</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,027::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= }</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,027::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,027::task::993::Storage.TaskManager.= Task::(_decref) Task=3D`9f38f64c-24e9-4f6b-9487-39384266bc71`::ref 0 aborti= ng False</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,027::__init__::500::jsonrpc.JsonRpcS= erver::(_serveRequest) Return 'StoragePool.disconnectStorageServer' in brid= ge with [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-208::DEBUG::2015-07-20 16:23:31,027::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:31,505::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command= =3D'SEND'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpcServer::DEBUG::2015-07-20 16:23:31,506::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-209::DEBUG::2015-07-20 16:23:31,507::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:34,537::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command= =3D'SEND'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> JsonRpcServer::DEBUG::2015-07-20 16:23:34,537::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';"> Thread-210::DEBUG::2015-07-20 16:23:34,538::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> <p style=3D"margin: 0px; font-family: Calibri;">Thanks in advance,</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> <p style=3D"margin: 0px; font-family: Calibri;">Jurri=C3=ABn</p> <p style=3D"margin: 0px; font-family: Calibri; min-height: 17px;"> <br> </p> </div> This message (including any attachments) may contain information that is pr= ivileged or confidential. If you are not the intended recipient, please not= ify the sender and delete this email immediately from your systems and dest= roy all copies of it. You may not, directly or indirectly, use, disclose, distribute, print or copy this emai= l or any part of it if you are not the intended recipient <br> <fieldset class=3D"mimeAttachmentHeader"></fieldset> <br> <pre>_______________________________________________ Users mailing list <a class=3D"moz-txt-link-abbreviated" href=3D"mailto:Users@ovirt.org" targe= t=3D"_blank">Users@ovirt.org</a> <a class=3D"moz-txt-link-freetext" href=3D"http://lists.ovirt.org/mailman/l= istinfo/users" target=3D"_blank">http://lists.ovirt.org/mailman/listinfo/us= ers</a> </pre> </blockquote> <br> <br> _______________________________________________<br> Users mailing list<br> <a class=3D"moz-txt-link-abbreviated" href=3D"mailto:Users@ovirt.org" targe= t=3D"_blank">Users@ovirt.org</a><br> <a class=3D"moz-txt-link-freetext" href=3D"http://lists.ovirt.org/mailman/l= istinfo/users" target=3D"_blank">http://lists.ovirt.org/mailman/listinfo/us= ers</a><br> </div> <div><br> </div> </div> </blockquote> <br> </div><div><br></div></div></div><div><br></div></div></body></html> ------=_Part_136909_782517491.1437895632232--