MainThread::INFO::2013-08-06 14:32:51,503::vdsm::88::vds::(run) I am the actual vdsm 4.10-18 onode.sh.intel.com (3.9.2-301.fc19.x86_64)
MainThread::DEBUG::2013-08-06 14:32:51,629::resourceManager::395::ResourceManager::(registerNamespace) Registering namespace 'Storage'
MainThread::DEBUG::2013-08-06 14:32:51,629::threadPool::34::Misc.ThreadPool::(__init__) Enter - numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0
MainThread::WARNING::2013-08-06 14:32:51,652::fileUtils::185::fileUtils::(createdir) Dir /rhev/data-center/mnt already exists
MainThread::DEBUG::2013-08-06 14:32:51,674::supervdsm::122::SuperVdsmProxy::(_start) Launching Super Vdsm
MainThread::DEBUG::2013-08-06 14:32:51,675::misc::84::Storage.Misc.excCmd::(<lambda>) '/usr/bin/sudo -n /usr/bin/python /usr/share/vdsm/supervdsmServer.py 41699956-29b6-42cb-bc9f-437dfd09633c 2664 /var/run/vdsm/svdsm.pid /var/run/vdsm/svdsm.time /var/run/vdsm/svdsm.sock 36' (cwd None)
MainThread::DEBUG::2013-08-06 14:32:53,679::supervdsm::186::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm
MainThread::DEBUG::2013-08-06 14:32:53,683::multipath::141::Storage.Multipath::(isEnabled) Current revision of multipath.conf detected, preserving
MainThread::DEBUG::2013-08-06 14:32:53,683::misc::84::Storage.Misc.excCmd::(<lambda>) '/usr/bin/sudo -n /sbin/lvm dumpconfig global/locking_type' (cwd None)
MainThread::DEBUG::2013-08-06 14:32:53,699::misc::84::Storage.Misc.excCmd::(<lambda>) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2013-08-06 14:32:53,699::hsm::434::Storage.HSM::(__cleanStorageRepository) Started cleaning storage repository at '/rhev/data-center'
MainThread::DEBUG::2013-08-06 14:32:53,702::hsm::466::Storage.HSM::(__cleanStorageRepository) White list: ['/rhev/data-center/hsm-tasks', '/rhev/data-center/hsm-tasks/*', '/rhev/data-center/mnt']
MainThread::DEBUG::2013-08-06 14:32:53,702::hsm::467::Storage.HSM::(__cleanStorageRepository) Mount list: []
MainThread::DEBUG::2013-08-06 14:32:53,702::hsm::469::Storage.HSM::(__cleanStorageRepository) Cleaning leftovers
MainThread::DEBUG::2013-08-06 14:32:53,703::hsm::512::Storage.HSM::(__cleanStorageRepository) Finished cleaning storage repository at '/rhev/data-center'
MainThread::INFO::2013-08-06 14:32:53,704::dispatcher::97::Storage.Dispatcher::(__init__) Starting StorageDispatcher...
storageRefresh::DEBUG::2013-08-06 14:32:53,704::lvm::334::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2013-08-06 14:32:53,705::misc::84::Storage.Misc.excCmd::(<lambda>) '/usr/bin/sudo -n /sbin/lvm pvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 filter = [ \\"r%.*%\\" ] }  global {  locking_type=1  prioritise_write_locks=1  wait_for_locks=1 }  backup {  retain_min = 50  retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,dev_size' (cwd None)
MainThread::INFO::2013-08-06 14:32:53,724::momIF::36::MOM::(__init__) Starting up MOM
storageRefresh::DEBUG::2013-08-06 14:32:53,725::misc::84::Storage.Misc.excCmd::(<lambda>) SUCCESS: <err> = '  No device found for PV kNhlH2-iA2q-Z37F-C1cg-Wd0L-gwqV-t4c4er.\n'; <rc> = 0
storageRefresh::DEBUG::2013-08-06 14:32:53,725::lvm::359::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2013-08-06 14:32:53,725::lvm::368::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2013-08-06 14:32:53,726::misc::84::Storage.Misc.excCmd::(<lambda>) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 filter = [ \\"r%.*%\\" ] }  global {  locking_type=1  prioritise_write_locks=1  wait_for_locks=1 }  backup {  retain_min = 50  retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free' (cwd None)
MainThread::INFO::2013-08-06 14:32:53,730::vmChannels::140::vds::(settimeout) Setting channels' timeout to 30 seconds.
VM Channels Listener::INFO::2013-08-06 14:32:53,731::vmChannels::128::vds::(run) Starting VM channels listener thread.
MainThread::WARNING::2013-08-06 14:32:53,735::clientIF::175::vds::(_prepareBindings) Unable to load the json rpc server module. Please make sure it is installed.
storageRefresh::DEBUG::2013-08-06 14:32:53,739::misc::84::Storage.Misc.excCmd::(<lambda>) SUCCESS: <err> = '  No device found for PV kNhlH2-iA2q-Z37F-C1cg-Wd0L-gwqV-t4c4er.\n  No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2013-08-06 14:32:53,740::lvm::397::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2013-08-06 14:32:53,740::misc::84::Storage.Misc.excCmd::(<lambda>) '/usr/bin/sudo -n /sbin/lvm lvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 filter = [ \\"r%.*%\\" ] }  global {  locking_type=1  prioritise_write_locks=1  wait_for_locks=1 }  backup {  retain_min = 50  retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags' (cwd None)
storageRefresh::DEBUG::2013-08-06 14:32:53,755::misc::84::Storage.Misc.excCmd::(<lambda>) SUCCESS: <err> = '  No device found for PV kNhlH2-iA2q-Z37F-C1cg-Wd0L-gwqV-t4c4er.\n  No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2013-08-06 14:32:53,756::misc::1054::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)
storageRefresh::DEBUG::2013-08-06 14:32:53,757::misc::1056::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2013-08-06 14:32:53,759::misc::1054::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
storageRefresh::DEBUG::2013-08-06 14:32:53,760::misc::1056::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2013-08-06 14:32:53,762::misc::84::Storage.Misc.excCmd::(<lambda>) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
storageRefresh::DEBUG::2013-08-06 14:32:53,772::misc::84::Storage.Misc.excCmd::(<lambda>) FAILED: <err> = 'iscsiadm: No session found.\n'; <rc> = 21
storageRefresh::DEBUG::2013-08-06 14:32:53,775::misc::1064::SamplingMethod::(__call__) Returning last result
Thread-13::DEBUG::2013-08-06 14:32:54,275::BindingXMLRPC::913::vds::(wrapper) client [10.239.131.222]::call ping with () {}
Thread-13::DEBUG::2013-08-06 14:32:54,275::BindingXMLRPC::920::vds::(wrapper) return ping with {'status': {'message': 'Done', 'code': 0}}
Thread-14::DEBUG::2013-08-06 14:32:54,291::BindingXMLRPC::913::vds::(wrapper) client [10.239.131.222]::call getCapabilities with () {}
Thread-14::DEBUG::2013-08-06 14:32:54,358::BindingXMLRPC::920::vds::(wrapper) return getCapabilities with {'status': {'message': 'Done', 'code': 0}, 'info': {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.1994-05.com.redhat:9fb571e343'}], 'FC': []}, 'packages2': {'kernel': {'release': '301.fc19.x86_64', 'buildtime': 1368462984.0, 'version': '3.9.2'}, 'spice-server': {'release': '5.fc19', 'buildtime': 1366036951L, 'version': '0.12.2'}, 'vdsm': {'release': '18.fc19', 'buildtime': 1373484771L, 'version': '4.10.3'}, 'qemu-kvm': {'release': '4.fc19', 'buildtime': 1371653911L, 'version': '1.4.2'}, 'libvirt': {'release': '1.fc19', 'buildtime': 1371074681L, 'version': '1.0.5.2'}, 'qemu-img': {'release': '4.fc19', 'buildtime': 1371653911L, 'version': '1.4.2'}, 'mom': {'release': '2.fc19', 'buildtime': 1374564325L, 'version': '0.3.2'}}, 'cpuModel': 'Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz', 'hooks': {}, 'cpuSockets': '1', 'vmTypes': ['kvm'], 'supportedProtocols': ['2.2', '2.3'], 'networks': {'ovirtmgmt': {'iface': 'ovirtmgmt', 'addr': '10.239.131.217', 'cfg': {'PEERROUTES': 'yes', 'IPV6INIT': 'yes', 'IPV6_PEERROUTES': 'yes', 'IPV6_PEERDNS': 'yes', 'DEFROUTE': 'yes', 'PEERDNS': 'yes', 'IPV6_AUTOCONF': 'yes', 'DELAY': '0', 'NM_CONTROLLED': 'no', 'IPV6_DEFROUTE': 'yes', 'DEVICE': 'ovirtmgmt', 'IPV6_FAILURE_FATAL': 'no', 'IPV4_FAILURE_FATAL': 'no', 'TYPE': 'Bridge', 'ONBOOT': 'yes', 'BOOTPROTO': 'dhcp', 'UUID': 'b6ecfa9d-0deb-4213-9348-11137f76735d'}, 'mtu': '1500', 'netmask': '255.255.255.0', 'stp': 'off', 'bridged': True, 'gateway': '10.239.131.1', 'ports': ['em1']}}, 'bridges': {'ovirtmgmt': {'addr': '10.239.131.217', 'cfg': {'PEERROUTES': 'yes', 'IPV6INIT': 'yes', 'IPV6_PEERROUTES': 'yes', 'IPV6_PEERDNS': 'yes', 'DEFROUTE': 'yes', 'PEERDNS': 'yes', 'IPV6_AUTOCONF': 'yes', 'DELAY': '0', 'NM_CONTROLLED': 'no', 'IPV6_DEFROUTE': 'yes', 'DEVICE': 'ovirtmgmt', 'IPV6_FAILURE_FATAL': 'no', 'IPV4_FAILURE_FATAL': 'no', 'TYPE': 'Bridge', 'ONBOOT': 'yes', 'BOOTPROTO': 'dhcp', 'UUID': 'b6ecfa9d-0deb-4213-9348-11137f76735d'}, 'mtu': '1500', 'netmask': '255.255.255.0', 'stp': 'off', 'ports': ['em1']}}, 'uuid': '30BBC800-4F47-11E0-0000-2C4138B2D0E8', 'lastClientIface': 'ovirtmgmt', 'nics': {'em1': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'hwaddr': '2c:41:38:b2:d0:e8', 'speed': 100}}, 'software_revision': '18', 'clusterLevels': ['3.0', '3.1', '3.2'], 'cpuFlags': u'fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,dts,acpi,mmx,fxsr,sse,sse2,ss,ht,tm,pbe,syscall,nx,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,smx,est,tm2,ssse3,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,popcnt,tsc_deadline_timer,aes,xsave,avx,lahf_lm,ida,arat,epb,xsaveopt,pln,pts,dtherm,tpr_shadow,vnmi,flexpriority,ept,vpid,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_Westmere,model_n270,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.1994-05.com.redhat:9fb571e343', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.0', '3.1'], 'reservedMem': '321', 'bondings': {'bond4': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '0e:00:b7:57:2c:c9'}, 'bond0': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '32:b3:88:1f:ef:91'}, 'bond1': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '4e:e5:80:93:ea:d9'}, 'bond2': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '16:ab:f6:e4:f2:27'}, 'bond3': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': 'ee:55:f5:e7:31:7c'}}, 'software_version': '4.10', 'memSize': '7944', 'cpuSpeed': '2890.000', 'version_name': 'Snow Man', 'vlans': {}, 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'management_ip': '', 'cpuThreads': '8', 'emulatedMachines': [u'clipper', u'none'], 'operatingSystem': {'release': '0.5', 'version': '19', 'name': 'Fedora'}, 'lastClient': '10.239.131.222'}}
Thread-15::DEBUG::2013-08-06 14:32:55,057::BindingXMLRPC::913::vds::(wrapper) client [10.239.131.222]::call getCapabilities with () {}
Thread-15::DEBUG::2013-08-06 14:32:55,070::BindingXMLRPC::920::vds::(wrapper) return getCapabilities with {'status': {'message': 'Done', 'code': 0}, 'info': {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.1994-05.com.redhat:9fb571e343'}], 'FC': []}, 'packages2': {'kernel': {'release': '301.fc19.x86_64', 'buildtime': 1368462984.0, 'version': '3.9.2'}, 'spice-server': {'release': '5.fc19', 'buildtime': 1366036951L, 'version': '0.12.2'}, 'vdsm': {'release': '18.fc19', 'buildtime': 1373484771L, 'version': '4.10.3'}, 'qemu-kvm': {'release': '4.fc19', 'buildtime': 1371653911L, 'version': '1.4.2'}, 'libvirt': {'release': '1.fc19', 'buildtime': 1371074681L, 'version': '1.0.5.2'}, 'qemu-img': {'release': '4.fc19', 'buildtime': 1371653911L, 'version': '1.4.2'}, 'mom': {'release': '2.fc19', 'buildtime': 1374564325L, 'version': '0.3.2'}}, 'cpuModel': 'Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz', 'hooks': {}, 'cpuSockets': '1', 'vmTypes': ['kvm'], 'supportedProtocols': ['2.2', '2.3'], 'networks': {'ovirtmgmt': {'iface': 'ovirtmgmt', 'addr': '10.239.131.217', 'cfg': {'PEERROUTES': 'yes', 'IPV6INIT': 'yes', 'IPV6_PEERROUTES': 'yes', 'IPV6_PEERDNS': 'yes', 'DEFROUTE': 'yes', 'PEERDNS': 'yes', 'IPV6_AUTOCONF': 'yes', 'DELAY': '0', 'NM_CONTROLLED': 'no', 'IPV6_DEFROUTE': 'yes', 'DEVICE': 'ovirtmgmt', 'IPV6_FAILURE_FATAL': 'no', 'IPV4_FAILURE_FATAL': 'no', 'TYPE': 'Bridge', 'ONBOOT': 'yes', 'BOOTPROTO': 'dhcp', 'UUID': 'b6ecfa9d-0deb-4213-9348-11137f76735d'}, 'mtu': '1500', 'netmask': '255.255.255.0', 'stp': 'off', 'bridged': True, 'gateway': '10.239.131.1', 'ports': ['em1']}}, 'bridges': {'ovirtmgmt': {'addr': '10.239.131.217', 'cfg': {'PEERROUTES': 'yes', 'IPV6INIT': 'yes', 'IPV6_PEERROUTES': 'yes', 'IPV6_PEERDNS': 'yes', 'DEFROUTE': 'yes', 'PEERDNS': 'yes', 'IPV6_AUTOCONF': 'yes', 'DELAY': '0', 'NM_CONTROLLED': 'no', 'IPV6_DEFROUTE': 'yes', 'DEVICE': 'ovirtmgmt', 'IPV6_FAILURE_FATAL': 'no', 'IPV4_FAILURE_FATAL': 'no', 'TYPE': 'Bridge', 'ONBOOT': 'yes', 'BOOTPROTO': 'dhcp', 'UUID': 'b6ecfa9d-0deb-4213-9348-11137f76735d'}, 'mtu': '1500', 'netmask': '255.255.255.0', 'stp': 'off', 'ports': ['em1']}}, 'uuid': '30BBC800-4F47-11E0-0000-2C4138B2D0E8', 'lastClientIface': 'ovirtmgmt', 'nics': {'em1': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'hwaddr': '2c:41:38:b2:d0:e8', 'speed': 100}}, 'software_revision': '18', 'clusterLevels': ['3.0', '3.1', '3.2'], 'cpuFlags': u'fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,dts,acpi,mmx,fxsr,sse,sse2,ss,ht,tm,pbe,syscall,nx,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,smx,est,tm2,ssse3,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,popcnt,tsc_deadline_timer,aes,xsave,avx,lahf_lm,ida,arat,epb,xsaveopt,pln,pts,dtherm,tpr_shadow,vnmi,flexpriority,ept,vpid,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_Westmere,model_n270,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.1994-05.com.redhat:9fb571e343', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.0', '3.1'], 'reservedMem': '321', 'bondings': {'bond4': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '0e:00:b7:57:2c:c9'}, 'bond0': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '32:b3:88:1f:ef:91'}, 'bond1': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '4e:e5:80:93:ea:d9'}, 'bond2': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '16:ab:f6:e4:f2:27'}, 'bond3': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': 'ee:55:f5:e7:31:7c'}}, 'software_version': '4.10', 'memSize': '7944', 'cpuSpeed': '1598.000', 'version_name': 'Snow Man', 'vlans': {}, 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'management_ip': '', 'cpuThreads': '8', 'emulatedMachines': [u'clipper', u'none'], 'operatingSystem': {'release': '0.5', 'version': '19', 'name': 'Fedora'}, 'lastClient': '10.239.131.222'}}
Thread-16::DEBUG::2013-08-06 14:32:55,089::BindingXMLRPC::913::vds::(wrapper) client [10.239.131.222]::call getHardwareInfo with () {}
Thread-16::DEBUG::2013-08-06 14:32:55,144::BindingXMLRPC::920::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'HP Compaq 8200 Elite SFF PC', 'systemSerialNumber': 'CNG1487LZN', 'systemFamily': '103C_53307F G=D', 'systemVersion': 'Not Specified', 'systemUUID': '30BBC800-4F47-11E0-0000-2C4138B2D0E8', 'systemManufacturer': 'Hewlett-Packard'}}
Thread-17::DEBUG::2013-08-06 14:32:55,388::BindingXMLRPC::913::vds::(wrapper) client [10.239.131.222]::call getCapabilities with () {}
Thread-17::DEBUG::2013-08-06 14:32:55,399::BindingXMLRPC::920::vds::(wrapper) return getCapabilities with {'status': {'message': 'Done', 'code': 0}, 'info': {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.1994-05.com.redhat:9fb571e343'}], 'FC': []}, 'packages2': {'kernel': {'release': '301.fc19.x86_64', 'buildtime': 1368462984.0, 'version': '3.9.2'}, 'spice-server': {'release': '5.fc19', 'buildtime': 1366036951L, 'version': '0.12.2'}, 'vdsm': {'release': '18.fc19', 'buildtime': 1373484771L, 'version': '4.10.3'}, 'qemu-kvm': {'release': '4.fc19', 'buildtime': 1371653911L, 'version': '1.4.2'}, 'libvirt': {'release': '1.fc19', 'buildtime': 1371074681L, 'version': '1.0.5.2'}, 'qemu-img': {'release': '4.fc19', 'buildtime': 1371653911L, 'version': '1.4.2'}, 'mom': {'release': '2.fc19', 'buildtime': 1374564325L, 'version': '0.3.2'}}, 'cpuModel': 'Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz', 'hooks': {}, 'cpuSockets': '1', 'vmTypes': ['kvm'], 'supportedProtocols': ['2.2', '2.3'], 'networks': {'ovirtmgmt': {'iface': 'ovirtmgmt', 'addr': '10.239.131.217', 'cfg': {'PEERROUTES': 'yes', 'IPV6INIT': 'yes', 'IPV6_PEERROUTES': 'yes', 'IPV6_PEERDNS': 'yes', 'DEFROUTE': 'yes', 'PEERDNS': 'yes', 'IPV6_AUTOCONF': 'yes', 'DELAY': '0', 'NM_CONTROLLED': 'no', 'IPV6_DEFROUTE': 'yes', 'DEVICE': 'ovirtmgmt', 'IPV6_FAILURE_FATAL': 'no', 'IPV4_FAILURE_FATAL': 'no', 'TYPE': 'Bridge', 'ONBOOT': 'yes', 'BOOTPROTO': 'dhcp', 'UUID': 'b6ecfa9d-0deb-4213-9348-11137f76735d'}, 'mtu': '1500', 'netmask': '255.255.255.0', 'stp': 'off', 'bridged': True, 'gateway': '10.239.131.1', 'ports': ['em1']}}, 'bridges': {'ovirtmgmt': {'addr': '10.239.131.217', 'cfg': {'PEERROUTES': 'yes', 'IPV6INIT': 'yes', 'IPV6_PEERROUTES': 'yes', 'IPV6_PEERDNS': 'yes', 'DEFROUTE': 'yes', 'PEERDNS': 'yes', 'IPV6_AUTOCONF': 'yes', 'DELAY': '0', 'NM_CONTROLLED': 'no', 'IPV6_DEFROUTE': 'yes', 'DEVICE': 'ovirtmgmt', 'IPV6_FAILURE_FATAL': 'no', 'IPV4_FAILURE_FATAL': 'no', 'TYPE': 'Bridge', 'ONBOOT': 'yes', 'BOOTPROTO': 'dhcp', 'UUID': 'b6ecfa9d-0deb-4213-9348-11137f76735d'}, 'mtu': '1500', 'netmask': '255.255.255.0', 'stp': 'off', 'ports': ['em1']}}, 'uuid': '30BBC800-4F47-11E0-0000-2C4138B2D0E8', 'lastClientIface': 'ovirtmgmt', 'nics': {'em1': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'hwaddr': '2c:41:38:b2:d0:e8', 'speed': 100}}, 'software_revision': '18', 'clusterLevels': ['3.0', '3.1', '3.2'], 'cpuFlags': u'fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,dts,acpi,mmx,fxsr,sse,sse2,ss,ht,tm,pbe,syscall,nx,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,smx,est,tm2,ssse3,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,popcnt,tsc_deadline_timer,aes,xsave,avx,lahf_lm,ida,arat,epb,xsaveopt,pln,pts,dtherm,tpr_shadow,vnmi,flexpriority,ept,vpid,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_Westmere,model_n270,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.1994-05.com.redhat:9fb571e343', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.0', '3.1'], 'reservedMem': '321', 'bondings': {'bond4': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '0e:00:b7:57:2c:c9'}, 'bond0': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '32:b3:88:1f:ef:91'}, 'bond1': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '4e:e5:80:93:ea:d9'}, 'bond2': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '16:ab:f6:e4:f2:27'}, 'bond3': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': 'ee:55:f5:e7:31:7c'}}, 'software_version': '4.10', 'memSize': '7944', 'cpuSpeed': '2176.000', 'version_name': 'Snow Man', 'vlans': {}, 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'management_ip': '', 'cpuThreads': '8', 'emulatedMachines': [u'clipper', u'none'], 'operatingSystem': {'release': '0.5', 'version': '19', 'name': 'Fedora'}, 'lastClient': '10.239.131.222'}}
Thread-18::DEBUG::2013-08-06 14:32:55,413::BindingXMLRPC::913::vds::(wrapper) client [10.239.131.222]::call getHardwareInfo with () {}
Thread-18::DEBUG::2013-08-06 14:32:55,414::BindingXMLRPC::920::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'HP Compaq 8200 Elite SFF PC', 'systemSerialNumber': 'CNG1487LZN', 'systemFamily': '103C_53307F G=D', 'systemVersion': 'Not Specified', 'systemUUID': '30BBC800-4F47-11E0-0000-2C4138B2D0E8', 'systemManufacturer': 'Hewlett-Packard'}}
storageRefresh::DEBUG::2013-08-06 14:32:59,796::misc::84::Storage.Misc.excCmd::(<lambda>) '/usr/bin/sudo -n /sbin/multipath' (cwd None)
storageRefresh::DEBUG::2013-08-06 14:32:59,904::misc::84::Storage.Misc.excCmd::(<lambda>) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2013-08-06 14:32:59,905::lvm::477::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2013-08-06 14:32:59,905::lvm::479::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2013-08-06 14:32:59,905::lvm::488::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2013-08-06 14:32:59,905::lvm::490::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2013-08-06 14:32:59,905::lvm::508::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2013-08-06 14:32:59,905::lvm::510::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2013-08-06 14:32:59,906::misc::1064::SamplingMethod::(__call__) Returning last result
Thread-20::DEBUG::2013-08-06 14:34:04,586::task::568::TaskManager.Task::(_updateState) Task=`ae6e5c59-4708-4f7c-b98f-9c5c1edb778d`::moving from state init -> state preparing
Thread-20::INFO::2013-08-06 14:34:04,587::logUtils::41::dispatcher::(wrapper) Run and protect: repoStats(options=None)
Thread-20::INFO::2013-08-06 14:34:04,587::logUtils::44::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
Thread-20::DEBUG::2013-08-06 14:34:04,587::task::1151::TaskManager.Task::(prepare) Task=`ae6e5c59-4708-4f7c-b98f-9c5c1edb778d`::finished: {}
Thread-20::DEBUG::2013-08-06 14:34:04,587::task::568::TaskManager.Task::(_updateState) Task=`ae6e5c59-4708-4f7c-b98f-9c5c1edb778d`::moving from state preparing -> state finished
Thread-20::DEBUG::2013-08-06 14:34:04,587::resourceManager::830::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
Thread-20::DEBUG::2013-08-06 14:34:04,587::resourceManager::864::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-20::DEBUG::2013-08-06 14:34:04,587::task::957::TaskManager.Task::(_decref) Task=`ae6e5c59-4708-4f7c-b98f-9c5c1edb778d`::ref 0 aborting False
Thread-22::DEBUG::2013-08-06 14:36:04,739::BindingXMLRPC::913::vds::(wrapper) client [10.239.131.222]::call getCapabilities with () {}
Thread-22::DEBUG::2013-08-06 14:36:04,752::BindingXMLRPC::920::vds::(wrapper) return getCapabilities with {'status': {'message': 'Done', 'code': 0}, 'info': {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.1994-05.com.redhat:9fb571e343'}], 'FC': []}, 'packages2': {'kernel': {'release': '301.fc19.x86_64', 'buildtime': 1368462984.0, 'version': '3.9.2'}, 'spice-server': {'release': '5.fc19', 'buildtime': 1366036951L, 'version': '0.12.2'}, 'vdsm': {'release': '18.fc19', 'buildtime': 1373484771L, 'version': '4.10.3'}, 'qemu-kvm': {'release': '4.fc19', 'buildtime': 1371653911L, 'version': '1.4.2'}, 'libvirt': {'release': '1.fc19', 'buildtime': 1371074681L, 'version': '1.0.5.2'}, 'qemu-img': {'release': '4.fc19', 'buildtime': 1371653911L, 'version': '1.4.2'}, 'mom': {'release': '2.fc19', 'buildtime': 1374564325L, 'version': '0.3.2'}}, 'cpuModel': 'Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz', 'hooks': {}, 'cpuSockets': '1', 'vmTypes': ['kvm'], 'supportedProtocols': ['2.2', '2.3'], 'networks': {'ovirtmgmt': {'iface': 'ovirtmgmt', 'addr': '10.239.131.217', 'cfg': {'PEERROUTES': 'yes', 'IPV6INIT': 'yes', 'IPV6_PEERROUTES': 'yes', 'IPV6_PEERDNS': 'yes', 'DEFROUTE': 'yes', 'PEERDNS': 'yes', 'IPV6_AUTOCONF': 'yes', 'DELAY': '0', 'NM_CONTROLLED': 'no', 'IPV6_DEFROUTE': 'yes', 'DEVICE': 'ovirtmgmt', 'IPV6_FAILURE_FATAL': 'no', 'IPV4_FAILURE_FATAL': 'no', 'TYPE': 'Bridge', 'ONBOOT': 'yes', 'BOOTPROTO': 'dhcp', 'UUID': 'b6ecfa9d-0deb-4213-9348-11137f76735d'}, 'mtu': '1500', 'netmask': '255.255.255.0', 'stp': 'off', 'bridged': True, 'gateway': '10.239.131.1', 'ports': ['em1']}}, 'bridges': {'ovirtmgmt': {'addr': '10.239.131.217', 'cfg': {'PEERROUTES': 'yes', 'IPV6INIT': 'yes', 'IPV6_PEERROUTES': 'yes', 'IPV6_PEERDNS': 'yes', 'DEFROUTE': 'yes', 'PEERDNS': 'yes', 'IPV6_AUTOCONF': 'yes', 'DELAY': '0', 'NM_CONTROLLED': 'no', 'IPV6_DEFROUTE': 'yes', 'DEVICE': 'ovirtmgmt', 'IPV6_FAILURE_FATAL': 'no', 'IPV4_FAILURE_FATAL': 'no', 'TYPE': 'Bridge', 'ONBOOT': 'yes', 'BOOTPROTO': 'dhcp', 'UUID': 'b6ecfa9d-0deb-4213-9348-11137f76735d'}, 'mtu': '1500', 'netmask': '255.255.255.0', 'stp': 'off', 'ports': ['em1']}}, 'uuid': '30BBC800-4F47-11E0-0000-2C4138B2D0E8', 'lastClientIface': 'ovirtmgmt', 'nics': {'em1': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'hwaddr': '2c:41:38:b2:d0:e8', 'speed': 100}}, 'software_revision': '18', 'clusterLevels': ['3.0', '3.1', '3.2'], 'cpuFlags': u'fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,clflush,dts,acpi,mmx,fxsr,sse,sse2,ss,ht,tm,pbe,syscall,nx,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,smx,est,tm2,ssse3,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,popcnt,tsc_deadline_timer,aes,xsave,avx,lahf_lm,ida,arat,epb,xsaveopt,pln,pts,dtherm,tpr_shadow,vnmi,flexpriority,ept,vpid,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_Westmere,model_n270,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.1994-05.com.redhat:9fb571e343', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.0', '3.1'], 'reservedMem': '321', 'bondings': {'bond4': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '0e:00:b7:57:2c:c9'}, 'bond0': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '32:b3:88:1f:ef:91'}, 'bond1': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '4e:e5:80:93:ea:d9'}, 'bond2': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': '16:ab:f6:e4:f2:27'}, 'bond3': {'addr': '', 'cfg': {}, 'mtu': '1500', 'netmask': '', 'slaves': [], 'hwaddr': 'ee:55:f5:e7:31:7c'}}, 'software_version': '4.10', 'memSize': '7944', 'cpuSpeed': '1598.000', 'version_name': 'Snow Man', 'vlans': {}, 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'management_ip': '', 'cpuThreads': '8', 'emulatedMachines': [u'clipper', u'none'], 'operatingSystem': {'release': '0.5', 'version': '19', 'name': 'Fedora'}, 'lastClient': '10.239.131.222'}}
Thread-23::DEBUG::2013-08-06 14:36:04,768::BindingXMLRPC::913::vds::(wrapper) client [10.239.131.222]::call getHardwareInfo with () {}
Thread-23::DEBUG::2013-08-06 14:36:04,769::BindingXMLRPC::920::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'HP Compaq 8200 Elite SFF PC', 'systemSerialNumber': 'CNG1487LZN', 'systemFamily': '103C_53307F G=D', 'systemVersion': 'Not Specified', 'systemUUID': '30BBC800-4F47-11E0-0000-2C4138B2D0E8', 'systemManufacturer': 'Hewlett-Packard'}}