2026-04-19 01:00:51.106634 | Job console starting
2026-04-19 01:00:51.118699 | Updating git repos
2026-04-19 01:00:51.145224 | Cloning repos into workspace
2026-04-19 01:00:55.277440 | Restoring repo states
2026-04-19 01:00:55.290197 | Merging changes
2026-04-19 01:00:56.353217 | Checking out repos
2026-04-19 01:00:57.276475 | Preparing playbooks
2026-04-19 01:01:16.591151 | Running Ansible setup
2026-04-19 01:01:21.429709 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-19 01:01:22.072151 | 
2026-04-19 01:01:22.072282 | PLAY [localhost]
2026-04-19 01:01:22.080079 | 
2026-04-19 01:01:22.080168 | TASK [Gathering Facts]
2026-04-19 01:01:23.118753 | localhost | ok
2026-04-19 01:01:23.130826 | 
2026-04-19 01:01:23.130951 | TASK [Setup log path fact]
2026-04-19 01:01:23.149070 | localhost | ok
2026-04-19 01:01:23.163172 | 
2026-04-19 01:01:23.163309 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-19 01:01:23.198479 | localhost | ok
2026-04-19 01:01:23.209183 | 
2026-04-19 01:01:23.209305 | TASK [emit-job-header : Print job information]
2026-04-19 01:01:23.252669 | # Job Information
2026-04-19 01:01:23.252880 | Ansible Version: 2.16.16
2026-04-19 01:01:23.253023 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9
2026-04-19 01:01:23.253060 | Pipeline: check
2026-04-19 01:01:23.253089 | Executor: 0a8996d2b663
2026-04-19 01:01:23.253117 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/105
2026-04-19 01:01:23.253152 | Event ID: 132c0160-3b8b-11f1-9de8-8d94a4603602
2026-04-19 01:01:23.260213 | 
2026-04-19 01:01:23.260335 | LOOP [emit-job-header : Print node information]
2026-04-19 01:01:23.517283 | localhost | ok:
2026-04-19 01:01:23.517895 | localhost | # Node Information
2026-04-19 01:01:23.517945 | localhost | Inventory Hostname: rockylinux-9
2026-04-19 01:01:23.517978 | localhost | Hostname: np0000167700
2026-04-19 01:01:23.518010 | localhost | Username: zuul
2026-04-19 01:01:23.518044 | localhost | Distro: Rocky 9.7
2026-04-19 01:01:23.518074 | localhost | Provider: yul1
2026-04-19 01:01:23.518102 | localhost | Region: ca-ymq-1
2026-04-19 01:01:23.518130 | localhost | Label: rockylinux-9
2026-04-19 01:01:23.518157 | localhost | Product Name: OpenStack Nova
2026-04-19 01:01:23.518186 | localhost | Interface IP: 199.204.45.132
2026-04-19 01:01:23.541162 | 
2026-04-19 01:01:23.541317 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-19 01:01:23.976706 | localhost -> localhost | changed
2026-04-19 01:01:23.984842 | 
2026-04-19 01:01:23.985010 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-19 01:01:25.273393 | localhost -> localhost | changed
2026-04-19 01:01:25.280172 | 
2026-04-19 01:01:25.280249 | PLAY [all]
2026-04-19 01:01:25.288273 | 
2026-04-19 01:01:25.288340 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-19 01:01:25.764920 | rockylinux-9 -> localhost | ok
2026-04-19 01:01:25.770455 | 
2026-04-19 01:01:25.770518 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-19 01:01:25.824427 | rockylinux-9 | ok
2026-04-19 01:01:25.842376 | rockylinux-9 | included: /var/lib/zuul/builds/e61c72574d234e9d9aef379e6960a152/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-19 01:01:25.855239 | 
2026-04-19 01:01:25.855350 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-19 01:01:27.684349 | rockylinux-9 -> localhost | Generating public/private rsa key pair.
2026-04-19 01:01:27.684518 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/e61c72574d234e9d9aef379e6960a152/work/e61c72574d234e9d9aef379e6960a152_id_rsa
2026-04-19 01:01:27.684549 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/e61c72574d234e9d9aef379e6960a152/work/e61c72574d234e9d9aef379e6960a152_id_rsa.pub
2026-04-19 01:01:27.684572 | rockylinux-9 -> localhost | The key fingerprint is:
2026-04-19 01:01:27.684594 | rockylinux-9 -> localhost | SHA256:QSrMJhoI4+wh78nBpOy6zdsDppgnXhZl0uj1lJbzRY8 zuul-build-sshkey
2026-04-19 01:01:27.684629 | rockylinux-9 -> localhost | The key's randomart image is:
2026-04-19 01:01:27.684651 | rockylinux-9 -> localhost | +---[RSA 3072]----+
2026-04-19 01:01:27.684675 | rockylinux-9 -> localhost | |o       .  .     |
2026-04-19 01:01:27.684697 | rockylinux-9 -> localhost | |=. oo  oo . o    |
2026-04-19 01:01:27.684789 | rockylinux-9 -> localhost | |++oo==.*.  E .   |
2026-04-19 01:01:27.684813 | rockylinux-9 -> localhost | |+Boo=.+ o..      |
2026-04-19 01:01:27.684833 | rockylinux-9 -> localhost | |oo+o   .S.       |
2026-04-19 01:01:27.684853 | rockylinux-9 -> localhost | |.ooo.            |
2026-04-19 01:01:27.684872 | rockylinux-9 -> localhost | |.=++             |
2026-04-19 01:01:27.684892 | rockylinux-9 -> localhost | |*o+..            |
2026-04-19 01:01:27.684914 | rockylinux-9 -> localhost | |+=+...           |
2026-04-19 01:01:27.684934 | rockylinux-9 -> localhost | +----[SHA256]-----+
2026-04-19 01:01:27.685016 | rockylinux-9 -> localhost | ok: Runtime: 0:00:01.161813
2026-04-19 01:01:27.689577 | 
2026-04-19 01:01:27.689639 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-19 01:01:27.707585 | rockylinux-9 | ok
2026-04-19 01:01:27.718258 | rockylinux-9 | included: /var/lib/zuul/builds/e61c72574d234e9d9aef379e6960a152/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-19 01:01:27.971554 | 
2026-04-19 01:01:27.971799 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-19 01:01:27.997045 | rockylinux-9 | skipping: Conditional result was False
2026-04-19 01:01:28.009897 | 
2026-04-19 01:01:28.010034 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-19 01:01:28.518875 | rockylinux-9 | changed
2026-04-19 01:01:28.524205 | 
2026-04-19 01:01:28.524355 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-19 01:01:28.796360 | rockylinux-9 | ok
2026-04-19 01:01:28.839291 | 
2026-04-19 01:01:28.839390 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-19 01:01:29.826108 | rockylinux-9 | changed
2026-04-19 01:01:29.954752 | 
2026-04-19 01:01:29.954935 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-19 01:01:30.870436 | rockylinux-9 | changed
2026-04-19 01:01:30.937489 | 
2026-04-19 01:01:30.937839 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-19 01:01:30.976259 | rockylinux-9 | skipping: Conditional result was False
2026-04-19 01:01:30.983442 | 
2026-04-19 01:01:30.983597 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-19 01:01:31.684273 | rockylinux-9 -> localhost | changed
2026-04-19 01:01:31.696633 | 
2026-04-19 01:01:31.696723 | TASK [add-build-sshkey : Add back temp key]
2026-04-19 01:01:32.955412 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/e61c72574d234e9d9aef379e6960a152/work/e61c72574d234e9d9aef379e6960a152_id_rsa (zuul-build-sshkey)
2026-04-19 01:01:32.955599 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.031664
2026-04-19 01:01:32.963183 | 
2026-04-19 01:01:32.963259 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-19 01:01:33.515245 | rockylinux-9 | ok
2026-04-19 01:01:33.521154 | 
2026-04-19 01:01:33.521241 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-19 01:01:33.548408 | rockylinux-9 | skipping: Conditional result was False
2026-04-19 01:01:33.558266 | 
2026-04-19 01:01:33.558349 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-19 01:01:33.970038 | rockylinux-9 | ok
2026-04-19 01:01:33.975153 | 
2026-04-19 01:01:33.975214 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-19 01:01:35.259702 | rockylinux-9 | Output suppressed because no_log was given
2026-04-19 01:01:35.270442 | 
2026-04-19 01:01:35.270522 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-19 01:01:35.523176 | rockylinux-9 | ok: "logs"
2026-04-19 01:01:35.523444 | rockylinux-9 | ok: All items complete
2026-04-19 01:01:35.523476 | 
2026-04-19 01:01:35.743453 | rockylinux-9 | ok: "artifacts"
2026-04-19 01:01:35.967685 | rockylinux-9 | ok: "docs"
2026-04-19 01:01:35.982875 | 
2026-04-19 01:01:35.982984 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-19 01:01:36.240919 | rockylinux-9 | changed: "logs"
2026-04-19 01:01:36.495303 | rockylinux-9 | changed: "artifacts"
2026-04-19 01:01:36.722174 | rockylinux-9 | changed: "docs"
2026-04-19 01:01:36.737339 | 
2026-04-19 01:01:36.737458 | PLAY RECAP
2026-04-19 01:01:36.737517 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-19 01:01:36.737560 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-19 01:01:36.737592 | 
2026-04-19 01:01:36.889022 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-19 01:01:36.890697 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-19 01:01:37.588672 | 
2026-04-19 01:01:37.935334 | PLAY [all]
2026-04-19 01:01:37.956537 | 
2026-04-19 01:01:37.956740 | TASK [setup-uv : Extract archive]
2026-04-19 01:01:42.051807 | rockylinux-9 | changed
2026-04-19 01:01:42.061674 | 
2026-04-19 01:01:42.061853 | TASK [setup-uv : Print version]
2026-04-19 01:01:42.101497 | [rockylinux-9] Waiting on logger
2026-04-19 01:01:42.612331 | rockylinux-9 | ok: Runtime: 0:00:00.014708
2026-04-19 01:01:42.618397 | 
2026-04-19 01:01:42.618496 | PLAY RECAP
2026-04-19 01:01:42.618540 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-19 01:01:42.618564 | 
2026-04-19 01:01:42.748464 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-19 01:01:42.749683 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-19 01:01:43.308257 | 
2026-04-19 01:01:43.329712 | PLAY [all]
2026-04-19 01:01:43.358429 | 
2026-04-19 01:01:43.358535 | TASK [Copy inventory file for Zuul]
2026-04-19 01:01:44.678172 | rockylinux-9 | changed
2026-04-19 01:01:44.684033 | 
2026-04-19 01:01:44.684133 | TASK [Switch "ansible_host" to private IP]
2026-04-19 01:01:45.037692 | rockylinux-9 | changed: 1 replacements made
2026-04-19 01:01:45.043991 | 
2026-04-19 01:01:45.044061 | TASK [Run Molecule scenario]
2026-04-19 01:01:45.064255 | [rockylinux-9] Waiting on logger
2026-04-19 01:01:53.196013 | [rockylinux-9] Waiting on logger
2026-04-19 01:02:03.370376 | [rockylinux-9] Waiting on logger
2026-04-19 01:02:14.102044 | [rockylinux-9] Waiting on logger
2026-04-19 01:02:23.625925 | [rockylinux-9] Waiting on logger
2026-04-19 01:02:33.797763 | [rockylinux-9] Waiting on logger
2026-04-19 01:02:43.974011 | [rockylinux-9] Waiting on logger
2026-04-19 01:02:53.131461 | [rockylinux-9] Waiting on logger
2026-04-19 01:03:03.301890 | [rockylinux-9] Waiting on logger
2026-04-19 01:03:13.989855 | [rockylinux-9] Waiting on logger
2026-04-19 01:03:23.147664 | [rockylinux-9] Waiting on logger
2026-04-19 01:03:33.317914 | [rockylinux-9] Waiting on logger
2026-04-19 01:03:43.497935 | [rockylinux-9] Waiting on logger
2026-04-19 01:03:50.317813 | rockylinux-9 | ok: Runtime: 0:02:03.752168
2026-04-19 01:03:50.323748 | 
2026-04-19 01:03:50.323814 | PLAY RECAP
2026-04-19 01:03:50.323870 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-19 01:03:50.323900 | 
2026-04-19 01:03:50.422999 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-19 01:03:50.461606 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-19 01:03:51.022802 | 
2026-04-19 01:03:51.022925 | PLAY [all]
2026-04-19 01:03:51.033781 | 
2026-04-19 01:03:51.033876 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-19 01:03:51.078886 | rockylinux-9 | skipping: Conditional result was False
2026-04-19 01:03:51.087068 | 
2026-04-19 01:03:51.087144 | TASK [fetch-output : Set log path for single node]
2026-04-19 01:03:51.119928 | rockylinux-9 | ok
2026-04-19 01:03:51.126143 | 
2026-04-19 01:03:51.126210 | LOOP [fetch-output : Ensure local output dirs]
2026-04-19 01:03:51.508226 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/e61c72574d234e9d9aef379e6960a152/work/logs"
2026-04-19 01:03:51.718836 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/e61c72574d234e9d9aef379e6960a152/work/artifacts"
2026-04-19 01:03:51.926056 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/e61c72574d234e9d9aef379e6960a152/work/docs"
2026-04-19 01:03:51.942441 | 
2026-04-19 01:03:51.942565 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-19 01:03:52.688430 | rockylinux-9 | changed: .d..t...... ./
2026-04-19 01:03:52.693085 | rockylinux-9 | changed: All items complete
2026-04-19 01:03:52.693145 | 
2026-04-19 01:03:53.211663 | rockylinux-9 | changed: .d..t...... ./
2026-04-19 01:03:53.889239 | rockylinux-9 | changed: .d..t...... ./
2026-04-19 01:03:53.935430 | 
2026-04-19 01:03:53.935548 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-19 01:03:54.338167 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007370
2026-04-19 01:03:54.555976 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.006122
2026-04-19 01:03:54.569373 | 
2026-04-19 01:03:54.569450 | PLAY [all]
2026-04-19 01:03:54.579085 | 
2026-04-19 01:03:54.579187 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-19 01:03:55.051711 | rockylinux-9 | changed
2026-04-19 01:03:55.056622 | 
2026-04-19 01:03:55.056670 | PLAY RECAP
2026-04-19 01:03:55.056712 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-19 01:03:55.056736 | 
2026-04-19 01:03:55.160673 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-19 01:03:55.163103 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-19 01:03:55.750941 | 
2026-04-19 01:03:55.751066 | PLAY [localhost]
2026-04-19 01:03:55.760857 | 
2026-04-19 01:03:55.760937 | TASK [Generate Zuul manifest]
2026-04-19 01:03:55.782333 | localhost | ok
2026-04-19 01:03:55.797570 | 
2026-04-19 01:03:55.797707 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-19 01:03:56.122984 | localhost | changed
2026-04-19 01:03:56.135298 | 
2026-04-19 01:03:56.135377 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-19 01:03:56.163897 | localhost | ok
2026-04-19 01:03:56.171721 | 
2026-04-19 01:03:56.171806 | TASK [Upload logs]
2026-04-19 01:03:56.191714 | localhost | ok
2026-04-19 01:03:56.248585 | 
2026-04-19 01:03:56.248702 | TASK [Set zuul-log-path fact]
2026-04-19 01:03:56.269019 | localhost | ok
2026-04-19 01:03:56.281644 | 
2026-04-19 01:03:56.281724 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-19 01:03:56.312204 | localhost | ok
2026-04-19 01:03:56.319783 | 
2026-04-19 01:03:56.319870 | TASK [upload-logs : Create log directories]
2026-04-19 01:03:56.725633 | localhost | changed
2026-04-19 01:03:56.730487 | 
2026-04-19 01:03:56.730555 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-19 01:03:57.093821 | localhost -> localhost | ok: Runtime: 0:00:00.004972
2026-04-19 01:03:57.099080 | 
2026-04-19 01:03:57.099146 | TASK [upload-logs : Upload logs to log server]
2026-04-19 01:03:57.559510 | localhost | Output suppressed because no_log was given
2026-04-19 01:03:57.564406 | 
2026-04-19 01:03:57.564491 | LOOP [upload-logs : Compress console log and json output]
2026-04-19 01:03:57.611808 | localhost | skipping: Conditional result was False
2026-04-19 01:03:57.620278 | localhost | skipping: Conditional result was False
2026-04-19 01:03:57.636851 | 
2026-04-19 01:03:57.636939 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-19 01:03:57.680304 | localhost | skipping: Conditional result was False
2026-04-19 01:03:57.680723 | 
2026-04-19 01:03:57.685202 | localhost | skipping: Conditional result was False
2026-04-19 01:03:57.702502 | 
2026-04-19 01:03:57.702656 | LOOP [upload-logs : Upload console log and json output]