search

canonical / cloud-init

Official upstream for the cloud-init: cloud instance initialization
https://cloud-init.io/
Other
2.99k stars 882 forks source link

network device initialization error #4260

Open nanalncux opened 1 year ago

nanalncux commented 1 year ago

Bug report

cloud-init can't find network adapter by mac address during host first power on

Steps to reproduce the problem

mellanox additional network card is installed in the baremetall server 41:00.0 Ethernet controller: Mellanox Technologies MT27520 Family [ConnectX-3 Pro] built-in network interfaces

01:00.0 Ethernet controller: Broadcom Inc. and subsidiaries NetXtreme BCM5720 Gigabit Ethernet PCIe
01:00.1 Ethernet controller: Broadcom Inc. and subsidiaries NetXtreme BCM5720 Gigabit Ethernet PCIe

Network devices setting, after first boot:

1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default qlen 1000
    link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
    inet 127.0.0.1/8 scope host lo
       valid_lft forever preferred_lft forever
    inet6 ::1/128 scope host 
       valid_lft forever preferred_lft forever
2: inet0 : <BROADCAST,MULTICAST> mtu 1500 qdisc mq state DOWN group default qlen 1000
    link/ether 3c:ec:ef:c6:5b:cc brd ff:ff:ff:ff:ff:ff
    altname eno1
    altname enp1s0f0
3: eth1: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN group default qlen 1000
    link/ether 3c:ec:ef:c6:5b:cd brd ff:ff:ff:ff:ff:ff
    altname eno2
    altname enp1s0f1
4: eth2: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN group default qlen 1000
    link/ether b0:3a:f2:b6:05:9f brd ff:ff:ff:ff:ff:ff
5: eth0: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN group default qlen 1000
    link/ether 1c:34:da:13:ba:90 brd ff:ff:ff:ff:ff:ff
    altname enp65s0
6: eth3: <BROADCAST,MULTICAST> mtu 1500 qdisc noop state DOWN group default qlen 1000
    link/ether 1c:34:da:13:ba:91 brd ff:ff:ff:ff:ff:ff
    altname enp65s0d1

after loading into the OS and cleaning cloud-init and reinitialize, the network interfaces are configured correctly.

Environment details

cloud-init configs

meta-data

#cloud-config
instance-id: 
local-hostname: DEDICATED-13492-1
network-interfaces: |
  auto inet0
  iface inet0 inet static
  address 192.168.0.2
  netmask 255.255.255.0
  gateway 192.168.0.1
  hwaddress ether 3c:ec:ef:c6:5b:cc
  dns-nameservers 8.8.8.8 1.1.1.1

