<html>
<head>
<style><!--
.hmmessage P
{
margin:0px;
padding:0px
}
body.hmmessage
{
font-size: 12pt;
font-family:΢ÈíÑźÚ
}
--></style></head>
<body class='hmmessage'><div dir='ltr'>dear friends:<br> recently i meet some problem:My company meeted interruption of power supply,which cause my server power off directly.when i start the server,it adviced to user fsck comnmand to repair FS.I did it and know my system had some bad block.And then i enter the ovirt's WEB administration portal normally,i try to start my VM,but i failed!it seems VM was locked .it tips"failed to get volume size:"XXX-XXXX-XXXXX".which confused me a long time!!Have someone meet this problem as me?please give me some advice.Thanks a lot.<br> i try to process service vdsmd restart ,but i throw exception:<br>#service vdsmd restart<br>----------------------------------------------------------------------<br>libvirt is already configured for vdsm<br>vdsm: Running validate_configuration<br>SUCCESS: ssl configured to false. No conflicts.<br>vdsm: Running prepare_transient_repository<br>vdsm: Running syslog_available<br>vdsm: Running nwfilter<br>libvirt: Network Filter Driver error : Requested operation is not valid: nwfilter is in use<br>vdsm: Running dummybr<br>vdsm: Running load_needed_modules<br>vdsm: Running tune_system<br>vdsm: Running test_space<br>vdsm: Running test_lo<br>Upgrading to unified persistence if needed<br>Traceback (most recent call last):<br> File "/usr/share/vdsm/vdsm-restore-net-config", line 346, in <module><br> restore(args)<br> File "/usr/share/vdsm/vdsm-restore-net-config", line 315, in restore<br> unified_restoration()<br> File "/usr/share/vdsm/vdsm-restore-net-config", line 93, in unified_restoration<br> setupNetworks(nets, bonds, connectivityCheck=False, _inRollback=True)<br> File "/usr/share/vdsm/network/api.py", line 666, in setupNetworks<br> _handleBondings(bondings, configurator, in_rollback)<br> File "/usr/share/vdsm/network/api.py", line 530, in _handleBondings<br> destroyOnMasterRemoval='remove' in attrs)<br> File "/usr/share/vdsm/network/models.py", line 242, in objectivize<br> mtu, _netinfo)<br> File "/usr/share/vdsm/network/models.py", line 232, in _objectivizeSlaves<br> (nic, nicVlans or nicNet or nicBond))<br>network.errors.ConfigNetworkError: (24, u'nic em1 already used by ovirtmgmt')<br>Traceback (most recent call last):<br> File "/usr/bin/vdsm-tool", line 219, in main<br> return tool_command[cmd]["command"](*args)<br> File "/usr/lib/python2.6/site-packages/vdsm/tool/restore_nets.py", line 40, in restore_command<br> exec_restore(cmd)<br> File "/usr/lib/python2.6/site-packages/vdsm/tool/restore_nets.py", line 53, in exec_restore<br> raise EnvironmentError('Failed to restore the persisted networks')<br>EnvironmentError: Failed to restore the persisted networks<br>Upgrading to v3.x networking if needed<br>Starting up vdsm daemon:<br>vdsm start [ OK ]<br>-----------------------------------------------------------------------------------<br><br>i check engine.log<br>#less engine.log<br>INFO [org.ovirt.engine.core.bll.RunVmCommand] (ajp--127.0.0.1-8702-4) [31d932f0] Lock Acquired to object EngineLock [exclusiveLocks= key: d6575495-5cb3-41df-9d6e-6b88186dbbb3 value: VM<br>, sharedLocks= ]<br>2016-07-23 11:30:00,931 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (ajp--127.0.0.1-8702-4) [31d932f0] START, IsVmDuringInitiatingVDSCommand( vmId = d6575495-5cb3-41df-9d6e-6b88186dbbb3), log id: 2fbe5c73<br>2016-07-23 11:30:00,933 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (ajp--127.0.0.1-8702-4) [31d932f0] FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 2fbe5c73<br>2016-07-23 11:30:00,966 INFO [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-25) [31d932f0] Running command: RunVmCommand internal: false. Entities affected : ID: d6575495-5cb3-41df-9d6e-6b88186dbbb3 Type: VMAction group VM_BASIC_OPERATIONS with role type USER<br>2016-07-23 11:30:00,996 INFO [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (org.ovirt.thread.pool-8-thread-25) [31d932f0] START, UpdateVmDynamicDataVDSCommand(HostName = local_host, HostId = 953cfb28-41a6-48f1-bcf5-58a741b1213b, vmDynamic=org.ovirt.engine.core.common.businessentities.VmDynamic@417b138a), log id: 1bca8285<br>2016-07-23 11:30:01,000 INFO [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (org.ovirt.thread.pool-8-thread-25) [31d932f0] FINISH, UpdateVmDynamicDataVDSCommand, log id: 1bca8285<br>2016-07-23 11:30:01,005 INFO [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (org.ovirt.thread.pool-8-thread-25) [31d932f0] START, CreateVmVDSCommand(HostName = local_host, HostId = 953cfb28-41a6-48f1-bcf5-58a741b1213b, vmId=d6575495-5cb3-41df-9d6e-6b88186dbbb3, vm=VM [Ïþ·å]), log id: 196e548a<br>2016-07-23 11:30:01,010 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (org.ovirt.thread.pool-8-thread-25) [31d932f0] START, CreateVDSCommand(HostName = local_host, HostId = 953cfb28-41a6-48f1-bcf5-58a741b1213b, vmId=d6575495-5cb3-41df-9d6e-6b88186dbbb3, vm=VM [Ïþ·å]), log id: 566631a7<br>2016-07-23 11:30:01,031 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (org.ovirt.thread.pool-8-thread-25) [31d932f0] org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand kvmEnable=true,keyboardLayout=en-us,nice=0,displayNetwork=ovirtmgmt,copyPasteEnable=true,timeOffset=28800,transparentHugePages=true,vmId=d6575495-5cb3-41df-9d6e-6b88186dbbb3,acpiEnable=true,custom={device_82fbfee2-6ff6-4b65-8d4f-92aa100f0e40device_897aa439-44f3-47b7-bdde-b719ed0d524f=VmDevice {vmId=d6575495-5cb3-41df-9d6e-6b88186dbbb3, deviceId=897aa439-44f3-47b7-bdde-b719ed0d524f, device=unix, type=CHANNEL, bootOrder=0, specParams={}, address={bus=0, controller=0, type=virtio-serial, port=2}, managed=false, plugged=true, readOnly=false, deviceAlias=channel1, customProperties={}, snapshotId=null, logicalName=null}, device_82fbfee2-6ff6-4b65-8d4f-92aa100f0e40device_897aa439-44f3-47b7-bdde-b719ed0d524fdevice_13730383-d2a9-4475-8465-721aaa3ca9f0device_6e251d6d-c788-4378-8a50-ba6807229c4c=VmDevice {vmId=d6575495-5cb3-41df-9d6e-6b88186dbbb3, deviceId=6e251d6d-c788-4378-8a50-ba6807229c4c, device=unix, type=CHANNEL, bootOrder=0, specParams={}, address={bus=0, controller=0, type=virtio-serial, port=1}, managed=false, plugged=true, readOnly=false, deviceAlias=channel0, customProperties={}, snapshotId=null, logicalName=null}, device_82fbfee2-6ff6-4b65-8d4f-92aa100f0e40device_897aa439-44f3-47b7-bdde-b719ed0d524fdevice_13730383-d2a9-4475-8465-721aaa3ca9f0=VmDevice {vmId=d6575495-5cb3-41df-9d6e-6b88186dbbb3, deviceId=13730383-d2a9-4475-8465-721aaa3ca9f0, device=spicevmc, type=CHANNEL, bootOrder=0, specParams={}, address={bus=0, controller=0, type=virtio-serial, port=3}, managed=false, plugged=true, readOnly=false, deviceAlias=channel2, customProperties={}, snapshotId=null, logicalName=null}, device_82fbfee2-6ff6-4b65-8d4f-92aa100f0e40=VmDevice {vmId=d6575495-5cb3-41df-9d6e-6b88186dbbb3, deviceId=82fbfee2-6ff6-4b65-8d4f-92aa100f0e40, device=ide, type=CONTROLLER, bootOrder=0, specParams={}, address={slot=0x01, bus=0x00, domain=0x0000, type=pci, function=0x1}, managed=false, plugged=true, readOnly=false, deviceAlias=ide0, customProperties={}, snapshotId=null, logicalName=null}},memSize=4096,smp=4,emulatedMachine=rhel6.5.0,vmType=kvm,memGuaranteedSize=1024,display=qxl,smartcardEnable=false,bootMenuEnable=false,smpCoresPerSocket=1,maxVCpus=16,hypervEnable=true,devices=[{model=ich9-ehci1, index=0, address={bus=0x00, domain=0x0000, type=pci, slot=0x04, function=0x7}, specParams={}, device=usb, type=controller, deviceId=f28a4ab1-1f8b-450c-945f-63c555e35493}, {address={bus=0x00, domain=0x0000, type=pci, slot=0x02, function=0x0}, specParams={vram=32768, heads=1}, device=qxl, type=video, deviceId=ebbb86af-594e-4507-b620-dbdfaea1dbed}, {shared=false, iface=ide, index=2, address={unit=0, bus=1, target=0, controller=0, type=drive}, specParams={path=}, path=, device=cdrom, type=disk, readonly=true, deviceId=c23c1941-3df5-4fac-be1d-98135b8cd41e}, {shared=false, index=0, volumeID=3e2bbe2b-39e2-4575-aac5-8f2c6fe31a88, propagateErrors=off, format=cow, type=disk, iface=virtio, bootOrder=1, domainID=e42469fc-13c8-4323-800f-9602150fb4e1, imageID=64d53873-af54-4c71-ae5e-f7675033c920, specParams={}, optional=false, device=disk, poolID=9049d6c1-00e3-46b3-ac3d-745f5c99f8b5, readonly=false, deviceId=64d53873-af54-4c71-ae5e-f7675033c920}, {shared=false, volumeID=06e72ea0-e4fb-4213-b5bc-d2b53acf36d9, iface=virtio, imageID=863fe11e-6a53-4981-b09a-ba2bb3f02e6a, domainID=7b74d992-823f-460c-8f84-47190b515d49, specParams={}, optional=false, propagateErrors=off, device=disk, poolID=9049d6c1-00e3-46b3-ac3d-745f5c99f8b5, format=cow, type=disk, readonly=false, deviceId=863fe11e-6a53-4981-b09a-ba2bb3f02e6a}, {nicModel=pv, address={bus=0x00, domain=0x0000, type=pci, slot=0x09, function=0x0}, specParams={outbound={}, inbound={}}, macAddr=00:1a:4a:1b:25:1c, device=bridge, linkActive=true, type=interface, filter=vdsm-no-mac-spoofing, network=ovirtmgmt, deviceId=8ae649b9-6dd0-4236-aecd-8e68d7dbe287}, {address={bus=0x00, domain=0x0000, type=pci, slot=0x03, function=0x0}, specParams={}, device=ich6, type=sound, deviceId=e04a692e-d0af-474a-99d8-93b487362131}, {model=ich9-uhci2, index=0, address={bus=0x00, domain=0x0000, type=pci, slot=0x04, function=0x1}, specParams={}, device=usb, type=controller, deviceId=110d4e02-fe82-4a3f-ab9b-57cf1e70360f}, {model=ich9-uhci1, index=0, address={bus=0x00, domain=0x0000, type=pci, multifunction=on, slot=0x04, function=0x0}, specParams={}, device=usb, type=controller, deviceId=925b918e-6e7c-4ce1-962e-ecceac5a3056}, {model=ich9-uhci3, index=0, address={bus=0x00, domain=0x0000, type=pci, slot=0x04, function=0x2}, specParams={}, device=usb, type=controller, deviceId=e469ef72-1f57-422b-b6ab-29176cf88439}, {bus=usb, specParams={}, device=spicevmc, type=redir, deviceId=2338974e-8753-42cb-98ca-41281bedae48}, {bus=usb, specParams={}, device=spicevmc, type=redir, deviceId=39badef1-50c5-4549-93a3-91d91ef98554}, {bus=usb, specParams={}, device=spicevmc, type=redir, deviceId=7a40dba2-5f6c-4e8a-bbf0-8559fe9aa553}, {bus=usb, specParams={}, device=spicevmc, type=redir, deviceId=d9930b40-d233-453a-b7fb-ddaa740978ec}, {index=0, model=virtio-scsi, address={bus=0x00, domain=0x0000, type=pci, slot=0x05, function=0x0}, specParams={}, device=scsi, type=controller, deviceId=7a0ed22b-a3c0-4a44-9874-58a40f1a01d4}, {address={bus=0x00, domain=0x0000, type=pci, slot=0x06, function=0x0}, specParams={}, device=virtio-serial, type=controller, deviceId=1d23f521-a6c0-4913-b239-8c47bf258fe7}],vmName=Ïþ·å,cpuType=SandyBridge,fileTransferEnable=true<br>2016-07-23 11:30:01,100 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (org.ovirt.thread.pool-8-thread-25) [31d932f0] FINISH, CreateVDSCommand, log id: 566631a7<br>2016-07-23 11:30:01,105 INFO [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (org.ovirt.thread.pool-8-thread-25) [31d932f0] FINISH, CreateVmVDSCommand, return: WaitForLaunch, log id: 196e548a<br>2016-07-23 11:30:01,107 INFO [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-25) [31d932f0] Lock freed to object EngineLock [exclusiveLocks= key: d6575495-5cb3-41df-9d6e-6b88186dbbb3 value: VM<br>, sharedLocks= ]<br>2016-07-23 11:30:01,111 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-25) [31d932f0] Correlation ID: 31d932f0, Job ID: cdac0f67-f098-485e-8232-ab2dc7de24c7, Call Stack: null, Custom Event ID: -1, Message: VM Ïþ·å was started by admin@internal (Host: local_host).<br>2016-07-23 11:30:02,611 INFO [org.ovirt.engine.core.bll.aaa.LoginUserCommand] (ajp--127.0.0.1-8702-8) Running command: LoginUserCommand internal: false.<br>2016-07-23 11:30:02,613 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-8) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: User admin@internal logged in.<br>2016-07-23 11:30:03,896 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (DefaultQuartzScheduler_Worker-56) START, DestroyVDSCommand(HostName = local_host, HostId = 953cfb28-41a6-48f1-bcf5-58a741b1213b, vmId=d6575495-5cb3-41df-9d6e-6b88186dbbb3, force=false, secondsToWait=0, gracefully=false, reason=), log id: 15692c5f<br>2016-07-23 11:30:03,936 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (DefaultQuartzScheduler_Worker-56) FINISH, DestroyVDSCommand, log id: 15692c5f<br>2016-07-23 11:30:03,948 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-56) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: VM Ïþ·å is down with error. Exit message: ('Failed to get size for volume %s', '3e2bbe2b-39e2-4575-aac5-8f2c6fe31a88').<br>2016-07-23 11:30:03,949 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-56) Running on vds during rerun failed vm: null<br>2016-07-23 11:30:03,967 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-56) VM Ïþ·å (d6575495-5cb3-41df-9d6e-6b88186dbbb3) is running in db and not running in VDS local_host<br>2016-07-23 11:30:03,995 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-56) Rerun vm d6575495-5cb3-41df-9d6e-6b88186dbbb3. Called from vds local_host<br>2016-07-23 11:30:04,002 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-45) Correlation ID: 31d932f0, Job ID: cdac0f67-f098-485e-8232-ab2dc7de24c7, Call Stack: null, Custom Event ID: -1, Message: Failed to run VM Ïþ·å on Host local_host.<br>2016-07-23 11:30:04,006 INFO [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-45) Lock Acquired to object EngineLock [exclusiveLocks= key: d6575495-5cb3-41df-9d6e-6b88186dbbb3 value: VM<br>, sharedLocks= ]<br>2016-07-23 11:30:04,027 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (org.ovirt.thread.pool-8-thread-45) START, IsVmDuringInitiatingVDSCommand( vmId = d6575495-5cb3-41df-9d6e-6b88186dbbb3), log id: 2ea731ec<br>2016-07-23 11:30:04,028 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (org.ovirt.thread.pool-8-thread-45) FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 2ea731ec<br>2016-07-23 11:30:04,039 WARN [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-45) CanDoAction of action RunVm failed for user admin@internal. Reasons: VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,SCHEDULING_NO_HOSTS<br>2016-07-23 11:30:04,041 INFO [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-45) Lock freed to object EngineLock [exclusiveLocks= key: d6575495-5cb3-41df-9d6e-6b88186dbbb3 value: VM<br>, sharedLocks= ]<br>2016-07-23 11:30:04,045 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-45) Correlation ID: 31d932f0, Job ID: cdac0f67-f098-485e-8232-ab2dc7de24c7, Call Stack: null, Custom Event ID: -1, Message: Failed to run VM Ïþ·å (User: admin@internal).<br>2016-07-23 11:30:04,051 INFO [org.ovirt.engine.core.bll.ProcessDownVmCommand] (org.ovirt.thread.pool-8-thread-20) [6de68e30] Running command: ProcessDownVmCommand internal: true.<br>--------------------------------------------------------------------------------------------<br><br> </div></body>
</html>