#0x2525
Linux debian-2gb-nbg1 6.1.0-37-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.140-1 (2025-05-22) x86_64
  SOFT : Apache/2.4.62 (Debian) PHP : 8.2.28
/var/log/
162.55.61.15

 
[ NAME ] [ SIZE ] [ PERM ] [ DATE ] [ ACT ]
+FILE +DIR
apache2 dir drwxr-x--- 2025-07-02 00:12 R D
apt dir drwxr-xr-x 2025-07-01 17:07 R D
clamav dir drwxr-xr-x 2025-07-01 17:07 R D
dbconfig-common dir drwxr-xr-x 2025-06-01 00:00 R D
journal dir drwxr-sr-x 2025-05-30 14:54 R D
letsencrypt dir drwx------ 2025-07-02 02:35 R D
private dir drwx------ 2025-07-01 18:30 R D
runit dir drwxr-xr-x 2025-05-31 06:32 R D
unattended-upgrades dir drwxr-xr-x 2025-07-01 00:00 R D
README 1.017 KB -rw-r--r-- 2025-05-29 17:04 R E G D
btmp 1.47 MB -rw-rw---- 2025-07-02 16:13 R E G D
cloud-init-output.log 3.76 KB -rw-r----- 2025-07-01 18:30 R E G D
cloud-init.log 77.257 KB -rw-r--r-- 2025-07-01 18:30 R E G D
lastlog 285.441 KB -rw-rw-r-- 2025-07-02 08:45 R E G D
wtmp 5.625 KB -rw-rw-r-- 2025-07-02 08:45 R E G D
REQUEST EXIT
2025-07-01 18:30:07,674 - util.py[DEBUG]: Cloud-init v. 22.4.2 running 'init-local' at Tue, 01 Jul 2025 18:30:07 +0000. Up 6.90 seconds. 2025-07-01 18:30:07,674 - main.py[DEBUG]: No kernel command line url found. 2025-07-01 18:30:07,674 - main.py[DEBUG]: Closing stdin. 2025-07-01 18:30:07,676 - util.py[DEBUG]: Writing to /var/log/cloud-init.log - ab: [644] 0 bytes 2025-07-01 18:30:07,716 - util.py[DEBUG]: Changing the ownership of /var/log/cloud-init.log to 0:4 2025-07-01 18:30:07,718 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance/boot-finished 2025-07-01 18:30:07,718 - handlers.py[DEBUG]: start: init-local/check-cache: attempting to read from cache [check] 2025-07-01 18:30:07,718 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/obj.pkl (quiet=False) 2025-07-01 18:30:07,719 - util.py[DEBUG]: Read 19990 bytes from /var/lib/cloud/instance/obj.pkl 2025-07-01 18:30:07,748 - dmi.py[DEBUG]: querying dmi data /sys/class/dmi/id/product_serial 2025-07-01 18:30:07,748 - stages.py[DEBUG]: restored from checked cache: DataSourceHetzner 2025-07-01 18:30:07,748 - handlers.py[DEBUG]: finish: init-local/check-cache: SUCCESS: restored from checked cache: DataSourceHetzner 2025-07-01 18:30:07,748 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) 2025-07-01 18:30:07,748 - util.py[DEBUG]: Read 2796 bytes from /etc/cloud/cloud.cfg 2025-07-01 18:30:07,748 - util.py[DEBUG]: Attempting to load yaml from string of length 2796 with allowed root types (,) 2025-07-01 18:30:07,756 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/99-hetznercloud.cfg (quiet=False) 2025-07-01 18:30:07,757 - util.py[DEBUG]: Read 134 bytes from /etc/cloud/cloud.cfg.d/99-hetznercloud.cfg 2025-07-01 18:30:07,757 - util.py[DEBUG]: Attempting to load yaml from string of length 134 with allowed root types (,) 2025-07-01 18:30:07,757 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90-hetznercloud.cfg (quiet=False) 2025-07-01 18:30:07,757 - util.py[DEBUG]: Read 2446 bytes from /etc/cloud/cloud.cfg.d/90-hetznercloud.cfg 2025-07-01 18:30:07,757 - util.py[DEBUG]: Attempting to load yaml from string of length 2446 with allowed root types (,) 2025-07-01 18:30:07,764 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/05_logging.cfg (quiet=False) 2025-07-01 18:30:07,765 - util.py[DEBUG]: Read 2070 bytes from /etc/cloud/cloud.cfg.d/05_logging.cfg 2025-07-01 18:30:07,765 - util.py[DEBUG]: Attempting to load yaml from string of length 2070 with allowed root types (,) 2025-07-01 18:30:07,768 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False) 2025-07-01 18:30:07,769 - util.py[DEBUG]: Read 35 bytes from /run/cloud-init/cloud.cfg 2025-07-01 18:30:07,769 - util.py[DEBUG]: Attempting to load yaml from string of length 35 with allowed root types (,) 2025-07-01 18:30:07,769 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:07,769 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:07,770 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) 2025-07-01 18:30:07,770 - util.py[DEBUG]: Read 0 bytes from /var/lib/cloud/instance/cloud-config.txt 2025-07-01 18:30:07,770 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:07,770 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:07,770 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/vendor-cloud-config.txt (quiet=False) 2025-07-01 18:30:07,770 - util.py[DEBUG]: Read 4541 bytes from /var/lib/cloud/instance/vendor-cloud-config.txt 2025-07-01 18:30:07,770 - util.py[DEBUG]: Attempting to load yaml from string of length 4541 with allowed root types (,) 2025-07-01 18:30:07,776 - util.py[DEBUG]: Writing to /run/cloud-init/cloud-id-hetzner - wb: [644] 8 bytes 2025-07-01 18:30:07,776 - util.py[DEBUG]: Creating symbolic link from '/run/cloud-init/cloud-id' => '/run/cloud-init/cloud-id-hetzner' 2025-07-01 18:30:07,777 - atomic_helper.py[DEBUG]: Atomically writing to file /run/cloud-init/instance-data-sensitive.json (via temporary file /run/cloud-init/tmp3_69ii67) - w: [600] 9287 bytes/chars 2025-07-01 18:30:07,777 - atomic_helper.py[DEBUG]: Atomically writing to file /run/cloud-init/instance-data.json (via temporary file /run/cloud-init/tmpolopyi3e) - w: [644] 2029 bytes/chars 2025-07-01 18:30:07,777 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance 2025-07-01 18:30:07,778 - util.py[DEBUG]: Creating symbolic link from '/var/lib/cloud/instance' => '/var/lib/cloud/instances/65005860' 2025-07-01 18:30:07,778 - util.py[DEBUG]: Reading from /var/lib/cloud/instances/65005860/datasource (quiet=False) 2025-07-01 18:30:07,779 - util.py[DEBUG]: Read 37 bytes from /var/lib/cloud/instances/65005860/datasource 2025-07-01 18:30:07,779 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/datasource - wb: [644] 37 bytes 2025-07-01 18:30:07,779 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-datasource - wb: [644] 37 bytes 2025-07-01 18:30:07,780 - util.py[DEBUG]: Reading from /var/lib/cloud/data/instance-id (quiet=False) 2025-07-01 18:30:07,780 - util.py[DEBUG]: Read 9 bytes from /var/lib/cloud/data/instance-id 2025-07-01 18:30:07,780 - stages.py[DEBUG]: previous iid found to be 65005860 2025-07-01 18:30:07,780 - util.py[DEBUG]: Writing to /var/lib/cloud/data/instance-id - wb: [644] 9 bytes 2025-07-01 18:30:07,781 - util.py[DEBUG]: Writing to /run/cloud-init/.instance-id - wb: [644] 9 bytes 2025-07-01 18:30:07,781 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-instance-id - wb: [644] 9 bytes 2025-07-01 18:30:07,782 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [400] 19990 bytes 2025-07-01 18:30:07,782 - main.py[DEBUG]: [local] init will now be targeting instance id: 65005860. new=False 2025-07-01 18:30:07,782 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) 2025-07-01 18:30:07,783 - util.py[DEBUG]: Read 2796 bytes from /etc/cloud/cloud.cfg 2025-07-01 18:30:07,783 - util.py[DEBUG]: Attempting to load yaml from string of length 2796 with allowed root types (,) 2025-07-01 18:30:07,796 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/99-hetznercloud.cfg (quiet=False) 2025-07-01 18:30:07,797 - util.py[DEBUG]: Read 134 bytes from /etc/cloud/cloud.cfg.d/99-hetznercloud.cfg 2025-07-01 18:30:07,797 - util.py[DEBUG]: Attempting to load yaml from string of length 134 with allowed root types (,) 2025-07-01 18:30:07,797 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90-hetznercloud.cfg (quiet=False) 2025-07-01 18:30:07,797 - util.py[DEBUG]: Read 2446 bytes from /etc/cloud/cloud.cfg.d/90-hetznercloud.cfg 2025-07-01 18:30:07,798 - util.py[DEBUG]: Attempting to load yaml from string of length 2446 with allowed root types (,) 2025-07-01 18:30:07,806 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/05_logging.cfg (quiet=False) 2025-07-01 18:30:07,807 - util.py[DEBUG]: Read 2070 bytes from /etc/cloud/cloud.cfg.d/05_logging.cfg 2025-07-01 18:30:07,807 - util.py[DEBUG]: Attempting to load yaml from string of length 2070 with allowed root types (,) 2025-07-01 18:30:07,810 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False) 2025-07-01 18:30:07,810 - util.py[DEBUG]: Read 35 bytes from /run/cloud-init/cloud.cfg 2025-07-01 18:30:07,810 - util.py[DEBUG]: Attempting to load yaml from string of length 35 with allowed root types (,) 2025-07-01 18:30:07,810 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:07,810 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:07,813 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) 2025-07-01 18:30:07,813 - util.py[DEBUG]: Read 0 bytes from /var/lib/cloud/instance/cloud-config.txt 2025-07-01 18:30:07,813 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:07,813 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:07,813 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/vendor-cloud-config.txt (quiet=False) 2025-07-01 18:30:07,813 - util.py[DEBUG]: Read 4541 bytes from /var/lib/cloud/instance/vendor-cloud-config.txt 2025-07-01 18:30:07,813 - util.py[DEBUG]: Attempting to load yaml from string of length 4541 with allowed root types (,) 2025-07-01 18:30:07,825 - stages.py[DEBUG]: Using distro class 2025-07-01 18:30:07,826 - util.py[DEBUG]: Reading from /var/lib/cloud/data/set-hostname (quiet=False) 2025-07-01 18:30:07,826 - util.py[DEBUG]: Read 63 bytes from /var/lib/cloud/data/set-hostname 2025-07-01 18:30:07,826 - cc_set_hostname.py[DEBUG]: No hostname changes. Skipping set-hostname 2025-07-01 18:30:07,827 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) 2025-07-01 18:30:07,828 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address 2025-07-01 18:30:07,828 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) 2025-07-01 18:30:07,828 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address 2025-07-01 18:30:07,829 - stages.py[DEBUG]: Allowed events: {: {}} 2025-07-01 18:30:07,829 - stages.py[DEBUG]: Event Denied: scopes=['network'] EventType=boot 2025-07-01 18:30:07,829 - stages.py[DEBUG]: Allowed events: {: {}} 2025-07-01 18:30:07,829 - stages.py[DEBUG]: Event Denied: scopes=['network'] EventType=boot-legacy 2025-07-01 18:30:07,830 - stages.py[DEBUG]: No network config applied. Neither a new instance nor datasource network update allowed 2025-07-01 18:30:07,830 - stages.py[DEBUG]: applying net config names for {'config': [{'mac_address': '96:00:04:56:47:2d', 'name': 'eth0', 'subnets': [{'ipv4': True, 'type': 'dhcp'}, {'address': '2a01:4f8:1c0c:473f::1/64', 'dns_nameservers': ['2a01:4ff:ff00::add:2', '2a01:4ff:ff00::add:1'], 'gateway': 'fe80::1', 'ipv6': True, 'type': 'static'}], 'type': 'physical'}], 'version': 1} 2025-07-01 18:30:07,830 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) 2025-07-01 18:30:07,830 - util.py[DEBUG]: Read 7 bytes from /sys/class/net/eth0/device/device 2025-07-01 18:30:07,830 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False) 2025-07-01 18:30:07,830 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type 2025-07-01 18:30:07,830 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False) 2025-07-01 18:30:07,830 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent 2025-07-01 18:30:07,830 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) 2025-07-01 18:30:07,830 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address 2025-07-01 18:30:07,831 - __init__.py[DEBUG]: ovs-vsctl not in PATH; not detecting Open vSwitch interfaces 2025-07-01 18:30:07,831 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False) 2025-07-01 18:30:07,831 - util.py[DEBUG]: Reading from /sys/class/net/eth0/addr_assign_type (quiet=False) 2025-07-01 18:30:07,831 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/addr_assign_type 2025-07-01 18:30:07,831 - util.py[DEBUG]: Reading from /sys/class/net/eth0/uevent (quiet=False) 2025-07-01 18:30:07,831 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth0/uevent 2025-07-01 18:30:07,831 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) 2025-07-01 18:30:07,831 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address 2025-07-01 18:30:07,831 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) 2025-07-01 18:30:07,831 - util.py[DEBUG]: Read 7 bytes from /sys/class/net/eth0/device/device 2025-07-01 18:30:07,831 - util.py[DEBUG]: Reading from /sys/class/net/lo/operstate (quiet=False) 2025-07-01 18:30:07,832 - util.py[DEBUG]: Read 8 bytes from /sys/class/net/lo/operstate 2025-07-01 18:30:07,832 - util.py[DEBUG]: Reading from /sys/class/net/eth0/operstate (quiet=False) 2025-07-01 18:30:07,832 - util.py[DEBUG]: Read 5 bytes from /sys/class/net/eth0/operstate 2025-07-01 18:30:07,832 - subp.py[DEBUG]: Running command ['ip', '-6', 'addr', 'show', 'permanent', 'scope', 'global'] with allowed return codes [0] (shell=False, capture=True) 2025-07-01 18:30:07,842 - subp.py[DEBUG]: Running command ['ip', '-4', 'addr', 'show'] with allowed return codes [0] (shell=False, capture=True) 2025-07-01 18:30:07,846 - __init__.py[DEBUG]: Detected interfaces {'lo': {'downable': False, 'device_id': None, 'driver': None, 'mac': '00:00:00:00:00:00', 'name': 'lo', 'up': True}, 'eth0': {'downable': True, 'device_id': '0x0001', 'driver': 'virtio_net', 'mac': '96:00:04:56:47:2d', 'name': 'eth0', 'up': False}} 2025-07-01 18:30:07,846 - __init__.py[DEBUG]: no work necessary for renaming of [['96:00:04:56:47:2d', 'eth0', 'virtio_net', '0x0001']] 2025-07-01 18:30:07,846 - main.py[DEBUG]: [local] Exiting. datasource DataSourceHetzner not in local mode. 2025-07-01 18:30:07,847 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/status.json (via temporary file /var/lib/cloud/data/tmpjxo16ah2) - w: [644] 490 bytes/chars 2025-07-01 18:30:07,847 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False) 2025-07-01 18:30:07,847 - util.py[DEBUG]: Read 11 bytes from /proc/uptime 2025-07-01 18:30:07,847 - util.py[DEBUG]: cloud-init mode 'init' took 0.283 seconds (0.28) 2025-07-01 18:30:07,847 - handlers.py[DEBUG]: finish: init-local: SUCCESS: searching for local datasources 2025-07-01 18:30:10,204 - util.py[DEBUG]: Cloud-init v. 22.4.2 running 'init' at Tue, 01 Jul 2025 18:30:10 +0000. Up 9.43 seconds. 2025-07-01 18:30:10,204 - main.py[DEBUG]: No kernel command line url found. 2025-07-01 18:30:10,205 - main.py[DEBUG]: Closing stdin. 2025-07-01 18:30:10,206 - util.py[DEBUG]: Writing to /var/log/cloud-init.log - ab: [644] 0 bytes 2025-07-01 18:30:10,211 - util.py[DEBUG]: Changing the ownership of /var/log/cloud-init.log to 0:4 2025-07-01 18:30:10,211 - subp.py[DEBUG]: Running command ['ip', '--json', 'addr'] with allowed return codes [0] (shell=False, capture=True) 2025-07-01 18:30:10,218 - subp.py[DEBUG]: Running command ['ip', '-o', 'route', 'list'] with allowed return codes [0] (shell=False, capture=True) 2025-07-01 18:30:10,224 - subp.py[DEBUG]: Running command ['ip', '--oneline', '-6', 'route', 'list', 'table', 'all'] with allowed return codes [0, 1] (shell=False, capture=True) 2025-07-01 18:30:10,232 - handlers.py[DEBUG]: start: init-network/check-cache: attempting to read from cache [trust] 2025-07-01 18:30:10,232 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/obj.pkl (quiet=False) 2025-07-01 18:30:10,232 - util.py[DEBUG]: Read 19990 bytes from /var/lib/cloud/instance/obj.pkl 2025-07-01 18:30:10,240 - util.py[DEBUG]: Reading from /run/cloud-init/.instance-id (quiet=False) 2025-07-01 18:30:10,240 - util.py[DEBUG]: Read 9 bytes from /run/cloud-init/.instance-id 2025-07-01 18:30:10,240 - stages.py[DEBUG]: restored from cache with run check: DataSourceHetzner 2025-07-01 18:30:10,240 - handlers.py[DEBUG]: finish: init-network/check-cache: SUCCESS: restored from cache with run check: DataSourceHetzner 2025-07-01 18:30:10,240 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) 2025-07-01 18:30:10,241 - util.py[DEBUG]: Read 2796 bytes from /etc/cloud/cloud.cfg 2025-07-01 18:30:10,241 - util.py[DEBUG]: Attempting to load yaml from string of length 2796 with allowed root types (,) 2025-07-01 18:30:10,251 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/99-hetznercloud.cfg (quiet=False) 2025-07-01 18:30:10,251 - util.py[DEBUG]: Read 134 bytes from /etc/cloud/cloud.cfg.d/99-hetznercloud.cfg 2025-07-01 18:30:10,251 - util.py[DEBUG]: Attempting to load yaml from string of length 134 with allowed root types (,) 2025-07-01 18:30:10,252 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90-hetznercloud.cfg (quiet=False) 2025-07-01 18:30:10,252 - util.py[DEBUG]: Read 2446 bytes from /etc/cloud/cloud.cfg.d/90-hetznercloud.cfg 2025-07-01 18:30:10,252 - util.py[DEBUG]: Attempting to load yaml from string of length 2446 with allowed root types (,) 2025-07-01 18:30:10,258 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/05_logging.cfg (quiet=False) 2025-07-01 18:30:10,258 - util.py[DEBUG]: Read 2070 bytes from /etc/cloud/cloud.cfg.d/05_logging.cfg 2025-07-01 18:30:10,258 - util.py[DEBUG]: Attempting to load yaml from string of length 2070 with allowed root types (,) 2025-07-01 18:30:10,260 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False) 2025-07-01 18:30:10,260 - util.py[DEBUG]: Read 35 bytes from /run/cloud-init/cloud.cfg 2025-07-01 18:30:10,260 - util.py[DEBUG]: Attempting to load yaml from string of length 35 with allowed root types (,) 2025-07-01 18:30:10,261 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:10,261 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:10,261 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) 2025-07-01 18:30:10,261 - util.py[DEBUG]: Read 0 bytes from /var/lib/cloud/instance/cloud-config.txt 2025-07-01 18:30:10,261 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:10,261 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:10,261 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/vendor-cloud-config.txt (quiet=False) 2025-07-01 18:30:10,261 - util.py[DEBUG]: Read 4541 bytes from /var/lib/cloud/instance/vendor-cloud-config.txt 2025-07-01 18:30:10,261 - util.py[DEBUG]: Attempting to load yaml from string of length 4541 with allowed root types (,) 2025-07-01 18:30:10,265 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance 2025-07-01 18:30:10,265 - util.py[DEBUG]: Creating symbolic link from '/var/lib/cloud/instance' => '/var/lib/cloud/instances/65005860' 2025-07-01 18:30:10,266 - util.py[DEBUG]: Reading from /var/lib/cloud/instances/65005860/datasource (quiet=False) 2025-07-01 18:30:10,266 - util.py[DEBUG]: Read 37 bytes from /var/lib/cloud/instances/65005860/datasource 2025-07-01 18:30:10,266 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/datasource - wb: [644] 37 bytes 2025-07-01 18:30:10,266 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-datasource - wb: [644] 37 bytes 2025-07-01 18:30:10,267 - util.py[DEBUG]: Reading from /var/lib/cloud/data/instance-id (quiet=False) 2025-07-01 18:30:10,267 - util.py[DEBUG]: Read 9 bytes from /var/lib/cloud/data/instance-id 2025-07-01 18:30:10,267 - stages.py[DEBUG]: previous iid found to be 65005860 2025-07-01 18:30:10,267 - util.py[DEBUG]: Writing to /var/lib/cloud/data/instance-id - wb: [644] 9 bytes 2025-07-01 18:30:10,267 - util.py[DEBUG]: Writing to /run/cloud-init/.instance-id - wb: [644] 9 bytes 2025-07-01 18:30:10,268 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-instance-id - wb: [644] 9 bytes 2025-07-01 18:30:10,268 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [400] 19990 bytes 2025-07-01 18:30:10,269 - main.py[DEBUG]: [net] init will now be targeting instance id: 65005860. new=False 2025-07-01 18:30:10,269 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) 2025-07-01 18:30:10,269 - util.py[DEBUG]: Read 2796 bytes from /etc/cloud/cloud.cfg 2025-07-01 18:30:10,269 - util.py[DEBUG]: Attempting to load yaml from string of length 2796 with allowed root types (,) 2025-07-01 18:30:10,275 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/99-hetznercloud.cfg (quiet=False) 2025-07-01 18:30:10,276 - util.py[DEBUG]: Read 134 bytes from /etc/cloud/cloud.cfg.d/99-hetznercloud.cfg 2025-07-01 18:30:10,276 - util.py[DEBUG]: Attempting to load yaml from string of length 134 with allowed root types (,) 2025-07-01 18:30:10,276 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90-hetznercloud.cfg (quiet=False) 2025-07-01 18:30:10,276 - util.py[DEBUG]: Read 2446 bytes from /etc/cloud/cloud.cfg.d/90-hetznercloud.cfg 2025-07-01 18:30:10,276 - util.py[DEBUG]: Attempting to load yaml from string of length 2446 with allowed root types (,) 2025-07-01 18:30:10,281 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/05_logging.cfg (quiet=False) 2025-07-01 18:30:10,281 - util.py[DEBUG]: Read 2070 bytes from /etc/cloud/cloud.cfg.d/05_logging.cfg 2025-07-01 18:30:10,281 - util.py[DEBUG]: Attempting to load yaml from string of length 2070 with allowed root types (,) 2025-07-01 18:30:10,283 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False) 2025-07-01 18:30:10,283 - util.py[DEBUG]: Read 35 bytes from /run/cloud-init/cloud.cfg 2025-07-01 18:30:10,283 - util.py[DEBUG]: Attempting to load yaml from string of length 35 with allowed root types (,) 2025-07-01 18:30:10,284 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:10,284 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:10,284 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) 2025-07-01 18:30:10,284 - util.py[DEBUG]: Read 0 bytes from /var/lib/cloud/instance/cloud-config.txt 2025-07-01 18:30:10,284 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:10,284 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:10,284 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/vendor-cloud-config.txt (quiet=False) 2025-07-01 18:30:10,284 - util.py[DEBUG]: Read 4541 bytes from /var/lib/cloud/instance/vendor-cloud-config.txt 2025-07-01 18:30:10,284 - util.py[DEBUG]: Attempting to load yaml from string of length 4541 with allowed root types (,) 2025-07-01 18:30:10,289 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) 2025-07-01 18:30:10,289 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address 2025-07-01 18:30:10,289 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) 2025-07-01 18:30:10,289 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address 2025-07-01 18:30:10,290 - stages.py[DEBUG]: Allowed events: {: {}} 2025-07-01 18:30:10,290 - stages.py[DEBUG]: Event Denied: scopes=['network'] EventType=boot 2025-07-01 18:30:10,290 - stages.py[DEBUG]: Allowed events: {: {}} 2025-07-01 18:30:10,290 - stages.py[DEBUG]: Event Denied: scopes=['network'] EventType=boot-legacy 2025-07-01 18:30:10,290 - stages.py[DEBUG]: No network config applied. Neither a new instance nor datasource network update allowed 2025-07-01 18:30:10,291 - stages.py[DEBUG]: applying net config names for {'config': [{'mac_address': '96:00:04:56:47:2d', 'name': 'eth0', 'subnets': [{'ipv4': True, 'type': 'dhcp'}, {'address': '2a01:4f8:1c0c:473f::1/64', 'dns_nameservers': ['2a01:4ff:ff00::add:2', '2a01:4ff:ff00::add:1'], 'gateway': 'fe80::1', 'ipv6': True, 'type': 'static'}], 'type': 'physical'}], 'version': 1} 2025-07-01 18:30:10,291 - stages.py[DEBUG]: Using distro class 2025-07-01 18:30:10,292 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) 2025-07-01 18:30:10,292 - util.py[DEBUG]: Read 7 bytes from /sys/class/net/eth0/device/device 2025-07-01 18:30:10,292 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False) 2025-07-01 18:30:10,292 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type 2025-07-01 18:30:10,292 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False) 2025-07-01 18:30:10,292 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent 2025-07-01 18:30:10,292 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) 2025-07-01 18:30:10,292 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address 2025-07-01 18:30:10,292 - __init__.py[DEBUG]: ovs-vsctl not in PATH; not detecting Open vSwitch interfaces 2025-07-01 18:30:10,292 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False) 2025-07-01 18:30:10,292 - util.py[DEBUG]: Reading from /sys/class/net/eth0/addr_assign_type (quiet=False) 2025-07-01 18:30:10,292 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/addr_assign_type 2025-07-01 18:30:10,292 - util.py[DEBUG]: Reading from /sys/class/net/eth0/uevent (quiet=False) 2025-07-01 18:30:10,292 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth0/uevent 2025-07-01 18:30:10,293 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) 2025-07-01 18:30:10,293 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address 2025-07-01 18:30:10,293 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) 2025-07-01 18:30:10,293 - util.py[DEBUG]: Read 7 bytes from /sys/class/net/eth0/device/device 2025-07-01 18:30:10,293 - util.py[DEBUG]: Reading from /sys/class/net/lo/operstate (quiet=False) 2025-07-01 18:30:10,293 - util.py[DEBUG]: Read 8 bytes from /sys/class/net/lo/operstate 2025-07-01 18:30:10,293 - util.py[DEBUG]: Reading from /sys/class/net/eth0/operstate (quiet=False) 2025-07-01 18:30:10,293 - util.py[DEBUG]: Read 3 bytes from /sys/class/net/eth0/operstate 2025-07-01 18:30:10,293 - subp.py[DEBUG]: Running command ['ip', '-6', 'addr', 'show', 'permanent', 'scope', 'global'] with allowed return codes [0] (shell=False, capture=True) 2025-07-01 18:30:10,296 - subp.py[DEBUG]: Running command ['ip', '-4', 'addr', 'show'] with allowed return codes [0] (shell=False, capture=True) 2025-07-01 18:30:10,298 - __init__.py[DEBUG]: Detected interfaces {'lo': {'downable': False, 'device_id': None, 'driver': None, 'mac': '00:00:00:00:00:00', 'name': 'lo', 'up': True}, 'eth0': {'downable': False, 'device_id': '0x0001', 'driver': 'virtio_net', 'mac': '96:00:04:56:47:2d', 'name': 'eth0', 'up': True}} 2025-07-01 18:30:10,298 - __init__.py[DEBUG]: no work necessary for renaming of [['96:00:04:56:47:2d', 'eth0', 'virtio_net', '0x0001']] 2025-07-01 18:30:10,298 - handlers.py[DEBUG]: start: init-network/setup-datasource: setting up datasource 2025-07-01 18:30:10,299 - handlers.py[DEBUG]: finish: init-network/setup-datasource: SUCCESS: setting up datasource 2025-07-01 18:30:10,299 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/user-data.txt - wb: [600] 0 bytes 2025-07-01 18:30:10,299 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/user-data.txt.i - wb: [600] 308 bytes 2025-07-01 18:30:10,300 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/vendor-data.txt - wb: [600] 4973 bytes 2025-07-01 18:30:10,301 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/vendor-data.txt.i - wb: [600] 4995 bytes 2025-07-01 18:30:10,301 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/vendor-data2.txt - wb: [600] 0 bytes 2025-07-01 18:30:10,301 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/vendor-data2.txt.i - wb: [600] 308 bytes 2025-07-01 18:30:10,302 - util.py[DEBUG]: Reading from /var/lib/cloud/data/set-hostname (quiet=False) 2025-07-01 18:30:10,302 - util.py[DEBUG]: Read 63 bytes from /var/lib/cloud/data/set-hostname 2025-07-01 18:30:10,302 - cc_set_hostname.py[DEBUG]: No hostname changes. Skipping set-hostname 2025-07-01 18:30:10,303 - helpers.py[DEBUG]: consume_data already ran (freq=once-per-instance) 2025-07-01 18:30:10,303 - handlers.py[DEBUG]: start: init-network/consume-user-data: reading and applying user-data 2025-07-01 18:30:10,303 - stages.py[DEBUG]: Added default handler for {'text/cloud-config-jsonp', 'text/cloud-config'} from CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] 2025-07-01 18:30:10,304 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript'} from ShellScriptPartHandler: [['text/x-shellscript']] 2025-07-01 18:30:10,304 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript-per-boot'} from ShellScriptByFreqPartHandler: [['text/x-shellscript-per-boot']] 2025-07-01 18:30:10,304 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript-per-instance'} from ShellScriptByFreqPartHandler: [['text/x-shellscript-per-instance']] 2025-07-01 18:30:10,304 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript-per-once'} from ShellScriptByFreqPartHandler: [['text/x-shellscript-per-once']] 2025-07-01 18:30:10,304 - stages.py[DEBUG]: Added default handler for {'text/cloud-boothook'} from BootHookPartHandler: [['text/cloud-boothook']] 2025-07-01 18:30:10,304 - stages.py[DEBUG]: Added default handler for {'text/jinja2'} from JinjaTemplatePartHandler: [['text/jinja2']] 2025-07-01 18:30:10,304 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (__begin__, None, 3) with frequency always 2025-07-01 18:30:10,304 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (__begin__, None, 2) with frequency always 2025-07-01 18:30:10,304 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-boot']] (__begin__, None, 2) with frequency always 2025-07-01 18:30:10,304 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-instance']] (__begin__, None, 2) with frequency always 2025-07-01 18:30:10,304 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-once']] (__begin__, None, 2) with frequency always 2025-07-01 18:30:10,304 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (__begin__, None, 2) with frequency always 2025-07-01 18:30:10,304 - __init__.py[DEBUG]: Calling handler JinjaTemplatePartHandler: [['text/jinja2']] (__begin__, None, 3) with frequency always 2025-07-01 18:30:10,304 - __init__.py[DEBUG]: {'MIME-Version': '1.0', 'Content-Type': 'text/x-not-multipart', 'Content-Disposition': 'attachment; filename="part-001"'} 2025-07-01 18:30:10,304 - __init__.py[DEBUG]: Empty payload of type text/x-not-multipart 2025-07-01 18:30:10,304 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (__end__, None, 3) with frequency always 2025-07-01 18:30:10,304 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/cloud-config.txt - wb: [600] 0 bytes 2025-07-01 18:30:10,305 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (__end__, None, 2) with frequency always 2025-07-01 18:30:10,305 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-boot']] (__end__, None, 2) with frequency always 2025-07-01 18:30:10,305 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-instance']] (__end__, None, 2) with frequency always 2025-07-01 18:30:10,305 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-once']] (__end__, None, 2) with frequency always 2025-07-01 18:30:10,305 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (__end__, None, 2) with frequency always 2025-07-01 18:30:10,305 - __init__.py[DEBUG]: Calling handler JinjaTemplatePartHandler: [['text/jinja2']] (__end__, None, 3) with frequency always 2025-07-01 18:30:10,305 - handlers.py[DEBUG]: finish: init-network/consume-user-data: SUCCESS: reading and applying user-data 2025-07-01 18:30:10,305 - handlers.py[DEBUG]: start: init-network/consume-vendor-data: reading and applying vendor-data 2025-07-01 18:30:10,306 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) 2025-07-01 18:30:10,306 - util.py[DEBUG]: Read 0 bytes from /var/lib/cloud/instance/cloud-config.txt 2025-07-01 18:30:10,306 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:10,306 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:10,306 - stages.py[DEBUG]: vendordata will be consumed. disabled_handlers=None 2025-07-01 18:30:10,306 - stages.py[DEBUG]: Added default handler for {'text/cloud-config-jsonp', 'text/cloud-config'} from CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] 2025-07-01 18:30:10,306 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript'} from ShellScriptPartHandler: [['text/x-shellscript']] 2025-07-01 18:30:10,306 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript-per-boot'} from ShellScriptByFreqPartHandler: [['text/x-shellscript-per-boot']] 2025-07-01 18:30:10,306 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript-per-instance'} from ShellScriptByFreqPartHandler: [['text/x-shellscript-per-instance']] 2025-07-01 18:30:10,306 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript-per-once'} from ShellScriptByFreqPartHandler: [['text/x-shellscript-per-once']] 2025-07-01 18:30:10,306 - stages.py[DEBUG]: Added default handler for {'text/cloud-boothook'} from BootHookPartHandler: [['text/cloud-boothook']] 2025-07-01 18:30:10,306 - stages.py[DEBUG]: Added default handler for {'text/jinja2'} from JinjaTemplatePartHandler: [['text/jinja2']] 2025-07-01 18:30:10,306 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (__begin__, None, 3) with frequency always 2025-07-01 18:30:10,307 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (__begin__, None, 2) with frequency always 2025-07-01 18:30:10,307 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-boot']] (__begin__, None, 2) with frequency always 2025-07-01 18:30:10,307 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-instance']] (__begin__, None, 2) with frequency always 2025-07-01 18:30:10,307 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-once']] (__begin__, None, 2) with frequency always 2025-07-01 18:30:10,307 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (__begin__, None, 2) with frequency always 2025-07-01 18:30:10,307 - __init__.py[DEBUG]: Calling handler JinjaTemplatePartHandler: [['text/jinja2']] (__begin__, None, 3) with frequency always 2025-07-01 18:30:10,307 - __init__.py[DEBUG]: {'Content-Type': 'text/cloud-config; charset="us-ascii"', 'MIME-Version': '1.0', 'Content-Transfer-Encoding': '7bit', 'Content-Disposition': 'attachment; filename="cloud-config"'} 2025-07-01 18:30:10,307 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (text/cloud-config, cloud-config, 3) with frequency always 2025-07-01 18:30:10,307 - util.py[DEBUG]: Attempting to load yaml from string of length 4285 with allowed root types (,) 2025-07-01 18:30:10,310 - cloud_config.py[DEBUG]: Merging by applying [('dict', ['replace']), ('list', []), ('str', [])] 2025-07-01 18:30:10,310 - __init__.py[DEBUG]: {'Content-Type': 'text/cloud-boothook; charset="us-ascii"', 'MIME-Version': '1.0', 'Content-Transfer-Encoding': '7bit', 'Content-Disposition': 'attachment; filename="hc-boot-script"'} 2025-07-01 18:30:10,310 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (text/cloud-boothook, hc-boot-script, 2) with frequency always 2025-07-01 18:30:10,311 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/boothooks/hc-boot-script - wb: [700] 145 bytes 2025-07-01 18:30:10,311 - subp.py[DEBUG]: Running command ['/var/lib/cloud/instances/65005860/boothooks/hc-boot-script'] with allowed return codes [0] (shell=False, capture=True) 2025-07-01 18:30:10,332 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (__end__, None, 3) with frequency always 2025-07-01 18:30:10,340 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/65005860/vendor-cloud-config.txt - wb: [600] 4541 bytes 2025-07-01 18:30:10,341 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (__end__, None, 2) with frequency always 2025-07-01 18:30:10,341 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-boot']] (__end__, None, 2) with frequency always 2025-07-01 18:30:10,341 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-instance']] (__end__, None, 2) with frequency always 2025-07-01 18:30:10,341 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-once']] (__end__, None, 2) with frequency always 2025-07-01 18:30:10,341 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (__end__, None, 2) with frequency always 2025-07-01 18:30:10,341 - __init__.py[DEBUG]: Calling handler JinjaTemplatePartHandler: [['text/jinja2']] (__end__, None, 3) with frequency always 2025-07-01 18:30:10,341 - handlers.py[DEBUG]: finish: init-network/consume-vendor-data: SUCCESS: reading and applying vendor-data 2025-07-01 18:30:10,342 - handlers.py[DEBUG]: start: init-network/consume-vendor-data2: reading and applying vendor-data2 2025-07-01 18:30:10,342 - stages.py[DEBUG]: no vendordata2 from datasource 2025-07-01 18:30:10,342 - handlers.py[DEBUG]: finish: init-network/consume-vendor-data2: SUCCESS: reading and applying vendor-data2 2025-07-01 18:30:10,342 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) 2025-07-01 18:30:10,342 - util.py[DEBUG]: Read 2796 bytes from /etc/cloud/cloud.cfg 2025-07-01 18:30:10,342 - util.py[DEBUG]: Attempting to load yaml from string of length 2796 with allowed root types (,) 2025-07-01 18:30:10,351 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/99-hetznercloud.cfg (quiet=False) 2025-07-01 18:30:10,351 - util.py[DEBUG]: Read 134 bytes from /etc/cloud/cloud.cfg.d/99-hetznercloud.cfg 2025-07-01 18:30:10,351 - util.py[DEBUG]: Attempting to load yaml from string of length 134 with allowed root types (,) 2025-07-01 18:30:10,352 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90-hetznercloud.cfg (quiet=False) 2025-07-01 18:30:10,352 - util.py[DEBUG]: Read 2446 bytes from /etc/cloud/cloud.cfg.d/90-hetznercloud.cfg 2025-07-01 18:30:10,352 - util.py[DEBUG]: Attempting to load yaml from string of length 2446 with allowed root types (,) 2025-07-01 18:30:10,357 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/05_logging.cfg (quiet=False) 2025-07-01 18:30:10,357 - util.py[DEBUG]: Read 2070 bytes from /etc/cloud/cloud.cfg.d/05_logging.cfg 2025-07-01 18:30:10,357 - util.py[DEBUG]: Attempting to load yaml from string of length 2070 with allowed root types (,) 2025-07-01 18:30:10,359 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False) 2025-07-01 18:30:10,359 - util.py[DEBUG]: Read 35 bytes from /run/cloud-init/cloud.cfg 2025-07-01 18:30:10,359 - util.py[DEBUG]: Attempting to load yaml from string of length 35 with allowed root types (,) 2025-07-01 18:30:10,360 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:10,360 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:10,360 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) 2025-07-01 18:30:10,360 - util.py[DEBUG]: Read 0 bytes from /var/lib/cloud/instance/cloud-config.txt 2025-07-01 18:30:10,360 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:10,360 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:10,360 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/vendor-cloud-config.txt (quiet=False) 2025-07-01 18:30:10,360 - util.py[DEBUG]: Read 4541 bytes from /var/lib/cloud/instance/vendor-cloud-config.txt 2025-07-01 18:30:10,360 - util.py[DEBUG]: Attempting to load yaml from string of length 4541 with allowed root types (,) 2025-07-01 18:30:10,364 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,364 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,373 - schema.py[WARNING]: Deprecated cloud-config provided: chpasswd.list: DEPRECATED: List of ``username:password`` pairs. Each user will have the corresponding password set. A password can be randomly generated by specifying ``RANDOM`` or ``R`` as a user's password. A hashed password, created by a tool like ``mkpasswd``, can be specified. A regex (``r'\$(1|2a|2y|5|6)(\$.+){2}'``) is used to determine if a password value should be treated as a hash. Use of a multiline string for this field is DEPRECATED and will result in an error in a future version of cloud-init. 2025-07-01 18:30:10,373 - schema.py[WARNING]: Invalid cloud-config provided: Please run 'sudo cloud-init schema --system' to see the schema errors. 2025-07-01 18:30:10,374 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) 2025-07-01 18:30:10,374 - util.py[DEBUG]: Read 0 bytes from /var/lib/cloud/instance/cloud-config.txt 2025-07-01 18:30:10,374 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (,) 2025-07-01 18:30:10,374 - util.py[DEBUG]: loaded blob returned None, returning default. 2025-07-01 18:30:10,374 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/vendor-cloud-config.txt (quiet=False) 2025-07-01 18:30:10,374 - util.py[DEBUG]: Read 4541 bytes from /var/lib/cloud/instance/vendor-cloud-config.txt 2025-07-01 18:30:10,374 - util.py[DEBUG]: Attempting to load yaml from string of length 4541 with allowed root types (,) 2025-07-01 18:30:10,379 - handlers.py[DEBUG]: start: init-network/activate-datasource: activating datasource 2025-07-01 18:30:10,380 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [400] 19990 bytes 2025-07-01 18:30:10,381 - handlers.py[DEBUG]: finish: init-network/activate-datasource: SUCCESS: activating datasource 2025-07-01 18:30:10,381 - main.py[DEBUG]: no di_report found in config. 2025-07-01 18:30:10,383 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,383 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,392 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,393 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,397 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,398 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,401 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,402 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,405 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,405 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,408 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,409 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,412 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,412 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,415 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,415 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,419 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,419 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,421 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,421 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,424 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,424 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,426 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,426 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,429 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,429 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,432 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:10,432 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:10,434 - stages.py[DEBUG]: Using distro class 2025-07-01 18:30:10,436 - modules.py[INFO]: Skipping modules 'bootcmd,write-files,disk_setup,ca-certs,rsyslog' because no applicable config is provided. 2025-07-01 18:30:10,436 - modules.py[DEBUG]: Running module migrator () with frequency always 2025-07-01 18:30:10,436 - handlers.py[DEBUG]: start: init-network/config-migrator: running config-migrator with frequency always 2025-07-01 18:30:10,436 - helpers.py[DEBUG]: Running config-migrator using lock () 2025-07-01 18:30:10,436 - cc_migrator.py[DEBUG]: Migrated 0 semaphore files to there canonicalized names 2025-07-01 18:30:10,437 - handlers.py[DEBUG]: finish: init-network/config-migrator: SUCCESS: config-migrator ran successfully 2025-07-01 18:30:10,437 - modules.py[DEBUG]: Running module seed_random () with frequency once-per-instance 2025-07-01 18:30:10,437 - handlers.py[DEBUG]: start: init-network/config-seed_random: running config-seed_random with frequency once-per-instance 2025-07-01 18:30:10,437 - helpers.py[DEBUG]: config-seed_random already ran (freq=once-per-instance) 2025-07-01 18:30:10,437 - handlers.py[DEBUG]: finish: init-network/config-seed_random: SUCCESS: config-seed_random previously ran 2025-07-01 18:30:10,437 - modules.py[DEBUG]: Running module growpart () with frequency always 2025-07-01 18:30:10,437 - handlers.py[DEBUG]: start: init-network/config-growpart: running config-growpart with frequency always 2025-07-01 18:30:10,437 - helpers.py[DEBUG]: Running config-growpart using lock () 2025-07-01 18:30:10,437 - cc_growpart.py[DEBUG]: No 'growpart' entry in cfg. Using default: {'mode': 'auto', 'devices': ['/'], 'ignore_growroot_disabled': False} 2025-07-01 18:30:10,437 - subp.py[DEBUG]: Running command ['growpart', '--help'] with allowed return codes [0] (shell=False, capture=True) 2025-07-01 18:30:10,443 - util.py[DEBUG]: Reading from /proc/836/mountinfo (quiet=False) 2025-07-01 18:30:10,444 - util.py[DEBUG]: Read 3200 bytes from /proc/836/mountinfo 2025-07-01 18:30:10,444 - util.py[DEBUG]: Reading from /sys/class/block/sda1/partition (quiet=False) 2025-07-01 18:30:10,444 - util.py[DEBUG]: Read 2 bytes from /sys/class/block/sda1/partition 2025-07-01 18:30:10,444 - util.py[DEBUG]: Reading from /sys/devices/pci0000:00/0000:00:02.5/0000:06:00.0/virtio5/host0/target0:0:0/0:0:0:0/block/sda/dev (quiet=False) 2025-07-01 18:30:10,444 - util.py[DEBUG]: Read 4 bytes from /sys/devices/pci0000:00/0000:00:02.5/0000:06:00.0/virtio5/host0/target0:0:0/0:0:0:0/block/sda/dev 2025-07-01 18:30:10,444 - util.py[DEBUG]: Reading from /proc/836/mountinfo (quiet=False) 2025-07-01 18:30:10,444 - util.py[DEBUG]: Read 3200 bytes from /proc/836/mountinfo 2025-07-01 18:30:10,444 - util.py[DEBUG]: Reading from /proc/836/mountinfo (quiet=False) 2025-07-01 18:30:10,445 - util.py[DEBUG]: Read 3200 bytes from /proc/836/mountinfo 2025-07-01 18:30:10,445 - subp.py[DEBUG]: Running command ['growpart', '--dry-run', '/dev/sda', '1'] with allowed return codes [0] (shell=False, capture=True) 2025-07-01 18:30:10,540 - util.py[DEBUG]: resize_devices took 0.097 seconds 2025-07-01 18:30:10,540 - cc_growpart.py[DEBUG]: '/' NOCHANGE: no change necessary (/dev/sda, 1) 2025-07-01 18:30:10,540 - handlers.py[DEBUG]: finish: init-network/config-growpart: SUCCESS: config-growpart ran successfully 2025-07-01 18:30:10,540 - modules.py[DEBUG]: Running module resizefs () with frequency always 2025-07-01 18:30:10,541 - handlers.py[DEBUG]: start: init-network/config-resizefs: running config-resizefs with frequency always 2025-07-01 18:30:10,541 - helpers.py[DEBUG]: Running config-resizefs using lock () 2025-07-01 18:30:10,541 - util.py[DEBUG]: Reading from /proc/836/mountinfo (quiet=False) 2025-07-01 18:30:10,542 - util.py[DEBUG]: Read 3200 bytes from /proc/836/mountinfo 2025-07-01 18:30:10,542 - cc_resizefs.py[DEBUG]: resize_info: dev=/dev/sda1 mnt_point=/ path=/ 2025-07-01 18:30:10,542 - cc_resizefs.py[DEBUG]: Resizing / (ext4) using resize2fs /dev/sda1 2025-07-01 18:30:10,542 - subp.py[DEBUG]: Running command ('resize2fs', '/dev/sda1') with allowed return codes [0] (shell=False, capture=True) 2025-07-01 18:30:10,561 - util.py[DEBUG]: Resizing took 0.019 seconds 2025-07-01 18:30:10,562 - cc_resizefs.py[DEBUG]: Resized root filesystem (type=ext4, val=True) 2025-07-01 18:30:10,562 - handlers.py[DEBUG]: finish: init-network/config-resizefs: SUCCESS: config-resizefs ran successfully 2025-07-01 18:30:10,562 - modules.py[DEBUG]: Running module mounts () with frequency once-per-instance 2025-07-01 18:30:10,563 - handlers.py[DEBUG]: start: init-network/config-mounts: running config-mounts with frequency once-per-instance 2025-07-01 18:30:10,563 - helpers.py[DEBUG]: config-mounts already ran (freq=once-per-instance) 2025-07-01 18:30:10,563 - handlers.py[DEBUG]: finish: init-network/config-mounts: SUCCESS: config-mounts previously ran 2025-07-01 18:30:10,563 - modules.py[DEBUG]: Running module set_hostname () with frequency once-per-instance 2025-07-01 18:30:10,564 - handlers.py[DEBUG]: start: init-network/config-set_hostname: running config-set_hostname with frequency once-per-instance 2025-07-01 18:30:10,564 - helpers.py[DEBUG]: config-set_hostname already ran (freq=once-per-instance) 2025-07-01 18:30:10,564 - handlers.py[DEBUG]: finish: init-network/config-set_hostname: SUCCESS: config-set_hostname previously ran 2025-07-01 18:30:10,564 - modules.py[DEBUG]: Running module update_hostname () with frequency always 2025-07-01 18:30:10,565 - handlers.py[DEBUG]: start: init-network/config-update_hostname: running config-update_hostname with frequency always 2025-07-01 18:30:10,565 - helpers.py[DEBUG]: Running config-update_hostname using lock () 2025-07-01 18:30:10,565 - cc_update_hostname.py[DEBUG]: Updating hostname to debian-2gb-nbg1 (debian-2gb-nbg1) 2025-07-01 18:30:10,565 - util.py[DEBUG]: Reading from /var/lib/cloud/data/previous-hostname (quiet=False) 2025-07-01 18:30:10,566 - util.py[DEBUG]: Read 16 bytes from /var/lib/cloud/data/previous-hostname 2025-07-01 18:30:10,566 - util.py[DEBUG]: Reading from /etc/hostname (quiet=False) 2025-07-01 18:30:10,566 - util.py[DEBUG]: Read 16 bytes from /etc/hostname 2025-07-01 18:30:10,566 - __init__.py[DEBUG]: Attempting to update hostname to debian-2gb-nbg1 in 0 files 2025-07-01 18:30:10,566 - handlers.py[DEBUG]: finish: init-network/config-update_hostname: SUCCESS: config-update_hostname ran successfully 2025-07-01 18:30:10,567 - modules.py[DEBUG]: Running module update_etc_hosts () with frequency once-per-instance 2025-07-01 18:30:10,567 - handlers.py[DEBUG]: start: init-network/config-update_etc_hosts: running config-update_etc_hosts with frequency once-per-instance 2025-07-01 18:30:10,567 - helpers.py[DEBUG]: config-update_etc_hosts already ran (freq=once-per-instance) 2025-07-01 18:30:10,567 - handlers.py[DEBUG]: finish: init-network/config-update_etc_hosts: SUCCESS: config-update_etc_hosts previously ran 2025-07-01 18:30:10,567 - modules.py[DEBUG]: Running module users-groups () with frequency once-per-instance 2025-07-01 18:30:10,567 - handlers.py[DEBUG]: start: init-network/config-users-groups: running config-users-groups with frequency once-per-instance 2025-07-01 18:30:10,568 - helpers.py[DEBUG]: config-users-groups already ran (freq=once-per-instance) 2025-07-01 18:30:10,568 - handlers.py[DEBUG]: finish: init-network/config-users-groups: SUCCESS: config-users-groups previously ran 2025-07-01 18:30:10,568 - modules.py[DEBUG]: Running module ssh () with frequency once-per-instance 2025-07-01 18:30:10,568 - handlers.py[DEBUG]: start: init-network/config-ssh: running config-ssh with frequency once-per-instance 2025-07-01 18:30:10,568 - helpers.py[DEBUG]: config-ssh already ran (freq=once-per-instance) 2025-07-01 18:30:10,568 - handlers.py[DEBUG]: finish: init-network/config-ssh: SUCCESS: config-ssh previously ran 2025-07-01 18:30:10,568 - main.py[DEBUG]: Ran 10 modules with 0 failures 2025-07-01 18:30:10,569 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/status.json (via temporary file /var/lib/cloud/data/tmpj_3jma8v) - w: [644] 518 bytes/chars 2025-07-01 18:30:10,569 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False) 2025-07-01 18:30:10,570 - util.py[DEBUG]: Read 11 bytes from /proc/uptime 2025-07-01 18:30:10,570 - util.py[DEBUG]: cloud-init mode 'init' took 0.446 seconds (0.45) 2025-07-01 18:30:10,570 - handlers.py[DEBUG]: finish: init-network: SUCCESS: searching for network datasources 2025-07-01 18:30:14,176 - util.py[DEBUG]: Cloud-init v. 22.4.2 running 'modules:config' at Tue, 01 Jul 2025 18:30:14 +0000. Up 13.36 seconds. 2025-07-01 18:30:14,177 - modules.py[WARNING]: Could not find module named cc_emit_upstart (searched ['cc_emit_upstart', 'cloudinit.config.cc_emit_upstart']) 2025-07-01 18:30:14,179 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,179 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,182 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,183 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,186 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,186 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,189 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,190 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,194 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,194 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,198 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,198 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,203 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,203 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,206 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,207 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,209 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,209 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,212 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,212 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,215 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json (quiet=False) 2025-07-01 18:30:14,215 - util.py[DEBUG]: Read 133834 bytes from /usr/lib/python3/dist-packages/cloudinit/config/schemas/schema-cloud-config-v1.json 2025-07-01 18:30:14,217 - stages.py[DEBUG]: Using distro class 2025-07-01 18:30:14,219 - modules.py[INFO]: Skipping modules 'apt-pipelining,ntp,timezone,disable-ec2-metadata' because no applicable config is provided. 2025-07-01 18:30:14,219 - modules.py[DEBUG]: Running module ssh-import-id () with frequency once-per-instance 2025-07-01 18:30:14,219 - handlers.py[DEBUG]: start: modules-config/config-ssh-import-id: running config-ssh-import-id with frequency once-per-instance 2025-07-01 18:30:14,219 - helpers.py[DEBUG]: config-ssh-import-id already ran (freq=once-per-instance) 2025-07-01 18:30:14,220 - handlers.py[DEBUG]: finish: modules-config/config-ssh-import-id: SUCCESS: config-ssh-import-id previously ran 2025-07-01 18:30:14,220 - modules.py[DEBUG]: Running module locale () with frequency once-per-instance 2025-07-01 18:30:14,220 - handlers.py[DEBUG]: start: modules-config/config-locale: running config-locale with frequency once-per-instance 2025-07-01 18:30:14,220 - helpers.py[DEBUG]: config-locale already ran (freq=once-per-instance) 2025-07-01 18:30:14,220 - handlers.py[DEBUG]: finish: modules-config/config-locale: SUCCESS: config-locale previously ran 2025-07-01 18:30:14,220 - modules.py[DEBUG]: Running module set-passwords () with frequency once-per-instance 2025-07-01 18:30:14,220 - handlers.py[DEBUG]: start: modules-config/config-set-passwords: running config-set-passwords with frequency once-per-instance 2025-07-01 18:30:14,220 - helpers.py[DEBUG]: config-set-passwords already ran (freq=once-per-instance) 2025-07-01 18:30:14,220 - handlers.py[DEBUG]: finish: modules-config/config-set-passwords: SUCCESS: config-set-passwords previously ran 2025-07-01 18:30:14,220 - modules.py[DEBUG]: Running module grub-dpkg () with frequency once-per-instance 2025-07-01 18:30:14,220 - handlers.py[DEBUG]: start: modules-config/config-grub-dpkg: running config-grub-dpkg with frequency once-per-instance 2025-07-01 18:30:14,220 - helpers.py[DEBUG]: config-grub-dpkg already ran (freq=once-per-instance) 2025-07-01 18:30:14,221 - handlers.py[DEBUG]: finish: modules-config/config-grub-dpkg: SUCCESS: config-grub-dpkg previously ran 2025-07-01 18:30:14,221 - modules.py[DEBUG]: Running module apt-configure () with frequency once-per-instance 2025-07-01 18:30:14,221 - handlers.py[DEBUG]: start: modules-config/config-apt-configure: running config-apt-configure with frequency once-per-instance 2025-07-01 18:30:14,221 - helpers.py[DEBUG]: config-apt-configure already ran (freq=once-per-instance) 2025-07-01 18:30:14,221 - handlers.py[DEBUG]: finish: modules-config/config-apt-configure: SUCCESS: config-apt-configure previously ran 2025-07-01 18:30:14,221 - modules.py[DEBUG]: Running module runcmd () with frequency once-per-instance 2025-07-01 18:30:14,221 - handlers.py[DEBUG]: start: modules-config/config-runcmd: running config-runcmd with frequency once-per-instance 2025-07-01 18:30:14,221 - helpers.py[DEBUG]: config-runcmd already ran (freq=once-per-instance) 2025-07-01 18:30:14,221 - handlers.py[DEBUG]: finish: modules-config/config-runcmd: SUCCESS: config-runcmd previously ran 2025-07-01 18:30:14,221 - modules.py[DEBUG]: Running module byobu () with frequency on