2026-04-10 00:54:11.612054 | Job console starting
2026-04-10 00:54:11.641850 | Updating git repos
2026-04-10 00:54:11.735903 | Cloning repos into workspace
2026-04-10 00:54:11.977012 | Restoring repo states
2026-04-10 00:54:11.994243 | Merging changes
2026-04-10 00:54:12.919995 | Checking out repos
2026-04-10 00:54:13.330362 | Preparing playbooks
2026-04-10 00:54:15.796712 | Running Ansible setup
2026-04-10 00:54:19.694772 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-10 00:54:20.297750 | 
2026-04-10 00:54:20.297888 | PLAY [localhost]
2026-04-10 00:54:20.305797 | 
2026-04-10 00:54:20.305872 | TASK [Gathering Facts]
2026-04-10 00:54:21.287325 | localhost | ok
2026-04-10 00:54:21.293974 | 
2026-04-10 00:54:21.294106 | TASK [Setup log path fact]
2026-04-10 00:54:21.311787 | localhost | ok
2026-04-10 00:54:21.323416 | 
2026-04-10 00:54:21.323612 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-10 00:54:21.353633 | localhost | ok
2026-04-10 00:54:21.361114 | 
2026-04-10 00:54:21.361183 | TASK [emit-job-header : Print job information]
2026-04-10 00:54:21.409754 | # Job Information
2026-04-10 00:54:21.409930 | Ansible Version: 2.16.16
2026-04-10 00:54:21.409963 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9
2026-04-10 00:54:21.409987 | Pipeline: check
2026-04-10 00:54:21.410007 | Executor: 0a8996d2b663
2026-04-10 00:54:21.410027 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/105
2026-04-10 00:54:21.410050 | Event ID: a2492050-3477-11f1-9e4c-c329e3910f5b
2026-04-10 00:54:21.413786 | 
2026-04-10 00:54:21.413861 | LOOP [emit-job-header : Print node information]
2026-04-10 00:54:21.515593 | localhost | ok:
2026-04-10 00:54:21.515829 | localhost | # Node Information
2026-04-10 00:54:21.515871 | localhost | Inventory Hostname: rockylinux-9
2026-04-10 00:54:21.515905 | localhost | Hostname: np0000164787
2026-04-10 00:54:21.515935 | localhost | Username: zuul
2026-04-10 00:54:21.515969 | localhost | Distro: Rocky 9.7
2026-04-10 00:54:21.515999 | localhost | Provider: yul1
2026-04-10 00:54:21.516028 | localhost | Region: ca-ymq-1
2026-04-10 00:54:21.516057 | localhost | Label: rockylinux-9
2026-04-10 00:54:21.516085 | localhost | Product Name: OpenStack Nova
2026-04-10 00:54:21.516114 | localhost | Interface IP: 199.204.45.156
2026-04-10 00:54:21.543938 | 
2026-04-10 00:54:21.544086 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-10 00:54:22.023954 | localhost -> localhost | changed
2026-04-10 00:54:22.030864 | 
2026-04-10 00:54:22.030946 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-10 00:54:23.047824 | localhost -> localhost | changed
2026-04-10 00:54:23.057393 | 
2026-04-10 00:54:23.057504 | PLAY [all]
2026-04-10 00:54:23.065265 | 
2026-04-10 00:54:23.065344 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-10 00:54:23.324938 | rockylinux-9 -> localhost | ok
2026-04-10 00:54:23.330854 | 
2026-04-10 00:54:23.330970 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-10 00:54:23.351462 | rockylinux-9 | ok
2026-04-10 00:54:23.365788 | rockylinux-9 | included: /var/lib/zuul/builds/d5b5de16606e49378310c3d10f69be6d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-10 00:54:23.371311 | 
2026-04-10 00:54:23.371420 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-10 00:54:24.060801 | rockylinux-9 -> localhost | Generating public/private rsa key pair.
2026-04-10 00:54:24.060981 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/d5b5de16606e49378310c3d10f69be6d/work/d5b5de16606e49378310c3d10f69be6d_id_rsa
2026-04-10 00:54:24.061030 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/d5b5de16606e49378310c3d10f69be6d/work/d5b5de16606e49378310c3d10f69be6d_id_rsa.pub
2026-04-10 00:54:24.061055 | rockylinux-9 -> localhost | The key fingerprint is:
2026-04-10 00:54:24.061077 | rockylinux-9 -> localhost | SHA256:Uw+7HHGaDHQ6CPtRo5XOQvfYegg6r7FH0nrIUeO1VkE zuul-build-sshkey
2026-04-10 00:54:24.061113 | rockylinux-9 -> localhost | The key's randomart image is:
2026-04-10 00:54:24.061135 | rockylinux-9 -> localhost | +---[RSA 3072]----+
2026-04-10 00:54:24.061162 | rockylinux-9 -> localhost | |    .   =oE      |
2026-04-10 00:54:24.061184 | rockylinux-9 -> localhost | |     o.*o+.      |
2026-04-10 00:54:24.061205 | rockylinux-9 -> localhost | |    ..+++++..    |
2026-04-10 00:54:24.061226 | rockylinux-9 -> localhost | |     .=.==+O     |
2026-04-10 00:54:24.061246 | rockylinux-9 -> localhost | |     =.=S=* .    |
2026-04-10 00:54:24.061266 | rockylinux-9 -> localhost | |    = + =o.o     |
2026-04-10 00:54:24.061285 | rockylinux-9 -> localhost | |   ..O . .o      |
2026-04-10 00:54:24.061305 | rockylinux-9 -> localhost | |    +o+          |
2026-04-10 00:54:24.061328 | rockylinux-9 -> localhost | |    o+           |
2026-04-10 00:54:24.061349 | rockylinux-9 -> localhost | +----[SHA256]-----+
2026-04-10 00:54:24.061401 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.236702
2026-04-10 00:54:24.066192 | 
2026-04-10 00:54:24.066258 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-10 00:54:24.096348 | rockylinux-9 | ok
2026-04-10 00:54:24.105345 | rockylinux-9 | included: /var/lib/zuul/builds/d5b5de16606e49378310c3d10f69be6d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-10 00:54:24.117451 | 
2026-04-10 00:54:24.117808 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-10 00:54:24.142846 | rockylinux-9 | skipping: Conditional result was False
2026-04-10 00:54:24.153174 | 
2026-04-10 00:54:24.153333 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-10 00:54:24.615729 | rockylinux-9 | changed
2026-04-10 00:54:24.622416 | 
2026-04-10 00:54:24.622556 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-10 00:54:24.860801 | rockylinux-9 | ok
2026-04-10 00:54:24.866693 | 
2026-04-10 00:54:24.866828 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-10 00:54:25.789365 | rockylinux-9 | changed
2026-04-10 00:54:25.795283 | 
2026-04-10 00:54:25.795360 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-10 00:54:26.712401 | rockylinux-9 | changed
2026-04-10 00:54:26.718350 | 
2026-04-10 00:54:26.718689 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-10 00:54:26.745920 | rockylinux-9 | skipping: Conditional result was False
2026-04-10 00:54:26.751765 | 
2026-04-10 00:54:26.751840 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-10 00:54:27.257436 | rockylinux-9 -> localhost | changed
2026-04-10 00:54:27.270786 | 
2026-04-10 00:54:27.270941 | TASK [add-build-sshkey : Add back temp key]
2026-04-10 00:54:27.591093 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/d5b5de16606e49378310c3d10f69be6d/work/d5b5de16606e49378310c3d10f69be6d_id_rsa (zuul-build-sshkey)
2026-04-10 00:54:27.591341 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.015370
2026-04-10 00:54:27.600080 | 
2026-04-10 00:54:27.600148 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-10 00:54:28.012811 | rockylinux-9 | ok
2026-04-10 00:54:28.053832 | 
2026-04-10 00:54:28.053933 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-10 00:54:28.088151 | rockylinux-9 | skipping: Conditional result was False
2026-04-10 00:54:28.102160 | 
2026-04-10 00:54:28.102288 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-10 00:54:28.539732 | rockylinux-9 | ok
2026-04-10 00:54:28.549464 | 
2026-04-10 00:54:28.549537 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-10 00:54:29.493999 | rockylinux-9 | Output suppressed because no_log was given
2026-04-10 00:54:29.654524 | 
2026-04-10 00:54:29.654642 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-10 00:54:29.901496 | rockylinux-9 | ok: "logs"
2026-04-10 00:54:29.902033 | rockylinux-9 | ok: All items complete
2026-04-10 00:54:29.902070 | 
2026-04-10 00:54:30.119056 | rockylinux-9 | ok: "artifacts"
2026-04-10 00:54:30.341398 | rockylinux-9 | ok: "docs"
2026-04-10 00:54:30.358714 | 
2026-04-10 00:54:30.358851 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-10 00:54:30.614533 | rockylinux-9 | changed: "logs"
2026-04-10 00:54:30.826028 | rockylinux-9 | changed: "artifacts"
2026-04-10 00:54:31.040520 | rockylinux-9 | changed: "docs"
2026-04-10 00:54:31.061337 | 
2026-04-10 00:54:31.061497 | PLAY RECAP
2026-04-10 00:54:31.061578 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-10 00:54:31.061625 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-10 00:54:31.061659 | 
2026-04-10 00:54:31.221235 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-10 00:54:31.222673 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-10 00:54:31.867869 | 
2026-04-10 00:54:31.868253 | PLAY [all]
2026-04-10 00:54:31.883599 | 
2026-04-10 00:54:31.883821 | TASK [setup-uv : Extract archive]
2026-04-10 00:54:34.673325 | rockylinux-9 | changed
2026-04-10 00:54:34.679665 | 
2026-04-10 00:54:34.679812 | TASK [setup-uv : Print version]
2026-04-10 00:54:34.714552 | [rockylinux-9] Waiting on logger
2026-04-10 00:54:35.228209 | rockylinux-9 | ok: Runtime: 0:00:00.014929
2026-04-10 00:54:35.236515 | 
2026-04-10 00:54:35.236580 | PLAY RECAP
2026-04-10 00:54:35.236633 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-10 00:54:35.236662 | 
2026-04-10 00:54:35.414905 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-10 00:54:35.488251 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-10 00:54:36.151742 | 
2026-04-10 00:54:36.151922 | PLAY [all]
2026-04-10 00:54:36.164624 | 
2026-04-10 00:54:36.164752 | TASK [Copy inventory file for Zuul]
2026-04-10 00:54:37.508078 | rockylinux-9 | changed
2026-04-10 00:54:37.521595 | 
2026-04-10 00:54:37.521683 | TASK [Switch "ansible_host" to private IP]
2026-04-10 00:54:37.860565 | rockylinux-9 | changed: 1 replacements made
2026-04-10 00:54:37.867182 | 
2026-04-10 00:54:37.867271 | TASK [Run Molecule scenario]
2026-04-10 00:54:37.916621 | [rockylinux-9] Waiting on logger
2026-04-10 00:54:46.054049 | [rockylinux-9] Waiting on logger
2026-04-10 00:54:56.293903 | [rockylinux-9] Waiting on logger
2026-04-10 00:55:06.473966 | [rockylinux-9] Waiting on logger
2026-04-10 00:55:16.646084 | [rockylinux-9] Waiting on logger
2026-04-10 00:55:25.803455 | [rockylinux-9] Waiting on logger
2026-04-10 00:55:35.974288 | [rockylinux-9] Waiting on logger
2026-04-10 00:55:46.149970 | [rockylinux-9] Waiting on logger
2026-04-10 00:55:56.330109 | [rockylinux-9] Waiting on logger
2026-04-10 00:56:06.502101 | [rockylinux-9] Waiting on logger
2026-04-10 00:56:16.678048 | [rockylinux-9] Waiting on logger
2026-04-10 00:56:20.141919 | rockylinux-9 | ok: Runtime: 0:01:41.466713
2026-04-10 00:56:20.147799 | 
2026-04-10 00:56:20.147859 | PLAY RECAP
2026-04-10 00:56:20.147918 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-10 00:56:20.147948 | 
2026-04-10 00:56:20.299466 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-10 00:56:20.302757 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-10 00:56:20.888638 | 
2026-04-10 00:56:20.888787 | PLAY [all]
2026-04-10 00:56:20.899618 | 
2026-04-10 00:56:20.899700 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-10 00:56:20.945942 | rockylinux-9 | skipping: Conditional result was False
2026-04-10 00:56:20.957066 | 
2026-04-10 00:56:20.957183 | TASK [fetch-output : Set log path for single node]
2026-04-10 00:56:21.000285 | rockylinux-9 | ok
2026-04-10 00:56:21.008911 | 
2026-04-10 00:56:21.009053 | LOOP [fetch-output : Ensure local output dirs]
2026-04-10 00:56:21.398460 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/d5b5de16606e49378310c3d10f69be6d/work/logs"
2026-04-10 00:56:21.611225 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/d5b5de16606e49378310c3d10f69be6d/work/artifacts"
2026-04-10 00:56:21.835413 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/d5b5de16606e49378310c3d10f69be6d/work/docs"
2026-04-10 00:56:21.851065 | 
2026-04-10 00:56:21.851311 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-10 00:56:22.585745 | rockylinux-9 | changed: .d..t...... ./
2026-04-10 00:56:22.586056 | rockylinux-9 | changed: All items complete
2026-04-10 00:56:22.586105 | 
2026-04-10 00:56:23.112636 | rockylinux-9 | changed: .d..t...... ./
2026-04-10 00:56:23.653545 | rockylinux-9 | changed: .d..t...... ./
2026-04-10 00:56:23.674157 | 
2026-04-10 00:56:23.674362 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-10 00:56:24.099564 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008082
2026-04-10 00:56:24.410143 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.008944
2026-04-10 00:56:24.429643 | 
2026-04-10 00:56:24.429795 | PLAY [all]
2026-04-10 00:56:24.440289 | 
2026-04-10 00:56:24.440433 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-10 00:56:24.911257 | rockylinux-9 | changed
2026-04-10 00:56:24.920713 | 
2026-04-10 00:56:24.920812 | PLAY RECAP
2026-04-10 00:56:24.920883 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-10 00:56:24.920919 | 
2026-04-10 00:56:25.082002 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-10 00:56:25.084089 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-10 00:56:25.669234 | 
2026-04-10 00:56:25.669379 | PLAY [localhost]
2026-04-10 00:56:25.679287 | 
2026-04-10 00:56:25.679360 | TASK [Generate Zuul manifest]
2026-04-10 00:56:25.699658 | localhost | ok
2026-04-10 00:56:25.715956 | 
2026-04-10 00:56:25.716042 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-10 00:56:26.050269 | localhost | changed
2026-04-10 00:56:26.067037 | 
2026-04-10 00:56:26.067154 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-10 00:56:26.099281 | localhost | ok
2026-04-10 00:56:26.108312 | 
2026-04-10 00:56:26.108409 | TASK [Upload logs]
2026-04-10 00:56:26.128291 | localhost | ok
2026-04-10 00:56:26.189884 | 
2026-04-10 00:56:26.190046 | TASK [Set zuul-log-path fact]
2026-04-10 00:56:26.210138 | localhost | ok
2026-04-10 00:56:26.223607 | 
2026-04-10 00:56:26.223687 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-10 00:56:26.254412 | localhost | ok
2026-04-10 00:56:26.264610 | 
2026-04-10 00:56:26.264704 | TASK [upload-logs : Create log directories]
2026-04-10 00:56:26.671929 | localhost | changed
2026-04-10 00:56:26.678584 | 
2026-04-10 00:56:26.678683 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-10 00:56:27.087725 | localhost -> localhost | ok: Runtime: 0:00:00.006341
2026-04-10 00:56:27.094460 | 
2026-04-10 00:56:27.094550 | TASK [upload-logs : Upload logs to log server]
2026-04-10 00:56:27.593361 | localhost | Output suppressed because no_log was given
2026-04-10 00:56:27.598980 | 
2026-04-10 00:56:27.599048 | LOOP [upload-logs : Compress console log and json output]
2026-04-10 00:56:27.647853 | localhost | skipping: Conditional result was False
2026-04-10 00:56:27.655416 | localhost | skipping: Conditional result was False
2026-04-10 00:56:27.674113 | 
2026-04-10 00:56:27.674301 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-10 00:56:27.721158 | localhost | skipping: Conditional result was False
2026-04-10 00:56:27.721809 | 
2026-04-10 00:56:27.724541 | localhost | skipping: Conditional result was False
2026-04-10 00:56:27.741697 | 
2026-04-10 00:56:27.741867 | LOOP [upload-logs : Upload console log and json output]