2025-10-10 00:07:50.303919 | Job console starting...
2025-10-10 00:07:50.318124 | Updating repositories
2025-10-10 00:07:50.343252 | Preparing job workspace
2025-10-10 00:07:55.391426 | Running Ansible setup...
2025-10-10 00:08:00.087233 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-10 00:08:00.741453 | 
2025-10-10 00:08:00.741606 | PLAY [localhost]
2025-10-10 00:08:00.755815 | 
2025-10-10 00:08:00.755940 | TASK [Gathering Facts]
2025-10-10 00:08:01.822500 | localhost | ok
2025-10-10 00:08:01.838803 | 
2025-10-10 00:08:01.838956 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-10 00:08:02.296934 | localhost -> localhost | changed
2025-10-10 00:08:02.303567 | 
2025-10-10 00:08:02.303651 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-10 00:08:03.275775 | localhost -> localhost | changed
2025-10-10 00:08:03.284618 | 
2025-10-10 00:08:03.284690 | TASK [Setup log path fact]
2025-10-10 00:08:03.311833 | localhost | ok
2025-10-10 00:08:03.331288 | 
2025-10-10 00:08:03.331443 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-10 00:08:03.374259 | localhost | ok
2025-10-10 00:08:03.387630 | 
2025-10-10 00:08:03.387832 | TASK [emit-job-header : Print job information]
2025-10-10 00:08:03.420431 | # Job Information
2025-10-10 00:08:03.420624 | Ansible Version: 2.15.12
2025-10-10 00:08:03.420661 | Job: tox-linters
2025-10-10 00:08:03.420692 | Pipeline: check
2025-10-10 00:08:03.420720 | Executor: ze03.softwarefactory-project.io
2025-10-10 00:08:03.420789 | Triggered by: https://review.rdoproject.org/r/c/nfvinfo/+/58414
2025-10-10 00:08:03.420817 | Log URL (when completed): https://logserver.rdoproject.org/5cb/rdoproject.org/5cbd55e9a34d4aa7809325cbb28ef43f/
2025-10-10 00:08:03.420842 | Event ID: 545e973d2d85475d98120a30497c1b87
2025-10-10 00:08:03.426438 | 
2025-10-10 00:08:03.426541 | LOOP [emit-job-header : Print node information]
2025-10-10 00:08:03.535393 | localhost | ok:
2025-10-10 00:08:03.535559 | localhost | # Node Information
2025-10-10 00:08:03.535586 | localhost | Inventory Hostname: cloud-centos-9-stream
2025-10-10 00:08:03.535610 | localhost | Hostname: np0005479196
2025-10-10 00:08:03.535630 | localhost | Username: zuul-worker
2025-10-10 00:08:03.535650 | localhost | Distro: CentOS 9
2025-10-10 00:08:03.535667 | localhost | Provider: vexxhost-nodepool-sf
2025-10-10 00:08:03.535684 | localhost | Region: RegionOne
2025-10-10 00:08:03.535701 | localhost | Label: cloud-centos-9-stream
2025-10-10 00:08:03.535718 | localhost | Product Name: OpenStack Nova
2025-10-10 00:08:03.535772 | localhost | Interface IP: 38.129.56.29
2025-10-10 00:08:03.590650 | 
2025-10-10 00:08:03.590792 | PLAY [all]
2025-10-10 00:08:03.608959 | 
2025-10-10 00:08:03.609045 | TASK [Gather network facts]
2025-10-10 00:08:04.350871 | cloud-centos-9-stream | ok
2025-10-10 00:08:04.388698 | 
2025-10-10 00:08:04.388831 | TASK [include_role : start-zuul-console]
2025-10-10 00:08:04.426163 | cloud-centos-9-stream | ok
2025-10-10 00:08:04.453733 | 
2025-10-10 00:08:04.453960 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-10 00:08:04.874075 | cloud-centos-9-stream | ok
2025-10-10 00:08:04.883324 | 
2025-10-10 00:08:04.883423 | TASK [include_role : add-build-sshkey]
2025-10-10 00:08:04.903175 | cloud-centos-9-stream | ok
2025-10-10 00:08:04.920226 | 
2025-10-10 00:08:04.920335 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-10 00:08:05.220182 | cloud-centos-9-stream -> localhost | ok
2025-10-10 00:08:05.227314 | 
2025-10-10 00:08:05.227435 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-10 00:08:05.254489 | cloud-centos-9-stream | ok
2025-10-10 00:08:05.281156 | cloud-centos-9-stream | included: /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-10 00:08:05.287846 | 
2025-10-10 00:08:05.287938 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-10 00:08:06.090081 | cloud-centos-9-stream -> localhost | Generating public/private rsa key pair.
2025-10-10 00:08:06.090318 | cloud-centos-9-stream -> localhost | Your identification has been saved in /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/work/5cbd55e9a34d4aa7809325cbb28ef43f_id_rsa.
2025-10-10 00:08:06.090353 | cloud-centos-9-stream -> localhost | Your public key has been saved in /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/work/5cbd55e9a34d4aa7809325cbb28ef43f_id_rsa.pub.
2025-10-10 00:08:06.090376 | cloud-centos-9-stream -> localhost | The key fingerprint is:
2025-10-10 00:08:06.090446 | cloud-centos-9-stream -> localhost | SHA256:FNnH5dCuVSsP+5eHGl2LbhosevvEca7hKBEfdx/c2h4 zuul-build-sshkey
2025-10-10 00:08:06.090469 | cloud-centos-9-stream -> localhost | The key's randomart image is:
2025-10-10 00:08:06.090488 | cloud-centos-9-stream -> localhost | +---[RSA 3072]----+
2025-10-10 00:08:06.090506 | cloud-centos-9-stream -> localhost | |        .o ..o.  |
2025-10-10 00:08:06.090525 | cloud-centos-9-stream -> localhost | |        ... oo. .|
2025-10-10 00:08:06.090543 | cloud-centos-9-stream -> localhost | |        .  . .o.o|
2025-10-10 00:08:06.090560 | cloud-centos-9-stream -> localhost | |       o . . +o+.|
2025-10-10 00:08:06.090577 | cloud-centos-9-stream -> localhost | |        S o..+*oo|
2025-10-10 00:08:06.090594 | cloud-centos-9-stream -> localhost | |       . .o =ooEo|
2025-10-10 00:08:06.090610 | cloud-centos-9-stream -> localhost | |        .. *.oo+o|
2025-10-10 00:08:06.090628 | cloud-centos-9-stream -> localhost | |       ...= =o.o+|
2025-10-10 00:08:06.090645 | cloud-centos-9-stream -> localhost | |       .ooo=+o  o|
2025-10-10 00:08:06.090661 | cloud-centos-9-stream -> localhost | +----[SHA256]-----+
2025-10-10 00:08:06.090703 | cloud-centos-9-stream -> localhost | ok: Runtime: 0:00:00.296185
2025-10-10 00:08:06.099351 | 
2025-10-10 00:08:06.099497 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-10 00:08:06.138409 | cloud-centos-9-stream | ok
2025-10-10 00:08:06.152063 | cloud-centos-9-stream | included: /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-10 00:08:06.177825 | 
2025-10-10 00:08:06.177945 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-10 00:08:06.219249 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:06.225444 | 
2025-10-10 00:08:06.225561 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-10 00:08:06.871193 | cloud-centos-9-stream | changed
2025-10-10 00:08:06.877110 | 
2025-10-10 00:08:06.877234 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-10 00:08:07.201579 | cloud-centos-9-stream | ok
2025-10-10 00:08:07.220059 | 
2025-10-10 00:08:07.222258 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-10 00:08:08.308707 | cloud-centos-9-stream | changed
2025-10-10 00:08:08.319428 | 
2025-10-10 00:08:08.319550 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-10 00:08:09.192546 | cloud-centos-9-stream | changed
2025-10-10 00:08:09.216115 | 
2025-10-10 00:08:09.216249 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-10 00:08:09.240386 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:09.247416 | 
2025-10-10 00:08:09.247534 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-10 00:08:09.670129 | cloud-centos-9-stream -> localhost | changed
2025-10-10 00:08:09.702020 | 
2025-10-10 00:08:09.702190 | TASK [add-build-sshkey : Add back temp key]
2025-10-10 00:08:10.017392 | cloud-centos-9-stream -> localhost | Identity added: /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/work/5cbd55e9a34d4aa7809325cbb28ef43f_id_rsa (zuul-build-sshkey)
2025-10-10 00:08:10.017610 | cloud-centos-9-stream -> localhost | ok: Runtime: 0:00:00.009666
2025-10-10 00:08:10.024239 | 
2025-10-10 00:08:10.024340 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-10 00:08:10.425778 | cloud-centos-9-stream | ok
2025-10-10 00:08:10.432043 | 
2025-10-10 00:08:10.432138 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-10 00:08:10.467431 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:10.480136 | 
2025-10-10 00:08:10.480267 | TASK [include_role : validate-host]
2025-10-10 00:08:10.514296 | cloud-centos-9-stream | ok
2025-10-10 00:08:10.545539 | 
2025-10-10 00:08:10.545658 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-10 00:08:10.588513 | cloud-centos-9-stream | ok
2025-10-10 00:08:10.596597 | 
2025-10-10 00:08:10.596697 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-10 00:08:10.858477 | cloud-centos-9-stream -> localhost | ok
2025-10-10 00:08:10.907872 | 
2025-10-10 00:08:10.907993 | TASK [validate-host : Collect information about the host]
2025-10-10 00:08:11.703399 | cloud-centos-9-stream | ok
2025-10-10 00:08:11.720910 | 
2025-10-10 00:08:11.721053 | TASK [validate-host : Sanitize hostname]
2025-10-10 00:08:11.808336 | cloud-centos-9-stream | ok
2025-10-10 00:08:11.817178 | 
2025-10-10 00:08:11.817324 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-10 00:08:12.307355 | cloud-centos-9-stream -> localhost | changed
2025-10-10 00:08:12.314524 | 
2025-10-10 00:08:12.314638 | TASK [validate-host : Collect information about zuul worker]
2025-10-10 00:08:12.785902 | cloud-centos-9-stream | ok
2025-10-10 00:08:12.791866 | 
2025-10-10 00:08:12.792011 | TASK [validate-host : Write out all zuul information for each host]
2025-10-10 00:08:13.266676 | cloud-centos-9-stream -> localhost | changed
2025-10-10 00:08:13.278115 | 
2025-10-10 00:08:13.278224 | TASK [include_role : prepare-workspace-openshift]
2025-10-10 00:08:13.295013 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:13.304695 | 
2025-10-10 00:08:13.305282 | TASK [include_role : remove-zuul-sshkey]
2025-10-10 00:08:13.319949 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:13.328051 | 
2025-10-10 00:08:13.328172 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-10 00:08:13.598433 | cloud-centos-9-stream | ok: "logs"
2025-10-10 00:08:13.598716 | cloud-centos-9-stream | ok: All items complete
2025-10-10 00:08:13.598772 | 
2025-10-10 00:08:13.827484 | cloud-centos-9-stream | ok: "artifacts"
2025-10-10 00:08:14.039545 | cloud-centos-9-stream | ok: "docs"
2025-10-10 00:08:14.057755 | 
2025-10-10 00:08:14.057862 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-10 00:08:14.338242 | cloud-centos-9-stream | changed: "logs"
2025-10-10 00:08:14.580068 | cloud-centos-9-stream | changed: "artifacts"
2025-10-10 00:08:14.851359 | cloud-centos-9-stream | changed: "docs"
2025-10-10 00:08:14.886797 | 
2025-10-10 00:08:14.886934 | PLAY RECAP
2025-10-10 00:08:14.887007 | cloud-centos-9-stream | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-10 00:08:14.887058 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-10 00:08:14.887081 | 
2025-10-10 00:08:15.023386 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-10 00:08:15.024326 | PRE-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master]
2025-10-10 00:08:15.653962 | 
2025-10-10 00:08:15.654089 | PLAY [localhost]
2025-10-10 00:08:15.672557 | 
2025-10-10 00:08:15.672711 | TASK [configure-ssh-config-fips : Ensure ssh config directory]
2025-10-10 00:08:16.082520 | localhost | ok
2025-10-10 00:08:16.088420 | 
2025-10-10 00:08:16.088514 | TASK [configure-ssh-config-fips : Setup ssh config]
2025-10-10 00:08:16.859785 | localhost | changed
2025-10-10 00:08:16.907054 | 
2025-10-10 00:08:16.907180 | PLAY [all]
2025-10-10 00:08:16.939423 | 
2025-10-10 00:08:16.939533 | TASK [include_role : prepare-workspace]
2025-10-10 00:08:16.964062 | cloud-centos-9-stream | ok
2025-10-10 00:08:16.985849 | 
2025-10-10 00:08:16.985972 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-10 00:08:17.406168 | cloud-centos-9-stream | ok
2025-10-10 00:08:17.415493 | 
2025-10-10 00:08:17.415617 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-10 00:08:18.424303 | cloud-centos-9-stream | Output suppressed because no_log was given
2025-10-10 00:08:18.447095 | 
2025-10-10 00:08:18.447235 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-10 00:08:18.753826 | cloud-centos-9-stream | changed: "logs"
2025-10-10 00:08:19.017710 | cloud-centos-9-stream | changed: "artifacts"
2025-10-10 00:08:19.278545 | cloud-centos-9-stream | changed: "docs"
2025-10-10 00:08:19.292495 | 
2025-10-10 00:08:19.292621 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-10 00:08:19.545695 | cloud-centos-9-stream | changed: "logs"
2025-10-10 00:08:19.545926 | cloud-centos-9-stream | changed: All items complete
2025-10-10 00:08:19.545954 | 
2025-10-10 00:08:19.804914 | cloud-centos-9-stream | changed: "artifacts"
2025-10-10 00:08:20.090044 | cloud-centos-9-stream | changed: "docs"
2025-10-10 00:08:20.114322 | 
2025-10-10 00:08:20.114428 | TASK [Check if worker can sudo]
2025-10-10 00:08:20.659089 | cloud-centos-9-stream | ok: Runtime: 0:00:00.067128
2025-10-10 00:08:20.666366 | 
2025-10-10 00:08:20.666498 | TASK [configure-mirrors : Gather needed facts]
2025-10-10 00:08:20.732567 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:20.738634 | 
2025-10-10 00:08:20.738786 | TASK [configure-mirrors : Set up infrastructure mirrors]
2025-10-10 00:08:20.799818 | cloud-centos-9-stream | ok
2025-10-10 00:08:20.809170 | cloud-centos-9-stream | included: /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror.yaml
2025-10-10 00:08:20.815515 | 
2025-10-10 00:08:20.815588 | TASK [configure-mirrors : Remove .pydistutils.cfg configuration in homedir]
2025-10-10 00:08:21.109530 | cloud-centos-9-stream | ok
2025-10-10 00:08:21.128036 | 
2025-10-10 00:08:21.128174 | LOOP [configure-mirrors : Include OS-specific variables]
2025-10-10 00:08:21.197511 | cloud-centos-9-stream | ok: "/var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/vars/CentOS-9.yaml"
2025-10-10 00:08:21.212667 | 
2025-10-10 00:08:21.212802 | TASK [configure-mirrors : Install /etc/pip.conf configuration]
2025-10-10 00:08:22.103128 | cloud-centos-9-stream | changed
2025-10-10 00:08:22.108886 | 
2025-10-10 00:08:22.108981 | LOOP [configure-mirrors : Setup distribution specific packaging mirrors]
2025-10-10 00:08:22.204499 | cloud-centos-9-stream | ok: "/var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml"
2025-10-10 00:08:22.204751 | cloud-centos-9-stream | ok: All items complete
2025-10-10 00:08:22.204785 | 
2025-10-10 00:08:22.272477 | cloud-centos-9-stream | included: /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml
2025-10-10 00:08:22.279575 | 
2025-10-10 00:08:22.279808 | LOOP [configure-mirrors : Install CentOS 9 repository files]
2025-10-10 00:08:23.151200 | cloud-centos-9-stream | changed: "etc/yum.repos.d/centos.repo"
2025-10-10 00:08:24.014828 | cloud-centos-9-stream | changed: "etc/yum.repos.d/centos-addons.repo"
2025-10-10 00:08:24.037907 | 
2025-10-10 00:08:24.038082 | TASK [configure-mirrors : Disable deltrarpm]
2025-10-10 00:08:24.482234 | cloud-centos-9-stream | changed: section and option added
2025-10-10 00:08:24.502911 | 
2025-10-10 00:08:24.503274 | LOOP [configure-mirrors : Update yum/dnf cache]
2025-10-10 00:08:25.440001 | cloud-centos-9-stream | 29 files removed
2025-10-10 00:08:25.440400 | cloud-centos-9-stream | ok: Item: dnf clean all Runtime: 0:00:00.585308
2025-10-10 00:08:25.440502 | cloud-centos-9-stream | changed: All items complete
2025-10-10 00:08:25.440581 | 
2025-10-10 00:08:36.342752 | cloud-centos-9-stream | Loaded plugins: builddep, changelog, config-manager, copr, debug, debuginfo-install, download, generate_completion_cache, groups-manager, needs-restarting, notify-packagekit, playground, repoclosure, repodiff, repograph, repomanage, reposync, system-upgrade
2025-10-10 00:08:36.342963 | cloud-centos-9-stream | DNF version: 4.14.0
2025-10-10 00:08:36.343005 | cloud-centos-9-stream | cachedir: /var/cache/dnf
2025-10-10 00:08:36.343037 | cloud-centos-9-stream | Making cache files for all metadata files.
2025-10-10 00:08:36.343065 | cloud-centos-9-stream | baseos: has expired and will be refreshed.
2025-10-10 00:08:36.343091 | cloud-centos-9-stream | appstream: has expired and will be refreshed.
2025-10-10 00:08:36.343119 | cloud-centos-9-stream | crb: has expired and will be refreshed.
2025-10-10 00:08:36.343147 | cloud-centos-9-stream | extras-common: has expired and will be refreshed.
2025-10-10 00:08:36.343175 | cloud-centos-9-stream | repo: downloading from remote: baseos
2025-10-10 00:08:36.343202 | cloud-centos-9-stream | CentOS Stream 9 - BaseOS                         66 MB/s | 8.8 MB     00:00
2025-10-10 00:08:36.343230 | cloud-centos-9-stream | baseos: using metadata from Wed 08 Oct 2025 09:42:12 AM EDT.
2025-10-10 00:08:36.343257 | cloud-centos-9-stream | repo: downloading from remote: appstream
2025-10-10 00:08:36.343283 | cloud-centos-9-stream | CentOS Stream 9 - AppStream                      84 MB/s |  25 MB     00:00
2025-10-10 00:08:36.343309 | cloud-centos-9-stream | appstream: using metadata from Wed 08 Oct 2025 09:45:45 AM EDT.
2025-10-10 00:08:36.343335 | cloud-centos-9-stream | repo: downloading from remote: crb
2025-10-10 00:08:36.343360 | cloud-centos-9-stream | CentOS Stream 9 - CRB                            33 MB/s | 7.2 MB     00:00
2025-10-10 00:08:36.343385 | cloud-centos-9-stream | crb: using metadata from Wed 08 Oct 2025 09:50:07 AM EDT.
2025-10-10 00:08:36.343411 | cloud-centos-9-stream | repo: downloading from remote: extras-common
2025-10-10 00:08:36.343438 | cloud-centos-9-stream | CentOS Stream 9 - Extras packages               1.2 MB/s |  20 kB     00:00
2025-10-10 00:08:36.343465 | cloud-centos-9-stream | extras-common: using metadata from Mon 15 Sep 2025 02:32:43 PM EDT.
2025-10-10 00:08:36.343492 | cloud-centos-9-stream | Last metadata expiration check: 0:00:01 ago on Thu 09 Oct 2025 08:08:34 PM EDT.
2025-10-10 00:08:36.343519 | cloud-centos-9-stream | User-Agent: constructed: 'libdnf (CentOS Stream 9; generic; Linux.x86_64)'
2025-10-10 00:08:36.343545 | cloud-centos-9-stream | Completion plugin: Generating completion cache...
2025-10-10 00:08:36.343573 | cloud-centos-9-stream | Metadata cache created.
2025-10-10 00:08:36.343614 | cloud-centos-9-stream | ok: Item: dnf makecache -v Runtime: 0:00:10.637753
2025-10-10 00:08:36.370806 | 
2025-10-10 00:08:36.371028 | PLAY RECAP
2025-10-10 00:08:36.371120 | cloud-centos-9-stream | ok: 13 changed: 7 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-10 00:08:36.371195 | localhost | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-10 00:08:36.371231 | 
2025-10-10 00:08:36.514551 | PRE-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master]
2025-10-10 00:08:36.515527 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2025-10-10 00:08:37.160959 | 
2025-10-10 00:08:37.161096 | PLAY [all]
2025-10-10 00:08:37.182913 | 
2025-10-10 00:08:37.183044 | TASK [Install binary dependencies]
2025-10-10 00:08:37.229686 | cloud-centos-9-stream | ok
2025-10-10 00:08:37.250275 | 
2025-10-10 00:08:37.250422 | TASK [bindep : Include find tasks]
2025-10-10 00:08:37.281070 | cloud-centos-9-stream | ok
2025-10-10 00:08:37.292427 | cloud-centos-9-stream | included: /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2025-10-10 00:08:37.299409 | 
2025-10-10 00:08:37.299506 | TASK [bindep : Look for bindep.txt]
2025-10-10 00:08:37.726022 | cloud-centos-9-stream | ok
2025-10-10 00:08:37.747172 | 
2025-10-10 00:08:37.747624 | TASK [bindep : Define bindep_file fact]
2025-10-10 00:08:37.779244 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:37.790654 | 
2025-10-10 00:08:37.791040 | TASK [bindep : Look for other-requirements.txt]
2025-10-10 00:08:38.070777 | cloud-centos-9-stream | ok
2025-10-10 00:08:38.077152 | 
2025-10-10 00:08:38.077291 | TASK [bindep : Define bindep_file fact]
2025-10-10 00:08:38.121874 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:38.130246 | 
2025-10-10 00:08:38.130417 | TASK [bindep : Look for bindep fallback file]
2025-10-10 00:08:38.156262 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:38.165000 | 
2025-10-10 00:08:38.165196 | TASK [bindep : Define bindep_file fact]
2025-10-10 00:08:38.215946 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:38.225577 | 
2025-10-10 00:08:38.225693 | TASK [bindep : Include bindep tasks]
2025-10-10 00:08:38.263625 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:38.269063 | 
2025-10-10 00:08:38.269151 | TASK [bindep : Include install tasks]
2025-10-10 00:08:38.293256 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:38.299233 | 
2025-10-10 00:08:38.299327 | LOOP [bindep : Include package tasks]
2025-10-10 00:08:38.356188 | 
2025-10-10 00:08:38.356408 | TASK [Run test-setup role]
2025-10-10 00:08:38.378817 | cloud-centos-9-stream | ok
2025-10-10 00:08:38.401537 | 
2025-10-10 00:08:38.401670 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2025-10-10 00:08:38.416489 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:38.427678 | 
2025-10-10 00:08:38.427798 | TASK [test-setup : Run tools/test-setup.sh]
2025-10-10 00:08:38.466817 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:38.499138 | 
2025-10-10 00:08:38.499258 | PLAY RECAP
2025-10-10 00:08:38.499309 | cloud-centos-9-stream | ok: 3 changed: 0 unreachable: 0 failed: 0 skipped: 9 rescued: 0 ignored: 0
2025-10-10 00:08:38.499339 | 
2025-10-10 00:08:38.636901 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2025-10-10 00:08:38.637828 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2025-10-10 00:08:39.413211 | 
2025-10-10 00:08:39.413347 | PLAY [all]
2025-10-10 00:08:39.444586 | 
2025-10-10 00:08:39.444774 | TASK [ensure-python : Validate python_version value]
2025-10-10 00:08:39.491059 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:39.501628 | 
2025-10-10 00:08:39.501842 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2025-10-10 00:08:39.542467 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:39.561915 | 
2025-10-10 00:08:39.562064 | TASK [ensure-python : Pull in venv package]
2025-10-10 00:08:39.606281 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:39.613869 | 
2025-10-10 00:08:39.613966 | TASK [ensure-python : Set default RPM package name]
2025-10-10 00:08:39.642401 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:39.648849 | 
2025-10-10 00:08:39.648931 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2025-10-10 00:08:39.684161 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:39.689793 | 
2025-10-10 00:08:39.689864 | TASK [ensure-python : Install RPM package]
2025-10-10 00:08:39.723942 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:39.730632 | 
2025-10-10 00:08:39.730721 | TASK [ensure-python : Install python using pyenv]
2025-10-10 00:08:39.779000 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:39.788981 | 
2025-10-10 00:08:39.789102 | TASK [ensure-python : Activate python using stow]
2025-10-10 00:08:39.817975 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:39.831820 | 
2025-10-10 00:08:39.831899 | TASK [Install pip]
2025-10-10 00:08:39.852253 | cloud-centos-9-stream | ok
2025-10-10 00:08:39.878177 | 
2025-10-10 00:08:39.878284 | TASK [ensure-pip : Check if pip is installed]
2025-10-09 20:08:40.390787 | cloud-centos-9-stream | /usr/bin/pip3
2025-10-09 20:08:40.434168 | cloud-centos-9-stream | /usr/bin/python3: No module named wheel
2025-10-10 00:08:40.919775 | cloud-centos-9-stream | ok: Runtime: 0:00:00.054955
2025-10-10 00:08:40.927087 | 
2025-10-10 00:08:40.927188 | LOOP [ensure-pip : Install pip from packages]
2025-10-10 00:08:40.978139 | cloud-centos-9-stream | ok: "/var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml"
2025-10-10 00:08:40.992189 | cloud-centos-9-stream | included: /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml
2025-10-10 00:08:41.001902 | 
2025-10-10 00:08:41.002015 | TASK [ensure-pip : Install Python 3 pip]
2025-10-10 00:08:43.842632 | cloud-centos-9-stream | changed
2025-10-10 00:08:43.849921 | 
2025-10-10 00:08:43.850014 | TASK [ensure-pip : Check for EPEL repository]
2025-10-10 00:08:43.874862 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:43.883527 | 
2025-10-10 00:08:43.883624 | TASK [ensure-pip : Fail with instructions when EPEL is not installed]
2025-10-10 00:08:43.908243 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:43.917025 | 
2025-10-10 00:08:43.917123 | TASK [ensure-pip : Install Python 2 pip]
2025-10-10 00:08:43.943275 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:43.950973 | 
2025-10-10 00:08:43.951050 | TASK [ensure-pip : Ensure setuptools]
2025-10-10 00:08:43.968268 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:43.977323 | 
2025-10-10 00:08:43.977431 | TASK [ensure-pip : Check for ensurepip module]
2025-10-10 00:08:44.512006 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:44.518485 | 
2025-10-10 00:08:44.518586 | TASK [ensure-pip : Ensure python3-venv]
2025-10-10 00:08:44.552681 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:44.559595 | 
2025-10-10 00:08:44.559749 | TASK [ensure-pip : Install pip from source]
2025-10-10 00:08:44.597420 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:44.603443 | 
2025-10-10 00:08:44.603518 | TASK [ensure-pip : Probe for venv python full path]
2025-10-09 20:08:45.035271 | cloud-centos-9-stream | /usr/bin/python3
2025-10-10 00:08:45.185361 | cloud-centos-9-stream | ok: Runtime: 0:00:00.007338
2025-10-10 00:08:45.196478 | 
2025-10-10 00:08:45.196595 | TASK [ensure-pip : Set host default]
2025-10-10 00:08:45.303695 | cloud-centos-9-stream | ok
2025-10-10 00:08:45.314671 | 
2025-10-10 00:08:45.319621 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2025-10-10 00:08:45.419238 | cloud-centos-9-stream | ok
2025-10-10 00:08:45.443872 | 
2025-10-10 00:08:45.444009 | TASK [ensure-tox : Check if tox is installed]
2025-10-10 00:08:46.013377 | cloud-centos-9-stream | ok: Runtime: 0:00:00.006495
2025-10-10 00:08:46.019090 | 
2025-10-10 00:08:46.019177 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2025-10-10 00:08:46.053970 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:46.060335 | 
2025-10-10 00:08:46.060452 | TASK [ensure-tox : Create local venv]
2025-10-10 00:08:49.152061 | cloud-centos-9-stream | ok: Runtime: 0:00:02.711863
2025-10-10 00:08:49.162417 | 
2025-10-10 00:08:49.162551 | TASK [ensure-tox : Install tox to local venv]
2025-10-09 20:08:49.843202 | 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
2025-10-09 20:08:50.118556 | cloud-centos-9-stream | Collecting tox
2025-10-09 20:08:50.122910 | 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)
2025-10-09 20:08:50.234048 | cloud-centos-9-stream | Collecting platformdirs>=4.3.8
2025-10-09 20:08:50.238163 | 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)
2025-10-09 20:08:50.311050 | cloud-centos-9-stream | Collecting tomli>=2.2.1
2025-10-09 20:08:50.314291 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/77/b8/0135fadc89e73be292b473cb820b4f5a08197779206b33191e801feeae40/tomli-2.3.0-py3-none-any.whl (14 kB)
2025-10-09 20:08:50.377041 | cloud-centos-9-stream | Collecting cachetools>=6.1
2025-10-09 20:08:50.380339 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/6c/56/3124f61d37a7a4e7cc96afc5492c78ba0cb551151e530b54669ddd1436ef/cachetools-6.2.0-py3-none-any.whl (11 kB)
2025-10-09 20:08:50.509562 | cloud-centos-9-stream | Collecting filelock>=3.18
2025-10-09 20:08:50.512578 | 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)
2025-10-09 20:08:50.705592 | cloud-centos-9-stream | Collecting virtualenv>=20.31.2
2025-10-09 20:08:50.709148 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/37/32/8ab08a0cf98bdc8e9fd7522111327e33089da79c7d6b05542626be34cbb8/virtualenv-20.35.1-py3-none-any.whl (6.0 MB)
2025-10-09 20:08:50.975658 | cloud-centos-9-stream | Collecting chardet>=5.2
2025-10-09 20:08:50.979967 | 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)
2025-10-09 20:08:51.158585 | cloud-centos-9-stream | Collecting pluggy>=1.6
2025-10-09 20:08:51.162595 | 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)
2025-10-09 20:08:51.310651 | cloud-centos-9-stream | Collecting packaging>=25
2025-10-09 20:08:51.314571 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/20/12/38679034af332785aac8774540895e234f4d07f7545804097de4b666afd8/packaging-25.0-py3-none-any.whl (66 kB)
2025-10-09 20:08:51.376703 | cloud-centos-9-stream | Collecting pyproject-api>=1.9.1
2025-10-09 20:08:51.380933 | 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)
2025-10-09 20:08:51.562094 | cloud-centos-9-stream | Collecting typing-extensions>=4.14.1
2025-10-09 20:08:51.564871 | 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)
2025-10-09 20:08:51.660129 | cloud-centos-9-stream | Collecting colorama>=0.4.6
2025-10-09 20:08:51.662751 | 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)
2025-10-09 20:08:51.898587 | cloud-centos-9-stream | Collecting distlib<1,>=0.3.7
2025-10-09 20:08:51.902511 | 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)
2025-10-09 20:08:52.051996 | cloud-centos-9-stream | Installing collected packages: typing-extensions, tomli, platformdirs, packaging, filelock, distlib, virtualenv, pyproject-api, pluggy, colorama, chardet, cachetools, tox
2025-10-09 20:08:53.448884 | cloud-centos-9-stream | Successfully installed cachetools-6.2.0 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.19.1 packaging-25.0 platformdirs-4.4.0 pluggy-1.6.0 pyproject-api-1.9.1 tomli-2.3.0 tox-4.30.3 typing-extensions-4.15.0 virtualenv-20.35.1
2025-10-09 20:08:53.568591 | cloud-centos-9-stream | WARNING: You are using pip version 21.3.1; however, version 25.2 is available.
2025-10-09 20:08:53.667238 | cloud-centos-9-stream | You should consider upgrading via the '/home/zuul-worker/.local/tox/bin/python3 -m pip install --upgrade pip' command.
2025-10-10 00:08:53.767484 | cloud-centos-9-stream | ok: Runtime: 0:00:04.108368
2025-10-10 00:08:53.775937 | 
2025-10-10 00:08:53.776153 | TASK [ensure-tox : Export installed tox_executable path]
2025-10-10 00:08:53.811446 | cloud-centos-9-stream | ok
2025-10-10 00:08:53.824826 | 
2025-10-10 00:08:53.825105 | TASK [ensure-tox : Output tox version]
2025-10-09 20:08:54.287914 | 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
2025-10-09 20:08:54.307553 | cloud-centos-9-stream | 4.30.3 from /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/tox/__init__.py
2025-10-10 00:08:54.377854 | cloud-centos-9-stream | ok: Runtime: 0:00:00.232382
2025-10-10 00:08:54.384422 | 
2025-10-10 00:08:54.384535 | TASK [ensure-tox : Make global symlink]
2025-10-10 00:08:54.399958 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:54.429982 | 
2025-10-10 00:08:54.430088 | PLAY RECAP
2025-10-10 00:08:54.430131 | cloud-centos-9-stream | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 17 rescued: 0 ignored: 0
2025-10-10 00:08:54.430152 | 
2025-10-10 00:08:54.555073 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2025-10-10 00:08:54.556590 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master]
2025-10-10 00:08:55.157590 | 
2025-10-10 00:08:55.157822 | PLAY [all]
2025-10-10 00:08:55.181920 | 
2025-10-10 00:08:55.182097 | TASK [revoke-sudo : Check if zuul is sudoer]
2025-10-10 00:08:55.715361 | cloud-centos-9-stream | ok: Runtime: 0:00:00.044378
2025-10-10 00:08:55.726044 | 
2025-10-10 00:08:55.726208 | TASK [revoke-sudo : Remove sudo access for zuul user.]
2025-10-10 00:08:56.283765 | cloud-centos-9-stream | ok: Runtime: 0:00:00.004465
2025-10-10 00:08:56.290171 | 
2025-10-10 00:08:56.290247 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.]
2025-10-09 20:08:56.567241 | cloud-centos-9-stream | sudo: a password is required
2025-10-10 00:08:56.823310 | cloud-centos-9-stream | ok: Runtime: 0:00:00.016632
2025-10-10 00:08:56.836437 | 
2025-10-10 00:08:56.836537 | TASK [tox : Check to see if the constraints file exists]
2025-10-10 00:08:56.871542 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:56.880673 | 
2025-10-10 00:08:56.880847 | TASK [tox : Fail if constraints file is missing]
2025-10-10 00:08:56.916584 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:56.924400 | 
2025-10-10 00:08:56.924504 | TASK [tox : Record file location]
2025-10-10 00:08:56.949386 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:08:56.955720 | 
2025-10-10 00:08:56.955829 | TASK [tox : Install tox siblings]
2025-10-10 00:08:56.986792 | cloud-centos-9-stream | ok
2025-10-10 00:08:57.001651 | cloud-centos-9-stream | included: /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml
2025-10-10 00:08:57.009153 | 
2025-10-10 00:08:57.009252 | TASK [tox : Run tox without tests]
2025-10-09 20:08:57.503466 | cloud-centos-9-stream | ROOT: 154 D setup logging to DEBUG on pid 3240 [tox/report.py:222]
2025-10-09 20:08:57.532314 | cloud-centos-9-stream | linters: 183 D created app data folder /home/zuul-worker/.local/share/virtualenv [virtualenv/app_data/__init__.py:42]
2025-10-09 20:08:57.538696 | cloud-centos-9-stream | linters: 190 I find interpreter for spec PythonSpec(path=/home/zuul-worker/.local/tox/bin/python3) [virtualenv/discovery/builtin.py:100]
2025-10-09 20:08:57.539094 | cloud-centos-9-stream | linters: 190 D filesystem is case-sensitive [virtualenv/discovery/info.py:20]
2025-10-09 20:08:57.539211 | cloud-centos-9-stream | linters: 190 D discover exe for PythonInfo(spec=CPython3.9.23.final.0-64, exe=/home/zuul-worker/.local/tox/bin/python3, platform=linux, version='3.9.23 (main, Aug 19 2025, 00:00:00) \n[GCC 11.5.0 20240719 (Red Hat 11.5.0-11)]', encoding_fs_io=utf-8-utf-8) in /usr [virtualenv/discovery/py_info.py:548]
2025-10-09 20:08:57.540416 | cloud-centos-9-stream | linters: 191 D get interpreter info via cmd: /usr/bin/python3.9 /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/virtualenv/discovery/py_info.py hqG5F4PkfVg7EKcYDnc43TJKGvFHbOdz wAf7ZBpH3s6GMbV7Yx3BSVrpyyiMfWcz [virtualenv/discovery/cached_py_info.py:142]
2025-10-09 20:08:57.597079 | cloud-centos-9-stream | linters: 248 D wrote python info of /usr/bin/python3.9 at /home/zuul-worker/.local/share/virtualenv/py_info/2/36cf16204b8548560b1c020c4e8fb5b57f0e4c58016f52f2d4be01e192833930.json [virtualenv/app_data/via_disk_folder.py:152]
2025-10-09 20:08:57.597292 | cloud-centos-9-stream | linters: 248 I proposed PythonInfo(spec=CPython3.9.23.final.0-64, system=/usr/bin/python3.9, exe=/home/zuul-worker/.local/tox/bin/python3, platform=linux, version='3.9.23 (main, Aug 19 2025, 00:00:00) \n[GCC 11.5.0 20240719 (Red Hat 11.5.0-11)]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:107]
2025-10-09 20:08:57.597368 | cloud-centos-9-stream | linters: 248 D accepted PythonInfo(spec=CPython3.9.23.final.0-64, system=/usr/bin/python3.9, exe=/home/zuul-worker/.local/tox/bin/python3, platform=linux, version='3.9.23 (main, Aug 19 2025, 00:00:00) \n[GCC 11.5.0 20240719 (Red Hat 11.5.0-11)]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:109]
2025-10-09 20:08:57.598925 | cloud-centos-9-stream | linters: 250 D symlink on filesystem does work [virtualenv/info.py:50]
2025-10-09 20:08:57.599069 | cloud-centos-9-stream | linters: 250 D filesystem is case-sensitive [virtualenv/info.py:27]
2025-10-09 20:08:57.624648 | cloud-centos-9-stream | linters: 275 I create virtual environment via CPython3Posix(dest=/home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:52]
2025-10-09 20:08:57.624854 | cloud-centos-9-stream | linters: 276 D create folder /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/bin [virtualenv/util/path/_sync.py:14]
2025-10-09 20:08:57.624977 | cloud-centos-9-stream | linters: 276 D create folder /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages [virtualenv/util/path/_sync.py:14]
2025-10-09 20:08:57.625142 | cloud-centos-9-stream | linters: 276 D create folder /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib64/python3.9/site-packages [virtualenv/util/path/_sync.py:14]
2025-10-09 20:08:57.625318 | cloud-centos-9-stream | linters: 276 D write /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35]
2025-10-09 20:08:57.625432 | cloud-centos-9-stream | linters: 276 D 	home = /usr/bin [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:57.625490 | cloud-centos-9-stream | linters: 276 D 	implementation = CPython [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:57.625542 | cloud-centos-9-stream | linters: 276 D 	version_info = 3.9.23.final.0 [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:57.625595 | cloud-centos-9-stream | linters: 276 D 	virtualenv = 20.35.1 [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:57.625645 | cloud-centos-9-stream | linters: 277 D 	include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:57.625709 | cloud-centos-9-stream | linters: 277 D 	base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:57.625773 | cloud-centos-9-stream | linters: 277 D 	base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:57.625835 | cloud-centos-9-stream | linters: 277 D 	base-executable = /usr/bin/python3.9 [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:57.626186 | cloud-centos-9-stream | linters: 277 D symlink /usr/bin/python3.9 to /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/bin/python [virtualenv/util/path/_sync.py:34]
2025-10-09 20:08:57.626634 | cloud-centos-9-stream | linters: 277 D create virtualenv import hook file /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/_virtualenv.pth [virtualenv/create/via_global_ref/api.py:98]
2025-10-09 20:08:57.626765 | cloud-centos-9-stream | linters: 278 D create /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/_virtualenv.py [virtualenv/create/via_global_ref/api.py:101]
2025-10-09 20:08:57.627168 | cloud-centos-9-stream | linters: 278 D ============================== target debug ============================== [virtualenv/run/session.py:54]
2025-10-09 20:08:57.627370 | cloud-centos-9-stream | linters: 278 D debug via /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/bin/python /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:215]
2025-10-09 20:08:57.653113 | cloud-centos-9-stream | linters: 278 D {
2025-10-09 20:08:57.653563 | cloud-centos-9-stream |   "sys": {
2025-10-09 20:08:57.653579 | cloud-centos-9-stream |     "executable": "/home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/bin/python",
2025-10-09 20:08:57.653595 | cloud-centos-9-stream |     "_base_executable": "/home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/bin/python",
2025-10-09 20:08:57.653604 | cloud-centos-9-stream |     "prefix": "/home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters",
2025-10-09 20:08:57.653612 | cloud-centos-9-stream |     "base_prefix": "/usr",
2025-10-09 20:08:57.653620 | cloud-centos-9-stream |     "real_prefix": null,
2025-10-09 20:08:57.653628 | cloud-centos-9-stream |     "exec_prefix": "/home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters",
2025-10-09 20:08:57.653636 | cloud-centos-9-stream |     "base_exec_prefix": "/usr",
2025-10-09 20:08:57.653644 | cloud-centos-9-stream |     "path": [
2025-10-09 20:08:57.653652 | cloud-centos-9-stream |       "/usr/lib64/python39.zip",
2025-10-09 20:08:57.653660 | cloud-centos-9-stream |       "/usr/lib64/python3.9",
2025-10-09 20:08:57.653668 | cloud-centos-9-stream |       "/usr/lib64/python3.9/lib-dynload",
2025-10-09 20:08:57.653677 | cloud-centos-9-stream |       "/home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib64/python3.9/site-packages",
2025-10-09 20:08:57.653685 | cloud-centos-9-stream |       "/home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages"
2025-10-09 20:08:57.653693 | cloud-centos-9-stream |     ],
2025-10-09 20:08:57.653700 | cloud-centos-9-stream |     "meta_path": [
2025-10-09 20:08:57.653708 | cloud-centos-9-stream |       "<class '_virtualenv._Finder'>",
2025-10-09 20:08:57.653716 | cloud-centos-9-stream |       "<class '_frozen_importlib.BuiltinImporter'>",
2025-10-09 20:08:57.653723 | cloud-centos-9-stream |       "<class '_frozen_importlib.FrozenImporter'>",
2025-10-09 20:08:57.653731 | cloud-centos-9-stream |       "<class '_frozen_importlib_external.PathFinder'>"
2025-10-09 20:08:57.653739 | cloud-centos-9-stream |     ],
2025-10-09 20:08:57.653749 | cloud-centos-9-stream |     "fs_encoding": "utf-8",
2025-10-09 20:08:57.653757 | cloud-centos-9-stream |     "io_encoding": "utf-8"
2025-10-09 20:08:57.653765 | cloud-centos-9-stream |   },
2025-10-09 20:08:57.653773 | cloud-centos-9-stream |   "version": "3.9.23 (main, Aug 19 2025, 00:00:00) \n[GCC 11.5.0 20240719 (Red Hat 11.5.0-11)]",
2025-10-09 20:08:57.653781 | cloud-centos-9-stream |   "makefile_filename": "/usr/lib64/python3.9/config-3.9-x86_64-linux-gnu/Makefile",
2025-10-09 20:08:57.653789 | cloud-centos-9-stream |   "os": "<module 'os' from '/usr/lib64/python3.9/os.py'>",
2025-10-09 20:08:57.653796 | cloud-centos-9-stream |   "site": "<module 'site' from '/usr/lib64/python3.9/site.py'>",
2025-10-09 20:08:57.653804 | cloud-centos-9-stream |   "datetime": "<module 'datetime' from '/usr/lib64/python3.9/datetime.py'>",
2025-10-09 20:08:57.653812 | cloud-centos-9-stream |   "math": "<module 'math' from '/usr/lib64/python3.9/lib-dynload/math.cpython-39-x86_64-linux-gnu.so'>",
2025-10-09 20:08:57.653820 | cloud-centos-9-stream |   "json": "<module 'json' from '/usr/lib64/python3.9/json/__init__.py'>"
2025-10-09 20:08:57.653827 | cloud-centos-9-stream | } [virtualenv/run/session.py:55]
2025-10-09 20:08:57.653857 | cloud-centos-9-stream | linters: 304 I add seed packages via FromAppData(download=False, pip=bundle, setuptools=bundle, via=copy, app_data_dir=/home/zuul-worker/.local/share/virtualenv) [virtualenv/run/session.py:59]
2025-10-09 20:08:57.655628 | cloud-centos-9-stream | linters: 306 D install pip from wheel /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/virtualenv/seed/wheels/embed/pip-25.2-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51]
2025-10-09 20:08:57.656471 | cloud-centos-9-stream | linters: 307 D install setuptools from wheel /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/virtualenv/seed/wheels/embed/setuptools-80.9.0-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51]
2025-10-09 20:08:57.657529 | cloud-centos-9-stream | linters: 308 D build install image for pip-25.2-py3-none-any.whl to /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/pip-25.2-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49]
2025-10-09 20:08:57.657829 | cloud-centos-9-stream | linters: 309 D build install image for setuptools-80.9.0-py3-none-any.whl to /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49]
2025-10-09 20:08:57.853659 | cloud-centos-9-stream | linters: 504 D copy /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/distutils-precedence.pth to /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:42]
2025-10-09 20:08:57.854467 | cloud-centos-9-stream | linters: 505 D copy directory /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/_distutils_hack to /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:42]
2025-10-09 20:08:57.856218 | cloud-centos-9-stream | linters: 507 D copy directory /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/pkg_resources to /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/pkg_resources [virtualenv/util/path/_sync.py:42]
2025-10-09 20:08:57.869035 | cloud-centos-9-stream | linters: 520 D copy directory /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools to /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/setuptools [virtualenv/util/path/_sync.py:42]
2025-10-09 20:08:57.879558 | cloud-centos-9-stream | linters: 530 D copy directory /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/pip-25.2-py3-none-any/pip to /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/pip [virtualenv/util/path/_sync.py:42]
2025-10-09 20:08:58.042858 | cloud-centos-9-stream | linters: 694 D copy directory /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/pip-25.2-py3-none-any/pip-25.2.dist-info to /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/pip-25.2.dist-info [virtualenv/util/path/_sync.py:42]
2025-10-09 20:08:58.053034 | cloud-centos-9-stream | linters: 704 D copy directory /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools-80.9.0.dist-info to /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/setuptools-80.9.0.dist-info [virtualenv/util/path/_sync.py:42]
2025-10-09 20:08:58.055915 | cloud-centos-9-stream | linters: 707 D copy /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools-80.9.0.virtualenv to /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/setuptools-80.9.0.virtualenv [virtualenv/util/path/_sync.py:42]
2025-10-09 20:08:58.056242 | cloud-centos-9-stream | linters: 707 D generated console scripts  [virtualenv/seed/embed/via_app_data/pip_install/base.py:45]
2025-10-09 20:08:58.057876 | cloud-centos-9-stream | linters: 709 D copy /home/zuul-worker/.local/share/virtualenv/wheel/3.9/image/1/CopyPipInstall/pip-25.2-py3-none-any/pip-25.2.virtualenv to /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/lib/python3.9/site-packages/pip-25.2.virtualenv [virtualenv/util/path/_sync.py:42]
2025-10-09 20:08:58.058576 | cloud-centos-9-stream | linters: 709 D generated console scripts pip3 pip3.9 pip-3.9 pip [virtualenv/seed/embed/via_app_data/pip_install/base.py:45]
2025-10-09 20:08:58.058953 | cloud-centos-9-stream | linters: 710 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65]
2025-10-09 20:08:58.075971 | cloud-centos-9-stream | linters: 727 D write /home/zuul-worker/src/review.rdoproject.org/nfvinfo/.tox/linters/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35]
2025-10-09 20:08:58.076045 | cloud-centos-9-stream | linters: 727 D 	home = /usr/bin [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:58.076093 | cloud-centos-9-stream | linters: 727 D 	implementation = CPython [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:58.076138 | cloud-centos-9-stream | linters: 727 D 	version_info = 3.9.23.final.0 [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:58.076185 | cloud-centos-9-stream | linters: 727 D 	virtualenv = 20.35.1 [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:58.076231 | cloud-centos-9-stream | linters: 727 D 	include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:58.076291 | cloud-centos-9-stream | linters: 727 D 	base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:58.076345 | cloud-centos-9-stream | linters: 727 D 	base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:58.076411 | cloud-centos-9-stream | linters: 727 D 	base-executable = /usr/bin/python3.9 [virtualenv/create/pyenv_cfg.py:40]
2025-10-09 20:08:58.079053 | cloud-centos-9-stream | linters: 730 W install_deps> python -I -m pip install yamllint [tox/tox_env/api.py:463]
2025-10-09 20:08:58.880118 | 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
2025-10-09 20:08:59.321871 | cloud-centos-9-stream | Collecting yamllint
2025-10-09 20:08:59.325434 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/dd/b9/be7a4cfdf47e03785f657f94daea8123e838d817be76c684298305bd789f/yamllint-1.37.1-py3-none-any.whl.metadata (4.3 kB)
2025-10-09 20:08:59.506817 | cloud-centos-9-stream | Collecting pathspec>=0.5.3 (from yamllint)
2025-10-09 20:08:59.511443 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/cc/20/ff623b09d963f88bfde16306a54e12ee5ea43e9b597108672ff3a408aad6/pathspec-0.12.1-py3-none-any.whl.metadata (21 kB)
2025-10-09 20:08:59.771768 | cloud-centos-9-stream | Collecting pyyaml (from yamllint)
2025-10-09 20:08:59.774177 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/73/b9/793686b2d54b531203c160ef12bec60228a0109c79bae6c1277961026770/pyyaml-6.0.3-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.4 kB)
2025-10-09 20:08:59.919859 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/dd/b9/be7a4cfdf47e03785f657f94daea8123e838d817be76c684298305bd789f/yamllint-1.37.1-py3-none-any.whl (68 kB)
2025-10-09 20:08:59.969703 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/cc/20/ff623b09d963f88bfde16306a54e12ee5ea43e9b597108672ff3a408aad6/pathspec-0.12.1-py3-none-any.whl (31 kB)
2025-10-09 20:09:00.011256 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/73/b9/793686b2d54b531203c160ef12bec60228a0109c79bae6c1277961026770/pyyaml-6.0.3-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (750 kB)
2025-10-09 20:09:00.055929 | cloud-centos-9-stream |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 750.8/750.8 kB 12.6 MB/s  0:00:00
2025-10-09 20:09:00.090106 | cloud-centos-9-stream | Installing collected packages: pyyaml, pathspec, yamllint
2025-10-09 20:09:00.495319 | cloud-centos-9-stream |
2025-10-09 20:09:00.498470 | cloud-centos-9-stream | Successfully installed pathspec-0.12.1 pyyaml-6.0.3 yamllint-1.37.1
2025-10-09 20:09:00.579213 | cloud-centos-9-stream | linters: 3230 I exit 0 (2.50 seconds) /home/zuul-worker/src/review.rdoproject.org/nfvinfo> python -I -m pip install yamllint pid=3253 [tox/execute/api.py:294]
2025-10-09 20:09:00.580753 | cloud-centos-9-stream |   linters: OK (3.05 seconds)
2025-10-09 20:09:00.623625 | cloud-centos-9-stream |   congratulations :) (3.08 seconds)
2025-10-10 00:09:01.060113 | cloud-centos-9-stream | ok: Runtime: 0:00:03.324368
2025-10-10 00:09:01.069819 | 
2025-10-10 00:09:01.069935 | TASK [tox : Create a tempfile to save tox showconfig]
2025-10-10 00:09:01.568319 | cloud-centos-9-stream | changed
2025-10-10 00:09:01.576203 | 
2025-10-10 00:09:01.576313 | TASK [tox : Get tox envlist config]
2025-10-10 00:09:02.617244 | cloud-centos-9-stream | ok: Runtime: 0:00:00.320265
2025-10-10 00:09:02.627161 | 
2025-10-10 00:09:02.627562 | TASK [tox : Install any sibling python packages]
2025-10-10 00:09:03.022474 | cloud-centos-9-stream | ok: No setup.cfg, no action needed
2025-10-10 00:09:03.034619 | 
2025-10-10 00:09:03.034768 | TASK [tox : Remove tempfile]
2025-10-10 00:09:03.372544 | cloud-centos-9-stream | changed
2025-10-10 00:09:03.381862 | 
2025-10-10 00:09:03.381978 | TASK [tox : Emit tox command]
2025-10-10 00:09:03.422958 | /home/zuul-worker/.local/tox/bin/tox   -elinters  -vv --skip-missing-interpreters=false
2025-10-10 00:09:03.428243 | 
2025-10-10 00:09:03.428333 | TASK [tox : Run tox]
2025-10-09 20:09:03.910376 | cloud-centos-9-stream | ROOT: 200 D setup logging to DEBUG on pid 3402 [tox/report.py:222]
2025-10-09 20:09:03.947759 | cloud-centos-9-stream | linters: 238 I find interpreter for spec PythonSpec(path=/home/zuul-worker/.local/tox/bin/python3) [virtualenv/discovery/builtin.py:100]
2025-10-09 20:09:03.948213 | cloud-centos-9-stream | linters: 238 D filesystem is case-sensitive [virtualenv/discovery/info.py:20]
2025-10-09 20:09:03.948368 | cloud-centos-9-stream | linters: 238 D discover exe for PythonInfo(spec=CPython3.9.23.final.0-64, exe=/home/zuul-worker/.local/tox/bin/python3, platform=linux, version='3.9.23 (main, Aug 19 2025, 00:00:00) \n[GCC 11.5.0 20240719 (Red Hat 11.5.0-11)]', encoding_fs_io=utf-8-utf-8) in /usr [virtualenv/discovery/py_info.py:548]
2025-10-09 20:09:03.949378 | cloud-centos-9-stream | linters: 239 D got python info of /usr/bin/python3.9 from /home/zuul-worker/.local/share/virtualenv/py_info/2/36cf16204b8548560b1c020c4e8fb5b57f0e4c58016f52f2d4be01e192833930.json [virtualenv/app_data/via_disk_folder.py:132]
2025-10-09 20:09:03.950217 | cloud-centos-9-stream | linters: 240 I proposed PythonInfo(spec=CPython3.9.23.final.0-64, system=/usr/bin/python3.9, exe=/home/zuul-worker/.local/tox/bin/python3, platform=linux, version='3.9.23 (main, Aug 19 2025, 00:00:00) \n[GCC 11.5.0 20240719 (Red Hat 11.5.0-11)]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:107]
2025-10-09 20:09:03.950294 | cloud-centos-9-stream | linters: 240 D accepted PythonInfo(spec=CPython3.9.23.final.0-64, system=/usr/bin/python3.9, exe=/home/zuul-worker/.local/tox/bin/python3, platform=linux, version='3.9.23 (main, Aug 19 2025, 00:00:00) \n[GCC 11.5.0 20240719 (Red Hat 11.5.0-11)]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:109]
2025-10-09 20:09:03.951153 | cloud-centos-9-stream | linters: 241 D symlink on filesystem does work [virtualenv/info.py:50]
2025-10-09 20:09:03.951303 | cloud-centos-9-stream | linters: 241 D filesystem is case-sensitive [virtualenv/info.py:27]
2025-10-09 20:09:03.977102 | cloud-centos-9-stream | linters: 267 W commands[0]> python -m yamllint -f parsable --strict . [tox/tox_env/api.py:463]
2025-10-09 20:09:04.177073 | cloud-centos-9-stream | linters: 467 I exit 0 (0.20 seconds) /home/zuul-worker/src/review.rdoproject.org/nfvinfo> python -m yamllint -f parsable --strict . pid=3409 [tox/execute/api.py:294]
2025-10-09 20:09:04.178182 | cloud-centos-9-stream |   linters: OK (0.24=setup[0.04]+cmd[0.20] seconds)
2025-10-09 20:09:04.220332 | cloud-centos-9-stream |   congratulations :) (0.27 seconds)
2025-10-10 00:09:04.464059 | cloud-centos-9-stream | ok: Runtime: 0:00:00.540236
2025-10-10 00:09:04.471388 | 
2025-10-10 00:09:04.471483 | TASK [tox : Look for output]
2025-10-10 00:09:04.994609 | cloud-centos-9-stream | ok
2025-10-10 00:09:05.000534 | 
2025-10-10 00:09:05.000660 | TASK [tox : Return file comments to Zuul]
2025-10-10 00:09:05.091139 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:05.145748 | 
2025-10-10 00:09:05.145847 | PLAY RECAP
2025-10-10 00:09:05.145891 | cloud-centos-9-stream | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0
2025-10-10 00:09:05.145911 | 
2025-10-10 00:09:05.303618 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master]
2025-10-10 00:09:05.305564 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2025-10-10 00:09:06.086832 | 
2025-10-10 00:09:06.086989 | PLAY [all]
2025-10-10 00:09:06.114010 | 
2025-10-10 00:09:06.114156 | TASK [fetch-tox-output : Set tox log path for multiple nodes]
2025-10-10 00:09:06.169876 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:06.176719 | 
2025-10-10 00:09:06.177047 | TASK [fetch-tox-output : Set tox log path for single node]
2025-10-10 00:09:06.216696 | cloud-centos-9-stream | ok
2025-10-10 00:09:06.225240 | 
2025-10-10 00:09:06.225356 | TASK [fetch-tox-output : Ensure local tox dir]
2025-10-10 00:09:06.678466 | cloud-centos-9-stream -> localhost | changed
2025-10-10 00:09:06.686850 | 
2025-10-10 00:09:06.686990 | TASK [fetch-tox-output : Ensure zuul-output tox dir]
2025-10-10 00:09:06.733080 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:06.740578 | 
2025-10-10 00:09:06.740707 | TASK [fetch-tox-output : Set envlist fact]
2025-10-10 00:09:06.785583 | cloud-centos-9-stream | ok
2025-10-10 00:09:06.797340 | 
2025-10-10 00:09:06.797482 | TASK [fetch-tox-output : Get tox version]
2025-10-09 20:09:07.477193 | 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
2025-10-09 20:09:07.496775 | cloud-centos-9-stream | 4.30.3 from /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/tox/__init__.py
2025-10-10 00:09:07.849001 | cloud-centos-9-stream | ok: Runtime: 0:00:00.247200
2025-10-10 00:09:07.855757 | 
2025-10-10 00:09:07.855896 | TASK [fetch-tox-output : Find all default environments]
2025-10-10 00:09:08.403480 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:08.409573 | 
2025-10-10 00:09:08.409657 | TASK [fetch-tox-output : Set envlist fact]
2025-10-10 00:09:08.443528 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:08.450150 | 
2025-10-10 00:09:08.450231 | TASK [fetch-tox-output : Find all default environments]
2025-10-10 00:09:09.002745 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:09.023011 | 
2025-10-10 00:09:09.023162 | TASK [fetch-tox-output : Set envlist fact]
2025-10-10 00:09:09.067721 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:09.076147 | 
2025-10-10 00:09:09.076242 | LOOP [fetch-tox-output : Copy tox logs]
2025-10-10 00:09:09.162714 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:09.171609 | 
2025-10-10 00:09:09.171912 | LOOP [fetch-tox-output : Collect tox logs]
2025-10-10 00:09:10.173316 | cloud-centos-9-stream | changed:
2025-10-10 00:09:10.173475 | cloud-centos-9-stream | cd+++++++++ ./
2025-10-10 00:09:10.173504 | cloud-centos-9-stream | >f+++++++++ 1-commands[0].log
2025-10-10 00:09:10.173529 | 
2025-10-10 00:09:10.209121 | 
2025-10-10 00:09:10.209207 | PLAY RECAP
2025-10-10 00:09:10.209251 | cloud-centos-9-stream | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0
2025-10-10 00:09:10.209273 | 
2025-10-10 00:09:10.338580 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2025-10-10 00:09:10.339847 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2025-10-10 00:09:10.978989 | 
2025-10-10 00:09:10.979113 | PLAY [all]
2025-10-10 00:09:11.003033 | 
2025-10-10 00:09:11.003257 | TASK [fetch-subunit-output : Find stestr or testr executable]
2025-10-10 00:09:11.331357 | cloud-centos-9-stream | changed: non-zero return code
2025-10-10 00:09:11.336645 | 
2025-10-10 00:09:11.336718 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2025-10-10 00:09:11.360742 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:11.366486 | 
2025-10-10 00:09:11.366559 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2025-10-10 00:09:11.400239 | 
2025-10-10 00:09:11.400523 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2025-10-10 00:09:11.434071 | 
2025-10-10 00:09:11.434266 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2025-10-10 00:09:11.449297 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:11.458245 | 
2025-10-10 00:09:11.458499 | LOOP [fetch-subunit-output : Generate subunit file]
2025-10-10 00:09:11.490692 | 
2025-10-10 00:09:11.490906 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2025-10-10 00:09:11.517756 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:11.525460 | 
2025-10-10 00:09:11.525564 | TASK [fetch-subunit-output : Remove the temporary file]
2025-10-10 00:09:11.550905 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:11.558782 | 
2025-10-10 00:09:11.558887 | TASK [fetch-subunit-output : Process and fetch subunit results]
2025-10-10 00:09:11.573400 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:11.611239 | 
2025-10-10 00:09:11.611369 | PLAY RECAP
2025-10-10 00:09:11.611446 | cloud-centos-9-stream | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2025-10-10 00:09:11.611481 | 
2025-10-10 00:09:11.728557 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2025-10-10 00:09:11.729658 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-10 00:09:12.464961 | 
2025-10-10 00:09:12.465082 | PLAY [all]
2025-10-10 00:09:12.484182 | 
2025-10-10 00:09:12.484268 | TASK [include_role : fetch-output]
2025-10-10 00:09:12.534109 | cloud-centos-9-stream | ok
2025-10-10 00:09:12.551167 | 
2025-10-10 00:09:12.551261 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-10 00:09:12.595657 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:12.601503 | 
2025-10-10 00:09:12.601573 | TASK [fetch-output : Set log path for single node]
2025-10-10 00:09:12.639903 | cloud-centos-9-stream | ok
2025-10-10 00:09:12.645305 | 
2025-10-10 00:09:12.645388 | LOOP [fetch-output : Ensure local output dirs]
2025-10-10 00:09:13.114654 | cloud-centos-9-stream -> localhost | ok: "/var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/work/logs"
2025-10-10 00:09:13.359198 | cloud-centos-9-stream -> localhost | changed: "/var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/work/artifacts"
2025-10-10 00:09:13.603273 | cloud-centos-9-stream -> localhost | changed: "/var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/work/docs"
2025-10-10 00:09:13.622213 | 
2025-10-10 00:09:13.622450 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-10 00:09:14.321103 | cloud-centos-9-stream | changed: .d..t...... ./
2025-10-10 00:09:14.321360 | cloud-centos-9-stream | changed: All items complete
2025-10-10 00:09:14.321396 | 
2025-10-10 00:09:14.803432 | cloud-centos-9-stream | changed: .d..t...... ./
2025-10-10 00:09:15.311099 | cloud-centos-9-stream | changed: .d..t...... ./
2025-10-10 00:09:15.327425 | 
2025-10-10 00:09:15.327553 | TASK [include_role : fetch-output-openshift]
2025-10-10 00:09:15.351553 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-10 00:09:15.360702 | 
2025-10-10 00:09:15.360840 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-10 00:09:15.783366 | cloud-centos-9-stream -> localhost | ok: Item: artifacts Runtime: 0:00:00.014771
2025-10-10 00:09:16.051383 | cloud-centos-9-stream -> localhost | ok: Item: docs Runtime: 0:00:00.012555
2025-10-10 00:09:16.117604 | 
2025-10-10 00:09:16.117971 | PLAY [all]
2025-10-10 00:09:16.150819 | 
2025-10-10 00:09:16.151023 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-10 00:09:16.628343 | cloud-centos-9-stream | changed
2025-10-10 00:09:16.670653 | 
2025-10-10 00:09:16.670786 | PLAY RECAP
2025-10-10 00:09:16.670844 | cloud-centos-9-stream | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-10 00:09:16.670874 | 
2025-10-10 00:09:16.791571 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-10 00:09:16.792520 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-10 00:09:17.433372 | 
2025-10-10 00:09:17.433521 | PLAY [localhost]
2025-10-10 00:09:17.453033 | 
2025-10-10 00:09:17.453140 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-10 00:09:17.969471 | localhost | changed
2025-10-10 00:09:17.982968 | 
2025-10-10 00:09:17.983156 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-10 00:09:18.014863 | localhost | ok
2025-10-10 00:09:18.027166 | 
2025-10-10 00:09:18.027312 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-10 00:09:18.424092 | localhost | changed
2025-10-10 00:09:18.430158 | 
2025-10-10 00:09:18.430258 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-10 00:09:19.123444 | localhost | changed
2025-10-10 00:09:19.129238 | 
2025-10-10 00:09:19.129312 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-10 00:09:19.592063 | localhost | Identity added: /var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/work/tmp/ansible.ovs2g0we (/var/lib/zuul/builds/5cbd55e9a34d4aa7809325cbb28ef43f/work/tmp/ansible.ovs2g0we)
2025-10-10 00:09:19.592394 | localhost | ok: Runtime: 0:00:00.009392
2025-10-10 00:09:19.605186 | 
2025-10-10 00:09:19.605571 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-10 00:09:19.914057 | localhost | ok: Runtime: 0:00:00.006342
2025-10-10 00:09:19.919205 | 
2025-10-10 00:09:19.919310 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-10 00:09:20.002505 | localhost | changed
2025-10-10 00:09:20.013146 | 
2025-10-10 00:09:20.013363 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-10 00:09:20.467275 | localhost | changed
2025-10-10 00:09:20.488111 | 
2025-10-10 00:09:20.488185 | PLAY [localhost]
2025-10-10 00:09:20.501349 | 
2025-10-10 00:09:20.501411 | TASK [Generate bulk log download script]
2025-10-10 00:09:20.526565 | localhost | ok
2025-10-10 00:09:20.543211 | 
2025-10-10 00:09:20.543305 | TASK [local-log-download : Check API endpoint is defined]
2025-10-10 00:09:20.574399 | localhost | ok: All assertions passed
2025-10-10 00:09:20.580487 | 
2025-10-10 00:09:20.580571 | TASK [local-log-download : Create download script]
2025-10-10 00:09:21.034138 | localhost -> localhost | changed
2025-10-10 00:09:21.044421 | 
2025-10-10 00:09:21.044543 | TASK [Register quick-download link]
2025-10-10 00:09:21.063082 | localhost | ok
2025-10-10 00:09:21.108048 | 
2025-10-10 00:09:21.108149 | PLAY [logserver.rdoproject.org]
2025-10-10 00:09:21.118214 | 
2025-10-10 00:09:21.118303 | TASK [Set zuul-log-path fact]
2025-10-10 00:09:21.134666 | logserver.rdoproject.org | ok
2025-10-10 00:09:21.144299 | 
2025-10-10 00:09:21.144405 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-10 00:09:21.171628 | logserver.rdoproject.org | ok
2025-10-10 00:09:21.177471 | 
2025-10-10 00:09:21.177553 | TASK [upload-logs : Create log directories]
2025-10-10 00:09:22.044869 | logserver.rdoproject.org | changed
2025-10-10 00:09:22.050254 | 
2025-10-10 00:09:22.050405 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-10 00:09:22.363248 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.009755
2025-10-10 00:09:22.372910 | 
2025-10-10 00:09:22.373050 | TASK [upload-logs : Upload logs to log server]
2025-10-10 00:09:23.119122 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-10 00:09:23.124868 | 
2025-10-10 00:09:23.124992 | LOOP [upload-logs : Compress console log and json output]
2025-10-10 00:09:23.182013 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-10 00:09:23.195187 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-10 00:09:23.208188 | 
2025-10-10 00:09:23.208334 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-10 00:09:23.255320 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-10 00:09:23.256012 | 
2025-10-10 00:09:23.259358 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-10 00:09:23.275147 | 
2025-10-10 00:09:23.275329 | LOOP [upload-logs : Upload console log and json output]