1726240 – Many restarts of NetworkManager when installing machine in beaker

Bug 1726240 - Many restarts of NetworkManager when installing machine in beaker

Summary: Many restarts of NetworkManager when installing machine in beaker

Keywords:
Status:	CLOSED NEXTRELEASE
Alias:	None
Product:	Fedora
Classification:	Fedora
Component:	NetworkManager
Sub Component:
Version:	rawhide
Hardware:	Unspecified
OS:	Unspecified
Priority:	urgent
Severity:	urgent
Target Milestone:	---
Assignee:	Lubomir Rintel
QA Contact:	Fedora Extras Quality Assurance
Docs Contact:
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+	depends on / blocked

Reported:	2019-07-02 12:07 UTC by Lukas Slebodnik
Modified:	2019-07-03 09:46 UTC (History)
CC List:	10 users (show)
Fixed In Version:	NetworkManager-1.20.0-0.3.fc31
Clone Of:
Environment:
Last Closed:	2019-07-03 09:46:49 UTC
Type:	Bug
Embargoed:
Dependent Products:

Attachments	(Terms of Use)

Description Lukas Slebodnik 2019-07-02 12:07:33 UTC

Description of problem:
Installation of fedora rawhide failed since 9th June and the latest update of NetworkManager in koji is from 2019-06-04 15:17:21. Which is related to rawhide compose from 9th June.

The installation with anaconda does not even start due to following error

[  226.252919] dracut-initqueue[856]: Warning: dracut-initqueue timeout - starting timeout scripts  
[  226.858260] dracut-initqueue[856]: Warning: dracut-initqueue timeout - starting timeout scripts  
[  227.465513] dracut-initqueue[856]: Warning: dracut-initqueue timeout - starting timeout scripts  
[  228.073304] dracut-initqueue[856]: Warning: dracut-initqueue timeout - starting timeout scripts  
[  228.681774] dracut-initqueue[856]: Warning: dracut-initqueue timeout - starting timeout scripts  
[  228.683214] dracut-initqueue[856]: Warning: Could not boot.  
         Starting         
Setup Virtual Console   
...  
[      
  OK     
] Started         
Setup Virtual Console   
.  
[  228.833821] kauditd_printk_skb: 2 callbacks suppressed 
[  228.833822] audit: type=1130 audit(1562064378.327:14): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
[  228.840498] audit: type=1131 audit(1562064378.331:15): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
         Starting         
Dracut Emergency Shell   
...  
[  228.881931] audit: type=1131 audit(1562064378.375:16): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=plymouth-start comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
Warning: /dev/root does not exist 
 
Generating "/run/initramfs/rdsosreport.txt" 
 
 
Entering emergency mode. Exit the shell to continue. 
Type "journalctl" to view system logs. 
You might want to save "/run/initramfs/rdsosreport.txt" to a USB stick or /boot 
after mounting them and attach it to a bug report. 
 
 
dracut:/# [-- MARK -- Tue Jul  2 10:50:00 2019]

Version-Release number of selected component (if applicable):

NetworkManager-1.20.0-0.2.fc31

How reproducible:

Deterministic in beaker

Additional info:
/run/initramfs/rdsosreport.txt contains  following lines:

