canonical / canonical/cloud-init

[BUG] submitting bug as it says in the logs

Open
#5,886 1 comment 0 reactions 0 assignees View on GitHub
bug incomplete
Dominant language
Python
Stars
3.8k
Forks
1.1k
Avg merge
2d 23h
Merged PRs (30d)
18

Description

# Bug report

![image](https://github.com/user-attachments/assets/c61b82c3-3a39-40e4-bb90-3901ed416d65)

the cloud-init instance is running on bare metal

## Steps to reproduce the problem
'
start the ubuntu server and run this command

## Environment details
- Cloud-init version:
```
sudo cloud-init --version
/usr/bin/cloud-init 24.1.3-0ubuntu3.3
```
- Operating System Distribution: ubuntu 24 lts
- Cloud provider, platform or installer type: bare metal

## cloud-init logs

Here are the latest lines of cloud init
```
2024-11-18 13:33:46,924 - handlers.py[DEBUG]: start: init-network/config-growpart: running config-growpart with frequency always
2024-11-18 13:33:46,924 - helpers.py[DEBUG]: Running config-growpart using lock ()
2024-11-18 13:33:46,924 - cc_growpart.py[DEBUG]: No 'growpart' entry in cfg. Using default: {'mode': 'auto', 'devices': ['/'], 'ignore_growroot_disabled': False}
2024-11-18 13:33:46,924 - subp.py[DEBUG]: Running command ['growpart', '--help'] with allowed return codes [0] (shell=False, capture=True)
2024-11-18 13:33:46,929 - util.py[DEBUG]: Reading from /proc/1587/mountinfo (quiet=False)
2024-11-18 13:33:46,929 - util.py[DEBUG]: Read 2338 bytes from /proc/1587/mountinfo
2024-11-18 13:33:46,930 - util.py[DEBUG]: Reading from /sys/class/block/md0p1/partition (quiet=False)
2024-11-18 13:33:46,930 - util.py[DEBUG]: Read 2 bytes from /sys/class/block/md0p1/partition
2024-11-18 13:33:46,930 - util.py[DEBUG]: Reading from /sys/devices/virtual/block/md0/dev (quiet=False)
2024-11-18 13:33:46,930 - util.py[DEBUG]: Read 4 bytes from /sys/devices/virtual/block/md0/dev
2024-11-18 13:33:46,931 - util.py[DEBUG]: Reading from /proc/1587/mountinfo (quiet=False)
2024-11-18 13:33:46,931 - util.py[DEBUG]: Read 2338 bytes from /proc/1587/mountinfo
2024-11-18 13:33:46,931 - util.py[DEBUG]: Reading from /proc/1587/mountinfo (quiet=False)
2024-11-18 13:33:46,931 - util.py[DEBUG]: Read 2338 bytes from /proc/1587/mountinfo
2024-11-18 13:33:46,932 - subp.py[DEBUG]: Running command ['growpart', '--dry-run', '/dev/md0', '1'] with allowed return codes [0] (shell=False, capture=True)
2024-11-18 13:33:47,560 - subp.py[DEBUG]: command ['growpart', '--dry-run', '/dev/md0', '1'] took 0.6s to run
2024-11-18 13:33:47,561 - util.py[DEBUG]: resize_devices took 0.632 seconds
2024-11-18 13:33:47,561 - cc_growpart.py[DEBUG]: '/' NOCHANGE: no change necessary (/dev/md0, 1)
2024-11-18 13:33:47,561 - handlers.py[DEBUG]: finish: init-network/config-growpart: SUCCESS: config-growpart ran successfully
2024-11-18 13:33:47,561 - modules.py[DEBUG]: Running module resizefs () with frequency always
2024-11-18 13:33:47,562 - handlers.py[DEBUG]: start: init-network/config-resizefs: running config-resizefs with frequency always
2024-11-18 13:33:47,562 - helpers.py[DEBUG]: Running config-resizefs using lock ()
2024-11-18 13:33:47,562 - util.py[DEBUG]: Reading from /proc/1587/mountinfo (quiet=False)
2024-11-18 13:33:47,562 - util.py[DEBUG]: Read 2338 bytes from /proc/1587/mountinfo
2024-11-18 13:33:47,562 - cc_resizefs.py[DEBUG]: resize_info: dev=/dev/md0p1 mnt_point=/ path=/
2024-11-18 13:33:47,563 - cc_resizefs.py[DEBUG]: Resizing / (ext4) using resize2fs /dev/md0p1
2024-11-18 13:33:47,563 - subp.py[DEBUG]: Running command ('resize2fs', '/dev/md0p1') with allowed return codes [0] (shell=False, capture=True)
2024-11-18 13:33:49,067 - subp.py[DEBUG]: command ('resize2fs', '/dev/md0p1') took 1.5s to run
2024-11-18 13:33:49,067 - util.py[DEBUG]: Resizing took 1.505 seconds
2024-11-18 13:33:49,067 - cc_resizefs.py[DEBUG]: Resized root filesystem (type=ext4, val=True)
2024-11-18 13:33:49,067 - handlers.py[DEBUG]: finish: init-network/config-resizefs: SUCCESS: config-resizefs ran successfully
2024-11-18 13:33:49,068 - modules.py[DEBUG]: Running module mounts () with frequency once-per-instance
2024-11-18 13:33:49,068 - handlers.py[DEBUG]: start: init-network/config-mounts: running config-mounts with frequency once-per-instance
2024-11-18 13:33:49,068 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/iid-datasource-none/sem/config_mounts - wb: [644] 23 bytes
2024-11-18 13:33:49,069 - helpers.py[DEBUG]: Running config-mounts using lock ()
2024-11-18 13:33:49,069 - cc_mounts.py[DEBUG]: mounts configuration is []
2024-11-18 13:33:49,069 - util.py[DEBUG]: Reading from /etc/fstab (quiet=False)
2024-11-18 13:33:49,069 - util.py[DEBUG]: Read 714 bytes from /etc/fstab
2024-11-18 13:33:49,069 - cc_mounts.py[DEBUG]: Attempting to determine the real name of ephemeral0
2024-11-18 13:33:49,069 - cc_mounts.py[DEBUG]: changed default device ephemeral0 => None
2024-11-18 13:33:49,069 - cc_mounts.py[DEBUG]: Ignoring nonexistent default named mount ephemeral0
2024-11-18 13:33:49,069 - cc_mounts.py[DEBUG]: Attempting to determine the real name of swap
2024-11-18 13:33:49,069 - cc_mounts.py[DEBUG]: changed default device swap => None
2024-11-18 13:33:49,069 - cc_mounts.py[DEBUG]: Ignoring nonexistent default named mount swap
2024-11-18 13:33:49,069 - cc_mounts.py[DEBUG]: no need to setup swap
2024-11-18 13:33:49,070 - cc_mounts.py[DEBUG]: No modifications to fstab needed
2024-11-18 13:33:49,070 - handlers.py[DEBUG]: finish: init-network/config-mounts: SUCCESS: config-mounts ran successfully
2024-11-18 13:33:49,070 - modules.py[DEBUG]: Running module set_hostname () with frequency once-per-instance
2024-11-18 13:33:49,070 - handlers.py[DEBUG]: start: init-network/config-set_hostname: running config-set_hostname with frequency once-per-instance
2024-11-18 13:33:49,070 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/iid-datasource-none/sem/config_set_hostname - wb: [644] 25 bytes
2024-11-18 13:33:49,070 - helpers.py[DEBUG]: Running config-set_hostname using lock ()
2024-11-18 13:33:49,071 - util.py[DEBUG]: Reading from /etc/hosts (quiet=False)
2024-11-18 13:33:49,071 - util.py[DEBUG]: Read 218 bytes from /etc/hosts
2024-11-18 13:33:49,071 - util.py[DEBUG]: Reading from /etc/hosts (quiet=False)
2024-11-18 13:33:49,071 - util.py[DEBUG]: Read 218 bytes from /etc/hosts
2024-11-18 13:33:49,071 - cc_set_hostname.py[DEBUG]: Setting the hostname to al5 (al5)
2024-11-18 13:33:49,071 - util.py[DEBUG]: Reading from /etc/hostname (quiet=False)
2024-11-18 13:33:49,071 - util.py[DEBUG]: Read 4 bytes from /etc/hostname
2024-11-18 13:33:49,071 - util.py[DEBUG]: Writing to /etc/hostname - wb: [644] 4 bytes
2024-11-18 13:33:49,072 - distros[DEBUG]: Non-persistently setting the system hostname to al5
2024-11-18 13:33:49,072 - subp.py[DEBUG]: Running command ['hostname', 'al5'] with allowed return codes [0] (shell=False, capture=True)
2024-11-18 13:33:49,074 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/set-hostname (via temporary file /var/lib/cloud/data/tmpwm4mond8) - w: [644] 39 bytes/chars
2024-11-18 13:33:49,074 - handlers.py[DEBUG]: finish: init-network/config-set_hostname: SUCCESS: config-set_hostname ran successfully
2024-11-18 13:33:49,074 - modules.py[DEBUG]: Running module update_hostname () with frequency always
2024-11-18 13:33:49,074 - handlers.py[DEBUG]: start: init-network/config-update_hostname: running config-update_hostname with frequency always
2024-11-18 13:33:49,074 - helpers.py[DEBUG]: Running config-update_hostname using lock ()
2024-11-18 13:33:49,075 - util.py[DEBUG]: Reading from /etc/hosts (quiet=False)
2024-11-18 13:33:49,075 - util.py[DEBUG]: Read 218 bytes from /etc/hosts
2024-11-18 13:33:49,075 - util.py[DEBUG]: Reading from /etc/hosts (quiet=False)
2024-11-18 13:33:49,075 - util.py[DEBUG]: Read 218 bytes from /etc/hosts
2024-11-18 13:33:49,075 - cc_update_hostname.py[DEBUG]: Updating hostname to al5 (al5)
2024-11-18 13:33:49,075 - util.py[DEBUG]: Reading from /etc/hostname (quiet=False)
2024-11-18 13:33:49,075 - util.py[DEBUG]: Read 4 bytes from /etc/hostname
2024-11-18 13:33:49,075 - distros[DEBUG]: Attempting to update hostname to al5 in 1 files
2024-11-18 13:33:49,075 - util.py[DEBUG]: Reading from /var/lib/cloud/data/previous-hostname (quiet=False)
2024-11-18 13:33:49,075 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-hostname - wb: [644] 4 bytes
2024-11-18 13:33:49,076 - handlers.py[DEBUG]: finish: init-network/config-update_hostname: SUCCESS: config-update_hostname ran successfully
2024-11-18 13:33:49,076 - modules.py[DEBUG]: Running module users_groups () with frequency once-per-instance
2024-11-18 13:33:49,076 - handlers.py[DEBUG]: start: init-network/config-users_groups: running config-users_groups with frequency once-per-instance
2024-11-18 13:33:49,076 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/iid-datasource-none/sem/config_users_groups - wb: [644] 25 bytes
2024-11-18 13:33:49,077 - helpers.py[DEBUG]: Running config-users_groups using lock ()
2024-11-18 13:33:49,077 - distros[INFO]: User ubuntu already exists, skipping.
2024-11-18 13:33:49,077 - subp.py[DEBUG]: Running command ['passwd', '-l', 'ubuntu'] with allowed return codes [0] (shell=False, capture=True)
2024-11-18 13:33:51,959 - subp.py[DEBUG]: command ['passwd', '-l', 'ubuntu'] took 2.8s to run
2024-11-18 13:33:51,960 - util.py[DEBUG]: Reading from /etc/sudoers (quiet=False)
2024-11-18 13:33:51,960 - util.py[DEBUG]: Read 1800 bytes from /etc/sudoers
2024-11-18 13:33:51,961 - util.py[DEBUG]: Reading from /etc/sudoers.d/90-cloud-init-users (quiet=False)
2024-11-18 13:33:51,961 - util.py[DEBUG]: Read 135 bytes from /etc/sudoers.d/90-cloud-init-users
2024-11-18 13:33:51,961 - handlers.py[DEBUG]: finish: init-network/config-users_groups: SUCCESS: config-users_groups ran successfully
2024-11-18 13:33:51,961 - modules.py[DEBUG]: Running module ssh () with frequency once-per-instance
2024-11-18 13:33:51,962 - handlers.py[DEBUG]: start: init-network/config-ssh: running config-ssh with frequency once-per-instance
2024-11-18 13:33:51,962 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/iid-datasource-none/sem/config_ssh - wb: [644] 25 bytes
2024-11-18 13:33:51,963 - helpers.py[DEBUG]: Running config-ssh using lock ()
2024-11-18 13:33:51,963 - util.py[DEBUG]: Attempting to remove /etc/ssh/ssh_host_ecdsa_key.pub
2024-11-18 13:33:51,964 - util.py[DEBUG]: Attempting to remove /etc/ssh/ssh_host_rsa_key
2024-11-18 13:33:51,964 - util.py[DEBUG]: Attempting to remove /etc/ssh/ssh_host_ecdsa_key
2024-11-18 13:33:51,964 - util.py[DEBUG]: Attempting to remove /etc/ssh/ssh_host_ed25519_key.pub
2024-11-18 13:33:51,964 - util.py[DEBUG]: Attempting to remove /etc/ssh/ssh_host_rsa_key.pub
2024-11-18 13:33:51,964 - util.py[DEBUG]: Attempting to remove /etc/ssh/ssh_host_ed25519_key
2024-11-18 13:33:51,964 - util.py[DEBUG]: Reading from /proc/sys/crypto/fips_enabled (quiet=False)
2024-11-18 13:33:51,965 - subp.py[DEBUG]: Running command ['ssh-keygen', '-t', 'rsa', '-N', '', '-f', '/etc/ssh/ssh_host_rsa_key'] with allowed return codes [0] (shell=False, capture=True)
2024-11-18 13:33:54,142 - subp.py[DEBUG]: command ['ssh-keygen', '-t', 'rsa', '-N', '', '-f', '/etc/ssh/ssh_host_rsa_key'] took 2.1s to run
2024-11-18 13:33:54,144 - util.py[DEBUG]: Group ssh_keys is not a valid group name
2024-11-18 13:33:54,145 - subp.py[DEBUG]: Running command ['ssh-keygen', '-t', 'ecdsa', '-N', '', '-f', '/etc/ssh/ssh_host_ecdsa_key'] with allowed return codes [0] (shell=False, capture=True)
2024-11-18 13:33:54,153 - util.py[DEBUG]: Group ssh_keys is not a valid group name
2024-11-18 13:33:54,154 - subp.py[DEBUG]: Running command ['ssh-keygen', '-t', 'ed25519', '-N', '', '-f', '/etc/ssh/ssh_host_ed25519_key'] with allowed return codes [0] (shell=False, capture=True)
2024-11-18 13:33:54,163 - util.py[DEBUG]: Group ssh_keys is not a valid group name
2024-11-18 13:33:54,163 - util.py[DEBUG]: Reading from /etc/ssh/ssh_host_ecdsa_key.pub (quiet=False)
2024-11-18 13:33:54,164 - util.py[DEBUG]: Read 170 bytes from /etc/ssh/ssh_host_ecdsa_key.pub
2024-11-18 13:33:54,164 - util.py[DEBUG]: Reading from /etc/ssh/ssh_host_ed25519_key.pub (quiet=False)
2024-11-18 13:33:54,164 - util.py[DEBUG]: Read 90 bytes from /etc/ssh/ssh_host_ed25519_key.pub
2024-11-18 13:33:54,164 - util.py[DEBUG]: Reading from /etc/ssh/ssh_host_rsa_key.pub (quiet=False)
2024-11-18 13:33:54,164 - util.py[DEBUG]: Read 562 bytes from /etc/ssh/ssh_host_rsa_key.pub
2024-11-18 13:33:54,165 - util.py[DEBUG]: Reading from /etc/ssh/sshd_config (quiet=False)
2024-11-18 13:33:54,165 - util.py[DEBUG]: Read 3255 bytes from /etc/ssh/sshd_config
2024-11-18 13:33:54,165 - util.py[DEBUG]: Reading from /home/ubuntu/.ssh/authorized_keys (quiet=False)
2024-11-18 13:33:54,165 - util.py[DEBUG]: Read 0 bytes from /home/ubuntu/.ssh/authorized_keys
2024-11-18 13:33:54,165 - util.py[DEBUG]: Writing to /home/ubuntu/.ssh/authorized_keys - wb: [600] 0 bytes
2024-11-18 13:33:54,166 - util.py[DEBUG]: Reading from /etc/ssh/sshd_config (quiet=False)
2024-11-18 13:33:54,166 - util.py[DEBUG]: Read 3255 bytes from /etc/ssh/sshd_config
2024-11-18 13:33:54,167 - util.py[DEBUG]: Reading from /root/.ssh/authorized_keys (quiet=False)
2024-11-18 13:33:54,167 - util.py[DEBUG]: Read 0 bytes from /root/.ssh/authorized_keys
2024-11-18 13:33:54,167 - util.py[DEBUG]: Writing to /root/.ssh/authorized_keys - wb: [600] 0 bytes
2024-11-18 13:33:54,167 - handlers.py[DEBUG]: finish: init-network/config-ssh: SUCCESS: config-ssh ran successfully
2024-11-18 13:33:54,168 - main.py[DEBUG]: Ran 8 modules with 0 failures
2024-11-18 13:33:54,168 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/status.json (via temporary file /var/lib/cloud/data/tmp4m54npq_) - w: [644] 5421 bytes/chars
2024-11-18 13:33:54,168 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False)
2024-11-18 13:33:54,169 - util.py[DEBUG]: Read 17 bytes from /proc/uptime
2024-11-18 13:33:54,169 - util.py[DEBUG]: cloud-init mode 'init' took 143.255 seconds (143.26)
2024-11-18 13:33:54,169 - handlers.py[DEBUG]: finish: init-network: FAIL: searching for network datasources
```

Contributor guide

Open the contributing guide

Assessment

This issue has not been assessed yet.

Get new issues in your inbox

A short digest of beginner-friendly GitHub issues.