2026-06-13 22:39:01.236666 | Job console starting 2026-06-13 22:39:01.252200 | Updating git repos 2026-06-13 22:39:01.909456 | Cloning repos into workspace 2026-06-13 22:39:24.646427 | Restoring repo states 2026-06-13 22:39:31.183175 | Merging changes 2026-06-13 22:39:33.127970 | Checking out repos 2026-06-13 22:39:35.790980 | Preparing playbooks 2026-06-13 22:39:39.006324 | Running Ansible setup 2026-06-13 22:39:43.476497 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-13 22:39:44.212581 | 2026-06-13 22:39:44.212709 | PLAY [localhost] 2026-06-13 22:39:44.220446 | 2026-06-13 22:39:44.220517 | TASK [Gathering Facts] 2026-06-13 22:39:45.246293 | localhost | ok 2026-06-13 22:39:45.257495 | 2026-06-13 22:39:45.257610 | TASK [Setup log path fact] 2026-06-13 22:39:45.290444 | localhost | ok 2026-06-13 22:39:45.304445 | 2026-06-13 22:39:45.304543 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-13 22:39:45.357327 | localhost | ok 2026-06-13 22:39:45.367864 | 2026-06-13 22:39:45.367972 | TASK [emit-job-header : Print job information] 2026-06-13 22:39:45.453422 | # Job Information 2026-06-13 22:39:45.453644 | Ansible Version: 2.16.18 2026-06-13 22:39:45.453694 | Job: atmosphere-molecule-aio-openvswitch 2026-06-13 22:39:45.453727 | Pipeline: check 2026-06-13 22:39:45.453757 | Executor: 2d72f0692154 2026-06-13 22:39:45.453819 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3985 2026-06-13 22:39:45.453857 | Event ID: 4d2da710-6778-11f1-8c8c-c662a9bb5d8b 2026-06-13 22:39:45.459107 | 2026-06-13 22:39:45.459242 | LOOP [emit-job-header : Print node information] 2026-06-13 22:39:45.563896 | localhost | ok: 2026-06-13 22:39:45.564197 | localhost | # Node Information 2026-06-13 22:39:45.564251 | localhost | Inventory Hostname: instance 2026-06-13 22:39:45.564285 | localhost | Hostname: np0000179920 2026-06-13 22:39:45.564314 | localhost | Username: zuul 2026-06-13 22:39:45.564356 | localhost | Distro: Ubuntu 22.04 2026-06-13 22:39:45.564399 | localhost | Provider: yul1 2026-06-13 22:39:45.564436 | localhost | Region: ca-ymq-1 2026-06-13 22:39:45.564472 | localhost | Label: ubuntu-jammy-16 2026-06-13 22:39:45.564500 | localhost | Product Name: OpenStack Nova 2026-06-13 22:39:45.564536 | localhost | Interface IP: 199.204.45.227 2026-06-13 22:39:45.586954 | 2026-06-13 22:39:45.587061 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-13 22:39:46.348912 | localhost -> localhost | changed 2026-06-13 22:39:46.356902 | 2026-06-13 22:39:46.357042 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-13 22:39:47.553362 | localhost -> localhost | changed 2026-06-13 22:39:47.566885 | 2026-06-13 22:39:47.566943 | PLAY [all] 2026-06-13 22:39:47.581972 | 2026-06-13 22:39:47.582044 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-13 22:39:48.186750 | instance -> localhost | ok 2026-06-13 22:39:48.196358 | 2026-06-13 22:39:48.196431 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-13 22:39:48.241449 | instance | ok 2026-06-13 22:39:48.259329 | instance | included: /var/lib/zuul/builds/af1c54dd8af14c8c927a46cc112e7f07/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-13 22:39:48.265367 | 2026-06-13 22:39:48.265433 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-13 22:39:49.703689 | instance -> localhost | Generating public/private rsa key pair. 2026-06-13 22:39:49.703924 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/af1c54dd8af14c8c927a46cc112e7f07/work/af1c54dd8af14c8c927a46cc112e7f07_id_rsa 2026-06-13 22:39:49.703969 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/af1c54dd8af14c8c927a46cc112e7f07/work/af1c54dd8af14c8c927a46cc112e7f07_id_rsa.pub 2026-06-13 22:39:49.704003 | instance -> localhost | The key fingerprint is: 2026-06-13 22:39:49.704034 | instance -> localhost | SHA256:+RBM7w13/UJdjiitv/q8AHiGS6gCjFO1wstBOwzLcDI zuul-build-sshkey 2026-06-13 22:39:49.704082 | instance -> localhost | The key's randomart image is: 2026-06-13 22:39:49.704116 | instance -> localhost | +---[RSA 3072]----+ 2026-06-13 22:39:49.704154 | instance -> localhost | |E o . . .| 2026-06-13 22:39:49.704187 | instance -> localhost | |oX o . o . . . =.| 2026-06-13 22:39:49.704218 | instance -> localhost | |..O . o + + + +| 2026-06-13 22:39:49.704248 | instance -> localhost | |oo = . o + * o .| 2026-06-13 22:39:49.704278 | instance -> localhost | |+.o . + S o . . .| 2026-06-13 22:39:49.704308 | instance -> localhost | |.. . . + + . . | 2026-06-13 22:39:49.704338 | instance -> localhost | |. . . o . | 2026-06-13 22:39:49.704369 | instance -> localhost | | . o . | 2026-06-13 22:39:49.704403 | instance -> localhost | | .o=. | 2026-06-13 22:39:49.704434 | instance -> localhost | +----[SHA256]-----+ 2026-06-13 22:39:49.704499 | instance -> localhost | ok: Runtime: 0:00:00.932955 2026-06-13 22:39:49.712434 | 2026-06-13 22:39:49.712504 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-13 22:39:49.755061 | instance | ok 2026-06-13 22:39:49.763234 | instance | included: /var/lib/zuul/builds/af1c54dd8af14c8c927a46cc112e7f07/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-13 22:39:49.770567 | 2026-06-13 22:39:49.770632 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-13 22:39:49.797326 | instance | skipping: Conditional result was False 2026-06-13 22:39:49.804081 | 2026-06-13 22:39:49.804176 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-13 22:39:50.258401 | instance | changed 2026-06-13 22:39:50.270135 | 2026-06-13 22:39:50.270205 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-13 22:39:50.498085 | instance | ok 2026-06-13 22:39:50.725396 | 2026-06-13 22:39:50.725641 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-13 22:39:51.207878 | instance | changed 2026-06-13 22:39:51.617289 | 2026-06-13 22:39:51.617499 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-13 22:39:52.096878 | instance | changed 2026-06-13 22:39:52.105375 | 2026-06-13 22:39:52.105545 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-13 22:39:52.132186 | instance | skipping: Conditional result was False 2026-06-13 22:39:52.141795 | 2026-06-13 22:39:52.141941 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-13 22:39:52.657580 | instance -> localhost | changed 2026-06-13 22:39:52.672994 | 2026-06-13 22:39:52.673108 | TASK [add-build-sshkey : Add back temp key] 2026-06-13 22:39:53.164559 | instance -> localhost | Identity added: /var/lib/zuul/builds/af1c54dd8af14c8c927a46cc112e7f07/work/af1c54dd8af14c8c927a46cc112e7f07_id_rsa (zuul-build-sshkey) 2026-06-13 22:39:53.164984 | instance -> localhost | ok: Runtime: 0:00:00.019049 2026-06-13 22:39:53.172686 | 2026-06-13 22:39:53.172777 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-13 22:39:53.439569 | instance | ok 2026-06-13 22:39:53.446517 | 2026-06-13 22:39:53.446582 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-13 22:39:53.471669 | instance | skipping: Conditional result was False 2026-06-13 22:39:53.484117 | 2026-06-13 22:39:53.484208 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-13 22:39:53.836478 | instance | ok 2026-06-13 22:39:53.850960 | 2026-06-13 22:39:53.851423 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-13 22:39:58.437795 | instance | Output suppressed because no_log was given 2026-06-13 22:39:58.448661 | 2026-06-13 22:39:58.448732 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-13 22:39:58.648986 | instance | ok: "logs" 2026-06-13 22:39:58.843210 | instance | ok: All items complete 2026-06-13 22:39:58.843943 | 2026-06-13 22:39:58.858128 | instance | ok: "artifacts" 2026-06-13 22:39:58.961592 | instance | ok: "docs" 2026-06-13 22:39:58.979542 | 2026-06-13 22:39:58.979635 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-13 22:39:59.170340 | instance | changed: "logs" 2026-06-13 22:39:59.332000 | instance | changed: "artifacts" 2026-06-13 22:39:59.483079 | instance | changed: "docs" 2026-06-13 22:39:59.492823 | 2026-06-13 22:39:59.492890 | PLAY RECAP 2026-06-13 22:39:59.492937 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-13 22:39:59.492967 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-13 22:39:59.492994 | 2026-06-13 22:39:59.815699 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-13 22:39:59.832934 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-13 22:40:00.573883 | 2026-06-13 22:40:00.930169 | PLAY [all] 2026-06-13 22:40:00.943643 | 2026-06-13 22:40:00.943769 | TASK [setup-uv : Extract archive] 2026-06-13 22:40:03.342043 | instance | changed 2026-06-13 22:40:03.351033 | 2026-06-13 22:40:03.351159 | TASK [setup-uv : Print version] 2026-06-13 22:40:03.737657 | instance | uv 0.8.13 2026-06-13 22:40:04.079521 | instance | ok: Runtime: 0:00:00.012301 2026-06-13 22:40:04.093837 | 2026-06-13 22:40:04.093987 | TASK [Install Ansible collection siblings] 2026-06-13 22:40:04.740341 | instance | ERROR 2026-06-13 22:40:04.799350 | instance | { 2026-06-13 22:40:04.799452 | instance | "log": [ 2026-06-13 22:40:04.799506 | instance | "Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon", 2026-06-13 22:40:04.799565 | instance | "Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix", 2026-06-13 22:40:04.799609 | instance | "Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils", 2026-06-13 22:40:04.799658 | instance | "Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto", 2026-06-13 22:40:04.799700 | instance | "Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general", 2026-06-13 22:40:04.799746 | instance | "Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql", 2026-06-13 22:40:04.799788 | instance | "Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core", 2026-06-13 22:40:04.799827 | instance | "Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph", 2026-06-13 22:40:04.799866 | instance | "Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers", 2026-06-13 22:40:04.799906 | instance | "Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes", 2026-06-13 22:40:04.799945 | instance | "Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common", 2026-06-13 22:40:04.799983 | instance | "Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack", 2026-06-13 22:40:04.800021 | instance | "Resolved ansible.netcommon to v8.5.2 for >=1.2.0", 2026-06-13 22:40:04.800061 | instance | "Resolved ansible.posix to 1.6.0 for 1.6.0", 2026-06-13 22:40:04.800107 | instance | "Resolved ansible.utils to v6.0.2 for >=2.9.0,>=3.0.0", 2026-06-13 22:40:04.800163 | instance | "Resolved community.crypto to 2.2.3 for 2.2.3", 2026-06-13 22:40:04.800207 | instance | "Resolved community.general to 7.3.0 for 7.3.0", 2026-06-13 22:40:04.800248 | instance | "Resolved community.mysql to 3.6.0 for 3.6.0", 2026-06-13 22:40:04.800287 | instance | "Resolved kubernetes.core to 2.4.0 for 2.4.0", 2026-06-13 22:40:04.800326 | instance | "Resolved openstack.cloud to 1.7.0 for 1.7.0", 2026-06-13 22:40:04.800368 | instance | "Resolved atmosphere.common to v0.7.0 for >=0.6.0", 2026-06-13 22:40:04.800427 | instance | "Resolved vexxhost.ceph to v4.0.0 for >=3.1.2", 2026-06-13 22:40:04.800471 | instance | "Resolved vexxhost.kubernetes to v3.2.0 for >=2.3.2,>=2.5.0", 2026-06-13 22:40:04.800511 | instance | "Resolved ansible.utils to v6.0.2 for >=2.9.0,>=3.0.0,>=6.0.0", 2026-06-13 22:40:04.800550 | instance | "Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2" 2026-06-13 22:40:04.800588 | instance | ], 2026-06-13 22:40:04.800627 | instance | "msg": "No local release tag for openstack.cloud satisfies 1.7.0,>=2.0.0" 2026-06-13 22:40:04.800665 | instance | } failure 2026-06-13 22:40:04.807605 | 2026-06-13 22:40:04.807655 | PLAY RECAP 2026-06-13 22:40:04.807700 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-06-13 22:40:04.807722 | 2026-06-13 22:40:05.093388 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-13 22:40:05.111172 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-13 22:40:05.779446 | 2026-06-13 22:40:05.932850 | PLAY [all] 2026-06-13 22:40:05.949359 | 2026-06-13 22:40:05.949508 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-13 22:40:05.986218 | instance | skipping: Conditional result was False 2026-06-13 22:40:05.997613 | 2026-06-13 22:40:05.997814 | TASK [fetch-output : Set log path for single node] 2026-06-13 22:40:06.041633 | instance | ok 2026-06-13 22:40:06.186380 | 2026-06-13 22:40:06.186530 | LOOP [fetch-output : Ensure local output dirs] 2026-06-13 22:40:06.760760 | instance -> localhost | ok: "/var/lib/zuul/builds/af1c54dd8af14c8c927a46cc112e7f07/work/logs" 2026-06-13 22:40:07.082888 | instance -> localhost | changed: "/var/lib/zuul/builds/af1c54dd8af14c8c927a46cc112e7f07/work/artifacts" 2026-06-13 22:40:07.618706 | instance -> localhost | changed: "/var/lib/zuul/builds/af1c54dd8af14c8c927a46cc112e7f07/work/docs" 2026-06-13 22:40:07.637292 | 2026-06-13 22:40:07.785151 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-13 22:40:08.427633 | instance | ok 2026-06-13 22:40:08.477723 | instance | changed: All items complete 2026-06-13 22:40:08.477911 | 2026-06-13 22:40:08.918209 | instance | changed: .d..t...... ./ 2026-06-13 22:40:09.434794 | instance | changed: .d..t...... ./ 2026-06-13 22:40:09.459847 | 2026-06-13 22:40:09.460052 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-13 22:40:10.531259 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008281 2026-06-13 22:40:11.019242 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.250243 2026-06-13 22:40:11.035380 | 2026-06-13 22:40:11.035509 | PLAY [all] 2026-06-13 22:40:11.041908 | 2026-06-13 22:40:11.041976 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-13 22:40:11.468580 | instance | changed 2026-06-13 22:40:11.626698 | 2026-06-13 22:40:11.626789 | PLAY RECAP 2026-06-13 22:40:11.626838 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-13 22:40:11.626860 | 2026-06-13 22:40:11.781435 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-13 22:40:11.795203 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-13 22:40:12.681896 | 2026-06-13 22:40:12.682063 | PLAY [localhost] 2026-06-13 22:40:12.693965 | 2026-06-13 22:40:12.694035 | TASK [Generate Zuul manifest] 2026-06-13 22:40:12.720408 | localhost | ok 2026-06-13 22:40:12.735842 | 2026-06-13 22:40:12.735923 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-13 22:40:13.720372 | localhost | changed 2026-06-13 22:40:13.749471 | 2026-06-13 22:40:13.749682 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-13 22:40:13.792721 | localhost | ok 2026-06-13 22:40:13.801113 | 2026-06-13 22:40:13.801191 | TASK [Upload logs] 2026-06-13 22:40:13.836465 | localhost | ok 2026-06-13 22:40:13.965825 | 2026-06-13 22:40:13.965963 | TASK [Set zuul-log-path fact] 2026-06-13 22:40:13.990276 | localhost | ok 2026-06-13 22:40:14.004508 | 2026-06-13 22:40:14.004625 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-13 22:40:14.050037 | localhost | ok 2026-06-13 22:40:14.057377 | 2026-06-13 22:40:14.057448 | TASK [upload-logs : Create log directories] 2026-06-13 22:40:15.114417 | localhost | changed 2026-06-13 22:40:15.120354 | 2026-06-13 22:40:15.120514 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-13 22:40:16.440375 | localhost -> localhost | ok: Runtime: 0:00:00.006688 2026-06-13 22:40:16.445838 | 2026-06-13 22:40:16.445913 | TASK [upload-logs : Upload logs to log server] 2026-06-13 22:40:17.347014 | localhost | Output suppressed because no_log was given 2026-06-13 22:40:17.351072 | 2026-06-13 22:40:17.351149 | LOOP [upload-logs : Compress console log and json output] 2026-06-13 22:40:17.401913 | localhost | skipping: Conditional result was False 2026-06-13 22:40:17.409754 | localhost | skipping: Conditional result was False 2026-06-13 22:40:17.424238 | 2026-06-13 22:40:17.424430 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-13 22:40:17.470487 | localhost | skipping: Conditional result was False 2026-06-13 22:40:17.566511 | 2026-06-13 22:40:17.567814 | localhost | skipping: Conditional result was False 2026-06-13 22:40:17.597933 | 2026-06-13 22:40:17.598079 | LOOP [upload-logs : Upload console log and json output]