[   11.301034] localhost systemd[1]: Started Open-iSCSI.
[   11.316407] localhost NetworkManager[985]: <info>  [1562064182.0612] NetworkManager (version 1.20.0-0.2.fc31) is starting... (for the first time)
[   11.317066] localhost NetworkManager[985]: <info>  [1562064182.0615] Read config: /etc/NetworkManager/NetworkManager.conf
[   11.320586] localhost NetworkManager[985]: <info>  [1562064182.0657] auth[0x55c4dd4f2ca0]: create auth-manager: D-Bus connection not available. Polkit is disabled and all requests are authenticated.
[   11.322784] localhost NetworkManager[985]: <info>  [1562064182.0679] manager[0x55c4dd4fc0a0]: monitoring kernel firmware directory '/lib/firmware'.
[   11.323003] localhost NetworkManager[985]: <info>  [1562064182.0681] hostname: hostname: hostnamed not used as proxy creation failed with: Could not connect: No such file or directory
[   11.323267] localhost NetworkManager[985]: <info>  [1562064182.0684] dns-mgr[0x55c4dd4f7210]: init: dns=default,systemd-resolved rc-manager=symlink
[   11.324394] localhost NetworkManager[985]: <info>  [1562064182.0695] settings: Loaded settings plugin: SettingsPluginIfcfg ("/usr/lib64/NetworkManager/1.20.0-0.2.fc31/libnm-settings-plugin-ifcfg-rh.so")
[   11.324443] localhost NetworkManager[985]: <info>  [1562064182.0696] settings: Loaded settings plugin: NMSKeyfilePlugin (internal)
[   11.324474] localhost NetworkManager[985]: <warn>  [1562064182.0696] ifcfg-rh: Could not read directory '/etc/sysconfig/network-scripts': Error opening directory “/etc/sysconfig/network-scripts”: No such file or directory
[   11.324621] localhost NetworkManager[985]: <info>  [1562064182.0697] manager: rfkill: Wi-Fi enabled by radio killswitch; enabled by state file
[   11.324661] localhost NetworkManager[985]: <info>  [1562064182.0698] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
[   11.324691] localhost NetworkManager[985]: <info>  [1562064182.0698] manager: Networking is enabled by state file
[   11.324733] localhost NetworkManager[985]: <info>  [1562064182.0698] dhcp-init: Using DHCP client 'internal'
[   11.326328] localhost NetworkManager[985]: <info>  [1562064182.0714] Loaded device plugin: NMTeamFactory (/usr/lib64/NetworkManager/1.20.0-0.2.fc31/libnm-device-plugin-team.so)
[   11.327602] localhost NetworkManager[985]: <info>  [1562064182.0727] device (lo): carrier: link connected
[   11.327643] localhost NetworkManager[985]: <info>  [1562064182.0728] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1)
[   11.328849] localhost NetworkManager[985]: <info>  [1562064182.0740] manager: (ens3): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2)
[   11.329028] localhost NetworkManager[985]: <info>  [1562064182.0741] device (ens3): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
[   11.335962] localhost NetworkManager[985]: <info>  [1562064182.0776] device (ens3): carrier: link connected
[   11.336016] localhost NetworkManager[985]: <warn>  [1562064182.0799] sleep-monitor-sd: failed to acquire D-Bus proxy: Could not connect: No such file or directory
[   11.336066] localhost NetworkManager[985]: <warn>  [1562064182.0799] firewall: could not connect to system D-Bus (Could not connect: No such file or directory)
[   11.336098] localhost NetworkManager[985]: <warn>  [1562064182.0800] ifcfg-rh: dbus: couldn't initialize system bus: Could not connect: No such file or directory
[   11.336128] localhost NetworkManager[985]: <info>  [1562064182.0801] device (ens3): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
[   11.336163] localhost NetworkManager[985]: <info>  [1562064182.0809] manager: startup complete
[   11.336194] localhost NetworkManager[985]: <info>  [1562064182.0809] quitting now that startup is complete
[   11.337632] localhost NetworkManager[985]: <info>  [1562064182.0827] exiting (success)
[   11.479005] localhost kernel: NetworkManager (985) used greatest stack depth: 12544 bytes left
[   11.972502] localhost kernel: IPv6: ADDRCONF(NETDEV_CHANGE): ens3: link becomes ready
[   11.952448] localhost NetworkManager[1007]: <info>  [1562064182.6973] NetworkManager (version 1.20.0-0.2.fc31) is starting... (after a restart)
[   11.953121] localhost NetworkManager[1007]: <info>  [1562064182.6982] Read config: /etc/NetworkManager/NetworkManager.conf
[   11.957446] localhost NetworkManager[1007]: <info>  [1562064182.7025] auth[0x55785a04dca0]: create auth-manager: D-Bus connection not available. Polkit is disabled and all requests are authenticated.
[   11.959786] localhost NetworkManager[1007]: <info>  [1562064182.7049] manager[0x55785a058020]: monitoring kernel firmware directory '/lib/firmware'.
[   11.960103] localhost NetworkManager[1007]: <info>  [1562064182.7052] hostname: hostname: hostnamed not used as proxy creation failed with: Could not connect: No such file or directory
[   11.960746] localhost NetworkManager[1007]: <info>  [1562064182.7059] dns-mgr[0x55785a052210]: init: dns=default,systemd-resolved rc-manager=symlink
[   11.961938] localhost NetworkManager[1007]: <info>  [1562064182.7070] settings: Loaded settings plugin: SettingsPluginIfcfg ("/usr/lib64/NetworkManager/1.20.0-0.2.fc31/libnm-settings-plugin-ifcfg-rh.so")
[   11.962065] localhost NetworkManager[1007]: <info>  [1562064182.7072] settings: Loaded settings plugin: NMSKeyfilePlugin (internal)
[   11.962171] localhost NetworkManager[1007]: <warn>  [1562064182.7073] ifcfg-rh: Could not read directory '/etc/sysconfig/network-scripts': Error opening directory “/etc/sysconfig/network-scripts”: No such file or directory
[   11.962662] localhost NetworkManager[1007]: <info>  [1562064182.7075] manager: rfkill: Wi-Fi enabled by radio killswitch; enabled by state file
[   11.962751] localhost NetworkManager[1007]: <info>  [1562064182.7079] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
[   11.962826] localhost NetworkManager[1007]: <info>  [1562064182.7080] manager: Networking is enabled by state file
[   11.962905] localhost NetworkManager[1007]: <info>  [1562064182.7080] dhcp-init: Using DHCP client 'internal'
[   11.964630] localhost NetworkManager[1007]: <info>  [1562064182.7097] Loaded device plugin: NMTeamFactory (/usr/lib64/NetworkManager/1.20.0-0.2.fc31/libnm-device-plugin-team.so)
[   11.965820] localhost NetworkManager[1007]: <info>  [1562064182.7109] device (lo): carrier: link connected
[   11.965944] localhost NetworkManager[1007]: <info>  [1562064182.7111] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1)
[   11.966879] localhost NetworkManager[1007]: <info>  [1562064182.7120] device (ens3): carrier: link connected
[   11.967467] localhost NetworkManager[1007]: <info>  [1562064182.7126] manager: (ens3): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2)
[   11.968255] localhost NetworkManager[1007]: <info>  [1562064182.7133] device (ens3): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
[   11.972767] localhost NetworkManager[1007]: <warn>  [1562064182.7179] sleep-monitor-sd: failed to acquire D-Bus proxy: Could not connect: No such file or directory
[   11.972881] localhost NetworkManager[1007]: <warn>  [1562064182.7180] firewall: could not connect to system D-Bus (Could not connect: No such file or directory)
[   11.972977] localhost NetworkManager[1007]: <warn>  [1562064182.7181] ifcfg-rh: dbus: couldn't initialize system bus: Could not connect: No such file or directory
[   11.973159] localhost NetworkManager[1007]: <info>  [1562064182.7183] device (ens3): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
[   11.974268] localhost NetworkManager[1007]: <info>  [1562064182.7194] manager: startup complete
[   11.975654] localhost NetworkManager[1007]: <info>  [1562064182.7208] quitting now that startup is complete
[   11.977180] localhost NetworkManager[1007]: <info>  [1562064182.7223] exiting (success)



