2025-11-27 03:10:27.130002 | Job console starting 2025-11-27 03:10:27.194112 | Updating git repos 2025-11-27 03:10:27.250913 | Cloning repos into workspace 2025-11-27 03:10:27.329579 | Restoring repo states 2025-11-27 03:10:27.350128 | Merging changes 2025-11-27 03:10:27.350151 | Checking out repos 2025-11-27 03:10:27.499447 | Preparing playbooks 2025-11-27 03:10:28.758265 | Running Ansible setup 2025-11-27 03:10:34.719110 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-27 03:10:35.626726 | 2025-11-27 03:10:35.626885 | PLAY [Base pre] 2025-11-27 03:10:35.653561 | 2025-11-27 03:10:35.653687 | TASK [Setup log path fact] 2025-11-27 03:10:35.671408 | debian-bookworm | ok 2025-11-27 03:10:35.690321 | 2025-11-27 03:10:35.690483 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-27 03:10:35.719408 | debian-bookworm | ok 2025-11-27 03:10:35.728760 | 2025-11-27 03:10:35.728866 | TASK [emit-job-header : Print job information] 2025-11-27 03:10:35.799167 | # Job Information 2025-11-27 03:10:35.799340 | Ansible Version: 2.16.14 2025-11-27 03:10:35.799376 | Job: tox 2025-11-27 03:10:35.799423 | Pipeline: periodic-daily 2025-11-27 03:10:35.799447 | Executor: 521e9411259a 2025-11-27 03:10:35.799468 | Triggered by: https://github.com/osism/openstack-image-manager 2025-11-27 03:10:35.799490 | Event ID: 0a7c277c088346c488aa048f59f183f2 2025-11-27 03:10:35.804738 | 2025-11-27 03:10:35.804839 | LOOP [emit-job-header : Print node information] 2025-11-27 03:10:35.929136 | debian-bookworm | ok: 2025-11-27 03:10:35.929318 | debian-bookworm | # Node Information 2025-11-27 03:10:35.929359 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-27 03:10:35.929396 | debian-bookworm | Hostname: debian 2025-11-27 03:10:35.929457 | debian-bookworm | Username: zuul 2025-11-27 03:10:35.929482 | debian-bookworm | Distro: Debian 12.12 2025-11-27 03:10:35.929506 | debian-bookworm | Provider: regiocloud-a 2025-11-27 03:10:35.929527 | debian-bookworm | Region: 2025-11-27 03:10:35.929549 | debian-bookworm | Label: debian-bookworm 2025-11-27 03:10:35.929569 | debian-bookworm | Product Name: OpenStack Nova 2025-11-27 03:10:35.929589 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe58:a32b 2025-11-27 03:10:35.953783 | 2025-11-27 03:10:35.953901 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-27 03:10:36.766715 | debian-bookworm -> localhost | changed 2025-11-27 03:10:36.773499 | 2025-11-27 03:10:36.773613 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-27 03:10:38.018856 | debian-bookworm -> localhost | changed 2025-11-27 03:10:38.032999 | 2025-11-27 03:10:38.042726 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-27 03:10:38.463712 | debian-bookworm -> localhost | ok 2025-11-27 03:10:38.475134 | 2025-11-27 03:10:38.475308 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-27 03:10:38.495530 | debian-bookworm | ok 2025-11-27 03:10:38.513001 | debian-bookworm | included: /var/lib/zuul/builds/fbac7790ba80465fb5b84c26b167f5b1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-27 03:10:38.519824 | 2025-11-27 03:10:38.519930 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-27 03:10:39.515397 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-27 03:10:39.515636 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fbac7790ba80465fb5b84c26b167f5b1/work/fbac7790ba80465fb5b84c26b167f5b1_id_rsa 2025-11-27 03:10:39.515675 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fbac7790ba80465fb5b84c26b167f5b1/work/fbac7790ba80465fb5b84c26b167f5b1_id_rsa.pub 2025-11-27 03:10:39.515702 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-27 03:10:39.515728 | debian-bookworm -> localhost | SHA256:TD7d63y3nHPJuRE8lZONtRKnsOTlK9/YFCtDS9c7Jf4 zuul-build-sshkey 2025-11-27 03:10:39.515751 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-27 03:10:39.515785 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-27 03:10:39.515808 | debian-bookworm -> localhost | | o o ..| 2025-11-27 03:10:39.515830 | debian-bookworm -> localhost | | o = +o*| 2025-11-27 03:10:39.515852 | debian-bookworm -> localhost | | . o *oB=| 2025-11-27 03:10:39.515872 | debian-bookworm -> localhost | | + . .o.*.B| 2025-11-27 03:10:39.515893 | debian-bookworm -> localhost | | S ...=.O | 2025-11-27 03:10:39.515919 | debian-bookworm -> localhost | | . o.B.+| 2025-11-27 03:10:39.515939 | debian-bookworm -> localhost | | .o.+E| 2025-11-27 03:10:39.515960 | debian-bookworm -> localhost | | o o==| 2025-11-27 03:10:39.515981 | debian-bookworm -> localhost | | o. *=| 2025-11-27 03:10:39.516000 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-27 03:10:39.516060 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.489624 2025-11-27 03:10:39.523925 | 2025-11-27 03:10:39.524052 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-27 03:10:39.563488 | debian-bookworm | ok 2025-11-27 03:10:39.586914 | debian-bookworm | included: /var/lib/zuul/builds/fbac7790ba80465fb5b84c26b167f5b1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-27 03:10:39.597730 | 2025-11-27 03:10:39.597859 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-27 03:10:39.653925 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:10:39.661013 | 2025-11-27 03:10:39.661153 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-27 03:10:40.435584 | debian-bookworm | changed 2025-11-27 03:10:40.449111 | 2025-11-27 03:10:40.449349 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-27 03:10:40.729068 | debian-bookworm | ok 2025-11-27 03:10:40.737428 | 2025-11-27 03:10:40.737574 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-27 03:10:41.456449 | debian-bookworm | changed 2025-11-27 03:10:41.463838 | 2025-11-27 03:10:41.463966 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-27 03:10:42.137934 | debian-bookworm | changed 2025-11-27 03:10:42.145071 | 2025-11-27 03:10:42.145206 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-27 03:10:42.169460 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:10:42.177461 | 2025-11-27 03:10:42.177614 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-27 03:10:42.766042 | debian-bookworm -> localhost | changed 2025-11-27 03:10:42.777990 | 2025-11-27 03:10:42.778133 | TASK [add-build-sshkey : Add back temp key] 2025-11-27 03:10:43.171819 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fbac7790ba80465fb5b84c26b167f5b1/work/fbac7790ba80465fb5b84c26b167f5b1_id_rsa (zuul-build-sshkey) 2025-11-27 03:10:43.172665 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013530 2025-11-27 03:10:43.192863 | 2025-11-27 03:10:43.193011 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-27 03:10:43.680892 | debian-bookworm | ok 2025-11-27 03:10:43.686770 | 2025-11-27 03:10:43.686919 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-27 03:10:43.711610 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:10:43.733230 | 2025-11-27 03:10:43.733433 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-27 03:10:44.174971 | debian-bookworm | ok 2025-11-27 03:10:44.192072 | 2025-11-27 03:10:44.192220 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-27 03:10:44.232097 | debian-bookworm | ok 2025-11-27 03:10:44.237558 | 2025-11-27 03:10:44.237682 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-27 03:10:44.585544 | debian-bookworm -> localhost | ok 2025-11-27 03:10:44.592647 | 2025-11-27 03:10:44.592792 | TASK [validate-host : Collect information about the host] 2025-11-27 03:10:45.710037 | debian-bookworm | ok 2025-11-27 03:10:45.720365 | 2025-11-27 03:10:45.720516 | TASK [validate-host : Sanitize hostname] 2025-11-27 03:10:45.850160 | debian-bookworm | ok 2025-11-27 03:10:45.894947 | 2025-11-27 03:10:45.895091 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-27 03:10:46.698757 | debian-bookworm -> localhost | changed 2025-11-27 03:10:46.714054 | 2025-11-27 03:10:46.714193 | TASK [validate-host : Collect information about zuul worker] 2025-11-27 03:10:47.351591 | debian-bookworm | ok 2025-11-27 03:10:47.363616 | 2025-11-27 03:10:47.363750 | TASK [validate-host : Write out all zuul information for each host] 2025-11-27 03:10:49.030400 | debian-bookworm -> localhost | changed 2025-11-27 03:10:49.058860 | 2025-11-27 03:10:49.059735 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-27 03:10:49.423351 | debian-bookworm | ok 2025-11-27 03:10:49.442590 | 2025-11-27 03:10:49.442734 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-27 03:10:51.303431 | debian-bookworm | changed: 2025-11-27 03:10:51.303661 | debian-bookworm | cd+++++++++ src/ 2025-11-27 03:10:51.303698 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-27 03:10:51.303724 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-27 03:10:51.303746 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-27 03:10:51.303766 | debian-bookworm | =6.2 2025-11-27 03:11:17.638064 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-11-27 03:11:17.672484 | debian-bookworm | Collecting chardet>=5.2 2025-11-27 03:11:17.685013 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-27 03:11:17.704690 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.7 MB/s eta 0:00:00 2025-11-27 03:11:17.746091 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-27 03:11:17.757426 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-27 03:11:17.814373 | debian-bookworm | Collecting filelock>=3.20 2025-11-27 03:11:17.825736 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-27 03:11:17.874257 | debian-bookworm | Collecting packaging>=25 2025-11-27 03:11:17.885641 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-27 03:11:17.894303 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.9 MB/s eta 0:00:00 2025-11-27 03:11:17.940023 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-27 03:11:17.951315 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-27 03:11:17.991012 | debian-bookworm | Collecting pluggy>=1.6 2025-11-27 03:11:18.002300 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-27 03:11:18.040892 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-27 03:11:18.052425 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-27 03:11:18.181346 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-27 03:11:18.192713 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-27 03:11:18.494181 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 20.3 MB/s eta 0:00:00 2025-11-27 03:11:18.599721 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-27 03:11:18.611072 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-27 03:11:18.637028 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.5 MB/s eta 0:00:00 2025-11-27 03:11:18.791757 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-27 03:11:19.680279 | debian-bookworm | Successfully installed cachetools-6.2.2 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.32.0 virtualenv-20.35.4 2025-11-27 03:11:19.983206 | debian-bookworm | ok: Runtime: 0:00:02.991497 2025-11-27 03:11:19.997629 | 2025-11-27 03:11:19.997726 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-27 03:11:20.067025 | debian-bookworm | ok 2025-11-27 03:11:20.072278 | 2025-11-27 03:11:20.072391 | TASK [ensure-tox : Output tox version] 2025-11-27 03:11:20.669644 | 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-11-27 03:11:20.688726 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-27 03:11:21.162849 | debian-bookworm | ok: Runtime: 0:00:00.312134 2025-11-27 03:11:21.168395 | 2025-11-27 03:11:21.168485 | TASK [ensure-tox : Make global symlink] 2025-11-27 03:11:21.203521 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:21.222723 | 2025-11-27 03:11:21.222808 | PLAY RECAP 2025-11-27 03:11:21.222892 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-27 03:11:21.222919 | 2025-11-27 03:11:21.458295 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-27 03:11:21.462427 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-27 03:11:22.999866 | 2025-11-27 03:11:23.002075 | PLAY [all] 2025-11-27 03:11:23.053452 | 2025-11-27 03:11:23.053632 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-27 03:11:23.968888 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-27 03:11:24.107422 | debian-bookworm | ok: Runtime: 0:00:00.025134 2025-11-27 03:11:24.113090 | 2025-11-27 03:11:24.113201 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-27 03:11:24.688336 | debian-bookworm | ok: Runtime: 0:00:00.007058 2025-11-27 03:11:24.694200 | 2025-11-27 03:11:24.694298 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-27 03:11:24.995412 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-27 03:11:24.995488 | debian-bookworm | sudo: a password is required 2025-11-27 03:11:25.223006 | debian-bookworm | ok: Runtime: 0:00:00.023430 2025-11-27 03:11:25.231490 | 2025-11-27 03:11:25.231572 | TASK [tox : Check to see if the constraints file exists] 2025-11-27 03:11:25.254814 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:25.260618 | 2025-11-27 03:11:25.260707 | TASK [tox : Fail if constraints file is missing] 2025-11-27 03:11:25.307072 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:25.312459 | 2025-11-27 03:11:25.312550 | TASK [tox : Record file location] 2025-11-27 03:11:25.361020 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:25.370588 | 2025-11-27 03:11:25.371145 | TASK [tox : Install tox siblings] 2025-11-27 03:11:25.412788 | debian-bookworm | ok 2025-11-27 03:11:25.433948 | debian-bookworm | included: /var/lib/zuul/builds/fbac7790ba80465fb5b84c26b167f5b1/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-27 03:11:25.448463 | 2025-11-27 03:11:25.448820 | TASK [tox : Run tox without tests] 2025-11-27 03:11:26.795836 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-27 03:11:40.943171 | debian-bookworm | test: OK (14.76 seconds) 2025-11-27 03:11:40.943252 | debian-bookworm | congratulations :) (14.79 seconds) 2025-11-27 03:11:41.051389 | debian-bookworm | ok: Runtime: 0:00:15.095808 2025-11-27 03:11:41.062883 | 2025-11-27 03:11:41.063033 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-27 03:11:41.888084 | debian-bookworm | changed 2025-11-27 03:11:41.898302 | 2025-11-27 03:11:41.898459 | TASK [tox : Get tox envlist config] 2025-11-27 03:11:43.063141 | debian-bookworm | ok: Runtime: 0:00:00.354410 2025-11-27 03:11:43.069599 | 2025-11-27 03:11:43.069732 | TASK [tox : Install any sibling python packages] 2025-11-27 03:11:44.091519 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-27 03:11:44.098451 | 2025-11-27 03:11:44.098576 | TASK [tox : Remove tempfile] 2025-11-27 03:11:45.114148 | debian-bookworm | changed 2025-11-27 03:11:45.124281 | 2025-11-27 03:11:45.124400 | TASK [tox : Emit tox command] 2025-11-27 03:11:45.266498 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-27 03:11:45.271491 | 2025-11-27 03:11:45.271590 | TASK [tox : Run tox] 2025-11-27 03:11:46.125231 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-27 03:11:46.801723 | debian-bookworm | ............... 2025-11-27 03:11:46.801788 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-27 03:11:46.801807 | debian-bookworm | Ran 15 tests in 0.170s 2025-11-27 03:11:46.801812 | debian-bookworm | 2025-11-27 03:11:46.801820 | debian-bookworm | OK 2025-11-27 03:11:46.916650 | debian-bookworm | test: OK (0.83=setup[0.05]+cmd[0.79] seconds) 2025-11-27 03:11:46.916740 | debian-bookworm | congratulations :) (0.87 seconds) 2025-11-27 03:11:47.446646 | debian-bookworm | ok: Runtime: 0:00:01.155568 2025-11-27 03:11:47.452716 | 2025-11-27 03:11:47.452814 | TASK [tox : Look for output] 2025-11-27 03:11:48.128131 | debian-bookworm | ok 2025-11-27 03:11:48.161718 | 2025-11-27 03:11:48.161834 | TASK [tox : Return file comments to Zuul] 2025-11-27 03:11:48.205326 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:48.216309 | 2025-11-27 03:11:48.216419 | PLAY RECAP 2025-11-27 03:11:48.216470 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-27 03:11:48.216494 | 2025-11-27 03:11:48.367888 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-27 03:11:48.368879 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-27 03:11:49.691457 | 2025-11-27 03:11:49.691592 | PLAY [all] 2025-11-27 03:11:49.725778 | 2025-11-27 03:11:49.725910 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-27 03:11:49.783616 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:49.789891 | 2025-11-27 03:11:49.790023 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-27 03:11:49.869034 | debian-bookworm | ok 2025-11-27 03:11:49.874471 | 2025-11-27 03:11:49.874588 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-27 03:11:51.257970 | debian-bookworm -> localhost | changed 2025-11-27 03:11:51.265311 | 2025-11-27 03:11:51.265430 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-27 03:11:51.350121 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:51.356329 | 2025-11-27 03:11:51.356448 | TASK [fetch-tox-output : Set envlist fact] 2025-11-27 03:11:51.414236 | debian-bookworm | ok 2025-11-27 03:11:51.421061 | 2025-11-27 03:11:51.421160 | TASK [fetch-tox-output : Get tox version] 2025-11-27 03:11:52.537863 | 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-11-27 03:11:52.557816 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-27 03:11:52.991023 | debian-bookworm | ok: Runtime: 0:00:00.290091 2025-11-27 03:11:52.996809 | 2025-11-27 03:11:52.996916 | TASK [fetch-tox-output : Find all default environments] 2025-11-27 03:11:53.592086 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:53.599383 | 2025-11-27 03:11:53.600023 | TASK [fetch-tox-output : Set envlist fact] 2025-11-27 03:11:53.720165 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:53.730655 | 2025-11-27 03:11:53.730943 | TASK [fetch-tox-output : Find all default environments] 2025-11-27 03:11:54.333385 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:54.345680 | 2025-11-27 03:11:54.346207 | TASK [fetch-tox-output : Set envlist fact] 2025-11-27 03:11:54.406952 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:54.423172 | 2025-11-27 03:11:54.423803 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-27 03:11:54.520328 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:54.527749 | 2025-11-27 03:11:54.527860 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-27 03:11:56.310936 | debian-bookworm | changed: 2025-11-27 03:11:56.311525 | debian-bookworm | created directory /var/lib/zuul/builds/fbac7790ba80465fb5b84c26b167f5b1/work/logs/tox/test 2025-11-27 03:11:56.311585 | debian-bookworm | cd+++++++++ ./ 2025-11-27 03:11:56.311614 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-27 03:11:56.311646 | 2025-11-27 03:11:56.326382 | 2025-11-27 03:11:56.326457 | PLAY RECAP 2025-11-27 03:11:56.326499 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-27 03:11:56.326520 | 2025-11-27 03:11:56.791576 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-27 03:11:56.792533 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-27 03:11:58.265501 | 2025-11-27 03:11:58.265611 | PLAY [all] 2025-11-27 03:11:58.285143 | 2025-11-27 03:11:58.285250 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-27 03:11:58.595679 | debian-bookworm | changed: non-zero return code 2025-11-27 03:11:58.601061 | 2025-11-27 03:11:58.601164 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-27 03:11:58.625110 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:58.630085 | 2025-11-27 03:11:58.630178 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-27 03:11:58.677628 | 2025-11-27 03:11:58.677790 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-27 03:11:58.707205 | 2025-11-27 03:11:58.707373 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-27 03:11:58.737236 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:58.748021 | 2025-11-27 03:11:58.748120 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-27 03:11:58.785583 | 2025-11-27 03:11:58.785736 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-27 03:11:58.818505 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:58.823120 | 2025-11-27 03:11:58.823210 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-27 03:11:58.856241 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:58.860952 | 2025-11-27 03:11:58.861039 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-27 03:11:58.914051 | debian-bookworm | skipping: Conditional result was False 2025-11-27 03:11:58.919537 | 2025-11-27 03:11:58.919605 | PLAY RECAP 2025-11-27 03:11:58.919644 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-27 03:11:58.919664 | 2025-11-27 03:11:59.161648 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-27 03:11:59.162466 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-27 03:11:59.888754 | 2025-11-27 03:11:59.888905 | PLAY [Base post] 2025-11-27 03:11:59.899010 | 2025-11-27 03:11:59.899109 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-27 03:12:00.516803 | debian-bookworm | changed 2025-11-27 03:12:00.522030 | 2025-11-27 03:12:00.522112 | PLAY RECAP 2025-11-27 03:12:00.522161 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-27 03:12:00.522211 | 2025-11-27 03:12:00.762817 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-27 03:12:00.763658 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-27 03:12:01.836240 | 2025-11-27 03:12:01.836405 | PLAY [Base post-logs] 2025-11-27 03:12:01.855740 | 2025-11-27 03:12:01.855874 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-27 03:12:02.309026 | localhost | changed 2025-11-27 03:12:02.323091 | 2025-11-27 03:12:02.323241 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-27 03:12:02.360138 | localhost | ok 2025-11-27 03:12:02.363041 | 2025-11-27 03:12:02.363189 | TASK [Set zuul-log-path fact] 2025-11-27 03:12:02.397667 | localhost | ok 2025-11-27 03:12:02.405402 | 2025-11-27 03:12:02.405514 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-27 03:12:02.454097 | localhost | ok 2025-11-27 03:12:02.457073 | 2025-11-27 03:12:02.457165 | TASK [upload-logs : Create log directories] 2025-11-27 03:12:03.116046 | localhost | changed 2025-11-27 03:12:03.118687 | 2025-11-27 03:12:03.118777 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-27 03:12:03.956096 | localhost -> localhost | ok: Runtime: 0:00:00.017097 2025-11-27 03:12:03.959131 | 2025-11-27 03:12:03.959214 | TASK [upload-logs : Upload logs to log server] 2025-11-27 03:12:05.090820 | localhost | Output suppressed because no_log was given 2025-11-27 03:12:05.092362 | 2025-11-27 03:12:05.092450 | LOOP [upload-logs : Compress console log and json output] 2025-11-27 03:12:05.167489 | localhost | skipping: Conditional result was False 2025-11-27 03:12:05.174428 | localhost | skipping: Conditional result was False 2025-11-27 03:12:05.180589 | 2025-11-27 03:12:05.180687 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-27 03:12:05.232590 | localhost | skipping: Conditional result was False 2025-11-27 03:12:05.232847 | 2025-11-27 03:12:05.242652 | localhost | skipping: Conditional result was False 2025-11-27 03:12:05.248265 | 2025-11-27 03:12:05.248391 | LOOP [upload-logs : Upload console log and json output]