2026-04-17 10:43:46.097487 | Job console starting
2026-04-17 10:43:46.105224 | Updating git repos
2026-04-17 10:43:46.128688 | Cloning repos into workspace
2026-04-17 10:43:51.578370 | Restoring repo states
2026-04-17 10:43:51.586959 | Merging changes
2026-04-17 10:43:53.259707 | Checking out repos
2026-04-17 10:43:53.424719 | Preparing playbooks
2026-04-17 10:44:04.641106 | Running Ansible setup
2026-04-17 10:44:09.648152 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-17 10:44:10.208337 | 
2026-04-17 10:44:10.208445 | PLAY [localhost]
2026-04-17 10:44:10.215545 | 
2026-04-17 10:44:10.215610 | TASK [Gathering Facts]
2026-04-17 10:44:11.255091 | localhost | ok
2026-04-17 10:44:11.261812 | 
2026-04-17 10:44:11.261946 | TASK [Setup log path fact]
2026-04-17 10:44:11.284153 | localhost | ok
2026-04-17 10:44:11.309257 | 
2026-04-17 10:44:11.309339 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-17 10:44:11.335586 | localhost | ok
2026-04-17 10:44:11.341331 | 
2026-04-17 10:44:11.341400 | TASK [emit-job-header : Print job information]
2026-04-17 10:44:11.378553 | # Job Information
2026-04-17 10:44:11.378703 | Ansible Version: 2.16.16
2026-04-17 10:44:11.378737 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9
2026-04-17 10:44:11.378760 | Pipeline: check
2026-04-17 10:44:11.378781 | Executor: 0a8996d2b663
2026-04-17 10:44:11.378801 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/114
2026-04-17 10:44:11.378823 | Event ID: 34b67640-3a4a-11f1-9787-0a435e8cfe42
2026-04-17 10:44:11.381575 | 
2026-04-17 10:44:11.381640 | LOOP [emit-job-header : Print node information]
2026-04-17 10:44:11.491377 | localhost | ok:
2026-04-17 10:44:11.491539 | localhost | # Node Information
2026-04-17 10:44:11.491570 | localhost | Inventory Hostname: rockylinux-9
2026-04-17 10:44:11.491598 | localhost | Hostname: np0000167093
2026-04-17 10:44:11.491621 | localhost | Username: zuul
2026-04-17 10:44:11.491645 | localhost | Distro: Rocky 9.7
2026-04-17 10:44:11.491667 | localhost | Provider: yul1
2026-04-17 10:44:11.491686 | localhost | Region: ca-ymq-1
2026-04-17 10:44:11.491706 | localhost | Label: rockylinux-9
2026-04-17 10:44:11.491724 | localhost | Product Name: OpenStack Nova
2026-04-17 10:44:11.491743 | localhost | Interface IP: 199.204.45.242
2026-04-17 10:44:11.503077 | 
2026-04-17 10:44:11.503196 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-17 10:44:11.910679 | localhost -> localhost | changed
2026-04-17 10:44:11.915908 | 
2026-04-17 10:44:11.915976 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-17 10:44:12.824468 | localhost -> localhost | changed
2026-04-17 10:44:12.847091 | 
2026-04-17 10:44:12.847197 | PLAY [all]
2026-04-17 10:44:12.870224 | 
2026-04-17 10:44:12.870364 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-17 10:44:13.191026 | rockylinux-9 -> localhost | ok
2026-04-17 10:44:13.196940 | 
2026-04-17 10:44:13.197058 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-17 10:44:13.225358 | rockylinux-9 | ok
2026-04-17 10:44:13.238816 | rockylinux-9 | included: /var/lib/zuul/builds/dfb9190f3b1c4cba9afb687e5b20fe41/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-17 10:44:13.244545 | 
2026-04-17 10:44:13.244647 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-17 10:44:14.234843 | rockylinux-9 -> localhost | Generating public/private rsa key pair.
2026-04-17 10:44:14.235012 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/dfb9190f3b1c4cba9afb687e5b20fe41/work/dfb9190f3b1c4cba9afb687e5b20fe41_id_rsa
2026-04-17 10:44:14.235044 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/dfb9190f3b1c4cba9afb687e5b20fe41/work/dfb9190f3b1c4cba9afb687e5b20fe41_id_rsa.pub
2026-04-17 10:44:14.235067 | rockylinux-9 -> localhost | The key fingerprint is:
2026-04-17 10:44:14.235089 | rockylinux-9 -> localhost | SHA256:kpgTqa8kzdTpb7n+x6CYQDA/8cSlJ1sbXeFmfR6EOnQ zuul-build-sshkey
2026-04-17 10:44:14.235124 | rockylinux-9 -> localhost | The key's randomart image is:
2026-04-17 10:44:14.235145 | rockylinux-9 -> localhost | +---[RSA 3072]----+
2026-04-17 10:44:14.235174 | rockylinux-9 -> localhost | |   . ..   o. ..  |
2026-04-17 10:44:14.235196 | rockylinux-9 -> localhost | |o . oo . o..E.   |
2026-04-17 10:44:14.235216 | rockylinux-9 -> localhost | | + += + ..+o. o  |
2026-04-17 10:44:14.235237 | rockylinux-9 -> localhost | |  +o.X + oo  o . |
2026-04-17 10:44:14.235257 | rockylinux-9 -> localhost | | .o.B + S  .  .  |
2026-04-17 10:44:14.235277 | rockylinux-9 -> localhost | | +.o . ..        |
2026-04-17 10:44:14.235297 | rockylinux-9 -> localhost | |. +.oo o o       |
2026-04-17 10:44:14.235317 | rockylinux-9 -> localhost | | o .o.+   o      |
2026-04-17 10:44:14.235339 | rockylinux-9 -> localhost | |  .  o+o..       |
2026-04-17 10:44:14.235360 | rockylinux-9 -> localhost | +----[SHA256]-----+
2026-04-17 10:44:14.235412 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.416318
2026-04-17 10:44:14.240312 | 
2026-04-17 10:44:14.240380 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-17 10:44:14.268847 | rockylinux-9 | ok
2026-04-17 10:44:14.277373 | rockylinux-9 | included: /var/lib/zuul/builds/dfb9190f3b1c4cba9afb687e5b20fe41/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-17 10:44:14.285694 | 
2026-04-17 10:44:14.285776 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-17 10:44:14.300883 | rockylinux-9 | skipping: Conditional result was False
2026-04-17 10:44:14.306712 | 
2026-04-17 10:44:14.306785 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-17 10:44:14.798664 | rockylinux-9 | changed
2026-04-17 10:44:14.804979 | 
2026-04-17 10:44:14.805124 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-17 10:44:15.071449 | rockylinux-9 | ok
2026-04-17 10:44:15.077131 | 
2026-04-17 10:44:15.077241 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-17 10:44:16.045087 | rockylinux-9 | changed
2026-04-17 10:44:16.053071 | 
2026-04-17 10:44:16.053168 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-17 10:44:17.001964 | rockylinux-9 | changed
2026-04-17 10:44:17.007077 | 
2026-04-17 10:44:17.007154 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-17 10:44:17.022924 | rockylinux-9 | skipping: Conditional result was False
2026-04-17 10:44:17.030006 | 
2026-04-17 10:44:17.030079 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-17 10:44:17.403996 | rockylinux-9 -> localhost | changed
2026-04-17 10:44:17.414041 | 
2026-04-17 10:44:17.414128 | TASK [add-build-sshkey : Add back temp key]
2026-04-17 10:44:17.696138 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/dfb9190f3b1c4cba9afb687e5b20fe41/work/dfb9190f3b1c4cba9afb687e5b20fe41_id_rsa (zuul-build-sshkey)
2026-04-17 10:44:17.696358 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.010376
2026-04-17 10:44:17.705048 | 
2026-04-17 10:44:17.709968 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-17 10:44:18.113963 | rockylinux-9 | ok
2026-04-17 10:44:18.121593 | 
2026-04-17 10:44:18.121730 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-17 10:44:18.147331 | rockylinux-9 | skipping: Conditional result was False
2026-04-17 10:44:18.164907 | 
2026-04-17 10:44:18.165163 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-17 10:44:18.558644 | rockylinux-9 | ok
2026-04-17 10:44:18.563995 | 
2026-04-17 10:44:18.564061 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-17 10:44:19.569557 | rockylinux-9 | Output suppressed because no_log was given
2026-04-17 10:44:19.577156 | 
2026-04-17 10:44:19.577231 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-17 10:44:19.837924 | rockylinux-9 | ok: "logs"
2026-04-17 10:44:19.859546 | rockylinux-9 | ok: All items complete
2026-04-17 10:44:19.859686 | 
2026-04-17 10:44:20.079693 | rockylinux-9 | ok: "artifacts"
2026-04-17 10:44:20.330236 | rockylinux-9 | ok: "docs"
2026-04-17 10:44:20.345131 | 
2026-04-17 10:44:20.345239 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-17 10:44:20.614550 | rockylinux-9 | changed: "logs"
2026-04-17 10:44:20.843104 | rockylinux-9 | changed: "artifacts"
2026-04-17 10:44:21.075061 | rockylinux-9 | changed: "docs"
2026-04-17 10:44:21.083680 | 
2026-04-17 10:44:21.083736 | PLAY RECAP
2026-04-17 10:44:21.083777 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-17 10:44:21.083806 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-17 10:44:21.083826 | 
2026-04-17 10:44:21.202665 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-17 10:44:21.204518 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-17 10:44:21.789986 | 
2026-04-17 10:44:21.790126 | PLAY [all]
2026-04-17 10:44:21.801155 | 
2026-04-17 10:44:21.801271 | TASK [setup-uv : Extract archive]
2026-04-17 10:44:24.568413 | rockylinux-9 | changed
2026-04-17 10:44:24.573928 | 
2026-04-17 10:44:24.574128 | TASK [setup-uv : Print version]
2026-04-17 10:44:24.596047 | [rockylinux-9] Waiting on logger
2026-04-17 10:44:25.108249 | rockylinux-9 | ok: Runtime: 0:00:00.015951
2026-04-17 10:44:25.120693 | 
2026-04-17 10:44:25.120842 | PLAY RECAP
2026-04-17 10:44:25.120901 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-17 10:44:25.120928 | 
2026-04-17 10:44:25.235431 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-17 10:44:25.237558 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-17 10:44:25.811840 | 
2026-04-17 10:44:25.811974 | PLAY [all]
2026-04-17 10:44:25.826521 | 
2026-04-17 10:44:25.826604 | TASK [Copy inventory file for Zuul]
2026-04-17 10:44:27.179610 | rockylinux-9 | changed
2026-04-17 10:44:27.184214 | 
2026-04-17 10:44:27.184289 | TASK [Switch "ansible_host" to private IP]
2026-04-17 10:44:27.559643 | rockylinux-9 | changed: 1 replacements made
2026-04-17 10:44:27.567855 | 
2026-04-17 10:44:27.567946 | TASK [Run Molecule scenario]
2026-04-17 10:44:27.589273 | [rockylinux-9] Waiting on logger
2026-04-17 10:44:35.718010 | [rockylinux-9] Waiting on logger
2026-04-17 10:44:45.893919 | [rockylinux-9] Waiting on logger
2026-04-17 10:44:56.166401 | [rockylinux-9] Waiting on logger
2026-04-17 10:45:06.346147 | [rockylinux-9] Waiting on logger
2026-04-17 10:45:16.518105 | [rockylinux-9] Waiting on logger
2026-04-17 10:45:25.675259 | [rockylinux-9] Waiting on logger
2026-04-17 10:45:35.846145 | [rockylinux-9] Waiting on logger
2026-04-17 10:45:46.022006 | [rockylinux-9] Waiting on logger
2026-04-17 10:45:56.198769 | [rockylinux-9] Waiting on logger
2026-04-17 10:46:06.374077 | [rockylinux-9] Waiting on logger
2026-04-17 10:46:16.558012 | rockylinux-9 | ok: Runtime: 0:01:47.620581
2026-04-17 10:46:16.563328 | 
2026-04-17 10:46:16.563379 | PLAY RECAP
2026-04-17 10:46:16.563429 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-17 10:46:16.563451 | 
2026-04-17 10:46:16.695591 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-17 10:46:16.697898 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-17 10:46:17.267314 | 
2026-04-17 10:46:17.267815 | PLAY [all]
2026-04-17 10:46:17.278975 | 
2026-04-17 10:46:17.279051 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-17 10:46:17.324459 | rockylinux-9 | skipping: Conditional result was False
2026-04-17 10:46:17.329924 | 
2026-04-17 10:46:17.330014 | TASK [fetch-output : Set log path for single node]
2026-04-17 10:46:17.360226 | rockylinux-9 | ok
2026-04-17 10:46:17.368221 | 
2026-04-17 10:46:17.368325 | LOOP [fetch-output : Ensure local output dirs]
2026-04-17 10:46:17.731361 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/dfb9190f3b1c4cba9afb687e5b20fe41/work/logs"
2026-04-17 10:46:17.961563 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/dfb9190f3b1c4cba9afb687e5b20fe41/work/artifacts"
2026-04-17 10:46:18.173992 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/dfb9190f3b1c4cba9afb687e5b20fe41/work/docs"
2026-04-17 10:46:18.198523 | 
2026-04-17 10:46:18.198854 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-17 10:46:18.882044 | rockylinux-9 | changed: .d..t...... ./
2026-04-17 10:46:18.882335 | rockylinux-9 | changed: All items complete
2026-04-17 10:46:18.882373 | 
2026-04-17 10:46:19.411771 | rockylinux-9 | changed: .d..t...... ./
2026-04-17 10:46:19.925240 | rockylinux-9 | changed: .d..t...... ./
2026-04-17 10:46:19.950847 | 
2026-04-17 10:46:19.951004 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-17 10:46:20.388728 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.006885
2026-04-17 10:46:20.661973 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.007020
2026-04-17 10:46:20.675894 | 
2026-04-17 10:46:20.676031 | PLAY [all]
2026-04-17 10:46:20.682735 | 
2026-04-17 10:46:20.682798 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-17 10:46:21.150476 | rockylinux-9 | changed
2026-04-17 10:46:21.157090 | 
2026-04-17 10:46:21.157157 | PLAY RECAP
2026-04-17 10:46:21.157216 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-17 10:46:21.157249 | 
2026-04-17 10:46:21.265701 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-17 10:46:21.267825 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-17 10:46:21.812426 | 
2026-04-17 10:46:21.812537 | PLAY [localhost]
2026-04-17 10:46:21.822543 | 
2026-04-17 10:46:21.822619 | TASK [Generate Zuul manifest]
2026-04-17 10:46:21.842755 | localhost | ok
2026-04-17 10:46:21.858876 | 
2026-04-17 10:46:21.858953 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-17 10:46:22.191376 | localhost | changed
2026-04-17 10:46:22.202860 | 
2026-04-17 10:46:22.202936 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-17 10:46:22.234544 | localhost | ok
2026-04-17 10:46:22.244118 | 
2026-04-17 10:46:22.244207 | TASK [Upload logs]
2026-04-17 10:46:22.266429 | localhost | ok
2026-04-17 10:46:22.339998 | 
2026-04-17 10:46:22.340191 | TASK [Set zuul-log-path fact]
2026-04-17 10:46:22.364188 | localhost | ok
2026-04-17 10:46:22.377712 | 
2026-04-17 10:46:22.377785 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-17 10:46:22.421852 | localhost | ok
2026-04-17 10:46:22.430685 | 
2026-04-17 10:46:22.430748 | TASK [upload-logs : Create log directories]
2026-04-17 10:46:22.829749 | localhost | changed
2026-04-17 10:46:22.841232 | 
2026-04-17 10:46:22.841314 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-17 10:46:23.233459 | localhost -> localhost | ok: Runtime: 0:00:00.005229
2026-04-17 10:46:23.239953 | 
2026-04-17 10:46:23.240015 | TASK [upload-logs : Upload logs to log server]
2026-04-17 10:46:23.677953 | localhost | Output suppressed because no_log was given
2026-04-17 10:46:23.682906 | 
2026-04-17 10:46:23.682993 | LOOP [upload-logs : Compress console log and json output]
2026-04-17 10:46:23.727977 | localhost | skipping: Conditional result was False
2026-04-17 10:46:23.734839 | localhost | skipping: Conditional result was False
2026-04-17 10:46:23.745922 | 
2026-04-17 10:46:23.746015 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-17 10:46:23.790301 | localhost | skipping: Conditional result was False
2026-04-17 10:46:23.790866 | 
2026-04-17 10:46:23.793492 | localhost | skipping: Conditional result was False
2026-04-17 10:46:23.810399 | 
2026-04-17 10:46:23.810496 | LOOP [upload-logs : Upload console log and json output]