2026-05-14 09:59:41.621867 | Job console starting 2026-05-14 09:59:41.637956 | Updating git repos 2026-05-14 09:59:41.687125 | Cloning repos into workspace 2026-05-14 09:59:42.204044 | Restoring repo states 2026-05-14 09:59:42.211730 | Merging changes 2026-05-14 09:59:42.673824 | Checking out repos 2026-05-14 09:59:42.870444 | Preparing playbooks 2026-05-14 09:59:44.601488 | Running Ansible setup 2026-05-14 09:59:49.228058 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-14 09:59:49.989864 | 2026-05-14 09:59:50.304189 | PLAY [localhost] 2026-05-14 09:59:50.316820 | 2026-05-14 09:59:50.316972 | TASK [Gathering Facts] 2026-05-14 09:59:51.469776 | localhost | ok 2026-05-14 09:59:51.484173 | 2026-05-14 09:59:51.484315 | TASK [Setup log path fact] 2026-05-14 09:59:51.517420 | localhost | ok 2026-05-14 09:59:51.543439 | 2026-05-14 09:59:51.543584 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-14 09:59:51.581931 | localhost | ok 2026-05-14 09:59:51.600830 | 2026-05-14 09:59:51.601012 | TASK [emit-job-header : Print job information] 2026-05-14 09:59:51.643267 | # Job Information 2026-05-14 09:59:51.643424 | Ansible Version: 2.16.18 2026-05-14 09:59:51.643457 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9 2026-05-14 09:59:51.643480 | Pipeline: check 2026-05-14 09:59:51.643501 | Executor: 2d72f0692154 2026-05-14 09:59:51.643521 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/129 2026-05-14 09:59:51.643543 | Event ID: e1cdee90-4f7a-11f1-8e86-6e434c085c6c 2026-05-14 09:59:51.647351 | 2026-05-14 09:59:51.647432 | LOOP [emit-job-header : Print node information] 2026-05-14 09:59:51.778358 | localhost | ok: 2026-05-14 09:59:51.778529 | localhost | # Node Information 2026-05-14 09:59:51.778559 | localhost | Inventory Hostname: rockylinux-9 2026-05-14 09:59:51.778582 | localhost | Hostname: np0000174158 2026-05-14 09:59:51.778603 | localhost | Username: zuul 2026-05-14 09:59:51.778627 | localhost | Distro: Rocky 9.7 2026-05-14 09:59:51.778648 | localhost | Provider: yul1 2026-05-14 09:59:51.778668 | localhost | Region: ca-ymq-1 2026-05-14 09:59:51.778688 | localhost | Label: rockylinux-9 2026-05-14 09:59:51.778707 | localhost | Product Name: OpenStack Nova 2026-05-14 09:59:51.778726 | localhost | Interface IP: 199.19.213.188 2026-05-14 09:59:51.793921 | 2026-05-14 09:59:51.794056 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-14 09:59:52.361559 | localhost -> localhost | changed 2026-05-14 09:59:52.371223 | 2026-05-14 09:59:52.371516 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-14 09:59:53.694011 | localhost -> localhost | changed 2026-05-14 09:59:53.709624 | 2026-05-14 09:59:53.709752 | PLAY [all] 2026-05-14 09:59:53.733227 | 2026-05-14 09:59:53.733367 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-14 09:59:54.088158 | rockylinux-9 -> localhost | ok 2026-05-14 09:59:54.095480 | 2026-05-14 09:59:54.095618 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-14 09:59:54.138162 | rockylinux-9 | ok 2026-05-14 09:59:54.168180 | rockylinux-9 | included: /var/lib/zuul/builds/67732213cdd240cb9566f2b0c762a89d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-14 09:59:54.182093 | 2026-05-14 09:59:54.182244 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-14 09:59:55.344390 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-05-14 09:59:55.344613 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/67732213cdd240cb9566f2b0c762a89d/work/67732213cdd240cb9566f2b0c762a89d_id_rsa 2026-05-14 09:59:55.344657 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/67732213cdd240cb9566f2b0c762a89d/work/67732213cdd240cb9566f2b0c762a89d_id_rsa.pub 2026-05-14 09:59:55.344703 | rockylinux-9 -> localhost | The key fingerprint is: 2026-05-14 09:59:55.344735 | rockylinux-9 -> localhost | SHA256:H1Lrf0bmkQFN6NZ2KQQdPzR68fJLQDd3wPvn2fP8ZOM zuul-build-sshkey 2026-05-14 09:59:55.344787 | rockylinux-9 -> localhost | The key's randomart image is: 2026-05-14 09:59:55.344830 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-05-14 09:59:55.344866 | rockylinux-9 -> localhost | | .oB+Bo| 2026-05-14 09:59:55.344896 | rockylinux-9 -> localhost | | +oB B| 2026-05-14 09:59:55.344936 | rockylinux-9 -> localhost | | ...=.=o| 2026-05-14 09:59:55.344997 | rockylinux-9 -> localhost | | . .o.B+o| 2026-05-14 09:59:55.345028 | rockylinux-9 -> localhost | | S o. ..*.| 2026-05-14 09:59:55.345058 | rockylinux-9 -> localhost | | + . * +| 2026-05-14 09:59:55.345087 | rockylinux-9 -> localhost | | o + =*| 2026-05-14 09:59:55.345116 | rockylinux-9 -> localhost | | . =*+| 2026-05-14 09:59:55.345148 | rockylinux-9 -> localhost | | .o EB| 2026-05-14 09:59:55.345178 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-05-14 09:59:55.345249 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.386388 2026-05-14 09:59:55.363949 | 2026-05-14 09:59:55.364093 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-14 09:59:55.421693 | rockylinux-9 | ok 2026-05-14 09:59:55.441088 | rockylinux-9 | included: /var/lib/zuul/builds/67732213cdd240cb9566f2b0c762a89d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-14 09:59:55.464842 | 2026-05-14 09:59:55.465009 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-14 09:59:55.491191 | rockylinux-9 | skipping: Conditional result was False 2026-05-14 09:59:55.503061 | 2026-05-14 09:59:55.503265 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-14 09:59:56.080263 | rockylinux-9 | changed 2026-05-14 09:59:56.085567 | 2026-05-14 09:59:56.085702 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-14 09:59:56.336005 | rockylinux-9 | ok 2026-05-14 09:59:56.487121 | 2026-05-14 09:59:56.487254 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-14 09:59:57.419805 | rockylinux-9 | changed 2026-05-14 09:59:57.425095 | 2026-05-14 09:59:57.425171 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-14 09:59:58.353478 | rockylinux-9 | changed 2026-05-14 09:59:58.528562 | 2026-05-14 09:59:58.528677 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-14 09:59:58.583291 | rockylinux-9 | skipping: Conditional result was False 2026-05-14 09:59:58.588828 | 2026-05-14 09:59:58.588933 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-14 09:59:59.132672 | rockylinux-9 -> localhost | changed 2026-05-14 09:59:59.141656 | 2026-05-14 09:59:59.141719 | TASK [add-build-sshkey : Add back temp key] 2026-05-14 09:59:59.496848 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/67732213cdd240cb9566f2b0c762a89d/work/67732213cdd240cb9566f2b0c762a89d_id_rsa (zuul-build-sshkey) 2026-05-14 09:59:59.497114 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.025543 2026-05-14 09:59:59.502664 | 2026-05-14 09:59:59.502752 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-14 09:59:59.878853 | rockylinux-9 | ok 2026-05-14 09:59:59.884678 | 2026-05-14 09:59:59.884754 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-14 09:59:59.909238 | rockylinux-9 | skipping: Conditional result was False 2026-05-14 09:59:59.923332 | 2026-05-14 09:59:59.923466 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-14 10:00:00.374125 | rockylinux-9 | ok 2026-05-14 10:00:00.382400 | 2026-05-14 10:00:00.382496 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-14 10:00:01.424635 | rockylinux-9 | Output suppressed because no_log was given 2026-05-14 10:00:01.906804 | 2026-05-14 10:00:01.906919 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-14 10:00:02.170611 | rockylinux-9 | ok: "logs" 2026-05-14 10:00:02.171353 | rockylinux-9 | ok: All items complete 2026-05-14 10:00:02.171412 | 2026-05-14 10:00:02.393685 | rockylinux-9 | ok: "artifacts" 2026-05-14 10:00:02.626094 | rockylinux-9 | ok: "docs" 2026-05-14 10:00:02.634947 | 2026-05-14 10:00:02.635122 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-14 10:00:02.898912 | rockylinux-9 | changed: "logs" 2026-05-14 10:00:03.141993 | rockylinux-9 | changed: "artifacts" 2026-05-14 10:00:03.441763 | rockylinux-9 | changed: "docs" 2026-05-14 10:00:08.082735 | 2026-05-14 10:00:08.082858 | PLAY RECAP 2026-05-14 10:00:08.082905 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-14 10:00:08.082937 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-14 10:00:08.082958 | 2026-05-14 10:00:08.271820 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-14 10:00:08.277910 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-14 10:00:09.037306 | 2026-05-14 10:00:09.037487 | PLAY [all] 2026-05-14 10:00:09.051049 | 2026-05-14 10:00:09.051199 | TASK [setup-uv : Extract archive] 2026-05-14 10:00:11.922512 | rockylinux-9 | changed 2026-05-14 10:00:12.068504 | 2026-05-14 10:00:12.068648 | TASK [setup-uv : Print version] 2026-05-14 10:00:12.095547 | [rockylinux-9] Waiting on logger 2026-05-14 10:00:12.612002 | rockylinux-9 | ok: Runtime: 0:00:00.014230 2026-05-14 10:00:12.620866 | 2026-05-14 10:00:12.620957 | PLAY RECAP 2026-05-14 10:00:12.621027 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-14 10:00:12.621052 | 2026-05-14 10:00:12.776025 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-14 10:00:13.222284 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-14 10:00:13.900554 | 2026-05-14 10:00:13.900695 | PLAY [all] 2026-05-14 10:00:13.914954 | 2026-05-14 10:00:13.915112 | TASK [Copy inventory file for Zuul] 2026-05-14 10:00:15.249742 | rockylinux-9 | changed 2026-05-14 10:00:15.258810 | 2026-05-14 10:00:15.258994 | TASK [Switch "ansible_host" to private IP] 2026-05-14 10:00:15.661826 | rockylinux-9 | changed: 1 replacements made 2026-05-14 10:00:15.671631 | 2026-05-14 10:00:15.671749 | TASK [Run Molecule scenario] 2026-05-14 10:00:15.696015 | [rockylinux-9] Waiting on logger 2026-05-14 10:00:23.851686 | [rockylinux-9] Waiting on logger 2026-05-14 10:00:34.025864 | [rockylinux-9] Waiting on logger 2026-05-14 10:00:43.179172 | [rockylinux-9] Waiting on logger 2026-05-14 10:00:53.353923 | [rockylinux-9] Waiting on logger 2026-05-14 10:01:07.365956 | [rockylinux-9] Waiting on logger 2026-05-14 10:01:16.517815 | [rockylinux-9] Waiting on logger 2026-05-14 10:01:26.693969 | [rockylinux-9] Waiting on logger 2026-05-14 10:01:37.098203 | [rockylinux-9] Waiting on logger 2026-05-14 10:01:47.274514 | [rockylinux-9] Waiting on logger 2026-05-14 10:01:56.463347 | [rockylinux-9] Waiting on logger 2026-05-14 10:02:06.630088 | [rockylinux-9] Waiting on logger 2026-05-14 10:02:16.806148 | [rockylinux-9] Waiting on logger 2026-05-14 10:02:26.985944 | [rockylinux-9] Waiting on logger 2026-05-14 10:02:37.158040 | [rockylinux-9] Waiting on logger 2026-05-14 10:02:47.333922 | [rockylinux-9] Waiting on logger 2026-05-14 10:02:56.491997 | [rockylinux-9] Waiting on logger 2026-05-14 10:02:59.859862 | rockylinux-9 | ok: Runtime: 0:02:43.686394 2026-05-14 10:02:59.868211 | 2026-05-14 10:02:59.868322 | PLAY RECAP 2026-05-14 10:02:59.868388 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-14 10:02:59.868427 | 2026-05-14 10:03:00.008886 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-14 10:03:00.014141 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-14 10:03:00.657259 | 2026-05-14 10:03:00.657417 | PLAY [all] 2026-05-14 10:03:00.669669 | 2026-05-14 10:03:00.669790 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-14 10:03:00.705271 | rockylinux-9 | skipping: Conditional result was False 2026-05-14 10:03:00.713695 | 2026-05-14 10:03:00.713841 | TASK [fetch-output : Set log path for single node] 2026-05-14 10:03:00.756733 | rockylinux-9 | ok 2026-05-14 10:03:00.762476 | 2026-05-14 10:03:00.762566 | LOOP [fetch-output : Ensure local output dirs] 2026-05-14 10:03:01.166853 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/67732213cdd240cb9566f2b0c762a89d/work/logs" 2026-05-14 10:03:01.411222 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/67732213cdd240cb9566f2b0c762a89d/work/artifacts" 2026-05-14 10:03:01.647936 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/67732213cdd240cb9566f2b0c762a89d/work/docs" 2026-05-14 10:03:01.671357 | 2026-05-14 10:03:01.671469 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-14 10:03:02.382248 | rockylinux-9 | changed: .d..t...... ./ 2026-05-14 10:03:02.382650 | rockylinux-9 | changed: All items complete 2026-05-14 10:03:02.382705 | 2026-05-14 10:03:02.941069 | rockylinux-9 | changed: .d..t...... ./ 2026-05-14 10:03:03.454272 | rockylinux-9 | changed: .d..t...... ./ 2026-05-14 10:03:03.480558 | 2026-05-14 10:03:03.480748 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-14 10:03:03.932263 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007764 2026-05-14 10:03:04.156540 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.006223 2026-05-14 10:03:04.169614 | 2026-05-14 10:03:04.169713 | PLAY [all] 2026-05-14 10:03:04.175371 | 2026-05-14 10:03:04.175438 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-14 10:03:04.634472 | rockylinux-9 | changed 2026-05-14 10:03:04.641784 | 2026-05-14 10:03:04.641838 | PLAY RECAP 2026-05-14 10:03:04.641883 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-14 10:03:04.641906 | 2026-05-14 10:03:04.814409 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-14 10:03:04.816828 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-14 10:03:05.459237 | 2026-05-14 10:03:05.459370 | PLAY [localhost] 2026-05-14 10:03:05.471100 | 2026-05-14 10:03:05.471254 | TASK [Generate Zuul manifest] 2026-05-14 10:03:05.493799 | localhost | ok 2026-05-14 10:03:05.508911 | 2026-05-14 10:03:05.509044 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-14 10:03:05.926488 | localhost | changed 2026-05-14 10:03:05.938721 | 2026-05-14 10:03:05.938851 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-14 10:03:05.970762 | localhost | ok 2026-05-14 10:03:05.979388 | 2026-05-14 10:03:05.979454 | TASK [Upload logs] 2026-05-14 10:03:05.997802 | localhost | ok 2026-05-14 10:03:06.057322 | 2026-05-14 10:03:06.057460 | TASK [Set zuul-log-path fact] 2026-05-14 10:03:06.078162 | localhost | ok 2026-05-14 10:03:06.090910 | 2026-05-14 10:03:06.090991 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-14 10:03:06.122978 | localhost | ok 2026-05-14 10:03:06.133625 | 2026-05-14 10:03:06.133699 | TASK [upload-logs : Create log directories] 2026-05-14 10:03:06.574883 | localhost | changed 2026-05-14 10:03:06.580866 | 2026-05-14 10:03:06.580947 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-14 10:03:07.004651 | localhost -> localhost | ok: Runtime: 0:00:00.004090 2026-05-14 10:03:07.009822 | 2026-05-14 10:03:07.009895 | TASK [upload-logs : Upload logs to log server] 2026-05-14 10:03:07.495479 | localhost | Output suppressed because no_log was given 2026-05-14 10:03:07.500982 | 2026-05-14 10:03:07.501085 | LOOP [upload-logs : Compress console log and json output] 2026-05-14 10:03:07.544590 | localhost | skipping: Conditional result was False 2026-05-14 10:03:07.552623 | localhost | skipping: Conditional result was False 2026-05-14 10:03:07.565456 | 2026-05-14 10:03:07.565672 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-14 10:03:07.606713 | localhost | skipping: Conditional result was False 2026-05-14 10:03:07.607134 | 2026-05-14 10:03:07.610656 | localhost | skipping: Conditional result was False 2026-05-14 10:03:07.620933 | 2026-05-14 10:03:07.621147 | LOOP [upload-logs : Upload console log and json output]