cloud-init logs

Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: WARN: no logging configured! (tried 0 configs)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: Setting up basic logging...
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: Cloud-init v. 22.4.2 running 'init-local' at Tue, 18 Jul 2023 10:42:18 +0000. Up 4.21 seconds.
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,195 - util.py[DEBUG]: Cloud-init v. 22.4.2 running 'init-local' at Tue, 18 Jul 2023 10:42:18 +0000. Up 4.21 seconds.
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,195 - main.py[DEBUG]: No kernel command line url found.
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,195 - main.py[DEBUG]: Closing stdin.
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,197 - util.py[DEBUG]: Writing to /var/log/cloud-init.log - ab: [640] 0 bytes
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,198 - util.py[DEBUG]: Writing to /var/lib/cloud/data/python-version - wb: [644] 4 bytes
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,198 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance/boot-finished
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,198 - handlers.py[DEBUG]: start: init-local/check-cache: attempting to read from cache [check]
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,198 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/obj.pkl (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,198 - stages.py[DEBUG]: no cache found
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,198 - handlers.py[DEBUG]: finish: init-local/check-cache: SUCCESS: no cache found
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,199 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,200 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'>
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,200 - __init__.py[DEBUG]: Looking for data source in: ['NoCloud', 'None'], via packages ['', 'cloudinit.sources'] that matches dependencies ['FILESYSTEM']
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,201 - __init__.py[DEBUG]: Searching for local data source in: ['DataSourceNoCloud']
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,201 - handlers.py[DEBUG]: start: init-local/search-NoCloud: searching for local data from DataSourceNoCloud
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - __init__.py[DEBUG]: Seeing if we can get any data from <class 'cloudinit.sources.DataSourceNoCloud.DataSourceNoCloud'>
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - __init__.py[DEBUG]: Update datasource metadata and network config due to events: boot-new-instance
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - dmi.py[DEBUG]: querying dmi data /sys/class/dmi/id/product_serial
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/user-data (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/meta-data (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/vendor-data (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/network-config (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/user-data (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/meta-data (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/vendor-data (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,202 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/network-config (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,203 - subp.py[DEBUG]: Running command ['blkid', '-tTYPE=vfat', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,235 - subp.py[DEBUG]: Running command ['blkid', '-tTYPE=iso9660', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,254 - subp.py[DEBUG]: Running command ['blkid', '-tLABEL=CIDATA', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,272 - subp.py[DEBUG]: Running command ['blkid', '-tLABEL=cidata', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,289 - subp.py[DEBUG]: Running command ['blkid', '-tLABEL_FATBOOT=cidata', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,307 - DataSourceNoCloud.py[DEBUG]: Attempting to use data from /dev/nvme0n1p5
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,307 - util.py[DEBUG]: Reading from /proc/mounts (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,307 - util.py[DEBUG]: Read 1810 bytes from /proc/mounts
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,307 - util.py[DEBUG]: Fetched {'proc': {'fstype': 'proc', 'mountpoint': '/proc', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'sysfs': {'fstype': 'sysfs', 'mountpoint': '/sys', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'devtmpfs': {'fstype': 'devtmpfs', 'mountpoint': '/dev', 'opts': 'rw,nosuid,size=4096k,nr_inodes=66014076,mode=755,inode64'}, 'securityfs': {'fstype': 'securityfs', 'mountpoint': '/sys/kernel/security', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'tmpfs': {'fstype': 'tmpfs', 'mountpoint': '/run/lock', 'opts': 'rw,nosuid,nodev,noexec,relatime,size=5120k,inode64'}, 'devpts': {'fstype': 'devpts', 'mountpoint': '/dev/pts', 'opts': 'rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000'}, 'cgroup2': {'fstype': 'cgroup2', 'mountpoint': '/sys/fs/cgroup', 'opts': 'rw,nosuid,nodev,noexec,relatime,nsdelegate,memory_recursiveprot'}, 'pstore': {'fstype': 'pstore', 'mountpoint': '/sys/fs/pstore', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'efivarfs': {'fstype': 'efivarfs', 'mountpoint': '/sys/firmware/efi/efivars', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'bpf': {'fstype': 'bpf', 'mountpoint': '/sys/fs/bpf', 'opts': 'rw,nosuid,nodev,noexec,relatime,mode=700'}, '/dev/md125': {'fstype': 'ext4', 'mountpoint': '/', 'opts': 'rw,relatime,stripe=32'}, 'systemd-1': {'fstype': 'autofs', 'mountpoint': '/proc/sys/fs/binfmt_misc', 'opts': 'rw,relatime,fd=29,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=30710'}, 'hugetlbfs': {'fstype': 'hugetlbfs', 'mountpoint': '/dev/hugepages', 'opts': 'rw,relatime,pagesize=2M'}, 'mqueue': {'fstype': 'mqueue', 'mountpoint': '/dev/mqueue', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'debugfs': {'fstype': 'debugfs', 'mountpoint': '/sys/kernel/debug', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'tracefs': {'fstype': 'tracefs', 'mountpoint': '/sys/kernel/tracing', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'fusectl': {'fstype': 'fusectl', 'mountpoint': '/sys/fs/fuse/connections', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'configfs': {'fstype': 'configfs', 'mountpoint': '/sys/kernel/config', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'ramfs': {'fstype': 'ramfs', 'mountpoint': '/run/credentials/systemd-tmpfiles-setup-dev.service', 'opts': 'ro,nosuid,nodev,noexec,relatime,mode=700'}, '/dev/md127': {'fstype': 'ext3', 'mountpoint': '/boot', 'opts': 'rw,relatime,stripe=32'}} mounts from proc
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,307 - subp.py[DEBUG]: Running command ['mount', '-o', 'ro', '-t', 'auto', '/dev/nvme0n1p5', '/run/cloud-init/tmp/tmpcm_tlgpi'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,324 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmpcm_tlgpi//user-data (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,324 - util.py[DEBUG]: Read 13 bytes from /run/cloud-init/tmp/tmpcm_tlgpi//user-data
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,324 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmpcm_tlgpi//meta-data (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,324 - util.py[DEBUG]: Read 272 bytes from /run/cloud-init/tmp/tmpcm_tlgpi//meta-data
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,324 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmpcm_tlgpi//vendor-data (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,324 - util.py[DEBUG]: Read 308 bytes from /run/cloud-init/tmp/tmpcm_tlgpi//vendor-data
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,324 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmpcm_tlgpi//network-config (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,324 - subp.py[DEBUG]: Running command ['umount', '/run/cloud-init/tmp/tmpcm_tlgpi'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,333 - util.py[DEBUG]: Attempting to load yaml from string of length 272 with allowed root types (<class 'dict'>,)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,333 - DataSourceNoCloud.py[DEBUG]: Using data from /dev/nvme0n1p5
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,334 - util.py[DEBUG]: Writing to /run/cloud-init/cloud-id-nocloud - wb: [644] 8 bytes
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,334 - util.py[DEBUG]: Creating symbolic link from '/run/cloud-init/cloud-id' => '/run/cloud-init/cloud-id-nocloud'
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,334 - atomic_helper.py[DEBUG]: Atomically writing to file /run/cloud-init/instance-data-sensitive.json (via temporary file /run/cloud-init/tmpnv8lc132) - w: [600] 2908 bytes/chars
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,334 - atomic_helper.py[DEBUG]: Atomically writing to file /run/cloud-init/instance-data.json (via temporary file /run/cloud-init/tmplnd3voe1) - w: [644] 1662 bytes/chars
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,334 - handlers.py[DEBUG]: finish: init-local/search-NoCloud: SUCCESS: found local data from DataSourceNoCloud
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,334 - stages.py[INFO]: Loaded datasource DataSourceNoCloud - DataSourceNoCloud [seed=/dev/nvme0n1p5][dsmode=net]
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,335 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,335 - util.py[DEBUG]: Read 1179 bytes from /etc/cloud/cloud.cfg
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,335 - util.py[DEBUG]: Attempting to load yaml from string of length 1179 with allowed root types (<class 'dict'>,)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,337 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,337 - util.py[DEBUG]: Read 35 bytes from /run/cloud-init/cloud.cfg
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,337 - util.py[DEBUG]: Attempting to load yaml from string of length 35 with allowed root types (<class 'dict'>,)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,337 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,)
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,337 - util.py[DEBUG]: loaded blob returned None, returning default.
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,337 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance
Jul 18 13:42:18 debian-autoinstall cloud-init[1877]: 2023-07-18 10:42:18,337 - util.py[DEBUG]: Creating symbolic link from '/var/lib/cloud/instance' => '/var/lib/cloud/instances/None'
Jul 18 13:42:18 DEDICATED-13492-1 systemd[1]: cloud-init-local.service: Main process exited, code=exited, status=1/FAILURE
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,338 - util.py[DEBUG]: Reading from /var/lib/cloud/instances/None/datasource (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,338 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/None/datasource - wb: [644] 71 bytes
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,338 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-datasource - wb: [644] 71 bytes
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,338 - util.py[DEBUG]: Reading from /var/lib/cloud/data/instance-id (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,338 - stages.py[DEBUG]: previous iid found to be NO_PREVIOUS_INSTANCE_ID
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,338 - util.py[DEBUG]: Writing to /var/lib/cloud/data/instance-id - wb: [644] 5 bytes
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,338 - util.py[DEBUG]: Writing to /run/cloud-init/.instance-id - wb: [644] 5 bytes
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,339 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-instance-id - wb: [644] 24 bytes
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,339 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [400] 4108 bytes
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,339 - main.py[DEBUG]: [local] init will now be targeting instance id: None. new=True
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,339 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,339 - util.py[DEBUG]: Read 1179 bytes from /etc/cloud/cloud.cfg
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,339 - util.py[DEBUG]: Attempting to load yaml from string of length 1179 with allowed root types (<class 'dict'>,)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,341 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,341 - util.py[DEBUG]: Read 35 bytes from /run/cloud-init/cloud.cfg
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,341 - util.py[DEBUG]: Attempting to load yaml from string of length 35 with allowed root types (<class 'dict'>,)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,342 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,342 - util.py[DEBUG]: loaded blob returned None, returning default.
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,342 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'>
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,342 - cc_set_hostname.py[DEBUG]: Setting the hostname to DEDICATED-13492-1 (DEDICATED-13492-1)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,342 - util.py[DEBUG]: Reading from /etc/hostname (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,342 - util.py[DEBUG]: Read 19 bytes from /etc/hostname
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,342 - util.py[DEBUG]: Writing to /etc/hostname - wb: [644] 18 bytes
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,342 - __init__.py[DEBUG]: Non-persistently setting the system hostname to DEDICATED-13492-1
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,342 - subp.py[DEBUG]: Running command ['hostname', 'DEDICATED-13492-1'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,343 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/set-hostname (via temporary file /var/lib/cloud/data/tmp921yxhgq) - w: [644] 67 bytes/chars
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Reading from /sys/class/net/inet0/device/device (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - __init__.py[DEBUG]: ovs-vsctl not in PATH; not detecting Open vSwitch interfaces
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,344 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,345 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,345 - networking.py[DEBUG]: net: waiting for expected net devices: {'3c:ec:ef:c6:5b:cc'}
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,345 - subp.py[DEBUG]: Running command ['udevadm', 'settle', '--exit-if-exists=/sys/class/net/inet0/'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,360 - util.py[DEBUG]: Waiting for settle or inet0 exists took 0.015 seconds
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,360 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,360 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,360 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,360 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,360 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,360 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,361 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,361 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,361 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,361 - networking.py[DEBUG]: net: waiting for expected net devices: {'3c:ec:ef:c6:5b:cc'}
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,361 - subp.py[DEBUG]: Running command ['udevadm', 'settle', '--exit-if-exists=/sys/class/net/inet0/'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:42:18 DEDICATED-13492-1 systemd[1]: cloud-init-local.service: Failed with result 'exit-code'.
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,376 - util.py[DEBUG]: Waiting for settle or inet0 exists took 0.015 seconds
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,376 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,376 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,376 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,376 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,376 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,376 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,376 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,377 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,377 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,377 - networking.py[DEBUG]: net: waiting for expected net devices: {'3c:ec:ef:c6:5b:cc'}
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,377 - subp.py[DEBUG]: Running command ['udevadm', 'settle', '--exit-if-exists=/sys/class/net/inet0/'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,392 - util.py[DEBUG]: Waiting for settle or inet0 exists took 0.015 seconds
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,392 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,392 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,392 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,392 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,392 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,392 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,392 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,392 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,392 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,393 - networking.py[DEBUG]: net: waiting for expected net devices: {'3c:ec:ef:c6:5b:cc'}
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,393 - subp.py[DEBUG]: Running command ['udevadm', 'settle', '--exit-if-exists=/sys/class/net/inet0/'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,408 - util.py[DEBUG]: Waiting for settle or inet0 exists took 0.015 seconds
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,408 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,408 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,408 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,408 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,408 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,408 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,408 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,408 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,408 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,409 - networking.py[DEBUG]: net: waiting for expected net devices: {'3c:ec:ef:c6:5b:cc'}
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,409 - subp.py[DEBUG]: Running command ['udevadm', 'settle', '--exit-if-exists=/sys/class/net/inet0/'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,424 - util.py[DEBUG]: Waiting for settle or inet0 exists took 0.016 seconds
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,424 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,424 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,424 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,424 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,424 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,424 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,424 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,424 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,425 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,425 - networking.py[WARNING]: Not all expected physical devices present: {'3c:ec:ef:c6:5b:cc'}
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,425 - util.py[WARNING]: failed stage init-local
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,425 - util.py[DEBUG]: failed stage init-local
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: Traceback (most recent call last):
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:   File "/usr/lib/python3/dist-packages/cloudinit/cmd/main.py", line 767, in status_wrapper
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:     ret = functor(name, args)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:           ^^^^^^^^^^^^^^^^^^^
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:   File "/usr/lib/python3/dist-packages/cloudinit/cmd/main.py", line 433, in main_init
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:     init.apply_network_config(bring_up=bring_up_interfaces)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:   File "/usr/lib/python3/dist-packages/cloudinit/stages.py", line 924, in apply_network_config
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:     self.distro.networking.wait_for_physdevs(netcfg)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:   File "/usr/lib/python3/dist-packages/cloudinit/distros/networking.py", line 179, in wait_for_physdevs
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:     raise RuntimeError(msg)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: RuntimeError: Not all expected physical devices present: {'3c:ec:ef:c6:5b:cc'}
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: failed run of stage init-local
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: ------------------------------------------------------------
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: Traceback (most recent call last):
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:   File "/usr/lib/python3/dist-packages/cloudinit/cmd/main.py", line 767, in status_wrapper
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:     ret = functor(name, args)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:           ^^^^^^^^^^^^^^^^^^^
Jul 18 13:42:18 DEDICATED-13492-1 systemd[1]: Failed to start cloud-init-local.service - Initial cloud-init job (pre-networking).
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:   File "/usr/lib/python3/dist-packages/cloudinit/cmd/main.py", line 433, in main_init
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:     init.apply_network_config(bring_up=bring_up_interfaces)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:   File "/usr/lib/python3/dist-packages/cloudinit/stages.py", line 924, in apply_network_config
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:     self.distro.networking.wait_for_physdevs(netcfg)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:   File "/usr/lib/python3/dist-packages/cloudinit/distros/networking.py", line 179, in wait_for_physdevs
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]:     raise RuntimeError(msg)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: RuntimeError: Not all expected physical devices present: {'3c:ec:ef:c6:5b:cc'}
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: ------------------------------------------------------------
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,427 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/status.json (via temporary file /var/lib/cloud/data/tmp0tl5b6eb) - w: [644] 550 bytes/chars
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,428 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,428 - util.py[DEBUG]: Read 12 bytes from /proc/uptime
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,428 - util.py[DEBUG]: cloud-init mode 'init' took 0.246 seconds (0.25)
Jul 18 13:42:18 DEDICATED-13492-1 cloud-init[1877]: 2023-07-18 10:42:18,428 - handlers.py[DEBUG]: finish: init-local: SUCCESS: searching for local datasources
nanalncux commented 1 year ago

For ubuntu 22.04 the issue on the same server is not reproducible.

Jun 26 09:41:48 localhost.localdomain systemd[1]: Starting Initial cloud-init job (pre-networking)...
Jun 26 09:41:49 localhost.localdomain cloud-init[596]: Cloud-init v. 23.1.2-0ubuntu0~22.04.1 running 'init-local' at Mon, 26 Jun 2023 09:41:49 +0000. Up 12.99 seconds.
Jun 26 09:41:49 localhost.localdomain systemd[1]: Finished Initial cloud-init job (pre-networking).
-- Boot 685ded5c29914071aaf9d2a40951bf12 --
Jul 18 13:04:54 ubuntu-autoinstall systemd[1]: Starting Initial cloud-init job (pre-networking)...
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: WARN: no logging configured! (tried 0 configs)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: Setting up basic logging...
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: Cloud-init v. 23.1.2-0ubuntu0~22.04.1 running 'init-local' at Tue, 18 Jul 2023 13:04:54 +0000. Up 6.19 seconds.
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,386 - util.py[DEBUG]: Cloud-init v. 23.1.2-0ubuntu0~22.04.1 running 'init-local' at Tue, 18 Jul 2023 13:04:54 +0000. Up 6.19 seconds.
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,386 - main.py[DEBUG]: No kernel command line url found.
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,386 - main.py[DEBUG]: Closing stdin.
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,387 - util.py[DEBUG]: Writing to /var/log/cloud-init.log - ab: [640] 0 bytes
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,387 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance/boot-finished
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,387 - handlers.py[DEBUG]: start: init-local/check-cache: attempting to read from cache [check]
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,387 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/obj.pkl (quiet=False)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,388 - util.py[DEBUG]: Read 8656 bytes from /var/lib/cloud/instance/obj.pkl
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,390 - stages.py[DEBUG]: cache invalid in datasource: DataSourceNone
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,390 - handlers.py[DEBUG]: finish: init-local/check-cache: SUCCESS: cache invalid in datasource: DataSourceNone
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,390 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,390 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'>
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,390 - __init__.py[DEBUG]: Looking for data source in: ['NoCloud', 'None'], via packages ['', 'cloudinit.sources'] that matches dependencies ['FILESYSTEM']
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - __init__.py[DEBUG]: Searching for local data source in: ['DataSourceNoCloud']
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - handlers.py[DEBUG]: start: init-local/search-NoCloud: searching for local data from DataSourceNoCloud
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - __init__.py[DEBUG]: Seeing if we can get any data from <class 'cloudinit.sources.DataSourceNoCloud.DataSourceNoCloud'>
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - __init__.py[DEBUG]: Update datasource metadata and network config due to events: boot-new-instance
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - __init__.py[DEBUG]: Machine is configured to run on single datasource DataSourceNoCloud [seed=None][dsmode=net].
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - dmi.py[DEBUG]: querying dmi data /sys/class/dmi/id/product_serial
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/user-data (quiet=False)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/meta-data (quiet=False)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/vendor-data (quiet=False)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/network-config (quiet=False)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,391 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/user-data (quiet=False)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,392 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/meta-data (quiet=False)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,392 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/vendor-data (quiet=False)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,392 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/network-config (quiet=False)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,392 - subp.py[DEBUG]: Running command ['blkid', '-tTYPE=vfat', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,422 - subp.py[DEBUG]: Running command ['blkid', '-tTYPE=iso9660', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,439 - subp.py[DEBUG]: Running command ['blkid', '-tLABEL=CIDATA', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,455 - subp.py[DEBUG]: Running command ['blkid', '-tLABEL=cidata', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,471 - subp.py[DEBUG]: Running command ['blkid', '-tLABEL_FATBOOT=cidata', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,488 - DataSourceNoCloud.py[DEBUG]: Attempting to use data from /dev/nvme0n1p5
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,488 - util.py[DEBUG]: Reading from /proc/mounts (quiet=False)
Jul 18 13:04:54 ubuntu-autoinstall cloud-init[2143]: 2023-07-18 13:04:54,488 - util.py[DEBUG]: Read 2049 bytes from /proc/mounts
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,488 - util.py[DEBUG]: Fetched {'proc': {'fstype': 'proc', 'mountpoint': '/proc', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'sysfs': {'fstype': 'sysfs', 'mountpoint': '/sys', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'devtmpfs': {'fstype': 'devtmpfs', 'mountpoint': '/dev', 'opts': 'rw,nosuid,size=4096k,nr_inodes=131072,mode=755,inode64'}, 'securityfs': {'fstype': 'securityfs', 'mountpoint': '/sys/kernel/security', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'tmpfs': {'fstype': 'tmpfs', 'mountpoint': '/run/lock', 'opts': 'rw,nosuid,nodev,noexec,relatime,size=5120k,inode64'}, 'devpts': {'fstype': 'devpts', 'mountpoint': '/dev/pts', 'opts': 'rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000'}, 'cgroup2': {'fstype': 'cgroup2', 'mountpoint': '/sys/fs/cgroup', 'opts': 'rw,nosuid,nodev,noexec,relatime,nsdelegate,memory_recursiveprot'}, 'pstore': {'fstype': 'pstore', 'mountpoint': '/sys/fs/pstore', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'efivarfs': {'fstype': 'efivarfs', 'mountpoint': '/sys/firmware/efi/efivars', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'bpf': {'fstype': 'bpf', 'mountpoint': '/sys/fs/bpf', 'opts': 'rw,nosuid,nodev,noexec,relatime,mode=700'}, '/dev/md127': {'fstype': 'ext4', 'mountpoint': '/', 'opts': 'rw,relatime,stripe=32'}, 'systemd-1': {'fstype': 'autofs', 'mountpoint': '/proc/sys/fs/binfmt_misc', 'opts': 'rw,relatime,fd=30,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=101457'}, 'hugetlbfs': {'fstype': 'hugetlbfs', 'mountpoint': '/dev/hugepages', 'opts': 'rw,relatime,pagesize=2M'}, 'mqueue': {'fstype': 'mqueue', 'mountpoint': '/dev/mqueue', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'debugfs': {'fstype': 'debugfs', 'mountpoint': '/sys/kernel/debug', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'tracefs': {'fstype': 'tracefs', 'mountpoint': '/sys/kernel/tracing', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'fusectl': {'fstype': 'fusectl', 'mountpoint': '/sys/fs/fuse/connections', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'configfs': {'fstype': 'configfs', 'mountpoint': '/sys/kernel/config', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'none': {'fstype': 'ramfs', 'mountpoint': '/run/credentials/systemd-sysusers.service', 'opts': 'ro,nosuid,nodev,noexec,relatime,mode=700'}, '/dev/loop0': {'fstype': 'squashfs', 'mountpoint': '/snap/core20/1822', 'opts': 'ro,nodev,relatime,errors=continue'}, '/dev/loop1': {'fstype': 'squashfs', 'mountpoint': '/snap/lxd/24322', 'opts': 'ro,nodev,relatime,errors=continue'}, '/dev/loop2': {'fstype': 'squashfs', 'mountpoint': '/snap/snapd/18357', 'opts': 'ro,nodev,relatime,errors=continue'}, '/dev/md126': {'fstype': 'ext3', 'mountpoint': '/boot', 'opts': 'rw,relatime,stripe=32'}, '/dev/nvme0n1p4': {'fstype': 'vfat', 'mountpoint': '/boot/efi', 'opts': 'rw,relatime,fmask=0022,dmask=0022,codepage=437,iocharset=ascii,shortname=mixed,utf8,errors=remount-ro'}, 'binfmt_misc': {'fstype': 'binfmt_misc', 'mountpoint': '/proc/sys/fs/binfmt_misc', 'opts': 'rw,nosuid,nodev,noexec,relatime'}} mounts from proc
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,488 - subp.py[DEBUG]: Running command ['mount', '-o', 'ro', '-t', 'auto', '/dev/nvme0n1p5', '/run/cloud-init/tmp/tmp08tn4myk'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,497 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmp08tn4myk//user-data (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,497 - util.py[DEBUG]: Read 13 bytes from /run/cloud-init/tmp/tmp08tn4myk//user-data
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,497 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmp08tn4myk//meta-data (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,497 - util.py[DEBUG]: Read 259 bytes from /run/cloud-init/tmp/tmp08tn4myk//meta-data
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,497 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmp08tn4myk//vendor-data (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,497 - util.py[DEBUG]: Read 308 bytes from /run/cloud-init/tmp/tmp08tn4myk//vendor-data
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,497 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmp08tn4myk//network-config (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,497 - subp.py[DEBUG]: Running command ['umount', '/run/cloud-init/tmp/tmp08tn4myk'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,507 - util.py[DEBUG]: Attempting to load yaml from string of length 259 with allowed root types (<class 'dict'>,)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,507 - DataSourceNoCloud.py[DEBUG]: Using data from /dev/nvme0n1p5
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,508 - util.py[DEBUG]: Writing to /run/cloud-init/cloud-id-nocloud - wb: [644] 8 bytes
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,508 - util.py[DEBUG]: Creating symbolic link from '/run/cloud-init/cloud-id' => '/run/cloud-init/cloud-id-nocloud'
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,508 - atomic_helper.py[DEBUG]: Atomically writing to file /run/cloud-init/instance-data-sensitive.json (via temporary file /run/cloud-init/tmpjwwt2i50) - w: [600] 3397 bytes/chars
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,509 - atomic_helper.py[DEBUG]: Atomically writing to file /run/cloud-init/instance-data.json (via temporary file /run/cloud-init/tmpdor7d6gb) - w: [644] 1662 bytes/chars
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,509 - handlers.py[DEBUG]: finish: init-local/search-NoCloud: SUCCESS: found local data from DataSourceNoCloud
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,509 - stages.py[INFO]: Loaded datasource DataSourceNoCloud - DataSourceNoCloud [seed=/dev/nvme0n1p5][dsmode=net]
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,509 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,509 - util.py[DEBUG]: Read 1179 bytes from /etc/cloud/cloud.cfg
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,509 - util.py[DEBUG]: Attempting to load yaml from string of length 1179 with allowed root types (<class 'dict'>,)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,512 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,512 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,512 - util.py[DEBUG]: loaded blob returned None, returning default.
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,513 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,513 - util.py[DEBUG]: Creating symbolic link from '/var/lib/cloud/instance' => '/var/lib/cloud/instances/None'
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,513 - util.py[DEBUG]: Reading from /var/lib/cloud/instances/None/datasource (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,513 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/None/datasource - wb: [644] 71 bytes
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,513 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-datasource - wb: [644] 71 bytes
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,514 - util.py[DEBUG]: Reading from /var/lib/cloud/data/instance-id (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,514 - util.py[DEBUG]: Read 20 bytes from /var/lib/cloud/data/instance-id
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,514 - stages.py[DEBUG]: previous iid found to be iid-datasource-none
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,514 - util.py[DEBUG]: Writing to /var/lib/cloud/data/instance-id - wb: [644] 5 bytes
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,514 - util.py[DEBUG]: Writing to /run/cloud-init/.instance-id - wb: [644] 5 bytes
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,514 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-instance-id - wb: [644] 20 bytes
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,515 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [400] 4500 bytes
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,515 - main.py[DEBUG]: [local] init will now be targeting instance id: None. new=True
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,515 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,515 - util.py[DEBUG]: Read 1179 bytes from /etc/cloud/cloud.cfg
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,515 - util.py[DEBUG]: Attempting to load yaml from string of length 1179 with allowed root types (<class 'dict'>,)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,518 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,518 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,518 - util.py[DEBUG]: loaded blob returned None, returning default.
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,519 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'>
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,519 - util.py[DEBUG]: Reading from /var/lib/cloud/data/set-hostname (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,519 - util.py[DEBUG]: Read 55 bytes from /var/lib/cloud/data/set-hostname
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,519 - cc_set_hostname.py[DEBUG]: Setting the hostname to DEDICATED-13492-1 (DEDICATED-13492-1)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,519 - util.py[DEBUG]: Reading from /etc/hostname (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,519 - util.py[DEBUG]: Read 19 bytes from /etc/hostname
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,519 - util.py[DEBUG]: Writing to /etc/hostname - wb: [644] 18 bytes
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,519 - __init__.py[DEBUG]: Non-persistently setting the system hostname to DEDICATED-13492-1
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,519 - subp.py[DEBUG]: Running command ['hostname', 'DEDICATED-13492-1'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,520 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/set-hostname (via temporary file /var/lib/cloud/data/tmp4jcgivsw) - w: [644] 67 bytes/chars
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Reading from /sys/class/net/eth2/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth2/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Reading from /sys/class/net/eth1/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth1/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Reading from /sys/class/net/eth2/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth2/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Reading from /sys/class/net/eth1/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth1/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Reading from /sys/class/net/inet0/device/device (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,521 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - __init__.py[DEBUG]: ovs-vsctl not in PATH; not detecting Open vSwitch interfaces
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/eth2/addr_assign_type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth2/addr_assign_type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/eth2/uevent (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth2/uevent
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/eth2/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth2/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/eth2/device/device (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/eth0/addr_assign_type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/addr_assign_type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/eth0/uevent (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth0/uevent
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 7 bytes from /sys/class/net/eth0/device/device
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/eth1/addr_assign_type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth1/addr_assign_type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Reading from /sys/class/net/eth1/uevent (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,522 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth1/uevent
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/eth1/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth1/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/eth1/device/device (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 7 bytes from /sys/class/net/eth1/device/device
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/eth2/type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth2/type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/eth0/type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/eth1/type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth1/type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - networking.py[DEBUG]: net: all expected physical devices present
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - stages.py[DEBUG]: applying net config names for {'version': 1, 'config': [{'type': 'physical', 'name': 'inet0', 'subnets': [{'_orig_eni_name': 'inet0', 'type': 'static', 'control': 'manual', 'address': '192.168.0.2', 'netmask': '255.255.255.0', 'gateway': '192.168.0.1', 'dns_nameservers': ['8.8.8.8', '1.1.1.1']}], 'mac_address': '3c:ec:ef:c6:5b:cc'}]}
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/inet0/device/device (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/eth2/addr_assign_type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth2/addr_assign_type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/eth2/uevent (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth2/uevent
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/eth2/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth2/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/eth2/device/device (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,523 - util.py[DEBUG]: Reading from /sys/class/net/eth0/addr_assign_type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/addr_assign_type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/eth0/uevent (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth0/uevent
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 7 bytes from /sys/class/net/eth0/device/device
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/eth1/addr_assign_type (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth1/addr_assign_type
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/eth1/uevent (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth1/uevent
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/eth1/address (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth1/address
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/eth1/device/device (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 7 bytes from /sys/class/net/eth1/device/device
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/lo/operstate (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 8 bytes from /sys/class/net/lo/operstate
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/eth2/operstate (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 5 bytes from /sys/class/net/eth2/operstate
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/eth0/operstate (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 5 bytes from /sys/class/net/eth0/operstate
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Reading from /sys/class/net/eth1/operstate (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - util.py[DEBUG]: Read 5 bytes from /sys/class/net/eth1/operstate
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,524 - subp.py[DEBUG]: Running command ['ip', '-6', 'addr', 'show', 'permanent', 'scope', 'global'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,528 - subp.py[DEBUG]: Running command ['ip', '-4', 'addr', 'show'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,529 - __init__.py[DEBUG]: Detected interfaces {'lo': {'downable': False, 'device_id': None, 'driver': None, 'mac': '00:00:00:00:00:00', 'name': 'lo', 'up': True}, 'eth2': {'downable': True, 'device_id': None, 'driver': 'rndis_host', 'mac': 'b0:3a:f2:b6:05:9f', 'name': 'eth2', 'up': False}, 'eth0': {'downable': True, 'device_id': '0x165f', 'driver': 'tg3', 'mac': '3c:ec:ef:c6:5b:cc', 'name': 'eth0', 'up': False}, 'eth1': {'downable': True, 'device_id': '0x165f', 'driver': 'tg3', 'mac': '3c:ec:ef:c6:5b:cd', 'name': 'eth1', 'up': False}}
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,529 - __init__.py[DEBUG]: achieving renaming of [['3c:ec:ef:c6:5b:cc', 'inet0', None, None]] with ops [('rename', '3c:ec:ef:c6:5b:cc', 'inet0', ('eth0', 'inet0'))]
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,529 - subp.py[DEBUG]: Running command ['ip', 'link', 'set', 'eth0', 'name', 'inet0'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,567 - stages.py[INFO]: Applying network configuration from ds bringup=False: {'version': 1, 'config': [{'type': 'physical', 'name': 'inet0', 'subnets': [{'_orig_eni_name': 'inet0', 'type': 'static', 'control': 'manual', 'address': '192.168.0.2', 'netmask': '255.255.255.0', 'gateway': '192.168.0.1', 'dns_nameservers': ['8.8.8.8', '1.1.1.1']}], 'mac_address': '3c:ec:ef:c6:5b:cc'}]}
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,568 - util.py[DEBUG]: Writing to /run/cloud-init/sem/apply_network_config.once - wb: [644] 24 bytes
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,568 - __init__.py[DEBUG]: Selected renderer 'netplan' from priority list: None
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,570 - subp.py[DEBUG]: Running command ['netplan', 'info'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,647 - util.py[DEBUG]: Attempting to load yaml from string of length 311 with allowed root types (<class 'dict'>,)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,649 - util.py[DEBUG]: Writing to /etc/netplan/50-cloud-init.yaml - wb: [644] 708 bytes
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,649 - subp.py[DEBUG]: Running command ['netplan', 'generate'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,755 - subp.py[DEBUG]: Running command ['udevadm', 'test-builtin', 'net_setup_link', '/sys/class/net/lo'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,758 - subp.py[DEBUG]: Running command ['udevadm', 'test-builtin', 'net_setup_link', '/sys/class/net/eth2'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,761 - subp.py[DEBUG]: Running command ['udevadm', 'test-builtin', 'net_setup_link', '/sys/class/net/inet0'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,764 - subp.py[DEBUG]: Running command ['udevadm', 'test-builtin', 'net_setup_link', '/sys/class/net/eth1'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,767 - __init__.py[DEBUG]: Not bringing up newly configured network interfaces
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,767 - main.py[DEBUG]: [local] Exiting. datasource DataSourceNoCloud [seed=/dev/nvme0n1p5][dsmode=net] not in local mode.
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,767 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/status.json (via temporary file /var/lib/cloud/data/tmp5zdwivn5) - w: [644] 524 bytes/chars
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,767 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,767 - util.py[DEBUG]: Read 12 bytes from /proc/uptime
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,767 - util.py[DEBUG]: cloud-init mode 'init' took 0.400 seconds (0.40)
Jul 18 13:04:54 DEDICATED-13492-1 cloud-init[2143]: 2023-07-18 13:04:54,768 - handlers.py[DEBUG]: finish: init-local: SUCCESS: searching for local datasources
Jul 18 13:04:54 DEDICATED-13492-1 systemd[1]: Finished Initial cloud-init job (pre-networking).
nanalncux commented 1 year ago

Debian 12. Problem reproduced when using cloud-init v23.2.1

Jul 18 18:02:20 proxmox cloud-init[1744]: WARN: no logging configured! (tried 0 configs)
Jul 18 18:02:20 proxmox cloud-init[1744]: Setting up basic logging...
Jul 18 18:02:20 proxmox cloud-init[1744]: Cloud-init v. 23.2.1 running 'init-local' at Tue, 18 Jul 2023 15:02:20 +0000. Up 5.52 seconds.
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,824 - util.py[DEBUG]: Cloud-init v. 23.2.1 running 'init-local' at Tue, 18 Jul 2023 15:02:20 +0000. Up 5.52 seconds.
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,824 - main.py[DEBUG]: No kernel command line url found.
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,824 - main.py[DEBUG]: Closing stdin.
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,826 - util.py[DEBUG]: Writing to /var/log/cloud-init.log - ab: [640] 0 bytes
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,826 - util.py[DEBUG]: Writing to /var/lib/cloud/data/python-version - wb: [644] 4 bytes
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,826 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance/boot-finished
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,826 - handlers.py[DEBUG]: start: init-local/check-cache: attempting to read from cache [check]
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,826 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/obj.pkl (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,826 - stages.py[DEBUG]: no cache found
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,826 - handlers.py[DEBUG]: finish: init-local/check-cache: SUCCESS: no cache found
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,826 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,828 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'>
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,828 - __init__.py[DEBUG]: Looking for data source in: ['NoCloud', 'None'], via packages ['', 'cloudinit.sources'] that matches dependencies ['FILESYSTEM']
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - __init__.py[DEBUG]: Searching for local data source in: ['DataSourceNoCloud']
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - handlers.py[DEBUG]: start: init-local/search-NoCloud: searching for local data from DataSourceNoCloud
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - __init__.py[DEBUG]: Seeing if we can get any data from <class 'cloudinit.sources.DataSourceNoCloud.DataSourceNoCloud'>
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - __init__.py[DEBUG]: Update datasource metadata and network config due to events: boot-new-instance
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - __init__.py[DEBUG]: Machine is configured to run on single datasource DataSourceNoCloud [seed=None][dsmode=net].
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - dmi.py[DEBUG]: querying dmi data /sys/class/dmi/id/product_serial
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/user-data (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/meta-data (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/vendor-data (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud/network-config (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/user-data (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/meta-data (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/vendor-data (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - util.py[DEBUG]: Reading from /var/lib/cloud/seed/nocloud-net/network-config (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,829 - subp.py[DEBUG]: Running command ['blkid', '-tTYPE=vfat', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,863 - subp.py[DEBUG]: Running command ['blkid', '-tTYPE=iso9660', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,881 - subp.py[DEBUG]: Running command ['blkid', '-tLABEL=CIDATA', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,898 - subp.py[DEBUG]: Running command ['blkid', '-tLABEL=cidata', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,915 - subp.py[DEBUG]: Running command ['blkid', '-tLABEL_FATBOOT=cidata', '-odevice'] with allowed return codes [0, 2] (shell=False, capture=True)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,931 - DataSourceNoCloud.py[DEBUG]: Attempting to use data from /dev/nvme0n1p4
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,931 - util.py[DEBUG]: Reading from /proc/mounts (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,931 - util.py[DEBUG]: Read 1762 bytes from /proc/mounts
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,931 - util.py[DEBUG]: Fetched {'proc': {'fstype': 'proc', 'mountpoint': '/proc', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'sysfs': {'fstype': 'sysfs', 'mountpoint': '/sys', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'devtmpfs': {'fstype': 'devtmpfs', 'mountpoint': '/dev', 'opts': 'rw,nosuid,size=4096k,nr_inodes=66011887,mode=755,inode64'}, 'securityfs': {'fstype': 'securityfs', 'mountpoint': '/sys/kernel/security', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'tmpfs': {'fstype': 'tmpfs', 'mountpoint': '/run/lock', 'opts': 'rw,nosuid,nodev,noexec,relatime,size=5120k,inode64'}, 'devpts': {'fstype': 'devpts', 'mountpoint': '/dev/pts', 'opts': 'rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000'}, 'cgroup2': {'fstype': 'cgroup2', 'mountpoint': '/sys/fs/cgroup', 'opts': 'rw,nosuid,nodev,noexec,relatime,nsdelegate,memory_recursiveprot'}, 'pstore': {'fstype': 'pstore', 'mountpoint': '/sys/fs/pstore', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'efivarfs': {'fstype': 'efivarfs', 'mountpoint': '/sys/firmware/efi/efivars', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'bpf': {'fstype': 'bpf', 'mountpoint': '/sys/fs/bpf', 'opts': 'rw,nosuid,nodev,noexec,relatime,mode=700'}, 'configfs': {'fstype': 'configfs', 'mountpoint': '/sys/kernel/config', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, '/dev/md126': {'fstype': 'ext4', 'mountpoint': '/', 'opts': 'rw,relatime,stripe=32'}, 'systemd-1': {'fstype': 'autofs', 'mountpoint': '/proc/sys/fs/binfmt_misc', 'opts': 'rw,relatime,fd=29,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=28672'}, 'hugetlbfs': {'fstype': 'hugetlbfs', 'mountpoint': '/dev/hugepages', 'opts': 'rw,relatime,pagesize=2M'}, 'mqueue': {'fstype': 'mqueue', 'mountpoint': '/dev/mqueue', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'debugfs': {'fstype': 'debugfs', 'mountpoint': '/sys/kernel/debug', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'tracefs': {'fstype': 'tracefs', 'mountpoint': '/sys/kernel/tracing', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'fusectl': {'fstype': 'fusectl', 'mountpoint': '/sys/fs/fuse/connections', 'opts': 'rw,nosuid,nodev,noexec,relatime'}, 'ramfs': {'fstype': 'ramfs', 'mountpoint': '/run/credentials/systemd-tmpfiles-setup-dev.service', 'opts': 'ro,nosuid,nodev,noexec,relatime,mode=700'}} mounts from proc
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,931 - subp.py[DEBUG]: Running command ['mount', '-o', 'ro', '-t', 'auto', '/dev/nvme0n1p4', '/run/cloud-init/tmp/tmp4xaeomki'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,936 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmp4xaeomki//user-data (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,936 - util.py[DEBUG]: Read 13 bytes from /run/cloud-init/tmp/tmp4xaeomki//user-data
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,936 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmp4xaeomki//meta-data (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,937 - util.py[DEBUG]: Read 272 bytes from /run/cloud-init/tmp/tmp4xaeomki//meta-data
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,937 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmp4xaeomki//vendor-data (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,937 - util.py[DEBUG]: Read 554 bytes from /run/cloud-init/tmp/tmp4xaeomki//vendor-data
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,937 - util.py[DEBUG]: Reading from /run/cloud-init/tmp/tmp4xaeomki//network-config (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,937 - subp.py[DEBUG]: Running command ['umount', '/run/cloud-init/tmp/tmp4xaeomki'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,944 - util.py[DEBUG]: Attempting to load yaml from string of length 272 with allowed root types (<class 'dict'>,)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,945 - DataSourceNoCloud.py[DEBUG]: Using data from /dev/nvme0n1p4
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,945 - util.py[DEBUG]: Writing to /run/cloud-init/cloud-id-nocloud - wb: [644] 8 bytes
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,946 - util.py[DEBUG]: Creating symbolic link from '/run/cloud-init/cloud-id' => '/run/cloud-init/cloud-id-nocloud'
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,946 - atomic_helper.py[DEBUG]: Atomically writing to file /run/cloud-init/instance-data-sensitive.json (via temporary file /run/cloud-init/tmpk0ggcpoj) - w: [600] 2909 bytes/chars
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,946 - atomic_helper.py[DEBUG]: Atomically writing to file /run/cloud-init/instance-data.json (via temporary file /run/cloud-init/tmpprg8bw_o) - w: [644] 1645 bytes/chars
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,946 - handlers.py[DEBUG]: finish: init-local/search-NoCloud: SUCCESS: found local data from DataSourceNoCloud
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,946 - stages.py[INFO]: Loaded datasource DataSourceNoCloud - DataSourceNoCloud [seed=/dev/nvme0n1p4][dsmode=net]
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,946 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,946 - util.py[DEBUG]: Read 1194 bytes from /etc/cloud/cloud.cfg
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,946 - util.py[DEBUG]: Attempting to load yaml from string of length 1194 with allowed root types (<class 'dict'>,)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,949 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,949 - util.py[DEBUG]: Read 35 bytes from /run/cloud-init/cloud.cfg
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,949 - util.py[DEBUG]: Attempting to load yaml from string of length 35 with allowed root types (<class 'dict'>,)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,949 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,949 - util.py[DEBUG]: loaded blob returned None, returning default.
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,949 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,949 - util.py[DEBUG]: Creating symbolic link from '/var/lib/cloud/instance' => '/var/lib/cloud/instances/None'
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,950 - util.py[DEBUG]: Reading from /var/lib/cloud/instances/None/datasource (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,950 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/None/datasource - wb: [644] 71 bytes
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,950 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-datasource - wb: [644] 71 bytes
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,950 - util.py[DEBUG]: Reading from /var/lib/cloud/data/instance-id (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,950 - stages.py[DEBUG]: previous iid found to be NO_PREVIOUS_INSTANCE_ID
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,950 - util.py[DEBUG]: Writing to /var/lib/cloud/data/instance-id - wb: [644] 5 bytes
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,951 - util.py[DEBUG]: Writing to /run/cloud-init/.instance-id - wb: [644] 5 bytes
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,951 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-instance-id - wb: [644] 24 bytes
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,951 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [400] 4420 bytes
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,951 - main.py[DEBUG]: [local] init will now be targeting instance id: None. new=True
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,951 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,951 - util.py[DEBUG]: Read 1194 bytes from /etc/cloud/cloud.cfg
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,951 - util.py[DEBUG]: Attempting to load yaml from string of length 1194 with allowed root types (<class 'dict'>,)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,954 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,954 - util.py[DEBUG]: Read 35 bytes from /run/cloud-init/cloud.cfg
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,954 - util.py[DEBUG]: Attempting to load yaml from string of length 35 with allowed root types (<class 'dict'>,)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,954 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,954 - util.py[DEBUG]: loaded blob returned None, returning default.
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,954 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'>
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,954 - cc_set_hostname.py[DEBUG]: Setting the hostname to DEDICATED-13492-p (DEDICATED-13492-p)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,954 - util.py[DEBUG]: Reading from /etc/hostname (quiet=False)
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,954 - util.py[DEBUG]: Read 8 bytes from /etc/hostname
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,954 - util.py[DEBUG]: Writing to /etc/hostname - wb: [644] 18 bytes
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,955 - __init__.py[DEBUG]: Non-persistently setting the system hostname to DEDICATED-13492-p
Jul 18 18:02:20 proxmox cloud-init[1744]: 2023-07-18 15:02:20,955 - subp.py[DEBUG]: Running command ['hostname', 'DEDICATED-13492-p'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,956 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/set-hostname (via temporary file /var/lib/cloud/data/tmpgyocdp3u) - w: [644] 67 bytes/chars
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,956 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,956 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Reading from /sys/class/net/inet0/device/device (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - __init__.py[DEBUG]: ovs-vsctl not in PATH; not detecting Open vSwitch interfaces
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - networking.py[DEBUG]: net: waiting for expected net devices: {'3c:ec:ef:c6:5b:cc'}
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,957 - subp.py[DEBUG]: Running command ['udevadm', 'settle', '--exit-if-exists=/sys/class/net/inet0/'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,966 - util.py[DEBUG]: Waiting for settle or inet0 exists took 0.009 seconds
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,966 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,966 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,966 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,966 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,966 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,966 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,966 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,967 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,967 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,967 - networking.py[DEBUG]: net: waiting for expected net devices: {'3c:ec:ef:c6:5b:cc'}
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,967 - subp.py[DEBUG]: Running command ['udevadm', 'settle', '--exit-if-exists=/sys/class/net/inet0/'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,986 - util.py[DEBUG]: Waiting for settle or inet0 exists took 0.019 seconds
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,986 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,986 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,986 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,986 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,986 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,986 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,986 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,986 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,987 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,987 - networking.py[DEBUG]: net: waiting for expected net devices: {'3c:ec:ef:c6:5b:cc'}
Jul 18 18:02:20 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:20,987 - subp.py[DEBUG]: Running command ['udevadm', 'settle', '--exit-if-exists=/sys/class/net/inet0/'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,006 - util.py[DEBUG]: Waiting for settle or inet0 exists took 0.019 seconds
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,006 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,006 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,006 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,006 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,006 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,006 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,006 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,006 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,007 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,007 - networking.py[DEBUG]: net: waiting for expected net devices: {'3c:ec:ef:c6:5b:cc'}
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,007 - subp.py[DEBUG]: Running command ['udevadm', 'settle', '--exit-if-exists=/sys/class/net/inet0/'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,022 - util.py[DEBUG]: Waiting for settle or inet0 exists took 0.015 seconds
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,022 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,022 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,022 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,022 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,022 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,022 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,022 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,022 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,022 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,023 - networking.py[DEBUG]: net: waiting for expected net devices: {'3c:ec:ef:c6:5b:cc'}
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,023 - subp.py[DEBUG]: Running command ['udevadm', 'settle', '--exit-if-exists=/sys/class/net/inet0/'] with allowed return codes [0] (shell=False, capture=True)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,042 - util.py[DEBUG]: Waiting for settle or inet0 exists took 0.020 seconds
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,042 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,042 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,042 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,042 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,042 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,043 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,043 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,043 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,043 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,043 - networking.py[WARNING]: Not all expected physical devices present: {'3c:ec:ef:c6:5b:cc'}
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,043 - util.py[WARNING]: failed stage init-local
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,043 - util.py[DEBUG]: failed stage init-local
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: Traceback (most recent call last):
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:   File "/usr/lib/python3/dist-packages/cloudinit/cmd/main.py", line 766, in status_wrapper
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:     ret = functor(name, args)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:           ^^^^^^^^^^^^^^^^^^^
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:   File "/usr/lib/python3/dist-packages/cloudinit/cmd/main.py", line 432, in main_init
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:     init.apply_network_config(bring_up=bring_up_interfaces)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:   File "/usr/lib/python3/dist-packages/cloudinit/stages.py", line 923, in apply_network_config
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:     self.distro.networking.wait_for_physdevs(netcfg)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:   File "/usr/lib/python3/dist-packages/cloudinit/distros/networking.py", line 169, in wait_for_physdevs
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:     raise RuntimeError(msg)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: RuntimeError: Not all expected physical devices present: {'3c:ec:ef:c6:5b:cc'}
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: failed run of stage init-local
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: ------------------------------------------------------------
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: Traceback (most recent call last):
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:   File "/usr/lib/python3/dist-packages/cloudinit/cmd/main.py", line 766, in status_wrapper
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:     ret = functor(name, args)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:           ^^^^^^^^^^^^^^^^^^^
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:   File "/usr/lib/python3/dist-packages/cloudinit/cmd/main.py", line 432, in main_init
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:     init.apply_network_config(bring_up=bring_up_interfaces)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:   File "/usr/lib/python3/dist-packages/cloudinit/stages.py", line 923, in apply_network_config
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:     self.distro.networking.wait_for_physdevs(netcfg)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:   File "/usr/lib/python3/dist-packages/cloudinit/distros/networking.py", line 169, in wait_for_physdevs
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]:     raise RuntimeError(msg)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: RuntimeError: Not all expected physical devices present: {'3c:ec:ef:c6:5b:cc'}
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: ------------------------------------------------------------
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,045 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/status.json (via temporary file /var/lib/cloud/data/tmp4udn6lrz) - w: [644] 547 bytes/chars
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,045 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,045 - util.py[DEBUG]: Read 12 bytes from /proc/uptime
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,045 - util.py[DEBUG]: cloud-init mode 'init' took 0.234 seconds (0.23)
Jul 18 18:02:21 DEDICATED-13492-p cloud-init[1744]: 2023-07-18 15:02:21,046 - handlers.py[DEBUG]: finish: init-local: SUCCESS: searching for local datasources
Jul 18 18:02:21 DEDICATED-13492-p systemd[1]: cloud-init-local.service: Main process exited, code=exited, status=1/FAILURE
Jul 18 18:02:21 DEDICATED-13492-p systemd[1]: cloud-init-local.service: Failed with result 'exit-code'.
Jul 18 18:02:21 DEDICATED-13492-p systemd[1]: Failed to start cloud-init-local.service - Initial cloud-init job (pre-networking).
aciba90 commented 1 year ago

Cloud-init waits for the NIC to be configured.

It loops 5 times calling udevadm settle --exit-if-exists=/sys/class/net/inet0/ and check if the NIC is up.

This sounds to me like a race between the card and cloud-init.

Could you please attach the logs of any failing run?

nanalncux commented 1 year ago

I apologize for taking so long to answer. Apparently some problem with the naming of the interface. In the first post I have attached a meta-data file with network settings.

Changing the interface name to default eth0 did not reproduce the problem. I also added an indication of a specific poppy address to the config, but for some reason this setting was not applied to the network configuration file.

meta-data

root@host:~# cat /mnt/meta-data 
#cloud-config
instance-id: 
local-hostname: host
network-interfaces: |
  auto eth0
  iface eth0 inet static
  address 192.168.100.2
  netmask 255.255.255.0
  gateway 192.168.100.1
  hwaddress ether fc:34:97:b1:68:0a
  dns-nameservers 1.1.1.1 8.8.8.8

network config:

auto eth0
iface eth0 inet static
    address 192.168.100.1/24
    dns-nameservers 1.1.1.1 8.8.8.8
    gateway 192.168.100.1

later I will send the requested logs

SuPerCxyz commented 7 months ago

In Cloud-init 19.4, the slow startup speed of the network interface resulted in the failure of the cloud-init-local.service to read information from the config drive to generate the network configuration file. Consequently, the IP address was not configured.