2026-05-01 01:10:07.295020 | Job console starting
2026-05-01 01:10:07.310834 | Updating git repos
2026-05-01 01:10:07.334146 | Cloning repos into workspace
2026-05-01 01:10:07.406278 | Restoring repo states
2026-05-01 01:10:07.412163 | Merging changes
2026-05-01 01:10:07.934132 | Checking out repos
2026-05-01 01:10:08.006104 | Preparing playbooks
2026-05-01 01:10:10.058811 | Running Ansible setup
2026-05-01 01:10:14.322818 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-01 01:10:14.952990 | 
2026-05-01 01:10:14.953281 | PLAY [localhost]
2026-05-01 01:10:14.960973 | 
2026-05-01 01:10:14.961058 | TASK [Gathering Facts]
2026-05-01 01:10:16.085744 | localhost | ok
2026-05-01 01:10:16.095787 | 
2026-05-01 01:10:16.095866 | TASK [Setup log path fact]
2026-05-01 01:10:16.118342 | localhost | ok
2026-05-01 01:10:16.131549 | 
2026-05-01 01:10:16.131632 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-01 01:10:16.167133 | localhost | ok
2026-05-01 01:10:16.174702 | 
2026-05-01 01:10:16.175144 | TASK [emit-job-header : Print job information]
2026-05-01 01:10:16.216111 | # Job Information
2026-05-01 01:10:16.216295 | Ansible Version: 2.16.18
2026-05-01 01:10:16.216328 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9
2026-05-01 01:10:16.216351 | Pipeline: check
2026-05-01 01:10:16.216371 | Executor: 2d72f0692154
2026-05-01 01:10:16.216391 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/127
2026-05-01 01:10:16.216413 | Event ID: 5d95fee0-44fa-11f1-996a-0310ba4962fe
2026-05-01 01:10:16.219445 | 
2026-05-01 01:10:16.219517 | LOOP [emit-job-header : Print node information]
2026-05-01 01:10:16.317481 | localhost | ok:
2026-05-01 01:10:16.317646 | localhost | # Node Information
2026-05-01 01:10:16.317675 | localhost | Inventory Hostname: rockylinux-9
2026-05-01 01:10:16.317698 | localhost | Hostname: np0000171428
2026-05-01 01:10:16.317719 | localhost | Username: zuul
2026-05-01 01:10:16.317743 | localhost | Distro: Rocky 9.7
2026-05-01 01:10:16.317763 | localhost | Provider: yul1
2026-05-01 01:10:16.317782 | localhost | Region: ca-ymq-1
2026-05-01 01:10:16.317801 | localhost | Label: rockylinux-9
2026-05-01 01:10:16.317820 | localhost | Product Name: OpenStack Nova
2026-05-01 01:10:16.317839 | localhost | Interface IP: 199.204.45.78
2026-05-01 01:10:16.333993 | 
2026-05-01 01:10:16.334195 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-01 01:10:16.725010 | localhost -> localhost | changed
2026-05-01 01:10:16.730989 | 
2026-05-01 01:10:16.731055 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-01 01:10:17.600818 | localhost -> localhost | changed
2026-05-01 01:10:17.606324 | 
2026-05-01 01:10:17.606393 | PLAY [all]
2026-05-01 01:10:17.614732 | 
2026-05-01 01:10:17.614847 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-01 01:10:17.865947 | rockylinux-9 -> localhost | ok
2026-05-01 01:10:17.871297 | 
2026-05-01 01:10:17.871370 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-01 01:10:17.906171 | rockylinux-9 | ok
2026-05-01 01:10:17.927451 | rockylinux-9 | included: /var/lib/zuul/builds/aed6dd21ddbb46dd82a60a04bb81e3a7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-01 01:10:17.937192 | 
2026-05-01 01:10:17.937306 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-01 01:10:19.312941 | rockylinux-9 -> localhost | Generating public/private rsa key pair.
2026-05-01 01:10:19.313560 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/aed6dd21ddbb46dd82a60a04bb81e3a7/work/aed6dd21ddbb46dd82a60a04bb81e3a7_id_rsa
2026-05-01 01:10:19.313598 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/aed6dd21ddbb46dd82a60a04bb81e3a7/work/aed6dd21ddbb46dd82a60a04bb81e3a7_id_rsa.pub
2026-05-01 01:10:19.313625 | rockylinux-9 -> localhost | The key fingerprint is:
2026-05-01 01:10:19.313650 | rockylinux-9 -> localhost | SHA256:vOZDpBRqqeD5LzIhP/59EqYeVkdlOoCUqEhmn0RV2N8 zuul-build-sshkey
2026-05-01 01:10:19.313693 | rockylinux-9 -> localhost | The key's randomart image is:
2026-05-01 01:10:19.313720 | rockylinux-9 -> localhost | +---[RSA 3072]----+
2026-05-01 01:10:19.313751 | rockylinux-9 -> localhost | |  .+o+=.  o      |
2026-05-01 01:10:19.313776 | rockylinux-9 -> localhost | | +..o..o +       |
2026-05-01 01:10:19.313799 | rockylinux-9 -> localhost | |=.o .o .= .      |
2026-05-01 01:10:19.313821 | rockylinux-9 -> localhost | |+  o+ .o.o E     |
2026-05-01 01:10:19.313844 | rockylinux-9 -> localhost | |...o ..oS        |
2026-05-01 01:10:19.313867 | rockylinux-9 -> localhost | |.+.  .+...       |
2026-05-01 01:10:19.313889 | rockylinux-9 -> localhost | |..o oo oo        |
2026-05-01 01:10:19.313911 | rockylinux-9 -> localhost | | oo+.o.oo        |
2026-05-01 01:10:19.313936 | rockylinux-9 -> localhost | | .++=..o..       |
2026-05-01 01:10:19.313958 | rockylinux-9 -> localhost | +----[SHA256]-----+
2026-05-01 01:10:19.314012 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.880524
2026-05-01 01:10:19.319223 | 
2026-05-01 01:10:19.319292 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-01 01:10:19.350405 | rockylinux-9 | ok
2026-05-01 01:10:19.364478 | rockylinux-9 | included: /var/lib/zuul/builds/aed6dd21ddbb46dd82a60a04bb81e3a7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-01 01:10:19.376220 | 
2026-05-01 01:10:19.376291 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-01 01:10:19.401803 | rockylinux-9 | skipping: Conditional result was False
2026-05-01 01:10:19.407796 | 
2026-05-01 01:10:19.407868 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-01 01:10:19.956792 | rockylinux-9 | changed
2026-05-01 01:10:19.963337 | 
2026-05-01 01:10:19.963401 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-01 01:10:20.232637 | rockylinux-9 | ok
2026-05-01 01:10:20.239035 | 
2026-05-01 01:10:20.239279 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-01 01:10:21.179927 | rockylinux-9 | changed
2026-05-01 01:10:21.185162 | 
2026-05-01 01:10:21.185245 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-01 01:10:22.071259 | rockylinux-9 | changed
2026-05-01 01:10:22.076545 | 
2026-05-01 01:10:22.076612 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-01 01:10:22.100366 | rockylinux-9 | skipping: Conditional result was False
2026-05-01 01:10:22.105525 | 
2026-05-01 01:10:22.105595 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-01 01:10:22.524502 | rockylinux-9 -> localhost | changed
2026-05-01 01:10:22.533222 | 
2026-05-01 01:10:22.533321 | TASK [add-build-sshkey : Add back temp key]
2026-05-01 01:10:22.805269 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/aed6dd21ddbb46dd82a60a04bb81e3a7/work/aed6dd21ddbb46dd82a60a04bb81e3a7_id_rsa (zuul-build-sshkey)
2026-05-01 01:10:22.805435 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.020705
2026-05-01 01:10:22.809831 | 
2026-05-01 01:10:22.809890 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-01 01:10:23.198091 | rockylinux-9 | ok
2026-05-01 01:10:23.203527 | 
2026-05-01 01:10:23.203602 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-01 01:10:23.227976 | rockylinux-9 | skipping: Conditional result was False
2026-05-01 01:10:23.236392 | 
2026-05-01 01:10:23.236465 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-05-01 01:10:23.626644 | rockylinux-9 | ok
2026-05-01 01:10:23.631489 | 
2026-05-01 01:10:23.631552 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-05-01 01:10:24.621094 | rockylinux-9 | Output suppressed because no_log was given
2026-05-01 01:10:24.630564 | 
2026-05-01 01:10:24.630648 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-05-01 01:10:24.883390 | rockylinux-9 | ok: "logs"
2026-05-01 01:10:24.883608 | rockylinux-9 | ok: All items complete
2026-05-01 01:10:24.883638 | 
2026-05-01 01:10:25.095400 | rockylinux-9 | ok: "artifacts"
2026-05-01 01:10:25.319110 | rockylinux-9 | ok: "docs"
2026-05-01 01:10:25.331590 | 
2026-05-01 01:10:25.331727 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-05-01 01:10:25.576786 | rockylinux-9 | changed: "logs"
2026-05-01 01:10:25.798203 | rockylinux-9 | changed: "artifacts"
2026-05-01 01:10:26.052403 | rockylinux-9 | changed: "docs"
2026-05-01 01:10:26.064607 | 
2026-05-01 01:10:26.064719 | PLAY RECAP
2026-05-01 01:10:26.064791 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-01 01:10:26.064824 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-01 01:10:26.064845 | 
2026-05-01 01:10:26.163202 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-01 01:10:26.165689 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-01 01:10:26.729964 | 
2026-05-01 01:10:26.730074 | PLAY [all]
2026-05-01 01:10:26.740873 | 
2026-05-01 01:10:26.740967 | TASK [setup-uv : Extract archive]
2026-05-01 01:10:29.474888 | rockylinux-9 | changed
2026-05-01 01:10:29.480249 | 
2026-05-01 01:10:29.480336 | TASK [setup-uv : Print version]
2026-05-01 01:10:29.510811 | [rockylinux-9] Waiting on logger
2026-05-01 01:10:29.919666 | rockylinux-9 | ok: Runtime: 0:00:00.016913
2026-05-01 01:10:29.924966 | 
2026-05-01 01:10:29.925028 | PLAY RECAP
2026-05-01 01:10:29.925115 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-01 01:10:29.925159 | 
2026-05-01 01:10:30.039865 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-01 01:10:30.043063 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-01 01:10:30.607697 | 
2026-05-01 01:10:30.607818 | PLAY [all]
2026-05-01 01:10:30.618306 | 
2026-05-01 01:10:30.618378 | TASK [Copy inventory file for Zuul]
2026-05-01 01:10:31.953487 | rockylinux-9 | changed
2026-05-01 01:10:31.958559 | 
2026-05-01 01:10:31.958636 | TASK [Switch "ansible_host" to private IP]
2026-05-01 01:10:32.335096 | rockylinux-9 | changed: 1 replacements made
2026-05-01 01:10:32.340757 | 
2026-05-01 01:10:32.340836 | TASK [Run Molecule scenario]
2026-05-01 01:10:32.364948 | [rockylinux-9] Waiting on logger
2026-05-01 01:10:40.518098 | [rockylinux-9] Waiting on logger
2026-05-01 01:10:49.670138 | [rockylinux-9] Waiting on logger
2026-05-01 01:10:59.846250 | [rockylinux-9] Waiting on logger
2026-05-01 01:11:10.026398 | [rockylinux-9] Waiting on logger
2026-05-01 01:11:20.198053 | [rockylinux-9] Waiting on logger
2026-05-01 01:11:30.374025 | [rockylinux-9] Waiting on logger
2026-05-01 01:11:39.531256 | [rockylinux-9] Waiting on logger
2026-05-01 01:11:49.701974 | [rockylinux-9] Waiting on logger
2026-05-01 01:11:59.878153 | [rockylinux-9] Waiting on logger
2026-05-01 01:12:10.054147 | [rockylinux-9] Waiting on logger
2026-05-01 01:12:20.230211 | [rockylinux-9] Waiting on logger
2026-05-01 01:12:30.406052 | [rockylinux-9] Waiting on logger
2026-05-01 01:12:32.749837 | rockylinux-9 | ok: Runtime: 0:01:59.435150
2026-05-01 01:12:33.028654 | 
2026-05-01 01:12:33.028732 | PLAY RECAP
2026-05-01 01:12:33.028790 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-01 01:12:33.028821 | 
2026-05-01 01:12:33.121616 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-01 01:12:33.124221 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-01 01:12:33.778741 | 
2026-05-01 01:12:33.778881 | PLAY [all]
2026-05-01 01:12:33.790204 | 
2026-05-01 01:12:33.790296 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-01 01:12:33.835263 | rockylinux-9 | skipping: Conditional result was False
2026-05-01 01:12:33.844027 | 
2026-05-01 01:12:33.844143 | TASK [fetch-output : Set log path for single node]
2026-05-01 01:12:33.886876 | rockylinux-9 | ok
2026-05-01 01:12:33.892906 | 
2026-05-01 01:12:33.893039 | LOOP [fetch-output : Ensure local output dirs]
2026-05-01 01:12:34.286060 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/aed6dd21ddbb46dd82a60a04bb81e3a7/work/logs"
2026-05-01 01:12:34.491630 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/aed6dd21ddbb46dd82a60a04bb81e3a7/work/artifacts"
2026-05-01 01:12:34.686663 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/aed6dd21ddbb46dd82a60a04bb81e3a7/work/docs"
2026-05-01 01:12:34.706435 | 
2026-05-01 01:12:34.706583 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-01 01:12:35.375068 | rockylinux-9 | changed: .d..t...... ./
2026-05-01 01:12:35.375348 | rockylinux-9 | changed: All items complete
2026-05-01 01:12:35.375388 | 
2026-05-01 01:12:35.861503 | rockylinux-9 | changed: .d..t...... ./
2026-05-01 01:12:36.901225 | rockylinux-9 | changed: .d..t...... ./
2026-05-01 01:12:36.926847 | 
2026-05-01 01:12:36.927009 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-01 01:12:37.316774 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.011774
2026-05-01 01:12:37.571574 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.009324
2026-05-01 01:12:37.595199 | 
2026-05-01 01:12:37.595319 | PLAY [all]
2026-05-01 01:12:37.601067 | 
2026-05-01 01:12:37.601132 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-01 01:12:38.049216 | rockylinux-9 | changed
2026-05-01 01:12:38.056605 | 
2026-05-01 01:12:38.056695 | PLAY RECAP
2026-05-01 01:12:38.056765 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-01 01:12:38.056805 | 
2026-05-01 01:12:38.177297 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-01 01:12:38.178717 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-01 01:12:38.773659 | 
2026-05-01 01:12:38.773786 | PLAY [localhost]
2026-05-01 01:12:38.784421 | 
2026-05-01 01:12:38.784518 | TASK [Generate Zuul manifest]
2026-05-01 01:12:38.805590 | localhost | ok
2026-05-01 01:12:38.821593 | 
2026-05-01 01:12:38.845560 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-01 01:12:39.292622 | localhost | changed
2026-05-01 01:12:39.305449 | 
2026-05-01 01:12:39.305531 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-01 01:12:39.376528 | localhost | ok
2026-05-01 01:12:39.385146 | 
2026-05-01 01:12:39.385208 | TASK [Upload logs]
2026-05-01 01:12:39.405334 | localhost | ok
2026-05-01 01:12:39.463961 | 
2026-05-01 01:12:39.464083 | TASK [Set zuul-log-path fact]
2026-05-01 01:12:39.482543 | localhost | ok
2026-05-01 01:12:39.496799 | 
2026-05-01 01:12:39.496887 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-01 01:12:39.527069 | localhost | ok
2026-05-01 01:12:39.536182 | 
2026-05-01 01:12:39.536252 | TASK [upload-logs : Create log directories]
2026-05-01 01:12:40.003048 | localhost | changed
2026-05-01 01:12:40.009797 | 
2026-05-01 01:12:40.009888 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-01 01:12:40.405945 | localhost -> localhost | ok: Runtime: 0:00:00.003853
2026-05-01 01:12:40.412992 | 
2026-05-01 01:12:40.413059 | TASK [upload-logs : Upload logs to log server]
2026-05-01 01:12:40.848623 | localhost | Output suppressed because no_log was given
2026-05-01 01:12:40.855565 | 
2026-05-01 01:12:40.855633 | LOOP [upload-logs : Compress console log and json output]
2026-05-01 01:12:40.910104 | localhost | skipping: Conditional result was False
2026-05-01 01:12:40.920185 | localhost | skipping: Conditional result was False
2026-05-01 01:12:40.928846 | 
2026-05-01 01:12:40.929017 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-01 01:12:40.969768 | localhost | skipping: Conditional result was False
2026-05-01 01:12:40.970206 | 
2026-05-01 01:12:40.973951 | localhost | skipping: Conditional result was False
2026-05-01 01:12:40.992050 | 
2026-05-01 01:12:40.992199 | LOOP [upload-logs : Upload console log and json output]