2025-09-25 03:10:20.821795 | Job console starting 2025-09-25 03:10:20.840478 | Updating git repos 2025-09-25 03:10:20.854456 | Cloning repos into workspace 2025-09-25 03:10:20.910122 | Restoring repo states 2025-09-25 03:10:20.948565 | Merging changes 2025-09-25 03:10:20.948586 | Checking out repos 2025-09-25 03:10:21.027008 | Preparing playbooks 2025-09-25 03:10:22.031904 | Running Ansible setup 2025-09-25 03:10:28.252886 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-25 03:10:29.089581 | 2025-09-25 03:10:29.089723 | PLAY [Base pre] 2025-09-25 03:10:29.114337 | 2025-09-25 03:10:29.114448 | TASK [Setup log path fact] 2025-09-25 03:10:29.144956 | debian-bookworm | ok 2025-09-25 03:10:29.164121 | 2025-09-25 03:10:29.164238 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-25 03:10:29.203004 | debian-bookworm | ok 2025-09-25 03:10:29.222379 | 2025-09-25 03:10:29.222960 | TASK [emit-job-header : Print job information] 2025-09-25 03:10:29.252267 | # Job Information 2025-09-25 03:10:29.252406 | Ansible Version: 2.16.14 2025-09-25 03:10:29.252436 | Job: tox 2025-09-25 03:10:29.252464 | Pipeline: periodic-daily 2025-09-25 03:10:29.252482 | Executor: 521e9411259a 2025-09-25 03:10:29.252642 | Triggered by: https://github.com/osism/openstack-image-manager 2025-09-25 03:10:29.252680 | Event ID: b571ac5e1ebd4ccda690951f787c4967 2025-09-25 03:10:29.256585 | 2025-09-25 03:10:29.256661 | LOOP [emit-job-header : Print node information] 2025-09-25 03:10:29.447488 | debian-bookworm | ok: 2025-09-25 03:10:29.447723 | debian-bookworm | # Node Information 2025-09-25 03:10:29.447761 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-25 03:10:29.447783 | debian-bookworm | Hostname: debian 2025-09-25 03:10:29.447802 | debian-bookworm | Username: zuul 2025-09-25 03:10:29.447819 | debian-bookworm | Distro: Debian 12.12 2025-09-25 03:10:29.447838 | debian-bookworm | Provider: regiocloud-a 2025-09-25 03:10:29.447856 | debian-bookworm | Region: 2025-09-25 03:10:29.447873 | debian-bookworm | Label: debian-bookworm 2025-09-25 03:10:29.447890 | debian-bookworm | Product Name: OpenStack Nova 2025-09-25 03:10:29.447906 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe97:2c31 2025-09-25 03:10:29.466197 | 2025-09-25 03:10:29.466296 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-25 03:10:30.028350 | debian-bookworm -> localhost | changed 2025-09-25 03:10:30.034420 | 2025-09-25 03:10:30.034510 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-25 03:10:31.121094 | debian-bookworm -> localhost | changed 2025-09-25 03:10:31.133986 | 2025-09-25 03:10:31.134171 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-25 03:10:31.454053 | debian-bookworm -> localhost | ok 2025-09-25 03:10:31.460353 | 2025-09-25 03:10:31.460458 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-25 03:10:31.488697 | debian-bookworm | ok 2025-09-25 03:10:31.506423 | debian-bookworm | included: /var/lib/zuul/builds/a3ae3ee54e62489c833ac778118eba8d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-25 03:10:31.512379 | 2025-09-25 03:10:31.512474 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-25 03:10:32.877455 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-25 03:10:32.877666 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a3ae3ee54e62489c833ac778118eba8d/work/a3ae3ee54e62489c833ac778118eba8d_id_rsa 2025-09-25 03:10:32.877748 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a3ae3ee54e62489c833ac778118eba8d/work/a3ae3ee54e62489c833ac778118eba8d_id_rsa.pub 2025-09-25 03:10:32.877777 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-25 03:10:32.877803 | debian-bookworm -> localhost | SHA256:fH5IO1MdCdCsdOVPl3Auj2/SLA1nlSU2D9NB0AlS+WI zuul-build-sshkey 2025-09-25 03:10:32.877826 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-25 03:10:32.877868 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-25 03:10:32.877892 | debian-bookworm -> localhost | | .=o*&=+| 2025-09-25 03:10:32.877916 | debian-bookworm -> localhost | | . ==+X=| 2025-09-25 03:10:32.877937 | debian-bookworm -> localhost | | . o .=+=| 2025-09-25 03:10:32.877964 | debian-bookworm -> localhost | | . . E+=o| 2025-09-25 03:10:32.877987 | debian-bookworm -> localhost | | S o ooo+.| 2025-09-25 03:10:32.878014 | debian-bookworm -> localhost | | + + O | 2025-09-25 03:10:32.878036 | debian-bookworm -> localhost | | * .o * | 2025-09-25 03:10:32.878058 | debian-bookworm -> localhost | | + + | 2025-09-25 03:10:32.878079 | debian-bookworm -> localhost | | | 2025-09-25 03:10:32.878100 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-25 03:10:32.878152 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.889610 2025-09-25 03:10:32.884828 | 2025-09-25 03:10:32.884935 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-25 03:10:32.904313 | debian-bookworm | ok 2025-09-25 03:10:32.914584 | debian-bookworm | included: /var/lib/zuul/builds/a3ae3ee54e62489c833ac778118eba8d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-25 03:10:32.923497 | 2025-09-25 03:10:32.923582 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-25 03:10:32.936427 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:10:32.941852 | 2025-09-25 03:10:32.941933 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-25 03:10:33.572052 | debian-bookworm | changed 2025-09-25 03:10:33.577240 | 2025-09-25 03:10:33.577327 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-25 03:10:33.843576 | debian-bookworm | ok 2025-09-25 03:10:33.855835 | 2025-09-25 03:10:33.855947 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-25 03:10:34.527469 | debian-bookworm | changed 2025-09-25 03:10:34.537114 | 2025-09-25 03:10:34.537224 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-25 03:10:35.218822 | debian-bookworm | changed 2025-09-25 03:10:35.236108 | 2025-09-25 03:10:35.236248 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-25 03:10:35.262865 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:10:35.268507 | 2025-09-25 03:10:35.268599 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-25 03:10:35.672237 | debian-bookworm -> localhost | changed 2025-09-25 03:10:35.682561 | 2025-09-25 03:10:35.682647 | TASK [add-build-sshkey : Add back temp key] 2025-09-25 03:10:36.047377 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a3ae3ee54e62489c833ac778118eba8d/work/a3ae3ee54e62489c833ac778118eba8d_id_rsa (zuul-build-sshkey) 2025-09-25 03:10:36.047593 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019020 2025-09-25 03:10:36.055057 | 2025-09-25 03:10:36.055150 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-25 03:10:36.448348 | debian-bookworm | ok 2025-09-25 03:10:36.454900 | 2025-09-25 03:10:36.455009 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-25 03:10:36.478817 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:10:36.497014 | 2025-09-25 03:10:36.497107 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-25 03:10:36.960602 | debian-bookworm | ok 2025-09-25 03:10:36.971276 | 2025-09-25 03:10:36.971373 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-25 03:10:36.999334 | debian-bookworm | ok 2025-09-25 03:10:37.004055 | 2025-09-25 03:10:37.004132 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-25 03:10:37.249529 | debian-bookworm -> localhost | ok 2025-09-25 03:10:37.256185 | 2025-09-25 03:10:37.256273 | TASK [validate-host : Collect information about the host] 2025-09-25 03:10:38.416121 | debian-bookworm | ok 2025-09-25 03:10:38.426191 | 2025-09-25 03:10:38.426280 | TASK [validate-host : Sanitize hostname] 2025-09-25 03:10:38.515965 | debian-bookworm | ok 2025-09-25 03:10:38.542934 | 2025-09-25 03:10:38.543032 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-25 03:10:39.062415 | debian-bookworm -> localhost | changed 2025-09-25 03:10:39.073944 | 2025-09-25 03:10:39.074081 | TASK [validate-host : Collect information about zuul worker] 2025-09-25 03:10:39.486347 | debian-bookworm | ok 2025-09-25 03:10:39.490996 | 2025-09-25 03:10:39.491088 | TASK [validate-host : Write out all zuul information for each host] 2025-09-25 03:10:40.069711 | debian-bookworm -> localhost | changed 2025-09-25 03:10:40.079563 | 2025-09-25 03:10:40.079671 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-25 03:10:40.366998 | debian-bookworm | ok 2025-09-25 03:10:40.376879 | 2025-09-25 03:10:40.377263 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-25 03:10:41.259310 | debian-bookworm | changed: 2025-09-25 03:10:41.259490 | debian-bookworm | cd+++++++++ src/ 2025-09-25 03:10:41.259527 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-25 03:10:41.259637 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-25 03:10:41.259663 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-09-25 03:10:41.259697 | debian-bookworm | =6.1 2025-09-25 03:11:07.574170 | debian-bookworm | Downloading cachetools-6.2.0-py3-none-any.whl (11 kB) 2025-09-25 03:11:07.626663 | debian-bookworm | Collecting chardet>=5.2 2025-09-25 03:11:07.635174 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-09-25 03:11:07.652853 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 13.9 MB/s eta 0:00:00 2025-09-25 03:11:07.692294 | debian-bookworm | Collecting colorama>=0.4.6 2025-09-25 03:11:07.701072 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-09-25 03:11:07.768989 | debian-bookworm | Collecting filelock>=3.18 2025-09-25 03:11:07.776551 | debian-bookworm | Downloading filelock-3.19.1-py3-none-any.whl (15 kB) 2025-09-25 03:11:07.820189 | debian-bookworm | Collecting packaging>=25 2025-09-25 03:11:07.827592 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-09-25 03:11:07.836802 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.3 MB/s eta 0:00:00 2025-09-25 03:11:07.877826 | debian-bookworm | Collecting platformdirs>=4.3.8 2025-09-25 03:11:07.885364 | debian-bookworm | Downloading platformdirs-4.4.0-py3-none-any.whl (18 kB) 2025-09-25 03:11:07.921118 | debian-bookworm | Collecting pluggy>=1.6 2025-09-25 03:11:07.928385 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-09-25 03:11:07.960743 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-09-25 03:11:07.968721 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-09-25 03:11:08.090707 | debian-bookworm | Collecting virtualenv>=20.31.2 2025-09-25 03:11:08.098675 | debian-bookworm | Downloading virtualenv-20.34.0-py3-none-any.whl (6.0 MB) 2025-09-25 03:11:08.404572 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 19.9 MB/s eta 0:00:00 2025-09-25 03:11:08.526677 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-09-25 03:11:08.536470 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-09-25 03:11:08.622831 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 5.7 MB/s eta 0:00:00 2025-09-25 03:11:08.782888 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-09-25 03:11:09.785217 | debian-bookworm | Successfully installed cachetools-6.2.0 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.19.1 packaging-25.0 platformdirs-4.4.0 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.30.2 virtualenv-20.34.0 2025-09-25 03:11:10.291601 | debian-bookworm | ok: Runtime: 0:00:03.233007 2025-09-25 03:11:10.297161 | 2025-09-25 03:11:10.297251 | TASK [ensure-tox : Export installed tox_executable path] 2025-09-25 03:11:10.336631 | debian-bookworm | ok 2025-09-25 03:11:10.342185 | 2025-09-25 03:11:10.342273 | TASK [ensure-tox : Output tox version] 2025-09-25 03:11:10.910181 | 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-09-25 03:11:10.929048 | debian-bookworm | 4.30.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-09-25 03:11:11.390626 | debian-bookworm | ok: Runtime: 0:00:00.303875 2025-09-25 03:11:11.396532 | 2025-09-25 03:11:11.396617 | TASK [ensure-tox : Make global symlink] 2025-09-25 03:11:11.419842 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:11.426519 | 2025-09-25 03:11:11.426591 | PLAY RECAP 2025-09-25 03:11:11.426698 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-09-25 03:11:11.426728 | 2025-09-25 03:11:11.616293 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-09-25 03:11:11.617266 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-09-25 03:11:12.289194 | 2025-09-25 03:11:12.289300 | PLAY [all] 2025-09-25 03:11:12.308019 | 2025-09-25 03:11:12.308118 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-09-25 03:11:12.807739 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-09-25 03:11:12.845120 | debian-bookworm | ok: Runtime: 0:00:00.028971 2025-09-25 03:11:12.859094 | 2025-09-25 03:11:12.859211 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-09-25 03:11:13.391218 | debian-bookworm | ok: Runtime: 0:00:00.007642 2025-09-25 03:11:13.397437 | 2025-09-25 03:11:13.397533 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-09-25 03:11:13.713266 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-09-25 03:11:13.715380 | debian-bookworm | sudo: a password is required 2025-09-25 03:11:13.927562 | debian-bookworm | ok: Runtime: 0:00:00.021005 2025-09-25 03:11:13.947834 | 2025-09-25 03:11:13.947953 | TASK [tox : Check to see if the constraints file exists] 2025-09-25 03:11:13.982223 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:13.988970 | 2025-09-25 03:11:13.989065 | TASK [tox : Fail if constraints file is missing] 2025-09-25 03:11:14.011952 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:14.018326 | 2025-09-25 03:11:14.018420 | TASK [tox : Record file location] 2025-09-25 03:11:14.041605 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:14.047343 | 2025-09-25 03:11:14.047446 | TASK [tox : Install tox siblings] 2025-09-25 03:11:14.065861 | debian-bookworm | ok 2025-09-25 03:11:14.074082 | debian-bookworm | included: /var/lib/zuul/builds/a3ae3ee54e62489c833ac778118eba8d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-09-25 03:11:14.080995 | 2025-09-25 03:11:14.081095 | TASK [tox : Run tox without tests] 2025-09-25 03:11:15.274301 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-09-25 03:11:28.452541 | debian-bookworm | test: OK (13.78 seconds) 2025-09-25 03:11:28.452601 | debian-bookworm | congratulations :) (13.81 seconds) 2025-09-25 03:11:28.624605 | debian-bookworm | ok: Runtime: 0:00:14.114812 2025-09-25 03:11:28.629909 | 2025-09-25 03:11:28.629998 | TASK [tox : Create a tempfile to save tox showconfig] 2025-09-25 03:11:29.015155 | debian-bookworm | changed 2025-09-25 03:11:29.020133 | 2025-09-25 03:11:29.020225 | TASK [tox : Get tox envlist config] 2025-09-25 03:11:30.071476 | debian-bookworm | ok: Runtime: 0:00:00.346078 2025-09-25 03:11:30.076997 | 2025-09-25 03:11:30.077084 | TASK [tox : Install any sibling python packages] 2025-09-25 03:11:30.509818 | debian-bookworm | ok: No setup.cfg, no action needed 2025-09-25 03:11:30.515125 | 2025-09-25 03:11:30.515206 | TASK [tox : Remove tempfile] 2025-09-25 03:11:30.938377 | debian-bookworm | changed 2025-09-25 03:11:30.944072 | 2025-09-25 03:11:30.944175 | TASK [tox : Emit tox command] 2025-09-25 03:11:30.972027 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-09-25 03:11:30.977182 | 2025-09-25 03:11:30.977293 | TASK [tox : Run tox] 2025-09-25 03:11:31.656480 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-09-25 03:11:32.332660 | debian-bookworm | ............... 2025-09-25 03:11:32.332731 | debian-bookworm | ---------------------------------------------------------------------- 2025-09-25 03:11:32.332750 | debian-bookworm | Ran 15 tests in 0.181s 2025-09-25 03:11:32.332756 | debian-bookworm | 2025-09-25 03:11:32.332764 | debian-bookworm | OK 2025-09-25 03:11:32.450210 | debian-bookworm | test: OK (0.83=setup[0.04]+cmd[0.79] seconds) 2025-09-25 03:11:32.450284 | debian-bookworm | congratulations :) (0.86 seconds) 2025-09-25 03:11:32.566238 | debian-bookworm | ok: Runtime: 0:00:01.166395 2025-09-25 03:11:32.574525 | 2025-09-25 03:11:32.574692 | TASK [tox : Look for output] 2025-09-25 03:11:33.084335 | debian-bookworm | ok 2025-09-25 03:11:33.099222 | 2025-09-25 03:11:33.099360 | TASK [tox : Return file comments to Zuul] 2025-09-25 03:11:33.133844 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:33.140537 | 2025-09-25 03:11:33.140651 | PLAY RECAP 2025-09-25 03:11:33.140705 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-09-25 03:11:33.140729 | 2025-09-25 03:11:33.286473 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-09-25 03:11:33.287672 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-09-25 03:11:34.140257 | 2025-09-25 03:11:34.140434 | PLAY [all] 2025-09-25 03:11:34.157461 | 2025-09-25 03:11:34.157617 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-09-25 03:11:34.222971 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:34.230115 | 2025-09-25 03:11:34.230266 | TASK [fetch-tox-output : Set tox log path for single node] 2025-09-25 03:11:34.279709 | debian-bookworm | ok 2025-09-25 03:11:34.284941 | 2025-09-25 03:11:34.285060 | TASK [fetch-tox-output : Ensure local tox dir] 2025-09-25 03:11:34.872709 | debian-bookworm -> localhost | changed 2025-09-25 03:11:34.881123 | 2025-09-25 03:11:34.881325 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-09-25 03:11:34.937030 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:34.949675 | 2025-09-25 03:11:34.949818 | TASK [fetch-tox-output : Set envlist fact] 2025-09-25 03:11:34.990613 | debian-bookworm | ok 2025-09-25 03:11:34.998898 | 2025-09-25 03:11:34.999016 | TASK [fetch-tox-output : Get tox version] 2025-09-25 03:11:35.678716 | 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-09-25 03:11:35.696168 | debian-bookworm | 4.30.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-09-25 03:11:36.035985 | debian-bookworm | ok: Runtime: 0:00:00.257194 2025-09-25 03:11:36.057344 | 2025-09-25 03:11:36.057488 | TASK [fetch-tox-output : Find all default environments] 2025-09-25 03:11:36.601514 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:36.612897 | 2025-09-25 03:11:36.613059 | TASK [fetch-tox-output : Set envlist fact] 2025-09-25 03:11:36.637398 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:36.643185 | 2025-09-25 03:11:36.643309 | TASK [fetch-tox-output : Find all default environments] 2025-09-25 03:11:37.174420 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:37.180518 | 2025-09-25 03:11:37.180653 | TASK [fetch-tox-output : Set envlist fact] 2025-09-25 03:11:37.214550 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:37.222291 | 2025-09-25 03:11:37.222407 | LOOP [fetch-tox-output : Copy tox logs] 2025-09-25 03:11:37.271861 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:37.284420 | 2025-09-25 03:11:37.284550 | LOOP [fetch-tox-output : Collect tox logs] 2025-09-25 03:11:38.245189 | debian-bookworm | changed: 2025-09-25 03:11:38.246030 | debian-bookworm | created directory /var/lib/zuul/builds/a3ae3ee54e62489c833ac778118eba8d/work/logs/tox/test 2025-09-25 03:11:38.246108 | debian-bookworm | cd+++++++++ ./ 2025-09-25 03:11:38.246136 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-09-25 03:11:38.246170 | 2025-09-25 03:11:38.257566 | 2025-09-25 03:11:38.257840 | PLAY RECAP 2025-09-25 03:11:38.257906 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-09-25 03:11:38.257931 | 2025-09-25 03:11:38.499949 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-09-25 03:11:38.500980 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-09-25 03:11:39.360537 | 2025-09-25 03:11:39.360730 | PLAY [all] 2025-09-25 03:11:39.378860 | 2025-09-25 03:11:39.379011 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-09-25 03:11:39.616885 | debian-bookworm | changed: non-zero return code 2025-09-25 03:11:39.622536 | 2025-09-25 03:11:39.622715 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-09-25 03:11:39.647043 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:39.653221 | 2025-09-25 03:11:39.653346 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-09-25 03:11:39.684235 | 2025-09-25 03:11:39.684481 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-09-25 03:11:39.716495 | 2025-09-25 03:11:39.716721 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-09-25 03:11:39.740855 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:39.748558 | 2025-09-25 03:11:39.748731 | LOOP [fetch-subunit-output : Generate subunit file] 2025-09-25 03:11:39.778247 | 2025-09-25 03:11:39.778469 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-09-25 03:11:39.819590 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:39.833524 | 2025-09-25 03:11:39.833719 | TASK [fetch-subunit-output : Remove the temporary file] 2025-09-25 03:11:39.866279 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:39.873002 | 2025-09-25 03:11:39.873138 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-09-25 03:11:39.898045 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:11:39.905225 | 2025-09-25 03:11:39.905313 | PLAY RECAP 2025-09-25 03:11:39.905362 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-09-25 03:11:39.905387 | 2025-09-25 03:11:40.040118 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-09-25 03:11:40.041216 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-25 03:11:40.786818 | 2025-09-25 03:11:40.787035 | PLAY [Base post] 2025-09-25 03:11:40.800951 | 2025-09-25 03:11:40.801091 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-25 03:11:41.430770 | debian-bookworm | changed 2025-09-25 03:11:41.442082 | 2025-09-25 03:11:41.442218 | PLAY RECAP 2025-09-25 03:11:41.442284 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-25 03:11:41.442384 | 2025-09-25 03:11:41.600257 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-25 03:11:41.601319 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-25 03:11:42.511218 | 2025-09-25 03:11:42.511393 | PLAY [Base post-logs] 2025-09-25 03:11:42.522035 | 2025-09-25 03:11:42.522178 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-25 03:11:43.168164 | localhost | changed 2025-09-25 03:11:43.178325 | 2025-09-25 03:11:43.178482 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-25 03:11:43.204188 | localhost | ok 2025-09-25 03:11:43.207558 | 2025-09-25 03:11:43.207691 | TASK [Set zuul-log-path fact] 2025-09-25 03:11:43.232859 | localhost | ok 2025-09-25 03:11:43.241591 | 2025-09-25 03:11:43.241745 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-25 03:11:43.268364 | localhost | ok 2025-09-25 03:11:43.272456 | 2025-09-25 03:11:43.272588 | TASK [upload-logs : Create log directories] 2025-09-25 03:11:43.918935 | localhost | changed 2025-09-25 03:11:43.922536 | 2025-09-25 03:11:43.922704 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-25 03:11:44.463296 | localhost -> localhost | ok: Runtime: 0:00:00.003827 2025-09-25 03:11:44.466741 | 2025-09-25 03:11:44.466828 | TASK [upload-logs : Upload logs to log server] 2025-09-25 03:11:44.932932 | localhost | Output suppressed because no_log was given 2025-09-25 03:11:44.934506 | 2025-09-25 03:11:44.934588 | LOOP [upload-logs : Compress console log and json output] 2025-09-25 03:11:45.008966 | localhost | skipping: Conditional result was False 2025-09-25 03:11:45.019421 | localhost | skipping: Conditional result was False 2025-09-25 03:11:45.030167 | 2025-09-25 03:11:45.030265 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-25 03:11:45.087903 | localhost | skipping: Conditional result was False 2025-09-25 03:11:45.088190 | 2025-09-25 03:11:45.098668 | localhost | skipping: Conditional result was False 2025-09-25 03:11:45.106017 | 2025-09-25 03:11:45.106110 | LOOP [upload-logs : Upload console log and json output]