Skip to content

Instantly share code, notes, and snippets.

@thomassuckow
Created August 26, 2013 22:44
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save thomassuckow/995f422cd5c46c6de98c to your computer and use it in GitHub Desktop.
Save thomassuckow/995f422cd5c46c6de98c to your computer and use it in GitHub Desktop.
ovirt logs on F19
2013-08-26 11:04:39,814 INFO [org.ovirt.engine.core.bll.AddVdsCommand] (ajp--127.0.0.1-8702-11) Running command: AddVdsCommand internal: false. Entities affected : ID: 88888888-8888-8888-8888-88888888888 Type: VdsGroups
2013-08-26 11:04:39,892 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--127.0.0.1-8702-11) Running command: AddVdsSpmIdCommand internal: true. Entities affected : ID: 99999999-9999-9999-999999999999 Type: VDS
2013-08-26 11:04:39,913 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--127.0.0.1-8702-11) Lock freed to object EngineLock [exclusiveLocks= key: 88888888-8888-8888-8888-88888888888 value: REGISTER_VDS
, sharedLocks= ]
2013-08-26 11:04:39,915 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-11) Cannot get vdsManager for vdsid=99999999-9999-9999-999999999999
2013-08-26 11:04:39,918 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--127.0.0.1-8702-11) START, RemoveVdsVDSCommand(HostName = myhost, HostId = 99999999-9999-9999-999999999999), log id: 4a5e5d42
2013-08-26 11:04:39,918 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-11) Cannot get vdsManager for vdsid=99999999-9999-9999-999999999999
2013-08-26 11:04:39,919 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--127.0.0.1-8702-11) FINISH, RemoveVdsVDSCommand, log id: 4a5e5d42
2013-08-26 11:04:39,920 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-11) Cannot get vdsManager for vdsid=99999999-9999-9999-999999999999
2013-08-26 11:04:39,921 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-11) START, AddVdsVDSCommand(HostName = myhost, HostId = 99999999-9999-9999-999999999999), log id: 79daf9a
2013-08-26 11:04:39,921 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-11) AddVds - entered , starting logic to add VDS 99999999-9999-9999-999999999999
2013-08-26 11:04:39,922 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-11) AddVds - VDS 99999999-9999-9999-999999999999 was added, will try to add it to the resource manager
2013-08-26 11:04:39,923 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--127.0.0.1-8702-11) Entered VdsManager constructor
2013-08-26 11:04:39,933 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--127.0.0.1-8702-11) Initialize vdsBroker (myhost.mydomain,54,321)
2013-08-26 11:04:39,935 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-11) VDS 99999999-9999-9999-999999999999 was added to the Resource Manager
2013-08-26 11:04:39,935 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-11) FINISH, AddVdsVDSCommand, log id: 79daf9a
2013-08-26 11:04:39,940 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-11) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host myhost.
2013-08-26 11:04:39,992 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-6-thread-50) Lock Acquired to object EngineLock [exclusiveLocks= key: 99999999-9999-9999-999999999999 value: VDS
, sharedLocks= ]
2013-08-26 11:04:39,997 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-11) Correlation ID: 15024524, Job ID: 88888888-8888-8888-8888-88888888888, Call Stack: null, Custom Event ID: -1, Message: Host myhost was added by admin@internal.
2013-08-26 11:04:40,013 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-6-thread-50) Running command: InstallVdsCommand internal: true. Entities affected : ID: 99999999-9999-9999-999999999999 Type: VDS
2013-08-26 11:04:40,014 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-6-thread-50) Before Installation host 99999999-9999-9999-999999999999, myhost
2013-08-26 11:04:40,035 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-6-thread-50) START, SetVdsStatusVDSCommand(HostName = myhost, HostId = 99999999-9999-9999-999999999999, status=Installing, nonOperationalReason=NONE), log id: 7319f5e4
2013-08-26 11:04:40,046 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-6-thread-50) FINISH, SetVdsStatusVDSCommand, log id: 7319f5e4
2013-08-26 11:04:40,119 INFO [org.ovirt.engine.core.bll.InstallerMessages] (pool-6-thread-50) Installation myhost.mydomain: Connected to host myhost.mydomain with SSH key fingerprint: aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa
2013-08-26 11:04:40,130 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (pool-6-thread-50) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Connected to host myhost.mydomain with SSH key fingerprint: aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa:aa.
2013-08-26 11:04:40,157 INFO [org.ovirt.engine.core.bll.VdsDeploy] (pool-6-thread-50) Installation of myhost.mydomain. 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}" && tar --warning=no-timestamp -C "${MYTMP}" -x && "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True < /var/cache/ovirt-engine/ovirt-host-deploy.tar
2013-08-26 11:04:40,236 INFO [org.ovirt.engine.core.utils.ssh.SSHDialog] (pool-6-thread-50) SSH execute root@myhost.mydomain '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}" && tar --warning=no-timestamp -C "${MYTMP}" -x && "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True'
2013-08-26 11:04:41,287 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Initializing
2013-08-26 11:04:41,314 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Initializing.
2013-08-26 11:04:41,327 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Environment setup
2013-08-26 11:04:41,363 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Environment setup.
2013-08-26 11:04:41,434 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Environment packages setup
2013-08-26 11:04:41,455 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Environment packages setup.
2013-08-26 11:04:42,936 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-74) Initializing Host: myhost
2013-08-26 11:04:45,872 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Programs detection
2013-08-26 11:04:45,881 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Programs detection.
2013-08-26 11:04:45,902 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Environment customization
2013-08-26 11:04:45,914 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Environment customization.
2013-08-26 11:04:48,312 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Logs at host located at: '/tmp/ovirt-host-deploy-20130826110440.log'
2013-08-26 11:04:48,340 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Logs at host located at: '/tmp/ovirt-host-deploy-20130826110440.log'.
2013-08-26 11:04:48,411 INFO [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Host myhost.mydomain reports unique id 44454C4C-5800-1030-8030-B7C04F594631
2013-08-26 11:04:48,428 INFO [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Assigning unique id 44454C4C-5800-1030-8030-B7C04F594631 to Host myhost.mydomain
2013-08-26 11:04:48,486 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Setup validation
2013-08-26 11:04:48,498 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Setup validation.
2013-08-26 11:04:48,513 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Hardware supports virtualization
2013-08-26 11:04:48,523 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Hardware supports virtualization.
2013-08-26 11:04:48,776 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Transaction setup
2013-08-26 11:04:48,790 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Transaction setup.
2013-08-26 11:04:48,848 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Package installation
2013-08-26 11:04:48,857 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Package installation.
2013-08-26 11:04:49,767 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Misc configuration
2013-08-26 11:04:49,782 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Misc configuration.
2013-08-26 11:04:57,098 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Setting time
2013-08-26 11:04:57,108 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Setting time.
2013-08-26 11:04:58,565 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Enrolling certificate
2013-08-26 11:04:58,585 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Enrolling certificate.
2013-08-26 11:04:59,953 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Transaction commit
2013-08-26 11:04:59,977 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Transaction commit.
2013-08-26 11:05:00,007 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Closing up
2013-08-26 11:05:00,019 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Closing up.
2013-08-26 11:05:01,042 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Starting vdsm
2013-08-26 11:05:01,069 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Starting vdsm.
2013-08-26 11:05:05,189 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Pre-termination
2013-08-26 11:05:05,287 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Pre-termination.
2013-08-26 11:05:05,300 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Retrieving installation logs to: '/var/log/ovirt-engine/host-deploy/ovirt-20130826110505-myhost.mydomain-14251cd9.log'
2013-08-26 11:05:05,345 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Retrieving installation logs to: '/var/log/ovirt-engine/host-deploy/ovirt-20130826110505-myhost.mydomain-14251cd9.log'.
2013-08-26 11:05:05,590 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation myhost.mydomain: Stage: Termination
2013-08-26 11:05:05,628 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 14251cd9, Call Stack: null, Custom Event ID: -1, Message: Installing Host myhost. Stage: Termination.
2013-08-26 11:05:05,643 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (pool-6-thread-50) java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException
2013-08-26 11:05:05,644 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (pool-6-thread-50) Command PollVDS execution failed. Exception: RuntimeException: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException
2013-08-26 11:05:06,360 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (pool-6-thread-50) org.ovirt.engine.core.vdsbroker.vdsbroker.VDSRecoveringException: Recovering from crash or Initializing
2013-08-26 11:05:06,360 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (pool-6-thread-50) Command PollVDS execution failed. Exception: VDSRecoveringException: Recovering from crash or Initializing
2013-08-26 11:05:06,868 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (pool-6-thread-50) org.ovirt.engine.core.vdsbroker.vdsbroker.VDSRecoveringException: Recovering from crash or Initializing
2013-08-26 11:05:06,869 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (pool-6-thread-50) Command PollVDS execution failed. Exception: VDSRecoveringException: Recovering from crash or Initializing
2013-08-26 11:05:07,376 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (pool-6-thread-50) org.ovirt.engine.core.vdsbroker.vdsbroker.VDSRecoveringException: Recovering from crash or Initializing
2013-08-26 11:05:07,377 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (pool-6-thread-50) Command PollVDS execution failed. Exception: VDSRecoveringException: Recovering from crash or Initializing
2013-08-26 11:05:07,884 INFO [org.ovirt.engine.core.bll.network.NetworkConfigurator] (pool-6-thread-50) Engine managed to communicate with VDSM agent on host myhost
2013-08-26 11:05:08,172 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-6-thread-50) START, SetVdsStatusVDSCommand(HostName = myhost, HostId = 99999999-9999-9999-999999999999, status=Initializing, nonOperationalReason=NONE), log id: dc01908
2013-08-26 11:05:08,179 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-6-thread-50) FINISH, SetVdsStatusVDSCommand, log id: dc01908
2013-08-26 11:05:08,179 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-6-thread-50) After Installation host myhost, VDS
2013-08-26 11:05:08,204 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (pool-6-thread-50) Correlation ID: 14251cd9, Job ID: 88888888-8888-8888888888888888888888, Call Stack: null, Custom Event ID: -1, Message: Host myhost installed
2013-08-26 11:05:08,212 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-6-thread-50) Lock freed to object EngineLock [exclusiveLocks= key: 99999999-9999-9999-999999999999 value: VDS
, sharedLocks= ]
2013-08-26 11:05:10,018 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-5) START, GetHardwareInfoVDSCommand(HostName = myhost, HostId = 99999999-9999-9999-999999999999, vds=Host[myhost]), log id: 25410613
2013-08-26 11:05:10,074 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-5) FINISH, GetHardwareInfoVDSCommand, log id: 25410613
2013-08-26 11:05:10,146 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler_Worker-5) Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: 99999999-9999-9999-999999999999 Type: VDS
2013-08-26 11:05:10,149 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-5) START, SetVdsStatusVDSCommand(HostName = myhost, HostId = 99999999-9999-9999-999999999999, status=NonOperational, nonOperationalReason=EMULATED_MACHINES_INCOMPATIBLE_WITH_CLUSTER), log id: 41d47f7b
2013-08-26 11:05:10,154 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-5) FINISH, SetVdsStatusVDSCommand, log id: 41d47f7b
2013-08-26 11:05:10,171 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-5) Correlation ID: 6b6c5394, Job ID: f0aba6aa-6ef7-4e6d-b282-82139e741b4d, Call Stack: null, Custom Event ID: -1, Message: Host myhost does not comply with the cluster Default emulated machines. The Hosts emulated machines are <UNKNOWN> and the cluster is [rhel6.4.0, pc-1.0]}
2013-08-26 11:05:10,222 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-5) START, GetHardwareInfoVDSCommand(HostName = myhost, HostId = 99999999-9999-9999-999999999999, vds=Host[myhost]), log id: 27437c4d
2013-08-26 11:05:10,233 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-5) FINISH, GetHardwareInfoVDSCommand, log id: 27437c4d
2013-08-26 11:05:10,271 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-5) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: State was set to NonOperational for host myhost.
2013-08-26 11:05:10,291 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-5) Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: 99999999-9999-9999-999999999999 Type: VDS
2013-08-26 11:05:10,295 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-5) Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: 99999999-9999-9999-999999999999 Type: VDS
2013-08-26 11:05:10,297 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-5) Host 99999999-9999-9999-9999-999999999999 : myhost is already in NonOperational status. SetNonOperationalVds command is skipped.
2013-08-26 11:05:05 DEBUG otopi.context context._executeMethod:118 Stage pre-terminate METHOD otopi.plugins.otopi.dialog.cli.Plugin._pre_terminate
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ###
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### Processing ended, use 'quit' to quit
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### COMMAND>
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:RECEIVE env-get -k BASE/error
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ***D:VALUE BASE/error=bool:False
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ###
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### Processing ended, use 'quit' to quit
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### COMMAND>
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:RECEIVE env-get -k BASE/aborted
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ***D:VALUE BASE/aborted=bool:False
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ###
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### Processing ended, use 'quit' to quit
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### COMMAND>
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:RECEIVE env-get -k ODEPLOY/installIncomplete
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ***D:VALUE ODEPLOY/installIncomplete=bool:False
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ###
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### Processing ended, use 'quit' to quit
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### COMMAND>
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:RECEIVE noop
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ###
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### Processing ended, use 'quit' to quit
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### COMMAND>
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:RECEIVE env-get -k SYSTEM/reboot
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ***D:VALUE SYSTEM/reboot=bool:False
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ***Q:STRING TERMINATION_COMMAND
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ###
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### Processing ended, use 'quit' to quit
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:SEND ### COMMAND>
2013-08-26 11:05:05 DEBUG otopi.plugins.otopi.dialog.machine dialog.__logString:215 DIALOG:RECEIVE log
Aug 26 14:52:17 systemd-logind[575]: New session 2 of user root.
Aug 26 14:52:17 systemd[1]: Starting Virtualization daemon...
Aug 26 14:52:17 systemd[1]: Started Virtualization daemon.
Aug 26 14:52:17 systemd[1]: Starting Virtual Desktop Server Manager...
Aug 26 14:52:17 libvirtd[2901]: 2013-08-26 21:52:17.765+0000: 2901: info : libvirt version: 1.0.5.5, package: 1.fc19 (Fedora Project, 2013-08-01-23:39:55, buildvm-09.phx2.fedoraproject.org)
Aug 26 14:52:17 libvirtd[2901]: 2013-08-26 21:52:17.765+0000: 2901: debug : virLogParseOutputs:1331 : outputs=1:file:/var/log/libvirt/libvirtd.log
Aug 26 14:52:18 systemd[1]: Reloading.
Aug 26 14:52:18 kernel: [ 484.264399] Ebtables v2.0 registered
Aug 26 14:52:18 kernel: [ 484.281536] ip6_tables: (C) 2000-2006 Netfilter Core Team
Aug 26 14:52:18 abrt: detected unhandled Python exception in '/usr/bin/vdsm-tool'
Aug 26 14:52:18 abrtd: New client connected
Aug 26 14:52:18 abrtd: Directory 'pyhook-2013-08-26-14:52:18-2957' creation detected
Aug 26 14:52:18 abrt-server[2979]: Saved problem directory of pid 2957 to '/var/tmp/abrt/pyhook-2013-08-26-14:52:18-2957'
Aug 26 14:52:18 systemd-vdsmd[2902]: Traceback (most recent call last):
Aug 26 14:52:18 systemd-vdsmd[2902]: File "/usr/bin/vdsm-tool", line 143, in <module>
Aug 26 14:52:18 systemd-vdsmd[2902]: sys.exit(main())
Aug 26 14:52:18 systemd-vdsmd[2902]: File "/usr/bin/vdsm-tool", line 140, in main
Aug 26 14:52:18 systemd-vdsmd[2902]: return tool_command[cmd]["command"](*args[1:])
Aug 26 14:52:18 systemd-vdsmd[2902]: File "/usr/lib64/python2.7/site-packages/vdsm/tool/service.py", line 405, in service_disable
Aug 26 14:52:18 systemd-vdsmd[2902]: return _runAlts(_srvDisableAlts, srvName)
Aug 26 14:52:18 systemd-vdsmd[2902]: File "/usr/lib64/python2.7/site-packages/vdsm/tool/service.py", line 353, in _runAlts
Aug 26 14:52:18 systemd-vdsmd[2902]: ('\n'.join(str(e) for errs in errors.values() for e in errs)))
Aug 26 14:52:18 systemd-vdsmd[2902]: service.ServiceNotExistError: ServiceNotExistError: Tried all alternatives but failed:
Aug 26 14:52:18 systemd-vdsmd[2902]: ServiceNotExistError: ksmtuned is not native systemctl service
Aug 26 14:52:18 systemd-vdsmd[2902]: ServiceNotExistError: ksmtuned is not a SysV service
Aug 26 14:52:18 abrtd: Generating core_backtrace
Aug 26 14:52:18 abrtd: Core backtrace is generated and saved, 383 bytes
Aug 26 14:52:18 abrtd: Duplicate: core backtrace
Aug 26 14:52:18 abrtd: DUP_OF_DIR: /var/tmp/abrt/pyhook-2013-08-23-17:21:03-15250
Aug 26 14:52:18 abrtd: Deleting problem directory pyhook-2013-08-26-14:52:18-2957 (dup of pyhook-2013-08-23-17:21:03-15250)
Aug 26 14:52:19 systemd-vdsmd[2902]: Starting configure libvirt to VDSM ...
Aug 26 14:52:19 systemd-vdsmd[2902]: libvirt is already configured for vdsm
Aug 26 14:52:19 systemd-vdsmd[2902]: =Done configuring libvirt=
Aug 26 14:52:21 systemd-vdsmd[2902]: Checking conflicts ...
Aug 26 14:52:21 systemd-vdsmd[2902]: SUCCESS: ssl configured to true. No conflicts
Aug 26 14:52:21 systemd-vdsmd[2902]: Starting up vdsm daemon:
Aug 26 14:52:22 systemd-vdsmd[2902]: [ OK ]#015vdsm start[ OK ]
Aug 26 14:52:22 systemd[1]: Started Virtual Desktop Server Manager.
Aug 26 14:52:22 systemd-logind[575]: Removed session 2.
Aug 26 14:52:23 vdsm vds WARNING Unable to load the json rpc server module. Please make sure it is installed.
Aug 26 14:52:23 kernel: [ 489.302160] ata1: hard resetting link
Aug 26 14:52:23 kernel: [ 489.607049] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
Aug 26 14:52:23 kernel: [ 489.608586] ata1.00: configured for UDMA/100
Aug 26 14:52:23 kernel: [ 489.609581] ata1: EH complete
Aug 26 14:52:24 kernel: [ 490.306021] ata2: hard resetting link
Aug 26 14:52:24 kernel: [ 490.309742] ata3: hard resetting link
Aug 26 14:52:24 kernel: [ 490.611029] ata2: SATA link down (SStatus 0 SControl 300)
Aug 26 14:52:24 kernel: [ 490.611045] ata2: EH complete
Aug 26 14:52:24 kernel: [ 490.614022] ata3: SATA link down (SStatus 0 SControl 300)
Aug 26 14:52:24 kernel: [ 490.614030] ata3: EH complete
Aug 26 14:52:27 kernel: [ 493.329142] ata7: EH complete
Aug 26 14:52:27 kernel: [ 493.334030] ata8: EH complete
Aug 26 14:52:29 kernel: [ 495.377585] device-mapper: table: 253:2: multipath: error getting device
Aug 26 14:52:29 kernel: [ 495.377591] device-mapper: ioctl: error adding target to table
Aug 26 14:52:29 kernel: [ 495.378735] device-mapper: table: 253:2: multipath: error getting device
Aug 26 14:52:29 kernel: [ 495.378737] device-mapper: ioctl: error adding target to table
Aug 26 14:52:29 multipathd: dm-2: remove map (uevent)
Aug 26 14:52:29 multipathd: dm-2: remove map (uevent)
Aug 26 14:52:29 multipathd: dm-2: remove map (uevent)
Aug 26 14:52:29 multipathd: dm-2: remove map (uevent)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment