Attachment 937653 Details for Bug 1141850 – engine log

engine log

engine.log (text/plain), 21.88 KB, created by Nir Soffer on 2014-09-15 15:24:55 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Nir Soffer

Created: 2014-09-15 15:24:55 UTC

Size: 21.88 KB

patch

obsolete

>2014-09-15 15:07:04,262 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStoragePoolVDSCommand] (DefaultQuartzScheduler_Worker-100) START, DisconnectStoragePoolVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, vds_spm_id = 1), log id: b64a46d
>2014-09-15 15:07:04,386 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-64) [444807fc] FINISH, DisconnectStorageServerVDSCommand, return: {e8d58651-6414-4fc2-b281-2141cc97829b=0}, log id: 70ae574e
>2014-09-15 15:07:05,837 INFO  [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (DefaultQuartzScheduler_Worker-20) [20a92c93] Storage Pool b86b687a-d073-497a-ac8a-249025419a3e - Updating Storage Domain b9c2b835-cdbd-48ea-8d69-7a33042c79b1 status from Active to Unknown, reason : no reporting hosts
>2014-09-15 15:07:05,882 INFO  [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (DefaultQuartzScheduler_Worker-20) [20a92c93] Storage Pool b86b687a-d073-497a-ac8a-249025419a3e - Updating Storage Domain aa740243-00c8-498a-a94a-f8330738e5b9 status from Active to Unknown, reason : no reporting hosts
>2014-09-15 15:07:05,893 INFO  [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (DefaultQuartzScheduler_Worker-20) [2fb359ac] Running command: SetStoragePoolStatusCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-09-15 15:07:05,915 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-20) [2fb359ac] Correlation ID: 2fb359ac, Call Stack: null, Custom Event ID: -1, Message: Invalid status on Data Center iscsi-el7. Setting status to Non Responsive.
>2014-09-15 15:07:09,540 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStoragePoolVDSCommand] (DefaultQuartzScheduler_Worker-100) FINISH, DisconnectStoragePoolVDSCommand, log id: b64a46d
>2014-09-15 15:07:09,542 INFO  [org.ovirt.engine.core.bll.storage.DisconnectHostFromStoragePoolServersCommand] (DefaultQuartzScheduler_Worker-100) [377ba1db] Running command: DisconnectHostFromStoragePoolServersCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-09-15 15:07:09,553 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-100) [377ba1db] START, DisconnectStorageServerVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, storageType = ISCSI, connectionList = [{ id: e8d58651-6414-4fc2-b281-2141cc97829b, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 51f5f911
>2014-09-15 15:07:10,197 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-100) [377ba1db] FINISH, DisconnectStorageServerVDSCommand, return: {e8d58651-6414-4fc2-b281-2141cc97829b=0}, log id: 51f5f911
>2014-09-15 15:58:33,183 INFO  [org.ovirt.engine.core.bll.OvfDataUpdater] (DefaultQuartzScheduler_Worker-58) Attempting to update VMs/Templates Ovf.
>2014-09-15 16:58:33,186 INFO  [org.ovirt.engine.core.bll.OvfDataUpdater] (DefaultQuartzScheduler_Worker-95) [612b8f4d] Attempting to update VMs/Templates Ovf.
>2014-09-15 17:58:33,188 INFO  [org.ovirt.engine.core.bll.OvfDataUpdater] (DefaultQuartzScheduler_Worker-90) Attempting to update VMs/Templates Ovf.
>2014-09-15 18:11:01,880 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (ajp--127.0.0.1-8702-9) [3946f558] Lock Acquired to object EngineLock [exclusiveLocks= key: 208d3b4f-6256-4be9-b0b3-d021b488217e value: VDS
>, sharedLocks= ]
>2014-09-15 18:11:01,930 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (org.ovirt.thread.pool-8-thread-16) [3946f558] Running command: ActivateVdsCommand internal: false. Entities affected :  ID: 208d3b4f-6256-4be9-b0b3-d021b488217e Type: VDSAction group MANIPULATE_HOST with role type ADMIN
>2014-09-15 18:11:01,930 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (org.ovirt.thread.pool-8-thread-16) [3946f558] Before acquiring lock in order to prevent monitoring for host el7-01 from data-center iscsi-el7
>2014-09-15 18:11:01,931 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (org.ovirt.thread.pool-8-thread-16) [3946f558] Lock acquired, from now a monitoring of host will be skipped for host el7-01 from data-center iscsi-el7
>2014-09-15 18:11:01,933 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-16) [3946f558] START, SetVdsStatusVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, status=Unassigned, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 22cb9a14
>2014-09-15 18:11:01,946 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-16) [3946f558] FINISH, SetVdsStatusVDSCommand, log id: 22cb9a14
>2014-09-15 18:11:01,971 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (org.ovirt.thread.pool-8-thread-16) [3946f558] Activate finished. Lock released. Monitoring can run now for host el7-01 from data-center iscsi-el7
>2014-09-15 18:11:01,980 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-16) [3946f558] Correlation ID: 3946f558, Job ID: f73415d8-c5de-4744-b5ba-1911a37f02be, Call Stack: null, Custom Event ID: -1, Message: Host el7-01 was activated by admin.
>2014-09-15 18:11:01,997 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (org.ovirt.thread.pool-8-thread-16) [3946f558] Lock freed to object EngineLock [exclusiveLocks= key: 208d3b4f-6256-4be9-b0b3-d021b488217e value: VDS
>, sharedLocks= ]
>2014-09-15 18:11:03,629 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /10.35.0.226
>2014-09-15 18:11:03,630 ERROR [org.ovirt.vdsm.jsonrpc.client.reactors.Reactor] (SSL Stomp Reactor) Unable to process messages: java.nio.channels.ClosedChannelException
>	at sun.nio.ch.SocketChannelImpl.ensureReadOpen(SocketChannelImpl.java:252) [rt.jar:1.7.0_65]
>	at sun.nio.ch.SocketChannelImpl.read(SocketChannelImpl.java:295) [rt.jar:1.7.0_65]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLEngineNioHelper.read(SSLEngineNioHelper.java:51) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLClient.read(SSLClient.java:81) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient.readBuffer(ReactorClient.java:210) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.stomp.StompCommonClient.processIncoming(StompCommonClient.java:90) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient.process(ReactorClient.java:151) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLClient.process(SSLClient.java:115) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.processChannels(Reactor.java:86) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.run(Reactor.java:62) [vdsm-jsonrpc-java-client.jar:]
>
>2014-09-15 18:17:04,014 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (DefaultQuartzScheduler_Worker-63) Command org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand return value 
> org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturnForXmlRpc@4b203016
>2014-09-15 18:17:04,016 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (DefaultQuartzScheduler_Worker-63) HostName = el7-01
>2014-09-15 18:17:04,017 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (DefaultQuartzScheduler_Worker-63) Command GetCapabilitiesVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, vds=Host[el7-01,208d3b4f-6256-4be9-b0b3-d021b488217e]) execution failed. Exception: VDSNetworkException: VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>2014-09-15 18:17:04,019 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-63) Host el7-01 is not responding. It will stay in Connecting state for a grace period of 60 seconds and after that an attempt to fence the host will be issued.
>2014-09-15 18:17:04,073 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-63) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Host el7-01 is not responding. It will stay in Connecting state for a grace period of 60 seconds and after that an attempt to fence the host will be issued.
>2014-09-15 18:17:04,098 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-63) Failure to refresh Vds runtime info: org.ovirt.engine.core.vdsbroker.vdsbroker.VDSNetworkException: VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase.proceedProxyReturnValue(BrokerCommandBase.java:183) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand.executeVdsBrokerCommand(GetCapabilitiesVDSCommand.java:16) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.executeVDSCommand(VdsBrokerCommand.java:96) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VDSCommandBase.executeCommand(VDSCommandBase.java:56) [vdsbroker.jar:]
>	at org.ovirt.engine.core.dal.VdcCommandBase.execute(VdcCommandBase.java:31) [dal.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsManager.refreshCapabilities(VdsManager.java:567) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refreshVdsRunTimeInfo(VdsUpdateRunTimeInfo.java:639) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refresh(VdsUpdateRunTimeInfo.java:486) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsManager.onTimer(VdsManager.java:236) [vdsbroker.jar:]
>	at sun.reflect.GeneratedMethodAccessor5.invoke(Unknown Source) [:1.7.0_65]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_65]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_65]
>	at org.ovirt.engine.core.utils.timer.JobWrapper.execute(JobWrapper.java:60) [scheduler.jar:]
>	at org.quartz.core.JobRunShell.run(JobRunShell.java:213) [quartz.jar:]
>	at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz.jar:]
>
>2014-09-15 18:17:04,107 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-63) Failed to refresh VDS , vds = 208d3b4f-6256-4be9-b0b3-d021b488217e : el7-01, VDS Network Error, continuing.
>VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>2014-09-15 18:17:07,157 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /10.35.0.226
>2014-09-15 18:17:07,340 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-6) START, GetHardwareInfoVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, vds=Host[el7-01,208d3b4f-6256-4be9-b0b3-d021b488217e]), log id: 622fc8d7
>2014-09-15 18:17:07,368 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-6) FINISH, GetHardwareInfoVDSCommand, log id: 622fc8d7
>2014-09-15 18:17:07,413 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-6) [229352a8] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 208d3b4f-6256-4be9-b0b3-d021b488217e Type: VDS
>2014-09-15 18:17:07,435 INFO  [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (DefaultQuartzScheduler_Worker-6) [3018646d] Running command: InitVdsOnUpCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-09-15 18:17:07,446 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (DefaultQuartzScheduler_Worker-6) [67179190] Running command: ConnectHostToStoragePoolServersCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-09-15 18:17:07,459 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-6) [67179190] START, ConnectStorageServerVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, storageType = ISCSI, connectionList = [{ id: e8d58651-6414-4fc2-b281-2141cc97829b, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 4b4a464a
>2014-09-15 18:17:08,066 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-6) [67179190] FINISH, ConnectStorageServerVDSCommand, return: {e8d58651-6414-4fc2-b281-2141cc97829b=0}, log id: 4b4a464a
>2014-09-15 18:17:08,066 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (DefaultQuartzScheduler_Worker-6) [67179190] Host el7-01 storage connection was succeeded 
>2014-09-15 18:17:08,070 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (org.ovirt.thread.pool-8-thread-15) START, ConnectStoragePoolVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, vdsId = 208d3b4f-6256-4be9-b0b3-d021b488217e, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, masterVersion = 1), log id: bcdde33
>2014-09-15 18:17:08,693 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (org.ovirt.thread.pool-8-thread-15) FINISH, ConnectStoragePoolVDSCommand, log id: bcdde33
>2014-09-15 18:17:08,747 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (DefaultQuartzScheduler_Worker-6) [67179190] START, SetMOMPolicyParametersVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e), log id: 78445680
>2014-09-15 18:17:08,790 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (DefaultQuartzScheduler_Worker-6) [67179190] FINISH, SetMOMPolicyParametersVDSCommand, log id: 78445680
>2014-09-15 18:17:08,810 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) [67179190] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Status of host el7-01 was set to Up.
>2014-09-15 18:17:08,819 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) [67179190] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host el7-01.
>2014-09-15 18:17:08,827 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) [67179190] Correlation ID: 3018646d, Call Stack: null, Custom Event ID: -1, Message: Unrecognized audit log type has been used.
>2014-09-15 18:17:08,874 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-6) [486345c3] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 208d3b4f-6256-4be9-b0b3-d021b488217e Type: VDS
>2014-09-15 18:17:14,926 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-58) hostFromVds::selectedVds - el7-01, spmStatus Free, storage pool iscsi-el7
>2014-09-15 18:17:14,973 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-58) starting spm on vds el7-01, storage pool iscsi-el7, prevId -1, LVER 0
>2014-09-15 18:17:14,976 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (DefaultQuartzScheduler_Worker-58) START, SpmStartVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, prevId=-1, prevLVER=0, storagePoolFormatType=V3, recoveryMode=Manual, SCSIFencing=false), log id: 6bab0220
>2014-09-15 18:17:14,989 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (DefaultQuartzScheduler_Worker-58) spmStart polling started: taskId = 9bd2e2cf-3e54-48f6-8ae5-2611478ac121
>2014-09-15 18:17:31,083 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (DefaultQuartzScheduler_Worker-58) spmStart polling ended: taskId = 9bd2e2cf-3e54-48f6-8ae5-2611478ac121 task status = finished
>2014-09-15 18:17:31,088 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (DefaultQuartzScheduler_Worker-58) spmStart polling ended, spm status: SPM
>2014-09-15 18:17:31,091 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (DefaultQuartzScheduler_Worker-58) START, HSMClearTaskVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, taskId=9bd2e2cf-3e54-48f6-8ae5-2611478ac121), log id: 2ca9a3c2
>2014-09-15 18:17:31,096 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (DefaultQuartzScheduler_Worker-58) FINISH, HSMClearTaskVDSCommand, log id: 2ca9a3c2
>2014-09-15 18:17:31,097 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (DefaultQuartzScheduler_Worker-58) FINISH, SpmStartVDSCommand, return: org.ovirt.engine.core.common.businessentities.SpmStatusResult@18280028, log id: 6bab0220
>2014-09-15 18:17:31,160 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-58) Initialize Irs proxy from vds: 10.35.0.226
>2014-09-15 18:17:31,284 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-58) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Storage Pool Manager runs on Host el7-01 (Address: 10.35.0.226).
>2014-09-15 18:17:31,285 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /10.35.0.226
>2014-09-15 18:17:31,292 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-34) START, SPMGetAllTasksInfoVDSCommand( storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, ignoreFailoverLimit = false), log id: 6a41c5af
>2014-09-15 18:17:31,418 INFO  [org.ovirt.engine.core.bll.storage.SyncLunsInfoForBlockStorageDomainCommand] (org.ovirt.thread.pool-8-thread-42) [5abd2498] Running command: SyncLunsInfoForBlockStorageDomainCommand internal: true. Entities affected :  ID: b9c2b835-cdbd-48ea-8d69-7a33042c79b1 Type: Storage
>2014-09-15 18:17:31,425 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-42) [5abd2498] START, GetVGInfoVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, VGID=cj2eX2-T2M2-sIbC-YyEJ-Bmun-Myi5-XCyhzc), log id: 451ffe9d
>2014-09-15 18:17:31,434 INFO  [org.ovirt.engine.core.bll.storage.SyncLunsInfoForBlockStorageDomainCommand] (org.ovirt.thread.pool-8-thread-28) [47e009f9] Running command: SyncLunsInfoForBlockStorageDomainCommand internal: true. Entities affected :  ID: aa740243-00c8-498a-a94a-f8330738e5b9 Type: Storage
>2014-09-15 18:17:31,440 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-28) [47e009f9] START, GetVGInfoVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e, VGID=Nbt1MO-vWgw-To2s-ytNe-AMWh-4fj9-uCrirj), log id: 75cf2785
>2014-09-15 18:17:31,441 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-34) -- executeIrsBrokerCommand: Attempting on storage pool b86b687a-d073-497a-ac8a-249025419a3e
>2014-09-15 18:17:31,445 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-34) START, HSMGetAllTasksInfoVDSCommand(HostName = el7-01, HostId = 208d3b4f-6256-4be9-b0b3-d021b488217e), log id: baaf3bc
>2014-09-15 18:17:31,483 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-34) FINISH, HSMGetAllTasksInfoVDSCommand, return: [], log id: baaf3bc
>2014-09-15 18:17:31,484 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-34) FINISH, SPMGetAllTasksInfoVDSCommand, return: [], log id: 6a41c5af
>2014-09-15 18:17:31,485 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (org.ovirt.thread.pool-8-thread-34) Discovered no tasks on Storage Pool iscsi-el7
>2014-09-15 18:17:31,701 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-42) [5abd2498] FINISH, GetVGInfoVDSCommand, return: [LUNs [id=1IET_00060007, physicalVolumeId=NID0Te-VHrS-5ghV-wLcv-n8lb-aflw-sutlh2, volumeGroupId=cj2eX2-T2M2-sIbC-YyEJ-Bmun-Myi5-XCyhzc, serial=SRed_Cat_VIRTUAL-DISK, lunMapping=7, vendorId=Red Cat, productId=VIRTUAL-DISK, _lunConnections=[{ id: null, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=20, vendorName=Red Cat, pathsDictionary={sdl=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=b9c2b835-cdbd-48ea-8d69-7a33042c79b1, storageDomainName=null]], log id: 451ffe9d
>2014-09-15 18:17:31,744 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-28) [47e009f9] FINISH, GetVGInfoVDSCommand, return: [LUNs [id=1IET_00060008, physicalVolumeId=KUcNT0-jKCl-jj2Y-AQBB-dPya-I71u-T5gtBU, volumeGroupId=Nbt1MO-vWgw-To2s-ytNe-AMWh-4fj9-uCrirj, serial=SRed_Cat_VIRTUAL-DISK, lunMapping=8, vendorId=Red Cat, productId=VIRTUAL-DISK, _lunConnections=[{ id: null, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=20, vendorName=Red Cat, pathsDictionary={sdm=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=aa740243-00c8-498a-a94a-f8330738e5b9, storageDomainName=null]], log id: 75cf2785

Actions: View

Attachments on bug 1141850: 937651 | 937653