2025-08-03 00:21:55.209737 | Job console starting 2025-08-03 00:21:55.234984 | Updating git repos 2025-08-03 00:21:55.301872 | Cloning repos into workspace 2025-08-03 00:21:55.346720 | Restoring repo states 2025-08-03 00:21:55.355458 | Merging changes 2025-08-03 00:21:56.036380 | Checking out repos 2025-08-03 00:21:56.158507 | Preparing playbooks 2025-08-03 00:21:57.343312 | Running Ansible setup 2025-08-03 00:22:03.275332 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-03 00:22:04.787992 | 2025-08-03 00:22:04.788421 | PLAY [Base pre] 2025-08-03 00:22:04.814446 | 2025-08-03 00:22:04.814738 | TASK [Setup log path fact] 2025-08-03 00:22:04.888737 | debian-bookworm | ok 2025-08-03 00:22:04.960844 | 2025-08-03 00:22:04.961047 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-03 00:22:04.998615 | debian-bookworm | ok 2025-08-03 00:22:05.015509 | 2025-08-03 00:22:05.015746 | TASK [emit-job-header : Print job information] 2025-08-03 00:22:05.078990 | # Job Information 2025-08-03 00:22:05.079234 | Ansible Version: 2.16.14 2025-08-03 00:22:05.079276 | Job: tox 2025-08-03 00:22:05.079311 | Pipeline: check 2025-08-03 00:22:05.079334 | Executor: 521e9411259a 2025-08-03 00:22:05.079356 | Triggered by: https://github.com/osism/openstack-image-manager/pull/936 2025-08-03 00:22:05.079377 | Event ID: cb930940-6fff-11f0-866d-8d980a825b53 2025-08-03 00:22:05.088575 | 2025-08-03 00:22:05.088703 | LOOP [emit-job-header : Print node information] 2025-08-03 00:22:05.277997 | debian-bookworm | ok: 2025-08-03 00:22:05.278329 | debian-bookworm | # Node Information 2025-08-03 00:22:05.278392 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-03 00:22:05.278469 | debian-bookworm | Hostname: debian 2025-08-03 00:22:05.278491 | debian-bookworm | Username: zuul 2025-08-03 00:22:05.278510 | debian-bookworm | Distro: Debian 12.11 2025-08-03 00:22:05.278530 | debian-bookworm | Provider: regiocloud-a 2025-08-03 00:22:05.278572 | debian-bookworm | Region: 2025-08-03 00:22:05.278591 | debian-bookworm | Label: debian-bookworm 2025-08-03 00:22:05.278608 | debian-bookworm | Product Name: OpenStack Nova 2025-08-03 00:22:05.278624 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed8:3c74 2025-08-03 00:22:05.309669 | 2025-08-03 00:22:05.309768 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-03 00:22:06.623980 | debian-bookworm -> localhost | changed 2025-08-03 00:22:06.631611 | 2025-08-03 00:22:06.631728 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-03 00:22:08.926645 | debian-bookworm -> localhost | changed 2025-08-03 00:22:08.937992 | 2025-08-03 00:22:08.938494 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-03 00:22:09.585316 | debian-bookworm -> localhost | ok 2025-08-03 00:22:09.590349 | 2025-08-03 00:22:09.590440 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-03 00:22:09.628077 | debian-bookworm | ok 2025-08-03 00:22:09.666443 | debian-bookworm | included: /var/lib/zuul/builds/dc71e37625654be3854ba1ce909e2f4d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-03 00:22:09.685670 | 2025-08-03 00:22:09.685761 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-03 00:22:12.517475 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-03 00:22:12.517713 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dc71e37625654be3854ba1ce909e2f4d/work/dc71e37625654be3854ba1ce909e2f4d_id_rsa 2025-08-03 00:22:12.517747 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dc71e37625654be3854ba1ce909e2f4d/work/dc71e37625654be3854ba1ce909e2f4d_id_rsa.pub 2025-08-03 00:22:12.517769 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-03 00:22:12.517791 | debian-bookworm -> localhost | SHA256:ySm8Ckv6uDkz+HEvobpDLxOVlOJIaLiZkVrLHCLm5V4 zuul-build-sshkey 2025-08-03 00:22:12.517810 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-03 00:22:12.517835 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-03 00:22:12.517853 | debian-bookworm -> localhost | |o. . | 2025-08-03 00:22:12.517870 | debian-bookworm -> localhost | |B=o+ | 2025-08-03 00:22:12.517887 | debian-bookworm -> localhost | |XX=o. | 2025-08-03 00:22:12.517904 | debian-bookworm -> localhost | |*o++ E . o | 2025-08-03 00:22:12.517920 | debian-bookworm -> localhost | | o . o S | 2025-08-03 00:22:12.517938 | debian-bookworm -> localhost | | o .. o | 2025-08-03 00:22:12.517955 | debian-bookworm -> localhost | |o *.... | 2025-08-03 00:22:12.517972 | debian-bookworm -> localhost | |*B.*.o | 2025-08-03 00:22:12.517990 | debian-bookworm -> localhost | |B@* ... | 2025-08-03 00:22:12.518007 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-03 00:22:12.518052 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.673871 2025-08-03 00:22:12.523722 | 2025-08-03 00:22:12.523811 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-03 00:22:12.561655 | debian-bookworm | ok 2025-08-03 00:22:12.579668 | debian-bookworm | included: /var/lib/zuul/builds/dc71e37625654be3854ba1ce909e2f4d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-03 00:22:12.591213 | 2025-08-03 00:22:12.591307 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-03 00:22:12.624685 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:22:12.630000 | 2025-08-03 00:22:12.630154 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-03 00:22:13.713730 | debian-bookworm | changed 2025-08-03 00:22:13.718276 | 2025-08-03 00:22:13.718363 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-03 00:22:13.960872 | debian-bookworm | ok 2025-08-03 00:22:13.965535 | 2025-08-03 00:22:13.965616 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-03 00:22:14.784116 | debian-bookworm | changed 2025-08-03 00:22:14.790019 | 2025-08-03 00:22:14.790105 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-03 00:22:15.559671 | debian-bookworm | changed 2025-08-03 00:22:15.564403 | 2025-08-03 00:22:15.564492 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-03 00:22:15.617710 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:22:15.624259 | 2025-08-03 00:22:15.624367 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-03 00:22:16.655135 | debian-bookworm -> localhost | changed 2025-08-03 00:22:16.664428 | 2025-08-03 00:22:16.664528 | TASK [add-build-sshkey : Add back temp key] 2025-08-03 00:22:17.511926 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dc71e37625654be3854ba1ce909e2f4d/work/dc71e37625654be3854ba1ce909e2f4d_id_rsa (zuul-build-sshkey) 2025-08-03 00:22:17.512142 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013475 2025-08-03 00:22:17.519525 | 2025-08-03 00:22:17.519622 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-03 00:22:17.976049 | debian-bookworm | ok 2025-08-03 00:22:17.980907 | 2025-08-03 00:22:17.980993 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-03 00:22:18.047664 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:22:18.057946 | 2025-08-03 00:22:18.058099 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-03 00:22:18.723019 | debian-bookworm | ok 2025-08-03 00:22:18.738445 | 2025-08-03 00:22:18.738540 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-03 00:22:18.813887 | debian-bookworm | ok 2025-08-03 00:22:18.829093 | 2025-08-03 00:22:18.829200 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-03 00:22:19.800527 | debian-bookworm -> localhost | ok 2025-08-03 00:22:19.806090 | 2025-08-03 00:22:19.806173 | TASK [validate-host : Collect information about the host] 2025-08-03 00:22:21.704893 | debian-bookworm | ok 2025-08-03 00:22:21.732847 | 2025-08-03 00:22:21.732948 | TASK [validate-host : Sanitize hostname] 2025-08-03 00:22:21.904509 | debian-bookworm | ok 2025-08-03 00:22:22.009048 | 2025-08-03 00:22:22.009248 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-03 00:22:23.562402 | debian-bookworm -> localhost | changed 2025-08-03 00:22:23.567321 | 2025-08-03 00:22:23.567408 | TASK [validate-host : Collect information about zuul worker] 2025-08-03 00:22:24.110354 | debian-bookworm | ok 2025-08-03 00:22:24.114251 | 2025-08-03 00:22:24.114337 | TASK [validate-host : Write out all zuul information for each host] 2025-08-03 00:22:25.216836 | debian-bookworm -> localhost | changed 2025-08-03 00:22:25.224256 | 2025-08-03 00:22:25.224346 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-03 00:22:25.543438 | debian-bookworm | ok 2025-08-03 00:22:25.548550 | 2025-08-03 00:22:25.548638 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-03 00:22:26.778011 | debian-bookworm | changed: 2025-08-03 00:22:26.778242 | debian-bookworm | cd+++++++++ src/ 2025-08-03 00:22:26.778276 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-03 00:22:26.778297 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-03 00:22:26.778315 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-08-03 00:22:26.778332 | debian-bookworm | =6.1 2025-08-03 00:22:52.743258 | debian-bookworm | Downloading cachetools-6.1.0-py3-none-any.whl (11 kB) 2025-08-03 00:22:52.781156 | debian-bookworm | Collecting chardet>=5.2 2025-08-03 00:22:52.788536 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-08-03 00:22:52.806042 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 13.0 MB/s eta 0:00:00 2025-08-03 00:22:52.836492 | debian-bookworm | Collecting colorama>=0.4.6 2025-08-03 00:22:52.843884 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-08-03 00:22:52.900069 | debian-bookworm | Collecting filelock>=3.18 2025-08-03 00:22:52.907167 | debian-bookworm | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-08-03 00:22:52.971391 | debian-bookworm | Collecting packaging>=25 2025-08-03 00:22:52.978640 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-08-03 00:22:52.988707 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.6 MB/s eta 0:00:00 2025-08-03 00:22:53.033736 | debian-bookworm | Collecting platformdirs>=4.3.8 2025-08-03 00:22:53.042247 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-08-03 00:22:53.079557 | debian-bookworm | Collecting pluggy>=1.6 2025-08-03 00:22:53.087575 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-08-03 00:22:53.133304 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-08-03 00:22:53.142293 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-08-03 00:22:53.275231 | debian-bookworm | Collecting virtualenv>=20.31.2 2025-08-03 00:22:53.282497 | debian-bookworm | Downloading virtualenv-20.32.0-py3-none-any.whl (6.1 MB) 2025-08-03 00:22:53.522251 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.1/6.1 MB 25.8 MB/s eta 0:00:00 2025-08-03 00:22:53.629108 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-08-03 00:22:53.636543 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-08-03 00:22:53.663971 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.6 MB/s eta 0:00:00 2025-08-03 00:22:53.805018 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-08-03 00:22:54.627183 | debian-bookworm | Successfully installed cachetools-6.1.0 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.18.0 packaging-25.0 platformdirs-4.3.8 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.28.4 virtualenv-20.32.0 2025-08-03 00:22:55.240758 | debian-bookworm | ok: Runtime: 0:00:02.708650 2025-08-03 00:22:55.253652 | 2025-08-03 00:22:55.253749 | TASK [ensure-tox : Export installed tox_executable path] 2025-08-03 00:22:55.314067 | debian-bookworm | ok 2025-08-03 00:22:55.318163 | 2025-08-03 00:22:55.318278 | TASK [ensure-tox : Output tox version] 2025-08-03 00:22:55.959402 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-08-03 00:22:55.977876 | debian-bookworm | 4.28.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-08-03 00:22:56.394913 | debian-bookworm | ok: Runtime: 0:00:00.304989 2025-08-03 00:22:56.401933 | 2025-08-03 00:22:56.402021 | TASK [ensure-tox : Make global symlink] 2025-08-03 00:22:56.446636 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:22:56.459012 | 2025-08-03 00:22:56.459102 | PLAY RECAP 2025-08-03 00:22:56.459154 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-08-03 00:22:56.459179 | 2025-08-03 00:22:56.809822 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-08-03 00:22:56.810682 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-08-03 00:22:58.771141 | 2025-08-03 00:22:58.771285 | PLAY [all] 2025-08-03 00:22:58.864146 | 2025-08-03 00:22:58.864310 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-08-03 00:23:00.109968 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-08-03 00:23:00.534550 | debian-bookworm | ok: Runtime: 0:00:00.026029 2025-08-03 00:23:00.539360 | 2025-08-03 00:23:00.539461 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-08-03 00:23:01.106575 | debian-bookworm | ok: Runtime: 0:00:00.007010 2025-08-03 00:23:01.111727 | 2025-08-03 00:23:01.111814 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-08-03 00:23:01.655708 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-08-03 00:23:01.655780 | debian-bookworm | sudo: a password is required 2025-08-03 00:23:01.697467 | debian-bookworm | ok: Runtime: 0:00:00.022650 2025-08-03 00:23:01.720329 | 2025-08-03 00:23:01.726107 | TASK [tox : Check to see if the constraints file exists] 2025-08-03 00:23:01.769099 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:01.774014 | 2025-08-03 00:23:01.774109 | TASK [tox : Fail if constraints file is missing] 2025-08-03 00:23:01.868713 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:01.873621 | 2025-08-03 00:23:01.873710 | TASK [tox : Record file location] 2025-08-03 00:23:01.916938 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:01.921517 | 2025-08-03 00:23:01.921605 | TASK [tox : Install tox siblings] 2025-08-03 00:23:01.949841 | debian-bookworm | ok 2025-08-03 00:23:01.957008 | debian-bookworm | included: /var/lib/zuul/builds/dc71e37625654be3854ba1ce909e2f4d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-08-03 00:23:01.963183 | 2025-08-03 00:23:01.963288 | TASK [tox : Run tox without tests] 2025-08-03 00:23:03.159485 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-08-03 00:23:16.061127 | debian-bookworm | test: OK (13.38 seconds) 2025-08-03 00:23:16.061223 | debian-bookworm | congratulations :) (13.45 seconds) 2025-08-03 00:23:16.534997 | debian-bookworm | ok: Runtime: 0:00:13.694434 2025-08-03 00:23:16.540571 | 2025-08-03 00:23:16.540664 | TASK [tox : Create a tempfile to save tox showconfig] 2025-08-03 00:23:17.128814 | debian-bookworm | changed 2025-08-03 00:23:17.135067 | 2025-08-03 00:23:17.135164 | TASK [tox : Get tox envlist config] 2025-08-03 00:23:18.206943 | debian-bookworm | ok: Runtime: 0:00:00.339255 2025-08-03 00:23:18.212432 | 2025-08-03 00:23:18.212526 | TASK [tox : Install any sibling python packages] 2025-08-03 00:23:18.748705 | debian-bookworm | ok: No setup.cfg, no action needed 2025-08-03 00:23:18.768016 | 2025-08-03 00:23:18.768127 | TASK [tox : Remove tempfile] 2025-08-03 00:23:19.467826 | debian-bookworm | changed 2025-08-03 00:23:19.473963 | 2025-08-03 00:23:19.474063 | TASK [tox : Emit tox command] 2025-08-03 00:23:19.547350 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-08-03 00:23:19.552368 | 2025-08-03 00:23:19.552471 | TASK [tox : Run tox] 2025-08-03 00:23:20.271155 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-08-03 00:23:20.833375 | debian-bookworm | /home/zuul/src/github.com/osism/openstack-image-manager/openstack_image_manager/__init__.py:5: UserWarning: pkg_resources is deprecated as an API. See https://setuptools.pypa.io/en/latest/pkg_resources.html. The pkg_resources package is slated for removal as early as 2025-11-30. Refrain from using this package or pin to Setuptools<81. 2025-08-03 00:23:20.833432 | debian-bookworm | from pkg_resources import get_distribution, DistributionNotFound 2025-08-03 00:23:21.151204 | debian-bookworm | ............... 2025-08-03 00:23:21.151261 | debian-bookworm | ---------------------------------------------------------------------- 2025-08-03 00:23:21.151268 | debian-bookworm | Ran 15 tests in 0.177s 2025-08-03 00:23:21.151313 | debian-bookworm | 2025-08-03 00:23:21.151334 | debian-bookworm | OK 2025-08-03 00:23:21.259890 | debian-bookworm | test: OK (1.03=setup[0.04]+cmd[0.99] seconds) 2025-08-03 00:23:21.259972 | debian-bookworm | congratulations :) (1.10 seconds) 2025-08-03 00:23:21.731792 | debian-bookworm | ok: Runtime: 0:00:01.333008 2025-08-03 00:23:21.737139 | 2025-08-03 00:23:21.737239 | TASK [tox : Look for output] 2025-08-03 00:23:22.104752 | debian-bookworm | ok 2025-08-03 00:23:22.119287 | 2025-08-03 00:23:22.119528 | TASK [tox : Return file comments to Zuul] 2025-08-03 00:23:22.165581 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:22.170966 | 2025-08-03 00:23:22.171034 | PLAY RECAP 2025-08-03 00:23:22.171084 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-08-03 00:23:22.171105 | 2025-08-03 00:23:22.311354 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-08-03 00:23:22.312329 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-08-03 00:23:23.080266 | 2025-08-03 00:23:23.080393 | PLAY [all] 2025-08-03 00:23:23.095860 | 2025-08-03 00:23:23.095988 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-08-03 00:23:23.169928 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:23.175447 | 2025-08-03 00:23:23.175574 | TASK [fetch-tox-output : Set tox log path for single node] 2025-08-03 00:23:23.203002 | debian-bookworm | ok 2025-08-03 00:23:23.208107 | 2025-08-03 00:23:23.208236 | TASK [fetch-tox-output : Ensure local tox dir] 2025-08-03 00:23:23.664621 | debian-bookworm -> localhost | changed 2025-08-03 00:23:23.677488 | 2025-08-03 00:23:23.677590 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-08-03 00:23:23.730461 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:23.735070 | 2025-08-03 00:23:23.735158 | TASK [fetch-tox-output : Set envlist fact] 2025-08-03 00:23:23.772102 | debian-bookworm | ok 2025-08-03 00:23:23.777001 | 2025-08-03 00:23:23.777086 | TASK [fetch-tox-output : Get tox version] 2025-08-03 00:23:24.395206 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-08-03 00:23:24.413104 | debian-bookworm | 4.28.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-08-03 00:23:24.804235 | debian-bookworm | ok: Runtime: 0:00:00.296914 2025-08-03 00:23:24.809853 | 2025-08-03 00:23:24.809948 | TASK [fetch-tox-output : Find all default environments] 2025-08-03 00:23:25.335454 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:25.351325 | 2025-08-03 00:23:25.351544 | TASK [fetch-tox-output : Set envlist fact] 2025-08-03 00:23:25.378930 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:25.385496 | 2025-08-03 00:23:25.385600 | TASK [fetch-tox-output : Find all default environments] 2025-08-03 00:23:25.911221 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:25.916871 | 2025-08-03 00:23:25.916977 | TASK [fetch-tox-output : Set envlist fact] 2025-08-03 00:23:25.950120 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:25.958489 | 2025-08-03 00:23:25.958617 | LOOP [fetch-tox-output : Copy tox logs] 2025-08-03 00:23:26.001665 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:26.014266 | 2025-08-03 00:23:26.014404 | LOOP [fetch-tox-output : Collect tox logs] 2025-08-03 00:23:26.828735 | debian-bookworm | changed: 2025-08-03 00:23:26.828990 | debian-bookworm | created directory /var/lib/zuul/builds/dc71e37625654be3854ba1ce909e2f4d/work/logs/tox/test 2025-08-03 00:23:26.829050 | debian-bookworm | cd+++++++++ ./ 2025-08-03 00:23:26.829096 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-08-03 00:23:26.829148 | 2025-08-03 00:23:26.847248 | 2025-08-03 00:23:26.847384 | PLAY RECAP 2025-08-03 00:23:26.847464 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-08-03 00:23:26.847504 | 2025-08-03 00:23:26.952176 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-08-03 00:23:26.954629 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-08-03 00:23:27.638552 | 2025-08-03 00:23:27.638668 | PLAY [all] 2025-08-03 00:23:27.650735 | 2025-08-03 00:23:27.650852 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-08-03 00:23:27.858288 | debian-bookworm | changed: non-zero return code 2025-08-03 00:23:27.866323 | 2025-08-03 00:23:27.866464 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-08-03 00:23:27.900739 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:27.911456 | 2025-08-03 00:23:27.911617 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-08-03 00:23:27.942983 | 2025-08-03 00:23:27.943384 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-08-03 00:23:27.984737 | 2025-08-03 00:23:27.985004 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-08-03 00:23:28.009814 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:28.024061 | 2025-08-03 00:23:28.024242 | LOOP [fetch-subunit-output : Generate subunit file] 2025-08-03 00:23:28.060758 | 2025-08-03 00:23:28.061023 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-08-03 00:23:28.075111 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:28.084743 | 2025-08-03 00:23:28.084903 | TASK [fetch-subunit-output : Remove the temporary file] 2025-08-03 00:23:28.110261 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:28.123474 | 2025-08-03 00:23:28.123602 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-08-03 00:23:28.137933 | debian-bookworm | skipping: Conditional result was False 2025-08-03 00:23:28.147940 | 2025-08-03 00:23:28.148031 | PLAY RECAP 2025-08-03 00:23:28.148090 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-08-03 00:23:28.148120 | 2025-08-03 00:23:28.260421 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-08-03 00:23:28.263050 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-03 00:23:28.953387 | 2025-08-03 00:23:28.953528 | PLAY [Base post] 2025-08-03 00:23:28.965935 | 2025-08-03 00:23:28.966063 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-03 00:23:29.494485 | debian-bookworm | changed 2025-08-03 00:23:29.502662 | 2025-08-03 00:23:29.502767 | PLAY RECAP 2025-08-03 00:23:29.502868 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-03 00:23:29.502948 | 2025-08-03 00:23:29.584905 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-03 00:23:29.585896 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-03 00:23:30.402553 | 2025-08-03 00:23:30.402725 | PLAY [Base post-logs] 2025-08-03 00:23:30.425670 | 2025-08-03 00:23:30.425839 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-03 00:23:30.925820 | localhost | changed 2025-08-03 00:23:30.937486 | 2025-08-03 00:23:30.937660 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-03 00:23:30.967656 | localhost | ok 2025-08-03 00:23:30.973332 | 2025-08-03 00:23:30.973652 | TASK [Set zuul-log-path fact] 2025-08-03 00:23:30.990992 | localhost | ok 2025-08-03 00:23:31.012940 | 2025-08-03 00:23:31.013072 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-03 00:23:31.039966 | localhost | ok 2025-08-03 00:23:31.044692 | 2025-08-03 00:23:31.044807 | TASK [upload-logs : Create log directories] 2025-08-03 00:23:31.564610 | localhost | changed 2025-08-03 00:23:31.570135 | 2025-08-03 00:23:31.570288 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-03 00:23:32.122367 | localhost -> localhost | ok: Runtime: 0:00:00.006468 2025-08-03 00:23:32.129324 | 2025-08-03 00:23:32.129515 | TASK [upload-logs : Upload logs to log server] 2025-08-03 00:23:32.698621 | localhost | Output suppressed because no_log was given 2025-08-03 00:23:32.702397 | 2025-08-03 00:23:32.702580 | LOOP [upload-logs : Compress console log and json output] 2025-08-03 00:23:32.767961 | localhost | skipping: Conditional result was False 2025-08-03 00:23:32.786789 | localhost | skipping: Conditional result was False 2025-08-03 00:23:32.792512 | 2025-08-03 00:23:32.792633 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-03 00:23:32.860914 | localhost | skipping: Conditional result was False 2025-08-03 00:23:32.861211 | 2025-08-03 00:23:32.869039 | localhost | skipping: Conditional result was False 2025-08-03 00:23:32.879626 | 2025-08-03 00:23:32.879765 | LOOP [upload-logs : Upload console log and json output]