vdsm_20160525.log

MainThread::WARNING::2016-05-25 08:42:26,395::vdsmDebugPlugin::40::DebugInterpreter::(turnOnDebugPlugin) Starting Debug Interpreter. Tread lightly!
MainThread::INFO::2016-05-25 08:42:26,396::vdsm::161::vds::(run) (PID: 1793) I am the actual vdsm 4.17.24.0 SDP_Basking-Ridge-3 (4.1.23-rt23)
MainThread::INFO::2016-05-25 08:42:26,396::vdsm::284::vds::(__set_cpu_affinity) VDSM will run with cpu affinity: frozenset([1])
MainThread::DEBUG::2016-05-25 08:42:26,397::utils::671::root::(execCmd) /usr/bin/taskset --all-tasks --pid --cpu-list 1 1793 (cwd None)
MainThread::DEBUG::2016-05-25 08:42:26,399::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2016-05-25 08:42:26,400::resourceManager::424::Storage.ResourceManager::(registerNamespace) Registering namespace 'Storage'
MainThread::DEBUG::2016-05-25 08:42:26,400::threadPool::29::Storage.ThreadPool::(__init__) Enter - numThreads: 10, waitTimeout: 3, maxTasks: 500
MainThread::DEBUG::2016-05-25 08:42:26,402::fileUtils::143::Storage.fileUtils::(createdir) Creating directory: /redhat/data-center/mnt mode: None
MainThread::WARNING::2016-05-25 08:42:26,414::fileUtils::152::Storage.fileUtils::(createdir) Dir /redhat/data-center/mnt already exists
MainThread::DEBUG::2016-05-25 08:42:26,434::hsm::409::Storage.Misc.excCmd::(__validateLvmLockingType) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/sbin/lvm dumpconfig global/locking_type (cwd None)
MainThread::DEBUG::2016-05-25 08:42:26,658::hsm::409::Storage.Misc.excCmd::(__validateLvmLockingType) SUCCESS: <err> = '  /run/lvm/lvmetad.socket: connect failed: No such file or directory\n  WARNING: Failed to connect to lvmetad. Falling back to internal scanning.\n'; <rc> = 0
MainThread::WARNING::2016-05-25 08:42:26,658::outOfProcess::68::Storage.oop::(setDefaultImpl) Cannot import IOProcess, set oop to use RFH
MainThread::DEBUG::2016-05-25 08:42:26,658::hsm::433::Storage.HSM::(__cleanStorageRepository) Started cleaning storage repository at '/redhat/data-center'
MainThread::DEBUG::2016-05-25 08:42:26,660::hsm::465::Storage.HSM::(__cleanStorageRepository) White list: ['/redhat/data-center/hsm-tasks', '/redhat/data-center/hsm-tasks/*', '/redhat/data-center/mnt']
MainThread::DEBUG::2016-05-25 08:42:26,661::hsm::466::Storage.HSM::(__cleanStorageRepository) Mount list: []
MainThread::DEBUG::2016-05-25 08:42:26,661::hsm::468::Storage.HSM::(__cleanStorageRepository) Cleaning leftovers
MainThread::DEBUG::2016-05-25 08:42:26,661::hsm::511::Storage.HSM::(__cleanStorageRepository) Finished cleaning storage repository at '/redhat/data-center'
MainThread::INFO::2016-05-25 08:42:26,663::dispatcher::46::Storage.Dispatcher::(__init__) Starting StorageDispatcher...
MainThread::DEBUG::2016-05-25 08:42:26,663::schedule::98::Scheduler::(start) Starting scheduler vdsm.Scheduler
storageRefresh::DEBUG::2016-05-25 08:42:26,664::misc::750::Storage.SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)
storageRefresh::DEBUG::2016-05-25 08:42:26,664::misc::753::Storage.SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2016-05-25 08:42:26,664::misc::750::Storage.SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
storageRefresh::DEBUG::2016-05-25 08:42:26,664::misc::753::Storage.SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2016-05-25 08:42:26,664::iscsi::434::Storage.ISCSI::(rescan) Performing SCSI scan, this will take up to 30 seconds
storageRefresh::DEBUG::2016-05-25 08:42:26,664::iscsiadm::97::Storage.Misc.excCmd::(_runCmd) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /sbin/iscsiadm -m session -R (cwd None)
storageRefresh::DEBUG::2016-05-25 08:42:27,244::misc::760::Storage.SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2016-05-25 08:42:27,244::misc::750::Storage.SamplingMethod::(__call__) Trying to enter sampling method (storage.hba.rescan)
storageRefresh::DEBUG::2016-05-25 08:42:27,244::misc::753::Storage.SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2016-05-25 08:42:27,244::hba::56::Storage.HBA::(rescan) Starting scan
storageRefresh::DEBUG::2016-05-25 08:42:27,244::supervdsm::76::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm
vdsm.Scheduler::DEBUG::2016-05-25 08:42:27,245::schedule::142::Scheduler::(_run) started
MainThread::DEBUG::2016-05-25 08:42:27,364::task::595::Storage.TaskManager.Task::(_updateState) Task=`0109d57c-8574-432e-a32c-1c3d8e2911d7`::moving from state init -> state preparing
MainThread::INFO::2016-05-25 08:42:27,364::logUtils::48::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback(callbackFunc=<functools.partial object at 0x7f31c0189940>)
MainThread::INFO::2016-05-25 08:42:27,364::logUtils::51::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback, Return response: None
MainThread::DEBUG::2016-05-25 08:42:27,364::task::1191::Storage.TaskManager.Task::(prepare) Task=`0109d57c-8574-432e-a32c-1c3d8e2911d7`::finished: None
MainThread::DEBUG::2016-05-25 08:42:27,368::task::595::Storage.TaskManager.Task::(_updateState) Task=`0109d57c-8574-432e-a32c-1c3d8e2911d7`::moving from state preparing -> state finished
MainThread::DEBUG::2016-05-25 08:42:27,368::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2016-05-25 08:42:27,368::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2016-05-25 08:42:27,369::task::993::Storage.TaskManager.Task::(_decref) Task=`0109d57c-8574-432e-a32c-1c3d8e2911d7`::ref 0 aborting False
MainThread::INFO::2016-05-25 08:42:27,369::momIF::46::MOM::(__init__) Preparing MOM interface
MainThread::INFO::2016-05-25 08:42:27,399::momIF::55::MOM::(__init__) Using named unix socket /var/run/vdsm/mom-vdsm.sock
MainThread::INFO::2016-05-25 08:42:27,401::secret::90::root::(clear) Unregistering all secrests
MainThread::DEBUG::2016-05-25 08:42:27,401::libvirtconnection::161::root::(get) trying to connect libvirt
MainThread::INFO::2016-05-25 08:42:27,404::vmchannels::211::vds::(settimeout) Setting channels' timeout to 30 seconds.
clientIFinit::DEBUG::2016-05-25 08:42:27,404::clientIF::462::vds::(_recoverExistingVms) recovery: started
MainThread::INFO::2016-05-25 08:42:27,405::protocoldetector::172::vds.MultiProtocolAcceptor::(__init__) Listening at 0.0.0.0:54321
storageRefresh::DEBUG::2016-05-25 08:42:27,508::hba::62::Storage.HBA::(rescan) Scan finished
storageRefresh::DEBUG::2016-05-25 08:42:27,508::misc::760::Storage.SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2016-05-25 08:42:27,509::multipath::77::Storage.Misc.excCmd::(rescan) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/bin/multipath (cwd None)
VM Channels Listener::DEBUG::2016-05-25 08:42:27,511::vmchannels::193::vds::(run) Starting VM channels listener thread.
clientIFinit::INFO::2016-05-25 08:42:27,519::clientIF::553::vds::(_recoverExistingVms) recovery: completed in 0s
MainThread::DEBUG::2016-05-25 08:42:27,519::protocoldetector::199::vds.MultiProtocolAcceptor::(add_detector) Adding detector <rpc.bindingxmlrpc.XmlDetector instance at 0x7f31a84bf710>
MainThread::DEBUG::2016-05-25 08:42:27,696::protocoldetector::199::vds.MultiProtocolAcceptor::(add_detector) Adding detector <yajsonrpc.stompreactor.StompDetector instance at 0x7f31c0144200>
MainThread::DEBUG::2016-05-25 08:42:27,696::executor::69::Executor::(start) Starting executor
MainThread::DEBUG::2016-05-25 08:42:27,696::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/0
MainThread::DEBUG::2016-05-25 08:42:27,696::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/1
jsonrpc.Executor/0::DEBUG::2016-05-25 08:42:27,696::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:42:27,697::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/2
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:27,697::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:42:27,697::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/3
jsonrpc.Executor/2::DEBUG::2016-05-25 08:42:27,697::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:42:27,697::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/4
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:27,697::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:42:27,698::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/5
jsonrpc.Executor/4::DEBUG::2016-05-25 08:42:27,698::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:42:27,698::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/6
jsonrpc.Executor/5::DEBUG::2016-05-25 08:42:27,698::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:42:27,698::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/7
jsonrpc.Executor/6::DEBUG::2016-05-25 08:42:27,698::executor::176::Executor::(_run) Worker started
jsonrpc.Executor/7::DEBUG::2016-05-25 08:42:27,699::executor::176::Executor::(_run) Worker started
BindingXMLRPC::INFO::2016-05-25 08:42:27,699::bindingxmlrpc::62::vds::(threaded_start) XMLRPC server running
MainThread::DEBUG::2016-05-25 08:42:27,700::executor::69::Executor::(start) Starting executor
MainThread::DEBUG::2016-05-25 08:42:27,700::executor::161::Executor::(__init__) Starting worker periodic/0
MainThread::DEBUG::2016-05-25 08:42:27,700::executor::161::Executor::(__init__) Starting worker periodic/1
periodic/0::DEBUG::2016-05-25 08:42:27,700::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:42:27,700::executor::161::Executor::(__init__) Starting worker periodic/2
periodic/1::DEBUG::2016-05-25 08:42:27,701::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:42:27,701::executor::161::Executor::(__init__) Starting worker periodic/3
periodic/2::DEBUG::2016-05-25 08:42:27,701::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:42:27,701::libvirtconnection::161::root::(get) trying to connect libvirt
periodic/3::DEBUG::2016-05-25 08:42:27,701::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:42:27,704::periodic::156::virt.periodic.Operation::(start) starting operation <VmDispatcher operation=<class 'virt.periodic.UpdateVolumes'> at 0x7f31c00f7750>
MainThread::DEBUG::2016-05-25 08:42:27,704::periodic::156::virt.periodic.Operation::(start) starting operation <VmDispatcher operation=<class 'virt.periodic.NumaInfoMonitor'> at 0x7f31c00f7990>
MainThread::DEBUG::2016-05-25 08:42:27,704::periodic::156::virt.periodic.Operation::(start) starting operation <VmDispatcher operation=<class 'virt.periodic.BlockjobMonitor'> at 0x7f31c00f7a10>
MainThread::DEBUG::2016-05-25 08:42:27,704::periodic::156::virt.periodic.Operation::(start) starting operation <VMBulkSampler at 0x7f31c00f7a90>
MainThread::DEBUG::2016-05-25 08:42:27,704::periodic::156::virt.periodic.Operation::(start) starting operation <VmDispatcher operation=<class 'virt.periodic.DriveWatermarkMonitor'> at 0x7f31c00f7dd0>
storageRefresh::DEBUG::2016-05-25 08:42:27,899::multipath::77::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:42:27,899::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /bin/udevadm settle --timeout=5 (cwd None)
storageRefresh::DEBUG::2016-05-25 08:42:27,904::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:42:27,905::lvm::497::Storage.OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:27,906::lvm::499::Storage.OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:27,906::lvm::508::Storage.OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:27,906::lvm::510::Storage.OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:27,906::lvm::528::Storage.OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:27,906::lvm::530::Storage.OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:27,907::misc::760::Storage.SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2016-05-25 08:42:27,907::lvm::319::Storage.OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:27,907::lvm::290::Storage.Misc.excCmd::(cmd) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/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  use_lvmetad=0 }  backup {  retain_min = 50  retain_days = 0 } ' --noheadings --units b --nosuffix --separator '|' --ignoreskippedcluster -o uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,dev_size (cwd None)
storageRefresh::DEBUG::2016-05-25 08:42:28,277::lvm::290::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:42:28,278::lvm::347::Storage.OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:28,278::lvm::370::Storage.OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:28,278::lvm::290::Storage.Misc.excCmd::(cmd) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/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  use_lvmetad=0 }  backup {  retain_min = 50  retain_days = 0 } ' --noheadings --units b --nosuffix --separator '|' --ignoreskippedcluster -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name (cwd None)
storageRefresh::DEBUG::2016-05-25 08:42:28,438::lvm::290::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:42:28,439::lvm::415::Storage.OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:28,439::lvm::290::Storage.Misc.excCmd::(cmd) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/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  use_lvmetad=0 }  backup {  retain_min = 50  retain_days = 0 } ' --noheadings --units b --nosuffix --separator '|' --ignoreskippedcluster -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags (cwd None)
storageRefresh::DEBUG::2016-05-25 08:42:28,603::lvm::290::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:42:28,604::lvm::370::Storage.OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:28,604::lvm::290::Storage.Misc.excCmd::(cmd) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/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  use_lvmetad=0 }  backup {  retain_min = 50  retain_days = 0 } ' --noheadings --units b --nosuffix --separator '|' --ignoreskippedcluster -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name (cwd None)
storageRefresh::DEBUG::2016-05-25 08:42:28,716::lvm::290::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:42:28,716::lvm::415::Storage.OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:42:28,716::hsm::379::Storage.HSM::(storageRefresh) HSM is ready
Reactor thread::INFO::2016-05-25 08:42:29,141::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle_accept) Accepting connection from 128.224.178.67:59392
Reactor thread::DEBUG::2016-05-25 08:42:29,141::protocoldetector::82::ProtocolDetector.Detector::(__init__) Using required_size=11
Reactor thread::INFO::2016-05-25 08:42:29,141::protocoldetector::118::ProtocolDetector.Detector::(handle_read) Detected protocol stomp from 128.224.178.67:59392
JsonRpc (StompReactor)::INFO::2016-05-25 08:42:29,143::stompreactor::101::Broker.StompAdapter::(_cmd_connect) Processing CONNECT request
JsonRpc (StompReactor)::INFO::2016-05-25 08:42:29,143::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe) Subscribe command received
JsonRpc (StompReactor)::INFO::2016-05-25 08:42:29,144::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe) Subscribe command received
Reactor thread::DEBUG::2016-05-25 08:42:29,144::stompreactor::470::protocoldetector.StompDetector::(handle_socket) Stomp detected from ('128.224.178.67', 59392)
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:29,152::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getCapabilities' in bridge with {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:29,250::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /sbin/tc qdisc show (cwd None)
Reactor thread::INFO::2016-05-25 08:42:29,316::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle_accept) Accepting connection from 128.224.162.248:39811
Reactor thread::DEBUG::2016-05-25 08:42:29,316::protocoldetector::82::ProtocolDetector.Detector::(__init__) Using required_size=11
Reactor thread::INFO::2016-05-25 08:42:29,317::protocoldetector::118::ProtocolDetector.Detector::(handle_read) Detected protocol stomp from 128.224.162.248:39811
Reactor thread::INFO::2016-05-25 08:42:29,319::stompreactor::101::Broker.StompAdapter::(_cmd_connect) Processing CONNECT request
Reactor thread::INFO::2016-05-25 08:42:29,319::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe) Subscribe command received
Reactor thread::INFO::2016-05-25 08:42:29,320::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe) Subscribe command received
Reactor thread::DEBUG::2016-05-25 08:42:29,320::stompreactor::470::protocoldetector.StompDetector::(handle_socket) Stomp detected from ('128.224.162.248', 39811)
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:29,325::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getCapabilities' in bridge with {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:29,345::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /sbin/tc qdisc show (cwd None)
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:29,422::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:29,422::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:29,826::caps::841::root::(_getKeyPackages) rpm package libspice-server1 not found
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:29,847::caps::841::root::(_getKeyPackages) rpm package libspice-server1 not found
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:30,372::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 numactl --hardware (cwd None)
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:30,376::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 numactl --hardware (cwd None)
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:30,445::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:30,446::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 sysctl -n -e kernel.numa_balancing (cwd None)
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:30,449::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:30,449::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 sysctl -n -e kernel.numa_balancing (cwd None)
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:30,453::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:30,461::caps::548::root::(_getKdumpStatus) Error detecting fence_kdump configuration status
Traceback (most recent call last):
  File "/usr/share/vdsm/caps.py", line 533, in _getKdumpStatus
    with open('/sys/kernel/kexec_crash_loaded', 'r') as f:
IOError: [Errno 2] No such file or directory: '/sys/kernel/kexec_crash_loaded'
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:30,463::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getCapabilities' in bridge with {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd'}], 'FC': []}, 'packages2': {'kernel': {'release': 'rt23', 'buildtime': 1464016625.0, 'version': '4.1.23'}, 'vdsm': {'release': 'r0.2', 'buildtime': 1464147403, 'version': '4.17.24'}, 'qemu-kvm': {'release': 'r1.0', 'buildtime': 1463991436, 'version': '2.4.0'}, 'python-mom': {'release': 'r0.0', 'buildtime': 1463988268, 'version': '0.5.2'}, 'libvirt': {'release': 'r1.0', 'buildtime': 1463991549, 'version': '1.3.2'}}, 'numaNodeDistance': {'0': [10]}, 'cpuModel': 'Genuine Intel(R) CPU 0000 @ 1.70GHz', 'liveMerge': 'true', 'hooks': {'before_vm_start': {'50_qemucmdline': {'md5': 'a884929ad6f5eb039887157288867409'}, '50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}, '10_faqemu': {'md5': '905dd6bc11753bc9351e85ae6ae704d0'}, '50_macspoof': {'md5': '68cf48c446387550a9a82283079b80f8'}}, 'after_network_setup': {'30_ethtool_options': {'md5': '9cdcf29a16651eb3abfda900312e8b31'}}, 'after_vm_destroy': {'50_vhostmd': {'md5': '92498ed80c0219749829ecce2813fc7c'}}, 'after_device_migrate_destination': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_device_migrate_destination': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '135e1b133e11d29ced7344aea7148ed4'}}, 'after_device_create': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'after_nic_hotplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_vm_migrate_destination': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_nic_hotunplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_vm_dehibernate': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_device_destroy': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_nic_hotplug': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}, 'before_network_setup': {'50_ipv6': {'md5': '34f9fdd03a8adf55636dcedaa49463a2'}}, 'before_device_create': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}}, 'vmTypes': ['kvm'], 'selinux': {'mode': '-1'}, 'liveSnapshot': 'true', 'kdumpStatus': -1, 'networks': {}, 'bridges': {'ovirtmgmt': {'addr': '128.224.165.170', 'cfg': {'BOOTPROTO': 'dhcp'}, 'ipv6addrs': ['fe80::213:20ff:feff:73aa/64'], 'gateway': '128.224.165.1', 'dhcpv4': False, 'netmask': '255.255.255.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['128.224.165.170/24'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': ['eth0'], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '89', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.001320ff73aa', 'bridge_id': '8000.001320ff73aa', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '26771', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}, 'docker0': {'addr': '172.17.0.1', 'cfg': {'BOOTPROTO': 'none'}, 'ipv6addrs': [], 'gateway': '', 'dhcpv4': False, 'netmask': '255.255.0.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['172.17.0.1/16'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': [], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '191', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.0242e4574c88', 'bridge_id': '8000.0242e4574c88', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '28511', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}}, 'uuid': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'onlineCpus': '0,1,2,3,4,5,6,7', 'nics': {'eth0': {'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'BOOTPROTO': 'none'}, 'hwaddr': '00:13:20:ff:73:aa', 'speed': 100, 'gateway': ''}}, 'software_revision': '0', 'hostdevPassthrough': 'true', 'clusterLevels': ['3.4', '3.5', '3.6'], 'cpuFlags': '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,pdpe1gb,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,est,tm2,ssse3,sdbg,fma,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,lahf_lm,abm,3dnowprefetch,ida,arat,epb,pln,pts,dtherm,intel_pt,tpr_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi2,erms,invpcid,rdseed,adx,smap,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_IvyBridge,model_Westmere,model_n270,model_Broadwell-noTSX,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.4', '3.5', '3.6'], 'autoNumaBalancing': 2, 'additionalFeatures': ['GLUSTER_SNAPSHOT', 'GLUSTER_GEO_REPLICATION', 'GLUSTER_BRICK_MANAGEMENT'], 'reservedMem': '321', 'bondings': {}, 'software_version': '4.17.24', 'memSize': '16032', 'cpuSpeed': '1696.945', 'numaNodes': {'0': {'totalMemory': '16032', 'cpus': [0, 1, 2, 3, 4, 5, 6, 7]}}, 'cpuSockets': '1', 'vlans': {}, 'lastClientIface': 'ovirtmgmt', 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'version_name': 'Snow Man', 'cpuThreads': '8', 'emulatedMachines': ['pc-q35-2.0', 'pc-q35-2.1', 'pc-q35-2.2', 'pc-q35-2.3', 'pc-q35-2.4', 'q35', 'pc-1.1', 'pc-1.0', 'pc-1.3', 'pc-1.2', 'pc-q35-1.7', 'pc-q35-1.6', 'pc-q35-1.5', 'pc-q35-1.4', 'pc', 'isapc', 'pc-i440fx-2.4', 'pc-i440fx-2.3', 'pc-i440fx-2.2', 'pc-i440fx-2.1', 'pc-i440fx-2.0', 'pc-0.12', 'pc-0.13', 'pc-0.10', 'pc-0.11', 'pc-0.14', 'pc-0.15', 'pc-i440fx-1.4', 'pc-i440fx-1.5', 'pc-i440fx-1.6', 'pc-i440fx-1.7'], 'rngSources': ['random'], 'operatingSystem': {'release': '8.0.0.0', 'version': '8.0.0.0', 'name': 'Linux'}}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:30,466::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:30,466::caps::548::root::(_getKdumpStatus) Error detecting fence_kdump configuration status
Traceback (most recent call last):
  File "/usr/share/vdsm/caps.py", line 533, in _getKdumpStatus
    with open('/sys/kernel/kexec_crash_loaded', 'r') as f:
IOError: [Errno 2] No such file or directory: '/sys/kernel/kexec_crash_loaded'
jsonrpc.Executor/3::DEBUG::2016-05-25 08:42:30,468::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getCapabilities' in bridge with {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd'}], 'FC': []}, 'packages2': {'kernel': {'release': 'rt23', 'buildtime': 1464016625.0, 'version': '4.1.23'}, 'vdsm': {'release': 'r0.2', 'buildtime': 1464147403, 'version': '4.17.24'}, 'qemu-kvm': {'release': 'r1.0', 'buildtime': 1463991436, 'version': '2.4.0'}, 'python-mom': {'release': 'r0.0', 'buildtime': 1463988268, 'version': '0.5.2'}, 'libvirt': {'release': 'r1.0', 'buildtime': 1463991549, 'version': '1.3.2'}}, 'numaNodeDistance': {'0': [10]}, 'cpuModel': 'Genuine Intel(R) CPU 0000 @ 1.70GHz', 'liveMerge': 'true', 'hooks': {'before_vm_start': {'50_qemucmdline': {'md5': 'a884929ad6f5eb039887157288867409'}, '50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}, '10_faqemu': {'md5': '905dd6bc11753bc9351e85ae6ae704d0'}, '50_macspoof': {'md5': '68cf48c446387550a9a82283079b80f8'}}, 'after_network_setup': {'30_ethtool_options': {'md5': '9cdcf29a16651eb3abfda900312e8b31'}}, 'after_vm_destroy': {'50_vhostmd': {'md5': '92498ed80c0219749829ecce2813fc7c'}}, 'after_device_migrate_destination': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_device_migrate_destination': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '135e1b133e11d29ced7344aea7148ed4'}}, 'after_device_create': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'after_nic_hotplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_vm_migrate_destination': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_nic_hotunplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_vm_dehibernate': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_device_destroy': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_nic_hotplug': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}, 'before_network_setup': {'50_ipv6': {'md5': '34f9fdd03a8adf55636dcedaa49463a2'}}, 'before_device_create': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}}, 'vmTypes': ['kvm'], 'selinux': {'mode': '-1'}, 'liveSnapshot': 'true', 'kdumpStatus': -1, 'networks': {}, 'bridges': {'ovirtmgmt': {'addr': '128.224.165.170', 'cfg': {'BOOTPROTO': 'dhcp'}, 'ipv6addrs': ['fe80::213:20ff:feff:73aa/64'], 'gateway': '128.224.165.1', 'dhcpv4': False, 'netmask': '255.255.255.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['128.224.165.170/24'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': ['eth0'], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '80', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.001320ff73aa', 'bridge_id': '8000.001320ff73aa', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '26761', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}, 'docker0': {'addr': '172.17.0.1', 'cfg': {'BOOTPROTO': 'none'}, 'ipv6addrs': [], 'gateway': '', 'dhcpv4': False, 'netmask': '255.255.0.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['172.17.0.1/16'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': [], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '181', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.0242e4574c88', 'bridge_id': '8000.0242e4574c88', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '28502', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}}, 'uuid': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'onlineCpus': '0,1,2,3,4,5,6,7', 'nics': {'eth0': {'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'BOOTPROTO': 'none'}, 'hwaddr': '00:13:20:ff:73:aa', 'speed': 100, 'gateway': ''}}, 'software_revision': '0', 'hostdevPassthrough': 'true', 'clusterLevels': ['3.4', '3.5', '3.6'], 'cpuFlags': '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,pdpe1gb,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,est,tm2,ssse3,sdbg,fma,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,lahf_lm,abm,3dnowprefetch,ida,arat,epb,pln,pts,dtherm,intel_pt,tpr_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi2,erms,invpcid,rdseed,adx,smap,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_IvyBridge,model_Westmere,model_n270,model_Broadwell-noTSX,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.4', '3.5', '3.6'], 'autoNumaBalancing': 2, 'additionalFeatures': ['GLUSTER_SNAPSHOT', 'GLUSTER_GEO_REPLICATION', 'GLUSTER_BRICK_MANAGEMENT'], 'reservedMem': '321', 'bondings': {}, 'software_version': '4.17.24', 'memSize': '16032', 'cpuSpeed': '1750.734', 'numaNodes': {'0': {'totalMemory': '16032', 'cpus': [0, 1, 2, 3, 4, 5, 6, 7]}}, 'cpuSockets': '1', 'vlans': {}, 'lastClientIface': 'ovirtmgmt', 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'version_name': 'Snow Man', 'cpuThreads': '8', 'emulatedMachines': ['pc-q35-2.0', 'pc-q35-2.1', 'pc-q35-2.2', 'pc-q35-2.3', 'pc-q35-2.4', 'q35', 'pc-1.1', 'pc-1.0', 'pc-1.3', 'pc-1.2', 'pc-q35-1.7', 'pc-q35-1.6', 'pc-q35-1.5', 'pc-q35-1.4', 'pc', 'isapc', 'pc-i440fx-2.4', 'pc-i440fx-2.3', 'pc-i440fx-2.2', 'pc-i440fx-2.1', 'pc-i440fx-2.0', 'pc-0.12', 'pc-0.13', 'pc-0.10', 'pc-0.11', 'pc-0.14', 'pc-0.15', 'pc-i440fx-1.4', 'pc-i440fx-1.5', 'pc-i440fx-1.6', 'pc-i440fx-1.7'], 'rngSources': ['random'], 'operatingSystem': {'release': '8.0.0.0', 'version': '8.0.0.0', 'name': 'Linux'}}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:42:30,530::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getHardwareInfo' in bridge with {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:42:30,550::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getHardwareInfo' in bridge with {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:42:30,954::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getHardwareInfo' in bridge with {'systemProductName': 'Broadwell Client platform', 'systemSerialNumber': 'System Serial Number', 'systemFamily': 'Broadwell Client System', 'systemVersion': '0.1', 'systemUUID': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'systemManufacturer': 'Intel Corporation'}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:42:30,955::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getHardwareInfo' in bridge with {'systemProductName': 'Broadwell Client platform', 'systemSerialNumber': 'System Serial Number', 'systemFamily': 'Broadwell Client System', 'systemVersion': '0.1', 'systemUUID': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'systemManufacturer': 'Intel Corporation'}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:42:37,511::task::595::Storage.TaskManager.Task::(_updateState) Task=`7728414c-04d8-49cb-b1b3-33ad7ad4fdaf`::moving from state init -> state preparing
jsonrpc.Executor/6::INFO::2016-05-25 08:42:37,511::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/6::INFO::2016-05-25 08:42:37,511::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:42:37,511::task::1191::Storage.TaskManager.Task::(prepare) Task=`7728414c-04d8-49cb-b1b3-33ad7ad4fdaf`::finished: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:42:37,511::task::595::Storage.TaskManager.Task::(_updateState) Task=`7728414c-04d8-49cb-b1b3-33ad7ad4fdaf`::moving from state preparing -> state finished
jsonrpc.Executor/6::DEBUG::2016-05-25 08:42:37,511::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:42:37,511::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:42:37,511::task::993::Storage.TaskManager.Task::(_decref) Task=`7728414c-04d8-49cb-b1b3-33ad7ad4fdaf`::ref 0 aborting False
jsonrpc.Executor/6::WARNING::2016-05-25 08:42:37,513::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/6::WARNING::2016-05-25 08:42:37,513::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/7::DEBUG::2016-05-25 08:42:40,543::task::595::Storage.TaskManager.Task::(_updateState) Task=`3417cf89-9650-4d4e-9a56-54543a247103`::moving from state init -> state preparing
jsonrpc.Executor/7::INFO::2016-05-25 08:42:40,543::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/7::INFO::2016-05-25 08:42:40,543::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:42:40,543::task::1191::Storage.TaskManager.Task::(prepare) Task=`3417cf89-9650-4d4e-9a56-54543a247103`::finished: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:42:40,543::task::595::Storage.TaskManager.Task::(_updateState) Task=`3417cf89-9650-4d4e-9a56-54543a247103`::moving from state preparing -> state finished
jsonrpc.Executor/7::DEBUG::2016-05-25 08:42:40,543::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:42:40,543::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:42:40,543::task::993::Storage.TaskManager.Task::(_decref) Task=`3417cf89-9650-4d4e-9a56-54543a247103`::ref 0 aborting False
jsonrpc.Executor/7::WARNING::2016-05-25 08:42:40,544::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/7::WARNING::2016-05-25 08:42:40,544::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/2::DEBUG::2016-05-25 08:42:52,760::task::595::Storage.TaskManager.Task::(_updateState) Task=`989f4a2d-28ba-4e93-8d5c-fcb1f6b4518c`::moving from state init -> state preparing
jsonrpc.Executor/2::INFO::2016-05-25 08:42:52,760::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/2::INFO::2016-05-25 08:42:52,760::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:42:52,760::task::1191::Storage.TaskManager.Task::(prepare) Task=`989f4a2d-28ba-4e93-8d5c-fcb1f6b4518c`::finished: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:42:52,761::task::595::Storage.TaskManager.Task::(_updateState) Task=`989f4a2d-28ba-4e93-8d5c-fcb1f6b4518c`::moving from state preparing -> state finished
jsonrpc.Executor/2::DEBUG::2016-05-25 08:42:52,761::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:42:52,761::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:42:52,761::task::993::Storage.TaskManager.Task::(_decref) Task=`989f4a2d-28ba-4e93-8d5c-fcb1f6b4518c`::ref 0 aborting False
jsonrpc.Executor/2::WARNING::2016-05-25 08:42:52,762::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/2::WARNING::2016-05-25 08:42:52,762::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:55,781::task::595::Storage.TaskManager.Task::(_updateState) Task=`a774c49d-453e-44cd-afae-280f00914203`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:42:55,781::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:42:55,781::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:55,781::task::1191::Storage.TaskManager.Task::(prepare) Task=`a774c49d-453e-44cd-afae-280f00914203`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:55,781::task::595::Storage.TaskManager.Task::(_updateState) Task=`a774c49d-453e-44cd-afae-280f00914203`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:55,781::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:55,781::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:42:55,781::task::993::Storage.TaskManager.Task::(_decref) Task=`a774c49d-453e-44cd-afae-280f00914203`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:42:55,782::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:42:55,783::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/4::DEBUG::2016-05-25 08:43:07,953::task::595::Storage.TaskManager.Task::(_updateState) Task=`14d3f3a5-c869-43f9-8381-6633a65a39f8`::moving from state init -> state preparing
jsonrpc.Executor/4::INFO::2016-05-25 08:43:07,954::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/4::INFO::2016-05-25 08:43:07,954::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:43:07,954::task::1191::Storage.TaskManager.Task::(prepare) Task=`14d3f3a5-c869-43f9-8381-6633a65a39f8`::finished: {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:43:07,954::task::595::Storage.TaskManager.Task::(_updateState) Task=`14d3f3a5-c869-43f9-8381-6633a65a39f8`::moving from state preparing -> state finished
jsonrpc.Executor/4::DEBUG::2016-05-25 08:43:07,954::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:43:07,954::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:43:07,954::task::993::Storage.TaskManager.Task::(_decref) Task=`14d3f3a5-c869-43f9-8381-6633a65a39f8`::ref 0 aborting False
jsonrpc.Executor/4::WARNING::2016-05-25 08:43:07,955::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/4::WARNING::2016-05-25 08:43:07,956::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:43:11,053::task::595::Storage.TaskManager.Task::(_updateState) Task=`d6537d2f-c7ce-4b82-9c7f-ead9b67c5fc9`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:43:11,053::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:43:11,054::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:43:11,054::task::1191::Storage.TaskManager.Task::(prepare) Task=`d6537d2f-c7ce-4b82-9c7f-ead9b67c5fc9`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:43:11,054::task::595::Storage.TaskManager.Task::(_updateState) Task=`d6537d2f-c7ce-4b82-9c7f-ead9b67c5fc9`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:43:11,054::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:43:11,054::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:43:11,054::task::993::Storage.TaskManager.Task::(_decref) Task=`d6537d2f-c7ce-4b82-9c7f-ead9b67c5fc9`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:43:11,055::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:43:11,055::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
JsonRpc (StompReactor)::INFO::2016-05-25 08:43:13,356::stompreactor::153::Broker.StompAdapter::(_cmd_unsubscribe) Unsubscribe command received
JsonRpc (StompReactor)::DEBUG::2016-05-25 08:43:13,356::stompreactor::165::Broker.StompAdapter::(_cmd_unsubscribe) No subscription for 2a8f5d62-c2a7-4ed0-9844-f3e1f8250953 id
JsonRpc (StompReactor)::INFO::2016-05-25 08:43:13,356::stompreactor::153::Broker.StompAdapter::(_cmd_unsubscribe) Unsubscribe command received
JsonRpc (StompReactor)::DEBUG::2016-05-25 08:43:13,357::stompreactor::165::Broker.StompAdapter::(_cmd_unsubscribe) No subscription for 36861537-d621-4a42-bcab-4430d1222dbe id
JsonRpc (StompReactor)::INFO::2016-05-25 08:43:13,357::stompreactor::153::Broker.StompAdapter::(_cmd_unsubscribe) Unsubscribe command received
JsonRpc (StompReactor)::DEBUG::2016-05-25 08:43:13,357::stompreactor::165::Broker.StompAdapter::(_cmd_unsubscribe) No subscription for e952b0bd-311e-4cd4-8045-b41c16dbfda6 id
JsonRpc (StompReactor)::INFO::2016-05-25 08:43:13,357::stompreactor::153::Broker.StompAdapter::(_cmd_unsubscribe) Unsubscribe command received
JsonRpc (StompReactor)::DEBUG::2016-05-25 08:43:13,357::stompreactor::165::Broker.StompAdapter::(_cmd_unsubscribe) No subscription for 1117358f-9f5a-4781-96b1-2333ab1ab236 id
jsonrpc.Executor/7::DEBUG::2016-05-25 08:43:26,322::task::595::Storage.TaskManager.Task::(_updateState) Task=`899c9043-8cda-4bb6-bde9-3e5c69923db7`::moving from state init -> state preparing
jsonrpc.Executor/7::INFO::2016-05-25 08:43:26,322::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/7::INFO::2016-05-25 08:43:26,323::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:43:26,323::task::1191::Storage.TaskManager.Task::(prepare) Task=`899c9043-8cda-4bb6-bde9-3e5c69923db7`::finished: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:43:26,323::task::595::Storage.TaskManager.Task::(_updateState) Task=`899c9043-8cda-4bb6-bde9-3e5c69923db7`::moving from state preparing -> state finished
jsonrpc.Executor/7::DEBUG::2016-05-25 08:43:26,323::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:43:26,323::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:43:26,323::task::993::Storage.TaskManager.Task::(_decref) Task=`899c9043-8cda-4bb6-bde9-3e5c69923db7`::ref 0 aborting False
jsonrpc.Executor/7::WARNING::2016-05-25 08:43:26,324::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/7::WARNING::2016-05-25 08:43:26,324::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/2::DEBUG::2016-05-25 08:43:41,600::task::595::Storage.TaskManager.Task::(_updateState) Task=`9ce695a2-d520-4546-80b3-4c27bd7589d9`::moving from state init -> state preparing
jsonrpc.Executor/2::INFO::2016-05-25 08:43:41,600::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/2::INFO::2016-05-25 08:43:41,600::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:43:41,600::task::1191::Storage.TaskManager.Task::(prepare) Task=`9ce695a2-d520-4546-80b3-4c27bd7589d9`::finished: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:43:41,600::task::595::Storage.TaskManager.Task::(_updateState) Task=`9ce695a2-d520-4546-80b3-4c27bd7589d9`::moving from state preparing -> state finished
jsonrpc.Executor/2::DEBUG::2016-05-25 08:43:41,600::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:43:41,600::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:43:41,601::task::993::Storage.TaskManager.Task::(_decref) Task=`9ce695a2-d520-4546-80b3-4c27bd7589d9`::ref 0 aborting False
jsonrpc.Executor/2::WARNING::2016-05-25 08:43:41,601::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/2::WARNING::2016-05-25 08:43:41,602::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
MainThread::DEBUG::2016-05-25 08:43:41,989::vdsm::71::vds::(sigtermHandler) Received signal 15
MainThread::DEBUG::2016-05-25 08:43:41,989::periodic::165::virt.periodic.Operation::(stop) stopping operation <VmDispatcher operation=<class 'virt.periodic.UpdateVolumes'> at 0x7f31c00f7750>
MainThread::DEBUG::2016-05-25 08:43:41,989::periodic::165::virt.periodic.Operation::(stop) stopping operation <VmDispatcher operation=<class 'virt.periodic.NumaInfoMonitor'> at 0x7f31c00f7990>
MainThread::DEBUG::2016-05-25 08:43:41,989::periodic::165::virt.periodic.Operation::(stop) stopping operation <VmDispatcher operation=<class 'virt.periodic.BlockjobMonitor'> at 0x7f31c00f7a10>
MainThread::DEBUG::2016-05-25 08:43:41,989::periodic::165::virt.periodic.Operation::(stop) stopping operation <VMBulkSampler at 0x7f31c00f7a90>
MainThread::DEBUG::2016-05-25 08:43:41,989::periodic::165::virt.periodic.Operation::(stop) stopping operation <VmDispatcher operation=<class 'virt.periodic.DriveWatermarkMonitor'> at 0x7f31c00f7dd0>
MainThread::DEBUG::2016-05-25 08:43:41,989::executor::78::Executor::(stop) Stopping executor
MainThread::DEBUG::2016-05-25 08:43:41,989::protocoldetector::203::vds.MultiProtocolAcceptor::(stop) Stopping Acceptor
MainThread::INFO::2016-05-25 08:43:41,990::__init__::612::jsonrpc.JsonRpcServer::(stop) Stopping JsonRPC Server
MainThread::DEBUG::2016-05-25 08:43:41,990::executor::78::Executor::(stop) Stopping executor
MainThread::DEBUG::2016-05-25 08:43:41,990::executor::170::Executor::(join) Waiting for worker jsonrpc.Executor/2
jsonrpc.Executor/0::DEBUG::2016-05-25 08:43:41,990::executor::181::Executor::(_run) Worker stopped
jsonrpc.Executor/2::DEBUG::2016-05-25 08:43:41,990::executor::181::Executor::(_run) Worker stopped
MainThread::DEBUG::2016-05-25 08:43:41,990::executor::170::Executor::(join) Waiting for worker jsonrpc.Executor/3
jsonrpc.Executor/4::DEBUG::2016-05-25 08:43:41,991::executor::181::Executor::(_run) Worker stopped
jsonrpc.Executor/5::DEBUG::2016-05-25 08:43:41,991::executor::181::Executor::(_run) Worker stopped
jsonrpc.Executor/6::DEBUG::2016-05-25 08:43:41,991::executor::181::Executor::(_run) Worker stopped
jsonrpc.Executor/7::DEBUG::2016-05-25 08:43:41,991::executor::181::Executor::(_run) Worker stopped
jsonrpc.Executor/1::DEBUG::2016-05-25 08:43:41,991::executor::181::Executor::(_run) Worker stopped
jsonrpc.Executor/3::DEBUG::2016-05-25 08:43:41,992::executor::181::Executor::(_run) Worker stopped
MainThread::DEBUG::2016-05-25 08:43:41,992::executor::170::Executor::(join) Waiting for worker jsonrpc.Executor/0
MainThread::DEBUG::2016-05-25 08:43:41,992::executor::170::Executor::(join) Waiting for worker jsonrpc.Executor/6
MainThread::DEBUG::2016-05-25 08:43:41,992::executor::170::Executor::(join) Waiting for worker jsonrpc.Executor/1
MainThread::DEBUG::2016-05-25 08:43:41,992::executor::170::Executor::(join) Waiting for worker jsonrpc.Executor/5
MainThread::DEBUG::2016-05-25 08:43:41,992::executor::170::Executor::(join) Waiting for worker jsonrpc.Executor/4
MainThread::DEBUG::2016-05-25 08:43:41,992::executor::170::Executor::(join) Waiting for worker jsonrpc.Executor/7
MainThread::INFO::2016-05-25 08:43:41,992::bindingxmlrpc::85::vds::(stop) Stopping XMLRPC server
BindingXMLRPC::INFO::2016-05-25 08:43:41,992::bindingxmlrpc::74::vds::(threaded_start) XMLRPC server stopped
MainThread::INFO::2016-05-25 08:43:41,992::secret::90::root::(clear) Unregistering all secrests
MainThread::DEBUG::2016-05-25 08:43:41,993::vmchannels::207::vds::(stop) VM channels listener was stopped.
MainThread::DEBUG::2016-05-25 08:43:41,993::task::595::Storage.TaskManager.Task::(_updateState) Task=`32a4c8c1-ee05-4712-9447-ac727b6c4acb`::moving from state init -> state preparing
MainThread::INFO::2016-05-25 08:43:41,993::logUtils::48::dispatcher::(wrapper) Run and protect: prepareForShutdown(options=None)
Thread-12::DEBUG::2016-05-25 08:43:41,993::storageServer::864::Storage.ConnectionMonitor::(_monitorConnections) Monitoring stopped
MainThread::INFO::2016-05-25 08:43:42,007::monitor::156::Storage.Monitor::(shutdown) Shutting down domain monitors
MainThread::DEBUG::2016-05-25 08:43:42,007::taskManager::90::Storage.TaskManager::(prepareForShutdown) Request to stop all tasks
MainThread::INFO::2016-05-25 08:43:42,008::logUtils::51::dispatcher::(wrapper) Run and protect: prepareForShutdown, Return response: None
MainThread::DEBUG::2016-05-25 08:43:42,008::task::1191::Storage.TaskManager.Task::(prepare) Task=`32a4c8c1-ee05-4712-9447-ac727b6c4acb`::finished: None
MainThread::DEBUG::2016-05-25 08:43:42,008::task::595::Storage.TaskManager.Task::(_updateState) Task=`32a4c8c1-ee05-4712-9447-ac727b6c4acb`::moving from state preparing -> state finished
MainThread::DEBUG::2016-05-25 08:43:42,008::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2016-05-25 08:43:42,008::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2016-05-25 08:43:42,008::task::993::Storage.TaskManager.Task::(_decref) Task=`32a4c8c1-ee05-4712-9447-ac727b6c4acb`::ref 0 aborting False
MainThread::DEBUG::2016-05-25 08:43:42,008::schedule::110::Scheduler::(stop) Stopping scheduler vdsm.Scheduler
vdsm.Scheduler::DEBUG::2016-05-25 08:43:42,008::schedule::145::Scheduler::(_run) stopped
MainThread::INFO::2016-05-25 08:43:42,008::vdsm::173::vds::(run) VDSM main thread ended. Waiting for 17 other threads...
MainThread::INFO::2016-05-25 08:43:42,008::vdsm::177::vds::(run) <_MainThread(MainThread, started 139851936933632)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <Thread(Thread-1, started daemon 139851698743040)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <WorkerThread(Thread-5, started daemon 139851315803904)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <WorkerThread(Thread-11, started daemon 139851265447680)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <WorkerThread(Thread-10, started daemon 139851273840384)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <WorkerThread(Thread-9, started daemon 139851282233088)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <WorkerThread(Thread-8, started daemon 139851290625792)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <WorkerThread(Thread-7, started daemon 139851299018496)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <WorkerThread(Thread-6, started daemon 139851307411200)>
MainThread::DEBUG::2016-05-25 08:43:42,009::vmchannels::207::vds::(stop) VM channels listener was stopped.
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <Listener(VM Channels Listener, started daemon 139850736969472)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <Thread(periodic/2, started daemon 139849663227648)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <Thread(periodic/3, started daemon 139849654834944)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <WorkerThread(Thread-4, started daemon 139851665172224)>
MainThread::INFO::2016-05-25 08:43:42,009::vdsm::177::vds::(run) <Thread(periodic/1, started daemon 139849671620352)>
MainThread::INFO::2016-05-25 08:43:42,010::vdsm::177::vds::(run) <WorkerThread(Thread-3, started daemon 139851673564928)>
MainThread::INFO::2016-05-25 08:43:42,010::vdsm::177::vds::(run) <Thread(periodic/0, started daemon 139849680013056)>
MainThread::INFO::2016-05-25 08:43:42,010::vdsm::177::vds::(run) <WorkerThread(Thread-2, started daemon 139851681957632)>
MainThread::INFO::2016-05-25 08:43:42,010::vdsm::177::vds::(run) <Thread(libvirtEventLoop, started daemon 139851690350336)>
periodic/0::DEBUG::2016-05-25 08:43:41,993::executor::181::Executor::(_run) Worker stopped
periodic/1::DEBUG::2016-05-25 08:43:42,010::executor::181::Executor::(_run) Worker stopped
MainThread::WARNING::2016-05-25 08:44:24,754::vdsmDebugPlugin::40::DebugInterpreter::(turnOnDebugPlugin) Starting Debug Interpreter. Tread lightly!
MainThread::INFO::2016-05-25 08:44:24,755::vdsm::161::vds::(run) (PID: 2252) I am the actual vdsm 4.17.24.0 SDP_Basking-Ridge-3 (4.1.23-rt23)
MainThread::INFO::2016-05-25 08:44:24,755::vdsm::284::vds::(__set_cpu_affinity) VDSM will run with cpu affinity: frozenset([1])
MainThread::DEBUG::2016-05-25 08:44:24,755::utils::671::root::(execCmd) /usr/bin/taskset --all-tasks --pid --cpu-list 1 2252 (cwd None)
MainThread::DEBUG::2016-05-25 08:44:24,757::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2016-05-25 08:44:24,758::resourceManager::424::Storage.ResourceManager::(registerNamespace) Registering namespace 'Storage'
MainThread::DEBUG::2016-05-25 08:44:24,758::threadPool::29::Storage.ThreadPool::(__init__) Enter - numThreads: 10, waitTimeout: 3, maxTasks: 500
MainThread::DEBUG::2016-05-25 08:44:24,760::fileUtils::143::Storage.fileUtils::(createdir) Creating directory: /redhat/data-center/mnt mode: None
MainThread::WARNING::2016-05-25 08:44:24,760::fileUtils::152::Storage.fileUtils::(createdir) Dir /redhat/data-center/mnt already exists
MainThread::DEBUG::2016-05-25 08:44:24,773::hsm::409::Storage.Misc.excCmd::(__validateLvmLockingType) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/sbin/lvm dumpconfig global/locking_type (cwd None)
MainThread::DEBUG::2016-05-25 08:44:24,780::hsm::409::Storage.Misc.excCmd::(__validateLvmLockingType) SUCCESS: <err> = '  /run/lvm/lvmetad.socket: connect failed: No such file or directory\n  WARNING: Failed to connect to lvmetad. Falling back to internal scanning.\n'; <rc> = 0
MainThread::WARNING::2016-05-25 08:44:24,780::outOfProcess::68::Storage.oop::(setDefaultImpl) Cannot import IOProcess, set oop to use RFH
MainThread::DEBUG::2016-05-25 08:44:24,781::hsm::433::Storage.HSM::(__cleanStorageRepository) Started cleaning storage repository at '/redhat/data-center'
MainThread::DEBUG::2016-05-25 08:44:24,782::hsm::465::Storage.HSM::(__cleanStorageRepository) White list: ['/redhat/data-center/hsm-tasks', '/redhat/data-center/hsm-tasks/*', '/redhat/data-center/mnt']
MainThread::DEBUG::2016-05-25 08:44:24,782::hsm::466::Storage.HSM::(__cleanStorageRepository) Mount list: []
MainThread::DEBUG::2016-05-25 08:44:24,782::hsm::468::Storage.HSM::(__cleanStorageRepository) Cleaning leftovers
MainThread::DEBUG::2016-05-25 08:44:24,804::hsm::511::Storage.HSM::(__cleanStorageRepository) Finished cleaning storage repository at '/redhat/data-center'
MainThread::INFO::2016-05-25 08:44:24,806::dispatcher::46::Storage.Dispatcher::(__init__) Starting StorageDispatcher...
MainThread::DEBUG::2016-05-25 08:44:24,806::schedule::98::Scheduler::(start) Starting scheduler vdsm.Scheduler
storageRefresh::DEBUG::2016-05-25 08:44:24,807::misc::750::Storage.SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)
storageRefresh::DEBUG::2016-05-25 08:44:24,807::misc::753::Storage.SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2016-05-25 08:44:24,807::misc::750::Storage.SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
storageRefresh::DEBUG::2016-05-25 08:44:24,807::misc::753::Storage.SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2016-05-25 08:44:24,807::iscsi::434::Storage.ISCSI::(rescan) Performing SCSI scan, this will take up to 30 seconds
storageRefresh::DEBUG::2016-05-25 08:44:24,807::iscsiadm::97::Storage.Misc.excCmd::(_runCmd) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /sbin/iscsiadm -m session -R (cwd None)
vdsm.Scheduler::DEBUG::2016-05-25 08:44:24,924::schedule::142::Scheduler::(_run) started
storageRefresh::DEBUG::2016-05-25 08:44:24,927::misc::760::Storage.SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2016-05-25 08:44:24,927::misc::750::Storage.SamplingMethod::(__call__) Trying to enter sampling method (storage.hba.rescan)
storageRefresh::DEBUG::2016-05-25 08:44:24,927::misc::753::Storage.SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2016-05-25 08:44:24,927::hba::56::Storage.HBA::(rescan) Starting scan
storageRefresh::DEBUG::2016-05-25 08:44:24,927::supervdsm::76::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm
MainThread::DEBUG::2016-05-25 08:44:24,929::task::595::Storage.TaskManager.Task::(_updateState) Task=`50fab7c6-8e50-4b07-82d0-060dc3f34d17`::moving from state init -> state preparing
MainThread::INFO::2016-05-25 08:44:24,929::logUtils::48::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback(callbackFunc=<functools.partial object at 0x7f6544694940>)
MainThread::INFO::2016-05-25 08:44:24,929::logUtils::51::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback, Return response: None
MainThread::DEBUG::2016-05-25 08:44:24,929::task::1191::Storage.TaskManager.Task::(prepare) Task=`50fab7c6-8e50-4b07-82d0-060dc3f34d17`::finished: None
MainThread::DEBUG::2016-05-25 08:44:24,932::task::595::Storage.TaskManager.Task::(_updateState) Task=`50fab7c6-8e50-4b07-82d0-060dc3f34d17`::moving from state preparing -> state finished
MainThread::DEBUG::2016-05-25 08:44:24,932::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2016-05-25 08:44:24,932::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2016-05-25 08:44:24,933::task::993::Storage.TaskManager.Task::(_decref) Task=`50fab7c6-8e50-4b07-82d0-060dc3f34d17`::ref 0 aborting False
MainThread::INFO::2016-05-25 08:44:24,933::momIF::46::MOM::(__init__) Preparing MOM interface
MainThread::INFO::2016-05-25 08:44:24,934::momIF::55::MOM::(__init__) Using named unix socket /var/run/vdsm/mom-vdsm.sock
MainThread::INFO::2016-05-25 08:44:24,936::secret::90::root::(clear) Unregistering all secrests
MainThread::DEBUG::2016-05-25 08:44:24,936::libvirtconnection::161::root::(get) trying to connect libvirt
MainThread::INFO::2016-05-25 08:44:24,938::vmchannels::211::vds::(settimeout) Setting channels' timeout to 30 seconds.
clientIFinit::DEBUG::2016-05-25 08:44:24,938::clientIF::462::vds::(_recoverExistingVms) recovery: started
MainThread::INFO::2016-05-25 08:44:24,938::protocoldetector::172::vds.MultiProtocolAcceptor::(__init__) Listening at 0.0.0.0:54321
MainThread::DEBUG::2016-05-25 08:44:24,969::protocoldetector::199::vds.MultiProtocolAcceptor::(add_detector) Adding detector <rpc.bindingxmlrpc.XmlDetector instance at 0x7f654c1b6d88>
clientIFinit::INFO::2016-05-25 08:44:24,973::clientIF::553::vds::(_recoverExistingVms) recovery: completed in 0s
VM Channels Listener::DEBUG::2016-05-25 08:44:24,978::vmchannels::193::vds::(run) Starting VM channels listener thread.
storageRefresh::DEBUG::2016-05-25 08:44:24,989::hba::62::Storage.HBA::(rescan) Scan finished
storageRefresh::DEBUG::2016-05-25 08:44:24,989::misc::760::Storage.SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2016-05-25 08:44:24,989::multipath::77::Storage.Misc.excCmd::(rescan) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/bin/multipath (cwd None)
MainThread::DEBUG::2016-05-25 08:44:25,036::protocoldetector::199::vds.MultiProtocolAcceptor::(add_detector) Adding detector <yajsonrpc.stompreactor.StompDetector instance at 0x7f65447b8488>
MainThread::DEBUG::2016-05-25 08:44:25,036::executor::69::Executor::(start) Starting executor
MainThread::DEBUG::2016-05-25 08:44:25,036::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/0
MainThread::DEBUG::2016-05-25 08:44:25,037::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/1
jsonrpc.Executor/0::DEBUG::2016-05-25 08:44:25,037::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:44:25,037::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/2
jsonrpc.Executor/1::DEBUG::2016-05-25 08:44:25,037::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:44:25,038::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/3
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,038::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:44:25,038::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/4
jsonrpc.Executor/3::DEBUG::2016-05-25 08:44:25,038::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:44:25,038::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/5
jsonrpc.Executor/4::DEBUG::2016-05-25 08:44:25,038::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:44:25,038::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/6
jsonrpc.Executor/5::DEBUG::2016-05-25 08:44:25,039::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:44:25,039::executor::161::Executor::(__init__) Starting worker jsonrpc.Executor/7
jsonrpc.Executor/6::DEBUG::2016-05-25 08:44:25,039::executor::176::Executor::(_run) Worker started
jsonrpc.Executor/7::DEBUG::2016-05-25 08:44:25,039::executor::176::Executor::(_run) Worker started
BindingXMLRPC::INFO::2016-05-25 08:44:25,039::bindingxmlrpc::62::vds::(threaded_start) XMLRPC server running
MainThread::DEBUG::2016-05-25 08:44:25,040::executor::69::Executor::(start) Starting executor
MainThread::DEBUG::2016-05-25 08:44:25,040::executor::161::Executor::(__init__) Starting worker periodic/0
MainThread::DEBUG::2016-05-25 08:44:25,041::executor::161::Executor::(__init__) Starting worker periodic/1
periodic/0::DEBUG::2016-05-25 08:44:25,041::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:44:25,041::executor::161::Executor::(__init__) Starting worker periodic/2
periodic/1::DEBUG::2016-05-25 08:44:25,041::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:44:25,041::executor::161::Executor::(__init__) Starting worker periodic/3
periodic/2::DEBUG::2016-05-25 08:44:25,041::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:44:25,042::libvirtconnection::161::root::(get) trying to connect libvirt
periodic/3::DEBUG::2016-05-25 08:44:25,042::executor::176::Executor::(_run) Worker started
MainThread::DEBUG::2016-05-25 08:44:25,044::periodic::156::virt.periodic.Operation::(start) starting operation <VmDispatcher operation=<class 'virt.periodic.UpdateVolumes'> at 0x7f654472b650>
MainThread::DEBUG::2016-05-25 08:44:25,045::periodic::156::virt.periodic.Operation::(start) starting operation <VmDispatcher operation=<class 'virt.periodic.NumaInfoMonitor'> at 0x7f654472b890>
MainThread::DEBUG::2016-05-25 08:44:25,045::periodic::156::virt.periodic.Operation::(start) starting operation <VmDispatcher operation=<class 'virt.periodic.BlockjobMonitor'> at 0x7f654472b910>
MainThread::DEBUG::2016-05-25 08:44:25,045::periodic::156::virt.periodic.Operation::(start) starting operation <VMBulkSampler at 0x7f654472b990>
MainThread::DEBUG::2016-05-25 08:44:25,045::periodic::156::virt.periodic.Operation::(start) starting operation <VmDispatcher operation=<class 'virt.periodic.DriveWatermarkMonitor'> at 0x7f654472bcd0>
Reactor thread::INFO::2016-05-25 08:44:25,421::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle_accept) Accepting connection from 128.224.162.248:39816
Reactor thread::DEBUG::2016-05-25 08:44:25,421::protocoldetector::82::ProtocolDetector.Detector::(__init__) Using required_size=11
Reactor thread::INFO::2016-05-25 08:44:25,422::protocoldetector::118::ProtocolDetector.Detector::(handle_read) Detected protocol stomp from 128.224.162.248:39816
Reactor thread::INFO::2016-05-25 08:44:25,422::stompreactor::101::Broker.StompAdapter::(_cmd_connect) Processing CONNECT request
Reactor thread::INFO::2016-05-25 08:44:25,423::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe) Subscribe command received
Reactor thread::INFO::2016-05-25 08:44:25,423::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe) Subscribe command received
Reactor thread::DEBUG::2016-05-25 08:44:25,423::stompreactor::470::protocoldetector.StompDetector::(handle_socket) Stomp detected from ('128.224.162.248', 39816)
jsonrpc.Executor/0::DEBUG::2016-05-25 08:44:25,427::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.ping' in bridge with {}
jsonrpc.Executor/0::DEBUG::2016-05-25 08:44:25,428::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.ping' in bridge with True
storageRefresh::DEBUG::2016-05-25 08:44:25,439::multipath::77::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:44:25,440::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /bin/udevadm settle --timeout=5 (cwd None)
storageRefresh::DEBUG::2016-05-25 08:44:25,444::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/1::DEBUG::2016-05-25 08:44:25,446::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.ping' in bridge with {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:44:25,446::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.ping' in bridge with True
storageRefresh::DEBUG::2016-05-25 08:44:25,447::lvm::497::Storage.OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:25,447::lvm::499::Storage.OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:25,448::lvm::508::Storage.OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:25,448::lvm::510::Storage.OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:25,448::lvm::528::Storage.OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:25,448::lvm::530::Storage.OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:25,448::misc::760::Storage.SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2016-05-25 08:44:25,448::lvm::319::Storage.OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:25,449::lvm::290::Storage.Misc.excCmd::(cmd) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/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  use_lvmetad=0 }  backup {  retain_min = 50  retain_days = 0 } ' --noheadings --units b --nosuffix --separator '|' --ignoreskippedcluster -o uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,dev_size (cwd None)
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,462::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getCapabilities' in bridge with {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,500::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /sbin/tc qdisc show (cwd None)
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,504::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,511::caps::841::root::(_getKeyPackages) rpm package libspice-server1 not found
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,528::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 numactl --hardware (cwd None)
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,531::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,532::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 sysctl -n -e kernel.numa_balancing (cwd None)
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,535::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,561::caps::548::root::(_getKdumpStatus) Error detecting fence_kdump configuration status
Traceback (most recent call last):
  File "/usr/share/vdsm/caps.py", line 533, in _getKdumpStatus
    with open('/sys/kernel/kexec_crash_loaded', 'r') as f:
IOError: [Errno 2] No such file or directory: '/sys/kernel/kexec_crash_loaded'
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:25,562::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getCapabilities' in bridge with {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd'}], 'FC': []}, 'packages2': {'kernel': {'release': 'rt23', 'buildtime': 1464016625.0, 'version': '4.1.23'}, 'vdsm': {'release': 'r0.2', 'buildtime': 1464147403, 'version': '4.17.24'}, 'qemu-kvm': {'release': 'r1.0', 'buildtime': 1463991436, 'version': '2.4.0'}, 'python-mom': {'release': 'r0.0', 'buildtime': 1463988268, 'version': '0.5.2'}, 'libvirt': {'release': 'r1.0', 'buildtime': 1463991549, 'version': '1.3.2'}}, 'numaNodeDistance': {'0': [10]}, 'cpuModel': 'Genuine Intel(R) CPU 0000 @ 1.70GHz', 'liveMerge': 'true', 'hooks': {'before_vm_start': {'50_qemucmdline': {'md5': 'a884929ad6f5eb039887157288867409'}, '50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}, '10_faqemu': {'md5': '905dd6bc11753bc9351e85ae6ae704d0'}, '50_macspoof': {'md5': '68cf48c446387550a9a82283079b80f8'}}, 'after_network_setup': {'30_ethtool_options': {'md5': '9cdcf29a16651eb3abfda900312e8b31'}}, 'after_vm_destroy': {'50_vhostmd': {'md5': '92498ed80c0219749829ecce2813fc7c'}}, 'after_device_migrate_destination': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_device_migrate_destination': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '135e1b133e11d29ced7344aea7148ed4'}}, 'after_device_create': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'after_nic_hotplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_vm_migrate_destination': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_nic_hotunplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_vm_dehibernate': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_device_destroy': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_nic_hotplug': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}, 'before_network_setup': {'50_ipv6': {'md5': '34f9fdd03a8adf55636dcedaa49463a2'}}, 'before_device_create': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}}, 'vmTypes': ['kvm'], 'selinux': {'mode': '-1'}, 'liveSnapshot': 'true', 'kdumpStatus': -1, 'networks': {}, 'bridges': {'ovirtmgmt': {'addr': '128.224.165.170', 'cfg': {'BOOTPROTO': 'dhcp'}, 'ipv6addrs': ['fe80::213:20ff:feff:73aa/64'], 'gateway': '128.224.165.1', 'dhcpv4': False, 'netmask': '255.255.255.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['128.224.165.170/24'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': ['eth0'], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '61', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.001320ff73aa', 'bridge_id': '8000.001320ff73aa', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '15143', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}, 'docker0': {'addr': '172.17.0.1', 'cfg': {'BOOTPROTO': 'none'}, 'ipv6addrs': [], 'gateway': '', 'dhcpv4': False, 'netmask': '255.255.0.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['172.17.0.1/16'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': [], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '163', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.0242e4574c88', 'bridge_id': '8000.0242e4574c88', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '16883', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}}, 'uuid': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'onlineCpus': '0,1,2,3,4,5,6,7', 'nics': {'eth0': {'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'BOOTPROTO': 'none'}, 'hwaddr': '00:13:20:ff:73:aa', 'speed': 100, 'gateway': ''}}, 'software_revision': '0', 'hostdevPassthrough': 'true', 'clusterLevels': ['3.4', '3.5', '3.6'], 'cpuFlags': '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,pdpe1gb,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,est,tm2,ssse3,sdbg,fma,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,lahf_lm,abm,3dnowprefetch,ida,arat,epb,pln,pts,dtherm,intel_pt,tpr_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi2,erms,invpcid,rdseed,adx,smap,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_IvyBridge,model_Westmere,model_n270,model_Broadwell-noTSX,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.4', '3.5', '3.6'], 'autoNumaBalancing': 2, 'additionalFeatures': ['GLUSTER_SNAPSHOT', 'GLUSTER_GEO_REPLICATION', 'GLUSTER_BRICK_MANAGEMENT'], 'reservedMem': '321', 'bondings': {}, 'software_version': '4.17.24', 'memSize': '16032', 'cpuSpeed': '1888.062', 'numaNodes': {'0': {'totalMemory': '16032', 'cpus': [0, 1, 2, 3, 4, 5, 6, 7]}}, 'cpuSockets': '1', 'vlans': {}, 'lastClientIface': 'ovirtmgmt', 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'version_name': 'Snow Man', 'cpuThreads': '8', 'emulatedMachines': ['pc-q35-2.0', 'pc-q35-2.1', 'pc-q35-2.2', 'pc-q35-2.3', 'pc-q35-2.4', 'q35', 'pc-1.1', 'pc-1.0', 'pc-1.3', 'pc-1.2', 'pc-q35-1.7', 'pc-q35-1.6', 'pc-q35-1.5', 'pc-q35-1.4', 'pc', 'isapc', 'pc-i440fx-2.4', 'pc-i440fx-2.3', 'pc-i440fx-2.2', 'pc-i440fx-2.1', 'pc-i440fx-2.0', 'pc-0.12', 'pc-0.13', 'pc-0.10', 'pc-0.11', 'pc-0.14', 'pc-0.15', 'pc-i440fx-1.4', 'pc-i440fx-1.5', 'pc-i440fx-1.6', 'pc-i440fx-1.7'], 'rngSources': ['random'], 'operatingSystem': {'release': '8.0.0.0', 'version': '8.0.0.0', 'name': 'Linux'}}
storageRefresh::DEBUG::2016-05-25 08:44:25,849::lvm::290::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:44:25,850::lvm::347::Storage.OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:25,850::lvm::370::Storage.OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:25,851::lvm::290::Storage.Misc.excCmd::(cmd) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/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  use_lvmetad=0 }  backup {  retain_min = 50  retain_days = 0 } ' --noheadings --units b --nosuffix --separator '|' --ignoreskippedcluster -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name (cwd None)
storageRefresh::DEBUG::2016-05-25 08:44:25,954::lvm::290::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:44:25,955::lvm::415::Storage.OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:25,955::lvm::290::Storage.Misc.excCmd::(cmd) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/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  use_lvmetad=0 }  backup {  retain_min = 50  retain_days = 0 } ' --noheadings --units b --nosuffix --separator '|' --ignoreskippedcluster -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags (cwd None)
storageRefresh::DEBUG::2016-05-25 08:44:26,067::lvm::290::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:44:26,068::lvm::370::Storage.OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:26,068::lvm::290::Storage.Misc.excCmd::(cmd) /usr/bin/taskset --cpu-list 0-7 /usr/bin/sudo -n /usr/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  use_lvmetad=0 }  backup {  retain_min = 50  retain_days = 0 } ' --noheadings --units b --nosuffix --separator '|' --ignoreskippedcluster -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name (cwd None)
storageRefresh::DEBUG::2016-05-25 08:44:26,175::lvm::290::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2016-05-25 08:44:26,176::lvm::415::Storage.OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2016-05-25 08:44:26,176::hsm::379::Storage.HSM::(storageRefresh) HSM is ready
Reactor thread::INFO::2016-05-25 08:44:27,610::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle_accept) Accepting connection from 128.224.178.67:59426
Reactor thread::DEBUG::2016-05-25 08:44:27,611::protocoldetector::82::ProtocolDetector.Detector::(__init__) Using required_size=11
Reactor thread::INFO::2016-05-25 08:44:27,611::protocoldetector::118::ProtocolDetector.Detector::(handle_read) Detected protocol stomp from 128.224.178.67:59426
Reactor thread::INFO::2016-05-25 08:44:27,612::stompreactor::101::Broker.StompAdapter::(_cmd_connect) Processing CONNECT request
Reactor thread::INFO::2016-05-25 08:44:27,612::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe) Subscribe command received
Reactor thread::INFO::2016-05-25 08:44:27,612::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe) Subscribe command received
Reactor thread::DEBUG::2016-05-25 08:44:27,612::stompreactor::470::protocoldetector.StompDetector::(handle_socket) Stomp detected from ('128.224.178.67', 59426)
jsonrpc.Executor/3::DEBUG::2016-05-25 08:44:27,617::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getCapabilities' in bridge with {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:44:27,665::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /sbin/tc qdisc show (cwd None)
jsonrpc.Executor/3::DEBUG::2016-05-25 08:44:27,669::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/3::DEBUG::2016-05-25 08:44:27,701::caps::841::root::(_getKeyPackages) rpm package libspice-server1 not found
jsonrpc.Executor/3::DEBUG::2016-05-25 08:44:27,702::caps::548::root::(_getKdumpStatus) Error detecting fence_kdump configuration status
Traceback (most recent call last):
  File "/usr/share/vdsm/caps.py", line 533, in _getKdumpStatus
    with open('/sys/kernel/kexec_crash_loaded', 'r') as f:
IOError: [Errno 2] No such file or directory: '/sys/kernel/kexec_crash_loaded'
jsonrpc.Executor/3::DEBUG::2016-05-25 08:44:27,703::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getCapabilities' in bridge with {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd'}], 'FC': []}, 'packages2': {'kernel': {'release': 'rt23', 'buildtime': 1464016625.0, 'version': '4.1.23'}, 'vdsm': {'release': 'r0.2', 'buildtime': 1464147403, 'version': '4.17.24'}, 'qemu-kvm': {'release': 'r1.0', 'buildtime': 1463991436, 'version': '2.4.0'}, 'python-mom': {'release': 'r0.0', 'buildtime': 1463988268, 'version': '0.5.2'}, 'libvirt': {'release': 'r1.0', 'buildtime': 1463991549, 'version': '1.3.2'}}, 'numaNodeDistance': {'0': [10]}, 'cpuModel': 'Genuine Intel(R) CPU 0000 @ 1.70GHz', 'liveMerge': 'true', 'hooks': {'before_vm_start': {'50_qemucmdline': {'md5': 'a884929ad6f5eb039887157288867409'}, '50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}, '10_faqemu': {'md5': '905dd6bc11753bc9351e85ae6ae704d0'}, '50_macspoof': {'md5': '68cf48c446387550a9a82283079b80f8'}}, 'after_network_setup': {'30_ethtool_options': {'md5': '9cdcf29a16651eb3abfda900312e8b31'}}, 'after_vm_destroy': {'50_vhostmd': {'md5': '92498ed80c0219749829ecce2813fc7c'}}, 'after_device_migrate_destination': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_device_migrate_destination': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '135e1b133e11d29ced7344aea7148ed4'}}, 'after_device_create': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'after_nic_hotplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_vm_migrate_destination': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_nic_hotunplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_vm_dehibernate': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_device_destroy': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_nic_hotplug': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}, 'before_network_setup': {'50_ipv6': {'md5': '34f9fdd03a8adf55636dcedaa49463a2'}}, 'before_device_create': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}}, 'vmTypes': ['kvm'], 'selinux': {'mode': '-1'}, 'liveSnapshot': 'true', 'kdumpStatus': -1, 'networks': {}, 'bridges': {'ovirtmgmt': {'addr': '128.224.165.170', 'cfg': {'BOOTPROTO': 'dhcp'}, 'ipv6addrs': ['fe80::213:20ff:feff:73aa/64'], 'gateway': '128.224.165.1', 'dhcpv4': False, 'netmask': '255.255.255.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['128.224.165.170/24'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': ['eth0'], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '45', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.001320ff73aa', 'bridge_id': '8000.001320ff73aa', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '14926', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}, 'docker0': {'addr': '172.17.0.1', 'cfg': {'BOOTPROTO': 'none'}, 'ipv6addrs': [], 'gateway': '', 'dhcpv4': False, 'netmask': '255.255.0.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['172.17.0.1/16'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': [], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '146', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.0242e4574c88', 'bridge_id': '8000.0242e4574c88', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '16667', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}}, 'uuid': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'onlineCpus': '0,1,2,3,4,5,6,7', 'nics': {'eth0': {'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'BOOTPROTO': 'none'}, 'hwaddr': '00:13:20:ff:73:aa', 'speed': 100, 'gateway': ''}}, 'software_revision': '0', 'hostdevPassthrough': 'true', 'clusterLevels': ['3.4', '3.5', '3.6'], 'cpuFlags': '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,pdpe1gb,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,est,tm2,ssse3,sdbg,fma,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,lahf_lm,abm,3dnowprefetch,ida,arat,epb,pln,pts,dtherm,intel_pt,tpr_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi2,erms,invpcid,rdseed,adx,smap,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_IvyBridge,model_Westmere,model_n270,model_Broadwell-noTSX,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.4', '3.5', '3.6'], 'autoNumaBalancing': 2, 'additionalFeatures': ['GLUSTER_SNAPSHOT', 'GLUSTER_GEO_REPLICATION', 'GLUSTER_BRICK_MANAGEMENT'], 'reservedMem': '321', 'bondings': {}, 'software_version': '4.17.24', 'memSize': '16032', 'cpuSpeed': '1699.933', 'numaNodes': {'0': {'totalMemory': '16032', 'cpus': [0, 1, 2, 3, 4, 5, 6, 7]}}, 'cpuSockets': '1', 'vlans': {}, 'lastClientIface': 'ovirtmgmt', 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'version_name': 'Snow Man', 'cpuThreads': '8', 'emulatedMachines': ['pc-q35-2.0', 'pc-q35-2.1', 'pc-q35-2.2', 'pc-q35-2.3', 'pc-q35-2.4', 'q35', 'pc-1.1', 'pc-1.0', 'pc-1.3', 'pc-1.2', 'pc-q35-1.7', 'pc-q35-1.6', 'pc-q35-1.5', 'pc-q35-1.4', 'pc', 'isapc', 'pc-i440fx-2.4', 'pc-i440fx-2.3', 'pc-i440fx-2.2', 'pc-i440fx-2.1', 'pc-i440fx-2.0', 'pc-0.12', 'pc-0.13', 'pc-0.10', 'pc-0.11', 'pc-0.14', 'pc-0.15', 'pc-i440fx-1.4', 'pc-i440fx-1.5', 'pc-i440fx-1.6', 'pc-i440fx-1.7'], 'rngSources': ['random'], 'operatingSystem': {'release': '8.0.0.0', 'version': '8.0.0.0', 'name': 'Linux'}}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:44:27,785::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getHardwareInfo' in bridge with {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:44:27,817::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getHardwareInfo' in bridge with {'systemProductName': 'Broadwell Client platform', 'systemSerialNumber': 'System Serial Number', 'systemFamily': 'Broadwell Client System', 'systemVersion': '0.1', 'systemUUID': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'systemManufacturer': 'Intel Corporation'}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:44:28,683::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getCapabilities' in bridge with {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:44:28,702::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /sbin/tc qdisc show (cwd None)
jsonrpc.Executor/5::DEBUG::2016-05-25 08:44:28,706::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/5::DEBUG::2016-05-25 08:44:28,711::caps::841::root::(_getKeyPackages) rpm package libspice-server1 not found
jsonrpc.Executor/5::DEBUG::2016-05-25 08:44:28,712::caps::548::root::(_getKdumpStatus) Error detecting fence_kdump configuration status
Traceback (most recent call last):
  File "/usr/share/vdsm/caps.py", line 533, in _getKdumpStatus
    with open('/sys/kernel/kexec_crash_loaded', 'r') as f:
