2026-06-16 00:50:37.117953 | Job console starting 2026-06-16 00:50:37.125569 | Updating git repos 2026-06-16 00:50:37.150922 | Cloning repos into workspace 2026-06-16 00:50:38.548363 | Restoring repo states 2026-06-16 00:50:38.556165 | Merging changes 2026-06-16 00:50:39.112335 | Checking out repos 2026-06-16 00:50:39.166053 | Preparing playbooks 2026-06-16 00:50:41.295309 | Running Ansible setup 2026-06-16 00:50:46.953382 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-16 00:50:48.018056 | 2026-06-16 00:50:48.018251 | PLAY [localhost] 2026-06-16 00:50:48.042217 | 2026-06-16 00:50:48.042499 | TASK [Gathering Facts] 2026-06-16 00:50:49.552101 | localhost | ok 2026-06-16 00:50:49.573970 | 2026-06-16 00:50:49.574185 | TASK [Setup log path fact] 2026-06-16 00:50:49.595088 | localhost | ok 2026-06-16 00:50:49.610379 | 2026-06-16 00:50:49.610518 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-16 00:50:49.644692 | localhost | ok 2026-06-16 00:50:49.654475 | 2026-06-16 00:50:49.654699 | TASK [emit-job-header : Print job information] 2026-06-16 00:50:49.698779 | # Job Information 2026-06-16 00:50:49.699021 | Ansible Version: 2.16.18 2026-06-16 00:50:49.699091 | Job: ansible-collection-containers-molecule-containerd-rockylinux-9 2026-06-16 00:50:49.699142 | Pipeline: check 2026-06-16 00:50:49.699188 | Executor: 2d72f0692154 2026-06-16 00:50:49.699233 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/122 2026-06-16 00:50:49.699283 | Event ID: 4ebe2140-691c-11f1-91ea-de5b29192145 2026-06-16 00:50:49.702669 | 2026-06-16 00:50:49.702736 | LOOP [emit-job-header : Print node information] 2026-06-16 00:50:49.797192 | localhost | ok: 2026-06-16 00:50:49.797381 | localhost | # Node Information 2026-06-16 00:50:49.797421 | localhost | Inventory Hostname: rockylinux-9 2026-06-16 00:50:49.797450 | localhost | Hostname: np0000180544 2026-06-16 00:50:49.797477 | localhost | Username: zuul 2026-06-16 00:50:49.797611 | localhost | Distro: Rocky 9.7 2026-06-16 00:50:49.797651 | localhost | Provider: yul1 2026-06-16 00:50:49.797685 | localhost | Region: ca-ymq-1 2026-06-16 00:50:49.797713 | localhost | Label: rockylinux-9 2026-06-16 00:50:49.797738 | localhost | Product Name: OpenStack Nova 2026-06-16 00:50:49.797765 | localhost | Interface IP: 199.19.213.124 2026-06-16 00:50:49.816396 | 2026-06-16 00:50:49.816532 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-16 00:50:50.335109 | localhost -> localhost | changed 2026-06-16 00:50:50.340520 | 2026-06-16 00:50:50.340595 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-16 00:50:52.529588 | localhost -> localhost | changed 2026-06-16 00:50:52.538031 | 2026-06-16 00:50:52.538141 | PLAY [all] 2026-06-16 00:50:52.547469 | 2026-06-16 00:50:52.547601 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-16 00:50:53.282833 | rockylinux-9 -> localhost | ok 2026-06-16 00:50:53.288856 | 2026-06-16 00:50:53.288925 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-16 00:50:53.311571 | rockylinux-9 | ok 2026-06-16 00:50:53.353130 | rockylinux-9 | included: /var/lib/zuul/builds/9e3827a42ae4433381f311fbfc555b87/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-16 00:50:53.359983 | 2026-06-16 00:50:53.360048 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-16 00:50:54.497185 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-06-16 00:50:54.497430 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/9e3827a42ae4433381f311fbfc555b87/work/9e3827a42ae4433381f311fbfc555b87_id_rsa 2026-06-16 00:50:54.497473 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/9e3827a42ae4433381f311fbfc555b87/work/9e3827a42ae4433381f311fbfc555b87_id_rsa.pub 2026-06-16 00:50:54.497506 | rockylinux-9 -> localhost | The key fingerprint is: 2026-06-16 00:50:54.497536 | rockylinux-9 -> localhost | SHA256:PR9VZl6NFLMV7fGOHsIROmMiCC0m/Crs3pKZwj2IPs4 zuul-build-sshkey 2026-06-16 00:50:54.497589 | rockylinux-9 -> localhost | The key's randomart image is: 2026-06-16 00:50:54.497620 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-06-16 00:50:54.497654 | rockylinux-9 -> localhost | |. . .++X| 2026-06-16 00:50:54.497685 | rockylinux-9 -> localhost | |..+ . . .X+| 2026-06-16 00:50:54.497714 | rockylinux-9 -> localhost | | o.o . . .o.+| 2026-06-16 00:50:54.497743 | rockylinux-9 -> localhost | | .. . ..= .. o| 2026-06-16 00:50:54.497771 | rockylinux-9 -> localhost | |. . .Soo+.. o | 2026-06-16 00:50:54.497799 | rockylinux-9 -> localhost | |.o oo.o .| 2026-06-16 00:50:54.497826 | rockylinux-9 -> localhost | |= * .o . | 2026-06-16 00:50:54.497854 | rockylinux-9 -> localhost | |+X.o . | 2026-06-16 00:50:54.497885 | rockylinux-9 -> localhost | |=Eo.. | 2026-06-16 00:50:54.497913 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-06-16 00:50:54.497982 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.721417 2026-06-16 00:50:54.504633 | 2026-06-16 00:50:54.504723 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-16 00:50:54.541025 | rockylinux-9 | ok 2026-06-16 00:50:54.554057 | rockylinux-9 | included: /var/lib/zuul/builds/9e3827a42ae4433381f311fbfc555b87/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-16 00:50:54.572070 | 2026-06-16 00:50:54.575813 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-16 00:50:54.607353 | rockylinux-9 | skipping: Conditional result was False 2026-06-16 00:50:54.620638 | 2026-06-16 00:50:54.620800 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-16 00:50:55.191631 | rockylinux-9 | changed 2026-06-16 00:50:55.196192 | 2026-06-16 00:50:55.196256 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-16 00:50:55.460810 | rockylinux-9 | ok 2026-06-16 00:50:55.469056 | 2026-06-16 00:50:55.469145 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-16 00:50:56.457427 | rockylinux-9 | changed 2026-06-16 00:50:56.464118 | 2026-06-16 00:50:56.464190 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-16 00:50:57.425713 | rockylinux-9 | changed 2026-06-16 00:50:57.431049 | 2026-06-16 00:50:57.431118 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-16 00:50:57.455852 | rockylinux-9 | skipping: Conditional result was False 2026-06-16 00:50:57.461403 | 2026-06-16 00:50:57.461473 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-16 00:50:57.852172 | rockylinux-9 -> localhost | changed 2026-06-16 00:50:57.866046 | 2026-06-16 00:50:57.866135 | TASK [add-build-sshkey : Add back temp key] 2026-06-16 00:50:58.166255 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/9e3827a42ae4433381f311fbfc555b87/work/9e3827a42ae4433381f311fbfc555b87_id_rsa (zuul-build-sshkey) 2026-06-16 00:50:58.166537 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.016196 2026-06-16 00:50:58.172567 | 2026-06-16 00:50:58.172630 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-16 00:50:58.577977 | rockylinux-9 | ok 2026-06-16 00:50:58.582424 | 2026-06-16 00:50:58.582490 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-16 00:50:58.605722 | rockylinux-9 | skipping: Conditional result was False 2026-06-16 00:50:58.614455 | 2026-06-16 00:50:58.614526 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-16 00:50:59.072368 | rockylinux-9 | ok 2026-06-16 00:50:59.084394 | 2026-06-16 00:50:59.084588 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-16 00:51:00.264656 | rockylinux-9 | Output suppressed because no_log was given 2026-06-16 00:51:00.285990 | 2026-06-16 00:51:00.286185 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-16 00:51:00.553743 | rockylinux-9 | ok: "logs" 2026-06-16 00:51:00.554015 | rockylinux-9 | ok: All items complete 2026-06-16 00:51:00.554045 | 2026-06-16 00:51:00.766713 | rockylinux-9 | ok: "artifacts" 2026-06-16 00:51:00.998694 | rockylinux-9 | ok: "docs" 2026-06-16 00:51:01.020192 | 2026-06-16 00:51:01.020373 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-16 00:51:01.413610 | rockylinux-9 | changed: "logs" 2026-06-16 00:51:01.715993 | rockylinux-9 | changed: "artifacts" 2026-06-16 00:51:01.876935 | rockylinux-9 | changed: "docs" 2026-06-16 00:51:02.136150 | 2026-06-16 00:51:02.136337 | PLAY RECAP 2026-06-16 00:51:02.136390 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-16 00:51:02.136420 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-16 00:51:02.136442 | 2026-06-16 00:51:02.349467 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-16 00:51:02.351344 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-16 00:51:03.195670 | 2026-06-16 00:51:03.195821 | PLAY [all] 2026-06-16 00:51:03.254074 | 2026-06-16 00:51:03.254260 | TASK [setup-uv : Extract archive] 2026-06-16 00:51:06.157868 | rockylinux-9 | changed 2026-06-16 00:51:06.165356 | 2026-06-16 00:51:06.165460 | TASK [setup-uv : Print version] 2026-06-16 00:51:06.225498 | [rockylinux-9] Waiting on logger 2026-06-16 00:51:07.881970 | rockylinux-9 | ok: Runtime: 0:00:00.014946 2026-06-16 00:51:07.891779 | 2026-06-16 00:51:07.891886 | TASK [Install Ansible collection siblings] 2026-06-16 00:51:11.203765 | rockylinux-9 | ok: 2026-06-16 00:51:13.664539 | rockylinux-9 | Skipping ansible.posix: no checked-out sibling 2026-06-16 00:51:13.664703 | rockylinux-9 | Skipping community.general: no checked-out sibling 2026-06-16 00:51:13.669182 | 2026-06-16 00:51:13.669371 | PLAY RECAP 2026-06-16 00:51:13.669480 | rockylinux-9 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-16 00:51:13.669531 | 2026-06-16 00:51:13.821615 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-16 00:51:13.826118 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-16 00:51:14.615882 | 2026-06-16 00:51:14.616007 | PLAY [all] 2026-06-16 00:51:14.626740 | 2026-06-16 00:51:14.626816 | TASK [Copy inventory file for Zuul] 2026-06-16 00:51:15.988529 | rockylinux-9 | changed 2026-06-16 00:51:15.993504 | 2026-06-16 00:51:15.993593 | TASK [Switch "ansible_host" to private IP] 2026-06-16 00:51:16.420437 | rockylinux-9 | changed: 1 replacements made 2026-06-16 00:51:16.425355 | 2026-06-16 00:51:16.425423 | TASK [Run Molecule scenario] 2026-06-16 00:51:16.447031 | [rockylinux-9] Waiting on logger 2026-06-16 00:51:21.547396 | [rockylinux-9] Waiting on logger 2026-06-16 00:51:31.719210 | [rockylinux-9] Waiting on logger 2026-06-16 00:51:41.898134 | [rockylinux-9] Waiting on logger 2026-06-16 00:51:52.229857 | [rockylinux-9] Waiting on logger 2026-06-16 00:52:02.409910 | [rockylinux-9] Waiting on logger 2026-06-16 00:52:11.594158 | [rockylinux-9] Waiting on logger 2026-06-16 00:52:21.862250 | [rockylinux-9] Waiting on logger 2026-06-16 00:52:32.295398 | [rockylinux-9] Waiting on logger 2026-06-16 00:52:41.483986 | [rockylinux-9] Waiting on logger 2026-06-16 00:52:51.654003 | [rockylinux-9] Waiting on logger 2026-06-16 00:53:01.833809 | [rockylinux-9] Waiting on logger 2026-06-16 00:53:12.042033 | [rockylinux-9] Waiting on logger 2026-06-16 00:53:22.214365 | [rockylinux-9] Waiting on logger 2026-06-16 00:53:32.395249 | [rockylinux-9] Waiting on logger 2026-06-16 00:53:41.550893 | [rockylinux-9] Waiting on logger 2026-06-16 00:53:51.717915 | [rockylinux-9] Waiting on logger 2026-06-16 00:54:01.893942 | [rockylinux-9] Waiting on logger 2026-06-16 00:54:12.074030 | [rockylinux-9] Waiting on logger 2026-06-16 00:54:22.246117 | [rockylinux-9] Waiting on logger 2026-06-16 00:54:32.430652 | [rockylinux-9] Waiting on logger 2026-06-16 00:54:41.574327 | [rockylinux-9] Waiting on logger 2026-06-16 00:54:51.750266 | [rockylinux-9] Waiting on logger 2026-06-16 00:55:01.925802 | [rockylinux-9] Waiting on logger 2026-06-16 00:55:12.101982 | [rockylinux-9] Waiting on logger 2026-06-16 00:55:22.277886 | [rockylinux-9] Waiting on logger 2026-06-16 00:55:32.454199 | [rockylinux-9] Waiting on logger 2026-06-16 00:55:41.606086 | [rockylinux-9] Waiting on logger 2026-06-16 00:55:51.785989 | [rockylinux-9] Waiting on logger 2026-06-16 00:56:01.962320 | [rockylinux-9] Waiting on logger 2026-06-16 00:56:12.134253 | [rockylinux-9] Waiting on logger 2026-06-16 00:56:21.638226 | [rockylinux-9] Waiting on logger 2026-06-16 00:56:26.123041 | rockylinux-9 | ok: Runtime: 0:05:08.483824 2026-06-16 00:56:26.133405 | 2026-06-16 00:56:26.133719 | PLAY RECAP 2026-06-16 00:56:26.133832 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-16 00:56:26.133919 | 2026-06-16 00:56:26.297891 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-16 00:56:26.302434 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-16 00:56:26.882800 | 2026-06-16 00:56:26.882962 | PLAY [all] 2026-06-16 00:56:26.895278 | 2026-06-16 00:56:26.895390 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-16 00:56:26.940521 | rockylinux-9 | skipping: Conditional result was False 2026-06-16 00:56:26.949067 | 2026-06-16 00:56:26.949185 | TASK [fetch-output : Set log path for single node] 2026-06-16 00:56:26.993429 | rockylinux-9 | ok 2026-06-16 00:56:27.000633 | 2026-06-16 00:56:27.000755 | LOOP [fetch-output : Ensure local output dirs] 2026-06-16 00:56:27.378609 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/9e3827a42ae4433381f311fbfc555b87/work/logs" 2026-06-16 00:56:27.589894 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/9e3827a42ae4433381f311fbfc555b87/work/artifacts" 2026-06-16 00:56:27.799513 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/9e3827a42ae4433381f311fbfc555b87/work/docs" 2026-06-16 00:56:27.815585 | 2026-06-16 00:56:27.815785 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-16 00:56:28.528223 | rockylinux-9 | changed: .d..t...... ./ 2026-06-16 00:56:28.528439 | rockylinux-9 | changed: All items complete 2026-06-16 00:56:28.528478 | 2026-06-16 00:56:29.046264 | rockylinux-9 | changed: .d..t...... ./ 2026-06-16 00:56:29.582457 | rockylinux-9 | changed: .d..t...... ./ 2026-06-16 00:56:29.597859 | 2026-06-16 00:56:29.598006 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-16 00:56:30.030157 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007184 2026-06-16 00:56:30.255963 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.006634 2026-06-16 00:56:30.274446 | 2026-06-16 00:56:30.274606 | PLAY [all] 2026-06-16 00:56:30.281385 | 2026-06-16 00:56:30.281453 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-16 00:56:30.739627 | rockylinux-9 | changed 2026-06-16 00:56:30.745308 | 2026-06-16 00:56:30.745368 | PLAY RECAP 2026-06-16 00:56:30.745413 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-16 00:56:30.745435 | 2026-06-16 00:56:30.873444 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-16 00:56:30.876521 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-16 00:56:31.514957 | 2026-06-16 00:56:31.515121 | PLAY [localhost] 2026-06-16 00:56:31.526950 | 2026-06-16 00:56:31.527106 | TASK [Generate Zuul manifest] 2026-06-16 00:56:31.551808 | localhost | ok 2026-06-16 00:56:31.572492 | 2026-06-16 00:56:31.572660 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-16 00:56:31.958234 | localhost | changed 2026-06-16 00:56:31.971910 | 2026-06-16 00:56:31.972047 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-16 00:56:32.010023 | localhost | ok 2026-06-16 00:56:32.017877 | 2026-06-16 00:56:32.018031 | TASK [Upload logs] 2026-06-16 00:56:32.041256 | localhost | ok 2026-06-16 00:56:32.109413 | 2026-06-16 00:56:32.109586 | TASK [Set zuul-log-path fact] 2026-06-16 00:56:32.133011 | localhost | ok 2026-06-16 00:56:32.148255 | 2026-06-16 00:56:32.148432 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-16 00:56:32.183016 | localhost | ok 2026-06-16 00:56:32.191532 | 2026-06-16 00:56:32.191648 | TASK [upload-logs : Create log directories] 2026-06-16 00:56:32.612877 | localhost | changed 2026-06-16 00:56:32.621171 | 2026-06-16 00:56:32.621289 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-16 00:56:33.050794 | localhost -> localhost | ok: Runtime: 0:00:00.004992 2026-06-16 00:56:33.057664 | 2026-06-16 00:56:33.057766 | TASK [upload-logs : Upload logs to log server] 2026-06-16 00:56:33.537392 | localhost | Output suppressed because no_log was given 2026-06-16 00:56:33.542462 | 2026-06-16 00:56:33.542555 | LOOP [upload-logs : Compress console log and json output] 2026-06-16 00:56:33.589758 | localhost | skipping: Conditional result was False 2026-06-16 00:56:33.596477 | localhost | skipping: Conditional result was False 2026-06-16 00:56:33.607270 | 2026-06-16 00:56:33.607457 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-16 00:56:33.648703 | localhost | skipping: Conditional result was False 2026-06-16 00:56:33.649148 | 2026-06-16 00:56:33.653883 | localhost | skipping: Conditional result was False 2026-06-16 00:56:33.673028 | 2026-06-16 00:56:33.673235 | LOOP [upload-logs : Upload console log and json output]