============================= 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-18 21:17:58 INFO integration_testing:clouds.py:73 Detected image: image_id=bionic os=ubuntu release=bionic 2021-01-18 21:18:00 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:18:00 INFO integration_testing:clouds.py:73 Detected image: image_id=bionic os=ubuntu release=bionic 2021-01-18 21:18:05 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=gce PUBLIC_SSH_KEY=/home/daniel/.ssh/id_rsa.canonical.pub RUN_UNSTABLE=False 2021-01-18 21:18:05 INFO integration_testing:conftest.py:141 Setting up environment for gce 2021-01-18 21:18:05 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=projects/ubuntu-os-cloud-devel/global/images/daily-ubuntu-1804-bionic-v20210118 user_data=None wait=False 2021-01-18 21:18:13 INFO pycloudlib.cloud:cloud.py:222 104.155.174.210 2021-01-18 21:18:14 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:18:15 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-18 21:18:15 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-18 21:18:31 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 104.155.174.210 Retrying ssh connection 60 more time(s) to ubuntu@104.155.174.210:22 2021-01-18 21:18:41 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_7.6p1) 2021-01-18 21:18:41 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-18 21:18:45 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-18 21:18:46 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-18 21:18:55 INFO integration_testing:clouds.py:168 Launched instance: GceInstance(instance_id=8968899625811985889) 2021-01-18 21:18:55 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-18 21:18:56 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4-0ubuntu1~18.04.2 2021-01-18 21:18:56 INFO integration_testing:instances.py:164 Installing deb package 2021-01-18 21:18:56 INFO paramiko.transport.sftp:sftp.py:158 [chan 4] Opened sftp connection (server version 3) 2021-01-18 21:18:56 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'mv /var/tmp/868dae7a-8d72-45d8-9139-ebfdfd1cfbd7.tmp /var/tmp/cloud-init_20.4.1-0ubuntu1~18.04.1_all.deb' 2021-01-18 21:18:57 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-18 21:19:00 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init -v' 2021-01-18 21:19:00 INFO integration_testing:instances.py:137 Installed cloud-init version: 20.4.1-0ubuntu1~18.04.1 2021-01-18 21:19:00 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-18 21:19:01 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-18 21:19:42 INFO integration_testing:instances.py:117 Created new image: projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161758-image 2021-01-18 21:19:49 INFO integration_testing:conftest.py:147 Done with environment setup -------------------------------- live log call --------------------------------- 2021-01-18 21:19:50 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161758-image 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-18 21:20:08 INFO pycloudlib.cloud:cloud.py:222 35.184.185.6 2021-01-18 21:20:11 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:20:11 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-18 21:20:11 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-18 21:20:43 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_7.6p1) 2021-01-18 21:20:44 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-18 21:20:44 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-18 21:20:44 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-18 21:20:44 INFO pycloudlib.instance:instance.py:336 Authentication failed. Retrying ssh connection 60 more time(s) to ubuntu@35.184.185.6:22 2021-01-18 21:20:54 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_7.6p1) 2021-01-18 21:20:54 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-18 21:20:54 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-18 21:20:58 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-18 21:20:59 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-18 21:20:59 INFO integration_testing:clouds.py:168 Launched instance: GceInstance(instance_id=6772858061110920600) 2021-01-18 21:20:59 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-18 21:21:00 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4.1-0ubuntu1~18.04.1 2021-01-18 21:21:00 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'test -f /etc/ssh/authorized_keys' PASSED [100%] ------------------------------ live log teardown ------------------------------- 2021-01-18 21:21:15 INFO integration_testing:clouds.py:194 Deleting snapshot image created for this testrun: projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161758-image =============================== warnings summary =============================== 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, 1 warning in 197.97s (0:03:17) =================== ============================= 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-18 21:16:57 INFO integration_testing:clouds.py:73 Detected image: image_id=focal os=ubuntu release=focal 2021-01-18 21:16:59 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:16:59 INFO integration_testing:clouds.py:73 Detected image: image_id=focal os=ubuntu release=focal 2021-01-18 21:17:05 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=gce PUBLIC_SSH_KEY=/home/daniel/.ssh/id_rsa.canonical.pub RUN_UNSTABLE=False 2021-01-18 21:17:05 INFO integration_testing:conftest.py:141 Setting up environment for gce 2021-01-18 21:17:05 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=projects/ubuntu-os-cloud-devel/global/images/daily-ubuntu-2004-focal-v20210114 user_data=None wait=False 2021-01-18 21:17:16 INFO pycloudlib.cloud:cloud.py:222 35.224.154.89 2021-01-18 21:17:17 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:17:18 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-18 21:17:18 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-18 21:17:33 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 35.224.154.89 Retrying ssh connection 60 more time(s) to ubuntu@35.224.154.89:22 2021-01-18 21:17:44 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 35.224.154.89 Retrying ssh connection 59 more time(s) to ubuntu@35.224.154.89:22 2021-01-18 21:17:54 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_8.2p1) 2021-01-18 21:17:54 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-18 21:17:56 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-18 21:17:57 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-18 21:17:57 INFO integration_testing:clouds.py:168 Launched instance: GceInstance(instance_id=118415859321947198) 2021-01-18 21:17:57 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-18 21:17:58 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4-0ubuntu1~20.04.2 2021-01-18 21:17:58 INFO integration_testing:instances.py:164 Installing deb package 2021-01-18 21:17:58 INFO paramiko.transport.sftp:sftp.py:158 [chan 4] Opened sftp connection (server version 3) 2021-01-18 21:17:59 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'mv /var/tmp/b8f07d56-9c4f-4183-8a6f-23694339b2e4.tmp /var/tmp/cloud-init_20.4.1-0ubuntu1~20.04.1_all.deb' 2021-01-18 21:17:59 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-18 21:18:02 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init -v' 2021-01-18 21:18:03 INFO integration_testing:instances.py:137 Installed cloud-init version: 20.4.1-0ubuntu1~20.04.1 2021-01-18 21:18:03 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-18 21:18:03 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-18 21:18:48 INFO integration_testing:instances.py:117 Created new image: projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161657-image 2021-01-18 21:18:54 INFO integration_testing:conftest.py:147 Done with environment setup -------------------------------- live log call --------------------------------- 2021-01-18 21:18:54 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161657-image 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-18 21:19:14 INFO pycloudlib.cloud:cloud.py:222 34.71.244.98 2021-01-18 21:19:15 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:19:16 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-18 21:19:16 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-18 21:19:48 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 34.71.244.98 Retrying ssh connection 60 more time(s) to ubuntu@34.71.244.98:22 2021-01-18 21:19:58 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_8.2p1) 2021-01-18 21:19:58 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-18 21:19:59 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-18 21:20:02 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-18 21:20:03 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-18 21:20:03 INFO integration_testing:clouds.py:168 Launched instance: GceInstance(instance_id=4453760464994190800) 2021-01-18 21:20:04 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-18 21:20:04 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4.1-0ubuntu1~20.04.1 2021-01-18 21:20:04 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'test -f /etc/ssh/authorized_keys' PASSED [100%] ------------------------------ live log teardown ------------------------------- 2021-01-18 21:20:26 INFO integration_testing:clouds.py:194 Deleting snapshot image created for this testrun: projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161657-image =============================== warnings summary =============================== 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, 1 warning in 210.31s (0:03:30) =================== ============================= 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-18 21:18:07 INFO integration_testing:clouds.py:73 Detected image: image_id=groovy os=ubuntu release=groovy 2021-01-18 21:18:10 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:18:10 INFO integration_testing:clouds.py:73 Detected image: image_id=groovy os=ubuntu release=groovy 2021-01-18 21:18:15 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=gce PUBLIC_SSH_KEY=/home/daniel/.ssh/id_rsa.canonical.pub RUN_UNSTABLE=False 2021-01-18 21:18:15 INFO integration_testing:conftest.py:141 Setting up environment for gce 2021-01-18 21:18:15 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=projects/ubuntu-os-cloud-devel/global/images/daily-ubuntu-2010-groovy-v20210114 user_data=None wait=False 2021-01-18 21:18:32 INFO pycloudlib.cloud:cloud.py:222 104.197.106.7 2021-01-18 21:18:34 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:18:34 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-18 21:18:34 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-18 21:18:50 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 104.197.106.7 Retrying ssh connection 60 more time(s) to ubuntu@104.197.106.7:22 2021-01-18 21:19:00 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 104.197.106.7 Retrying ssh connection 59 more time(s) to ubuntu@104.197.106.7:22 2021-01-18 21:19:10 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_8.3p1) 2021-01-18 21:19:10 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-18 21:19:12 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-18 21:19:13 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-18 21:19:13 INFO integration_testing:clouds.py:168 Launched instance: GceInstance(instance_id=1384249219462219255) 2021-01-18 21:19:13 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-18 21:19:14 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4-0ubuntu1~20.10.2 2021-01-18 21:19:14 INFO integration_testing:instances.py:164 Installing deb package 2021-01-18 21:19:14 INFO paramiko.transport.sftp:sftp.py:158 [chan 4] Opened sftp connection (server version 3) 2021-01-18 21:19:15 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'mv /var/tmp/a60db223-9fcb-4512-8510-7ff4021584b9.tmp /var/tmp/cloud-init_20.4.1-0ubuntu1~20.10.1_all.deb' 2021-01-18 21:19:15 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-18 21:19:18 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init -v' 2021-01-18 21:19:19 INFO integration_testing:instances.py:137 Installed cloud-init version: 20.4.1-0ubuntu1~20.10.1 2021-01-18 21:19:19 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-18 21:19:19 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-18 21:20:01 INFO integration_testing:instances.py:117 Created new image: projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161807-image 2021-01-18 21:20:07 INFO integration_testing:conftest.py:147 Done with environment setup -------------------------------- live log call --------------------------------- 2021-01-18 21:20:08 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161807-image 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-18 21:20:26 INFO pycloudlib.cloud:cloud.py:222 34.70.21.229 2021-01-18 21:20:27 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:20:28 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-18 21:20: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-18 21:21:00 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 34.70.21.229 Retrying ssh connection 60 more time(s) to ubuntu@34.70.21.229:22 2021-01-18 21:21:10 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_8.3p1) 2021-01-18 21:21:10 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-18 21:21:10 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-18 21:21:15 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-18 21:21:15 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-18 21:21:16 INFO integration_testing:clouds.py:168 Launched instance: GceInstance(instance_id=8171977987456517479) 2021-01-18 21:21:16 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-18 21:21:16 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4.1-0ubuntu1~20.10.1 2021-01-18 21:21:16 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'test -f /etc/ssh/authorized_keys' PASSED [100%] ------------------------------ live log teardown ------------------------------- 2021-01-18 21:21:39 INFO integration_testing:clouds.py:194 Deleting snapshot image created for this testrun: projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161807-image =============================== warnings summary =============================== 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, 1 warning in 212.30s (0:03:32) =================== ============================= 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-18 21:16:03 INFO integration_testing:clouds.py:73 Detected image: image_id=xenial os=ubuntu release=xenial 2021-01-18 21:16:06 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:16:06 INFO integration_testing:clouds.py:73 Detected image: image_id=xenial os=ubuntu release=xenial 2021-01-18 21:16:12 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=gce PUBLIC_SSH_KEY=/home/daniel/.ssh/id_rsa.canonical.pub RUN_UNSTABLE=False 2021-01-18 21:16:12 INFO integration_testing:conftest.py:141 Setting up environment for gce 2021-01-18 21:16:12 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=projects/ubuntu-os-cloud-devel/global/images/daily-ubuntu-1604-xenial-v20210114 user_data=None wait=False 2021-01-18 21:16:21 INFO pycloudlib.cloud:cloud.py:222 34.70.21.229 2021-01-18 21:16:22 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:16:23 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-18 21:16:23 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-18 21:16:38 INFO pycloudlib.instance:instance.py:336 [Errno None] Unable to connect to port 22 on 34.70.21.229 Retrying ssh connection 60 more time(s) to ubuntu@34.70.21.229:22 2021-01-18 21:16:48 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_7.2p2) 2021-01-18 21:16:49 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-18 21:16:49 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-18 21:16:50 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-18 21:16:50 INFO integration_testing:clouds.py:168 Launched instance: GceInstance(instance_id=3311414256496821362) 2021-01-18 21:16:50 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-18 21:16:51 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4-0ubuntu1~16.04.2 2021-01-18 21:16:51 INFO integration_testing:instances.py:164 Installing deb package 2021-01-18 21:16:51 INFO paramiko.transport.sftp:sftp.py:158 [chan 4] Opened sftp connection (server version 3) 2021-01-18 21:16:52 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'mv /var/tmp/802ca088-54a8-4ddf-9a9f-784e90ae957e.tmp /var/tmp/cloud-init_20.4.1-0ubuntu1~16.04.1_all.deb' 2021-01-18 21:16:52 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-18 21:16:54 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init -v' 2021-01-18 21:16:55 INFO integration_testing:instances.py:137 Installed cloud-init version: 20.4.1-0ubuntu1~16.04.1 2021-01-18 21:16:55 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo cloud-init clean --logs' 2021-01-18 21:16:55 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'sudo rm -rf /var/log/syslog' 2021-01-18 21:17:36 INFO integration_testing:instances.py:117 Created new image: projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161603-image 2021-01-18 21:17:39 INFO integration_testing:conftest.py:147 Done with environment setup -------------------------------- live log call --------------------------------- 2021-01-18 21:17:39 INFO integration_testing:clouds.py:159 Launching instance with launch_kwargs: image_id=projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161603-image 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-18 21:17:56 INFO pycloudlib.cloud:cloud.py:222 34.70.69.108 2021-01-18 21:17:58 WARNING google.auth._default:_default.py:346 No project ID could be determined. Consider running `gcloud config set project` or setting the GOOGLE_CLOUD_PROJECT environment variable 2021-01-18 21:17:58 INFO pycloudlib.instance:instance.py:166 executing: sh -c whoami 2021-01-18 21:17:58 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-18 21:18:30 INFO paramiko.transport:transport.py:1819 Connected (version 2.0, client OpenSSH_7.2p2) 2021-01-18 21:18:31 INFO paramiko.transport:transport.py:1819 Authentication (publickey) failed. 2021-01-18 21:18:31 INFO paramiko.transport:transport.py:1819 Authentication (publickey) successful! 2021-01-18 21:18:32 INFO pycloudlib.instance:instance.py:166 executing: sh -c 'cloud-init status --help' 2021-01-18 21:18:33 INFO pycloudlib.instance:instance.py:166 executing: cloud-init status --wait --long 2021-01-18 21:18:33 INFO integration_testing:clouds.py:168 Launched instance: GceInstance(instance_id=5820590956057478171) 2021-01-18 21:18:33 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'cloud-init --version' 2021-01-18 21:18:34 INFO integration_testing:clouds.py:172 cloud-init version: /usr/bin/cloud-init 20.4.1-0ubuntu1~16.04.1 2021-01-18 21:18:34 INFO pycloudlib.instance:instance.py:166 executing: sudo -- sh -c 'test -f /etc/ssh/authorized_keys' PASSED [100%] ------------------------------ live log teardown ------------------------------- 2021-01-18 21:18:49 INFO integration_testing:clouds.py:194 Deleting snapshot image created for this testrun: projects/ubuntu-oddbloke/global/images/i0-gce-integration-test-0118-161603-image =============================== warnings summary =============================== 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, 1 warning in 167.82s (0:02:47) ===================