2026-04-14 02:23:41.211409 | Job console starting 2026-04-14 02:23:41.222052 | Updating git repos 2026-04-14 02:23:41.251482 | Cloning repos into workspace 2026-04-14 02:23:41.396298 | Restoring repo states 2026-04-14 02:23:41.403303 | Merging changes 2026-04-14 02:23:41.666011 | Checking out repos 2026-04-14 02:23:41.703673 | Preparing playbooks 2026-04-14 02:23:43.149672 | Running Ansible setup 2026-04-14 02:23:46.658060 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-14 02:23:47.279245 | 2026-04-14 02:23:47.279453 | PLAY [localhost] 2026-04-14 02:23:47.290494 | 2026-04-14 02:23:47.290665 | TASK [Gathering Facts] 2026-04-14 02:23:48.208634 | localhost | ok 2026-04-14 02:23:48.219199 | 2026-04-14 02:23:48.219313 | TASK [Setup log path fact] 2026-04-14 02:23:48.240329 | localhost | ok 2026-04-14 02:23:48.253359 | 2026-04-14 02:23:48.253461 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-14 02:23:48.282872 | localhost | ok 2026-04-14 02:23:48.290898 | 2026-04-14 02:23:48.290989 | TASK [emit-job-header : Print job information] 2026-04-14 02:23:48.332634 | # Job Information 2026-04-14 02:23:48.332851 | Ansible Version: 2.16.16 2026-04-14 02:23:48.332923 | Job: ansible-collection-containers-molecule-docker-rockylinux-9 2026-04-14 02:23:48.333004 | Pipeline: check 2026-04-14 02:23:48.333054 | Executor: 0a8996d2b663 2026-04-14 02:23:48.333098 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/108 2026-04-14 02:23:48.333147 | Event ID: ccc5bb20-37a8-11f1-82ba-71f59466e919 2026-04-14 02:23:48.337187 | 2026-04-14 02:23:48.337270 | LOOP [emit-job-header : Print node information] 2026-04-14 02:23:48.426157 | localhost | ok: 2026-04-14 02:23:48.426928 | localhost | # Node Information 2026-04-14 02:23:48.426973 | localhost | Inventory Hostname: rockylinux-9 2026-04-14 02:23:48.426997 | localhost | Hostname: np0000165932 2026-04-14 02:23:48.427017 | localhost | Username: zuul 2026-04-14 02:23:48.427040 | localhost | Distro: Rocky 9.7 2026-04-14 02:23:48.427060 | localhost | Provider: yul1 2026-04-14 02:23:48.427079 | localhost | Region: ca-ymq-1 2026-04-14 02:23:48.427097 | localhost | Label: rockylinux-9 2026-04-14 02:23:48.427115 | localhost | Product Name: OpenStack Nova 2026-04-14 02:23:48.427133 | localhost | Interface IP: 199.19.213.128 2026-04-14 02:23:48.439875 | 2026-04-14 02:23:48.440012 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-14 02:23:48.864882 | localhost -> localhost | changed 2026-04-14 02:23:48.874577 | 2026-04-14 02:23:48.874648 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-14 02:23:49.758508 | localhost -> localhost | changed 2026-04-14 02:23:49.768121 | 2026-04-14 02:23:49.768219 | PLAY [all] 2026-04-14 02:23:49.776282 | 2026-04-14 02:23:49.776369 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-14 02:23:50.005151 | rockylinux-9 -> localhost | ok 2026-04-14 02:23:50.014396 | 2026-04-14 02:23:50.014573 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-14 02:23:50.047719 | rockylinux-9 | ok 2026-04-14 02:23:50.066490 | rockylinux-9 | included: /var/lib/zuul/builds/aea59b3e980e4307968b7af4dead63e2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-14 02:23:50.072213 | 2026-04-14 02:23:50.072275 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-14 02:23:50.878289 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-04-14 02:23:50.878516 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/aea59b3e980e4307968b7af4dead63e2/work/aea59b3e980e4307968b7af4dead63e2_id_rsa 2026-04-14 02:23:50.878559 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/aea59b3e980e4307968b7af4dead63e2/work/aea59b3e980e4307968b7af4dead63e2_id_rsa.pub 2026-04-14 02:23:50.878593 | rockylinux-9 -> localhost | The key fingerprint is: 2026-04-14 02:23:50.878623 | rockylinux-9 -> localhost | SHA256:p/zeFtfqEQH9gl6ykOjK3N962DuYkSOjuFrr5tp5G+4 zuul-build-sshkey 2026-04-14 02:23:50.878676 | rockylinux-9 -> localhost | The key's randomart image is: 2026-04-14 02:23:50.878709 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-04-14 02:23:50.878745 | rockylinux-9 -> localhost | | .. | 2026-04-14 02:23:50.878777 | rockylinux-9 -> localhost | | .. | 2026-04-14 02:23:50.878808 | rockylinux-9 -> localhost | | . . ... | 2026-04-14 02:23:50.878836 | rockylinux-9 -> localhost | | . o o o..| 2026-04-14 02:23:50.878865 | rockylinux-9 -> localhost | | .S .+ +.o | 2026-04-14 02:23:50.878892 | rockylinux-9 -> localhost | | .+o+ + ...| 2026-04-14 02:23:50.878920 | rockylinux-9 -> localhost | | .+.+oo B o.. | 2026-04-14 02:23:50.878947 | rockylinux-9 -> localhost | | oo+*...+o= .. | 2026-04-14 02:23:50.878979 | rockylinux-9 -> localhost | | o*B+E. o=+++. | 2026-04-14 02:23:50.879008 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-04-14 02:23:50.879073 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.371710 2026-04-14 02:23:50.886250 | 2026-04-14 02:23:50.886339 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-14 02:23:50.921063 | rockylinux-9 | ok 2026-04-14 02:23:50.929409 | rockylinux-9 | included: /var/lib/zuul/builds/aea59b3e980e4307968b7af4dead63e2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-14 02:23:50.937850 | 2026-04-14 02:23:50.937914 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-14 02:23:50.963047 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:23:50.973785 | 2026-04-14 02:23:50.973874 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-14 02:23:51.430174 | rockylinux-9 | changed 2026-04-14 02:23:51.436602 | 2026-04-14 02:23:51.436689 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-14 02:23:51.701480 | rockylinux-9 | ok 2026-04-14 02:23:51.709249 | 2026-04-14 02:23:51.709337 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-14 02:23:52.584484 | rockylinux-9 | changed 2026-04-14 02:23:52.591296 | 2026-04-14 02:23:52.591388 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-14 02:23:53.465375 | rockylinux-9 | changed 2026-04-14 02:23:53.470134 | 2026-04-14 02:23:53.470199 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-14 02:23:53.495442 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:23:53.502425 | 2026-04-14 02:23:53.502518 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-14 02:23:53.893582 | rockylinux-9 -> localhost | changed 2026-04-14 02:23:53.909780 | 2026-04-14 02:23:53.909895 | TASK [add-build-sshkey : Add back temp key] 2026-04-14 02:23:54.193116 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/aea59b3e980e4307968b7af4dead63e2/work/aea59b3e980e4307968b7af4dead63e2_id_rsa (zuul-build-sshkey) 2026-04-14 02:23:54.193324 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.015903 2026-04-14 02:23:54.199638 | 2026-04-14 02:23:54.199701 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-14 02:23:54.565008 | rockylinux-9 | ok 2026-04-14 02:23:54.570746 | 2026-04-14 02:23:54.570811 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-14 02:23:54.594740 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:23:54.610212 | 2026-04-14 02:23:54.610322 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-14 02:23:55.001276 | rockylinux-9 | ok 2026-04-14 02:23:55.006794 | 2026-04-14 02:23:55.006854 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-14 02:23:56.137350 | rockylinux-9 | Output suppressed because no_log was given 2026-04-14 02:23:56.159213 | 2026-04-14 02:23:56.159339 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-14 02:23:56.407384 | rockylinux-9 | ok: "logs" 2026-04-14 02:23:56.407674 | rockylinux-9 | ok: All items complete 2026-04-14 02:23:56.407716 | 2026-04-14 02:23:56.623779 | rockylinux-9 | ok: "artifacts" 2026-04-14 02:23:56.910665 | rockylinux-9 | ok: "docs" 2026-04-14 02:23:56.927479 | 2026-04-14 02:23:56.927638 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-14 02:23:57.165921 | rockylinux-9 | changed: "logs" 2026-04-14 02:23:57.384315 | rockylinux-9 | changed: "artifacts" 2026-04-14 02:23:57.592204 | rockylinux-9 | changed: "docs" 2026-04-14 02:23:57.614092 | 2026-04-14 02:23:57.614253 | PLAY RECAP 2026-04-14 02:23:57.614308 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-14 02:23:57.614340 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-14 02:23:57.614360 | 2026-04-14 02:23:57.829951 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-14 02:23:57.833149 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-14 02:23:58.412045 | 2026-04-14 02:23:58.412196 | PLAY [all] 2026-04-14 02:23:58.423651 | 2026-04-14 02:23:58.423748 | TASK [setup-uv : Extract archive] 2026-04-14 02:24:01.128743 | rockylinux-9 | changed 2026-04-14 02:24:01.984796 | 2026-04-14 02:24:01.984950 | TASK [setup-uv : Print version] 2026-04-14 02:24:02.009060 | [rockylinux-9] Waiting on logger 2026-04-14 02:24:03.627547 | rockylinux-9 | ok: Runtime: 0:00:00.011464 2026-04-14 02:24:03.635013 | 2026-04-14 02:24:03.635068 | PLAY RECAP 2026-04-14 02:24:03.635112 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-14 02:24:03.635136 | 2026-04-14 02:24:03.830296 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-14 02:24:03.840520 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-14 02:24:04.524455 | 2026-04-14 02:24:04.799838 | PLAY [all] 2026-04-14 02:24:04.820919 | 2026-04-14 02:24:04.821056 | TASK [Copy inventory file for Zuul] 2026-04-14 02:24:06.207794 | rockylinux-9 | changed 2026-04-14 02:24:06.212590 | 2026-04-14 02:24:06.212677 | TASK [Switch "ansible_host" to private IP] 2026-04-14 02:24:06.541691 | rockylinux-9 | changed: 1 replacements made 2026-04-14 02:24:06.655699 | 2026-04-14 02:24:06.655869 | TASK [Run Molecule scenario] 2026-04-14 02:24:06.701141 | [rockylinux-9] Waiting on logger 2026-04-14 02:24:14.854030 | [rockylinux-9] Waiting on logger 2026-04-14 02:24:24.197969 | [rockylinux-9] Waiting on logger 2026-04-14 02:24:34.377982 | [rockylinux-9] Waiting on logger 2026-04-14 02:24:44.550033 | [rockylinux-9] Waiting on logger 2026-04-14 02:24:54.758141 | [rockylinux-9] Waiting on logger 2026-04-14 02:25:04.933957 | [rockylinux-9] Waiting on logger 2026-04-14 02:25:14.091471 | [rockylinux-9] Waiting on logger 2026-04-14 02:25:24.261978 | [rockylinux-9] Waiting on logger 2026-04-14 02:25:34.441865 | [rockylinux-9] Waiting on logger 2026-04-14 02:25:44.613977 | [rockylinux-9] Waiting on logger 2026-04-14 02:25:54.790103 | [rockylinux-9] Waiting on logger 2026-04-14 02:25:59.375164 | rockylinux-9 | ok: Runtime: 0:01:52.130267 2026-04-14 02:25:59.381706 | 2026-04-14 02:25:59.381862 | PLAY RECAP 2026-04-14 02:25:59.381933 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-14 02:25:59.381973 | 2026-04-14 02:25:59.551326 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-14 02:25:59.555176 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-14 02:26:00.267722 | 2026-04-14 02:26:00.306956 | PLAY [all] 2026-04-14 02:26:00.327633 | 2026-04-14 02:26:00.327798 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-14 02:26:00.386226 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:26:00.394958 | 2026-04-14 02:26:00.395078 | TASK [fetch-output : Set log path for single node] 2026-04-14 02:26:00.439811 | rockylinux-9 | ok 2026-04-14 02:26:00.553881 | 2026-04-14 02:26:00.554051 | LOOP [fetch-output : Ensure local output dirs] 2026-04-14 02:26:01.052127 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/aea59b3e980e4307968b7af4dead63e2/work/logs" 2026-04-14 02:26:01.390844 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/aea59b3e980e4307968b7af4dead63e2/work/artifacts" 2026-04-14 02:26:01.657056 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/aea59b3e980e4307968b7af4dead63e2/work/docs" 2026-04-14 02:26:01.677093 | 2026-04-14 02:26:01.677293 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-14 02:26:02.453117 | rockylinux-9 | changed: .d..t...... ./ 2026-04-14 02:26:02.453346 | rockylinux-9 | changed: All items complete 2026-04-14 02:26:02.453376 | 2026-04-14 02:26:03.013061 | rockylinux-9 | changed: .d..t...... ./ 2026-04-14 02:26:03.557896 | rockylinux-9 | changed: .d..t...... ./ 2026-04-14 02:26:03.578658 | 2026-04-14 02:26:03.578755 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-14 02:26:04.471502 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.099862 2026-04-14 02:26:04.765824 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.007428 2026-04-14 02:26:04.774531 | 2026-04-14 02:26:04.774614 | PLAY [all] 2026-04-14 02:26:04.780549 | 2026-04-14 02:26:04.780641 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-14 02:26:05.237420 | rockylinux-9 | changed 2026-04-14 02:26:05.243795 | 2026-04-14 02:26:05.243847 | PLAY RECAP 2026-04-14 02:26:05.243891 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-14 02:26:05.243914 | 2026-04-14 02:26:05.361979 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-14 02:26:05.377861 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-14 02:26:05.984002 | 2026-04-14 02:26:05.984157 | PLAY [localhost] 2026-04-14 02:26:05.994713 | 2026-04-14 02:26:05.994806 | TASK [Generate Zuul manifest] 2026-04-14 02:26:06.037705 | localhost | ok 2026-04-14 02:26:06.056146 | 2026-04-14 02:26:06.056284 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-14 02:26:06.432190 | localhost | changed 2026-04-14 02:26:06.444341 | 2026-04-14 02:26:06.444467 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-14 02:26:06.490345 | localhost | ok 2026-04-14 02:26:06.500307 | 2026-04-14 02:26:06.500380 | TASK [Upload logs] 2026-04-14 02:26:06.532585 | localhost | ok 2026-04-14 02:26:06.602801 | 2026-04-14 02:26:06.602963 | TASK [Set zuul-log-path fact] 2026-04-14 02:26:06.628037 | localhost | ok 2026-04-14 02:26:06.642881 | 2026-04-14 02:26:06.642976 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-14 02:26:06.674198 | localhost | ok 2026-04-14 02:26:06.784263 | 2026-04-14 02:26:06.784379 | TASK [upload-logs : Create log directories] 2026-04-14 02:26:07.345636 | localhost | changed 2026-04-14 02:26:07.350909 | 2026-04-14 02:26:07.350979 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-14 02:26:07.783960 | localhost -> localhost | ok: Runtime: 0:00:00.007784 2026-04-14 02:26:07.789889 | 2026-04-14 02:26:07.789958 | TASK [upload-logs : Upload logs to log server] 2026-04-14 02:26:08.350823 | localhost | Output suppressed because no_log was given 2026-04-14 02:26:08.358902 | 2026-04-14 02:26:08.358995 | LOOP [upload-logs : Compress console log and json output] 2026-04-14 02:26:08.409801 | localhost | skipping: Conditional result was False 2026-04-14 02:26:08.418252 | localhost | skipping: Conditional result was False 2026-04-14 02:26:08.434953 | 2026-04-14 02:26:08.435119 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-14 02:26:08.491353 | localhost | skipping: Conditional result was False 2026-04-14 02:26:08.491663 | 2026-04-14 02:26:08.495701 | localhost | skipping: Conditional result was False 2026-04-14 02:26:08.506493 | 2026-04-14 02:26:08.506806 | LOOP [upload-logs : Upload console log and json output]