IOError: [Errno 2] No such file or directory: '/sys/kernel/kexec_crash_loaded'
jsonrpc.Executor/5::DEBUG::2016-05-25 08:44:28,713::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getCapabilities' in bridge with {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd'}], 'FC': []}, 'packages2': {'kernel': {'release': 'rt23', 'buildtime': 1464016625.0, 'version': '4.1.23'}, 'vdsm': {'release': 'r0.2', 'buildtime': 1464147403, 'version': '4.17.24'}, 'qemu-kvm': {'release': 'r1.0', 'buildtime': 1463991436, 'version': '2.4.0'}, 'python-mom': {'release': 'r0.0', 'buildtime': 1463988268, 'version': '0.5.2'}, 'libvirt': {'release': 'r1.0', 'buildtime': 1463991549, 'version': '1.3.2'}}, 'numaNodeDistance': {'0': [10]}, 'cpuModel': 'Genuine Intel(R) CPU 0000 @ 1.70GHz', 'liveMerge': 'true', 'hooks': {'before_vm_start': {'50_qemucmdline': {'md5': 'a884929ad6f5eb039887157288867409'}, '50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}, '10_faqemu': {'md5': '905dd6bc11753bc9351e85ae6ae704d0'}, '50_macspoof': {'md5': '68cf48c446387550a9a82283079b80f8'}}, 'after_network_setup': {'30_ethtool_options': {'md5': '9cdcf29a16651eb3abfda900312e8b31'}}, 'after_vm_destroy': {'50_vhostmd': {'md5': '92498ed80c0219749829ecce2813fc7c'}}, 'after_device_migrate_destination': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_device_migrate_destination': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '135e1b133e11d29ced7344aea7148ed4'}}, 'after_device_create': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'after_nic_hotplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_vm_migrate_destination': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_nic_hotunplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_vm_dehibernate': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_device_destroy': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_nic_hotplug': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}, 'before_network_setup': {'50_ipv6': {'md5': '34f9fdd03a8adf55636dcedaa49463a2'}}, 'before_device_create': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}}, 'vmTypes': ['kvm'], 'selinux': {'mode': '-1'}, 'liveSnapshot': 'true', 'kdumpStatus': -1, 'networks': {}, 'bridges': {'ovirtmgmt': {'addr': '128.224.165.170', 'cfg': {'BOOTPROTO': 'dhcp'}, 'ipv6addrs': ['fe80::213:20ff:feff:73aa/64'], 'gateway': '128.224.165.1', 'dhcpv4': False, 'netmask': '255.255.255.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['128.224.165.170/24'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': ['eth0'], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '141', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.001320ff73aa', 'bridge_id': '8000.001320ff73aa', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '14823', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}, 'docker0': {'addr': '172.17.0.1', 'cfg': {'BOOTPROTO': 'none'}, 'ipv6addrs': [], 'gateway': '', 'dhcpv4': False, 'netmask': '255.255.0.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['172.17.0.1/16'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': [], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '42', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.0242e4574c88', 'bridge_id': '8000.0242e4574c88', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '16563', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}}, 'uuid': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'onlineCpus': '0,1,2,3,4,5,6,7', 'nics': {'eth0': {'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'BOOTPROTO': 'none'}, 'hwaddr': '00:13:20:ff:73:aa', 'speed': 100, 'gateway': ''}}, 'software_revision': '0', 'hostdevPassthrough': 'true', 'clusterLevels': ['3.4', '3.5', '3.6'], 'cpuFlags': '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,pdpe1gb,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,est,tm2,ssse3,sdbg,fma,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,lahf_lm,abm,3dnowprefetch,ida,arat,epb,pln,pts,dtherm,intel_pt,tpr_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi2,erms,invpcid,rdseed,adx,smap,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_IvyBridge,model_Westmere,model_n270,model_Broadwell-noTSX,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.4', '3.5', '3.6'], 'autoNumaBalancing': 2, 'additionalFeatures': ['GLUSTER_SNAPSHOT', 'GLUSTER_GEO_REPLICATION', 'GLUSTER_BRICK_MANAGEMENT'], 'reservedMem': '321', 'bondings': {}, 'software_version': '4.17.24', 'memSize': '16032', 'cpuSpeed': '1700.398', 'numaNodes': {'0': {'totalMemory': '16032', 'cpus': [0, 1, 2, 3, 4, 5, 6, 7]}}, 'cpuSockets': '1', 'vlans': {}, 'lastClientIface': 'ovirtmgmt', 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'version_name': 'Snow Man', 'cpuThreads': '8', 'emulatedMachines': ['pc-q35-2.0', 'pc-q35-2.1', 'pc-q35-2.2', 'pc-q35-2.3', 'pc-q35-2.4', 'q35', 'pc-1.1', 'pc-1.0', 'pc-1.3', 'pc-1.2', 'pc-q35-1.7', 'pc-q35-1.6', 'pc-q35-1.5', 'pc-q35-1.4', 'pc', 'isapc', 'pc-i440fx-2.4', 'pc-i440fx-2.3', 'pc-i440fx-2.2', 'pc-i440fx-2.1', 'pc-i440fx-2.0', 'pc-0.12', 'pc-0.13', 'pc-0.10', 'pc-0.11', 'pc-0.14', 'pc-0.15', 'pc-i440fx-1.4', 'pc-i440fx-1.5', 'pc-i440fx-1.6', 'pc-i440fx-1.7'], 'rngSources': ['random'], 'operatingSystem': {'release': '8.0.0.0', 'version': '8.0.0.0', 'name': 'Linux'}}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:44:28,768::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getHardwareInfo' in bridge with {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:44:28,769::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getHardwareInfo' in bridge with {'systemProductName': 'Broadwell Client platform', 'systemSerialNumber': 'System Serial Number', 'systemFamily': 'Broadwell Client System', 'systemVersion': '0.1', 'systemUUID': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'systemManufacturer': 'Intel Corporation'}
jsonrpc.Executor/0::DEBUG::2016-05-25 08:44:35,335::task::595::Storage.TaskManager.Task::(_updateState) Task=`d75357d1-0130-453d-a805-389e4eedd867`::moving from state init -> state preparing
jsonrpc.Executor/0::INFO::2016-05-25 08:44:35,336::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/0::INFO::2016-05-25 08:44:35,336::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/0::DEBUG::2016-05-25 08:44:35,336::task::1191::Storage.TaskManager.Task::(prepare) Task=`d75357d1-0130-453d-a805-389e4eedd867`::finished: {}
jsonrpc.Executor/0::DEBUG::2016-05-25 08:44:35,336::task::595::Storage.TaskManager.Task::(_updateState) Task=`d75357d1-0130-453d-a805-389e4eedd867`::moving from state preparing -> state finished
jsonrpc.Executor/0::DEBUG::2016-05-25 08:44:35,336::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/0::DEBUG::2016-05-25 08:44:35,336::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/0::DEBUG::2016-05-25 08:44:35,336::task::993::Storage.TaskManager.Task::(_decref) Task=`d75357d1-0130-453d-a805-389e4eedd867`::ref 0 aborting False
jsonrpc.Executor/0::WARNING::2016-05-25 08:44:35,337::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/0::WARNING::2016-05-25 08:44:35,338::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:43,519::task::595::Storage.TaskManager.Task::(_updateState) Task=`5e43d636-4116-48cf-be4a-81d60bfb097c`::moving from state init -> state preparing
jsonrpc.Executor/2::INFO::2016-05-25 08:44:43,520::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/2::INFO::2016-05-25 08:44:43,520::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:43,520::task::1191::Storage.TaskManager.Task::(prepare) Task=`5e43d636-4116-48cf-be4a-81d60bfb097c`::finished: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:43,520::task::595::Storage.TaskManager.Task::(_updateState) Task=`5e43d636-4116-48cf-be4a-81d60bfb097c`::moving from state preparing -> state finished
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:43,520::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:43,520::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:44:43,520::task::993::Storage.TaskManager.Task::(_decref) Task=`5e43d636-4116-48cf-be4a-81d60bfb097c`::ref 0 aborting False
jsonrpc.Executor/2::WARNING::2016-05-25 08:44:43,521::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/2::WARNING::2016-05-25 08:44:43,521::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/4::DEBUG::2016-05-25 08:44:50,621::task::595::Storage.TaskManager.Task::(_updateState) Task=`91f932e6-1427-4e03-8679-d5a54d8c5924`::moving from state init -> state preparing
jsonrpc.Executor/4::INFO::2016-05-25 08:44:50,622::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/4::INFO::2016-05-25 08:44:50,622::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:44:50,622::task::1191::Storage.TaskManager.Task::(prepare) Task=`91f932e6-1427-4e03-8679-d5a54d8c5924`::finished: {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:44:50,622::task::595::Storage.TaskManager.Task::(_updateState) Task=`91f932e6-1427-4e03-8679-d5a54d8c5924`::moving from state preparing -> state finished
jsonrpc.Executor/4::DEBUG::2016-05-25 08:44:50,622::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:44:50,622::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:44:50,622::task::993::Storage.TaskManager.Task::(_decref) Task=`91f932e6-1427-4e03-8679-d5a54d8c5924`::ref 0 aborting False
jsonrpc.Executor/4::WARNING::2016-05-25 08:44:50,623::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/4::WARNING::2016-05-25 08:44:50,623::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/6::DEBUG::2016-05-25 08:44:58,744::task::595::Storage.TaskManager.Task::(_updateState) Task=`097ce2c4-0fab-4a01-9c9b-15aa980e51b8`::moving from state init -> state preparing
jsonrpc.Executor/6::INFO::2016-05-25 08:44:58,745::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/6::INFO::2016-05-25 08:44:58,745::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:44:58,745::task::1191::Storage.TaskManager.Task::(prepare) Task=`097ce2c4-0fab-4a01-9c9b-15aa980e51b8`::finished: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:44:58,745::task::595::Storage.TaskManager.Task::(_updateState) Task=`097ce2c4-0fab-4a01-9c9b-15aa980e51b8`::moving from state preparing -> state finished
jsonrpc.Executor/6::DEBUG::2016-05-25 08:44:58,745::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:44:58,745::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:44:58,745::task::993::Storage.TaskManager.Task::(_decref) Task=`097ce2c4-0fab-4a01-9c9b-15aa980e51b8`::ref 0 aborting False
jsonrpc.Executor/6::WARNING::2016-05-25 08:44:58,746::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/6::WARNING::2016-05-25 08:44:58,746::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/0::DEBUG::2016-05-25 08:45:01,882::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getCapabilities' in bridge with {}
jsonrpc.Executor/0::DEBUG::2016-05-25 08:45:01,901::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /sbin/tc qdisc show (cwd None)
jsonrpc.Executor/0::DEBUG::2016-05-25 08:45:01,905::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/0::DEBUG::2016-05-25 08:45:01,910::caps::841::root::(_getKeyPackages) rpm package libspice-server1 not found
jsonrpc.Executor/0::DEBUG::2016-05-25 08:45:01,911::caps::548::root::(_getKdumpStatus) Error detecting fence_kdump configuration status
Traceback (most recent call last):
  File "/usr/share/vdsm/caps.py", line 533, in _getKdumpStatus
    with open('/sys/kernel/kexec_crash_loaded', 'r') as f:
IOError: [Errno 2] No such file or directory: '/sys/kernel/kexec_crash_loaded'
jsonrpc.Executor/0::DEBUG::2016-05-25 08:45:01,912::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getCapabilities' in bridge with {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd'}], 'FC': []}, 'packages2': {'kernel': {'release': 'rt23', 'buildtime': 1464016625.0, 'version': '4.1.23'}, 'vdsm': {'release': 'r0.2', 'buildtime': 1464147403, 'version': '4.17.24'}, 'qemu-kvm': {'release': 'r1.0', 'buildtime': 1463991436, 'version': '2.4.0'}, 'python-mom': {'release': 'r0.0', 'buildtime': 1463988268, 'version': '0.5.2'}, 'libvirt': {'release': 'r1.0', 'buildtime': 1463991549, 'version': '1.3.2'}}, 'numaNodeDistance': {'0': [10]}, 'cpuModel': 'Genuine Intel(R) CPU 0000 @ 1.70GHz', 'liveMerge': 'true', 'hooks': {'before_vm_start': {'50_qemucmdline': {'md5': 'a884929ad6f5eb039887157288867409'}, '50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}, '10_faqemu': {'md5': '905dd6bc11753bc9351e85ae6ae704d0'}, '50_macspoof': {'md5': '68cf48c446387550a9a82283079b80f8'}}, 'after_network_setup': {'30_ethtool_options': {'md5': '9cdcf29a16651eb3abfda900312e8b31'}}, 'after_vm_destroy': {'50_vhostmd': {'md5': '92498ed80c0219749829ecce2813fc7c'}}, 'after_device_migrate_destination': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_device_migrate_destination': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '135e1b133e11d29ced7344aea7148ed4'}}, 'after_device_create': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'after_nic_hotplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_vm_migrate_destination': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_nic_hotunplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_vm_dehibernate': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_device_destroy': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_nic_hotplug': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}, 'before_network_setup': {'50_ipv6': {'md5': '34f9fdd03a8adf55636dcedaa49463a2'}}, 'before_device_create': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}}, 'vmTypes': ['kvm'], 'selinux': {'mode': '-1'}, 'liveSnapshot': 'true', 'kdumpStatus': -1, 'networks': {}, 'bridges': {'ovirtmgmt': {'addr': '128.224.165.170', 'cfg': {'BOOTPROTO': 'dhcp'}, 'ipv6addrs': ['fe80::213:20ff:feff:73aa/64'], 'gateway': '128.224.165.1', 'dhcpv4': False, 'netmask': '255.255.255.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['128.224.165.170/24'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': ['eth0'], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '21', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.001320ff73aa', 'bridge_id': '8000.001320ff73aa', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '11503', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}, 'docker0': {'addr': '172.17.0.1', 'cfg': {'BOOTPROTO': 'none'}, 'ipv6addrs': [], 'gateway': '', 'dhcpv4': False, 'netmask': '255.255.0.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['172.17.0.1/16'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': [], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '123', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.0242e4574c88', 'bridge_id': '8000.0242e4574c88', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '13243', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}}, 'uuid': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'onlineCpus': '0,1,2,3,4,5,6,7', 'nics': {'eth0': {'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'BOOTPROTO': 'none'}, 'hwaddr': '00:13:20:ff:73:aa', 'speed': 100, 'gateway': ''}}, 'software_revision': '0', 'hostdevPassthrough': 'true', 'clusterLevels': ['3.4', '3.5', '3.6'], 'cpuFlags': '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,pdpe1gb,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,est,tm2,ssse3,sdbg,fma,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,lahf_lm,abm,3dnowprefetch,ida,arat,epb,pln,pts,dtherm,intel_pt,tpr_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi2,erms,invpcid,rdseed,adx,smap,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_IvyBridge,model_Westmere,model_n270,model_Broadwell-noTSX,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.4', '3.5', '3.6'], 'autoNumaBalancing': 2, 'additionalFeatures': ['GLUSTER_SNAPSHOT', 'GLUSTER_GEO_REPLICATION', 'GLUSTER_BRICK_MANAGEMENT'], 'reservedMem': '321', 'bondings': {}, 'software_version': '4.17.24', 'memSize': '16032', 'cpuSpeed': '1700.597', 'numaNodes': {'0': {'totalMemory': '16032', 'cpus': [0, 1, 2, 3, 4, 5, 6, 7]}}, 'cpuSockets': '1', 'vlans': {}, 'lastClientIface': 'ovirtmgmt', 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'version_name': 'Snow Man', 'cpuThreads': '8', 'emulatedMachines': ['pc-q35-2.0', 'pc-q35-2.1', 'pc-q35-2.2', 'pc-q35-2.3', 'pc-q35-2.4', 'q35', 'pc-1.1', 'pc-1.0', 'pc-1.3', 'pc-1.2', 'pc-q35-1.7', 'pc-q35-1.6', 'pc-q35-1.5', 'pc-q35-1.4', 'pc', 'isapc', 'pc-i440fx-2.4', 'pc-i440fx-2.3', 'pc-i440fx-2.2', 'pc-i440fx-2.1', 'pc-i440fx-2.0', 'pc-0.12', 'pc-0.13', 'pc-0.10', 'pc-0.11', 'pc-0.14', 'pc-0.15', 'pc-i440fx-1.4', 'pc-i440fx-1.5', 'pc-i440fx-1.6', 'pc-i440fx-1.7'], 'rngSources': ['random'], 'operatingSystem': {'release': '8.0.0.0', 'version': '8.0.0.0', 'name': 'Linux'}}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:01,962::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getHardwareInfo' in bridge with {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:01,964::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getHardwareInfo' in bridge with {'systemProductName': 'Broadwell Client platform', 'systemSerialNumber': 'System Serial Number', 'systemFamily': 'Broadwell Client System', 'systemVersion': '0.1', 'systemUUID': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'systemManufacturer': 'Intel Corporation'}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:02,812::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getCapabilities' in bridge with {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:02,831::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /sbin/tc qdisc show (cwd None)
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:02,835::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:02,840::caps::841::root::(_getKeyPackages) rpm package libspice-server1 not found
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:02,841::caps::548::root::(_getKdumpStatus) Error detecting fence_kdump configuration status
Traceback (most recent call last):
  File "/usr/share/vdsm/caps.py", line 533, in _getKdumpStatus
    with open('/sys/kernel/kexec_crash_loaded', 'r') as f:
