1057657 – vdsm-4.14.1-2 unable to restart on reboot after a network is defined on Fedora 19

Bug 1057657 - vdsm-4.14.1-2 unable to restart on reboot after a network is defined on Fedora 19

Summary: vdsm-4.14.1-2 unable to restart on reboot after a network is defined on Fedor...

Keywords:
Status:	CLOSED CURRENTRELEASE
Alias:	None
Product:	oVirt
Classification:	Retired
Component:	vdsm
Sub Component:
Version:	3.4
Hardware:	All
OS:	Linux
Priority:	medium
Severity:	high
Target Milestone:	---
Target Release:	3.4.1
Assignee:	Antoni Segura Puimedon
QA Contact:	Meni Yakove
Docs Contact:
URL:
Whiteboard:	network
Depends On:	1057772
Blocks:
TreeView+	depends on / blocked

Reported:	2014-01-24 15:05 UTC by Douglas Schilling Landgraf
Modified:	2014-05-08 13:36 UTC (History)
CC List:	9 users (show)
Fixed In Version:	3.4.1
Doc Type:	Bug Fix
Doc Text:
Clone Of:
Environment:
Last Closed:	2014-05-08 13:36:22 UTC
oVirt Team:	---
Embargoed:
Dependent Products:

Attachments	(Terms of Use)
vdsm and supervdsm logs (126.52 KB, application/x-gzip) 2014-01-24 15:06 UTC, Douglas Schilling Landgraf	no flags	Details
View All

Links
System	ID	Private	Priority	Status	Summary	Last Updated
oVirt gerrit	23518	0	None	None	None	Never

Description Douglas Schilling Landgraf 2014-01-24 15:05:01 UTC

Description of problem:

Vdsm cannot start


Steps executed:
================
- Setup Node -> put it in maintenance 
- Changed the vdsm.conf on node to:

============
[vars]
ssl = true
net_configurator = iproute2
net_persistence = unified

[addresses]
management_port = 54321
================

- Restart vdsm/supervdsm
- Host is UP again, no problems


- DataCenter -> Logical Network -> New
  - Name: net25 -> [x] Enable Vlan tagging  [  ] VM Network

- Since I have just one nic at host I have added dummy interface.
  # ip link add name dummy_interface type dummy

- Put the host in maintenance and put again UP to recognize the new dummy interface

- Host -> Network -> Setup Host Networks 
  -> drag/drop net25 to dummy_interace 
  -> [x] save network interface

On host vdsClient -s 0 getVdsCaps appears [net25] - OK

* Reboot host (to check if it persist)


==== initially showed in vdsm.log =========

Thread-13::ERROR::2014-01-23 19:44:59,905::BindingXMLRPC::989::vds::(wrapper) unexpected error
Traceback (most recent call last):
  File "/usr/share/vdsm/BindingXMLRPC.py", line 973, in wrapper
    res = f(*args, **kwargs)
  File "/usr/share/vdsm/BindingXMLRPC.py", line 301, in getCapabilities
    ret = api.getCapabilities()
  File "/usr/share/vdsm/API.py", line 1180, in getCapabilities
    c = caps.get()
  File "/usr/share/vdsm/caps.py", line 369, in get
    caps.update(netinfo.get())
  File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 564, in get
    _bridgeinfo(dev.name, gateways, ipv6routes)
  File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 508, in _bridgeinfo
    info = _devinfo(bridge)
  File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 536, in _devinfo
    ipv4addr, ipv4netmask, ipv6addrs = getIpInfo(dev)
  File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 317, in getIpInfo
    ipv6addrs = devInfo.get_ipv6_addresses()
SystemError: error return without exception set

