2026-04-18 16:35:44.540852 | Job console starting 2026-04-18 16:35:44.559236 | Updating git repos 2026-04-18 16:35:44.581737 | Cloning repos into workspace 2026-04-18 16:35:51.355812 | Restoring repo states 2026-04-18 16:35:51.365642 | Merging changes 2026-04-18 16:35:52.411868 | Checking out repos 2026-04-18 16:35:52.606503 | Preparing playbooks 2026-04-18 16:36:02.747110 | Running Ansible setup 2026-04-18 16:36:06.567089 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 16:36:07.243207 | 2026-04-18 16:36:07.243337 | PLAY [localhost] 2026-04-18 16:36:07.253014 | 2026-04-18 16:36:07.253110 | TASK [Gathering Facts] 2026-04-18 16:36:08.140259 | localhost | ok 2026-04-18 16:36:08.146597 | 2026-04-18 16:36:08.146669 | TASK [Setup log path fact] 2026-04-18 16:36:08.163878 | localhost | ok 2026-04-18 16:36:08.173187 | 2026-04-18 16:36:08.173268 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 16:36:08.201842 | localhost | ok 2026-04-18 16:36:08.210141 | 2026-04-18 16:36:08.210213 | TASK [emit-job-header : Print job information] 2026-04-18 16:36:08.248944 | # Job Information 2026-04-18 16:36:08.249431 | Ansible Version: 2.16.16 2026-04-18 16:36:08.249481 | Job: ansible-collection-containers-molecule-docker-ubuntu-noble 2026-04-18 16:36:08.249514 | Pipeline: check 2026-04-18 16:36:08.249543 | Executor: 0a8996d2b663 2026-04-18 16:36:08.249571 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/104 2026-04-18 16:36:08.249604 | Event ID: 3b9743e0-3b44-11f1-8b36-e33dc4de3ce3 2026-04-18 16:36:08.253456 | 2026-04-18 16:36:08.253541 | LOOP [emit-job-header : Print node information] 2026-04-18 16:36:08.342056 | localhost | ok: 2026-04-18 16:36:08.342191 | localhost | # Node Information 2026-04-18 16:36:08.342220 | localhost | Inventory Hostname: ubuntu-noble 2026-04-18 16:36:08.342243 | localhost | Hostname: np0000167390 2026-04-18 16:36:08.342262 | localhost | Username: zuul 2026-04-18 16:36:08.342284 | localhost | Distro: Ubuntu 24.04 2026-04-18 16:36:08.342304 | localhost | Provider: yul1 2026-04-18 16:36:08.342323 | localhost | Region: ca-ymq-1 2026-04-18 16:36:08.342341 | localhost | Label: ubuntu-noble 2026-04-18 16:36:08.342359 | localhost | Product Name: OpenStack Nova 2026-04-18 16:36:08.342378 | localhost | Interface IP: 199.19.213.14 2026-04-18 16:36:08.355431 | 2026-04-18 16:36:08.355546 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-18 16:36:08.709234 | localhost -> localhost | changed 2026-04-18 16:36:08.715434 | 2026-04-18 16:36:08.715532 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-18 16:36:09.869704 | localhost -> localhost | changed 2026-04-18 16:36:09.875062 | 2026-04-18 16:36:09.875121 | PLAY [all] 2026-04-18 16:36:09.894441 | 2026-04-18 16:36:09.894554 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-18 16:36:10.131313 | ubuntu-noble -> localhost | ok 2026-04-18 16:36:10.139132 | 2026-04-18 16:36:10.139207 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-18 16:36:10.173221 | ubuntu-noble | ok 2026-04-18 16:36:10.203589 | ubuntu-noble | included: /var/lib/zuul/builds/38fb8dc50aec49828c446985990eafe9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 16:36:10.217378 | 2026-04-18 16:36:10.217535 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-18 16:36:13.528524 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-04-18 16:36:13.528742 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/38fb8dc50aec49828c446985990eafe9/work/38fb8dc50aec49828c446985990eafe9_id_rsa 2026-04-18 16:36:13.528783 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/38fb8dc50aec49828c446985990eafe9/work/38fb8dc50aec49828c446985990eafe9_id_rsa.pub 2026-04-18 16:36:13.528953 | ubuntu-noble -> localhost | The key fingerprint is: 2026-04-18 16:36:13.528992 | ubuntu-noble -> localhost | SHA256:rGHycWJoZYg7e46xfTcx5E4XucM2QmHCjsogiU4SZoo zuul-build-sshkey 2026-04-18 16:36:13.529047 | ubuntu-noble -> localhost | The key's randomart image is: 2026-04-18 16:36:13.529072 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-04-18 16:36:13.529096 | ubuntu-noble -> localhost | | . | 2026-04-18 16:36:13.529118 | ubuntu-noble -> localhost | |.o . .o o | 2026-04-18 16:36:13.529139 | ubuntu-noble -> localhost | |*o. .ooo . . | 2026-04-18 16:36:13.529159 | ubuntu-noble -> localhost | |E. ..+..o o | 2026-04-18 16:36:13.529179 | ubuntu-noble -> localhost | |=oo.+ *+S. o | 2026-04-18 16:36:13.529199 | ubuntu-noble -> localhost | | .o+ = ** B | 2026-04-18 16:36:13.529219 | ubuntu-noble -> localhost | | o . oo * o | 2026-04-18 16:36:13.529238 | ubuntu-noble -> localhost | | B . + | 2026-04-18 16:36:13.529261 | ubuntu-noble -> localhost | | o o. . . | 2026-04-18 16:36:13.529281 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-04-18 16:36:13.529346 | ubuntu-noble -> localhost | ok: Runtime: 0:00:02.752132 2026-04-18 16:36:13.540565 | 2026-04-18 16:36:13.540670 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-18 16:36:13.574453 | ubuntu-noble | ok 2026-04-18 16:36:13.589209 | ubuntu-noble | included: /var/lib/zuul/builds/38fb8dc50aec49828c446985990eafe9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 16:36:13.600903 | 2026-04-18 16:36:13.601024 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-18 16:36:13.633367 | ubuntu-noble | skipping: Conditional result was False 2026-04-18 16:36:13.646123 | 2026-04-18 16:36:13.646255 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-18 16:36:14.208994 | ubuntu-noble | changed 2026-04-18 16:36:14.214762 | 2026-04-18 16:36:14.214842 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-18 16:36:14.450556 | ubuntu-noble | ok 2026-04-18 16:36:14.457638 | 2026-04-18 16:36:14.458027 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-18 16:36:15.191065 | ubuntu-noble | changed 2026-04-18 16:36:15.198227 | 2026-04-18 16:36:15.198303 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-18 16:36:15.768856 | ubuntu-noble | changed 2026-04-18 16:36:15.976978 | 2026-04-18 16:36:15.977229 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-18 16:36:15.991436 | ubuntu-noble | skipping: Conditional result was False 2026-04-18 16:36:16.001876 | 2026-04-18 16:36:16.002009 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-18 16:36:16.423683 | ubuntu-noble -> localhost | changed 2026-04-18 16:36:16.438094 | 2026-04-18 16:36:16.438541 | TASK [add-build-sshkey : Add back temp key] 2026-04-18 16:36:16.745489 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/38fb8dc50aec49828c446985990eafe9/work/38fb8dc50aec49828c446985990eafe9_id_rsa (zuul-build-sshkey) 2026-04-18 16:36:16.745656 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.015038 2026-04-18 16:36:16.750857 | 2026-04-18 16:36:16.750920 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-18 16:36:17.085917 | ubuntu-noble | ok 2026-04-18 16:36:17.091827 | 2026-04-18 16:36:17.091903 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-18 16:36:17.115965 | ubuntu-noble | skipping: Conditional result was False 2026-04-18 16:36:17.137461 | 2026-04-18 16:36:17.137559 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-18 16:36:17.556626 | ubuntu-noble | ok 2026-04-18 16:36:17.833601 | 2026-04-18 16:36:17.833703 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-18 16:36:18.766530 | ubuntu-noble | Output suppressed because no_log was given 2026-04-18 16:36:19.068133 | 2026-04-18 16:36:19.068265 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-18 16:36:19.331806 | ubuntu-noble | ok: "logs" 2026-04-18 16:36:19.331980 | ubuntu-noble | ok: All items complete 2026-04-18 16:36:19.332008 | 2026-04-18 16:36:19.488943 | ubuntu-noble | ok: "artifacts" 2026-04-18 16:36:19.760349 | ubuntu-noble | ok: "docs" 2026-04-18 16:36:19.781050 | 2026-04-18 16:36:19.781172 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-18 16:36:20.003653 | ubuntu-noble | changed: "logs" 2026-04-18 16:36:20.206057 | ubuntu-noble | changed: "artifacts" 2026-04-18 16:36:21.459519 | ubuntu-noble | changed: "docs" 2026-04-18 16:36:21.492400 | 2026-04-18 16:36:21.492536 | PLAY RECAP 2026-04-18 16:36:21.492586 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:36:21.492618 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-18 16:36:21.492638 | 2026-04-18 16:36:21.630209 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 16:36:21.632008 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 16:36:22.235082 | 2026-04-18 16:36:22.235212 | PLAY [all] 2026-04-18 16:36:22.246941 | 2026-04-18 16:36:22.247046 | TASK [setup-uv : Extract archive] 2026-04-18 16:36:33.463132 | ubuntu-noble | ERROR 2026-04-18 16:36:34.507798 | ubuntu-noble | { 2026-04-18 16:36:34.507920 | ubuntu-noble | "msg": "Failure downloading https://github.com/astral-sh/uv/releases/download/0.8.13/uv-x86_64-unknown-linux-gnu.tar.gz, Connection failure: The read operation timed out" 2026-04-18 16:36:34.507965 | ubuntu-noble | } failure 2026-04-18 16:36:34.515289 | 2026-04-18 16:36:34.515408 | PLAY RECAP 2026-04-18 16:36:34.515479 | ubuntu-noble | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:36:34.515514 | 2026-04-18 16:36:34.670000 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 16:36:34.671587 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 16:36:35.371688 | 2026-04-18 16:36:35.490705 | PLAY [all] 2026-04-18 16:36:35.507555 | 2026-04-18 16:36:35.507661 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-18 16:36:35.562005 | ubuntu-noble | skipping: Conditional result was False 2026-04-18 16:36:35.571011 | 2026-04-18 16:36:35.571214 | TASK [fetch-output : Set log path for single node] 2026-04-18 16:36:35.624694 | ubuntu-noble | ok 2026-04-18 16:36:35.631510 | 2026-04-18 16:36:35.631644 | LOOP [fetch-output : Ensure local output dirs] 2026-04-18 16:36:36.231928 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/38fb8dc50aec49828c446985990eafe9/work/logs" 2026-04-18 16:36:36.465828 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/38fb8dc50aec49828c446985990eafe9/work/artifacts" 2026-04-18 16:36:36.909702 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/38fb8dc50aec49828c446985990eafe9/work/docs" 2026-04-18 16:36:36.936554 | 2026-04-18 16:36:36.936679 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-18 16:36:37.612292 | ubuntu-noble | changed: .d..t...... ./ 2026-04-18 16:36:37.612515 | ubuntu-noble | changed: All items complete 2026-04-18 16:36:37.612555 | 2026-04-18 16:36:38.151220 | ubuntu-noble | changed: .d..t...... ./ 2026-04-18 16:36:38.635878 | ubuntu-noble | changed: .d..t...... ./ 2026-04-18 16:36:38.652196 | 2026-04-18 16:36:38.652430 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-18 16:36:39.118649 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.009343 2026-04-18 16:36:39.436244 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.016307 2026-04-18 16:36:39.450430 | 2026-04-18 16:36:39.450545 | PLAY [all] 2026-04-18 16:36:39.457449 | 2026-04-18 16:36:39.457558 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-18 16:36:39.977204 | ubuntu-noble | changed 2026-04-18 16:36:39.985560 | 2026-04-18 16:36:39.985669 | PLAY RECAP 2026-04-18 16:36:39.985733 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 16:36:39.985757 | 2026-04-18 16:36:40.189248 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 16:36:40.191303 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-18 16:36:40.820846 | 2026-04-18 16:36:40.820999 | PLAY [localhost] 2026-04-18 16:36:40.831832 | 2026-04-18 16:36:40.831931 | TASK [Generate Zuul manifest] 2026-04-18 16:36:40.853828 | localhost | ok 2026-04-18 16:36:40.869271 | 2026-04-18 16:36:40.869398 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-18 16:36:41.312889 | localhost | changed 2026-04-18 16:36:41.324321 | 2026-04-18 16:36:41.324441 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-18 16:36:41.842416 | localhost | ok 2026-04-18 16:36:41.856419 | 2026-04-18 16:36:41.856509 | TASK [Upload logs] 2026-04-18 16:36:41.883138 | localhost | ok 2026-04-18 16:36:41.982684 | 2026-04-18 16:36:41.982810 | TASK [Set zuul-log-path fact] 2026-04-18 16:36:41.999981 | localhost | ok 2026-04-18 16:36:42.012179 | 2026-04-18 16:36:42.012262 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 16:36:42.044288 | localhost | ok 2026-04-18 16:36:42.054720 | 2026-04-18 16:36:42.054879 | TASK [upload-logs : Create log directories] 2026-04-18 16:36:42.524146 | localhost | changed 2026-04-18 16:36:42.530539 | 2026-04-18 16:36:42.530631 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-18 16:36:42.979004 | localhost -> localhost | ok: Runtime: 0:00:00.007347 2026-04-18 16:36:42.984942 | 2026-04-18 16:36:42.985033 | TASK [upload-logs : Upload logs to log server] 2026-04-18 16:36:44.122404 | localhost | Output suppressed because no_log was given 2026-04-18 16:36:44.135134 | 2026-04-18 16:36:44.135267 | LOOP [upload-logs : Compress console log and json output] 2026-04-18 16:36:44.193837 | localhost | skipping: Conditional result was False 2026-04-18 16:36:44.202225 | localhost | skipping: Conditional result was False 2026-04-18 16:36:44.222549 | 2026-04-18 16:36:44.222760 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-18 16:36:44.267608 | localhost | skipping: Conditional result was False 2026-04-18 16:36:44.267888 | 2026-04-18 16:36:44.272842 | localhost | skipping: Conditional result was False 2026-04-18 16:36:44.287544 | 2026-04-18 16:36:44.287748 | LOOP [upload-logs : Upload console log and json output]