Anaconda for AlmaLinux 9.2 hangs sometimes with a kickstart NFS install

[tsgsh]

I have a process for building KVM VMs that uses Ansible to set up (a) a DHCP entry, (b) a tailored PXE config and AlmaLinux image, (c) a Kickstart config file pointing to an NFS share with the AlmaLinux 9.2 image and then boots the server to do the install.

This is completely reliable with Centos Stream 9. With AlmaLinux 9.2, roughly 50% of the time, it hangs during the Anaconda install shortly after the * when reporting a bug message and about 16 seconds after the NFS transfer starts. Two minutes later the NFS server closes the TCP session on port 2049 (6 FIN/ACK attempts with no response). I can send Ctrl-Alt-F4 etc to the VM and it will show me the logs but otherwise it's unresponsive. I'm not aware of a way to get the logs off the virtual /dev/tty4 except by watching them in virt-viewer but what that tells me is that Anaconda is deactivating the enp1s0 interface (which would definitely stop NFS). I have no idea why it's doing this.

The other 50% of the time it installs normally. The DHCP, TFTP and NFS servers are all the same 192.168.1.3 and that is a VM in the same subnet, running on the same host connected to the same Linux bridge (br1).

From the /var/lib/tftpboot/pxelinux.cfg/C0A8017F

# This PXELINUX menu was created by virt_install
#
# Installs AlmaLinux 9 on agrajag at IP address=192.168.1.126 (hexadecimal=C0A8017E)
#
default vesamenu.c32
prompt 0
timeout 10
ONTIMEOUT 1
display boot.msg

menu title ## virt-install PXE Boot Menu for agrajag ##
 label 1
 menu label virt_install of AlmaLinux 9
 menu default
 kernel almalinux-9/vmlinuz
 append initrd=almalinux-9/initrd.img ip=dhcp inst.ks=nfs:192.168.1.3:/srv/shares/kickstart/agrajag.ks

/srv/shares/kickstart/agrajag.ks

# KVM/libvirt Kickstart install file for minimal server NIC enp1s0, DHCP
# dynamically created by virt-install playbook

%packages
@^minimal-environment
@headless-management
@guest-agents
@standard
@system-tools

%end

eula --agreed

# Keyboard layouts
keyboard --xlayouts='gb'
# System language
lang en_GB.UTF-8

# Network information for DHCP
network --bootproto=dhcp --device=enp1s0 --noipv6 --activate

nfs --server=192.168.1.3 --dir=/srv/shares/install_media/almalinux-9  --opts=ro,auto,soft,intr

ignoredisk --only-use=vda

clearpart --none --initlabel

partition /boot --size=1024 --fstype=xfs --ondisk=vda
partition /boot/efi --size=200 --fstype=vfat --ondisk=vda
partition pv.1 --size=1024 --grow --ondisk=vda

volgroup vg_fenchurch pv.1
logvol swap --recommended --vgname=vg_fenchurch --name=swap
logvol / --vgname=vg_fenchurch --name=root --fstype=xfs --size=1024 --grow

bootloader

# System timezone
timezone Europe/London --utc
timesource --ntp-server ntp.REDACTED.com

# Root password
rootpw --iscrypted REDACTED

# Groups
group --name=steve --gid=1000
group --name=ansible --gid=800

# Users
user --name=steve --password=REDACTED --iscrypted --uid 1000 --gid 1000 --groups=wheel --gecos="Steve Hayes"
user --name=ansible --uid 800 --gid 800 --gecos="Ansible Service Account"

# automatically reboot
reboot

%addon com_redhat_kdump --disable --reserve-mb='auto'

%end

%post