//snip



[  237.758434] localhost dracut-initqueue[867]: Warning: dracut-initqueue timeout - starting timeout scripts
[  237.826028] localhost NetworkManager[8552]: <info>  [1562064408.5709] NetworkManager (version 1.20.0-0.2.fc31) is starting... (after a restart)
[  237.826779] localhost NetworkManager[8552]: <info>  [1562064408.5719] Read config: /etc/NetworkManager/NetworkManager.conf
[  237.831123] localhost NetworkManager[8552]: <info>  [1562064408.5762] auth[0x560c833f8ca0]: create auth-manager: D-Bus connection not available. Polkit is disabled and all requests are authenticated.
[  237.833694] localhost NetworkManager[8552]: <info>  [1562064408.5788] manager[0x560c834020a0]: monitoring kernel firmware directory '/lib/firmware'.
[  237.834025] localhost NetworkManager[8552]: <info>  [1562064408.5791] hostname: hostname: hostnamed not used as proxy creation failed with: Could not connect: No such file or directory
[  237.834587] localhost NetworkManager[8552]: <info>  [1562064408.5795] dns-mgr[0x560c833fd210]: init: dns=default,systemd-resolved rc-manager=symlink
[  237.835866] localhost NetworkManager[8552]: <info>  [1562064408.5810] settings: Loaded settings plugin: SettingsPluginIfcfg ("/usr/lib64/NetworkManager/1.20.0-0.2.fc31/libnm-settings-plugin-ifcfg-rh.so")
[  237.835999] localhost NetworkManager[8552]: <info>  [1562064408.5811] settings: Loaded settings plugin: NMSKeyfilePlugin (internal)
[  237.836105] localhost NetworkManager[8552]: <warn>  [1562064408.5812] ifcfg-rh: Could not read directory '/etc/sysconfig/network-scripts': Error opening directory “/etc/sysconfig/network-scripts”: No such file or directory
[  237.836293] localhost NetworkManager[8552]: <info>  [1562064408.5814] manager: rfkill: Wi-Fi enabled by radio killswitch; enabled by state file
[  237.836667] localhost NetworkManager[8552]: <info>  [1562064408.5818] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
[  237.836752] localhost NetworkManager[8552]: <info>  [1562064408.5819] manager: Networking is enabled by state file
[  237.836852] localhost NetworkManager[8552]: <info>  [1562064408.5820] dhcp-init: Using DHCP client 'internal'
[  237.838639] localhost NetworkManager[8552]: <info>  [1562064408.5837] Loaded device plugin: NMTeamFactory (/usr/lib64/NetworkManager/1.20.0-0.2.fc31/libnm-device-plugin-team.so)
[  237.839854] localhost NetworkManager[8552]: <info>  [1562064408.5850] device (lo): carrier: link connected
[  237.840007] localhost NetworkManager[8552]: <info>  [1562064408.5851] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1)
[  237.840987] localhost NetworkManager[8552]: <info>  [1562064408.5861] device (ens3): carrier: link connected
[  237.841570] localhost NetworkManager[8552]: <info>  [1562064408.5867] manager: (ens3): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2)
[  237.841824] localhost NetworkManager[8552]: <info>  [1562064408.5869] device (ens3): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
[  237.845984] localhost NetworkManager[8552]: <warn>  [1562064408.5911] sleep-monitor-sd: failed to acquire D-Bus proxy: Could not connect: No such file or directory
[  237.846120] localhost NetworkManager[8552]: <warn>  [1562064408.5912] firewall: could not connect to system D-Bus (Could not connect: No such file or directory)
[  237.846261] localhost NetworkManager[8552]: <warn>  [1562064408.5914] ifcfg-rh: dbus: couldn't initialize system bus: Could not connect: No such file or directory
[  237.846507] localhost NetworkManager[8552]: <info>  [1562064408.5916] device (ens3): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
[  237.848077] localhost NetworkManager[8552]: <info>  [1562064408.5932] manager: startup complete
[  237.848208] localhost NetworkManager[8552]: <info>  [1562064408.5933] quitting now that startup is complete
[  237.850007] localhost NetworkManager[8552]: <info>  [1562064408.5951] exiting (success)
[  238.398179] localhost dracut-initqueue[867]: Warning: dracut-initqueue timeout - starting timeout scripts
[  238.398839] localhost dracut-initqueue[867]: Warning: Could not boot.

Comment 1 Lubomir Rintel 2019-07-02 12:36:46 UTC

Please include full console log.

Also, what's your kernel command line?

Comment 4 Lukas Slebodnik 2019-07-03 07:32:20 UTC

I can confirm that workaround `kernel_options="rd.bootif=0"` work as expected.

Comment 6 Lubomir Rintel 2019-07-03 09:46:49 UTC

Thanks for the report.

The fixed build is now in Rawhide.

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