2018-12-08 08:56:10 DEBUG otopi.context context._executeMethod:128 Stage closeup METHOD
otopi.plugins.ovirt_host_deploy.tune.iosched.Plugin._refresh
2018-12-08 08:56:10 DEBUG otopi.plugins.ovirt_host_deploy.tune.iosched
plugin.executeRaw:813 execute: ['/bin/udevadm', 'trigger',
'--type=devices', '--action=change'], executable='None',
cwd='None', env=None
2018-12-08 08:56:10 DEBUG otopi.plugins.ovirt_host_deploy.tune.iosched
plugin.executeRaw:863 execute-result: ['/bin/udevadm', 'trigger',
'--type=devices', '--action=change'], rc=0
2018-12-08 08:56:10 DEBUG otopi.plugins.ovirt_host_deploy.tune.iosched plugin.execute:921
execute-output: ['/bin/udevadm', 'trigger', '--type=devices',
'--action=change'] stdout:
2018-12-08 08:56:10 DEBUG otopi.plugins.ovirt_host_deploy.tune.iosched plugin.execute:926
execute-output: ['/bin/udevadm', 'trigger', '--type=devices',
'--action=change'] stderr:
2018-12-08 08:56:10 DEBUG otopi.context context._executeMethod:128 Stage closeup METHOD
otopi.plugins.ovirt_host_deploy.vdsm.packages.Plugin._start
2018-12-08 08:56:10 INFO otopi.plugins.ovirt_host_deploy.vdsm.packages packages._start:163
Stopping libvirtd
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:73 check if
service libvirtd exists
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:813
execute: ('/bin/systemctl', 'show', '-p', 'LoadState',
'libvirtd.service'), executable='None', cwd='None', env=None
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:863
execute-result: ('/bin/systemctl', 'show', '-p',
'LoadState', 'libvirtd.service'), rc=0
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:921
execute-output: ('/bin/systemctl', 'show', '-p',
'LoadState', 'libvirtd.service') stdout:
LoadState=loaded
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:926
execute-output: ('/bin/systemctl', 'show', '-p',
'LoadState', 'libvirtd.service') stderr:
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd systemd.state:130 stopping
service libvirtd
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:813
execute: ('/bin/systemctl', 'stop', 'libvirtd.service'),
executable='None', cwd='None', env=None
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:863
execute-result: ('/bin/systemctl', 'stop', 'libvirtd.service'),
rc=0
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:921
execute-output: ('/bin/systemctl', 'stop', 'libvirtd.service')
stdout:
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:926
execute-output: ('/bin/systemctl', 'stop', 'libvirtd.service')
stderr:
2018-12-08 08:56:10 INFO otopi.plugins.ovirt_host_deploy.vdsm.packages packages._start:167
Starting vdsm
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:73 check if
service NetworkManager exists
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:813
execute: ('/bin/systemctl', 'show', '-p', 'LoadState',
'NetworkManager.service'), executable='None', cwd='None',
env=None
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:863
execute-result: ('/bin/systemctl', 'show', '-p',
'LoadState', 'NetworkManager.service'), rc=0
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:921
execute-output: ('/bin/systemctl', 'show', '-p',
'LoadState', 'NetworkManager.service') stdout:
LoadState=not-found
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:926
execute-output: ('/bin/systemctl', 'show', '-p',
'LoadState', 'NetworkManager.service') stderr:
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd systemd.exists:73 check if
service network exists
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:813
execute: ('/bin/systemctl', 'show', '-p', 'LoadState',
'network.service'), executable='None', cwd='None', env=None
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:863
execute-result: ('/bin/systemctl', 'show', '-p',
'LoadState', 'network.service'), rc=0
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:921
execute-output: ('/bin/systemctl', 'show', '-p',
'LoadState', 'network.service') stdout:
LoadState=loaded
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:926
execute-output: ('/bin/systemctl', 'show', '-p',
'LoadState', 'network.service') stderr:
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd systemd.status:90 check
service network status
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:813
execute: ('/bin/systemctl', 'status', 'network.service'),
executable='None', cwd='None', env=None
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:863
execute-result: ('/bin/systemctl', 'status', 'network.service'),
rc=0
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:921
execute-output: ('/bin/systemctl', 'status', 'network.service')
stdout:
● network.service - LSB: Bring up/down networking
Loaded: loaded (/etc/rc.d/init.d/network; bad; vendor preset: disabled)
Active: active (exited) since Sat 2018-12-08 07:15:58 UTC; 1h 40min ago
Docs: man:systemd-sysv-generator(8)
Dec 08 07:15:45 localhost.localdomain systemd[1]: Starting LSB: Bring up/down
networking...
Dec 08 07:15:45 localhost.localdomain network[597]: Bringing up loopback interface: [ OK
]
Dec 08 07:15:54 localhost.localdomain network[597]: Bringing up interface eth0: RTNETLINK
answers: File exists
Dec 08 07:15:54 localhost.localdomain network[597]: [ OK ]
Dec 08 07:15:58 localhost.localdomain network[597]: Bringing up interface eth1: RTNETLINK
answers: File exists
Dec 08 07:15:58 localhost.localdomain network[597]: [ OK ]
Dec 08 07:15:58 localhost.localdomain systemd[1]: Started LSB: Bring up/down networking.
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:926
execute-output: ('/bin/systemctl', 'status', 'network.service')
stderr:
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd systemd.startup:99 set
service network startup to True
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:813
execute: ('/bin/systemctl', 'show', '-p', 'Id',
'network.service'), executable='None', cwd='None', env=None
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:863
execute-result: ('/bin/systemctl', 'show', '-p', 'Id',
'network.service'), rc=0
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:921
execute-output: ('/bin/systemctl', 'show', '-p', 'Id',
'network.service') stdout:
Id=network.service
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:926
execute-output: ('/bin/systemctl', 'show', '-p', 'Id',
'network.service') stderr:
2018-12-08 08:56:10 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:813
execute: ('/bin/systemctl', 'enable', u'network.service'),
executable='None', cwd='None', env=None
2018-12-08 08:56:11 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:863
execute-result: ('/bin/systemctl', 'enable', u'network.service'),
rc=0
2018-12-08 08:56:11 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:921
execute-output: ('/bin/systemctl', 'enable', u'network.service')
stdout:
2018-12-08 08:56:11 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:926
execute-output: ('/bin/systemctl', 'enable', u'network.service')
stderr:
network.service is not a native service, redirecting to /sbin/chkconfig.
Executing /sbin/chkconfig network on
2018-12-08 08:56:11 DEBUG otopi.plugins.otopi.services.systemd systemd.state:130 starting
service vdsmd
2018-12-08 08:56:11 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:813
execute: ('/bin/systemctl', 'start', 'vdsmd.service'),
executable='None', cwd='None', env=None
2018-12-08 08:56:22 DEBUG otopi.plugins.otopi.services.systemd plugin.executeRaw:863
execute-result: ('/bin/systemctl', 'start', 'vdsmd.service'),
rc=1
2018-12-08 08:56:22 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:921
execute-output: ('/bin/systemctl', 'start', 'vdsmd.service')
stdout:
2018-12-08 08:56:22 DEBUG otopi.plugins.otopi.services.systemd plugin.execute:926
execute-output: ('/bin/systemctl', 'start', 'vdsmd.service')
stderr:
A dependency job for vdsmd.service failed. See 'journalctl -xe' for details.
2018-12-08 08:56:22 DEBUG otopi.context context._executeMethod:142 method exception
Traceback (most recent call last):
File "/tmp/ovirt-k9euqzUiWK/pythonlib/otopi/context.py", line 132, in
_executeMethod
method['method']()
File "/tmp/ovirt-k9euqzUiWK/otopi-plugins/ovirt-host-deploy/vdsm/packages.py",
line 209, in _start
self.services.state('vdsmd', True)
File "/tmp/ovirt-k9euqzUiWK/otopi-plugins/otopi/services/systemd.py", line
141, in state
service=name,
RuntimeError: Failed to start service 'vdsmd'
2018-12-08 08:56:22 ERROR otopi.context context._executeMethod:151 Failed to execute stage
'Closing up': Failed to start service 'vdsmd'
2018-12-08 08:56:22 DEBUG otopi.context context.dumpEnvironment:760 ENVIRONMENT DUMP -
BEGIN
2018-12-08 08:56:22 DEBUG otopi.context context.dumpEnvironment:770 ENV
BASE/error=bool:'True'
2018-12-08 08:56:22 DEBUG otopi.context context.dumpEnvironment:770 ENV
BASE/exceptionInfo=list:'[(<type 'exceptions.RuntimeError'>,
RuntimeError("Failed to start service 'vdsmd'",), <traceback object
at 0x7f83c380e908>)]'
2018-12-08 08:56:22 DEBUG otopi.context context.dumpEnvironment:774 ENVIRONMENT DUMP -
END
2018-12-08 08:56:22 INFO otopi.context context.runSequence:687 Stage: Pre-termination
2018-12-08 08:56:22 DEBUG otopi.context context.runSequence:691 STAGE pre-terminate
2018-12-08 08:56:22 DEBUG otopi.context context._executeMethod:128 Stage pre-terminate
METHOD otopi.plugins.otopi.core.misc.Plugin._preTerminate