2026-06-13 22:43:43.071990 | Job console starting 2026-06-13 22:43:43.082729 | Updating git repos 2026-06-13 22:43:43.821601 | Cloning repos into workspace 2026-06-13 22:43:57.301182 | Restoring repo states 2026-06-13 22:44:06.543603 | Merging changes 2026-06-13 22:44:07.796351 | Checking out repos 2026-06-13 22:44:10.508165 | Preparing playbooks 2026-06-13 22:44:13.142166 | Running Ansible setup 2026-06-13 22:44:16.902893 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-13 22:44:17.514282 | 2026-06-13 22:44:17.514416 | PLAY [localhost] 2026-06-13 22:44:17.523452 | 2026-06-13 22:44:17.523526 | TASK [Gathering Facts] 2026-06-13 22:44:18.422367 | localhost | ok 2026-06-13 22:44:18.432607 | 2026-06-13 22:44:18.432684 | TASK [Setup log path fact] 2026-06-13 22:44:18.464390 | localhost | ok 2026-06-13 22:44:18.475975 | 2026-06-13 22:44:18.476036 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-13 22:44:18.507067 | localhost | ok 2026-06-13 22:44:18.515751 | 2026-06-13 22:44:18.515826 | TASK [emit-job-header : Print job information] 2026-06-13 22:44:18.548404 | # Job Information 2026-06-13 22:44:18.548570 | Ansible Version: 2.16.18 2026-06-13 22:44:18.548612 | Job: atmosphere-molecule-csi-local-path-provisioner 2026-06-13 22:44:18.548642 | Pipeline: check 2026-06-13 22:44:18.548669 | Executor: 2d72f0692154 2026-06-13 22:44:18.548695 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3991 2026-06-13 22:44:18.548726 | Event ID: db68a200-6778-11f1-8371-8dddab958de6 2026-06-13 22:44:18.552506 | 2026-06-13 22:44:18.552589 | LOOP [emit-job-header : Print node information] 2026-06-13 22:44:18.642747 | localhost | ok: 2026-06-13 22:44:18.643039 | localhost | # Node Information 2026-06-13 22:44:18.643073 | localhost | Inventory Hostname: instance 2026-06-13 22:44:18.643095 | localhost | Hostname: np0000179948 2026-06-13 22:44:18.643119 | localhost | Username: zuul 2026-06-13 22:44:18.643147 | localhost | Distro: Ubuntu 22.04 2026-06-13 22:44:18.643171 | localhost | Provider: yul1 2026-06-13 22:44:18.643196 | localhost | Region: ca-ymq-1 2026-06-13 22:44:18.643220 | localhost | Label: ubuntu-jammy 2026-06-13 22:44:18.643244 | localhost | Product Name: OpenStack Nova 2026-06-13 22:44:18.643267 | localhost | Interface IP: 199.204.45.3 2026-06-13 22:44:18.654570 | 2026-06-13 22:44:18.654771 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-13 22:44:19.045445 | localhost -> localhost | changed 2026-06-13 22:44:19.054596 | 2026-06-13 22:44:19.054698 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-13 22:44:19.880454 | localhost -> localhost | changed 2026-06-13 22:44:19.886837 | 2026-06-13 22:44:19.886889 | PLAY [all] 2026-06-13 22:44:19.895059 | 2026-06-13 22:44:19.895126 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-13 22:44:20.131662 | instance -> localhost | ok 2026-06-13 22:44:20.143701 | 2026-06-13 22:44:20.143794 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-13 22:44:20.175704 | instance | ok 2026-06-13 22:44:20.190073 | instance | included: /var/lib/zuul/builds/5818d82740fc4fab8820799cb48709a0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-13 22:44:20.195731 | 2026-06-13 22:44:20.195832 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-13 22:44:21.404352 | instance -> localhost | Generating public/private rsa key pair. 2026-06-13 22:44:21.404553 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/5818d82740fc4fab8820799cb48709a0/work/5818d82740fc4fab8820799cb48709a0_id_rsa 2026-06-13 22:44:21.404584 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/5818d82740fc4fab8820799cb48709a0/work/5818d82740fc4fab8820799cb48709a0_id_rsa.pub 2026-06-13 22:44:21.404607 | instance -> localhost | The key fingerprint is: 2026-06-13 22:44:21.404628 | instance -> localhost | SHA256:iT6eow+ZetJXVlTLEC4ExH3eQzbyMLZEjUZrpUlxnn8 zuul-build-sshkey 2026-06-13 22:44:21.404660 | instance -> localhost | The key's randomart image is: 2026-06-13 22:44:21.404683 | instance -> localhost | +---[RSA 3072]----+ 2026-06-13 22:44:21.404709 | instance -> localhost | | ooo.oB*+ | 2026-06-13 22:44:21.404730 | instance -> localhost | | ...o@X=o | 2026-06-13 22:44:21.404751 | instance -> localhost | | .B*X=. | 2026-06-13 22:44:21.404770 | instance -> localhost | | . ++ +. | 2026-06-13 22:44:21.404790 | instance -> localhost | | . S. .. E| 2026-06-13 22:44:21.404809 | instance -> localhost | | + o . | 2026-06-13 22:44:21.404827 | instance -> localhost | | .+ oo | 2026-06-13 22:44:21.404847 | instance -> localhost | | ..oooo | 2026-06-13 22:44:21.404869 | instance -> localhost | | .o.++. | 2026-06-13 22:44:21.404889 | instance -> localhost | +----[SHA256]-----+ 2026-06-13 22:44:21.404937 | instance -> localhost | ok: Runtime: 0:00:00.799142 2026-06-13 22:44:21.411358 | 2026-06-13 22:44:21.411424 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-13 22:44:21.440994 | instance | ok 2026-06-13 22:44:21.449739 | instance | included: /var/lib/zuul/builds/5818d82740fc4fab8820799cb48709a0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-13 22:44:21.457490 | 2026-06-13 22:44:21.457553 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-13 22:44:21.482623 | instance | skipping: Conditional result was False 2026-06-13 22:44:21.492018 | 2026-06-13 22:44:21.492108 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-13 22:44:21.972890 | instance | changed 2026-06-13 22:44:21.984538 | 2026-06-13 22:44:21.984794 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-13 22:44:22.182520 | instance | ok 2026-06-13 22:44:22.189312 | 2026-06-13 22:44:22.189378 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-13 22:44:23.455661 | instance | changed 2026-06-13 22:44:23.462828 | 2026-06-13 22:44:23.462927 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-13 22:44:23.932363 | instance | changed 2026-06-13 22:44:23.938851 | 2026-06-13 22:44:23.938922 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-13 22:44:23.963573 | instance | skipping: Conditional result was False 2026-06-13 22:44:23.973462 | 2026-06-13 22:44:23.973565 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-13 22:44:24.322671 | instance -> localhost | changed 2026-06-13 22:44:24.335835 | 2026-06-13 22:44:24.335895 | TASK [add-build-sshkey : Add back temp key] 2026-06-13 22:44:24.619348 | instance -> localhost | Identity added: /var/lib/zuul/builds/5818d82740fc4fab8820799cb48709a0/work/5818d82740fc4fab8820799cb48709a0_id_rsa (zuul-build-sshkey) 2026-06-13 22:44:24.619601 | instance -> localhost | ok: Runtime: 0:00:00.015118 2026-06-13 22:44:24.626531 | 2026-06-13 22:44:24.626614 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-13 22:44:24.935053 | instance | ok 2026-06-13 22:44:24.940601 | 2026-06-13 22:44:24.940661 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-13 22:44:24.965705 | instance | skipping: Conditional result was False 2026-06-13 22:44:24.979538 | 2026-06-13 22:44:24.979604 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-13 22:44:25.306239 | instance | ok 2026-06-13 22:44:25.314355 | 2026-06-13 22:44:25.314423 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-13 22:44:28.497925 | instance | Output suppressed because no_log was given 2026-06-13 22:44:28.509412 | 2026-06-13 22:44:28.509476 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-13 22:44:28.702995 | instance | ok: "logs" 2026-06-13 22:44:28.703635 | instance | ok: All items complete 2026-06-13 22:44:28.703668 | 2026-06-13 22:44:28.863862 | instance | ok: "artifacts" 2026-06-13 22:44:29.030003 | instance | ok: "docs" 2026-06-13 22:44:29.046461 | 2026-06-13 22:44:29.046661 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-13 22:44:29.234325 | instance | changed: "logs" 2026-06-13 22:44:29.706864 | instance | changed: "artifacts" 2026-06-13 22:44:31.524573 | instance | changed: "docs" 2026-06-13 22:44:31.547154 | 2026-06-13 22:44:31.547285 | PLAY RECAP 2026-06-13 22:44:31.547333 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-13 22:44:31.547361 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-13 22:44:31.547388 | 2026-06-13 22:44:31.706461 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-13 22:44:31.710530 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-13 22:44:32.341829 | 2026-06-13 22:44:32.341987 | PLAY [all] 2026-06-13 22:44:32.353451 | 2026-06-13 22:44:32.353559 | TASK [setup-uv : Extract archive] 2026-06-13 22:44:35.324892 | instance | changed 2026-06-13 22:44:35.334174 | 2026-06-13 22:44:35.334256 | TASK [setup-uv : Print version] 2026-06-13 22:44:35.664225 | instance | uv 0.8.13 2026-06-13 22:44:35.875128 | instance | ok: Runtime: 0:00:00.012878 2026-06-13 22:44:35.886333 | 2026-06-13 22:44:35.886404 | TASK [Install Ansible collection siblings] 2026-06-13 22:44:36.486164 | instance | ERROR 2026-06-13 22:44:36.486510 | instance | { 2026-06-13 22:44:36.486605 | instance | "log": [ 2026-06-13 22:44:36.486787 | instance | "Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon", 2026-06-13 22:44:36.486822 | instance | "Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix", 2026-06-13 22:44:36.486850 | instance | "Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils", 2026-06-13 22:44:36.486882 | instance | "Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto", 2026-06-13 22:44:36.486909 | instance | "Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general", 2026-06-13 22:44:36.486938 | instance | "Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql", 2026-06-13 22:44:36.486964 | instance | "Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core", 2026-06-13 22:44:36.486988 | instance | "Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph", 2026-06-13 22:44:36.487013 | instance | "Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers", 2026-06-13 22:44:36.487037 | instance | "Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes", 2026-06-13 22:44:36.487062 | instance | "Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common", 2026-06-13 22:44:36.487086 | instance | "Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack", 2026-06-13 22:44:36.487110 | instance | "Resolved ansible.netcommon to v8.5.2 for >=1.2.0", 2026-06-13 22:44:36.487136 | instance | "Resolved ansible.posix to 1.6.0 for 1.6.0", 2026-06-13 22:44:36.487162 | instance | "Resolved ansible.utils to v6.0.2 for >=2.9.0,>=3.0.0", 2026-06-13 22:44:36.487187 | instance | "Resolved community.crypto to 2.2.3 for 2.2.3", 2026-06-13 22:44:36.487212 | instance | "Resolved community.general to 7.3.0 for 7.3.0", 2026-06-13 22:44:36.487236 | instance | "Resolved community.mysql to 3.6.0 for 3.6.0", 2026-06-13 22:44:36.487260 | instance | "Resolved kubernetes.core to 2.4.0 for 2.4.0", 2026-06-13 22:44:36.487284 | instance | "Resolved openstack.cloud to 1.7.0 for 1.7.0", 2026-06-13 22:44:36.487362 | instance | "Resolved atmosphere.common to v0.7.0 for >=0.6.0", 2026-06-13 22:44:36.487392 | instance | "Resolved vexxhost.ceph to v4.0.0 for >=3.1.2", 2026-06-13 22:44:36.487417 | instance | "Resolved vexxhost.kubernetes to v3.2.0 for >=2.3.2,>=2.5.0", 2026-06-13 22:44:36.487444 | instance | "Resolved ansible.utils to v6.0.2 for >=2.9.0,>=3.0.0,>=6.0.0", 2026-06-13 22:44:36.487469 | instance | "Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2" 2026-06-13 22:44:36.487492 | instance | ], 2026-06-13 22:44:36.487516 | instance | "msg": "No local release tag for openstack.cloud satisfies 1.7.0,>=2.0.0" 2026-06-13 22:44:36.487540 | instance | } failure 2026-06-13 22:44:36.490577 | 2026-06-13 22:44:36.490624 | PLAY RECAP 2026-06-13 22:44:36.490667 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-06-13 22:44:36.490688 | 2026-06-13 22:44:36.632839 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-13 22:44:36.636102 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-13 22:44:37.257970 | 2026-06-13 22:44:37.258103 | PLAY [all] 2026-06-13 22:44:37.270170 | 2026-06-13 22:44:37.270261 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-13 22:44:37.315864 | instance | skipping: Conditional result was False 2026-06-13 22:44:37.326294 | 2026-06-13 22:44:37.326459 | TASK [fetch-output : Set log path for single node] 2026-06-13 22:44:37.371636 | instance | ok 2026-06-13 22:44:37.378169 | 2026-06-13 22:44:37.378256 | LOOP [fetch-output : Ensure local output dirs] 2026-06-13 22:44:37.766124 | instance -> localhost | ok: "/var/lib/zuul/builds/5818d82740fc4fab8820799cb48709a0/work/logs" 2026-06-13 22:44:38.004018 | instance -> localhost | changed: "/var/lib/zuul/builds/5818d82740fc4fab8820799cb48709a0/work/artifacts" 2026-06-13 22:44:38.213978 | instance -> localhost | changed: "/var/lib/zuul/builds/5818d82740fc4fab8820799cb48709a0/work/docs" 2026-06-13 22:44:38.237026 | 2026-06-13 22:44:38.237159 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-13 22:44:38.866346 | instance | changed: .d..t...... ./ 2026-06-13 22:44:38.866524 | instance | changed: All items complete 2026-06-13 22:44:38.866552 | 2026-06-13 22:44:39.342648 | instance | changed: .d..t...... ./ 2026-06-13 22:44:39.826403 | instance | changed: .d..t...... ./ 2026-06-13 22:44:39.855215 | 2026-06-13 22:44:39.855344 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-13 22:44:40.447848 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007752 2026-06-13 22:44:40.668541 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007794 2026-06-13 22:44:40.692403 | 2026-06-13 22:44:40.692516 | PLAY [all] 2026-06-13 22:44:40.698502 | 2026-06-13 22:44:40.698571 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-13 22:44:41.099803 | instance | changed 2026-06-13 22:44:41.131603 | 2026-06-13 22:44:41.131729 | PLAY RECAP 2026-06-13 22:44:41.131820 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-13 22:44:41.131869 | 2026-06-13 22:44:41.264551 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-13 22:44:41.270244 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-13 22:44:41.875190 | 2026-06-13 22:44:41.875315 | PLAY [localhost] 2026-06-13 22:44:41.885151 | 2026-06-13 22:44:41.885225 | TASK [Generate Zuul manifest] 2026-06-13 22:44:41.907554 | localhost | ok 2026-06-13 22:44:42.070020 | 2026-06-13 22:44:42.070155 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-13 22:44:42.445536 | localhost | changed 2026-06-13 22:44:42.459092 | 2026-06-13 22:44:42.459206 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-13 22:44:42.492238 | localhost | ok 2026-06-13 22:44:42.500806 | 2026-06-13 22:44:42.500871 | TASK [Upload logs] 2026-06-13 22:44:42.524749 | localhost | ok 2026-06-13 22:44:42.581887 | 2026-06-13 22:44:42.582002 | TASK [Set zuul-log-path fact] 2026-06-13 22:44:42.605532 | localhost | ok 2026-06-13 22:44:42.621275 | 2026-06-13 22:44:42.621349 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-13 22:44:42.653379 | localhost | ok 2026-06-13 22:44:42.660767 | 2026-06-13 22:44:42.660832 | TASK [upload-logs : Create log directories] 2026-06-13 22:44:43.065318 | localhost | changed 2026-06-13 22:44:43.071831 | 2026-06-13 22:44:43.071923 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-13 22:44:43.488164 | localhost -> localhost | ok: Runtime: 0:00:00.005027 2026-06-13 22:44:43.493335 | 2026-06-13 22:44:43.493403 | TASK [upload-logs : Upload logs to log server] 2026-06-13 22:44:43.961535 | localhost | Output suppressed because no_log was given 2026-06-13 22:44:43.999498 | 2026-06-13 22:44:43.999638 | LOOP [upload-logs : Compress console log and json output] 2026-06-13 22:44:44.046462 | localhost | skipping: Conditional result was False 2026-06-13 22:44:44.053406 | localhost | skipping: Conditional result was False 2026-06-13 22:44:44.063866 | 2026-06-13 22:44:44.064011 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-13 22:44:44.105911 | localhost | skipping: Conditional result was False 2026-06-13 22:44:44.106302 | 2026-06-13 22:44:44.110025 | localhost | skipping: Conditional result was False 2026-06-13 22:44:44.121011 | 2026-06-13 22:44:44.121230 | LOOP [upload-logs : Upload console log and json output]