Attachment 668917 Details for Bug 890167 – engine.log

engine.log

engine.log (text/x-log), 100.36 KB, created by Ohad Basan on 2012-12-25 13:05:28 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Ohad Basan

Created: 2012-12-25 13:05:28 UTC

Size: 100.36 KB

patch

obsolete

>2012-12-25 15:00:23,712 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) Start time: 12/25/12 3:00 PM
>2012-12-25 15:00:24,007 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-14) Could not parse option AutoRecoveryAllowedTypes value.
>2012-12-25 15:00:24,025 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (MSC service thread 1-14) Failed to decrypt Data must start with zero
>2012-12-25 15:00:24,025 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-14) Failed to decrypt value for property TruststorePass will be used encrypted value
>2012-12-25 15:00:24,042 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) VDSBrokerFrontend: 12/25/12 3:00 PM
>2012-12-25 15:00:24,044 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) CpuFlagsManager: 12/25/12 3:00 PM
>2012-12-25 15:00:24,045 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-14) Setting audit clean up manager to run at: 35 35 3 * * ?
>2012-12-25 15:00:24,055 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) AuditLogCleanupManager: 12/25/12 3:00 PM
>2012-12-25 15:00:24,057 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-14) TagsDirector initialization
>2012-12-25 15:00:24,068 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-14) Tag root added to tree
>2012-12-25 15:00:24,074 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) TagsDirector: 12/25/12 3:00 PM
>2012-12-25 15:00:24,079 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) IsoDomainListSyncronizer: 12/25/12 3:00 PM
>2012-12-25 15:00:24,091 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) InitHandlers: 12/25/12 3:00 PM
>2012-12-25 15:00:24,097 WARN  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-14) Code VDS_FENCING_OPERATION_FAILED appears more than once in string table.
>2012-12-25 15:00:24,098 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) ErrorTranslator: 12/25/12 3:00 PM
>2012-12-25 15:00:24,099 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) VdsErrorTranslator: 12/25/12 3:00 PM
>2012-12-25 15:00:24,099 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) Mark uncompleted jobs as UNKNOWN: 12/25/12 3:00 PM
>2012-12-25 15:00:24,129 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) JobRepositoryCleanupManager: 12/25/12 3:00 PM
>2012-12-25 15:00:24,131 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) AutoRecoveryManager: 12/25/12 3:00 PM
>2012-12-25 15:00:24,133 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-14) ExecutionMessageDirector: 12/25/12 3:00 PM
>2012-12-25 15:00:24,147 INFO  [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (MSC service thread 1-14) UsersDomainsCacheManager: 12/25/12 3:00 PM
>2012-12-25 15:00:24,148 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-2) InitResourceManager: 12/25/12 3:00 PM
>2012-12-25 15:00:24,150 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) ResourceManager::ResourceManager::Entered
>2012-12-25 15:00:24,159 INFO  [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (MSC service thread 1-14) DbUserCacheManager: 12/25/12 3:00 PM
>2012-12-25 15:00:24,172 INFO  [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-1) DbUserCacheManager::refreshAllUserData() - entered
>2012-12-25 15:00:24,211 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (MSC service thread 1-2) AsyncTaskManager: Initialization of AsyncTaskManager completed successfully.
>2012-12-25 15:00:24,211 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-2) AsyncTaskManager: 12/25/12 3:00 PM
>2012-12-25 15:00:24,212 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-2) VdsLoadBalancer: 12/25/12 3:00 PM
>2012-12-25 15:00:24,214 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (pool-3-thread-1) MacPoolManager started: 12/25/12 3:00 PM
>2012-12-25 15:00:24,220 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-2) Init VM Custom Properties utilities: 12/25/12 3:00 PM
>2012-12-25 15:00:24,240 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (pool-3-thread-1) MacPoolManager finished: 12/25/12 3:00 PM
>2012-12-25 15:00:28,943 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:28,947 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:28,991 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: UNASSIGNED not exist in string table
>2012-12-25 15:00:28,991 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: USER_RUN_UNLOCK_ENTITY_SCRIPT not exist in string table
>2012-12-25 15:00:28,992 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: VDS_NETWORK_MTU_DIFFER_FROM_LOGICAL_NETWORK not exist in string table
>2012-12-25 15:00:28,992 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: STORAGE_ACTIVATE_ASYNC not exist in string table
>2012-12-25 15:00:28,992 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: DWH_STOPPED not exist in string table
>2012-12-25 15:00:28,992 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: DWH_STARTED not exist in string table
>2012-12-25 15:00:28,993 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: DWH_ERROR not exist in string table
>2012-12-25 15:00:28,995 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: USER_ATTACH_DISK_TO_VM not have severity. Assumed Normal
>2012-12-25 15:00:28,995 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: USER_DETACH_DISK_FROM_VM not have severity. Assumed Normal
>2012-12-25 15:00:28,996 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: USER_FAILED_DETACH_DISK_FROM_VM not have severity. Assumed Normal
>2012-12-25 15:00:28,996 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: USER_RUN_UNLOCK_ENTITY_SCRIPT not have severity. Assumed Normal
>2012-12-25 15:00:28,996 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: VM_MIGRATION_START_SYSTEM_INITIATED not have severity. Assumed Normal
>2012-12-25 15:00:28,997 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) AuditLogType: VDS_NETWORK_MTU_DIFFER_FROM_LOGICAL_NETWORK not have severity. Assumed Normal
>2012-12-25 15:00:29,017 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:29,024 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (VdcVersion) with null version, using default general for version
>2012-12-25 15:00:29,836 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:29,838 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:29,854 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-4) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:30,060 INFO  [org.ovirt.engine.core.bll.storage.AddEmptyStoragePoolCommand] (ajp--127.0.0.1-8702-4) [5cca8e56] Running command: AddEmptyStoragePoolCommand internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type: System
>2012-12-25 15:00:30,143 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:30,143 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:30,155 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:30,387 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:30,388 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:30,395 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-1) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:30,551 INFO  [org.ovirt.engine.core.bll.AddVdsGroupCommand] (ajp--127.0.0.1-8702-1) [41e467e] Running command: AddVdsGroupCommand internal: false. Entities affected :  ID: 63a90c8c-dd4a-4089-aa32-ae1f686e74af Type: StoragePool
>2012-12-25 15:00:30,618 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:30,619 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:30,624 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-2) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:30,801 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:30,802 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:30,806 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:31,131 INFO  [org.ovirt.engine.core.bll.AddVdsCommand] (ajp--127.0.0.1-8702-6) [206db0e7] Running command: AddVdsCommand internal: false. Entities affected :  ID: 405febdf-f1ba-4db5-95a3-a389836bce84 Type: VdsGroups
>2012-12-25 15:00:31,194 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--127.0.0.1-8702-6) [40ca819d] Running command: AddVdsSpmIdCommand internal: true. Entities affected :  ID: 8051a860-e096-4d76-8593-2b866214b861 Type: VDS
>2012-12-25 15:00:31,204 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--127.0.0.1-8702-6) [40ca819d] Lock freed to object EngineLock [exclusiveLocks= key: 63a90c8c-dd4a-4089-aa32-ae1f686e74af value: REGISTER_VDS
>, sharedLocks= ]
>2012-12-25 15:00:31,207 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-6) [40ca819d] Cannot get vdsManager for vdsid=8051a860-e096-4d76-8593-2b866214b861
>2012-12-25 15:00:31,215 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--127.0.0.1-8702-6) [40ca819d] START, RemoveVdsVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861), log id: 3bf4e566
>2012-12-25 15:00:31,216 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-6) [40ca819d] Cannot get vdsManager for vdsid=8051a860-e096-4d76-8593-2b866214b861
>2012-12-25 15:00:31,216 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--127.0.0.1-8702-6) [40ca819d] FINISH, RemoveVdsVDSCommand, log id: 3bf4e566
>2012-12-25 15:00:31,217 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-6) [40ca819d] Cannot get vdsManager for vdsid=8051a860-e096-4d76-8593-2b866214b861
>2012-12-25 15:00:31,224 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-6) [40ca819d] START, AddVdsVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861), log id: 44383b19
>2012-12-25 15:00:31,224 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-6) [40ca819d] AddVds - entered , starting logic to add VDS 8051a860-e096-4d76-8593-2b866214b861
>2012-12-25 15:00:31,231 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-6) [40ca819d] AddVds - VDS 8051a860-e096-4d76-8593-2b866214b861 was added, will try to add it to the resource manager
>2012-12-25 15:00:31,236 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--127.0.0.1-8702-6) [40ca819d] Eneterd VdsManager:constructor
>2012-12-25 15:00:31,238 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--127.0.0.1-8702-6) [40ca819d] vdsBroker(localhost.localdomain,54,321)
>2012-12-25 15:00:31,298 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-6) [40ca819d] ResourceManager::AddVds - VDS 8051a860-e096-4d76-8593-2b866214b861 was added to the Resource Manager
>2012-12-25 15:00:31,298 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-6) [40ca819d] FINISH, AddVdsVDSCommand, log id: 44383b19
>2012-12-25 15:00:31,342 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-3-thread-8) [93f7d1a] Running command: InstallVdsCommand internal: true. Entities affected :  ID: 8051a860-e096-4d76-8593-2b866214b861 Type: VDS
>2012-12-25 15:00:31,342 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-3-thread-8) [93f7d1a] Before Installation host 8051a860-e096-4d76-8593-2b866214b861, local_host
>2012-12-25 15:00:31,351 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Loaded file "/usr/share/ovirt-engine/conf/engine.conf.defaults".
>2012-12-25 15:00:31,352 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Loaded file "/etc/sysconfig/ovirt-engine".
>2012-12-25 15:00:31,352 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_DB_URL" is "jdbc:postgresql://localhost:5432/engine".
>2012-12-25 15:00:31,352 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_PROPERTIES" is "".
>2012-12-25 15:00:31,352 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_PKI" is "/etc/pki/ovirt-engine".
>2012-12-25 15:00:31,353 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_PERM_MIN" is "256m".
>2012-12-25 15:00:31,353 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "JBOSS_HOME" is "/usr/share/jboss-as".
>2012-12-25 15:00:31,353 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_DB_USER" is "engine".
>2012-12-25 15:00:31,353 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_LOG" is "/var/log/ovirt-engine".
>2012-12-25 15:00:31,353 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_PROXY_HTTP_PORT" is "80".
>2012-12-25 15:00:31,354 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_STOP_TIME" is "10".
>2012-12-25 15:00:31,354 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_FQDN" is "localhost.localdomain".
>2012-12-25 15:00:31,354 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_HEAP_MAX" is "1g".
>2012-12-25 15:00:31,354 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_DB_MIN_CONNECTIONS" is "1".
>2012-12-25 15:00:31,354 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_LOCK" is "/var/lock/ovirt-engine".
>2012-12-25 15:00:31,355 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_STOP_INTERVAL" is "1".
>2012-12-25 15:00:31,355 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_PROXY_ENABLED" is "true".
>2012-12-25 15:00:31,355 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_DB_DRIVER" is "org.postgresql.Driver".
>2012-12-25 15:00:31,355 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_APPS" is "engine.ear".
>2012-12-25 15:00:31,355 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_DB_PASSWORD" is "5abede1108a20837".
>2012-12-25 15:00:31,355 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_ETC" is "/etc/ovirt-engine".
>2012-12-25 15:00:31,356 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_VAR" is "/var/lib/ovirt-engine".
>2012-12-25 15:00:31,356 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_DB_MAX_CONNECTIONS" is "100".
>2012-12-25 15:00:31,356 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_HTTP_PORT" is "8700".
>2012-12-25 15:00:31,356 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_AJP_PORT" is "8702".
>2012-12-25 15:00:31,356 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_PERM_MAX" is "256m".
>2012-12-25 15:00:31,357 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_VERBOSE_GC" is "false".
>2012-12-25 15:00:31,357 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_HTTPS_PORT" is "8701".
>2012-12-25 15:00:31,357 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_DEBUG_ADDRESS" is "".
>2012-12-25 15:00:31,357 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_CACHE" is "/var/cache/ovirt-engine".
>2012-12-25 15:00:31,357 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_NOFILE" is "65535".
>2012-12-25 15:00:31,358 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_PROXY_HTTPS_PORT" is "443".
>2012-12-25 15:00:31,358 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_PID" is "/var/run/ovirt-engine.pid".
>2012-12-25 15:00:31,358 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_USR" is "/usr/share/ovirt-engine".
>2012-12-25 15:00:31,358 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_HTTP_ENABLED" is "false".
>2012-12-25 15:00:31,358 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_GROUP" is "ovirt".
>2012-12-25 15:00:31,359 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "JAVA_HOME" is "/usr/lib/jvm/jre-1.7.0-openjdk.x86_64".
>2012-12-25 15:00:31,359 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_HTTPS_ENABLED" is "false".
>2012-12-25 15:00:31,359 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_DB_SSL" is "false".
>2012-12-25 15:00:31,359 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_TMP" is "/var/tmp/ovirt-engine".
>2012-12-25 15:00:31,359 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_HEAP_MIN" is "1g".
>2012-12-25 15:00:31,359 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_AJP_ENABLED" is "true".
>2012-12-25 15:00:31,360 INFO  [org.ovirt.engine.core.utils.LocalConfig] (pool-3-thread-8) Value of property "ENGINE_USER" is "ovirt".
>2012-12-25 15:00:31,422 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:31,423 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:31,426 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (pool-3-thread-8) [93f7d1a] Installation localhost.localdomain: Connected to host localhost.localdomain with SSH key fingerprint: 6e:6c:40:31:82:6f:9f:98:31:ba:51:e7:f1:75:05:09
>2012-12-25 15:00:31,434 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:31,452 INFO  [org.ovirt.engine.core.bll.VdsDeploy] (pool-3-thread-8) [93f7d1a] Installation of localhost.localdomain. Executing command via SSH umask 0077; MYTMP="$(mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && python -c "import sys, tarfile; tarfile.open(fileobj=sys.stdin, mode='r|').extractall(path='${MYTMP}')" &&  "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True < /var/cache/ovirt-engine/ovirt-host-deploy.tar
>2012-12-25 15:00:31,454 INFO  [org.ovirt.engine.core.utils.archivers.tar.CachedTar] (pool-3-thread-8) Tarball '/var/cache/ovirt-engine/ovirt-host-deploy.tar' is missing, creating
>2012-12-25 15:00:31,546 INFO  [org.ovirt.engine.core.utils.ssh.SSHDialog] (pool-3-thread-8) SSH execute root@localhost.localdomain 'umask 0077; MYTMP="$(mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && python -c "import sys, tarfile; tarfile.open(fileobj=sys.stdin, mode='r|').extractall(path='${MYTMP}')" &&  "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True'
>2012-12-25 15:00:32,092 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Initializing
>2012-12-25 15:00:32,123 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Environment setup
>2012-12-25 15:00:32,132 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Installation packages setup
>2012-12-25 15:00:32,141 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Programs detection
>2012-12-25 15:00:32,154 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Environment customization
>2012-12-25 15:00:32,161 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Logs at host located at: '/tmp/ovirt-host-deploy-20121225150031.log'
>2012-12-25 15:00:32,188 INFO  [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Host localhost.localdomain reports unique id 4C4C4544-0032-4310-8051-B8C04F39354A
>2012-12-25 15:00:32,199 INFO  [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Assigning unique id 4C4C4544-0032-4310-8051-B8C04F39354A to Host localhost.localdomain
>2012-12-25 15:00:32,227 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Setup validation
>2012-12-25 15:00:32,253 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Hardware supports virtualization
>2012-12-25 15:00:32,273 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Transaction setup
>2012-12-25 15:00:32,280 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Package installation
>2012-12-25 15:00:33,302 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-3) Initializing Host: local_host
>2012-12-25 15:00:34,549 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Misc configuration
>2012-12-25 15:00:36,719 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:36,720 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:36,727 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:37,655 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Setting time
>2012-12-25 15:00:37,754 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Enrolling certificate
>2012-12-25 15:00:38,780 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Transaction commit
>2012-12-25 15:00:38,788 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Closing up
>2012-12-25 15:00:39,053 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Starting vdsm
>2012-12-25 15:00:40,349 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Pre-termination
>2012-12-25 15:00:40,361 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Retrieving installation logs to: '/var/log/ovirt-engine/host-deploy/ovirt-20121225150040-localhost.localdomain.log'
>2012-12-25 15:00:40,453 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation localhost.localdomain: Stage: Termination
>2012-12-25 15:00:40,482 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-3-thread-8) [93f7d1a] After Installation host local_host, VDS
>2012-12-25 15:00:41,153 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:41,154 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:41,199 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-2) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:43,690 INFO  [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (QuartzScheduler_Worker-12) [157b3aa2] Running command: InitVdsOnUpCommand internal: true.
>2012-12-25 15:00:43,702 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-12) [157b3aa2] No string for UNASSIGNED type. Use default Log
>2012-12-25 15:00:43,711 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (QuartzScheduler_Worker-12) [5275b5dd] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 8051a860-e096-4d76-8593-2b866214b861 Type: VDS
>2012-12-25 15:00:43,712 INFO  [org.ovirt.engine.core.bll.MultipleActionsRunner] (pool-3-thread-16) [157b3aa2] MultipleActionsRunner of type MigrateVmToServer invoked with no actions
>2012-12-25 15:00:43,725 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (QuartzScheduler_Worker-12) [6129080b] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 8051a860-e096-4d76-8593-2b866214b861 Type: VDS
>2012-12-25 15:00:46,286 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:46,286 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:46,292 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:46,370 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:46,370 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:46,375 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:46,410 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:46,410 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:46,414 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-4) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:46,487 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:00:46,488 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:00:46,492 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:00:46,624 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand] (ajp--127.0.0.1-8702-5) [2a29500f] START, ValidateStorageServerConnectionVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = LOCALFS, connectionList = [{ id: null, connection: /usr/local/ovirt/data, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 4cb4716b
>2012-12-25 15:00:46,633 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand] (ajp--127.0.0.1-8702-5) [2a29500f] FINISH, ValidateStorageServerConnectionVDSCommand, return: {00000000-0000-0000-0000-000000000000=0}, log id: 4cb4716b
>2012-12-25 15:00:46,638 INFO  [org.ovirt.engine.core.bll.storage.AddStorageServerConnectionCommand] (ajp--127.0.0.1-8702-5) [2a29500f] Running command: AddStorageServerConnectionCommand internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type: System
>2012-12-25 15:00:46,645 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-5) [2a29500f] START, ConnectStorageServerVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = LOCALFS, connectionList = [{ id: null, connection: /usr/local/ovirt/data, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 38c81d51
>2012-12-25 15:00:46,702 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-5) [2a29500f] FINISH, ConnectStorageServerVDSCommand, return: {00000000-0000-0000-0000-000000000000=0}, log id: 38c81d51
>2012-12-25 15:00:46,738 INFO  [org.ovirt.engine.core.bll.storage.AddLocalStorageDomainCommand] (ajp--127.0.0.1-8702-5) [36d96b3c] Running command: AddLocalStorageDomainCommand internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type: System
>2012-12-25 15:00:46,750 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-5) [36d96b3c] START, CreateStorageDomainVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storageDomain=org.ovirt.engine.core.common.businessentities.StorageDomainStatic@d7092bd9, args=/usr/local/ovirt/data), log id: 37df5e23
>2012-12-25 15:00:47,275 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-5) [36d96b3c] FINISH, CreateStorageDomainVDSCommand, log id: 37df5e23
>2012-12-25 15:00:47,277 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetStorageDomainStatsVDSCommand] (ajp--127.0.0.1-8702-5) [36d96b3c] START, GetStorageDomainStatsVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storageDomainId=6b3ca157-b6e7-405d-8995-063c16640670), log id: 70446d01
>2012-12-25 15:00:47,285 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetStorageDomainStatsVDSCommand] (ajp--127.0.0.1-8702-5) [36d96b3c] FINISH, GetStorageDomainStatsVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage_domains@4cbde77e, log id: 70446d01
>2012-12-25 15:00:47,331 INFO  [org.ovirt.engine.core.bll.storage.AttachStorageDomainToPoolCommand] (ajp--127.0.0.1-8702-5) [619fe850] Running command: AttachStorageDomainToPoolCommand internal: true. Entities affected :  ID: 6b3ca157-b6e7-405d-8995-063c16640670 Type: Storage
>2012-12-25 15:00:47,336 INFO  [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (ajp--127.0.0.1-8702-5) [6d9193f1] Lock Acquired to object EngineLock [exclusiveLocks= key: 63a90c8c-dd4a-4089-aa32-ae1f686e74af value: POOL
>, sharedLocks= ]
>2012-12-25 15:00:47,341 INFO  [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (ajp--127.0.0.1-8702-5) [6d9193f1] Running command: AddStoragePoolWithStoragesCommand internal: true. Entities affected :  ID: 63a90c8c-dd4a-4089-aa32-ae1f686e74af Type: StoragePool
>2012-12-25 15:00:47,391 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand] (ajp--127.0.0.1-8702-5) [7b0376bc] START, ValidateStorageServerConnectionVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = LOCALFS, connectionList = [{ id: 281d3562-b4ae-4c1f-b0ec-61a5fddeac1c, connection: /usr/local/ovirt/data, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 62efaafb
>2012-12-25 15:00:47,397 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand] (ajp--127.0.0.1-8702-5) [7b0376bc] FINISH, ValidateStorageServerConnectionVDSCommand, return: {281d3562-b4ae-4c1f-b0ec-61a5fddeac1c=0}, log id: 62efaafb
>2012-12-25 15:00:47,398 INFO  [org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand] (ajp--127.0.0.1-8702-5) [7b0376bc] Running command: ConnectStorageToVdsCommand internal: true. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type: System
>2012-12-25 15:00:47,400 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-5) [7b0376bc] START, ConnectStorageServerVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = LOCALFS, connectionList = [{ id: 281d3562-b4ae-4c1f-b0ec-61a5fddeac1c, connection: /usr/local/ovirt/data, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 4693d318
>2012-12-25 15:00:47,410 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (ajp--127.0.0.1-8702-5) [7b0376bc] FINISH, ConnectStorageServerVDSCommand, return: {281d3562-b4ae-4c1f-b0ec-61a5fddeac1c=0}, log id: 4693d318
>2012-12-25 15:00:47,414 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand] (ajp--127.0.0.1-8702-5) [7b0376bc] START, CreateStoragePoolVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId=63a90c8c-dd4a-4089-aa32-ae1f686e74af, storageType=LOCALFS, storagePoolName=local_datacenter, masterDomainId=6b3ca157-b6e7-405d-8995-063c16640670, domainsIdList=[6b3ca157-b6e7-405d-8995-063c16640670], masterVersion=1), log id: 7509219f
>2012-12-25 15:01:10,472 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand] (ajp--127.0.0.1-8702-5) [7b0376bc] FINISH, CreateStoragePoolVDSCommand, log id: 7509219f
>2012-12-25 15:01:10,474 INFO  [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (ajp--127.0.0.1-8702-5) [7b0376bc] Lock freed to object EngineLock [exclusiveLocks= key: 63a90c8c-dd4a-4089-aa32-ae1f686e74af value: POOL
>, sharedLocks= ]
>2012-12-25 15:01:10,476 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [6bec94ee] Lock Acquired to object EngineLock [exclusiveLocks= key: 6b3ca157-b6e7-405d-8995-063c16640670 value: STORAGE
>, sharedLocks= ]
>2012-12-25 15:01:10,479 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [6bec94ee] Running command: ActivateStorageDomainCommand internal: true. Entities affected :  ID: 6b3ca157-b6e7-405d-8995-063c16640670 Type: Storage
>2012-12-25 15:01:10,487 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [6bec94ee] Lock freed to object EngineLock [exclusiveLocks= key: 6b3ca157-b6e7-405d-8995-063c16640670 value: STORAGE
>, sharedLocks= ]
>2012-12-25 15:01:10,487 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [6bec94ee] ActivateStorage Domain. Before Connect all hosts to pool. Time:12/25/12 3:01 PM
>2012-12-25 15:01:10,495 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand] (pool-3-thread-43) [e5552d9] START, ValidateStorageServerConnectionVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = LOCALFS, connectionList = [{ id: 281d3562-b4ae-4c1f-b0ec-61a5fddeac1c, connection: /usr/local/ovirt/data, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 58ff3a4f
>2012-12-25 15:01:10,501 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand] (pool-3-thread-43) [e5552d9] FINISH, ValidateStorageServerConnectionVDSCommand, return: {281d3562-b4ae-4c1f-b0ec-61a5fddeac1c=0}, log id: 58ff3a4f
>2012-12-25 15:01:10,502 INFO  [org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand] (pool-3-thread-43) [e5552d9] Running command: ConnectStorageToVdsCommand internal: true. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type: System
>2012-12-25 15:01:10,504 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (pool-3-thread-43) [e5552d9] START, ConnectStorageServerVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = LOCALFS, connectionList = [{ id: 281d3562-b4ae-4c1f-b0ec-61a5fddeac1c, connection: /usr/local/ovirt/data, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 2614f131
>2012-12-25 15:01:10,514 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (pool-3-thread-43) [e5552d9] FINISH, ConnectStorageServerVDSCommand, return: {281d3562-b4ae-4c1f-b0ec-61a5fddeac1c=0}, log id: 2614f131
>2012-12-25 15:01:10,516 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-5) [6bec94ee] START, ActivateStorageDomainVDSCommand( storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId = 6b3ca157-b6e7-405d-8995-063c16640670), log id: 7b8521ed
>2012-12-25 15:01:10,527 INFO  [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] Running command: SetStoragePoolStatusCommand internal: true. Entities affected :  ID: 63a90c8c-dd4a-4089-aa32-ae1f686e74af Type: StoragePool
>2012-12-25 15:01:10,554 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] hostFromVds::selectedVds - local_host, spmStatus Unknown_Pool, storage pool local_datacenter
>2012-12-25 15:01:10,563 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] START, ConnectStoragePoolVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, vds_spm_id = 1, masterDomainId = 6b3ca157-b6e7-405d-8995-063c16640670, masterVersion = 1), log id: 1ab22259
>2012-12-25 15:01:11,007 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] FINISH, ConnectStoragePoolVDSCommand, log id: 1ab22259
>2012-12-25 15:01:11,012 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] hostFromVds::Connected host to pool - selectedVds - local_host, spmStatus Free, storage pool local_datacenter
>2012-12-25 15:01:11,017 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] starting spm on vds local_host, storage pool local_datacenter, prevId -1, LVER -1
>2012-12-25 15:01:11,019 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] START, SpmStartVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, prevId=-1, prevLVER=-1, storagePoolFormatType=V3, recoveryMode=Manual, SCSIFencing=false), log id: 36d4423d
>2012-12-25 15:01:11,028 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] spmStart polling started: taskId = 7b7696b7-ab4e-4555-a1b1-cbad1554fa7a
>2012-12-25 15:01:32,155 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] spmStart polling ended: taskId = 7b7696b7-ab4e-4555-a1b1-cbad1554fa7a task status = finished
>2012-12-25 15:01:32,159 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] spmStart polling ended, spm status: SPM
>2012-12-25 15:01:32,161 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] START, HSMClearTaskVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, taskId=7b7696b7-ab4e-4555-a1b1-cbad1554fa7a), log id: 70bd32cc
>2012-12-25 15:01:32,165 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] FINISH, HSMClearTaskVDSCommand, log id: 70bd32cc
>2012-12-25 15:01:32,166 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] FINISH, SpmStartVDSCommand, return: org.ovirt.engine.core.common.businessentities.SpmStatusResult@5384cbc1, log id: 36d4423d
>2012-12-25 15:01:32,167 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] Initialize Irs proxy from vds: localhost.localdomain
>2012-12-25 15:01:32,182 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] FINISH, ActivateStorageDomainVDSCommand, log id: 7b8521ed
>2012-12-25 15:01:32,182 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] ActivateStorage Domain. After Connect all hosts to pool. Time:12/25/12 3:01 PM
>2012-12-25 15:01:32,188 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (pool-3-thread-50) [4f6d0c0d] START, ConnectStoragePoolVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, vds_spm_id = 1, masterDomainId = 6b3ca157-b6e7-405d-8995-063c16640670, masterVersion = 1), log id: 211945a1
>2012-12-25 15:01:32,194 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (pool-3-thread-50) [4f6d0c0d] FINISH, ConnectStoragePoolVDSCommand, log id: 211945a1
>2012-12-25 15:01:32,205 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [4f6d0c0d] ActivateStorage Domain. After change storage pool status in vds. Time:12/25/12 3:01 PM
>2012-12-25 15:01:32,257 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:32,258 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:32,262 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-1) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:32,298 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:32,299 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:32,302 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-2) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:32,446 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:32,447 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:32,451 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:32,488 INFO  [org.ovirt.engine.core.bll.storage.AttachStorageDomainToPoolCommand] (ajp--127.0.0.1-8702-6) [6db79a52] Running command: AttachStorageDomainToPoolCommand internal: false. Entities affected :  ID: 3c2d5823-821d-4e0e-89a1-eb7f198226c1 Type: Storage
>2012-12-25 15:01:32,498 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand] (pool-3-thread-50) [15fb6c03] START, ValidateStorageServerConnectionVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = NFS, connectionList = [{ id: cc1d853c-a0ea-45a5-8343-a82aedb35b84, connection: localhost.localdomain:/usr/local/ovirt/iso, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 391a0a8c
>2012-12-25 15:01:32,503 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand] (pool-3-thread-50) [15fb6c03] FINISH, ValidateStorageServerConnectionVDSCommand, return: {cc1d853c-a0ea-45a5-8343-a82aedb35b84=0}, log id: 391a0a8c
>2012-12-25 15:01:32,504 INFO  [org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand] (pool-3-thread-50) [15fb6c03] Running command: ConnectStorageToVdsCommand internal: true. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type: System
>2012-12-25 15:01:32,506 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (pool-3-thread-50) [15fb6c03] START, ConnectStorageServerVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = NFS, connectionList = [{ id: cc1d853c-a0ea-45a5-8343-a82aedb35b84, connection: localhost.localdomain:/usr/local/ovirt/iso, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 30350f0a
>2012-12-25 15:01:32,610 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (pool-3-thread-50) [15fb6c03] FINISH, ConnectStorageServerVDSCommand, return: {cc1d853c-a0ea-45a5-8343-a82aedb35b84=0}, log id: 30350f0a
>2012-12-25 15:01:32,612 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.AttachStorageDomainVDSCommand] (ajp--127.0.0.1-8702-6) [6db79a52] START, AttachStorageDomainVDSCommand( storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId = 3c2d5823-821d-4e0e-89a1-eb7f198226c1), log id: 7a8e8aa0
>2012-12-25 15:01:47,217 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.AttachStorageDomainVDSCommand] (ajp--127.0.0.1-8702-6) [6db79a52] FINISH, AttachStorageDomainVDSCommand, log id: 7a8e8aa0
>2012-12-25 15:01:47,260 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:47,261 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:47,264 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:47,296 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:47,297 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:47,300 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-4) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:47,349 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:47,350 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:47,353 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:47,466 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [7e4d8584] Lock Acquired to object EngineLock [exclusiveLocks= key: 3c2d5823-821d-4e0e-89a1-eb7f198226c1 value: STORAGE
>, sharedLocks= ]
>2012-12-25 15:01:47,471 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [7e4d8584] Running command: ActivateStorageDomainCommand internal: false. Entities affected :  ID: 3c2d5823-821d-4e0e-89a1-eb7f198226c1 Type: Storage
>2012-12-25 15:01:47,476 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [7e4d8584] Lock freed to object EngineLock [exclusiveLocks= key: 3c2d5823-821d-4e0e-89a1-eb7f198226c1 value: STORAGE
>, sharedLocks= ]
>2012-12-25 15:01:47,476 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [7e4d8584] ActivateStorage Domain. Before Connect all hosts to pool. Time:12/25/12 3:01 PM
>2012-12-25 15:01:47,481 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand] (pool-3-thread-50) [4dfc4227] START, ValidateStorageServerConnectionVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = NFS, connectionList = [{ id: cc1d853c-a0ea-45a5-8343-a82aedb35b84, connection: localhost.localdomain:/usr/local/ovirt/iso, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 5950c4ce
>2012-12-25 15:01:47,487 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand] (pool-3-thread-50) [4dfc4227] FINISH, ValidateStorageServerConnectionVDSCommand, return: {cc1d853c-a0ea-45a5-8343-a82aedb35b84=0}, log id: 5950c4ce
>2012-12-25 15:01:47,487 INFO  [org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand] (pool-3-thread-50) [4dfc4227] Running command: ConnectStorageToVdsCommand internal: true. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type: System
>2012-12-25 15:01:47,489 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (pool-3-thread-50) [4dfc4227] START, ConnectStorageServerVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 00000000-0000-0000-0000-000000000000, storageType = NFS, connectionList = [{ id: cc1d853c-a0ea-45a5-8343-a82aedb35b84, connection: localhost.localdomain:/usr/local/ovirt/iso, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 71f69817
>2012-12-25 15:01:47,497 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (pool-3-thread-50) [4dfc4227] FINISH, ConnectStorageServerVDSCommand, return: {cc1d853c-a0ea-45a5-8343-a82aedb35b84=0}, log id: 71f69817
>2012-12-25 15:01:47,498 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-5) [7e4d8584] START, ActivateStorageDomainVDSCommand( storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId = 3c2d5823-821d-4e0e-89a1-eb7f198226c1), log id: 783c9758
>2012-12-25 15:01:47,521 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand] (ajp--127.0.0.1-8702-5) [7e4d8584] FINISH, ActivateStorageDomainVDSCommand, log id: 783c9758
>2012-12-25 15:01:47,522 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [7e4d8584] ActivateStorage Domain. After Connect all hosts to pool. Time:12/25/12 3:01 PM
>2012-12-25 15:01:47,530 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.RefreshStoragePoolVDSCommand] (pool-3-thread-50) [7e4d8584] START, RefreshStoragePoolVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, masterStorageDomainId=6b3ca157-b6e7-405d-8995-063c16640670, msterVersion=1), log id: 5a005940
>2012-12-25 15:01:47,978 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.RefreshStoragePoolVDSCommand] (pool-3-thread-50) [7e4d8584] FINISH, RefreshStoragePoolVDSCommand, log id: 5a005940
>2012-12-25 15:01:47,979 INFO  [org.ovirt.engine.core.bll.storage.RefreshPoolSingleAsyncOperation] (pool-3-thread-50) [7e4d8584] Refreshed vds local_host in pool local_datacenter
>2012-12-25 15:01:47,980 INFO  [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (ajp--127.0.0.1-8702-5) [7e4d8584] ActivateStorage Domain. After change storage pool status in vds. Time:12/25/12 3:01 PM
>2012-12-25 15:01:47,982 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.GetIsoListVDSCommand] (pool-3-thread-50) [7e4d8584] START, GetIsoListVDSCommand( storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, ignoreFailoverLimit = false, compatabilityVersion = null), log id: 587528eb
>2012-12-25 15:01:47,984 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HsmGetIsoListVDSCommand] (pool-3-thread-50) [7e4d8584] START, HsmGetIsoListVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, storagePoolId=63a90c8c-dd4a-4089-aa32-ae1f686e74af), log id: 6a16cec1
>2012-12-25 15:01:48,010 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:48,010 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:48,013 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-1) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:48,026 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HsmGetIsoListVDSCommand] (pool-3-thread-50) [7e4d8584] FINISH, HsmGetIsoListVDSCommand, return: [], log id: 6a16cec1
>2012-12-25 15:01:48,027 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.GetIsoListVDSCommand] (pool-3-thread-50) [7e4d8584] FINISH, GetIsoListVDSCommand, return: [], log id: 587528eb
>2012-12-25 15:01:48,031 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.GetFloppyListVDSCommand] (pool-3-thread-50) [7e4d8584] START, GetFloppyListVDSCommand( storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, ignoreFailoverLimit = false, compatabilityVersion = null), log id: 6ff664c8
>2012-12-25 15:01:48,039 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.GetFloppyListVDSCommand] (pool-3-thread-50) [7e4d8584] FINISH, GetFloppyListVDSCommand, return: [], log id: 6ff664c8
>2012-12-25 15:01:48,052 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:48,052 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:48,057 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-2) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:48,232 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:48,233 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:48,236 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:48,386 INFO  [org.ovirt.engine.core.bll.AddVmFromScratchCommand] (ajp--127.0.0.1-8702-6) [9e7f5c] Lock Acquired to object EngineLock [exclusiveLocks= key: local_vm value: VM_NAME
>, sharedLocks= ]
>2012-12-25 15:01:48,407 INFO  [org.ovirt.engine.core.bll.AddVmFromScratchCommand] (ajp--127.0.0.1-8702-6) [9e7f5c] Running command: AddVmFromScratchCommand internal: false. Entities affected :  ID: 405febdf-f1ba-4db5-95a3-a389836bce84 Type: VdsGroups
>2012-12-25 15:01:48,440 INFO  [org.ovirt.engine.core.bll.AddVmFromScratchCommand] (ajp--127.0.0.1-8702-6) [9e7f5c] Lock freed to object EngineLock [exclusiveLocks= key: local_vm value: VM_NAME
>, sharedLocks= ]
>2012-12-25 15:01:48,616 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:48,617 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:48,620 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:48,873 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:48,874 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:48,879 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-4) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:49,062 INFO  [org.ovirt.engine.core.bll.AddVmInterfaceCommand] (ajp--127.0.0.1-8702-4) [5a8fa643] Running command: AddVmInterfaceCommand internal: false. Entities affected :  ID: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 Type: VM,  ID: d3faa25a-0c9a-4af7-9fdb-2e73cfc952ca Type: Network
>2012-12-25 15:01:49,063 INFO  [org.ovirt.engine.core.bll.MacPoolManager] (ajp--127.0.0.1-8702-4) [5a8fa643] MacPoolManager::allocateNewMac entered
>2012-12-25 15:01:49,064 INFO  [org.ovirt.engine.core.bll.MacPoolManager] (ajp--127.0.0.1-8702-4) [5a8fa643] MacPoolManager::allocateNewMac allocated mac = 00:1a:4a:23:01:8a
>2012-12-25 15:01:49,123 INFO  [org.ovirt.engine.core.bll.ActivateDeactivateVmNicCommand] (ajp--127.0.0.1-8702-4) [206bdb59] Running command: ActivateDeactivateVmNicCommand internal: true. Entities affected :  ID: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 Type: VM
>2012-12-25 15:01:49,201 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:49,202 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:49,205 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:49,281 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:49,281 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:49,284 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-1) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:49,325 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:49,325 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:49,328 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-2) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:49,459 INFO  [org.ovirt.engine.core.bll.AddDiskCommand] (ajp--127.0.0.1-8702-2) [4cb546c] Lock Acquired to object EngineLock [exclusiveLocks= key: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 value: VM_DISK_BOOT
>, sharedLocks= key: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 value: VM
>]
>2012-12-25 15:01:49,474 INFO  [org.ovirt.engine.core.bll.AddDiskCommand] (ajp--127.0.0.1-8702-2) [4cb546c] Running command: AddDiskCommand internal: false. Entities affected :  ID: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 Type: VM,  ID: 6b3ca157-b6e7-405d-8995-063c16640670 Type: Storage
>2012-12-25 15:01:49,475 INFO  [org.ovirt.engine.core.bll.ImagesHandler] (ajp--127.0.0.1-8702-2) [4cb546c] Disk alias retrieved from the client is null or empty, the suggested default disk alias to be used is local_vm_Disk1
>2012-12-25 15:01:49,503 INFO  [org.ovirt.engine.core.bll.AddImageFromScratchCommand] (ajp--127.0.0.1-8702-2) [37ea273a] Running command: AddImageFromScratchCommand internal: true. Entities affected :  ID: 6b3ca157-b6e7-405d-8995-063c16640670 Type: Storage
>2012-12-25 15:01:49,521 INFO  [org.ovirt.engine.core.bll.AddImageFromScratchCommand] (ajp--127.0.0.1-8702-2) [37ea273a] Lock freed to object EngineLock [exclusiveLocks= key: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 value: VM_DISK_BOOT
>, sharedLocks= key: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 value: VM
>]
>2012-12-25 15:01:49,523 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (ajp--127.0.0.1-8702-2) [37ea273a] START, CreateImageVDSCommand( storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, ignoreFailoverLimit = false, compatabilityVersion = 3.1, storageDomainId = 6b3ca157-b6e7-405d-8995-063c16640670, imageGroupId = 3f51cf09-00c3-4394-9c73-9214be17dd45, imageSizeInBytes = 6442450944, volumeFormat = COW, newImageId = 907aad4f-ffdb-4731-a230-296ec719713c, newImageDescription = ), log id: 66e207d1
>2012-12-25 15:01:49,524 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (ajp--127.0.0.1-8702-2) [37ea273a] -- CreateImageVDSCommand::ExecuteIrsBrokerCommand: calling 'createVolume' with two new parameters: description and UUID
>2012-12-25 15:01:49,524 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (ajp--127.0.0.1-8702-2) [37ea273a] -- createVolume parameters:
>                sdUUID=6b3ca157-b6e7-405d-8995-063c16640670
>                spUUID=63a90c8c-dd4a-4089-aa32-ae1f686e74af
>                imgGUID=3f51cf09-00c3-4394-9c73-9214be17dd45
>                size=6,442,450,944 bytes
>                volFormat=COW
>                volType=Sparse
>                volUUID=907aad4f-ffdb-4731-a230-296ec719713c
>                descr=
>                srcImgGUID=00000000-0000-0000-0000-000000000000
>                srcVolUUID=00000000-0000-0000-0000-000000000000
>                
>2012-12-25 15:01:49,543 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (ajp--127.0.0.1-8702-2) [37ea273a] FINISH, CreateImageVDSCommand, return: 907aad4f-ffdb-4731-a230-296ec719713c, log id: 66e207d1
>2012-12-25 15:01:49,546 INFO  [org.ovirt.engine.core.bll.EntityAsyncTask] (ajp--127.0.0.1-8702-2) [37ea273a] EntityAsyncTask::Adding EntityMultiAsyncTasks object for entity 3f51cf09-00c3-4394-9c73-9214be17dd45
>2012-12-25 15:01:49,547 INFO  [org.ovirt.engine.core.bll.EntityMultiAsyncTasks] (ajp--127.0.0.1-8702-2) [37ea273a] EntityMultiAsyncTasks::AttachTask: Attaching task 7fe25479-5244-4e5a-adcb-b0dc341db26a to entity 3f51cf09-00c3-4394-9c73-9214be17dd45.
>2012-12-25 15:01:49,573 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (ajp--127.0.0.1-8702-2) [37ea273a] Adding task 7fe25479-5244-4e5a-adcb-b0dc341db26a (Parent Command AddDisk, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters), polling hasn't started yet..
>2012-12-25 15:01:49,587 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (ajp--127.0.0.1-8702-2) [37ea273a] BaseAsyncTask::StartPollingTask: Starting to poll task 7fe25479-5244-4e5a-adcb-b0dc341db26a.
>2012-12-25 15:01:49,587 INFO  [org.ovirt.engine.core.bll.EntityMultiAsyncTasks] (ajp--127.0.0.1-8702-2) [37ea273a] EntityMultiAsyncTasks::StartPollingTask: Current Action Type for entity 3f51cf09-00c3-4394-9c73-9214be17dd45 is AddDisk (determined by task 7fe25479-5244-4e5a-adcb-b0dc341db26a)
>2012-12-25 15:01:49,655 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:49,655 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:49,659 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:49,737 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:49,737 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:49,741 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:54,213 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-83) Polling and updating Async Tasks: 1 tasks, 1 tasks to poll now
>2012-12-25 15:01:54,220 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (QuartzScheduler_Worker-83) SPMAsyncTask::PollTask: Polling task 7fe25479-5244-4e5a-adcb-b0dc341db26a (Parent Command AddDisk, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'success'.
>2012-12-25 15:01:54,224 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (QuartzScheduler_Worker-83) BaseAsyncTask::OnTaskEndSuccess: Task 7fe25479-5244-4e5a-adcb-b0dc341db26a (Parent Command AddDisk, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended successfully.
>2012-12-25 15:01:54,225 INFO  [org.ovirt.engine.core.bll.EntityAsyncTask] (QuartzScheduler_Worker-83) EntityAsyncTask::EndActionIfNecessary: All tasks of entity 3f51cf09-00c3-4394-9c73-9214be17dd45 has ended -> executing EndAction
>2012-12-25 15:01:54,225 INFO  [org.ovirt.engine.core.bll.EntityAsyncTask] (QuartzScheduler_Worker-83) EntityAsyncTask::EndAction: Ending action for 1 tasks (entity ID: 3f51cf09-00c3-4394-9c73-9214be17dd45): calling EndAction for action type AddDisk.
>2012-12-25 15:01:54,226 INFO  [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-3-thread-50) EntityAsyncTask::EndCommandAction [within thread] context: Attempting to EndAction AddDisk, executionIndex: 0
>2012-12-25 15:01:54,237 INFO  [org.ovirt.engine.core.bll.AddDiskCommand] (pool-3-thread-50) [4cb546c] Ending command successfully: org.ovirt.engine.core.bll.AddDiskCommand
>2012-12-25 15:01:54,238 INFO  [org.ovirt.engine.core.bll.AddImageFromScratchCommand] (pool-3-thread-50) [37ea273a] Ending command successfully: org.ovirt.engine.core.bll.AddImageFromScratchCommand
>2012-12-25 15:01:54,244 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (pool-3-thread-50) [37ea273a] START, GetImageInfoVDSCommand( storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId = 6b3ca157-b6e7-405d-8995-063c16640670, imageGroupId = 3f51cf09-00c3-4394-9c73-9214be17dd45, imageId = 907aad4f-ffdb-4731-a230-296ec719713c), log id: 329b6449
>2012-12-25 15:01:54,274 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (pool-3-thread-50) [37ea273a] FINISH, GetImageInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.DiskImage@82fd6366, log id: 329b6449
>2012-12-25 15:01:54,329 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.UpdateVMVDSCommand] (pool-3-thread-50) START, UpdateVMVDSCommand( storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId = 00000000-0000-0000-0000-000000000000, infoDictionary.size = 1), log id: 25583409
>2012-12-25 15:01:54,337 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.UpdateVMVDSCommand] (pool-3-thread-50) FINISH, UpdateVMVDSCommand, log id: 25583409
>2012-12-25 15:01:54,344 INFO  [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-3-thread-50) EntityAsyncTask::HandleEndActionResult [within thread]: EndAction for action type AddDisk completed, handling the result.
>2012-12-25 15:01:54,344 INFO  [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-3-thread-50) EntityAsyncTask::HandleEndActionResult [within thread]: EndAction for action type AddDisk succeeded, clearing tasks.
>2012-12-25 15:01:54,345 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (pool-3-thread-50) SPMAsyncTask::ClearAsyncTask: Attempting to clear task 7fe25479-5244-4e5a-adcb-b0dc341db26a
>2012-12-25 15:01:54,347 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (pool-3-thread-50) START, SPMClearTaskVDSCommand( storagePoolId = 63a90c8c-dd4a-4089-aa32-ae1f686e74af, ignoreFailoverLimit = false, compatabilityVersion = null, taskId = 7fe25479-5244-4e5a-adcb-b0dc341db26a), log id: 6d79fc03
>2012-12-25 15:01:54,348 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (pool-3-thread-50) START, HSMClearTaskVDSCommand(HostName = local_host, HostId = 8051a860-e096-4d76-8593-2b866214b861, taskId=7fe25479-5244-4e5a-adcb-b0dc341db26a), log id: 3c289b95
>2012-12-25 15:01:54,353 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (pool-3-thread-50) FINISH, HSMClearTaskVDSCommand, log id: 3c289b95
>2012-12-25 15:01:54,353 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (pool-3-thread-50) FINISH, SPMClearTaskVDSCommand, log id: 6d79fc03
>2012-12-25 15:01:54,357 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (pool-3-thread-50) BaseAsyncTask::RemoveTaskFromDB: Removed task 7fe25479-5244-4e5a-adcb-b0dc341db26a from DataBase
>2012-12-25 15:01:54,357 INFO  [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-3-thread-50) EntityAsyncTask::HandleEndActionResult [within thread]: Removing EntityMultiAsyncTasks object for entity 3f51cf09-00c3-4394-9c73-9214be17dd45
>2012-12-25 15:01:54,824 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:54,825 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:54,828 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-4) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:01:59,908 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:01:59,909 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:01:59,912 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:04,991 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:04,992 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:04,995 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-1) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:10,072 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:10,073 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:10,075 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-2) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:15,154 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:15,154 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:15,158 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:20,238 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:20,238 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:20,242 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:25,324 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:25,325 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:25,328 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-1) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:28,651 WARN  [org.ovirt.engine.ui.frontend.server.gwt.plugin.PluginDataManager] (ajp--127.0.0.1-8702-3) Cannot list UI plugin descriptor files in [/usr/share/ovirt-engine/ui-plugins]
>2012-12-25 15:02:30,413 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-7) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:30,413 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-7) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:30,416 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-7) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:33,298 INFO  [org.ovirt.engine.core.bll.LoginAdminUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:33,298 INFO  [org.ovirt.engine.core.bll.LoginAdminUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginAdminUserCommand internal: false.
>2012-12-25 15:02:33,325 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:33,326 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:33,329 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:33,330 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (VdcVersion) with null version, using default general for version
>2012-12-25 15:02:33,333 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (ajp--127.0.0.1-8702-3) Failed to decrypt Data must start with zero
>2012-12-25 15:02:33,333 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (ajp--127.0.0.1-8702-3) Failed to decrypt value for property LocalAdminPassword will be used encrypted value
>2012-12-25 15:02:33,346 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (ajp--127.0.0.1-8702-3) Failed to decrypt Data must start with zero
>2012-12-25 15:02:33,346 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (ajp--127.0.0.1-8702-3) Failed to decrypt value for property LocalAdminPassword will be used encrypted value
>2012-12-25 15:02:33,362 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (ajp--127.0.0.1-8702-3) Failed to decrypt Data must start with zero
>2012-12-25 15:02:33,362 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (ajp--127.0.0.1-8702-3) Failed to decrypt value for property LocalAdminPassword will be used encrypted value
>2012-12-25 15:02:33,375 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (ajp--127.0.0.1-8702-3) Failed to decrypt Data must start with zero
>2012-12-25 15:02:33,375 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (ajp--127.0.0.1-8702-3) Failed to decrypt value for property LocalAdminPassword will be used encrypted value
>2012-12-25 15:02:33,974 ERROR [org.ovirt.engine.core.utils.ServletUtils] (ajp--127.0.0.1-8702-3) Can't read file "/usr/share/ovirt-engine/docs/DocumentationPath.csv" for request "/docs/DocumentationPath.csv", will send a 404 error response.
>2012-12-25 15:02:35,501 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-8) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:35,501 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-8) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:35,505 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-8) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:40,604 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-12) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:40,604 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-12) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:40,607 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-12) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:42,314 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (ajp--127.0.0.1-8702-6) Lock Acquired to object EngineLock [exclusiveLocks= key: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 value: VM
>, sharedLocks= ]
>2012-12-25 15:02:42,327 INFO  [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (ajp--127.0.0.1-8702-6) START, IsVmDuringInitiatingVDSCommand( vmId = d60c6c02-eddd-46d2-90d6-94ec0cafabe0), log id: 41d9e547
>2012-12-25 15:02:42,327 INFO  [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (ajp--127.0.0.1-8702-6) FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 41d9e547
>2012-12-25 15:02:42,344 INFO  [org.ovirt.engine.core.bll.VdsSelector] (ajp--127.0.0.1-8702-6)  VDS local_host 8051a860-e096-4d76-8593-2b866214b861 is missing networks required by VM nics [ovirtmgmt]
>2012-12-25 15:02:42,344 WARN  [org.ovirt.engine.core.bll.RunVmCommand] (ajp--127.0.0.1-8702-6) CanDoAction of action RunVm failed. Reasons:VAR__ACTION__RUN,VAR__TYPE__VM,ACTION_TYPE_FAILED_VDS_VM_NETWORKS
>2012-12-25 15:02:42,345 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (ajp--127.0.0.1-8702-6) Lock freed to object EngineLock [exclusiveLocks= key: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 value: VM
>, sharedLocks= ]
>2012-12-25 15:02:45,687 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:45,687 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:45,690 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:50,764 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:50,765 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:50,769 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-1) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:02:56,388 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Checking if user admin@internal is an admin, result true
>2012-12-25 15:02:56,388 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Running command: LoginUserCommand internal: false.
>2012-12-25 15:02:56,391 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-2) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:01,471 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:01,471 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:01,474 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:06,553 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-8) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:06,554 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-8) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:06,557 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-8) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:10,932 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (ajp--127.0.0.1-8702-6) Lock Acquired to object EngineLock [exclusiveLocks= key: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 value: VM
>, sharedLocks= ]
>2012-12-25 15:03:10,944 INFO  [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (ajp--127.0.0.1-8702-6) START, IsVmDuringInitiatingVDSCommand( vmId = d60c6c02-eddd-46d2-90d6-94ec0cafabe0), log id: 429b09a2
>2012-12-25 15:03:10,945 INFO  [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (ajp--127.0.0.1-8702-6) FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 429b09a2
>2012-12-25 15:03:10,961 INFO  [org.ovirt.engine.core.bll.VdsSelector] (ajp--127.0.0.1-8702-6)  VDS local_host 8051a860-e096-4d76-8593-2b866214b861 is missing networks required by VM nics [ovirtmgmt]
>2012-12-25 15:03:10,961 WARN  [org.ovirt.engine.core.bll.RunVmCommand] (ajp--127.0.0.1-8702-6) CanDoAction of action RunVm failed. Reasons:VAR__ACTION__RUN,VAR__TYPE__VM,ACTION_TYPE_FAILED_VDS_VM_NETWORKS
>2012-12-25 15:03:10,962 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (ajp--127.0.0.1-8702-6) Lock freed to object EngineLock [exclusiveLocks= key: d60c6c02-eddd-46d2-90d6-94ec0cafabe0 value: VM
>, sharedLocks= ]
>2012-12-25 15:03:11,636 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-12) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:11,636 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-12) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:11,639 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-12) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:16,721 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-11) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:16,721 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-11) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:16,724 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-11) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:21,805 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-7) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:21,805 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-7) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:21,809 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-7) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:24,214 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-76) Setting new tasks map. The map contains now 0 tasks
>2012-12-25 15:03:24,214 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-76) Cleared all tasks of pool 63a90c8c-dd4a-4089-aa32-ae1f686e74af.
>2012-12-25 15:03:24,216 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-76) Could not find vds that is spm and non-operational.
>2012-12-25 15:03:26,888 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-10) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:26,888 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-10) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:26,892 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-10) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:31,976 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:31,976 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:31,979 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:33,902 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:33,902 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:33,905 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:33,906 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (VdcVersion) with null version, using default general for version
>2012-12-25 15:03:37,057 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:37,058 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:37,060 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-1) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:42,140 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:42,140 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:42,143 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:47,221 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-12) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:47,221 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-12) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:47,225 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-12) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:52,302 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:52,302 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:52,305 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-4) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:03:57,387 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-11) Checking if user admin@internal is an admin, result true
>2012-12-25 15:03:57,388 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-11) Running command: LoginUserCommand internal: false.
>2012-12-25 15:03:57,390 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-11) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:02,467 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-7) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:02,467 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-7) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:02,470 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-7) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:07,549 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-10) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:07,549 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-10) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:07,552 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-10) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:12,631 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:12,632 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:12,635 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:17,713 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-11) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:17,713 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-11) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:17,716 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-11) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:22,796 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-7) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:22,797 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-7) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:22,799 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-7) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:27,880 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-10) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:27,880 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-10) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:27,883 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-10) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:32,963 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:32,963 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:32,967 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:33,902 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-12) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:33,902 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-12) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:33,905 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-12) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:33,905 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-12) calling GetConfigurationValueQuery (VdcVersion) with null version, using default general for version
>2012-12-25 15:04:38,049 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:38,049 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:38,052 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-2) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:43,130 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-11) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:43,130 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-11) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:43,133 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-11) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:48,210 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:48,210 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-6) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:48,213 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-6) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:53,291 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:53,291 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-1) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:53,294 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-1) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:04:58,372 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-8) Checking if user admin@internal is an admin, result true
>2012-12-25 15:04:58,372 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-8) Running command: LoginUserCommand internal: false.
>2012-12-25 15:04:58,375 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-8) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:05:00,002 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (QuartzScheduler_Worker-79) Autorecovering hosts is disabled, skipping
>2012-12-25 15:05:00,002 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (QuartzScheduler_Worker-79) Autorecovering storage domains is disabled, skipping
>2012-12-25 15:05:03,451 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Checking if user admin@internal is an admin, result true
>2012-12-25 15:05:03,451 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false.
>2012-12-25 15:05:03,454 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-3) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:05:08,530 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Checking if user admin@internal is an admin, result true
>2012-12-25 15:05:08,531 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-4) Running command: LoginUserCommand internal: false.
>2012-12-25 15:05:08,534 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-4) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:05:13,607 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-7) Checking if user admin@internal is an admin, result true
>2012-12-25 15:05:13,607 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-7) Running command: LoginUserCommand internal: false.
>2012-12-25 15:05:13,610 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-7) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:05:18,690 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-10) Checking if user admin@internal is an admin, result true
>2012-12-25 15:05:18,690 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-10) Running command: LoginUserCommand internal: false.
>2012-12-25 15:05:18,693 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-10) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:05:23,770 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Checking if user admin@internal is an admin, result true
>2012-12-25 15:05:23,770 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginUserCommand internal: false.
>2012-12-25 15:05:23,773 WARN  [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (ajp--127.0.0.1-8702-5) calling GetConfigurationValueQuery (ApplicationMode) with null version, using default general for version
>2012-12-25 15:05:24,085 INFO  [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (pool-3-thread-50) Finished automatic refresh process for Unknown file type with success, for storage domain id 3c2d5823-821d-4e0e-89a1-eb7f198226c1.

Actions: View

Attachments on bug 890167: 668916 | 668917 | 668918