IOError: [Errno 2] No such file or directory: '/sys/kernel/kexec_crash_loaded'
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:02,842::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getCapabilities' in bridge with {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd'}], 'FC': []}, 'packages2': {'kernel': {'release': 'rt23', 'buildtime': 1464016625.0, 'version': '4.1.23'}, 'vdsm': {'release': 'r0.2', 'buildtime': 1464147403, 'version': '4.17.24'}, 'qemu-kvm': {'release': 'r1.0', 'buildtime': 1463991436, 'version': '2.4.0'}, 'python-mom': {'release': 'r0.0', 'buildtime': 1463988268, 'version': '0.5.2'}, 'libvirt': {'release': 'r1.0', 'buildtime': 1463991549, 'version': '1.3.2'}}, 'numaNodeDistance': {'0': [10]}, 'cpuModel': 'Genuine Intel(R) CPU 0000 @ 1.70GHz', 'liveMerge': 'true', 'hooks': {'before_vm_start': {'50_qemucmdline': {'md5': 'a884929ad6f5eb039887157288867409'}, '50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}, '10_faqemu': {'md5': '905dd6bc11753bc9351e85ae6ae704d0'}, '50_macspoof': {'md5': '68cf48c446387550a9a82283079b80f8'}}, 'after_network_setup': {'30_ethtool_options': {'md5': '9cdcf29a16651eb3abfda900312e8b31'}}, 'after_vm_destroy': {'50_vhostmd': {'md5': '92498ed80c0219749829ecce2813fc7c'}}, 'after_device_migrate_destination': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_device_migrate_destination': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '135e1b133e11d29ced7344aea7148ed4'}}, 'after_device_create': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'after_nic_hotplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_vm_migrate_destination': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_nic_hotunplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_vm_dehibernate': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_device_destroy': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_nic_hotplug': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}, 'before_network_setup': {'50_ipv6': {'md5': '34f9fdd03a8adf55636dcedaa49463a2'}}, 'before_device_create': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}}, 'vmTypes': ['kvm'], 'selinux': {'mode': '-1'}, 'liveSnapshot': 'true', 'kdumpStatus': -1, 'networks': {}, 'bridges': {'ovirtmgmt': {'addr': '128.224.165.170', 'cfg': {'BOOTPROTO': 'dhcp'}, 'ipv6addrs': ['fe80::213:20ff:feff:73aa/64'], 'gateway': '128.224.165.1', 'dhcpv4': False, 'netmask': '255.255.255.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['128.224.165.170/24'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': ['eth0'], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '128', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.001320ff73aa', 'bridge_id': '8000.001320ff73aa', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '11410', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}, 'docker0': {'addr': '172.17.0.1', 'cfg': {'BOOTPROTO': 'none'}, 'ipv6addrs': [], 'gateway': '', 'dhcpv4': False, 'netmask': '255.255.0.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['172.17.0.1/16'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': [], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '30', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.0242e4574c88', 'bridge_id': '8000.0242e4574c88', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '13150', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}}, 'uuid': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'onlineCpus': '0,1,2,3,4,5,6,7', 'nics': {'eth0': {'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'BOOTPROTO': 'none'}, 'hwaddr': '00:13:20:ff:73:aa', 'speed': 100, 'gateway': ''}}, 'software_revision': '0', 'hostdevPassthrough': 'true', 'clusterLevels': ['3.4', '3.5', '3.6'], 'cpuFlags': '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,pdpe1gb,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,est,tm2,ssse3,sdbg,fma,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,lahf_lm,abm,3dnowprefetch,ida,arat,epb,pln,pts,dtherm,intel_pt,tpr_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi2,erms,invpcid,rdseed,adx,smap,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_IvyBridge,model_Westmere,model_n270,model_Broadwell-noTSX,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.4', '3.5', '3.6'], 'autoNumaBalancing': 2, 'additionalFeatures': ['GLUSTER_SNAPSHOT', 'GLUSTER_GEO_REPLICATION', 'GLUSTER_BRICK_MANAGEMENT'], 'reservedMem': '321', 'bondings': {}, 'software_version': '4.17.24', 'memSize': '16032', 'cpuSpeed': '1700.664', 'numaNodes': {'0': {'totalMemory': '16032', 'cpus': [0, 1, 2, 3, 4, 5, 6, 7]}}, 'cpuSockets': '1', 'vlans': {}, 'lastClientIface': 'ovirtmgmt', 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'version_name': 'Snow Man', 'cpuThreads': '8', 'emulatedMachines': ['pc-q35-2.0', 'pc-q35-2.1', 'pc-q35-2.2', 'pc-q35-2.3', 'pc-q35-2.4', 'q35', 'pc-1.1', 'pc-1.0', 'pc-1.3', 'pc-1.2', 'pc-q35-1.7', 'pc-q35-1.6', 'pc-q35-1.5', 'pc-q35-1.4', 'pc', 'isapc', 'pc-i440fx-2.4', 'pc-i440fx-2.3', 'pc-i440fx-2.2', 'pc-i440fx-2.1', 'pc-i440fx-2.0', 'pc-0.12', 'pc-0.13', 'pc-0.10', 'pc-0.11', 'pc-0.14', 'pc-0.15', 'pc-i440fx-1.4', 'pc-i440fx-1.5', 'pc-i440fx-1.6', 'pc-i440fx-1.7'], 'rngSources': ['random'], 'operatingSystem': {'release': '8.0.0.0', 'version': '8.0.0.0', 'name': 'RHEL'}}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:45:02,896::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getHardwareInfo' in bridge with {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:45:02,898::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getHardwareInfo' in bridge with {'systemProductName': 'Broadwell Client platform', 'systemSerialNumber': 'System Serial Number', 'systemFamily': 'Broadwell Client System', 'systemVersion': '0.1', 'systemUUID': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'systemManufacturer': 'Intel Corporation'}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:45:06,356::task::595::Storage.TaskManager.Task::(_updateState) Task=`6d6a7ec0-e50e-4202-9a05-4f3896bd121c`::moving from state init -> state preparing
jsonrpc.Executor/4::INFO::2016-05-25 08:45:06,356::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/4::INFO::2016-05-25 08:45:06,356::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:45:06,356::task::1191::Storage.TaskManager.Task::(prepare) Task=`6d6a7ec0-e50e-4202-9a05-4f3896bd121c`::finished: {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:45:06,356::task::595::Storage.TaskManager.Task::(_updateState) Task=`6d6a7ec0-e50e-4202-9a05-4f3896bd121c`::moving from state preparing -> state finished
jsonrpc.Executor/4::DEBUG::2016-05-25 08:45:06,356::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:45:06,356::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/4::DEBUG::2016-05-25 08:45:06,357::task::993::Storage.TaskManager.Task::(_decref) Task=`6d6a7ec0-e50e-4202-9a05-4f3896bd121c`::ref 0 aborting False
jsonrpc.Executor/4::WARNING::2016-05-25 08:45:06,357::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/4::WARNING::2016-05-25 08:45:06,358::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:14,504::task::595::Storage.TaskManager.Task::(_updateState) Task=`cbc53e65-3081-4145-b196-11f0fa468585`::moving from state init -> state preparing
jsonrpc.Executor/6::INFO::2016-05-25 08:45:14,504::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/6::INFO::2016-05-25 08:45:14,505::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:14,505::task::1191::Storage.TaskManager.Task::(prepare) Task=`cbc53e65-3081-4145-b196-11f0fa468585`::finished: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:14,505::task::595::Storage.TaskManager.Task::(_updateState) Task=`cbc53e65-3081-4145-b196-11f0fa468585`::moving from state preparing -> state finished
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:14,505::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:14,505::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:14,505::task::993::Storage.TaskManager.Task::(_decref) Task=`cbc53e65-3081-4145-b196-11f0fa468585`::ref 0 aborting False
jsonrpc.Executor/6::WARNING::2016-05-25 08:45:14,506::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/6::WARNING::2016-05-25 08:45:14,506::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:21,684::task::595::Storage.TaskManager.Task::(_updateState) Task=`b909c1d7-765e-412d-b958-3c08e7900993`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:45:21,685::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:45:21,685::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:21,685::task::1191::Storage.TaskManager.Task::(prepare) Task=`b909c1d7-765e-412d-b958-3c08e7900993`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:21,685::task::595::Storage.TaskManager.Task::(_updateState) Task=`b909c1d7-765e-412d-b958-3c08e7900993`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:21,685::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:21,685::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:21,685::task::993::Storage.TaskManager.Task::(_decref) Task=`b909c1d7-765e-412d-b958-3c08e7900993`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:45:21,686::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:45:21,686::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:29,790::task::595::Storage.TaskManager.Task::(_updateState) Task=`290f1f12-143e-45af-9a55-c775b6a1e2e1`::moving from state init -> state preparing
jsonrpc.Executor/2::INFO::2016-05-25 08:45:29,790::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/2::INFO::2016-05-25 08:45:29,791::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:29,791::task::1191::Storage.TaskManager.Task::(prepare) Task=`290f1f12-143e-45af-9a55-c775b6a1e2e1`::finished: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:29,791::task::595::Storage.TaskManager.Task::(_updateState) Task=`290f1f12-143e-45af-9a55-c775b6a1e2e1`::moving from state preparing -> state finished
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:29,791::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:29,791::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:45:29,791::task::993::Storage.TaskManager.Task::(_decref) Task=`290f1f12-143e-45af-9a55-c775b6a1e2e1`::ref 0 aborting False
jsonrpc.Executor/2::WARNING::2016-05-25 08:45:29,792::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/2::WARNING::2016-05-25 08:45:29,792::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:45:36,986::task::595::Storage.TaskManager.Task::(_updateState) Task=`0535f88f-efe5-4270-9012-49a1cef8ca80`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:45:36,986::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:45:36,987::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:45:36,987::task::1191::Storage.TaskManager.Task::(prepare) Task=`0535f88f-efe5-4270-9012-49a1cef8ca80`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:45:36,987::task::595::Storage.TaskManager.Task::(_updateState) Task=`0535f88f-efe5-4270-9012-49a1cef8ca80`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:45:36,987::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:45:36,987::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:45:36,987::task::993::Storage.TaskManager.Task::(_decref) Task=`0535f88f-efe5-4270-9012-49a1cef8ca80`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:45:36,988::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:45:36,988::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:45,065::task::595::Storage.TaskManager.Task::(_updateState) Task=`f762c872-c532-4576-86d4-d7e761e75eb0`::moving from state init -> state preparing
jsonrpc.Executor/6::INFO::2016-05-25 08:45:45,065::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/6::INFO::2016-05-25 08:45:45,065::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:45,065::task::1191::Storage.TaskManager.Task::(prepare) Task=`f762c872-c532-4576-86d4-d7e761e75eb0`::finished: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:45,065::task::595::Storage.TaskManager.Task::(_updateState) Task=`f762c872-c532-4576-86d4-d7e761e75eb0`::moving from state preparing -> state finished
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:45,065::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:45,065::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:45:45,066::task::993::Storage.TaskManager.Task::(_decref) Task=`f762c872-c532-4576-86d4-d7e761e75eb0`::ref 0 aborting False
jsonrpc.Executor/6::WARNING::2016-05-25 08:45:45,066::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/6::WARNING::2016-05-25 08:45:45,067::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:52,242::task::595::Storage.TaskManager.Task::(_updateState) Task=`a9cda755-e3c0-4090-b080-a925b7808287`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:45:52,242::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:45:52,243::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:52,243::task::1191::Storage.TaskManager.Task::(prepare) Task=`a9cda755-e3c0-4090-b080-a925b7808287`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:52,243::task::595::Storage.TaskManager.Task::(_updateState) Task=`a9cda755-e3c0-4090-b080-a925b7808287`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:52,243::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:52,243::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:45:52,243::task::993::Storage.TaskManager.Task::(_decref) Task=`a9cda755-e3c0-4090-b080-a925b7808287`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:45:52,244::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:45:52,244::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:00,343::task::595::Storage.TaskManager.Task::(_updateState) Task=`076ab295-239a-45d5-a308-1b0246ccdbed`::moving from state init -> state preparing
jsonrpc.Executor/2::INFO::2016-05-25 08:46:00,343::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/2::INFO::2016-05-25 08:46:00,344::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:00,344::task::1191::Storage.TaskManager.Task::(prepare) Task=`076ab295-239a-45d5-a308-1b0246ccdbed`::finished: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:00,344::task::595::Storage.TaskManager.Task::(_updateState) Task=`076ab295-239a-45d5-a308-1b0246ccdbed`::moving from state preparing -> state finished
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:00,344::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:00,344::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:00,344::task::993::Storage.TaskManager.Task::(_decref) Task=`076ab295-239a-45d5-a308-1b0246ccdbed`::ref 0 aborting False
jsonrpc.Executor/2::WARNING::2016-05-25 08:46:00,345::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/2::WARNING::2016-05-25 08:46:00,345::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:07,534::task::595::Storage.TaskManager.Task::(_updateState) Task=`f0e44e9f-c650-4bf0-a9c7-66c4a2b432e9`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:46:07,534::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:46:07,534::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:07,534::task::1191::Storage.TaskManager.Task::(prepare) Task=`f0e44e9f-c650-4bf0-a9c7-66c4a2b432e9`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:07,534::task::595::Storage.TaskManager.Task::(_updateState) Task=`f0e44e9f-c650-4bf0-a9c7-66c4a2b432e9`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:07,535::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:07,535::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:07,535::task::993::Storage.TaskManager.Task::(_decref) Task=`f0e44e9f-c650-4bf0-a9c7-66c4a2b432e9`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:46:07,536::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:46:07,536::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:15,600::task::595::Storage.TaskManager.Task::(_updateState) Task=`0648c007-7588-4622-a8cd-c5b7ccc869d5`::moving from state init -> state preparing
jsonrpc.Executor/6::INFO::2016-05-25 08:46:15,600::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/6::INFO::2016-05-25 08:46:15,601::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:15,601::task::1191::Storage.TaskManager.Task::(prepare) Task=`0648c007-7588-4622-a8cd-c5b7ccc869d5`::finished: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:15,601::task::595::Storage.TaskManager.Task::(_updateState) Task=`0648c007-7588-4622-a8cd-c5b7ccc869d5`::moving from state preparing -> state finished
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:15,601::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:15,601::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:15,601::task::993::Storage.TaskManager.Task::(_decref) Task=`0648c007-7588-4622-a8cd-c5b7ccc869d5`::ref 0 aborting False
jsonrpc.Executor/6::WARNING::2016-05-25 08:46:15,602::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/6::WARNING::2016-05-25 08:46:15,603::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:22,830::task::595::Storage.TaskManager.Task::(_updateState) Task=`c75b6d9d-ace3-4c04-99fc-8b0aa962cc98`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:46:22,830::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:46:22,830::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:22,830::task::1191::Storage.TaskManager.Task::(prepare) Task=`c75b6d9d-ace3-4c04-99fc-8b0aa962cc98`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:22,831::task::595::Storage.TaskManager.Task::(_updateState) Task=`c75b6d9d-ace3-4c04-99fc-8b0aa962cc98`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:22,831::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:22,831::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:22,831::task::993::Storage.TaskManager.Task::(_decref) Task=`c75b6d9d-ace3-4c04-99fc-8b0aa962cc98`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:46:22,832::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:46:22,832::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:30,893::task::595::Storage.TaskManager.Task::(_updateState) Task=`fe292af3-2419-4e8e-9f5d-0484d3525ebf`::moving from state init -> state preparing
jsonrpc.Executor/2::INFO::2016-05-25 08:46:30,893::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/2::INFO::2016-05-25 08:46:30,893::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:30,893::task::1191::Storage.TaskManager.Task::(prepare) Task=`fe292af3-2419-4e8e-9f5d-0484d3525ebf`::finished: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:30,893::task::595::Storage.TaskManager.Task::(_updateState) Task=`fe292af3-2419-4e8e-9f5d-0484d3525ebf`::moving from state preparing -> state finished
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:30,893::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:30,894::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:46:30,894::task::993::Storage.TaskManager.Task::(_decref) Task=`fe292af3-2419-4e8e-9f5d-0484d3525ebf`::ref 0 aborting False
jsonrpc.Executor/2::WARNING::2016-05-25 08:46:30,894::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/2::WARNING::2016-05-25 08:46:30,895::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:38,083::task::595::Storage.TaskManager.Task::(_updateState) Task=`8810d962-298b-4644-a2da-eaf4b4b3fcf2`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:46:38,083::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:46:38,084::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:38,084::task::1191::Storage.TaskManager.Task::(prepare) Task=`8810d962-298b-4644-a2da-eaf4b4b3fcf2`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:38,084::task::595::Storage.TaskManager.Task::(_updateState) Task=`8810d962-298b-4644-a2da-eaf4b4b3fcf2`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:38,084::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:38,084::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:46:38,084::task::993::Storage.TaskManager.Task::(_decref) Task=`8810d962-298b-4644-a2da-eaf4b4b3fcf2`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:46:38,085::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:46:38,085::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:46,157::task::595::Storage.TaskManager.Task::(_updateState) Task=`47da8d81-3516-49ec-9e0a-1339e7bf6efb`::moving from state init -> state preparing
jsonrpc.Executor/6::INFO::2016-05-25 08:46:46,158::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/6::INFO::2016-05-25 08:46:46,158::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:46,158::task::1191::Storage.TaskManager.Task::(prepare) Task=`47da8d81-3516-49ec-9e0a-1339e7bf6efb`::finished: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:46,158::task::595::Storage.TaskManager.Task::(_updateState) Task=`47da8d81-3516-49ec-9e0a-1339e7bf6efb`::moving from state preparing -> state finished
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:46,158::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:46,158::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:46:46,158::task::993::Storage.TaskManager.Task::(_decref) Task=`47da8d81-3516-49ec-9e0a-1339e7bf6efb`::ref 0 aborting False
jsonrpc.Executor/6::WARNING::2016-05-25 08:46:46,159::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/6::WARNING::2016-05-25 08:46:46,160::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:53,446::task::595::Storage.TaskManager.Task::(_updateState) Task=`e91fd683-ca1d-4bcd-8baf-f546a7adcc42`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:46:53,446::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:46:53,446::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:53,446::task::1191::Storage.TaskManager.Task::(prepare) Task=`e91fd683-ca1d-4bcd-8baf-f546a7adcc42`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:53,446::task::595::Storage.TaskManager.Task::(_updateState) Task=`e91fd683-ca1d-4bcd-8baf-f546a7adcc42`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:53,446::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:53,446::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:46:53,447::task::993::Storage.TaskManager.Task::(_decref) Task=`e91fd683-ca1d-4bcd-8baf-f546a7adcc42`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:46:53,447::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:46:53,448::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:01,435::task::595::Storage.TaskManager.Task::(_updateState) Task=`fd8b5adb-64e6-4882-b016-64cd858d62b3`::moving from state init -> state preparing
jsonrpc.Executor/2::INFO::2016-05-25 08:47:01,436::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/2::INFO::2016-05-25 08:47:01,436::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:01,436::task::1191::Storage.TaskManager.Task::(prepare) Task=`fd8b5adb-64e6-4882-b016-64cd858d62b3`::finished: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:01,436::task::595::Storage.TaskManager.Task::(_updateState) Task=`fd8b5adb-64e6-4882-b016-64cd858d62b3`::moving from state preparing -> state finished
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:01,436::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:01,436::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:01,436::task::993::Storage.TaskManager.Task::(_decref) Task=`fd8b5adb-64e6-4882-b016-64cd858d62b3`::ref 0 aborting False
jsonrpc.Executor/2::WARNING::2016-05-25 08:47:01,437::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/2::WARNING::2016-05-25 08:47:01,437::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:08,810::task::595::Storage.TaskManager.Task::(_updateState) Task=`a3fc6d05-bfc5-4aad-9928-6685cbfcee3d`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:47:08,810::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:47:08,810::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:08,810::task::1191::Storage.TaskManager.Task::(prepare) Task=`a3fc6d05-bfc5-4aad-9928-6685cbfcee3d`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:08,811::task::595::Storage.TaskManager.Task::(_updateState) Task=`a3fc6d05-bfc5-4aad-9928-6685cbfcee3d`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:08,811::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:08,811::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:08,811::task::993::Storage.TaskManager.Task::(_decref) Task=`a3fc6d05-bfc5-4aad-9928-6685cbfcee3d`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:47:08,812::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:47:08,812::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:16,684::task::595::Storage.TaskManager.Task::(_updateState) Task=`5c8fad38-23d3-48ea-838c-de719201c977`::moving from state init -> state preparing
jsonrpc.Executor/6::INFO::2016-05-25 08:47:16,684::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/6::INFO::2016-05-25 08:47:16,684::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:16,684::task::1191::Storage.TaskManager.Task::(prepare) Task=`5c8fad38-23d3-48ea-838c-de719201c977`::finished: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:16,684::task::595::Storage.TaskManager.Task::(_updateState) Task=`5c8fad38-23d3-48ea-838c-de719201c977`::moving from state preparing -> state finished
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:16,684::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:16,685::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:16,685::task::993::Storage.TaskManager.Task::(_decref) Task=`5c8fad38-23d3-48ea-838c-de719201c977`::ref 0 aborting False
jsonrpc.Executor/6::WARNING::2016-05-25 08:47:16,686::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/6::WARNING::2016-05-25 08:47:16,686::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:24,057::task::595::Storage.TaskManager.Task::(_updateState) Task=`6bc2d62b-3a38-4c58-b992-32ce55a20baf`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:47:24,057::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:47:24,057::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:24,057::task::1191::Storage.TaskManager.Task::(prepare) Task=`6bc2d62b-3a38-4c58-b992-32ce55a20baf`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:24,057::task::595::Storage.TaskManager.Task::(_updateState) Task=`6bc2d62b-3a38-4c58-b992-32ce55a20baf`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:24,057::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:24,057::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:24,057::task::993::Storage.TaskManager.Task::(_decref) Task=`6bc2d62b-3a38-4c58-b992-32ce55a20baf`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:47:24,058::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:47:24,059::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:31,955::task::595::Storage.TaskManager.Task::(_updateState) Task=`7d1fad81-6d49-4bcf-a943-5cc955c0bf60`::moving from state init -> state preparing
jsonrpc.Executor/2::INFO::2016-05-25 08:47:31,955::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/2::INFO::2016-05-25 08:47:31,955::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:31,955::task::1191::Storage.TaskManager.Task::(prepare) Task=`7d1fad81-6d49-4bcf-a943-5cc955c0bf60`::finished: {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:31,955::task::595::Storage.TaskManager.Task::(_updateState) Task=`7d1fad81-6d49-4bcf-a943-5cc955c0bf60`::moving from state preparing -> state finished
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:31,955::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:31,955::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:47:31,956::task::993::Storage.TaskManager.Task::(_decref) Task=`7d1fad81-6d49-4bcf-a943-5cc955c0bf60`::ref 0 aborting False
jsonrpc.Executor/2::WARNING::2016-05-25 08:47:31,956::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/2::WARNING::2016-05-25 08:47:31,957::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:39,358::task::595::Storage.TaskManager.Task::(_updateState) Task=`7b148a70-bc85-42f9-ac5e-6484d553db4d`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:47:39,358::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:47:39,359::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:39,359::task::1191::Storage.TaskManager.Task::(prepare) Task=`7b148a70-bc85-42f9-ac5e-6484d553db4d`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:39,359::task::595::Storage.TaskManager.Task::(_updateState) Task=`7b148a70-bc85-42f9-ac5e-6484d553db4d`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:39,359::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:39,359::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:47:39,359::task::993::Storage.TaskManager.Task::(_decref) Task=`7b148a70-bc85-42f9-ac5e-6484d553db4d`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:47:39,360::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:47:39,360::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:47,239::task::595::Storage.TaskManager.Task::(_updateState) Task=`49e6b651-25ed-4724-ae6d-0b8792a89cc0`::moving from state init -> state preparing
jsonrpc.Executor/6::INFO::2016-05-25 08:47:47,239::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/6::INFO::2016-05-25 08:47:47,239::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:47,239::task::1191::Storage.TaskManager.Task::(prepare) Task=`49e6b651-25ed-4724-ae6d-0b8792a89cc0`::finished: {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:47,239::task::595::Storage.TaskManager.Task::(_updateState) Task=`49e6b651-25ed-4724-ae6d-0b8792a89cc0`::moving from state preparing -> state finished
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:47,239::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:47,240::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:47:47,240::task::993::Storage.TaskManager.Task::(_decref) Task=`49e6b651-25ed-4724-ae6d-0b8792a89cc0`::ref 0 aborting False
jsonrpc.Executor/6::WARNING::2016-05-25 08:47:47,240::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/6::WARNING::2016-05-25 08:47:47,241::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:54,670::task::595::Storage.TaskManager.Task::(_updateState) Task=`667b73eb-a634-4273-818b-3a9f70e0526d`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:47:54,670::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:47:54,670::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:54,670::task::1191::Storage.TaskManager.Task::(prepare) Task=`667b73eb-a634-4273-818b-3a9f70e0526d`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:54,670::task::595::Storage.TaskManager.Task::(_updateState) Task=`667b73eb-a634-4273-818b-3a9f70e0526d`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:54,670::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:54,671::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:47:54,671::task::993::Storage.TaskManager.Task::(_decref) Task=`667b73eb-a634-4273-818b-3a9f70e0526d`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:47:54,672::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:47:54,672::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:02,492::task::595::Storage.TaskManager.Task::(_updateState) Task=`197de875-f6f1-49bb-afec-5fc193c1255f`::moving from state init -> state preparing
jsonrpc.Executor/3::INFO::2016-05-25 08:48:02,493::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/3::INFO::2016-05-25 08:48:02,493::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:02,493::task::1191::Storage.TaskManager.Task::(prepare) Task=`197de875-f6f1-49bb-afec-5fc193c1255f`::finished: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:02,493::task::595::Storage.TaskManager.Task::(_updateState) Task=`197de875-f6f1-49bb-afec-5fc193c1255f`::moving from state preparing -> state finished
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:02,493::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:02,493::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:02,493::task::993::Storage.TaskManager.Task::(_decref) Task=`197de875-f6f1-49bb-afec-5fc193c1255f`::ref 0 aborting False
jsonrpc.Executor/3::WARNING::2016-05-25 08:48:02,494::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/3::WARNING::2016-05-25 08:48:02,495::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:09,978::task::595::Storage.TaskManager.Task::(_updateState) Task=`44e27d93-a45c-46f0-a628-d516984bf99c`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:48:09,978::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:48:09,979::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:09,979::task::1191::Storage.TaskManager.Task::(prepare) Task=`44e27d93-a45c-46f0-a628-d516984bf99c`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:09,979::task::595::Storage.TaskManager.Task::(_updateState) Task=`44e27d93-a45c-46f0-a628-d516984bf99c`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:09,979::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:09,979::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:09,979::task::993::Storage.TaskManager.Task::(_decref) Task=`44e27d93-a45c-46f0-a628-d516984bf99c`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:48:09,980::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:48:09,980::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:17,781::task::595::Storage.TaskManager.Task::(_updateState) Task=`82b3cc2f-1f50-4f23-a57a-e6d41b5f99e5`::moving from state init -> state preparing
jsonrpc.Executor/7::INFO::2016-05-25 08:48:17,782::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/7::INFO::2016-05-25 08:48:17,782::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:17,782::task::1191::Storage.TaskManager.Task::(prepare) Task=`82b3cc2f-1f50-4f23-a57a-e6d41b5f99e5`::finished: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:17,782::task::595::Storage.TaskManager.Task::(_updateState) Task=`82b3cc2f-1f50-4f23-a57a-e6d41b5f99e5`::moving from state preparing -> state finished
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:17,782::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:17,782::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:17,782::task::993::Storage.TaskManager.Task::(_decref) Task=`82b3cc2f-1f50-4f23-a57a-e6d41b5f99e5`::ref 0 aborting False
jsonrpc.Executor/7::WARNING::2016-05-25 08:48:17,783::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/7::WARNING::2016-05-25 08:48:17,784::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:25,308::task::595::Storage.TaskManager.Task::(_updateState) Task=`e09e42d0-6a84-43df-9106-350bece650c8`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:48:25,308::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:48:25,308::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:25,309::task::1191::Storage.TaskManager.Task::(prepare) Task=`e09e42d0-6a84-43df-9106-350bece650c8`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:25,309::task::595::Storage.TaskManager.Task::(_updateState) Task=`e09e42d0-6a84-43df-9106-350bece650c8`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:25,309::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:25,309::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:25,309::task::993::Storage.TaskManager.Task::(_decref) Task=`e09e42d0-6a84-43df-9106-350bece650c8`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:48:25,310::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:48:25,310::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:33,061::task::595::Storage.TaskManager.Task::(_updateState) Task=`52a28d8b-b5f6-4af5-bfc6-a443bb21580e`::moving from state init -> state preparing
jsonrpc.Executor/3::INFO::2016-05-25 08:48:33,061::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/3::INFO::2016-05-25 08:48:33,061::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:33,061::task::1191::Storage.TaskManager.Task::(prepare) Task=`52a28d8b-b5f6-4af5-bfc6-a443bb21580e`::finished: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:33,062::task::595::Storage.TaskManager.Task::(_updateState) Task=`52a28d8b-b5f6-4af5-bfc6-a443bb21580e`::moving from state preparing -> state finished
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:33,062::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:33,062::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:48:33,062::task::993::Storage.TaskManager.Task::(_decref) Task=`52a28d8b-b5f6-4af5-bfc6-a443bb21580e`::ref 0 aborting False
jsonrpc.Executor/3::WARNING::2016-05-25 08:48:33,063::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/3::WARNING::2016-05-25 08:48:33,063::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:40,585::task::595::Storage.TaskManager.Task::(_updateState) Task=`6db45ccc-8e88-40e3-adf6-9986f454689f`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:48:40,586::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:48:40,586::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:40,586::task::1191::Storage.TaskManager.Task::(prepare) Task=`6db45ccc-8e88-40e3-adf6-9986f454689f`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:40,586::task::595::Storage.TaskManager.Task::(_updateState) Task=`6db45ccc-8e88-40e3-adf6-9986f454689f`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:40,586::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:40,586::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:48:40,586::task::993::Storage.TaskManager.Task::(_decref) Task=`6db45ccc-8e88-40e3-adf6-9986f454689f`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:48:40,587::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:48:40,588::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:48,343::task::595::Storage.TaskManager.Task::(_updateState) Task=`d1cf5fe0-6dce-4f48-a3f9-2d51a09b0c54`::moving from state init -> state preparing
jsonrpc.Executor/7::INFO::2016-05-25 08:48:48,343::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/7::INFO::2016-05-25 08:48:48,344::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:48,344::task::1191::Storage.TaskManager.Task::(prepare) Task=`d1cf5fe0-6dce-4f48-a3f9-2d51a09b0c54`::finished: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:48,344::task::595::Storage.TaskManager.Task::(_updateState) Task=`d1cf5fe0-6dce-4f48-a3f9-2d51a09b0c54`::moving from state preparing -> state finished
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:48,344::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:48,344::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:48:48,344::task::993::Storage.TaskManager.Task::(_decref) Task=`d1cf5fe0-6dce-4f48-a3f9-2d51a09b0c54`::ref 0 aborting False
jsonrpc.Executor/7::WARNING::2016-05-25 08:48:48,345::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/7::WARNING::2016-05-25 08:48:48,345::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:55,890::task::595::Storage.TaskManager.Task::(_updateState) Task=`5ae8fe91-d678-4787-a437-4d1faa7979e9`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:48:55,891::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:48:55,891::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:55,891::task::1191::Storage.TaskManager.Task::(prepare) Task=`5ae8fe91-d678-4787-a437-4d1faa7979e9`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:55,891::task::595::Storage.TaskManager.Task::(_updateState) Task=`5ae8fe91-d678-4787-a437-4d1faa7979e9`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:55,891::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:55,891::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:48:55,891::task::993::Storage.TaskManager.Task::(_decref) Task=`5ae8fe91-d678-4787-a437-4d1faa7979e9`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:48:55,892::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:48:55,892::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:03,601::task::595::Storage.TaskManager.Task::(_updateState) Task=`a2fcd084-de3f-40b1-9981-06be19c38f2e`::moving from state init -> state preparing
jsonrpc.Executor/3::INFO::2016-05-25 08:49:03,601::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/3::INFO::2016-05-25 08:49:03,601::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:03,601::task::1191::Storage.TaskManager.Task::(prepare) Task=`a2fcd084-de3f-40b1-9981-06be19c38f2e`::finished: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:03,601::task::595::Storage.TaskManager.Task::(_updateState) Task=`a2fcd084-de3f-40b1-9981-06be19c38f2e`::moving from state preparing -> state finished
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:03,601::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:03,601::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:03,601::task::993::Storage.TaskManager.Task::(_decref) Task=`a2fcd084-de3f-40b1-9981-06be19c38f2e`::ref 0 aborting False
jsonrpc.Executor/3::WARNING::2016-05-25 08:49:03,602::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/3::WARNING::2016-05-25 08:49:03,602::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:11,196::task::595::Storage.TaskManager.Task::(_updateState) Task=`6caa69ac-1a98-49e3-867f-da96d5793ac9`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:49:11,196::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:49:11,196::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:11,196::task::1191::Storage.TaskManager.Task::(prepare) Task=`6caa69ac-1a98-49e3-867f-da96d5793ac9`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:11,196::task::595::Storage.TaskManager.Task::(_updateState) Task=`6caa69ac-1a98-49e3-867f-da96d5793ac9`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:11,196::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:11,197::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:11,197::task::993::Storage.TaskManager.Task::(_decref) Task=`6caa69ac-1a98-49e3-867f-da96d5793ac9`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:49:11,197::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:49:11,198::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:18,881::task::595::Storage.TaskManager.Task::(_updateState) Task=`50c1f264-9965-4c86-afeb-7a788051c04c`::moving from state init -> state preparing
jsonrpc.Executor/7::INFO::2016-05-25 08:49:18,881::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/7::INFO::2016-05-25 08:49:18,882::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:18,882::task::1191::Storage.TaskManager.Task::(prepare) Task=`50c1f264-9965-4c86-afeb-7a788051c04c`::finished: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:18,882::task::595::Storage.TaskManager.Task::(_updateState) Task=`50c1f264-9965-4c86-afeb-7a788051c04c`::moving from state preparing -> state finished
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:18,882::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:18,882::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:18,882::task::993::Storage.TaskManager.Task::(_decref) Task=`50c1f264-9965-4c86-afeb-7a788051c04c`::ref 0 aborting False
jsonrpc.Executor/7::WARNING::2016-05-25 08:49:18,883::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/7::WARNING::2016-05-25 08:49:18,883::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:26,449::task::595::Storage.TaskManager.Task::(_updateState) Task=`9b7f16a4-10c1-4e87-b142-db6d9853daad`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:49:26,449::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:49:26,449::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:26,450::task::1191::Storage.TaskManager.Task::(prepare) Task=`9b7f16a4-10c1-4e87-b142-db6d9853daad`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:26,450::task::595::Storage.TaskManager.Task::(_updateState) Task=`9b7f16a4-10c1-4e87-b142-db6d9853daad`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:26,450::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:26,450::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:26,450::task::993::Storage.TaskManager.Task::(_decref) Task=`9b7f16a4-10c1-4e87-b142-db6d9853daad`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:49:26,451::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:49:26,451::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:34,148::task::595::Storage.TaskManager.Task::(_updateState) Task=`b34b4ba7-abfa-4999-aa61-179c8b8f5779`::moving from state init -> state preparing
jsonrpc.Executor/3::INFO::2016-05-25 08:49:34,148::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/3::INFO::2016-05-25 08:49:34,149::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:34,149::task::1191::Storage.TaskManager.Task::(prepare) Task=`b34b4ba7-abfa-4999-aa61-179c8b8f5779`::finished: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:34,149::task::595::Storage.TaskManager.Task::(_updateState) Task=`b34b4ba7-abfa-4999-aa61-179c8b8f5779`::moving from state preparing -> state finished
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:34,149::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:34,149::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:49:34,149::task::993::Storage.TaskManager.Task::(_decref) Task=`b34b4ba7-abfa-4999-aa61-179c8b8f5779`::ref 0 aborting False
jsonrpc.Executor/3::WARNING::2016-05-25 08:49:34,150::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/3::WARNING::2016-05-25 08:49:34,150::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:41,726::task::595::Storage.TaskManager.Task::(_updateState) Task=`290e2594-0b9c-4631-9e6b-90ad7ec2d2bb`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:49:41,726::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:49:41,726::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:41,726::task::1191::Storage.TaskManager.Task::(prepare) Task=`290e2594-0b9c-4631-9e6b-90ad7ec2d2bb`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:41,727::task::595::Storage.TaskManager.Task::(_updateState) Task=`290e2594-0b9c-4631-9e6b-90ad7ec2d2bb`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:41,727::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:41,727::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:49:41,727::task::993::Storage.TaskManager.Task::(_decref) Task=`290e2594-0b9c-4631-9e6b-90ad7ec2d2bb`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:49:41,728::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:49:41,728::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:49,415::task::595::Storage.TaskManager.Task::(_updateState) Task=`c746f061-baee-4015-88ba-376cbe669c44`::moving from state init -> state preparing
jsonrpc.Executor/7::INFO::2016-05-25 08:49:49,415::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/7::INFO::2016-05-25 08:49:49,415::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:49,415::task::1191::Storage.TaskManager.Task::(prepare) Task=`c746f061-baee-4015-88ba-376cbe669c44`::finished: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:49,415::task::595::Storage.TaskManager.Task::(_updateState) Task=`c746f061-baee-4015-88ba-376cbe669c44`::moving from state preparing -> state finished
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:49,415::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:49,415::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:49:49,415::task::993::Storage.TaskManager.Task::(_decref) Task=`c746f061-baee-4015-88ba-376cbe669c44`::ref 0 aborting False
jsonrpc.Executor/7::WARNING::2016-05-25 08:49:49,416::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/7::WARNING::2016-05-25 08:49:49,416::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:56,997::task::595::Storage.TaskManager.Task::(_updateState) Task=`ce3e48c5-b74f-4918-90b9-d79898ddd796`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:49:56,998::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:49:56,998::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:56,998::task::1191::Storage.TaskManager.Task::(prepare) Task=`ce3e48c5-b74f-4918-90b9-d79898ddd796`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:56,998::task::595::Storage.TaskManager.Task::(_updateState) Task=`ce3e48c5-b74f-4918-90b9-d79898ddd796`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:56,998::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:56,998::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:49:56,998::task::993::Storage.TaskManager.Task::(_decref) Task=`ce3e48c5-b74f-4918-90b9-d79898ddd796`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:49:56,999::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:49:56,999::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/2::DEBUG::2016-05-25 08:50:01,651::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getCapabilities' in bridge with {}
jsonrpc.Executor/2::DEBUG::2016-05-25 08:50:01,672::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /sbin/tc qdisc show (cwd None)
jsonrpc.Executor/2::DEBUG::2016-05-25 08:50:01,677::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/2::DEBUG::2016-05-25 08:50:01,681::caps::841::root::(_getKeyPackages) rpm package libspice-server1 not found
jsonrpc.Executor/2::DEBUG::2016-05-25 08:50:01,682::caps::548::root::(_getKdumpStatus) Error detecting fence_kdump configuration status
Traceback (most recent call last):
  File "/usr/share/vdsm/caps.py", line 533, in _getKdumpStatus
    with open('/sys/kernel/kexec_crash_loaded', 'r') as f:
IOError: [Errno 2] No such file or directory: '/sys/kernel/kexec_crash_loaded'
jsonrpc.Executor/2::DEBUG::2016-05-25 08:50:01,684::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getCapabilities' in bridge with {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd'}], 'FC': []}, 'packages2': {'kernel': {'release': 'rt23-rhel8.0.0.0_ovp', 'buildtime': 1464016625.0, 'version': '4.1.23'}, 'vdsm': {'release': 'r0.2', 'buildtime': 1464147403, 'version': '4.17.24'}, 'qemu-kvm': {'release': 'r1.0', 'buildtime': 1463991436, 'version': '2.4.0'}, 'python-mom': {'release': 'r0.0', 'buildtime': 1463988268, 'version': '0.5.2'}, 'libvirt': {'release': 'r1.0', 'buildtime': 1463991549, 'version': '1.3.2'}}, 'numaNodeDistance': {'0': [10]}, 'cpuModel': 'Genuine Intel(R) CPU 0000 @ 1.70GHz', 'liveMerge': 'true', 'hooks': {'before_vm_start': {'50_qemucmdline': {'md5': 'a884929ad6f5eb039887157288867409'}, '50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}, '10_faqemu': {'md5': '905dd6bc11753bc9351e85ae6ae704d0'}, '50_macspoof': {'md5': '68cf48c446387550a9a82283079b80f8'}}, 'after_network_setup': {'30_ethtool_options': {'md5': '9cdcf29a16651eb3abfda900312e8b31'}}, 'after_vm_destroy': {'50_vhostmd': {'md5': '92498ed80c0219749829ecce2813fc7c'}}, 'after_device_migrate_destination': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_device_migrate_destination': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '135e1b133e11d29ced7344aea7148ed4'}}, 'after_device_create': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'after_nic_hotplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_vm_migrate_destination': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_nic_hotunplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_vm_dehibernate': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_device_destroy': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_nic_hotplug': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}, 'before_network_setup': {'50_ipv6': {'md5': '34f9fdd03a8adf55636dcedaa49463a2'}}, 'before_device_create': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}}, 'vmTypes': ['kvm'], 'selinux': {'mode': '-1'}, 'liveSnapshot': 'true', 'kdumpStatus': -1, 'networks': {}, 'bridges': {'ovirtmgmt': {'addr': '128.224.165.170', 'cfg': {'BOOTPROTO': 'dhcp'}, 'ipv6addrs': ['fe80::213:20ff:feff:73aa/64'], 'gateway': '128.224.165.1', 'dhcpv4': False, 'netmask': '255.255.255.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['128.224.165.170/24'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': ['eth0'], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '44', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.001320ff73aa', 'bridge_id': '8000.001320ff73aa', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '15266', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}, 'docker0': {'addr': '172.17.0.1', 'cfg': {'BOOTPROTO': 'none'}, 'ipv6addrs': [], 'gateway': '', 'dhcpv4': False, 'netmask': '255.255.0.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['172.17.0.1/16'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': [], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '145', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.0242e4574c88', 'bridge_id': '8000.0242e4574c88', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '13372', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}}, 'uuid': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'onlineCpus': '0,1,2,3,4,5,6,7', 'nics': {'eth0': {'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'BOOTPROTO': 'none'}, 'hwaddr': '00:13:20:ff:73:aa', 'speed': 100, 'gateway': ''}}, 'software_revision': '0', 'hostdevPassthrough': 'true', 'clusterLevels': ['3.4', '3.5', '3.6'], 'cpuFlags': '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,pdpe1gb,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,est,tm2,ssse3,sdbg,fma,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,lahf_lm,abm,3dnowprefetch,ida,arat,epb,pln,pts,dtherm,intel_pt,tpr_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi2,erms,invpcid,rdseed,adx,smap,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_IvyBridge,model_Westmere,model_n270,model_Broadwell-noTSX,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.4', '3.5', '3.6'], 'autoNumaBalancing': 2, 'additionalFeatures': ['GLUSTER_SNAPSHOT', 'GLUSTER_GEO_REPLICATION', 'GLUSTER_BRICK_MANAGEMENT'], 'reservedMem': '321', 'bondings': {}, 'software_version': '4.17.24', 'memSize': '16032', 'cpuSpeed': '1700.464', 'numaNodes': {'0': {'totalMemory': '16032', 'cpus': [0, 1, 2, 3, 4, 5, 6, 7]}}, 'cpuSockets': '1', 'vlans': {}, 'lastClientIface': 'ovirtmgmt', 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'version_name': 'Snow Man', 'cpuThreads': '8', 'emulatedMachines': ['pc-q35-2.0', 'pc-q35-2.1', 'pc-q35-2.2', 'pc-q35-2.3', 'pc-q35-2.4', 'q35', 'pc-1.1', 'pc-1.0', 'pc-1.3', 'pc-1.2', 'pc-q35-1.7', 'pc-q35-1.6', 'pc-q35-1.5', 'pc-q35-1.4', 'pc', 'isapc', 'pc-i440fx-2.4', 'pc-i440fx-2.3', 'pc-i440fx-2.2', 'pc-i440fx-2.1', 'pc-i440fx-2.0', 'pc-0.12', 'pc-0.13', 'pc-0.10', 'pc-0.11', 'pc-0.14', 'pc-0.15', 'pc-i440fx-1.4', 'pc-i440fx-1.5', 'pc-i440fx-1.6', 'pc-i440fx-1.7'], 'rngSources': ['random'], 'operatingSystem': {'release': '8.0.0.0', 'version': '8.0.0.0', 'name': 'Linux'}}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:01,757::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getHardwareInfo' in bridge with {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:01,758::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getHardwareInfo' in bridge with {'systemProductName': 'Broadwell Client platform', 'systemSerialNumber': 'System Serial Number', 'systemFamily': 'Broadwell Client System', 'systemVersion': '0.1', 'systemUUID': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'systemManufacturer': 'Intel Corporation'}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:03,186::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getCapabilities' in bridge with {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:03,205::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-7 /sbin/tc qdisc show (cwd None)
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:03,210::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> = 0
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:03,214::caps::841::root::(_getKeyPackages) rpm package libspice-server1 not found
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:03,215::caps::548::root::(_getKdumpStatus) Error detecting fence_kdump configuration status
Traceback (most recent call last):
  File "/usr/share/vdsm/caps.py", line 533, in _getKdumpStatus
    with open('/sys/kernel/kexec_crash_loaded', 'r') as f:
IOError: [Errno 2] No such file or directory: '/sys/kernel/kexec_crash_loaded'
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:03,217::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getCapabilities' in bridge with {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd'}], 'FC': []}, 'packages2': {'kernel': {'release': 'rt23', 'buildtime': 1464016625.0, 'version': '4.1.23'}, 'vdsm': {'release': 'r0.2', 'buildtime': 1464147403, 'version': '4.17.24'}, 'qemu-kvm': {'release': 'r1.0', 'buildtime': 1463991436, 'version': '2.4.0'}, 'python-mom': {'release': 'r0.0', 'buildtime': 1463988268, 'version': '0.5.2'}, 'libvirt': {'release': 'r1.0', 'buildtime': 1463991549, 'version': '1.3.2'}}, 'numaNodeDistance': {'0': [10]}, 'cpuModel': 'Genuine Intel(R) CPU 0000 @ 1.70GHz', 'liveMerge': 'true', 'hooks': {'before_vm_start': {'50_qemucmdline': {'md5': 'a884929ad6f5eb039887157288867409'}, '50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}, '10_faqemu': {'md5': '905dd6bc11753bc9351e85ae6ae704d0'}, '50_macspoof': {'md5': '68cf48c446387550a9a82283079b80f8'}}, 'after_network_setup': {'30_ethtool_options': {'md5': '9cdcf29a16651eb3abfda900312e8b31'}}, 'after_vm_destroy': {'50_vhostmd': {'md5': '92498ed80c0219749829ecce2813fc7c'}}, 'after_device_migrate_destination': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_device_migrate_destination': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '135e1b133e11d29ced7344aea7148ed4'}}, 'after_device_create': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'after_nic_hotplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': 'ec28d5c17500ef0cf8f1a6393ac58506'}}, 'before_vm_migrate_destination': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_nic_hotunplug': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_vm_dehibernate': {'50_vhostmd': {'md5': 'f3ee6dbf6fbd01333bd3e32afec4fbba'}}, 'after_device_destroy': {'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '356db41e728db63bf6f7b28c5cfcbf70'}}, 'before_nic_hotplug': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}, 'before_network_setup': {'50_ipv6': {'md5': '34f9fdd03a8adf55636dcedaa49463a2'}}, 'before_device_create': {'50_vmfex': {'md5': 'e05994261acaea7dcf4b88ea0e81f1f5'}, 'openstacknet_utils.py': {'md5': '2464625f639fbd5adec8faf0c4363017'}, '50_openstacknet': {'md5': '1132774e4f2d299283e44fa6c8704f2d'}, '50_macspoof': {'md5': '6c5cee1d729261e99dde5c9412c7ee22'}}}, 'vmTypes': ['kvm'], 'selinux': {'mode': '-1'}, 'liveSnapshot': 'true', 'kdumpStatus': -1, 'networks': {}, 'bridges': {'ovirtmgmt': {'addr': '128.224.165.170', 'cfg': {'BOOTPROTO': 'dhcp'}, 'ipv6addrs': ['fe80::213:20ff:feff:73aa/64'], 'gateway': '128.224.165.1', 'dhcpv4': False, 'netmask': '255.255.255.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['128.224.165.170/24'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': ['eth0'], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '91', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.001320ff73aa', 'bridge_id': '8000.001320ff73aa', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '15113', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}, 'docker0': {'addr': '172.17.0.1', 'cfg': {'BOOTPROTO': 'none'}, 'ipv6addrs': [], 'gateway': '', 'dhcpv4': False, 'netmask': '255.255.0.0', 'dhcpv6': False, 'stp': 'off', 'ipv4addrs': ['172.17.0.1/16'], 'mtu': '1500', 'ipv6gateway': '::', 'ports': [], 'opts': {'multicast_last_member_count': '2', 'hash_elasticity': '4', 'multicast_query_response_interval': '1000', 'group_fwd_mask': '0x0', 'multicast_snooping': '1', 'multicast_startup_query_interval': '3125', 'hello_timer': '192', 'multicast_querier_interval': '25500', 'max_age': '2000', 'hash_max': '512', 'stp_state': '0', 'topology_change_detected': '0', 'priority': '32768', 'multicast_membership_interval': '26000', 'root_path_cost': '0', 'root_port': '0', 'multicast_querier': '0', 'multicast_startup_query_count': '2', 'nf_call_iptables': '0', 'topology_change': '0', 'hello_time': '200', 'root_id': '8000.0242e4574c88', 'bridge_id': '8000.0242e4574c88', 'topology_change_timer': '0', 'ageing_time': '30000', 'nf_call_ip6tables': '0', 'gc_timer': '13218', 'nf_call_arptables': '0', 'group_addr': '1:80:c2:0:0:0', 'multicast_last_member_interval': '100', 'multicast_query_interval': '12500', 'multicast_query_use_ifaddr': '0', 'tcn_timer': '0', 'multicast_router': '1', 'forward_delay': '1500'}}}, 'uuid': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'onlineCpus': '0,1,2,3,4,5,6,7', 'nics': {'eth0': {'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'BOOTPROTO': 'none'}, 'hwaddr': '00:13:20:ff:73:aa', 'speed': 100, 'gateway': ''}}, 'software_revision': '0', 'hostdevPassthrough': 'true', 'clusterLevels': ['3.4', '3.5', '3.6'], 'cpuFlags': '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,pdpe1gb,rdtscp,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,est,tm2,ssse3,sdbg,fma,cx16,xtpr,pdcm,pcid,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadline_timer,aes,xsave,avx,f16c,rdrand,lahf_lm,abm,3dnowprefetch,ida,arat,epb,pln,pts,dtherm,intel_pt,tpr_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi2,erms,invpcid,rdseed,adx,smap,xsaveopt,model_Haswell-noTSX,model_Nehalem,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_IvyBridge,model_Westmere,model_n270,model_Broadwell-noTSX,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.2005-03.org.open-iscsi:1f5a71311bd', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.4', '3.5', '3.6'], 'autoNumaBalancing': 2, 'additionalFeatures': ['GLUSTER_SNAPSHOT', 'GLUSTER_GEO_REPLICATION', 'GLUSTER_BRICK_MANAGEMENT'], 'reservedMem': '321', 'bondings': {}, 'software_version': '4.17.24', 'memSize': '16032', 'cpuSpeed': '1700.464', 'numaNodes': {'0': {'totalMemory': '16032', 'cpus': [0, 1, 2, 3, 4, 5, 6, 7]}}, 'cpuSockets': '1', 'vlans': {}, 'lastClientIface': 'ovirtmgmt', 'cpuCores': '4', 'kvmEnabled': 'true', 'guestOverhead': '65', 'version_name': 'Snow Man', 'cpuThreads': '8', 'emulatedMachines': ['pc-q35-2.0', 'pc-q35-2.1', 'pc-q35-2.2', 'pc-q35-2.3', 'pc-q35-2.4', 'q35', 'pc-1.1', 'pc-1.0', 'pc-1.3', 'pc-1.2', 'pc-q35-1.7', 'pc-q35-1.6', 'pc-q35-1.5', 'pc-q35-1.4', 'pc', 'isapc', 'pc-i440fx-2.4', 'pc-i440fx-2.3', 'pc-i440fx-2.2', 'pc-i440fx-2.1', 'pc-i440fx-2.0', 'pc-0.12', 'pc-0.13', 'pc-0.10', 'pc-0.11', 'pc-0.14', 'pc-0.15', 'pc-i440fx-1.4', 'pc-i440fx-1.5', 'pc-i440fx-1.6', 'pc-i440fx-1.7'], 'rngSources': ['random'], 'operatingSystem': {'release': '8.0.0.0', 'version': '8.0.0.0', 'name': 'Linux'}}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:50:03,271::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest) Calling 'Host.getHardwareInfo' in bridge with {}
jsonrpc.Executor/6::DEBUG::2016-05-25 08:50:03,272::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest) Return 'Host.getHardwareInfo' in bridge with {'systemProductName': 'Broadwell Client platform', 'systemSerialNumber': 'System Serial Number', 'systemFamily': 'Broadwell Client System', 'systemVersion': '0.1', 'systemUUID': '8BF28680-CF1D-8680-F28B-1DCF8086F28B', 'systemManufacturer': 'Intel Corporation'}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:05,247::task::595::Storage.TaskManager.Task::(_updateState) Task=`32a21d93-3cc2-4020-adc2-5afbfeddb839`::moving from state init -> state preparing
jsonrpc.Executor/7::INFO::2016-05-25 08:50:05,248::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/7::INFO::2016-05-25 08:50:05,248::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:05,248::task::1191::Storage.TaskManager.Task::(prepare) Task=`32a21d93-3cc2-4020-adc2-5afbfeddb839`::finished: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:05,248::task::595::Storage.TaskManager.Task::(_updateState) Task=`32a21d93-3cc2-4020-adc2-5afbfeddb839`::moving from state preparing -> state finished
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:05,248::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:05,248::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:05,248::task::993::Storage.TaskManager.Task::(_decref) Task=`32a21d93-3cc2-4020-adc2-5afbfeddb839`::ref 0 aborting False
jsonrpc.Executor/7::WARNING::2016-05-25 08:50:05,249::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/7::WARNING::2016-05-25 08:50:05,249::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:12,826::task::595::Storage.TaskManager.Task::(_updateState) Task=`23c825a5-d094-4799-a8f0-ab104700df5a`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:50:12,826::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:50:12,827::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:12,827::task::1191::Storage.TaskManager.Task::(prepare) Task=`23c825a5-d094-4799-a8f0-ab104700df5a`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:12,827::task::595::Storage.TaskManager.Task::(_updateState) Task=`23c825a5-d094-4799-a8f0-ab104700df5a`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:12,827::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:12,827::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:12,827::task::993::Storage.TaskManager.Task::(_decref) Task=`23c825a5-d094-4799-a8f0-ab104700df5a`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:50:12,828::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:50:12,828::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:20,517::task::595::Storage.TaskManager.Task::(_updateState) Task=`6ee5b833-e288-46e6-ae70-6acd41b96602`::moving from state init -> state preparing
jsonrpc.Executor/3::INFO::2016-05-25 08:50:20,517::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/3::INFO::2016-05-25 08:50:20,517::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:20,517::task::1191::Storage.TaskManager.Task::(prepare) Task=`6ee5b833-e288-46e6-ae70-6acd41b96602`::finished: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:20,518::task::595::Storage.TaskManager.Task::(_updateState) Task=`6ee5b833-e288-46e6-ae70-6acd41b96602`::moving from state preparing -> state finished
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:20,518::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:20,518::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:20,518::task::993::Storage.TaskManager.Task::(_decref) Task=`6ee5b833-e288-46e6-ae70-6acd41b96602`::ref 0 aborting False
jsonrpc.Executor/3::WARNING::2016-05-25 08:50:20,519::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/3::WARNING::2016-05-25 08:50:20,519::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:28,084::task::595::Storage.TaskManager.Task::(_updateState) Task=`2a4b11f7-4a5d-493a-8d8b-23688d37ccb5`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:50:28,084::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:50:28,084::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:28,085::task::1191::Storage.TaskManager.Task::(prepare) Task=`2a4b11f7-4a5d-493a-8d8b-23688d37ccb5`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:28,085::task::595::Storage.TaskManager.Task::(_updateState) Task=`2a4b11f7-4a5d-493a-8d8b-23688d37ccb5`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:28,085::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:28,085::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:28,085::task::993::Storage.TaskManager.Task::(_decref) Task=`2a4b11f7-4a5d-493a-8d8b-23688d37ccb5`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:50:28,086::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:50:28,086::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:35,768::task::595::Storage.TaskManager.Task::(_updateState) Task=`121e58e3-3622-471b-b702-56403545673b`::moving from state init -> state preparing
jsonrpc.Executor/7::INFO::2016-05-25 08:50:35,768::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/7::INFO::2016-05-25 08:50:35,768::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:35,768::task::1191::Storage.TaskManager.Task::(prepare) Task=`121e58e3-3622-471b-b702-56403545673b`::finished: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:35,768::task::595::Storage.TaskManager.Task::(_updateState) Task=`121e58e3-3622-471b-b702-56403545673b`::moving from state preparing -> state finished
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:35,769::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:35,769::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:50:35,769::task::993::Storage.TaskManager.Task::(_decref) Task=`121e58e3-3622-471b-b702-56403545673b`::ref 0 aborting False
jsonrpc.Executor/7::WARNING::2016-05-25 08:50:35,769::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/7::WARNING::2016-05-25 08:50:35,770::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:43,386::task::595::Storage.TaskManager.Task::(_updateState) Task=`283ec545-ae82-4ff1-a6f4-a456850b424c`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:50:43,386::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:50:43,387::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:43,387::task::1191::Storage.TaskManager.Task::(prepare) Task=`283ec545-ae82-4ff1-a6f4-a456850b424c`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:43,387::task::595::Storage.TaskManager.Task::(_updateState) Task=`283ec545-ae82-4ff1-a6f4-a456850b424c`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:43,387::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:43,387::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:50:43,387::task::993::Storage.TaskManager.Task::(_decref) Task=`283ec545-ae82-4ff1-a6f4-a456850b424c`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:50:43,388::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:50:43,388::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:51,039::task::595::Storage.TaskManager.Task::(_updateState) Task=`5a1d1604-0f22-49e2-b1b5-83cc874fedf2`::moving from state init -> state preparing
jsonrpc.Executor/3::INFO::2016-05-25 08:50:51,039::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/3::INFO::2016-05-25 08:50:51,039::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:51,040::task::1191::Storage.TaskManager.Task::(prepare) Task=`5a1d1604-0f22-49e2-b1b5-83cc874fedf2`::finished: {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:51,040::task::595::Storage.TaskManager.Task::(_updateState) Task=`5a1d1604-0f22-49e2-b1b5-83cc874fedf2`::moving from state preparing -> state finished
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:51,040::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:51,040::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/3::DEBUG::2016-05-25 08:50:51,040::task::993::Storage.TaskManager.Task::(_decref) Task=`5a1d1604-0f22-49e2-b1b5-83cc874fedf2`::ref 0 aborting False
jsonrpc.Executor/3::WARNING::2016-05-25 08:50:51,041::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/3::WARNING::2016-05-25 08:50:51,041::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:58,672::task::595::Storage.TaskManager.Task::(_updateState) Task=`9e9b5dfa-dfed-4367-87de-16cc2931d8fc`::moving from state init -> state preparing
jsonrpc.Executor/5::INFO::2016-05-25 08:50:58,672::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/5::INFO::2016-05-25 08:50:58,672::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:58,672::task::1191::Storage.TaskManager.Task::(prepare) Task=`9e9b5dfa-dfed-4367-87de-16cc2931d8fc`::finished: {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:58,672::task::595::Storage.TaskManager.Task::(_updateState) Task=`9e9b5dfa-dfed-4367-87de-16cc2931d8fc`::moving from state preparing -> state finished
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:58,672::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:58,672::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/5::DEBUG::2016-05-25 08:50:58,672::task::993::Storage.TaskManager.Task::(_decref) Task=`9e9b5dfa-dfed-4367-87de-16cc2931d8fc`::ref 0 aborting False
jsonrpc.Executor/5::WARNING::2016-05-25 08:50:58,673::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/5::WARNING::2016-05-25 08:50:58,674::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/7::DEBUG::2016-05-25 08:51:06,288::task::595::Storage.TaskManager.Task::(_updateState) Task=`06c74fa3-7261-45af-8f40-185641f6216c`::moving from state init -> state preparing
jsonrpc.Executor/7::INFO::2016-05-25 08:51:06,288::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/7::INFO::2016-05-25 08:51:06,288::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:51:06,288::task::1191::Storage.TaskManager.Task::(prepare) Task=`06c74fa3-7261-45af-8f40-185641f6216c`::finished: {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:51:06,288::task::595::Storage.TaskManager.Task::(_updateState) Task=`06c74fa3-7261-45af-8f40-185641f6216c`::moving from state preparing -> state finished
jsonrpc.Executor/7::DEBUG::2016-05-25 08:51:06,288::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:51:06,288::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/7::DEBUG::2016-05-25 08:51:06,288::task::993::Storage.TaskManager.Task::(_decref) Task=`06c74fa3-7261-45af-8f40-185641f6216c`::ref 0 aborting False
jsonrpc.Executor/7::WARNING::2016-05-25 08:51:06,289::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/7::WARNING::2016-05-25 08:51:06,289::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.
jsonrpc.Executor/1::DEBUG::2016-05-25 08:51:13,927::task::595::Storage.TaskManager.Task::(_updateState) Task=`6cdad90a-0466-4fd6-8d78-a755c94345b1`::moving from state init -> state preparing
jsonrpc.Executor/1::INFO::2016-05-25 08:51:13,927::logUtils::48::dispatcher::(wrapper) Run and protect: repoStats(options=None)
jsonrpc.Executor/1::INFO::2016-05-25 08:51:13,927::logUtils::51::dispatcher::(wrapper) Run and protect: repoStats, Return response: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:51:13,927::task::1191::Storage.TaskManager.Task::(prepare) Task=`6cdad90a-0466-4fd6-8d78-a755c94345b1`::finished: {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:51:13,927::task::595::Storage.TaskManager.Task::(_updateState) Task=`6cdad90a-0466-4fd6-8d78-a755c94345b1`::moving from state preparing -> state finished
jsonrpc.Executor/1::DEBUG::2016-05-25 08:51:13,928::resourceManager::943::Storage.ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:51:13,928::resourceManager::980::Storage.ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
jsonrpc.Executor/1::DEBUG::2016-05-25 08:51:13,928::task::993::Storage.TaskManager.Task::(_decref) Task=`6cdad90a-0466-4fd6-8d78-a755c94345b1`::ref 0 aborting False
jsonrpc.Executor/1::WARNING::2016-05-25 08:51:13,929::momIF::113::MOM::(getStatus) MOM not available.
jsonrpc.Executor/1::WARNING::2016-05-25 08:51:13,929::momIF::76::MOM::(getKsmStats) MOM not available, KSM stats will be missing.