2026-01-26 03:05:04.914890 | Job console starting...
2026-01-26 03:05:04.923909 | Updating repositories
2026-01-26 03:05:04.966157 | Preparing job workspace
2026-01-26 03:05:09.316429 | Running Ansible setup...
2026-01-26 03:05:13.478724 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-01-26 03:05:14.098540 | 
2026-01-26 03:05:14.098641 | PLAY [localhost]
2026-01-26 03:05:14.107161 | 
2026-01-26 03:05:14.107228 | TASK [Gathering Facts]
2026-01-26 03:05:15.070941 | localhost | ok
2026-01-26 03:05:15.093051 | 
2026-01-26 03:05:15.093192 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-01-26 03:05:15.589390 | localhost -> localhost | changed
2026-01-26 03:05:15.595620 | 
2026-01-26 03:05:15.595769 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-01-26 03:05:16.444504 | localhost -> localhost | changed
2026-01-26 03:05:16.453250 | 
2026-01-26 03:05:16.453350 | TASK [Setup log path fact]
2026-01-26 03:05:16.478589 | localhost | ok
2026-01-26 03:05:16.490540 | 
2026-01-26 03:05:16.490609 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-01-26 03:05:16.518386 | localhost | ok
2026-01-26 03:05:16.526874 | 
2026-01-26 03:05:16.526939 | TASK [emit-job-header : Print job information]
2026-01-26 03:05:16.564573 | # Job Information
2026-01-26 03:05:16.564714 | Ansible Version: 2.15.12
2026-01-26 03:05:16.564742 | Job: weirdo-bobcat-promote-packstack-scenario001-centos-stream-9
2026-01-26 03:05:16.564762 | Pipeline: openstack-periodic-daily
2026-01-26 03:05:16.564781 | Executor: ze04.softwarefactory-project.io
2026-01-26 03:05:16.564798 | Triggered by: https://review.rdoproject.org/r/plugins/gitiles/rdoinfo/+/None^!/
2026-01-26 03:05:16.564817 | Log URL (when completed): https://logserver.rdoproject.org/eb0/rdoproject.org/eb0d2c6ac97041c08632d444f0542ecd/
2026-01-26 03:05:16.564835 | Event ID: 337223b13ed449e8bd7523c5b701b0de
2026-01-26 03:05:16.568313 | 
2026-01-26 03:05:16.568374 | LOOP [emit-job-header : Print node information]
2026-01-26 03:05:16.687866 | localhost | ok:
2026-01-26 03:05:16.688017 | localhost | # Node Information
2026-01-26 03:05:16.688044 | localhost | Inventory Hostname: cloud-centos-9-stream
2026-01-26 03:05:16.688067 | localhost | Hostname: np0005595283
2026-01-26 03:05:16.688087 | localhost | Username: zuul-worker
2026-01-26 03:05:16.688108 | localhost | Distro: CentOS 9
2026-01-26 03:05:16.688126 | localhost | Provider: vexxhost-nodepool-sf
2026-01-26 03:05:16.688144 | localhost | Region: RegionOne
2026-01-26 03:05:16.688161 | localhost | Label: cloud-centos-9-stream
2026-01-26 03:05:16.688178 | localhost | Product Name: OpenStack Nova
2026-01-26 03:05:16.688195 | localhost | Interface IP: 38.102.83.233
2026-01-26 03:05:16.707113 | 
2026-01-26 03:05:16.707220 | PLAY [all]
2026-01-26 03:05:16.713978 | 
2026-01-26 03:05:16.714062 | TASK [Gather network facts]
2026-01-26 03:05:17.254557 | cloud-centos-9-stream | ok
2026-01-26 03:05:17.286044 | 
2026-01-26 03:05:17.286163 | TASK [include_role : start-zuul-console]
2026-01-26 03:05:17.308083 | cloud-centos-9-stream | ok
2026-01-26 03:05:17.325794 | 
2026-01-26 03:05:17.325892 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-01-26 03:05:17.748751 | cloud-centos-9-stream | ok
2026-01-26 03:05:17.772673 | 
2026-01-26 03:05:17.772859 | TASK [include_role : add-build-sshkey]
2026-01-26 03:05:17.806538 | cloud-centos-9-stream | ok
2026-01-26 03:05:17.825112 | 
2026-01-26 03:05:17.825206 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-01-26 03:05:18.117226 | cloud-centos-9-stream -> localhost | ok
2026-01-26 03:05:18.123922 | 
2026-01-26 03:05:18.124011 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-01-26 03:05:18.169429 | cloud-centos-9-stream | ok
2026-01-26 03:05:18.185503 | cloud-centos-9-stream | included: /var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-01-26 03:05:18.191307 | 
2026-01-26 03:05:18.191377 | TASK [add-build-sshkey : Create Temp SSH key]
2026-01-26 03:05:18.810908 | cloud-centos-9-stream -> localhost | Generating public/private rsa key pair.
2026-01-26 03:05:18.811110 | cloud-centos-9-stream -> localhost | Your identification has been saved in /var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/work/eb0d2c6ac97041c08632d444f0542ecd_id_rsa.
2026-01-26 03:05:18.811142 | cloud-centos-9-stream -> localhost | Your public key has been saved in /var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/work/eb0d2c6ac97041c08632d444f0542ecd_id_rsa.pub.
2026-01-26 03:05:18.811163 | cloud-centos-9-stream -> localhost | The key fingerprint is:
2026-01-26 03:05:18.811185 | cloud-centos-9-stream -> localhost | SHA256:JQ9wJ43f+N2q5+/j5TgLMrdEEjpE2qhswoH7y4PnTlA zuul-build-sshkey
2026-01-26 03:05:18.811204 | cloud-centos-9-stream -> localhost | The key's randomart image is:
2026-01-26 03:05:18.811222 | cloud-centos-9-stream -> localhost | +---[RSA 3072]----+
2026-01-26 03:05:18.811240 | cloud-centos-9-stream -> localhost | |      . +o.      |
2026-01-26 03:05:18.811258 | cloud-centos-9-stream -> localhost | | .     B.o.      |
2026-01-26 03:05:18.811276 | cloud-centos-9-stream -> localhost | |. E   o =.oo     |
2026-01-26 03:05:18.811297 | cloud-centos-9-stream -> localhost | | + o . . *o..    |
2026-01-26 03:05:18.811316 | cloud-centos-9-stream -> localhost | |o o +   S o... . |
2026-01-26 03:05:18.811334 | cloud-centos-9-stream -> localhost | | o o     . o. . .|
2026-01-26 03:05:18.811351 | cloud-centos-9-stream -> localhost | | .o       o +  ..|
2026-01-26 03:05:18.811368 | cloud-centos-9-stream -> localhost | |.oo.       = o++.|
2026-01-26 03:05:18.811385 | cloud-centos-9-stream -> localhost | | +=.        o+=*=|
2026-01-26 03:05:18.811402 | cloud-centos-9-stream -> localhost | +----[SHA256]-----+
2026-01-26 03:05:18.811449 | cloud-centos-9-stream -> localhost | ok: Runtime: 0:00:00.131063
2026-01-26 03:05:18.817477 | 
2026-01-26 03:05:18.817539 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-01-26 03:05:18.835840 | cloud-centos-9-stream | ok
2026-01-26 03:05:18.849646 | cloud-centos-9-stream | included: /var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-01-26 03:05:18.858145 | 
2026-01-26 03:05:18.858226 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-01-26 03:05:18.882336 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:18.887782 | 
2026-01-26 03:05:18.887845 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-01-26 03:05:19.359941 | cloud-centos-9-stream | changed
2026-01-26 03:05:19.371862 | 
2026-01-26 03:05:19.371953 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-01-26 03:05:19.667140 | cloud-centos-9-stream | ok
2026-01-26 03:05:19.675616 | 
2026-01-26 03:05:19.675721 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-01-26 03:05:20.640366 | cloud-centos-9-stream | changed
2026-01-26 03:05:20.646015 | 
2026-01-26 03:05:20.646076 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-01-26 03:05:21.574075 | cloud-centos-9-stream | changed
2026-01-26 03:05:21.587247 | 
2026-01-26 03:05:21.587597 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-01-26 03:05:21.604645 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:21.613823 | 
2026-01-26 03:05:21.613913 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-01-26 03:05:22.035947 | cloud-centos-9-stream -> localhost | changed
2026-01-26 03:05:22.059166 | 
2026-01-26 03:05:22.059282 | TASK [add-build-sshkey : Add back temp key]
2026-01-26 03:05:22.410065 | cloud-centos-9-stream -> localhost | Identity added: /var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/work/eb0d2c6ac97041c08632d444f0542ecd_id_rsa (zuul-build-sshkey)
2026-01-26 03:05:22.410344 | cloud-centos-9-stream -> localhost | ok: Runtime: 0:00:00.015899
2026-01-26 03:05:22.416730 | 
2026-01-26 03:05:22.416791 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-01-26 03:05:22.821076 | cloud-centos-9-stream | ok
2026-01-26 03:05:22.831890 | 
2026-01-26 03:05:22.832022 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-01-26 03:05:22.869358 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:22.892073 | 
2026-01-26 03:05:22.892228 | TASK [include_role : validate-host]
2026-01-26 03:05:22.931171 | cloud-centos-9-stream | ok
2026-01-26 03:05:22.976515 | 
2026-01-26 03:05:22.976680 | TASK [validate-host : Define zuul_info_dir fact]
2026-01-26 03:05:23.019348 | cloud-centos-9-stream | ok
2026-01-26 03:05:23.027433 | 
2026-01-26 03:05:23.027549 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-01-26 03:05:23.320897 | cloud-centos-9-stream -> localhost | ok
2026-01-26 03:05:23.332013 | 
2026-01-26 03:05:23.332100 | TASK [validate-host : Collect information about the host]
2026-01-26 03:05:24.205236 | cloud-centos-9-stream | ok
2026-01-26 03:05:24.216654 | 
2026-01-26 03:05:24.216766 | TASK [validate-host : Sanitize hostname]
2026-01-26 03:05:24.292578 | cloud-centos-9-stream | ok
2026-01-26 03:05:24.304253 | 
2026-01-26 03:05:24.304407 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-01-26 03:05:24.750697 | cloud-centos-9-stream -> localhost | changed
2026-01-26 03:05:24.760941 | 
2026-01-26 03:05:24.761086 | TASK [validate-host : Collect information about zuul worker]
2026-01-26 03:05:25.166671 | cloud-centos-9-stream | ok
2026-01-26 03:05:25.171640 | 
2026-01-26 03:05:25.171719 | TASK [validate-host : Write out all zuul information for each host]
2026-01-26 03:05:25.644012 | cloud-centos-9-stream -> localhost | changed
2026-01-26 03:05:25.654312 | 
2026-01-26 03:05:25.654412 | TASK [include_role : prepare-workspace-openshift]
2026-01-26 03:05:25.679456 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:25.685322 | 
2026-01-26 03:05:25.685389 | TASK [include_role : remove-zuul-sshkey]
2026-01-26 03:05:25.710263 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:25.716558 | 
2026-01-26 03:05:25.716625 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-01-26 03:05:26.030042 | cloud-centos-9-stream | ok: "logs"
2026-01-26 03:05:26.030492 | cloud-centos-9-stream | ok: All items complete
2026-01-26 03:05:26.030549 | 
2026-01-26 03:05:26.300002 | cloud-centos-9-stream | ok: "artifacts"
2026-01-26 03:05:26.581610 | cloud-centos-9-stream | ok: "docs"
2026-01-26 03:05:26.598013 | 
2026-01-26 03:05:26.598222 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-01-26 03:05:26.921798 | cloud-centos-9-stream | changed: "logs"
2026-01-26 03:05:27.149479 | cloud-centos-9-stream | changed: "artifacts"
2026-01-26 03:05:27.409530 | cloud-centos-9-stream | changed: "docs"
2026-01-26 03:05:27.463994 | 
2026-01-26 03:05:27.464196 | PLAY RECAP
2026-01-26 03:05:27.464267 | cloud-centos-9-stream | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-01-26 03:05:27.464309 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-26 03:05:27.464334 | 
2026-01-26 03:05:27.607848 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-01-26 03:05:27.608768 | PRE-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master]
2026-01-26 03:05:28.217481 | 
2026-01-26 03:05:28.217615 | PLAY [localhost]
2026-01-26 03:05:28.234707 | 
2026-01-26 03:05:28.234823 | TASK [configure-ssh-config-fips : Ensure ssh config directory]
2026-01-26 03:05:28.628308 | localhost | ok
2026-01-26 03:05:28.634568 | 
2026-01-26 03:05:28.634646 | TASK [configure-ssh-config-fips : Setup ssh config]
2026-01-26 03:05:29.270213 | localhost | changed
2026-01-26 03:05:29.290084 | 
2026-01-26 03:05:29.290153 | PLAY [all]
2026-01-26 03:05:29.306258 | 
2026-01-26 03:05:29.306350 | TASK [include_role : prepare-workspace]
2026-01-26 03:05:29.324996 | cloud-centos-9-stream | ok
2026-01-26 03:05:29.338788 | 
2026-01-26 03:05:29.338861 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-01-26 03:05:29.782941 | cloud-centos-9-stream | ok
2026-01-26 03:05:29.799156 | 
2026-01-26 03:05:29.799342 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-01-26 03:05:32.669497 | cloud-centos-9-stream | Output suppressed because no_log was given
2026-01-26 03:05:32.687250 | 
2026-01-26 03:05:32.687382 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-01-26 03:05:32.944616 | cloud-centos-9-stream | changed: "logs"
2026-01-26 03:05:33.199414 | cloud-centos-9-stream | changed: "artifacts"
2026-01-26 03:05:33.438041 | cloud-centos-9-stream | changed: "docs"
2026-01-26 03:05:33.461896 | 
2026-01-26 03:05:33.462096 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-01-26 03:05:33.767964 | cloud-centos-9-stream | changed: "logs"
2026-01-26 03:05:33.768406 | cloud-centos-9-stream | changed: All items complete
2026-01-26 03:05:33.768473 | 
2026-01-26 03:05:34.031169 | cloud-centos-9-stream | changed: "artifacts"
2026-01-26 03:05:34.304108 | cloud-centos-9-stream | changed: "docs"
2026-01-26 03:05:34.337776 | 
2026-01-26 03:05:34.337968 | TASK [Check if worker can sudo]
2026-01-26 03:05:34.885889 | cloud-centos-9-stream | ok: Runtime: 0:00:00.036058
2026-01-26 03:05:34.891311 | 
2026-01-26 03:05:34.891394 | TASK [configure-mirrors : Gather needed facts]
2026-01-26 03:05:34.936531 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:34.942294 | 
2026-01-26 03:05:34.942440 | TASK [configure-mirrors : Set up infrastructure mirrors]
2026-01-26 03:05:35.010728 | cloud-centos-9-stream | ok
2026-01-26 03:05:35.030014 | cloud-centos-9-stream | included: /var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror.yaml
2026-01-26 03:05:35.041923 | 
2026-01-26 03:05:35.042027 | TASK [configure-mirrors : Remove .pydistutils.cfg configuration in homedir]
2026-01-26 03:05:35.356062 | cloud-centos-9-stream | ok
2026-01-26 03:05:35.363769 | 
2026-01-26 03:05:35.363852 | LOOP [configure-mirrors : Include OS-specific variables]
2026-01-26 03:05:35.454311 | cloud-centos-9-stream | ok: "/var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/vars/CentOS-9.yaml"
2026-01-26 03:05:35.471172 | 
2026-01-26 03:05:35.471451 | TASK [configure-mirrors : Install /etc/pip.conf configuration]
2026-01-26 03:05:36.406327 | cloud-centos-9-stream | changed
2026-01-26 03:05:36.418485 | 
2026-01-26 03:05:36.418624 | LOOP [configure-mirrors : Setup distribution specific packaging mirrors]
2026-01-26 03:05:36.472464 | cloud-centos-9-stream | ok: "/var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml"
2026-01-26 03:05:36.472711 | cloud-centos-9-stream | ok: All items complete
2026-01-26 03:05:36.472758 | 
2026-01-26 03:05:36.528739 | cloud-centos-9-stream | included: /var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml
2026-01-26 03:05:36.535229 | 
2026-01-26 03:05:36.535294 | LOOP [configure-mirrors : Install CentOS 9 repository files]
2026-01-26 03:05:37.586640 | cloud-centos-9-stream | changed: "etc/yum.repos.d/centos.repo"
2026-01-26 03:05:38.574858 | cloud-centos-9-stream | changed: "etc/yum.repos.d/centos-addons.repo"
2026-01-26 03:05:38.590851 | 
2026-01-26 03:05:38.591041 | TASK [configure-mirrors : Disable deltrarpm]
2026-01-26 03:05:39.098077 | cloud-centos-9-stream | changed: section and option added
2026-01-26 03:05:39.139084 | 
2026-01-26 03:05:39.139200 | LOOP [configure-mirrors : Update yum/dnf cache]
2026-01-26 03:05:39.819183 | cloud-centos-9-stream | 29 files removed
2026-01-26 03:05:39.819458 | cloud-centos-9-stream | ok: Item: dnf clean all Runtime: 0:00:00.299221
2026-01-26 03:05:39.819513 | cloud-centos-9-stream | changed: All items complete
2026-01-26 03:05:39.819543 | 
2026-01-26 03:05:50.889105 | cloud-centos-9-stream | Loaded plugins: builddep, changelog, config-manager, copr, debug, debuginfo-install, download, generate_completion_cache, groups-manager, needs-restarting, playground, repoclosure, repodiff, repograph, repomanage, reposync, system-upgrade
2026-01-26 03:05:50.889477 | cloud-centos-9-stream | DNF version: 4.14.0
2026-01-26 03:05:50.889556 | cloud-centos-9-stream | cachedir: /var/cache/dnf
2026-01-26 03:05:50.889614 | cloud-centos-9-stream | Making cache files for all metadata files.
2026-01-26 03:05:50.889667 | cloud-centos-9-stream | baseos: has expired and will be refreshed.
2026-01-26 03:05:50.889774 | cloud-centos-9-stream | appstream: has expired and will be refreshed.
2026-01-26 03:05:50.889828 | cloud-centos-9-stream | crb: has expired and will be refreshed.
2026-01-26 03:05:50.889880 | cloud-centos-9-stream | extras-common: has expired and will be refreshed.
2026-01-26 03:05:50.889929 | cloud-centos-9-stream | repo: downloading from remote: baseos
2026-01-26 03:05:50.889978 | cloud-centos-9-stream | CentOS Stream 9 - BaseOS                         81 MB/s | 8.9 MB     00:00
2026-01-26 03:05:50.890027 | cloud-centos-9-stream | baseos: using metadata from Mon 19 Jan 2026 01:03:35 PM EST.
2026-01-26 03:05:50.890075 | cloud-centos-9-stream | repo: downloading from remote: appstream
2026-01-26 03:05:50.890121 | cloud-centos-9-stream | CentOS Stream 9 - AppStream                      82 MB/s |  26 MB     00:00
2026-01-26 03:05:50.890169 | cloud-centos-9-stream | appstream: using metadata from Mon 19 Jan 2026 01:07:04 PM EST.
2026-01-26 03:05:50.890219 | cloud-centos-9-stream | repo: downloading from remote: crb
2026-01-26 03:05:50.890271 | cloud-centos-9-stream | CentOS Stream 9 - CRB                            71 MB/s | 7.6 MB     00:00
2026-01-26 03:05:50.890311 | cloud-centos-9-stream | crb: using metadata from Mon 19 Jan 2026 01:11:31 PM EST.
2026-01-26 03:05:50.890350 | cloud-centos-9-stream | repo: downloading from remote: extras-common
2026-01-26 03:05:50.890388 | cloud-centos-9-stream | CentOS Stream 9 - Extras packages               1.3 MB/s |  20 kB     00:00
2026-01-26 03:05:50.890425 | cloud-centos-9-stream | extras-common: using metadata from Thu 30 Oct 2025 09:20:08 AM EDT.
2026-01-26 03:05:50.890466 | cloud-centos-9-stream | User-Agent: constructed: 'libdnf (CentOS Stream 9; generic; Linux.x86_64)'
2026-01-26 03:05:50.890505 | cloud-centos-9-stream | Completion plugin: Generating completion cache...
2026-01-26 03:05:50.890543 | cloud-centos-9-stream | Metadata cache created.
2026-01-26 03:05:50.890599 | cloud-centos-9-stream | ok: Item: dnf makecache -v Runtime: 0:00:10.746436
2026-01-26 03:05:50.923269 | 
2026-01-26 03:05:50.923411 | PLAY RECAP
2026-01-26 03:05:50.923482 | cloud-centos-9-stream | ok: 13 changed: 7 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-01-26 03:05:50.923532 | localhost | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-26 03:05:50.923569 | 
2026-01-26 03:05:51.022830 | PRE-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master]
2026-01-26 03:05:51.024134 | RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/rdoinfo/weirdo-periodic.yaml@master]
2026-01-26 03:05:51.634395 | 
2026-01-26 03:05:51.634506 | PLAY [all]
2026-01-26 03:05:51.655479 | 
2026-01-26 03:05:51.655589 | TASK [Run common weirdo tasks]
2026-01-26 03:05:51.687423 | cloud-centos-9-stream | ok
2026-01-26 03:05:51.707905 | cloud-centos-9-stream | included: /var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/untrusted/project_0/review.rdoproject.org/rdo-jobs/playbooks/weirdo/common.yaml
2026-01-26 03:05:51.713457 | 
2026-01-26 03:05:51.713531 | TASK [Create workspace directory]
2026-01-26 03:05:52.151714 | cloud-centos-9-stream | changed
2026-01-26 03:05:52.160172 | 
2026-01-26 03:05:52.160285 | TASK [Create centos_releasever fact]
2026-01-26 03:05:52.185097 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:52.194438 | 
2026-01-26 03:05:52.194538 | TASK [set centos_release fact]
2026-01-26 03:05:52.236438 | cloud-centos-9-stream | ok
2026-01-26 03:05:52.243877 | 
2026-01-26 03:05:52.243967 | TASK [Install pip]
2026-01-26 03:05:52.264991 | cloud-centos-9-stream | ok
2026-01-26 03:05:52.297838 | 
2026-01-26 03:05:52.297962 | TASK [ensure-pip : Check if pip is installed]
2026-01-25 22:05:52.704516 | cloud-centos-9-stream | /usr/bin/pip3
2026-01-25 22:05:52.750750 | cloud-centos-9-stream | /usr/bin/python3: No module named wheel
2026-01-26 03:05:52.829945 | cloud-centos-9-stream | ok: Runtime: 0:00:00.061078
2026-01-26 03:05:52.842434 | 
2026-01-26 03:05:52.842601 | LOOP [ensure-pip : Install pip from packages]
2026-01-26 03:05:52.886896 | cloud-centos-9-stream | ok: "/var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml"
2026-01-26 03:05:52.934296 | cloud-centos-9-stream | included: /var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml
2026-01-26 03:05:52.953105 | 
2026-01-26 03:05:52.953242 | TASK [ensure-pip : Install Python 3 pip]
2026-01-26 03:05:54.804001 | cloud-centos-9-stream | changed
2026-01-26 03:05:54.812539 | 
2026-01-26 03:05:54.812693 | TASK [ensure-pip : Check for EPEL repository]
2026-01-26 03:05:54.838014 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:54.849483 | 
2026-01-26 03:05:54.849646 | TASK [ensure-pip : Fail with instructions when EPEL is not installed]
2026-01-26 03:05:54.874997 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:54.882131 | 
2026-01-26 03:05:54.882209 | TASK [ensure-pip : Install Python 2 pip]
2026-01-26 03:05:54.906340 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:54.912390 | 
2026-01-26 03:05:54.912457 | TASK [ensure-pip : Ensure setuptools]
2026-01-26 03:05:54.936381 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:54.942476 | 
2026-01-26 03:05:54.942542 | TASK [ensure-pip : Check for ensurepip module]
2026-01-26 03:05:55.471055 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:55.485086 | 
2026-01-26 03:05:55.485246 | TASK [ensure-pip : Ensure python3-venv]
2026-01-26 03:05:55.512046 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:55.519385 | 
2026-01-26 03:05:55.519456 | TASK [ensure-pip : Install pip from source]
2026-01-26 03:05:55.543333 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:55.549532 | 
2026-01-26 03:05:55.549603 | TASK [ensure-pip : Probe for venv python full path]
2026-01-25 22:05:55.818860 | cloud-centos-9-stream | /usr/bin/python3
2026-01-26 03:05:56.081002 | cloud-centos-9-stream | ok: Runtime: 0:00:00.006975
2026-01-26 03:05:56.093908 | 
2026-01-26 03:05:56.094093 | TASK [ensure-pip : Set host default]
2026-01-26 03:05:56.194656 | cloud-centos-9-stream | ok
2026-01-26 03:05:56.240981 | 
2026-01-26 03:05:56.241131 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-01-26 03:05:56.325066 | cloud-centos-9-stream | ok
2026-01-26 03:05:56.336089 | 
2026-01-26 03:05:56.336211 | TASK [ensure-tox : Check if tox is installed]
2026-01-26 03:05:56.865259 | cloud-centos-9-stream | ok: Runtime: 0:00:00.007397
2026-01-26 03:05:56.878477 | 
2026-01-26 03:05:56.878646 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2026-01-26 03:05:56.906770 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:05:56.922516 | 
2026-01-26 03:05:56.922759 | TASK [ensure-tox : Create local venv]
2026-01-26 03:05:59.979721 | cloud-centos-9-stream | ok: Runtime: 0:00:02.572027
2026-01-26 03:05:59.991866 | 
2026-01-26 03:05:59.992027 | TASK [ensure-tox : Install tox to local venv]
2026-01-25 22:06:00.616501 | cloud-centos-9-stream | Looking in indexes: http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypi/simple, http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/wheel/centos-9-x86_64
2026-01-25 22:06:00.910940 | cloud-centos-9-stream | Collecting tox
2026-01-25 22:06:00.913992 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/e2/e4/8bb9ce952820df4165eb34610af347665d6cb436898a234db9d84d093ce6/tox-4.30.3-py3-none-any.whl (175 kB)
2026-01-25 22:06:01.016651 | cloud-centos-9-stream | Collecting filelock>=3.18
2026-01-25 22:06:01.020126 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/42/14/42b2651a2f46b022ccd948bca9f2d5af0fd8929c4eec235b8d6d844fbe67/filelock-3.19.1-py3-none-any.whl (15 kB)
2026-01-25 22:06:01.098597 | cloud-centos-9-stream | Collecting cachetools>=6.1
2026-01-25 22:06:01.102159 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/e3/a6/24169d70ec5264b65ba54ba49b3d10f46d6b1ad97e185c94556539b3dfc8/cachetools-6.2.5-py3-none-any.whl (11 kB)
2026-01-25 22:06:01.155152 | cloud-centos-9-stream | Collecting colorama>=0.4.6
2026-01-25 22:06:01.157953 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/wheel/centos-9-x86_64/colorama/colorama-0.4.6-py2.py3-none-any.whl (25 kB)
2026-01-25 22:06:01.365858 | cloud-centos-9-stream | Collecting virtualenv>=20.31.2
2026-01-25 22:06:01.368841 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/6a/2a/dc2228b2888f51192c7dc766106cd475f1b768c10caaf9727659726f7391/virtualenv-20.36.1-py3-none-any.whl (6.0 MB)
2026-01-25 22:06:01.499974 | cloud-centos-9-stream | Collecting pluggy>=1.6
2026-01-25 22:06:01.505653 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/54/20/4d324d65cc6d9205fabedc306948156824eb9f0ee1633355a8f7ec5c66bf/pluggy-1.6.0-py3-none-any.whl (20 kB)
2026-01-25 22:06:01.582895 | cloud-centos-9-stream | Collecting tomli>=2.2.1
2026-01-25 22:06:01.585831 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/23/d1/136eb2cb77520a31e1f64cbae9d33ec6df0d78bdf4160398e86eec8a8754/tomli-2.4.0-py3-none-any.whl (14 kB)
2026-01-25 22:06:01.650111 | cloud-centos-9-stream | Collecting typing-extensions>=4.14.1
2026-01-25 22:06:01.653127 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/18/67/36e9267722cc04a6b9f15c7f3441c2363321a3ea07da7ae0c0707beb2a9c/typing_extensions-4.15.0-py3-none-any.whl (44 kB)
2026-01-25 22:06:01.717393 | cloud-centos-9-stream | Collecting packaging>=25
2026-01-25 22:06:01.720822 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/b7/b9/c538f279a4e237a006a2c98387d081e9eb060d203d8ed34467cc0f0b9b53/packaging-26.0-py3-none-any.whl (74 kB)
2026-01-25 22:06:01.761137 | cloud-centos-9-stream | Collecting pyproject-api>=1.9.1
2026-01-25 22:06:01.764036 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/ef/e6/c293c06695d4a3ab0260ef124a74ebadba5f4c511ce3a4259e976902c00b/pyproject_api-1.9.1-py3-none-any.whl (13 kB)
2026-01-25 22:06:01.830236 | cloud-centos-9-stream | Collecting platformdirs>=4.3.8
2026-01-25 22:06:01.833324 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/40/4b/2028861e724d3bd36227adfa20d3fd24c3fc6d52032f4a93c133be5d17ce/platformdirs-4.4.0-py3-none-any.whl (18 kB)
2026-01-25 22:06:01.864513 | cloud-centos-9-stream | Collecting chardet>=5.2
2026-01-25 22:06:01.867428 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/38/6f/f5fbc992a329ee4e0f288c1fe0e2ad9485ed064cac731ed2fe47dcc38cbf/chardet-5.2.0-py3-none-any.whl (199 kB)
2026-01-25 22:06:01.960212 | cloud-centos-9-stream | Collecting distlib<1,>=0.3.7
2026-01-25 22:06:01.965474 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/33/6b/e0547afaf41bf2c42e52430072fa5658766e3d65bd4b03a563d1b6336f57/distlib-0.4.0-py2.py3-none-any.whl (469 kB)
2026-01-25 22:06:02.094712 | cloud-centos-9-stream | Installing collected packages: typing-extensions, tomli, platformdirs, packaging, filelock, distlib, virtualenv, pyproject-api, pluggy, colorama, chardet, cachetools, tox
2026-01-25 22:06:02.768049 | cloud-centos-9-stream | Successfully installed cachetools-6.2.5 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.19.1 packaging-26.0 platformdirs-4.4.0 pluggy-1.6.0 pyproject-api-1.9.1 tomli-2.4.0 tox-4.30.3 typing-extensions-4.15.0 virtualenv-20.36.1
2026-01-25 22:06:02.885494 | cloud-centos-9-stream | WARNING: You are using pip version 21.3.1; however, version 25.3 is available.
2026-01-25 22:06:02.976083 | cloud-centos-9-stream | You should consider upgrading via the '/home/zuul-worker/.local/tox/bin/python3 -m pip install --upgrade pip' command.
2026-01-26 03:06:03.051711 | cloud-centos-9-stream | ok: Runtime: 0:00:02.699397
2026-01-26 03:06:03.064134 | 
2026-01-26 03:06:03.064279 | TASK [ensure-tox : Export installed tox_executable path]
2026-01-26 03:06:03.115565 | cloud-centos-9-stream | ok
2026-01-26 03:06:03.126836 | 
2026-01-26 03:06:03.126975 | TASK [ensure-tox : Output tox version]
2026-01-25 22:06:03.604409 | cloud-centos-9-stream | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul-worker
2026-01-25 22:06:03.624574 | cloud-centos-9-stream | 4.30.3 from /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/tox/__init__.py
2026-01-26 03:06:03.712194 | cloud-centos-9-stream | ok: Runtime: 0:00:00.255607
2026-01-26 03:06:03.725921 | 
2026-01-26 03:06:03.726114 | TASK [ensure-tox : Make global symlink]
2026-01-26 03:06:04.041955 | cloud-centos-9-stream | changed
2026-01-26 03:06:04.064190 | 
2026-01-26 03:06:04.064358 | TASK [Setup weirdo roles]
2026-01-26 03:06:04.607185 | cloud-centos-9-stream | ok: Runtime: 0:00:00.026793
2026-01-26 03:06:04.613458 | 
2026-01-26 03:06:04.613545 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-01-26 03:06:04.668485 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:06:04.681528 | 
2026-01-26 03:06:04.681665 | TASK [mirror-info-fork : Create /etc/ci]
2026-01-26 03:06:04.985121 | cloud-centos-9-stream | changed
2026-01-26 03:06:04.998023 | 
2026-01-26 03:06:04.998174 | TASK [mirror-info-fork : Install ci_mirror script]
2026-01-26 03:06:06.742905 | cloud-centos-9-stream | changed
2026-01-26 03:06:06.761837 | 
2026-01-26 03:06:06.761966 | TASK [install rdopkg dependencies]
2026-01-25 22:06:07.438262 | cloud-centos-9-stream | Last metadata expiration check: 0:00:18 ago on Sun 25 Jan 2026 10:05:49 PM EST.
2026-01-25 22:06:07.556778 | cloud-centos-9-stream | Package python3-pip-21.3.1-1.el9.noarch is already installed.
2026-01-25 22:06:07.557229 | cloud-centos-9-stream | Package rpmlint-1.11-19.el9.noarch is already installed.
2026-01-25 22:06:07.557880 | cloud-centos-9-stream | Package python3-rpm-4.16.1.3-40.el9.x86_64 is already installed.
2026-01-25 22:06:07.589805 | cloud-centos-9-stream | Dependencies resolved.
2026-01-25 22:06:07.591006 | cloud-centos-9-stream | Nothing to do.
2026-01-25 22:06:07.591057 | cloud-centos-9-stream | Complete!
2026-01-26 03:06:07.804354 | cloud-centos-9-stream | ok: Runtime: 0:00:00.589101
2026-01-26 03:06:07.817482 | 
2026-01-26 03:06:07.817626 | TASK [pip install rdopkg]
2026-01-26 03:06:14.161383 | cloud-centos-9-stream | changed
2026-01-26 03:06:14.173777 | 
2026-01-26 03:06:14.173930 | TASK [Run weirdo for the desired project and scenario]
2026-01-25 22:06:14.530847 | cloud-centos-9-stream | + source /home/zuul-worker/rdopkg-venv/bin/activate
2026-01-25 22:06:14.531064 | cloud-centos-9-stream | ++ deactivate nondestructive
2026-01-25 22:06:14.531105 | cloud-centos-9-stream | ++ '[' -n '' ']'
2026-01-25 22:06:14.531121 | cloud-centos-9-stream | ++ '[' -n '' ']'
2026-01-25 22:06:14.531138 | cloud-centos-9-stream | ++ '[' -n /bin/sh -o -n '' ']'
2026-01-25 22:06:14.531229 | cloud-centos-9-stream | ++ hash -r
2026-01-25 22:06:14.531261 | cloud-centos-9-stream | ++ '[' -n '' ']'
2026-01-25 22:06:14.531275 | cloud-centos-9-stream | ++ unset VIRTUAL_ENV
2026-01-25 22:06:14.531289 | cloud-centos-9-stream | ++ '[' '!' nondestructive = nondestructive ']'
2026-01-25 22:06:14.531309 | cloud-centos-9-stream | ++ VIRTUAL_ENV=/home/zuul-worker/rdopkg-venv
2026-01-25 22:06:14.531342 | cloud-centos-9-stream | ++ export VIRTUAL_ENV
2026-01-25 22:06:14.531357 | cloud-centos-9-stream | ++ _OLD_VIRTUAL_PATH=/home/zuul-worker/.local/bin:/home/zuul-worker/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2026-01-25 22:06:14.531374 | cloud-centos-9-stream | ++ PATH=/home/zuul-worker/rdopkg-venv/bin:/home/zuul-worker/.local/bin:/home/zuul-worker/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2026-01-25 22:06:14.531413 | cloud-centos-9-stream | ++ export PATH
2026-01-25 22:06:14.531427 | cloud-centos-9-stream | ++ '[' -n '' ']'
2026-01-25 22:06:14.531444 | cloud-centos-9-stream | ++ '[' -z '' ']'
2026-01-25 22:06:14.531479 | cloud-centos-9-stream | ++ _OLD_VIRTUAL_PS1=
2026-01-25 22:06:14.531493 | cloud-centos-9-stream | ++ PS1='(rdopkg-venv) '
2026-01-25 22:06:14.531506 | cloud-centos-9-stream | ++ export PS1
2026-01-25 22:06:14.531523 | cloud-centos-9-stream | ++ '[' -n /bin/sh -o -n '' ']'
2026-01-25 22:06:14.532844 | cloud-centos-9-stream | ++ hash -r
2026-01-25 22:06:14.532893 | cloud-centos-9-stream | ++ rdopkg info
2026-01-25 22:06:14.533151 | cloud-centos-9-stream | ++ grep -e 'in development phase'
2026-01-25 22:06:14.533238 | cloud-centos-9-stream | ++ awk '{print $1}'
2026-01-25 22:06:18.574157 | cloud-centos-9-stream | + MASTER=flamingo
2026-01-25 22:06:18.574286 | cloud-centos-9-stream | + RELEASE=bobcat
2026-01-25 22:06:18.574303 | cloud-centos-9-stream | + DIST_VER=9
2026-01-25 22:06:18.574317 | cloud-centos-9-stream | + [[ weirdo-bobcat-promote-packstack-scenario001-centos-stream-9 == *\p\u\p\p\e\t* ]]
2026-01-25 22:06:18.574331 | cloud-centos-9-stream | + project=packstack
2026-01-25 22:06:18.574345 | cloud-centos-9-stream | + scenario=scenario001
2026-01-25 22:06:18.574364 | cloud-centos-9-stream | + '[' bobcat = flamingo ']'
2026-01-25 22:06:18.575428 | cloud-centos-9-stream | ++ rdopkg release -r bobcat
2026-01-25 22:06:18.575670 | cloud-centos-9-stream | ++ grep upstream_branch
2026-01-25 22:06:18.575823 | cloud-centos-9-stream | ++ awk '{print $2}'
2026-01-25 22:06:20.517189 | cloud-centos-9-stream | + VERSION=stable/2023.2
2026-01-25 22:06:20.517345 | cloud-centos-9-stream | + O_RELEASE=bobcat
2026-01-25 22:06:20.517365 | cloud-centos-9-stream | + [[ promotion == \p\r\o\m\o\t\i\o\n ]]
2026-01-25 22:06:20.517380 | cloud-centos-9-stream | + enable_puppet_modules_rpm=false
2026-01-25 22:06:20.517394 | cloud-centos-9-stream | + dlrn_repo=puppet-ci-testing
2026-01-25 22:06:20.517414 | cloud-centos-9-stream | + pushd /home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo
2026-01-25 22:06:20.521623 | cloud-centos-9-stream | ~/src/review.rdoproject.org/rdo-infra/weirdo ~
2026-01-25 22:06:20.521705 | cloud-centos-9-stream | + cat
2026-01-25 22:06:20.521732 | cloud-centos-9-stream | + REPOS_URL=http://trunk.rdoproject.org/centos9-bobcat/puppet-ci-testing/delorean.repo,https://trunk.rdoproject.org/centos9-bobcat/delorean-deps.repo
2026-01-25 22:06:21.284682 | cloud-centos-9-stream | + tox -e ansible-playbook -- -vv -b -i hosts playbooks/packstack-scenario001.yml -e version=stable/2023.2 -e openstack_release=bobcat -e selinux_enforcing=false -e tempest_from_source=false -e enable_puppet_modules_rpm=false -e trunk_repositories=http://trunk.rdoproject.org/centos9-bobcat/puppet-ci-testing/delorean.repo,https://trunk.rdoproject.org/centos9-bobcat/delorean-deps.repo
2026-01-25 22:06:21.284736 | cloud-centos-9-stream | ansible-playbook: install_deps> pip install -U -r /home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/test-requirements.txt
2026-01-25 22:06:51.721141 | cloud-centos-9-stream | .pkg: install_requires> python -I -m pip install 'setuptools>=40.8.0'
2026-01-25 22:06:52.429961 | cloud-centos-9-stream | .pkg: _optional_hooks> python /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-01-25 22:06:52.683527 | cloud-centos-9-stream | .pkg: get_requires_for_build_editable> python /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-01-25 22:06:52.830785 | cloud-centos-9-stream | .pkg: install_requires_for_build_editable> python -I -m pip install pbr
2026-01-25 22:06:53.469434 | cloud-centos-9-stream | .pkg: build_editable> python /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-01-25 22:06:54.946350 | cloud-centos-9-stream | ansible-playbook: install_package_deps> pip install -U 'Django<2.2' ansible==2.9.27 'ara[server]' dlrnapi_client jinja2==3.0.3 'pbr>=1.6'
2026-01-25 22:07:10.828975 | cloud-centos-9-stream | ansible-playbook: install_package> pip install -U --force-reinstall --no-deps /home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/.tox/.tmp/package/1/weirdo-0.0.1.dev166-0.editable-py2.py3-none-any.whl
2026-01-25 22:07:11.219640 | cloud-centos-9-stream | ansible-playbook: commands[0]> ansible-galaxy role install -r ansible-role-requirements.yml --ignore-errors
2026-01-25 22:07:12.037677 | cloud-centos-9-stream | - extracting kolla to /home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/playbooks/roles/kolla
2026-01-25 22:07:12.038132 | cloud-centos-9-stream | [WARNING]: - kolla was NOT installed successfully: the specified role kolla
2026-01-25 22:07:12.412077 | cloud-centos-9-stream | appears to already exist. Use --force to replace it.
2026-01-25 22:07:12.412170 | cloud-centos-9-stream | - extracting packstack to /home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/playbooks/roles/packstack
2026-01-25 22:07:12.412385 | cloud-centos-9-stream | [WARNING]: - packstack was NOT installed successfully: the specified role
2026-01-25 22:07:12.670574 | cloud-centos-9-stream | packstack appears to already exist. Use --force to replace it.
2026-01-25 22:07:12.670652 | cloud-centos-9-stream | - extracting puppet-openstack to /home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/playbooks/roles/puppet-openstack
2026-01-25 22:07:12.671109 | cloud-centos-9-stream | [WARNING]: - puppet-openstack was NOT installed successfully: the specified
2026-01-25 22:07:13.165325 | cloud-centos-9-stream | role puppet-openstack appears to already exist. Use --force to replace it.
2026-01-25 22:07:13.165417 | cloud-centos-9-stream | - extracting common to /home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/playbooks/roles/common
2026-01-25 22:07:13.165874 | cloud-centos-9-stream | [WARNING]: - common was NOT installed successfully: the specified role common
2026-01-25 22:07:13.455281 | cloud-centos-9-stream | appears to already exist. Use --force to replace it.
2026-01-25 22:07:13.455342 | cloud-centos-9-stream | - extracting logs to /home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/playbooks/roles/logs
2026-01-25 22:07:13.455698 | cloud-centos-9-stream | [WARNING]: - logs was NOT installed successfully: the specified role logs
2026-01-25 22:07:14.829377 | cloud-centos-9-stream | appears to already exist. Use --force to replace it.
2026-01-25 22:07:14.829455 | cloud-centos-9-stream | - extracting ci-framework to /home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/playbooks/roles/ci-framework
2026-01-25 22:07:14.830424 | cloud-centos-9-stream | /usr/lib64/python3.9/tarfile.py:2288: RuntimeWarning: The default behavior of tarfile extraction has been changed to disallow common exploits (including CVE-2007-4559). By default, absolute/parent paths are disallowed and some mode bits are cleared. See https://access.redhat.com/articles/7004769 for more details.
2026-01-25 22:07:15.422256 | cloud-centos-9-stream |   warnings.warn(
2026-01-25 22:07:15.422326 | cloud-centos-9-stream | - ci-framework (main) was installed successfully
2026-01-25 22:07:15.585174 | cloud-centos-9-stream | ansible-playbook: commands[1]> ansible-galaxy collection install -r ansible-role-requirements.yml --ignore-errors
2026-01-25 22:07:16.118578 | cloud-centos-9-stream | Process install dependency map
2026-01-25 22:07:18.564073 | cloud-centos-9-stream | |/-\|/-\|/-\|/-\|/-\|/-\ERROR! Error when getting collection version metadata for containers.podman:1.18.1 from default (https://galaxy.ansible.com/api/) (HTTP Code: 500, Message: Internal Server Error Code: Unknown)
2026-01-25 22:07:18.624178 | cloud-centos-9-stream | ansible-playbook: exit 1 (3.04 seconds) /home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo> ansible-galaxy collection install -r ansible-role-requirements.yml --ignore-errors pid=6894
2026-01-25 22:07:18.625973 | cloud-centos-9-stream |   ansible-playbook: FAIL code 1 (57.78=setup[50.38]+cmd[4.36,3.04] seconds)
2026-01-25 22:07:18.667337 | cloud-centos-9-stream |   evaluation failed :( (57.94 seconds)
2026-01-26 03:07:18.856429 | cloud-centos-9-stream | ERROR
2026-01-26 03:07:18.856814 | cloud-centos-9-stream | {
2026-01-26 03:07:18.856902 | cloud-centos-9-stream |   "delta": "0:01:04.144044",
2026-01-26 03:07:18.856948 | cloud-centos-9-stream |   "end": "2026-01-25 22:07:18.667943",
2026-01-26 03:07:18.856986 | cloud-centos-9-stream |   "msg": "non-zero return code",
2026-01-26 03:07:18.857022 | cloud-centos-9-stream |   "rc": 1,
2026-01-26 03:07:18.857056 | cloud-centos-9-stream |   "start": "2026-01-25 22:06:14.523899"
2026-01-26 03:07:18.857090 | cloud-centos-9-stream | }
failure
2026-01-26 03:07:18.866648 | 
2026-01-26 03:07:18.866819 | PLAY RECAP
2026-01-26 03:07:18.866905 | cloud-centos-9-stream | ok: 20 changed: 14 unreachable: 0 failed: 1 skipped: 10 rescued: 0 ignored: 0
2026-01-26 03:07:18.866950 | 
2026-01-26 03:07:19.003116 | RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/rdoinfo/weirdo-periodic.yaml@master]
2026-01-26 03:07:19.004016 | POST-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/weirdo/integration/post.yaml@master]
2026-01-26 03:07:19.577121 | 
2026-01-26 03:07:19.577251 | PLAY [all]
2026-01-26 03:07:19.619371 | 
2026-01-26 03:07:19.619532 | TASK [Prepare logs]
2026-01-25 22:07:20.417874 | cloud-centos-9-stream | [ara] No setting found for SECRET_KEY. Generating a random key...
2026-01-25 22:07:20.418028 | cloud-centos-9-stream | [ara] Creating data & configuration directory: /root/.ara/server
2026-01-25 22:07:20.418043 | cloud-centos-9-stream | [ara] Writing default settings to /root/.ara/server/settings.yaml
2026-01-25 22:07:20.418052 | cloud-centos-9-stream | Traceback (most recent call last):
2026-01-25 22:07:20.418060 | cloud-centos-9-stream |   File "/home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/.tox/ansible-playbook/bin/ara-manage", line 7, in <module>
2026-01-25 22:07:20.418068 | cloud-centos-9-stream |     sys.exit(main())
2026-01-25 22:07:20.418077 | cloud-centos-9-stream |   File "/home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/.tox/ansible-playbook/lib/python3.9/site-packages/ara/server/__main__.py", line 43, in main
2026-01-25 22:07:20.418088 | cloud-centos-9-stream |     if not os.path.exists(settings.ARA_SETTINGS):
2026-01-25 22:07:20.418103 | cloud-centos-9-stream |   File "/home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/.tox/ansible-playbook/lib/python3.9/site-packages/django/conf/__init__.py", line 57, in __getattr__
2026-01-25 22:07:20.418114 | cloud-centos-9-stream |     self._setup(name)
2026-01-25 22:07:20.418122 | cloud-centos-9-stream |   File "/home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/.tox/ansible-playbook/lib/python3.9/site-packages/django/conf/__init__.py", line 44, in _setup
2026-01-25 22:07:20.418130 | cloud-centos-9-stream |     self._wrapped = Settings(settings_module)
2026-01-25 22:07:20.418138 | cloud-centos-9-stream |   File "/home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/.tox/ansible-playbook/lib/python3.9/site-packages/django/conf/__init__.py", line 107, in __init__
2026-01-25 22:07:20.418146 | cloud-centos-9-stream |     mod = importlib.import_module(self.SETTINGS_MODULE)
2026-01-25 22:07:20.418155 | cloud-centos-9-stream |   File "/usr/lib64/python3.9/importlib/__init__.py", line 127, in import_module
2026-01-25 22:07:20.418163 | cloud-centos-9-stream |     return _bootstrap._gcd_import(name[level:], package, level)
2026-01-25 22:07:20.418171 | cloud-centos-9-stream |   File "<frozen importlib._bootstrap>", line 1030, in _gcd_import
2026-01-25 22:07:20.418183 | cloud-centos-9-stream |   File "<frozen importlib._bootstrap>", line 1007, in _find_and_load
2026-01-25 22:07:20.418252 | cloud-centos-9-stream |   File "<frozen importlib._bootstrap>", line 986, in _find_and_load_unlocked
2026-01-25 22:07:20.418272 | cloud-centos-9-stream |   File "<frozen importlib._bootstrap>", line 680, in _load_unlocked
2026-01-25 22:07:20.418284 | cloud-centos-9-stream |   File "<frozen importlib._bootstrap_external>", line 850, in exec_module
2026-01-25 22:07:20.418378 | cloud-centos-9-stream |   File "<frozen importlib._bootstrap>", line 228, in _call_with_frames_removed
2026-01-25 22:07:20.418412 | cloud-centos-9-stream |   File "/home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/.tox/ansible-playbook/lib/python3.9/site-packages/ara/server/settings.py", line 312, in <module>
2026-01-25 22:07:20.418514 | cloud-centos-9-stream |     yaml.dump({"default": SETTINGS}, settings_file, default_flow_style=False)
2026-01-25 22:07:20.418718 | cloud-centos-9-stream |   File "/home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/.tox/ansible-playbook/lib/python3.9/site-packages/ruamel/yaml/main.py", line 1255, in dump
2026-01-25 22:07:20.418737 | cloud-centos-9-stream |     error_deprecation('dump', 'dump', arg="typ='unsafe', pure=True")
2026-01-25 22:07:20.418885 | cloud-centos-9-stream |   File "/home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/.tox/ansible-playbook/lib/python3.9/site-packages/ruamel/yaml/main.py", line 1041, in error_deprecation
2026-01-25 22:07:20.418902 | cloud-centos-9-stream |     raise AttributeError(s)
2026-01-25 22:07:20.475303 | cloud-centos-9-stream | AttributeError:
2026-01-25 22:07:20.475378 | cloud-centos-9-stream | "dump()" has been removed, use
2026-01-25 22:07:20.475400 | cloud-centos-9-stream |
2026-01-25 22:07:20.475418 | cloud-centos-9-stream |   yaml = YAML(typ='unsafe', pure=True)
2026-01-25 22:07:20.475443 | cloud-centos-9-stream |   yaml.dump(...)
2026-01-25 22:07:20.475460 | cloud-centos-9-stream |
2026-01-25 22:07:20.475480 | cloud-centos-9-stream | instead of file "/home/zuul-worker/src/review.rdoproject.org/rdo-infra/weirdo/.tox/ansible-playbook/lib/python3.9/site-packages/ara/server/settings.py", line 312
2026-01-25 22:07:20.475498 | cloud-centos-9-stream |
2026-01-25 22:07:20.475515 | cloud-centos-9-stream |         yaml.dump({"default": SETTINGS}, settings_file, default_flow_style=False)
2026-01-25 22:07:20.475533 | cloud-centos-9-stream |
2026-01-25 22:07:20.475550 | cloud-centos-9-stream |
2026-01-25 22:07:20.475580 | cloud-centos-9-stream | cp: cannot stat '/var/log/weirdo/*': No such file or directory
2026-01-25 22:07:20.529601 | cloud-centos-9-stream | cp: cannot stat '/home/zuul-worker/workspace/ara.sqlite': No such file or directory
2026-01-26 03:07:20.661781 | cloud-centos-9-stream | ok: Runtime: 0:00:00.498000
2026-01-26 03:07:20.676193 | 
2026-01-26 03:07:20.676356 | TASK [Copy Weirdo logs]
2026-01-26 03:07:21.402444 | cloud-centos-9-stream | changed:
2026-01-26 03:07:21.402631 | cloud-centos-9-stream | cd+++++++++ ./
2026-01-26 03:07:21.402660 | cloud-centos-9-stream | cd+++++++++ ara-database/
2026-01-26 03:07:21.426353 | 
2026-01-26 03:07:21.426456 | PLAY RECAP
2026-01-26 03:07:21.426499 | cloud-centos-9-stream | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-26 03:07:21.426529 | 
2026-01-26 03:07:21.515888 | POST-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/weirdo/integration/post.yaml@master]
2026-01-26 03:07:21.516932 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-01-26 03:07:22.099625 | 
2026-01-26 03:07:22.099758 | PLAY [all]
2026-01-26 03:07:22.118168 | 
2026-01-26 03:07:22.118240 | TASK [include_role : fetch-output]
2026-01-26 03:07:22.157607 | cloud-centos-9-stream | ok
2026-01-26 03:07:22.174544 | 
2026-01-26 03:07:22.174625 | TASK [fetch-output : Set log path for multiple nodes]
2026-01-26 03:07:22.239789 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:07:22.252255 | 
2026-01-26 03:07:22.252399 | TASK [fetch-output : Set log path for single node]
2026-01-26 03:07:22.289961 | cloud-centos-9-stream | ok
2026-01-26 03:07:22.300977 | 
2026-01-26 03:07:22.301119 | LOOP [fetch-output : Ensure local output dirs]
2026-01-26 03:07:22.720719 | cloud-centos-9-stream -> localhost | ok: "/var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/work/logs"
2026-01-26 03:07:22.954133 | cloud-centos-9-stream -> localhost | changed: "/var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/work/artifacts"
2026-01-26 03:07:23.168485 | cloud-centos-9-stream -> localhost | changed: "/var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/work/docs"
2026-01-26 03:07:23.182395 | 
2026-01-26 03:07:23.182485 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-01-26 03:07:23.796575 | cloud-centos-9-stream | changed: .d..t...... ./
2026-01-26 03:07:23.796783 | cloud-centos-9-stream | changed: All items complete
2026-01-26 03:07:23.796813 | 
2026-01-26 03:07:24.359081 | cloud-centos-9-stream | changed: .d..t...... ./
2026-01-26 03:07:24.892542 | cloud-centos-9-stream | changed: .d..t...... ./
2026-01-26 03:07:24.917375 | 
2026-01-26 03:07:24.917626 | TASK [include_role : fetch-output-openshift]
2026-01-26 03:07:24.944783 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:07:24.959180 | 
2026-01-26 03:07:24.959350 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-01-26 03:07:25.007407 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:07:25.018357 | cloud-centos-9-stream | skipping: Conditional result was False
2026-01-26 03:07:25.063113 | 
2026-01-26 03:07:25.063252 | PLAY [all]
2026-01-26 03:07:25.086498 | 
2026-01-26 03:07:25.086615 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-01-26 03:07:25.573213 | cloud-centos-9-stream | changed
2026-01-26 03:07:25.621092 | 
2026-01-26 03:07:25.621194 | PLAY RECAP
2026-01-26 03:07:25.621249 | cloud-centos-9-stream | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-01-26 03:07:25.621277 | 
2026-01-26 03:07:25.719033 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-01-26 03:07:25.720735 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2026-01-26 03:07:26.344695 | 
2026-01-26 03:07:26.344825 | PLAY [localhost]
2026-01-26 03:07:26.362669 | 
2026-01-26 03:07:26.362783 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-01-26 03:07:26.749451 | localhost | changed
2026-01-26 03:07:26.755271 | 
2026-01-26 03:07:26.755346 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-01-26 03:07:26.793585 | localhost | ok
2026-01-26 03:07:26.801490 | 
2026-01-26 03:07:26.801559 | TASK [add-fileserver : Create SSH private key tempfile]
2026-01-26 03:07:27.181874 | localhost | changed
2026-01-26 03:07:27.193816 | 
2026-01-26 03:07:27.193991 | TASK [add-fileserver : Create SSH private key from secret]
2026-01-26 03:07:27.894661 | localhost | changed
2026-01-26 03:07:27.905949 | 
2026-01-26 03:07:27.906119 | TASK [add-fileserver : Add fileserver ssh key]
2026-01-26 03:07:28.319659 | localhost | Identity added: /var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/work/tmp/ansible.toc372xe (/var/lib/zuul/builds/eb0d2c6ac97041c08632d444f0542ecd/work/tmp/ansible.toc372xe)
2026-01-26 03:07:28.319976 | localhost | ok: Runtime: 0:00:00.007560
2026-01-26 03:07:28.329306 | 
2026-01-26 03:07:28.329453 | TASK [add-fileserver : Remove SSH private key from disk]
2026-01-26 03:07:28.594414 | localhost | ok: Runtime: 0:00:00.008119
2026-01-26 03:07:28.599667 | 
2026-01-26 03:07:28.599749 | TASK [add-fileserver : Add fileserver to inventory]
2026-01-26 03:07:28.647955 | localhost | changed
2026-01-26 03:07:28.652104 | 
2026-01-26 03:07:28.652167 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-01-26 03:07:29.061867 | localhost | changed
2026-01-26 03:07:29.101875 | 
2026-01-26 03:07:29.101973 | PLAY [localhost]
2026-01-26 03:07:29.118873 | 
2026-01-26 03:07:29.118963 | TASK [Generate bulk log download script]
2026-01-26 03:07:29.139674 | localhost | ok
2026-01-26 03:07:29.155554 | 
2026-01-26 03:07:29.155648 | TASK [local-log-download : Check API endpoint is defined]
2026-01-26 03:07:29.195036 | localhost | ok: All assertions passed
2026-01-26 03:07:29.199491 | 
2026-01-26 03:07:29.199552 | TASK [local-log-download : Create download script]
2026-01-26 03:07:29.652298 | localhost -> localhost | changed
2026-01-26 03:07:29.671098 | 
2026-01-26 03:07:29.671243 | TASK [Register quick-download link]
2026-01-26 03:07:29.705972 | localhost | ok
2026-01-26 03:07:29.762256 | 
2026-01-26 03:07:29.762376 | PLAY [logserver.rdoproject.org]
2026-01-26 03:07:29.775253 | 
2026-01-26 03:07:29.775341 | TASK [Set zuul-log-path fact]
2026-01-26 03:07:29.793847 | logserver.rdoproject.org | ok
2026-01-26 03:07:29.806275 | 
2026-01-26 03:07:29.806370 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-01-26 03:07:29.846012 | logserver.rdoproject.org | ok
2026-01-26 03:07:29.857443 | 
2026-01-26 03:07:29.857524 | TASK [upload-logs : Create log directories]
2026-01-26 03:07:30.602383 | logserver.rdoproject.org | changed
2026-01-26 03:07:30.609775 | 
2026-01-26 03:07:30.609917 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-01-26 03:07:30.922168 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.005953
2026-01-26 03:07:30.929894 | 
2026-01-26 03:07:30.929990 | TASK [upload-logs : Upload logs to log server]
2026-01-26 03:07:31.707966 | logserver.rdoproject.org | Output suppressed because no_log was given
2026-01-26 03:07:31.714288 | 
2026-01-26 03:07:31.714424 | LOOP [upload-logs : Compress console log and json output]
2026-01-26 03:07:31.782022 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-26 03:07:31.793191 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-26 03:07:31.810813 | 
2026-01-26 03:07:31.811002 | LOOP [upload-logs : Upload compressed console log and json output]
2026-01-26 03:07:31.862668 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-26 03:07:31.863117 | 
2026-01-26 03:07:31.867210 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-26 03:07:31.876355 | 
2026-01-26 03:07:31.876534 | LOOP [upload-logs : Upload console log and json output]