2026-06-13 00:58:24.975109 | Job console starting 2026-06-13 00:58:25.103728 | Updating git repos 2026-06-13 00:58:28.977263 | Cloning repos into workspace 2026-06-13 00:58:42.118187 | Restoring repo states 2026-06-13 00:58:56.212566 | Merging changes 2026-06-13 00:58:57.330934 | Checking out repos 2026-06-13 00:58:58.965907 | Preparing playbooks 2026-06-13 00:59:03.459708 | Running Ansible setup 2026-06-13 00:59:06.857097 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-13 00:59:07.493678 | 2026-06-13 00:59:07.497884 | PLAY [localhost] 2026-06-13 00:59:07.507421 | 2026-06-13 00:59:07.507532 | TASK [Gathering Facts] 2026-06-13 00:59:08.473099 | localhost | ok 2026-06-13 00:59:08.483746 | 2026-06-13 00:59:08.483824 | TASK [Setup log path fact] 2026-06-13 00:59:08.503241 | localhost | ok 2026-06-13 00:59:08.515588 | 2026-06-13 00:59:08.515656 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-13 00:59:08.546529 | localhost | ok 2026-06-13 00:59:08.554433 | 2026-06-13 00:59:08.554504 | TASK [emit-job-header : Print job information] 2026-06-13 00:59:08.595664 | # Job Information 2026-06-13 00:59:08.595863 | Ansible Version: 2.16.18 2026-06-13 00:59:08.595932 | Job: atmosphere-molecule-aio-ovn 2026-06-13 00:59:08.595980 | Pipeline: check 2026-06-13 00:59:08.596126 | Executor: 2d72f0692154 2026-06-13 00:59:08.596207 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3985 2026-06-13 00:59:08.596262 | Event ID: d5e8fa20-66c2-11f1-9142-8939870a2e2d 2026-06-13 00:59:08.600699 | 2026-06-13 00:59:08.600763 | LOOP [emit-job-header : Print node information] 2026-06-13 00:59:08.691221 | localhost | ok: 2026-06-13 00:59:08.691416 | localhost | # Node Information 2026-06-13 00:59:08.691454 | localhost | Inventory Hostname: instance 2026-06-13 00:59:08.691490 | localhost | Hostname: np0000179851 2026-06-13 00:59:08.691524 | localhost | Username: zuul 2026-06-13 00:59:08.691563 | localhost | Distro: Ubuntu 22.04 2026-06-13 00:59:08.691598 | localhost | Provider: yul1 2026-06-13 00:59:08.691630 | localhost | Region: ca-ymq-1 2026-06-13 00:59:08.691662 | localhost | Label: ubuntu-jammy-16 2026-06-13 00:59:08.691688 | localhost | Product Name: OpenStack Nova 2026-06-13 00:59:08.691713 | localhost | Interface IP: 199.204.45.222 2026-06-13 00:59:08.706534 | 2026-06-13 00:59:08.706685 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-13 00:59:09.095182 | localhost -> localhost | changed 2026-06-13 00:59:09.105269 | 2026-06-13 00:59:09.105336 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-13 00:59:10.025566 | localhost -> localhost | changed 2026-06-13 00:59:10.034785 | 2026-06-13 00:59:10.034868 | PLAY [all] 2026-06-13 00:59:10.043141 | 2026-06-13 00:59:10.043211 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-13 00:59:10.303497 | instance -> localhost | ok 2026-06-13 00:59:10.316050 | 2026-06-13 00:59:10.316156 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-13 00:59:10.350546 | instance | ok 2026-06-13 00:59:10.365588 | instance | included: /var/lib/zuul/builds/d1dcdd47190f4940a5da578a4c6e96e0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-13 00:59:10.371432 | 2026-06-13 00:59:10.371498 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-13 00:59:11.444419 | instance -> localhost | Generating public/private rsa key pair. 2026-06-13 00:59:11.444915 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/d1dcdd47190f4940a5da578a4c6e96e0/work/d1dcdd47190f4940a5da578a4c6e96e0_id_rsa 2026-06-13 00:59:11.445012 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/d1dcdd47190f4940a5da578a4c6e96e0/work/d1dcdd47190f4940a5da578a4c6e96e0_id_rsa.pub 2026-06-13 00:59:11.445053 | instance -> localhost | The key fingerprint is: 2026-06-13 00:59:11.445095 | instance -> localhost | SHA256:OXOemrxB8qd1A5kqO33Yt5tidLYpyHXomg2E3K9jLqA zuul-build-sshkey 2026-06-13 00:59:11.445155 | instance -> localhost | The key's randomart image is: 2026-06-13 00:59:11.445198 | instance -> localhost | +---[RSA 3072]----+ 2026-06-13 00:59:11.445240 | instance -> localhost | | | 2026-06-13 00:59:11.445274 | instance -> localhost | | | 2026-06-13 00:59:11.445304 | instance -> localhost | | | 2026-06-13 00:59:11.445333 | instance -> localhost | | . o . o | 2026-06-13 00:59:11.445361 | instance -> localhost | | + S =. | 2026-06-13 00:59:11.445389 | instance -> localhost | | . = B+o+ | 2026-06-13 00:59:11.445418 | instance -> localhost | | . ..o=B*+oo | 2026-06-13 00:59:11.445447 | instance -> localhost | | E o+B%B.+o | 2026-06-13 00:59:11.445479 | instance -> localhost | | .=@*.++o | 2026-06-13 00:59:11.445508 | instance -> localhost | +----[SHA256]-----+ 2026-06-13 00:59:11.445580 | instance -> localhost | ok: Runtime: 0:00:00.519067 2026-06-13 00:59:11.453902 | 2026-06-13 00:59:11.453970 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-13 00:59:11.501439 | instance | ok 2026-06-13 00:59:11.512575 | instance | included: /var/lib/zuul/builds/d1dcdd47190f4940a5da578a4c6e96e0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-13 00:59:11.521342 | 2026-06-13 00:59:11.521407 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-13 00:59:11.548088 | instance | skipping: Conditional result was False 2026-06-13 00:59:11.555254 | 2026-06-13 00:59:11.555325 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-13 00:59:12.024420 | instance | changed 2026-06-13 00:59:12.031782 | 2026-06-13 00:59:12.031854 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-13 00:59:12.244848 | instance | ok 2026-06-13 00:59:12.249836 | 2026-06-13 00:59:12.249900 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-13 00:59:12.711532 | instance | changed 2026-06-13 00:59:12.717149 | 2026-06-13 00:59:12.717226 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-13 00:59:13.157084 | instance | changed 2026-06-13 00:59:13.162630 | 2026-06-13 00:59:13.162703 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-13 00:59:13.187590 | instance | skipping: Conditional result was False 2026-06-13 00:59:13.199284 | 2026-06-13 00:59:13.199397 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-13 00:59:13.508838 | instance -> localhost | changed 2026-06-13 00:59:13.525813 | 2026-06-13 00:59:13.525887 | TASK [add-build-sshkey : Add back temp key] 2026-06-13 00:59:13.809104 | instance -> localhost | Identity added: /var/lib/zuul/builds/d1dcdd47190f4940a5da578a4c6e96e0/work/d1dcdd47190f4940a5da578a4c6e96e0_id_rsa (zuul-build-sshkey) 2026-06-13 00:59:13.809388 | instance -> localhost | ok: Runtime: 0:00:00.013006 2026-06-13 00:59:13.825202 | 2026-06-13 00:59:13.825569 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-13 00:59:14.111750 | instance | ok 2026-06-13 00:59:14.127475 | 2026-06-13 00:59:14.127588 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-13 00:59:14.156412 | instance | skipping: Conditional result was False 2026-06-13 00:59:14.170271 | 2026-06-13 00:59:14.170368 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-13 00:59:14.466274 | instance | ok 2026-06-13 00:59:14.472642 | 2026-06-13 00:59:14.472705 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-13 00:59:17.798318 | instance | Output suppressed because no_log was given 2026-06-13 00:59:17.808711 | 2026-06-13 00:59:17.808773 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-13 00:59:18.009374 | instance | ok: "logs" 2026-06-13 00:59:18.009598 | instance | ok: All items complete 2026-06-13 00:59:18.009626 | 2026-06-13 00:59:18.156994 | instance | ok: "artifacts" 2026-06-13 00:59:18.309104 | instance | ok: "docs" 2026-06-13 00:59:18.329695 | 2026-06-13 00:59:18.329770 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-13 00:59:18.518957 | instance | changed: "logs" 2026-06-13 00:59:18.671843 | instance | changed: "artifacts" 2026-06-13 00:59:18.830592 | instance | changed: "docs" 2026-06-13 00:59:18.850582 | 2026-06-13 00:59:18.851011 | PLAY RECAP 2026-06-13 00:59:18.851109 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-13 00:59:18.851153 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-13 00:59:18.851178 | 2026-06-13 00:59:19.034828 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-13 00:59:19.048393 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-13 00:59:19.671924 | 2026-06-13 00:59:19.672046 | PLAY [all] 2026-06-13 00:59:19.683185 | 2026-06-13 00:59:19.683265 | TASK [setup-uv : Extract archive] 2026-06-13 00:59:21.963867 | instance | changed 2026-06-13 00:59:21.971423 | 2026-06-13 00:59:21.971507 | TASK [setup-uv : Print version] 2026-06-13 00:59:22.344819 | instance | uv 0.8.13 2026-06-13 00:59:22.517561 | instance | ok: Runtime: 0:00:00.011794 2026-06-13 00:59:22.528398 | 2026-06-13 00:59:22.528469 | TASK [Install Ansible collection siblings] 2026-06-13 00:59:23.135138 | instance | ERROR 2026-06-13 00:59:23.135393 | instance | { 2026-06-13 00:59:23.135425 | instance | "log": [ 2026-06-13 00:59:23.135447 | instance | "Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon", 2026-06-13 00:59:23.135472 | instance | "Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix", 2026-06-13 00:59:23.135497 | instance | "Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils", 2026-06-13 00:59:23.135520 | instance | "Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto", 2026-06-13 00:59:23.135566 | instance | "Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general", 2026-06-13 00:59:23.135587 | instance | "Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql", 2026-06-13 00:59:23.135606 | instance | "Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core", 2026-06-13 00:59:23.135624 | instance | "Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph", 2026-06-13 00:59:23.135642 | instance | "Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers", 2026-06-13 00:59:23.135660 | instance | "Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes", 2026-06-13 00:59:23.135678 | instance | "Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common", 2026-06-13 00:59:23.135696 | instance | "Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack", 2026-06-13 00:59:23.135714 | instance | "Resolved ansible.netcommon to v8.5.2 for >=1.2.0", 2026-06-13 00:59:23.135732 | instance | "Resolved ansible.posix to 1.6.0 for 1.6.0", 2026-06-13 00:59:23.135750 | instance | "Resolved ansible.utils to v6.0.2 for >=2.9.0,>=3.0.0", 2026-06-13 00:59:23.135768 | instance | "Resolved community.crypto to 2.2.3 for 2.2.3", 2026-06-13 00:59:23.135785 | instance | "Resolved community.general to 7.3.0 for 7.3.0", 2026-06-13 00:59:23.135803 | instance | "Resolved community.mysql to 3.6.0 for 3.6.0", 2026-06-13 00:59:23.135820 | instance | "Resolved kubernetes.core to 2.4.0 for 2.4.0", 2026-06-13 00:59:23.135837 | instance | "Resolved openstack.cloud to 1.7.0 for 1.7.0", 2026-06-13 00:59:23.135856 | instance | "Resolved atmosphere.common to v0.7.0 for >=0.6.0", 2026-06-13 00:59:23.135880 | instance | "Resolved vexxhost.ceph to v4.0.0 for >=3.1.2", 2026-06-13 00:59:23.135899 | instance | "Resolved vexxhost.kubernetes to v3.2.0 for >=2.3.2,>=2.5.0", 2026-06-13 00:59:23.135917 | instance | "Resolved ansible.utils to v6.0.2 for >=2.9.0,>=3.0.0,>=6.0.0", 2026-06-13 00:59:23.135934 | instance | "Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2" 2026-06-13 00:59:23.135951 | instance | ], 2026-06-13 00:59:23.135969 | instance | "msg": "No local release tag for openstack.cloud satisfies 1.7.0,>=2.0.0" 2026-06-13 00:59:23.135986 | instance | } failure 2026-06-13 00:59:23.139349 | 2026-06-13 00:59:23.139397 | PLAY RECAP 2026-06-13 00:59:23.139444 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-06-13 00:59:23.139466 | 2026-06-13 00:59:23.305958 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-13 00:59:23.318978 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-13 00:59:24.019954 | 2026-06-13 00:59:24.020081 | PLAY [all] 2026-06-13 00:59:24.030933 | 2026-06-13 00:59:24.031007 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-13 00:59:24.076296 | instance | skipping: Conditional result was False 2026-06-13 00:59:24.088294 | 2026-06-13 00:59:24.088378 | TASK [fetch-output : Set log path for single node] 2026-06-13 00:59:24.131007 | instance | ok 2026-06-13 00:59:24.136921 | 2026-06-13 00:59:24.137015 | LOOP [fetch-output : Ensure local output dirs] 2026-06-13 00:59:24.527430 | instance -> localhost | ok: "/var/lib/zuul/builds/d1dcdd47190f4940a5da578a4c6e96e0/work/logs" 2026-06-13 00:59:24.741105 | instance -> localhost | changed: "/var/lib/zuul/builds/d1dcdd47190f4940a5da578a4c6e96e0/work/artifacts" 2026-06-13 00:59:24.943700 | instance -> localhost | changed: "/var/lib/zuul/builds/d1dcdd47190f4940a5da578a4c6e96e0/work/docs" 2026-06-13 00:59:24.957681 | 2026-06-13 00:59:24.957802 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-13 00:59:25.575060 | instance | ok 2026-06-13 00:59:25.575313 | instance | changed: All items complete 2026-06-13 00:59:25.575353 | 2026-06-13 00:59:26.007096 | instance | changed: .d..t...... ./ 2026-06-13 00:59:26.481425 | instance | changed: .d..t...... ./ 2026-06-13 00:59:26.498745 | 2026-06-13 00:59:26.498872 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-13 00:59:26.887563 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008059 2026-06-13 00:59:27.127286 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007678 2026-06-13 00:59:27.142483 | 2026-06-13 00:59:27.142651 | PLAY [all] 2026-06-13 00:59:27.149604 | 2026-06-13 00:59:27.149687 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-13 00:59:29.867341 | instance | changed 2026-06-13 00:59:29.876742 | 2026-06-13 00:59:29.876839 | PLAY RECAP 2026-06-13 00:59:29.876919 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-13 00:59:29.876958 | 2026-06-13 00:59:30.043967 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-13 00:59:30.057562 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-13 00:59:30.676083 | 2026-06-13 00:59:30.676216 | PLAY [localhost] 2026-06-13 00:59:30.686332 | 2026-06-13 00:59:30.686428 | TASK [Generate Zuul manifest] 2026-06-13 00:59:30.709709 | localhost | ok 2026-06-13 00:59:30.729392 | 2026-06-13 00:59:30.729550 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-13 00:59:31.125705 | localhost | changed 2026-06-13 00:59:31.139010 | 2026-06-13 00:59:31.139175 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-13 00:59:31.174247 | localhost | ok 2026-06-13 00:59:31.182662 | 2026-06-13 00:59:31.182804 | TASK [Upload logs] 2026-06-13 00:59:31.204557 | localhost | ok 2026-06-13 00:59:31.351307 | 2026-06-13 00:59:31.351666 | TASK [Set zuul-log-path fact] 2026-06-13 00:59:31.374831 | localhost | ok 2026-06-13 00:59:31.395929 | 2026-06-13 00:59:31.396127 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-13 00:59:31.430208 | localhost | ok 2026-06-13 00:59:31.438282 | 2026-06-13 00:59:31.438352 | TASK [upload-logs : Create log directories] 2026-06-13 00:59:31.817134 | localhost | changed 2026-06-13 00:59:31.824727 | 2026-06-13 00:59:31.824810 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-13 00:59:32.365692 | localhost -> localhost | ok: Runtime: 0:00:00.168197 2026-06-13 00:59:32.373109 | 2026-06-13 00:59:32.373211 | TASK [upload-logs : Upload logs to log server] 2026-06-13 00:59:32.811591 | localhost | Output suppressed because no_log was given 2026-06-13 00:59:32.816735 | 2026-06-13 00:59:32.816821 | LOOP [upload-logs : Compress console log and json output] 2026-06-13 00:59:32.862081 | localhost | skipping: Conditional result was False 2026-06-13 00:59:32.869669 | localhost | skipping: Conditional result was False 2026-06-13 00:59:32.883229 | 2026-06-13 00:59:32.883344 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-13 00:59:32.929759 | localhost | skipping: Conditional result was False 2026-06-13 00:59:32.930050 | 2026-06-13 00:59:32.934414 | localhost | skipping: Conditional result was False 2026-06-13 00:59:32.946910 | 2026-06-13 00:59:32.947108 | LOOP [upload-logs : Upload console log and json output]