legacy-wiki
Lab RHEV Adding new storage
Recovered from the older tannerjc.net wiki snapshot dated January 23, 2016.
RHEV M Adding a new FCP Storage Domain
Storage New Domain FCP
Retrieving LUNs
repoStats()
From the VDSM logs we can see:
Run and protect: repoStats, Return response: {'status': {'message': 'OK', 'code': 0}}
repoStats() is defined in hsm.py
def public_repoStats(self, options = None):
Collects a storage repository's information and stats.
:param options: ?
:returns: result
In the context of adding a new LUN repoStats seems to be done in order to check the status of existing storage from the StoragePool
getDeviceList()
From the VDSM logs the next command run
Run and protect: getDeviceList, args: ( storageType=2)
getDeviceList definition from hsm.py
def public_getDeviceList(self, storageType=None, options = None):
List all Block Devices.
:param storageType: Filter by storage type.
:type storageType: Some enum?
:param options: ?
:returns: Dict containing a list of all the devices of the storage type specified.
:rtype: dict
vars.task.setDefaultException(se.BlockDeviceActionError())
#getSharedLock(connectionsResource...)
SDF.refreshStorage()
devices = []
multipathStatus = multipath.getStatus() -----getStatus() is called from inside getDeviceList
devices = pv.PV.getAllPVs(multipathStatus.iterkeys())
devs = []
snip
getStatus()
getStatus() seems to be the function that parses the multipath -ll output
getStatus() definition from multipath.py
MULTIPATH_DEVICE_HEADER = re.compile(r^\s*(?Pguid[^\s]*)\s+(?Pdmdm-[\d]+)\s+(?Pvendor[^,]*?)\s*,\s*(?Pproduct[^.]*?)\s*$)
MULTIPATH_PATH_LINE = re.compile(r^\s*\\_\s*[^\s*]+\s+\d+\s+\[prio=\d+\]\[\w+\]\s*$)
MULTIPATH_DEVICE_LINE = re.compile(r^\s*\\_\s*\d+:\d+:\d+:(?Plun\d+)\s+(?Pphysdev\w+)\s+\d+:\d+\s+\[(?Pstate\w+)\]\s*\[\w+\]\s*$)
def getStatus(filter=None):
results = {}
knownSessions = {}
sizes = getMpathDeviceCapacity()
cmd = [constants.EXT_MULTIPATH, -ll]
(rc, out, err) = misc.execCmd(cmd)
if rc:
return results
i = 0
outLength = len(out)
while i outLength:
match = MULTIPATH_DEVICE_HEADER.match(out[i])
if match is None:
i += 1
continue
devHeader = match.groupdict()
guid = devHeader[guid]
if filter is not None and guid not in filter:
i += 1
continue
results[guid] = { vendor : devHeader[vendor],
product : devHeader[product],
serial : ,
devtype : [],
connections : [],
paths : [],
size : str(sizes.get(devHeader[dm], 0))
}
# Skip the next line
# it contains nothing of importance
i += 2
while True:
if i = outLength:
break
match = MULTIPATH_PATH_LINE.match(out[i])
if match is None:
break
i += 1
while True:
if i = outLength:
break
match = MULTIPATH_DEVICE_LINE.match(out[i])
if match is None:
break
devLine = match.groupdict()
physdev = devLine[physdev]
if not os.path.exists(os.path.join(/dev, physdev)):
log.warning((pathinfo) no such physdev %s: '%s' is ignored % (physdev, out[i]))
continue
results[guid][paths].append(devLine)
if iscsi.devIsiSCSI(physdev):
results[guid][devtype].append(DEV_ISCSI)
sessionID = iscsi.getiScsiSession(physdev)
if sessionID not in knownSessions:
if sessionID not in knownSessions:
knownSessions[sessionID] = iscsi.getdeviSCSIinfo(physdev)
results[guid][connections].append(knownSessions[sessionID])
else:
results[guid][devtype].append(DEV_FCP)
if results[guid][serial] == :
results[guid][serial] = getSerial(physdev)
i += 1
if results[guid][devtype]:
results[guid][devtype] = reduce(deduceType, results[guid][devtype])
return results
VDSM logs with user_friendly_names yes
Thread-49693::INFO::2011-05-18 17:37:39,009::dispatcher::101::irs::Run and protect: repoStats, Return response: {'status': {'message': 'OK', 'code': 0}}
Thread-49697::INFO::2011-05-18 17:37:44,745::dispatcher::95::irs::Run and protect: getDeviceList, args: ( storageType=2)
Thread-49697::DEBUG::2011-05-18 17:37:44,745::task::577::irs::Task 17d9d006-a99c-40e4-bd39-1c46666e22f2: moving from state init - state preparing
Thread-49697::DEBUG::2011-05-18 17:37:44,745::misc::701::SamplingMethod::Trying to enter rescan
Thread-49697::DEBUG::2011-05-18 17:37:44,746::misc::704::SamplingMethod::Performing rescan
Thread-49697::DEBUG::2011-05-18 17:37:44,746::misc::100::irs::'/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:44,787::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:44,788::misc::713::SamplingMethod::Returning last result for rescan
Thread-49697::DEBUG::2011-05-18 17:37:44,788::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host11/scan' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:44,823::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.004274 seconds, 1.2 kB/s\n'; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:44,823::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.004274 seconds, 1.2 kB/s'], size
: 5
Thread-49697::DEBUG::2011-05-18 17:37:44,823::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host10/scan' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:44,854::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 2.2e-05 seconds, 227 kB/s\n'; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:44,854::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 2.2e-05 seconds, 227 kB/s'], size: 5
Thread-49697::DEBUG::2011-05-18 17:37:44,854::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host9/scan' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:44,885::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 2.9e-05 seconds, 172 kB/s\n'; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:44,886::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 2.9e-05 seconds, 172 kB/s'], size: 5
Thread-49697::DEBUG::2011-05-18 17:37:44,886::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host6/scan' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:44,917::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.000521 seconds, 9.6 kB/s\n'; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:44,917::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.000521 seconds, 9.6 kB/s'], size: 5
Thread-49697::DEBUG::2011-05-18 17:37:44,917::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host5/scan' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:44,947::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 5.6e-05 seconds, 89.3 kB/s\n'; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:44,948::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 5.6e-05 seconds, 89.3 kB/s'], size: 5
Thread-49697::DEBUG::2011-05-18 17:37:44,948::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host4/scan' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:44,978::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.000286 seconds, 17.5 kB/s\n'; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:44,978::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.000286 seconds, 17.5 kB/s'], size: 5
Thread-49697::DEBUG::2011-05-18 17:37:44,979::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host3/scan' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:45,009::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.000245 seconds, 20.4 kB/s\n'; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:45,009::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.000245 seconds, 20.4 kB/s'], size: 5
Thread-49697::DEBUG::2011-05-18 17:37:45,009::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host2/scan' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:45,039::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 3.9e-05 seconds, 128 kB/s\n'; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:45,039::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 3.9e-05 seconds, 128 kB/s'], size: 5
Thread-49697::DEBUG::2011-05-18 17:37:45,040::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host1/scan' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:45,232::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.162157 seconds, 0.0 kB/s\n'; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:45,232::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.162157 seconds, 0.0 kB/s'], size: 5
Thread-49697::DEBUG::2011-05-18 17:37:45,232::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host0/scan' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:45,426::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.164285 seconds, 0.0 kB/s\n'; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:45,426::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.164285 seconds, 0.0 kB/s'], size: 5
Thread-49697::DEBUG::2011-05-18 17:37:45,427::misc::100::irs::'/usr/bin/sudo -n /sbin/multipath' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:45,498::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:45,498::misc::100::irs::'/usr/bin/sudo -n /sbin/dmsetup ls --target multipath' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:45,529::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:45,530::misc::100::irs::'/usr/bin/sudo -n /usr/sbin/vgscan --config devices { preferred_names = [\\^/dev/mapper/\\] write_cache_state=0 filter = [ \\a%/dev/mapper/mpath0|/dev/mapper/mpath1|/dev/mapper/mpath2|/dev/mapper/mpath3%\\, \\r%.*%\\ ] } backup { retain_min = 50 retain_days = 0 } ' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:45,583::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:45,584::misc::100::irs::'/usr/bin/sudo -n /sbin/multipath -ll' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:45,630::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:45,631::misc::100::irs::'/usr/bin/sudo -n /usr/sbin/pvs --config devices { preferred_names = [\\^/dev/mapper/\\] write_cache_state=0 filter = [ \\r%.*%\\ ] } backup { retain_min = 50 retain_days = 0 } --noheadings -o pv_name,pv_uuid,dev_size,vg_uuid,pv_pe_count,pv_pe_alloc_count --units b --nosuffix' (cwd None)
Thread-49697::DEBUG::2011-05-18 17:37:45,673::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-49697::DEBUG::2011-05-18 17:37:45,673::task::577::irs::Task 17d9d006-a99c-40e4-bd39-1c46666e22f2: finished: {'devList': []}
Thread-49697::DEBUG::2011-05-18 17:37:45,673::task::577::irs::Task 17d9d006-a99c-40e4-bd39-1c46666e22f2: moving from state preparing - state finished
Thread-49697::DEBUG::2011-05-18 17:37:45,674::resource::670::irs::Owner.releaseAll requests [] resources []
Thread-49697::DEBUG::2011-05-18 17:37:45,674::task::577::irs::Task 17d9d006-a99c-40e4-bd39-1c46666e22f2: ref 0 aborting False
Thread-49697::INFO::2011-05-18 17:37:45,674::dispatcher::101::irs::Run and protect: getDeviceList, Return response: {'status': {'message': 'OK', 'code': 0}, 'devList': []}
VDSM logs with user_friendly_names no
Thread-56882::INFO::2011-05-18 21:00:01,777::dispatcher::101::irs::Run and protect: repoStats, Return response: {'status': {'message': 'OK', 'code': 0}}
Thread-56888::INFO::2011-05-18 21:00:09,302::dispatcher::95::irs::Run and protect: getDeviceList, args: ( storageType=2)
Thread-56888::DEBUG::2011-05-18 21:00:09,302::task::577::irs::Task daff5362-3b92-4aa8-b07b-8a3bb3a72f1b: moving from state init - state preparing
Thread-56888::DEBUG::2011-05-18 21:00:09,302::misc::701::SamplingMethod::Trying to enter rescan
Thread-56888::DEBUG::2011-05-18 21:00:09,302::misc::704::SamplingMethod::Performing rescan
Thread-56888::DEBUG::2011-05-18 21:00:09,303::misc::100::irs::'/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,344::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,345::misc::713::SamplingMethod::Returning last result for rescan
Thread-56888::DEBUG::2011-05-18 21:00:09,345::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host11/scan' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,380::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.004379 seconds, 1.1 kB/s\n'; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,381::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.004379 seconds, 1.1 kB/s'], size: 5
Thread-56888::DEBUG::2011-05-18 21:00:09,381::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host10/scan' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,411::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 2.6e-05 seconds, 192 kB/s\n'; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,411::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 2.6e-05 seconds, 192 kB/s'], size: 5
Thread-56888::DEBUG::2011-05-18 21:00:09,411::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host9/scan' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,441::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 3.1e-05 seconds, 161 kB/s\n'; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,441::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 3.1e-05 seconds, 161 kB/s'], size: 5
Thread-56888::DEBUG::2011-05-18 21:00:09,442::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host6/scan' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,472::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.000517 seconds, 9.7 kB/s\n'; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,472::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.000517 seconds, 9.7 kB/s'], size: 5
Thread-56888::DEBUG::2011-05-18 21:00:09,472::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host5/scan' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,502::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 6.2e-05 seconds, 80.6 kB/s\n'; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,503::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 6.2e-05 seconds, 80.6 kB/s'], size: 5
Thread-56888::DEBUG::2011-05-18 21:00:09,503::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host4/scan' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,534::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.000282 seconds, 17.7 kB/s\n'; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,534::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.000282 seconds, 17.7 kB/s'], size: 5
Thread-56888::DEBUG::2011-05-18 21:00:09,534::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host3/scan' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,565::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.000241 seconds, 20.7 kB/s\n'; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,565::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.000241 seconds, 20.7 kB/s'], size: 5
Thread-56888::DEBUG::2011-05-18 21:00:09,565::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host2/scan' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,595::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 3.8e-05 seconds, 132 kB/s\n'; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,596::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 3.8e-05 seconds, 132 kB/s'], size: 5
Thread-56888::DEBUG::2011-05-18 21:00:09,596::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host1/scan' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,788::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.162106 seconds, 0.0 kB/s\n'; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,789::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.162106 seconds, 0.0 kB/s'], size: 5
Thread-56888::DEBUG::2011-05-18 21:00:09,789::misc::100::irs::'/usr/bin/sudo -n /bin/dd of=/sys/class/scsi_host/host0/scan' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:09,983::misc::123::irs::SUCCESS: err = '0+1 records in\n0+1 records out\n5 bytes (5 B) copied, 0.164685 seconds, 0.0 kB/s\n'; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:09,984::misc::291::irs::(validateDDBytes) err: ['0+1 records in', '0+1 records out', '5 bytes (5 B) copied, 0.164685 seconds, 0.0 kB/s'], size: 5
Thread-56888::DEBUG::2011-05-18 21:00:09,984::misc::100::irs::'/usr/bin/sudo -n /sbin/multipath' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:10,115::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:10,115::misc::100::irs::'/usr/bin/sudo -n /sbin/dmsetup ls --target multipath' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:10,149::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:10,150::misc::100::irs::'/usr/bin/sudo -n /usr/sbin/vgscan --config devices { preferred_names = [\\^/dev/mapper/\\] write_cache_state=0 filter = [ \\a%/dev/mapper/360014380125989a10000400000480000|/dev/mapper/360014380125989a100004000004c0000|/dev/mapper/360014380125989a10000400000500000|/dev/mapper/mpath0%\\, \\r%.*%\\ ] } backup { retain_min = 50 retain_days = 0 } ' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:10,248::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:10,249::misc::100::irs::'/usr/bin/sudo -n /sbin/multipath -ll' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:10,297::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:10,298::misc::100::irs::'/usr/bin/sudo -n /sbin/scsi_id -p 0x80 -guxs /block/sdh' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:10,330::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:10,332::misc::100::irs::'/usr/bin/sudo -n /sbin/scsi_id -p 0x80 -guxs /block/sdf' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:10,332::misc::100::irs::'/usr/bin/sudo -n /sbin/scsi_id -p 0x80 -guxs /block/sdf' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:10,364::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:10,366::misc::100::irs::'/usr/bin/sudo -n /sbin/scsi_id -p 0x80 -guxs /block/sdd' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:10,397::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:10,399::misc::100::irs::'/usr/bin/sudo -n /usr/sbin/pvs --config devices { preferred_names = [\\^/dev/mapper/\\] write_cache_state=0 filter = [ \\a%360014380125989a10000400000480000|360014380125989a100004000004c0000|360014380125989a10000400000500000%\\, \\r%.*%\\ ] } backup { retain_min = 50 retain_days = 0 } --noheadings -o pv_name,pv_uuid,dev_size,vg_uuid,pv_pe_count,pv_pe_alloc_count --units b --nosuffix' (cwd None)
Thread-56888::DEBUG::2011-05-18 21:00:10,446::misc::123::irs::SUCCESS: err = ''; rc = 0
Thread-56888::DEBUG::2011-05-18 21:00:10,447::task::577::irs::Task daff5362-3b92-4aa8-b07b-8a3bb3a72f1b: finished: {'devList': [{'vendorID': 'HP', 'capacity': '107374182400', 'fwrev': '0000', 'vgUUID': '', 'pathlist': [], 'pathstatus': [{'physdev': 'sdh', 'state': 'active', 'lun': '3'}, {'physdev': 'sdn', 'state': 'active', 'lun': '3'}, {'physdev': 'sde', 'state': 'active', 'lun': '3'}, {'physdev': 'sdk', 'state': 'active', 'lun': '3'}], 'devtype': 'FCP', 'pvUUID': '', 'serial': 'SHP_HSV300_PAXPVG79S0D081', 'GUID': '360014380125989a10000400000500000', 'productID': 'HSV300'}, {'vendorID': 'HP', 'capacity': '107374182400', 'fwrev': '0000', 'vgUUID': '', 'pathlist': [], 'pathstatus': [{'physdev': 'sdf', 'state': 'active', 'lun': '1'}, {'physdev': 'sdl', 'state': 'active', 'lun': '1'}, {'physdev': 'sdc', 'state': 'active', 'lun': '1'}, {'physdev': 'sdi', 'state': 'active', 'lun': '1'}], 'devtype': 'FCP', 'pvUUID': '', 'serial': 'SHP_HSV300_PAXPVG79S0D081', 'GUID': '360014380125989a10000400000480000', 'productID': 'HSV300'}, {'vendorID': 'HP', 'capacity': '107374182400', 'fwrev': '0000', 'vgUUID': '', 'pathlist': [], 'pathstatus': [{'physdev': 'sdd', 'state': 'active', 'lun': '2'}, {'physdev': 'sdj', 'state': 'active', 'lun': '2'}, {'physdev': 'sdg', 'state': 'active', 'lun': '2'}, {'physdev': 'sdm', 'state': 'active', 'lun': '2'}], 'devtype': 'FCP', 'pvUUID': '', 'serial': 'SHP_HSV300_PAXPVG79S0D06V', 'GUID': '360014380125989a100004000004c0000', 'productID': 'HSV300'}]}
Thread-56888::DEBUG::2011-05-18 21:00:10,447::task::577::irs::Task daff5362-3b92-4aa8-b07b-8a3bb3a72f1b: moving from state preparing - state finished
Thread-56888::DEBUG::2011-05-18 21:00:10,447::resource::670::irs::Owner.releaseAll requests [] resources []
Thread-56888::DEBUG::2011-05-18 21:00:10,448::task::577::irs::Task daff5362-3b92-4aa8-b07b-8a3bb3a72f1b: ref 0 aborting False
Thread-56888::INFO::2011-05-18 21:00:10,448::dispatcher::101::irs::Run and protect: getDeviceList, Return response: {'status': {'message': 'OK', 'code': 0}, 'devList': [{'vendorID': 'HP', 'capacity': '107374182400', 'fwrev': '0000', 'vgUUID': '', 'pathlist': [], 'pathstatus': [{'physdev': 'sdh', 'state': 'active', 'lun': '3'}, {'physdev': 'sdn', 'state': 'active', 'lun': '3'}, {'physdev': 'sde', 'state': 'active', 'lun': '3'}, {'physdev': 'sdk', 'state': 'active', 'lun': '3'}], 'devtype': 'FCP', 'pvUUID': '', 'serial': 'SHP_HSV300_PAXPVG79S0D081', 'GUID': '360014380125989a10000400000500000', 'productID': 'HSV300'}, {'vendorID': 'HP', 'capacity': '107374182400', 'fwrev': '0000', 'vgUUID': '', 'pathlist': [], 'pathstatus': [{'physdev': 'sdf', 'state': 'active', 'lun': '1'}, {'physdev': 'sdl', 'state': 'active', 'lun': '1'}, {'physdev': 'sdc', 'state': 'active', 'lun': '1'}, {'physdev': 'sdi', 'state': 'active', 'lun': '1'}], 'devtype': 'FCP', 'pvUUID': '', 'serial': 'SHP_HSV300_PAXPVG79S0D081', 'GUID': '360014380125989a10000400000480000', 'productID': 'HSV300'}, {'vendorID': 'HP', 'capacity': '107374182400', 'fwrev': '0000', 'vgUUID': '', 'pathlist': [], 'pathstatus': [{'physdev': 'sdd', 'state': 'active', 'lun': '2'}, {'physdev': 'sdj', 'state': 'active', 'lun': '2'}, {'physdev': 'sdg', 'state': 'active', 'lun': '2'}, {'physdev': 'sdm', 'state': 'active', 'lun': '2'}], 'devtype': 'FCP', 'pvUUID': '', 'serial': 'SHP_HSV300_PAXPVG79S0D06V', 'GUID': '360014380125989a100004000004c0000', 'productID': 'HSV300'}]}