2026-05-28 21:33:20.513640 | Job console starting 2026-05-28 21:33:20.523643 | Updating git repos 2026-05-28 21:33:24.072342 | Cloning repos into workspace 2026-05-28 21:33:46.953258 | Restoring repo states 2026-05-28 21:33:52.810099 | Merging changes 2026-05-28 21:33:54.246744 | Checking out repos 2026-05-28 21:33:57.387222 | Preparing playbooks 2026-05-28 21:34:03.018455 | Running Ansible setup 2026-05-28 21:34:06.876494 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-28 21:34:07.510620 | 2026-05-28 21:34:07.510759 | PLAY [localhost] 2026-05-28 21:34:07.519149 | 2026-05-28 21:34:07.519222 | TASK [Gathering Facts] 2026-05-28 21:34:08.951349 | localhost | ok 2026-05-28 21:34:08.961111 | 2026-05-28 21:34:08.961218 | TASK [Setup log path fact] 2026-05-28 21:34:08.986671 | localhost | ok 2026-05-28 21:34:09.001239 | 2026-05-28 21:34:09.001349 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 21:34:09.031677 | localhost | ok 2026-05-28 21:34:09.040325 | 2026-05-28 21:34:09.040404 | TASK [emit-job-header : Print job information] 2026-05-28 21:34:09.080734 | # Job Information 2026-05-28 21:34:09.080954 | Ansible Version: 2.16.18 2026-05-28 21:34:09.081027 | Job: atmosphere-molecule-csi-local-path-provisioner 2026-05-28 21:34:09.081060 | Pipeline: check 2026-05-28 21:34:09.081090 | Executor: 2d72f0692154 2026-05-28 21:34:09.081120 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3985 2026-05-28 21:34:09.081154 | Event ID: bae4fc70-5adc-11f1-96fc-0d8014616d34 2026-05-28 21:34:09.085175 | 2026-05-28 21:34:09.085268 | LOOP [emit-job-header : Print node information] 2026-05-28 21:34:09.192009 | localhost | ok: 2026-05-28 21:34:09.192282 | localhost | # Node Information 2026-05-28 21:34:09.192333 | localhost | Inventory Hostname: instance 2026-05-28 21:34:09.192370 | localhost | Hostname: np0000177263 2026-05-28 21:34:09.192404 | localhost | Username: zuul 2026-05-28 21:34:09.192443 | localhost | Distro: Ubuntu 22.04 2026-05-28 21:34:09.192477 | localhost | Provider: yul1 2026-05-28 21:34:09.192511 | localhost | Region: ca-ymq-1 2026-05-28 21:34:09.192546 | localhost | Label: ubuntu-jammy 2026-05-28 21:34:09.192577 | localhost | Product Name: OpenStack Nova 2026-05-28 21:34:09.192608 | localhost | Interface IP: 199.204.45.70 2026-05-28 21:34:09.200052 | 2026-05-28 21:34:09.200220 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-28 21:34:09.735780 | localhost -> localhost | changed 2026-05-28 21:34:09.744854 | 2026-05-28 21:34:09.744977 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-28 21:34:10.694562 | localhost -> localhost | changed 2026-05-28 21:34:10.706039 | 2026-05-28 21:34:10.706094 | PLAY [all] 2026-05-28 21:34:10.715222 | 2026-05-28 21:34:10.715291 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-28 21:34:10.932687 | instance -> localhost | ok 2026-05-28 21:34:10.941934 | 2026-05-28 21:34:10.942023 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-28 21:34:10.977120 | instance | ok 2026-05-28 21:34:10.991406 | instance | included: /var/lib/zuul/builds/073f5e5424be462caafe2449d7d188aa/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-28 21:34:10.997674 | 2026-05-28 21:34:10.997735 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-28 21:34:11.794303 | instance -> localhost | Generating public/private rsa key pair. 2026-05-28 21:34:11.794498 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/073f5e5424be462caafe2449d7d188aa/work/073f5e5424be462caafe2449d7d188aa_id_rsa 2026-05-28 21:34:11.794529 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/073f5e5424be462caafe2449d7d188aa/work/073f5e5424be462caafe2449d7d188aa_id_rsa.pub 2026-05-28 21:34:11.794552 | instance -> localhost | The key fingerprint is: 2026-05-28 21:34:11.794574 | instance -> localhost | SHA256:jH8+qaRnIDpMoiHszuyWYwqVrLKYnTVMSBS9Bm9Cmq0 zuul-build-sshkey 2026-05-28 21:34:11.794611 | instance -> localhost | The key's randomart image is: 2026-05-28 21:34:11.794636 | instance -> localhost | +---[RSA 3072]----+ 2026-05-28 21:34:11.794661 | instance -> localhost | | oo | 2026-05-28 21:34:11.794683 | instance -> localhost | | .o . | 2026-05-28 21:34:11.794703 | instance -> localhost | | =.o . | 2026-05-28 21:34:11.794724 | instance -> localhost | |oooo= o | 2026-05-28 21:34:11.794744 | instance -> localhost | |..=+. . S | 2026-05-28 21:34:11.794811 | instance -> localhost | |E+.o. .. | 2026-05-28 21:34:11.794839 | instance -> localhost | |B=..+. .o .. | 2026-05-28 21:34:11.794861 | instance -> localhost | |BX+o . oooo | 2026-05-28 21:34:11.794884 | instance -> localhost | |@=+. .o.... | 2026-05-28 21:34:11.794906 | instance -> localhost | +----[SHA256]-----+ 2026-05-28 21:34:11.794955 | instance -> localhost | ok: Runtime: 0:00:00.324661 2026-05-28 21:34:11.810510 | 2026-05-28 21:34:11.870552 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-28 21:34:11.915351 | instance | ok 2026-05-28 21:34:11.926421 | instance | included: /var/lib/zuul/builds/073f5e5424be462caafe2449d7d188aa/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-28 21:34:11.934290 | 2026-05-28 21:34:11.934362 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-28 21:34:11.959965 | instance | skipping: Conditional result was False 2026-05-28 21:34:11.971431 | 2026-05-28 21:34:11.971650 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-28 21:34:12.433732 | instance | changed 2026-05-28 21:34:12.442337 | 2026-05-28 21:34:12.442429 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-28 21:34:12.628708 | instance | ok 2026-05-28 21:34:12.633923 | 2026-05-28 21:34:12.633990 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-28 21:34:13.177105 | instance | changed 2026-05-28 21:34:13.183686 | 2026-05-28 21:34:13.183769 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-28 21:34:13.691500 | instance | changed 2026-05-28 21:34:13.956202 | 2026-05-28 21:34:13.956354 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-28 21:34:13.974633 | instance | skipping: Conditional result was False 2026-05-28 21:34:13.982325 | 2026-05-28 21:34:13.982415 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-28 21:34:14.592981 | instance -> localhost | changed 2026-05-28 21:34:14.622359 | 2026-05-28 21:34:14.622467 | TASK [add-build-sshkey : Add back temp key] 2026-05-28 21:34:14.910913 | instance -> localhost | Identity added: /var/lib/zuul/builds/073f5e5424be462caafe2449d7d188aa/work/073f5e5424be462caafe2449d7d188aa_id_rsa (zuul-build-sshkey) 2026-05-28 21:34:14.911144 | instance -> localhost | ok: Runtime: 0:00:00.025426 2026-05-28 21:34:14.916442 | 2026-05-28 21:34:15.041037 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-28 21:34:15.366774 | instance | ok 2026-05-28 21:34:15.371663 | 2026-05-28 21:34:15.371730 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-28 21:34:15.420096 | instance | skipping: Conditional result was False 2026-05-28 21:34:15.432885 | 2026-05-28 21:34:15.432980 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-28 21:34:15.788315 | instance | ok 2026-05-28 21:34:15.911520 | 2026-05-28 21:34:15.911622 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-28 21:34:19.683740 | instance | Output suppressed because no_log was given 2026-05-28 21:34:19.698055 | 2026-05-28 21:34:19.698166 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-28 21:34:19.902657 | instance | ok: "logs" 2026-05-28 21:34:19.903039 | instance | ok: All items complete 2026-05-28 21:34:19.903079 | 2026-05-28 21:34:20.055836 | instance | ok: "artifacts" 2026-05-28 21:34:20.221410 | instance | ok: "docs" 2026-05-28 21:34:20.231839 | 2026-05-28 21:34:20.231985 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-28 21:34:20.433716 | instance | changed: "logs" 2026-05-28 21:34:20.587909 | instance | changed: "artifacts" 2026-05-28 21:34:20.758836 | instance | changed: "docs" 2026-05-28 21:34:20.910743 | 2026-05-28 21:34:20.910870 | PLAY RECAP 2026-05-28 21:34:20.910927 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-28 21:34:20.910968 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-28 21:34:20.910994 | 2026-05-28 21:34:21.091152 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-28 21:34:21.252704 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-28 21:34:21.912686 | 2026-05-28 21:34:22.038544 | PLAY [all] 2026-05-28 21:34:22.056161 | 2026-05-28 21:34:22.056263 | TASK [setup-uv : Extract archive] 2026-05-28 21:34:24.435575 | instance | changed 2026-05-28 21:34:24.444282 | 2026-05-28 21:34:24.444408 | TASK [setup-uv : Print version] 2026-05-28 21:34:24.866732 | instance | uv 0.8.13 2026-05-28 21:34:24.995764 | instance | ok: Runtime: 0:00:00.015918 2026-05-28 21:34:25.007142 | 2026-05-28 21:34:25.007211 | TASK [Install Ansible collection siblings] 2026-05-28 21:34:25.640868 | instance | ERROR 2026-05-28 21:34:25.703542 | instance | { 2026-05-28 21:34:25.703652 | instance | "log": [ 2026-05-28 21:34:25.703706 | instance | "Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon", 2026-05-28 21:34:25.703752 | instance | "Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix", 2026-05-28 21:34:25.703794 | instance | "Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils", 2026-05-28 21:34:25.703843 | instance | "Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto", 2026-05-28 21:34:25.703886 | instance | "Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general", 2026-05-28 21:34:25.703932 | instance | "Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql", 2026-05-28 21:34:25.703973 | instance | "Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core", 2026-05-28 21:34:25.704015 | instance | "Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph", 2026-05-28 21:34:25.704056 | instance | "Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers", 2026-05-28 21:34:25.704096 | instance | "Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes", 2026-05-28 21:34:25.704137 | instance | "Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common", 2026-05-28 21:34:25.704176 | instance | "Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack", 2026-05-28 21:34:25.704214 | instance | "Resolved ansible.netcommon to v8.5.2 for >=1.2.0", 2026-05-28 21:34:25.704255 | instance | "Resolved ansible.posix to 1.6.0 for 1.6.0", 2026-05-28 21:34:25.704296 | instance | "Resolved ansible.utils to v6.0.2 for >=2.9.0,>=3.0.0", 2026-05-28 21:34:25.704335 | instance | "Resolved community.crypto to 2.2.3 for 2.2.3", 2026-05-28 21:34:25.704374 | instance | "Resolved community.general to 7.3.0 for 7.3.0", 2026-05-28 21:34:25.704413 | instance | "Resolved community.mysql to 3.6.0 for 3.6.0", 2026-05-28 21:34:25.704451 | instance | "Resolved kubernetes.core to 2.4.0 for 2.4.0", 2026-05-28 21:34:25.704489 | instance | "Resolved openstack.cloud to 1.7.0 for 1.7.0", 2026-05-28 21:34:25.704556 | instance | "Resolved atmosphere.common to v0.7.0 for >=0.6.0", 2026-05-28 21:34:25.704598 | instance | "Resolved vexxhost.ceph to v4.0.0 for >=3.1.2", 2026-05-28 21:34:25.704637 | instance | "Resolved vexxhost.kubernetes to v3.1.0 for >=2.3.2,>=2.5.0", 2026-05-28 21:34:25.704676 | instance | "Resolved ansible.utils to v6.0.2 for >=2.9.0,>=3.0.0,>=6.0.0", 2026-05-28 21:34:25.704713 | instance | "Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2" 2026-05-28 21:34:25.704751 | instance | ], 2026-05-28 21:34:25.704792 | instance | "msg": "No local release tag for openstack.cloud satisfies 1.7.0,>=2.0.0" 2026-05-28 21:34:25.704831 | instance | } failure 2026-05-28 21:34:25.710916 | 2026-05-28 21:34:25.711010 | PLAY RECAP 2026-05-28 21:34:25.711098 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-05-28 21:34:25.711146 | 2026-05-28 21:34:25.882346 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-28 21:34:25.889345 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 21:34:26.572640 | 2026-05-28 21:34:26.572776 | PLAY [all] 2026-05-28 21:34:26.584580 | 2026-05-28 21:34:26.584659 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-28 21:34:26.640479 | instance | skipping: Conditional result was False 2026-05-28 21:34:26.696417 | 2026-05-28 21:34:26.696541 | TASK [fetch-output : Set log path for single node] 2026-05-28 21:34:26.760558 | instance | ok 2026-05-28 21:34:26.768055 | 2026-05-28 21:34:26.768125 | LOOP [fetch-output : Ensure local output dirs] 2026-05-28 21:34:27.311334 | instance -> localhost | ok: "/var/lib/zuul/builds/073f5e5424be462caafe2449d7d188aa/work/logs" 2026-05-28 21:34:27.581540 | instance -> localhost | changed: "/var/lib/zuul/builds/073f5e5424be462caafe2449d7d188aa/work/artifacts" 2026-05-28 21:34:27.900524 | instance -> localhost | changed: "/var/lib/zuul/builds/073f5e5424be462caafe2449d7d188aa/work/docs" 2026-05-28 21:34:27.921645 | 2026-05-28 21:34:27.921850 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-28 21:34:28.567756 | instance | ok 2026-05-28 21:34:28.627457 | instance | changed: All items complete 2026-05-28 21:34:28.627552 | 2026-05-28 21:34:29.050366 | instance | changed: .d..t...... ./ 2026-05-28 21:34:29.537087 | instance | changed: .d..t...... ./ 2026-05-28 21:34:29.564949 | 2026-05-28 21:34:29.565137 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-28 21:34:30.013362 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008461 2026-05-28 21:34:30.251211 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008034 2026-05-28 21:34:30.275822 | 2026-05-28 21:34:30.275956 | PLAY [all] 2026-05-28 21:34:30.282802 | 2026-05-28 21:34:30.282876 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-28 21:34:30.708244 | instance | changed 2026-05-28 21:34:30.715592 | 2026-05-28 21:34:30.715643 | PLAY RECAP 2026-05-28 21:34:30.715688 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-28 21:34:30.715710 | 2026-05-28 21:34:30.853819 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 21:34:30.858579 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-28 21:34:31.466389 | 2026-05-28 21:34:31.466517 | PLAY [localhost] 2026-05-28 21:34:31.476537 | 2026-05-28 21:34:31.476610 | TASK [Generate Zuul manifest] 2026-05-28 21:34:31.497704 | localhost | ok 2026-05-28 21:34:31.515544 | 2026-05-28 21:34:31.515626 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-28 21:34:31.963733 | localhost | changed 2026-05-28 21:34:31.976397 | 2026-05-28 21:34:31.976474 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-28 21:34:32.008055 | localhost | ok 2026-05-28 21:34:32.017934 | 2026-05-28 21:34:32.017999 | TASK [Upload logs] 2026-05-28 21:34:32.041122 | localhost | ok 2026-05-28 21:34:32.099710 | 2026-05-28 21:34:32.099843 | TASK [Set zuul-log-path fact] 2026-05-28 21:34:32.122999 | localhost | ok 2026-05-28 21:34:32.137062 | 2026-05-28 21:34:32.137129 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 21:34:32.170183 | localhost | ok 2026-05-28 21:34:32.176784 | 2026-05-28 21:34:32.176852 | TASK [upload-logs : Create log directories] 2026-05-28 21:34:32.582335 | localhost | changed 2026-05-28 21:34:32.587571 | 2026-05-28 21:34:32.587645 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-28 21:34:33.074114 | localhost -> localhost | ok: Runtime: 0:00:00.004913 2026-05-28 21:34:33.079420 | 2026-05-28 21:34:33.079490 | TASK [upload-logs : Upload logs to log server] 2026-05-28 21:34:33.669994 | localhost | Output suppressed because no_log was given 2026-05-28 21:34:33.725876 | 2026-05-28 21:34:33.726029 | LOOP [upload-logs : Compress console log and json output] 2026-05-28 21:34:33.766712 | localhost | skipping: Conditional result was False 2026-05-28 21:34:33.775683 | localhost | skipping: Conditional result was False 2026-05-28 21:34:33.791654 | 2026-05-28 21:34:33.791856 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-28 21:34:33.843293 | localhost | skipping: Conditional result was False 2026-05-28 21:34:33.843618 | 2026-05-28 21:34:33.849482 | localhost | skipping: Conditional result was False 2026-05-28 21:34:33.867457 | 2026-05-28 21:34:33.867649 | LOOP [upload-logs : Upload console log and json output]