2025-06-22 03:15:01.982608 | Job console starting 2025-06-22 03:15:02.000686 | Updating git repos 2025-06-22 03:15:02.059401 | Cloning repos into workspace 2025-06-22 03:15:02.172999 | Restoring repo states 2025-06-22 03:15:02.195873 | Merging changes 2025-06-22 03:15:02.195895 | Checking out repos 2025-06-22 03:15:02.317106 | Preparing playbooks 2025-06-22 03:15:03.507243 | Running Ansible setup 2025-06-22 03:15:09.612491 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-22 03:15:11.277996 | 2025-06-22 03:15:11.278132 | PLAY [Base pre] 2025-06-22 03:15:11.327513 | 2025-06-22 03:15:11.327639 | TASK [Setup log path fact] 2025-06-22 03:15:11.378430 | debian-bookworm | ok 2025-06-22 03:15:11.417183 | 2025-06-22 03:15:11.417327 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-22 03:15:11.468657 | debian-bookworm | ok 2025-06-22 03:15:11.489067 | 2025-06-22 03:15:11.489185 | TASK [emit-job-header : Print job information] 2025-06-22 03:15:11.558176 | # Job Information 2025-06-22 03:15:11.558347 | Ansible Version: 2.16.14 2025-06-22 03:15:11.558382 | Job: tox 2025-06-22 03:15:11.558414 | Pipeline: periodic-daily 2025-06-22 03:15:11.558436 | Executor: 521e9411259a 2025-06-22 03:15:11.558459 | Triggered by: https://github.com/osism/openstack-image-manager 2025-06-22 03:15:11.558486 | Event ID: f134c7c26f7d415681af02cc29ee138d 2025-06-22 03:15:11.565772 | 2025-06-22 03:15:11.565886 | LOOP [emit-job-header : Print node information] 2025-06-22 03:15:11.749066 | debian-bookworm | ok: 2025-06-22 03:15:11.749239 | debian-bookworm | # Node Information 2025-06-22 03:15:11.749275 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-22 03:15:11.749301 | debian-bookworm | Hostname: debian 2025-06-22 03:15:11.749323 | debian-bookworm | Username: zuul 2025-06-22 03:15:11.749344 | debian-bookworm | Distro: Debian 12.11 2025-06-22 03:15:11.749368 | debian-bookworm | Provider: regiocloud-a 2025-06-22 03:15:11.749390 | debian-bookworm | Region: 2025-06-22 03:15:11.749412 | debian-bookworm | Label: debian-bookworm 2025-06-22 03:15:11.749434 | debian-bookworm | Product Name: OpenStack Nova 2025-06-22 03:15:11.749455 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed1:649 2025-06-22 03:15:11.760556 | 2025-06-22 03:15:11.760671 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-22 03:15:12.378438 | debian-bookworm -> localhost | changed 2025-06-22 03:15:12.385478 | 2025-06-22 03:15:12.385594 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-22 03:15:14.625011 | debian-bookworm -> localhost | changed 2025-06-22 03:15:14.635943 | 2025-06-22 03:15:14.639646 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-22 03:15:15.075820 | debian-bookworm -> localhost | ok 2025-06-22 03:15:15.081894 | 2025-06-22 03:15:15.082005 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-22 03:15:15.119862 | debian-bookworm | ok 2025-06-22 03:15:15.149966 | debian-bookworm | included: /var/lib/zuul/builds/adcebb16d142416e82d7b56800b9fa7b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-22 03:15:15.155926 | 2025-06-22 03:15:15.156022 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-22 03:15:16.188246 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-22 03:15:16.188459 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/adcebb16d142416e82d7b56800b9fa7b/work/adcebb16d142416e82d7b56800b9fa7b_id_rsa 2025-06-22 03:15:16.188499 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/adcebb16d142416e82d7b56800b9fa7b/work/adcebb16d142416e82d7b56800b9fa7b_id_rsa.pub 2025-06-22 03:15:16.188525 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-22 03:15:16.188549 | debian-bookworm -> localhost | SHA256:qlBZ4a60qnR1eAUjoT2bhDNkFAZ7k9/NBHgNgy1NNWM zuul-build-sshkey 2025-06-22 03:15:16.188571 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-22 03:15:16.188602 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-22 03:15:16.188627 | debian-bookworm -> localhost | | .o*.oOB+E | 2025-06-22 03:15:16.188651 | debian-bookworm -> localhost | | = ==.=*.o | 2025-06-22 03:15:16.188673 | debian-bookworm -> localhost | | . O += o | 2025-06-22 03:15:16.188721 | debian-bookworm -> localhost | | . *+* = | 2025-06-22 03:15:16.188746 | debian-bookworm -> localhost | | +*.+So | 2025-06-22 03:15:16.188771 | debian-bookworm -> localhost | | o.oo. | 2025-06-22 03:15:16.188793 | debian-bookworm -> localhost | | ...o . | 2025-06-22 03:15:16.188814 | debian-bookworm -> localhost | |. .o . | 2025-06-22 03:15:16.188837 | debian-bookworm -> localhost | |... . | 2025-06-22 03:15:16.188859 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-22 03:15:16.188977 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.471152 2025-06-22 03:15:16.196029 | 2025-06-22 03:15:16.196129 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-22 03:15:16.235768 | debian-bookworm | ok 2025-06-22 03:15:16.244879 | debian-bookworm | included: /var/lib/zuul/builds/adcebb16d142416e82d7b56800b9fa7b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-22 03:15:16.273966 | 2025-06-22 03:15:16.274069 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-22 03:15:16.288718 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:15:16.294379 | 2025-06-22 03:15:16.294472 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-22 03:15:16.919160 | debian-bookworm | changed 2025-06-22 03:15:16.930536 | 2025-06-22 03:15:16.930658 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-22 03:15:17.241199 | debian-bookworm | ok 2025-06-22 03:15:17.251373 | 2025-06-22 03:15:17.251618 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-22 03:15:17.937882 | debian-bookworm | changed 2025-06-22 03:15:17.948181 | 2025-06-22 03:15:17.948285 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-22 03:15:18.640052 | debian-bookworm | changed 2025-06-22 03:15:18.647868 | 2025-06-22 03:15:18.647958 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-22 03:15:18.674862 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:15:18.682243 | 2025-06-22 03:15:18.682342 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-22 03:15:19.185247 | debian-bookworm -> localhost | changed 2025-06-22 03:15:19.198033 | 2025-06-22 03:15:19.198135 | TASK [add-build-sshkey : Add back temp key] 2025-06-22 03:15:19.586080 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/adcebb16d142416e82d7b56800b9fa7b/work/adcebb16d142416e82d7b56800b9fa7b_id_rsa (zuul-build-sshkey) 2025-06-22 03:15:19.586380 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012270 2025-06-22 03:15:19.602304 | 2025-06-22 03:15:19.602579 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-22 03:15:20.052633 | debian-bookworm | ok 2025-06-22 03:15:20.092381 | 2025-06-22 03:15:20.093471 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-22 03:15:20.126203 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:15:20.147801 | 2025-06-22 03:15:20.147901 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-22 03:15:20.641809 | debian-bookworm | ok 2025-06-22 03:15:20.654962 | 2025-06-22 03:15:20.655106 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-22 03:15:20.706399 | debian-bookworm | ok 2025-06-22 03:15:20.715719 | 2025-06-22 03:15:20.715851 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-22 03:15:21.263558 | debian-bookworm -> localhost | ok 2025-06-22 03:15:21.275162 | 2025-06-22 03:15:21.275296 | TASK [validate-host : Collect information about the host] 2025-06-22 03:15:22.676315 | debian-bookworm | ok 2025-06-22 03:15:22.700877 | 2025-06-22 03:15:22.701019 | TASK [validate-host : Sanitize hostname] 2025-06-22 03:15:22.852638 | debian-bookworm | ok 2025-06-22 03:15:22.995481 | 2025-06-22 03:15:22.996022 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-22 03:15:23.845577 | debian-bookworm -> localhost | changed 2025-06-22 03:15:23.856439 | 2025-06-22 03:15:23.856565 | TASK [validate-host : Collect information about zuul worker] 2025-06-22 03:15:24.284637 | debian-bookworm | ok 2025-06-22 03:15:24.300588 | 2025-06-22 03:15:24.300790 | TASK [validate-host : Write out all zuul information for each host] 2025-06-22 03:15:25.389119 | debian-bookworm -> localhost | changed 2025-06-22 03:15:25.420756 | 2025-06-22 03:15:25.420984 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-22 03:15:25.695548 | debian-bookworm | ok 2025-06-22 03:15:25.706185 | 2025-06-22 03:15:25.706325 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-22 03:15:27.153027 | debian-bookworm | changed: 2025-06-22 03:15:27.153355 | debian-bookworm | cd+++++++++ src/ 2025-06-22 03:15:27.153408 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-22 03:15:27.153434 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-22 03:15:27.153456 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-06-22 03:15:27.153477 | debian-bookworm | =5.5.1 2025-06-22 03:15:50.179750 | debian-bookworm | Downloading cachetools-6.1.0-py3-none-any.whl (11 kB) 2025-06-22 03:15:50.208598 | debian-bookworm | Collecting chardet>=5.2 2025-06-22 03:15:50.216034 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-06-22 03:15:50.231871 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 15.0 MB/s eta 0:00:00 2025-06-22 03:15:50.264560 | debian-bookworm | Collecting colorama>=0.4.6 2025-06-22 03:15:50.272391 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-06-22 03:15:50.340893 | debian-bookworm | Collecting filelock>=3.16.1 2025-06-22 03:15:50.349079 | debian-bookworm | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-06-22 03:15:50.394721 | debian-bookworm | Collecting packaging>=24.2 2025-06-22 03:15:50.402782 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-06-22 03:15:50.411814 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.0 MB/s eta 0:00:00 2025-06-22 03:15:50.451824 | debian-bookworm | Collecting platformdirs>=4.3.6 2025-06-22 03:15:50.459867 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-06-22 03:15:50.496828 | debian-bookworm | Collecting pluggy>=1.5 2025-06-22 03:15:50.504460 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-06-22 03:15:50.539557 | debian-bookworm | Collecting pyproject-api>=1.8 2025-06-22 03:15:50.547172 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-06-22 03:15:50.666009 | debian-bookworm | Collecting virtualenv>=20.31 2025-06-22 03:15:50.673639 | debian-bookworm | Downloading virtualenv-20.31.2-py3-none-any.whl (6.1 MB) 2025-06-22 03:15:50.935328 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.1/6.1 MB 23.5 MB/s eta 0:00:00 2025-06-22 03:15:51.048959 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-06-22 03:15:51.056430 | debian-bookworm | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-06-22 03:15:51.079815 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 22.5 MB/s eta 0:00:00 2025-06-22 03:15:51.238461 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-06-22 03:15:52.066766 | debian-bookworm | Successfully installed cachetools-6.1.0 chardet-5.2.0 colorama-0.4.6 distlib-0.3.9 filelock-3.18.0 packaging-25.0 platformdirs-4.3.8 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.27.0 virtualenv-20.31.2 2025-06-22 03:15:52.619386 | debian-bookworm | ok: Runtime: 0:00:02.779147 2025-06-22 03:15:52.628738 | 2025-06-22 03:15:52.628910 | TASK [ensure-tox : Export installed tox_executable path] 2025-06-22 03:15:52.673458 | debian-bookworm | ok 2025-06-22 03:15:52.680253 | 2025-06-22 03:15:52.680388 | TASK [ensure-tox : Output tox version] 2025-06-22 03:15:53.206009 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-06-22 03:15:53.224549 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-06-22 03:15:53.711725 | debian-bookworm | ok: Runtime: 0:00:00.301096 2025-06-22 03:15:53.718962 | 2025-06-22 03:15:53.719102 | TASK [ensure-tox : Make global symlink] 2025-06-22 03:15:53.743435 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:15:53.750942 | 2025-06-22 03:15:53.751039 | PLAY RECAP 2025-06-22 03:15:53.751091 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-06-22 03:15:53.751116 | 2025-06-22 03:15:53.904925 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-06-22 03:15:53.906068 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-06-22 03:15:54.721514 | 2025-06-22 03:15:54.721714 | PLAY [all] 2025-06-22 03:15:54.762274 | 2025-06-22 03:15:54.762898 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-06-22 03:15:55.294030 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-06-22 03:15:55.341063 | debian-bookworm | ok: Runtime: 0:00:00.025208 2025-06-22 03:15:55.348188 | 2025-06-22 03:15:55.348599 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-06-22 03:15:55.876605 | debian-bookworm | ok: Runtime: 0:00:00.008472 2025-06-22 03:15:55.892483 | 2025-06-22 03:15:55.892716 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-06-22 03:15:56.173417 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-06-22 03:15:56.175173 | debian-bookworm | sudo: a password is required 2025-06-22 03:15:56.428246 | debian-bookworm | ok: Runtime: 0:00:00.019242 2025-06-22 03:15:56.457912 | 2025-06-22 03:15:56.458029 | TASK [tox : Check to see if the constraints file exists] 2025-06-22 03:15:56.482032 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:15:56.491541 | 2025-06-22 03:15:56.491676 | TASK [tox : Fail if constraints file is missing] 2025-06-22 03:15:56.526155 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:15:56.542137 | 2025-06-22 03:15:56.542287 | TASK [tox : Record file location] 2025-06-22 03:15:56.567346 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:15:56.582759 | 2025-06-22 03:15:56.582963 | TASK [tox : Install tox siblings] 2025-06-22 03:15:56.621347 | debian-bookworm | ok 2025-06-22 03:15:56.633136 | debian-bookworm | included: /var/lib/zuul/builds/adcebb16d142416e82d7b56800b9fa7b/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-06-22 03:15:56.639929 | 2025-06-22 03:15:56.640031 | TASK [tox : Run tox without tests] 2025-06-22 03:15:57.742642 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-06-22 03:16:11.350147 | debian-bookworm | test: OK (14.14 seconds) 2025-06-22 03:16:11.350198 | debian-bookworm | congratulations :) (14.21 seconds) 2025-06-22 03:16:11.675321 | debian-bookworm | ok: Runtime: 0:00:14.464274 2025-06-22 03:16:11.689911 | 2025-06-22 03:16:11.690089 | TASK [tox : Create a tempfile to save tox showconfig] 2025-06-22 03:16:12.076565 | debian-bookworm | changed 2025-06-22 03:16:12.084568 | 2025-06-22 03:16:12.084743 | TASK [tox : Get tox envlist config] 2025-06-22 03:16:13.125255 | debian-bookworm | ok: Runtime: 0:00:00.284929 2025-06-22 03:16:13.133267 | 2025-06-22 03:16:13.133886 | TASK [tox : Install any sibling python packages] 2025-06-22 03:16:13.579896 | debian-bookworm | ok: No setup.cfg, no action needed 2025-06-22 03:16:13.586393 | 2025-06-22 03:16:13.586521 | TASK [tox : Remove tempfile] 2025-06-22 03:16:14.018238 | debian-bookworm | changed 2025-06-22 03:16:14.025928 | 2025-06-22 03:16:14.026057 | TASK [tox : Emit tox command] 2025-06-22 03:16:14.084359 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-06-22 03:16:14.098416 | 2025-06-22 03:16:14.098651 | TASK [tox : Run tox] 2025-06-22 03:16:14.712142 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-06-22 03:16:15.164884 | debian-bookworm | /home/zuul/src/github.com/osism/openstack-image-manager/openstack_image_manager/__init__.py:5: UserWarning: pkg_resources is deprecated as an API. See https://setuptools.pypa.io/en/latest/pkg_resources.html. The pkg_resources package is slated for removal as early as 2025-11-30. Refrain from using this package or pin to Setuptools<81. 2025-06-22 03:16:15.164925 | debian-bookworm | from pkg_resources import get_distribution, DistributionNotFound 2025-06-22 03:16:15.465964 | debian-bookworm | ............... 2025-06-22 03:16:15.466002 | debian-bookworm | ---------------------------------------------------------------------- 2025-06-22 03:16:15.466009 | debian-bookworm | Ran 15 tests in 0.171s 2025-06-22 03:16:15.466014 | debian-bookworm | 2025-06-22 03:16:15.466031 | debian-bookworm | OK 2025-06-22 03:16:15.545966 | debian-bookworm | test: OK (0.87=setup[0.04]+cmd[0.83] seconds) 2025-06-22 03:16:15.546033 | debian-bookworm | congratulations :) (0.94 seconds) 2025-06-22 03:16:15.681943 | debian-bookworm | ok: Runtime: 0:00:01.150455 2025-06-22 03:16:15.695398 | 2025-06-22 03:16:15.695556 | TASK [tox : Look for output] 2025-06-22 03:16:16.081719 | debian-bookworm | ok 2025-06-22 03:16:16.098544 | 2025-06-22 03:16:16.098729 | TASK [tox : Return file comments to Zuul] 2025-06-22 03:16:16.143368 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:16.156722 | 2025-06-22 03:16:16.156838 | PLAY RECAP 2025-06-22 03:16:16.156899 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-06-22 03:16:16.156928 | 2025-06-22 03:16:16.294102 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-06-22 03:16:16.295266 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-06-22 03:16:17.242453 | 2025-06-22 03:16:17.243156 | PLAY [all] 2025-06-22 03:16:17.263914 | 2025-06-22 03:16:17.264087 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-06-22 03:16:17.319334 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:17.325489 | 2025-06-22 03:16:17.325648 | TASK [fetch-tox-output : Set tox log path for single node] 2025-06-22 03:16:17.366527 | debian-bookworm | ok 2025-06-22 03:16:17.372594 | 2025-06-22 03:16:17.372750 | TASK [fetch-tox-output : Ensure local tox dir] 2025-06-22 03:16:17.940089 | debian-bookworm -> localhost | changed 2025-06-22 03:16:17.950965 | 2025-06-22 03:16:17.951317 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-06-22 03:16:18.053068 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:18.072575 | 2025-06-22 03:16:18.073731 | TASK [fetch-tox-output : Set envlist fact] 2025-06-22 03:16:18.138184 | debian-bookworm | ok 2025-06-22 03:16:18.166736 | 2025-06-22 03:16:18.167471 | TASK [fetch-tox-output : Get tox version] 2025-06-22 03:16:18.986227 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-06-22 03:16:19.004544 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-06-22 03:16:19.234526 | debian-bookworm | ok: Runtime: 0:00:00.284850 2025-06-22 03:16:19.241552 | 2025-06-22 03:16:19.241739 | TASK [fetch-tox-output : Find all default environments] 2025-06-22 03:16:19.799520 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:19.807788 | 2025-06-22 03:16:19.807926 | TASK [fetch-tox-output : Set envlist fact] 2025-06-22 03:16:19.861867 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:19.867932 | 2025-06-22 03:16:19.868054 | TASK [fetch-tox-output : Find all default environments] 2025-06-22 03:16:20.433220 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:20.441174 | 2025-06-22 03:16:20.441316 | TASK [fetch-tox-output : Set envlist fact] 2025-06-22 03:16:20.499559 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:20.507831 | 2025-06-22 03:16:20.507973 | LOOP [fetch-tox-output : Copy tox logs] 2025-06-22 03:16:20.581090 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:20.592952 | 2025-06-22 03:16:20.593094 | LOOP [fetch-tox-output : Collect tox logs] 2025-06-22 03:16:21.521520 | debian-bookworm | changed: 2025-06-22 03:16:21.521819 | debian-bookworm | created directory /var/lib/zuul/builds/adcebb16d142416e82d7b56800b9fa7b/work/logs/tox/test 2025-06-22 03:16:21.521878 | debian-bookworm | cd+++++++++ ./ 2025-06-22 03:16:21.521919 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-06-22 03:16:21.521966 | 2025-06-22 03:16:21.530632 | 2025-06-22 03:16:21.531196 | PLAY RECAP 2025-06-22 03:16:21.531303 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-06-22 03:16:21.531333 | 2025-06-22 03:16:21.693121 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-06-22 03:16:21.694196 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-06-22 03:16:22.721584 | 2025-06-22 03:16:22.721771 | PLAY [all] 2025-06-22 03:16:22.738174 | 2025-06-22 03:16:22.738343 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-06-22 03:16:23.022466 | debian-bookworm | changed: non-zero return code 2025-06-22 03:16:23.028604 | 2025-06-22 03:16:23.028805 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-06-22 03:16:23.081968 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:23.088502 | 2025-06-22 03:16:23.088648 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-06-22 03:16:23.139929 | 2025-06-22 03:16:23.140143 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-06-22 03:16:23.181862 | 2025-06-22 03:16:23.182077 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-06-22 03:16:23.206319 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:23.213036 | 2025-06-22 03:16:23.213173 | LOOP [fetch-subunit-output : Generate subunit file] 2025-06-22 03:16:23.243429 | 2025-06-22 03:16:23.243655 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-06-22 03:16:23.267698 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:23.275167 | 2025-06-22 03:16:23.275311 | TASK [fetch-subunit-output : Remove the temporary file] 2025-06-22 03:16:23.299689 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:23.305559 | 2025-06-22 03:16:23.305695 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-06-22 03:16:23.329586 | debian-bookworm | skipping: Conditional result was False 2025-06-22 03:16:23.336148 | 2025-06-22 03:16:23.336240 | PLAY RECAP 2025-06-22 03:16:23.336294 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-06-22 03:16:23.336321 | 2025-06-22 03:16:23.471478 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-06-22 03:16:23.472641 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-22 03:16:24.294512 | 2025-06-22 03:16:24.294722 | PLAY [Base post] 2025-06-22 03:16:24.310249 | 2025-06-22 03:16:24.310419 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-06-22 03:16:24.901025 | debian-bookworm | changed 2025-06-22 03:16:24.910258 | 2025-06-22 03:16:24.910399 | PLAY RECAP 2025-06-22 03:16:24.910465 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-06-22 03:16:24.910529 | 2025-06-22 03:16:25.344626 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-22 03:16:25.345794 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-06-22 03:16:26.567656 | 2025-06-22 03:16:26.567887 | PLAY [Base post-logs] 2025-06-22 03:16:26.581359 | 2025-06-22 03:16:26.581535 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-06-22 03:16:27.584408 | localhost | changed 2025-06-22 03:16:27.601652 | 2025-06-22 03:16:27.601883 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-06-22 03:16:27.658664 | localhost | ok 2025-06-22 03:16:27.662027 | 2025-06-22 03:16:27.662139 | TASK [Set zuul-log-path fact] 2025-06-22 03:16:27.698443 | localhost | ok 2025-06-22 03:16:27.707732 | 2025-06-22 03:16:27.707885 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-22 03:16:27.758955 | localhost | ok 2025-06-22 03:16:27.762176 | 2025-06-22 03:16:27.762303 | TASK [upload-logs : Create log directories] 2025-06-22 03:16:28.389552 | localhost | changed 2025-06-22 03:16:28.392090 | 2025-06-22 03:16:28.392168 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-06-22 03:16:29.136393 | localhost -> localhost | ok: Runtime: 0:00:00.013487 2025-06-22 03:16:29.139444 | 2025-06-22 03:16:29.139527 | TASK [upload-logs : Upload logs to log server] 2025-06-22 03:16:29.898639 | localhost | Output suppressed because no_log was given 2025-06-22 03:16:29.900181 | 2025-06-22 03:16:29.900257 | LOOP [upload-logs : Compress console log and json output] 2025-06-22 03:16:29.986813 | localhost | skipping: Conditional result was False 2025-06-22 03:16:29.998808 | localhost | skipping: Conditional result was False 2025-06-22 03:16:30.006481 | 2025-06-22 03:16:30.006566 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-22 03:16:30.074584 | localhost | skipping: Conditional result was False 2025-06-22 03:16:30.074872 | 2025-06-22 03:16:30.085958 | localhost | skipping: Conditional result was False 2025-06-22 03:16:30.091280 | 2025-06-22 03:16:30.091364 | LOOP [upload-logs : Upload console log and json output]