2026-01-27 16:59:04.875087 | Job console starting...
2026-01-27 16:59:04.887190 | Updating repositories
2026-01-27 16:59:04.915492 | Preparing job workspace
2026-01-27 16:59:10.158143 | Running Ansible setup...
2026-01-27 16:59:17.293460 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-01-27 16:59:17.921123 | 
2026-01-27 16:59:17.921270 | PLAY [localhost]
2026-01-27 16:59:17.930939 | 
2026-01-27 16:59:17.931038 | TASK [Gathering Facts]
2026-01-27 16:59:18.907433 | localhost | ok
2026-01-27 16:59:18.938641 | 
2026-01-27 16:59:18.938896 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-01-27 16:59:19.397697 | localhost -> localhost | changed
2026-01-27 16:59:19.404720 | 
2026-01-27 16:59:19.404864 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-01-27 16:59:20.290636 | localhost -> localhost | changed
2026-01-27 16:59:20.299775 | 
2026-01-27 16:59:20.299877 | TASK [Setup log path fact]
2026-01-27 16:59:20.317859 | localhost | ok
2026-01-27 16:59:20.330851 | 
2026-01-27 16:59:20.330961 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-01-27 16:59:20.358945 | localhost | ok
2026-01-27 16:59:20.366799 | 
2026-01-27 16:59:20.366904 | TASK [emit-job-header : Print job information]
2026-01-27 16:59:20.405502 | # Job Information
2026-01-27 16:59:20.405668 | Ansible Version: 2.15.12
2026-01-27 16:59:20.405694 | Job: cifmw-pod-pre-commit
2026-01-27 16:59:20.405714 | Pipeline: github-check
2026-01-27 16:59:20.405731 | Executor: ze01.softwarefactory-project.io
2026-01-27 16:59:20.405750 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3625
2026-01-27 16:59:20.405770 | Log URL (when completed): https://logserver.rdoproject.org/d7c/rdoproject.org/d7cd1d8e0f034914a78a864fc47baffc/
2026-01-27 16:59:20.405788 | Event ID: 693ac110-fba1-11f0-9cdd-ca36bc7e3858
2026-01-27 16:59:20.409676 | 
2026-01-27 16:59:20.409747 | LOOP [emit-job-header : Print node information]
2026-01-27 16:59:20.503707 | localhost | ok:
2026-01-27 16:59:20.503885 | localhost | # Node Information
2026-01-27 16:59:20.503917 | localhost | Inventory Hostname: container
2026-01-27 16:59:20.503946 | localhost | Hostname: b8caa148d5a9
2026-01-27 16:59:20.503971 | localhost | Username: zuul
2026-01-27 16:59:20.503997 | localhost | Distro: CentOS 9
2026-01-27 16:59:20.504022 | localhost | Provider: k1s04
2026-01-27 16:59:20.504074 | localhost | Region:
2026-01-27 16:59:20.504100 | localhost | Label: pod-centos-9-stream
2026-01-27 16:59:20.504122 | localhost | Product Name: OpenStack Nova
2026-01-27 16:59:20.504143 | localhost | Interface IP: pod-centos-9-stream-0005597819
2026-01-27 16:59:20.525657 | 
2026-01-27 16:59:20.525756 | PLAY [all]
2026-01-27 16:59:20.533799 | 
2026-01-27 16:59:20.533897 | TASK [Gather network facts]
2026-01-27 16:59:25.577672 | container | ok
2026-01-27 16:59:25.590244 | 
2026-01-27 16:59:25.590330 | TASK [include_role : start-zuul-console]
2026-01-27 16:59:25.609077 | container | ok
2026-01-27 16:59:25.620363 | 
2026-01-27 16:59:25.620510 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-01-27 16:59:31.140637 | container | ok
2026-01-27 16:59:31.152454 | 
2026-01-27 16:59:31.152575 | TASK [include_role : add-build-sshkey]
2026-01-27 16:59:31.166927 | container | skipping: Conditional result was False
2026-01-27 16:59:31.172018 | 
2026-01-27 16:59:31.172131 | TASK [include_role : validate-host]
2026-01-27 16:59:31.185595 | container | skipping: Conditional result was False
2026-01-27 16:59:31.191190 | 
2026-01-27 16:59:31.191271 | TASK [include_role : prepare-workspace-openshift]
2026-01-27 16:59:31.208994 | container | ok
2026-01-27 16:59:31.220674 | 
2026-01-27 16:59:31.220777 | LOOP [prepare-workspace-openshift : include_tasks]
2026-01-27 16:59:31.262922 | container | ok:
2026-01-27 16:59:31.263140 | container | [
2026-01-27 16:59:31.263170 | container |   "container",
2026-01-27 16:59:31.263192 | container |   {
2026-01-27 16:59:31.263212 | container |     "context": "main:zuul-worker/38-102-83-54:9023",
2026-01-27 16:59:31.263230 | container |     "namespace": "main",
2026-01-27 16:59:31.263257 | container |     "pod": "pod-centos-9-stream-0005597819",
2026-01-27 16:59:31.263275 | container |     "stream_port": "34623"
2026-01-27 16:59:31.263292 | container |   }
2026-01-27 16:59:31.263308 | container | ]
2026-01-27 16:59:31.263340 | container | ok: All items complete
2026-01-27 16:59:31.263361 | 
2026-01-27 16:59:31.271435 | container | included: /var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/trusted/project_0/review.rdoproject.org/config/roles/prepare-workspace-openshift/tasks/rsync.yaml
2026-01-27 16:59:31.276423 | 
2026-01-27 16:59:31.276486 | TASK [prepare-workspace-openshift : Create src directory]
2026-01-27 16:59:32.633552 | container -> localhost | ok: Runtime: 0:00:00.955980
2026-01-27 16:59:32.644713 | 
2026-01-27 16:59:32.644928 | TASK [prepare-workspace-openshift : Copy src repos to the pod]
2026-01-27 16:59:35.058669 | container -> localhost | Output suppressed because no_log was given
2026-01-27 16:59:35.078485 | 
2026-01-27 16:59:35.078640 | TASK [include_role : remove-zuul-sshkey]
2026-01-27 16:59:35.115700 | container | ok
2026-01-27 16:59:35.146316 | 
2026-01-27 16:59:35.146454 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-01-27 16:59:35.588824 | container -> localhost | changed
2026-01-27 16:59:35.605457 | 
2026-01-27 16:59:35.605601 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-01-27 16:59:40.539458 | container | ok: "logs"
2026-01-27 16:59:46.223937 | container | ok: "artifacts"
2026-01-27 16:59:51.970213 | container | ok: "docs"
2026-01-27 16:59:51.981546 | 
2026-01-27 16:59:51.981705 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-01-27 16:59:57.741105 | container | changed: "logs"
2026-01-27 16:59:57.741540 | container | ok: All items complete
2026-01-27 16:59:57.741600 | 
2026-01-27 17:00:03.588405 | container | changed: "artifacts"
2026-01-27 17:00:09.371752 | container | changed: "docs"
2026-01-27 17:00:09.426747 | 
2026-01-27 17:00:09.426920 | PLAY RECAP
2026-01-27 17:00:09.426973 | container | ok: 8 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-01-27 17:00:09.427063 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-27 17:00:09.427158 | 
2026-01-27 17:00:09.531100 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-01-27 17:00:09.531888 | PRE-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master]
2026-01-27 17:00:10.116415 | 
2026-01-27 17:00:10.116523 | PLAY [localhost]
2026-01-27 17:00:10.133041 | 
2026-01-27 17:00:10.133127 | TASK [configure-ssh-config-fips : Ensure ssh config directory]
2026-01-27 17:00:10.578093 | localhost | ok
2026-01-27 17:00:10.583066 | 
2026-01-27 17:00:10.583141 | TASK [configure-ssh-config-fips : Setup ssh config]
2026-01-27 17:00:11.325507 | localhost | changed
2026-01-27 17:00:11.346422 | 
2026-01-27 17:00:11.346518 | PLAY [all]
2026-01-27 17:00:11.360686 | 
2026-01-27 17:00:11.360786 | TASK [include_role : prepare-workspace]
2026-01-27 17:00:11.398331 | container | skipping: Conditional result was False
2026-01-27 17:00:11.405845 | 
2026-01-27 17:00:11.406054 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-01-27 17:00:17.301748 | container | changed: "logs"
2026-01-27 17:00:22.878169 | container | changed: "artifacts"
2026-01-27 17:00:28.331340 | container | changed: "docs"
2026-01-27 17:00:28.351283 | 
2026-01-27 17:00:28.351477 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-01-27 17:00:33.961491 | container | changed: "logs"
2026-01-27 17:00:33.961843 | container | changed: All items complete
2026-01-27 17:00:33.961929 | 
2026-01-27 17:00:39.703625 | container | changed: "artifacts"
2026-01-27 17:00:45.323273 | container | changed: "docs"
2026-01-27 17:00:45.352171 | 
2026-01-27 17:00:45.352360 | TASK [Check if worker can sudo]
2026-01-27 17:00:51.532537 | container | ok: Runtime: 0:00:00.032337
2026-01-27 17:00:51.544271 | 
2026-01-27 17:00:51.544581 | TASK [configure-mirrors : Gather needed facts]
2026-01-27 17:00:51.572295 | container | skipping: Conditional result was False
2026-01-27 17:00:51.584644 | 
2026-01-27 17:00:51.584853 | TASK [configure-mirrors : Set up infrastructure mirrors]
2026-01-27 17:00:51.612844 | container | skipping: Conditional result was False
2026-01-27 17:00:51.660943 | 
2026-01-27 17:00:51.661084 | PLAY RECAP
2026-01-27 17:00:51.661144 | container | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-01-27 17:00:51.661181 | localhost | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-27 17:00:51.661207 | 
2026-01-27 17:00:51.767725 | PRE-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master]
2026-01-27 17:00:51.768569 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/pod-jobs.yml@main]
2026-01-27 17:00:52.383894 | 
2026-01-27 17:00:52.384007 | PLAY [Run light checks in pod]
2026-01-27 17:00:52.403879 | 
2026-01-27 17:00:52.403985 | TASK [Install packages]
2026-01-27 17:01:09.590798 | container | ok: Nothing to do
2026-01-27 17:01:09.597752 | 
2026-01-27 17:01:09.597921 | TASK [Ensure zuul-output exists]
2026-01-27 17:01:15.563381 | container | ok
2026-01-27 17:01:15.577943 | 
2026-01-27 17:01:15.578183 | TASK [Install dependencies]
2026-01-27 17:29:21.816655 | RUN END RESULT_TIMED_OUT: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/pod-jobs.yml@main]
2026-01-27 17:29:21.818367 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-01-27 17:29:22.477106 | 
2026-01-27 17:29:22.477239 | PLAY [all]
2026-01-27 17:29:22.498037 | 
2026-01-27 17:29:22.498171 | TASK [include_role : fetch-output]
2026-01-27 17:29:22.522573 | container | skipping: Conditional result was False
2026-01-27 17:29:22.528784 | 
2026-01-27 17:29:22.528916 | TASK [include_role : fetch-output-openshift]
2026-01-27 17:29:22.557856 | container | ok
2026-01-27 17:29:22.574686 | 
2026-01-27 17:29:22.574811 | TASK [fetch-output-openshift : Set log path for multiple nodes]
2026-01-27 17:29:22.619504 | container | skipping: Conditional result was False
2026-01-27 17:29:22.625080 | 
2026-01-27 17:29:22.625164 | TASK [fetch-output-openshift : Set log path for single node]
2026-01-27 17:29:22.664214 | container | ok
2026-01-27 17:29:22.668963 | 
2026-01-27 17:29:22.669058 | LOOP [fetch-output-openshift : Ensure local output dirs]
2026-01-27 17:29:23.132352 | container -> localhost | ok: "/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/logs"
2026-01-27 17:29:23.434011 | container -> localhost | changed: "/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/logs/npm"
2026-01-27 17:29:23.689078 | container -> localhost | changed: "/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/artifacts"
2026-01-27 17:29:23.947747 | container -> localhost | changed: "/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/docs"
2026-01-27 17:29:23.970237 | 
2026-01-27 17:29:23.970455 | LOOP [fetch-output-openshift : include_tasks]
2026-01-27 17:29:24.026824 | container | ok:
2026-01-27 17:29:24.027262 | container | [
2026-01-27 17:29:24.027318 | container |   "container",
2026-01-27 17:29:24.027358 | container |   {
2026-01-27 17:29:24.027394 | container |     "context": "main:zuul-worker/38-102-83-54:9023",
2026-01-27 17:29:24.027431 | container |     "namespace": "main",
2026-01-27 17:29:24.027466 | container |     "pod": "pod-centos-9-stream-0005597819",
2026-01-27 17:29:24.027500 | container |     "stream_port": "34623"
2026-01-27 17:29:24.027533 | container |   }
2026-01-27 17:29:24.027567 | container | ]
2026-01-27 17:29:24.027627 | container | changed: All items complete
2026-01-27 17:29:24.027669 | 
2026-01-27 17:29:24.059554 | container | included: /var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/trusted/project_0/review.rdoproject.org/config/roles/fetch-output-openshift/tasks/rsync.yaml
2026-01-27 17:29:24.074611 | 
2026-01-27 17:29:24.074832 | LOOP [fetch-output-openshift : Ensure local directory exists]
2026-01-27 17:29:29.507836 | container | changed: "/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/logs"
2026-01-27 17:29:35.182282 | container | changed: "/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/logs/npm"
2026-01-27 17:29:40.688860 | container | changed: "/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/artifacts"
2026-01-27 17:29:46.355546 | container | changed: "/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/docs"
2026-01-27 17:29:46.372133 | 
2026-01-27 17:29:46.372284 | LOOP [fetch-output-openshift : Copy zuul-output from the pod to the executor]
2026-01-27 17:29:52.070241 | container | Output suppressed because no_log was given
2026-01-27 17:29:52.081908 | 
2026-01-27 17:29:52.082079 | TASK [fetch-output-openshift : Remove empty directory]
2026-01-27 17:29:52.481421 | container -> localhost | ok: Runtime: 0:00:00.062725
2026-01-27 17:29:52.497313 | 
2026-01-27 17:29:52.497472 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-01-27 17:29:52.828225 | container -> localhost | find: ‘/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/artifacts’: No such file or directory
2026-01-27 17:29:52.828626 | container -> localhost | find: ‘/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/artifacts’: No such file or directory
2026-01-27 17:29:52.828708 | container -> localhost | ok: Item: artifacts Runtime: 0:00:00.014714
2026-01-27 17:29:52.828772 | container -> localhost | changed: All items complete
2026-01-27 17:29:52.828804 | 
2026-01-27 17:29:53.129424 | container -> localhost | find: ‘/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/docs’: No such file or directory
2026-01-27 17:29:53.129625 | container -> localhost | find: ‘/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/docs’: No such file or directory
2026-01-27 17:29:53.129663 | container -> localhost | ok: Item: docs Runtime: 0:00:00.011014
2026-01-27 17:29:53.163530 | 
2026-01-27 17:29:53.163732 | PLAY [all]
2026-01-27 17:29:53.177756 | 
2026-01-27 17:29:53.177838 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-01-27 17:29:53.208493 | container | ERROR
2026-01-27 17:29:53.208746 | container | {
2026-01-27 17:29:53.208778 | container |   "msg": "The 'file' lookup had an issue accessing the file '/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/src/../d7cd1d8e0f034914a78a864fc47baffc_id_rsa.pub'. file not found, use -vvvvv to see paths searched"
2026-01-27 17:29:53.208801 | container | }
2026-01-27 17:29:53.208828 | container | ERROR: Ignoring Errors
2026-01-27 17:29:53.232583 | 
2026-01-27 17:29:53.232682 | PLAY RECAP
2026-01-27 17:29:53.232737 | container | ok: 8 changed: 5 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 1
2026-01-27 17:29:53.232758 | 
2026-01-27 17:29:53.438744 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-01-27 17:29:53.439581 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2026-01-27 17:29:54.070493 | 
2026-01-27 17:29:54.070660 | PLAY [localhost]
2026-01-27 17:29:54.089304 | 
2026-01-27 17:29:54.089416 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-01-27 17:29:54.592605 | localhost | changed
2026-01-27 17:29:54.597477 | 
2026-01-27 17:29:54.597579 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-01-27 17:29:54.628077 | localhost | ok
2026-01-27 17:29:54.636685 | 
2026-01-27 17:29:54.636762 | TASK [add-fileserver : Create SSH private key tempfile]
2026-01-27 17:29:55.048470 | localhost | changed
2026-01-27 17:29:55.060902 | 
2026-01-27 17:29:55.061167 | TASK [add-fileserver : Create SSH private key from secret]
2026-01-27 17:29:55.891423 | localhost | changed
2026-01-27 17:29:55.897175 | 
2026-01-27 17:29:55.897268 | TASK [add-fileserver : Add fileserver ssh key]
2026-01-27 17:29:56.359733 | localhost | Identity added: /var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/tmp/ansible.1rt7cags (/var/lib/zuul/builds/d7cd1d8e0f034914a78a864fc47baffc/work/tmp/ansible.1rt7cags)
2026-01-27 17:29:56.360023 | localhost | ok: Runtime: 0:00:00.008543
2026-01-27 17:29:56.364741 | 
2026-01-27 17:29:56.364818 | TASK [add-fileserver : Remove SSH private key from disk]
2026-01-27 17:29:56.685929 | localhost | ok: Runtime: 0:00:00.010503
2026-01-27 17:29:56.693830 | 
2026-01-27 17:29:56.693955 | TASK [add-fileserver : Add fileserver to inventory]
2026-01-27 17:29:56.784233 | localhost | changed
2026-01-27 17:29:56.794739 | 
2026-01-27 17:29:56.794904 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-01-27 17:29:57.271215 | localhost | changed
2026-01-27 17:29:57.316250 | 
2026-01-27 17:29:57.316384 | PLAY [localhost]
2026-01-27 17:29:57.334912 | 
2026-01-27 17:29:57.335121 | TASK [Generate bulk log download script]
2026-01-27 17:29:57.357259 | localhost | ok
2026-01-27 17:29:57.373824 | 
2026-01-27 17:29:57.373917 | TASK [local-log-download : Check API endpoint is defined]
2026-01-27 17:29:57.426182 | localhost | ok: All assertions passed
2026-01-27 17:29:57.433453 | 
2026-01-27 17:29:57.433576 | TASK [local-log-download : Create download script]
2026-01-27 17:29:57.906965 | localhost -> localhost | changed
2026-01-27 17:29:57.921487 | 
2026-01-27 17:29:57.921641 | TASK [Register quick-download link]
2026-01-27 17:29:57.950764 | localhost | ok
2026-01-27 17:29:58.011825 | 
2026-01-27 17:29:58.011946 | PLAY [logserver.rdoproject.org]
2026-01-27 17:29:58.025794 | 
2026-01-27 17:29:58.025882 | TASK [Set zuul-log-path fact]
2026-01-27 17:29:58.044884 | logserver.rdoproject.org | ok
2026-01-27 17:29:58.058271 | 
2026-01-27 17:29:58.058367 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-01-27 17:29:58.097635 | logserver.rdoproject.org | ok
2026-01-27 17:29:58.105142 | 
2026-01-27 17:29:58.105239 | TASK [upload-logs : Create log directories]
2026-01-27 17:29:59.089009 | logserver.rdoproject.org | changed
2026-01-27 17:29:59.096352 | 
2026-01-27 17:29:59.096515 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-01-27 17:29:59.412606 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.011004
2026-01-27 17:29:59.419695 | 
2026-01-27 17:29:59.419800 | TASK [upload-logs : Upload logs to log server]
2026-01-27 17:30:00.238815 | logserver.rdoproject.org | Output suppressed because no_log was given
2026-01-27 17:30:00.245415 | 
2026-01-27 17:30:00.245556 | LOOP [upload-logs : Compress console log and json output]
2026-01-27 17:30:00.319982 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-27 17:30:00.336618 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-27 17:30:00.353271 | 
2026-01-27 17:30:00.353509 | LOOP [upload-logs : Upload compressed console log and json output]
2026-01-27 17:30:00.424431 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-27 17:30:00.424942 | 
2026-01-27 17:30:00.429564 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-27 17:30:00.437966 | 
2026-01-27 17:30:00.438352 | LOOP [upload-logs : Upload console log and json output]