======== Trying to start vdsm manually (from /var/log/messages) ============
Jan 24 09:58:27 localhost systemd[1]: Starting Virtual Desktop Server Manager...
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: vdsm: Running mkdirs
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: vdsm: Running configure_coredump
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: vdsm: Running run_init_hooks
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: vdsm: Running gencerts
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: vdsm: Running check_is_configured
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: libvirt is already configured for vdsm
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: sanlock service is already configured
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: vdsm: Running validate_configuration
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: SUCCESS: ssl configured to true. No conflicts
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: vdsm: Running prepare_transient_repository
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: vdsm: Running syslog_available
Jan 24 09:58:27 localhost vdsmd_init_common.sh[2555]: vdsm: Running nwfilter
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: vdsm: Running dummybr
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: vdsm: Running load_needed_modules
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: vdsm: Running tune_system
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: vdsm: Running test_space
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: vdsm: Running test_lo
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: vdsm: Running restore_nets
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: Traceback (most recent call last):
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: File "/usr/share/vdsm/vdsm-restore-net-config", line 78, in <module>
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: restore()
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: File "/usr/share/vdsm/vdsm-restore-net-config", line 65, in restore
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: unified_restoration()
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: File "/usr/share/vdsm/vdsm-restore-net-config", line 52, in unified_restoration
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: _inRollback=True)
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: File "/usr/share/vdsm/configNetwork.py", line 584, in setupNetworks
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: _netinfo = netinfo.NetInfo()
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 648, in __init__
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: _netinfo = get()
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: netAttr.get('qosOutbound'))
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 487, in _getNetInfo
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: ipv4addr, ipv4netmask, ipv6addrs = getIpInfo(iface)
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 317, in getIpInfo
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: ipv6addrs = devInfo.get_ipv6_addresses()
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: SystemError: error return without exception set
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2555]: vdsm: stopped during execute restore_nets task (task returned with error code 1).
Jan 24 09:58:28 localhost systemd[1]: vdsmd.service: control process exited, code=exited status=1
Jan 24 09:58:28 localhost systemd[1]: Failed to start Virtual Desktop Server Manager.
Jan 24 09:58:28 localhost systemd[1]: Unit vdsmd.service entered failed state.
Jan 24 09:58:28 localhost systemd[1]: vdsmd.service holdoff time over, scheduling restart.
Jan 24 09:58:28 localhost systemd[1]: Stopping Virtual Desktop Server Manager...
Jan 24 09:58:28 localhost systemd[1]: Starting Virtual Desktop Server Manager...
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2607]: vdsm: Running mkdirs
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2607]: vdsm: Running configure_coredump
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2607]: vdsm: Running run_init_hooks
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2607]: vdsm: Running gencerts
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2607]: vdsm: Running check_is_configured
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2607]: libvirt is already configured for vdsm
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2607]: sanlock service is already configured
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2607]: vdsm: Running validate_configuration
Jan 24 09:58:28 localhost vdsmd_init_common.sh[2607]: SUCCESS: ssl configured to true. No conflicts
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: vdsm: Running prepare_transient_repository
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: vdsm: Running syslog_available
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: vdsm: Running nwfilter
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: vdsm: Running dummybr
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: vdsm: Running load_needed_modules
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: vdsm: Running tune_system
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: vdsm: Running test_space
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: vdsm: Running test_lo
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: vdsm: Running restore_nets
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: Traceback (most recent call last):
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: File "/usr/share/vdsm/vdsm-restore-net-config", line 78, in <module>
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: restore()
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: File "/usr/share/vdsm/vdsm-restore-net-config", line 65, in restore
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: unified_restoration()
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: File "/usr/share/vdsm/vdsm-restore-net-config", line 52, in unified_restoration
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: _inRollback=True)
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: File "/usr/share/vdsm/configNetwork.py", line 584, in setupNetworks
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: _netinfo = netinfo.NetInfo()
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 648, in __init__
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: _netinfo = get()
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: netAttr.get('qosOutbound'))
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 487, in _getNetInfo
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: ipv4addr, ipv4netmask, ipv6addrs = getIpInfo(iface)
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 317, in getIpInfo
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: ipv6addrs = devInfo.get_ipv6_addresses()
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: SystemError: error return without exception set
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2607]: vdsm: stopped during execute restore_nets task (task returned with error code 1).
Jan 24 09:58:29 localhost systemd[1]: vdsmd.service: control process exited, code=exited status=1
Jan 24 09:58:29 localhost systemd[1]: Failed to start Virtual Desktop Server Manager.
Jan 24 09:58:29 localhost systemd[1]: Unit vdsmd.service entered failed state.
Jan 24 09:58:29 localhost systemd[1]: vdsmd.service holdoff time over, scheduling restart.
Jan 24 09:58:29 localhost systemd[1]: Stopping Virtual Desktop Server Manager...
Jan 24 09:58:29 localhost systemd[1]: Starting Virtual Desktop Server Manager...
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2659]: vdsm: Running mkdirs
Jan 24 09:58:29 localhost vdsmd_init_common.sh[2659]: vdsm: Running configure_coredump
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: vdsm: Running run_init_hooks
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: vdsm: Running gencerts
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: vdsm: Running check_is_configured
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: libvirt is already configured for vdsm
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: sanlock service is already configured
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: vdsm: Running validate_configuration
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: SUCCESS: ssl configured to true. No conflicts
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: vdsm: Running prepare_transient_repository
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: vdsm: Running syslog_available
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: vdsm: Running nwfilter
Jan 24 09:58:30 localhost vdsmd_init_common.sh[2659]: vdsm: Running dummybr
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: vdsm: Running load_needed_modules
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: vdsm: Running tune_system
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: vdsm: Running test_space
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: vdsm: Running test_lo
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: vdsm: Running restore_nets
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: Traceback (most recent call last):
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: File "/usr/share/vdsm/vdsm-restore-net-config", line 78, in <module>
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: restore()
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: File "/usr/share/vdsm/vdsm-restore-net-config", line 65, in restore
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: unified_restoration()
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: File "/usr/share/vdsm/vdsm-restore-net-config", line 52, in unified_restoration
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: _inRollback=True)
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: File "/usr/share/vdsm/configNetwork.py", line 584, in setupNetworks
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: _netinfo = netinfo.NetInfo()
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 648, in __init__
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: _netinfo = get()
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2659]: vdsm: stopped during execute restore_nets task (task returned with error code 1).
Jan 24 09:58:31 localhost systemd[1]: vdsmd.service: control process exited, code=exited status=1
Jan 24 09:58:31 localhost systemd[1]: Failed to start Virtual Desktop Server Manager.
Jan 24 09:58:31 localhost systemd[1]: Unit vdsmd.service entered failed state.
Jan 24 09:58:31 localhost systemd[1]: vdsmd.service holdoff time over, scheduling restart.
Jan 24 09:58:31 localhost systemd[1]: Stopping Virtual Desktop Server Manager...
Jan 24 09:58:31 localhost systemd[1]: Starting Virtual Desktop Server Manager...
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2712]: vdsm: Running mkdirs
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2712]: vdsm: Running configure_coredump
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2712]: vdsm: Running run_init_hooks
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2712]: vdsm: Running gencerts
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2712]: vdsm: Running check_is_configured
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2712]: libvirt is already configured for vdsm
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2712]: sanlock service is already configured
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2712]: vdsm: Running validate_configuration
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2712]: SUCCESS: ssl configured to true. No conflicts
Jan 24 09:58:31 localhost vdsmd_init_common.sh[2712]: vdsm: Running prepare_transient_repository
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: vdsm: Running syslog_available
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: vdsm: Running nwfilter
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: vdsm: Running dummybr
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: vdsm: Running load_needed_modules
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: vdsm: Running tune_system
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: vdsm: Running test_space
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: vdsm: Running test_lo
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: vdsm: Running restore_nets
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: Traceback (most recent call last):
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: File "/usr/share/vdsm/vdsm-restore-net-config", line 78, in <module>
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: restore()
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: File "/usr/share/vdsm/vdsm-restore-net-config", line 65, in restore
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: unified_restoration()
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: File "/usr/share/vdsm/vdsm-restore-net-config", line 52, in unified_restoration
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: _inRollback=True)
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: File "/usr/share/vdsm/configNetwork.py", line 584, in setupNetworks
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: _netinfo = netinfo.NetInfo()
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 648, in __init__
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: _netinfo = get()
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 317, in getIpInfo
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: ipv6addrs = devInfo.get_ipv6_addresses()
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: SystemError: error return without exception set
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2712]: vdsm: stopped during execute restore_nets task (task returned with error code 1).
Jan 24 09:58:32 localhost systemd[1]: vdsmd.service: control process exited, code=exited status=1
Jan 24 09:58:32 localhost systemd[1]: Failed to start Virtual Desktop Server Manager.
Jan 24 09:58:32 localhost systemd[1]: Unit vdsmd.service entered failed state.
Jan 24 09:58:32 localhost systemd[1]: vdsmd.service holdoff time over, scheduling restart.
Jan 24 09:58:32 localhost systemd[1]: Stopping Virtual Desktop Server Manager...
Jan 24 09:58:32 localhost systemd[1]: Starting Virtual Desktop Server Manager...
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2764]: vdsm: Running mkdirs
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2764]: vdsm: Running configure_coredump
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2764]: vdsm: Running run_init_hooks
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2764]: vdsm: Running gencerts
Jan 24 09:58:32 localhost vdsmd_init_common.sh[2764]: vdsm: Running check_is_configured
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: libvirt is already configured for vdsm
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: sanlock service is already configured
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: vdsm: Running validate_configuration
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: SUCCESS: ssl configured to true. No conflicts
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: vdsm: Running prepare_transient_repository
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: vdsm: Running syslog_available
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: vdsm: Running nwfilter
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: vdsm: Running dummybr
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: vdsm: Running load_needed_modules
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: vdsm: Running tune_system
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: vdsm: Running test_space
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: vdsm: Running test_lo
Jan 24 09:58:33 localhost vdsmd_init_common.sh[2764]: vdsm: Running restore_nets
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: Traceback (most recent call last):
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: File "/usr/share/vdsm/vdsm-restore-net-config", line 78, in <module>
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: restore()
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: File "/usr/share/vdsm/vdsm-restore-net-config", line 65, in restore
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: unified_restoration()
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: File "/usr/share/vdsm/vdsm-restore-net-config", line 52, in unified_restoration
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: _inRollback=True)
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: File "/usr/share/vdsm/configNetwork.py", line 584, in setupNetworks
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: _netinfo = netinfo.NetInfo()
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 648, in __init__
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: _netinfo = get()
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: ipv4addr, ipv4netmask, ipv6addrs = getIpInfo(iface)
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 317, in getIpInfo
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: ipv6addrs = devInfo.get_ipv6_addresses()
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: SystemError: error return without exception set
Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: vdsm: stopped during execute restore_nets task (task returned with error code 1).
Jan 24 09:58:34 localhost systemd[1]: vdsmd.service: control process exited, code=exited status=1
Jan 24 09:58:34 localhost systemd[1]: Failed to start Virtual Desktop Server Manager.
Jan 24 09:58:34 localhost systemd[1]: Unit vdsmd.service entered failed state.
Jan 24 09:58:34 localhost systemd[1]: vdsmd.service holdoff time over, scheduling restart.
Jan 24 09:58:34 localhost systemd[1]: Stopping Virtual Desktop Server Manager...
Jan 24 09:58:34 localhost systemd[1]: Starting Virtual Desktop Server Manager...
Jan 24 09:58:34 localhost systemd[1]: vdsmd.service start request repeated too quickly, refusing to start.
Jan 24 09:58:34 localhost systemd[1]: Failed to start Virtual Desktop Server Manager.
Jan 24 09:58:34 localhost systemd[1]: Unit vdsmd.service entered failed state.

