2025-12-14 00:19:43.858092 | Job console starting 2025-12-14 00:19:43.895765 | Updating git repos 2025-12-14 00:19:44.298519 | Cloning repos into workspace 2025-12-14 00:19:44.434648 | Restoring repo states 2025-12-14 00:19:44.462158 | Merging changes 2025-12-14 00:19:45.016814 | Checking out repos 2025-12-14 00:19:45.128127 | Preparing playbooks 2025-12-14 00:19:46.366071 | Running Ansible setup 2025-12-14 00:19:53.932160 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-14 00:19:55.730058 | 2025-12-14 00:19:55.730255 | PLAY [Base pre] 2025-12-14 00:19:55.768641 | 2025-12-14 00:19:55.768809 | TASK [Setup log path fact] 2025-12-14 00:19:55.798665 | debian-bookworm | ok 2025-12-14 00:19:55.826687 | 2025-12-14 00:19:55.826885 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-14 00:19:55.889882 | debian-bookworm | ok 2025-12-14 00:19:55.916380 | 2025-12-14 00:19:55.916527 | TASK [emit-job-header : Print job information] 2025-12-14 00:19:56.025828 | # Job Information 2025-12-14 00:19:56.026032 | Ansible Version: 2.16.14 2025-12-14 00:19:56.026068 | Job: tox 2025-12-14 00:19:56.026099 | Pipeline: check 2025-12-14 00:19:56.026122 | Executor: 521e9411259a 2025-12-14 00:19:56.026143 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1034 2025-12-14 00:19:56.026165 | Event ID: 9189f150-d882-11f0-926c-fe9d72b36e79 2025-12-14 00:19:56.031987 | 2025-12-14 00:19:56.032114 | LOOP [emit-job-header : Print node information] 2025-12-14 00:19:56.343735 | debian-bookworm | ok: 2025-12-14 00:19:56.344020 | debian-bookworm | # Node Information 2025-12-14 00:19:56.344068 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-14 00:19:56.344095 | debian-bookworm | Hostname: debian 2025-12-14 00:19:56.344118 | debian-bookworm | Username: zuul 2025-12-14 00:19:56.344140 | debian-bookworm | Distro: Debian 12.12 2025-12-14 00:19:56.344221 | debian-bookworm | Provider: regiocloud-a 2025-12-14 00:19:56.344245 | debian-bookworm | Region: 2025-12-14 00:19:56.344282 | debian-bookworm | Label: debian-bookworm 2025-12-14 00:19:56.344305 | debian-bookworm | Product Name: OpenStack Nova 2025-12-14 00:19:56.344326 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7f:e192 2025-12-14 00:19:56.367918 | 2025-12-14 00:19:56.368077 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-14 00:19:57.565569 | debian-bookworm -> localhost | changed 2025-12-14 00:19:57.573160 | 2025-12-14 00:19:57.573347 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-14 00:20:01.005130 | debian-bookworm -> localhost | changed 2025-12-14 00:20:01.056102 | 2025-12-14 00:20:01.056307 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-14 00:20:02.759025 | debian-bookworm -> localhost | ok 2025-12-14 00:20:02.767028 | 2025-12-14 00:20:02.767170 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-14 00:20:02.821803 | debian-bookworm | ok 2025-12-14 00:20:02.858765 | debian-bookworm | included: /var/lib/zuul/builds/8426327fc3074e77ba5af4ed5e353547/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-14 00:20:02.867072 | 2025-12-14 00:20:02.867247 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-14 00:20:06.598651 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-14 00:20:06.598963 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8426327fc3074e77ba5af4ed5e353547/work/8426327fc3074e77ba5af4ed5e353547_id_rsa 2025-12-14 00:20:06.599005 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8426327fc3074e77ba5af4ed5e353547/work/8426327fc3074e77ba5af4ed5e353547_id_rsa.pub 2025-12-14 00:20:06.599032 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-14 00:20:06.599057 | debian-bookworm -> localhost | SHA256:gQnNy9cbWIUmNj9n0SCB/4vlKuwcLAHtPVPYBtwRo+4 zuul-build-sshkey 2025-12-14 00:20:06.599079 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-14 00:20:06.599120 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-14 00:20:06.599143 | debian-bookworm -> localhost | | .o ..o**oo | 2025-12-14 00:20:06.599165 | debian-bookworm -> localhost | | ooo*==o. . | 2025-12-14 00:20:06.599250 | debian-bookworm -> localhost | | ..+o+X+ . | 2025-12-14 00:20:06.599288 | debian-bookworm -> localhost | | oooo+* o | 2025-12-14 00:20:06.599312 | debian-bookworm -> localhost | | o.S B | 2025-12-14 00:20:06.599339 | debian-bookworm -> localhost | | + o. o | 2025-12-14 00:20:06.599361 | debian-bookworm -> localhost | | ..E + . | 2025-12-14 00:20:06.599383 | debian-bookworm -> localhost | | oo.. o | 2025-12-14 00:20:06.599405 | debian-bookworm -> localhost | | .o... | 2025-12-14 00:20:06.599425 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-14 00:20:06.599481 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.950672 2025-12-14 00:20:06.607240 | 2025-12-14 00:20:06.607386 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-14 00:20:06.661060 | debian-bookworm | ok 2025-12-14 00:20:06.686722 | debian-bookworm | included: /var/lib/zuul/builds/8426327fc3074e77ba5af4ed5e353547/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-14 00:20:06.709999 | 2025-12-14 00:20:06.710164 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-14 00:20:06.751369 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:20:06.757809 | 2025-12-14 00:20:06.757943 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-14 00:20:07.925270 | debian-bookworm | changed 2025-12-14 00:20:07.936981 | 2025-12-14 00:20:07.937110 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-14 00:20:08.280591 | debian-bookworm | ok 2025-12-14 00:20:08.295551 | 2025-12-14 00:20:08.296950 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-14 00:20:09.118414 | debian-bookworm | changed 2025-12-14 00:20:09.147336 | 2025-12-14 00:20:09.148002 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-14 00:20:10.076142 | debian-bookworm | changed 2025-12-14 00:20:10.105452 | 2025-12-14 00:20:10.105602 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-14 00:20:10.179400 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:20:10.188446 | 2025-12-14 00:20:10.188843 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-14 00:20:12.039211 | debian-bookworm -> localhost | changed 2025-12-14 00:20:12.058507 | 2025-12-14 00:20:12.058718 | TASK [add-build-sshkey : Add back temp key] 2025-12-14 00:20:13.158565 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8426327fc3074e77ba5af4ed5e353547/work/8426327fc3074e77ba5af4ed5e353547_id_rsa (zuul-build-sshkey) 2025-12-14 00:20:13.158872 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026667 2025-12-14 00:20:13.169802 | 2025-12-14 00:20:13.169942 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-14 00:20:14.179086 | debian-bookworm | ok 2025-12-14 00:20:14.186490 | 2025-12-14 00:20:14.186639 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-14 00:20:14.281560 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:20:14.316907 | 2025-12-14 00:20:14.317056 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-14 00:20:15.251389 | debian-bookworm | ok 2025-12-14 00:20:15.287905 | 2025-12-14 00:20:15.288062 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-14 00:20:15.350306 | debian-bookworm | ok 2025-12-14 00:20:15.357043 | 2025-12-14 00:20:15.357170 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-14 00:20:16.870047 | debian-bookworm -> localhost | ok 2025-12-14 00:20:16.877086 | 2025-12-14 00:20:16.877229 | TASK [validate-host : Collect information about the host] 2025-12-14 00:20:18.866255 | debian-bookworm | ok 2025-12-14 00:20:18.885309 | 2025-12-14 00:20:18.885454 | TASK [validate-host : Sanitize hostname] 2025-12-14 00:20:19.206123 | debian-bookworm | ok 2025-12-14 00:20:19.323370 | 2025-12-14 00:20:19.323537 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-14 00:20:20.867854 | debian-bookworm -> localhost | changed 2025-12-14 00:20:20.874058 | 2025-12-14 00:20:20.874178 | TASK [validate-host : Collect information about zuul worker] 2025-12-14 00:20:21.594008 | debian-bookworm | ok 2025-12-14 00:20:21.606414 | 2025-12-14 00:20:21.606566 | TASK [validate-host : Write out all zuul information for each host] 2025-12-14 00:20:23.222333 | debian-bookworm -> localhost | changed 2025-12-14 00:20:23.238660 | 2025-12-14 00:20:23.238801 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-14 00:20:23.571589 | debian-bookworm | ok 2025-12-14 00:20:23.580234 | 2025-12-14 00:20:23.580358 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-14 00:20:25.274417 | debian-bookworm | changed: 2025-12-14 00:20:25.274639 | debian-bookworm | cd+++++++++ src/ 2025-12-14 00:20:25.274673 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-14 00:20:25.274698 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-14 00:20:25.274719 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-14 00:20:25.274740 | debian-bookworm | =6.2 2025-12-14 00:20:53.857646 | debian-bookworm | Downloading cachetools-6.2.3-py3-none-any.whl (11 kB) 2025-12-14 00:20:53.909125 | debian-bookworm | Collecting chardet>=5.2 2025-12-14 00:20:53.921725 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-14 00:20:53.936597 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 23.5 MB/s eta 0:00:00 2025-12-14 00:20:53.990813 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-14 00:20:54.004065 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-14 00:20:54.076873 | debian-bookworm | Collecting filelock>=3.20 2025-12-14 00:20:54.088200 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-12-14 00:20:54.138712 | debian-bookworm | Collecting packaging>=25 2025-12-14 00:20:54.149967 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-14 00:20:54.157489 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 11.6 MB/s eta 0:00:00 2025-12-14 00:20:54.206483 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-14 00:20:54.217530 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-14 00:20:54.257011 | debian-bookworm | Collecting pluggy>=1.6 2025-12-14 00:20:54.268621 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-14 00:20:54.316690 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-14 00:20:54.328252 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-14 00:20:54.462468 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-14 00:20:54.496563 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-14 00:20:54.791656 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 20.7 MB/s eta 0:00:00 2025-12-14 00:20:54.897337 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-14 00:20:54.910646 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-14 00:20:54.938160 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.2 MB/s eta 0:00:00 2025-12-14 00:20:55.089786 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-14 00:20:55.972907 | debian-bookworm | Successfully installed cachetools-6.2.3 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-12-14 00:20:56.331781 | debian-bookworm | ok: Runtime: 0:00:03.008548 2025-12-14 00:20:56.340030 | 2025-12-14 00:20:56.340250 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-14 00:20:56.435467 | debian-bookworm | ok 2025-12-14 00:20:56.447894 | 2025-12-14 00:20:56.448035 | TASK [ensure-tox : Output tox version] 2025-12-14 00:20:56.996649 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-14 00:20:57.014922 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-14 00:20:57.513151 | debian-bookworm | ok: Runtime: 0:00:00.289984 2025-12-14 00:20:57.519310 | 2025-12-14 00:20:57.519418 | TASK [ensure-tox : Make global symlink] 2025-12-14 00:20:57.563978 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:20:57.571710 | 2025-12-14 00:20:57.571819 | PLAY RECAP 2025-12-14 00:20:57.571875 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-14 00:20:57.571899 | 2025-12-14 00:20:58.255140 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-14 00:20:58.256431 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-14 00:21:01.173875 | 2025-12-14 00:21:01.174066 | PLAY [all] 2025-12-14 00:21:01.283249 | 2025-12-14 00:21:01.283431 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-14 00:21:03.084646 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-14 00:21:03.355032 | debian-bookworm | ok: Runtime: 0:00:00.025794 2025-12-14 00:21:03.360875 | 2025-12-14 00:21:03.361020 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-14 00:21:04.001679 | debian-bookworm | ok: Runtime: 0:00:00.006746 2025-12-14 00:21:04.008916 | 2025-12-14 00:21:04.009066 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-14 00:21:04.569944 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-14 00:21:04.573579 | debian-bookworm | sudo: a password is required 2025-12-14 00:21:04.679731 | debian-bookworm | ok: Runtime: 0:00:00.022225 2025-12-14 00:21:04.705121 | 2025-12-14 00:21:04.705294 | TASK [tox : Check to see if the constraints file exists] 2025-12-14 00:21:04.835173 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:04.843506 | 2025-12-14 00:21:04.843673 | TASK [tox : Fail if constraints file is missing] 2025-12-14 00:21:04.935693 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:04.944212 | 2025-12-14 00:21:04.944359 | TASK [tox : Record file location] 2025-12-14 00:21:05.003222 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:05.021860 | 2025-12-14 00:21:05.022004 | TASK [tox : Install tox siblings] 2025-12-14 00:21:05.153278 | debian-bookworm | ok 2025-12-14 00:21:05.201655 | debian-bookworm | included: /var/lib/zuul/builds/8426327fc3074e77ba5af4ed5e353547/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-14 00:21:05.243451 | 2025-12-14 00:21:05.243619 | TASK [tox : Run tox without tests] 2025-12-14 00:21:06.628238 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-14 00:21:20.277759 | debian-bookworm | test: OK (14.16 seconds) 2025-12-14 00:21:20.277833 | debian-bookworm | congratulations :) (14.19 seconds) 2025-12-14 00:21:20.443784 | debian-bookworm | ok: Runtime: 0:00:14.465886 2025-12-14 00:21:20.450981 | 2025-12-14 00:21:20.451110 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-14 00:21:21.097606 | debian-bookworm | changed 2025-12-14 00:21:21.110767 | 2025-12-14 00:21:21.112762 | TASK [tox : Get tox envlist config] 2025-12-14 00:21:22.222009 | debian-bookworm | ok: Runtime: 0:00:00.334467 2025-12-14 00:21:22.250482 | 2025-12-14 00:21:22.250632 | TASK [tox : Install any sibling python packages] 2025-12-14 00:21:23.141526 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-14 00:21:23.148222 | 2025-12-14 00:21:23.148362 | TASK [tox : Remove tempfile] 2025-12-14 00:21:23.985119 | debian-bookworm | changed 2025-12-14 00:21:24.010637 | 2025-12-14 00:21:24.010801 | TASK [tox : Emit tox command] 2025-12-14 00:21:24.119243 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-14 00:21:24.124810 | 2025-12-14 00:21:24.124950 | TASK [tox : Run tox] 2025-12-14 00:21:25.047104 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-14 00:21:25.668319 | debian-bookworm | ............... 2025-12-14 00:21:25.668368 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-14 00:21:25.668384 | debian-bookworm | Ran 15 tests in 0.169s 2025-12-14 00:21:25.668389 | debian-bookworm | 2025-12-14 00:21:25.668398 | debian-bookworm | OK 2025-12-14 00:21:25.759152 | debian-bookworm | test: OK (0.76=setup[0.05]+cmd[0.71] seconds) 2025-12-14 00:21:25.759221 | debian-bookworm | congratulations :) (0.78 seconds) 2025-12-14 00:21:25.886612 | debian-bookworm | ok: Runtime: 0:00:01.065734 2025-12-14 00:21:25.892741 | 2025-12-14 00:21:25.892860 | TASK [tox : Look for output] 2025-12-14 00:21:26.986331 | debian-bookworm | ok 2025-12-14 00:21:27.038240 | 2025-12-14 00:21:27.038406 | TASK [tox : Return file comments to Zuul] 2025-12-14 00:21:27.114424 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:27.124036 | 2025-12-14 00:21:27.124150 | PLAY RECAP 2025-12-14 00:21:27.124229 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-14 00:21:27.124258 | 2025-12-14 00:21:27.744993 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-14 00:21:27.746256 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-14 00:21:29.225078 | 2025-12-14 00:21:29.225329 | PLAY [all] 2025-12-14 00:21:29.266825 | 2025-12-14 00:21:29.267076 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-14 00:21:29.392277 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:29.399925 | 2025-12-14 00:21:29.400122 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-14 00:21:29.489648 | debian-bookworm | ok 2025-12-14 00:21:29.505862 | 2025-12-14 00:21:29.506011 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-14 00:21:31.120030 | debian-bookworm -> localhost | changed 2025-12-14 00:21:31.135547 | 2025-12-14 00:21:31.135698 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-14 00:21:31.210604 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:31.224553 | 2025-12-14 00:21:31.224711 | TASK [fetch-tox-output : Set envlist fact] 2025-12-14 00:21:31.384820 | debian-bookworm | ok 2025-12-14 00:21:31.418454 | 2025-12-14 00:21:31.418611 | TASK [fetch-tox-output : Get tox version] 2025-12-14 00:21:33.128204 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-14 00:21:33.146256 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-14 00:21:33.534683 | debian-bookworm | ok: Runtime: 0:00:00.286690 2025-12-14 00:21:33.541677 | 2025-12-14 00:21:33.541815 | TASK [fetch-tox-output : Find all default environments] 2025-12-14 00:21:34.144203 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:34.150563 | 2025-12-14 00:21:34.150726 | TASK [fetch-tox-output : Set envlist fact] 2025-12-14 00:21:34.234677 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:34.241520 | 2025-12-14 00:21:34.241654 | TASK [fetch-tox-output : Find all default environments] 2025-12-14 00:21:34.858043 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:34.867217 | 2025-12-14 00:21:34.867367 | TASK [fetch-tox-output : Set envlist fact] 2025-12-14 00:21:34.969887 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:34.977514 | 2025-12-14 00:21:34.977659 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-14 00:21:35.093492 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:35.104626 | 2025-12-14 00:21:35.104823 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-14 00:21:37.827325 | debian-bookworm | changed: 2025-12-14 00:21:37.827553 | debian-bookworm | created directory /var/lib/zuul/builds/8426327fc3074e77ba5af4ed5e353547/work/logs/tox/test 2025-12-14 00:21:37.827590 | debian-bookworm | cd+++++++++ ./ 2025-12-14 00:21:37.827619 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-14 00:21:37.827653 | 2025-12-14 00:21:37.848068 | 2025-12-14 00:21:37.848229 | PLAY RECAP 2025-12-14 00:21:37.848294 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-14 00:21:37.848320 | 2025-12-14 00:21:38.667754 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-14 00:21:38.668897 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-14 00:21:41.489634 | 2025-12-14 00:21:41.489816 | PLAY [all] 2025-12-14 00:21:41.594452 | 2025-12-14 00:21:41.594626 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-14 00:21:42.137180 | debian-bookworm | changed: non-zero return code 2025-12-14 00:21:42.147535 | 2025-12-14 00:21:42.147708 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-14 00:21:42.230442 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:42.237323 | 2025-12-14 00:21:42.237463 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-14 00:21:42.290895 | 2025-12-14 00:21:42.291120 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-14 00:21:42.363277 | 2025-12-14 00:21:42.363582 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-14 00:21:42.411923 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:42.419989 | 2025-12-14 00:21:42.420134 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-14 00:21:42.544388 | 2025-12-14 00:21:42.544617 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-14 00:21:42.585508 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:42.592674 | 2025-12-14 00:21:42.592818 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-14 00:21:42.695480 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:42.703250 | 2025-12-14 00:21:42.703820 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-14 00:21:42.783795 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:42.791530 | 2025-12-14 00:21:42.791635 | PLAY RECAP 2025-12-14 00:21:42.791691 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-14 00:21:42.791718 | 2025-12-14 00:21:43.270852 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-14 00:21:43.275589 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-14 00:21:45.208799 | 2025-12-14 00:21:45.208983 | PLAY [Base post] 2025-12-14 00:21:45.238821 | 2025-12-14 00:21:45.239028 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-14 00:21:46.127581 | debian-bookworm | changed 2025-12-14 00:21:46.149808 | 2025-12-14 00:21:46.149959 | PLAY RECAP 2025-12-14 00:21:46.150028 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-14 00:21:46.150093 | 2025-12-14 00:21:46.406706 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-14 00:21:46.408640 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-14 00:21:47.709950 | 2025-12-14 00:21:47.710117 | PLAY [Base post-logs] 2025-12-14 00:21:47.722631 | 2025-12-14 00:21:47.722794 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-14 00:21:48.618380 | localhost | changed 2025-12-14 00:21:48.632984 | 2025-12-14 00:21:48.633261 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-14 00:21:48.677175 | localhost | ok 2025-12-14 00:21:48.682714 | 2025-12-14 00:21:48.682940 | TASK [Set zuul-log-path fact] 2025-12-14 00:21:48.739915 | localhost | ok 2025-12-14 00:21:48.765140 | 2025-12-14 00:21:48.765320 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-14 00:21:48.814959 | localhost | ok 2025-12-14 00:21:48.819241 | 2025-12-14 00:21:48.819435 | TASK [upload-logs : Create log directories] 2025-12-14 00:21:50.244059 | localhost | changed 2025-12-14 00:21:50.247419 | 2025-12-14 00:21:50.247546 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-14 00:21:51.460839 | localhost -> localhost | ok: Runtime: 0:00:00.031081 2025-12-14 00:21:51.466645 | 2025-12-14 00:21:51.466800 | TASK [upload-logs : Upload logs to log server] 2025-12-14 00:21:52.371999 | localhost | Output suppressed because no_log was given 2025-12-14 00:21:52.373959 | 2025-12-14 00:21:52.374064 | LOOP [upload-logs : Compress console log and json output] 2025-12-14 00:21:52.442665 | localhost | skipping: Conditional result was False 2025-12-14 00:21:52.451184 | localhost | skipping: Conditional result was False 2025-12-14 00:21:52.469507 | 2025-12-14 00:21:52.469650 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-14 00:21:52.526327 | localhost | skipping: Conditional result was False 2025-12-14 00:21:52.526622 | 2025-12-14 00:21:52.533931 | localhost | skipping: Conditional result was False 2025-12-14 00:21:52.538473 | 2025-12-14 00:21:52.538611 | LOOP [upload-logs : Upload console log and json output]