2026-02-13 23:19:01.236609 | Job console starting 2026-02-13 23:19:01.246738 | Updating git repos 2026-02-13 23:19:01.275655 | Cloning repos into workspace 2026-02-13 23:19:01.320983 | Restoring repo states 2026-02-13 23:19:01.331175 | Merging changes 2026-02-13 23:19:01.584663 | Checking out repos 2026-02-13 23:19:01.613994 | Preparing playbooks 2026-02-13 23:19:02.507658 | Running Ansible setup 2026-02-13 23:19:06.061078 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-13 23:19:06.674379 | 2026-02-13 23:19:06.675110 | PLAY [localhost] 2026-02-13 23:19:06.833704 | 2026-02-13 23:19:06.833928 | TASK [Gathering Facts] 2026-02-13 23:19:07.843409 | localhost | ok 2026-02-13 23:19:07.863644 | 2026-02-13 23:19:07.863859 | TASK [Setup log path fact] 2026-02-13 23:19:07.894053 | localhost | ok 2026-02-13 23:19:07.909357 | 2026-02-13 23:19:08.015253 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-13 23:19:08.047949 | localhost | ok 2026-02-13 23:19:08.062711 | 2026-02-13 23:19:08.062880 | TASK [emit-job-header : Print job information] 2026-02-13 23:19:08.108921 | # Job Information 2026-02-13 23:19:08.205398 | Ansible Version: 2.16.15 2026-02-13 23:19:08.205604 | Job: ansible-collection-containers-molecule-containerd-rockylinux-9 2026-02-13 23:19:08.205664 | Pipeline: check 2026-02-13 23:19:08.205710 | Executor: 3a2793d2bd32 2026-02-13 23:19:08.205753 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/93 2026-02-13 23:19:08.205802 | Event ID: 40d80630-0932-11f1-9f6d-138448d30538 2026-02-13 23:19:08.214085 | 2026-02-13 23:19:08.214242 | LOOP [emit-job-header : Print node information] 2026-02-13 23:19:08.313453 | localhost | ok: 2026-02-13 23:19:08.313692 | localhost | # Node Information 2026-02-13 23:19:08.313734 | localhost | Inventory Hostname: rockylinux-9 2026-02-13 23:19:08.313766 | localhost | Hostname: np0000155475 2026-02-13 23:19:08.313795 | localhost | Username: zuul 2026-02-13 23:19:08.313828 | localhost | Distro: Rocky 9.7 2026-02-13 23:19:08.313857 | localhost | Provider: yul1 2026-02-13 23:19:08.313884 | localhost | Region: ca-ymq-1 2026-02-13 23:19:08.313911 | localhost | Label: rockylinux-9 2026-02-13 23:19:08.313938 | localhost | Product Name: OpenStack Nova 2026-02-13 23:19:08.313966 | localhost | Interface IP: 199.204.45.227 2026-02-13 23:19:08.334935 | 2026-02-13 23:19:08.335197 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-13 23:19:08.758176 | localhost -> localhost | changed 2026-02-13 23:19:08.765055 | 2026-02-13 23:19:08.765216 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-13 23:19:10.139103 | localhost -> localhost | changed 2026-02-13 23:19:10.149411 | 2026-02-13 23:19:10.149463 | PLAY [all] 2026-02-13 23:19:10.157469 | 2026-02-13 23:19:10.157538 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-13 23:19:10.393895 | rockylinux-9 -> localhost | ok 2026-02-13 23:19:10.399716 | 2026-02-13 23:19:10.399788 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-13 23:19:10.428863 | rockylinux-9 | ok 2026-02-13 23:19:10.442909 | rockylinux-9 | included: /var/lib/zuul/builds/ace0c83875904d28b530e8a1cfc6af99/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-13 23:19:10.449537 | 2026-02-13 23:19:10.449596 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-13 23:19:11.598720 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-02-13 23:19:11.598975 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/ace0c83875904d28b530e8a1cfc6af99/work/ace0c83875904d28b530e8a1cfc6af99_id_rsa 2026-02-13 23:19:11.599026 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/ace0c83875904d28b530e8a1cfc6af99/work/ace0c83875904d28b530e8a1cfc6af99_id_rsa.pub 2026-02-13 23:19:11.599057 | rockylinux-9 -> localhost | The key fingerprint is: 2026-02-13 23:19:11.599086 | rockylinux-9 -> localhost | SHA256:XcqIdV4IhH9QC0wjaIPY9ac6dm7Z8q28BW4tf1WyyGM zuul-build-sshkey 2026-02-13 23:19:11.599127 | rockylinux-9 -> localhost | The key's randomart image is: 2026-02-13 23:19:11.599155 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-02-13 23:19:11.599187 | rockylinux-9 -> localhost | | o o...=*.. | 2026-02-13 23:19:11.599215 | rockylinux-9 -> localhost | |. o +...o+ o | 2026-02-13 23:19:11.599241 | rockylinux-9 -> localhost | | . ...o.+ o | 2026-02-13 23:19:11.599267 | rockylinux-9 -> localhost | | =.*.+ . .| 2026-02-13 23:19:11.599293 | rockylinux-9 -> localhost | | o S.=. . + | 2026-02-13 23:19:11.599319 | rockylinux-9 -> localhost | | . . o E o | 2026-02-13 23:19:11.599344 | rockylinux-9 -> localhost | | + .o+ o. o | 2026-02-13 23:19:11.599370 | rockylinux-9 -> localhost | | . ++o.= . | 2026-02-13 23:19:11.599399 | rockylinux-9 -> localhost | | ..o=oo. | 2026-02-13 23:19:11.599425 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-02-13 23:19:11.599491 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.734364 2026-02-13 23:19:11.608184 | 2026-02-13 23:19:11.608266 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-13 23:19:11.640767 | rockylinux-9 | ok 2026-02-13 23:19:11.653346 | rockylinux-9 | included: /var/lib/zuul/builds/ace0c83875904d28b530e8a1cfc6af99/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-13 23:19:11.660397 | 2026-02-13 23:19:11.660463 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-13 23:19:11.688470 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:19:11.700006 | 2026-02-13 23:19:11.700124 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-13 23:19:12.168889 | rockylinux-9 | changed 2026-02-13 23:19:12.176130 | 2026-02-13 23:19:12.176223 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-13 23:19:12.414568 | rockylinux-9 | ok 2026-02-13 23:19:12.425044 | 2026-02-13 23:19:12.425221 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-13 23:19:13.203366 | rockylinux-9 | changed 2026-02-13 23:19:13.210939 | 2026-02-13 23:19:13.211007 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-13 23:19:13.981910 | rockylinux-9 | changed 2026-02-13 23:19:14.049527 | 2026-02-13 23:19:14.049667 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-13 23:19:14.075201 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:19:14.085775 | 2026-02-13 23:19:14.085911 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-13 23:19:14.505474 | rockylinux-9 -> localhost | changed 2026-02-13 23:19:14.520451 | 2026-02-13 23:19:14.520531 | TASK [add-build-sshkey : Add back temp key] 2026-02-13 23:19:15.095415 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/ace0c83875904d28b530e8a1cfc6af99/work/ace0c83875904d28b530e8a1cfc6af99_id_rsa (zuul-build-sshkey) 2026-02-13 23:19:15.095613 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.014384 2026-02-13 23:19:15.100229 | 2026-02-13 23:19:15.100295 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-13 23:19:15.490823 | rockylinux-9 | ok 2026-02-13 23:19:15.498500 | 2026-02-13 23:19:15.498590 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-13 23:19:15.524436 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:19:15.539586 | 2026-02-13 23:19:15.539721 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-13 23:19:15.965947 | rockylinux-9 | ok 2026-02-13 23:19:16.077671 | 2026-02-13 23:19:16.077807 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-13 23:19:17.058497 | rockylinux-9 | Output suppressed because no_log was given 2026-02-13 23:19:17.069984 | 2026-02-13 23:19:17.070101 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-13 23:19:17.304160 | rockylinux-9 | ok: "logs" 2026-02-13 23:19:17.304759 | rockylinux-9 | ok: All items complete 2026-02-13 23:19:17.304797 | 2026-02-13 23:19:17.511733 | rockylinux-9 | ok: "artifacts" 2026-02-13 23:19:17.726759 | rockylinux-9 | ok: "docs" 2026-02-13 23:19:17.735460 | 2026-02-13 23:19:17.735624 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-13 23:19:17.982035 | rockylinux-9 | changed: "logs" 2026-02-13 23:19:18.197808 | rockylinux-9 | changed: "artifacts" 2026-02-13 23:19:18.403945 | rockylinux-9 | changed: "docs" 2026-02-13 23:19:18.420682 | 2026-02-13 23:19:18.420826 | PLAY RECAP 2026-02-13 23:19:18.420878 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-13 23:19:18.420910 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-13 23:19:18.420943 | 2026-02-13 23:19:18.593497 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-13 23:19:18.594585 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-02-13 23:19:19.147012 | 2026-02-13 23:19:19.147148 | PLAY [all] 2026-02-13 23:19:19.158463 | 2026-02-13 23:19:19.158549 | TASK [setup-uv : Extract archive] 2026-02-13 23:19:21.980851 | rockylinux-9 | changed 2026-02-13 23:19:22.017096 | 2026-02-13 23:19:22.017258 | TASK [setup-uv : Print version] 2026-02-13 23:19:22.061937 | [rockylinux-9] Waiting on logger 2026-02-13 23:19:22.584559 | rockylinux-9 | ok: Runtime: 0:00:00.010001 2026-02-13 23:19:22.593711 | 2026-02-13 23:19:22.593781 | PLAY RECAP 2026-02-13 23:19:22.593882 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-13 23:19:22.593926 | 2026-02-13 23:19:22.727040 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-02-13 23:19:22.732645 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-02-13 23:19:23.416129 | 2026-02-13 23:19:23.416264 | PLAY [all] 2026-02-13 23:19:23.428344 | 2026-02-13 23:19:23.428422 | TASK [Copy inventory file for Zuul] 2026-02-13 23:19:24.777450 | rockylinux-9 | changed 2026-02-13 23:19:24.786459 | 2026-02-13 23:19:24.786573 | TASK [Switch "ansible_host" to private IP] 2026-02-13 23:19:25.120514 | rockylinux-9 | changed: 1 replacements made 2026-02-13 23:19:25.275589 | 2026-02-13 23:19:25.275741 | TASK [Run Molecule scenario] 2026-02-13 23:19:25.301658 | [rockylinux-9] Waiting on logger 2026-02-13 23:19:33.449633 | [rockylinux-9] Waiting on logger 2026-02-13 23:19:43.625646 | [rockylinux-9] Waiting on logger 2026-02-13 23:19:53.802133 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:03.973789 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:13.130958 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:23.301967 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:33.477773 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:43.657683 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:53.829790 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:04.010476 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:13.166622 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:23.337660 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:33.509651 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:43.685820 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:53.865823 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:04.037764 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:13.189945 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:23.365964 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:33.546304 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:43.717727 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:53.893747 | [rockylinux-9] Waiting on logger 2026-02-13 23:23:04.070018 | [rockylinux-9] Waiting on logger 2026-02-13 23:23:13.221727 | [rockylinux-9] Waiting on logger 2026-02-13 23:23:23.401813 | [rockylinux-9] Waiting on logger 2026-02-13 23:23:26.768802 | rockylinux-9 | ok: Runtime: 0:04:01.007775 2026-02-13 23:23:26.776355 | 2026-02-13 23:23:26.776420 | PLAY RECAP 2026-02-13 23:23:26.776474 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-13 23:23:26.776504 | 2026-02-13 23:23:26.895740 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-02-13 23:23:26.897926 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-13 23:23:27.501169 | 2026-02-13 23:23:27.501309 | PLAY [all] 2026-02-13 23:23:27.514624 | 2026-02-13 23:23:27.514744 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-13 23:23:27.549754 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:23:27.559205 | 2026-02-13 23:23:27.559286 | TASK [fetch-output : Set log path for single node] 2026-02-13 23:23:27.590812 | rockylinux-9 | ok 2026-02-13 23:23:27.595115 | 2026-02-13 23:23:27.595186 | LOOP [fetch-output : Ensure local output dirs] 2026-02-13 23:23:27.962334 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/ace0c83875904d28b530e8a1cfc6af99/work/logs" 2026-02-13 23:23:28.167694 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/ace0c83875904d28b530e8a1cfc6af99/work/artifacts" 2026-02-13 23:23:28.370913 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/ace0c83875904d28b530e8a1cfc6af99/work/docs" 2026-02-13 23:23:28.392840 | 2026-02-13 23:23:28.392932 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-13 23:23:29.049538 | rockylinux-9 | ok 2026-02-13 23:23:29.049740 | rockylinux-9 | changed: All items complete 2026-02-13 23:23:29.049768 | 2026-02-13 23:23:29.524093 | rockylinux-9 | changed: .d..t...... ./ 2026-02-13 23:23:30.008258 | rockylinux-9 | changed: .d..t...... ./ 2026-02-13 23:23:30.031602 | 2026-02-13 23:23:30.031676 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-13 23:23:30.427240 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.005979 2026-02-13 23:23:30.643071 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.007305 2026-02-13 23:23:30.662974 | 2026-02-13 23:23:30.663119 | PLAY [all] 2026-02-13 23:23:30.669407 | 2026-02-13 23:23:30.669472 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-13 23:23:31.117084 | rockylinux-9 | changed 2026-02-13 23:23:31.123204 | 2026-02-13 23:23:31.123266 | PLAY RECAP 2026-02-13 23:23:31.123325 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-13 23:23:31.123355 | 2026-02-13 23:23:31.251566 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-13 23:23:31.253673 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-13 23:23:31.821958 | 2026-02-13 23:23:31.822085 | PLAY [localhost] 2026-02-13 23:23:31.833015 | 2026-02-13 23:23:31.833104 | TASK [Generate Zuul manifest] 2026-02-13 23:23:31.855196 | localhost | ok 2026-02-13 23:23:31.872911 | 2026-02-13 23:23:31.873013 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-13 23:23:32.200039 | localhost | changed 2026-02-13 23:23:32.213780 | 2026-02-13 23:23:32.213865 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-13 23:23:32.247633 | localhost | ok 2026-02-13 23:23:32.255140 | 2026-02-13 23:23:32.255221 | TASK [Upload logs] 2026-02-13 23:23:32.278033 | localhost | ok 2026-02-13 23:23:32.342504 | 2026-02-13 23:23:32.342676 | TASK [Set zuul-log-path fact] 2026-02-13 23:23:32.362059 | localhost | ok 2026-02-13 23:23:32.374925 | 2026-02-13 23:23:32.374999 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-13 23:23:32.405748 | localhost | ok 2026-02-13 23:23:32.415183 | 2026-02-13 23:23:32.415270 | TASK [upload-logs : Create log directories] 2026-02-13 23:23:32.832285 | localhost | changed 2026-02-13 23:23:32.837991 | 2026-02-13 23:23:32.838061 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-13 23:23:33.268189 | localhost -> localhost | ok: Runtime: 0:00:00.004565 2026-02-13 23:23:33.275519 | 2026-02-13 23:23:33.275614 | TASK [upload-logs : Upload logs to log server] 2026-02-13 23:23:33.741609 | localhost | Output suppressed because no_log was given 2026-02-13 23:23:33.747005 | 2026-02-13 23:23:33.747099 | LOOP [upload-logs : Compress console log and json output] 2026-02-13 23:23:33.788787 | localhost | skipping: Conditional result was False 2026-02-13 23:23:33.795435 | localhost | skipping: Conditional result was False 2026-02-13 23:23:33.808538 | 2026-02-13 23:23:33.808648 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-13 23:23:33.854496 | localhost | skipping: Conditional result was False 2026-02-13 23:23:33.855057 | 2026-02-13 23:23:33.858999 | localhost | skipping: Conditional result was False 2026-02-13 23:23:33.869704 | 2026-02-13 23:23:33.869818 | LOOP [upload-logs : Upload console log and json output]