Comment 1 Douglas Schilling Landgraf 2014-01-24 15:06:36 UTC

Created attachment 855007 [details]
vdsm and supervdsm logs

Comment 2 Antoni Segura Puimedon 2014-01-24 15:26:53 UTC

This
    Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: File "/usr/lib64/python2.7/site-packages/vdsm/netinfo.py", line 317, in getIpInfo
    Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: ipv6addrs = devInfo.get_ipv6_addresses()
    Jan 24 09:58:34 localhost vdsmd_init_common.sh[2764]: SystemError: error return without exception set

Is a python-ethtool bug. I have sent a patch that is applied upstream (needs backporting) that adds errno before raising for all the python-ethtool cases I could find. I'll do the backport and try to reproduce.

Comment 3 Antoni Segura Puimedon 2014-01-24 19:48:04 UTC

Reported https://bugzilla.redhat.com/1057772 but want still to check that there's no further issue.

Comment 4 Itamar Heim 2014-01-26 08:10:48 UTC

Setting target release to current version for consideration and review. please
do not push non-RFE bugs to an undefined target release to make sure bugs are
reviewed for relevancy, fix, closure, etc.

Comment 5 Dan Kenigsberg 2014-01-30 14:12:56 UTC

Douglas, which ovirt-node image did you use?
Could it be one with http://gerrit.ovirt.org/#/c/20068/1/src/ovirtnode/network.py missing?

