2025-10-19 17:55:48.539614 | Job console starting 2025-10-19 17:55:48.577134 | Updating git repos 2025-10-19 17:55:48.619225 | Cloning repos into workspace 2025-10-19 17:55:48.675726 | Restoring repo states 2025-10-19 17:55:48.686333 | Merging changes 2025-10-19 17:55:49.241895 | Checking out repos 2025-10-19 17:55:49.323810 | Preparing playbooks 2025-10-19 17:55:50.092170 | Running Ansible setup 2025-10-19 17:55:55.318072 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-19 17:55:56.382088 | 2025-10-19 17:55:56.382215 | PLAY [Base pre] 2025-10-19 17:55:56.396967 | 2025-10-19 17:55:56.397078 | TASK [Setup log path fact] 2025-10-19 17:55:56.424814 | debian-bookworm | ok 2025-10-19 17:55:56.459325 | 2025-10-19 17:55:56.459459 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-19 17:55:56.504490 | debian-bookworm | ok 2025-10-19 17:55:56.518042 | 2025-10-19 17:55:56.518155 | TASK [emit-job-header : Print job information] 2025-10-19 17:55:56.556921 | # Job Information 2025-10-19 17:55:56.557070 | Ansible Version: 2.16.14 2025-10-19 17:55:56.557104 | Job: tox 2025-10-19 17:55:56.557135 | Pipeline: check 2025-10-19 17:55:56.557158 | Executor: 521e9411259a 2025-10-19 17:55:56.557179 | Triggered by: https://github.com/osism/openstack-image-manager/pull/965 2025-10-19 17:55:56.557202 | Event ID: d319cd00-ad14-11f0-97bf-3ea05d137a08 2025-10-19 17:55:56.561896 | 2025-10-19 17:55:56.561986 | LOOP [emit-job-header : Print node information] 2025-10-19 17:55:56.662117 | debian-bookworm | ok: 2025-10-19 17:55:56.662269 | debian-bookworm | # Node Information 2025-10-19 17:55:56.662302 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-19 17:55:56.662328 | debian-bookworm | Hostname: debian 2025-10-19 17:55:56.662349 | debian-bookworm | Username: zuul 2025-10-19 17:55:56.662370 | debian-bookworm | Distro: Debian 12.12 2025-10-19 17:55:56.662394 | debian-bookworm | Provider: regiocloud-a 2025-10-19 17:55:56.662414 | debian-bookworm | Region: 2025-10-19 17:55:56.662435 | debian-bookworm | Label: debian-bookworm 2025-10-19 17:55:56.662454 | debian-bookworm | Product Name: OpenStack Nova 2025-10-19 17:55:56.662473 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe85:aeb0 2025-10-19 17:55:56.680749 | 2025-10-19 17:55:56.680849 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-19 17:55:57.242308 | debian-bookworm -> localhost | changed 2025-10-19 17:55:57.247958 | 2025-10-19 17:55:57.248047 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-19 17:55:58.486771 | debian-bookworm -> localhost | changed 2025-10-19 17:55:58.498056 | 2025-10-19 17:55:58.498157 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-19 17:55:58.795132 | debian-bookworm -> localhost | ok 2025-10-19 17:55:58.800008 | 2025-10-19 17:55:58.800097 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-19 17:55:58.826929 | debian-bookworm | ok 2025-10-19 17:55:58.840733 | debian-bookworm | included: /var/lib/zuul/builds/2a72cb011b544c31ac5d2b19b7c00d70/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-19 17:55:58.845666 | 2025-10-19 17:55:58.845742 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-19 17:56:00.344040 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-19 17:56:00.344202 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2a72cb011b544c31ac5d2b19b7c00d70/work/2a72cb011b544c31ac5d2b19b7c00d70_id_rsa 2025-10-19 17:56:00.344232 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2a72cb011b544c31ac5d2b19b7c00d70/work/2a72cb011b544c31ac5d2b19b7c00d70_id_rsa.pub 2025-10-19 17:56:00.344253 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-19 17:56:00.344274 | debian-bookworm -> localhost | SHA256:/mFz6YpymXyfv5W0mPJ8c5qBU11H9UVUIy28ZrZtH8k zuul-build-sshkey 2025-10-19 17:56:00.344293 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-19 17:56:00.344319 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-19 17:56:00.344337 | debian-bookworm -> localhost | | ...+X| 2025-10-19 17:56:00.344355 | debian-bookworm -> localhost | | o.o+| 2025-10-19 17:56:00.344371 | debian-bookworm -> localhost | | o +| 2025-10-19 17:56:00.344388 | debian-bookworm -> localhost | | = .o| 2025-10-19 17:56:00.344403 | debian-bookworm -> localhost | | S + =.o| 2025-10-19 17:56:00.344422 | debian-bookworm -> localhost | | . =+Eo| 2025-10-19 17:56:00.344438 | debian-bookworm -> localhost | | ..o+.=ooo+| 2025-10-19 17:56:00.344455 | debian-bookworm -> localhost | | . =+.=+o *o| 2025-10-19 17:56:00.344472 | debian-bookworm -> localhost | | o..oo++*oo| 2025-10-19 17:56:00.344488 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-19 17:56:00.344527 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.902754 2025-10-19 17:56:00.349834 | 2025-10-19 17:56:00.349914 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-19 17:56:00.375937 | debian-bookworm | ok 2025-10-19 17:56:00.385512 | debian-bookworm | included: /var/lib/zuul/builds/2a72cb011b544c31ac5d2b19b7c00d70/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-19 17:56:00.398828 | 2025-10-19 17:56:00.403031 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-19 17:56:00.425283 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:56:00.429958 | 2025-10-19 17:56:00.430028 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-19 17:56:01.001674 | debian-bookworm | changed 2025-10-19 17:56:01.006086 | 2025-10-19 17:56:01.006162 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-19 17:56:01.257272 | debian-bookworm | ok 2025-10-19 17:56:01.265555 | 2025-10-19 17:56:01.265673 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-19 17:56:01.881837 | debian-bookworm | changed 2025-10-19 17:56:01.887928 | 2025-10-19 17:56:01.888022 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-19 17:56:02.528670 | debian-bookworm | changed 2025-10-19 17:56:02.534638 | 2025-10-19 17:56:02.534792 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-19 17:56:02.558679 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:56:02.568211 | 2025-10-19 17:56:02.568320 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-19 17:56:02.946373 | debian-bookworm -> localhost | changed 2025-10-19 17:56:02.956780 | 2025-10-19 17:56:02.956877 | TASK [add-build-sshkey : Add back temp key] 2025-10-19 17:56:03.282625 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2a72cb011b544c31ac5d2b19b7c00d70/work/2a72cb011b544c31ac5d2b19b7c00d70_id_rsa (zuul-build-sshkey) 2025-10-19 17:56:03.282877 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020559 2025-10-19 17:56:03.290393 | 2025-10-19 17:56:03.290496 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-19 17:56:03.666039 | debian-bookworm | ok 2025-10-19 17:56:03.670820 | 2025-10-19 17:56:03.671008 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-19 17:56:03.703935 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:56:03.713876 | 2025-10-19 17:56:03.713974 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-19 17:56:04.226404 | debian-bookworm | ok 2025-10-19 17:56:04.244018 | 2025-10-19 17:56:04.244121 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-19 17:56:04.291558 | debian-bookworm | ok 2025-10-19 17:56:04.296314 | 2025-10-19 17:56:04.296400 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-19 17:56:04.644523 | debian-bookworm -> localhost | ok 2025-10-19 17:56:04.650440 | 2025-10-19 17:56:04.650527 | TASK [validate-host : Collect information about the host] 2025-10-19 17:56:05.733373 | debian-bookworm | ok 2025-10-19 17:56:05.754489 | 2025-10-19 17:56:05.754605 | TASK [validate-host : Sanitize hostname] 2025-10-19 17:56:05.833390 | debian-bookworm | ok 2025-10-19 17:56:05.863717 | 2025-10-19 17:56:05.863826 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-19 17:56:06.326077 | debian-bookworm -> localhost | changed 2025-10-19 17:56:06.330580 | 2025-10-19 17:56:06.330694 | TASK [validate-host : Collect information about zuul worker] 2025-10-19 17:56:06.691003 | debian-bookworm | ok 2025-10-19 17:56:06.695475 | 2025-10-19 17:56:06.695574 | TASK [validate-host : Write out all zuul information for each host] 2025-10-19 17:56:07.328271 | debian-bookworm -> localhost | changed 2025-10-19 17:56:07.337144 | 2025-10-19 17:56:07.337244 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-19 17:56:07.595836 | debian-bookworm | ok 2025-10-19 17:56:07.616625 | 2025-10-19 17:56:07.616793 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-19 17:56:08.506955 | debian-bookworm | changed: 2025-10-19 17:56:08.507115 | debian-bookworm | cd+++++++++ src/ 2025-10-19 17:56:08.507149 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-19 17:56:08.507173 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-19 17:56:08.507195 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-19 17:56:08.507215 | debian-bookworm | =6.2 2025-10-19 17:56:31.321705 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-10-19 17:56:31.376796 | debian-bookworm | Collecting chardet>=5.2 2025-10-19 17:56:31.396429 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-10-19 17:56:31.416244 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 14.6 MB/s eta 0:00:00 2025-10-19 17:56:31.474246 | debian-bookworm | Collecting colorama>=0.4.6 2025-10-19 17:56:31.487484 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-19 17:56:31.561055 | debian-bookworm | Collecting filelock>=3.20 2025-10-19 17:56:31.601778 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-10-19 17:56:31.697122 | debian-bookworm | Collecting packaging>=25 2025-10-19 17:56:31.753726 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-19 17:56:31.766177 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 6.3 MB/s eta 0:00:00 2025-10-19 17:56:31.850823 | debian-bookworm | Collecting platformdirs>=4.5 2025-10-19 17:56:31.863497 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-10-19 17:56:31.909003 | debian-bookworm | Collecting pluggy>=1.6 2025-10-19 17:56:31.921257 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-10-19 17:56:31.963589 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-10-19 17:56:31.977551 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-10-19 17:56:32.112082 | debian-bookworm | Collecting virtualenv>=20.34 2025-10-19 17:56:32.129995 | debian-bookworm | Downloading virtualenv-20.35.3-py3-none-any.whl (6.0 MB) 2025-10-19 17:56:32.371266 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 26.3 MB/s eta 0:00:00 2025-10-19 17:56:32.481333 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-10-19 17:56:32.496156 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-10-19 17:56:32.524806 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.2 MB/s eta 0:00:00 2025-10-19 17:56:32.681541 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-10-19 17:56:33.583005 | debian-bookworm | Successfully installed cachetools-6.2.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.0 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.31.0 virtualenv-20.35.3 2025-10-19 17:56:34.059167 | debian-bookworm | ok: Runtime: 0:00:03.390193 2025-10-19 17:56:34.078127 | 2025-10-19 17:56:34.078385 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-19 17:56:34.109044 | debian-bookworm | ok 2025-10-19 17:56:34.114123 | 2025-10-19 17:56:34.114232 | TASK [ensure-tox : Output tox version] 2025-10-19 17:56:34.653651 | 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-10-19 17:56:34.672171 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-19 17:56:35.160032 | debian-bookworm | ok: Runtime: 0:00:00.316385 2025-10-19 17:56:35.173445 | 2025-10-19 17:56:35.173575 | TASK [ensure-tox : Make global symlink] 2025-10-19 17:56:35.202192 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:56:35.208995 | 2025-10-19 17:56:35.209081 | PLAY RECAP 2025-10-19 17:56:35.209134 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-19 17:56:35.209159 | 2025-10-19 17:56:35.358625 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-10-19 17:56:35.359782 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-19 17:56:36.245322 | 2025-10-19 17:56:36.245493 | PLAY [all] 2025-10-19 17:56:36.261687 | 2025-10-19 17:56:36.261832 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-10-19 17:56:36.744017 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-19 17:56:36.803065 | debian-bookworm | ok: Runtime: 0:00:00.027030 2025-10-19 17:56:36.816170 | 2025-10-19 17:56:36.816353 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-10-19 17:56:37.351896 | debian-bookworm | ok: Runtime: 0:00:00.007491 2025-10-19 17:56:37.358590 | 2025-10-19 17:56:37.358755 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-10-19 17:56:37.690330 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-19 17:56:37.694535 | debian-bookworm | sudo: a password is required 2025-10-19 17:56:37.903410 | debian-bookworm | ok: Runtime: 0:00:00.028373 2025-10-19 17:56:37.925572 | 2025-10-19 17:56:37.925766 | TASK [tox : Check to see if the constraints file exists] 2025-10-19 17:56:37.950925 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:56:37.959842 | 2025-10-19 17:56:37.959978 | TASK [tox : Fail if constraints file is missing] 2025-10-19 17:56:37.994104 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:56:38.007842 | 2025-10-19 17:56:38.008008 | TASK [tox : Record file location] 2025-10-19 17:56:38.043063 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:56:38.055747 | 2025-10-19 17:56:38.055915 | TASK [tox : Install tox siblings] 2025-10-19 17:56:38.096408 | debian-bookworm | ok 2025-10-19 17:56:38.107448 | debian-bookworm | included: /var/lib/zuul/builds/2a72cb011b544c31ac5d2b19b7c00d70/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-10-19 17:56:38.113152 | 2025-10-19 17:56:38.113258 | TASK [tox : Run tox without tests] 2025-10-19 17:56:39.288736 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-10-19 17:56:53.618366 | debian-bookworm | test: OK (14.94 seconds) 2025-10-19 17:56:53.618439 | debian-bookworm | congratulations :) (14.97 seconds) 2025-10-19 17:56:54.154398 | debian-bookworm | ok: Runtime: 0:00:15.278455 2025-10-19 17:56:54.167739 | 2025-10-19 17:56:54.167920 | TASK [tox : Create a tempfile to save tox showconfig] 2025-10-19 17:56:54.580667 | debian-bookworm | changed 2025-10-19 17:56:54.588577 | 2025-10-19 17:56:54.588736 | TASK [tox : Get tox envlist config] 2025-10-19 17:56:55.621266 | debian-bookworm | ok: Runtime: 0:00:00.365505 2025-10-19 17:56:55.634562 | 2025-10-19 17:56:55.634799 | TASK [tox : Install any sibling python packages] 2025-10-19 17:56:56.090318 | debian-bookworm | ok: No setup.cfg, no action needed 2025-10-19 17:56:56.098234 | 2025-10-19 17:56:56.098361 | TASK [tox : Remove tempfile] 2025-10-19 17:56:56.530615 | debian-bookworm | changed 2025-10-19 17:56:56.540102 | 2025-10-19 17:56:56.540233 | TASK [tox : Emit tox command] 2025-10-19 17:56:56.585588 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-10-19 17:56:56.592734 | 2025-10-19 17:56:56.592855 | TASK [tox : Run tox] 2025-10-19 17:56:57.210218 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-10-19 17:56:57.872123 | debian-bookworm | ............... 2025-10-19 17:56:57.872175 | debian-bookworm | ---------------------------------------------------------------------- 2025-10-19 17:56:57.872192 | debian-bookworm | Ran 15 tests in 0.186s 2025-10-19 17:56:57.872197 | debian-bookworm | 2025-10-19 17:56:57.872204 | debian-bookworm | OK 2025-10-19 17:56:57.971269 | debian-bookworm | test: OK (0.81=setup[0.05]+cmd[0.76] seconds) 2025-10-19 17:56:57.971357 | debian-bookworm | congratulations :) (0.84 seconds) 2025-10-19 17:56:58.154013 | debian-bookworm | ok: Runtime: 0:00:01.135142 2025-10-19 17:56:58.165834 | 2025-10-19 17:56:58.165992 | TASK [tox : Look for output] 2025-10-19 17:56:58.561232 | debian-bookworm | ok 2025-10-19 17:56:58.575125 | 2025-10-19 17:56:58.575286 | TASK [tox : Return file comments to Zuul] 2025-10-19 17:56:58.608947 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:56:58.615301 | 2025-10-19 17:56:58.615383 | PLAY RECAP 2025-10-19 17:56:58.615435 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-19 17:56:58.615459 | 2025-10-19 17:56:58.729993 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-19 17:56:58.732904 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-19 17:56:59.468251 | 2025-10-19 17:56:59.468401 | PLAY [all] 2025-10-19 17:56:59.483215 | 2025-10-19 17:56:59.483336 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-10-19 17:56:59.538612 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:56:59.549862 | 2025-10-19 17:56:59.550073 | TASK [fetch-tox-output : Set tox log path for single node] 2025-10-19 17:56:59.595783 | debian-bookworm | ok 2025-10-19 17:56:59.603819 | 2025-10-19 17:56:59.603955 | TASK [fetch-tox-output : Ensure local tox dir] 2025-10-19 17:57:00.084106 | debian-bookworm -> localhost | changed 2025-10-19 17:57:00.101049 | 2025-10-19 17:57:00.101205 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-10-19 17:57:00.145959 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:00.151468 | 2025-10-19 17:57:00.151582 | TASK [fetch-tox-output : Set envlist fact] 2025-10-19 17:57:00.203958 | debian-bookworm | ok 2025-10-19 17:57:00.212408 | 2025-10-19 17:57:00.212525 | TASK [fetch-tox-output : Get tox version] 2025-10-19 17:57:00.888267 | 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-10-19 17:57:00.906914 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-19 17:57:01.242581 | debian-bookworm | ok: Runtime: 0:00:00.306138 2025-10-19 17:57:01.255368 | 2025-10-19 17:57:01.255540 | TASK [fetch-tox-output : Find all default environments] 2025-10-19 17:57:01.789320 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:01.803611 | 2025-10-19 17:57:01.803878 | TASK [fetch-tox-output : Set envlist fact] 2025-10-19 17:57:01.841059 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:01.855181 | 2025-10-19 17:57:01.855329 | TASK [fetch-tox-output : Find all default environments] 2025-10-19 17:57:02.385866 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:02.398946 | 2025-10-19 17:57:02.399125 | TASK [fetch-tox-output : Set envlist fact] 2025-10-19 17:57:02.434423 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:02.448836 | 2025-10-19 17:57:02.448991 | LOOP [fetch-tox-output : Copy tox logs] 2025-10-19 17:57:02.500587 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:02.517003 | 2025-10-19 17:57:02.517152 | LOOP [fetch-tox-output : Collect tox logs] 2025-10-19 17:57:03.290070 | debian-bookworm | changed: 2025-10-19 17:57:03.290347 | debian-bookworm | created directory /var/lib/zuul/builds/2a72cb011b544c31ac5d2b19b7c00d70/work/logs/tox/test 2025-10-19 17:57:03.290404 | debian-bookworm | cd+++++++++ ./ 2025-10-19 17:57:03.290445 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-10-19 17:57:03.290495 | 2025-10-19 17:57:03.309728 | 2025-10-19 17:57:03.309848 | PLAY RECAP 2025-10-19 17:57:03.309928 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-19 17:57:03.309970 | 2025-10-19 17:57:03.432423 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-19 17:57:03.433492 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-19 17:57:04.173285 | 2025-10-19 17:57:04.173448 | PLAY [all] 2025-10-19 17:57:04.189801 | 2025-10-19 17:57:04.189930 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-10-19 17:57:04.438043 | debian-bookworm | changed: non-zero return code 2025-10-19 17:57:04.446448 | 2025-10-19 17:57:04.446608 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-10-19 17:57:04.471471 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:04.482557 | 2025-10-19 17:57:04.482768 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-10-19 17:57:04.518521 | 2025-10-19 17:57:04.518802 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-10-19 17:57:04.561647 | 2025-10-19 17:57:04.561960 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-10-19 17:57:04.586773 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:04.600243 | 2025-10-19 17:57:04.600427 | LOOP [fetch-subunit-output : Generate subunit file] 2025-10-19 17:57:04.641707 | 2025-10-19 17:57:04.642047 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-10-19 17:57:04.668529 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:04.682199 | 2025-10-19 17:57:04.682372 | TASK [fetch-subunit-output : Remove the temporary file] 2025-10-19 17:57:04.707378 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:04.713247 | 2025-10-19 17:57:04.713353 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-10-19 17:57:04.737014 | debian-bookworm | skipping: Conditional result was False 2025-10-19 17:57:04.745656 | 2025-10-19 17:57:04.745763 | PLAY RECAP 2025-10-19 17:57:04.745828 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-19 17:57:04.745858 | 2025-10-19 17:57:04.862134 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-19 17:57:04.863253 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-19 17:57:05.566392 | 2025-10-19 17:57:05.566568 | PLAY [Base post] 2025-10-19 17:57:05.580651 | 2025-10-19 17:57:05.580822 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-19 17:57:06.161202 | debian-bookworm | changed 2025-10-19 17:57:06.170363 | 2025-10-19 17:57:06.170493 | PLAY RECAP 2025-10-19 17:57:06.170576 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-19 17:57:06.170711 | 2025-10-19 17:57:06.283388 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-19 17:57:06.284477 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-19 17:57:07.040563 | 2025-10-19 17:57:07.040767 | PLAY [Base post-logs] 2025-10-19 17:57:07.051405 | 2025-10-19 17:57:07.051535 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-19 17:57:07.492203 | localhost | changed 2025-10-19 17:57:07.501991 | 2025-10-19 17:57:07.502138 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-19 17:57:07.538033 | localhost | ok 2025-10-19 17:57:07.541622 | 2025-10-19 17:57:07.541743 | TASK [Set zuul-log-path fact] 2025-10-19 17:57:07.558556 | localhost | ok 2025-10-19 17:57:07.567503 | 2025-10-19 17:57:07.567607 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-19 17:57:07.603746 | localhost | ok 2025-10-19 17:57:07.609283 | 2025-10-19 17:57:07.609453 | TASK [upload-logs : Create log directories] 2025-10-19 17:57:08.083779 | localhost | changed 2025-10-19 17:57:08.086512 | 2025-10-19 17:57:08.086613 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-19 17:57:08.560480 | localhost -> localhost | ok: Runtime: 0:00:00.007032 2025-10-19 17:57:08.570187 | 2025-10-19 17:57:08.570433 | TASK [upload-logs : Upload logs to log server] 2025-10-19 17:57:09.117514 | localhost | Output suppressed because no_log was given 2025-10-19 17:57:09.120754 | 2025-10-19 17:57:09.120918 | LOOP [upload-logs : Compress console log and json output] 2025-10-19 17:57:09.168304 | localhost | skipping: Conditional result was False 2025-10-19 17:57:09.174434 | localhost | skipping: Conditional result was False 2025-10-19 17:57:09.182523 | 2025-10-19 17:57:09.182905 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-19 17:57:09.230615 | localhost | skipping: Conditional result was False 2025-10-19 17:57:09.232080 | 2025-10-19 17:57:09.235235 | localhost | skipping: Conditional result was False 2025-10-19 17:57:09.247373 | 2025-10-19 17:57:09.247615 | LOOP [upload-logs : Upload console log and json output]