May 10 18:30:51 hircine-tonette rsyslogd: [origin software="rsyslogd" swVersion="8.16.0" x-pid="1637" x-info="http://www.rsyslog.com"] start
May 10 18:30:51 hircine-tonette rsyslogd-2222: command 'KLogPermitNonKernelFacility' is currently not permitted - did you already set it via a RainerScript command (v6+ config)? [v8.16.0 try http://www.rsyslog.com/e/2222 ]
May 10 18:30:51 hircine-tonette rsyslogd-2307: warning: ~ action is deprecated, consider using the 'stop' statement instead [v8.16.0 try http://www.rsyslog.com/e/2307 ]
May 10 18:30:51 hircine-tonette rsyslogd: rsyslogd's groupid changed to 108
May 10 18:30:51 hircine-tonette rsyslogd: rsyslogd's userid changed to 104
May 10 18:30:51 hircine-tonette systemd[1]: Stopping System Logging Service...
May 10 18:30:51 hircine-tonette systemd[1]: Stopped System Logging Service.
May 10 18:30:51 hircine-tonette systemd[1]: Starting System Logging Service...
May 10 18:30:51 hircine-tonette rsyslogd-2039: Could not open output pipe '/dev/xconsole':: No such file or directory [v8.16.0 try http://www.rsyslog.com/e/2039 ]
May 10 18:30:51 hircine-tonette rsyslogd-2007: action 'action 13' suspended, next retry is Tue May 10 18:31:21 2016 [v8.16.0 try http://www.rsyslog.com/e/2007 ]
May 10 18:30:51 hircine-tonette systemd[1]: Started System Logging Service.
May 10 18:30:51 hircine-tonette [CLOUDINIT] cc_rsyslog.py[DEBUG]: rsyslog configured ['/etc/rsyslog.d/20-cloud-config.conf'] files
May 10 18:30:51 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: init-network/config-rsyslog: SUCCESS: config-rsyslog ran successfully
May 10 18:30:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'method': 'POST', 'allow_redirects': True, 'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'headers': {'Authorization': 'OAuth oauth_nonce="182330487079415874671462905051", oauth_timestamp="1462905051", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:30:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:30:51 hircine-tonette [CLOUDINIT] 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
May 10 18:30:51 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: init-network/config-users-groups: running config-users-groups with frequency once-per-instance
May 10 18:30:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'method': 'POST', 'allow_redirects': True, 'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'headers': {'Authorization': 'OAuth oauth_nonce="58313686486390540011462905051", oauth_timestamp="1462905051", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:30:52 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:30:52 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_users_groups - wb: [420] 25 bytes
May 10 18:30:52 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-users-groups using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_users_groups'>)
May 10 18:30:52 hircine-tonette [CLOUDINIT] __init__.py[DEBUG]: Adding user ubuntu
May 10 18:30:52 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Running hidden command to protect sensitive input/output logstring: ['useradd', 'ubuntu', '--comment', 'Ubuntu', '--shell', '/bin/bash', '--groups', 'adm,audio,cdrom,dialout,dip,floppy,lxd,netdev,plugdev,sudo,video', '-m']
May 10 18:30:53 hircine-tonette useradd[1642]: new group: name=ubuntu, GID=1000
May 10 18:30:53 hircine-tonette useradd[1642]: new user: name=ubuntu, UID=1000, GID=1000, home=/home/ubuntu, shell=/bin/bash
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'adm'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'dialout'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'cdrom'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'floppy'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'sudo'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'audio'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'dip'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'video'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'plugdev'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'netdev'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to group 'lxd'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'adm'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'dialout'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'cdrom'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'floppy'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'sudo'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'audio'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'dip'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'video'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'plugdev'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'netdev'
May 10 18:30:53 hircine-tonette useradd[1642]: add 'ubuntu' to shadow group 'lxd'
May 10 18:30:53 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Running command ['passwd', '-l', 'ubuntu'] with allowed return codes [0] (shell=False, capture=True)
May 10 18:30:53 hircine-tonette passwd[1647]: password for 'ubuntu' changed by 'root'
May 10 18:30:53 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /etc/sudoers (quiet=False)
May 10 18:30:53 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 745 bytes from /etc/sudoers
May 10 18:30:53 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /etc/sudoers.d/90-cloud-init-users - wb: [288] 123 bytes
May 10 18:30:53 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: init-network/config-users-groups: SUCCESS: config-users-groups ran successfully
May 10 18:30:53 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'method': 'POST', 'allow_redirects': True, 'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'headers': {'Authorization': 'OAuth oauth_nonce="105652668452026009301462905053", oauth_timestamp="1462905053", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:30:53 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:30:53 hircine-tonette [CLOUDINIT] 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
May 10 18:30:53 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: init-network/config-ssh: running config-ssh with frequency once-per-instance
May 10 18:30:53 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'method': 'POST', 'allow_redirects': True, 'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'headers': {'Authorization': 'OAuth oauth_nonce="127640710673591820421462905053", oauth_timestamp="1462905053", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:30:54 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:30:54 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_ssh - wb: [420] 25 bytes
May 10 18:30:54 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-ssh using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_ssh'>)
May 10 18:30:54 hircine-tonette [CLOUDINIT] util.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)
May 10 18:30:54 hircine-tonette [CLOUDINIT] util.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)
May 10 18:30:54 hircine-tonette [CLOUDINIT] util.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)
May 10 18:30:54 hircine-tonette [CLOUDINIT] util.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)
May 10 18:30:54 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Changing the ownership of /home/ubuntu/.ssh to 1000:1000
May 10 18:30:54 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /etc/ssh/sshd_config (quiet=False)
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 2540 bytes from /etc/ssh/sshd_config
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /home/ubuntu/.ssh/authorized_keys - wb: [384] 398 bytes
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Changing the ownership of /home/ubuntu/.ssh/authorized_keys to 1000:1000
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Changing the ownership of /root/.ssh to 0:0
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /etc/ssh/sshd_config (quiet=False)
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 2540 bytes from /etc/ssh/sshd_config
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /root/.ssh/authorized_keys - wb: [384] 553 bytes
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Changing the ownership of /root/.ssh/authorized_keys to 0:0
May 10 18:30:55 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: init-network/config-ssh: SUCCESS: config-ssh ran successfully
May 10 18:30:55 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'method': 'POST', 'allow_redirects': True, 'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'headers': {'Authorization': 'OAuth oauth_nonce="29274511762714103941462905055", oauth_timestamp="1462905055", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:30:55 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:30:55 hircine-tonette [CLOUDINIT] cloud-init[DEBUG]: Ran 14 modules with 0 failures
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /proc/uptime (quiet=False)
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 13 bytes from /proc/uptime
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: cloud-init mode 'init' took 15.791 seconds (15.79)
May 10 18:30:55 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: init-network: SUCCESS: searching for network datasources
May 10 18:30:55 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'method': 'POST', 'allow_redirects': True, 'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'headers': {'Authorization': 'OAuth oauth_nonce="80658797046761664011462905055", oauth_timestamp="1462905055", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:30:55 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:30:55 hircine-tonette cloud-init[1593]: Generating public/private rsa key pair.
May 10 18:30:55 hircine-tonette cloud-init[1593]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key.
May 10 18:30:55 hircine-tonette cloud-init[1593]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub.
May 10 18:30:55 hircine-tonette cloud-init[1593]: The key fingerprint is:
May 10 18:30:55 hircine-tonette cloud-init[1593]: SHA256:lCeqNXOH0dS/OTXA9+4N1z6ASlRpzH2Fu3kLvVMt00g root@hircine-tonette
May 10 18:30:55 hircine-tonette cloud-init[1593]: The key's randomart image is:
May 10 18:30:55 hircine-tonette cloud-init[1593]: +---[RSA 2048]----+
May 10 18:30:55 hircine-tonette cloud-init[1593]: |          +.+  .o|
May 10 18:30:55 hircine-tonette cloud-init[1593]: |         + *.+.o |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |        = =  .+..|
May 10 18:30:55 hircine-tonette cloud-init[1593]: |       o *    E.o|
May 10 18:30:55 hircine-tonette cloud-init[1593]: |      = S . ...X+|
May 10 18:30:55 hircine-tonette cloud-init[1593]: |     o + o . o@.O|
May 10 18:30:55 hircine-tonette cloud-init[1593]: |    .   . .   oX=|
May 10 18:30:55 hircine-tonette cloud-init[1593]: |         .     =+|
May 10 18:30:55 hircine-tonette cloud-init[1593]: |                o|
May 10 18:30:55 hircine-tonette cloud-init[1593]: +----[SHA256]-----+
May 10 18:30:55 hircine-tonette cloud-init[1593]: Generating public/private dsa key pair.
May 10 18:30:55 hircine-tonette cloud-init[1593]: Your identification has been saved in /etc/ssh/ssh_host_dsa_key.
May 10 18:30:55 hircine-tonette cloud-init[1593]: Your public key has been saved in /etc/ssh/ssh_host_dsa_key.pub.
May 10 18:30:55 hircine-tonette cloud-init[1593]: The key fingerprint is:
May 10 18:30:55 hircine-tonette cloud-init[1593]: SHA256:ZP3OoaNZhhWB6pPOcPkiRJ+vv4A3nSDvF2BEV41fKjA root@hircine-tonette
May 10 18:30:55 hircine-tonette cloud-init[1593]: The key's randomart image is:
May 10 18:30:55 hircine-tonette cloud-init[1593]: +---[DSA 1024]----+
May 10 18:30:55 hircine-tonette cloud-init[1593]: |     .. .ooo     |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |      ..E.... .  |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |     . .ooo. o   |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |    . +o  .oo    |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |   ..+.=S ..o    |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |    o+Oo.+ + .   |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |   ..==++.= o    |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |    .o+o+= .     |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |     .o==.       |
May 10 18:30:55 hircine-tonette cloud-init[1593]: +----[SHA256]-----+
May 10 18:30:55 hircine-tonette cloud-init[1593]: Generating public/private ecdsa key pair.
May 10 18:30:55 hircine-tonette cloud-init[1593]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key.
May 10 18:30:55 hircine-tonette cloud-init[1593]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub.
May 10 18:30:55 hircine-tonette cloud-init[1593]: The key fingerprint is:
May 10 18:30:55 hircine-tonette cloud-init[1593]: SHA256:ghkZJGYh3iOGQI2AXqFdr7kCp/N9lk0t8mObb0Jg7hM root@hircine-tonette
May 10 18:30:55 hircine-tonette cloud-init[1593]: The key's randomart image is:
May 10 18:30:55 hircine-tonette cloud-init[1593]: +---[ECDSA 256]---+
May 10 18:30:55 hircine-tonette cloud-init[1593]: |B.B++.           |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |==++.o.          |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |o=.+o  .         |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |... .+oo         |
May 10 18:30:55 hircine-tonette cloud-init[1593]: | . .oo+ S .      |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |  +   .E + .     |
May 10 18:30:55 hircine-tonette cloud-init[1593]: | o . .. O .      |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |  o o  * *..     |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |   . .o oo*.     |
May 10 18:30:55 hircine-tonette cloud-init[1593]: +----[SHA256]-----+
May 10 18:30:55 hircine-tonette cloud-init[1593]: Generating public/private ed25519 key pair.
May 10 18:30:55 hircine-tonette cloud-init[1593]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key.
May 10 18:30:55 hircine-tonette cloud-init[1593]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub.
May 10 18:30:55 hircine-tonette cloud-init[1593]: The key fingerprint is:
May 10 18:30:55 hircine-tonette cloud-init[1593]: SHA256:p62eh54gspUlDSXr/EmaGM+n9PD/S4j7ZAzOOiqJs7Q root@hircine-tonette
May 10 18:30:55 hircine-tonette cloud-init[1593]: The key's randomart image is:
May 10 18:30:55 hircine-tonette cloud-init[1593]: +--[ED25519 256]--+
May 10 18:30:55 hircine-tonette cloud-init[1593]: |    . .          |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |     +           |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |    o            |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |   o o           |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |  . + = S .      |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |   = @ = =       |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |.oo @ O *.o      |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |* .=.O =.=.      |
May 10 18:30:55 hircine-tonette cloud-init[1593]: |.Eo.o.+=Ooo.     |
May 10 18:30:55 hircine-tonette cloud-init[1593]: +----[SHA256]-----+
May 10 18:30:55 hircine-tonette systemd[1]: Started Initial cloud-init job (metadata service crawler).
May 10 18:30:55 hircine-tonette systemd[1]: Reached target Cloud-config availability.
May 10 18:30:55 hircine-tonette systemd[1]: Reached target Network is Online.
May 10 18:30:55 hircine-tonette systemd[1]: Starting Apply the settings specified in cloud-config...
May 10 18:30:55 hircine-tonette systemd[1]: Starting iSCSI initiator daemon (iscsid)...
May 10 18:30:55 hircine-tonette systemd[1]: Starting /etc/rc.local Compatibility...
May 10 18:30:55 hircine-tonette systemd[1]: Starting OpenBSD Secure Shell server...
May 10 18:30:55 hircine-tonette systemd[1]: Started /etc/rc.local Compatibility.
May 10 18:30:55 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Cloud-init v. 0.7.7 running 'modules:config' at Tue, 10 May 2016 18:30:55 +0000. Up 58.27 seconds.
May 10 18:30:56 hircine-tonette iscsid: iSCSI logger with pid=1679 started!
May 10 18:30:56 hircine-tonette systemd[1]: Started iSCSI initiator daemon (iscsid).
May 10 18:30:56 hircine-tonette systemd[1]: Starting Login to default iSCSI targets...
May 10 18:30:57 hircine-tonette iscsid: iSCSI daemon with pid=1680 started!
May 10 18:30:57 hircine-tonette iscsid: Could not read data from db. Using default and currently negotiated values
May 10 18:30:59 hircine-tonette sshd[1664]: Server listening on 0.0.0.0 port 22.
May 10 18:30:59 hircine-tonette sshd[1664]: Server listening on :: port 22.
May 10 18:30:59 hircine-tonette systemd[1]: Started OpenBSD Secure Shell server.
May 10 18:30:59 hircine-tonette iscsid: connection1:0 is operational after recovery (1 attempts)
May 10 18:30:59 hircine-tonette iscsiadm[1686]: iscsiadm: No records found
May 10 18:30:59 hircine-tonette systemd[1]: Started Login to default iSCSI targets.
May 10 18:30:59 hircine-tonette systemd[1]: Reached target Remote File Systems (Pre).
May 10 18:30:59 hircine-tonette systemd[1]: Reached target Remote File Systems.
May 10 18:30:59 hircine-tonette systemd[1]: Starting LSB: automatic crash report generation...
May 10 18:30:59 hircine-tonette systemd[1]: Starting Permit User Sessions...
May 10 18:30:59 hircine-tonette systemd[1]: Starting LSB: daemon to balance interrupts for SMP systems...
May 10 18:30:59 hircine-tonette systemd[1]: Starting LSB: Set the CPU Frequency Scaling governor to "ondemand"...
May 10 18:30:59 hircine-tonette irqbalance[1700]:  * Starting SMP IRQ Balancer: irqbalance
May 10 18:30:59 hircine-tonette systemd[1]: Started Permit User Sessions.
May 10 18:30:59 hircine-tonette systemd[1]: Starting Terminate Plymouth Boot Screen...
May 10 18:30:59 hircine-tonette systemd[1]: Starting Hold until boot process finishes up...
May 10 18:30:59 hircine-tonette systemd[1]: Started Hold until boot process finishes up.
May 10 18:30:59 hircine-tonette apport[1696]:  * Starting automatic crash report generation: apport
May 10 18:30:59 hircine-tonette systemd[1]: Started Getty on tty1.
May 10 18:30:59 hircine-tonette systemd[1]: Reached target Login Prompts.
May 10 18:30:59 hircine-tonette systemd[1]: Started Terminate Plymouth Boot Screen.
May 10 18:30:59 hircine-tonette systemd[1]: Started LSB: Set the CPU Frequency Scaling governor to "ondemand".
May 10 18:30:59 hircine-tonette apport[1696]:    ...done.
May 10 18:30:59 hircine-tonette irqbalance[1700]:    ...done.
May 10 18:30:59 hircine-tonette systemd[1]: Started LSB: automatic crash report generation.
May 10 18:30:59 hircine-tonette systemd[1]: Started LSB: daemon to balance interrupts for SMP systems.
May 10 18:30:59 hircine-tonette [CLOUDINIT] stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'>
May 10 18:30:59 hircine-tonette [CLOUDINIT] 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
May 10 18:30:59 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="116708574017512072921462905059", oauth_timestamp="1462905059", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:30:59 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:30:59 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-emit_upstart: running config-emit_upstart with frequency always
May 10 18:30:59 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-emit_upstart using lock (<cloudinit.helpers.DummyLock object at 0x7f20d689dfd0>)
May 10 18:30:59 hircine-tonette [CLOUDINIT] cc_emit_upstart.py[DEBUG]: no /sbin/initctl located
May 10 18:30:59 hircine-tonette [CLOUDINIT] cc_emit_upstart.py[DEBUG]: not upstart system, '%s' disabled
May 10 18:30:59 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="39566882317433174621462905059", oauth_timestamp="1462905059", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:30:59 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:30:59 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-emit_upstart: SUCCESS: config-emit_upstart ran successfully
May 10 18:30:59 hircine-tonette [CLOUDINIT] 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
May 10 18:30:59 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="137395652248671285011462905059", oauth_timestamp="1462905059", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:00 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-disk_setup: running config-disk_setup with frequency once-per-instance
May 10 18:31:00 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_disk_setup - wb: [420] 25 bytes
May 10 18:31:00 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-disk_setup using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_disk_setup'>)
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="40555611610948301981462905060", oauth_timestamp="1462905060", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:00 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-disk_setup: SUCCESS: config-disk_setup ran successfully
May 10 18:31:00 hircine-tonette [CLOUDINIT] 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
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="27817611416195008821462905060", oauth_timestamp="1462905060", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:00 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-mounts: running config-mounts with frequency once-per-instance
May 10 18:31:00 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_mounts - wb: [420] 25 bytes
May 10 18:31:00 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-mounts using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_mounts'>)
May 10 18:31:00 hircine-tonette [CLOUDINIT] cc_mounts.py[DEBUG]: Attempting to determine the real name of ephemeral0
May 10 18:31:00 hircine-tonette [CLOUDINIT] cc_mounts.py[DEBUG]: Ignoring nonexistant default named mount ephemeral0
May 10 18:31:00 hircine-tonette [CLOUDINIT] cc_mounts.py[DEBUG]: Attempting to determine the real name of swap
May 10 18:31:00 hircine-tonette [CLOUDINIT] cc_mounts.py[DEBUG]: Ignoring nonexistant default named mount swap
May 10 18:31:00 hircine-tonette [CLOUDINIT] cc_mounts.py[DEBUG]: no need to setup swap
May 10 18:31:00 hircine-tonette [CLOUDINIT] cc_mounts.py[DEBUG]: No modifications to fstab needed.
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="162790898620911770001462905060", oauth_timestamp="1462905060", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:00 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-mounts: SUCCESS: config-mounts ran successfully
May 10 18:31:00 hircine-tonette [CLOUDINIT] 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
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="81330248814561769981462905060", oauth_timestamp="1462905060", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:00 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-ssh-import-id: running config-ssh-import-id with frequency once-per-instance
May 10 18:31:00 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_ssh_import_id - wb: [420] 25 bytes
May 10 18:31:00 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-ssh-import-id using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_ssh_import_id'>)
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="91781945441855329791462905060", oauth_timestamp="1462905060", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:00 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-ssh-import-id: SUCCESS: config-ssh-import-id ran successfully
May 10 18:31:00 hircine-tonette [CLOUDINIT] 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
May 10 18:31:00 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="126459624153250077071462905060", oauth_timestamp="1462905060", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:01 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:01 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-locale: running config-locale with frequency once-per-instance
May 10 18:31:01 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_locale - wb: [420] 25 bytes
May 10 18:31:01 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-locale using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_locale'>)
May 10 18:31:01 hircine-tonette [CLOUDINIT] cc_locale.py[DEBUG]: Setting locale to en_US.UTF-8
May 10 18:31:01 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Running command ['locale-gen', 'en_US.UTF-8'] with allowed return codes [0] (shell=False, capture=False)
May 10 18:31:01 hircine-tonette cloud-init[1657]: Generating locales (this might take a while)...
May 10 18:31:03 hircine-tonette cloud-init[1657]:   en_US.UTF-8... done
May 10 18:31:03 hircine-tonette cloud-init[1657]: Generation complete.
May 10 18:31:03 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Running command ['update-locale', 'en_US.UTF-8'] with allowed return codes [0] (shell=False, capture=False)
May 10 18:31:04 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /etc/default/locale - wb: [420] 87 bytes
May 10 18:31:04 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="24056306161692287191462905064", oauth_timestamp="1462905064", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:04 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:04 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-locale: SUCCESS: config-locale ran successfully
May 10 18:31:04 hircine-tonette [CLOUDINIT] 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
May 10 18:31:04 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="79914991607017511591462905064", oauth_timestamp="1462905064", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:04 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:04 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-set-passwords: running config-set-passwords with frequency once-per-instance
May 10 18:31:04 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_set_passwords - wb: [420] 25 bytes
May 10 18:31:04 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-set-passwords using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_set_passwords'>)
May 10 18:31:04 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="172634474930830926271462905064", oauth_timestamp="1462905064", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:05 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:05 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-set-passwords: SUCCESS: config-set-passwords ran successfully
May 10 18:31:05 hircine-tonette [CLOUDINIT] stages.py[DEBUG]: Running module snappy (<module 'cloudinit.config.cc_snappy' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_snappy.py'>) with frequency once-per-instance
May 10 18:31:05 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="42591895683148853871462905065", oauth_timestamp="1462905065", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:05 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:05 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-snappy: running config-snappy with frequency once-per-instance
May 10 18:31:05 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_snappy - wb: [420] 25 bytes
May 10 18:31:05 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-snappy using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_snappy'>)
May 10 18:31:05 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /etc/system-image/channel.ini (quiet=True)
May 10 18:31:05 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 0 bytes from /etc/system-image/channel.ini
May 10 18:31:05 hircine-tonette [CLOUDINIT] cc_snappy.py[DEBUG]: snappy: 'auto' mode, and system not snappy
May 10 18:31:05 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="167037758642943980121462905065", oauth_timestamp="1462905065", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:05 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:05 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-snappy: SUCCESS: config-snappy ran successfully
May 10 18:31:05 hircine-tonette [CLOUDINIT] 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
May 10 18:31:05 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="35822390506866027221462905065", oauth_timestamp="1462905065", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:05 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:05 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-grub-dpkg: running config-grub-dpkg with frequency once-per-instance
May 10 18:31:05 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_grub_dpkg - wb: [420] 25 bytes
May 10 18:31:05 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-grub-dpkg using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_grub_dpkg'>)
May 10 18:31:05 hircine-tonette [CLOUDINIT] cc_grub_dpkg.py[DEBUG]: Setting grub debconf-set-selections with '/dev/sda','false'
May 10 18:31:05 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Running command ['debconf-set-selections'] with allowed return codes [0] (shell=False, capture=True)
May 10 18:31:06 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="127169180659813634971462905066", oauth_timestamp="1462905066", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:06 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:06 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-grub-dpkg: SUCCESS: config-grub-dpkg ran successfully
May 10 18:31:06 hircine-tonette [CLOUDINIT] 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
May 10 18:31:06 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="165006750690781350541462905066", oauth_timestamp="1462905066", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:07 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:07 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-apt-pipelining: running config-apt-pipelining with frequency once-per-instance
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_apt_pipelining - wb: [420] 25 bytes
May 10 18:31:07 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-apt-pipelining using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_apt_pipelining'>)
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /etc/apt/apt.conf.d/90cloud-init-pipelining - wb: [420] 80 bytes
May 10 18:31:07 hircine-tonette [CLOUDINIT] cc_apt_pipelining.py[DEBUG]: Wrote /etc/apt/apt.conf.d/90cloud-init-pipelining with apt pipeline depth setting 0
May 10 18:31:07 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="109318041433984750371462905067", oauth_timestamp="1462905067", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:07 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:07 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-apt-pipelining: SUCCESS: config-apt-pipelining ran successfully
May 10 18:31:07 hircine-tonette [CLOUDINIT] 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
May 10 18:31:07 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="94455900874015799171462905067", oauth_timestamp="1462905067", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:07 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:07 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-apt-configure: running config-apt-configure with frequency once-per-instance
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_apt_configure - wb: [420] 25 bytes
May 10 18:31:07 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-apt-configure using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_apt_configure'>)
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Running command ['lsb_release', '-cs'] with allowed return codes [0] (shell=False, capture=True)
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Running command ['dpkg', '--print-architecture'] with allowed return codes [0] (shell=False, capture=True)
May 10 18:31:07 hircine-tonette [CLOUDINIT] __init__.py[DEBUG]: filtered distro mirror info: {'primary': 'http://archive.ubuntu.com//ubuntu', 'security': 'http://archive.ubuntu.com//ubuntu'}
May 10 18:31:07 hircine-tonette [CLOUDINIT] cc_apt_configure.py[DEBUG]: Mirror info: {'primary': 'http://archive.ubuntu.com//ubuntu', 'mirror': 'http://archive.ubuntu.com//ubuntu', 'security': 'http://archive.ubuntu.com//ubuntu'}
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /etc/cloud/templates/sources.list.ubuntu.tmpl (quiet=False)
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 2841 bytes from /etc/cloud/templates/sources.list.ubuntu.tmpl
May 10 18:31:07 hircine-tonette [CLOUDINIT] templater.py[DEBUG]: Rendering content of '/etc/cloud/templates/sources.list.ubuntu.tmpl' using renderer jinja
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /etc/apt/sources.list - wb: [420] 3139 bytes
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial_universe_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial_universe_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial_multiverse_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial_multiverse_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial_multiverse_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial_multiverse_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial_restricted_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial_restricted_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial-updates_multiverse_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-updates_multiverse_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial_restricted_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial_restricted_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial-updates_universe_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-updates_universe_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial-updates_restricted_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-updates_restricted_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial_universe_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial_universe_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial-updates_restricted_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-updates_restricted_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial_InRelease to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial_InRelease
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial-updates_main_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-updates_main_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial_main_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial_main_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial-updates_multiverse_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-updates_multiverse_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial-updates_InRelease to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-updates_InRelease
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial_main_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial_main_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial-updates_main_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-updates_main_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_xenial-updates_universe_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-updates_universe_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/security.ubuntu.com_ubuntu_dists_xenial-security_universe_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-security_universe_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/security.ubuntu.com_ubuntu_dists_xenial-security_restricted_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-security_restricted_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/security.ubuntu.com_ubuntu_dists_xenial-security_multiverse_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-security_multiverse_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/security.ubuntu.com_ubuntu_dists_xenial-security_multiverse_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-security_multiverse_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/security.ubuntu.com_ubuntu_dists_xenial-security_restricted_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-security_restricted_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/security.ubuntu.com_ubuntu_dists_xenial-security_main_i18n_Translation-en to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-security_main_i18n_Translation-en
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/security.ubuntu.com_ubuntu_dists_xenial-security_universe_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-security_universe_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/security.ubuntu.com_ubuntu_dists_xenial-security_main_binary-amd64_Packages to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-security_main_binary-amd64_Packages
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Renaming /var/lib/apt/lists/security.ubuntu.com_ubuntu_dists_xenial-security_InRelease to /var/lib/apt/lists/archive.ubuntu.com__ubuntu_dists_xenial-security_InRelease
May 10 18:31:07 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /etc/apt/apt.conf.d/95cloud-init-proxy - wb: [420] 51 bytes
May 10 18:31:07 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="8078321618767285571462905067", oauth_timestamp="1462905067", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:08 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:08 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-apt-configure: SUCCESS: config-apt-configure ran successfully
May 10 18:31:08 hircine-tonette [CLOUDINIT] 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
May 10 18:31:08 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="43827170357902412641462905068", oauth_timestamp="1462905068", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:08 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:08 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-package-update-upgrade-install: running config-package-update-upgrade-install with frequency once-per-instance
May 10 18:31:08 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_package_update_upgrade_install - wb: [420] 24 bytes
May 10 18:31:08 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-package-update-upgrade-install using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_package_update_upgrade_install'>)
May 10 18:31:08 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="100699348737486428521462905068", oauth_timestamp="1462905068", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:08 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:08 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-package-update-upgrade-install: SUCCESS: config-package-update-upgrade-install ran successfully
May 10 18:31:08 hircine-tonette [CLOUDINIT] 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
May 10 18:31:08 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="167664833013650511621462905068", oauth_timestamp="1462905068", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:08 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:08 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-fan: running config-fan with frequency once-per-instance
May 10 18:31:08 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_fan - wb: [420] 25 bytes
May 10 18:31:08 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-fan using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_fan'>)
May 10 18:31:08 hircine-tonette [CLOUDINIT] cc_fan.py[DEBUG]: fan: no 'fan' config entry. disabling
May 10 18:31:08 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="105343912584355928771462905068", oauth_timestamp="1462905068", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:09 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:09 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-fan: SUCCESS: config-fan ran successfully
May 10 18:31:09 hircine-tonette [CLOUDINIT] 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
May 10 18:31:09 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="177436081166304507271462905069", oauth_timestamp="1462905069", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:10 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:10 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-landscape: running config-landscape with frequency once-per-instance
May 10 18:31:10 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_landscape - wb: [420] 25 bytes
May 10 18:31:10 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-landscape using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_landscape'>)
May 10 18:31:10 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="144358318596084967621462905070", oauth_timestamp="1462905070", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:10 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:10 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-landscape: SUCCESS: config-landscape ran successfully
May 10 18:31:10 hircine-tonette [CLOUDINIT] 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
May 10 18:31:10 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="179293764323372685091462905070", oauth_timestamp="1462905070", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:10 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:10 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-timezone: running config-timezone with frequency once-per-instance
May 10 18:31:10 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_timezone - wb: [420] 24 bytes
May 10 18:31:10 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-timezone using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_timezone'>)
May 10 18:31:10 hircine-tonette [CLOUDINIT] cc_timezone.py[DEBUG]: Skipping module named timezone, no 'timezone' specified
May 10 18:31:10 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="55959186688665371331462905070", oauth_timestamp="1462905070", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:10 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:10 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-timezone: SUCCESS: config-timezone ran successfully
May 10 18:31:10 hircine-tonette [CLOUDINIT] 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
May 10 18:31:10 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="164770715309059899261462905070", oauth_timestamp="1462905070", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:11 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:11 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-lxd: running config-lxd with frequency once-per-instance
May 10 18:31:11 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_lxd - wb: [420] 25 bytes
May 10 18:31:11 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-lxd using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_lxd'>)
May 10 18:31:11 hircine-tonette [CLOUDINIT] cc_lxd.py[DEBUG]: Skipping module named %s, not present or disabled by cfg
May 10 18:31:11 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="170088580612547874391462905071", oauth_timestamp="1462905071", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:11 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:11 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-lxd: SUCCESS: config-lxd ran successfully
May 10 18:31:11 hircine-tonette [CLOUDINIT] 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
May 10 18:31:11 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="146764869631595414171462905071", oauth_timestamp="1462905071", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:12 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:12 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-puppet: running config-puppet with frequency once-per-instance
May 10 18:31:12 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_puppet - wb: [420] 25 bytes
May 10 18:31:12 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-puppet using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_puppet'>)
May 10 18:31:12 hircine-tonette [CLOUDINIT] cc_puppet.py[DEBUG]: Skipping module named puppet, no 'puppet' configuration found
May 10 18:31:12 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="121208576378826653091462905072", oauth_timestamp="1462905072", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:12 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:12 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-puppet: SUCCESS: config-puppet ran successfully
May 10 18:31:12 hircine-tonette [CLOUDINIT] stages.py[DEBUG]: Running module chef (<module 'cloudinit.config.cc_chef' from '/usr/lib/python3/dist-packages/cloudinit/config/cc_chef.py'>) with frequency once-per-instance
May 10 18:31:12 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="182187274491343814991462905072", oauth_timestamp="1462905072", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:12 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:12 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-chef: running config-chef with frequency once-per-instance
May 10 18:31:12 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_chef - wb: [420] 25 bytes
May 10 18:31:12 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-chef using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_chef'>)
May 10 18:31:12 hircine-tonette [CLOUDINIT] cc_chef.py[DEBUG]: Skipping module named chef, no 'chef' key in configuration
May 10 18:31:12 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="46773578565305599951462905072", oauth_timestamp="1462905072", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:13 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:13 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-chef: SUCCESS: config-chef ran successfully
May 10 18:31:13 hircine-tonette [CLOUDINIT] 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
May 10 18:31:13 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="52772142201932850991462905073", oauth_timestamp="1462905073", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:13 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:13 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-salt-minion: running config-salt-minion with frequency once-per-instance
May 10 18:31:13 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_salt_minion - wb: [420] 25 bytes
May 10 18:31:13 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-salt-minion using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_salt_minion'>)
May 10 18:31:13 hircine-tonette [CLOUDINIT] cc_salt_minion.py[DEBUG]: Skipping module named salt-minion, no 'salt_minion' key in configuration
May 10 18:31:13 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="165030573996434849241462905073", oauth_timestamp="1462905073", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:13 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:13 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-salt-minion: SUCCESS: config-salt-minion ran successfully
May 10 18:31:13 hircine-tonette [CLOUDINIT] 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
May 10 18:31:13 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="15407480139759679071462905073", oauth_timestamp="1462905073", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:14 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:14 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-mcollective: running config-mcollective with frequency once-per-instance
May 10 18:31:14 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_mcollective - wb: [420] 24 bytes
May 10 18:31:14 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-mcollective using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_mcollective'>)
May 10 18:31:14 hircine-tonette [CLOUDINIT] cc_mcollective.py[DEBUG]: Skipping module named mcollective, no 'mcollective' key in configuration
May 10 18:31:14 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="159062463444884593571462905074", oauth_timestamp="1462905074", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:14 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:14 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-mcollective: SUCCESS: config-mcollective ran successfully
May 10 18:31:14 hircine-tonette [CLOUDINIT] 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 always
May 10 18:31:14 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="50590828085155905301462905074", oauth_timestamp="1462905074", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:14 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:14 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-disable-ec2-metadata: running config-disable-ec2-metadata with frequency always
May 10 18:31:14 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-disable-ec2-metadata using lock (<cloudinit.helpers.DummyLock object at 0x7f20d67acba8>)
May 10 18:31:14 hircine-tonette [CLOUDINIT] cc_disable_ec2_metadata.py[DEBUG]: Skipping module named disable-ec2-metadata, disabling the ec2 route not enabled
May 10 18:31:14 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="152250466781613033271462905074", oauth_timestamp="1462905074", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:15 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:15 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-disable-ec2-metadata: SUCCESS: config-disable-ec2-metadata ran successfully
May 10 18:31:15 hircine-tonette [CLOUDINIT] 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
May 10 18:31:15 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="29583497091876015811462905075", oauth_timestamp="1462905075", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:15 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:15 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-runcmd: running config-runcmd with frequency once-per-instance
May 10 18:31:15 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_runcmd - wb: [420] 24 bytes
May 10 18:31:15 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-runcmd using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_runcmd'>)
May 10 18:31:15 hircine-tonette [CLOUDINIT] cc_runcmd.py[DEBUG]: Skipping module named runcmd, no 'runcmd' key in configuration
May 10 18:31:15 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="31622139848496656941462905075", oauth_timestamp="1462905075", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:15 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:15 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-runcmd: SUCCESS: config-runcmd ran successfully
May 10 18:31:15 hircine-tonette [CLOUDINIT] 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
May 10 18:31:15 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="139928605387349898541462905075", oauth_timestamp="1462905075", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:15 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:15 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-config/config-byobu: running config-byobu with frequency once-per-instance
May 10 18:31:15 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_byobu - wb: [420] 25 bytes
May 10 18:31:15 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-byobu using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_byobu'>)
May 10 18:31:15 hircine-tonette [CLOUDINIT] cc_byobu.py[DEBUG]: Skipping module named byobu, no 'byobu' values found
May 10 18:31:15 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="90222446563554037311462905075", oauth_timestamp="1462905075", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:16 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:16 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config/config-byobu: SUCCESS: config-byobu ran successfully
May 10 18:31:16 hircine-tonette [CLOUDINIT] cloud-init[DEBUG]: Ran 22 modules with 0 failures
May 10 18:31:16 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /proc/uptime (quiet=False)
May 10 18:31:16 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 13 bytes from /proc/uptime
May 10 18:31:16 hircine-tonette [CLOUDINIT] util.py[DEBUG]: cloud-init mode 'modules' took 20.315 seconds (20.32)
May 10 18:31:16 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'method': 'POST', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="111427981831638506181462905076", oauth_timestamp="1462905076", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}} configuration
May 10 18:31:16 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:16 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-config: SUCCESS: running modules for config
May 10 18:31:16 hircine-tonette cloud-init[1657]: Cloud-init v. 0.7.7 running 'modules:config' at Tue, 10 May 2016 18:30:55 +0000. Up 58.27 seconds.
May 10 18:31:16 hircine-tonette systemd[1]: Started Apply the settings specified in cloud-config.
May 10 18:31:16 hircine-tonette systemd[1]: Starting Execute cloud user/final scripts...
May 10 18:31:16 hircine-tonette systemd-timesyncd[1323]: Timed out waiting for reply from 91.189.94.4:123 (ntp.ubuntu.com).
May 10 18:31:16 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Cloud-init v. 0.7.7 running 'modules:final' at Tue, 10 May 2016 18:31:16 +0000. Up 79.26 seconds.
May 10 18:31:16 hircine-tonette [CLOUDINIT] stages.py[DEBUG]: Using distro class <class 'cloudinit.distros.ubuntu.Distro'>
May 10 18:31:16 hircine-tonette [CLOUDINIT] 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
May 10 18:31:16 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="160310467104366967611462905076", oauth_timestamp="1462905076", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:17 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:17 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-rightscale_userdata: running config-rightscale_userdata with frequency once-per-instance
May 10 18:31:17 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_rightscale_userdata - wb: [420] 25 bytes
May 10 18:31:17 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-rightscale_userdata using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_rightscale_userdata'>)
May 10 18:31:17 hircine-tonette [CLOUDINIT] cc_rightscale_userdata.py[DEBUG]: Failed to get raw userdata in module rightscale_userdata
May 10 18:31:17 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="75914751044536946061462905077", oauth_timestamp="1462905077", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:17 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:17 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-rightscale_userdata: SUCCESS: config-rightscale_userdata ran successfully
May 10 18:31:17 hircine-tonette [CLOUDINIT] 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
May 10 18:31:17 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="142720603590669938071462905077", oauth_timestamp="1462905077", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:17 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:17 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-scripts-vendor: running config-scripts-vendor with frequency once-per-instance
May 10 18:31:17 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_scripts_vendor - wb: [420] 25 bytes
May 10 18:31:17 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-scripts-vendor using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_scripts_vendor'>)
May 10 18:31:17 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="88175462338488732291462905077", oauth_timestamp="1462905077", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:17 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:17 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-scripts-vendor: SUCCESS: config-scripts-vendor ran successfully
May 10 18:31:17 hircine-tonette [CLOUDINIT] 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
May 10 18:31:17 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="5975378626884324661462905077", oauth_timestamp="1462905077", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:17 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:17 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-scripts-per-once: running config-scripts-per-once with frequency once
May 10 18:31:17 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/sem/config_scripts_per_once.once - wb: [420] 23 bytes
May 10 18:31:17 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-scripts-per-once using lock (<FileLock using file '/var/lib/cloud/sem/config_scripts_per_once.once'>)
May 10 18:31:17 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="169083437418928499531462905077", oauth_timestamp="1462905077", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:18 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:18 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-scripts-per-once: SUCCESS: config-scripts-per-once ran successfully
May 10 18:31:18 hircine-tonette [CLOUDINIT] 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
May 10 18:31:18 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="105650179876155288091462905078", oauth_timestamp="1462905078", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:18 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:18 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-scripts-per-boot: running config-scripts-per-boot with frequency always
May 10 18:31:18 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-scripts-per-boot using lock (<cloudinit.helpers.DummyLock object at 0x7f656d5ea390>)
May 10 18:31:18 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="168715686490249237661462905078", oauth_timestamp="1462905078", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:19 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:19 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-scripts-per-boot: SUCCESS: config-scripts-per-boot ran successfully
May 10 18:31:19 hircine-tonette [CLOUDINIT] 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
May 10 18:31:19 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="69493975122860321691462905079", oauth_timestamp="1462905079", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:19 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:19 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-scripts-per-instance: running config-scripts-per-instance with frequency once-per-instance
May 10 18:31:19 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_scripts_per_instance - wb: [420] 25 bytes
May 10 18:31:19 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-scripts-per-instance using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_scripts_per_instance'>)
May 10 18:31:19 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="169022892255182213021462905079", oauth_timestamp="1462905079", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:19 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:19 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-scripts-per-instance: SUCCESS: config-scripts-per-instance ran successfully
May 10 18:31:19 hircine-tonette [CLOUDINIT] 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
May 10 18:31:19 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="35303606447321918101462905079", oauth_timestamp="1462905079", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:31:20 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:31:20 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-scripts-user: running config-scripts-user with frequency once-per-instance
May 10 18:31:20 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_scripts_user - wb: [420] 24 bytes
May 10 18:31:20 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-scripts-user using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_scripts_user'>)
May 10 18:31:20 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Running command ['/var/lib/cloud/instance/scripts/user_data.sh'] with allowed return codes [0] (shell=False, capture=False)
May 10 18:31:20 hircine-tonette cloud-init[1772]: Get:1 http://archive.ubuntu.com//ubuntu xenial InRelease [247 kB]
May 10 18:31:20 hircine-tonette cloud-init[1772]: Get:2 http://archive.ubuntu.com//ubuntu xenial-updates InRelease [94.5 kB]
May 10 18:31:20 hircine-tonette cloud-init[1772]: Get:3 http://archive.ubuntu.com//ubuntu xenial-backports InRelease [82.2 kB]
May 10 18:31:21 hircine-tonette cloud-init[1772]: Get:4 http://archive.ubuntu.com//ubuntu xenial-security InRelease [93.3 kB]
May 10 18:31:21 hircine-tonette cloud-init[1772]: Get:5 http://archive.ubuntu.com//ubuntu xenial/main Sources [868 kB]
May 10 18:31:21 hircine-tonette cloud-init[1772]: Get:6 http://archive.ubuntu.com//ubuntu xenial/restricted Sources [4808 B]
May 10 18:31:21 hircine-tonette cloud-init[1772]: Get:7 http://archive.ubuntu.com//ubuntu xenial/universe Sources [7728 kB]
May 10 18:31:22 hircine-tonette cloud-init[1772]: Get:8 http://archive.ubuntu.com//ubuntu xenial/multiverse Sources [179 kB]
May 10 18:31:22 hircine-tonette cloud-init[1772]: Get:9 http://archive.ubuntu.com//ubuntu xenial/main amd64 Packages [1201 kB]
May 10 18:31:22 hircine-tonette cloud-init[1772]: Get:10 http://archive.ubuntu.com//ubuntu xenial/main Translation-en [568 kB]
May 10 18:31:22 hircine-tonette cloud-init[1772]: Get:11 http://archive.ubuntu.com//ubuntu xenial/universe amd64 Packages [7532 kB]
May 10 18:31:22 hircine-tonette cloud-init[1772]: Get:12 http://archive.ubuntu.com//ubuntu xenial/universe Translation-en [4354 kB]
May 10 18:31:23 hircine-tonette cloud-init[1772]: Get:13 http://archive.ubuntu.com//ubuntu xenial/multiverse amd64 Packages [144 kB]
May 10 18:31:23 hircine-tonette cloud-init[1772]: Get:14 http://archive.ubuntu.com//ubuntu xenial/multiverse Translation-en [106 kB]
May 10 18:31:23 hircine-tonette cloud-init[1772]: Get:15 http://archive.ubuntu.com//ubuntu xenial-updates/main Sources [20.9 kB]
May 10 18:31:23 hircine-tonette cloud-init[1772]: Get:16 http://archive.ubuntu.com//ubuntu xenial-updates/restricted Sources [64 B]
May 10 18:31:23 hircine-tonette cloud-init[1772]: Get:17 http://archive.ubuntu.com//ubuntu xenial-updates/universe Sources [5464 B]
May 10 18:31:23 hircine-tonette cloud-init[1772]: Get:18 http://archive.ubuntu.com//ubuntu xenial-updates/multiverse Sources [64 B]
May 10 18:31:23 hircine-tonette cloud-init[1772]: Get:19 http://archive.ubuntu.com//ubuntu xenial-updates/main amd64 Packages [64.3 kB]
May 10 18:31:23 hircine-tonette cloud-init[1772]: Get:20 http://archive.ubuntu.com//ubuntu xenial-updates/main Translation-en [25.9 kB]
May 10 18:31:23 hircine-tonette cloud-init[1772]: Get:21 http://archive.ubuntu.com//ubuntu xenial-updates/universe amd64 Packages [15.0 kB]
May 10 18:31:23 hircine-tonette cloud-init[1772]: Get:22 http://archive.ubuntu.com//ubuntu xenial-updates/universe Translation-en [11.7 kB]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:23 http://archive.ubuntu.com//ubuntu xenial-backports/main Sources [28 B]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:24 http://archive.ubuntu.com//ubuntu xenial-backports/restricted Sources [28 B]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:25 http://archive.ubuntu.com//ubuntu xenial-backports/universe Sources [28 B]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:26 http://archive.ubuntu.com//ubuntu xenial-backports/multiverse Sources [28 B]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:27 http://archive.ubuntu.com//ubuntu xenial-backports/main amd64 Packages [28 B]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:28 http://archive.ubuntu.com//ubuntu xenial-backports/main Translation-en [28 B]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:29 http://archive.ubuntu.com//ubuntu xenial-backports/restricted amd64 Packages [28 B]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:30 http://archive.ubuntu.com//ubuntu xenial-backports/restricted Translation-en [28 B]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:31 http://archive.ubuntu.com//ubuntu xenial-backports/universe amd64 Packages [28 B]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:32 http://archive.ubuntu.com//ubuntu xenial-backports/universe Translation-en [28 B]
May 10 18:31:24 hircine-tonette cloud-init[1772]: Get:33 http://archive.ubuntu.com//ubuntu xenial-backports/multiverse amd64 Packages [28 B]
May 10 18:31:25 hircine-tonette cloud-init[1772]: Get:34 http://archive.ubuntu.com//ubuntu xenial-backports/multiverse Translation-en [28 B]
May 10 18:31:25 hircine-tonette cloud-init[1772]: Get:35 http://archive.ubuntu.com//ubuntu xenial-security/main Sources [11.6 kB]
May 10 18:31:25 hircine-tonette cloud-init[1772]: Get:36 http://archive.ubuntu.com//ubuntu xenial-security/restricted Sources [64 B]
May 10 18:31:25 hircine-tonette cloud-init[1772]: Get:37 http://archive.ubuntu.com//ubuntu xenial-security/universe Sources [3176 B]
May 10 18:31:25 hircine-tonette cloud-init[1772]: Get:38 http://archive.ubuntu.com//ubuntu xenial-security/multiverse Sources [64 B]
May 10 18:31:25 hircine-tonette cloud-init[1772]: Get:39 http://archive.ubuntu.com//ubuntu xenial-security/main amd64 Packages [48.5 kB]
May 10 18:31:25 hircine-tonette cloud-init[1772]: Get:40 http://archive.ubuntu.com//ubuntu xenial-security/main Translation-en [17.9 kB]
May 10 18:31:25 hircine-tonette cloud-init[1772]: Get:41 http://archive.ubuntu.com//ubuntu xenial-security/universe amd64 Packages [6076 B]
May 10 18:31:25 hircine-tonette cloud-init[1772]: Get:42 http://archive.ubuntu.com//ubuntu xenial-security/universe Translation-en [5212 B]
May 10 18:31:26 hircine-tonette systemd-timesyncd[1323]: Timed out waiting for reply from 91.189.89.199:123 (ntp.ubuntu.com).
May 10 18:31:27 hircine-tonette cloud-init[1772]: Fetched 23.4 MB in 5s (4235 kB/s)
May 10 18:31:28 hircine-tonette cloud-init[1772]: Reading package lists...
May 10 18:31:28 hircine-tonette cloud-init[1772]: Reading package lists...
May 10 18:31:28 hircine-tonette cloud-init[1772]: Building dependency tree...
May 10 18:31:28 hircine-tonette cloud-init[1772]: Reading state information...
May 10 18:31:28 hircine-tonette cloud-init[1772]: python3-oauthlib is already the newest version (1.0.3-1).
May 10 18:31:28 hircine-tonette cloud-init[1772]: python3-yaml is already the newest version (3.11-3build1).
May 10 18:31:28 hircine-tonette cloud-init[1772]: The following additional packages will be installed:
May 10 18:31:28 hircine-tonette cloud-init[1772]:   freeipmi-common libfreeipmi16 libipmiconsole2 libipmidetect0 libopenipmi0
May 10 18:31:28 hircine-tonette cloud-init[1772]:   libsensors4 libsnmp-base libsnmp30
May 10 18:31:28 hircine-tonette cloud-init[1772]: Suggested packages:
May 10 18:31:28 hircine-tonette cloud-init[1772]:   freeipmi-ipmidetect freeipmi-bmc-watchdog lm-sensors snmp-mibs-downloader
May 10 18:31:28 hircine-tonette cloud-init[1772]: The following NEW packages will be installed:
May 10 18:31:28 hircine-tonette cloud-init[1772]:   freeipmi-common freeipmi-tools ipmitool libfreeipmi16 libipmiconsole2
May 10 18:31:28 hircine-tonette cloud-init[1772]:   libipmidetect0 libopenipmi0 libsensors4 libsnmp-base libsnmp30 openipmi
May 10 18:31:29 hircine-tonette cloud-init[1772]: 0 upgraded, 11 newly installed, 0 to remove and 23 not upgraded.
May 10 18:31:29 hircine-tonette cloud-init[1772]: Need to get 3743 kB of archives.
May 10 18:31:29 hircine-tonette cloud-init[1772]: After this operation, 16.9 MB of additional disk space will be used.
May 10 18:31:29 hircine-tonette cloud-init[1772]: Get:1 http://archive.ubuntu.com//ubuntu xenial/main amd64 freeipmi-common all 1.4.11-1ubuntu1 [175 kB]
May 10 18:31:29 hircine-tonette cloud-init[1772]: Get:2 http://archive.ubuntu.com//ubuntu xenial/main amd64 libfreeipmi16 amd64 1.4.11-1ubuntu1 [824 kB]
May 10 18:31:29 hircine-tonette cloud-init[1772]: Get:3 http://archive.ubuntu.com//ubuntu xenial/universe amd64 ipmitool amd64 1.8.16-3 [386 kB]
May 10 18:31:29 hircine-tonette cloud-init[1772]: Get:4 http://archive.ubuntu.com//ubuntu xenial/main amd64 libopenipmi0 amd64 2.0.18-0ubuntu11 [438 kB]
May 10 18:31:29 hircine-tonette cloud-init[1772]: Get:5 http://archive.ubuntu.com//ubuntu xenial/main amd64 libsensors4 amd64 1:3.4.0-2 [28.4 kB]
May 10 18:31:30 hircine-tonette cloud-init[1772]: Get:6 http://archive.ubuntu.com//ubuntu xenial/main amd64 libsnmp-base all 5.7.3+dfsg-1ubuntu4 [224 kB]
May 10 18:31:30 hircine-tonette cloud-init[1772]: Get:7 http://archive.ubuntu.com//ubuntu xenial/main amd64 libsnmp30 amd64 5.7.3+dfsg-1ubuntu4 [813 kB]
May 10 18:31:30 hircine-tonette cloud-init[1772]: Get:8 http://archive.ubuntu.com//ubuntu xenial/main amd64 openipmi amd64 2.0.18-0ubuntu11 [127 kB]
May 10 18:31:30 hircine-tonette cloud-init[1772]: Get:9 http://archive.ubuntu.com//ubuntu xenial/main amd64 libipmiconsole2 amd64 1.4.11-1ubuntu1 [85.0 kB]
May 10 18:31:30 hircine-tonette cloud-init[1772]: Get:10 http://archive.ubuntu.com//ubuntu xenial/main amd64 libipmidetect0 amd64 1.4.11-1ubuntu1 [25.3 kB]
May 10 18:31:30 hircine-tonette cloud-init[1772]: Get:11 http://archive.ubuntu.com//ubuntu xenial/main amd64 freeipmi-tools amd64 1.4.11-1ubuntu1 [618 kB]
May 10 18:31:30 hircine-tonette cloud-init[1772]: Fetched 3743 kB in 1s (2327 kB/s)
May 10 18:31:30 hircine-tonette cloud-init[1772]: Selecting previously unselected package freeipmi-common.
May 10 18:31:31 hircine-tonette cloud-init[1772]: (Reading database ... #015(Reading database ... 5%#015(Reading database ... 10%#015(Reading database ... 15%#015(Reading database ... 20%#015(Reading database ... 25%#015(Reading database ... 30%#015(Reading database ... 35%#015(Reading database ... 40%#015(Reading database ... 45%#015(Reading database ... 50%#015(Reading database ... 55%#015(Reading database ... 60%#015(Reading database ... 65%#015(Reading database ... 70%#015(Reading database ... 75%#015(Reading database ... 80%#015(Reading database ... 85%#015(Reading database ... 90%#015(Reading database ... 95%#015(Reading database ... 100%#015(Reading database ... 25401 files and directories currently installed.)
May 10 18:31:31 hircine-tonette cloud-init[1772]: Preparing to unpack .../freeipmi-common_1.4.11-1ubuntu1_all.deb ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Unpacking freeipmi-common (1.4.11-1ubuntu1) ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Selecting previously unselected package libfreeipmi16.
May 10 18:31:31 hircine-tonette cloud-init[1772]: Preparing to unpack .../libfreeipmi16_1.4.11-1ubuntu1_amd64.deb ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Unpacking libfreeipmi16 (1.4.11-1ubuntu1) ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Selecting previously unselected package ipmitool.
May 10 18:31:31 hircine-tonette cloud-init[1772]: Preparing to unpack .../ipmitool_1.8.16-3_amd64.deb ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Unpacking ipmitool (1.8.16-3) ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Selecting previously unselected package libopenipmi0.
May 10 18:31:31 hircine-tonette cloud-init[1772]: Preparing to unpack .../libopenipmi0_2.0.18-0ubuntu11_amd64.deb ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Unpacking libopenipmi0 (2.0.18-0ubuntu11) ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Selecting previously unselected package libsensors4:amd64.
May 10 18:31:31 hircine-tonette cloud-init[1772]: Preparing to unpack .../libsensors4_1%3a3.4.0-2_amd64.deb ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Unpacking libsensors4:amd64 (1:3.4.0-2) ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Selecting previously unselected package libsnmp-base.
May 10 18:31:31 hircine-tonette cloud-init[1772]: Preparing to unpack .../libsnmp-base_5.7.3+dfsg-1ubuntu4_all.deb ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Unpacking libsnmp-base (5.7.3+dfsg-1ubuntu4) ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Selecting previously unselected package libsnmp30:amd64.
May 10 18:31:31 hircine-tonette cloud-init[1772]: Preparing to unpack .../libsnmp30_5.7.3+dfsg-1ubuntu4_amd64.deb ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Unpacking libsnmp30:amd64 (5.7.3+dfsg-1ubuntu4) ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Selecting previously unselected package openipmi.
May 10 18:31:31 hircine-tonette cloud-init[1772]: Preparing to unpack .../openipmi_2.0.18-0ubuntu11_amd64.deb ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Unpacking openipmi (2.0.18-0ubuntu11) ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Selecting previously unselected package libipmiconsole2.
May 10 18:31:31 hircine-tonette cloud-init[1772]: Preparing to unpack .../libipmiconsole2_1.4.11-1ubuntu1_amd64.deb ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Unpacking libipmiconsole2 (1.4.11-1ubuntu1) ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Selecting previously unselected package libipmidetect0.
May 10 18:31:31 hircine-tonette cloud-init[1772]: Preparing to unpack .../libipmidetect0_1.4.11-1ubuntu1_amd64.deb ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Unpacking libipmidetect0 (1.4.11-1ubuntu1) ...
May 10 18:31:31 hircine-tonette cloud-init[1772]: Selecting previously unselected package freeipmi-tools.
May 10 18:31:32 hircine-tonette cloud-init[1772]: Preparing to unpack .../freeipmi-tools_1.4.11-1ubuntu1_amd64.deb ...
May 10 18:31:32 hircine-tonette cloud-init[1772]: Unpacking freeipmi-tools (1.4.11-1ubuntu1) ...
May 10 18:31:32 hircine-tonette cloud-init[1772]: Processing triggers for install-info (6.1.0.dfsg.1-5) ...
May 10 18:31:32 hircine-tonette cloud-init[1772]: Processing triggers for man-db (2.7.5-1) ...
May 10 18:31:32 hircine-tonette cloud-init[1772]: Processing triggers for libc-bin (2.23-0ubuntu3) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Processing triggers for ureadahead (0.100.0-19) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Processing triggers for systemd (229-4ubuntu4) ...
May 10 18:31:34 hircine-tonette systemd[1]: Reloading.
May 10 18:31:34 hircine-tonette systemd[1]: Started ACPI event daemon.
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up freeipmi-common (1.4.11-1ubuntu1) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up libfreeipmi16 (1.4.11-1ubuntu1) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up ipmitool (1.8.16-3) ...
May 10 18:31:34 hircine-tonette systemd[1]: Reloading.
May 10 18:31:34 hircine-tonette systemd[1]: Started ACPI event daemon.
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up libopenipmi0 (2.0.18-0ubuntu11) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up libsensors4:amd64 (1:3.4.0-2) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up libsnmp-base (5.7.3+dfsg-1ubuntu4) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up libsnmp30:amd64 (5.7.3+dfsg-1ubuntu4) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up openipmi (2.0.18-0ubuntu11) ...
May 10 18:31:34 hircine-tonette systemd[1]: Reloading.
May 10 18:31:34 hircine-tonette systemd[1]: Started ACPI event daemon.
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up libipmiconsole2 (1.4.11-1ubuntu1) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up libipmidetect0 (1.4.11-1ubuntu1) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Setting up freeipmi-tools (1.4.11-1ubuntu1) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Processing triggers for libc-bin (2.23-0ubuntu3) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Processing triggers for ureadahead (0.100.0-19) ...
May 10 18:31:34 hircine-tonette cloud-init[1772]: Processing triggers for systemd (229-4ubuntu4) ...
May 10 18:31:34 hircine-tonette systemd[1]: Reloading.
May 10 18:31:34 hircine-tonette systemd[1]: Started ACPI event daemon.
May 10 18:31:35 hircine-tonette kernel: [   98.370158] ipmi device interface
May 10 18:31:35 hircine-tonette kernel: [   98.410843] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.411172] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.411317] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.411450] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.411754] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.411888] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.412048] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.412418] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.412552] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.412684] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.412965] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.413098] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.413231] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.413511] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.413645] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.413783] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.414065] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.414199] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.414331] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.414612] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.414745] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.414877] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.415158] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.415291] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.415423] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.415704] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.415838] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.415986] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.416319] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.416454] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.416592] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.416874] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.417007] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.417139] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.417420] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.417554] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.417686] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.417966] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.418100] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.418232] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.418512] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.418646] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.418778] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.419058] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.419192] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.419329] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.419611] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.419744] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.419877] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.420191] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.420390] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.420523] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.420802] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.420935] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.421067] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.421345] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.421479] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.421610] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.421888] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:35 hircine-tonette kernel: [   98.422022] x86/PAT: ipmi-locate:3094 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.639460] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.639786] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.639953] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.640138] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.640452] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.640587] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.640719] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.641001] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.641134] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.641266] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.641546] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.641679] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.641811] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.642091] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.642224] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.642363] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.642643] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.642777] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.642909] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.645681] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.645890] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.646023] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.646304] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.646437] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.646569] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.646849] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.646982] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.647114] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.647394] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.647527] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.647665] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.647967] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.648113] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.648249] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.648533] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.648667] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.648799] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.649079] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.649212] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.649344] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.649621] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.649754] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.649886] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.650164] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.650297] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.650435] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.650713] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.650846] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.650978] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.651256] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.651389] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.651521] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.651798] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.651946] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.652124] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.652417] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.652551] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.652683] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0x00000000-0x00000fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.652963] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:36 hircine-tonette kernel: [   99.653096] x86/PAT: ipmi-locate:3110 map pfn expected mapping type uncached-minus for [mem 0xbf770000-0xbf770fff], got write-back
May 10 18:31:37 hircine-tonette cloud-init[1772]: Success
May 10 18:31:38 hircine-tonette cloud-init[1772]: Success
May 10 18:31:38 hircine-tonette sudo:     root : unable to resolve host hircine-tonette
May 10 18:31:38 hircine-tonette sudo:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/lshw -xml
May 10 18:31:38 hircine-tonette sudo: pam_unix(sudo:session): session opened for user root by (uid=0)
May 10 18:31:39 hircine-tonette sudo: pam_unix(sudo:session): session closed for user root
May 10 18:31:39 hircine-tonette cloud-init[1772]: Success
May 10 18:31:40 hircine-tonette cloud-init[1772]: message repeated 3 times: [ Success]
May 10 18:31:42 hircine-tonette systemd[1]: Reloading.
May 10 18:31:42 hircine-tonette systemd[1]: Started ACPI event daemon.
May 10 18:31:42 hircine-tonette groupadd[3454]: group added to /etc/group: name=_lldpd, GID=116
May 10 18:31:42 hircine-tonette groupadd[3454]: group added to /etc/gshadow: name=_lldpd
May 10 18:31:42 hircine-tonette groupadd[3454]: new group: name=_lldpd, GID=116
May 10 18:31:42 hircine-tonette useradd[3458]: new user: name=_lldpd, UID=112, GID=116, home=/var/run/lldpd, shell=/bin/false
May 10 18:31:42 hircine-tonette chage[3463]: changed password expiry for _lldpd
May 10 18:31:42 hircine-tonette systemd[1]: Reloading.
May 10 18:31:42 hircine-tonette systemd[1]: Started ACPI event daemon.
May 10 18:31:42 hircine-tonette systemd[1]: Reloading.
May 10 18:31:42 hircine-tonette systemd[1]: Started ACPI event daemon.
May 10 18:31:42 hircine-tonette systemd[1]: Reloading.
May 10 18:31:42 hircine-tonette systemd[1]: Started ACPI event daemon.
May 10 18:31:43 hircine-tonette systemd[1]: Reloading.
May 10 18:31:43 hircine-tonette systemd[1]: Started ACPI event daemon.
May 10 18:31:43 hircine-tonette systemd[1]: Stopped LLDP daemon.
May 10 18:31:43 hircine-tonette systemd[1]: Starting LLDP daemon...
May 10 18:31:43 hircine-tonette systemd[1]: Started LLDP daemon.
May 10 18:31:43 hircine-tonette lldpd[3617]: created chroot directory /var/run/lldpd
May 10 18:31:43 hircine-tonette lldpd[3617]: /etc/localtime copied to chroot
May 10 18:31:43 hircine-tonette lldpd[3617]: protocol LLDP enabled
May 10 18:31:43 hircine-tonette lldpd[3617]: protocol CDPv1 enabled
May 10 18:31:43 hircine-tonette lldpd[3617]: protocol CDPv2 enabled
May 10 18:31:43 hircine-tonette lldpd[3617]: protocol SONMP enabled
May 10 18:31:43 hircine-tonette lldpd[3617]: protocol EDP enabled
May 10 18:31:43 hircine-tonette lldpd[3617]: protocol FDP enabled
May 10 18:31:43 hircine-tonette lldpd[3617]: libevent 2.0.21-stable initialized with epoll method
May 10 18:31:43 hircine-tonette lldpcli[3616]: cannot find configuration file/directory /etc/lldpd.conf: No such file or directory
May 10 18:31:43 hircine-tonette lldpd[3612]: unable to get system name
May 10 18:31:43 hircine-tonette lldpd[3612]: unable to get system name
May 10 18:31:43 hircine-tonette lldpcli[3616]: lldpd should resume operations
May 10 18:31:44 hircine-tonette cloud-init[1772]: Success
May 10 18:31:45 hircine-tonette kernel: [  107.723184] IPv6: ADDRCONF(NETDEV_UP): enp2s0: link is not ready
May 10 18:31:44 hircine-tonette cloud-init[1772]: message repeated 3 times: [ Success]
May 10 18:31:45 hircine-tonette dhclient[3630]: DHCPDISCOVER on enp2s0 to 255.255.255.255 port 67 interval 3 (xid=0xff45aa20)
May 10 18:31:45 hircine-tonette cloud-init[1772]: Success
May 10 18:31:45 hircine-tonette cloud-init[1772]: Success
May 10 18:31:45 hircine-tonette sudo:     root : unable to resolve host hircine-tonette
May 10 18:31:45 hircine-tonette sudo:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/blockdev --getsize64 /dev/sda
May 10 18:31:45 hircine-tonette sudo: pam_unix(sudo:session): session opened for user root by (uid=0)
May 10 18:31:45 hircine-tonette sudo: pam_unix(sudo:session): session closed for user root
May 10 18:31:45 hircine-tonette sudo:     root : unable to resolve host hircine-tonette
May 10 18:31:45 hircine-tonette sudo:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/blockdev --getbsz /dev/sda
May 10 18:31:45 hircine-tonette sudo: pam_unix(sudo:session): session opened for user root by (uid=0)
May 10 18:31:45 hircine-tonette sudo: pam_unix(sudo:session): session closed for user root
May 10 18:31:45 hircine-tonette sudo:     root : unable to resolve host hircine-tonette
May 10 18:31:45 hircine-tonette sudo:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/blockdev --getsize64 /dev/sdb
May 10 18:31:45 hircine-tonette sudo: pam_unix(sudo:session): session opened for user root by (uid=0)
May 10 18:31:45 hircine-tonette sudo: pam_unix(sudo:session): session closed for user root
May 10 18:31:45 hircine-tonette sudo:     root : unable to resolve host hircine-tonette
May 10 18:31:45 hircine-tonette sudo:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/blockdev --getbsz /dev/sdb
May 10 18:31:45 hircine-tonette sudo: pam_unix(sudo:session): session opened for user root by (uid=0)
May 10 18:31:45 hircine-tonette sudo: pam_unix(sudo:session): session closed for user root
May 10 18:31:45 hircine-tonette cloud-init[1772]: Success
May 10 18:31:48 hircine-tonette kernel: [  110.757204] e1000e: enp2s0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: None
May 10 18:31:48 hircine-tonette kernel: [  110.757514] IPv6: ADDRCONF(NETDEV_CHANGE): enp2s0: link becomes ready
May 10 18:31:46 hircine-tonette cloud-init[1772]: Success
May 10 18:31:48 hircine-tonette dhclient[3635]: DHCPDISCOVER on enp2s0 to 255.255.255.255 port 67 interval 4 (xid=0xff45aa20)
May 10 18:31:52 hircine-tonette dhclient[3635]: DHCPDISCOVER on enp2s0 to 255.255.255.255 port 67 interval 5 (xid=0xff45aa20)
May 10 18:31:53 hircine-tonette dhclient[3635]: DHCPREQUEST of 10.245.136.23 on enp2s0 to 255.255.255.255 port 67 (xid=0x20aa45ff)
May 10 18:31:53 hircine-tonette dhclient[3635]: DHCPOFFER of 10.245.136.23 from 10.245.136.6
May 10 18:31:53 hircine-tonette dhclient[3635]: DHCPACK of 10.245.136.23 from 10.245.136.6
May 10 18:31:53 hircine-tonette dhclient[3635]: bound to 10.245.136.23 -- renewal in 283 seconds.
May 10 18:32:41 hircine-tonette systemd-timesyncd[1323]: Timed out waiting for reply from 91.189.89.199:123 (ntp.ubuntu.com).
May 10 18:32:44 hircine-tonette cloud-init[1772]: Success
May 10 18:32:45 hircine-tonette cloud-init[1772]: message repeated 4 times: [ Success]
May 10 18:32:51 hircine-tonette systemd-timesyncd[1323]: Timed out waiting for reply from 91.189.94.4:123 (ntp.ubuntu.com).
May 10 18:33:50 hircine-tonette cloud-init[1772]: request to http://10.245.136.6/MAAS/metadata//2012-03-01/ failed. sleeping 1.: HTTP Error 400: BAD REQUEST
May 10 18:33:50 hircine-tonette cloud-init[1772]: request to http://10.245.136.6/MAAS/metadata//2012-03-01/ failed. sleeping 1.: HTTP Error 400: BAD REQUEST
May 10 18:33:50 hircine-tonette cloud-init[1772]: request to http://10.245.136.6/MAAS/metadata//2012-03-01/ failed. sleeping 2.: HTTP Error 400: BAD REQUEST
May 10 18:33:50 hircine-tonette cloud-init[1772]: request to http://10.245.136.6/MAAS/metadata//2012-03-01/ failed. sleeping 4.: HTTP Error 400: BAD REQUEST
May 10 18:33:50 hircine-tonette cloud-init[1772]: request to http://10.245.136.6/MAAS/metadata//2012-03-01/ failed. sleeping 8.: HTTP Error 400: BAD REQUEST
May 10 18:33:50 hircine-tonette cloud-init[1772]: request to http://10.245.136.6/MAAS/metadata//2012-03-01/ failed. sleeping 16.: HTTP Error 400: BAD REQUEST
May 10 18:33:50 hircine-tonette cloud-init[1772]: request to http://10.245.136.6/MAAS/metadata//2012-03-01/ failed. sleeping 32.: HTTP Error 400: BAD REQUEST
May 10 18:33:50 hircine-tonette cloud-init[1772]: http error [400]
May 10 18:33:50 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="63815968446942458761462905230", oauth_timestamp="1462905230", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:50 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:50 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-scripts-user: SUCCESS: config-scripts-user ran successfully
May 10 18:33:50 hircine-tonette [CLOUDINIT] 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
May 10 18:33:50 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="130375109536954313551462905230", oauth_timestamp="1462905230", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:50 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:50 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-ssh-authkey-fingerprints: running config-ssh-authkey-fingerprints with frequency once-per-instance
May 10 18:33:50 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_ssh_authkey_fingerprints - wb: [420] 25 bytes
May 10 18:33:50 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-ssh-authkey-fingerprints using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_ssh_authkey_fingerprints'>)
May 10 18:33:50 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /etc/ssh/sshd_config (quiet=False)
May 10 18:33:50 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 2540 bytes from /etc/ssh/sshd_config
May 10 18:33:50 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /home/ubuntu/.ssh/authorized_keys (quiet=False)
May 10 18:33:50 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 398 bytes from /home/ubuntu/.ssh/authorized_keys
May 10 18:33:50 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="81653182597294857771462905230", oauth_timestamp="1462905230", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:50 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:50 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-ssh-authkey-fingerprints: SUCCESS: config-ssh-authkey-fingerprints ran successfully
May 10 18:33:50 hircine-tonette [CLOUDINIT] 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
May 10 18:33:50 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="44270462135365773871462905230", oauth_timestamp="1462905230", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:51 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-keys-to-console: running config-keys-to-console with frequency once-per-instance
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_keys_to_console - wb: [420] 24 bytes
May 10 18:33:51 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-keys-to-console using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_keys_to_console'>)
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Running command ['/usr/lib/cloud-init/write-ssh-key-fingerprints', '', 'ssh-dss'] with allowed return codes [0] (shell=False, capture=True)
May 10 18:33:51 hircine-tonette ec2: 
May 10 18:33:51 hircine-tonette ec2: #############################################################
May 10 18:33:51 hircine-tonette ec2: -----BEGIN SSH HOST KEY FINGERPRINTS-----
May 10 18:33:51 hircine-tonette ec2: 1024 SHA256:ZP3OoaNZhhWB6pPOcPkiRJ+vv4A3nSDvF2BEV41fKjA root@hircine-tonette (DSA)
May 10 18:33:51 hircine-tonette ec2: 256 SHA256:ghkZJGYh3iOGQI2AXqFdr7kCp/N9lk0t8mObb0Jg7hM root@hircine-tonette (ECDSA)
May 10 18:33:51 hircine-tonette ec2: 256 SHA256:p62eh54gspUlDSXr/EmaGM+n9PD/S4j7ZAzOOiqJs7Q root@hircine-tonette (ED25519)
May 10 18:33:51 hircine-tonette ec2: 2048 SHA256:lCeqNXOH0dS/OTXA9+4N1z6ASlRpzH2Fu3kLvVMt00g root@hircine-tonette (RSA)
May 10 18:33:51 hircine-tonette ec2: -----END SSH HOST KEY FINGERPRINTS-----
May 10 18:33:51 hircine-tonette ec2: #############################################################
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="175146720730034668351462905231", oauth_timestamp="1462905231", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:51 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-keys-to-console: SUCCESS: config-keys-to-console ran successfully
May 10 18:33:51 hircine-tonette [CLOUDINIT] 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
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="127970718698176110981462905231", oauth_timestamp="1462905231", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:51 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-phone-home: running config-phone-home with frequency once-per-instance
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_phone_home - wb: [420] 25 bytes
May 10 18:33:51 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-phone-home using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_phone_home'>)
May 10 18:33:51 hircine-tonette [CLOUDINIT] cc_phone_home.py[DEBUG]: Skipping module named phone-home, no 'phone_home' configuration found
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="86400740009597683631462905231", oauth_timestamp="1462905231", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:51 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-phone-home: SUCCESS: config-phone-home ran successfully
May 10 18:33:51 hircine-tonette [CLOUDINIT] 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
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="129356664148127628881462905231", oauth_timestamp="1462905231", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:51 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-final-message: running config-final-message with frequency always
May 10 18:33:51 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-final-message using lock (<cloudinit.helpers.DummyLock object at 0x7f65724bd0b8>)
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /proc/uptime (quiet=False)
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 15 bytes from /proc/uptime
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Cloud-init v. 0.7.7 finished at Tue, 10 May 2016 18:33:51 +0000. Datasource DataSourceMAAS [http://10.245.136.6/MAAS/metadata/].  Up 234.07 seconds
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instance/boot-finished - wb: [420] 52 bytes
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="167694315146694467031462905231", oauth_timestamp="1462905231", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:51 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-final-message: SUCCESS: config-final-message ran successfully
May 10 18:33:51 hircine-tonette [CLOUDINIT] 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
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="102501135400364026731462905231", oauth_timestamp="1462905231", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:51 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: start: modules-final/config-power-state-change: running config-power-state-change with frequency once-per-instance
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Writing to /var/lib/cloud/instances/4y3h7s/sem/config_power_state_change - wb: [420] 25 bytes
May 10 18:33:51 hircine-tonette [CLOUDINIT] helpers.py[DEBUG]: Running config-power-state-change using lock (<FileLock using file '/var/lib/cloud/instances/4y3h7s/sem/config_power_state_change'>)
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /proc/1772/cmdline (quiet=False)
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 58 bytes from /proc/1772/cmdline
May 10 18:33:51 hircine-tonette [CLOUDINIT] cc_power_state_change.py[DEBUG]: After pid 1772 ends, will execute: shutdown -P now
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Forked child 3706 who will run callback run_after_pid_gone
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /proc/1772/cmdline (quiet=False)
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 58 bytes from /proc/1772/cmdline
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="130932658410667689881462905231", oauth_timestamp="1462905231", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:51 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final/config-power-state-change: SUCCESS: config-power-state-change ran successfully
May 10 18:33:51 hircine-tonette [CLOUDINIT] cloud-init[DEBUG]: Ran 11 modules with 0 failures
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Creating symbolic link from '/run/cloud-init/result.json' => '../../var/lib/cloud/data/result.json'
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /proc/uptime (quiet=False)
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Read 15 bytes from /proc/uptime
May 10 18:33:51 hircine-tonette [CLOUDINIT] util.py[DEBUG]: cloud-init mode 'modules' took 155.162 seconds (155.16)
May 10 18:33:51 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: [0/1] open 'http://10.245.136.6/MAAS/metadata/status/4y3h7s' with {'url': 'http://10.245.136.6/MAAS/metadata/status/4y3h7s', 'allow_redirects': True, 'headers': {'Authorization': 'OAuth oauth_nonce="96098090659008960641462905231", oauth_timestamp="1462905231", oauth_version="1.0", oauth_signature_method="PLAINTEXT", oauth_consumer_key="yPyg7nfU5tk5hEnTRn", oauth_token="cKKZEHSAYEgLGFEgqY", oauth_signature="%265yLxHAAytSDfZ4SRDp2n46tPtBX6DDyj"'}, 'method': 'POST'} configuration
May 10 18:33:52 hircine-tonette [CLOUDINIT] url_helper.py[DEBUG]: Read from http://10.245.136.6/MAAS/metadata/status/4y3h7s (200, 2b) after 1 attempts
May 10 18:33:52 hircine-tonette [CLOUDINIT] handlers.py[DEBUG]: finish: modules-final: SUCCESS: running modules for final
May 10 18:33:52 hircine-tonette cloud-init[1772]: Cloud-init v. 0.7.7 running 'modules:final' at Tue, 10 May 2016 18:31:16 +0000. Up 79.26 seconds.
May 10 18:33:52 hircine-tonette cloud-init[1772]: Cloud-init v. 0.7.7 finished at Tue, 10 May 2016 18:33:51 +0000. Datasource DataSourceMAAS [http://10.245.136.6/MAAS/metadata/].  Up 234.07 seconds
May 10 18:33:52 hircine-tonette systemd[1]: Started Execute cloud user/final scripts.
May 10 18:33:52 hircine-tonette systemd[1]: Reached target Cloud-init target.
May 10 18:33:52 hircine-tonette systemd[1]: Reached target Multi-User System.
May 10 18:33:52 hircine-tonette systemd[1]: Reached target Graphical Interface.
May 10 18:33:52 hircine-tonette systemd[1]: Started Stop ureadahead data collection 45s after completed startup.
May 10 18:33:52 hircine-tonette systemd[1]: Starting Update UTMP about System Runlevel Changes...
May 10 18:33:52 hircine-tonette [CLOUDINIT] util.py[DEBUG]: Reading from /proc/1772/cmdline (quiet=False)
May 10 18:33:52 hircine-tonette [CLOUDINIT] cc_power_state_change.py[DEBUG]: cmdline changed for 1772 [now: None]
May 10 18:33:52 hircine-tonette [CLOUDINIT] cc_power_state_change.py[DEBUG]: check_condition command (test ! -e /tmp/block-poweroff): exited 0. condition met.
May 10 18:33:52 hircine-tonette systemd[1]: systemd-journald.socket: Found ordering cycle on systemd-journald.socket/stop
May 10 18:33:52 hircine-tonette systemd[1]: systemd-journald.socket: Found dependency on -.mount/start
May 10 18:33:52 hircine-tonette systemd[1]: systemd-journald.socket: Found dependency on media-root\x2dro.mount/start
May 10 18:33:52 hircine-tonette systemd[1]: systemd-journald.socket: Found dependency on local-fs-pre.target/stop
May 10 18:33:52 hircine-tonette systemd[1]: systemd-journald.socket: Found dependency on systemd-remount-fs.service/stop
May 10 18:33:52 hircine-tonette systemd[1]: systemd-journald.socket: Found dependency on systemd-journald.socket/stop
May 10 18:33:52 hircine-tonette systemd[1]: systemd-journald.socket: Breaking ordering cycle by deleting job -.mount/start
May 10 18:33:52 hircine-tonette systemd[1]: -.mount: Job -.mount/start deleted to break ordering cycle starting with systemd-journald.socket/stop
May 10 18:33:52 hircine-tonette systemd[1]: Stopped Stop ureadahead data collection 45s after completed startup.
May 10 18:33:52 hircine-tonette systemd[1]: Starting Unattended Upgrades Shutdown...
May 10 18:33:52 hircine-tonette systemd[1]: Stopping Authenticate and Authorize Users to Run Privileged Tasks...
May 10 18:33:52 hircine-tonette systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
May 10 18:33:52 hircine-tonette systemd[1]: Stopping ACPI event daemon...
May 10 18:33:52 hircine-tonette systemd[1]: Stopped target Timers.
May 10 18:33:52 hircine-tonette systemd[1]: Stopped Daily apt activities.
May 10 18:33:52 hircine-tonette systemd[1]: Stopped target System Time Synchronized.
May 10 18:33:52 hircine-tonette systemd[1]: Stopped Daily Cleanup of Temporary Directories.
May 10 18:33:52 hircine-tonette systemd[1]: Stopping Read required files in advance...
May 10 18:33:52 hircine-tonette systemd[1]: Stopped Authenticate and Authorize Users to Run Privileged Tasks.
May 10 18:33:52 hircine-tonette systemd[1]: Stopped Update UTMP about System Runlevel Changes.
May 10 18:33:52 hircine-tonette systemd[1]: Stopped target Graphical Interface.
May 10 18:33:52 hircine-tonette systemd[1]: Stopped target Multi-User System.
May 10 18:33:52 hircine-tonette systemd[1]: Stopping Regular background program processing daemon...
May 10 18:33:52 hircine-tonette systemd[1]: Stopping Deferred execution scheduler...
May 10 18:33:52 hircine-tonette systemd[1]: Stopping OpenBSD Secure Shell server...
May 10 18:33:52 hircine-tonette rsyslogd: [origin software="rsyslogd" swVersion="8.16.0" x-pid="1637" x-info="http://www.rsyslog.com"] exiting on signal 15.