Comment 6 Douglas Schilling Landgraf 2014-01-30 14:18:25 UTC

(In reply to Dan Kenigsberg from comment #5)
> Douglas, which ovirt-node image did you use?
> Could it be one with
> http://gerrit.ovirt.org/#/c/20068/1/src/ovirtnode/network.py missing?

Dan, it was Fedora 19 minimal install, sorry about not being explicit.

Comment 7 Dan Kenigsberg 2014-02-11 17:02:12 UTC

Reducing priority, as this does not easily reproduces.

Comment 8 Antoni Segura Puimedon 2014-03-03 08:34:56 UTC

The SystemError that led up to the bug here reported was solved by http://gerrit.ovirt.org/#/c/23518/6

Now the ip information for a non-existing device is reported as:
ipv4addr == '',
ipv4netmask == '',
ipv6addrs == []

There might be some other thing affecting the reported flow.

Comment 9 Antoni Segura Puimedon 2014-03-03 08:38:05 UTC

The only other thing that I see that could affect the flow is the fact that after reboot the device dummy_interface will not exist any longer. If the user wishes to use such devices, the user should have some script that creates them on boot (I suggest some script called by a systemd service file).

I consider the bug as not requiring further patches.

Comment 10 Sandro Bonazzola 2014-03-04 09:18:43 UTC

This is an automated message.
Re-targeting all non-blocker bugs still open on 3.4.0 to 3.4.1.

Comment 11 Sandro Bonazzola 2014-05-08 13:36:22 UTC

This is an automated message

oVirt 3.4.1 has been released:
 * should fix your issue
 * should be available at your local mirror within two days.

If problems still persist, please make note of it in this bug report.

Note You need to log in before you can comment on or make changes to this bug.