============================= test session starts ============================== platform linux -- Python 3.8.6, pytest-6.1.0, py-1.9.0, pluggy-0.13.1 rootdir: /home/daniel/scratch/cloud-init, configfile: tox.ini plugins: xdist-2.1.0, forked-1.3.0, parallel-0.1.0, cov-2.8.1 collected 1 item tests/integration_tests/test_1911680.py::test_test -------------------------------- live log setup -------------------------------- 2021-01-19 00:02:00 INFO integration_testing:clouds.py:73 Detected image: image_id=bionic os=ubuntu release=bionic 2021-01-19 00:02:00 INFO integration_testing:clouds.py:73 Detected image: image_id=bionic os=ubuntu release=bionic 2021-01-19 00:02:09 INFO integration_testing:clouds.py:113 Settings: CLOUD_INIT_SOURCE=cloud-init_20.4.1-0ubuntu1~18.04.1_all.deb COLLECT_LOGS=ON_ERROR EXISTING_INSTANCE_ID=None GCE_PROJECT=None GCE_REGION=us-central1 GCE_ZONE=a INSTANCE_TYPE=None KEEP_IMAGE=False KEEP_INSTANCE=False KEYPAIR_NAME=canonical LOCAL_LOG_PATH=/tmp/cloud_init_test_logs OCI_COMPARTMENT_ID=None OS_IMAGE=bionic PLATFORM=lxd_vm PUBLIC_SSH_KEY=/home/daniel/.ssh/id_rsa.canonical.pub RUN_UNSTABLE=False 2021-01-19 00:02:09 INFO integration_testing:conftest.py:141 Setting up environment for lxd_vm 2021-01-19 00:02:09 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=ubuntu:45de923aa33ed1cd743c0d8c94e9842dda7991b5b7933804bcf7ec5a12412cd6 user_data=None wait=False 2021-01-19 00:04:10 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-19 00:04:10 WARNING pycloudlib.instance:instance.py:311 The specified key (/home/daniel/.ssh/id_rsa.canonical) requires a passphrase. If you have not added this key to a running SSH agent, you will see failures to connect after a long timeout. 2021-01-19 00:04:51 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 10.236.135.179 Retrying ssh connection 60 more time(s) to ubuntu@10.236.135.179:22 2021-01-19 00:05:01 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 10.236.135.179 Retrying ssh connection 59 more time(s) to ubuntu@10.236.135.179:22 2021-01-19 00:05:42 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_7.6p1) 2021-01-19 00:05:42 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:05:42 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-19 00:05:44 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-19 00:05:44 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-19 00:05:45 INFO integration_testing:clouds.py:168 Launched instance: LXDInstance(name=happy-elk) 2021-01-19 00:05:45 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-19 00:05:45 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4-0ubuntu1~18.04.2 2021-01-19 00:05:45 INFO integration_testing:instances.py:164 Installing deb package 2021-01-19 00:05:45 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'mv /var/tmp/ab3af677-8b32-4e50-9fee-67385e0fccdf.tmp /var/tmp/cloud-init_20.4.1-0ubuntu1~18.04.1_all.deb' 2021-01-19 00:05:45 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'dpkg -i /var/tmp/cloud-init_20.4.1-0ubuntu1~18.04.1_all.deb' 2021-01-19 00:05:48 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init -v' 2021-01-19 00:05:48 INFO integration_testing:instances.py:137 Installed cloud-init version: 20.4.1-0ubuntu1~18.04.1 2021-01-19 00:05:48 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:05:49 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:05:49 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:05:49 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:05:49 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:05:49 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:09:13 INFO integration_testing:instances.py:117 Created new image: local:happy-elk-snapshot 2021-01-19 00:09:14 INFO integration_testing:conftest.py:147 Done with environment setup -------------------------------- live log call --------------------------------- 2021-01-19 00:09:14 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=local:happy-elk-snapshot user_data=#cloud-config bootcmd: - sed -i "s,#AuthorizedKeysFile.*,AuthorizedKeysFile /etc/ssh/authorized_keys /etc/backdoor_keys," /etc/ssh/sshd_config runcmd: - | cat << EOF > /etc/backdoor_keys ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDes50i5YZ1QYVqii7L4wu5K1zAEBEYfA3vE1delFH9XQNXJ4oVNQNcsZMqMnE4Kad4VZo1SuRAa5X7tZiVpPF7WcsTm3HXhJmDjUT5FMmZ1c8NwtMETNOo2zAF9KEfJLQo99a9UZwhkiRudjZWA/FqBOJxBlnirSq7TOgrMin0/qlODQz8nrYoPj8mFGAuOiyKtqaLcH0C8Xl/DVCMgC6YLv5xDFTP1Jz5pLG59aqaAuc+3QKdYqoSTjT8IZEtpkNHuqTBaDkaopWogHEc3yjfc8VtkV4x/WVtvv9oqQQCqu8+JHm1/mFvDD/yL90wR+L261MdlN+ojojdmCP9jXFf canonical EOF wait=False 2021-01-19 00:10:30 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-19 00:10:30 WARNING pycloudlib.instance:instance.py:311 The specified key (/home/daniel/.ssh/id_rsa.canonical) requires a passphrase. If you have not added this key to a running SSH agent, you will see failures to connect after a long timeout. 2021-01-19 00:11:31 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_7.6p1) 2021-01-19 00:11:31 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:11:31 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-19 00:11:32 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-19 00:11:32 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-19 00:11:32 INFO integration_testing:clouds.py:168 Launched instance: LXDInstance(name=winning-piranha) 2021-01-19 00:11:32 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-19 00:11:33 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4.1-0ubuntu1~18.04.1 2021-01-19 00:11:33 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'test -f /etc/ssh/authorized_keys' PASSED [100%] ------------------------------ live log teardown ------------------------------- 2021-01-19 00:11:34 INFO integration_testing:clouds.py:194 Deleting snapshot image created for this testrun: local:happy-elk-snapshot =============================== warnings summary =============================== tests/integration_tests/test_1911680.py::test_test tests/integration_tests/test_1911680.py::test_test tests/integration_tests/test_1911680.py::test_test /home/daniel/.virtualenvs/cloud-init/lib/python3.8/site-packages/simplestreams/mirrors/__init__.py:206: DeprecationWarning: The 'warn' method is deprecated, use 'warning' instead LOG.warn("got ENOENT for (%s, %s), trying with trailing /", -- Docs: https://docs.pytest.org/en/stable/warnings.html ================== 1 passed, 3 warnings in 574.14s (0:09:34) =================== ============================= test session starts ============================== platform linux -- Python 3.8.6, pytest-6.1.0, py-1.9.0, pluggy-0.13.1 rootdir: /home/daniel/scratch/cloud-init, configfile: tox.ini plugins: xdist-2.1.0, forked-1.3.0, parallel-0.1.0, cov-2.8.1 collected 1 item tests/integration_tests/test_1911680.py::test_test -------------------------------- live log setup -------------------------------- 2021-01-19 00:02:22 INFO integration_testing:clouds.py:73 Detected image: image_id=focal os=ubuntu release=focal 2021-01-19 00:02:22 INFO integration_testing:clouds.py:73 Detected image: image_id=focal os=ubuntu release=focal 2021-01-19 00:02:31 INFO integration_testing:clouds.py:113 Settings: CLOUD_INIT_SOURCE=cloud-init_20.4.1-0ubuntu1~20.04.1_all.deb COLLECT_LOGS=ON_ERROR EXISTING_INSTANCE_ID=None GCE_PROJECT=None GCE_REGION=us-central1 GCE_ZONE=a INSTANCE_TYPE=None KEEP_IMAGE=False KEEP_INSTANCE=False KEYPAIR_NAME=canonical LOCAL_LOG_PATH=/tmp/cloud_init_test_logs OCI_COMPARTMENT_ID=None OS_IMAGE=focal PLATFORM=lxd_vm PUBLIC_SSH_KEY=/home/daniel/.ssh/id_rsa.canonical.pub RUN_UNSTABLE=False 2021-01-19 00:02:31 INFO integration_testing:conftest.py:141 Setting up environment for lxd_vm 2021-01-19 00:02:31 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=ubuntu:00c6f6a6c254a6fd448b4316668d16c47a6a94e0169d31f179629dc74ba718d0 user_data=None wait=False 2021-01-19 00:03:42 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-19 00:03:42 WARNING pycloudlib.instance:instance.py:311 The specified key (/home/daniel/.ssh/id_rsa.canonical) requires a passphrase. If you have not added this key to a running SSH agent, you will see failures to connect after a long timeout. 2021-01-19 00:04:22 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_8.2p1) 2021-01-19 00:04:22 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:04:22 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-19 00:04:24 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-19 00:04:24 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-19 00:04:26 INFO integration_testing:clouds.py:168 Launched instance: LXDInstance(name=eager-javelin) 2021-01-19 00:04:26 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-19 00:04:27 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4-0ubuntu1~20.04.2 2021-01-19 00:04:27 INFO integration_testing:instances.py:164 Installing deb package 2021-01-19 00:04:30 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'mv /var/tmp/281f71ae-1f04-422a-8f34-56d87a2f0fc8.tmp /var/tmp/cloud-init_20.4.1-0ubuntu1~20.04.1_all.deb' 2021-01-19 00:04:30 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'dpkg -i /var/tmp/cloud-init_20.4.1-0ubuntu1~20.04.1_all.deb' 2021-01-19 00:04:34 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init -v' 2021-01-19 00:04:35 INFO integration_testing:instances.py:137 Installed cloud-init version: 20.4.1-0ubuntu1~20.04.1 2021-01-19 00:04:35 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:04:35 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:04:35 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:04:35 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:04:35 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:04:36 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:06:07 INFO integration_testing:instances.py:117 Created new image: local:eager-javelin-snapshot 2021-01-19 00:06:08 INFO integration_testing:conftest.py:147 Done with environment setup -------------------------------- live log call --------------------------------- 2021-01-19 00:06:08 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=local:eager-javelin-snapshot user_data=#cloud-config bootcmd: - sed -i "s,#AuthorizedKeysFile.*,AuthorizedKeysFile /etc/ssh/authorized_keys /etc/backdoor_keys," /etc/ssh/sshd_config runcmd: - | cat << EOF > /etc/backdoor_keys ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDes50i5YZ1QYVqii7L4wu5K1zAEBEYfA3vE1delFH9XQNXJ4oVNQNcsZMqMnE4Kad4VZo1SuRAa5X7tZiVpPF7WcsTm3HXhJmDjUT5FMmZ1c8NwtMETNOo2zAF9KEfJLQo99a9UZwhkiRudjZWA/FqBOJxBlnirSq7TOgrMin0/qlODQz8nrYoPj8mFGAuOiyKtqaLcH0C8Xl/DVCMgC6YLv5xDFTP1Jz5pLG59aqaAuc+3QKdYqoSTjT8IZEtpkNHuqTBaDkaopWogHEc3yjfc8VtkV4x/WVtvv9oqQQCqu8+JHm1/mFvDD/yL90wR+L261MdlN+ojojdmCP9jXFf canonical EOF wait=False 2021-01-19 00:07:28 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-19 00:07:28 WARNING pycloudlib.instance:instance.py:311 The specified key (/home/daniel/.ssh/id_rsa.canonical) requires a passphrase. If you have not added this key to a running SSH agent, you will see failures to connect after a long timeout. 2021-01-19 00:08:08 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_8.2p1) 2021-01-19 00:08:08 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:08:08 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-19 00:08:09 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-19 00:08:09 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-19 00:08:10 INFO integration_testing:clouds.py:168 Launched instance: LXDInstance(name=growing-ox) 2021-01-19 00:08:10 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-19 00:08:10 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4.1-0ubuntu1~20.04.1 2021-01-19 00:08:10 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'test -f /etc/ssh/authorized_keys' PASSED [100%] ------------------------------ live log teardown ------------------------------- 2021-01-19 00:08:11 INFO integration_testing:clouds.py:194 Deleting snapshot image created for this testrun: local:eager-javelin-snapshot =============================== warnings summary =============================== tests/integration_tests/test_1911680.py::test_test tests/integration_tests/test_1911680.py::test_test /home/daniel/.virtualenvs/cloud-init/lib/python3.8/site-packages/simplestreams/mirrors/__init__.py:206: DeprecationWarning: The 'warn' method is deprecated, use 'warning' instead LOG.warn("got ENOENT for (%s, %s), trying with trailing /", -- Docs: https://docs.pytest.org/en/stable/warnings.html ================== 1 passed, 2 warnings in 349.46s (0:05:49) =================== ============================= test session starts ============================== platform linux -- Python 3.8.6, pytest-6.1.0, py-1.9.0, pluggy-0.13.1 rootdir: /home/daniel/scratch/cloud-init, configfile: tox.ini plugins: xdist-2.1.0, forked-1.3.0, parallel-0.1.0, cov-2.8.1 collected 1 item tests/integration_tests/test_1911680.py::test_test -------------------------------- live log setup -------------------------------- 2021-01-19 00:02:56 INFO integration_testing:clouds.py:73 Detected image: image_id=groovy os=ubuntu release=groovy 2021-01-19 00:02:56 INFO integration_testing:clouds.py:73 Detected image: image_id=groovy os=ubuntu release=groovy 2021-01-19 00:03:09 INFO integration_testing:clouds.py:113 Settings: CLOUD_INIT_SOURCE=cloud-init_20.4.1-0ubuntu1~20.10.1_all.deb COLLECT_LOGS=ON_ERROR EXISTING_INSTANCE_ID=None GCE_PROJECT=None GCE_REGION=us-central1 GCE_ZONE=a INSTANCE_TYPE=None KEEP_IMAGE=False KEEP_INSTANCE=False KEYPAIR_NAME=canonical LOCAL_LOG_PATH=/tmp/cloud_init_test_logs OCI_COMPARTMENT_ID=None OS_IMAGE=groovy PLATFORM=lxd_vm PUBLIC_SSH_KEY=/home/daniel/.ssh/id_rsa.canonical.pub RUN_UNSTABLE=False 2021-01-19 00:03:09 INFO integration_testing:conftest.py:141 Setting up environment for lxd_vm 2021-01-19 00:03:09 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=ubuntu:d6b18271794527f62c99aafddea3dee987a53311d42ac4acaa81f3f75edbe491 user_data=None wait=False 2021-01-19 00:04:19 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-19 00:04:19 WARNING pycloudlib.instance:instance.py:311 The specified key (/home/daniel/.ssh/id_rsa.canonical) requires a passphrase. If you have not added this key to a running SSH agent, you will see failures to connect after a long timeout. 2021-01-19 00:05:20 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_8.3p1) 2021-01-19 00:05:20 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:05:20 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-19 00:05:21 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-19 00:05:22 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-19 00:05:22 INFO integration_testing:clouds.py:168 Launched instance: LXDInstance(name=profound-ghost) 2021-01-19 00:05:22 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-19 00:05:22 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4-0ubuntu1~20.10.2 2021-01-19 00:05:22 INFO integration_testing:instances.py:164 Installing deb package 2021-01-19 00:05:23 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'mv /var/tmp/9aa31003-5eaa-4182-b406-8f5ed593e529.tmp /var/tmp/cloud-init_20.4.1-0ubuntu1~20.10.1_all.deb' 2021-01-19 00:05:23 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'dpkg -i /var/tmp/cloud-init_20.4.1-0ubuntu1~20.10.1_all.deb' 2021-01-19 00:05:26 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init -v' 2021-01-19 00:05:26 INFO integration_testing:instances.py:137 Installed cloud-init version: 20.4.1-0ubuntu1~20.10.1 2021-01-19 00:05:26 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:05:26 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:05:26 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:05:27 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:05:27 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:05:27 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:07:48 INFO integration_testing:instances.py:117 Created new image: local:profound-ghost-snapshot 2021-01-19 00:07:49 INFO integration_testing:conftest.py:147 Done with environment setup -------------------------------- live log call --------------------------------- 2021-01-19 00:07:49 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=local:profound-ghost-snapshot user_data=#cloud-config bootcmd: - sed -i "s,#AuthorizedKeysFile.*,AuthorizedKeysFile /etc/ssh/authorized_keys /etc/backdoor_keys," /etc/ssh/sshd_config runcmd: - | cat << EOF > /etc/backdoor_keys ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDes50i5YZ1QYVqii7L4wu5K1zAEBEYfA3vE1delFH9XQNXJ4oVNQNcsZMqMnE4Kad4VZo1SuRAa5X7tZiVpPF7WcsTm3HXhJmDjUT5FMmZ1c8NwtMETNOo2zAF9KEfJLQo99a9UZwhkiRudjZWA/FqBOJxBlnirSq7TOgrMin0/qlODQz8nrYoPj8mFGAuOiyKtqaLcH0C8Xl/DVCMgC6YLv5xDFTP1Jz5pLG59aqaAuc+3QKdYqoSTjT8IZEtpkNHuqTBaDkaopWogHEc3yjfc8VtkV4x/WVtvv9oqQQCqu8+JHm1/mFvDD/yL90wR+L261MdlN+ojojdmCP9jXFf canonical EOF wait=False 2021-01-19 00:09:10 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-19 00:09:10 WARNING pycloudlib.instance:instance.py:311 The specified key (/home/daniel/.ssh/id_rsa.canonical) requires a passphrase. If you have not added this key to a running SSH agent, you will see failures to connect after a long timeout. 2021-01-19 00:09:51 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_8.3p1) 2021-01-19 00:09:51 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:09:51 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-19 00:09:52 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-19 00:09:52 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-19 00:09:53 INFO integration_testing:clouds.py:168 Launched instance: LXDInstance(name=worthy-kit) 2021-01-19 00:09:53 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-19 00:09:53 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4.1-0ubuntu1~20.10.1 2021-01-19 00:09:53 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'test -f /etc/ssh/authorized_keys' PASSED [100%] ------------------------------ live log teardown ------------------------------- 2021-01-19 00:09:54 INFO integration_testing:clouds.py:194 Deleting snapshot image created for this testrun: local:profound-ghost-snapshot =============================== warnings summary =============================== tests/integration_tests/test_1911680.py::test_test tests/integration_tests/test_1911680.py::test_test /home/daniel/.virtualenvs/cloud-init/lib/python3.8/site-packages/simplestreams/mirrors/__init__.py:206: DeprecationWarning: The 'warn' method is deprecated, use 'warning' instead LOG.warn("got ENOENT for (%s, %s), trying with trailing /", -- Docs: https://docs.pytest.org/en/stable/warnings.html ================== 1 passed, 2 warnings in 417.68s (0:06:57) =================== ============================= test session starts ============================== platform linux -- Python 3.8.6, pytest-6.1.0, py-1.9.0, pluggy-0.13.1 rootdir: /home/daniel/scratch/cloud-init, configfile: tox.ini plugins: xdist-2.1.0, forked-1.3.0, parallel-0.1.0, cov-2.8.1 collected 1 item tests/integration_tests/test_1911680.py::test_test -------------------------------- live log setup -------------------------------- 2021-01-19 00:01:29 INFO integration_testing:clouds.py:73 Detected image: image_id=xenial os=ubuntu release=xenial 2021-01-19 00:01:29 INFO integration_testing:clouds.py:73 Detected image: image_id=xenial os=ubuntu release=xenial 2021-01-19 00:01:29 INFO integration_testing:clouds.py:113 Settings: CLOUD_INIT_SOURCE=cloud-init_20.4.1-0ubuntu1~16.04.1_all.deb COLLECT_LOGS=ON_ERROR EXISTING_INSTANCE_ID=None GCE_PROJECT=None GCE_REGION=us-central1 GCE_ZONE=a INSTANCE_TYPE=None KEEP_IMAGE=False KEEP_INSTANCE=False KEYPAIR_NAME=canonical LOCAL_LOG_PATH=/tmp/cloud_init_test_logs OCI_COMPARTMENT_ID=None OS_IMAGE=xenial PLATFORM=lxd_vm PUBLIC_SSH_KEY=/home/daniel/.ssh/id_rsa.canonical.pub RUN_UNSTABLE=False 2021-01-19 00:01:29 INFO integration_testing:conftest.py:141 Setting up environment for lxd_vm 2021-01-19 00:01:29 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=images:ubuntu/16.04/cloud user_data=None wait=False 2021-01-19 00:02:12 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-19 00:02:12 WARNING pycloudlib.instance:instance.py:311 The specified key (/home/daniel/.ssh/id_rsa.canonical) requires a passphrase. If you have not added this key to a running SSH agent, you will see failures to connect after a long timeout. 2021-01-19 00:02:33 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 10.236.135.177 Retrying ssh connection 60 more time(s) to ubuntu@10.236.135.177:22 2021-01-19 00:02:43 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_7.2p2) 2021-01-19 00:02:43 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:02:43 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-19 00:02:43 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-19 00:02:44 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-19 00:02:44 INFO integration_testing:clouds.py:168 Launched instance: LXDInstance(name=saved-fish) 2021-01-19 00:02:44 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-19 00:02:44 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4-0ubuntu1~16.04.2 2021-01-19 00:02:44 INFO integration_testing:instances.py:164 Installing deb package 2021-01-19 00:02:45 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'mv /var/tmp/b7cc9cf4-b4bc-4ae5-b880-6f7ea5ac1f67.tmp /var/tmp/cloud-init_20.4.1-0ubuntu1~16.04.1_all.deb' 2021-01-19 00:02:45 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'dpkg -i /var/tmp/cloud-init_20.4.1-0ubuntu1~16.04.1_all.deb' 2021-01-19 00:02:47 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init -v' 2021-01-19 00:02:47 INFO integration_testing:instances.py:137 Installed cloud-init version: 20.4.1-0ubuntu1~16.04.1 2021-01-19 00:02:47 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:02:47 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:02:47 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:02:48 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:02:48 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-19 00:02:48 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-19 00:03:54 INFO integration_testing:instances.py:117 Created new image: local:saved-fish-snapshot 2021-01-19 00:03:54 INFO integration_testing:conftest.py:147 Done with environment setup -------------------------------- live log call --------------------------------- 2021-01-19 00:03:54 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=local:saved-fish-snapshot user_data=#cloud-config bootcmd: - sed -i "s,#AuthorizedKeysFile.*,AuthorizedKeysFile /etc/ssh/authorized_keys /etc/backdoor_keys," /etc/ssh/sshd_config runcmd: - | cat << EOF > /etc/backdoor_keys ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDes50i5YZ1QYVqii7L4wu5K1zAEBEYfA3vE1delFH9XQNXJ4oVNQNcsZMqMnE4Kad4VZo1SuRAa5X7tZiVpPF7WcsTm3HXhJmDjUT5FMmZ1c8NwtMETNOo2zAF9KEfJLQo99a9UZwhkiRudjZWA/FqBOJxBlnirSq7TOgrMin0/qlODQz8nrYoPj8mFGAuOiyKtqaLcH0C8Xl/DVCMgC6YLv5xDFTP1Jz5pLG59aqaAuc+3QKdYqoSTjT8IZEtpkNHuqTBaDkaopWogHEc3yjfc8VtkV4x/WVtvv9oqQQCqu8+JHm1/mFvDD/yL90wR+L261MdlN+ojojdmCP9jXFf canonical EOF wait=False 2021-01-19 00:05:06 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-19 00:05:06 WARNING pycloudlib.instance:instance.py:311 The specified key (/home/daniel/.ssh/id_rsa.canonical) requires a passphrase. If you have not added this key to a running SSH agent, you will see failures to connect after a long timeout. 2021-01-19 00:05:27 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_7.2p2) 2021-01-19 00:05:27 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:05:27 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:05:27 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:05:27 INFO pycloudlib.instance:instance.py:336 Authentication failed. Retrying ssh connection 60 more time(s) to ubuntu@10.236.135.177:22 2021-01-19 00:05:37 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_7.2p2) 2021-01-19 00:05:38 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-19 00:05:38 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-19 00:05:38 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-19 00:05:38 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-19 00:05:38 INFO integration_testing:clouds.py:168 Launched instance: LXDInstance(name=large-wallaby) 2021-01-19 00:05:38 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-19 00:05:39 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4.1-0ubuntu1~16.04.1 2021-01-19 00:05:39 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'test -f /etc/ssh/authorized_keys' PASSED [100%] ------------------------------ live log teardown ------------------------------- 2021-01-19 00:05:40 INFO integration_testing:clouds.py:194 Deleting snapshot image created for this testrun: local:saved-fish-snapshot ======================== 1 passed in 250.65s (0:04:10) =========================