2026-03-16 00:54:20.664124 | Job console starting
2026-03-16 00:54:20.671563 | Updating git repos
2026-03-16 00:54:20.686755 | Cloning repos into workspace
2026-03-16 00:54:20.730739 | Restoring repo states
2026-03-16 00:54:20.739052 | Merging changes
2026-03-16 00:54:21.003478 | Checking out repos
2026-03-16 00:54:21.035848 | Preparing playbooks
2026-03-16 00:54:22.013154 | Running Ansible setup
2026-03-16 00:54:25.489492 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-16 00:54:26.062412 | 
2026-03-16 00:54:26.062612 | PLAY [localhost]
2026-03-16 00:54:26.071231 | 
2026-03-16 00:54:26.071307 | TASK [Gathering Facts]
2026-03-16 00:54:26.940117 | localhost | ok
2026-03-16 00:54:26.947551 | 
2026-03-16 00:54:26.947632 | TASK [Setup log path fact]
2026-03-16 00:54:26.966996 | localhost | ok
2026-03-16 00:54:26.982650 | 
2026-03-16 00:54:26.982715 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-16 00:54:27.010541 | localhost | ok
2026-03-16 00:54:27.018062 | 
2026-03-16 00:54:27.018134 | TASK [emit-job-header : Print job information]
2026-03-16 00:54:27.058278 | # Job Information
2026-03-16 00:54:27.058423 | Ansible Version: 2.16.16
2026-03-16 00:54:27.058466 | Job: ansible-collection-containers-molecule-containerd-rockylinux-9
2026-03-16 00:54:27.058497 | Pipeline: check
2026-03-16 00:54:27.058524 | Executor: 0a8996d2b663
2026-03-16 00:54:27.058551 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/101
2026-03-16 00:54:27.058580 | Event ID: 77b9c3c0-20d2-11f1-8fa9-da7cf51ce81d
2026-03-16 00:54:27.062165 | 
2026-03-16 00:54:27.062249 | LOOP [emit-job-header : Print node information]
2026-03-16 00:54:27.157470 | localhost | ok:
2026-03-16 00:54:27.157713 | localhost | # Node Information
2026-03-16 00:54:27.157741 | localhost | Inventory Hostname: rockylinux-9
2026-03-16 00:54:27.157766 | localhost | Hostname: np0000158867
2026-03-16 00:54:27.157786 | localhost | Username: zuul
2026-03-16 00:54:27.157809 | localhost | Distro: Rocky 9.7
2026-03-16 00:54:27.157828 | localhost | Provider: yul1
2026-03-16 00:54:27.157847 | localhost | Region: ca-ymq-1
2026-03-16 00:54:27.157865 | localhost | Label: rockylinux-9
2026-03-16 00:54:27.157883 | localhost | Product Name: OpenStack Nova
2026-03-16 00:54:27.157901 | localhost | Interface IP: 162.253.55.110
2026-03-16 00:54:27.169749 | 
2026-03-16 00:54:27.169857 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-16 00:54:27.582580 | localhost -> localhost | changed
2026-03-16 00:54:27.602119 | 
2026-03-16 00:54:27.602195 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-16 00:54:28.487054 | localhost -> localhost | changed
2026-03-16 00:54:28.497173 | 
2026-03-16 00:54:28.497263 | PLAY [all]
2026-03-16 00:54:28.506120 | 
2026-03-16 00:54:28.506209 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-16 00:54:28.765587 | rockylinux-9 -> localhost | ok
2026-03-16 00:54:28.776558 | 
2026-03-16 00:54:28.776715 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-16 00:54:28.807522 | rockylinux-9 | ok
2026-03-16 00:54:28.823728 | rockylinux-9 | included: /var/lib/zuul/builds/ea40920e237f4746bc23fb5b715453b6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-16 00:54:28.829607 | 
2026-03-16 00:54:28.830388 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-16 00:54:29.987929 | rockylinux-9 -> localhost | Generating public/private rsa key pair.
2026-03-16 00:54:29.988827 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/ea40920e237f4746bc23fb5b715453b6/work/ea40920e237f4746bc23fb5b715453b6_id_rsa
2026-03-16 00:54:29.988864 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/ea40920e237f4746bc23fb5b715453b6/work/ea40920e237f4746bc23fb5b715453b6_id_rsa.pub
2026-03-16 00:54:29.988888 | rockylinux-9 -> localhost | The key fingerprint is:
2026-03-16 00:54:29.988912 | rockylinux-9 -> localhost | SHA256:zaTxVaZkTf1A+AC8aia1hSGJunhhBv4tD858393g9CQ zuul-build-sshkey
2026-03-16 00:54:29.988977 | rockylinux-9 -> localhost | The key's randomart image is:
2026-03-16 00:54:29.989013 | rockylinux-9 -> localhost | +---[RSA 3072]----+
2026-03-16 00:54:29.989043 | rockylinux-9 -> localhost | |     . . ...o==. |
2026-03-16 00:54:29.989066 | rockylinux-9 -> localhost | |.   . o . .oo+o .|
2026-03-16 00:54:29.989085 | rockylinux-9 -> localhost | |.. .   ..o..oo ..|
2026-03-16 00:54:29.989105 | rockylinux-9 -> localhost | | .=     oBo.  . .|
2026-03-16 00:54:29.989125 | rockylinux-9 -> localhost | | +.o.  .S++      |
2026-03-16 00:54:29.989144 | rockylinux-9 -> localhost | |. o+ .. =        |
2026-03-16 00:54:29.989163 | rockylinux-9 -> localhost | | .+ +  +   E .   |
2026-03-16 00:54:29.989182 | rockylinux-9 -> localhost | |   + o  . + *    |
2026-03-16 00:54:29.989205 | rockylinux-9 -> localhost | |    . .. . o o   |
2026-03-16 00:54:29.989225 | rockylinux-9 -> localhost | +----[SHA256]-----+
2026-03-16 00:54:29.989277 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.732646
2026-03-16 00:54:29.995115 | 
2026-03-16 00:54:29.995201 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-16 00:54:30.027500 | rockylinux-9 | ok
2026-03-16 00:54:30.037228 | rockylinux-9 | included: /var/lib/zuul/builds/ea40920e237f4746bc23fb5b715453b6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-16 00:54:30.045158 | 
2026-03-16 00:54:30.045225 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-16 00:54:30.070607 | rockylinux-9 | skipping: Conditional result was False
2026-03-16 00:54:30.080466 | 
2026-03-16 00:54:30.080599 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-16 00:54:30.549979 | rockylinux-9 | changed
2026-03-16 00:54:30.557250 | 
2026-03-16 00:54:30.557353 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-16 00:54:30.823173 | rockylinux-9 | ok
2026-03-16 00:54:30.829973 | 
2026-03-16 00:54:30.830112 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-16 00:54:31.695492 | rockylinux-9 | changed
2026-03-16 00:54:31.703122 | 
2026-03-16 00:54:31.703214 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-16 00:54:32.602133 | rockylinux-9 | changed
2026-03-16 00:54:32.607170 | 
2026-03-16 00:54:32.607236 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-16 00:54:32.632403 | rockylinux-9 | skipping: Conditional result was False
2026-03-16 00:54:32.643451 | 
2026-03-16 00:54:32.643538 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-16 00:54:32.992125 | rockylinux-9 -> localhost | changed
2026-03-16 00:54:33.005347 | 
2026-03-16 00:54:33.005436 | TASK [add-build-sshkey : Add back temp key]
2026-03-16 00:54:33.281031 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/ea40920e237f4746bc23fb5b715453b6/work/ea40920e237f4746bc23fb5b715453b6_id_rsa (zuul-build-sshkey)
2026-03-16 00:54:33.281213 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.015855
2026-03-16 00:54:33.288985 | 
2026-03-16 00:54:33.289046 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-16 00:54:33.665299 | rockylinux-9 | ok
2026-03-16 00:54:33.670941 | 
2026-03-16 00:54:33.671026 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-16 00:54:33.695829 | rockylinux-9 | skipping: Conditional result was False
2026-03-16 00:54:33.708939 | 
2026-03-16 00:54:33.709040 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-16 00:54:34.117755 | rockylinux-9 | ok
2026-03-16 00:54:34.123439 | 
2026-03-16 00:54:34.123506 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-16 00:54:35.020532 | rockylinux-9 | Output suppressed because no_log was given
2026-03-16 00:54:35.030401 | 
2026-03-16 00:54:35.030470 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-16 00:54:35.301030 | rockylinux-9 | ok: "logs"
2026-03-16 00:54:35.301707 | rockylinux-9 | ok: All items complete
2026-03-16 00:54:35.301751 | 
2026-03-16 00:54:35.525209 | rockylinux-9 | ok: "artifacts"
2026-03-16 00:54:35.753865 | rockylinux-9 | ok: "docs"
2026-03-16 00:54:35.769119 | 
2026-03-16 00:54:35.769309 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-16 00:54:36.024240 | rockylinux-9 | changed: "logs"
2026-03-16 00:54:36.246186 | rockylinux-9 | changed: "artifacts"
2026-03-16 00:54:36.497653 | rockylinux-9 | changed: "docs"
2026-03-16 00:54:36.517842 | 
2026-03-16 00:54:36.518016 | PLAY RECAP
2026-03-16 00:54:36.518069 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-16 00:54:36.518100 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-16 00:54:36.518192 | 
2026-03-16 00:54:36.697936 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-16 00:54:36.699990 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-16 00:54:37.267939 | 
2026-03-16 00:54:37.268135 | PLAY [all]
2026-03-16 00:54:37.280484 | 
2026-03-16 00:54:37.280572 | TASK [setup-uv : Extract archive]
2026-03-16 00:54:40.102684 | rockylinux-9 | changed
2026-03-16 00:54:40.108726 | 
2026-03-16 00:54:40.108809 | TASK [setup-uv : Print version]
2026-03-16 00:54:40.132370 | [rockylinux-9] Waiting on logger
2026-03-16 00:54:40.649089 | rockylinux-9 | ok: Runtime: 0:00:00.013877
2026-03-16 00:54:40.656761 | 
2026-03-16 00:54:40.656812 | PLAY RECAP
2026-03-16 00:54:40.656864 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-16 00:54:40.656897 | 
2026-03-16 00:54:40.782600 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-16 00:54:40.784919 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-16 00:54:41.364627 | 
2026-03-16 00:54:41.364812 | PLAY [all]
2026-03-16 00:54:41.376253 | 
2026-03-16 00:54:41.376352 | TASK [Copy inventory file for Zuul]
2026-03-16 00:54:42.685053 | rockylinux-9 | changed
2026-03-16 00:54:42.690231 | 
2026-03-16 00:54:42.690363 | TASK [Switch "ansible_host" to private IP]
2026-03-16 00:54:43.018978 | rockylinux-9 | changed: 1 replacements made
2026-03-16 00:54:43.024860 | 
2026-03-16 00:54:43.024936 | TASK [Run Molecule scenario]
2026-03-16 00:54:43.048305 | [rockylinux-9] Waiting on logger
2026-03-16 00:54:51.179142 | [rockylinux-9] Waiting on logger
2026-03-16 00:55:01.360975 | rockylinux-9 | ERROR
2026-03-16 00:55:01.361207 | rockylinux-9 | {
2026-03-16 00:55:01.361256 | rockylinux-9 |   "delta": "0:00:16.925438",
2026-03-16 00:55:01.361290 | rockylinux-9 |   "end": "2026-03-16 00:54:58.939387",
2026-03-16 00:55:01.361322 | rockylinux-9 |   "msg": "non-zero return code",
2026-03-16 00:55:01.361349 | rockylinux-9 |   "rc": 4,
2026-03-16 00:55:01.361380 | rockylinux-9 |   "start": "2026-03-16 00:54:42.013949"
2026-03-16 00:55:01.361410 | rockylinux-9 | }
failure
2026-03-16 00:55:01.363691 | 
2026-03-16 00:55:01.363755 | PLAY RECAP
2026-03-16 00:55:01.363813 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-03-16 00:55:01.363844 | 
2026-03-16 00:55:01.520768 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-16 00:55:01.523168 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-16 00:55:02.124964 | 
2026-03-16 00:55:02.125188 | PLAY [all]
2026-03-16 00:55:02.141641 | 
2026-03-16 00:55:02.141821 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-16 00:55:02.188664 | rockylinux-9 | skipping: Conditional result was False
2026-03-16 00:55:02.197073 | 
2026-03-16 00:55:02.197475 | TASK [fetch-output : Set log path for single node]
2026-03-16 00:55:02.241679 | rockylinux-9 | ok
2026-03-16 00:55:02.249192 | 
2026-03-16 00:55:02.249280 | LOOP [fetch-output : Ensure local output dirs]
2026-03-16 00:55:02.636404 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/ea40920e237f4746bc23fb5b715453b6/work/logs"
2026-03-16 00:55:02.854737 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/ea40920e237f4746bc23fb5b715453b6/work/artifacts"
2026-03-16 00:55:03.071124 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/ea40920e237f4746bc23fb5b715453b6/work/docs"
2026-03-16 00:55:03.089504 | 
2026-03-16 00:55:03.089714 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-16 00:55:03.835132 | rockylinux-9 | changed: .d..t...... ./
2026-03-16 00:55:03.835405 | rockylinux-9 | changed: All items complete
2026-03-16 00:55:03.835447 | 
2026-03-16 00:55:04.425581 | rockylinux-9 | changed: .d..t...... ./
2026-03-16 00:55:04.972056 | rockylinux-9 | changed: .d..t...... ./
2026-03-16 00:55:04.997766 | 
2026-03-16 00:55:04.997910 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-16 00:55:05.435312 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008433
2026-03-16 00:55:05.663952 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.008483
2026-03-16 00:55:05.675363 | 
2026-03-16 00:55:05.675441 | PLAY [all]
2026-03-16 00:55:05.680973 | 
2026-03-16 00:55:05.681035 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-16 00:55:06.168151 | rockylinux-9 | changed
2026-03-16 00:55:06.178812 | 
2026-03-16 00:55:06.178895 | PLAY RECAP
2026-03-16 00:55:06.178970 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-16 00:55:06.178998 | 
2026-03-16 00:55:06.287639 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-16 00:55:06.289478 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-16 00:55:06.927406 | 
2026-03-16 00:55:06.927540 | PLAY [localhost]
2026-03-16 00:55:06.938060 | 
2026-03-16 00:55:06.938157 | TASK [Generate Zuul manifest]
2026-03-16 00:55:06.958571 | localhost | ok
2026-03-16 00:55:06.976222 | 
2026-03-16 00:55:06.976838 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-16 00:55:07.310526 | localhost | changed
2026-03-16 00:55:07.328774 | 
2026-03-16 00:55:07.328982 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-16 00:55:07.363424 | localhost | ok
2026-03-16 00:55:07.373081 | 
2026-03-16 00:55:07.373183 | TASK [Upload logs]
2026-03-16 00:55:07.393534 | localhost | ok
2026-03-16 00:55:07.462191 | 
2026-03-16 00:55:07.462414 | TASK [Set zuul-log-path fact]
2026-03-16 00:55:07.486525 | localhost | ok
2026-03-16 00:55:07.503894 | 
2026-03-16 00:55:07.504369 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-16 00:55:07.539377 | localhost | ok
2026-03-16 00:55:07.547932 | 
2026-03-16 00:55:07.548013 | TASK [upload-logs : Create log directories]
2026-03-16 00:55:07.965937 | localhost | changed
2026-03-16 00:55:07.972304 | 
2026-03-16 00:55:07.972399 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-16 00:55:08.389347 | localhost -> localhost | ok: Runtime: 0:00:00.005411
2026-03-16 00:55:08.396866 | 
2026-03-16 00:55:08.396980 | TASK [upload-logs : Upload logs to log server]
2026-03-16 00:55:09.006736 | localhost | Output suppressed because no_log was given
2026-03-16 00:55:09.012516 | 
2026-03-16 00:55:09.012586 | LOOP [upload-logs : Compress console log and json output]
2026-03-16 00:55:09.061452 | localhost | skipping: Conditional result was False
2026-03-16 00:55:09.067961 | localhost | skipping: Conditional result was False
2026-03-16 00:55:09.079080 | 
2026-03-16 00:55:09.079336 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-16 00:55:09.121428 | localhost | skipping: Conditional result was False
2026-03-16 00:55:09.122255 | 
2026-03-16 00:55:09.125942 | localhost | skipping: Conditional result was False
2026-03-16 00:55:09.141968 | 
2026-03-16 00:55:09.142176 | LOOP [upload-logs : Upload console log and json output]