# set ssh keys
/bin/mkdir /home/steve/.ssh
/bin/chmod 700 /home/steve/.ssh
/bin/echo -e 'ssh-rsa REDACTED' >> /home/steve/.ssh/authorized_keys
![Screenshot_agrajag_2023-10-12_18:52:39](https://github.com/AlmaLinux/almalinux-deploy/assets/53232196/ae16cdf9-8454-4b54-a436-f763300bb6c7)

/bin/chmod 600 /home/steve/.ssh/authorized_keys
/bin/chown -R steve:steve /home/steve/.ssh
/bin/mkdir /home/ansible/.ssh
/bin/chmod 700 /home/ansible/.ssh
/bin/echo -e 'ssh-rsa REDACTED'  >> /home/ansible/.ssh/authorized_keys
/bin/chmod 600 /home/ansible/.ssh/authorized_keys
/bin/chown -R ansible:ansible /home/ansible/.ssh

# sudoers_entry for ansible user
/bin/echo "%ansible ALL=(ALL) NOPASSWD: ALL" >> /etc/sudoers.d/ansible-nopasswd
/bin/chmod 440 /etc/sudoers.d/ansible-nopasswd
/bin/chmod root:root /etc/sudoers.d/ansible-nopasswd

%end

Final screen from /dev/tty4 as processed (mangled) by tesseract and manually corrected as far as I can:

DEBUG NetworkManager:<debug> [1697131597.3930] platform: (enp1s0) signal: address 6 removed: fe80::5054:ff:fe01:7e00/64 lft forever pref forever lifetime 10-0[4294967295,4294967295] dev 2 flags permanent ,noprefixroute src kernel
DEBUG NetworkManager:<debug> [1697131597.9930] l3cfg[f8da0cf05cdbce1d, if index=2]: obj-state: zombie gone (untrack): [04075d756b87d07f, ip6-address, fe80::5054:ff:fe01:7e00/64 lft forever pref forever lifetime 10-0[0,0] dev 2 src ipv6ll], nm-configured, was-in-platform
DEBUG NetworkManager:<debug> [1697131597.9931] l3cfg[f8da0f05cdbce1d, if index-2]: obj-state: zombie pruned during reapply: [a7603b192df6eaf1, ip4-route, type unicast 192.168.1.0/24 dev 2 metric 100 mss 0 rt-src rt-kernel scope link pref-src 192.168.1.126],zombie[4], nm-configured, in-platform
DEBUG NetworkManager:<debug> [1697131597.9931] l3cfg[f8da0cf05cdbce1d, if index-2]: obj-state: zombie pruned during reapply: [5d233ed6cc4dbc66, ip4-route, type unicast 0.0.0.0/0 via 192.168.1.1 dev 2 metric 100 mss 0 rt-src dhcp pref-src 192.168.1.126], zombie[4], nm-configured, in-platform
DEBUG NetworkManager:<debug> [1697131597.9931] l3cfg[f8da0cf05cdbce1d, if index=2]: obj-state: zombie pruned during reapply: [0f042e168cd253c7, ip4-address, 192.168.1.126/24 brd* 192.168.1.255 lft 3591sec pref 3591sec lifetime 18-1[3600,3600] dev 2 src dhcp], zombie[4], nm-configured, in-platform
DEBUG NetworkManager:<debug> [1697131597.9931] platform: (enp1s0) address: deleting IPv4 address 192.168.1.126/24,  dev 2
DEBUG NetworkManager:<debug> [1697131597.9931] platform: (enp1s0) signal: address 4 removed: 192.168.1.126/24 brd 192.168.1.255 lft 3591sec pref 3591sec lifetime 10-1[3680,3600] dev 2 flags noprefixroute src kernel
DEBUG NetworkManager:<debug> [1697131597.9931] l3cfg[f8da0cf05cdbce1d, if index=2]: obj-state: zombie gone (untrack): [0f042e168cd253c7, ip4-address, 192.168.1.126/24 brd* 192.168.1.255 lft 3591sec pref 3591sec lifetime 10-1[3600,3600] dev 2 src dhcp], nm-configured, was-in-platform
DEBUG NetworkManager:<debug> [1697131597.9931] platform: (enp1s0) signal: route    4 removed: type local table 255 192.168.1.126/32 dev 2 metric 0 mss 0 rt-src rt-kernel scope host pref-src 192.168.1.126
DEBUG NetworkManager:<debug> [1697131597.9932] platform: (enp1s0) signal: route    4 removed: type unicast 0.0.0.0/0 via 192.168.1.1 dev 2 metric 100 mss @ rt-src rt-dhcp scope global pref-src 192.168.1.126
DEBUG NetworkManager:<debug> [1697131597.9932] l3cfg[f8da0cf05cdbce1d, if index=2]: obj-state: zombie gone (untrack): [5d233ed6cc4dbc66, ip4-route, type unicast 0.0.0.0/0 via 192.168.1.1 dev 2 metric 100 mss 0 rt-src dhcp pref-sre 192.168.1.126], nm-configured, was-in-platform
DEBUG NetworkManager:<debug> [1697131597.9932] platform: (enp1s0) signal: route    4 removed: type unicast 192.168.1.0/24 dev 2 metric 100 mss 0 rt-src rt-kernel scope link pref-src 192.168.1.126
DEBUG NetworkManager:<debug> [1697131597.9932] l3cfg[f8da0cf05cdbce1d, if index=2]: obj-state: zombie gone (untrack): [a763b192df6eaf1, ip4-route, type unicast 192.168.1.0/24 dev 2 metric 100 mss 0 rt-src rt-kernel scope link pref-src 192.168.1.126], nm-configured, was-in-platform
DEBUG NetworkManager:<debug> [1697131597 9932] platform-linux: do-delete-ip4-address[2: 192.168.1.126/24]: success
DEBUG NetworkManager:<debug> [1697131597.9932] global-tracker: sync ip4-route
DEBUG NetworkManager:<debug> [1697131597.9932] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf /enp1s0/use_tempaddr' to '0' (current value is identical)
DEBUG NetworkManager:<debug> [1697131597.9932] global-tracker: sync ip6-route
DEBUG NetworkManager:<debug> [1697131597.9932] global-tracker: sync mptcp-addr (reapply)
DEBUG NetworkManager:<debug> [1697131597.9933] global-tracker: sync routing-rule
DEBUG NetworkManager:<debug> [1697131597.9933] device[4e8776fec9c7d826] (enp1s0): set metered value 0
DEBUG NetworkManager:<debug> [1697131597.9934] manager: new metered value: 0
DEBUG NetworkManager:<debug> [1697131597.9945] active-connection[3f9dcecZ1192b449]: set state deactivated (was deactivating)
INFO NetworkManager:<info> [1697131597.99491 manager: NetworkManager state is now DISCONNECTED
WARNING org.fedoraproject.Anaconda.Modules.Network : DEBUG :anaconda modules network .network:NeworkManager state changed to <enum NM_STATE_DISCONNECTED of type NM.State>
WARNING org.fedoraproject.Anaconda.Modules Network:DEBUG:anaconda modules network .network:Connected to network: False
INFO systemd:systemd-hostnamed.service: Deactivated successfully.

Original screenshot:

[tsgsh]

I managed to get Anaconda logs as described in https://fedoraproject.org/wiki/Anaconda/Logging. Logs attached below: what seems to happen is that NetworkManager seems to want to activate enp1s0 and to do so, it deactivates it first!

22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1147] device[e159282a864db490] (enp1s0): queue activation request waiting for currently active connection to disconnect

Full logs

22:41:30,919 INFO anaconda:program: Running... systemctl restart rsyslog
22:41:30,926 INFO systemd:Stopping System Logging Service...
22:41:31,235 INFO rsyslogd:[origin software="rsyslogd" swVersion="8.2102.0-111.el9" x-pid="1748" x-info="https://www.rsyslog.com"] exiting on signal 15.
22:41:31,237 INFO systemd:rsyslog.service: Deactivated successfully.
22:41:31,237 INFO systemd:Stopped System Logging Service.
22:41:31,237 INFO systemd:Starting System Logging Service...
22:41:31,240 ERR rsyslogd:imfile: on startup file '/tmp/X.log' does not exist but is configured in static file monitor - this may indicate a misconfiguration. If the file appears at a later time, it will automatically be processed. Reason: No such file or directory [v8.2102.0-111.el9]
22:41:31,240 INFO systemd:Started System Logging Service.
22:41:31,240 ERR rsyslogd:imfile: on startup file '/tmp/anaconda-tb-all.log' does not exist but is configured in static file monitor - this may indicate a misconfiguration. If the file appears at a later time, it will automatically be processed. Reason: No such file or directory [v8.2102.0-111.el9]
22:41:31,240 INFO rsyslogd:[origin software="rsyslogd" swVersion="8.2102.0-111.el9" x-pid="1864" x-info="https://www.rsyslog.com"] start
22:41:31,241 NOTICE rsyslogd:imjournal: journal files changed, reloading...  [v8.2102.0-111.el9 try https://www.rsyslog.com/e/0 ]
22:41:31,247 DEBUG anaconda:program: Return code: 0
22:41:31,247 INFO anaconda:anaconda: core.configuration.product: Loading information about products from /etc/anaconda/product.d.
22:41:31,249 INFO anaconda:anaconda: core.configuration.product: Found AlmaLinux at /etc/anaconda/product.d/almalinux.conf.
22:41:31,249 INFO anaconda:anaconda: core.configuration.product: Found Fedora-IoT IoT at /etc/anaconda/product.d/fedora-iot.conf.
22:41:31,249 INFO anaconda:anaconda: core.configuration.product: Found Circle Linux at /etc/anaconda/product.d/circle.conf.
22:41:31,250 INFO anaconda:anaconda: core.configuration.product: Found Rocky Linux at /etc/anaconda/product.d/rocky.conf.
22:41:31,250 INFO anaconda:anaconda: core.configuration.product: Found Fedora Server at /etc/anaconda/product.d/fedora-server.conf.
22:41:31,250 INFO anaconda:anaconda: core.configuration.product: Found Fedora-ELN at /etc/anaconda/product.d/fedora-eln.conf.
22:41:31,250 INFO anaconda:anaconda: core.configuration.product: Found Fedora Silverblue at /etc/anaconda/product.d/fedora-silverblue.conf.
22:41:31,251 INFO anaconda:anaconda: core.configuration.product: Found Virtuozzo Linux at /etc/anaconda/product.d/virtuozzo-linux.conf.
22:41:31,251 INFO anaconda:anaconda: core.configuration.product: Found Fedora at /etc/anaconda/product.d/fedora.conf.
22:41:31,251 INFO anaconda:anaconda: core.configuration.product: Found CentOS Stream at /etc/anaconda/product.d/centos-stream.conf.
22:41:31,252 INFO anaconda:anaconda: core.configuration.product: Found Scientific Linux at /etc/anaconda/product.d/scientific-linux.conf.
22:41:31,252 INFO anaconda:anaconda: core.configuration.product: Found RHVH at /etc/anaconda/product.d/rhvh.conf.
22:41:31,252 INFO anaconda:anaconda: core.configuration.product: Found Red Hat Enterprise Linux at /etc/anaconda/product.d/rhel.conf.
22:41:31,253 INFO anaconda:anaconda: core.configuration.product: Found oVirt Node Next at /etc/anaconda/product.d/ovirt.conf.
22:41:31,253 INFO anaconda:anaconda: core.configuration.product: Found Fedora Workstation Live at /etc/anaconda/product.d/fedora-workstation-live.conf.
22:41:31,253 INFO anaconda:anaconda: core.configuration.product: Found Fedora Workstation at /etc/anaconda/product.d/fedora-workstation.conf.
22:41:31,254 INFO anaconda:anaconda: core.configuration.product: Found CentOS Linux at /etc/anaconda/product.d/centos.conf.
22:41:31,254 WARNING anaconda:anaconda: core.configuration.product: No support for the product AlmaLinux BaseOS.
22:41:31,254 INFO anaconda:anaconda: core.configuration.product: The product AlmaLinux is supported.
22:41:31,257 INFO anaconda:anaconda: main: /sbin/anaconda 34.25.2.10-1.el9_2.alma
22:41:31,269 INFO anaconda:anaconda: core.util: Reporting the IPMI event: 7
22:41:31,281 WARNING anaconda:anaconda: misc: /usr/lib64/python3.9/site-packages/dbus/connection.py:337: DeprecationWarning: invalid escape sequence \ #012  """Arrange for the given function to be called when a signal matching
22:41:31,284 WARNING anaconda:anaconda: misc: /usr/lib64/python3.9/site-packages/dbus/proxies.py:307: DeprecationWarning: invalid escape sequence \ #012  """Arrange for the given function to be called when the given signal
22:41:32,089 INFO anaconda:anaconda: isys: 1099920 kB (1074 MB) are available
22:41:32,090 INFO anaconda:program: Running... losetup --list
22:41:32,090 WARNING anaconda:anaconda: misc: /usr/lib64/python3.9/subprocess.py:941: RuntimeWarning: line buffering (buffering=1) isn't supported in binary mode, the default buffer size will be used#012  self.stdout = io.open(c2pread, 'rb', bufsize)
22:41:32,094 INFO anaconda:anaconda: startup_utils: check_memory(): total:1074, needed:320, graphical:410
22:41:32,095 DEBUG anaconda:anaconda: startup_utils: Don't set up proxy variables.
22:41:32,095 INFO anaconda:program: Running... /sbin/auditd
22:41:32,097 DEBUG anaconda:program: Return code: 0
22:41:32,098 INFO anaconda:anaconda: main: anaconda called with cmdline = ['/sbin/anaconda']
22:41:32,098 INFO anaconda:anaconda: main: Default encoding = utf-8 
22:41:32,098 INFO anaconda:anaconda: misc: Writing a temporary configuration loaded from: ['/etc/anaconda/anaconda.conf', '/etc/anaconda/product.d/rhel.conf', '/etc/anaconda/product.d/almalinux.conf', '/etc/anaconda/conf.d/00-do-nothing.conf', '/etc/anaconda/conf.d/01-still-do-nothing.conf']
22:41:32,098 INFO anaconda:program: Running... dbus-daemon --print-address --syslog --config-file=/usr/share/anaconda/dbus/anaconda-bus.conf
22:41:32,111 INFO anaconda:anaconda: core.dbus: Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:32,113 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Boss' requested by ':1.0' (uid=0 pid=1838 comm="/usr/bin/python3 /sbin/anaconda " label="system_u:system_r:kernel_t:s0")
22:41:32,195 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:32,273 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:32,273 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Boss/UserInterface.
22:41:32,273 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:32,275 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Boss.
22:41:32,275 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Boss.
22:41:32,276 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Boss'
22:41:32,277 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:32,278 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Boss/Task/1.
22:41:32,279 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.threading:Running Thread: AnaTaskThread-StartModulesTask-1 (139932942464576)
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Found org.fedoraproject.Anaconda.Modules.Services.
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Found org.fedoraproject.Anaconda.Modules.Security.
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Found org.fedoraproject.Anaconda.Modules.Users.
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Found org.fedoraproject.Anaconda.Modules.Payloads.
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Found org.fedoraproject.Anaconda.Modules.Storage.
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Found org.fedoraproject.Anaconda.Modules.Localization.
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Found org.fedoraproject.Anaconda.Modules.Timezone.
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Found org.fedoraproject.Anaconda.Modules.Network.
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Found org.fedoraproject.Anaconda.Addons.OSCAP.
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Found org.fedoraproject.Anaconda.Addons.Kdump.
22:41:32,280 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Skip org.fedoraproject.Anaconda.Modules.Subscription. The module won't be started, because it's marked as forbidden in the Anaconda configuration files.
22:41:32,281 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Starting org.fedoraproject.Anaconda.Modules.Services.
22:41:32,281 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Modules.Services' requested by ':1.1' (uid=0 pid=1877 comm="python3 -m pyanaconda.modules.boss " label="system_u:system_r:kernel_t:s0")
22:41:32,281 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Starting org.fedoraproject.Anaconda.Modules.Security.
22:41:32,281 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Modules.Security' requested by ':1.1' (uid=0 pid=1877 comm="python3 -m pyanaconda.modules.boss " label="system_u:system_r:kernel_t:s0")
22:41:32,282 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Starting org.fedoraproject.Anaconda.Modules.Users.
22:41:32,282 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Modules.Users' requested by ':1.1' (uid=0 pid=1877 comm="python3 -m pyanaconda.modules.boss " label="system_u:system_r:kernel_t:s0")
22:41:32,282 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Starting org.fedoraproject.Anaconda.Modules.Payloads.
22:41:32,283 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Modules.Payloads' requested by ':1.1' (uid=0 pid=1877 comm="python3 -m pyanaconda.modules.boss " label="system_u:system_r:kernel_t:s0")
22:41:32,283 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Starting org.fedoraproject.Anaconda.Modules.Storage.
22:41:32,283 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Modules.Storage' requested by ':1.1' (uid=0 pid=1877 comm="python3 -m pyanaconda.modules.boss " label="system_u:system_r:kernel_t:s0")
22:41:32,284 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Starting org.fedoraproject.Anaconda.Modules.Localization.
22:41:32,284 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Modules.Localization' requested by ':1.1' (uid=0 pid=1877 comm="python3 -m pyanaconda.modules.boss " label="system_u:system_r:kernel_t:s0")
22:41:32,285 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Starting org.fedoraproject.Anaconda.Modules.Timezone.
22:41:32,285 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Modules.Timezone' requested by ':1.1' (uid=0 pid=1877 comm="python3 -m pyanaconda.modules.boss " label="system_u:system_r:kernel_t:s0")
22:41:32,285 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Starting org.fedoraproject.Anaconda.Modules.Network.
22:41:32,286 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Modules.Network' requested by ':1.1' (uid=0 pid=1877 comm="python3 -m pyanaconda.modules.boss " label="system_u:system_r:kernel_t:s0")
22:41:32,286 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Starting org.fedoraproject.Anaconda.Addons.OSCAP.
22:41:32,286 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Addons.OSCAP' requested by ':1.1' (uid=0 pid=1877 comm="python3 -m pyanaconda.modules.boss " label="system_u:system_r:kernel_t:s0")
22:41:32,287 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Starting org.fedoraproject.Anaconda.Addons.Kdump.
22:41:32,287 INFO dbus-daemon:Activating service name='org.fedoraproject.Anaconda.Addons.Kdump' requested by ':1.1' (uid=0 pid=1877 comm="python3 -m pyanaconda.modules.boss " label="system_u:system_r:kernel_t:s0")
22:41:33,187 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:33,203 WARNING org.fedoraproject.Anaconda.Modules.Services:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:33,216 WARNING org.fedoraproject.Anaconda.Modules.Security:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:33,217 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:33,221 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:33,229 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:33,231 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:33,238 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:33,244 WARNING org.fedoraproject.Anaconda.Modules.Localization:INFO:root:reading file=<gzip _io.BufferedReader name='/usr/lib/python3.9/site-packages/langtable/data/territories.xml.gz' 0x7ff4db30c3a0>
22:41:33,271 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:33,272 WARNING org.fedoraproject.Anaconda.Addons.OSCAP:DEBUG:anaconda.modules.common:The configuration is loaded from: ['/run/anaconda/anaconda.conf']
22:41:33,428 DEBUG NetworkManager:<debug> [1697323293.4286] ndisc[0x555c976ec160,"enp1s0"]: solicit: schedule sending next solicitation in 7.735 seconds
22:41:33,474 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class DeviceFormat as None
22:41:33,617 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class BIOSBoot as biosboot
22:41:33,699 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class DiskLabel as disklabel
22:41:33,701 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class DMRaidMember as dmraidmember
22:41:33,776 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running [1] mkdosfs --help ...
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:stdout[1]: mkfs.fat 4.2 (2021-01-31)
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:stderr[1]: Usage: mkdosfs [OPTIONS] TARGET [BLOCKS]
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:Create FAT filesystem in TARGET, which can be a block device or file. Use only
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:up to BLOCKS 1024 byte blocks if specified. With the -C option, file TARGET will be
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:created with a size of 1024 bytes times BLOCKS, which must be specified.
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:Options:
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -a              Disable alignment of data structures
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -A              Toggle Atari variant of the filesystem
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -b SECTOR       Select SECTOR as location of the FAT32 backup boot sector
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -c              Check device for bad blocks before creating the filesystem
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -C              Create file TARGET then create filesystem in it
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -D NUMBER       Write BIOS drive number NUMBER to boot sector
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -f COUNT        Create COUNT file allocation tables
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -F SIZE         Select FAT size SIZE (12, 16 or 32)
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -g GEOM         Select disk geometry: heads/sectors_per_track
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -h NUMBER       Write hidden sectors NUMBER to boot sector
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -i VOLID        Set volume ID to VOLID (a 32 bit hexadecimal number)
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -I              Ignore and disable safety checks
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -l FILENAME     Read bad blocks list from FILENAME
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -m FILENAME     Replace default error message in boot block with contents of FILENAME
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -M TYPE         Set media type in boot sector to TYPE
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  --mbr[=y|n|a]   Fill (fake) MBR table with one partition which spans whole disk
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -n LABEL        Set volume name to LABEL (up to 11 characters long)
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  --codepage=N    use DOS codepage N to encode label (default: 850)
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -r COUNT        Make room for at least COUNT entries in the root directory
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -R COUNT        Set minimal number of reserved sectors to COUNT
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -s COUNT        Set number of sectors per cluster to COUNT
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -S SIZE         Select a sector size of SIZE (a power of two, at least 512)
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  -v              Verbose execution
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  --variant=TYPE  Select variant TYPE of filesystem (standard or Atari)
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  --invariant     Use constants for randomly generated or time based values
22:41:33,805 WARNING org.fedoraproject.Anaconda.Modules.Storage:  --offset=SECTOR Write the filesystem at a specific sector into the device file.
22:41:33,806 WARNING org.fedoraproject.Anaconda.Modules.Storage:  --help          Show this help message and exit
22:41:33,806 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:...done [1] (exit code: 0)
22:41:33,943 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class Ext2FS as ext2
22:41:33,944 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class Ext3FS as ext3
22:41:33,946 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class Ext4FS as ext4
22:41:33,946 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class FATFS as vfat
22:41:33,947 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class EFIFS as efi
22:41:33,947 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class BTRFS as btrfs
22:41:33,951 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class GFS2 as gfs2
22:41:33,951 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class JFS as jfs
22:41:33,953 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class ReiserFS as reiserfs
22:41:33,957 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class XFS as xfs
22:41:33,957 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class StratisXFS as stratis xfs
22:41:33,960 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class HFS as hfs
22:41:33,960 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class AppleBootstrapFS as appleboot
22:41:33,961 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class HFSPlus as hfs+
22:41:33,961 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class MacEFIFS as macefi
22:41:33,966 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class NTFS as ntfs
22:41:33,967 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class ExFATFS as exfat
22:41:33,968 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class F2FS as f2fs
22:41:33,968 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class NFS as nfs
22:41:33,968 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class NFSv4 as nfs4
22:41:33,969 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class Iso9660FS as iso9660
22:41:33,970 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class NoDevFS as nodev
22:41:33,970 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class DevPtsFS as devpts
22:41:33,970 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class ProcFS as proc
22:41:33,971 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class SysFS as sysfs
22:41:33,971 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class TmpFS as tmpfs
22:41:33,975 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class BindFS as bind
22:41:33,976 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class SELinuxFS as selinuxfs
22:41:33,976 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class USBFS as usbfs
22:41:33,976 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class EFIVarFS as efivarfs
22:41:34,084 WARNING org.fedoraproject.Anaconda.Modules.Timezone:INFO:root:reading file=<gzip _io.BufferedReader name='/usr/lib/python3.9/site-packages/langtable/data/territories.xml.gz' 0x7fe4a6f33790>
22:41:34,223 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:34,229 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Payloads.
22:41:34,232 WARNING org.fedoraproject.Anaconda.Modules.Payloads:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:34,242 WARNING org.fedoraproject.Anaconda.Modules.Services:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:34,244 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Modules.Payloads.
22:41:34,252 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Modules.Payloads'
22:41:34,253 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Service org.fedoraproject.Anaconda.Modules.Payloads started successfully.
22:41:34,253 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:org.fedoraproject.Anaconda.Modules.Payloads is available.
22:41:34,255 WARNING org.fedoraproject.Anaconda.Modules.Services:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Services.
22:41:34,255 WARNING org.fedoraproject.Anaconda.Modules.Services:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:34,259 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:34,266 WARNING org.fedoraproject.Anaconda.Modules.Services:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Modules.Services.
22:41:34,274 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Modules.Services'
22:41:34,274 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Service org.fedoraproject.Anaconda.Modules.Services started successfully.
22:41:34,275 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:org.fedoraproject.Anaconda.Modules.Services is available.
22:41:34,281 WARNING org.fedoraproject.Anaconda.Modules.Services:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:34,294 WARNING org.fedoraproject.Anaconda.Modules.Security:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:34,302 WARNING org.fedoraproject.Anaconda.Modules.Security:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Security.
22:41:34,302 WARNING org.fedoraproject.Anaconda.Modules.Security:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:34,311 WARNING org.fedoraproject.Anaconda.Modules.Security:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Modules.Security.
22:41:34,318 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Modules.Security'
22:41:34,318 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Service org.fedoraproject.Anaconda.Modules.Security started successfully.
22:41:34,319 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:org.fedoraproject.Anaconda.Modules.Security is available.
22:41:34,325 WARNING org.fedoraproject.Anaconda.Modules.Security:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:34,424 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:34,427 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Users.
22:41:34,432 WARNING org.fedoraproject.Anaconda.Modules.Users:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:34,443 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Modules.Users.
22:41:34,445 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Modules.Users'
22:41:34,445 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Service org.fedoraproject.Anaconda.Modules.Users started successfully.
22:41:34,446 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:org.fedoraproject.Anaconda.Modules.Users is available.
22:41:34,448 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:34,472 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running [2] lvm version ...
22:41:34,573 WARNING org.fedoraproject.Anaconda.Modules.Network:INFO:dasbus.connection:Connecting to the system bus.
22:41:34,573 WARNING org.fedoraproject.Anaconda.Modules.Network:INFO:dasbus.connection:Connecting to the system bus.
22:41:34,647 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:stdout[2]:   LVM version:     2.03.17(2) (2022-11-10)
22:41:34,647 WARNING org.fedoraproject.Anaconda.Modules.Storage:  Library version: 1.02.187 (2022-11-10)
22:41:34,647 WARNING org.fedoraproject.Anaconda.Modules.Storage:  Driver version:  4.47.0
22:41:34,647 WARNING org.fedoraproject.Anaconda.Modules.Storage:  Configuration:   ./configure --build=x86_64-redhat-linux-gnu --host=x86_64-redhat-linux-gnu --program-prefix= --disable-dependency-tracking --prefix=/usr --exec-prefix=/usr --bindir=/usr/bin --sbindir=/usr/sbin --sysconfdir=/etc --datadir=/usr/share --includedir=/usr/include --libdir=/usr/lib64 --libexecdir=/usr/libexec --localstatedir=/var --sharedstatedir=/var/lib --mandir=/usr/share/man --infodir=/usr/share/info --with-default-dm-run-dir=/run --with-default-run-dir=/run/lvm --with-default-pid-dir=/run --with-default-locking-dir=/run/lock/lvm --with-usrlibdir=/usr/lib64 --enable-fsadm --enable-write_install --with-user= --with-group= --with-device-uid=0 --with-device-gid=6 --with-device-mode=0660 --enable-pkgconfig --enable-cmdlib --enable-dmeventd --enable-blkid_wiping --with-cluster=internal --with-udevdir=/usr/lib/udev/rules.d --enable-udev_sync --with-thin=internal --with-cache=internal --enable-lvmpolld --enable-lvmlockd-dlm --enable-lvmlockd-dlmcontrol --enable-lvmlockd-sanlock --enable-dbus-service --enable-notify-dbus --enable-dmfilemapd --with-writecache=internal --with-vdo=internal --with-vdo-format=/usr/bin/vdoformat --with-integrity=internal --with-default-use-devices-file=1 --disable-silent-rules --enable-app-machineid --enable-editline --disable-readline
22:41:34,649 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:stderr[2]:
22:41:34,650 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:...done [2] (exit code: 0)
22:41:34,660 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.nm_client:get new NM Client succeeded.
22:41:34,660 WARNING org.fedoraproject.Anaconda.Addons.OSCAP:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:34,660 WARNING org.fedoraproject.Anaconda.Addons.OSCAP:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Addons/OSCAP.
22:41:34,661 WARNING org.fedoraproject.Anaconda.Addons.OSCAP:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:34,661 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:Connected to network: True
22:41:34,661 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:Applying boot options <pyanaconda.core.kernel.KernelArguments object at 0x7fc624e049d0>
22:41:34,661 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:34,663 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Network/Firewall.
22:41:34,664 WARNING org.fedoraproject.Anaconda.Modules.Network:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:34,666 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Network.
22:41:34,668 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Modules.Network.
22:41:34,669 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Modules.Network'
22:41:34,670 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Service org.fedoraproject.Anaconda.Modules.Network started successfully.
22:41:34,670 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:org.fedoraproject.Anaconda.Modules.Network is available.
22:41:34,671 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:34,675 WARNING org.fedoraproject.Anaconda.Addons.OSCAP:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Addons.OSCAP.
22:41:34,678 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Addons.OSCAP'
22:41:34,678 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Service org.fedoraproject.Anaconda.Addons.OSCAP started successfully.
22:41:34,679 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:org.fedoraproject.Anaconda.Addons.OSCAP is available.
22:41:34,680 WARNING org.fedoraproject.Anaconda.Addons.OSCAP:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:34,680 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:Connecting to the hostnamed service.
22:41:34,786 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class LUKS as luks
22:41:34,787 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class Integrity as integrity
22:41:34,802 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class LVMPhysicalVolume as lvmpv
22:41:34,804 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class MDRaidMember as mdmember
22:41:34,806 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class MultipathMember as multipath_member
22:41:34,809 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class PPCPRePBoot as prepboot
22:41:34,815 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class SwapSpace as swap
22:41:34,817 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:registered device format class StratisBlockdev as stratis
22:41:34,851 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... udevadm trigger --action=change --subsystem-match=block
22:41:34,904 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0
22:41:34,904 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... udevadm settle --timeout=300
22:41:34,956 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0
22:41:35,192 WARNING org.fedoraproject.Anaconda.Modules.Localization:INFO:root:reading file=<gzip _io.BufferedReader name='/usr/lib/python3.9/site-packages/langtable/data/languages.xml.gz' 0x7ff4db30c400>
22:41:35,343 INFO systemd:Starting Disk Manager...
22:41:35,391 NOTICE journal:udisks daemon version 2.9.4 starting
22:41:35,413 INFO systemd:Starting Authorization Manager...
22:41:35,611 WARNING org.fedoraproject.Anaconda.Modules.Timezone:INFO:root:reading file=<gzip _io.BufferedReader name='/usr/lib/python3.9/site-packages/langtable/data/languages.xml.gz' 0x7fe4a588d1f0>
22:41:35,612 INFO polkitd:Started polkitd version 0.117
22:41:35,863 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:35,864 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Addons/Kdump.
22:41:35,864 WARNING org.fedoraproject.Anaconda.Addons.Kdump:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:35,871 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Addons.Kdump.
22:41:35,872 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Addons.Kdump'
22:41:35,876 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Service org.fedoraproject.Anaconda.Addons.Kdump started successfully.
22:41:35,876 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:org.fedoraproject.Anaconda.Addons.Kdump is available.
22:41:35,877 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:36,047 NOTICE polkitd:Loading rules from directory /etc/polkit-1/rules.d
22:41:36,047 NOTICE polkitd:Loading rules from directory /usr/share/polkit-1/rules.d
22:41:36,052 NOTICE polkitd:Finished loading, compiling and executing 4 rules
22:41:36,052 INFO systemd:Started Authorization Manager.
22:41:36,053 NOTICE polkitd:Acquired the name org.freedesktop.PolicyKit1 on the system bus
22:41:36,154 INFO systemd:Started Disk Manager.
22:41:36,155 NOTICE journal:Acquired the name org.freedesktop.UDisks2 on the system message bus
22:41:36,176 NOTICE journal:Loading module iscsi ...
22:41:36,214 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:blivet:failed to get initiator name from iscsi firmware: Failed to call GetFirmwareInitiatorName method on /org/freedesktop/UDisks2/Manager with None arguments: GDBus.Error:org.freedesktop.UDisks2.Error.ISCSI.NoFirmware: No firmware found
22:41:36,317 WARNING org.fedoraproject.Anaconda.Modules.Localization:INFO:root:reading file=<gzip _io.BufferedReader name='/usr/lib/python3.9/site-packages/langtable/data/keyboards.xml.gz' 0x7ff4dad3bee0>
22:41:36,333 WARNING org.fedoraproject.Anaconda.Modules.Localization:INFO:root:reading file=<gzip _io.BufferedReader name='/usr/lib/python3.9/site-packages/langtable/data/timezones.xml.gz' 0x7ff4dad3bcd0>
22:41:36,341 WARNING org.fedoraproject.Anaconda.Modules.Localization:INFO:root:reading file=<gzip _io.BufferedReader name='/usr/lib/python3.9/site-packages/langtable/data/timezoneidparts.xml.gz' 0x7ff4dad3bc40>
22:41:36,557 WARNING org.fedoraproject.Anaconda.Modules.Timezone:INFO:root:reading file=<gzip _io.BufferedReader name='/usr/lib/python3.9/site-packages/langtable/data/keyboards.xml.gz' 0x7fe4a51ea640>
22:41:36,575 WARNING org.fedoraproject.Anaconda.Modules.Timezone:INFO:root:reading file=<gzip _io.BufferedReader name='/usr/lib/python3.9/site-packages/langtable/data/timezones.xml.gz' 0x7fe4a51ea3a0>
22:41:36,576 WARNING org.fedoraproject.Anaconda.Modules.Timezone:INFO:root:reading file=<gzip _io.BufferedReader name='/usr/lib/python3.9/site-packages/langtable/data/timezoneidparts.xml.gz' 0x7fe4a51ea3d0>
22:41:36,710 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.bootloader.bootloader:The default type is set to 'BootloaderType.DEFAULT'.
22:41:36,714 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.fcoe.fcoe:Start up the FCoE module.
22:41:36,714 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... modprobe libfc
22:41:36,831 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0
22:41:36,832 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... /usr/libexec/fcoe/fcoe_edd.sh -i
22:41:36,956 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:stdout:
22:41:36,956 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:No FCoE boot disk information is found in EDD!
22:41:36,956 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 1
22:41:36,956 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:blivet:No FCoE EDD info found: No FCoE boot disk information is found in EDD!
22:41:36,956 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.iscsi.iscsi:Start up the iSCSI module.
22:41:36,957 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:blivet:ISCSID is /sbin/iscsid
22:41:36,957 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... systemctl start iscsi-init.service
22:41:36,984 INFO systemd:Starting One time configuration for iscsi.service...
22:41:37,011 INFO systemd:iscsi-init.service: Deactivated successfully.
22:41:37,011 INFO systemd:Finished One time configuration for iscsi.service.
22:41:37,013 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0
22:41:37,013 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:blivet:no initiator set
22:41:37,013 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.zfcp.zfcp:Start up the zFCP module.
22:41:37,014 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running [3] e2fsck -V ...
22:41:37,039 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:stdout[3]:
22:41:37,039 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:stderr[3]: e2fsck 1.46.5 (30-Dec-2021)
22:41:37,039 WARNING org.fedoraproject.Anaconda.Modules.Storage:#011Using EXT2FS Library version 1.46.5, 30-Dec-2021
22:41:37,039 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:...done [3] (exit code: 0)
22:41:37,108 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:               Ext4FS.supported: supported: True ;
22:41:37,110 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:get_format('ext4') returning Ext4FS instance with object id 0
22:41:37,112 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:            Ext4FS.supported: supported: True ;
22:41:37,112 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:trying to set new default fstype to 'ext4'
22:41:37,114 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                  Ext4FS.supported: supported: True ;
22:41:37,114 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:get_format('ext4') returning Ext4FS instance with object id 1
22:41:37,115 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:               Ext4FS.supported: supported: True ;
22:41:37,115 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... lsblk --bytes -a -o NAME,SIZE,OWNER,GROUP,MODE,FSTYPE,LABEL,UUID,PARTUUID,MOUNTPOINT
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:stdout:
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:NAME               SIZE OWNER GROUP MODE       FSTYPE          LABEL    UUID                                 PARTUUID MOUNTPOINT
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:loop0         776011776 root  disk  brw-rw---- squashfs
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:loop1        3221225472 root  disk  brw-rw---- ext4            Anaconda d74c798c-87ad-4ae3-8410-302272394520
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:|-live-rw    3221225472 root  disk  brw-rw---- ext4            Anaconda d74c798c-87ad-4ae3-8410-302272394520          /
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:`-live-base  3221225472 root  disk  brw-rw---- ext4            Anaconda d74c798c-87ad-4ae3-8410-302272394520
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:loop2       34359738368 root  disk  brw-rw---- DM_snapshot_cow
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:`-live-rw    3221225472 root  disk  brw-rw---- ext4            Anaconda d74c798c-87ad-4ae3-8410-302272394520          /
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:zram0        2065694720 root  disk  brw-rw----                                                                        [SWAP]
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:vda         16106127360 root  disk  brw-rw----
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:lsblk output:
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:NAME               SIZE OWNER GROUP MODE       FSTYPE          LABEL    UUID                                 PARTUUID MOUNTPOINT
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:loop0         776011776 root  disk  brw-rw---- squashfs
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:loop1        3221225472 root  disk  brw-rw---- ext4            Anaconda d74c798c-87ad-4ae3-8410-302272394520
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:|-live-rw    3221225472 root  disk  brw-rw---- ext4            Anaconda d74c798c-87ad-4ae3-8410-302272394520          /
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:`-live-base  3221225472 root  disk  brw-rw---- ext4            Anaconda d74c798c-87ad-4ae3-8410-302272394520
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:loop2       34359738368 root  disk  brw-rw---- DM_snapshot_cow
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:`-live-rw    3221225472 root  disk  brw-rw---- ext4            Anaconda d74c798c-87ad-4ae3-8410-302272394520          /
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:zram0        2065694720 root  disk  brw-rw----                                                                        [SWAP]
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:vda         16106127360 root  disk  brw-rw----
22:41:37,148 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:lvm filter: clearing the lvm devices list
22:41:37,149 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:lvm filter: clearing the lvm devices list
22:41:37,149 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:trying to set new default fstype to 'xfs'
22:41:37,151 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                XFS.supported: supported: True ;
22:41:37,153 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... modprobe --dry-run xfs
22:41:37,167 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0
22:41:37,167 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:get_format('xfs') returning XFS instance with object id 2
22:41:37,168 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:             XFS.supported: supported: True ;
22:41:37,168 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.storage:trying to set new default luks version to 'luks2'
22:41:37,169 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:              LUKS.__init__: luks_version: luks2 ;
22:41:37,170 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:get_format('luks') returning LUKS instance with object id 3
22:41:37,170 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.storage:The storage model has changed.
22:41:37,170 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:37,170 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/Checker.
22:41:37,171 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:37,173 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/DeviceTree.
22:41:37,175 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/DiskInitialization.
22:41:37,177 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/DiskSelection.
22:41:37,178 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/Snapshot.
22:41:37,179 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/Bootloader.
22:41:37,180 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/FCoE.
22:41:37,182 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/iSCSI.
22:41:37,183 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/NVDIMM.
22:41:37,185 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/DASD.
22:41:37,185 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/zFCP.
22:41:37,186 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage.
22:41:37,188 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Modules.Storage.
22:41:37,190 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Modules.Storage'
22:41:37,191 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Service org.fedoraproject.Anaconda.Modules.Storage started successfully.
22:41:37,191 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:org.fedoraproject.Anaconda.Modules.Storage is available.
22:41:37,192 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:37,268 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:37,270 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Localization.
22:41:37,270 WARNING org.fedoraproject.Anaconda.Modules.Localization:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:37,272 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:anaconda.modules.common.base.base:Publish the service.
22:41:37,272 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Timezone.
22:41:37,272 WARNING org.fedoraproject.Anaconda.Modules.Timezone:INFO:anaconda.core.dbus:Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-BlK46qz6Ux,guid=550d3e9efbc4bc00d2f8a8e4652b191c.
22:41:37,274 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Modules.Localization.
22:41:37,275 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Modules.Localization'
22:41:37,275 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Service org.fedoraproject.Anaconda.Modules.Localization started successfully.
22:41:37,276 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:org.fedoraproject.Anaconda.Modules.Localization is available.
22:41:37,277 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:37,278 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:dasbus.connection:Registering a service name org.fedoraproject.Anaconda.Modules.Timezone.
22:41:37,279 INFO dbus-daemon:Successfully activated service 'org.fedoraproject.Anaconda.Modules.Timezone'
22:41:37,279 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:Service org.fedoraproject.Anaconda.Modules.Timezone started successfully.
22:41:37,279 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.boss.module_manager.start_modules:org.fedoraproject.Anaconda.Modules.Timezone is available.
22:41:37,280 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:anaconda.modules.common.base.base:Start the loop.
22:41:37,280 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.threading:Thread Done: AnaTaskThread-StartModulesTask-1 (139932942464576)
22:41:37,287 INFO anaconda:anaconda: main: Found a kickstart file: /run/install/ks.cfg
22:41:37,323 INFO anaconda:anaconda: startup_utils: Parsing kickstart: /run/install/ks.cfg
22:41:37,324 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.boss:Reading a kickstart file at /run/install/ks.cfg.
22:41:37,373 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:org.fedoraproject.Anaconda.Modules.Services handles commands ['firstboot', 'services', 'skipx', 'xconfig'] sections [] addons [].
22:41:37,377 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:There are no kickstart data for org.fedoraproject.Anaconda.Modules.Services.
22:41:37,381 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:org.fedoraproject.Anaconda.Modules.Security handles commands ['auth', 'authconfig', 'authselect', 'selinux', 'realm'] sections [] addons [].
22:41:37,382 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:There are no kickstart data for org.fedoraproject.Anaconda.Modules.Security.
22:41:37,384 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:org.fedoraproject.Anaconda.Modules.Users handles commands ['rootpw', 'user', 'group', 'sshkey'] sections [] addons [].
22:41:37,384 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.common.base.base:Reading kickstart...
22:41:37,387 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.users.users:Root password set.
22:41:37,387 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.users.users:Root account has been unlocked.
22:41:37,387 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.users.users:SSH login as root with password will not be allowed.
22:41:37,387 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.users.users:Can change root password state changed: False.
22:41:37,387 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.users.users:user (ansible) specified in kickstart without password, locking account
22:41:37,388 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.users.users:A new user list has been set: [UserData(gecos='Steve Hayes', gid=1000, gid_mode='ID_MODE_USE_VALUE', groups=['wheel'], homedir='', is_crypted=True, lock=False, name='steve', password_set=True, shell='', uid=1000, uid_mode='ID_MODE_USE_VALUE'), UserData(gecos='Ansible Service Account', gid=800, gid_mode='ID_MODE_USE_VALUE', groups=[], homedir='', is_crypted=False, lock=True, name='ansible', password_set=False, shell='', uid=800, uid_mode='ID_MODE_USE_VALUE')]
22:41:37,388 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.users.users:A new group list has been set: [GroupData(gid=1000, gid_mode='ID_MODE_USE_VALUE', name='steve'), GroupData(gid=800, gid_mode='ID_MODE_USE_VALUE', name='ansible')]
22:41:37,388 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.users.users:A new ssh key list has been set: []
22:41:37,388 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.common.base.base:Kickstarted is set to True.
22:41:37,392 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:org.fedoraproject.Anaconda.Modules.Payloads handles commands ['cdrom', 'harddrive', 'hmc', 'liveimg', 'nfs', 'ostreesetup', 'url'] sections ['packages'] addons [].
22:41:37,393 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.common.base.base:Reading kickstart...
22:41:37,406 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.payloads.payloads:Created the payload PayloadType.DNF.
22:41:37,447 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.payloads.source.nfs.nfs:NFS URL is set to nfs:ro,auto,soft,intr:192.168.1.3:/srv/shares/install_media/almalinux-9
22:41:37,447 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.payloads.payload.payload_base:New sources [Source(type='NFS', url='nfs:ro,auto,soft,intr:192.168.1.3:/srv/shares/install_media/almalinux-9')] were added.
22:41:37,447 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.payloads.payload.dnf.dnf:Packages are set to 'PackagesConfigurationData(broken_ignored=False, core_group_enabled=True, default_environment_enabled=False, docs_excluded=False, environment='minimal-environment', excluded_groups=[], excluded_packages=[], groups=['headless-management', 'guest-agents', 'standard', 'system-tools'], groups_package_types={}, languages='all', missing_ignored=False, multilib_policy='best', packages=[], retries=-1, timeout=-1, weakdeps_excluded=False)'.
22:41:37,447 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.payloads.payload.dnf.dnf:Are the packages set from a kickstart? True
22:41:37,447 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.payloads.payloads:Activated the payload PayloadType.DNF.
22:41:37,448 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.common.base.base:Kickstarted is set to True.
22:41:37,448 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Payloads/Payload/1.
22:41:37,451 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:org.fedoraproject.Anaconda.Modules.Storage handles commands ['autopart', 'bootloader', 'btrfs', 'clearpart', 'fcoe', 'ignoredisk', 'iscsi', 'iscsiname', 'logvol', 'mount', 'nvdimm', 'part', 'partition', 'raid', 'reqpart', 'snapshot', 'volgroup', 'zerombr', 'zfcp', 'zipl'] sections [] addons [].
22:41:37,452 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.common.base.base:Reading kickstart...
22:41:37,465 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... udevadm settle --timeout=300
22:41:37,476 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0
22:41:37,478 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... udevadm settle --timeout=300
22:41:37,488 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0
22:41:37,490 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... udevadm settle --timeout=300
22:41:37,501 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0
22:41:37,503 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.core.storage:vda matches ['vda'] for devicetree=None and disks_only=True
22:41:37,505 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.disk_initialization.initialization:Can format unrecognized is set to 'False'.
22:41:37,505 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.disk_initialization.initialization:Default disk label is set to ''.
22:41:37,505 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.disk_initialization.initialization:Can initialize labels is set to 'True'.
22:41:37,505 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.disk_initialization.initialization:Can format LDL is set to 'False'.
22:41:37,505 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.disk_initialization.initialization:The initialization mode is set to 'InitializationMode.CLEAR_NONE'.
22:41:37,505 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.disk_initialization.initialization:Devices to clear are set to '[]'.
22:41:37,505 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.disk_initialization.initialization:Drives to clear are set to '[]'.
22:41:37,505 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.disk_selection.selection:Selected disks are set to '['vda']'.
22:41:37,505 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.disk_selection.selection:Exclusive disks are set to '['vda']'.
22:41:37,505 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.disk_selection.selection:Ignored disks are set to '[]'.
22:41:37,506 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.bootloader.bootloader:Bootloader mode is set to 'BootloaderMode.ENABLED'.
22:41:37,506 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.bootloader.bootloader:Preferred location is set to 'MBR'.
22:41:37,521 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.storage.storage:Created the partitioning CUSTOM.
22:41:37,521 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.common.base.base:Kickstarted is set to True.
22:41:37,522 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/Partitioning/1.
22:41:37,525 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:org.fedoraproject.Anaconda.Modules.Localization handles commands ['keyboard', 'lang'] sections [] addons [].
22:41:37,525 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.common.base.base:Reading kickstart...
22:41:37,527 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.localization.localization:Language is set to en_GB.UTF-8.
22:41:37,527 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.localization.localization:Language support is set to [].
22:41:37,527 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.localization.localization:Language seen set to True.
22:41:37,527 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.localization.localization:Virtual console keymap is set to .
22:41:37,527 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.localization.localization:X Layouts are set to ['gb'].
22:41:37,527 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.localization.localization:X layout switch options are set to [].
22:41:37,527 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.localization.localization:keyboard command considered seen in kicksatart: True.
22:41:37,527 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.common.base.base:Kickstarted is set to True.
22:41:37,530 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:org.fedoraproject.Anaconda.Modules.Timezone handles commands ['timezone', 'timesource'] sections [] addons [].
22:41:37,530 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:anaconda.modules.common.base.base:Reading kickstart...
22:41:37,533 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:anaconda.modules.timezone.timezone:Timezone is set to Europe/London.
22:41:37,533 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:anaconda.modules.timezone.timezone:UTC is set to True.
22:41:37,533 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:anaconda.modules.timezone.timezone:NTP is set to True.
22:41:37,533 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:anaconda.modules.timezone.timezone:Time sources are set to: [TimeSourceData(hostname='ntp.purplehayes.uk', options=['iburst'], type='SERVER')]
22:41:37,533 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:anaconda.modules.common.base.base:Kickstarted is set to True.
22:41:37,536 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:org.fedoraproject.Anaconda.Modules.Network handles commands ['network', 'firewall'] sections [] addons [].
22:41:37,536 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.common.base.base:Reading kickstart...
22:41:37,539 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.firewall.firewall:Firewall command considered seen in kickstart: False.
22:41:37,539 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.firewall.firewall:Ports that will be allowed through the firewall: []
22:41:37,539 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.firewall.firewall:Trusted devices that will be allowed through the firewall: []
22:41:37,539 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.firewall.firewall:Services that will be allowed through the firewall: []
22:41:37,539 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.firewall.firewall:Services that will be explicitly disabled on the firewall: []
22:41:37,539 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.common.base.base:Kickstarted is set to True.
22:41:37,541 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:org.fedoraproject.Anaconda.Addons.OSCAP handles commands [] sections [] addons ['com_redhat_oscap', 'org_fedora_oscap'].
22:41:37,542 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:There are no kickstart data for org.fedoraproject.Anaconda.Addons.OSCAP.
22:41:37,543 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.kickstart_manager.kickstart_manager:org.fedoraproject.Anaconda.Addons.Kdump handles commands [] sections [] addons ['com_redhat_kdump'].
22:41:37,543 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:anaconda.modules.common.base.base:Reading kickstart...
22:41:37,544 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:com_redhat_kdump.service.kdump:Kdump enabled is set to 'False'.
22:41:37,545 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:com_redhat_kdump.service.kdump:Fadump enabled is set to 'False'.
22:41:37,545 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:com_redhat_kdump.service.kdump:Reserved memory is set to 'auto'.
22:41:37,545 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:anaconda.modules.common.base.base:Kickstarted is set to True.
22:41:37,546 WARNING anaconda:anaconda: kickstart: Command keyboard will be parsed in DBus module.
22:41:37,547 WARNING anaconda:anaconda: kickstart: Command lang will be parsed in DBus module.
22:41:37,547 WARNING anaconda:anaconda: kickstart: Command network will be parsed in DBus module.
22:41:37,547 WARNING anaconda:anaconda: kickstart: Command nfs will be parsed in DBus module.
22:41:37,547 WARNING anaconda:anaconda: kickstart: Command ignoredisk will be parsed in DBus module.
22:41:37,547 WARNING anaconda:anaconda: kickstart: Command clearpart will be parsed in DBus module.
22:41:37,547 WARNING anaconda:anaconda: kickstart: Command partition will be parsed in DBus module.
22:41:37,548 WARNING anaconda:anaconda: kickstart: Command partition will be parsed in DBus module.
22:41:37,548 WARNING anaconda:anaconda: kickstart: Command partition will be parsed in DBus module.
22:41:37,548 WARNING anaconda:anaconda: kickstart: Command volgroup will be parsed in DBus module.
22:41:37,548 WARNING anaconda:anaconda: kickstart: Command logvol will be parsed in DBus module.
22:41:37,548 WARNING anaconda:anaconda: kickstart: Command logvol will be parsed in DBus module.
22:41:37,548 WARNING anaconda:anaconda: kickstart: Command bootloader will be parsed in DBus module.
22:41:37,548 WARNING anaconda:anaconda: kickstart: Command timezone will be parsed in DBus module.
22:41:37,549 WARNING anaconda:anaconda: kickstart: Command timesource will be parsed in DBus module.
22:41:37,549 WARNING anaconda:anaconda: kickstart: Command rootpw will be parsed in DBus module.
22:41:37,549 WARNING anaconda:anaconda: kickstart: Command group will be parsed in DBus module.
22:41:37,549 WARNING anaconda:anaconda: kickstart: Command group will be parsed in DBus module.
22:41:37,549 WARNING anaconda:anaconda: kickstart: Command user will be parsed in DBus module.
22:41:37,550 WARNING anaconda:anaconda: kickstart: Command user will be parsed in DBus module.
22:41:37,550 DEBUG anaconda:anaconda: pwpolicy: Using the password policy from the configuration.
22:41:37,554 WARNING org.fedoraproject.Anaconda.Modules.Localization:INFO:dasbus.connection:Connecting to the system bus.
22:41:37,554 WARNING org.fedoraproject.Anaconda.Modules.Localization:INFO:dasbus.connection:Connecting to the system bus.
22:41:37,554 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Localization/Task/1.
22:41:37,556 WARNING org.fedoraproject.Anaconda.Modules.Localization:INFO:anaconda.threading:Running Thread: AnaTaskThread-ApplyKeyboardTask-1 (140689505515072)
22:41:37,569 INFO systemd:Starting Locale Service...
22:41:37,602 INFO systemd:Started Locale Service.
22:41:37,645 INFO systemd-localed:Changed X11 keyboard layout to 'gb' model '' variant '' options ''
22:41:37,656 INFO systemd-localed:Changing virtual console keymap to 'gb' toggle ''
22:41:37,658 INFO systemd:systemd-vconsole-setup.service: Deactivated successfully.
22:41:37,658 INFO systemd:Stopped Setup Virtual Console.
22:41:37,658 INFO systemd:Stopping Setup Virtual Console...
22:41:37,659 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.localization.localization:Virtual console keymap is set to gb.
22:41:37,659 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.localization.localization:X Layouts are set to ['gb'].
22:41:37,659 WARNING org.fedoraproject.Anaconda.Modules.Localization:INFO:anaconda.threading:Thread Done: AnaTaskThread-ApplyKeyboardTask-1 (140689505515072)
22:41:37,660 INFO systemd:Starting Setup Virtual Console...
22:41:37,753 INFO systemd:Finished Setup Virtual Console.
22:41:38,765 INFO anaconda:librepo: Librepo version: 1.14.5 with CURL_GLOBAL_ACK_EINTR support (libcurl/7.76.1 OpenSSL/3.0.7 zlib/1.2.11 brotli/1.0.9 libidn2/2.3.0 libpsl/0.21.1 (+libidn2/2.3.0) libssh/0.10.4/openssl/zlib nghttp2/1.43.0)
22:41:38,765 DEBUG anaconda:anaconda: modules.payloads.payload.dnf.dnf_manager: The DNF base has been reset.
22:41:38,786 INFO anaconda:librepo: Librepo version: 1.14.5 with CURL_GLOBAL_ACK_EINTR support (libcurl/7.76.1 OpenSSL/3.0.7 zlib/1.2.11 brotli/1.0.9 libidn2/2.3.0 libpsl/0.21.1 (+libidn2/2.3.0) libssh/0.10.4/openssl/zlib nghttp2/1.43.0)
22:41:38,787 DEBUG anaconda:dnf: User-Agent: constructed: 'libdnf (AlmaLinux 9.2; generic; Linux.x86_64)'
22:41:38,978 DEBUG anaconda:anaconda: modules.payloads.payload.dnf.utils: Release version of AlmaLinux is 9.2.
22:41:38,979 DEBUG anaconda:anaconda: modules.payloads.payload.dnf.dnf_manager: The DNF base has been created.
22:41:38,979 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Payloads/Source/1.
22:41:38,990 DEBUG anaconda:anaconda: modules.payloads.payload.dnf.dnf_manager: DNF configuration:#012[main]#012allow_vendor_change = 1#012assumeno = 0#012assumeyes = 0#012autocheck_running_kernel = 1#012bandwidth = 0#012best = 1#012bugtracker_url = https://bugs.almalinux.org/#012cachedir = /tmp/dnf.cache#012cacheonly = 0#012check_config_file_age = 1#012clean_requirements_on_remove = 1#012color = auto#012color_list_available_downgrade = magenta#012color_list_available_install = bold,cyan#012color_list_available_reinstall = bold,underline,green#012color_list_available_upgrade = bold,blue#012color_list_installed_extra = bold,red#012color_list_installed_newer = bold,yellow#012color_list_installed_older = yellow#012color_list_installed_reinstall = cyan#012color_search_match = bold,magenta#012color_update_installed = red#012color_update_local = green#012color_update_remote = bold,green#012config_file_path = /etc/dnf/dnf.conf#012countme = 0#012debug_solver = 0#012debuglevel = 2#012defaultyes = 0#012deltarpm = 1#012deltarpm_percentage = 75#012disable_excludes = #012diskspacecheck = 1#012enabled = 1#012enablegroups = 1#012errorlevel = 3#012exclude = #012exclude_from_weak = #012exclude_from_weak_autodetect = 1#012excludepkgs = #012exit_on_lock = 0#012fastestmirror = 0#012gpgcheck = 0#012gpgkey_dns_verification = 0#012group_package_types = mandatory, default, conditional#012history_list_view = commands#012history_record = 1#012history_record_packages = dnf, rpm#012ignorearch = 0#012includepkgs = #012install_weak_deps = 1#012installonly_limit = 3#012installonlypkgs = kernel, kernel-PAE, installonlypkg(kernel), installonlypkg(kernel-module), installonlypkg(vm), multiversion(kernel)#012installroot = /mnt/sysroot#012ip_resolve = whatever#012keepcache = 0#012localpkg_gpgcheck = 0#012log_compress = 0#012log_rotate = 4#012log_size = 1048576#012logdir = /tmp/#012logfilelevel = 9#012max_downloads_per_mirror = 3#012max_parallel_downloads = 3#012metadata_expire = 172800#012metadata_timer_sync = 10800#012minrate = 1000#012module_obsoletes = 0#012module_platform_id = platform:el9#012module_stream_switch = 0#012multilib_policy = best#012obsoletes = 1#012password = #012persistdir = /mnt/sysroot/var/lib/dnf#012pluginconfpath = /tmp/dnf.pluginconf#012pluginpath = /usr/lib/python3.9/site-packages/dnf-plugins#012plugins = 1#012protect_running_kernel = 1#012protected_packages = dnf, grub2-tools-minimal, grub2-efi-x64, systemd, systemd-udev, dnf, setup#012proxy = #012proxy_auth_method = any#012proxy_password = #012proxy_sslcacert = #012proxy_sslclientcert = #012proxy_sslclientkey = #012proxy_sslverify = 1#012proxy_username = #012recent = 7#012repo_gpgcheck = 0#012reposdir = /etc/yum.repos.d, /etc/anaconda.repos.d#012reset_nice = 1#012retries = 10#012rpmverbosity = info#012showdupesfromrepos = 0#012skip_broken = 0#012skip_if_unavailable = 0#012sslcacert = #012sslclientcert = #012sslclientkey = #012sslverify = 1#012sslverifystatus = 0#012strict = 1#012system_cachedir = /var/cache/dnf#012throttle = 0#012timeout = 30#012transformdb = 1#012tsflags = #012upgrade_group_objects_upgrade = 1#012user_agent = libdnf (AlmaLinux 9.2; generic; Linux.x86_64)#012username = #012varsdir = /etc/yum/vars, /etc/dnf/vars#012zchunk = 1
22:41:39,020 DEBUG anaconda:anaconda: modules.payloads.payload.dnf.dnf_manager: The DNF base has been reset.
22:41:39,022 DEBUG anaconda:dnf: User-Agent: constructed: 'libdnf (AlmaLinux 9.2; generic; Linux.x86_64)'
22:41:39,023 DEBUG anaconda:anaconda: modules.payloads.payload.dnf.utils: Release version of AlmaLinux is 9.2.
22:41:39,024 DEBUG anaconda:anaconda: modules.payloads.payload.dnf.dnf_manager: The DNF base has been created.
22:41:39,025 DEBUG anaconda:anaconda: modules.payloads.payload.dnf.dnf_manager: DNF configuration:#012[main]#012allow_vendor_change = 1#012assumeno = 0#012assumeyes = 0#012autocheck_running_kernel = 1#012bandwidth = 0#012best = 1#012bugtracker_url = https://bugs.almalinux.org/#012cachedir = /tmp/dnf.cache#012cacheonly = 0#012check_config_file_age = 1#012clean_requirements_on_remove = 1#012color = auto#012color_list_available_downgrade = magenta#012color_list_available_install = bold,cyan#012color_list_available_reinstall = bold,underline,green#012color_list_available_upgrade = bold,blue#012color_list_installed_extra = bold,red#012color_list_installed_newer = bold,yellow#012color_list_installed_older = yellow#012color_list_installed_reinstall = cyan#012color_search_match = bold,magenta#012color_update_installed = red#012color_update_local = green#012color_update_remote = bold,green#012config_file_path = /etc/dnf/dnf.conf#012countme = 0#012debug_solver = 0#012debuglevel = 2#012defaultyes = 0#012deltarpm = 1#012deltarpm_percentage = 75#012disable_excludes = #012diskspacecheck = 1#012enabled = 1#012enablegroups = 1#012errorlevel = 3#012exclude = #012exclude_from_weak = #012exclude_from_weak_autodetect = 1#012excludepkgs = #012exit_on_lock = 0#012fastestmirror = 0#012gpgcheck = 0#012gpgkey_dns_verification = 0#012group_package_types = mandatory, default, conditional#012history_list_view = commands#012history_record = 1#012history_record_packages = dnf, rpm#012ignorearch = 0#012includepkgs = #012install_weak_deps = 1#012installonly_limit = 3#012installonlypkgs = kernel, kernel-PAE, installonlypkg(kernel), installonlypkg(kernel-module), installonlypkg(vm), multiversion(kernel)#012installroot = /mnt/sysroot#012ip_resolve = whatever#012keepcache = 0#012localpkg_gpgcheck = 0#012log_compress = 0#012log_rotate = 4#012log_size = 1048576#012logdir = /tmp/#012logfilelevel = 9#012max_downloads_per_mirror = 3#012max_parallel_downloads = 3#012metadata_expire = 172800#012metadata_timer_sync = 10800#012minrate = 1000#012module_obsoletes = 0#012module_platform_id = platform:el9#012module_stream_switch = 0#012multilib_policy = best#012obsoletes = 1#012password = #012persistdir = /mnt/sysroot/var/lib/dnf#012pluginconfpath = /tmp/dnf.pluginconf#012pluginpath = /usr/lib/python3.9/site-packages/dnf-plugins#012plugins = 1#012protect_running_kernel = 1#012protected_packages = dnf, grub2-tools-minimal, grub2-efi-x64, systemd, systemd-udev, dnf, setup#012proxy = #012proxy_auth_method = any#012proxy_password = #012proxy_sslcacert = #012proxy_sslclientcert = #012proxy_sslclientkey = #012proxy_sslverify = 1#012proxy_username = #012recent = 7#012repo_gpgcheck = 0#012reposdir = /etc/yum.repos.d, /etc/anaconda.repos.d#012reset_nice = 1#012retries = 10#012rpmverbosity = info#012showdupesfromrepos = 0#012skip_broken = 0#012skip_if_unavailable = 0#012sslcacert = #012sslclientcert = #012sslclientkey = #012sslverify = 1#012sslverifystatus = 0#012strict = 1#012system_cachedir = /var/cache/dnf#012throttle = 0#012timeout = 30#012transformdb = 1#012tsflags = #012upgrade_group_objects_upgrade = 1#012user_agent = libdnf (AlmaLinux 9.2; generic; Linux.x86_64)#012username = #012varsdir = /etc/yum/vars, /etc/dnf/vars#012zchunk = 1
22:41:39,029 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.localization.localization:Language is set to en_GB.UTF-8.
22:41:39,030 DEBUG anaconda:anaconda: localization: setting locale to: en_GB.UTF-8
22:41:39,045 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.boss:Setting locale of all modules to en_GB.UTF-8.
22:41:39,045 WARNING org.fedoraproject.Anaconda.Boss:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,045 WARNING org.fedoraproject.Anaconda.Boss:INFO:anaconda.modules.boss.module_manager.module_manager:Setting locale of all modules to en_GB.UTF-8.
22:41:39,046 WARNING org.fedoraproject.Anaconda.Modules.Services:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,046 WARNING org.fedoraproject.Anaconda.Modules.Security:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,047 WARNING org.fedoraproject.Anaconda.Modules.Users:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,048 WARNING org.fedoraproject.Anaconda.Modules.Payloads:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,048 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,049 WARNING org.fedoraproject.Anaconda.Modules.Localization:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,049 WARNING org.fedoraproject.Anaconda.Modules.Timezone:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,050 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,051 WARNING org.fedoraproject.Anaconda.Addons.OSCAP:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,051 WARNING org.fedoraproject.Anaconda.Addons.Kdump:DEBUG:anaconda.modules.common.base.base:Locale is set to en_GB.UTF-8.
22:41:39,052 DEBUG anaconda:anaconda: network: Initialization started.
22:41:39,053 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:Dumping configuration state - Initialization started.
22:41:39,057 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:{'connection': {'autoconnect': <false>, 'id': <'lo'>, 'interface-name': <'lo'>, 'permissions': <@as []>, 'timestamp': <uint64 1697323289>, 'type': <'loopback'>, 'uuid': <'c625d7da-184e-45af-95ed-bd298254485e'>}, 'loopback': {}, 'ipv4': {'address-data': <[{'address': <'127.0.0.1'>, 'prefix': <uint32 8>}]>, 'dns-search': <@as []>, 'method': <'manual'>, 'route-data': <@aa{sv} []>}, 'ipv6': {'address-data': <[{'address': <'::1'>, 'prefix': <uint32 128>}]>, 'dns-search': <@as []>, 'method': <'manual'>, 'route-data': <@aa{sv} []>}, 'proxy': {}}
22:41:39,057 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:{'connection': {'autoconnect-priority': <-100>, 'autoconnect-retries': <1>, 'id': <'Wired Connection'>, 'multi-connect': <3>, 'permissions': <@as []>, 'timestamp': <uint64 1697323289>, 'type': <'802-3-ethernet'>, 'uuid': <'b7e70884-f1e5-480b-a379-644fd0b58240'>, 'wait-device-timeout': <60000>}, '802-3-ethernet': {'auto-negotiate': <false>, 'mac-address-blacklist': <@as []>, 's390-options': <@a{ss} {}>}, 'ipv4': {'address-data': <@aa{sv} []>, 'dhcp-timeout': <90>, 'dhcp-vendor-class-identifier': <'anaconda-Linux'>, 'dns-search': <@as []>, 'may-fail': <false>, 'method': <'auto'>, 'route-data': <@aa{sv} []>}, 'ipv6': {'addr-gen-mode': <2>, 'address-data': <@aa{sv} []>, 'dhcp-timeout': <90>, 'dns-search': <@as []>, 'method': <'auto'>, 'route-data': <@aa{sv} []>}, 'proxy': {}, 'user': {'data': <{'org.freedesktop.NetworkManager.origin': 'nm-initrd-generator'}>}}
22:41:39,059 DEBUG anaconda:anaconda: network: Devices found: ['enp1s0']
22:41:39,059 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Network/Task/1.
22:41:39,061 DEBUG anaconda:anaconda: network: Running task Apply kickstart
22:41:39,062 WARNING org.fedoraproject.Anaconda.Modules.Network:INFO:anaconda.threading:Running Thread: AnaTaskThread-ApplyKickstartTask-1 (140488950945344)
22:41:39,075 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.nm_client:get new NM Client succeeded.
22:41:39,075 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.nm_client:kickstart specification --device=enp1s0 -> enp1s0 (existing device found)
22:41:39,075 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.initialization:Apply kickstart: adding connection for enp1s0
22:41:39,079 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.nm_client:Bind to device: enp1s0 -> enp1s0
22:41:39,079 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.nm_client:add connection (activate=True): 93cc0f01-17c5-4f56-aec3-cda68f2e57e8 for enp1s0
22:41:39,079 WARNING org.fedoraproject.Anaconda.Modules.Network:{'connection': {'id': <'enp1s0'>, 'interface-name': <'enp1s0'>, 'permissions': <@as []>, 'type': <'802-3-ethernet'>, 'uuid': <'93cc0f01-17c5-4f56-aec3-cda68f2e57e8'>}, '802-3-ethernet': {'auto-negotiate': <false>, 'mac-address-blacklist': <@as []>, 's390-options': <@a{ss} {}>}, 'ipv4': {'address-data': <@aa{sv} []>, 'dns-search': <@as []>, 'method': <'auto'>, 'route-data': <@aa{sv} []>}, 'ipv6': {'addr-gen-mode': <0>, 'address-data': <@aa{sv} []>, 'dns-search': <@as []>, 'method': <'ignore'>, 'route-data': <@aa{sv} []>}}
22:41:39,079 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.core.glib:sync_call_glib[nm_client_add_connection2]: call
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ connection 'new connection' (0x555c976a89b0/NMSimpleConnection/"802-3-ethernet"): [/org/freedesktop/NetworkManager/Settings/3]
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ connection                [ 0x555c97644b40 ]
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ connection.id             = 'enp1s0'
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ connection.interface-name = 'enp1s0'
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ connection.permissions    = []
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ connection.type           = '802-3-ethernet'
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ connection.uuid           = '93cc0f01-17c5-4f56-aec3-cda68f2e57e8'
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ 802-3-ethernet            [ 0x555c976c28c0 ]
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ 802-3-ethernet.mac-address-blacklist = []
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ 802-3-ethernet.s390-options = ((GHashTable*) 0x7f3288008180)
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ ipv4                      [ 0x555c97636e10 ]
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ ipv4.addresses            = ((GPtrArray*) 0x7f3288001c80)
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1040] ++ ipv4.dns                  = []
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv4.dns-search           = []
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv4.method               = 'auto'
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv4.routes               = ((GPtrArray*) 0x555c9767c720)
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv4.routing-rules        = <unknown>
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv6                      [ 0x555c97636ef0 ]
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv6.addr-gen-mode        = 0
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv6.addresses            = ((GPtrArray*) 0x7f32880022e0)
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv6.dns                  = []
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv6.dns-search           = []
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv6.method               = 'ignore'
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv6.routes               = ((GPtrArray*) 0x7f3288001cc0)
22:41:39,104 DEBUG NetworkManager:<debug> [1697323299.1041] ++ ipv6.routing-rules        = <unknown>
22:41:39,105 DEBUG NetworkManager:<debug> [1697323299.1043] create NMAuditManager singleton (7989f8b086ad71a6)
22:41:39,105 INFO NetworkManager:<info>  [1697323299.1043] audit: op="connection-add" uuid="93cc0f01-17c5-4f56-aec3-cda68f2e57e8" name="enp1s0" pid=1910 uid=0 result="success"
22:41:39,105 DEBUG NetworkManager:<debug> [1697323299.1044] Saving secrets for connection /org/freedesktop/NetworkManager/Settings/3 (enp1s0)
22:41:39,105 DEBUG NetworkManager:<debug> [1697323299.1044] device[85090afc7f58f754] (lo): add_pending_action (1): 'autoactivate'
22:41:39,113 DEBUG NetworkManager:<debug> [1697323299.1134] device[85090afc7f58f754] (lo): remove_pending_action (0): 'autoactivate'
22:41:39,114 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.core.glib:sync_call_glib[nm_client_add_connection2]: call nm_client_add_connection2_finish
22:41:39,114 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.core.glib:sync_call_glib[nm_client_add_connection2]: quit
22:41:39,114 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.core.glib:sync_call_glib[nm_client_add_connection2]: quit
22:41:39,114 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.nm_client:connection 93cc0f01-17c5-4f56-aec3-cda68f2e57e8 added:
22:41:39,114 WARNING org.fedoraproject.Anaconda.Modules.Network:{'connection': {'id': <'enp1s0'>, 'interface-name': <'enp1s0'>, 'permissions': <@as []>, 'type': <'802-3-ethernet'>, 'uuid': <'93cc0f01-17c5-4f56-aec3-cda68f2e57e8'>}, '802-3-ethernet': {'auto-negotiate': <false>, 'mac-address-blacklist': <@as []>, 's390-options': <@a{ss} {}>}, 'ipv4': {'address-data': <@aa{sv} []>, 'dns-search': <@as []>, 'method': <'auto'>, 'route-data': <@aa{sv} []>}, 'ipv6': {'addr-gen-mode': <0>, 'address-data': <@aa{sv} []>, 'dns-search': <@as []>, 'method': <'ignore'>, 'route-data': <@aa{sv} []>}}
22:41:39,114 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.nm_client:activating with device enp1s0
22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1145] active-connection[cc061fb8b21fc1a6]: set device "enp1s0" [0x555c976d6de0]
22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1145] device[e159282a864db490] (enp1s0): add_pending_action (1): 'activation-3'
22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1146] active-connection[cc061fb8b21fc1a6]: constructed (NMActRequest, version-id 3, type managed)
22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1147] device[e159282a864db490] (enp1s0): queue activation request waiting for currently active connection to disconnect
22:41:39,115 INFO NetworkManager:<info>  [1697323299.1147] device (enp1s0): disconnecting for new activation request.
22:41:39,115 INFO NetworkManager:<info>  [1697323299.1147] device (enp1s0): state change: activated -> deactivating (reason 'new-activation', sys-iface-state: 'managed')
22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1148] device[e159282a864db490] (enp1s0): add_pending_action (2): 'in-state-change'
22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1149] active-connection[6644ee4943fdfb5a]: set state deactivating (was activated)
22:41:39,115 INFO NetworkManager:<info>  [1697323299.1149] manager: NetworkManager state is now DISCONNECTING
22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1150] active-connection[6644ee4943fdfb5a]: check-master-ready: not signalling (state deactivating, no master)
22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1151] device[e159282a864db490] (enp1s0): ip4: set state none (was done, reason: ip-state-clear)
22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1152] device[e159282a864db490] (enp1s0): ip6: set state none (was pending, reason: ip-state-clear)
22:41:39,115 DEBUG NetworkManager:<debug> [1697323299.1152] dispatcher: (9) (enp1s0) dispatching action 'pre-down' (with callback)
22:41:39,116 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:NeworkManager state changed to <enum NM_STATE_DISCONNECTING of type NM.State>
22:41:39,116 DEBUG NetworkManager:<debug> [1697323299.1165] device[e159282a864db490] (enp1s0): connectivity state changed from FULL to NONE
22:41:39,117 DEBUG NetworkManager:<debug> [1697323299.1166] device[e159282a864db490] (enp1s0): connectivity state changed from FULL to NONE
22:41:39,118 DEBUG NetworkManager:<debug> [1697323299.1179] manager: connectivity checking indicates NONE
22:41:39,118 DEBUG NetworkManager:<debug> [1697323299.1181] dispatcher: (10) dispatching action 'connectivity-change'
22:41:39,118 DEBUG NetworkManager:<debug> [1697323299.1182] device[e159282a864db490] (enp1s0): remove_pending_action (1): 'in-state-change'
22:41:39,118 INFO NetworkManager:<info>  [1697323299.1183] audit: op="connection-activate" uuid="93cc0f01-17c5-4f56-aec3-cda68f2e57e8" name="enp1s0" pid=1910 uid=0 result="success"
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:Connected to network: False
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:Apply kickstart result: ['enp1s0']
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:Dumping configuration state - Apply kickstart
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:/etc/NetworkManager/system-connections/enp1s0.nmconnection:
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:[connection]
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:id=enp1s0
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:uuid=93cc0f01-17c5-4f56-aec3-cda68f2e57e8
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:type=ethernet
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:interface-name=enp1s0
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:[ethernet]
22:41:39,119 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:[ipv4]
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:method=auto
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:[ipv6]
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:addr-gen-mode=eui64
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:method=ignore
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:[proxy]
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:{'connection': {'autoconnect': <false>, 'id': <'lo'>, 'interface-name': <'lo'>, 'permissions': <@as []>, 'timestamp': <uint64 1697323289>, 'type': <'loopback'>, 'uuid': <'c625d7da-184e-45af-95ed-bd298254485e'>}, 'loopback': {}, 'ipv4': {'address-data': <[{'address': <'127.0.0.1'>, 'prefix': <uint32 8>}]>, 'dns-search': <@as []>, 'method': <'manual'>, 'route-data': <@aa{sv} []>}, 'ipv6': {'address-data': <[{'address': <'::1'>, 'prefix': <uint32 128>}]>, 'dns-search': <@as []>, 'method': <'manual'>, 'route-data': <@aa{sv} []>}, 'proxy': {}}
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:{'connection': {'autoconnect-priority': <-100>, 'autoconnect-retries': <1>, 'id': <'Wired Connection'>, 'multi-connect': <3>, 'permissions': <@as []>, 'timestamp': <uint64 1697323289>, 'type': <'802-3-ethernet'>, 'uuid': <'b7e70884-f1e5-480b-a379-644fd0b58240'>, 'wait-device-timeout': <60000>}, '802-3-ethernet': {'auto-negotiate': <false>, 'mac-address-blacklist': <@as []>, 's390-options': <@a{ss} {}>}, 'ipv4': {'address-data': <@aa{sv} []>, 'dhcp-timeout': <90>, 'dhcp-vendor-class-identifier': <'anaconda-Linux'>, 'dns-search': <@as []>, 'may-fail': <false>, 'method': <'auto'>, 'route-data': <@aa{sv} []>}, 'ipv6': {'addr-gen-mode': <2>, 'address-data': <@aa{sv} []>, 'dhcp-timeout': <90>, 'dns-search': <@as []>, 'method': <'auto'>, 'route-data': <@aa{sv} []>}, 'proxy': {}, 'user': {'data': <{'org.freedesktop.NetworkManager.origin': 'nm-initrd-generator'}>}}
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:{'connection': {'id': <'enp1s0'>, 'interface-name': <'enp1s0'>, 'permissions': <@as []>, 'type': <'802-3-ethernet'>, 'uuid': <'93cc0f01-17c5-4f56-aec3-cda68f2e57e8'>}, '802-3-ethernet': {'auto-negotiate': <false>, 'mac-address-blacklist': <@as []>, 's390-options': <@a{ss} {}>}, 'ipv4': {'address-data': <@aa{sv} []>, 'dns-search': <@as []>, 'method': <'auto'>, 'route-data': <@aa{sv} []>}, 'ipv6': {'addr-gen-mode': <0>, 'address-data': <@aa{sv} []>, 'dns-search': <@as []>, 'method': <'ignore'>, 'route-data': <@aa{sv} []>}, 'proxy': {}}
22:41:39,120 WARNING org.fedoraproject.Anaconda.Modules.Network:INFO:anaconda.threading:Thread Done: AnaTaskThread-ApplyKickstartTask-1 (140488950945344)
22:41:39,127 INFO nm-dispatcher:req:9 'pre-down' [enp1s0]: new request (0 scripts)
22:41:39,127 DEBUG nm-dispatcher:req:9 'pre-down' [enp1s0]: environment: CONNECTION_DBUS_PATH=/org/freedesktop/NetworkManager/Settings/2
22:41:39,127 DEBUG nm-dispatcher:req:9 'pre-down' [enp1s0]: environment: CONNECTION_FILENAME=/run/NetworkManager/system-connections/default_connection.nmconnection
22:41:39,127 DEBUG nm-dispatcher:req:9 'pre-down' [enp1s0]: environment: CONNECTION_UUID=b7e70884-f1e5-480b-a379-644fd0b58240
22:41:39,127 DEBUG nm-dispatcher:req:9 'pre-down' [enp1s0]: environment: CONNECTION_ID=Wired Connection
22:41:39,127 DEBUG nm-dispatcher:req:9 'pre-down' [enp1s0]: environment: DEVICE_IFACE=enp1s0
22:41:39,127 DEBUG nm-dispatcher:req:9 'pre-down' [enp1s0]: environment: DEVICE_IP_IFACE=enp1s0
22:41:39,127 DEBUG nm-dispatcher:req:9 'pre-down' [enp1s0]: environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
22:41:39,127 DEBUG nm-dispatcher:req:9 'pre-down' [enp1s0]: environment: NM_DISPATCHER_ACTION=pre-down
22:41:39,127 INFO nm-dispatcher:req:9 'pre-down' [enp1s0]: completed: no scripts
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1275] dispatcher: (9) succeeded (after 0.013 sec, 0 scripts invoked)
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1276] device[e159282a864db490] (enp1s0): add_pending_action (2): 'queued-state-change-disconnected'
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1276] device[e159282a864db490] (enp1s0): queue-state[disconnected, reason:new-activation, id:177]: queue state change
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1276] device[e159282a864db490] (enp1s0): queue-state[disconnected, reason:new-activation, id:177]: change state
22:41:39,128 INFO NetworkManager:<info>  [1697323299.1276] device (enp1s0): state change: deactivating -> disconnected (reason 'new-activation', sys-iface-state: 'managed')
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1276] device[e159282a864db490] (enp1s0): add_pending_action (3): 'in-state-change'
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1276] device[e159282a864db490] (enp1s0): ip6: addrgenmode6: set none (already set)
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1276] device[e159282a864db490] (enp1s0): ip6: addrgenmode6: toggle disable_ipv6 sysctl after disabling addr-gen-mode
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1277] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/enp1s0/disable_ipv6' to '1' (current value is '0')
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1278] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/enp1s0/disable_ipv6' to '0' (current value is '1')
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1278] device[e159282a864db490] (enp1s0): deactivating device (reason 'new-activation') [60]
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1278] firewalld: [c2ce9aa487b3876e,remove*:"enp1s0"]: firewall zone remove enp1s0:default (not running, simulate success)
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1278] firewalld: [c2ce9aa487b3876e,remove*:"enp1s0"]: complete: drop request simulating success
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1278] device[e159282a864db490] (enp1s0): ip:dhcp4: set state none (was done)
22:41:39,128 INFO NetworkManager:<info>  [1697323299.1279] dhcp4 (enp1s0): canceled DHCP transaction
22:41:39,128 INFO NetworkManager:<info>  [1697323299.1279] dhcp4 (enp1s0): activation: beginning transaction (timeout in 90 seconds)
22:41:39,128 INFO NetworkManager:<info>  [1697323299.1279] dhcp4 (enp1s0): state changed no lease
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1280] device[e159282a864db490] (enp1s0): ip:manual4: set state none
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1280] device[e159282a864db490] (enp1s0): ip:manual6: set state none
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1280] device[e159282a864db490] (enp1s0): ip: set (combined) state none (was done, reason: ip-state-clear)
22:41:39,128 DEBUG NetworkManager:<debug> [1697323299.1280] ndisc[0x555c976ec160,"enp1s0"]: stopping neighbor discovery for ifindex 2
22:41:39,129 INFO nm-dispatcher:req:10 'connectivity-change': new request (3 scripts)
22:41:39,129 DEBUG nm-dispatcher:req:10 'connectivity-change': environment: CONNECTIVITY_STATE=NONE
22:41:39,129 DEBUG nm-dispatcher:req:10 'connectivity-change': environment: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin
22:41:39,129 DEBUG nm-dispatcher:req:10 'connectivity-change': environment: NM_DISPATCHER_ACTION=connectivity-change
22:41:39,129 INFO nm-dispatcher:req:10 'connectivity-change': start running ordered scripts...
22:41:39,129 DEBUG nm-dispatcher:req:10 'connectivity-change', "/usr/lib/NetworkManager/dispatcher.d/04-iscsi": run script
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1328] device[e159282a864db490] (enp1s0): ip:ac6: set state: none (was pending)
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1329] device[e159282a864db490] (enp1s0): ip:ll6: set state none (was done)
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1329] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/enp1s0/use_tempaddr' to '0' (current value is identical)
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1330] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: now zombie: [5bde94d2cc52db06, ip4-address, 192.168.1.126/24 brd* 192.168.1.255 lft 3590sec pref 3590sec lifetime 11-1[3600,3600] dev 2 src dhcp], zombie[5], nm-configured, in-platform
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1330] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: now zombie: [751da1b8baf9d3fa, ip4-route, type unicast 192.168.1.0/24 dev 2 metric 100 mss 0 rt-src rt-kernel scope link pref-src 192.168.1.126], zombie[5], nm-configured, in-platform
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1330] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: now zombie: [7db8ef3745b0a76a, ip6-route, type unicast fe80::/64 dev 2 metric 1024 mss 0 rt-src ipv6ll], zombie[5], nm-configured, in-platform
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1331] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: now zombie: [2738fbf7e1101dd7, ip6-address, fe80::5054:ff:fe01:7e00/64 lft forever pref forever lifetime 11-0[0,0] dev 2 src ipv6ll], zombie[5], nm-configured, in-platform
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1331] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: now zombie: [4386c4c767a8d4ce, ip4-route, type unicast 0.0.0.0/0 via 192.168.1.1 dev 2 metric 100 mss 0 rt-src dhcp pref-src 192.168.1.126], zombie[5], nm-configured, in-platform
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1331] dns-mgr: (device_l3cd_changed): queueing DNS updates (1)
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1331] dns-mgr: (device_l3cd_changed): DNS configuration changed
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1331] dns-mgr: (device_l3cd_changed): committing DNS changes (0)
22:41:39,133 DEBUG NetworkManager:<debug> [1697323299.1331] dns-mgr: update-dns: updating resolv.conf
22:41:39,134 DEBUG NetworkManager:<debug> [1697323299.1339] resolve-addr[82543befdb6dcaad,192.168.1.126]: start lookup via nm-daemon-helper
22:41:39,137 DEBUG NetworkManager:<debug> [1697323299.1371] helper[d57dc144948df8e2,2014]: spawned process with args: resolve-address 192.168.1.126
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1374] platform: (enp1s0) signal: route   6 removed: type unicast fe80::/64 dev 2 metric 1024 mss 0 rt-src rt-kernel
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1374] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: zombie gone (untrack): [7db8ef3745b0a76a, ip6-route, type unicast fe80::/64 dev 2 metric 1024 mss 0 rt-src ipv6ll], nm-configured, was-in-platform
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1374] platform: (enp1s0) signal: route   6 removed: type local table 255 fe80::5054:ff:fe01:7e00/128 dev 2 metric 0 mss 0 rt-src rt-kernel
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1374] platform: (enp1s0) signal: address 6 removed: fe80::5054:ff:fe01:7e00/64 lft forever pref forever lifetime 11-0[4294967295,4294967295] dev 2 flags permanent,noprefixroute src kernel
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1374] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: zombie gone (untrack): [2738fbf7e1101dd7, ip6-address, fe80::5054:ff:fe01:7e00/64 lft forever pref forever lifetime 11-0[0,0] dev 2 src ipv6ll], nm-configured, was-in-platform
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1374] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: zombie pruned during reapply: [5bde94d2cc52db06, ip4-address, 192.168.1.126/24 brd* 192.168.1.255 lft 3590sec pref 3590sec lifetime 11-1[3600,3600] dev 2 src dhcp], zombie[4], nm-configured, in-platform
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1374] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: zombie pruned during reapply: [751da1b8baf9d3fa, ip4-route, type unicast 192.168.1.0/24 dev 2 metric 100 mss 0 rt-src rt-kernel scope link pref-src 192.168.1.126], zombie[4], nm-configured, in-platform
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1374] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: zombie pruned during reapply: [4386c4c767a8d4ce, ip4-route, type unicast 0.0.0.0/0 via 192.168.1.1 dev 2 metric 100 mss 0 rt-src dhcp pref-src 192.168.1.126], zombie[4], nm-configured, in-platform
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1375] platform: (enp1s0) address: deleting IPv4 address 192.168.1.126/24,  dev 2
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1375] platform: (enp1s0) signal: address 4 removed: 192.168.1.126/24 brd 192.168.1.255 lft 3590sec pref 3590sec lifetime 11-1[3600,3600] dev 2 flags noprefixroute src kernel
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1375] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: zombie gone (untrack): [5bde94d2cc52db06, ip4-address, 192.168.1.126/24 brd* 192.168.1.255 lft 3590sec pref 3590sec lifetime 11-1[3600,3600] dev 2 src dhcp], nm-configured, was-in-platform
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1375] platform: (enp1s0) signal: route   4 removed: type local table 255 192.168.1.126/32 dev 2 metric 0 mss 0 rt-src rt-kernel scope host pref-src 192.168.1.126
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1375] platform: (enp1s0) signal: route   4 removed: type unicast 0.0.0.0/0 via 192.168.1.1 dev 2 metric 100 mss 0 rt-src rt-dhcp scope global pref-src 192.168.1.126
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1375] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: zombie gone (untrack): [4386c4c767a8d4ce, ip4-route, type unicast 0.0.0.0/0 via 192.168.1.1 dev 2 metric 100 mss 0 rt-src dhcp pref-src 192.168.1.126], nm-configured, was-in-platform
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1375] platform: (enp1s0) signal: route   4 removed: type unicast 192.168.1.0/24 dev 2 metric 100 mss 0 rt-src rt-kernel scope link pref-src 192.168.1.126
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1376] l3cfg[e9f74485c6a98861,ifindex=2]: obj-state: zombie gone (untrack): [751da1b8baf9d3fa, ip4-route, type unicast 192.168.1.0/24 dev 2 metric 100 mss 0 rt-src rt-kernel scope link pref-src 192.168.1.126], nm-configured, was-in-platform
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1376] platform-linux: do-delete-ip4-address[2: 192.168.1.126/24]: success
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1376] global-tracker: sync ip4-route
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1376] platform-linux: sysctl: setting '/proc/sys/net/ipv6/conf/enp1s0/use_tempaddr' to '0' (current value is identical)
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1376] global-tracker: sync ip6-route
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1376] global-tracker: sync mptcp-addr (reapply)
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1377] global-tracker: sync routing-rule
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1377] device[e159282a864db490] (enp1s0): set metered value 0
22:41:39,138 DEBUG NetworkManager:<debug> [1697323299.1378] manager: new metered value: 0
22:41:39,139 DEBUG NetworkManager:<debug> [1697323299.1391] active-connection[6644ee4943fdfb5a]: set state deactivated (was deactivating)
22:41:39,139 INFO NetworkManager:<info>  [1697323299.1394] manager: NetworkManager state is now DISCONNECTED
22:41:39,140 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:NeworkManager state changed to <enum NM_STATE_DISCONNECTED of type NM.State>
22:41:39,140 WARNING org.fedoraproject.Anaconda.Modules.Network:DEBUG:anaconda.modules.network.network:Connected to network: False
22:41:40,065 DEBUG anaconda:anaconda: network: Apply kickstart result: ['enp1s0']
22:42:04,712 INFO systemd:systemd-hostnamed.service: Deactivated successfully.