[ovirt-users] Error creating a storage domain

--_000_D1D2EEF556D0jurrienbloemendmcamcnetworkscom_ Content-Type: text/plain; charset="iso-8859-1" Content-Transfer-Encoding: quoted-printable Hi all, I have some trouble with adding a gluster storage domain: Error while executing action AddGlusterFsStorageDomain: Error creating a st= orage domain 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. I also tried to reinstall the oVirtH node. May worth of telling is that I already have one gluster mount running perfe= ctly but add a new one does not work. Can somebody help me? This is the engine.log of the oVirt manager: 2015-07-20 18:23:30,766 INFO [org.ovirt.engine.core.bll.storage.AddStorage= ServerConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Lock Acquired t= o object EngineLock [exclusiveLocks=3D key: superstore001-stor.cs.example.c= om:/ovirtprd01 value: STORAGE_CONNECTION , sharedLocks=3D ] 2015-07-20 18:23:30,791 INFO [org.ovirt.engine.core.bll.storage.AddStorage= ServerConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Running command= : AddStorageServerConnectionCommand internal: false. Entities affected : I= D: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_STO= RAGE_DOMAIN with role type ADMIN 2015-07-20 18:23:30,811 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Co= nnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [61712435] START, Con= nectStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-= 4f4d-98a1-49e87443eddc, storagePoolId =3D 00000000-0000-0000-0000-000000000= 000, storageType =3D GLUSTERFS, connectionList =3D [{ id: null, connection:= superstore001-stor.cs.example.com:/ovirtprd01, iqn: null, vfsType: gluster= fs, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null = };]), log id: 44c1a9f2 2015-07-20 18:23:31,074 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Co= nnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [61712435] FINISH, Co= nnectStorageServerVDSCommand, return: {00000000-0000-0000-0000-000000000000= =3D0}, log id: 44c1a9f2 2015-07-20 18:23:31,085 INFO [org.ovirt.engine.core.bll.storage.AddStorage= ServerConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Lock freed to o= bject EngineLock [exclusiveLocks=3D key: superstore001-stor.cs.example.com:= /ovirtprd01 value: STORAGE_CONNECTION , sharedLocks=3D ] 2015-07-20 18:23:31,138 WARN [org.ovirt.engine.core.dal.job.ExecutionMessa= geDirector] (ajp--127.0.0.1-8702-3) [8d11fec] The message key AddGlusterFsS= torageDomain is missing from bundles/ExecutionMessages 2015-07-20 18:23:31,156 INFO [org.ovirt.engine.core.bll.storage.AddGluster= FsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Running command: = AddGlusterFsStorageDomainCommand internal: false. Entities affected : ID: = aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_STORAG= E_DOMAIN with role type ADMIN 2015-07-20 18:23:31,183 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Co= nnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] 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: ece6ad42-be90-4980= -98dd-d7ae12cc6709, connection: superstore001-stor.cs.example.com:/ovirtprd= 01, iqn: null, vfsType: glusterfs, mountOptions: null, nfsVersion: null, nf= sRetrans: null, nfsTimeo: null };]), log id: 3bb1d8b0 2015-07-20 18:23:31,207 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Co= nnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] FINISH, Con= nectStorageServerVDSCommand, return: {ece6ad42-be90-4980-98dd-d7ae12cc6709= =3D0}, log id: 3bb1d8b0 2015-07-20 18:23:31,223 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Cr= eateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] START, Creat= eStorageDomainVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4f4= d-98a1-49e87443eddc, storageDomain=3DStorageDomainStatic[ovirtprd01, d6df79= 30-342a-493a-b70b-fb1c52b0828c], args=3Dsuperstore001-stor.cs.example.com:/= ovirtprd01), log id: 42df6467 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 2015-07-20 18:23:31,358 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Cr= eateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command org.= ovirt.engine.core.vdsbroker.vdsbroker.CreateStorageDomainVDSCommand return = value StatusOnlyReturnForXmlRpc [mStatus=3DStatusForXmlRpc [mCode=3D351, mMessag= e=3DError creating a storage domain: (u'storageType=3D7, sdUUID=3Dd6df7930-= 342a-493a-b70b-fb1c52b0828c, domainName=3Dovirtprd01, domClass=3D1, typeSpe= cificArg=3Dsuperstore001-stor.cs.example.com:/ovirtprd01 domVersion=3D3',)]= ] 2015-07-20 18:23:31,364 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Cr= eateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] HostName =3D= twin189 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 2015-07-20 18:23:31,375 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Cr= eateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] FINISH, Crea= teStorageDomainVDSCommand, log id: 42df6467 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) 2015-07-20 18:23:31,386 INFO [org.ovirt.engine.core.bll.storage.AddGluster= FsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command [id=3Db1e= 0d0ec-526b-42e4-997f-ff55614e0797]: Compensating NEW_ENTITY_ID of org.ovirt= .engine.core.common.businessentities.StorageDomainDynamic; snapshot: d6df79= 30-342a-493a-b70b-fb1c52b0828c. 2015-07-20 18:23:31,390 INFO [org.ovirt.engine.core.bll.storage.AddGluster= FsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command [id=3Db1e= 0d0ec-526b-42e4-997f-ff55614e0797]: Compensating NEW_ENTITY_ID of org.ovirt= .engine.core.common.businessentities.StorageDomainStatic; snapshot: d6df793= 0-342a-493a-b70b-fb1c52b0828c. 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. 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) 2015-07-20 18:23:31,451 INFO [org.ovirt.engine.core.bll.storage.RemoveStor= ageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Lock Acquire= d to object EngineLock [exclusiveLocks=3D key: ece6ad42-be90-4980-98dd-d7ae= 12cc6709 value: STORAGE_CONNECTION key: superstore001-stor.cs.example.com:/ovirtprd01 value: STORAGE_CONNECTIO= N , sharedLocks=3D ] 2015-07-20 18:23:31,607 INFO [org.ovirt.engine.core.bll.storage.RemoveStor= ageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Running comm= and: RemoveStorageServerConnectionCommand internal: false. Entities affecte= d : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREA= TE_STORAGE_DOMAIN with role type ADMIN 2015-07-20 18:23:31,615 INFO [org.ovirt.engine.core.bll.storage.RemoveStor= ageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Removing con= nection ece6ad42-be90-4980-98dd-d7ae12cc6709 from database 2015-07-20 18:23:31,631 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Di= sconnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [406a3269] START, = DisconnectStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad392b6d= -12b8-4f4d-98a1-49e87443eddc, storagePoolId =3D 00000000-0000-0000-0000-000= 000000000, storageType =3D GLUSTERFS, connectionList =3D [{ id: ece6ad42-be= 90-4980-98dd-d7ae12cc6709, connection: superstore001-stor.cs.example.com:/o= virtprd01, iqn: null, vfsType: glusterfs, mountOptions: null, nfsVersion: n= ull, nfsRetrans: null, nfsTimeo: null };]), log id: 372ee09d 2015-07-20 18:23:31,723 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.Di= sconnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [406a3269] FINISH,= DisconnectStorageServerVDSCommand, return: {ece6ad42-be90-4980-98dd-d7ae12= cc6709=3D0}, log id: 372ee09d 2015-07-20 18:23:31,728 INFO [org.ovirt.engine.core.bll.storage.RemoveStor= ageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Lock freed t= o object EngineLock [exclusiveLocks=3D key: ece6ad42-be90-4980-98dd-d7ae12c= c6709 value: STORAGE_CONNECTION key: superstore001-stor.cs.example.com:/ovirtprd01 value: STORAGE_CONNECTIO= N , sharedLocks=3D ] And this is de vdsm.log of the hypervisor: JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:25,456::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'> JsonRpcServer::DEBUG::2015-07-20 16:23:25,458::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request Thread-199::DEBUG::2015-07-20 16:23:25,460::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:28,483::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'> JsonRpcServer::DEBUG::2015-07-20 16:23:28,484::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request Thread-200::DEBUG::2015-07-20 16:23:28,485::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,124::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'> JsonRpcServer::DEBUG::2015-07-20 16:23:30,125::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request 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} 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 Thread-201::INFO::2015-07-20 16:23:30,127::logUtils::44::dispatcher::(wrapp= er) Run and protect: connectStorageServer(domType=3D7, spUUID=3Du'00000000-= 0000-0000-0000-000000000000', conList=3D[{u'port': u'', u'connection': u'su= perstore001-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'000= 00000-0000-0000-0000-000000000000'}], options=3DNone) 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 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) Thread-201::DEBUG::2015-07-20 16:23:30,371::hsm::2375::Storage.HSM::(__pref= etchDomains) glusterDomPath: glusterSD/* Thread-201::DEBUG::2015-07-20 16:23:30,377::hsm::2387::Storage.HSM::(__pref= etchDomains) Found SD uuids: () Thread-201::DEBUG::2015-07-20 16:23:30,377::hsm::2443::Storage.HSM::(connec= tStorageServer) knownSDs: {} Thread-201::INFO::2015-07-20 16:23:30,377::logUtils::47::dispatcher::(wrapp= er) Run and protect: connectStorageServer, Return response: {'statuslist': = [{'status': 0, 'id': u'00000000-0000-0000-0000-000000000000'}]} 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'}= ]} 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 Thread-201::DEBUG::2015-07-20 16:23:30,377::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= } Thread-201::DEBUG::2015-07-20 16:23:30,378::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {} 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 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'}] Thread-201::DEBUG::2015-07-20 16:23:30,378::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,497::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'> JsonRpcServer::DEBUG::2015-07-20 16:23:30,497::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request 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} 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 Thread-203::INFO::2015-07-20 16:23:30,499::logUtils::44::dispatcher::(wrapp= er) Run and protect: connectStorageServer(domType=3D7, spUUID=3Du'00000000-= 0000-0000-0000-000000000000', conList=3D[{u'port': u'', u'connection': u'su= perstore001-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'ece= 6ad42-be90-4980-98dd-d7ae12cc6709'}], options=3DNone) Thread-203::DEBUG::2015-07-20 16:23:30,505::hsm::2375::Storage.HSM::(__pref= etchDomains) glusterDomPath: glusterSD/* Thread-203::DEBUG::2015-07-20 16:23:30,511::hsm::2387::Storage.HSM::(__pref= etchDomains) Found SD uuids: () Thread-203::DEBUG::2015-07-20 16:23:30,511::hsm::2443::Storage.HSM::(connec= tStorageServer) knownSDs: {} Thread-203::INFO::2015-07-20 16:23:30,511::logUtils::47::dispatcher::(wrapp= er) Run and protect: connectStorageServer, Return response: {'statuslist': = [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]} 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'}= ]} 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 Thread-203::DEBUG::2015-07-20 16:23:30,511::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= } Thread-203::DEBUG::2015-07-20 16:23:30,511::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {} 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 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'}] Thread-203::DEBUG::2015-07-20 16:23:30,512::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,532::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'> JsonRpcServer::DEBUG::2015-07-20 16:23:30,533::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request 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'} 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 Thread-205::INFO::2015-07-20 16:23:30,534::logUtils::44::dispatcher::(wrapp= er) Run and protect: createStorageDomain(storageType=3D7, sdUUID=3Du'd6df79= 30-342a-493a-b70b-fb1c52b0828c', domainName=3Du'ovirtprd01', typeSpecificAr= g=3Du'superstore001-stor.cs.example.com:/ovirtprd01', domClass=3D1, domVers= ion=3Du'3', options=3DNone) Thread-205::DEBUG::2015-07-20 16:23:30,534::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage) Thread-205::DEBUG::2015-07-20 16:23:30,534::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method Thread-205::DEBUG::2015-07-20 16:23:30,534::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.iscsi.rescan) Thread-205::DEBUG::2015-07-20 16:23:30,535::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method 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 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) Thread-205::DEBUG::2015-07-20 16:23:30,545::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result Thread-205::DEBUG::2015-07-20 16:23:30,545::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.hba.rescan) Thread-205::DEBUG::2015-07-20 16:23:30,545::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method Thread-205::DEBUG::2015-07-20 16:23:30,545::hba::53::Storage.HBA::(rescan) = Starting scan 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) Thread-205::DEBUG::2015-07-20 16:23:30,565::hba::66::Storage.HBA::(rescan) = Scan finished Thread-205::DEBUG::2015-07-20 16:23:30,565::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result 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) Thread-205::DEBUG::2015-07-20 16:23:30,606::multipath::128::Storage.Misc.ex= cCmd::(rescan) SUCCESS: <err> =3D ''; <rc> =3D 0 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 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 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 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 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 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 Thread-205::DEBUG::2015-07-20 16:23:30,608::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result 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 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 Thread-205::DEBUG::2015-07-20 16:23:30,608::lvm::365::Storage.OperationMute= x::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex 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 } ' --n= oheadings --units b --nosuffix --separator '|' --ignoreskippedcluster -o uu= id,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) 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-fb1c52b082= 8c" not found\n Skipping volume group d6df7930-342a-493a-b70b-fb1c52b0828c= \n'; <rc> =3D 5 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-fb1c5= 2b0828c" not found', ' Skipping volume group d6df7930-342a-493a-b70b-fb1c5= 2b0828c'] 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 Thread-205::ERROR::2015-07-20 16:23:30,644::sdc::143::Storage.StorageDomain= Cache::(_findDomain) domain d6df7930-342a-493a-b70b-fb1c52b0828c not found Traceback (most recent call last): File "/usr/share/vdsm/storage/sdc.py", line 141, in _findDomain File "/usr/share/vdsm/storage/sdc.py", line 171, in _findUnfetchedDomain StorageDomainDoesNotExist: Storage domain does not exist: (u'd6df7930-342a-= 493a-b70b-fb1c52b0828c',) Thread-205::INFO::2015-07-20 16:23:30,644::nfsSD::69::Storage.StorageDomain= ::(create) sdUUID=3Dd6df7930-342a-493a-b70b-fb1c52b0828c domainName=3Dovirt= prd01 remotePath=3Dsuperstore001-stor.cs.example.com:/ovirtprd01 domClass= =3D1 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 Traceback (most recent call last): File "/usr/share/vdsm/storage/task.py", line 873, in _run File "/usr/share/vdsm/logUtils.py", line 45, in wrapper File "/usr/share/vdsm/storage/hsm.py", line 2670, in createStorageDomain File "/usr/share/vdsm/storage/nfsSD.py", line 80, in create File "/usr/share/vdsm/storage/nfsSD.py", line 49, in _preCreateValidation File "/usr/share/vdsm/storage/fileSD.py", line 88, in validateFileSystemF= eatures File "/usr/share/vdsm/storage/outOfProcess.py", line 320, in directTouch File "/usr/lib/python2.7/site-packages/ioprocess/__init__.py", line 507, = in touch File "/usr/lib/python2.7/site-packages/ioprocess/__init__.py", line 391, = in _sendCommand OSError: [Errno 2] No such file or directory 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 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) 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 Thread-205::INFO::2015-07-20 16:23:30,659::task::1171::Storage.TaskManager.= Task::(prepare) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::aborting: Ta= sk is aborted: u'[Errno 2] No such file or directory' - code 100 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 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 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 Thread-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {} 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 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 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 Thread-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= } Thread-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-205::ERROR::2015-07-20 16:23:30,660::dispatcher::79::Storage.Dispatc= her::(wrapper) [Errno 2] No such file or directory Traceback (most recent call last): File "/usr/share/vdsm/storage/dispatcher.py", line 71, in wrapper File "/usr/share/vdsm/storage/task.py", line 103, in wrapper File "/usr/share/vdsm/storage/task.py", line 1179, in prepare OSError: [Errno 2] No such file or directory Thread-205::DEBUG::2015-07-20 16:23:30,660::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:30,945::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'> JsonRpcServer::DEBUG::2015-07-20 16:23:30,945::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request 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} 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 Thread-208::INFO::2015-07-20 16:23:30,947::logUtils::44::dispatcher::(wrapp= er) Run and protect: disconnectStorageServer(domType=3D7, spUUID=3Du'000000= 00-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) 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) Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage) Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.iscsi.rescan) Thread-208::DEBUG::2015-07-20 16:23:30,958::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method 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 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) Thread-208::DEBUG::2015-07-20 16:23:30,971::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result Thread-208::DEBUG::2015-07-20 16:23:30,971::misc::741::Storage.SamplingMeth= od::(__call__) Trying to enter sampling method (storage.hba.rescan) Thread-208::DEBUG::2015-07-20 16:23:30,971::misc::743::Storage.SamplingMeth= od::(__call__) Got in to sampling method Thread-208::DEBUG::2015-07-20 16:23:30,971::hba::53::Storage.HBA::(rescan) = Starting scan 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) Thread-208::DEBUG::2015-07-20 16:23:30,989::hba::66::Storage.HBA::(rescan) = Scan finished Thread-208::DEBUG::2015-07-20 16:23:30,989::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result 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) Thread-208::DEBUG::2015-07-20 16:23:31,025::multipath::128::Storage.Misc.ex= cCmd::(rescan) SUCCESS: <err> =3D ''; <rc> =3D 0 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 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 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 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 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 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 Thread-208::DEBUG::2015-07-20 16:23:31,026::misc::751::Storage.SamplingMeth= od::(__call__) Returning last result Thread-208::INFO::2015-07-20 16:23:31,026::logUtils::47::dispatcher::(wrapp= er) Run and protect: disconnectStorageServer, Return response: {'statuslist= ': [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]} 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'}= ]} 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 Thread-208::DEBUG::2015-07-20 16:23:31,027::resourceManager::940::Storage.R= esourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {= } Thread-208::DEBUG::2015-07-20 16:23:31,027::resourceManager::977::Storage.R= esourceManager.Owner::(cancelAll) Owner.cancelAll requests {} 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 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'}] Thread-208::DEBUG::2015-07-20 16:23:31,027::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:31,505::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'> JsonRpcServer::DEBUG::2015-07-20 16:23:31,506::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request Thread-209::DEBUG::2015-07-20 16:23:31,507::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response JsonRpc (StompReactor)::DEBUG::2015-07-20 16:23:34,537::stompReactor::98::B= roker.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'= SEND'> JsonRpcServer::DEBUG::2015-07-20 16:23:34,537::__init__::506::jsonrpc.JsonR= pcServer::(serve_requests) Waiting for request Thread-210::DEBUG::2015-07-20 16:23:34,538::stompReactor::163::yajsonrpc.St= ompServer::(send) Sending response Thanks in advance, Jurri=EBn 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 --_000_D1D2EEF556D0jurrienbloemendmcamcnetworkscom_ Content-Type: text/html; charset="iso-8859-1" Content-ID: <A3B9614D37E8C6449BBC61BC1CA4496A@chellomedia.com> Content-Transfer-Encoding: quoted-printable <html> <head> <meta http-equiv=3D"Content-Type" content=3D"text/html; charset=3Diso-8859-= 1"> </head> <body style=3D"word-wrap: break-word; -webkit-nbsp-mode: space; -webkit-lin= e-break: after-white-space; font-family: Calibri, sans-serif;"> <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 s= torage 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.AddStorag= eServerConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Lock Acquired = 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';">, sh= aredLocks=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.AddStorag= eServerConnectionCommand] (ajp--127.0.0.1-8702-3) [61712435] Running comman= d: 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.vdsbroker.C= onnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [61712435] START, Co= nnectStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4f4d-98a1-49e87443eddc, storagePoolId = =3D 00000000-0000-0000-0000-000000000000, storageType =3D GLUSTERFS, connec= tionList =3D [{ id: null, connection: superstore001-stor.cs.example.com:/ov= irtprd01, iqn: null, vfsType: glusterfs, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 44c= 1a9f2</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.vdsbroker.C= onnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [61712435] FINISH, C= onnectStorageServerVDSCommand, return: {00000000-0000-0000-0000-000000000000=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.AddStorag= eServerConnectionCommand] (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';">, sh= aredLocks=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.ExecutionMess= ageDirector] (ajp--127.0.0.1-8702-3) [8d11fec] The message key AddGlusterFs= StorageDomain 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.AddGluste= rFsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Running command:= AddGlusterFsStorageDomainCommand 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:31,183 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.C= onnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] START, Con= nectStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4f4d-98a1-49e87443eddc, storagePoolId = =3D 00000000-0000-0000-0000-000000000000, storageType =3D GLUSTERFS, connec= tionList =3D [{ id: ece6ad42-be90-4980-98dd-d7ae12cc6709, connection: super= store001-stor.cs.example.com:/ovirtprd01, iqn: null, vfsType: glusterfs, mountOptions: null, nfsVersion: null, nfsRe= trans: 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.vdsbroker.C= onnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] FINISH, Co= nnectStorageServerVDSCommand, return: {ece6ad42-be90-4980-98dd-d7ae12cc6709= =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.vdsbroker.C= reateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] START, Crea= teStorageDomainVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4f4d-98a1-49e87443eddc, storageDomain=3DStorageDo= mainStatic[ovirtprd01, d6df7930-342a-493a-b70b-fb1c52b0828c], args=3Dsupers= tore001-stor.cs.example.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.Create= StorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Failed in Create= StorageDomainVDS 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.vdsbroker.C= reateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command org= .ovirt.engine.core.vdsbroker.vdsbroker.CreateStorageDomainVDSCommand return value </p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p;StatusOnlyReturnForXmlRpc [mStatus=3DStatusForXmlRpc [mCode=3D351, mMessa= ge=3DError creating a storage domain: (u'storageType=3D7, sdUUID=3Dd6df7930= -342a-493a-b70b-fb1c52b0828c, domainName=3Dovirtprd01, domClass=3D1, typeSpecificArg=3Dsuperstore001-stor.cs.example.com:/ovirtpr= d01 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.vdsbroker.C= reateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] HostName = =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.Create= StorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command CreateSt= orageDomainVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4f4d-98a1-49e87443eddc, storageDomain=3DStorageDo= mainStatic[ovirtprd01, d6df7930-342a-493a-b70b-fb1c52b0828c], args=3Dsupers= tore001-stor.cs.example.com:/ovirtprd01) execution failed. Exception: VDSEr= rorException: VDSGenericException: VDSErrorException: Failed to CreateStorageDomainVDS, error =3D Error creating a storage domai= n: (u'storageType=3D7, sdUUID=3Dd6df7930-342a-493a-b70b-fb1c52b0828c, domai= nName=3Dovirtprd01, domClass=3D1, typeSpecificArg=3Dsuperstore001-stor.cs.e= xample.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.vdsbroker.C= reateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-3) [8d11fec] FINISH, Cre= ateStorageDomainVDSCommand, 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.AddGlusterFsSt= orageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command org.ovirt.eng= ine.core.bll.storage.AddGlusterFsStorageDomainCommand throw Vdc Bll exception. With error message VdcBLLException: org.ovirt.eng= ine.core.vdsbroker.vdsbroker.VDSErrorException: VDSGenericException: VDSErr= orException: Failed to CreateStorageDomainVDS, error =3D Error creating a s= torage domain: (u'storageType=3D7, sdUUID=3Dd6df7930-342a-493a-b70b-fb1c52b= 0828c, domainName=3Dovirtprd01, domClass=3D1, typeSpecificArg=3Dsuperstore001-sto= r.cs.example.com:/ovirtprd01 domVersion=3D3',), code =3D 351 (Failed with e= rror StorageDomainCreationError 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.AddGluste= rFsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command [id=3Db1= e0d0ec-526b-42e4-997f-ff55614e0797]: Compensating NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.StorageDoma= inDynamic; 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.AddGluste= rFsStorageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Command [id=3Db1= e0d0ec-526b-42e4-997f-ff55614e0797]: Compensating NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.StorageDoma= inStatic; 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.AddGlusterFsSt= orageDomainCommand] (ajp--127.0.0.1-8702-3) [8d11fec] Transaction rolled-ba= ck for command: org.ovirt.engine.core.bll.storage.AddGlusterFsStorageDomain= Command.</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.auditloghandl= ing.AuditLogDirector] (ajp--127.0.0.1-8702-3) [8d11fec] Correlation ID: 8d1= 1fec, Job ID: 9c59789a-ab38-4171-96c5-3d8da688e2bb, Call Stack: null, Custom Event ID: -1, Message: Failed to add Storage Doma= in 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.RemoveSto= rageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Lock Acquir= ed 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_CONNECTION</p=

<p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">, sh= aredLocks=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.RemoveSto= rageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Running com= mand: RemoveStorageServerConnectionCommand internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123= 456789aaa Type: SystemAction group CREATE_STORAGE_DOMAIN with role type ADM= IN</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.RemoveSto= rageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Removing co= nnection 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.vdsbroker.D= isconnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [406a3269] START,= DisconnectStorageServerVDSCommand(HostName =3D twin189, HostId =3D ad392b6d-12b8-4f4d-98a1-49e87443eddc, storagePoolI= d =3D 00000000-0000-0000-0000-000000000000, storageType =3D GLUSTERFS, conn= ectionList =3D [{ id: ece6ad42-be90-4980-98dd-d7ae12cc6709, connection: sup= erstore001-stor.cs.example.com:/ovirtprd01, iqn: null, vfsType: glusterfs, mountOptions: null, nfsVersion: null, nfsRe= trans: 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.vdsbroker.D= isconnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-3) [406a3269] FINISH= , DisconnectStorageServerVDSCommand, return: {ece6ad42-be90-4980-98dd-d7ae12cc6709=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.RemoveSto= rageServerConnectionCommand] (ajp--127.0.0.1-8702-3) [406a3269] Lock freed = 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_CONNECTION</p=

<p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">, sh= aredLocks=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';">Json= Rpc (StompReactor)::DEBUG::2015-07-20 16:23:25,456::stompReactor::98::Broke= r.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'S= END'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= RpcServer::DEBUG::2015-07-20 16:23:25,458::__init__::506::jsonrpc.JsonRpcSe= rver::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-199::DEBUG::2015-07-20 16:23:25,460::stompReactor::163::yajsonrpc.StompS= erver::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= Rpc (StompReactor)::DEBUG::2015-07-20 16:23:28,483::stompReactor::98::Broke= r.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'S= END'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= RpcServer::DEBUG::2015-07-20 16:23:28,484::__init__::506::jsonrpc.JsonRpcSe= rver::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-200::DEBUG::2015-07-20 16:23:28,485::stompReactor::163::yajsonrpc.StompS= erver::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= Rpc (StompReactor)::DEBUG::2015-07-20 16:23:30,124::stompReactor::98::Broke= r.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'S= END'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= RpcServer::DEBUG::2015-07-20 16:23:30,125::__init__::506::jsonrpc.JsonRpcSe= rver::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,125::__init__::469::jsonrpc.JsonRpcServe= r::(_serveRequest) Calling 'StoragePool.connectStorageServer' in bridge wit= h {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-000000000000= ', u'domainType': 7}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-201::INFO::2015-07-20 16:23:30,127::logUtils::44::dispatcher::(wrapper) = Run and protect: connectStorageServer(domType=3D7, spUUID=3Du'00000000-0000= -0000-0000-000000000000', conList=3D[{u'port': u'', 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'id': u'00000000-0000-0000-0000-000000000000'}], options=3DNo= ne)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,137::fileUtils::142::Storage.fileUtils::= (createdir) Creating directory: /rhev/data-center/mnt/glusterSD/superstore0= 01-stor.cs.example.com:_ovirtprd01</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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-stor.= cs.example.com:_ovirtprd01 (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,371::hsm::2375::Storage.HSM::(__prefetch= Domains) glusterDomPath: glusterSD/*</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,377::hsm::2387::Storage.HSM::(__prefetch= Domains) Found SD uuids: ()</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,377::hsm::2443::Storage.HSM::(connectSto= rageServer) knownSDs: {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-201::INFO::2015-07-20 16:23:30,377::logUtils::47::dispatcher::(wrapper) = Run and protect: connectStorageServer, Return response: {'statuslist': [{'s= tatus': 0, 'id': u'00000000-0000-0000-0000-000000000000'}]}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,377::task::1191::Storage.TaskManager.Tas= k::(prepare) Task=3D`417462a8-3817-4e44-ac89-20ea4e3c8709`::finished: {'sta= tuslist': [{'status': 0, 'id': u'00000000-0000-0000-0000-000000000000'}]}</= p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,377::resourceManager::940::Storage.Resou= rceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}</p=

<p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,378::resourceManager::977::Storage.Resou= rceManager.Owner::(cancelAll) Owner.cancelAll requests {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,378::task::993::Storage.TaskManager.Task= ::(_decref) Task=3D`417462a8-3817-4e44-ac89-20ea4e3c8709`::ref 0 aborting F= alse</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,378::__init__::500::jsonrpc.JsonRpcServe= r::(_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';">Thre= ad-201::DEBUG::2015-07-20 16:23:30,378::stompReactor::163::yajsonrpc.StompS= erver::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= Rpc (StompReactor)::DEBUG::2015-07-20 16:23:30,497::stompReactor::98::Broke= r.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'S= END'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= RpcServer::DEBUG::2015-07-20 16:23:30,497::__init__::506::jsonrpc.JsonRpcSe= rver::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-203::DEBUG::2015-07-20 16:23:30,497::__init__::469::jsonrpc.JsonRpcServe= r::(_serveRequest) Calling 'StoragePool.connectStorageServer' in bridge wit= h {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-000000000000= ', u'domainType': 7}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-203::INFO::2015-07-20 16:23:30,499::logUtils::44::dispatcher::(wrapper) = Run and protect: connectStorageServer(domType=3D7, spUUID=3Du'00000000-0000= -0000-0000-000000000000', conList=3D[{u'port': u'', 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'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}], options=3DNo= ne)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-203::DEBUG::2015-07-20 16:23:30,505::hsm::2375::Storage.HSM::(__prefetch= Domains) glusterDomPath: glusterSD/*</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-203::DEBUG::2015-07-20 16:23:30,511::hsm::2387::Storage.HSM::(__prefetch= Domains) Found SD uuids: ()</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-203::DEBUG::2015-07-20 16:23:30,511::hsm::2443::Storage.HSM::(connectSto= rageServer) knownSDs: {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-203::INFO::2015-07-20 16:23:30,511::logUtils::47::dispatcher::(wrapper) = Run and protect: connectStorageServer, Return response: {'statuslist': [{'s= tatus': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-203::DEBUG::2015-07-20 16:23:30,511::task::1191::Storage.TaskManager.Tas= k::(prepare) Task=3D`627a1260-b231-493f-b0f1-14c0a8501f49`::finished: {'sta= tuslist': [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]}</= p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-203::DEBUG::2015-07-20 16:23:30,511::resourceManager::940::Storage.Resou= rceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}</p=

<p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-203::DEBUG::2015-07-20 16:23:30,511::resourceManager::977::Storage.Resou= rceManager.Owner::(cancelAll) Owner.cancelAll requests {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-203::DEBUG::2015-07-20 16:23:30,511::task::993::Storage.TaskManager.Task= ::(_decref) Task=3D`627a1260-b231-493f-b0f1-14c0a8501f49`::ref 0 aborting F= alse</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-203::DEBUG::2015-07-20 16:23:30,511::__init__::500::jsonrpc.JsonRpcServe= r::(_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';">Thre= ad-203::DEBUG::2015-07-20 16:23:30,512::stompReactor::163::yajsonrpc.StompS= erver::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= Rpc (StompReactor)::DEBUG::2015-07-20 16:23:30,532::stompReactor::98::Broke= r.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'S= END'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= RpcServer::DEBUG::2015-07-20 16:23:30,533::__init__::506::jsonrpc.JsonRpcSe= rver::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,533::__init__::469::jsonrpc.JsonRpcServe= r::(_serveRequest) Calling 'StorageDomain.create' in bridge with {u'name': = u'ovirtprd01', u'domainType': 7, u'domainClass': 1, u'typeArgs': u'superstore001-stor.cs.example.com:/ovirtprd01', u'versio= n': u'3', u'storagedomainID': u'd6df7930-342a-493a-b70b-fb1c52b0828c'}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-205::INFO::2015-07-20 16:23:30,534::logUtils::44::dispatcher::(wrapper) = Run and protect: createStorageDomain(storageType=3D7, sdUUID=3Du'd6df7930-3= 42a-493a-b70b-fb1c52b0828c', domainName=3Du'ovirtprd01', typeSpecificArg=3Du'superstore001-stor.cs.example.com:/ovirtprd01', domCla= ss=3D1, domVersion=3Du'3', options=3DNone)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,534::misc::741::Storage.SamplingMethod::= (__call__) Trying to enter sampling method (storage.sdc.refreshStorage)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,534::misc::743::Storage.SamplingMethod::= (__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,534::misc::741::Storage.SamplingMethod::= (__call__) Trying to enter sampling method (storage.iscsi.rescan)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,535::misc::743::Storage.SamplingMethod::= (__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,535::iscsi::403::Storage.ISCSI::(rescan)= Performing SCSI scan, this will take up to 30 seconds</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,535::iscsiadm::92::Storage.Misc.excCmd::= (_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';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,545::misc::751::Storage.SamplingMethod::= (__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,545::misc::741::Storage.SamplingMethod::= (__call__) Trying to enter sampling method (storage.hba.rescan)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,545::misc::743::Storage.SamplingMethod::= (__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,545::hba::53::Storage.HBA::(rescan) Star= ting scan</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,545::utils::739::Storage.HBA::(execCmd) = /usr/bin/sudo -n /usr/libexec/vdsm/fc-scan (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,565::misc::751::Storage.SamplingMethod::= (__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,565::multipath::128::Storage.Misc.excCmd= ::(rescan) /usr/bin/sudo -n /sbin/multipath (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,606::multipath::128::Storage.Misc.excCmd= ::(rescan) SUCCESS: <err> =3D ''; <rc> =3D 0</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,607::lvm::489::Storage.OperationMutex::(= _invalidateAllPvs) Operation 'lvm invalidate operation' got the operation m= utex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,607::lvm::491::Storage.OperationMutex::(= _invalidateAllPvs) Operation 'lvm invalidate operation' released the operat= ion mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,607::lvm::500::Storage.OperationMutex::(= _invalidateAllVgs) Operation 'lvm invalidate operation' got the operation m= utex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,607::lvm::502::Storage.OperationMutex::(= _invalidateAllVgs) Operation 'lvm invalidate operation' released the operat= ion mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,607::lvm::520::Storage.OperationMutex::(= _invalidateAllLvs) Operation 'lvm invalidate operation' got the operation m= utex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,607::lvm::522::Storage.OperationMutex::(= _invalidateAllLvs) Operation 'lvm invalidate operation' released the operat= ion mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,608::misc::751::Storage.SamplingMethod::= (__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::ERROR::2015-07-20 16:23:30,608::sdc::137::Storage.StorageDomainCach= e::(_findDomain) looking for unfetched domain d6df7930-342a-493a-b70b-fb1c5= 2b0828c</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::ERROR::2015-07-20 16:23:30,608::sdc::154::Storage.StorageDomainCach= e::(_findUnfetchedDomain) looking for domain d6df7930-342a-493a-b70b-fb1c52= b0828c</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,608::lvm::365::Storage.OperationMutex::(= _reloadvgs) Operation 'lvm reload operation' got the operation mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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 disable_after_error_count=3D3 obtain_device_list_fro= m_udev=3D0 filter =3D [ '\''a|/dev/mapper/3600304801a8505001cd001f904750aa2= |'\'', '\''r|.*|'\'' ] }  global {  locking_type=3D1  priori= tise_write_locks=3D1  wait_for_locks=3D1  use_lvmetad=3D0 } = backup {  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_c= ount,pv_count,pv_name d6df7930-342a-493a-b70b-fb1c52b0828c (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,630::lvm::288::Storage.Misc.excCmd::(cmd= ) FAILED: <err> =3D '  Volume group "d6df7930-342a-493a-b70= b-fb1c52b0828c" not found\n  Skipping volume group d6df7930-342a-= 493a-b70b-fb1c52b0828c\n'; <rc> =3D 5</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::WARNING::2015-07-20 16:23:30,631::lvm::370::Storage.LVM::(_reloadvg= s) 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';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,631::lvm::407::Storage.OperationMutex::(= _reloadvgs) Operation 'lvm reload operation' released the operation mutex</= p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::ERROR::2015-07-20 16:23:30,644::sdc::143::Storage.StorageDomainCach= e::(_findDomain) domain d6df7930-342a-493a-b70b-fb1c52b0828c not found</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Trac= eback (most recent call last):</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/sdc.py", line 141, in _findDomai= n</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/sdc.py", line 171, in _findUnfet= chedDomain</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Stor= ageDomainDoesNotExist: Storage domain does not exist: (u'd6df7930-342a-493a= -b70b-fb1c52b0828c',)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::INFO::2015-07-20 16:23:30,644::nfsSD::69::Storage.StorageDomain::(c= reate) sdUUID=3Dd6df7930-342a-493a-b70b-fb1c52b0828c domainName=3Dovirtprd0= 1 remotePath=3Dsuperstore001-stor.cs.example.com:/ovirtprd01 domClass=3D1</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::ERROR::2015-07-20 16:23:30,659::task::866::Storage.TaskManager.Task= ::(_setError) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Unexpected err= or</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Trac= eback (most recent call last):</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/task.py", line 873, in _run</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/logUtils.py", line 45, in wrapper</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/hsm.py", line 2670, in createSto= rageDomain</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/nfsSD.py", line 80, in create</p=

<p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/nfsSD.py", line 49, in _preCreat= eValidation</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/fileSD.py", line 88, in validate= FileSystemFeatures</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/outOfProcess.py", line 320, in d= irectTouch</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; 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';">&nbs= p; 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';">OSEr= ror: [Errno 2] No such file or directory</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,659::task::885::Storage.TaskManager.Task= ::(_run) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Task._run: 050e9378= -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';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,659::task::1217::Storage.TaskManager.Tas= k::(stop) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::stopping in state = preparing (force False)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,659::task::993::Storage.TaskManager.Task= ::(_decref) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::ref 1 aborting T= rue</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::INFO::2015-07-20 16:23:30,659::task::1171::Storage.TaskManager.Task= ::(prepare) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::aborting: Task i= s aborted: u'[Errno 2] No such file or directory' - code 100</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,659::task::1176::Storage.TaskManager.Tas= k::(prepare) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Prepare: aborte= d: [Errno 2] No such file or directory</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,660::task::993::Storage.TaskManager.Task= ::(_decref) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::ref 0 aborting T= rue</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,660::task::928::Storage.TaskManager.Task= ::(_doAbort) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::Task._doAbort: = force False</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::977::Storage.Resou= rceManager.Owner::(cancelAll) Owner.cancelAll requests {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,660::task::550::Storage.TaskManager.Task= ::(__state_aborting) Task=3D`050e9378-ba78-4e6f-b986-0dda7bb09aa7`::_aborti= ng: recover policy none</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::940::Storage.Resou= rceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}</p=

<p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,660::resourceManager::977::Storage.Resou= rceManager.Owner::(cancelAll) Owner.cancelAll requests {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::ERROR::2015-07-20 16:23:30,660::dispatcher::79::Storage.Dispatcher:= :(wrapper) [Errno 2] No such file or directory</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Trac= eback (most recent call last):</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/dispatcher.py", line 71, in wrap= per</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/task.py", line 103, in wrapper</= p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">&nbs= p; File "/usr/share/vdsm/storage/task.py", line 1179, in prepare<= /p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">OSEr= ror: [Errno 2] No such file or directory</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-205::DEBUG::2015-07-20 16:23:30,660::stompReactor::163::yajsonrpc.StompS= erver::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= Rpc (StompReactor)::DEBUG::2015-07-20 16:23:30,945::stompReactor::98::Broke= r.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'S= END'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= RpcServer::DEBUG::2015-07-20 16:23:30,945::__init__::506::jsonrpc.JsonRpcSe= rver::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,945::__init__::469::jsonrpc.JsonRpcServe= r::(_serveRequest) Calling 'StoragePool.disconnectStorageServer' in bridge = with {u'connectionParams': [{u'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709', u'connection': u'superstore001-st= or.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-000000000000', u'domainType': 7}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-208::INFO::2015-07-20 16:23:30,947::logUtils::44::dispatcher::(wrapper) = Run and protect: disconnectStorageServer(domType=3D7, spUUID=3Du'00000000-0= 000-0000-0000-000000000000', conList=3D[{u'port': u'', 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'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}], options=3DNo= ne)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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/gluste= rSD/superstore001-stor.cs.example.com:_ovirtprd01 (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,958::misc::741::Storage.SamplingMethod::= (__call__) Trying to enter sampling method (storage.sdc.refreshStorage)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,958::misc::743::Storage.SamplingMethod::= (__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,958::misc::741::Storage.SamplingMethod::= (__call__) Trying to enter sampling method (storage.iscsi.rescan)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,958::misc::743::Storage.SamplingMethod::= (__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,958::iscsi::403::Storage.ISCSI::(rescan)= Performing SCSI scan, this will take up to 30 seconds</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,958::iscsiadm::92::Storage.Misc.excCmd::= (_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';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,971::misc::751::Storage.SamplingMethod::= (__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,971::misc::741::Storage.SamplingMethod::= (__call__) Trying to enter sampling method (storage.hba.rescan)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,971::misc::743::Storage.SamplingMethod::= (__call__) Got in to sampling method</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,971::hba::53::Storage.HBA::(rescan) Star= ting scan</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,971::utils::739::Storage.HBA::(execCmd) = /usr/bin/sudo -n /usr/libexec/vdsm/fc-scan (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,989::misc::751::Storage.SamplingMethod::= (__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:30,989::multipath::128::Storage.Misc.excCmd= ::(rescan) /usr/bin/sudo -n /sbin/multipath (cwd None)</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,025::multipath::128::Storage.Misc.excCmd= ::(rescan) SUCCESS: <err> =3D ''; <rc> =3D 0</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,026::lvm::489::Storage.OperationMutex::(= _invalidateAllPvs) Operation 'lvm invalidate operation' got the operation m= utex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,026::lvm::491::Storage.OperationMutex::(= _invalidateAllPvs) Operation 'lvm invalidate operation' released the operat= ion mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,026::lvm::500::Storage.OperationMutex::(= _invalidateAllVgs) Operation 'lvm invalidate operation' got the operation m= utex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,026::lvm::502::Storage.OperationMutex::(= _invalidateAllVgs) Operation 'lvm invalidate operation' released the operat= ion mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,026::lvm::520::Storage.OperationMutex::(= _invalidateAllLvs) Operation 'lvm invalidate operation' got the operation m= utex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,026::lvm::522::Storage.OperationMutex::(= _invalidateAllLvs) Operation 'lvm invalidate operation' released the operat= ion mutex</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,026::misc::751::Storage.SamplingMethod::= (__call__) Returning last result</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::INFO::2015-07-20 16:23:31,026::logUtils::47::dispatcher::(wrapper) = Run and protect: disconnectStorageServer, Return response: {'statuslist': [= {'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,026::task::1191::Storage.TaskManager.Tas= k::(prepare) Task=3D`9f38f64c-24e9-4f6b-9487-39384266bc71`::finished: {'sta= tuslist': [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]}</= p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-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';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,027::resourceManager::940::Storage.Resou= rceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}</p=

<p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,027::resourceManager::977::Storage.Resou= rceManager.Owner::(cancelAll) Owner.cancelAll requests {}</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,027::task::993::Storage.TaskManager.Task= ::(_decref) Task=3D`9f38f64c-24e9-4f6b-9487-39384266bc71`::ref 0 aborting F= alse</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,027::__init__::500::jsonrpc.JsonRpcServe= r::(_serveRequest) Return 'StoragePool.disconnectStorageServer' in bridge w= ith [{'status': 0, 'id': u'ece6ad42-be90-4980-98dd-d7ae12cc6709'}]</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-208::DEBUG::2015-07-20 16:23:31,027::stompReactor::163::yajsonrpc.StompS= erver::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= Rpc (StompReactor)::DEBUG::2015-07-20 16:23:31,505::stompReactor::98::Broke= r.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'S= END'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= RpcServer::DEBUG::2015-07-20 16:23:31,506::__init__::506::jsonrpc.JsonRpcSe= rver::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-209::DEBUG::2015-07-20 16:23:31,507::stompReactor::163::yajsonrpc.StompS= erver::(send) Sending response</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= Rpc (StompReactor)::DEBUG::2015-07-20 16:23:34,537::stompReactor::98::Broke= r.StompAdapter::(handle_frame) Handling message <StompFrame command=3D'S= END'></p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Json= RpcServer::DEBUG::2015-07-20 16:23:34,537::__init__::506::jsonrpc.JsonRpcSe= rver::(serve_requests) Waiting for request</p> <p style=3D"margin: 0px; font-size: 10px; font-family: 'Courier New';">Thre= ad-210::DEBUG::2015-07-20 16:23:34,538::stompReactor::163::yajsonrpc.StompS= erver::(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=EBn</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 </body> </html> --_000_D1D2EEF556D0jurrienbloemendmcamcnetworkscom_--