2026-05-29 04:56:35.256383 | Job console starting 2026-05-29 04:56:35.270541 | Updating git repos 2026-05-29 04:56:43.731152 | Cloning repos into workspace 2026-05-29 04:56:58.406393 | Restoring repo states 2026-05-29 04:57:04.550661 | Merging changes 2026-05-29 04:57:07.256566 | Checking out repos 2026-05-29 04:57:13.594759 | Preparing playbooks 2026-05-29 04:57:26.719749 | Running Ansible setup 2026-05-29 04:57:30.861293 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-29 04:57:31.566836 | 2026-05-29 04:57:31.586358 | PLAY [localhost] 2026-05-29 04:57:31.610438 | 2026-05-29 04:57:31.610541 | TASK [Gathering Facts] 2026-05-29 04:57:32.748454 | localhost | ok 2026-05-29 04:57:32.756855 | 2026-05-29 04:57:32.756983 | TASK [Setup log path fact] 2026-05-29 04:57:32.778395 | localhost | ok 2026-05-29 04:57:32.790679 | 2026-05-29 04:57:32.889618 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 04:57:32.922793 | localhost | ok 2026-05-29 04:57:32.930168 | 2026-05-29 04:57:32.930244 | TASK [emit-job-header : Print job information] 2026-05-29 04:57:32.972524 | # Job Information 2026-05-29 04:57:32.972776 | Ansible Version: 2.16.18 2026-05-29 04:57:32.972845 | Job: atmosphere-molecule-csi-local-path-provisioner 2026-05-29 04:57:32.972923 | Pipeline: check 2026-05-29 04:57:32.973006 | Executor: 2d72f0692154 2026-05-29 04:57:32.973051 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3985 2026-05-29 04:57:32.973089 | Event ID: 6ba50450-5b1a-11f1-9af1-a5fe015184d9 2026-05-29 04:57:32.977266 | 2026-05-29 04:57:32.977376 | LOOP [emit-job-header : Print node information] 2026-05-29 04:57:33.102887 | localhost | ok: 2026-05-29 04:57:33.103044 | localhost | # Node Information 2026-05-29 04:57:33.103126 | localhost | Inventory Hostname: instance 2026-05-29 04:57:33.103154 | localhost | Hostname: np0000177464 2026-05-29 04:57:33.103174 | localhost | Username: zuul 2026-05-29 04:57:33.103200 | localhost | Distro: Ubuntu 22.04 2026-05-29 04:57:33.103220 | localhost | Provider: yul1 2026-05-29 04:57:33.103240 | localhost | Region: ca-ymq-1 2026-05-29 04:57:33.103258 | localhost | Label: ubuntu-jammy 2026-05-29 04:57:33.103276 | localhost | Product Name: OpenStack Nova 2026-05-29 04:57:33.103295 | localhost | Interface IP: 199.204.45.89 2026-05-29 04:57:33.110245 | 2026-05-29 04:57:33.110598 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-29 04:57:33.667355 | localhost -> localhost | changed 2026-05-29 04:57:33.672598 | 2026-05-29 04:57:33.672682 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-29 04:57:34.763464 | localhost -> localhost | changed 2026-05-29 04:57:34.771689 | 2026-05-29 04:57:34.771762 | PLAY [all] 2026-05-29 04:57:34.780865 | 2026-05-29 04:57:34.780948 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-29 04:57:35.022265 | instance -> localhost | ok 2026-05-29 04:57:35.028743 | 2026-05-29 04:57:35.028820 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-29 04:57:35.061632 | instance | ok 2026-05-29 04:57:35.089086 | instance | included: /var/lib/zuul/builds/8be80db0b2ca43f3b752c335e0069837/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-29 04:57:35.214640 | 2026-05-29 04:57:35.214805 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-29 04:57:36.276659 | instance -> localhost | Generating public/private rsa key pair. 2026-05-29 04:57:36.276884 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/8be80db0b2ca43f3b752c335e0069837/work/8be80db0b2ca43f3b752c335e0069837_id_rsa 2026-05-29 04:57:36.276927 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/8be80db0b2ca43f3b752c335e0069837/work/8be80db0b2ca43f3b752c335e0069837_id_rsa.pub 2026-05-29 04:57:36.276968 | instance -> localhost | The key fingerprint is: 2026-05-29 04:57:36.276992 | instance -> localhost | SHA256:jxrasj2fW5JjFKr62C/6iICTaan0G/yeu45SSE5koqw zuul-build-sshkey 2026-05-29 04:57:36.277026 | instance -> localhost | The key's randomart image is: 2026-05-29 04:57:36.277047 | instance -> localhost | +---[RSA 3072]----+ 2026-05-29 04:57:36.277071 | instance -> localhost | | | 2026-05-29 04:57:36.277092 | instance -> localhost | |.o | 2026-05-29 04:57:36.277111 | instance -> localhost | |* . | 2026-05-29 04:57:36.277130 | instance -> localhost | |.+ . . | 2026-05-29 04:57:36.277149 | instance -> localhost | |= . . S | 2026-05-29 04:57:36.277167 | instance -> localhost | |E=o. . . + | 2026-05-29 04:57:36.277186 | instance -> localhost | |*+.o. . * o | 2026-05-29 04:57:36.277204 | instance -> localhost | |=+.=*+o+ = | 2026-05-29 04:57:36.277226 | instance -> localhost | |o *BX%Bo+. | 2026-05-29 04:57:36.277245 | instance -> localhost | +----[SHA256]-----+ 2026-05-29 04:57:36.277293 | instance -> localhost | ok: Runtime: 0:00:00.559464 2026-05-29 04:57:36.287953 | 2026-05-29 04:57:36.288018 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-29 04:57:36.325002 | instance | ok 2026-05-29 04:57:36.337169 | instance | included: /var/lib/zuul/builds/8be80db0b2ca43f3b752c335e0069837/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-29 04:57:36.346412 | 2026-05-29 04:57:36.346482 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-29 04:57:36.372492 | instance | skipping: Conditional result was False 2026-05-29 04:57:36.382078 | 2026-05-29 04:57:36.382230 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-29 04:57:36.855851 | instance | changed 2026-05-29 04:57:37.090297 | 2026-05-29 04:57:37.090413 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-29 04:57:37.263484 | instance | ok 2026-05-29 04:57:37.271146 | 2026-05-29 04:57:37.271227 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-29 04:57:37.730683 | instance | changed 2026-05-29 04:57:37.737736 | 2026-05-29 04:57:37.737826 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-29 04:57:38.223267 | instance | changed 2026-05-29 04:57:38.229314 | 2026-05-29 04:57:38.229382 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-29 04:57:38.253666 | instance | skipping: Conditional result was False 2026-05-29 04:57:38.264757 | 2026-05-29 04:57:38.264897 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-29 04:57:38.674027 | instance -> localhost | changed 2026-05-29 04:57:38.683731 | 2026-05-29 04:57:38.683797 | TASK [add-build-sshkey : Add back temp key] 2026-05-29 04:57:38.978022 | instance -> localhost | Identity added: /var/lib/zuul/builds/8be80db0b2ca43f3b752c335e0069837/work/8be80db0b2ca43f3b752c335e0069837_id_rsa (zuul-build-sshkey) 2026-05-29 04:57:38.978263 | instance -> localhost | ok: Runtime: 0:00:00.014881 2026-05-29 04:57:38.983746 | 2026-05-29 04:57:38.983810 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-29 04:57:39.342430 | instance | ok 2026-05-29 04:57:39.349667 | 2026-05-29 04:57:39.349765 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-29 04:57:39.374170 | instance | skipping: Conditional result was False 2026-05-29 04:57:39.390014 | 2026-05-29 04:57:39.390185 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-29 04:57:39.716633 | instance | ok 2026-05-29 04:57:39.722699 | 2026-05-29 04:57:39.722791 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-29 04:57:44.402911 | instance | Output suppressed because no_log was given 2026-05-29 04:57:44.471632 | 2026-05-29 04:57:44.471757 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-29 04:57:44.663775 | instance | ok: "logs" 2026-05-29 04:57:44.664054 | instance | ok: All items complete 2026-05-29 04:57:44.664082 | 2026-05-29 04:57:44.809537 | instance | ok: "artifacts" 2026-05-29 04:57:45.245705 | instance | ok: "docs" 2026-05-29 04:57:45.264018 | 2026-05-29 04:57:45.264213 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-29 04:57:45.454909 | instance | changed: "logs" 2026-05-29 04:57:45.606623 | instance | changed: "artifacts" 2026-05-29 04:57:45.758080 | instance | changed: "docs" 2026-05-29 04:57:45.828606 | 2026-05-29 04:57:45.828697 | PLAY RECAP 2026-05-29 04:57:45.828761 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-29 04:57:45.828801 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-29 04:57:45.828831 | 2026-05-29 04:57:45.972986 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-29 04:57:45.975185 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-29 04:57:46.606390 | 2026-05-29 04:57:46.652949 | PLAY [all] 2026-05-29 04:57:46.674380 | 2026-05-29 04:57:46.674513 | TASK [setup-uv : Extract archive] 2026-05-29 04:57:48.838194 | instance | changed 2026-05-29 04:57:49.185208 | 2026-05-29 04:57:49.185412 | TASK [setup-uv : Print version] 2026-05-29 04:57:49.597414 | instance | uv 0.8.13 2026-05-29 04:57:50.577833 | instance | ok: Runtime: 0:00:00.023000 2026-05-29 04:57:50.587386 | 2026-05-29 04:57:50.587476 | TASK [Install Ansible collection siblings] 2026-05-29 04:57:51.245642 | instance | ERROR 2026-05-29 04:57:52.842353 | instance | { 2026-05-29 04:57:52.842491 | instance | "log": [ 2026-05-29 04:57:52.842542 | instance | "Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon", 2026-05-29 04:57:52.842586 | instance | "Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix", 2026-05-29 04:57:52.842630 | instance | "Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils", 2026-05-29 04:57:52.842683 | instance | "Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto", 2026-05-29 04:57:52.842735 | instance | "Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general", 2026-05-29 04:57:52.842873 | instance | "Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql", 2026-05-29 04:57:52.842933 | instance | "Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core", 2026-05-29 04:57:52.842983 | instance | "Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph", 2026-05-29 04:57:52.843026 | instance | "Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers", 2026-05-29 04:57:52.843068 | instance | "Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes", 2026-05-29 04:57:52.843108 | instance | "Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common", 2026-05-29 04:57:52.843148 | instance | "Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack", 2026-05-29 04:57:52.843218 | instance | "Resolved ansible.netcommon to v8.5.2 for >=1.2.0", 2026-05-29 04:57:52.843309 | instance | "Resolved ansible.posix to 1.6.0 for 1.6.0", 2026-05-29 04:57:52.843366 | instance | "Resolved ansible.utils to v6.0.2 for >=2.9.0,>=3.0.0", 2026-05-29 04:57:52.843406 | instance | "Resolved community.crypto to 2.2.3 for 2.2.3", 2026-05-29 04:57:52.843446 | instance | "Resolved community.general to 7.3.0 for 7.3.0", 2026-05-29 04:57:52.843486 | instance | "Resolved community.mysql to 3.6.0 for 3.6.0", 2026-05-29 04:57:52.843527 | instance | "Resolved kubernetes.core to 2.4.0 for 2.4.0", 2026-05-29 04:57:52.843570 | instance | "Resolved openstack.cloud to 1.7.0 for 1.7.0", 2026-05-29 04:57:52.843626 | instance | "Resolved atmosphere.common to v0.7.0 for >=0.6.0", 2026-05-29 04:57:52.843659 | instance | "Resolved vexxhost.ceph to v4.0.0 for >=3.1.2", 2026-05-29 04:57:52.843687 | instance | "Resolved vexxhost.kubernetes to v3.1.0 for >=2.3.2,>=2.5.0", 2026-05-29 04:57:52.843712 | instance | "Resolved ansible.utils to v6.0.2 for >=2.9.0,>=3.0.0,>=6.0.0", 2026-05-29 04:57:52.843737 | instance | "Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2" 2026-05-29 04:57:52.843762 | instance | ], 2026-05-29 04:57:52.843789 | instance | "msg": "No local release tag for openstack.cloud satisfies 1.7.0,>=2.0.0" 2026-05-29 04:57:52.843815 | instance | } failure 2026-05-29 04:57:52.849396 | 2026-05-29 04:57:52.849505 | PLAY RECAP 2026-05-29 04:57:52.849589 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-05-29 04:57:52.849636 | 2026-05-29 04:57:53.004852 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-29 04:57:53.007703 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 04:57:53.602918 | 2026-05-29 04:57:54.942146 | PLAY [all] 2026-05-29 04:57:54.959487 | 2026-05-29 04:57:54.959626 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-29 04:57:55.004572 | instance | skipping: Conditional result was False 2026-05-29 04:57:55.015194 | 2026-05-29 04:57:55.015273 | TASK [fetch-output : Set log path for single node] 2026-05-29 04:57:55.058936 | instance | ok 2026-05-29 04:57:55.065262 | 2026-05-29 04:57:55.065358 | LOOP [fetch-output : Ensure local output dirs] 2026-05-29 04:57:57.210782 | instance -> localhost | ok: "/var/lib/zuul/builds/8be80db0b2ca43f3b752c335e0069837/work/logs" 2026-05-29 04:57:57.425453 | instance -> localhost | changed: "/var/lib/zuul/builds/8be80db0b2ca43f3b752c335e0069837/work/artifacts" 2026-05-29 04:57:58.412632 | instance -> localhost | changed: "/var/lib/zuul/builds/8be80db0b2ca43f3b752c335e0069837/work/docs" 2026-05-29 04:57:58.431047 | 2026-05-29 04:57:58.431176 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-29 04:57:59.118438 | instance | ok 2026-05-29 04:57:59.153297 | instance | changed: All items complete 2026-05-29 04:57:59.153449 | 2026-05-29 04:57:59.553229 | instance | changed: .d..t...... ./ 2026-05-29 04:58:00.075529 | instance | changed: .d..t...... ./ 2026-05-29 04:58:00.097200 | 2026-05-29 04:58:00.130295 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-29 04:58:00.645888 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007090 2026-05-29 04:58:01.015574 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006337 2026-05-29 04:58:01.034936 | 2026-05-29 04:58:01.035050 | PLAY [all] 2026-05-29 04:58:01.041813 | 2026-05-29 04:58:01.144930 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-29 04:58:01.590458 | instance | changed 2026-05-29 04:58:01.597137 | 2026-05-29 04:58:01.597207 | PLAY RECAP 2026-05-29 04:58:01.597255 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-29 04:58:01.597278 | 2026-05-29 04:58:01.744497 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 04:58:01.881481 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-29 04:58:02.503999 | 2026-05-29 04:58:02.556100 | PLAY [localhost] 2026-05-29 04:58:02.572978 | 2026-05-29 04:58:02.573103 | TASK [Generate Zuul manifest] 2026-05-29 04:58:02.594246 | localhost | ok 2026-05-29 04:58:02.610896 | 2026-05-29 04:58:02.611074 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-29 04:58:03.250802 | localhost | changed 2026-05-29 04:58:03.260858 | 2026-05-29 04:58:03.260975 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-29 04:58:03.292169 | localhost | ok 2026-05-29 04:58:03.304613 | 2026-05-29 04:58:03.304703 | TASK [Upload logs] 2026-05-29 04:58:03.335677 | localhost | ok 2026-05-29 04:58:03.527579 | 2026-05-29 04:58:03.597364 | TASK [Set zuul-log-path fact] 2026-05-29 04:58:03.620287 | localhost | ok 2026-05-29 04:58:03.633666 | 2026-05-29 04:58:03.633752 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 04:58:03.664738 | localhost | ok 2026-05-29 04:58:03.672795 | 2026-05-29 04:58:03.672864 | TASK [upload-logs : Create log directories] 2026-05-29 04:58:04.115425 | localhost | changed 2026-05-29 04:58:04.120371 | 2026-05-29 04:58:04.120454 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-29 04:58:05.012076 | localhost -> localhost | ok: Runtime: 0:00:00.023060 2026-05-29 04:58:05.019174 | 2026-05-29 04:58:05.019293 | TASK [upload-logs : Upload logs to log server] 2026-05-29 04:58:05.678799 | localhost | Output suppressed because no_log was given 2026-05-29 04:58:05.718586 | 2026-05-29 04:58:05.755556 | LOOP [upload-logs : Compress console log and json output] 2026-05-29 04:58:05.810448 | localhost | skipping: Conditional result was False 2026-05-29 04:58:05.819488 | localhost | skipping: Conditional result was False 2026-05-29 04:58:05.830480 | 2026-05-29 04:58:05.862165 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-29 04:58:05.899594 | localhost | skipping: Conditional result was False 2026-05-29 04:58:05.899972 | 2026-05-29 04:58:05.904873 | localhost | skipping: Conditional result was False 2026-05-29 04:58:05.917585 | 2026-05-29 04:58:06.031598 | LOOP [upload-logs : Upload console log and json output]