Created
June 27, 2022 21:26
-
-
Save arpit15/7d56703539d42c23a63d12929b9794cf to your computer and use it in GitHub Desktop.
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
ubuntu@ip-10-0-0-151:/var/log$ cat cloud-init.log | |
2022-06-27 21:18:52,349 - util.py[DEBUG]: Cloud-init v. 22.1-14-g2e17a0d6-0ubuntu1~20.04.3 running 'init-local' at Mon, 27 Jun 2022 21:18:52 +0000. Up 15.26 seconds. | |
2022-06-27 21:18:52,349 - main.py[DEBUG]: No kernel command line url found. | |
2022-06-27 21:18:52,349 - main.py[DEBUG]: Closing stdin. | |
2022-06-27 21:18:52,352 - util.py[DEBUG]: Writing to /var/log/cloud-init.log - ab: [644] 0 bytes | |
2022-06-27 21:18:52,352 - util.py[DEBUG]: Changing the ownership of /var/log/cloud-init.log to 104:4 | |
2022-06-27 21:18:52,376 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance/boot-finished | |
2022-06-27 21:18:52,376 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/data/no-net | |
2022-06-27 21:18:52,376 - handlers.py[DEBUG]: start: init-local/check-cache: attempting to read from cache [check] | |
2022-06-27 21:18:52,376 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/obj.pkl (quiet=False) | |
2022-06-27 21:18:52,377 - stages.py[DEBUG]: no cache found | |
2022-06-27 21:18:52,377 - handlers.py[DEBUG]: finish: init-local/check-cache: SUCCESS: no cache found | |
2022-06-27 21:18:52,377 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance | |
2022-06-27 21:18:52,380 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'> | |
2022-06-27 21:18:52,380 - __init__.py[DEBUG]: Looking for data source in: ['Ec2', 'None'], via packages ['', 'cloudinit.sources'] that matches dependencies ['FILESYSTEM'] | |
2022-06-27 21:18:52,385 - __init__.py[DEBUG]: Searching for local data source in: ['DataSourceEc2Local'] | |
2022-06-27 21:18:52,385 - handlers.py[DEBUG]: start: init-local/search-Ec2Local: searching for local data from DataSourceEc2Local | |
2022-06-27 21:18:52,385 - __init__.py[DEBUG]: Seeing if we can get any data from <class 'cloudinit.sources.DataSourceEc2.DataSourceEc2Local'> | |
2022-06-27 21:18:52,385 - __init__.py[DEBUG]: Update datasource metadata and network config due to events: boot-new-instance | |
2022-06-27 21:18:52,385 - util.py[DEBUG]: Reading from /sys/hypervisor/uuid (quiet=False) | |
2022-06-27 21:18:52,385 - util.py[DEBUG]: Read 37 bytes from /sys/hypervisor/uuid | |
2022-06-27 21:18:52,385 - dmi.py[DEBUG]: querying dmi data /sys/class/dmi/id/product_serial | |
2022-06-27 21:18:52,385 - dmi.py[DEBUG]: querying dmi data /sys/class/dmi/id/chassis_asset_tag | |
2022-06-27 21:18:52,386 - dmi.py[DEBUG]: querying dmi data /sys/class/dmi/id/sys_vendor | |
2022-06-27 21:18:52,386 - DataSourceEc2.py[DEBUG]: strict_mode: warn, cloud_name=aws cloud_platform=ec2 | |
2022-06-27 21:18:52,386 - util.py[DEBUG]: Reading from /sys/class/net/eth0/name_assign_type (quiet=False) | |
2022-06-27 21:18:52,386 - __init__.py[DEBUG]: Found unstable nic names: ['eth0']; calling udevadm settle | |
2022-06-27 21:18:52,386 - subp.py[DEBUG]: Running command ['udevadm', 'settle'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,404 - util.py[DEBUG]: Waiting for udev events to settle took 0.018 seconds | |
2022-06-27 21:18:52,404 - util.py[DEBUG]: Reading from /sys/class/net/eth0/carrier (quiet=False) | |
2022-06-27 21:18:52,405 - util.py[DEBUG]: Reading from /sys/class/net/eth0/dormant (quiet=False) | |
2022-06-27 21:18:52,405 - util.py[DEBUG]: Reading from /sys/class/net/eth0/operstate (quiet=False) | |
2022-06-27 21:18:52,405 - util.py[DEBUG]: Read 5 bytes from /sys/class/net/eth0/operstate | |
2022-06-27 21:18:52,405 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
2022-06-27 21:18:52,405 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
2022-06-27 21:18:52,405 - dhcp.py[DEBUG]: Performing a dhcp discovery on eth0 | |
2022-06-27 21:18:52,406 - util.py[DEBUG]: Copying /usr/sbin/dhclient to /var/tmp/cloud-init/cloud-init-dhcp-_zuwp105/dhclient | |
2022-06-27 21:18:52,409 - subp.py[DEBUG]: Running command ['ip', 'link', 'set', 'dev', 'eth0', 'up'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,418 - subp.py[DEBUG]: Running command ['/var/tmp/cloud-init/cloud-init-dhcp-_zuwp105/dhclient', '-1', '-v', '-lf', '/var/tmp/cloud-init/cloud-init-dhcp-_zuwp105/dhcp.leases', '-pf', '/var/tmp/cloud-init/cloud-init-dhcp-_zuwp105/dhclient.pid', 'eth0', '-sf', '/bin/true'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,446 - util.py[DEBUG]: All files appeared after 0 seconds: ['/var/tmp/cloud-init/cloud-init-dhcp-_zuwp105/dhclient.pid', '/var/tmp/cloud-init/cloud-init-dhcp-_zuwp105/dhcp.leases'] | |
2022-06-27 21:18:52,446 - util.py[DEBUG]: Reading from /var/tmp/cloud-init/cloud-init-dhcp-_zuwp105/dhclient.pid (quiet=False) | |
2022-06-27 21:18:52,447 - util.py[DEBUG]: Read 4 bytes from /var/tmp/cloud-init/cloud-init-dhcp-_zuwp105/dhclient.pid | |
2022-06-27 21:18:52,447 - util.py[DEBUG]: Reading from /proc/424/stat (quiet=True) | |
2022-06-27 21:18:52,447 - util.py[DEBUG]: Read 306 bytes from /proc/424/stat | |
2022-06-27 21:18:52,447 - dhcp.py[DEBUG]: killing dhclient with pid=424 | |
2022-06-27 21:18:52,448 - util.py[DEBUG]: Reading from /var/tmp/cloud-init/cloud-init-dhcp-_zuwp105/dhcp.leases (quiet=False) | |
2022-06-27 21:18:52,448 - util.py[DEBUG]: Read 513 bytes from /var/tmp/cloud-init/cloud-init-dhcp-_zuwp105/dhcp.leases | |
2022-06-27 21:18:52,448 - dhcp.py[DEBUG]: Received dhcp lease on eth0 for 10.0.0.151/255.255.255.0 | |
2022-06-27 21:18:52,449 - __init__.py[DEBUG]: Attempting setup of ephemeral network on eth0 with 10.0.0.151/24 brd 10.0.0.255 | |
2022-06-27 21:18:52,449 - subp.py[DEBUG]: Running command ['ip', '-family', 'inet', 'addr', 'add', '10.0.0.151/24', 'broadcast', '10.0.0.255', 'dev', 'eth0'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,451 - subp.py[DEBUG]: Running command ['ip', '-family', 'inet', 'link', 'set', 'dev', 'eth0', 'up'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,454 - subp.py[DEBUG]: Running command ['ip', 'route', 'show', '0.0.0.0/0'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,456 - subp.py[DEBUG]: Running command ['ip', '-4', 'route', 'add', '10.0.0.1', 'dev', 'eth0', 'src', '10.0.0.151'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,459 - subp.py[DEBUG]: Running command ['ip', '-4', 'route', 'add', 'default', 'via', '10.0.0.1', 'dev', 'eth0'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,462 - util.py[DEBUG]: Resolving URL: http://169.254.169.254 took 0.001 seconds | |
2022-06-27 21:18:52,463 - util.py[DEBUG]: Resolving URL: http://instance-data.:8773 took 0.000 seconds | |
2022-06-27 21:18:52,463 - DataSourceEc2.py[DEBUG]: Removed the following from metadata urls: ['http://instance-data.:8773'] | |
2022-06-27 21:18:52,463 - DataSourceEc2.py[DEBUG]: Fetching Ec2 IMDSv2 API Token | |
2022-06-27 21:18:52,463 - url_helper.py[DEBUG]: [0/1] open 'http://169.254.169.254/latest/api/token' with {'url': 'http://169.254.169.254/latest/api/token', 'allow_redirects': True, 'method': 'PUT', 'timeout': 50.0, 'headers': {'User-Agent': 'Cloud-Init/22.1-14-g2e17a0d6-0ubuntu1~20.04.3', 'X-aws-ec2-metadata-token-ttl-seconds': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,468 - url_helper.py[DEBUG]: Read from http://169.254.169.254/latest/api/token (200, 56b) after 1 attempts | |
2022-06-27 21:18:52,468 - DataSourceEc2.py[DEBUG]: Using metadata source: 'http://169.254.169.254' | |
2022-06-27 21:18:52,469 - url_helper.py[DEBUG]: [0/1] open 'http://169.254.169.254/2018-09-24/meta-data/instance-id' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/instance-id', 'allow_redirects': True, 'method': 'GET', 'headers': {'User-Agent': 'Cloud-Init/22.1-14-g2e17a0d6-0ubuntu1~20.04.3', 'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,471 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/instance-id (200, 19b) after 1 attempts | |
2022-06-27 21:18:52,471 - DataSourceEc2.py[DEBUG]: Found preferred metadata version 2018-09-24 | |
2022-06-27 21:18:52,471 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/user-data' with {'url': 'http://169.254.169.254/2018-09-24/user-data', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,473 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/user-data (200, 4010b) after 1 attempts | |
2022-06-27 21:18:52,474 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,476 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/ (200, 298b) after 1 attempts | |
2022-06-27 21:18:52,476 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,478 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ (200, 286b) after 1 attempts | |
2022-06-27 21:18:52,479 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ami' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ami', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,481 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ami (200, 9b) after 1 attempts | |
2022-06-27 21:18:52,481 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral0' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral0', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,483 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral0 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,484 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral1' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral1', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,486 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral1 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,486 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral10' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral10', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,488 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral10 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,488 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral11' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral11', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,491 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral11 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,491 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral12' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral12', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,493 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral12 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,493 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral13' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral13', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,496 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral13 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,496 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral14' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral14', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,498 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral14 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,498 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral15' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral15', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,501 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral15 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,501 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral16' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral16', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,503 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral16 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,503 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral17' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral17', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,505 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral17 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,506 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral18' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral18', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,508 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral18 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,508 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral19' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral19', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,510 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral19 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,511 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral2' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral2', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,513 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral2 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,513 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral20' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral20', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,515 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral20 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,515 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral21' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral21', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,518 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral21 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,518 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral22' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral22', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,520 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral22 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,520 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral23' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral23', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,522 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral23 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,523 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral3' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral3', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,525 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral3 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,525 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral4' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral4', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,527 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral4 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,528 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral5' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral5', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,530 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral5 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,530 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral6' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral6', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,532 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral6 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,532 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral7' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral7', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,535 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral7 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,535 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral8' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral8', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,537 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral8 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,537 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral9' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral9', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,540 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/ephemeral9 (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,540 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/root' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/root', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,543 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/block-device-mapping/root (200, 9b) after 1 attempts | |
2022-06-27 21:18:52,543 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/events/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/events/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,545 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/events/ (200, 12b) after 1 attempts | |
2022-06-27 21:18:52,545 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/events/maintenance/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/events/maintenance/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,547 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/events/maintenance/ (200, 17b) after 1 attempts | |
2022-06-27 21:18:52,548 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/events/maintenance/history' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/events/maintenance/history', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,550 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/events/maintenance/history (200, 2b) after 1 attempts | |
2022-06-27 21:18:52,550 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/events/maintenance/scheduled' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/events/maintenance/scheduled', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,553 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/events/maintenance/scheduled (200, 2b) after 1 attempts | |
2022-06-27 21:18:52,553 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/iam/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/iam/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,555 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/iam/ (200, 26b) after 1 attempts | |
2022-06-27 21:18:52,555 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/iam/info' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/iam/info', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,558 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/iam/info (200, 257b) after 1 attempts | |
2022-06-27 21:18:52,558 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/identity-credentials/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/identity-credentials/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,560 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/identity-credentials/ (200, 4b) after 1 attempts | |
2022-06-27 21:18:52,561 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/identity-credentials/ec2/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/identity-credentials/ec2/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,563 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/identity-credentials/ec2/ (200, 26b) after 1 attempts | |
2022-06-27 21:18:52,563 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/identity-credentials/ec2/info' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/identity-credentials/ec2/info', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,565 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/identity-credentials/ec2/info (200, 98b) after 1 attempts | |
2022-06-27 21:18:52,566 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/metrics/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/metrics/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,568 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/metrics/ (200, 7b) after 1 attempts | |
2022-06-27 21:18:52,568 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/metrics/vhostmd' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/metrics/vhostmd', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,570 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/metrics/vhostmd (200, 38b) after 1 attempts | |
2022-06-27 21:18:52,571 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,573 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/ (200, 11b) after 1 attempts | |
2022-06-27 21:18:52,573 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,576 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/ (200, 5b) after 1 attempts | |
2022-06-27 21:18:52,576 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,578 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/ (200, 18b) after 1 attempts | |
2022-06-27 21:18:52,579 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,581 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/ (200, 230b) after 1 attempts | |
2022-06-27 21:18:52,581 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/ipv4-associations/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/ipv4-associations/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,584 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/ipv4-associations/ (200, 13b) after 1 attempts | |
2022-06-27 21:18:52,584 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/ipv4-associations/3.129.218.217' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/ipv4-associations/3.129.218.217', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,587 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/ipv4-associations/3.129.218.217 (200, 10b) after 1 attempts | |
2022-06-27 21:18:52,587 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/device-number' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/device-number', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,589 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/device-number (200, 1b) after 1 attempts | |
2022-06-27 21:18:52,589 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/interface-id' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/interface-id', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,592 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/interface-id (200, 21b) after 1 attempts | |
2022-06-27 21:18:52,592 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/local-hostname' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/local-hostname', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,594 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/local-hostname (200, 40b) after 1 attempts | |
2022-06-27 21:18:52,594 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/local-ipv4s' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/local-ipv4s', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,597 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/local-ipv4s (200, 10b) after 1 attempts | |
2022-06-27 21:18:52,597 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/mac' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/mac', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,599 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/mac (200, 17b) after 1 attempts | |
2022-06-27 21:18:52,599 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/owner-id' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/owner-id', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,602 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/owner-id (200, 12b) after 1 attempts | |
2022-06-27 21:18:52,602 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/public-hostname' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/public-hostname', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,604 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/public-hostname (200, 49b) after 1 attempts | |
2022-06-27 21:18:52,605 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/public-ipv4s' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/public-ipv4s', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,607 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/public-ipv4s (200, 13b) after 1 attempts | |
2022-06-27 21:18:52,607 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/security-group-ids' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/security-group-ids', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,610 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/security-group-ids (200, 20b) after 1 attempts | |
2022-06-27 21:18:52,610 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/security-groups' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/security-groups', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,612 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/security-groups (200, 44b) after 1 attempts | |
2022-06-27 21:18:52,613 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/subnet-id' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/subnet-id', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,615 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/subnet-id (200, 24b) after 1 attempts | |
2022-06-27 21:18:52,615 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/subnet-ipv4-cidr-block' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/subnet-ipv4-cidr-block', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,617 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/subnet-ipv4-cidr-block (200, 11b) after 1 attempts | |
2022-06-27 21:18:52,618 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/vpc-id' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/vpc-id', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,620 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/vpc-id (200, 21b) after 1 attempts | |
2022-06-27 21:18:52,620 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/vpc-ipv4-cidr-block' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/vpc-ipv4-cidr-block', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,623 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/vpc-ipv4-cidr-block (200, 11b) after 1 attempts | |
2022-06-27 21:18:52,623 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/vpc-ipv4-cidr-blocks' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/vpc-ipv4-cidr-blocks', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,625 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/network/interfaces/macs/02:61:92:1c:1a:1e/vpc-ipv4-cidr-blocks (200, 11b) after 1 attempts | |
2022-06-27 21:18:52,626 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/placement/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/placement/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,628 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/placement/ (200, 17b) after 1 attempts | |
2022-06-27 21:18:52,628 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/placement/availability-zone' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/placement/availability-zone', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,631 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/placement/availability-zone (200, 10b) after 1 attempts | |
2022-06-27 21:18:52,631 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/public-keys/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/public-keys/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,633 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/public-keys/ (200, 6b) after 1 attempts | |
2022-06-27 21:18:52,633 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/public-keys/0/openssh-key' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/public-keys/0/openssh-key', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,636 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/public-keys/0/openssh-key (200, 386b) after 1 attempts | |
2022-06-27 21:18:52,636 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/services/' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/services/', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,639 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/services/ (200, 16b) after 1 attempts | |
2022-06-27 21:18:52,639 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/services/domain' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/services/domain', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,641 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/services/domain (200, 13b) after 1 attempts | |
2022-06-27 21:18:52,641 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/services/partition' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/services/partition', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,644 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/services/partition (200, 3b) after 1 attempts | |
2022-06-27 21:18:52,644 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/ami-id' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/ami-id', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,647 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/ami-id (200, 21b) after 1 attempts | |
2022-06-27 21:18:52,647 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/ami-launch-index' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/ami-launch-index', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,649 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/ami-launch-index (200, 1b) after 1 attempts | |
2022-06-27 21:18:52,649 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/ami-manifest-path' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/ami-manifest-path', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,652 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/ami-manifest-path (200, 9b) after 1 attempts | |
2022-06-27 21:18:52,652 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/hostname' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/hostname', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,654 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/hostname (200, 40b) after 1 attempts | |
2022-06-27 21:18:52,655 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/instance-action' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/instance-action', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,657 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/instance-action (200, 4b) after 1 attempts | |
2022-06-27 21:18:52,657 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/instance-id' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/instance-id', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,659 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/instance-id (200, 19b) after 1 attempts | |
2022-06-27 21:18:52,660 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/instance-type' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/instance-type', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,662 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/instance-type (200, 8b) after 1 attempts | |
2022-06-27 21:18:52,662 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/local-hostname' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/local-hostname', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,664 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/local-hostname (200, 40b) after 1 attempts | |
2022-06-27 21:18:52,665 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/local-ipv4' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/local-ipv4', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,667 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/local-ipv4 (200, 10b) after 1 attempts | |
2022-06-27 21:18:52,667 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/mac' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/mac', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,669 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/mac (200, 17b) after 1 attempts | |
2022-06-27 21:18:52,669 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/profile' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/profile', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,672 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/profile (200, 11b) after 1 attempts | |
2022-06-27 21:18:52,672 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/public-hostname' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/public-hostname', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,674 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/public-hostname (200, 49b) after 1 attempts | |
2022-06-27 21:18:52,674 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/public-ipv4' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/public-ipv4', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,677 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/public-ipv4 (200, 13b) after 1 attempts | |
2022-06-27 21:18:52,677 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/reservation-id' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/reservation-id', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,679 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/reservation-id (200, 19b) after 1 attempts | |
2022-06-27 21:18:52,679 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/meta-data/security-groups' with {'url': 'http://169.254.169.254/2018-09-24/meta-data/security-groups', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,681 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/meta-data/security-groups (200, 44b) after 1 attempts | |
2022-06-27 21:18:52,682 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/dynamic/instance-identity' with {'url': 'http://169.254.169.254/2018-09-24/dynamic/instance-identity', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,684 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/dynamic/instance-identity (200, 33b) after 1 attempts | |
2022-06-27 21:18:52,684 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/dynamic/instance-identity/signature' with {'url': 'http://169.254.169.254/2018-09-24/dynamic/instance-identity/signature', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,687 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/dynamic/instance-identity/signature (200, 174b) after 1 attempts | |
2022-06-27 21:18:52,687 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/dynamic/instance-identity/rsa2048' with {'url': 'http://169.254.169.254/2018-09-24/dynamic/instance-identity/rsa2048', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,689 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/dynamic/instance-identity/rsa2048 (200, 1483b) after 1 attempts | |
2022-06-27 21:18:52,689 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/dynamic/instance-identity/pkcs7' with {'url': 'http://169.254.169.254/2018-09-24/dynamic/instance-identity/pkcs7', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,691 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/dynamic/instance-identity/pkcs7 (200, 1163b) after 1 attempts | |
2022-06-27 21:18:52,692 - url_helper.py[DEBUG]: [0/6] open 'http://169.254.169.254/2018-09-24/dynamic/instance-identity/document' with {'url': 'http://169.254.169.254/2018-09-24/dynamic/instance-identity/document', 'allow_redirects': True, 'method': 'GET', 'timeout': 5.0, 'headers': {'X-aws-ec2-metadata-token': 'REDACTED'}} configuration | |
2022-06-27 21:18:52,694 - url_helper.py[DEBUG]: Read from http://169.254.169.254/2018-09-24/dynamic/instance-identity/document (200, 474b) after 1 attempts | |
2022-06-27 21:18:52,694 - util.py[DEBUG]: Crawl of metadata service took 0.233 seconds | |
2022-06-27 21:18:52,694 - subp.py[DEBUG]: Running command ['ip', '-4', 'route', 'del', 'default', 'dev', 'eth0'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,697 - subp.py[DEBUG]: Running command ['ip', '-4', 'route', 'del', '10.0.0.1', 'dev', 'eth0', 'src', '10.0.0.151'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,700 - subp.py[DEBUG]: Running command ['ip', '-family', 'inet', 'link', 'set', 'dev', 'eth0', 'down'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,703 - subp.py[DEBUG]: Running command ['ip', '-family', 'inet', 'addr', 'del', '10.0.0.151/24', 'dev', 'eth0'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,708 - util.py[DEBUG]: Writing to /run/cloud-init/cloud-id-aws - wb: [644] 4 bytes | |
2022-06-27 21:18:52,708 - util.py[DEBUG]: Creating symbolic link from '/run/cloud-init/cloud-id' => '/run/cloud-init/cloud-id-aws' | |
2022-06-27 21:18:52,709 - atomic_helper.py[DEBUG]: Atomically writing to file /run/cloud-init/instance-data-sensitive.json (via temporary file /run/cloud-init/tmpgkec3mo5) - w: [600] 12449 bytes/chars | |
2022-06-27 21:18:52,711 - atomic_helper.py[DEBUG]: Atomically writing to file /run/cloud-init/instance-data.json (via temporary file /run/cloud-init/tmpqp0hvuyf) - w: [644] 9158 bytes/chars | |
2022-06-27 21:18:52,711 - handlers.py[DEBUG]: finish: init-local/search-Ec2Local: SUCCESS: found local data from DataSourceEc2Local | |
2022-06-27 21:18:52,711 - stages.py[INFO]: Loaded datasource DataSourceEc2Local - DataSourceEc2Local | |
2022-06-27 21:18:52,712 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) | |
2022-06-27 21:18:52,712 - util.py[DEBUG]: Read 3819 bytes from /etc/cloud/cloud.cfg | |
2022-06-27 21:18:52,712 - util.py[DEBUG]: Attempting to load yaml from string of length 3819 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:52,723 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90_dpkg.cfg (quiet=False) | |
2022-06-27 21:18:52,723 - util.py[DEBUG]: Read 314 bytes from /etc/cloud/cloud.cfg.d/90_dpkg.cfg | |
2022-06-27 21:18:52,723 - util.py[DEBUG]: Attempting to load yaml from string of length 314 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:52,725 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/05_logging.cfg (quiet=False) | |
2022-06-27 21:18:52,725 - util.py[DEBUG]: Read 2070 bytes from /etc/cloud/cloud.cfg.d/05_logging.cfg | |
2022-06-27 21:18:52,725 - util.py[DEBUG]: Attempting to load yaml from string of length 2070 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:52,728 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False) | |
2022-06-27 21:18:52,728 - util.py[DEBUG]: Read 31 bytes from /run/cloud-init/cloud.cfg | |
2022-06-27 21:18:52,728 - util.py[DEBUG]: Attempting to load yaml from string of length 31 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:52,729 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:52,729 - util.py[DEBUG]: loaded blob returned None, returning default. | |
2022-06-27 21:18:52,729 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance | |
2022-06-27 21:18:52,729 - util.py[DEBUG]: Creating symbolic link from '/var/lib/cloud/instance' => '/var/lib/cloud/instances/i-0791381a1090bf470' | |
2022-06-27 21:18:52,731 - util.py[DEBUG]: Reading from /var/lib/cloud/instances/i-0791381a1090bf470/datasource (quiet=False) | |
2022-06-27 21:18:52,731 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/datasource - wb: [644] 39 bytes | |
2022-06-27 21:18:52,731 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-datasource - wb: [644] 39 bytes | |
2022-06-27 21:18:52,732 - util.py[DEBUG]: Reading from /var/lib/cloud/data/instance-id (quiet=False) | |
2022-06-27 21:18:52,733 - util.py[DEBUG]: Read 20 bytes from /var/lib/cloud/data/instance-id | |
2022-06-27 21:18:52,733 - stages.py[DEBUG]: previous iid found to be i-0d330aafb375ba962 | |
2022-06-27 21:18:52,733 - util.py[DEBUG]: Writing to /var/lib/cloud/data/instance-id - wb: [644] 20 bytes | |
2022-06-27 21:18:52,733 - util.py[DEBUG]: Writing to /run/cloud-init/.instance-id - wb: [644] 20 bytes | |
2022-06-27 21:18:52,734 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-instance-id - wb: [644] 20 bytes | |
2022-06-27 21:18:52,734 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [400] 15999 bytes | |
2022-06-27 21:18:52,735 - main.py[DEBUG]: [local] init will now be targeting instance id: i-0791381a1090bf470. new=True | |
2022-06-27 21:18:52,735 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) | |
2022-06-27 21:18:52,735 - util.py[DEBUG]: Read 3819 bytes from /etc/cloud/cloud.cfg | |
2022-06-27 21:18:52,735 - util.py[DEBUG]: Attempting to load yaml from string of length 3819 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:52,746 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90_dpkg.cfg (quiet=False) | |
2022-06-27 21:18:52,746 - util.py[DEBUG]: Read 314 bytes from /etc/cloud/cloud.cfg.d/90_dpkg.cfg | |
2022-06-27 21:18:52,746 - util.py[DEBUG]: Attempting to load yaml from string of length 314 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:52,748 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/05_logging.cfg (quiet=False) | |
2022-06-27 21:18:52,748 - util.py[DEBUG]: Read 2070 bytes from /etc/cloud/cloud.cfg.d/05_logging.cfg | |
2022-06-27 21:18:52,748 - util.py[DEBUG]: Attempting to load yaml from string of length 2070 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:52,751 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False) | |
2022-06-27 21:18:52,751 - util.py[DEBUG]: Read 31 bytes from /run/cloud-init/cloud.cfg | |
2022-06-27 21:18:52,751 - util.py[DEBUG]: Attempting to load yaml from string of length 31 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:52,752 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:52,752 - util.py[DEBUG]: loaded blob returned None, returning default. | |
2022-06-27 21:18:52,753 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'> | |
2022-06-27 21:18:52,753 - util.py[DEBUG]: Reading from /var/lib/cloud/data/set-hostname (quiet=False) | |
2022-06-27 21:18:52,754 - util.py[DEBUG]: Read 76 bytes from /var/lib/cloud/data/set-hostname | |
2022-06-27 21:18:52,754 - cc_set_hostname.py[DEBUG]: Setting the hostname to ip-10-0-0-151.us-east-2.compute.internal (ip-10-0-0-151) | |
2022-06-27 21:18:52,754 - util.py[DEBUG]: Reading from /etc/hostname (quiet=False) | |
2022-06-27 21:18:52,754 - util.py[DEBUG]: Read 16 bytes from /etc/hostname | |
2022-06-27 21:18:52,754 - util.py[DEBUG]: Writing to /etc/hostname - wb: [644] 14 bytes | |
2022-06-27 21:18:52,755 - __init__.py[DEBUG]: Non-persistently setting the system hostname to ip-10-0-0-151 | |
2022-06-27 21:18:52,755 - subp.py[DEBUG]: Running command ['hostname', 'ip-10-0-0-151'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,758 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/set-hostname (via temporary file /var/lib/cloud/data/tmp1d2j7iq1) - w: [644] 86 bytes/chars | |
2022-06-27 21:18:52,759 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
2022-06-27 21:18:52,760 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
2022-06-27 21:18:52,760 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) | |
2022-06-27 21:18:52,760 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address | |
2022-06-27 21:18:52,760 - util.py[DEBUG]: Reading from /sys/class/net/eth0/addr_assign_type (quiet=False) | |
2022-06-27 21:18:52,760 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/addr_assign_type | |
2022-06-27 21:18:52,760 - util.py[DEBUG]: Reading from /sys/class/net/eth0/uevent (quiet=False) | |
2022-06-27 21:18:52,760 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth0/uevent | |
2022-06-27 21:18:52,760 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
2022-06-27 21:18:52,760 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
2022-06-27 21:18:52,761 - __init__.py[DEBUG]: ovs-vsctl not in PATH; not detecting Open vSwitch interfaces | |
2022-06-27 21:18:52,761 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) | |
2022-06-27 21:18:52,761 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False) | |
2022-06-27 21:18:52,761 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type | |
2022-06-27 21:18:52,761 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False) | |
2022-06-27 21:18:52,761 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent | |
2022-06-27 21:18:52,761 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) | |
2022-06-27 21:18:52,761 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address | |
2022-06-27 21:18:52,761 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False) | |
2022-06-27 21:18:52,761 - util.py[DEBUG]: Reading from /sys/class/net/eth0/type (quiet=False) | |
2022-06-27 21:18:52,761 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/type | |
2022-06-27 21:18:52,762 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False) | |
2022-06-27 21:18:52,762 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type | |
2022-06-27 21:18:52,762 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
2022-06-27 21:18:52,762 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
2022-06-27 21:18:52,762 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) | |
2022-06-27 21:18:52,762 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address | |
2022-06-27 21:18:52,762 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) | |
2022-06-27 21:18:52,762 - util.py[DEBUG]: Reading from /sys/class/net/eth0/addr_assign_type (quiet=False) | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/addr_assign_type | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Reading from /sys/class/net/eth0/uevent (quiet=False) | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth0/uevent | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False) | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False) | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address | |
2022-06-27 21:18:52,763 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False) | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Reading from /sys/class/net/eth0/type (quiet=False) | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/type | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False) | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type | |
2022-06-27 21:18:52,764 - networking.py[DEBUG]: net: all expected physical devices present | |
2022-06-27 21:18:52,764 - stages.py[DEBUG]: applying net config names for {'version': 2, 'ethernets': {'eth0': {'dhcp4': True, 'dhcp6': False, 'match': {'macaddress': '02:61:92:1c:1a:1e'}, 'set-name': 'eth0'}}} | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Reading from /sys/class/net/eth0/addr_assign_type (quiet=False) | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/addr_assign_type | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Reading from /sys/class/net/eth0/uevent (quiet=False) | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth0/uevent | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
2022-06-27 21:18:52,764 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False) | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False) | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False) | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Reading from /sys/class/net/eth0/operstate (quiet=False) | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Read 5 bytes from /sys/class/net/eth0/operstate | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Reading from /sys/class/net/lo/operstate (quiet=False) | |
2022-06-27 21:18:52,765 - util.py[DEBUG]: Read 8 bytes from /sys/class/net/lo/operstate | |
2022-06-27 21:18:52,766 - subp.py[DEBUG]: Running command ['ip', '-6', 'addr', 'show', 'permanent', 'scope', 'global'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,769 - subp.py[DEBUG]: Running command ['ip', '-4', 'addr', 'show'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:52,772 - __init__.py[DEBUG]: Detected interfaces {'eth0': {'downable': True, 'device_id': None, 'driver': 'vif', 'mac': '02:61:92:1c:1a:1e', 'name': 'eth0', 'up': False}, 'lo': {'downable': False, 'device_id': None, 'driver': None, 'mac': '00:00:00:00:00:00', 'name': 'lo', 'up': True}} | |
2022-06-27 21:18:52,772 - __init__.py[DEBUG]: no work necessary for renaming of [['02:61:92:1c:1a:1e', 'eth0', 'vif', None]] | |
2022-06-27 21:18:52,772 - stages.py[INFO]: Applying network configuration from ds bringup=False: {'version': 2, 'ethernets': {'eth0': {'dhcp4': True, 'dhcp6': False, 'match': {'macaddress': '02:61:92:1c:1a:1e'}, 'set-name': 'eth0'}}} | |
2022-06-27 21:18:52,773 - util.py[DEBUG]: Writing to /run/cloud-init/sem/apply_network_config.once - wb: [644] 22 bytes | |
2022-06-27 21:18:52,773 - network_state.py[DEBUG]: v2(ethernets) -> v1(physical): | |
{'type': 'physical', 'name': 'eth0', 'mac_address': '02:61:92:1c:1a:1e', 'match': {'macaddress': '02:61:92:1c:1a:1e'}, 'subnets': [{'type': 'dhcp4'}]} | |
2022-06-27 21:18:52,775 - network_state.py[DEBUG]: v2_common: handling config: | |
{'eth0': {'dhcp4': True, 'dhcp6': False, 'match': {'macaddress': '02:61:92:1c:1a:1e'}, 'set-name': 'eth0'}} | |
2022-06-27 21:18:52,777 - __init__.py[DEBUG]: Selected renderer 'netplan' from priority list: ['netplan', 'eni', 'sysconfig'] | |
2022-06-27 21:18:52,777 - netplan.py[DEBUG]: V2 to V2 passthrough | |
2022-06-27 21:18:52,778 - util.py[DEBUG]: Writing to /etc/netplan/50-cloud-init.yaml - wb: [644] 506 bytes | |
2022-06-27 21:18:52,779 - subp.py[DEBUG]: Running command ['netplan', 'generate'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:53,125 - subp.py[DEBUG]: Running command ['udevadm', 'test-builtin', 'net_setup_link', '/sys/class/net/eth0'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:53,133 - subp.py[DEBUG]: Running command ['udevadm', 'test-builtin', 'net_setup_link', '/sys/class/net/lo'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:53,138 - __init__.py[DEBUG]: Not bringing up newly configured network interfaces | |
2022-06-27 21:18:53,138 - main.py[DEBUG]: [local] Exiting. datasource DataSourceEc2Local not in local mode. | |
2022-06-27 21:18:53,139 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/status.json (via temporary file /var/lib/cloud/data/tmpczli9zsu) - w: [644] 490 bytes/chars | |
2022-06-27 21:18:53,139 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False) | |
2022-06-27 21:18:53,139 - util.py[DEBUG]: Read 11 bytes from /proc/uptime | |
2022-06-27 21:18:53,139 - util.py[DEBUG]: cloud-init mode 'init' took 0.840 seconds (0.84) | |
2022-06-27 21:18:53,139 - handlers.py[DEBUG]: finish: init-local: SUCCESS: searching for local datasources | |
2022-06-27 21:18:55,863 - util.py[DEBUG]: Cloud-init v. 22.1-14-g2e17a0d6-0ubuntu1~20.04.3 running 'init' at Mon, 27 Jun 2022 21:18:55 +0000. Up 18.78 seconds. | |
2022-06-27 21:18:55,863 - main.py[DEBUG]: No kernel command line url found. | |
2022-06-27 21:18:55,863 - main.py[DEBUG]: Closing stdin. | |
2022-06-27 21:18:55,865 - util.py[DEBUG]: Writing to /var/log/cloud-init.log - ab: [644] 0 bytes | |
2022-06-27 21:18:55,866 - util.py[DEBUG]: Changing the ownership of /var/log/cloud-init.log to 104:4 | |
2022-06-27 21:18:55,866 - subp.py[DEBUG]: Running command ['ip', '--json', 'addr'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:55,870 - subp.py[DEBUG]: Running command ['ip', '-o', 'route', 'list'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:55,872 - subp.py[DEBUG]: Running command ['ip', '--oneline', '-6', 'route', 'list', 'table', 'all'] with allowed return codes [0, 1] (shell=False, capture=True) | |
2022-06-27 21:18:55,876 - main.py[DEBUG]: Checking to see if files that we need already exist from a previous run that would allow us to stop early. | |
2022-06-27 21:18:55,876 - main.py[DEBUG]: Execution continuing, no previous run detected that would allow us to stop early. | |
2022-06-27 21:18:55,876 - handlers.py[DEBUG]: start: init-network/check-cache: attempting to read from cache [trust] | |
2022-06-27 21:18:55,877 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/obj.pkl (quiet=False) | |
2022-06-27 21:18:55,877 - util.py[DEBUG]: Read 15999 bytes from /var/lib/cloud/instance/obj.pkl | |
2022-06-27 21:18:55,880 - util.py[DEBUG]: Reading from /run/cloud-init/.instance-id (quiet=False) | |
2022-06-27 21:18:55,880 - util.py[DEBUG]: Read 20 bytes from /run/cloud-init/.instance-id | |
2022-06-27 21:18:55,880 - stages.py[DEBUG]: restored from cache with run check: DataSourceEc2Local | |
2022-06-27 21:18:55,880 - handlers.py[DEBUG]: finish: init-network/check-cache: SUCCESS: restored from cache with run check: DataSourceEc2Local | |
2022-06-27 21:18:55,880 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) | |
2022-06-27 21:18:55,880 - util.py[DEBUG]: Read 3819 bytes from /etc/cloud/cloud.cfg | |
2022-06-27 21:18:55,880 - util.py[DEBUG]: Attempting to load yaml from string of length 3819 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,893 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90_dpkg.cfg (quiet=False) | |
2022-06-27 21:18:55,893 - util.py[DEBUG]: Read 314 bytes from /etc/cloud/cloud.cfg.d/90_dpkg.cfg | |
2022-06-27 21:18:55,893 - util.py[DEBUG]: Attempting to load yaml from string of length 314 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,895 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/05_logging.cfg (quiet=False) | |
2022-06-27 21:18:55,895 - util.py[DEBUG]: Read 2070 bytes from /etc/cloud/cloud.cfg.d/05_logging.cfg | |
2022-06-27 21:18:55,895 - util.py[DEBUG]: Attempting to load yaml from string of length 2070 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,898 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False) | |
2022-06-27 21:18:55,898 - util.py[DEBUG]: Read 31 bytes from /run/cloud-init/cloud.cfg | |
2022-06-27 21:18:55,898 - util.py[DEBUG]: Attempting to load yaml from string of length 31 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,898 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,899 - util.py[DEBUG]: loaded blob returned None, returning default. | |
2022-06-27 21:18:55,899 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance | |
2022-06-27 21:18:55,899 - util.py[DEBUG]: Creating symbolic link from '/var/lib/cloud/instance' => '/var/lib/cloud/instances/i-0791381a1090bf470' | |
2022-06-27 21:18:55,900 - util.py[DEBUG]: Reading from /var/lib/cloud/instances/i-0791381a1090bf470/datasource (quiet=False) | |
2022-06-27 21:18:55,900 - util.py[DEBUG]: Read 39 bytes from /var/lib/cloud/instances/i-0791381a1090bf470/datasource | |
2022-06-27 21:18:55,900 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/datasource - wb: [644] 39 bytes | |
2022-06-27 21:18:55,900 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-datasource - wb: [644] 39 bytes | |
2022-06-27 21:18:55,901 - util.py[DEBUG]: Reading from /var/lib/cloud/data/instance-id (quiet=False) | |
2022-06-27 21:18:55,901 - util.py[DEBUG]: Read 20 bytes from /var/lib/cloud/data/instance-id | |
2022-06-27 21:18:55,901 - stages.py[DEBUG]: previous iid found to be i-0791381a1090bf470 | |
2022-06-27 21:18:55,901 - util.py[DEBUG]: Writing to /var/lib/cloud/data/instance-id - wb: [644] 20 bytes | |
2022-06-27 21:18:55,901 - util.py[DEBUG]: Writing to /run/cloud-init/.instance-id - wb: [644] 20 bytes | |
2022-06-27 21:18:55,902 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-instance-id - wb: [644] 20 bytes | |
2022-06-27 21:18:55,902 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [400] 16002 bytes | |
2022-06-27 21:18:55,903 - main.py[DEBUG]: [net] init will now be targeting instance id: i-0791381a1090bf470. new=False | |
2022-06-27 21:18:55,903 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) | |
2022-06-27 21:18:55,903 - util.py[DEBUG]: Read 3819 bytes from /etc/cloud/cloud.cfg | |
2022-06-27 21:18:55,903 - util.py[DEBUG]: Attempting to load yaml from string of length 3819 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,914 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90_dpkg.cfg (quiet=False) | |
2022-06-27 21:18:55,914 - util.py[DEBUG]: Read 314 bytes from /etc/cloud/cloud.cfg.d/90_dpkg.cfg | |
2022-06-27 21:18:55,914 - util.py[DEBUG]: Attempting to load yaml from string of length 314 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,916 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/05_logging.cfg (quiet=False) | |
2022-06-27 21:18:55,916 - util.py[DEBUG]: Read 2070 bytes from /etc/cloud/cloud.cfg.d/05_logging.cfg | |
2022-06-27 21:18:55,916 - util.py[DEBUG]: Attempting to load yaml from string of length 2070 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,919 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False) | |
2022-06-27 21:18:55,919 - util.py[DEBUG]: Read 31 bytes from /run/cloud-init/cloud.cfg | |
2022-06-27 21:18:55,919 - util.py[DEBUG]: Attempting to load yaml from string of length 31 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,919 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,919 - util.py[DEBUG]: loaded blob returned None, returning default. | |
2022-06-27 21:18:55,920 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
2022-06-27 21:18:55,921 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
2022-06-27 21:18:55,921 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) | |
2022-06-27 21:18:55,921 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address | |
2022-06-27 21:18:55,921 - util.py[DEBUG]: Reading from /sys/class/net/eth0/addr_assign_type (quiet=False) | |
2022-06-27 21:18:55,921 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/addr_assign_type | |
2022-06-27 21:18:55,921 - util.py[DEBUG]: Reading from /sys/class/net/eth0/uevent (quiet=False) | |
2022-06-27 21:18:55,921 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth0/uevent | |
2022-06-27 21:18:55,921 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
2022-06-27 21:18:55,921 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
2022-06-27 21:18:55,922 - __init__.py[DEBUG]: ovs-vsctl not in PATH; not detecting Open vSwitch interfaces | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False) | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False) | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False) | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Reading from /sys/class/net/eth0/type (quiet=False) | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/type | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Reading from /sys/class/net/lo/type (quiet=False) | |
2022-06-27 21:18:55,922 - util.py[DEBUG]: Read 4 bytes from /sys/class/net/lo/type | |
2022-06-27 21:18:55,923 - stages.py[DEBUG]: Allowed events: {<EventScope.NETWORK: 'network'>: {<EventType.BOOT_NEW_INSTANCE: 'boot-new-instance'>}} | |
2022-06-27 21:18:55,923 - stages.py[DEBUG]: Event Denied: scopes=['network'] EventType=boot-legacy | |
2022-06-27 21:18:55,923 - stages.py[DEBUG]: No network config applied. Neither a new instance nor datasource network update allowed | |
2022-06-27 21:18:55,923 - stages.py[DEBUG]: applying net config names for {'version': 2, 'ethernets': {'eth0': {'dhcp4': True, 'dhcp6': False, 'match': {'macaddress': '02:61:92:1c:1a:1e'}, 'set-name': 'eth0'}}} | |
2022-06-27 21:18:55,924 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'> | |
2022-06-27 21:18:55,924 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) | |
2022-06-27 21:18:55,924 - util.py[DEBUG]: Reading from /sys/class/net/eth0/addr_assign_type (quiet=False) | |
2022-06-27 21:18:55,924 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/eth0/addr_assign_type | |
2022-06-27 21:18:55,924 - util.py[DEBUG]: Reading from /sys/class/net/eth0/uevent (quiet=False) | |
2022-06-27 21:18:55,924 - util.py[DEBUG]: Read 25 bytes from /sys/class/net/eth0/uevent | |
2022-06-27 21:18:55,924 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
2022-06-27 21:18:55,924 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Reading from /sys/class/net/eth0/device/device (quiet=False) | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Reading from /sys/class/net/lo/addr_assign_type (quiet=False) | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Read 2 bytes from /sys/class/net/lo/addr_assign_type | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Reading from /sys/class/net/lo/uevent (quiet=False) | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Read 23 bytes from /sys/class/net/lo/uevent | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Reading from /sys/class/net/lo/device/device (quiet=False) | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Reading from /sys/class/net/eth0/operstate (quiet=False) | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Read 3 bytes from /sys/class/net/eth0/operstate | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Reading from /sys/class/net/lo/operstate (quiet=False) | |
2022-06-27 21:18:55,925 - util.py[DEBUG]: Read 8 bytes from /sys/class/net/lo/operstate | |
2022-06-27 21:18:55,926 - subp.py[DEBUG]: Running command ['ip', '-6', 'addr', 'show', 'permanent', 'scope', 'global'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:55,928 - subp.py[DEBUG]: Running command ['ip', '-4', 'addr', 'show'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:55,931 - __init__.py[DEBUG]: Detected interfaces {'eth0': {'downable': False, 'device_id': None, 'driver': 'vif', 'mac': '02:61:92:1c:1a:1e', 'name': 'eth0', 'up': True}, 'lo': {'downable': False, 'device_id': None, 'driver': None, 'mac': '00:00:00:00:00:00', 'name': 'lo', 'up': True}} | |
2022-06-27 21:18:55,931 - __init__.py[DEBUG]: no work necessary for renaming of [['02:61:92:1c:1a:1e', 'eth0', 'vif', None]] | |
2022-06-27 21:18:55,932 - handlers.py[DEBUG]: start: init-network/setup-datasource: setting up datasource | |
2022-06-27 21:18:55,932 - handlers.py[DEBUG]: finish: init-network/setup-datasource: SUCCESS: setting up datasource | |
2022-06-27 21:18:55,932 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/user-data.txt - wb: [600] 4010 bytes | |
2022-06-27 21:18:55,934 - util.py[DEBUG]: Attempting to load yaml from string of length 96 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,937 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/user-data.txt.i - wb: [600] 4407 bytes | |
2022-06-27 21:18:55,937 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/vendor-data.txt - wb: [600] 0 bytes | |
2022-06-27 21:18:55,938 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/vendor-data.txt.i - wb: [600] 308 bytes | |
2022-06-27 21:18:55,939 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/vendor-data2.txt - wb: [600] 0 bytes | |
2022-06-27 21:18:55,940 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/vendor-data2.txt.i - wb: [600] 308 bytes | |
2022-06-27 21:18:55,941 - util.py[DEBUG]: Reading from /var/lib/cloud/data/set-hostname (quiet=False) | |
2022-06-27 21:18:55,941 - util.py[DEBUG]: Read 86 bytes from /var/lib/cloud/data/set-hostname | |
2022-06-27 21:18:55,941 - cc_set_hostname.py[DEBUG]: No hostname changes. Skipping set-hostname | |
2022-06-27 21:18:55,941 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/consume_data - wb: [644] 24 bytes | |
2022-06-27 21:18:55,941 - helpers.py[DEBUG]: Running consume_data using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/consume_data'>) | |
2022-06-27 21:18:55,942 - handlers.py[DEBUG]: start: init-network/consume-user-data: reading and applying user-data | |
2022-06-27 21:18:55,942 - launch_index.py[DEBUG]: Discarding 0 multipart messages which do not match launch index 0 | |
2022-06-27 21:18:55,964 - stages.py[DEBUG]: Added default handler for {'text/cloud-config', 'text/cloud-config-jsonp'} from CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] | |
2022-06-27 21:18:55,964 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript'} from ShellScriptPartHandler: [['text/x-shellscript']] | |
2022-06-27 21:18:55,964 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript-per-boot'} from ShellScriptByFreqPartHandler: [['text/x-shellscript-per-boot']] | |
2022-06-27 21:18:55,964 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript-per-instance'} from ShellScriptByFreqPartHandler: [['text/x-shellscript-per-instance']] | |
2022-06-27 21:18:55,964 - stages.py[DEBUG]: Added default handler for {'text/x-shellscript-per-once'} from ShellScriptByFreqPartHandler: [['text/x-shellscript-per-once']] | |
2022-06-27 21:18:55,964 - stages.py[DEBUG]: Added default handler for {'text/cloud-boothook'} from BootHookPartHandler: [['text/cloud-boothook']] | |
2022-06-27 21:18:55,965 - stages.py[DEBUG]: Added default handler for {'text/upstart-job'} from UpstartJobPartHandler: [['text/upstart-job']] | |
2022-06-27 21:18:55,965 - stages.py[DEBUG]: Added default handler for {'text/jinja2'} from JinjaTemplatePartHandler: [['text/jinja2']] | |
2022-06-27 21:18:55,965 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (__begin__, None, 3) with frequency once-per-instance | |
2022-06-27 21:18:55,965 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (__begin__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,965 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-boot']] (__begin__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,965 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-instance']] (__begin__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,965 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-once']] (__begin__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,965 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (__begin__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,965 - __init__.py[DEBUG]: Calling handler UpstartJobPartHandler: [['text/upstart-job']] (__begin__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,965 - __init__.py[DEBUG]: Calling handler JinjaTemplatePartHandler: [['text/jinja2']] (__begin__, None, 3) with frequency once-per-instance | |
2022-06-27 21:18:55,965 - __init__.py[DEBUG]: {'Content-Type': 'text/cloud-boothook; charset="us-ascii"', 'MIME-Version': '1.0', 'Content-Disposition': 'attachment; filename="part-001"'} | |
2022-06-27 21:18:55,966 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (text/cloud-boothook, part-001, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,966 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/boothooks/part-001 - wb: [700] 895 bytes | |
2022-06-27 21:18:55,966 - subp.py[DEBUG]: Running command ['/var/lib/cloud/instances/i-0791381a1090bf470/boothooks/part-001'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:55,982 - __init__.py[DEBUG]: {'Content-Type': 'text/cloud-config; charset=us-ascii', 'MIME-Version': '1.0', 'Content-Disposition': 'attachment; filename="part-002"'} | |
2022-06-27 21:18:55,982 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (text/cloud-config, part-002, 3) with frequency once-per-instance | |
2022-06-27 21:18:55,982 - util.py[DEBUG]: Attempting to load yaml from string of length 96 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,983 - cloud_config.py[DEBUG]: Merging by applying [('dict', ['replace']), ('list', []), ('str', [])] | |
2022-06-27 21:18:55,983 - __init__.py[DEBUG]: {'Content-Type': 'text/x-shellscript; charset="us-ascii"', 'MIME-Version': '1.0', 'Content-Disposition': 'attachment; filename="part-003"'} | |
2022-06-27 21:18:55,983 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (text/x-shellscript, part-003, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,983 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/scripts/part-003 - wb: [700] 2668 bytes | |
2022-06-27 21:18:55,984 - __init__.py[DEBUG]: {'Content-Disposition': 'attachment; filename="part-004"'} | |
2022-06-27 21:18:55,984 - __init__.py[DEBUG]: Empty payload of type text/plain | |
2022-06-27 21:18:55,984 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (__end__, None, 3) with frequency once-per-instance | |
2022-06-27 21:18:55,985 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/cloud-config.txt - wb: [600] 144 bytes | |
2022-06-27 21:18:55,985 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (__end__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,985 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-boot']] (__end__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,985 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-instance']] (__end__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,985 - __init__.py[DEBUG]: Calling handler ShellScriptByFreqPartHandler: [['text/x-shellscript-per-once']] (__end__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,986 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (__end__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,986 - __init__.py[DEBUG]: Calling handler UpstartJobPartHandler: [['text/upstart-job']] (__end__, None, 2) with frequency once-per-instance | |
2022-06-27 21:18:55,986 - __init__.py[DEBUG]: Calling handler JinjaTemplatePartHandler: [['text/jinja2']] (__end__, None, 3) with frequency once-per-instance | |
2022-06-27 21:18:55,986 - handlers.py[DEBUG]: finish: init-network/consume-user-data: SUCCESS: reading and applying user-data | |
2022-06-27 21:18:55,986 - handlers.py[DEBUG]: start: init-network/consume-vendor-data: reading and applying vendor-data | |
2022-06-27 21:18:55,986 - stages.py[DEBUG]: no vendordata from datasource | |
2022-06-27 21:18:55,986 - handlers.py[DEBUG]: finish: init-network/consume-vendor-data: SUCCESS: reading and applying vendor-data | |
2022-06-27 21:18:55,986 - handlers.py[DEBUG]: start: init-network/consume-vendor-data2: reading and applying vendor-data2 | |
2022-06-27 21:18:55,986 - stages.py[DEBUG]: no vendordata2 from datasource | |
2022-06-27 21:18:55,986 - handlers.py[DEBUG]: finish: init-network/consume-vendor-data2: SUCCESS: reading and applying vendor-data2 | |
2022-06-27 21:18:55,986 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) | |
2022-06-27 21:18:55,987 - util.py[DEBUG]: Read 3819 bytes from /etc/cloud/cloud.cfg | |
2022-06-27 21:18:55,987 - util.py[DEBUG]: Attempting to load yaml from string of length 3819 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,998 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90_dpkg.cfg (quiet=False) | |
2022-06-27 21:18:55,998 - util.py[DEBUG]: Read 314 bytes from /etc/cloud/cloud.cfg.d/90_dpkg.cfg | |
2022-06-27 21:18:55,998 - util.py[DEBUG]: Attempting to load yaml from string of length 314 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:55,999 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/05_logging.cfg (quiet=False) | |
2022-06-27 21:18:56,000 - util.py[DEBUG]: Read 2070 bytes from /etc/cloud/cloud.cfg.d/05_logging.cfg | |
2022-06-27 21:18:56,000 - util.py[DEBUG]: Attempting to load yaml from string of length 2070 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:56,003 - util.py[DEBUG]: Reading from /run/cloud-init/cloud.cfg (quiet=False) | |
2022-06-27 21:18:56,003 - util.py[DEBUG]: Read 31 bytes from /run/cloud-init/cloud.cfg | |
2022-06-27 21:18:56,003 - util.py[DEBUG]: Attempting to load yaml from string of length 31 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:56,003 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:56,003 - util.py[DEBUG]: loaded blob returned None, returning default. | |
2022-06-27 21:18:56,003 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) | |
2022-06-27 21:18:56,004 - util.py[DEBUG]: Read 144 bytes from /var/lib/cloud/instance/cloud-config.txt | |
2022-06-27 21:18:56,004 - util.py[DEBUG]: Attempting to load yaml from string of length 144 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:56,005 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,006 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,013 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,013 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,016 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,016 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,022 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,022 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,024 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,024 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,027 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,027 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,036 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,036 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,047 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,047 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,049 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,049 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,054 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,054 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,066 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:18:56,066 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:18:56,134 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) | |
2022-06-27 21:18:56,134 - util.py[DEBUG]: Read 144 bytes from /var/lib/cloud/instance/cloud-config.txt | |
2022-06-27 21:18:56,135 - util.py[DEBUG]: Attempting to load yaml from string of length 144 with allowed root types (<class 'dict'>,) | |
2022-06-27 21:18:56,144 - handlers.py[DEBUG]: start: init-network/activate-datasource: activating datasource | |
2022-06-27 21:18:56,144 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [400] 22499 bytes | |
2022-06-27 21:18:56,145 - handlers.py[DEBUG]: finish: init-network/activate-datasource: SUCCESS: activating datasource | |
2022-06-27 21:18:56,145 - main.py[DEBUG]: no di_report found in config. | |
2022-06-27 21:18:56,152 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'> | |
2022-06-27 21:18:56,153 - stages.py[DEBUG]: Running module migrator (<module 'cloudinit.config.cc_migrator' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_migrator.py'>) with frequency always | |
2022-06-27 21:18:56,153 - handlers.py[DEBUG]: start: init-network/config-migrator: running config-migrator with frequency always | |
2022-06-27 21:18:56,153 - helpers.py[DEBUG]: Running config-migrator using lock (<cloudinit.helpers.DummyLock object at 0x7fbfd23c8a00>) | |
2022-06-27 21:18:56,212 - cc_migrator.py[DEBUG]: Migrated 0 semaphore files to there canonicalized names | |
2022-06-27 21:18:56,212 - handlers.py[DEBUG]: finish: init-network/config-migrator: SUCCESS: config-migrator ran successfully | |
2022-06-27 21:18:56,212 - stages.py[DEBUG]: Running module seed_random (<module 'cloudinit.config.cc_seed_random' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_seed_random.py'>) with frequency once-per-instance | |
2022-06-27 21:18:56,213 - handlers.py[DEBUG]: start: init-network/config-seed_random: running config-seed_random with frequency once-per-instance | |
2022-06-27 21:18:56,213 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_seed_random - wb: [644] 24 bytes | |
2022-06-27 21:18:56,213 - helpers.py[DEBUG]: Running config-seed_random using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_seed_random'>) | |
2022-06-27 21:18:56,213 - cc_seed_random.py[DEBUG]: no command provided | |
2022-06-27 21:18:56,213 - handlers.py[DEBUG]: finish: init-network/config-seed_random: SUCCESS: config-seed_random ran successfully | |
2022-06-27 21:18:56,213 - stages.py[DEBUG]: Running module bootcmd (<module 'cloudinit.config.cc_bootcmd' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_bootcmd.py'>) with frequency always | |
2022-06-27 21:18:56,214 - handlers.py[DEBUG]: start: init-network/config-bootcmd: running config-bootcmd with frequency always | |
2022-06-27 21:18:56,214 - helpers.py[DEBUG]: Running config-bootcmd using lock (<cloudinit.helpers.DummyLock object at 0x7fbfd2155e50>) | |
2022-06-27 21:18:56,214 - cc_bootcmd.py[DEBUG]: Skipping module named bootcmd, no 'bootcmd' key in configuration | |
2022-06-27 21:18:56,214 - handlers.py[DEBUG]: finish: init-network/config-bootcmd: SUCCESS: config-bootcmd ran successfully | |
2022-06-27 21:18:56,214 - stages.py[DEBUG]: Running module write-files (<module 'cloudinit.config.cc_write_files' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_write_files.py'>) with frequency once-per-instance | |
2022-06-27 21:18:56,214 - handlers.py[DEBUG]: start: init-network/config-write-files: running config-write-files with frequency once-per-instance | |
2022-06-27 21:18:56,214 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_write_files - wb: [644] 24 bytes | |
2022-06-27 21:18:56,215 - helpers.py[DEBUG]: Running config-write-files using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_write_files'>) | |
2022-06-27 21:18:56,215 - cc_write_files.py[DEBUG]: Skipping module named write-files, no/empty 'write_files' key in configuration | |
2022-06-27 21:18:56,215 - handlers.py[DEBUG]: finish: init-network/config-write-files: SUCCESS: config-write-files ran successfully | |
2022-06-27 21:18:56,220 - stages.py[DEBUG]: Running module growpart (<module 'cloudinit.config.cc_growpart' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_growpart.py'>) with frequency always | |
2022-06-27 21:18:56,220 - handlers.py[DEBUG]: start: init-network/config-growpart: running config-growpart with frequency always | |
2022-06-27 21:18:56,220 - helpers.py[DEBUG]: Running config-growpart using lock (<cloudinit.helpers.DummyLock object at 0x7fbfd2155e20>) | |
2022-06-27 21:18:56,220 - cc_growpart.py[DEBUG]: No 'growpart' entry in cfg. Using default: {'mode': 'auto', 'devices': ['/'], 'ignore_growroot_disabled': False} | |
2022-06-27 21:18:56,220 - subp.py[DEBUG]: Running command ['growpart', '--help'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:56,229 - util.py[DEBUG]: Reading from /proc/459/mountinfo (quiet=False) | |
2022-06-27 21:18:56,229 - util.py[DEBUG]: Read 4121 bytes from /proc/459/mountinfo | |
2022-06-27 21:18:56,229 - util.py[DEBUG]: Reading from /sys/class/block/xvda1/partition (quiet=False) | |
2022-06-27 21:18:56,229 - util.py[DEBUG]: Read 2 bytes from /sys/class/block/xvda1/partition | |
2022-06-27 21:18:56,230 - util.py[DEBUG]: Reading from /sys/devices/vbd-768/block/xvda/dev (quiet=False) | |
2022-06-27 21:18:56,230 - util.py[DEBUG]: Read 6 bytes from /sys/devices/vbd-768/block/xvda/dev | |
2022-06-27 21:18:56,230 - subp.py[DEBUG]: Running command ['growpart', '--dry-run', '/dev/xvda', '1'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:56,287 - subp.py[DEBUG]: Running command ['growpart', '/dev/xvda', '1'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:56,613 - util.py[DEBUG]: resize_devices took 0.384 seconds | |
2022-06-27 21:18:56,613 - cc_growpart.py[INFO]: '/' resized: changed (/dev/xvda, 1) from 37579898368 to 48317316608 | |
2022-06-27 21:18:56,613 - handlers.py[DEBUG]: finish: init-network/config-growpart: SUCCESS: config-growpart ran successfully | |
2022-06-27 21:18:56,613 - stages.py[DEBUG]: Running module resizefs (<module 'cloudinit.config.cc_resizefs' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_resizefs.py'>) with frequency always | |
2022-06-27 21:18:56,614 - handlers.py[DEBUG]: start: init-network/config-resizefs: running config-resizefs with frequency always | |
2022-06-27 21:18:56,614 - helpers.py[DEBUG]: Running config-resizefs using lock (<cloudinit.helpers.DummyLock object at 0x7fbfd2155fd0>) | |
2022-06-27 21:18:56,615 - util.py[DEBUG]: Reading from /proc/459/mountinfo (quiet=False) | |
2022-06-27 21:18:56,615 - util.py[DEBUG]: Read 4121 bytes from /proc/459/mountinfo | |
2022-06-27 21:18:56,615 - cc_resizefs.py[DEBUG]: resize_info: dev=/dev/root mnt_point=/ path=/ | |
2022-06-27 21:18:56,615 - cc_resizefs.py[DEBUG]: Resizing / (ext4) using resize2fs /dev/root | |
2022-06-27 21:18:56,615 - subp.py[DEBUG]: Running command ('resize2fs', '/dev/root') with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:56,716 - util.py[DEBUG]: Resizing took 0.101 seconds | |
2022-06-27 21:18:56,716 - cc_resizefs.py[DEBUG]: Resized root filesystem (type=ext4, val=True) | |
2022-06-27 21:18:56,717 - handlers.py[DEBUG]: finish: init-network/config-resizefs: SUCCESS: config-resizefs ran successfully | |
2022-06-27 21:18:56,717 - stages.py[DEBUG]: Running module disk_setup (<module 'cloudinit.config.cc_disk_setup' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_disk_setup.py'>) with frequency once-per-instance | |
2022-06-27 21:18:56,717 - handlers.py[DEBUG]: start: init-network/config-disk_setup: running config-disk_setup with frequency once-per-instance | |
2022-06-27 21:18:56,717 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_disk_setup - wb: [644] 23 bytes | |
2022-06-27 21:18:56,718 - helpers.py[DEBUG]: Running config-disk_setup using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_disk_setup'>) | |
2022-06-27 21:18:56,718 - handlers.py[DEBUG]: finish: init-network/config-disk_setup: SUCCESS: config-disk_setup ran successfully | |
2022-06-27 21:18:56,718 - stages.py[DEBUG]: Running module mounts (<module 'cloudinit.config.cc_mounts' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_mounts.py'>) with frequency once-per-instance | |
2022-06-27 21:18:56,718 - handlers.py[DEBUG]: start: init-network/config-mounts: running config-mounts with frequency once-per-instance | |
2022-06-27 21:18:56,719 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_mounts - wb: [644] 24 bytes | |
2022-06-27 21:18:56,719 - helpers.py[DEBUG]: Running config-mounts using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_mounts'>) | |
2022-06-27 21:18:56,719 - cc_mounts.py[DEBUG]: mounts configuration is [] | |
2022-06-27 21:18:56,719 - util.py[DEBUG]: Reading from /etc/fstab (quiet=False) | |
2022-06-27 21:18:56,719 - util.py[DEBUG]: Read 51 bytes from /etc/fstab | |
2022-06-27 21:18:56,719 - cc_mounts.py[DEBUG]: Attempting to determine the real name of ephemeral0 | |
2022-06-27 21:18:56,720 - cc_mounts.py[DEBUG]: changed default device ephemeral0 => None | |
2022-06-27 21:18:56,724 - cc_mounts.py[DEBUG]: Ignoring nonexistent default named mount ephemeral0 | |
2022-06-27 21:18:56,724 - cc_mounts.py[DEBUG]: Attempting to determine the real name of swap | |
2022-06-27 21:18:56,724 - DataSourceEc2.py[DEBUG]: Unable to convert swap to a device | |
2022-06-27 21:18:56,724 - cc_mounts.py[DEBUG]: changed default device swap => None | |
2022-06-27 21:18:56,724 - cc_mounts.py[DEBUG]: Ignoring nonexistent default named mount swap | |
2022-06-27 21:18:56,724 - cc_mounts.py[DEBUG]: no need to setup swap | |
2022-06-27 21:18:56,724 - cc_mounts.py[DEBUG]: No modifications to fstab needed | |
2022-06-27 21:18:56,724 - handlers.py[DEBUG]: finish: init-network/config-mounts: SUCCESS: config-mounts ran successfully | |
2022-06-27 21:18:56,724 - stages.py[DEBUG]: Running module set_hostname (<module 'cloudinit.config.cc_set_hostname' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_set_hostname.py'>) with frequency once-per-instance | |
2022-06-27 21:18:56,724 - handlers.py[DEBUG]: start: init-network/config-set_hostname: running config-set_hostname with frequency once-per-instance | |
2022-06-27 21:18:56,724 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_set_hostname - wb: [644] 24 bytes | |
2022-06-27 21:18:56,725 - helpers.py[DEBUG]: Running config-set_hostname using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_set_hostname'>) | |
2022-06-27 21:18:56,725 - util.py[DEBUG]: Reading from /var/lib/cloud/data/set-hostname (quiet=False) | |
2022-06-27 21:18:56,725 - util.py[DEBUG]: Read 86 bytes from /var/lib/cloud/data/set-hostname | |
2022-06-27 21:18:56,725 - cc_set_hostname.py[DEBUG]: No hostname changes. Skipping set-hostname | |
2022-06-27 21:18:56,725 - handlers.py[DEBUG]: finish: init-network/config-set_hostname: SUCCESS: config-set_hostname ran successfully | |
2022-06-27 21:18:56,725 - stages.py[DEBUG]: Running module update_hostname (<module 'cloudinit.config.cc_update_hostname' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_update_hostname.py'>) with frequency always | |
2022-06-27 21:18:56,726 - handlers.py[DEBUG]: start: init-network/config-update_hostname: running config-update_hostname with frequency always | |
2022-06-27 21:18:56,726 - helpers.py[DEBUG]: Running config-update_hostname using lock (<cloudinit.helpers.DummyLock object at 0x7fbfd2322dc0>) | |
2022-06-27 21:18:56,726 - cc_update_hostname.py[DEBUG]: Updating hostname to ip-10-0-0-151.us-east-2.compute.internal (ip-10-0-0-151) | |
2022-06-27 21:18:56,726 - util.py[DEBUG]: Reading from /var/lib/cloud/data/previous-hostname (quiet=False) | |
2022-06-27 21:18:56,775 - util.py[DEBUG]: Read 16 bytes from /var/lib/cloud/data/previous-hostname | |
2022-06-27 21:18:56,775 - util.py[DEBUG]: Reading from /etc/hostname (quiet=False) | |
2022-06-27 21:18:56,776 - util.py[DEBUG]: Read 14 bytes from /etc/hostname | |
2022-06-27 21:18:56,776 - __init__.py[INFO]: /var/lib/cloud/data/previous-hostname differs from /etc/hostname, assuming user maintained hostname. | |
2022-06-27 21:18:56,776 - handlers.py[DEBUG]: finish: init-network/config-update_hostname: SUCCESS: config-update_hostname ran successfully | |
2022-06-27 21:18:56,776 - stages.py[DEBUG]: Running module update_etc_hosts (<module 'cloudinit.config.cc_update_etc_hosts' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_update_etc_hosts.py'>) with frequency always | |
2022-06-27 21:18:56,776 - handlers.py[DEBUG]: start: init-network/config-update_etc_hosts: running config-update_etc_hosts with frequency always | |
2022-06-27 21:18:56,776 - helpers.py[DEBUG]: Running config-update_etc_hosts using lock (<cloudinit.helpers.DummyLock object at 0x7fbfd21558e0>) | |
2022-06-27 21:18:56,776 - cc_update_etc_hosts.py[DEBUG]: Configuration option 'manage_etc_hosts' is not set, not managing /etc/hosts in module update_etc_hosts | |
2022-06-27 21:18:56,776 - handlers.py[DEBUG]: finish: init-network/config-update_etc_hosts: SUCCESS: config-update_etc_hosts ran successfully | |
2022-06-27 21:18:56,776 - stages.py[DEBUG]: Running module ca-certs (<module 'cloudinit.config.cc_ca_certs' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_ca_certs.py'>) with frequency once-per-instance | |
2022-06-27 21:18:56,777 - handlers.py[DEBUG]: start: init-network/config-ca-certs: running config-ca-certs with frequency once-per-instance | |
2022-06-27 21:18:56,777 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ca_certs - wb: [644] 23 bytes | |
2022-06-27 21:18:56,777 - helpers.py[DEBUG]: Running config-ca-certs using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ca_certs'>) | |
2022-06-27 21:18:56,777 - cc_ca_certs.py[DEBUG]: Skipping module named ca-certs, no 'ca_certs' key in configuration | |
2022-06-27 21:18:56,777 - handlers.py[DEBUG]: finish: init-network/config-ca-certs: SUCCESS: config-ca-certs ran successfully | |
2022-06-27 21:18:56,777 - stages.py[DEBUG]: Running module rsyslog (<module 'cloudinit.config.cc_rsyslog' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_rsyslog.py'>) with frequency once-per-instance | |
2022-06-27 21:18:56,778 - handlers.py[DEBUG]: start: init-network/config-rsyslog: running config-rsyslog with frequency once-per-instance | |
2022-06-27 21:18:56,778 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_rsyslog - wb: [644] 24 bytes | |
2022-06-27 21:18:56,778 - helpers.py[DEBUG]: Running config-rsyslog using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_rsyslog'>) | |
2022-06-27 21:18:56,778 - cc_rsyslog.py[DEBUG]: Skipping module named rsyslog, no 'rsyslog' key in configuration | |
2022-06-27 21:18:56,778 - handlers.py[DEBUG]: finish: init-network/config-rsyslog: SUCCESS: config-rsyslog ran successfully | |
2022-06-27 21:18:56,778 - stages.py[DEBUG]: Running module users-groups (<module 'cloudinit.config.cc_users_groups' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_users_groups.py'>) with frequency once-per-instance | |
2022-06-27 21:18:56,779 - handlers.py[DEBUG]: start: init-network/config-users-groups: running config-users-groups with frequency once-per-instance | |
2022-06-27 21:18:56,779 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_users_groups - wb: [644] 23 bytes | |
2022-06-27 21:18:56,779 - helpers.py[DEBUG]: Running config-users-groups using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_users_groups'>) | |
2022-06-27 21:18:56,780 - __init__.py[INFO]: User ubuntu already exists, skipping. | |
2022-06-27 21:18:56,784 - subp.py[DEBUG]: Running command ['passwd', '-l', 'ubuntu'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:57,443 - util.py[DEBUG]: Reading from /etc/sudoers (quiet=False) | |
2022-06-27 21:18:57,443 - util.py[DEBUG]: Read 755 bytes from /etc/sudoers | |
2022-06-27 21:18:57,445 - util.py[DEBUG]: Writing to /etc/sudoers.d/90-cloud-init-users - ab: [None] 55 bytes | |
2022-06-27 21:18:57,446 - handlers.py[DEBUG]: finish: init-network/config-users-groups: SUCCESS: config-users-groups ran successfully | |
2022-06-27 21:18:57,446 - stages.py[DEBUG]: Running module ssh (<module 'cloudinit.config.cc_ssh' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_ssh.py'>) with frequency once-per-instance | |
2022-06-27 21:18:57,446 - handlers.py[DEBUG]: start: init-network/config-ssh: running config-ssh with frequency once-per-instance | |
2022-06-27 21:18:57,446 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ssh - wb: [644] 24 bytes | |
2022-06-27 21:18:57,447 - helpers.py[DEBUG]: Running config-ssh using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ssh'>) | |
2022-06-27 21:18:57,448 - 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) | |
2022-06-27 21:18:58,238 - util.py[DEBUG]: Group ssh_keys is not a valid group name | |
2022-06-27 21:18:58,239 - subp.py[DEBUG]: Running command ['ssh-keygen', '-t', 'dsa', '-N', '', '-f', '/etc/ssh/ssh_host_dsa_key'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:18:58,463 - util.py[DEBUG]: Group ssh_keys is not a valid group name | |
2022-06-27 21:18:58,463 - 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) | |
2022-06-27 21:18:58,469 - util.py[DEBUG]: Group ssh_keys is not a valid group name | |
2022-06-27 21:18:58,470 - 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) | |
2022-06-27 21:18:58,477 - util.py[DEBUG]: Group ssh_keys is not a valid group name | |
2022-06-27 21:18:58,477 - util.py[DEBUG]: Reading from /etc/ssh/ssh_host_rsa_key.pub (quiet=False) | |
2022-06-27 21:18:58,477 - util.py[DEBUG]: Read 572 bytes from /etc/ssh/ssh_host_rsa_key.pub | |
2022-06-27 21:18:58,477 - util.py[DEBUG]: Reading from /etc/ssh/ssh_host_ecdsa_key.pub (quiet=False) | |
2022-06-27 21:18:58,478 - util.py[DEBUG]: Read 180 bytes from /etc/ssh/ssh_host_ecdsa_key.pub | |
2022-06-27 21:18:58,478 - util.py[DEBUG]: Reading from /etc/ssh/ssh_host_ed25519_key.pub (quiet=False) | |
2022-06-27 21:18:58,478 - util.py[DEBUG]: Read 100 bytes from /etc/ssh/ssh_host_ed25519_key.pub | |
2022-06-27 21:18:58,478 - util.py[DEBUG]: Reading from /etc/ssh/sshd_config (quiet=False) | |
2022-06-27 21:18:58,479 - util.py[DEBUG]: Read 689 bytes from /etc/ssh/sshd_config | |
2022-06-27 21:18:58,481 - util.py[DEBUG]: Reading from /home/ubuntu/.ssh/authorized_keys (quiet=False) | |
2022-06-27 21:18:58,481 - util.py[DEBUG]: Read 0 bytes from /home/ubuntu/.ssh/authorized_keys | |
2022-06-27 21:18:58,481 - util.py[DEBUG]: Writing to /home/ubuntu/.ssh/authorized_keys - wb: [600] 386 bytes | |
2022-06-27 21:18:58,482 - util.py[DEBUG]: Reading from /etc/ssh/sshd_config (quiet=False) | |
2022-06-27 21:18:58,482 - util.py[DEBUG]: Read 689 bytes from /etc/ssh/sshd_config | |
2022-06-27 21:18:58,483 - util.py[DEBUG]: Reading from /root/.ssh/authorized_keys (quiet=False) | |
2022-06-27 21:18:58,483 - util.py[DEBUG]: Read 0 bytes from /root/.ssh/authorized_keys | |
2022-06-27 21:18:58,483 - util.py[DEBUG]: Writing to /root/.ssh/authorized_keys - wb: [600] 550 bytes | |
2022-06-27 21:18:58,484 - handlers.py[DEBUG]: finish: init-network/config-ssh: SUCCESS: config-ssh ran successfully | |
2022-06-27 21:18:58,484 - main.py[DEBUG]: Ran 15 modules with 0 failures | |
2022-06-27 21:18:58,484 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/status.json (via temporary file /var/lib/cloud/data/tmpdj73xdea) - w: [644] 518 bytes/chars | |
2022-06-27 21:18:58,484 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False) | |
2022-06-27 21:18:58,485 - util.py[DEBUG]: Read 11 bytes from /proc/uptime | |
2022-06-27 21:18:58,485 - util.py[DEBUG]: cloud-init mode 'init' took 2.664 seconds (2.66) | |
2022-06-27 21:18:58,485 - handlers.py[DEBUG]: finish: init-network: SUCCESS: searching for network datasources | |
2022-06-27 21:19:08,275 - util.py[DEBUG]: Cloud-init v. 22.1-14-g2e17a0d6-0ubuntu1~20.04.3 running 'modules:config' at Mon, 27 Jun 2022 21:19:07 +0000. Up 30.90 seconds. | |
2022-06-27 21:19:08,329 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:08,329 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:08,338 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:08,338 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:08,354 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:08,354 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:08,367 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:08,367 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:08,368 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:08,368 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:08,378 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:08,378 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:08,413 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:08,413 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:08,415 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:08,415 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:08,434 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:08,434 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:08,447 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:08,447 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:08,471 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'> | |
2022-06-27 21:19:08,476 - stages.py[DEBUG]: Running module emit_upstart (<module 'cloudinit.config.cc_emit_upstart' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_emit_upstart.py'>) with frequency always | |
2022-06-27 21:19:08,477 - handlers.py[DEBUG]: start: modules-config/config-emit_upstart: running config-emit_upstart with frequency always | |
2022-06-27 21:19:08,477 - helpers.py[DEBUG]: Running config-emit_upstart using lock (<cloudinit.helpers.DummyLock object at 0x7fa7047b9190>) | |
2022-06-27 21:19:08,477 - cc_emit_upstart.py[DEBUG]: no /sbin/initctl located | |
2022-06-27 21:19:08,477 - cc_emit_upstart.py[DEBUG]: not upstart system, 'emit_upstart' disabled | |
2022-06-27 21:19:08,478 - handlers.py[DEBUG]: finish: modules-config/config-emit_upstart: SUCCESS: config-emit_upstart ran successfully | |
2022-06-27 21:19:08,478 - stages.py[DEBUG]: Running module snap (<module 'cloudinit.config.cc_snap' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_snap.py'>) with frequency once-per-instance | |
2022-06-27 21:19:08,478 - handlers.py[DEBUG]: start: modules-config/config-snap: running config-snap with frequency once-per-instance | |
2022-06-27 21:19:08,478 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_snap - wb: [644] 24 bytes | |
2022-06-27 21:19:08,478 - helpers.py[DEBUG]: Running config-snap using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_snap'>) | |
2022-06-27 21:19:08,478 - cc_snap.py[DEBUG]: Skipping module named snap, no 'snap' key in configuration | |
2022-06-27 21:19:08,480 - handlers.py[DEBUG]: finish: modules-config/config-snap: SUCCESS: config-snap ran successfully | |
2022-06-27 21:19:08,480 - stages.py[DEBUG]: Running module ssh-import-id (<module 'cloudinit.config.cc_ssh_import_id' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_ssh_import_id.py'>) with frequency once-per-instance | |
2022-06-27 21:19:08,480 - handlers.py[DEBUG]: start: modules-config/config-ssh-import-id: running config-ssh-import-id with frequency once-per-instance | |
2022-06-27 21:19:08,485 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ssh_import_id - wb: [644] 24 bytes | |
2022-06-27 21:19:08,486 - helpers.py[DEBUG]: Running config-ssh-import-id using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ssh_import_id'>) | |
2022-06-27 21:19:08,486 - handlers.py[DEBUG]: finish: modules-config/config-ssh-import-id: SUCCESS: config-ssh-import-id ran successfully | |
2022-06-27 21:19:08,486 - stages.py[DEBUG]: Running module keyboard (<module 'cloudinit.config.cc_keyboard' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_keyboard.py'>) with frequency once-per-instance | |
2022-06-27 21:19:08,486 - handlers.py[DEBUG]: start: modules-config/config-keyboard: running config-keyboard with frequency once-per-instance | |
2022-06-27 21:19:08,486 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_keyboard - wb: [644] 24 bytes | |
2022-06-27 21:19:08,487 - helpers.py[DEBUG]: Running config-keyboard using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_keyboard'>) | |
2022-06-27 21:19:08,492 - cc_keyboard.py[DEBUG]: Skipping module named keyboard, no 'keyboard' section found | |
2022-06-27 21:19:08,492 - handlers.py[DEBUG]: finish: modules-config/config-keyboard: SUCCESS: config-keyboard ran successfully | |
2022-06-27 21:19:08,492 - stages.py[DEBUG]: Running module locale (<module 'cloudinit.config.cc_locale' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_locale.py'>) with frequency once-per-instance | |
2022-06-27 21:19:08,492 - handlers.py[DEBUG]: start: modules-config/config-locale: running config-locale with frequency once-per-instance | |
2022-06-27 21:19:08,492 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_locale - wb: [644] 24 bytes | |
2022-06-27 21:19:08,492 - helpers.py[DEBUG]: Running config-locale using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_locale'>) | |
2022-06-27 21:19:08,493 - util.py[DEBUG]: Reading from /etc/default/locale (quiet=False) | |
2022-06-27 21:19:08,493 - util.py[DEBUG]: Read 13 bytes from /etc/default/locale | |
2022-06-27 21:19:08,663 - cc_locale.py[DEBUG]: Setting locale to C.UTF-8 | |
2022-06-27 21:19:08,663 - debian.py[DEBUG]: System has 'LANG=C.UTF-8' requested 'C.UTF-8', skipping regeneration. | |
2022-06-27 21:19:08,663 - handlers.py[DEBUG]: finish: modules-config/config-locale: SUCCESS: config-locale ran successfully | |
2022-06-27 21:19:08,663 - stages.py[DEBUG]: Running module set-passwords (<module 'cloudinit.config.cc_set_passwords' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_set_passwords.py'>) with frequency once-per-instance | |
2022-06-27 21:19:08,663 - handlers.py[DEBUG]: start: modules-config/config-set-passwords: running config-set-passwords with frequency once-per-instance | |
2022-06-27 21:19:08,664 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_set_passwords - wb: [644] 24 bytes | |
2022-06-27 21:19:08,664 - helpers.py[DEBUG]: Running config-set-passwords using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_set_passwords'>) | |
2022-06-27 21:19:08,664 - cc_set_passwords.py[DEBUG]: Leaving SSH config 'PasswordAuthentication' unchanged. ssh_pwauth=None | |
2022-06-27 21:19:08,664 - handlers.py[DEBUG]: finish: modules-config/config-set-passwords: SUCCESS: config-set-passwords ran successfully | |
2022-06-27 21:19:08,664 - stages.py[DEBUG]: Running module grub-dpkg (<module 'cloudinit.config.cc_grub_dpkg' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_grub_dpkg.py'>) with frequency once-per-instance | |
2022-06-27 21:19:08,667 - handlers.py[DEBUG]: start: modules-config/config-grub-dpkg: running config-grub-dpkg with frequency once-per-instance | |
2022-06-27 21:19:08,667 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_grub_dpkg - wb: [644] 24 bytes | |
2022-06-27 21:19:08,667 - helpers.py[DEBUG]: Running config-grub-dpkg using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_grub_dpkg'>) | |
2022-06-27 21:19:08,667 - subp.py[DEBUG]: Running command ['grub-probe', '-t', 'disk', '/boot'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:19:08,703 - subp.py[DEBUG]: Running command ['udevadm', 'info', '--root', '--query=symlink', '/dev/xvda'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:19:08,710 - cc_grub_dpkg.py[DEBUG]: considering these device symlinks: | |
2022-06-27 21:19:08,710 - cc_grub_dpkg.py[DEBUG]: filtered to these disk/by-id symlinks: | |
2022-06-27 21:19:08,710 - cc_grub_dpkg.py[DEBUG]: selected /dev/xvda | |
2022-06-27 21:19:08,710 - cc_grub_dpkg.py[DEBUG]: Setting grub debconf-set-selections with '/dev/xvda','false' | |
2022-06-27 21:19:08,710 - subp.py[DEBUG]: Running command ['debconf-set-selections'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:19:09,137 - handlers.py[DEBUG]: finish: modules-config/config-grub-dpkg: SUCCESS: config-grub-dpkg ran successfully | |
2022-06-27 21:19:09,137 - stages.py[DEBUG]: Running module apt-pipelining (<module 'cloudinit.config.cc_apt_pipelining' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_apt_pipelining.py'>) with frequency once-per-instance | |
2022-06-27 21:19:09,137 - handlers.py[DEBUG]: start: modules-config/config-apt-pipelining: running config-apt-pipelining with frequency once-per-instance | |
2022-06-27 21:19:09,138 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_apt_pipelining - wb: [644] 24 bytes | |
2022-06-27 21:19:09,138 - helpers.py[DEBUG]: Running config-apt-pipelining using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_apt_pipelining'>) | |
2022-06-27 21:19:09,138 - handlers.py[DEBUG]: finish: modules-config/config-apt-pipelining: SUCCESS: config-apt-pipelining ran successfully | |
2022-06-27 21:19:09,138 - stages.py[DEBUG]: Running module apt-configure (<module 'cloudinit.config.cc_apt_configure' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_apt_configure.py'>) with frequency once-per-instance | |
2022-06-27 21:19:09,139 - handlers.py[DEBUG]: start: modules-config/config-apt-configure: running config-apt-configure with frequency once-per-instance | |
2022-06-27 21:19:09,139 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_apt_configure - wb: [644] 24 bytes | |
2022-06-27 21:19:09,139 - helpers.py[DEBUG]: Running config-apt-configure using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_apt_configure'>) | |
2022-06-27 21:19:09,139 - cc_apt_configure.py[DEBUG]: debconf_selections was not set in config | |
2022-06-27 21:19:09,139 - util.py[DEBUG]: Reading from /etc/os-release (quiet=True) | |
2022-06-27 21:19:09,139 - util.py[DEBUG]: Read 382 bytes from /etc/os-release | |
2022-06-27 21:19:09,140 - util.py[DEBUG]: Reading from /etc/system-image/channel.ini (quiet=True) | |
2022-06-27 21:19:09,140 - util.py[DEBUG]: Read 0 bytes from /etc/system-image/channel.ini | |
2022-06-27 21:19:09,140 - cc_apt_configure.py[DEBUG]: handling apt config: {} | |
2022-06-27 21:19:09,140 - subp.py[DEBUG]: Running command ['lsb_release', '--all'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:19:09,334 - subp.py[DEBUG]: Running command ['dpkg', '--print-architecture'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:19:09,365 - cc_apt_configure.py[DEBUG]: got primary mirror: None | |
2022-06-27 21:19:09,365 - cc_apt_configure.py[DEBUG]: got security mirror: None | |
2022-06-27 21:19:09,365 - subp.py[DEBUG]: Running command ['dpkg', '--print-architecture'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:19:09,370 - util.py[DEBUG]: search for mirror in candidates: '['http://us-east-2.ec2.archive.ubuntu.com/ubuntu/', 'http://us-east-2a.clouds.archive.ubuntu.com/ubuntu/', 'http://us-east-2.clouds.archive.ubuntu.com/ubuntu/']' | |
2022-06-27 21:19:09,441 - util.py[DEBUG]: Resolving URL: http://us-east-2.ec2.archive.ubuntu.com/ubuntu/ took 0.071 seconds | |
2022-06-27 21:19:09,442 - util.py[DEBUG]: found working mirror: 'http://us-east-2.ec2.archive.ubuntu.com/ubuntu/' | |
2022-06-27 21:19:09,442 - util.py[DEBUG]: search for mirror in candidates: '[]' | |
2022-06-27 21:19:09,442 - __init__.py[DEBUG]: filtered distro mirror info: {'primary': 'http://us-east-2.ec2.archive.ubuntu.com/ubuntu/', 'security': 'http://security.ubuntu.com/ubuntu'} | |
2022-06-27 21:19:09,442 - cc_apt_configure.py[DEBUG]: Apt Mirror info: {'primary': 'http://us-east-2.ec2.archive.ubuntu.com/ubuntu/', 'security': 'http://security.ubuntu.com/ubuntu', 'PRIMARY': 'http://us-east-2.ec2.archive.ubuntu.com/ubuntu/', 'SECURITY': 'http://security.ubuntu.com/ubuntu', 'MIRROR': 'http://us-east-2.ec2.archive.ubuntu.com/ubuntu/'} | |
2022-06-27 21:19:09,442 - cc_apt_configure.py[INFO]: No custom template provided, fall back to builtin | |
2022-06-27 21:19:09,442 - util.py[DEBUG]: Reading from /etc/cloud/templates/sources.list.ubuntu.tmpl (quiet=False) | |
2022-06-27 21:19:09,443 - util.py[DEBUG]: Read 2858 bytes from /etc/cloud/templates/sources.list.ubuntu.tmpl | |
2022-06-27 21:19:09,449 - util.py[DEBUG]: Writing to /etc/apt/sources.list - wb: [644] 3330 bytes | |
2022-06-27 21:19:09,451 - handlers.py[DEBUG]: finish: modules-config/config-apt-configure: SUCCESS: config-apt-configure ran successfully | |
2022-06-27 21:19:09,451 - stages.py[DEBUG]: Running module ubuntu-advantage (<module 'cloudinit.config.cc_ubuntu_advantage' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_ubuntu_advantage.py'>) with frequency once-per-instance | |
2022-06-27 21:19:09,452 - handlers.py[DEBUG]: start: modules-config/config-ubuntu-advantage: running config-ubuntu-advantage with frequency once-per-instance | |
2022-06-27 21:19:09,452 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ubuntu_advantage - wb: [644] 24 bytes | |
2022-06-27 21:19:09,452 - helpers.py[DEBUG]: Running config-ubuntu-advantage using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ubuntu_advantage'>) | |
2022-06-27 21:19:09,452 - cc_ubuntu_advantage.py[DEBUG]: Skipping module named ubuntu-advantage, no 'ubuntu_advantage' configuration found | |
2022-06-27 21:19:09,452 - handlers.py[DEBUG]: finish: modules-config/config-ubuntu-advantage: SUCCESS: config-ubuntu-advantage ran successfully | |
2022-06-27 21:19:09,452 - stages.py[DEBUG]: Running module ntp (<module 'cloudinit.config.cc_ntp' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_ntp.py'>) with frequency once-per-instance | |
2022-06-27 21:19:09,453 - handlers.py[DEBUG]: start: modules-config/config-ntp: running config-ntp with frequency once-per-instance | |
2022-06-27 21:19:09,453 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ntp - wb: [644] 24 bytes | |
2022-06-27 21:19:09,453 - helpers.py[DEBUG]: Running config-ntp using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ntp'>) | |
2022-06-27 21:19:09,453 - cc_ntp.py[DEBUG]: Skipping module named ntp, not present or disabled by cfg | |
2022-06-27 21:19:09,453 - handlers.py[DEBUG]: finish: modules-config/config-ntp: SUCCESS: config-ntp ran successfully | |
2022-06-27 21:19:09,453 - stages.py[DEBUG]: Running module timezone (<module 'cloudinit.config.cc_timezone' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_timezone.py'>) with frequency once-per-instance | |
2022-06-27 21:19:09,453 - handlers.py[DEBUG]: start: modules-config/config-timezone: running config-timezone with frequency once-per-instance | |
2022-06-27 21:19:09,453 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_timezone - wb: [644] 24 bytes | |
2022-06-27 21:19:09,454 - helpers.py[DEBUG]: Running config-timezone using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_timezone'>) | |
2022-06-27 21:19:09,454 - cc_timezone.py[DEBUG]: Skipping module named timezone, no 'timezone' specified | |
2022-06-27 21:19:09,454 - handlers.py[DEBUG]: finish: modules-config/config-timezone: SUCCESS: config-timezone ran successfully | |
2022-06-27 21:19:09,454 - stages.py[DEBUG]: Running module disable-ec2-metadata (<module 'cloudinit.config.cc_disable_ec2_metadata' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_disable_ec2_metadata.py'>) with frequency once-per-instance | |
2022-06-27 21:19:09,454 - handlers.py[DEBUG]: start: modules-config/config-disable-ec2-metadata: running config-disable-ec2-metadata with frequency once-per-instance | |
2022-06-27 21:19:09,454 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_disable_ec2_metadata - wb: [644] 23 bytes | |
2022-06-27 21:19:09,455 - helpers.py[DEBUG]: Running config-disable-ec2-metadata using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_disable_ec2_metadata'>) | |
2022-06-27 21:19:09,455 - cc_disable_ec2_metadata.py[DEBUG]: Skipping module named disable-ec2-metadata, disabling the ec2 route not enabled | |
2022-06-27 21:19:09,455 - handlers.py[DEBUG]: finish: modules-config/config-disable-ec2-metadata: SUCCESS: config-disable-ec2-metadata ran successfully | |
2022-06-27 21:19:09,455 - stages.py[DEBUG]: Running module runcmd (<module 'cloudinit.config.cc_runcmd' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_runcmd.py'>) with frequency once-per-instance | |
2022-06-27 21:19:09,455 - handlers.py[DEBUG]: start: modules-config/config-runcmd: running config-runcmd with frequency once-per-instance | |
2022-06-27 21:19:09,455 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_runcmd - wb: [644] 24 bytes | |
2022-06-27 21:19:09,455 - helpers.py[DEBUG]: Running config-runcmd using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_runcmd'>) | |
2022-06-27 21:19:09,455 - cc_runcmd.py[DEBUG]: Skipping module named runcmd, no 'runcmd' key in configuration | |
2022-06-27 21:19:09,455 - handlers.py[DEBUG]: finish: modules-config/config-runcmd: SUCCESS: config-runcmd ran successfully | |
2022-06-27 21:19:09,455 - stages.py[DEBUG]: Running module byobu (<module 'cloudinit.config.cc_byobu' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_byobu.py'>) with frequency once-per-instance | |
2022-06-27 21:19:09,456 - handlers.py[DEBUG]: start: modules-config/config-byobu: running config-byobu with frequency once-per-instance | |
2022-06-27 21:19:09,456 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_byobu - wb: [644] 24 bytes | |
2022-06-27 21:19:09,456 - helpers.py[DEBUG]: Running config-byobu using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_byobu'>) | |
2022-06-27 21:19:09,456 - cc_byobu.py[DEBUG]: Skipping module named byobu, no 'byobu' values found | |
2022-06-27 21:19:09,456 - handlers.py[DEBUG]: finish: modules-config/config-byobu: SUCCESS: config-byobu ran successfully | |
2022-06-27 21:19:09,456 - main.py[DEBUG]: Ran 15 modules with 0 failures | |
2022-06-27 21:19:09,457 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/status.json (via temporary file /var/lib/cloud/data/tmpo4w61_4q) - w: [644] 546 bytes/chars | |
2022-06-27 21:19:09,457 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False) | |
2022-06-27 21:19:09,457 - util.py[DEBUG]: Read 11 bytes from /proc/uptime | |
2022-06-27 21:19:09,457 - util.py[DEBUG]: cloud-init mode 'modules' took 1.500 seconds (1.50) | |
2022-06-27 21:19:09,457 - handlers.py[DEBUG]: finish: modules-config: SUCCESS: running modules for config | |
2022-06-27 21:19:15,908 - util.py[DEBUG]: Cloud-init v. 22.1-14-g2e17a0d6-0ubuntu1~20.04.3 running 'modules:final' at Mon, 27 Jun 2022 21:19:15 +0000. Up 38.78 seconds. | |
2022-06-27 21:19:15,914 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:15,914 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:15,918 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:15,918 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:15,921 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:15,922 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:15,923 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:15,923 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:15,925 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:15,925 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:15,927 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:15,928 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:15,931 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:15,931 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:15,932 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:15,933 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:15,934 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:15,935 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:15,940 - util.py[DEBUG]: Reading from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json (quiet=False) | |
2022-06-27 21:19:15,940 - util.py[DEBUG]: Read 28978 bytes from /usr/lib/python3/dist-packages/cloudinit/config/cloud-init-schema.json | |
2022-06-27 21:19:15,947 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'> | |
2022-06-27 21:19:15,948 - stages.py[DEBUG]: Running module package-update-upgrade-install (<module 'cloudinit.config.cc_package_update_upgrade_install' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_package_update_upgrade_install.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,948 - handlers.py[DEBUG]: start: modules-final/config-package-update-upgrade-install: running config-package-update-upgrade-install with frequency once-per-instance | |
2022-06-27 21:19:15,949 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_package_update_upgrade_install - wb: [644] 24 bytes | |
2022-06-27 21:19:15,949 - helpers.py[DEBUG]: Running config-package-update-upgrade-install using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_package_update_upgrade_install'>) | |
2022-06-27 21:19:15,949 - handlers.py[DEBUG]: finish: modules-final/config-package-update-upgrade-install: SUCCESS: config-package-update-upgrade-install ran successfully | |
2022-06-27 21:19:15,949 - stages.py[DEBUG]: Running module fan (<module 'cloudinit.config.cc_fan' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_fan.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,949 - handlers.py[DEBUG]: start: modules-final/config-fan: running config-fan with frequency once-per-instance | |
2022-06-27 21:19:15,949 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_fan - wb: [644] 25 bytes | |
2022-06-27 21:19:15,950 - helpers.py[DEBUG]: Running config-fan using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_fan'>) | |
2022-06-27 21:19:15,950 - cc_fan.py[DEBUG]: fan: no 'fan' config entry. disabling | |
2022-06-27 21:19:15,950 - handlers.py[DEBUG]: finish: modules-final/config-fan: SUCCESS: config-fan ran successfully | |
2022-06-27 21:19:15,950 - stages.py[DEBUG]: Running module landscape (<module 'cloudinit.config.cc_landscape' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_landscape.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,950 - handlers.py[DEBUG]: start: modules-final/config-landscape: running config-landscape with frequency once-per-instance | |
2022-06-27 21:19:15,950 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_landscape - wb: [644] 24 bytes | |
2022-06-27 21:19:15,951 - helpers.py[DEBUG]: Running config-landscape using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_landscape'>) | |
2022-06-27 21:19:15,951 - handlers.py[DEBUG]: finish: modules-final/config-landscape: SUCCESS: config-landscape ran successfully | |
2022-06-27 21:19:15,951 - stages.py[DEBUG]: Running module lxd (<module 'cloudinit.config.cc_lxd' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_lxd.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,951 - handlers.py[DEBUG]: start: modules-final/config-lxd: running config-lxd with frequency once-per-instance | |
2022-06-27 21:19:15,951 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_lxd - wb: [644] 24 bytes | |
2022-06-27 21:19:15,951 - helpers.py[DEBUG]: Running config-lxd using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_lxd'>) | |
2022-06-27 21:19:15,952 - cc_lxd.py[DEBUG]: Skipping module named lxd, not present or disabled by cfg | |
2022-06-27 21:19:15,952 - handlers.py[DEBUG]: finish: modules-final/config-lxd: SUCCESS: config-lxd ran successfully | |
2022-06-27 21:19:15,952 - stages.py[DEBUG]: Running module ubuntu-drivers (<module 'cloudinit.config.cc_ubuntu_drivers' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_ubuntu_drivers.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,952 - handlers.py[DEBUG]: start: modules-final/config-ubuntu-drivers: running config-ubuntu-drivers with frequency once-per-instance | |
2022-06-27 21:19:15,952 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ubuntu_drivers - wb: [644] 25 bytes | |
2022-06-27 21:19:15,952 - helpers.py[DEBUG]: Running config-ubuntu-drivers using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ubuntu_drivers'>) | |
2022-06-27 21:19:15,952 - cc_ubuntu_drivers.py[DEBUG]: Skipping module named ubuntu-drivers, no 'drivers' key in config | |
2022-06-27 21:19:15,953 - handlers.py[DEBUG]: finish: modules-final/config-ubuntu-drivers: SUCCESS: config-ubuntu-drivers ran successfully | |
2022-06-27 21:19:15,953 - stages.py[DEBUG]: Running module write-files-deferred (<module 'cloudinit.config.cc_write_files_deferred' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_write_files_deferred.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,953 - handlers.py[DEBUG]: start: modules-final/config-write-files-deferred: running config-write-files-deferred with frequency once-per-instance | |
2022-06-27 21:19:15,953 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_write_files_deferred - wb: [644] 24 bytes | |
2022-06-27 21:19:15,953 - helpers.py[DEBUG]: Running config-write-files-deferred using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_write_files_deferred'>) | |
2022-06-27 21:19:15,991 - cc_write_files_deferred.py[DEBUG]: Skipping module named write-files-deferred, no deferred file defined in configuration | |
2022-06-27 21:19:15,991 - handlers.py[DEBUG]: finish: modules-final/config-write-files-deferred: SUCCESS: config-write-files-deferred ran successfully | |
2022-06-27 21:19:15,991 - stages.py[DEBUG]: Running module puppet (<module 'cloudinit.config.cc_puppet' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_puppet.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,991 - handlers.py[DEBUG]: start: modules-final/config-puppet: running config-puppet with frequency once-per-instance | |
2022-06-27 21:19:15,991 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_puppet - wb: [644] 25 bytes | |
2022-06-27 21:19:15,992 - helpers.py[DEBUG]: Running config-puppet using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_puppet'>) | |
2022-06-27 21:19:15,992 - cc_puppet.py[DEBUG]: Skipping module named puppet, no 'puppet' configuration found | |
2022-06-27 21:19:15,992 - handlers.py[DEBUG]: finish: modules-final/config-puppet: SUCCESS: config-puppet ran successfully | |
2022-06-27 21:19:15,992 - stages.py[DEBUG]: Running module chef (<module 'cloudinit.config.cc_chef' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_chef.py'>) with frequency always | |
2022-06-27 21:19:15,992 - handlers.py[DEBUG]: start: modules-final/config-chef: running config-chef with frequency always | |
2022-06-27 21:19:15,992 - helpers.py[DEBUG]: Running config-chef using lock (<cloudinit.helpers.DummyLock object at 0x7f9444427a00>) | |
2022-06-27 21:19:15,992 - cc_chef.py[DEBUG]: Skipping module named chef, no 'chef' key in configuration | |
2022-06-27 21:19:15,992 - handlers.py[DEBUG]: finish: modules-final/config-chef: SUCCESS: config-chef ran successfully | |
2022-06-27 21:19:15,992 - stages.py[DEBUG]: Running module mcollective (<module 'cloudinit.config.cc_mcollective' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_mcollective.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,993 - handlers.py[DEBUG]: start: modules-final/config-mcollective: running config-mcollective with frequency once-per-instance | |
2022-06-27 21:19:15,993 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_mcollective - wb: [644] 25 bytes | |
2022-06-27 21:19:15,993 - helpers.py[DEBUG]: Running config-mcollective using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_mcollective'>) | |
2022-06-27 21:19:15,993 - cc_mcollective.py[DEBUG]: Skipping module named mcollective, no 'mcollective' key in configuration | |
2022-06-27 21:19:15,993 - handlers.py[DEBUG]: finish: modules-final/config-mcollective: SUCCESS: config-mcollective ran successfully | |
2022-06-27 21:19:15,993 - stages.py[DEBUG]: Running module salt-minion (<module 'cloudinit.config.cc_salt_minion' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_salt_minion.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,993 - handlers.py[DEBUG]: start: modules-final/config-salt-minion: running config-salt-minion with frequency once-per-instance | |
2022-06-27 21:19:15,994 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_salt_minion - wb: [644] 25 bytes | |
2022-06-27 21:19:15,994 - helpers.py[DEBUG]: Running config-salt-minion using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_salt_minion'>) | |
2022-06-27 21:19:15,994 - cc_salt_minion.py[DEBUG]: Skipping module named salt-minion, no 'salt_minion' key in configuration | |
2022-06-27 21:19:15,994 - handlers.py[DEBUG]: finish: modules-final/config-salt-minion: SUCCESS: config-salt-minion ran successfully | |
2022-06-27 21:19:15,994 - stages.py[DEBUG]: Running module reset_rmc (<module 'cloudinit.config.cc_reset_rmc' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_reset_rmc.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,994 - handlers.py[DEBUG]: start: modules-final/config-reset_rmc: running config-reset_rmc with frequency once-per-instance | |
2022-06-27 21:19:15,994 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_reset_rmc - wb: [644] 25 bytes | |
2022-06-27 21:19:15,995 - helpers.py[DEBUG]: Running config-reset_rmc using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_reset_rmc'>) | |
2022-06-27 21:19:15,995 - cc_reset_rmc.py[DEBUG]: module disabled, RSCT_PATH not present | |
2022-06-27 21:19:15,995 - handlers.py[DEBUG]: finish: modules-final/config-reset_rmc: SUCCESS: config-reset_rmc ran successfully | |
2022-06-27 21:19:15,995 - stages.py[DEBUG]: Running module refresh_rmc_and_interface (<module 'cloudinit.config.cc_refresh_rmc_and_interface' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_refresh_rmc_and_interface.py'>) with frequency always | |
2022-06-27 21:19:15,995 - handlers.py[DEBUG]: start: modules-final/config-refresh_rmc_and_interface: running config-refresh_rmc_and_interface with frequency always | |
2022-06-27 21:19:15,995 - helpers.py[DEBUG]: Running config-refresh_rmc_and_interface using lock (<cloudinit.helpers.DummyLock object at 0x7f9444427a00>) | |
2022-06-27 21:19:15,995 - cc_refresh_rmc_and_interface.py[DEBUG]: No 'rmcctrl' in path, disabled | |
2022-06-27 21:19:15,995 - handlers.py[DEBUG]: finish: modules-final/config-refresh_rmc_and_interface: SUCCESS: config-refresh_rmc_and_interface ran successfully | |
2022-06-27 21:19:15,996 - stages.py[DEBUG]: Running module rightscale_userdata (<module 'cloudinit.config.cc_rightscale_userdata' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_rightscale_userdata.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,996 - handlers.py[DEBUG]: start: modules-final/config-rightscale_userdata: running config-rightscale_userdata with frequency once-per-instance | |
2022-06-27 21:19:15,996 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_rightscale_userdata - wb: [644] 24 bytes | |
2022-06-27 21:19:15,996 - helpers.py[DEBUG]: Running config-rightscale_userdata using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_rightscale_userdata'>) | |
2022-06-27 21:19:15,996 - cc_rightscale_userdata.py[DEBUG]: Failed to get raw userdata in module rightscale_userdata | |
2022-06-27 21:19:15,996 - handlers.py[DEBUG]: finish: modules-final/config-rightscale_userdata: SUCCESS: config-rightscale_userdata ran successfully | |
2022-06-27 21:19:15,996 - stages.py[DEBUG]: Running module scripts-vendor (<module 'cloudinit.config.cc_scripts_vendor' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_scripts_vendor.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,997 - handlers.py[DEBUG]: start: modules-final/config-scripts-vendor: running config-scripts-vendor with frequency once-per-instance | |
2022-06-27 21:19:15,997 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_scripts_vendor - wb: [644] 25 bytes | |
2022-06-27 21:19:15,997 - helpers.py[DEBUG]: Running config-scripts-vendor using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_scripts_vendor'>) | |
2022-06-27 21:19:15,997 - handlers.py[DEBUG]: finish: modules-final/config-scripts-vendor: SUCCESS: config-scripts-vendor ran successfully | |
2022-06-27 21:19:15,997 - stages.py[DEBUG]: Running module scripts-per-once (<module 'cloudinit.config.cc_scripts_per_once' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_scripts_per_once.py'>) with frequency once | |
2022-06-27 21:19:15,997 - handlers.py[DEBUG]: start: modules-final/config-scripts-per-once: running config-scripts-per-once with frequency once | |
2022-06-27 21:19:15,997 - helpers.py[DEBUG]: config-scripts-per-once already ran (freq=once) | |
2022-06-27 21:19:15,998 - handlers.py[DEBUG]: finish: modules-final/config-scripts-per-once: SUCCESS: config-scripts-per-once previously ran | |
2022-06-27 21:19:15,998 - stages.py[DEBUG]: Running module scripts-per-boot (<module 'cloudinit.config.cc_scripts_per_boot' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_scripts_per_boot.py'>) with frequency always | |
2022-06-27 21:19:15,998 - handlers.py[DEBUG]: start: modules-final/config-scripts-per-boot: running config-scripts-per-boot with frequency always | |
2022-06-27 21:19:15,998 - helpers.py[DEBUG]: Running config-scripts-per-boot using lock (<cloudinit.helpers.DummyLock object at 0x7f94441b04f0>) | |
2022-06-27 21:19:15,998 - handlers.py[DEBUG]: finish: modules-final/config-scripts-per-boot: SUCCESS: config-scripts-per-boot ran successfully | |
2022-06-27 21:19:15,998 - stages.py[DEBUG]: Running module scripts-per-instance (<module 'cloudinit.config.cc_scripts_per_instance' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_scripts_per_instance.py'>) with frequency once-per-instance | |
2022-06-27 21:19:15,999 - handlers.py[DEBUG]: start: modules-final/config-scripts-per-instance: running config-scripts-per-instance with frequency once-per-instance | |
2022-06-27 21:19:15,999 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_scripts_per_instance - wb: [644] 24 bytes | |
2022-06-27 21:19:15,999 - helpers.py[DEBUG]: Running config-scripts-per-instance using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_scripts_per_instance'>) | |
2022-06-27 21:19:15,999 - handlers.py[DEBUG]: finish: modules-final/config-scripts-per-instance: SUCCESS: config-scripts-per-instance ran successfully | |
2022-06-27 21:19:16,000 - stages.py[DEBUG]: Running module scripts-user (<module 'cloudinit.config.cc_scripts_user' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_scripts_user.py'>) with frequency once-per-instance | |
2022-06-27 21:19:16,000 - handlers.py[DEBUG]: start: modules-final/config-scripts-user: running config-scripts-user with frequency once-per-instance | |
2022-06-27 21:19:16,000 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_scripts_user - wb: [644] 25 bytes | |
2022-06-27 21:19:16,000 - helpers.py[DEBUG]: Running config-scripts-user using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_scripts_user'>) | |
2022-06-27 21:19:16,000 - subp.py[DEBUG]: Running command ['/var/lib/cloud/instance/scripts/part-003'] with allowed return codes [0] (shell=False, capture=False) | |
2022-06-27 21:20:20,298 - subp.py[DEBUG]: Unexpected error while running command. | |
Command: ['/var/lib/cloud/instance/scripts/part-003'] | |
Exit code: 1 | |
Reason: - | |
Stdout: - | |
Stderr: - | |
2022-06-27 21:20:20,298 - cc_scripts_user.py[WARNING]: Failed to run module scripts-user (scripts in /var/lib/cloud/instance/scripts) | |
2022-06-27 21:20:20,299 - handlers.py[DEBUG]: finish: modules-final/config-scripts-user: FAIL: running config-scripts-user with frequency once-per-instance | |
2022-06-27 21:20:20,299 - util.py[WARNING]: Running module scripts-user (<module 'cloudinit.config.cc_scripts_user' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_scripts_user.py'>) failed | |
2022-06-27 21:20:20,299 - util.py[DEBUG]: Running module scripts-user (<module 'cloudinit.config.cc_scripts_user' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_scripts_user.py'>) failed | |
Traceback (most recent call last): | |
File "/usr/lib/python3/dist-packages/cloudinit/stages.py", line 1086, in _run_modules | |
ran, _r = cc.run( | |
File "/usr/lib/python3/dist-packages/cloudinit/cloud.py", line 55, in run | |
return self._runners.run(name, functor, args, freq, clear_on_fail) | |
File "/usr/lib/python3/dist-packages/cloudinit/helpers.py", line 185, in run | |
results = functor(*args) | |
File "/usr/lib/python3/dist-packages/cloudinit/config/cc_scripts_user.py", line 44, in handle | |
subp.runparts(runparts_path) | |
File "/usr/lib/python3/dist-packages/cloudinit/subp.py", line 424, in runparts | |
raise RuntimeError( | |
RuntimeError: Runparts: 1 failures (part-003) in 1 attempted commands | |
2022-06-27 21:20:20,320 - stages.py[DEBUG]: Running module ssh-authkey-fingerprints (<module 'cloudinit.config.cc_ssh_authkey_fingerprints' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_ssh_authkey_fingerprints.py'>) with frequency once-per-instance | |
2022-06-27 21:20:20,321 - handlers.py[DEBUG]: start: modules-final/config-ssh-authkey-fingerprints: running config-ssh-authkey-fingerprints with frequency once-per-instance | |
2022-06-27 21:20:20,321 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ssh_authkey_fingerprints - wb: [644] 24 bytes | |
2022-06-27 21:20:20,324 - helpers.py[DEBUG]: Running config-ssh-authkey-fingerprints using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_ssh_authkey_fingerprints'>) | |
2022-06-27 21:20:20,326 - util.py[DEBUG]: Reading from /etc/ssh/sshd_config (quiet=False) | |
2022-06-27 21:20:20,326 - util.py[DEBUG]: Read 689 bytes from /etc/ssh/sshd_config | |
2022-06-27 21:20:20,326 - util.py[DEBUG]: Reading from /home/ubuntu/.ssh/authorized_keys (quiet=False) | |
2022-06-27 21:20:20,327 - util.py[DEBUG]: Read 386 bytes from /home/ubuntu/.ssh/authorized_keys | |
2022-06-27 21:20:20,354 - handlers.py[DEBUG]: finish: modules-final/config-ssh-authkey-fingerprints: SUCCESS: config-ssh-authkey-fingerprints ran successfully | |
2022-06-27 21:20:20,354 - stages.py[DEBUG]: Running module keys-to-console (<module 'cloudinit.config.cc_keys_to_console' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_keys_to_console.py'>) with frequency once-per-instance | |
2022-06-27 21:20:20,354 - handlers.py[DEBUG]: start: modules-final/config-keys-to-console: running config-keys-to-console with frequency once-per-instance | |
2022-06-27 21:20:20,354 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_keys_to_console - wb: [644] 25 bytes | |
2022-06-27 21:20:20,354 - helpers.py[DEBUG]: Running config-keys-to-console using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_keys_to_console'>) | |
2022-06-27 21:20:20,355 - subp.py[DEBUG]: Running command ['/usr/lib/cloud-init/write-ssh-key-fingerprints', '', 'ssh-dss'] with allowed return codes [0] (shell=False, capture=True) | |
2022-06-27 21:20:20,452 - handlers.py[DEBUG]: finish: modules-final/config-keys-to-console: SUCCESS: config-keys-to-console ran successfully | |
2022-06-27 21:20:20,452 - stages.py[DEBUG]: Running module install-hotplug (<module 'cloudinit.config.cc_install_hotplug' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_install_hotplug.py'>) with frequency once-per-instance | |
2022-06-27 21:20:20,453 - handlers.py[DEBUG]: start: modules-final/config-install-hotplug: running config-install-hotplug with frequency once-per-instance | |
2022-06-27 21:20:20,453 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_install_hotplug - wb: [644] 25 bytes | |
2022-06-27 21:20:20,454 - helpers.py[DEBUG]: Running config-install-hotplug using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_install_hotplug'>) | |
2022-06-27 21:20:20,455 - stages.py[DEBUG]: Allowed events: {<EventScope.NETWORK: 'network'>: {<EventType.BOOT_NEW_INSTANCE: 'boot-new-instance'>}} | |
2022-06-27 21:20:20,455 - stages.py[DEBUG]: Event Denied: scopes=['network'] EventType=hotplug | |
2022-06-27 21:20:20,455 - cc_install_hotplug.py[DEBUG]: Skipping hotplug install, not enabled | |
2022-06-27 21:20:20,455 - handlers.py[DEBUG]: finish: modules-final/config-install-hotplug: SUCCESS: config-install-hotplug ran successfully | |
2022-06-27 21:20:20,455 - stages.py[DEBUG]: Running module phone-home (<module 'cloudinit.config.cc_phone_home' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_phone_home.py'>) with frequency once-per-instance | |
2022-06-27 21:20:20,455 - handlers.py[DEBUG]: start: modules-final/config-phone-home: running config-phone-home with frequency once-per-instance | |
2022-06-27 21:20:20,455 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_phone_home - wb: [644] 25 bytes | |
2022-06-27 21:20:20,456 - helpers.py[DEBUG]: Running config-phone-home using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_phone_home'>) | |
2022-06-27 21:20:20,456 - cc_phone_home.py[DEBUG]: Skipping module named phone-home, no 'phone_home' configuration found | |
2022-06-27 21:20:20,456 - handlers.py[DEBUG]: finish: modules-final/config-phone-home: SUCCESS: config-phone-home ran successfully | |
2022-06-27 21:20:20,456 - stages.py[DEBUG]: Running module final-message (<module 'cloudinit.config.cc_final_message' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_final_message.py'>) with frequency always | |
2022-06-27 21:20:20,456 - handlers.py[DEBUG]: start: modules-final/config-final-message: running config-final-message with frequency always | |
2022-06-27 21:20:20,456 - helpers.py[DEBUG]: Running config-final-message using lock (<cloudinit.helpers.DummyLock object at 0x7f9444290310>) | |
2022-06-27 21:20:20,456 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False) | |
2022-06-27 21:20:20,456 - util.py[DEBUG]: Read 13 bytes from /proc/uptime | |
2022-06-27 21:20:20,460 - util.py[DEBUG]: Cloud-init v. 22.1-14-g2e17a0d6-0ubuntu1~20.04.3 finished at Mon, 27 Jun 2022 21:20:20 +0000. Datasource DataSourceEc2Local. Up 103.40 seconds | |
2022-06-27 21:20:20,460 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/boot-finished - wb: [644] 81 bytes | |
2022-06-27 21:20:20,460 - handlers.py[DEBUG]: finish: modules-final/config-final-message: SUCCESS: config-final-message ran successfully | |
2022-06-27 21:20:20,461 - stages.py[DEBUG]: Running module power-state-change (<module 'cloudinit.config.cc_power_state_change' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_power_state_change.py'>) with frequency once-per-instance | |
2022-06-27 21:20:20,461 - handlers.py[DEBUG]: start: modules-final/config-power-state-change: running config-power-state-change with frequency once-per-instance | |
2022-06-27 21:20:20,461 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/i-0791381a1090bf470/sem/config_power_state_change - wb: [644] 25 bytes | |
2022-06-27 21:20:20,462 - helpers.py[DEBUG]: Running config-power-state-change using lock (<FileLock using file '/var/lib/cloud/instances/i-0791381a1090bf470/sem/config_power_state_change'>) | |
2022-06-27 21:20:20,462 - cc_power_state_change.py[DEBUG]: no power_state provided. doing nothing | |
2022-06-27 21:20:20,462 - handlers.py[DEBUG]: finish: modules-final/config-power-state-change: SUCCESS: config-power-state-change ran successfully | |
2022-06-27 21:20:20,462 - main.py[DEBUG]: Ran 24 modules with 1 failures | |
2022-06-27 21:20:20,462 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/status.json (via temporary file /var/lib/cloud/data/tmp1xmblxjo) - w: [644] 672 bytes/chars | |
2022-06-27 21:20:20,463 - atomic_helper.py[DEBUG]: Atomically writing to file /var/lib/cloud/data/result.json (via temporary file /var/lib/cloud/data/tmpw53cw3ot) - w: [644] 167 bytes/chars | |
2022-06-27 21:20:20,463 - util.py[DEBUG]: Creating symbolic link from '/run/cloud-init/result.json' => '../../var/lib/cloud/data/result.json' | |
2022-06-27 21:20:20,463 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False) | |
2022-06-27 21:20:20,463 - util.py[DEBUG]: Read 13 bytes from /proc/uptime | |
2022-06-27 21:20:20,464 - util.py[DEBUG]: cloud-init mode 'modules' took 64.624 seconds (64.62) | |
2022-06-27 21:20:20,464 - handlers.py[DEBUG]: finish: modules-final: FAIL: running modules for final |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment