2026-04-29 20:48:18.868294 | Job console starting 2026-04-29 20:48:18.879855 | Updating git repos 2026-04-29 20:48:18.917117 | Cloning repos into workspace 2026-04-29 20:48:20.095744 | Restoring repo states 2026-04-29 20:48:20.104410 | Merging changes 2026-04-29 20:48:20.856432 | Checking out repos 2026-04-29 20:48:20.979831 | Preparing playbooks 2026-04-29 20:48:28.715960 | Running Ansible setup 2026-04-29 20:48:32.437267 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-29 20:48:33.146055 | 2026-04-29 20:48:33.146593 | PLAY [localhost] 2026-04-29 20:48:33.177583 | 2026-04-29 20:48:33.177767 | TASK [Gathering Facts] 2026-04-29 20:48:34.006234 | localhost | ok 2026-04-29 20:48:34.013742 | 2026-04-29 20:48:34.013849 | TASK [Setup log path fact] 2026-04-29 20:48:34.034139 | localhost | ok 2026-04-29 20:48:34.049244 | 2026-04-29 20:48:34.049401 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 20:48:34.079769 | localhost | ok 2026-04-29 20:48:34.088298 | 2026-04-29 20:48:34.088451 | TASK [emit-job-header : Print job information] 2026-04-29 20:48:34.129054 | # Job Information 2026-04-29 20:48:34.129270 | Ansible Version: 2.16.18 2026-04-29 20:48:34.129318 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal 2026-04-29 20:48:34.129348 | Pipeline: check 2026-04-29 20:48:34.129374 | Executor: 2d72f0692154 2026-04-29 20:48:34.129400 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/126 2026-04-29 20:48:34.129428 | Event ID: 9b4e1cc0-440c-11f1-90ca-0e5250fcd001 2026-04-29 20:48:34.133575 | 2026-04-29 20:48:34.133648 | LOOP [emit-job-header : Print node information] 2026-04-29 20:48:34.222711 | localhost | ok: 2026-04-29 20:48:34.222918 | localhost | # Node Information 2026-04-29 20:48:34.222961 | localhost | Inventory Hostname: ubuntu-focal 2026-04-29 20:48:34.222993 | localhost | Hostname: np0000171284 2026-04-29 20:48:34.223024 | localhost | Username: zuul 2026-04-29 20:48:34.223057 | localhost | Distro: Ubuntu 20.04 2026-04-29 20:48:34.223086 | localhost | Provider: yul1 2026-04-29 20:48:34.223115 | localhost | Region: ca-ymq-1 2026-04-29 20:48:34.223142 | localhost | Label: ubuntu-focal 2026-04-29 20:48:34.223173 | localhost | Product Name: OpenStack Nova 2026-04-29 20:48:34.223210 | localhost | Interface IP: 199.204.45.44 2026-04-29 20:48:34.242245 | 2026-04-29 20:48:34.242421 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-29 20:48:34.685036 | localhost -> localhost | changed 2026-04-29 20:48:34.693451 | 2026-04-29 20:48:34.693533 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-29 20:48:35.577957 | localhost -> localhost | changed 2026-04-29 20:48:35.584344 | 2026-04-29 20:48:35.584403 | PLAY [all] 2026-04-29 20:48:35.591873 | 2026-04-29 20:48:35.591941 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-29 20:48:35.870584 | ubuntu-focal -> localhost | ok 2026-04-29 20:48:35.876644 | 2026-04-29 20:48:35.876741 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-29 20:48:35.906953 | ubuntu-focal | ok 2026-04-29 20:48:35.921170 | ubuntu-focal | included: /var/lib/zuul/builds/6937ff9f2bdb4e9db6f997b7d5724f46/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-29 20:48:35.929427 | 2026-04-29 20:48:35.929547 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-29 20:48:37.030471 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-04-29 20:48:37.030707 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/6937ff9f2bdb4e9db6f997b7d5724f46/work/6937ff9f2bdb4e9db6f997b7d5724f46_id_rsa 2026-04-29 20:48:37.030750 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/6937ff9f2bdb4e9db6f997b7d5724f46/work/6937ff9f2bdb4e9db6f997b7d5724f46_id_rsa.pub 2026-04-29 20:48:37.030781 | ubuntu-focal -> localhost | The key fingerprint is: 2026-04-29 20:48:37.030810 | ubuntu-focal -> localhost | SHA256:IUri8RuitC6j/ARoLa+mLAF8YkOj35XgwPdvq+1YPP0 zuul-build-sshkey 2026-04-29 20:48:37.030858 | ubuntu-focal -> localhost | The key's randomart image is: 2026-04-29 20:48:37.030888 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-04-29 20:48:37.030923 | ubuntu-focal -> localhost | | . | 2026-04-29 20:48:37.030952 | ubuntu-focal -> localhost | | oo o | 2026-04-29 20:48:37.030979 | ubuntu-focal -> localhost | |+ ++.o... | 2026-04-29 20:48:37.031007 | ubuntu-focal -> localhost | |+*.*..+. . | 2026-04-29 20:48:37.031034 | ubuntu-focal -> localhost | |+**o+. .S | 2026-04-29 20:48:37.031060 | ubuntu-focal -> localhost | |+.*..o .o. | 2026-04-29 20:48:37.031087 | ubuntu-focal -> localhost | |.o o. .+.. | 2026-04-29 20:48:37.031113 | ubuntu-focal -> localhost | |B.o +.. . | 2026-04-29 20:48:37.031144 | ubuntu-focal -> localhost | |O*.. ooo E | 2026-04-29 20:48:37.031172 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-04-29 20:48:37.031236 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.558336 2026-04-29 20:48:37.039769 | 2026-04-29 20:48:37.039834 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-29 20:48:37.075546 | ubuntu-focal | ok 2026-04-29 20:48:37.086843 | ubuntu-focal | included: /var/lib/zuul/builds/6937ff9f2bdb4e9db6f997b7d5724f46/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-29 20:48:37.096102 | 2026-04-29 20:48:37.096163 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-29 20:48:37.122320 | ubuntu-focal | skipping: Conditional result was False 2026-04-29 20:48:37.131230 | 2026-04-29 20:48:37.131301 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-29 20:48:37.594072 | ubuntu-focal | changed 2026-04-29 20:48:37.645752 | 2026-04-29 20:48:37.645869 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-29 20:48:37.808552 | ubuntu-focal | ok 2026-04-29 20:48:37.813685 | 2026-04-29 20:48:37.813749 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-29 20:48:38.254094 | ubuntu-focal | changed 2026-04-29 20:48:38.262864 | 2026-04-29 20:48:38.262941 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-29 20:48:38.739065 | ubuntu-focal | changed 2026-04-29 20:48:38.744600 | 2026-04-29 20:48:38.744668 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-29 20:48:38.790189 | ubuntu-focal | skipping: Conditional result was False 2026-04-29 20:48:38.827923 | 2026-04-29 20:48:38.828041 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-29 20:48:39.272472 | ubuntu-focal -> localhost | changed 2026-04-29 20:48:39.288639 | 2026-04-29 20:48:39.288921 | TASK [add-build-sshkey : Add back temp key] 2026-04-29 20:48:39.682023 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/6937ff9f2bdb4e9db6f997b7d5724f46/work/6937ff9f2bdb4e9db6f997b7d5724f46_id_rsa (zuul-build-sshkey) 2026-04-29 20:48:39.682272 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.014269 2026-04-29 20:48:39.687925 | 2026-04-29 20:48:39.687988 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-29 20:48:40.026003 | ubuntu-focal | ok 2026-04-29 20:48:40.041039 | 2026-04-29 20:48:40.041121 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-29 20:48:40.066966 | ubuntu-focal | skipping: Conditional result was False 2026-04-29 20:48:40.077114 | 2026-04-29 20:48:40.077179 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-29 20:48:40.402200 | ubuntu-focal | ok 2026-04-29 20:48:40.408136 | 2026-04-29 20:48:40.408209 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-29 20:48:42.044348 | ubuntu-focal | Output suppressed because no_log was given 2026-04-29 20:48:42.054637 | 2026-04-29 20:48:42.054703 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-29 20:48:42.267062 | ubuntu-focal | ok: "logs" 2026-04-29 20:48:42.267298 | ubuntu-focal | ok: All items complete 2026-04-29 20:48:42.267327 | 2026-04-29 20:48:42.364429 | ubuntu-focal | ok: "artifacts" 2026-04-29 20:48:42.504065 | ubuntu-focal | ok: "docs" 2026-04-29 20:48:42.518421 | 2026-04-29 20:48:42.518568 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-29 20:48:42.706643 | ubuntu-focal | changed: "logs" 2026-04-29 20:48:42.856573 | ubuntu-focal | changed: "artifacts" 2026-04-29 20:48:43.003197 | ubuntu-focal | changed: "docs" 2026-04-29 20:48:43.021120 | 2026-04-29 20:48:43.021262 | PLAY RECAP 2026-04-29 20:48:43.021311 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-29 20:48:43.021341 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-29 20:48:43.021364 | 2026-04-29 20:48:43.199057 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-29 20:48:43.200863 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-29 20:48:43.907791 | 2026-04-29 20:48:43.907934 | PLAY [all] 2026-04-29 20:48:43.920080 | 2026-04-29 20:48:43.920162 | TASK [setup-uv : Extract archive] 2026-04-29 20:48:46.238101 | ubuntu-focal | changed 2026-04-29 20:48:46.250061 | 2026-04-29 20:48:46.250204 | TASK [setup-uv : Print version] 2026-04-29 20:48:46.491092 | ubuntu-focal | uv 0.8.13 2026-04-29 20:48:46.791847 | ubuntu-focal | ok: Runtime: 0:00:00.009202 2026-04-29 20:48:46.810339 | 2026-04-29 20:48:46.810480 | PLAY RECAP 2026-04-29 20:48:46.810535 | ubuntu-focal | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-29 20:48:46.810559 | 2026-04-29 20:48:47.028044 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-29 20:48:47.030404 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-29 20:48:47.672041 | 2026-04-29 20:48:47.672583 | PLAY [all] 2026-04-29 20:48:47.684898 | 2026-04-29 20:48:47.684978 | TASK [Copy inventory file for Zuul] 2026-04-29 20:48:48.521884 | ubuntu-focal | changed 2026-04-29 20:48:48.527149 | 2026-04-29 20:48:48.527405 | TASK [Switch "ansible_host" to private IP] 2026-04-29 20:48:48.834487 | ubuntu-focal | changed: 1 replacements made 2026-04-29 20:48:48.842463 | 2026-04-29 20:48:48.842560 | TASK [Run Molecule scenario] 2026-04-29 20:48:49.443164 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-04-29 20:48:50.117113 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-04-29 20:48:50.285788 | ubuntu-focal | Using CPython 3.13.7 2026-04-29 20:48:50.285908 | ubuntu-focal | Creating virtual environment at: .venv 2026-04-29 20:48:50.559622 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-04-29 20:48:50.560546 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-04-29 20:48:50.596303 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-04-29 20:48:50.709691 | ubuntu-focal | Downloading cryptography 2026-04-29 20:48:50.748548 | ubuntu-focal | Downloading pygments 2026-04-29 20:48:50.904027 | ubuntu-focal | Downloading ansible-core 2026-04-29 20:48:50.928697 | ubuntu-focal | Installed 36 packages in 24ms 2026-04-29 20:48:52.083287 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-04-29 20:48:52.083375 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-04-29 20:48:52.946982 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-29 20:48:52.947065 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-04-29 20:48:52.947119 | ubuntu-focal | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-29 20:48:52.947222 | ubuntu-focal | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-04-29 20:49:03.678408 | ubuntu-focal | INFO [forget-package > dependency] Executing 2026-04-29 20:49:03.678492 | ubuntu-focal | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-04-29 20:49:03.678657 | ubuntu-focal | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-04-29 20:49:03.678707 | ubuntu-focal | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-29 20:49:03.683795 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-04-29 20:49:03.683928 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-29 20:49:03.688879 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-04-29 20:49:03.688936 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-29 20:49:03.688954 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-04-29 20:49:03.693841 | ubuntu-focal | INFO [forget-package > syntax] Executing 2026-04-29 20:49:04.186656 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-29 20:49:04.186837 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-04-29 20:49:04.187078 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-04-29 20:49:04.187197 | ubuntu-focal | 2026-04-29 20:49:04.530924 | ubuntu-focal | 2026-04-29 20:49:04.531007 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-04-29 20:49:04.610300 | ubuntu-focal | INFO [forget-package > syntax] Executed: Successful 2026-04-29 20:49:04.620895 | ubuntu-focal | INFO [forget-package > create] Executing 2026-04-29 20:49:04.622124 | ubuntu-focal | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-29 20:49:04.626950 | ubuntu-focal | INFO [forget-package > prepare] Executing 2026-04-29 20:49:05.146116 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-29 20:49:05.146227 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-04-29 20:49:05.146475 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-04-29 20:49:05.146594 | ubuntu-focal | 2026-04-29 20:49:05.512851 | ubuntu-focal | 2026-04-29 20:49:05.512971 | ubuntu-focal | PLAY [Prepare] ***************************************************************** 2026-04-29 20:49:05.513139 | ubuntu-focal | 2026-04-29 20:49:05.513310 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-29 20:49:05.513488 | ubuntu-focal | Wednesday 29 April 2026 20:49:05 +0000 (0:00:00.047) 0:00:00.047 ******* 2026-04-29 20:49:06.655074 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-04-29 20:49:06.656976 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-29 20:49:06.657155 | ubuntu-focal | 2026-04-29 20:49:06.657364 | ubuntu-focal | TASK [Install NGINX] *********************************************************** 2026-04-29 20:49:06.657550 | ubuntu-focal | Wednesday 29 April 2026 20:49:06 +0000 (0:00:01.145) 0:00:01.192 ******* 2026-04-29 20:49:24.651830 | ubuntu-focal | changed: [ubuntu-focal] 2026-04-29 20:49:24.651983 | ubuntu-focal | 2026-04-29 20:49:24.652186 | ubuntu-focal | TASK [Ensure NGINX is running] ************************************************* 2026-04-29 20:49:24.652383 | ubuntu-focal | Wednesday 29 April 2026 20:49:24 +0000 (0:00:17.994) 0:00:19.187 ******* 2026-04-29 20:49:25.301181 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-29 20:49:25.301249 | ubuntu-focal | 2026-04-29 20:49:25.301320 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-29 20:49:25.301426 | ubuntu-focal | ubuntu-focal : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-29 20:49:25.301471 | ubuntu-focal | 2026-04-29 20:49:25.301553 | ubuntu-focal | 2026-04-29 20:49:25.301638 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-29 20:49:25.301721 | ubuntu-focal | Wednesday 29 April 2026 20:49:25 +0000 (0:00:00.650) 0:00:19.837 ******* 2026-04-29 20:49:25.301794 | ubuntu-focal | =============================================================================== 2026-04-29 20:49:25.301875 | ubuntu-focal | Install NGINX ---------------------------------------------------------- 17.99s 2026-04-29 20:49:25.301956 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.15s 2026-04-29 20:49:25.302036 | ubuntu-focal | Ensure NGINX is running ------------------------------------------------- 0.65s 2026-04-29 20:49:25.415338 | ubuntu-focal | INFO [forget-package > prepare] Executed: Successful 2026-04-29 20:49:25.424129 | ubuntu-focal | INFO [forget-package > converge] Executing 2026-04-29 20:49:25.936485 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-29 20:49:25.936703 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-04-29 20:49:25.936928 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-04-29 20:49:25.937083 | ubuntu-focal | 2026-04-29 20:49:26.283740 | ubuntu-focal | 2026-04-29 20:49:26.283903 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-04-29 20:49:26.284073 | ubuntu-focal | 2026-04-29 20:49:26.284280 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-29 20:49:26.284474 | ubuntu-focal | Wednesday 29 April 2026 20:49:26 +0000 (0:00:00.010) 0:00:00.010 ******* 2026-04-29 20:49:27.379556 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-04-29 20:49:27.382035 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-29 20:49:27.382184 | ubuntu-focal | 2026-04-29 20:49:27.382361 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-29 20:49:27.382620 | ubuntu-focal | Wednesday 29 April 2026 20:49:27 +0000 (0:00:01.098) 0:00:01.109 ******* 2026-04-29 20:49:27.753829 | ubuntu-focal | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-29 20:49:27.757543 | ubuntu-focal | changed: [ubuntu-focal] 2026-04-29 20:49:27.757715 | ubuntu-focal | 2026-04-29 20:49:27.757889 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-29 20:49:27.758076 | ubuntu-focal | ubuntu-focal : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-29 20:49:27.758227 | ubuntu-focal | 2026-04-29 20:49:27.758376 | ubuntu-focal | 2026-04-29 20:49:27.758543 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-29 20:49:27.758716 | ubuntu-focal | Wednesday 29 April 2026 20:49:27 +0000 (0:00:00.375) 0:00:01.485 ******* 2026-04-29 20:49:27.758873 | ubuntu-focal | =============================================================================== 2026-04-29 20:49:27.759038 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.10s 2026-04-29 20:49:27.759205 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.38s 2026-04-29 20:49:27.874434 | ubuntu-focal | INFO [forget-package > converge] Executed: Successful 2026-04-29 20:49:27.884887 | ubuntu-focal | INFO [forget-package > idempotence] Executing 2026-04-29 20:49:28.360762 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-29 20:49:28.360842 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-04-29 20:49:28.360932 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-04-29 20:49:28.361025 | ubuntu-focal | 2026-04-29 20:49:28.662145 | ubuntu-focal | 2026-04-29 20:49:28.662350 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-04-29 20:49:28.662554 | ubuntu-focal | 2026-04-29 20:49:28.662779 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-29 20:49:28.662959 | ubuntu-focal | Wednesday 29 April 2026 20:49:28 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-04-29 20:49:29.713135 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-04-29 20:49:29.715231 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-29 20:49:29.715410 | ubuntu-focal | 2026-04-29 20:49:29.715607 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-29 20:49:29.715794 | ubuntu-focal | Wednesday 29 April 2026 20:49:29 +0000 (0:00:01.053) 0:00:01.061 ******* 2026-04-29 20:49:30.073183 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-29 20:49:30.073333 | ubuntu-focal | 2026-04-29 20:49:30.073536 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-29 20:49:30.073773 | ubuntu-focal | ubuntu-focal : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-29 20:49:30.073991 | ubuntu-focal | 2026-04-29 20:49:30.074212 | ubuntu-focal | 2026-04-29 20:49:30.074479 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-29 20:49:30.074743 | ubuntu-focal | Wednesday 29 April 2026 20:49:30 +0000 (0:00:00.357) 0:00:01.419 ******* 2026-04-29 20:49:30.074936 | ubuntu-focal | =============================================================================== 2026-04-29 20:49:30.075180 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.05s 2026-04-29 20:49:30.075415 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.36s 2026-04-29 20:49:30.172220 | ubuntu-focal | INFO [forget-package > idempotence] Executed: Successful 2026-04-29 20:49:30.182287 | ubuntu-focal | INFO [forget-package > side_effect] Executing 2026-04-29 20:49:30.182599 | ubuntu-focal | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-29 20:49:30.187717 | ubuntu-focal | INFO [forget-package > verify] Executing 2026-04-29 20:49:30.698711 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-29 20:49:30.698853 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-04-29 20:49:30.699017 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-04-29 20:49:30.699161 | ubuntu-focal | 2026-04-29 20:49:30.996934 | ubuntu-focal | 2026-04-29 20:49:30.997099 | ubuntu-focal | PLAY [Verify] ****************************************************************** 2026-04-29 20:49:30.997270 | ubuntu-focal | 2026-04-29 20:49:30.997465 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-29 20:49:30.997653 | ubuntu-focal | Wednesday 29 April 2026 20:49:30 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-04-29 20:49:32.059796 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-04-29 20:49:32.062989 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-29 20:49:32.063162 | ubuntu-focal | 2026-04-29 20:49:32.063355 | ubuntu-focal | TASK [Populate package facts] ************************************************** 2026-04-29 20:49:32.063543 | ubuntu-focal | Wednesday 29 April 2026 20:49:32 +0000 (0:00:01.065) 0:00:01.073 ******* 2026-04-29 20:49:33.978066 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-29 20:49:33.978228 | ubuntu-focal | 2026-04-29 20:49:33.978476 | ubuntu-focal | TASK [Populate service facts] ************************************************** 2026-04-29 20:49:33.978678 | ubuntu-focal | Wednesday 29 April 2026 20:49:33 +0000 (0:00:01.915) 0:00:02.988 ******* 2026-04-29 20:49:35.779695 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-29 20:49:35.780042 | ubuntu-focal | 2026-04-29 20:49:35.780360 | ubuntu-focal | TASK [Assert that the NGINX package is not installed] ************************** 2026-04-29 20:49:35.780722 | ubuntu-focal | Wednesday 29 April 2026 20:49:35 +0000 (0:00:01.801) 0:00:04.790 ******* 2026-04-29 20:49:35.808745 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-04-29 20:49:35.808968 | ubuntu-focal | "changed": false, 2026-04-29 20:49:35.809130 | ubuntu-focal | "msg": "All assertions passed" 2026-04-29 20:49:35.809305 | ubuntu-focal | } 2026-04-29 20:49:35.809453 | ubuntu-focal | 2026-04-29 20:49:35.809612 | ubuntu-focal | TASK [Assert that the NGINX service is still up] ******************************* 2026-04-29 20:49:35.809770 | ubuntu-focal | Wednesday 29 April 2026 20:49:35 +0000 (0:00:00.027) 0:00:04.818 ******* 2026-04-29 20:49:35.830166 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-04-29 20:49:35.830261 | ubuntu-focal | "changed": false, 2026-04-29 20:49:35.830351 | ubuntu-focal | "msg": "All assertions passed" 2026-04-29 20:49:35.830432 | ubuntu-focal | } 2026-04-29 20:49:35.830511 | ubuntu-focal | 2026-04-29 20:49:35.830594 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-29 20:49:35.830687 | ubuntu-focal | ubuntu-focal : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-29 20:49:35.830761 | ubuntu-focal | 2026-04-29 20:49:35.830835 | ubuntu-focal | 2026-04-29 20:49:35.830913 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-29 20:49:35.830995 | ubuntu-focal | Wednesday 29 April 2026 20:49:35 +0000 (0:00:00.023) 0:00:04.841 ******* 2026-04-29 20:49:35.831072 | ubuntu-focal | =============================================================================== 2026-04-29 20:49:35.831151 | ubuntu-focal | Populate package facts -------------------------------------------------- 1.92s 2026-04-29 20:49:35.831232 | ubuntu-focal | Populate service facts -------------------------------------------------- 1.80s 2026-04-29 20:49:35.831316 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.07s 2026-04-29 20:49:35.831398 | ubuntu-focal | Assert that the NGINX package is not installed -------------------------- 0.03s 2026-04-29 20:49:35.831470 | ubuntu-focal | Assert that the NGINX service is still up ------------------------------- 0.02s 2026-04-29 20:49:35.946947 | ubuntu-focal | INFO [forget-package > verify] Executed: Successful 2026-04-29 20:49:35.957874 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-04-29 20:49:35.958178 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-29 20:49:35.963106 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-04-29 20:49:35.963178 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-29 20:49:35.963255 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-04-29 20:49:35.963533 | ubuntu-focal | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-29 20:49:36.481623 | ubuntu-focal | ok: Runtime: 0:00:46.922235 2026-04-29 20:49:36.485795 | 2026-04-29 20:49:36.485891 | PLAY RECAP 2026-04-29 20:49:36.485952 | ubuntu-focal | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-29 20:49:36.485984 | 2026-04-29 20:49:36.619688 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-29 20:49:36.621081 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 20:49:37.256568 | 2026-04-29 20:49:37.256754 | PLAY [all] 2026-04-29 20:49:37.269792 | 2026-04-29 20:49:37.269936 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-29 20:49:37.316310 | ubuntu-focal | skipping: Conditional result was False 2026-04-29 20:49:37.326804 | 2026-04-29 20:49:37.326957 | TASK [fetch-output : Set log path for single node] 2026-04-29 20:49:37.370066 | ubuntu-focal | ok 2026-04-29 20:49:37.376591 | 2026-04-29 20:49:37.376688 | LOOP [fetch-output : Ensure local output dirs] 2026-04-29 20:49:37.800119 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/6937ff9f2bdb4e9db6f997b7d5724f46/work/logs" 2026-04-29 20:49:38.028078 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/6937ff9f2bdb4e9db6f997b7d5724f46/work/artifacts" 2026-04-29 20:49:38.238370 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/6937ff9f2bdb4e9db6f997b7d5724f46/work/docs" 2026-04-29 20:49:38.253619 | 2026-04-29 20:49:38.253718 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-29 20:49:38.862073 | ubuntu-focal | changed: .d..t...... ./ 2026-04-29 20:49:38.862353 | ubuntu-focal | changed: All items complete 2026-04-29 20:49:38.862395 | 2026-04-29 20:49:39.264044 | ubuntu-focal | changed: .d..t...... ./ 2026-04-29 20:49:39.656093 | ubuntu-focal | changed: .d..t...... ./ 2026-04-29 20:49:39.679767 | 2026-04-29 20:49:39.679949 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-29 20:49:40.736891 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.009441 2026-04-29 20:49:40.982940 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.007892 2026-04-29 20:49:41.004163 | 2026-04-29 20:49:41.004317 | PLAY [all] 2026-04-29 20:49:41.010953 | 2026-04-29 20:49:41.011018 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-29 20:49:41.426038 | ubuntu-focal | changed 2026-04-29 20:49:41.432629 | 2026-04-29 20:49:41.432843 | PLAY RECAP 2026-04-29 20:49:41.432945 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-29 20:49:41.433037 | 2026-04-29 20:49:41.576246 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 20:49:41.579267 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-29 20:49:42.170314 | 2026-04-29 20:49:42.170440 | PLAY [localhost] 2026-04-29 20:49:42.181086 | 2026-04-29 20:49:42.181164 | TASK [Generate Zuul manifest] 2026-04-29 20:49:42.203329 | localhost | ok 2026-04-29 20:49:42.219312 | 2026-04-29 20:49:42.219398 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-29 20:49:42.624505 | localhost | changed 2026-04-29 20:49:42.639738 | 2026-04-29 20:49:42.639918 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-29 20:49:42.671855 | localhost | ok 2026-04-29 20:49:42.683915 | 2026-04-29 20:49:42.684038 | TASK [Upload logs] 2026-04-29 20:49:42.705485 | localhost | ok 2026-04-29 20:49:42.771156 | 2026-04-29 20:49:42.771321 | TASK [Set zuul-log-path fact] 2026-04-29 20:49:42.794143 | localhost | ok 2026-04-29 20:49:42.807571 | 2026-04-29 20:49:42.807699 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 20:49:42.840915 | localhost | ok 2026-04-29 20:49:42.850570 | 2026-04-29 20:49:42.850643 | TASK [upload-logs : Create log directories] 2026-04-29 20:49:43.270009 | localhost | changed 2026-04-29 20:49:43.276330 | 2026-04-29 20:49:43.276401 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-29 20:49:43.703901 | localhost -> localhost | ok: Runtime: 0:00:00.005840 2026-04-29 20:49:43.709128 | 2026-04-29 20:49:43.709199 | TASK [upload-logs : Upload logs to log server] 2026-04-29 20:49:44.210824 | localhost | Output suppressed because no_log was given 2026-04-29 20:49:44.215603 | 2026-04-29 20:49:44.215668 | LOOP [upload-logs : Compress console log and json output] 2026-04-29 20:49:44.283312 | localhost | skipping: Conditional result was False 2026-04-29 20:49:44.291441 | localhost | skipping: Conditional result was False 2026-04-29 20:49:44.302045 | 2026-04-29 20:49:44.302234 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-29 20:49:44.345584 | localhost | skipping: Conditional result was False 2026-04-29 20:49:44.345934 | 2026-04-29 20:49:44.350890 | localhost | skipping: Conditional result was False 2026-04-29 20:49:44.365838 | 2026-04-29 20:49:44.366082 | LOOP [upload-logs : Upload console log and json output]