Created
March 28, 2019 13:23
-
-
Save eamsden/bfb5153844f800241549695b48606f11 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
| -- Logs begin at Thu 2019-03-28 13:10:39 UTC, end at Thu 2019-03-28 13:21:32 UTC. -- | |
| Mar 28 13:10:47 localhost systemd[1]: Starting Initial cloud-init job (metadata service crawler)... | |
| Mar 28 13:10:47 localhost cloud-init[743]: WARN: no logging configured! (tried 0 configs) | |
| Mar 28 13:10:47 localhost cloud-init[743]: Setting up basic logging... | |
| Mar 28 13:10:47 localhost cloud-init[743]: Cloud-init v. 0.7.9 running 'init' at Thu, 28 Mar 2019 13:10:47 +0000. Up 12.66 seconds. | |
| Mar 28 13:10:47 localhost cloud-init[743]: 2019-03-28 13:10:47,975 - util.py[DEBUG]: Cloud-init v. 0.7.9 running 'init' at Thu, 28 Mar 2019 13:10:47 +0000. Up 12.66 seconds. | |
| Mar 28 13:10:47 localhost cloud-init[743]: 2019-03-28 13:10:47,981 - util.py[DEBUG]: Writing to /var/log/cloud-init.log - ab: [420] 0 bytes | |
| Mar 28 13:10:47 localhost cloud-init[743]: 2019-03-28 13:10:47,985 - util.py[DEBUG]: Changing the ownership of /var/log/cloud-init.log to 0:55 | |
| Mar 28 13:10:47 localhost cloud-init[743]: 2019-03-28 13:10:47,985 - util.py[DEBUG]: Running command ['ifconfig', '-a'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:47 localhost cloud-init[743]: 2019-03-28 13:10:47,995 - util.py[DEBUG]: Running command ['netstat', '-rn'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:47,999 - util.py[DEBUG]: Running command ['netstat', '-A', 'inet6', '-n'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: +++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++ | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: +--------+------+---------------+---------------+-------+-------------------+ | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: +--------+------+---------------+---------------+-------+-------------------+ | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: | lo: | True | 127.0.0.1 | 255.0.0.0 | . | . | | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: | lo: | True | . | . | d | . | | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: | eth0: | True | 134.209.45.23 | 255.255.240.0 | . | 8e:a9:a8:33:d0:7d | | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: | eth0: | True | . | . | d | 8e:a9:a8:33:d0:7d | | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: +--------+------+---------------+---------------+-------+-------------------+ | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: ++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++ | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: +-------+--------------+--------------+---------------+-----------+-------+ | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: +-------+--------------+--------------+---------------+-----------+-------+ | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: | 0 | 0.0.0.0 | 134.209.32.1 | 0.0.0.0 | eth0 | UG | | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: | 1 | 134.209.32.0 | 0.0.0.0 | 255.255.240.0 | eth0 | U | | |
| Mar 28 13:10:48 localhost cloud-init[743]: ci-info: +-------+--------------+--------------+---------------+-----------+-------+ | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,004 - main.py[DEBUG]: Checking to see if files that we need already exist from a previous run that would allow us to stop early. | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,005 - main.py[DEBUG]: Execution continuing, no previous run detected that would allow us to stop early. | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,005 - handlers.py[DEBUG]: start: init-network/check-cache: attempting to read from cache [trust] | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,005 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/obj.pkl (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,005 - util.py[DEBUG]: Read 16572 bytes from /var/lib/cloud/instance/obj.pkl | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,008 - util.py[DEBUG]: Reading from /run/cloud-init/.instance-id (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,008 - util.py[DEBUG]: Read 10 bytes from /run/cloud-init/.instance-id | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,008 - stages.py[DEBUG]: restored from cache with run check: DataSourceConfigDrive [net,ver=2][source=/dev/vdb] | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,008 - handlers.py[DEBUG]: finish: init-network/check-cache: SUCCESS: restored from cache with run check: DataSourceConfigDrive [net,ver=2][source=/dev/vdb] | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,011 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,011 - util.py[DEBUG]: Read 810 bytes from /etc/cloud/cloud.cfg | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,011 - util.py[DEBUG]: Attempting to load yaml from string of length 810 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,019 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,020 - util.py[DEBUG]: load_yaml given empty string, returning default | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,020 - util.py[DEBUG]: Attempting to remove /var/lib/cloud/instance | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,020 - util.py[DEBUG]: Creating symbolic link from '/var/lib/cloud/instance' => '/var/lib/cloud/instances/138061459' | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,021 - util.py[DEBUG]: Reading from /var/lib/cloud/instances/138061459/datasource (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,021 - util.py[DEBUG]: Read 74 bytes from /var/lib/cloud/instances/138061459/datasource | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,021 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/datasource - wb: [420] 74 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,021 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-datasource - wb: [420] 74 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,022 - util.py[DEBUG]: Reading from /var/lib/cloud/data/instance-id (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,022 - util.py[DEBUG]: Read 10 bytes from /var/lib/cloud/data/instance-id | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,022 - stages.py[DEBUG]: previous iid found to be 138061459 | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,022 - util.py[DEBUG]: Writing to /var/lib/cloud/data/instance-id - wb: [420] 10 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,024 - util.py[DEBUG]: Writing to /run/cloud-init/.instance-id - wb: [420] 10 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,028 - util.py[DEBUG]: Writing to /var/lib/cloud/data/previous-instance-id - wb: [420] 10 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,029 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [256] 16661 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,030 - main.py[DEBUG]: [net] init will now be targeting instance id: 138061459. new=False | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,030 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,030 - util.py[DEBUG]: Read 810 bytes from /etc/cloud/cloud.cfg | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,030 - util.py[DEBUG]: Attempting to load yaml from string of length 810 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,034 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,034 - util.py[DEBUG]: load_yaml given empty string, returning default | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,040 - DataSourceConfigDrive.py[DEBUG]: network config provided via network_json | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,040 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,040 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,040 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,040 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,041 - stages.py[DEBUG]: applying net config names for {'version': 1, 'config': [{'subnets': [{u'type': 'dhcp4'}], 'mac_address': u'8e:a9:a8:33:d0:7d', u'type': 'physical', 'name': 'eth0', u'mtu': 1500}]} | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,041 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.nixos.Distro'> | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,041 - util.py[DEBUG]: Reading from /sys/class/net/eth0/operstate (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,041 - util.py[DEBUG]: Read 3 bytes from /sys/class/net/eth0/operstate | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,041 - util.py[DEBUG]: Reading from /sys/class/net/eth0/address (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,041 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/eth0/address | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,041 - util.py[DEBUG]: Reading from /sys/class/net/lo/operstate (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,041 - util.py[DEBUG]: Read 8 bytes from /sys/class/net/lo/operstate | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,041 - util.py[DEBUG]: Reading from /sys/class/net/lo/address (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,042 - util.py[DEBUG]: Read 18 bytes from /sys/class/net/lo/address | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,042 - util.py[DEBUG]: Running command ['ip', '-6', 'addr', 'show', 'permanent', 'scope', 'global'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,048 - util.py[DEBUG]: Running command ['ip', '-4', 'addr', 'show'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,052 - __init__.py[DEBUG]: no work necessary for renaming of [[u'8e:a9:a8:33:d0:7d', 'eth0']] | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,052 - stages.py[DEBUG]: not a new instance. network config is not applied. | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,056 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/user-data.txt - wb: [384] 0 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,059 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/user-data.txt.i - wb: [384] 345 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,060 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/vendor-data.txt - wb: [384] 11143 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,065 - util.py[DEBUG]: Attempting to load yaml from string of length 108 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,067 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/vendor-data.txt.i - wb: [384] 11201 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,069 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/sem/consume_data - wb: [420] 19 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,072 - helpers.py[DEBUG]: Running consume_data using lock (<FileLock using file '/var/lib/cloud/instances/138061459/sem/consume_data'>) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,072 - handlers.py[DEBUG]: start: init-network/consume-user-data: reading and applying user-data | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - stages.py[DEBUG]: Added default handler for set(['text/cloud-config-jsonp', 'text/cloud-config']) from CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - stages.py[DEBUG]: Added default handler for set(['text/x-shellscript']) from ShellScriptPartHandler: [['text/x-shellscript']] | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - stages.py[DEBUG]: Added default handler for set(['text/cloud-boothook']) from BootHookPartHandler: [['text/cloud-boothook']] | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - stages.py[DEBUG]: Added default handler for set(['text/upstart-job']) from UpstartJobPartHandler: [['text/upstart-job']] | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (__begin__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - __init__.py[DEBUG]: Calling handler UpstartJobPartHandler: [['text/upstart-job']] (__begin__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (__begin__, None, 3) with frequency once-per-instance | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (__begin__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - __init__.py[DEBUG]: {'Content-Type': 'text/x-not-multipart', 'Content-Disposition': 'attachment; filename="part-001"', 'MIME-Version': '1.0'} | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - __init__.py[DEBUG]: Empty payload of type text/x-not-multipart | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,073 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (__end__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:48 localhost systemd[1]: cloud-init.service: Main process exited, code=exited, status=1/FAILURE | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,074 - __init__.py[DEBUG]: Calling handler UpstartJobPartHandler: [['text/upstart-job']] (__end__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,074 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (__end__, None, 3) with frequency once-per-instance | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,074 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/cloud-config.txt - wb: [384] 0 bytes | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,074 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (__end__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,076 - handlers.py[DEBUG]: finish: init-network/consume-user-data: SUCCESS: reading and applying user-data | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,076 - handlers.py[DEBUG]: start: init-network/consume-vendor-data: reading and applying vendor-data | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,076 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,076 - util.py[DEBUG]: Read 0 bytes from /var/lib/cloud/instance/cloud-config.txt | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,076 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,076 - util.py[DEBUG]: load_yaml given empty string, returning default | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,076 - stages.py[DEBUG]: vendor data will be consumed. disabled_handlers=None | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,079 - stages.py[DEBUG]: Added default handler for set(['text/cloud-config-jsonp', 'text/cloud-config']) from CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,079 - stages.py[DEBUG]: Added default handler for set(['text/x-shellscript']) from ShellScriptPartHandler: [['text/x-shellscript']] | |
| Mar 28 13:10:48 localhost cloud-init[743]: 2019-03-28 13:10:48,079 - stages.py[DEBUG]: Added default handler for set(['text/cloud-boothook']) from BootHookPartHandler: [['text/cloud-boothook']] | |
| Mar 28 13:10:48 localhost systemd[1]: cloud-init.service: Failed with result 'exit-code'. | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,079 - stages.py[DEBUG]: Added default handler for set(['text/upstart-job']) from UpstartJobPartHandler: [['text/upstart-job']] | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,079 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (__begin__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,079 - __init__.py[DEBUG]: Calling handler UpstartJobPartHandler: [['text/upstart-job']] (__begin__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,079 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (__begin__, None, 3) with frequency once-per-instance | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,079 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (__begin__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,079 - __init__.py[DEBUG]: {'Content-Transfer-Encoding': '7bit', 'Content-Type': 'text/cloud-config; charset="us-ascii"', 'Content-Disposition': 'attachment; filename="cloud-config"', 'MIME-Version': '1.0'} | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,079 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (text/cloud-config, cloud-config, 3) with frequency once-per-instance | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,080 - util.py[DEBUG]: Attempting to load yaml from string of length 108 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,083 - cloud_config.py[DEBUG]: Merging by applying [('dict', ['replace']), ('list', []), ('str', [])] | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,083 - __init__.py[DEBUG]: {'Content-Transfer-Encoding': '7bit', 'Content-Type': 'text/cloud-boothook; charset="us-ascii"', 'Content-Disposition': 'attachment; filename="entropy-seed"', 'MIME-Version': '1.0'} | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,083 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (text/cloud-boothook, entropy-seed, 2) with frequency once-per-instance | |
| Mar 28 13:10:48 localhost systemd[1]: Failed to start Initial cloud-init job (metadata service crawler). | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,086 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/boothooks/entropy-seed - wb: [448] 4299 bytes | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,087 - util.py[DEBUG]: Running command ['/var/lib/cloud/instances/138061459/boothooks/entropy-seed'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,103 - __init__.py[DEBUG]: {'Content-Transfer-Encoding': '7bit', 'Content-Type': 'text/cloud-boothook; charset="us-ascii"', 'Content-Disposition': 'attachment; filename="digitalocean_fixups"', 'MIME-Version': '1.0'} | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,103 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (text/cloud-boothook, digitalocean_fixups, 2) with frequency once-per-instance | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,103 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/boothooks/digitalocean_fixups - wb: [448] 5985 bytes | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,105 - util.py[DEBUG]: Running command ['/var/lib/cloud/instances/138061459/boothooks/digitalocean_fixups'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,136 - __init__.py[DEBUG]: Calling handler BootHookPartHandler: [['text/cloud-boothook']] (__end__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,137 - __init__.py[DEBUG]: Calling handler UpstartJobPartHandler: [['text/upstart-job']] (__end__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,137 - __init__.py[DEBUG]: Calling handler CloudConfigPartHandler: [['text/cloud-config', 'text/cloud-config-jsonp']] (__end__, None, 3) with frequency once-per-instance | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,138 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/vendor-cloud-config.txt - wb: [384] 145 bytes | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,140 - __init__.py[DEBUG]: Calling handler ShellScriptPartHandler: [['text/x-shellscript']] (__end__, None, 2) with frequency once-per-instance | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,140 - handlers.py[DEBUG]: finish: init-network/consume-vendor-data: SUCCESS: reading and applying vendor-data | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,143 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg (quiet=False) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,143 - util.py[DEBUG]: Read 810 bytes from /etc/cloud/cloud.cfg | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,143 - util.py[DEBUG]: Attempting to load yaml from string of length 810 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,150 - util.py[DEBUG]: Reading from /etc/cloud/cloud.cfg.d/90-digitalocean.cfg (quiet=False) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,151 - util.py[DEBUG]: Read 1329 bytes from /etc/cloud/cloud.cfg.d/90-digitalocean.cfg | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,151 - util.py[DEBUG]: Attempting to load yaml from string of length 1329 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,159 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,159 - util.py[DEBUG]: load_yaml given empty string, returning default | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,165 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,165 - util.py[DEBUG]: Read 0 bytes from /var/lib/cloud/instance/cloud-config.txt | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,165 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,165 - util.py[DEBUG]: load_yaml given empty string, returning default | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,165 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/vendor-cloud-config.txt (quiet=False) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,165 - util.py[DEBUG]: Read 145 bytes from /var/lib/cloud/instance/vendor-cloud-config.txt | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,165 - util.py[DEBUG]: Attempting to load yaml from string of length 145 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,166 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/cloud-config.txt (quiet=False) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,166 - util.py[DEBUG]: Read 0 bytes from /var/lib/cloud/instance/cloud-config.txt | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,166 - util.py[DEBUG]: Attempting to load yaml from string of length 0 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,166 - util.py[DEBUG]: load_yaml given empty string, returning default | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,167 - util.py[DEBUG]: Reading from /var/lib/cloud/instance/vendor-cloud-config.txt (quiet=False) | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,167 - util.py[DEBUG]: Read 145 bytes from /var/lib/cloud/instance/vendor-cloud-config.txt | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,167 - util.py[DEBUG]: Attempting to load yaml from string of length 145 with allowed root types (<type 'dict'>,) | |
| Mar 28 13:10:49 localhost cloud-init[743]: WARN: no logging configured! (tried 0 configs) | |
| Mar 28 13:10:49 localhost cloud-init[743]: Setting up basic logging... | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,169 - util.py[DEBUG]: Writing to /var/lib/cloud/instance/obj.pkl - wb: [256] 28983 bytes | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,191 - stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.nixos.Distro'> | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,191 - stages.py[INFO]: Skipping modules ['ca-certs'] because they are not verified on distro 'nixos'. To run anyway, add them to 'unverified_modules' in config. | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,191 - stages.py[DEBUG]: Running module migrator (<module 'cloudinit.config.cc_migrator' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_migrator.pyc'>) with frequency always | |
| Mar 28 13:10:49 localhost cloud-init[743]: 2019-03-28 13:10:48,192 - handlers.py[DEBUG]: start: init-network/config-migrator: running config-migrator with frequency always | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,192 - handlers.py[DEBUG]: start: init-network/config-migrator: running config-migrator with frequency always | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,192 - helpers.py[DEBUG]: Running config-migrator using lock (<cloudinit.helpers.DummyLock object at 0x7f1c5e4170d0>) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,192 - cc_migrator.py[DEBUG]: Migrated 0 semaphore files to there canonicalized names | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,192 - handlers.py[DEBUG]: finish: init-network/config-migrator: SUCCESS: config-migrator ran successfully | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,192 - stages.py[DEBUG]: Running module seed_random (<module 'cloudinit.config.cc_seed_random' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_seed_random.pyc'>) with frequency once-per-instance | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,192 - handlers.py[DEBUG]: start: init-network/config-seed_random: running config-seed_random with frequency once-per-instance | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,192 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/sem/config_seed_random - wb: [420] 19 bytes | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,193 - helpers.py[DEBUG]: Running config-seed_random using lock (<FileLock using file '/var/lib/cloud/instances/138061459/sem/config_seed_random'>) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,193 - cc_seed_random.py[DEBUG]: no command provided | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,193 - handlers.py[DEBUG]: finish: init-network/config-seed_random: SUCCESS: config-seed_random ran successfully | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,193 - stages.py[DEBUG]: Running module bootcmd (<module 'cloudinit.config.cc_bootcmd' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_bootcmd.pyc'>) with frequency always | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,194 - handlers.py[DEBUG]: start: init-network/config-bootcmd: running config-bootcmd with frequency always | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,194 - helpers.py[DEBUG]: Running config-bootcmd using lock (<cloudinit.helpers.DummyLock object at 0x7f1c5e417250>) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,194 - cc_bootcmd.py[DEBUG]: Skipping module named bootcmd, no 'bootcmd' key in configuration | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,194 - handlers.py[DEBUG]: finish: init-network/config-bootcmd: SUCCESS: config-bootcmd ran successfully | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,194 - stages.py[DEBUG]: Running module write-files (<module 'cloudinit.config.cc_write_files' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_write_files.pyc'>) with frequency once-per-instance | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,194 - handlers.py[DEBUG]: start: init-network/config-write-files: running config-write-files with frequency once-per-instance | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,194 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/sem/config_write_files - wb: [420] 19 bytes | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,196 - helpers.py[DEBUG]: Running config-write-files using lock (<FileLock using file '/var/lib/cloud/instances/138061459/sem/config_write_files'>) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,196 - cc_write_files.py[DEBUG]: Skipping module named write-files, no/empty 'write_files' key in configuration | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,196 - handlers.py[DEBUG]: finish: init-network/config-write-files: SUCCESS: config-write-files ran successfully | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,196 - stages.py[DEBUG]: Running module growpart (<module 'cloudinit.config.cc_growpart' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_growpart.pyc'>) with frequency always | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,196 - handlers.py[DEBUG]: start: init-network/config-growpart: running config-growpart with frequency always | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,196 - helpers.py[DEBUG]: Running config-growpart using lock (<cloudinit.helpers.DummyLock object at 0x7f1c5e417310>) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,196 - cc_growpart.py[DEBUG]: No 'growpart' entry in cfg. Using default: {'ignore_growroot_disabled': False, 'mode': 'auto', 'devices': ['/']} | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,196 - util.py[DEBUG]: Running command ['/nix/store/hbzsppz29w50qb5f9663fzqqrr6k54gq-cloud-utils-0.30/bin/growpart', '--help'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,196 - util.py[DEBUG]: Running command ['/nix/store/hbzsppz29w50qb5f9663fzqqrr6k54gq-cloud-utils-0.30/bin/growpart', '--help'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,224 - util.py[DEBUG]: Reading from /proc/743/mountinfo (quiet=False) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,225 - util.py[DEBUG]: Read 2723 bytes from /proc/743/mountinfo | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,236 - util.py[DEBUG]: Reading from /sys/class/block/vda1/partition (quiet=False) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,237 - util.py[DEBUG]: Read 2 bytes from /sys/class/block/vda1/partition | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,237 - util.py[DEBUG]: Reading from /sys/devices/pci0000:00/0000:00:05.0/virtio2/block/vda/dev (quiet=False) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,237 - util.py[DEBUG]: Read 6 bytes from /sys/devices/pci0000:00/0000:00:05.0/virtio2/block/vda/dev | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,237 - util.py[DEBUG]: Running command ['/nix/store/hbzsppz29w50qb5f9663fzqqrr6k54gq-cloud-utils-0.30/bin/growpart', '--dry-run', '/dev/vda', '1'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:50 localhost cloud-init[743]: 2019-03-28 13:10:48,337 - util.py[DEBUG]: resize_devices took 0.113 seconds | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,337 - cc_growpart.py[DEBUG]: '/' NOCHANGE: no change necessary (/dev/vda, 1) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,337 - handlers.py[DEBUG]: finish: init-network/config-growpart: SUCCESS: config-growpart ran successfully | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,338 - stages.py[DEBUG]: Running module resizefs (<module 'cloudinit.config.cc_resizefs' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_resizefs.pyc'>) with frequency always | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,338 - handlers.py[DEBUG]: start: init-network/config-resizefs: running config-resizefs with frequency always | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,338 - helpers.py[DEBUG]: Running config-resizefs using lock (<cloudinit.helpers.DummyLock object at 0x7f1c5e417210>) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,338 - util.py[DEBUG]: Reading from /proc/743/mountinfo (quiet=False) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,338 - util.py[DEBUG]: Read 2723 bytes from /proc/743/mountinfo | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,338 - cc_resizefs.py[DEBUG]: resize_info: dev=/dev/disk/by-label/nixos mnt_point=/ path=/ | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,338 - cc_resizefs.py[DEBUG]: resize_info: dev=/dev/disk/by-label/nixos mnt_point=/ path=/ | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,338 - util.py[DEBUG]: Running command ['systemd-detect-virt', '--quiet', '--container'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,348 - util.py[DEBUG]: Running command ['running-in-container'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,354 - util.py[DEBUG]: Running command ['lxc-is-container'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,360 - util.py[DEBUG]: Reading from /proc/1/environ (quiet=False) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,360 - util.py[DEBUG]: Read 266 bytes from /proc/1/environ | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,360 - util.py[DEBUG]: Reading from /proc/self/status (quiet=False) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,361 - util.py[DEBUG]: Read 1018 bytes from /proc/self/status | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,361 - cc_resizefs.py[DEBUG]: Resizing / (ext4) using resize2fs /dev/disk/by-label/nixos | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,361 - util.py[DEBUG]: Running command ('resize2fs', '/dev/disk/by-label/nixos') with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,361 - util.py[DEBUG]: Running command ('resize2fs', '/dev/disk/by-label/nixos') with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,377 - util.py[DEBUG]: Resizing took 0.016 seconds | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,377 - cc_resizefs.py[DEBUG]: Resized root filesystem (type=ext4, val=True) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,378 - handlers.py[DEBUG]: finish: init-network/config-resizefs: SUCCESS: config-resizefs ran successfully | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,378 - stages.py[DEBUG]: Running module update_etc_hosts (<module 'cloudinit.config.cc_update_etc_hosts' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_update_etc_hosts.pyc'>) with frequency once-per-instance | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,378 - handlers.py[DEBUG]: start: init-network/config-update_etc_hosts: running config-update_etc_hosts with frequency once-per-instance | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,378 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/sem/config_update_etc_hosts - wb: [420] 19 bytes | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,380 - helpers.py[DEBUG]: Running config-update_etc_hosts using lock (<FileLock using file '/var/lib/cloud/instances/138061459/sem/config_update_etc_hosts'>) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,380 - util.py[DEBUG]: Reading from /etc/cloud/templates/hosts.nixos.tmpl (quiet=False) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,382 - util.py[DEBUG]: Read 66 bytes from /etc/cloud/templates/hosts.nixos.tmpl | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,382 - templater.py[DEBUG]: Using Cheetah as the renderer for unknown template. | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,382 - templater.py[DEBUG]: Rendering content of '/etc/cloud/templates/hosts.nixos.tmpl' using renderer cheetah | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,392 - util.py[DEBUG]: Writing to /etc/hosts - wb: [420] 90 bytes | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,392 - handlers.py[DEBUG]: finish: init-network/config-update_etc_hosts: FAIL: running config-update_etc_hosts with frequency once-per-instance | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,392 - util.py[WARNING]: Running module update_etc_hosts (<module 'cloudinit.config.cc_update_etc_hosts' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_update_etc_hosts.pyc'>) failed | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,392 - util.py[WARNING]: Running module update_etc_hosts (<module 'cloudinit.config.cc_update_etc_hosts' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_update_etc_hosts.pyc'>) failed | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,392 - util.py[DEBUG]: Running module update_etc_hosts (<module 'cloudinit.config.cc_update_etc_hosts' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_update_etc_hosts.pyc'>) failed | |
| Mar 28 13:10:51 localhost cloud-init[743]: Traceback (most recent call last): | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/stages.py", line 776, in _run_modules | |
| Mar 28 13:10:51 localhost cloud-init[743]: freq=freq) | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/cloud.py", line 54, in run | |
| Mar 28 13:10:51 localhost cloud-init[743]: return self._runners.run(name, functor, args, freq, clear_on_fail) | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/helpers.py", line 187, in run | |
| Mar 28 13:10:51 localhost cloud-init[743]: results = functor(*args) | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_update_etc_hosts.py", line 78, in handle | |
| Mar 28 13:10:51 localhost cloud-init[743]: {'hostname': hostname, 'fqdn': fqdn}) | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/templater.py", line 131, in render_to_file | |
| Mar 28 13:10:51 localhost cloud-init[743]: util.write_file(outfn, contents, mode=mode) | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/util.py", line 1755, in write_file | |
| Mar 28 13:10:51 localhost cloud-init[743]: with open(filename, omode) as fh: | |
| Mar 28 13:10:51 localhost cloud-init[743]: IOError: [Errno 30] Read-only file system: '/etc/hosts' | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,392 - util.py[DEBUG]: Running module update_etc_hosts (<module 'cloudinit.config.cc_update_etc_hosts' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_update_etc_hosts.pyc'>) failed | |
| Mar 28 13:10:51 localhost cloud-init[743]: Traceback (most recent call last): | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/stages.py", line 776, in _run_modules | |
| Mar 28 13:10:51 localhost cloud-init[743]: freq=freq) | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/cloud.py", line 54, in run | |
| Mar 28 13:10:51 localhost cloud-init[743]: return self._runners.run(name, functor, args, freq, clear_on_fail) | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/helpers.py", line 187, in run | |
| Mar 28 13:10:51 localhost cloud-init[743]: results = functor(*args) | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_update_etc_hosts.py", line 78, in handle | |
| Mar 28 13:10:51 localhost cloud-init[743]: {'hostname': hostname, 'fqdn': fqdn}) | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/templater.py", line 131, in render_to_file | |
| Mar 28 13:10:51 localhost cloud-init[743]: util.write_file(outfn, contents, mode=mode) | |
| Mar 28 13:10:51 localhost cloud-init[743]: File "/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/util.py", line 1755, in write_file | |
| Mar 28 13:10:51 localhost cloud-init[743]: with open(filename, omode) as fh: | |
| Mar 28 13:10:51 localhost cloud-init[743]: IOError: [Errno 30] Read-only file system: '/etc/hosts' | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,399 - stages.py[DEBUG]: Running module ca-certs (<module 'cloudinit.config.cc_ca_certs' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_ca_certs.pyc'>) with frequency once-per-instance | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,400 - handlers.py[DEBUG]: start: init-network/config-ca-certs: running config-ca-certs with frequency once-per-instance | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,400 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/sem/config_ca_certs - wb: [420] 18 bytes | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,400 - helpers.py[DEBUG]: Running config-ca-certs using lock (<FileLock using file '/var/lib/cloud/instances/138061459/sem/config_ca_certs'>) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,401 - cc_ca_certs.py[DEBUG]: Skipping module named ca-certs, no 'ca-certs' key in configuration | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,401 - handlers.py[DEBUG]: finish: init-network/config-ca-certs: SUCCESS: config-ca-certs ran successfully | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,401 - stages.py[DEBUG]: Running module rsyslog (<module 'cloudinit.config.cc_rsyslog' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_rsyslog.pyc'>) with frequency once-per-instance | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,401 - handlers.py[DEBUG]: start: init-network/config-rsyslog: running config-rsyslog with frequency once-per-instance | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,401 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/sem/config_rsyslog - wb: [420] 18 bytes | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,401 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/sem/config_rsyslog - wb: [420] 18 bytes | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,402 - helpers.py[DEBUG]: Running config-rsyslog using lock (<FileLock using file '/var/lib/cloud/instances/138061459/sem/config_rsyslog'>) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,402 - cc_rsyslog.py[DEBUG]: Skipping module named rsyslog, no 'rsyslog' key in configuration | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,402 - handlers.py[DEBUG]: finish: init-network/config-rsyslog: SUCCESS: config-rsyslog ran successfully | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,402 - stages.py[DEBUG]: Running module users-groups (<module 'cloudinit.config.cc_users_groups' from '/nix/store/lfb4vx0fl1v2n30hs79bsy5pwfk622ip-cloud-init-0.7.9/lib/python2.7/site-packages/cloudinit/config/cc_users_groups.pyc'>) with frequency once-per-instance | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,402 - handlers.py[DEBUG]: start: init-network/config-users-groups: running config-users-groups with frequency once-per-instance | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,402 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/sem/config_users_groups - wb: [420] 18 bytes | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,402 - util.py[DEBUG]: Writing to /var/lib/cloud/instances/138061459/sem/config_users_groups - wb: [420] 18 bytes | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,406 - helpers.py[DEBUG]: Running config-users-groups using lock (<FileLock using file '/var/lib/cloud/instances/138061459/sem/config_users_groups'>) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,406 - __init__.py[INFO]: User root already exists, skipping. | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,406 - util.py[DEBUG]: Running command ['passwd', '-l', 'root'] with allowed return codes [0] (shell=False, capture=True) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,429 - handlers.py[DEBUG]: finish: init-network/config-users-groups: SUCCESS: config-users-groups ran successfully | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,429 - main.py[DEBUG]: Ran 10 modules with 1 failures | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,430 - util.py[DEBUG]: Reading from /proc/uptime (quiet=False) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,430 - util.py[DEBUG]: Read 11 bytes from /proc/uptime | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,430 - util.py[DEBUG]: cloud-init mode 'init' took 0.481 seconds (0.48) | |
| Mar 28 13:10:51 localhost cloud-init[743]: 2019-03-28 13:10:48,430 - handlers.py[DEBUG]: finish: init-network: FAIL: searching for network datasources |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment