2025-10-09 00:06:01.816400 | Job console starting...
2025-10-09 00:06:01.836332 | Updating repositories
2025-10-09 00:06:01.857362 | Preparing job workspace
2025-10-09 00:06:04.966808 | Running Ansible setup...
2025-10-09 00:06:10.638602 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-09 00:06:11.375205 | 
2025-10-09 00:06:11.375334 | PLAY [localhost]
2025-10-09 00:06:11.385267 | 
2025-10-09 00:06:11.385357 | TASK [Gathering Facts]
2025-10-09 00:06:12.388014 | localhost | ok
2025-10-09 00:06:12.401797 | 
2025-10-09 00:06:12.401912 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-09 00:06:12.782593 | localhost -> localhost | changed
2025-10-09 00:06:12.790313 | 
2025-10-09 00:06:12.790430 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-09 00:06:13.680784 | localhost -> localhost | changed
2025-10-09 00:06:13.689768 | 
2025-10-09 00:06:13.689840 | TASK [Setup log path fact]
2025-10-09 00:06:13.728764 | localhost | ok
2025-10-09 00:06:13.742179 | 
2025-10-09 00:06:13.742326 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-09 00:06:13.771164 | localhost | ok
2025-10-09 00:06:13.780440 | 
2025-10-09 00:06:13.780554 | TASK [emit-job-header : Print job information]
2025-10-09 00:06:13.809760 | # Job Information
2025-10-09 00:06:13.809921 | Ansible Version: 2.15.12
2025-10-09 00:06:13.809948 | Job: tox-py39
2025-10-09 00:06:13.809968 | Pipeline: check
2025-10-09 00:06:13.809986 | Executor: ze03.softwarefactory-project.io
2025-10-09 00:06:13.810004 | Triggered by: https://review.rdoproject.org/r/c/rdoinfo/+/58331
2025-10-09 00:06:13.810022 | Log URL (when completed): https://logserver.rdoproject.org/643/rdoproject.org/6435e012013d4e60983dd7f5a5079574/
2025-10-09 00:06:13.810040 | Event ID: ce3d0cf56ea84c9c9092a66780372f13
2025-10-09 00:06:13.814510 | 
2025-10-09 00:06:13.814577 | LOOP [emit-job-header : Print node information]
2025-10-09 00:06:13.928933 | localhost | ok:
2025-10-09 00:06:13.929106 | localhost | # Node Information
2025-10-09 00:06:13.929141 | localhost | Inventory Hostname: cloud-centos-9-stream
2025-10-09 00:06:13.929173 | localhost | Hostname: np0005477895
2025-10-09 00:06:13.929198 | localhost | Username: zuul-worker
2025-10-09 00:06:13.929225 | localhost | Distro: CentOS 9
2025-10-09 00:06:13.929251 | localhost | Provider: vexxhost-nodepool-sf
2025-10-09 00:06:13.929273 | localhost | Region: RegionOne
2025-10-09 00:06:13.929295 | localhost | Label: cloud-centos-9-stream
2025-10-09 00:06:13.929335 | localhost | Product Name: OpenStack Nova
2025-10-09 00:06:13.929357 | localhost | Interface IP: 38.102.83.236
2025-10-09 00:06:13.970138 | 
2025-10-09 00:06:13.970230 | PLAY [all]
2025-10-09 00:06:13.977557 | 
2025-10-09 00:06:13.977628 | TASK [Gather network facts]
2025-10-09 00:06:14.606891 | cloud-centos-9-stream | ok
2025-10-09 00:06:14.640460 | 
2025-10-09 00:06:14.640584 | TASK [include_role : start-zuul-console]
2025-10-09 00:06:14.671673 | cloud-centos-9-stream | ok
2025-10-09 00:06:14.693511 | 
2025-10-09 00:06:14.693670 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-09 00:06:15.172183 | cloud-centos-9-stream | ok
2025-10-09 00:06:15.195580 | 
2025-10-09 00:06:15.195710 | TASK [include_role : add-build-sshkey]
2025-10-09 00:06:15.224562 | cloud-centos-9-stream | ok
2025-10-09 00:06:15.238807 | 
2025-10-09 00:06:15.238931 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-09 00:06:15.486877 | cloud-centos-9-stream -> localhost | ok
2025-10-09 00:06:15.492906 | 
2025-10-09 00:06:15.493007 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-09 00:06:15.513524 | cloud-centos-9-stream | ok
2025-10-09 00:06:15.527553 | cloud-centos-9-stream | included: /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-09 00:06:15.533932 | 
2025-10-09 00:06:15.534006 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-09 00:06:16.078537 | cloud-centos-9-stream -> localhost | Generating public/private rsa key pair.
2025-10-09 00:06:16.078788 | cloud-centos-9-stream -> localhost | Your identification has been saved in /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/work/6435e012013d4e60983dd7f5a5079574_id_rsa.
2025-10-09 00:06:16.078831 | cloud-centos-9-stream -> localhost | Your public key has been saved in /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/work/6435e012013d4e60983dd7f5a5079574_id_rsa.pub.
2025-10-09 00:06:16.078863 | cloud-centos-9-stream -> localhost | The key fingerprint is:
2025-10-09 00:06:16.078891 | cloud-centos-9-stream -> localhost | SHA256:aeOu8erO7tH+v1Ie0cYL4yNc4X+wqKalnBhwczsKGuw zuul-build-sshkey
2025-10-09 00:06:16.078919 | cloud-centos-9-stream -> localhost | The key's randomart image is:
2025-10-09 00:06:16.078946 | cloud-centos-9-stream -> localhost | +---[RSA 3072]----+
2025-10-09 00:06:16.078972 | cloud-centos-9-stream -> localhost | |                 |
2025-10-09 00:06:16.078999 | cloud-centos-9-stream -> localhost | |            .    |
2025-10-09 00:06:16.079026 | cloud-centos-9-stream -> localhost | |           . +   |
2025-10-09 00:06:16.079052 | cloud-centos-9-stream -> localhost | |         .  * =  |
2025-10-09 00:06:16.079078 | cloud-centos-9-stream -> localhost | |    . o S. o B + |
2025-10-09 00:06:16.079104 | cloud-centos-9-stream -> localhost | | .   o * oo * + .|
2025-10-09 00:06:16.079130 | cloud-centos-9-stream -> localhost | |  o . + = .= o . |
2025-10-09 00:06:16.079158 | cloud-centos-9-stream -> localhost | | . o o @ =+ .    |
2025-10-09 00:06:16.079184 | cloud-centos-9-stream -> localhost | |  E  =@oO+.oo.   |
2025-10-09 00:06:16.079209 | cloud-centos-9-stream -> localhost | +----[SHA256]-----+
2025-10-09 00:06:16.079268 | cloud-centos-9-stream -> localhost | ok: Runtime: 0:00:00.133627
2025-10-09 00:06:16.087601 | 
2025-10-09 00:06:16.087690 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-09 00:06:16.110304 | cloud-centos-9-stream | ok
2025-10-09 00:06:16.124167 | cloud-centos-9-stream | included: /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-09 00:06:16.134941 | 
2025-10-09 00:06:16.135006 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-09 00:06:16.158841 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:16.164059 | 
2025-10-09 00:06:16.164118 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-09 00:06:16.650958 | cloud-centos-9-stream | changed
2025-10-09 00:06:16.664267 | 
2025-10-09 00:06:16.664492 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-09 00:06:16.947039 | cloud-centos-9-stream | ok
2025-10-09 00:06:16.953955 | 
2025-10-09 00:06:16.954053 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-09 00:06:17.947572 | cloud-centos-9-stream | changed
2025-10-09 00:06:17.952575 | 
2025-10-09 00:06:17.954144 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-09 00:06:18.988650 | cloud-centos-9-stream | changed
2025-10-09 00:06:18.997956 | 
2025-10-09 00:06:18.998111 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-09 00:06:19.026435 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:19.035288 | 
2025-10-09 00:06:19.035464 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-09 00:06:19.459947 | cloud-centos-9-stream -> localhost | changed
2025-10-09 00:06:19.472567 | 
2025-10-09 00:06:19.472687 | TASK [add-build-sshkey : Add back temp key]
2025-10-09 00:06:19.752090 | cloud-centos-9-stream -> localhost | Identity added: /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/work/6435e012013d4e60983dd7f5a5079574_id_rsa (zuul-build-sshkey)
2025-10-09 00:06:19.752566 | cloud-centos-9-stream -> localhost | ok: Runtime: 0:00:00.015794
2025-10-09 00:06:19.788105 | 
2025-10-09 00:06:19.788257 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-09 00:06:20.235017 | cloud-centos-9-stream | ok
2025-10-09 00:06:20.246922 | 
2025-10-09 00:06:20.247167 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-09 00:06:20.277063 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:20.300631 | 
2025-10-09 00:06:20.300887 | TASK [include_role : validate-host]
2025-10-09 00:06:20.332459 | cloud-centos-9-stream | ok
2025-10-09 00:06:20.357564 | 
2025-10-09 00:06:20.357775 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-09 00:06:20.399874 | cloud-centos-9-stream | ok
2025-10-09 00:06:20.406150 | 
2025-10-09 00:06:20.406338 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-09 00:06:20.701275 | cloud-centos-9-stream -> localhost | ok
2025-10-09 00:06:20.708645 | 
2025-10-09 00:06:20.708818 | TASK [validate-host : Collect information about the host]
2025-10-09 00:06:21.610718 | cloud-centos-9-stream | ok
2025-10-09 00:06:21.620227 | 
2025-10-09 00:06:21.620327 | TASK [validate-host : Sanitize hostname]
2025-10-09 00:06:21.670994 | cloud-centos-9-stream | ok
2025-10-09 00:06:21.676931 | 
2025-10-09 00:06:21.677033 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-09 00:06:22.124176 | cloud-centos-9-stream -> localhost | changed
2025-10-09 00:06:22.132114 | 
2025-10-09 00:06:22.132224 | TASK [validate-host : Collect information about zuul worker]
2025-10-09 00:06:22.628197 | cloud-centos-9-stream | ok
2025-10-09 00:06:22.633615 | 
2025-10-09 00:06:22.633693 | TASK [validate-host : Write out all zuul information for each host]
2025-10-09 00:06:23.080397 | cloud-centos-9-stream -> localhost | changed
2025-10-09 00:06:23.092119 | 
2025-10-09 00:06:23.092260 | TASK [include_role : prepare-workspace-openshift]
2025-10-09 00:06:23.118087 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:23.125641 | 
2025-10-09 00:06:23.125800 | TASK [include_role : remove-zuul-sshkey]
2025-10-09 00:06:23.151511 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:23.158853 | 
2025-10-09 00:06:23.158945 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-09 00:06:23.454793 | cloud-centos-9-stream | ok: "logs"
2025-10-09 00:06:23.455299 | cloud-centos-9-stream | ok: All items complete
2025-10-09 00:06:23.455346 | 
2025-10-09 00:06:23.724496 | cloud-centos-9-stream | ok: "artifacts"
2025-10-09 00:06:23.975519 | cloud-centos-9-stream | ok: "docs"
2025-10-09 00:06:23.987421 | 
2025-10-09 00:06:23.987540 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-09 00:06:24.330089 | cloud-centos-9-stream | changed: "logs"
2025-10-09 00:06:24.566999 | cloud-centos-9-stream | changed: "artifacts"
2025-10-09 00:06:24.800511 | cloud-centos-9-stream | changed: "docs"
2025-10-09 00:06:24.843705 | 
2025-10-09 00:06:24.843862 | PLAY RECAP
2025-10-09 00:06:24.843939 | cloud-centos-9-stream | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-09 00:06:24.843981 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-09 00:06:24.844012 | 
2025-10-09 00:06:24.986079 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-09 00:06:24.987299 | PRE-RUN START: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master]
2025-10-09 00:06:25.639251 | 
2025-10-09 00:06:25.639397 | PLAY [localhost]
2025-10-09 00:06:25.656625 | 
2025-10-09 00:06:25.656756 | TASK [configure-ssh-config-fips : Ensure ssh config directory]
2025-10-09 00:06:26.055589 | localhost | ok
2025-10-09 00:06:26.064395 | 
2025-10-09 00:06:26.064487 | TASK [configure-ssh-config-fips : Setup ssh config]
2025-10-09 00:06:26.778508 | localhost | changed
2025-10-09 00:06:26.819935 | 
2025-10-09 00:06:26.820090 | PLAY [all]
2025-10-09 00:06:26.845139 | 
2025-10-09 00:06:26.845297 | TASK [include_role : prepare-workspace]
2025-10-09 00:06:26.877328 | cloud-centos-9-stream | ok
2025-10-09 00:06:26.894581 | 
2025-10-09 00:06:26.894716 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-09 00:06:27.439625 | cloud-centos-9-stream | ok
2025-10-09 00:06:27.451086 | 
2025-10-09 00:06:27.451386 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-09 00:06:29.513242 | cloud-centos-9-stream | Output suppressed because no_log was given
2025-10-09 00:06:29.525013 | 
2025-10-09 00:06:29.525155 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-09 00:06:29.808920 | cloud-centos-9-stream | changed: "logs"
2025-10-09 00:06:30.052850 | cloud-centos-9-stream | changed: "artifacts"
2025-10-09 00:06:30.318862 | cloud-centos-9-stream | changed: "docs"
2025-10-09 00:06:30.335639 | 
2025-10-09 00:06:30.335839 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-09 00:06:30.627024 | cloud-centos-9-stream | changed: "logs"
2025-10-09 00:06:30.627372 | cloud-centos-9-stream | changed: All items complete
2025-10-09 00:06:30.627405 | 
2025-10-09 00:06:30.868970 | cloud-centos-9-stream | changed: "artifacts"
2025-10-09 00:06:31.095298 | cloud-centos-9-stream | changed: "docs"
2025-10-09 00:06:31.118566 | 
2025-10-09 00:06:31.118692 | TASK [Check if worker can sudo]
2025-10-09 00:06:31.652488 | cloud-centos-9-stream | ok: Runtime: 0:00:00.050271
2025-10-09 00:06:31.660796 | 
2025-10-09 00:06:31.661157 | TASK [configure-mirrors : Gather needed facts]
2025-10-09 00:06:31.715984 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:31.722922 | 
2025-10-09 00:06:31.723031 | TASK [configure-mirrors : Set up infrastructure mirrors]
2025-10-09 00:06:31.783228 | cloud-centos-9-stream | ok
2025-10-09 00:06:31.791829 | cloud-centos-9-stream | included: /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror.yaml
2025-10-09 00:06:31.798168 | 
2025-10-09 00:06:31.798261 | TASK [configure-mirrors : Remove .pydistutils.cfg configuration in homedir]
2025-10-09 00:06:32.075894 | cloud-centos-9-stream | ok
2025-10-09 00:06:32.091100 | 
2025-10-09 00:06:32.091264 | LOOP [configure-mirrors : Include OS-specific variables]
2025-10-09 00:06:32.212693 | cloud-centos-9-stream | ok: "/var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/vars/CentOS-9.yaml"
2025-10-09 00:06:32.225982 | 
2025-10-09 00:06:32.226117 | TASK [configure-mirrors : Install /etc/pip.conf configuration]
2025-10-09 00:06:33.213956 | cloud-centos-9-stream | changed
2025-10-09 00:06:33.223684 | 
2025-10-09 00:06:33.223893 | LOOP [configure-mirrors : Setup distribution specific packaging mirrors]
2025-10-09 00:06:33.285849 | cloud-centos-9-stream | ok: "/var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml"
2025-10-09 00:06:33.286107 | cloud-centos-9-stream | ok: All items complete
2025-10-09 00:06:33.286144 | 
2025-10-09 00:06:33.343213 | cloud-centos-9-stream | included: /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/configure-mirrors/tasks/mirror/CentOS-9.yaml
2025-10-09 00:06:33.350579 | 
2025-10-09 00:06:33.350693 | LOOP [configure-mirrors : Install CentOS 9 repository files]
2025-10-09 00:06:34.436256 | cloud-centos-9-stream | changed: "etc/yum.repos.d/centos.repo"
2025-10-09 00:06:35.381479 | cloud-centos-9-stream | changed: "etc/yum.repos.d/centos-addons.repo"
2025-10-09 00:06:35.397630 | 
2025-10-09 00:06:35.397796 | TASK [configure-mirrors : Disable deltrarpm]
2025-10-09 00:06:35.920966 | cloud-centos-9-stream | changed: section and option added
2025-10-09 00:06:35.951164 | 
2025-10-09 00:06:35.951398 | LOOP [configure-mirrors : Update yum/dnf cache]
2025-10-09 00:06:37.012708 | cloud-centos-9-stream | 29 files removed
2025-10-09 00:06:37.013217 | cloud-centos-9-stream | ok: Item: dnf clean all Runtime: 0:00:00.700510
2025-10-09 00:06:37.013350 | cloud-centos-9-stream | changed: All items complete
2025-10-09 00:06:37.013420 | 
2025-10-09 00:06:47.581030 | 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-09 00:06:47.581231 | cloud-centos-9-stream | DNF version: 4.14.0
2025-10-09 00:06:47.581302 | cloud-centos-9-stream | cachedir: /var/cache/dnf
2025-10-09 00:06:47.581350 | cloud-centos-9-stream | Making cache files for all metadata files.
2025-10-09 00:06:47.581394 | cloud-centos-9-stream | baseos: has expired and will be refreshed.
2025-10-09 00:06:47.581434 | cloud-centos-9-stream | appstream: has expired and will be refreshed.
2025-10-09 00:06:47.581474 | cloud-centos-9-stream | crb: has expired and will be refreshed.
2025-10-09 00:06:47.581514 | cloud-centos-9-stream | extras-common: has expired and will be refreshed.
2025-10-09 00:06:47.581552 | cloud-centos-9-stream | repo: downloading from remote: baseos
2025-10-09 00:06:47.581591 | cloud-centos-9-stream | CentOS Stream 9 - BaseOS                         63 MB/s | 8.8 MB     00:00
2025-10-09 00:06:47.581630 | cloud-centos-9-stream | baseos: using metadata from Wed 08 Oct 2025 09:42:12 AM EDT.
2025-10-09 00:06:47.581672 | cloud-centos-9-stream | repo: downloading from remote: appstream
2025-10-09 00:06:47.581711 | cloud-centos-9-stream | CentOS Stream 9 - AppStream                     115 MB/s |  25 MB     00:00
2025-10-09 00:06:47.581831 | cloud-centos-9-stream | appstream: using metadata from Wed 08 Oct 2025 09:45:45 AM EDT.
2025-10-09 00:06:47.581876 | cloud-centos-9-stream | repo: downloading from remote: crb
2025-10-09 00:06:47.581915 | cloud-centos-9-stream | CentOS Stream 9 - CRB                            80 MB/s | 7.2 MB     00:00
2025-10-09 00:06:47.581955 | cloud-centos-9-stream | crb: using metadata from Wed 08 Oct 2025 09:50:07 AM EDT.
2025-10-09 00:06:47.581994 | cloud-centos-9-stream | repo: downloading from remote: extras-common
2025-10-09 00:06:47.582034 | cloud-centos-9-stream | CentOS Stream 9 - Extras packages               1.2 MB/s |  20 kB     00:00
2025-10-09 00:06:47.582073 | cloud-centos-9-stream | extras-common: using metadata from Mon 15 Sep 2025 02:32:43 PM EDT.
2025-10-09 00:06:47.582111 | cloud-centos-9-stream | User-Agent: constructed: 'libdnf (CentOS Stream 9; generic; Linux.x86_64)'
2025-10-09 00:06:47.582151 | cloud-centos-9-stream | Completion plugin: Generating completion cache...
2025-10-09 00:06:47.582190 | cloud-centos-9-stream | Metadata cache created.
2025-10-09 00:06:47.582252 | cloud-centos-9-stream | ok: Item: dnf makecache -v Runtime: 0:00:10.275850
2025-10-09 00:06:47.617318 | 
2025-10-09 00:06:47.617464 | PLAY RECAP
2025-10-09 00:06:47.617549 | cloud-centos-9-stream | ok: 13 changed: 7 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-09 00:06:47.617609 | localhost | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-09 00:06:47.617651 | 
2025-10-09 00:06:47.768316 | PRE-RUN END RESULT_NORMAL: [untrusted : review.rdoproject.org/rdo-jobs/playbooks/base/pre.yaml@master]
2025-10-09 00:06:47.770488 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2025-10-09 00:06:48.373550 | 
2025-10-09 00:06:48.373664 | PLAY [all]
2025-10-09 00:06:48.395530 | 
2025-10-09 00:06:48.395633 | TASK [Install binary dependencies]
2025-10-09 00:06:48.455123 | cloud-centos-9-stream | ok
2025-10-09 00:06:48.473913 | 
2025-10-09 00:06:48.474047 | TASK [bindep : Include find tasks]
2025-10-09 00:06:48.502616 | cloud-centos-9-stream | ok
2025-10-09 00:06:48.510093 | cloud-centos-9-stream | included: /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2025-10-09 00:06:48.516087 | 
2025-10-09 00:06:48.516168 | TASK [bindep : Look for bindep.txt]
2025-10-09 00:06:48.917587 | cloud-centos-9-stream | ok
2025-10-09 00:06:48.930601 | 
2025-10-09 00:06:48.930781 | TASK [bindep : Define bindep_file fact]
2025-10-09 00:06:48.959051 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:48.972310 | 
2025-10-09 00:06:48.972447 | TASK [bindep : Look for other-requirements.txt]
2025-10-09 00:06:49.253954 | cloud-centos-9-stream | ok
2025-10-09 00:06:49.260277 | 
2025-10-09 00:06:49.260368 | TASK [bindep : Define bindep_file fact]
2025-10-09 00:06:49.284479 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:49.293084 | 
2025-10-09 00:06:49.293179 | TASK [bindep : Look for bindep fallback file]
2025-10-09 00:06:49.318549 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:49.326852 | 
2025-10-09 00:06:49.326962 | TASK [bindep : Define bindep_file fact]
2025-10-09 00:06:49.352160 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:49.360050 | 
2025-10-09 00:06:49.360137 | TASK [bindep : Include bindep tasks]
2025-10-09 00:06:49.394975 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:49.411671 | 
2025-10-09 00:06:49.411965 | TASK [bindep : Include install tasks]
2025-10-09 00:06:49.439970 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:49.448651 | 
2025-10-09 00:06:49.448776 | LOOP [bindep : Include package tasks]
2025-10-09 00:06:49.507924 | 
2025-10-09 00:06:49.508086 | TASK [Run test-setup role]
2025-10-09 00:06:49.526986 | cloud-centos-9-stream | ok
2025-10-09 00:06:49.543864 | 
2025-10-09 00:06:49.543954 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2025-10-09 00:06:49.855164 | cloud-centos-9-stream | ok
2025-10-09 00:06:49.868238 | 
2025-10-09 00:06:49.868361 | TASK [test-setup : Run tools/test-setup.sh]
2025-10-09 00:06:50.410664 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:50.457630 | 
2025-10-09 00:06:50.457831 | PLAY RECAP
2025-10-09 00:06:50.457889 | cloud-centos-9-stream | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2025-10-09 00:06:50.457911 | 
2025-10-09 00:06:50.614502 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2025-10-09 00:06:50.615449 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2025-10-09 00:06:51.299764 | 
2025-10-09 00:06:51.299875 | PLAY [all]
2025-10-09 00:06:51.322158 | 
2025-10-09 00:06:51.322259 | TASK [ensure-python : Validate python_version value]
2025-10-09 00:06:51.393967 | cloud-centos-9-stream | ok: All assertions passed
2025-10-09 00:06:51.402778 | 
2025-10-09 00:06:51.402862 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2025-10-09 00:06:51.426301 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:51.432575 | 
2025-10-09 00:06:51.432649 | TASK [ensure-python : Pull in venv package]
2025-10-09 00:06:51.457128 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:51.463053 | 
2025-10-09 00:06:51.463127 | TASK [ensure-python : Set default RPM package name]
2025-10-09 00:06:51.522329 | cloud-centos-9-stream | ok
2025-10-09 00:06:51.527329 | 
2025-10-09 00:06:51.527394 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2025-10-09 00:06:51.586988 | cloud-centos-9-stream | ok
2025-10-09 00:06:51.593483 | 
2025-10-09 00:06:51.593596 | TASK [ensure-python : Install RPM package]
2025-10-09 00:06:53.339679 | cloud-centos-9-stream | ok: Nothing to do
2025-10-09 00:06:53.347918 | 
2025-10-09 00:06:53.348055 | TASK [ensure-python : Install python using pyenv]
2025-10-09 00:06:53.382875 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:53.389908 | 
2025-10-09 00:06:53.389999 | TASK [ensure-python : Activate python using stow]
2025-10-09 00:06:53.435697 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:53.448272 | 
2025-10-09 00:06:53.448388 | TASK [Install pip]
2025-10-09 00:06:53.468986 | cloud-centos-9-stream | ok
2025-10-09 00:06:53.494846 | 
2025-10-09 00:06:53.494999 | TASK [ensure-pip : Check if pip is installed]
2025-10-08 20:06:53.972550 | cloud-centos-9-stream | /usr/bin/pip3
2025-10-08 20:06:54.018994 | cloud-centos-9-stream | /usr/bin/python3: No module named wheel
2025-10-09 00:06:54.063042 | cloud-centos-9-stream | ok: Runtime: 0:00:00.063076
2025-10-09 00:06:54.070490 | 
2025-10-09 00:06:54.070584 | LOOP [ensure-pip : Install pip from packages]
2025-10-09 00:06:54.104180 | cloud-centos-9-stream | ok: "/var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml"
2025-10-09 00:06:54.123382 | cloud-centos-9-stream | included: /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml
2025-10-09 00:06:54.132011 | 
2025-10-09 00:06:54.132108 | TASK [ensure-pip : Install Python 3 pip]
2025-10-09 00:06:56.292194 | cloud-centos-9-stream | changed
2025-10-09 00:06:56.302366 | 
2025-10-09 00:06:56.302532 | TASK [ensure-pip : Check for EPEL repository]
2025-10-09 00:06:56.329240 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:56.342261 | 
2025-10-09 00:06:56.342411 | TASK [ensure-pip : Fail with instructions when EPEL is not installed]
2025-10-09 00:06:56.369428 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:56.379545 | 
2025-10-09 00:06:56.379754 | TASK [ensure-pip : Install Python 2 pip]
2025-10-09 00:06:56.406259 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:56.417079 | 
2025-10-09 00:06:56.417251 | TASK [ensure-pip : Ensure setuptools]
2025-10-09 00:06:56.434406 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:56.442163 | 
2025-10-09 00:06:56.442271 | TASK [ensure-pip : Check for ensurepip module]
2025-10-09 00:06:56.973977 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:56.983895 | 
2025-10-09 00:06:56.984045 | TASK [ensure-pip : Ensure python3-venv]
2025-10-09 00:06:57.019594 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:57.027941 | 
2025-10-09 00:06:57.028048 | TASK [ensure-pip : Install pip from source]
2025-10-09 00:06:57.053216 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:57.059854 | 
2025-10-09 00:06:57.059922 | TASK [ensure-pip : Probe for venv python full path]
2025-10-08 20:06:57.341801 | cloud-centos-9-stream | /usr/bin/python3
2025-10-09 00:06:57.614380 | cloud-centos-9-stream | ok: Runtime: 0:00:00.008389
2025-10-09 00:06:57.627186 | 
2025-10-09 00:06:57.627357 | TASK [ensure-pip : Set host default]
2025-10-09 00:06:57.699643 | cloud-centos-9-stream | ok
2025-10-09 00:06:57.713386 | 
2025-10-09 00:06:57.713586 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2025-10-09 00:06:57.790831 | cloud-centos-9-stream | ok
2025-10-09 00:06:57.818058 | 
2025-10-09 00:06:57.818446 | TASK [ensure-tox : Check if tox is installed]
2025-10-09 00:06:58.377710 | cloud-centos-9-stream | ok: Runtime: 0:00:00.004572
2025-10-09 00:06:58.389933 | 
2025-10-09 00:06:58.390084 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2025-10-09 00:06:58.416947 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:06:58.425038 | 
2025-10-09 00:06:58.425130 | TASK [ensure-tox : Create local venv]
2025-10-09 00:07:01.470774 | cloud-centos-9-stream | ok: Runtime: 0:00:02.642746
2025-10-09 00:07:01.478984 | 
2025-10-09 00:07:01.479105 | TASK [ensure-tox : Install tox to local venv]
2025-10-08 20:07:02.084555 | 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-08 20:07:02.353100 | cloud-centos-9-stream | Collecting tox
2025-10-08 20:07:02.357009 | 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-08 20:07:02.418359 | cloud-centos-9-stream | Collecting pyproject-api>=1.9.1
2025-10-08 20:07:02.421121 | 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-08 20:07:02.509666 | cloud-centos-9-stream | Collecting typing-extensions>=4.14.1
2025-10-08 20:07:02.514003 | 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-08 20:07:02.578538 | cloud-centos-9-stream | Collecting cachetools>=6.1
2025-10-08 20:07:02.581442 | 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-08 20:07:02.632089 | cloud-centos-9-stream | Collecting pluggy>=1.6
2025-10-08 20:07:02.634962 | 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-08 20:07:02.728070 | cloud-centos-9-stream | Collecting filelock>=3.18
2025-10-08 20:07:02.734047 | 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-08 20:07:02.811309 | cloud-centos-9-stream | Collecting platformdirs>=4.3.8
2025-10-08 20:07:02.814047 | 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-08 20:07:02.885738 | cloud-centos-9-stream | Collecting tomli>=2.2.1
2025-10-08 20:07:02.891381 | 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-08 20:07:02.942806 | cloud-centos-9-stream | Collecting colorama>=0.4.6
2025-10-08 20:07:02.945304 | 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-08 20:07:03.009624 | cloud-centos-9-stream | Collecting packaging>=25
2025-10-08 20:07:03.012744 | 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-08 20:07:03.139330 | cloud-centos-9-stream | Collecting chardet>=5.2
2025-10-08 20:07:03.142584 | 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-08 20:07:03.367008 | cloud-centos-9-stream | Collecting virtualenv>=20.31.2
2025-10-08 20:07:03.370495 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/20/fd/fe3a1d787b9d56b8497c1cb120da87f81e4fd73af1e193592320f7c7206e/virtualenv-20.35.0-py3-none-any.whl (6.0 MB)
2025-10-08 20:07:03.542744 | cloud-centos-9-stream | Collecting distlib<1,>=0.3.7
2025-10-08 20:07:03.545667 | 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-08 20:07:03.640318 | cloud-centos-9-stream | Installing collected packages: typing-extensions, tomli, platformdirs, packaging, filelock, distlib, virtualenv, pyproject-api, pluggy, colorama, chardet, cachetools, tox
2025-10-08 20:07:04.455658 | 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.0
2025-10-08 20:07:04.572255 | cloud-centos-9-stream | WARNING: You are using pip version 21.3.1; however, version 25.2 is available.
2025-10-08 20:07:04.647568 | 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-09 00:07:05.027849 | cloud-centos-9-stream | ok: Runtime: 0:00:02.903115
2025-10-09 00:07:05.034919 | 
2025-10-09 00:07:05.035016 | TASK [ensure-tox : Export installed tox_executable path]
2025-10-09 00:07:05.066670 | cloud-centos-9-stream | ok
2025-10-09 00:07:05.073030 | 
2025-10-09 00:07:05.073119 | TASK [ensure-tox : Output tox version]
2025-10-08 20:07:05.556917 | 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-08 20:07:05.575571 | cloud-centos-9-stream | 4.30.3 from /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/tox/__init__.py
2025-10-09 00:07:05.631408 | cloud-centos-9-stream | ok: Runtime: 0:00:00.258182
2025-10-09 00:07:05.639051 | 
2025-10-09 00:07:05.639151 | TASK [ensure-tox : Make global symlink]
2025-10-09 00:07:05.655947 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:07:05.682263 | 
2025-10-09 00:07:05.682367 | PLAY RECAP
2025-10-09 00:07:05.682410 | cloud-centos-9-stream | ok: 15 changed: 7 unreachable: 0 failed: 0 skipped: 13 rescued: 0 ignored: 0
2025-10-09 00:07:05.682432 | 
2025-10-09 00:07:05.789974 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2025-10-09 00:07:05.791085 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master]
2025-10-09 00:07:06.519307 | 
2025-10-09 00:07:06.519429 | PLAY [all]
2025-10-09 00:07:06.542637 | 
2025-10-09 00:07:06.542788 | TASK [revoke-sudo : Check if zuul is sudoer]
2025-10-09 00:07:07.074812 | cloud-centos-9-stream | ok: Runtime: 0:00:00.021732
2025-10-09 00:07:07.085871 | 
2025-10-09 00:07:07.086284 | TASK [revoke-sudo : Remove sudo access for zuul user.]
2025-10-09 00:07:07.641488 | cloud-centos-9-stream | ok: Runtime: 0:00:00.006685
2025-10-09 00:07:07.648278 | 
2025-10-09 00:07:07.648379 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.]
2025-10-08 20:07:07.931642 | cloud-centos-9-stream | sudo: a password is required
2025-10-09 00:07:08.205459 | cloud-centos-9-stream | ok: Runtime: 0:00:00.020073
2025-10-09 00:07:08.221240 | 
2025-10-09 00:07:08.221351 | TASK [tox : Check to see if the constraints file exists]
2025-10-09 00:07:08.258398 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:07:08.268109 | 
2025-10-09 00:07:08.268228 | TASK [tox : Fail if constraints file is missing]
2025-10-09 00:07:08.304477 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:07:08.311227 | 
2025-10-09 00:07:08.311335 | TASK [tox : Record file location]
2025-10-09 00:07:08.347180 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:07:08.355428 | 
2025-10-09 00:07:08.355565 | TASK [tox : Install tox siblings]
2025-10-09 00:07:08.393461 | cloud-centos-9-stream | ok
2025-10-09 00:07:08.408608 | cloud-centos-9-stream | included: /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml
2025-10-09 00:07:08.414141 | 
2025-10-09 00:07:08.414212 | TASK [tox : Run tox without tests]
2025-10-08 20:07:08.870998 | cloud-centos-9-stream | ROOT: 162 D setup logging to DEBUG on pid 3288 [tox/report.py:222]
2025-10-08 20:07:08.908367 | cloud-centos-9-stream | py39: 199 D created app data folder /home/zuul-worker/.local/share/virtualenv [virtualenv/app_data/__init__.py:42]
2025-10-08 20:07:08.915391 | cloud-centos-9-stream | py39: 207 I find interpreter for spec PythonSpec(major=3, minor=9, free_threaded=False) [virtualenv/discovery/builtin.py:81]
2025-10-08 20:07:08.915568 | cloud-centos-9-stream | py39: 207 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:546]
2025-10-08 20:07:08.916004 | cloud-centos-9-stream | py39: 207 D filesystem is case-sensitive [virtualenv/discovery/info.py:20]
2025-10-08 20:07:08.917361 | cloud-centos-9-stream | py39: 209 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 cEjOGR6HTttecHnDTEdXnYuQyXRCmKgx GChavO6DWSB25wU8JInQLZDGSQEOvXfk [virtualenv/discovery/cached_py_info.py:142]
2025-10-08 20:07:08.974510 | cloud-centos-9-stream | py39: 266 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-08 20:07:08.974703 | cloud-centos-9-stream | py39: 266 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:88]
2025-10-08 20:07:08.974765 | cloud-centos-9-stream | py39: 266 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:90]
2025-10-08 20:07:08.976172 | cloud-centos-9-stream | py39: 267 D symlink on filesystem does work [virtualenv/info.py:50]
2025-10-08 20:07:08.976282 | cloud-centos-9-stream | py39: 268 D filesystem is case-sensitive [virtualenv/info.py:27]
2025-10-08 20:07:09.001458 | cloud-centos-9-stream | py39: 293 I create virtual environment via CPython3Posix(dest=/home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:52]
2025-10-08 20:07:09.001651 | cloud-centos-9-stream | py39: 293 D create folder /home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/bin [virtualenv/util/path/_sync.py:14]
2025-10-08 20:07:09.001784 | cloud-centos-9-stream | py39: 293 D create folder /home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/lib/python3.9/site-packages [virtualenv/util/path/_sync.py:14]
2025-10-08 20:07:09.001963 | cloud-centos-9-stream | py39: 293 D create folder /home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/lib64/python3.9/site-packages [virtualenv/util/path/_sync.py:14]
2025-10-08 20:07:09.002191 | cloud-centos-9-stream | py39: 293 D write /home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35]
2025-10-08 20:07:09.002275 | cloud-centos-9-stream | py39: 293 D 	home = /usr/bin [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.002334 | cloud-centos-9-stream | py39: 294 D 	implementation = CPython [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.002372 | cloud-centos-9-stream | py39: 294 D 	version_info = 3.9.23.final.0 [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.002426 | cloud-centos-9-stream | py39: 294 D 	virtualenv = 20.35.0 [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.002472 | cloud-centos-9-stream | py39: 294 D 	include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.002524 | cloud-centos-9-stream | py39: 294 D 	base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.002587 | cloud-centos-9-stream | py39: 294 D 	base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.002650 | cloud-centos-9-stream | py39: 294 D 	base-executable = /usr/bin/python3.9 [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.003032 | cloud-centos-9-stream | py39: 294 D symlink /usr/bin/python3.9 to /home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/bin/python [virtualenv/util/path/_sync.py:34]
2025-10-08 20:07:09.003530 | cloud-centos-9-stream | py39: 295 D create virtualenv import hook file /home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/lib/python3.9/site-packages/_virtualenv.pth [virtualenv/create/via_global_ref/api.py:98]
2025-10-08 20:07:09.003648 | cloud-centos-9-stream | py39: 295 D create /home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/lib/python3.9/site-packages/_virtualenv.py [virtualenv/create/via_global_ref/api.py:101]
2025-10-08 20:07:09.004089 | cloud-centos-9-stream | py39: 295 D ============================== target debug ============================== [virtualenv/run/session.py:54]
2025-10-08 20:07:09.004293 | cloud-centos-9-stream | py39: 295 D debug via /home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/bin/python /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:215]
2025-10-08 20:07:09.037382 | cloud-centos-9-stream | py39: 295 D {
2025-10-08 20:07:09.037710 | cloud-centos-9-stream |   "sys": {
2025-10-08 20:07:09.037726 | cloud-centos-9-stream |     "executable": "/home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/bin/python",
2025-10-08 20:07:09.037736 | cloud-centos-9-stream |     "_base_executable": "/home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/bin/python",
2025-10-08 20:07:09.037743 | cloud-centos-9-stream |     "prefix": "/home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39",
2025-10-08 20:07:09.037749 | cloud-centos-9-stream |     "base_prefix": "/usr",
2025-10-08 20:07:09.037756 | cloud-centos-9-stream |     "real_prefix": null,
2025-10-08 20:07:09.037762 | cloud-centos-9-stream |     "exec_prefix": "/home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39",
2025-10-08 20:07:09.037768 | cloud-centos-9-stream |     "base_exec_prefix": "/usr",
2025-10-08 20:07:09.037796 | cloud-centos-9-stream |     "path": [
2025-10-08 20:07:09.037802 | cloud-centos-9-stream |       "/usr/lib64/python39.zip",
2025-10-08 20:07:09.037810 | cloud-centos-9-stream |       "/usr/lib64/python3.9",
2025-10-08 20:07:09.037816 | cloud-centos-9-stream |       "/usr/lib64/python3.9/lib-dynload",
2025-10-08 20:07:09.037823 | cloud-centos-9-stream |       "/home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/lib64/python3.9/site-packages",
2025-10-08 20:07:09.037829 | cloud-centos-9-stream |       "/home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/lib/python3.9/site-packages"
2025-10-08 20:07:09.037835 | cloud-centos-9-stream |     ],
2025-10-08 20:07:09.037841 | cloud-centos-9-stream |     "meta_path": [
2025-10-08 20:07:09.037847 | cloud-centos-9-stream |       "<class '_virtualenv._Finder'>",
2025-10-08 20:07:09.037853 | cloud-centos-9-stream |       "<class '_frozen_importlib.BuiltinImporter'>",
2025-10-08 20:07:09.037859 | cloud-centos-9-stream |       "<class '_frozen_importlib.FrozenImporter'>",
2025-10-08 20:07:09.037865 | cloud-centos-9-stream |       "<class '_frozen_importlib_external.PathFinder'>"
2025-10-08 20:07:09.037871 | cloud-centos-9-stream |     ],
2025-10-08 20:07:09.037877 | cloud-centos-9-stream |     "fs_encoding": "utf-8",
2025-10-08 20:07:09.037883 | cloud-centos-9-stream |     "io_encoding": "utf-8"
2025-10-08 20:07:09.037889 | cloud-centos-9-stream |   },
2025-10-08 20:07:09.037895 | 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-08 20:07:09.037901 | cloud-centos-9-stream |   "makefile_filename": "/usr/lib64/python3.9/config-3.9-x86_64-linux-gnu/Makefile",
2025-10-08 20:07:09.037907 | cloud-centos-9-stream |   "os": "<module 'os' from '/usr/lib64/python3.9/os.py'>",
2025-10-08 20:07:09.037913 | cloud-centos-9-stream |   "site": "<module 'site' from '/usr/lib64/python3.9/site.py'>",
2025-10-08 20:07:09.037919 | cloud-centos-9-stream |   "datetime": "<module 'datetime' from '/usr/lib64/python3.9/datetime.py'>",
2025-10-08 20:07:09.037925 | cloud-centos-9-stream |   "math": "<module 'math' from '/usr/lib64/python3.9/lib-dynload/math.cpython-39-x86_64-linux-gnu.so'>",
2025-10-08 20:07:09.037931 | cloud-centos-9-stream |   "json": "<module 'json' from '/usr/lib64/python3.9/json/__init__.py'>"
2025-10-08 20:07:09.037938 | cloud-centos-9-stream | } [virtualenv/run/session.py:55]
2025-10-08 20:07:09.037950 | cloud-centos-9-stream | py39: 329 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-08 20:07:09.039586 | cloud-centos-9-stream | py39: 331 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-08 20:07:09.040282 | cloud-centos-9-stream | py39: 331 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-08 20:07:09.041259 | cloud-centos-9-stream | py39: 332 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-08 20:07:09.041759 | cloud-centos-9-stream | py39: 333 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-08 20:07:09.240939 | cloud-centos-9-stream | py39: 532 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/rdoinfo/.tox/py39/lib/python3.9/site-packages/pip [virtualenv/util/path/_sync.py:42]
2025-10-08 20:07:09.255381 | cloud-centos-9-stream | py39: 546 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/rdoinfo/.tox/py39/lib/python3.9/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:42]
2025-10-08 20:07:09.256002 | cloud-centos-9-stream | py39: 547 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/rdoinfo/.tox/py39/lib/python3.9/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:42]
2025-10-08 20:07:09.257215 | cloud-centos-9-stream | py39: 548 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/rdoinfo/.tox/py39/lib/python3.9/site-packages/pkg_resources [virtualenv/util/path/_sync.py:42]
2025-10-08 20:07:09.266282 | cloud-centos-9-stream | py39: 557 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/rdoinfo/.tox/py39/lib/python3.9/site-packages/setuptools [virtualenv/util/path/_sync.py:42]
2025-10-08 20:07:09.403914 | cloud-centos-9-stream | py39: 695 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/rdoinfo/.tox/py39/lib/python3.9/site-packages/pip-25.2.dist-info [virtualenv/util/path/_sync.py:42]
2025-10-08 20:07:09.419719 | cloud-centos-9-stream | py39: 711 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/rdoinfo/.tox/py39/lib/python3.9/site-packages/pip-25.2.virtualenv [virtualenv/util/path/_sync.py:42]
2025-10-08 20:07:09.421057 | cloud-centos-9-stream | py39: 712 D generated console scripts pip3 pip3.9 pip pip-3.9 [virtualenv/seed/embed/via_app_data/pip_install/base.py:45]
2025-10-08 20:07:09.434225 | cloud-centos-9-stream | py39: 725 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/rdoinfo/.tox/py39/lib/python3.9/site-packages/setuptools-80.9.0.dist-info [virtualenv/util/path/_sync.py:42]
2025-10-08 20:07:09.435524 | cloud-centos-9-stream | py39: 727 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/rdoinfo/.tox/py39/lib/python3.9/site-packages/setuptools-80.9.0.virtualenv [virtualenv/util/path/_sync.py:42]
2025-10-08 20:07:09.435702 | cloud-centos-9-stream | py39: 727 D generated console scripts  [virtualenv/seed/embed/via_app_data/pip_install/base.py:45]
2025-10-08 20:07:09.435925 | cloud-centos-9-stream | py39: 727 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65]
2025-10-08 20:07:09.438685 | cloud-centos-9-stream | py39: 730 D write /home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35]
2025-10-08 20:07:09.438782 | cloud-centos-9-stream | py39: 730 D 	home = /usr/bin [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.438831 | cloud-centos-9-stream | py39: 730 D 	implementation = CPython [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.438878 | cloud-centos-9-stream | py39: 730 D 	version_info = 3.9.23.final.0 [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.438926 | cloud-centos-9-stream | py39: 730 D 	virtualenv = 20.35.0 [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.438968 | cloud-centos-9-stream | py39: 730 D 	include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.439023 | cloud-centos-9-stream | py39: 730 D 	base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.439070 | cloud-centos-9-stream | py39: 730 D 	base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.439138 | cloud-centos-9-stream | py39: 730 D 	base-executable = /usr/bin/python3.9 [virtualenv/create/pyenv_cfg.py:40]
2025-10-08 20:07:09.442301 | cloud-centos-9-stream | py39: 734 W install_deps> python -I -m pip install distroinfo pytest pytest-html pytest-xdist pyyaml six yamllint [tox/tox_env/api.py:463]
2025-10-08 20:07:10.120343 | 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-08 20:07:10.197406 | cloud-centos-9-stream | Collecting distroinfo
2025-10-08 20:07:10.204601 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/ac/67/a946f13f2693aa5f28d0053fb18799f0b67449dabd70bc2ce36372179d26/distroinfo-0.6.3-py3-none-any.whl.metadata (7.6 kB)
2025-10-08 20:07:10.621602 | cloud-centos-9-stream | Collecting pytest
2025-10-08 20:07:10.630617 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/a8/a4/20da314d277121d6534b3a980b29035dcd51e6744bd79075a6ce8fa4eb8d/pytest-8.4.2-py3-none-any.whl.metadata (7.7 kB)
2025-10-08 20:07:10.817567 | cloud-centos-9-stream | Collecting pytest-html
2025-10-08 20:07:10.826413 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/c8/c7/c160021cbecd956cc1a6f79e5fe155f7868b2e5b848f1320dad0b3e3122f/pytest_html-4.1.1-py3-none-any.whl.metadata (3.9 kB)
2025-10-08 20:07:10.936270 | cloud-centos-9-stream | Collecting pytest-xdist
2025-10-08 20:07:10.941291 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/ca/31/d4e37e9e550c2b92a9cbc2e4d0b7420a27224968580b5a447f420847c975/pytest_xdist-3.8.0-py3-none-any.whl.metadata (3.0 kB)
2025-10-08 20:07:11.103131 | cloud-centos-9-stream | Collecting pyyaml
2025-10-08 20:07:11.106185 | 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-08 20:07:11.315595 | cloud-centos-9-stream | Collecting six
2025-10-08 20:07:11.319622 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/b7/ce/149a00dd41f10bc29e5921b496af8b574d8413afcd5e30dfa0ed46c2cc5e/six-1.17.0-py2.py3-none-any.whl.metadata (1.7 kB)
2025-10-08 20:07:11.430401 | cloud-centos-9-stream | Collecting yamllint
2025-10-08 20:07:11.435414 | 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-08 20:07:11.490960 | cloud-centos-9-stream | Collecting pbr>=6.0.0 (from distroinfo)
2025-10-08 20:07:11.494520 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/56/c1/7e588435c2394dfded9197a8307417d1ca3b7f49d9bd5b6227d1f3f03ccd/pbr-7.0.1-py2.py3-none-any.whl.metadata (1.4 kB)
2025-10-08 20:07:11.565536 | cloud-centos-9-stream | Collecting requests (from distroinfo)
2025-10-08 20:07:11.568955 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/1e/db/4254e3eabe8020b458f1a747140d32277ec7a271daf1d235b70dc0b4e6e3/requests-2.32.5-py3-none-any.whl.metadata (4.9 kB)
2025-10-08 20:07:11.761956 | cloud-centos-9-stream | Collecting exceptiongroup>=1 (from pytest)
2025-10-08 20:07:11.766674 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/36/f4/c6e662dade71f56cd2f3735141b265c3c79293c109549c1e6933b0651ffc/exceptiongroup-1.3.0-py3-none-any.whl.metadata (6.7 kB)
2025-10-08 20:07:11.903320 | cloud-centos-9-stream | Collecting iniconfig>=1 (from pytest)
2025-10-08 20:07:11.907712 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/2c/e1/e6716421ea10d38022b952c159d5161ca1193197fb744506875fbb87ea7b/iniconfig-2.1.0-py3-none-any.whl.metadata (2.7 kB)
2025-10-08 20:07:11.947934 | cloud-centos-9-stream | Collecting packaging>=20 (from pytest)
2025-10-08 20:07:11.954396 | 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.metadata (3.3 kB)
2025-10-08 20:07:12.007847 | cloud-centos-9-stream | Collecting pluggy<2,>=1.5 (from pytest)
2025-10-08 20:07:12.016269 | 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.metadata (4.8 kB)
2025-10-08 20:07:12.506178 | cloud-centos-9-stream | Collecting pygments>=2.7.2 (from pytest)
2025-10-08 20:07:12.512198 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/c7/21/705964c7812476f378728bdf590ca4b771ec72385c533964653c68e86bdc/pygments-2.19.2-py3-none-any.whl.metadata (2.5 kB)
2025-10-08 20:07:12.628296 | cloud-centos-9-stream | Collecting tomli>=1 (from pytest)
2025-10-08 20:07:12.633256 | 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.metadata (10 kB)
2025-10-08 20:07:12.745093 | cloud-centos-9-stream | Collecting jinja2>=3.0.0 (from pytest-html)
2025-10-08 20:07:12.749662 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/62/a1/3d680cbfd5f4b8f15abc1d571870c5fc3e594bb582bc3b64ea099db13e56/jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB)
2025-10-08 20:07:12.920518 | cloud-centos-9-stream | Collecting pytest-metadata>=2.0.0 (from pytest-html)
2025-10-08 20:07:12.925065 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/3e/43/7e7b2ec865caa92f67b8f0e9231a798d102724ca4c0e1f414316be1c1ef2/pytest_metadata-3.1.1-py3-none-any.whl.metadata (8.6 kB)
2025-10-08 20:07:13.091876 | cloud-centos-9-stream | Collecting execnet>=2.1 (from pytest-xdist)
2025-10-08 20:07:13.096819 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/43/09/2aea36ff60d16dd8879bdb2f5b3ee0ba8d08cbbdcdfe870e695ce3784385/execnet-2.1.1-py3-none-any.whl.metadata (2.9 kB)
2025-10-08 20:07:13.142643 | cloud-centos-9-stream | Collecting pathspec>=0.5.3 (from yamllint)
2025-10-08 20:07:13.147039 | 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-08 20:07:13.188004 | cloud-centos-9-stream | Collecting typing-extensions>=4.6.0 (from exceptiongroup>=1->pytest)
2025-10-08 20:07:13.190556 | 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.metadata (3.3 kB)
2025-10-08 20:07:13.309277 | cloud-centos-9-stream | Collecting MarkupSafe>=2.0 (from jinja2>=3.0.0->pytest-html)
2025-10-08 20:07:13.312170 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/6f/bc/4dc914ead3fe6ddaef035341fee0fc956949bbd27335b611829292b89ee2/markupsafe-3.0.3-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.7 kB)
2025-10-08 20:07:13.326480 | cloud-centos-9-stream | Requirement already satisfied: setuptools in ./.tox/py39/lib/python3.9/site-packages (from pbr>=6.0.0->distroinfo) (80.9.0)
2025-10-08 20:07:13.504594 | cloud-centos-9-stream | Collecting charset_normalizer<4,>=2 (from requests->distroinfo)
2025-10-08 20:07:13.507640 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/b0/a8/6f5bcf1bcf63cb45625f7c5cadca026121ff8a6c8a3256d8d8cd59302663/charset_normalizer-3.4.3-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (36 kB)
2025-10-08 20:07:13.560866 | cloud-centos-9-stream | Collecting idna<4,>=2.5 (from requests->distroinfo)
2025-10-08 20:07:13.564011 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/76/c6/c88e154df9c4e1a2a66ccf0005a88dfb2650c1dffb6f5ce603dfbd452ce3/idna-3.10-py3-none-any.whl.metadata (10 kB)
2025-10-08 20:07:13.649522 | cloud-centos-9-stream | Collecting urllib3<3,>=1.21.1 (from requests->distroinfo)
2025-10-08 20:07:13.653260 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/a7/c2/fe1e52489ae3122415c51f387e221dd0773709bad6c6cdaa599e8a2c5185/urllib3-2.5.0-py3-none-any.whl.metadata (6.5 kB)
2025-10-08 20:07:13.731574 | cloud-centos-9-stream | Collecting certifi>=2017.4.17 (from requests->distroinfo)
2025-10-08 20:07:13.734408 | cloud-centos-9-stream |   Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/e4/37/af0d2ef3967ac0d6113837b44a4f0bfe1328c2b9763bd5b1744520e5cfed/certifi-2025.10.5-py3-none-any.whl.metadata (2.5 kB)
2025-10-08 20:07:13.773192 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/ac/67/a946f13f2693aa5f28d0053fb18799f0b67449dabd70bc2ce36372179d26/distroinfo-0.6.3-py3-none-any.whl (20 kB)
2025-10-08 20:07:13.795521 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/a8/a4/20da314d277121d6534b3a980b29035dcd51e6744bd79075a6ce8fa4eb8d/pytest-8.4.2-py3-none-any.whl (365 kB)
2025-10-08 20:07:13.813087 | 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-08 20:07:13.824860 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/c8/c7/c160021cbecd956cc1a6f79e5fe155f7868b2e5b848f1320dad0b3e3122f/pytest_html-4.1.1-py3-none-any.whl (23 kB)
2025-10-08 20:07:13.845696 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/ca/31/d4e37e9e550c2b92a9cbc2e4d0b7420a27224968580b5a447f420847c975/pytest_xdist-3.8.0-py3-none-any.whl (46 kB)
2025-10-08 20:07:13.863045 | 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-08 20:07:13.888814 | cloud-centos-9-stream |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 750.8/750.8 kB 22.3 MB/s  0:00:00
2025-10-08 20:07:13.892596 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/b7/ce/149a00dd41f10bc29e5921b496af8b574d8413afcd5e30dfa0ed46c2cc5e/six-1.17.0-py2.py3-none-any.whl (11 kB)
2025-10-08 20:07:13.914546 | 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-08 20:07:13.931156 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/36/f4/c6e662dade71f56cd2f3735141b265c3c79293c109549c1e6933b0651ffc/exceptiongroup-1.3.0-py3-none-any.whl (16 kB)
2025-10-08 20:07:13.943577 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/43/09/2aea36ff60d16dd8879bdb2f5b3ee0ba8d08cbbdcdfe870e695ce3784385/execnet-2.1.1-py3-none-any.whl (40 kB)
2025-10-08 20:07:13.960178 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/2c/e1/e6716421ea10d38022b952c159d5161ca1193197fb744506875fbb87ea7b/iniconfig-2.1.0-py3-none-any.whl (6.0 kB)
2025-10-08 20:07:13.976056 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/62/a1/3d680cbfd5f4b8f15abc1d571870c5fc3e594bb582bc3b64ea099db13e56/jinja2-3.1.6-py3-none-any.whl (134 kB)
2025-10-08 20:07:13.990840 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/6f/bc/4dc914ead3fe6ddaef035341fee0fc956949bbd27335b611829292b89ee2/markupsafe-3.0.3-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (20 kB)
2025-10-08 20:07:14.003856 | 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-08 20:07:14.018601 | 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-08 20:07:14.032377 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/56/c1/7e588435c2394dfded9197a8307417d1ca3b7f49d9bd5b6227d1f3f03ccd/pbr-7.0.1-py2.py3-none-any.whl (126 kB)
2025-10-08 20:07:14.051503 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/c7/21/705964c7812476f378728bdf590ca4b771ec72385c533964653c68e86bdc/pygments-2.19.2-py3-none-any.whl (1.2 MB)
2025-10-08 20:07:14.079347 | cloud-centos-9-stream |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 43.0 MB/s  0:00:00
2025-10-08 20:07:14.082467 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/3e/43/7e7b2ec865caa92f67b8f0e9231a798d102724ca4c0e1f414316be1c1ef2/pytest_metadata-3.1.1-py3-none-any.whl (11 kB)
2025-10-08 20:07:14.096079 | 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-08 20:07:14.107394 | 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-08 20:07:14.120938 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/1e/db/4254e3eabe8020b458f1a747140d32277ec7a271daf1d235b70dc0b4e6e3/requests-2.32.5-py3-none-any.whl (64 kB)
2025-10-08 20:07:14.137622 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/b0/a8/6f5bcf1bcf63cb45625f7c5cadca026121ff8a6c8a3256d8d8cd59302663/charset_normalizer-3.4.3-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (152 kB)
2025-10-08 20:07:14.148631 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/76/c6/c88e154df9c4e1a2a66ccf0005a88dfb2650c1dffb6f5ce603dfbd452ce3/idna-3.10-py3-none-any.whl (70 kB)
2025-10-08 20:07:14.158747 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/a7/c2/fe1e52489ae3122415c51f387e221dd0773709bad6c6cdaa599e8a2c5185/urllib3-2.5.0-py3-none-any.whl (129 kB)
2025-10-08 20:07:14.179969 | cloud-centos-9-stream | Downloading http://mirror.regionone.vexxhost-nodepool-sf.rdoproject.org/pypifiles/packages/e4/37/af0d2ef3967ac0d6113837b44a4f0bfe1328c2b9763bd5b1744520e5cfed/certifi-2025.10.5-py3-none-any.whl (163 kB)
2025-10-08 20:07:14.282972 | cloud-centos-9-stream | Installing collected packages: urllib3, typing-extensions, tomli, six, pyyaml, pygments, pluggy, pbr, pathspec, packaging, MarkupSafe, iniconfig, idna, execnet, charset_normalizer, certifi, yamllint, requests, jinja2, exceptiongroup, pytest, distroinfo, pytest-xdist, pytest-metadata, pytest-html
2025-10-08 20:07:16.066003 | cloud-centos-9-stream |
2025-10-08 20:07:16.070995 | cloud-centos-9-stream | Successfully installed MarkupSafe-3.0.3 certifi-2025.10.5 charset_normalizer-3.4.3 distroinfo-0.6.3 exceptiongroup-1.3.0 execnet-2.1.1 idna-3.10 iniconfig-2.1.0 jinja2-3.1.6 packaging-25.0 pathspec-0.12.1 pbr-7.0.1 pluggy-1.6.0 pygments-2.19.2 pytest-8.4.2 pytest-html-4.1.1 pytest-metadata-3.1.1 pytest-xdist-3.8.0 pyyaml-6.0.3 requests-2.32.5 six-1.17.0 tomli-2.3.0 typing-extensions-4.15.0 urllib3-2.5.0 yamllint-1.37.1
2025-10-08 20:07:16.180157 | cloud-centos-9-stream | py39: 7471 I exit 0 (6.74 seconds) /home/zuul-worker/src/review.rdoproject.org/rdoinfo> python -I -m pip install distroinfo pytest pytest-html pytest-xdist pyyaml six yamllint pid=3301 [tox/execute/api.py:294]
2025-10-08 20:07:16.181604 | cloud-centos-9-stream |   py39: OK (7.28 seconds)
2025-10-08 20:07:16.243317 | cloud-centos-9-stream |   congratulations :) (7.31 seconds)
2025-10-09 00:07:16.470297 | cloud-centos-9-stream | ok: Runtime: 0:00:07.557970
2025-10-09 00:07:16.477852 | 
2025-10-09 00:07:16.477946 | TASK [tox : Create a tempfile to save tox showconfig]
2025-10-09 00:07:16.890123 | cloud-centos-9-stream | changed
2025-10-09 00:07:16.905181 | 
2025-10-09 00:07:16.905380 | TASK [tox : Get tox envlist config]
2025-10-09 00:07:17.960634 | cloud-centos-9-stream | ok: Runtime: 0:00:00.313635
2025-10-09 00:07:17.973777 | 
2025-10-09 00:07:17.973921 | TASK [tox : Install any sibling python packages]
2025-10-09 00:07:18.655935 | cloud-centos-9-stream | ok:
2025-10-09 00:07:18.656157 | cloud-centos-9-stream | Using envlist: ['py39']
2025-10-09 00:07:18.656199 | cloud-centos-9-stream | Processing siblings for rdoinfo from src/review.rdoproject.org/rdoinfo
2025-10-09 00:07:18.656232 | cloud-centos-9-stream | Found certifi python package installed
2025-10-09 00:07:18.656261 | cloud-centos-9-stream | Found charset-normalizer python package installed
2025-10-09 00:07:18.656288 | cloud-centos-9-stream | Found distroinfo python package installed
2025-10-09 00:07:18.656314 | cloud-centos-9-stream | Found exceptiongroup python package installed
2025-10-09 00:07:18.656339 | cloud-centos-9-stream | Found execnet python package installed
2025-10-09 00:07:18.656365 | cloud-centos-9-stream | Found idna python package installed
2025-10-09 00:07:18.656391 | cloud-centos-9-stream | Found iniconfig python package installed
2025-10-09 00:07:18.656416 | cloud-centos-9-stream | Found Jinja2 python package installed
2025-10-09 00:07:18.656439 | cloud-centos-9-stream | Found MarkupSafe python package installed
2025-10-09 00:07:18.656462 | cloud-centos-9-stream | Found packaging python package installed
2025-10-09 00:07:18.656482 | cloud-centos-9-stream | Found pathspec python package installed
2025-10-09 00:07:18.656503 | cloud-centos-9-stream | Found pbr python package installed
2025-10-09 00:07:18.656524 | cloud-centos-9-stream | Found pluggy python package installed
2025-10-09 00:07:18.656547 | cloud-centos-9-stream | Found Pygments python package installed
2025-10-09 00:07:18.656572 | cloud-centos-9-stream | Found pytest python package installed
2025-10-09 00:07:18.656596 | cloud-centos-9-stream | Found pytest-html python package installed
2025-10-09 00:07:18.656622 | cloud-centos-9-stream | Found pytest-metadata python package installed
2025-10-09 00:07:18.656966 | cloud-centos-9-stream | Found pytest-xdist python package installed
2025-10-09 00:07:18.657168 | cloud-centos-9-stream | Found PyYAML python package installed
2025-10-09 00:07:18.657211 | cloud-centos-9-stream | Found requests python package installed
2025-10-09 00:07:18.657242 | cloud-centos-9-stream | Found six python package installed
2025-10-09 00:07:18.657269 | cloud-centos-9-stream | Found tomli python package installed
2025-10-09 00:07:18.657292 | cloud-centos-9-stream | Found typing_extensions python package installed
2025-10-09 00:07:18.657312 | cloud-centos-9-stream | Found urllib3 python package installed
2025-10-09 00:07:18.657332 | cloud-centos-9-stream | Found yamllint python package installed
2025-10-09 00:07:18.665085 | 
2025-10-09 00:07:18.665178 | TASK [tox : Remove tempfile]
2025-10-09 00:07:19.114123 | cloud-centos-9-stream | changed
2025-10-09 00:07:19.120112 | 
2025-10-09 00:07:19.120193 | TASK [tox : Emit tox command]
2025-10-09 00:07:19.150812 | /home/zuul-worker/.local/tox/bin/tox   -epy39  -vv --skip-missing-interpreters=false
2025-10-09 00:07:19.156372 | 
2025-10-09 00:07:19.156462 | TASK [tox : Run tox]
2025-10-08 20:07:19.687836 | cloud-centos-9-stream | ROOT: 166 D setup logging to DEBUG on pid 3521 [tox/report.py:222]
2025-10-08 20:07:19.731873 | cloud-centos-9-stream | py39: 209 I find interpreter for spec PythonSpec(major=3, minor=9, free_threaded=False) [virtualenv/discovery/builtin.py:81]
2025-10-08 20:07:19.732321 | cloud-centos-9-stream | py39: 210 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:546]
2025-10-08 20:07:19.733378 | cloud-centos-9-stream | py39: 211 D filesystem is case-sensitive [virtualenv/discovery/info.py:20]
2025-10-08 20:07:19.735129 | cloud-centos-9-stream | py39: 213 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-08 20:07:19.736322 | cloud-centos-9-stream | py39: 214 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:88]
2025-10-08 20:07:19.736432 | cloud-centos-9-stream | py39: 215 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:90]
2025-10-08 20:07:19.737962 | cloud-centos-9-stream | py39: 216 D symlink on filesystem does work [virtualenv/info.py:50]
2025-10-08 20:07:19.738189 | cloud-centos-9-stream | py39: 216 D filesystem is case-sensitive [virtualenv/info.py:27]
2025-10-08 20:07:19.773743 | cloud-centos-9-stream | py39: 252 W commands[0]> python -m yamllint -f parsable --strict . [tox/tox_env/api.py:463]
2025-10-08 20:07:44.966986 | cloud-centos-9-stream | py39: 25445 I exit 0 (25.19 seconds) /home/zuul-worker/src/review.rdoproject.org/rdoinfo> python -m yamllint -f parsable --strict . pid=3528 [tox/execute/api.py:294]
2025-10-08 20:07:44.967121 | cloud-centos-9-stream | py39: 25445 W commands[1]> python -m pytest --html=/home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/log/reports.html --self-contained-html -n auto [tox/tox_env/api.py:463]
2025-10-08 20:07:48.746856 | cloud-centos-9-stream | ============================= test session starts ==============================
2025-10-08 20:07:48.837256 | cloud-centos-9-stream | platform linux -- Python 3.9.23, pytest-8.4.2, pluggy-1.6.0
2025-10-08 20:07:48.837340 | cloud-centos-9-stream | cachedir: .tox/py39/.pytest_cache
2025-10-08 20:07:48.837352 | cloud-centos-9-stream | rootdir: /home/zuul-worker/src/review.rdoproject.org/rdoinfo
2025-10-08 20:07:48.837361 | cloud-centos-9-stream | plugins: xdist-3.8.0, metadata-3.1.1, html-4.1.1
2025-10-08 20:07:48.837371 | cloud-centos-9-stream | created: 8/8 workers
2025-10-08 20:07:48.837380 | cloud-centos-9-stream | 8 workers [2 items]
2025-10-08 20:07:48.837389 | cloud-centos-9-stream |
2025-10-08 20:07:55.166268 | cloud-centos-9-stream | s.                                                                       [100%]
2025-10-08 20:07:55.234572 | cloud-centos-9-stream | - Generated html report: file:///home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/log/reports.html -
2025-10-08 20:07:55.234644 | cloud-centos-9-stream | ========================= 1 passed, 1 skipped in 9.74s =========================
2025-10-08 20:07:55.234666 | cloud-centos-9-stream | py39: 35713 I exit 0 (10.27 seconds) /home/zuul-worker/src/review.rdoproject.org/rdoinfo> python -m pytest --html=/home/zuul-worker/src/review.rdoproject.org/rdoinfo/.tox/py39/log/reports.html --self-contained-html -n auto pid=3533 [tox/execute/api.py:294]
2025-10-08 20:07:55.235916 | cloud-centos-9-stream |   py39: OK (35.52=setup[0.06]+cmd[25.19,10.27] seconds)
2025-10-08 20:07:55.292546 | cloud-centos-9-stream |   congratulations :) (35.55 seconds)
2025-10-09 00:07:55.736880 | cloud-centos-9-stream | ok: Runtime: 0:00:35.825352
2025-10-09 00:07:55.743933 | 
2025-10-09 00:07:55.744021 | TASK [tox : Look for output]
2025-10-09 00:07:56.180930 | cloud-centos-9-stream | ok
2025-10-09 00:07:56.186514 | 
2025-10-09 00:07:56.186596 | TASK [tox : Return file comments to Zuul]
2025-10-09 00:07:56.244237 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:07:56.290875 | 
2025-10-09 00:07:56.290982 | PLAY RECAP
2025-10-09 00:07:56.291039 | cloud-centos-9-stream | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0
2025-10-09 00:07:56.291070 | 
2025-10-09 00:07:56.407309 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master]
2025-10-09 00:07:56.419464 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2025-10-09 00:07:57.238869 | 
2025-10-09 00:07:57.238984 | PLAY [all]
2025-10-09 00:07:57.262703 | 
2025-10-09 00:07:57.262845 | TASK [fetch-tox-output : Set tox log path for multiple nodes]
2025-10-09 00:07:57.318225 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:07:57.325550 | 
2025-10-09 00:07:57.325673 | TASK [fetch-tox-output : Set tox log path for single node]
2025-10-09 00:07:57.354436 | cloud-centos-9-stream | ok
2025-10-09 00:07:57.362533 | 
2025-10-09 00:07:57.362710 | TASK [fetch-tox-output : Ensure local tox dir]
2025-10-09 00:07:57.785750 | cloud-centos-9-stream -> localhost | changed
2025-10-09 00:07:57.795287 | 
2025-10-09 00:07:57.795406 | TASK [fetch-tox-output : Ensure zuul-output tox dir]
2025-10-09 00:07:57.852697 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:07:57.862256 | 
2025-10-09 00:07:57.862381 | TASK [fetch-tox-output : Set envlist fact]
2025-10-09 00:07:57.899511 | cloud-centos-9-stream | ok
2025-10-09 00:07:57.909164 | 
2025-10-09 00:07:57.909268 | TASK [fetch-tox-output : Get tox version]
2025-10-08 20:07:58.593658 | 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-08 20:07:58.619928 | cloud-centos-9-stream | 4.30.3 from /home/zuul-worker/.local/tox/lib64/python3.9/site-packages/tox/__init__.py
2025-10-09 00:07:58.947036 | cloud-centos-9-stream | ok: Runtime: 0:00:00.266078
2025-10-09 00:07:58.953552 | 
2025-10-09 00:07:58.953803 | TASK [fetch-tox-output : Find all default environments]
2025-10-09 00:07:59.496971 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:07:59.506545 | 
2025-10-09 00:07:59.506695 | TASK [fetch-tox-output : Set envlist fact]
2025-10-09 00:07:59.538023 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:07:59.545386 | 
2025-10-09 00:07:59.545642 | TASK [fetch-tox-output : Find all default environments]
2025-10-09 00:08:00.083089 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:08:00.093085 | 
2025-10-09 00:08:00.093215 | TASK [fetch-tox-output : Set envlist fact]
2025-10-09 00:08:00.130027 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:08:00.139473 | 
2025-10-09 00:08:00.139599 | LOOP [fetch-tox-output : Copy tox logs]
2025-10-09 00:08:00.192176 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:08:00.205913 | 
2025-10-09 00:08:00.206024 | LOOP [fetch-tox-output : Collect tox logs]
2025-10-09 00:08:01.085850 | cloud-centos-9-stream | changed:
2025-10-09 00:08:01.086035 | cloud-centos-9-stream | cd+++++++++ ./
2025-10-09 00:08:01.086074 | cloud-centos-9-stream | >f+++++++++ 1-commands[0].log
2025-10-09 00:08:01.086104 | cloud-centos-9-stream | >f+++++++++ 2-commands[1].log
2025-10-09 00:08:01.086132 | cloud-centos-9-stream | >f+++++++++ reports.html
2025-10-09 00:08:01.086171 | 
2025-10-09 00:08:01.130269 | 
2025-10-09 00:08:01.130399 | PLAY RECAP
2025-10-09 00:08:01.130447 | cloud-centos-9-stream | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0
2025-10-09 00:08:01.130474 | 
2025-10-09 00:08:01.236999 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2025-10-09 00:08:01.237902 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2025-10-09 00:08:01.948712 | 
2025-10-09 00:08:01.948848 | PLAY [all]
2025-10-09 00:08:01.970741 | 
2025-10-09 00:08:01.970875 | TASK [fetch-subunit-output : Find stestr or testr executable]
2025-10-09 00:08:02.348245 | cloud-centos-9-stream | changed: non-zero return code
2025-10-09 00:08:02.353990 | 
2025-10-09 00:08:02.354081 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2025-10-09 00:08:02.368321 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:08:02.374310 | 
2025-10-09 00:08:02.374396 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2025-10-09 00:08:02.408707 | 
2025-10-09 00:08:02.408979 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2025-10-09 00:08:02.444239 | 
2025-10-09 00:08:02.444468 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2025-10-09 00:08:02.460116 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:08:02.470574 | 
2025-10-09 00:08:02.470717 | LOOP [fetch-subunit-output : Generate subunit file]
2025-10-09 00:08:02.495212 | 
2025-10-09 00:08:02.495424 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2025-10-09 00:08:02.523641 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:08:02.532373 | 
2025-10-09 00:08:02.532519 | TASK [fetch-subunit-output : Remove the temporary file]
2025-10-09 00:08:02.547662 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:08:02.556929 | 
2025-10-09 00:08:02.557070 | TASK [fetch-subunit-output : Process and fetch subunit results]
2025-10-09 00:08:02.572582 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:08:02.605600 | 
2025-10-09 00:08:02.605704 | PLAY RECAP
2025-10-09 00:08:02.605776 | cloud-centos-9-stream | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2025-10-09 00:08:02.605798 | 
2025-10-09 00:08:02.717515 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2025-10-09 00:08:02.718846 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-09 00:08:03.369151 | 
2025-10-09 00:08:03.369277 | PLAY [all]
2025-10-09 00:08:03.392006 | 
2025-10-09 00:08:03.392160 | TASK [include_role : fetch-output]
2025-10-09 00:08:03.425349 | cloud-centos-9-stream | ok
2025-10-09 00:08:03.458946 | 
2025-10-09 00:08:03.459103 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-09 00:08:03.504512 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:08:03.510292 | 
2025-10-09 00:08:03.510365 | TASK [fetch-output : Set log path for single node]
2025-10-09 00:08:03.539483 | cloud-centos-9-stream | ok
2025-10-09 00:08:03.544878 | 
2025-10-09 00:08:03.544956 | LOOP [fetch-output : Ensure local output dirs]
2025-10-09 00:08:03.984049 | cloud-centos-9-stream -> localhost | ok: "/var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/work/logs"
2025-10-09 00:08:04.198778 | cloud-centos-9-stream -> localhost | changed: "/var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/work/artifacts"
2025-10-09 00:08:04.498486 | cloud-centos-9-stream -> localhost | changed: "/var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/work/docs"
2025-10-09 00:08:04.510975 | 
2025-10-09 00:08:04.511091 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-09 00:08:05.188672 | cloud-centos-9-stream | changed: .d..t...... ./
2025-10-09 00:08:05.189108 | cloud-centos-9-stream | changed: All items complete
2025-10-09 00:08:05.189158 | 
2025-10-09 00:08:05.703853 | cloud-centos-9-stream | changed: .d..t...... ./
2025-10-09 00:08:06.271009 | cloud-centos-9-stream | changed: .d..t...... ./
2025-10-09 00:08:06.294027 | 
2025-10-09 00:08:06.294137 | TASK [include_role : fetch-output-openshift]
2025-10-09 00:08:06.318965 | cloud-centos-9-stream | skipping: Conditional result was False
2025-10-09 00:08:06.328709 | 
2025-10-09 00:08:06.328838 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-09 00:08:06.792191 | cloud-centos-9-stream -> localhost | ok: Item: artifacts Runtime: 0:00:00.012989
2025-10-09 00:08:07.066514 | cloud-centos-9-stream -> localhost | ok: Item: docs Runtime: 0:00:00.014168
2025-10-09 00:08:07.101883 | 
2025-10-09 00:08:07.101979 | PLAY [all]
2025-10-09 00:08:07.117614 | 
2025-10-09 00:08:07.117743 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-09 00:08:07.584307 | cloud-centos-9-stream | changed
2025-10-09 00:08:07.609366 | 
2025-10-09 00:08:07.609463 | PLAY RECAP
2025-10-09 00:08:07.609502 | cloud-centos-9-stream | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-09 00:08:07.609523 | 
2025-10-09 00:08:07.734858 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-09 00:08:07.736034 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-09 00:08:08.608123 | 
2025-10-09 00:08:08.608288 | PLAY [localhost]
2025-10-09 00:08:08.629296 | 
2025-10-09 00:08:08.629440 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-09 00:08:09.094008 | localhost | changed
2025-10-09 00:08:09.099381 | 
2025-10-09 00:08:09.099528 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-09 00:08:09.128004 | localhost | ok
2025-10-09 00:08:09.136404 | 
2025-10-09 00:08:09.136511 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-09 00:08:09.502421 | localhost | changed
2025-10-09 00:08:09.511325 | 
2025-10-09 00:08:09.511446 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-09 00:08:10.201081 | localhost | changed
2025-10-09 00:08:10.206261 | 
2025-10-09 00:08:10.206340 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-09 00:08:10.657266 | localhost | Identity added: /var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/work/tmp/ansible.eo65mex7 (/var/lib/zuul/builds/6435e012013d4e60983dd7f5a5079574/work/tmp/ansible.eo65mex7)
2025-10-09 00:08:10.657552 | localhost | ok: Runtime: 0:00:00.010491
2025-10-09 00:08:10.664683 | 
2025-10-09 00:08:10.664817 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-09 00:08:10.981180 | localhost | ok: Runtime: 0:00:00.010639
2025-10-09 00:08:10.988065 | 
2025-10-09 00:08:10.988167 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-09 00:08:11.041235 | localhost | changed
2025-10-09 00:08:11.047682 | 
2025-10-09 00:08:11.047835 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-09 00:08:11.570794 | localhost | changed
2025-10-09 00:08:11.599585 | 
2025-10-09 00:08:11.599672 | PLAY [localhost]
2025-10-09 00:08:11.616572 | 
2025-10-09 00:08:11.616666 | TASK [Generate bulk log download script]
2025-10-09 00:08:11.634684 | localhost | ok
2025-10-09 00:08:11.646530 | 
2025-10-09 00:08:11.646598 | TASK [local-log-download : Check API endpoint is defined]
2025-10-09 00:08:11.685399 | localhost | ok: All assertions passed
2025-10-09 00:08:11.690788 | 
2025-10-09 00:08:11.690858 | TASK [local-log-download : Create download script]
2025-10-09 00:08:12.197874 | localhost -> localhost | changed
2025-10-09 00:08:12.222386 | 
2025-10-09 00:08:12.222600 | TASK [Register quick-download link]
2025-10-09 00:08:12.249441 | localhost | ok
2025-10-09 00:08:12.300153 | 
2025-10-09 00:08:12.300247 | PLAY [logserver.rdoproject.org]
2025-10-09 00:08:12.312003 | 
2025-10-09 00:08:12.312100 | TASK [Set zuul-log-path fact]
2025-10-09 00:08:12.329802 | logserver.rdoproject.org | ok
2025-10-09 00:08:12.342458 | 
2025-10-09 00:08:12.342581 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-09 00:08:12.370492 | logserver.rdoproject.org | ok
2025-10-09 00:08:12.376529 | 
2025-10-09 00:08:12.376768 | TASK [upload-logs : Create log directories]
2025-10-09 00:08:13.329561 | logserver.rdoproject.org | changed
2025-10-09 00:08:13.332874 | 
2025-10-09 00:08:13.332948 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-09 00:08:13.724138 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.007350
2025-10-09 00:08:13.729605 | 
2025-10-09 00:08:13.729686 | TASK [upload-logs : Upload logs to log server]
2025-10-09 00:08:14.526624 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-09 00:08:14.530817 | 
2025-10-09 00:08:14.530890 | LOOP [upload-logs : Compress console log and json output]
2025-10-09 00:08:14.601628 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-09 00:08:14.602823 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-09 00:08:14.614752 | 
2025-10-09 00:08:14.615164 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-09 00:08:14.660103 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-09 00:08:14.660355 | 
2025-10-09 00:08:14.666172 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-09 00:08:14.674508 | 
2025-10-09 00:08:14.674609 | LOOP [upload-logs : Upload console log and json output]