2025-08-24 00:20:26.077540 | Job console starting 2025-08-24 00:20:26.090613 | Updating git repos 2025-08-24 00:20:26.131479 | Cloning repos into workspace 2025-08-24 00:20:26.224817 | Restoring repo states 2025-08-24 00:20:26.266505 | Merging changes 2025-08-24 00:20:26.956545 | Checking out repos 2025-08-24 00:20:27.032894 | Preparing playbooks 2025-08-24 00:20:27.719255 | Running Ansible setup 2025-08-24 00:20:32.508875 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-24 00:20:33.940306 | 2025-08-24 00:20:33.940447 | PLAY [Base pre] 2025-08-24 00:20:33.955865 | 2025-08-24 00:20:33.955998 | TASK [Setup log path fact] 2025-08-24 00:20:33.984674 | debian-bookworm | ok 2025-08-24 00:20:34.004992 | 2025-08-24 00:20:34.005119 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-24 00:20:34.038171 | debian-bookworm | ok 2025-08-24 00:20:34.051969 | 2025-08-24 00:20:34.052084 | TASK [emit-job-header : Print job information] 2025-08-24 00:20:34.193125 | # Job Information 2025-08-24 00:20:34.193300 | Ansible Version: 2.16.14 2025-08-24 00:20:34.193336 | Job: tox 2025-08-24 00:20:34.193368 | Pipeline: check 2025-08-24 00:20:34.193391 | Executor: 521e9411259a 2025-08-24 00:20:34.193411 | Triggered by: https://github.com/osism/openstack-image-manager/pull/941 2025-08-24 00:20:34.193432 | Event ID: 03670de0-8080-11f0-895d-be7691f15110 2025-08-24 00:20:34.205512 | 2025-08-24 00:20:34.205619 | LOOP [emit-job-header : Print node information] 2025-08-24 00:20:34.395425 | debian-bookworm | ok: 2025-08-24 00:20:34.395831 | debian-bookworm | # Node Information 2025-08-24 00:20:34.395882 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-24 00:20:34.395920 | debian-bookworm | Hostname: debian 2025-08-24 00:20:34.395944 | debian-bookworm | Username: zuul 2025-08-24 00:20:34.395966 | debian-bookworm | Distro: Debian 12.11 2025-08-24 00:20:34.395991 | debian-bookworm | Provider: regiocloud-a 2025-08-24 00:20:34.396012 | debian-bookworm | Region: 2025-08-24 00:20:34.396033 | debian-bookworm | Label: debian-bookworm 2025-08-24 00:20:34.396054 | debian-bookworm | Product Name: OpenStack Nova 2025-08-24 00:20:34.396073 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec2:73db 2025-08-24 00:20:34.416911 | 2025-08-24 00:20:34.417024 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-24 00:20:35.046251 | debian-bookworm -> localhost | changed 2025-08-24 00:20:35.053198 | 2025-08-24 00:20:35.053308 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-24 00:20:38.307595 | debian-bookworm -> localhost | changed 2025-08-24 00:20:38.316352 | 2025-08-24 00:20:38.316448 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-24 00:20:39.120913 | debian-bookworm -> localhost | ok 2025-08-24 00:20:39.125801 | 2025-08-24 00:20:39.125890 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-24 00:20:39.169015 | debian-bookworm | ok 2025-08-24 00:20:39.215570 | debian-bookworm | included: /var/lib/zuul/builds/d4408f15e48f4010be934dff4fb3336d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-24 00:20:39.236800 | 2025-08-24 00:20:39.236891 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-24 00:20:41.993377 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-24 00:20:41.993565 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d4408f15e48f4010be934dff4fb3336d/work/d4408f15e48f4010be934dff4fb3336d_id_rsa 2025-08-24 00:20:41.993605 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d4408f15e48f4010be934dff4fb3336d/work/d4408f15e48f4010be934dff4fb3336d_id_rsa.pub 2025-08-24 00:20:41.993634 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-24 00:20:41.993662 | debian-bookworm -> localhost | SHA256:Sfz62QddzVCYtul5U6CAuMlBY96AOGJD5t7pBC8bhF0 zuul-build-sshkey 2025-08-24 00:20:41.993685 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-24 00:20:41.993716 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-24 00:20:41.993738 | debian-bookworm -> localhost | |.o .Eo=. . +.| 2025-08-24 00:20:41.993760 | debian-bookworm -> localhost | |=+o..oo=. . * | 2025-08-24 00:20:41.993781 | debian-bookworm -> localhost | |o=o. ..++ . o *.| 2025-08-24 00:20:41.993801 | debian-bookworm -> localhost | |o + . +. o . o =| 2025-08-24 00:20:41.993821 | debian-bookworm -> localhost | | + = S . o o.| 2025-08-24 00:20:41.993852 | debian-bookworm -> localhost | | * . . +..| 2025-08-24 00:20:41.993888 | debian-bookworm -> localhost | | . . . . ..| 2025-08-24 00:20:41.993918 | debian-bookworm -> localhost | | . o . | 2025-08-24 00:20:41.993941 | debian-bookworm -> localhost | | o .. | 2025-08-24 00:20:41.993962 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-24 00:20:41.994020 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.656488 2025-08-24 00:20:42.000242 | 2025-08-24 00:20:42.000336 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-24 00:20:42.038404 | debian-bookworm | ok 2025-08-24 00:20:42.056174 | debian-bookworm | included: /var/lib/zuul/builds/d4408f15e48f4010be934dff4fb3336d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-24 00:20:42.081273 | 2025-08-24 00:20:42.081389 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-24 00:20:42.106590 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:20:42.112456 | 2025-08-24 00:20:42.112560 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-24 00:20:42.772042 | debian-bookworm | changed 2025-08-24 00:20:42.783859 | 2025-08-24 00:20:42.783947 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-24 00:20:43.091986 | debian-bookworm | ok 2025-08-24 00:20:43.098381 | 2025-08-24 00:20:43.098513 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-24 00:20:43.781783 | debian-bookworm | changed 2025-08-24 00:20:43.792287 | 2025-08-24 00:20:43.792423 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-24 00:20:44.487390 | debian-bookworm | changed 2025-08-24 00:20:44.494023 | 2025-08-24 00:20:44.494111 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-24 00:20:44.537136 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:20:44.543227 | 2025-08-24 00:20:44.543329 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-24 00:20:45.134558 | debian-bookworm -> localhost | changed 2025-08-24 00:20:45.150172 | 2025-08-24 00:20:45.150279 | TASK [add-build-sshkey : Add back temp key] 2025-08-24 00:20:45.536754 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d4408f15e48f4010be934dff4fb3336d/work/d4408f15e48f4010be934dff4fb3336d_id_rsa (zuul-build-sshkey) 2025-08-24 00:20:45.536958 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.007846 2025-08-24 00:20:45.544553 | 2025-08-24 00:20:45.544645 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-24 00:20:45.980671 | debian-bookworm | ok 2025-08-24 00:20:45.991020 | 2025-08-24 00:20:45.991245 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-24 00:20:46.019135 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:20:46.033709 | 2025-08-24 00:20:46.033834 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-24 00:20:46.480684 | debian-bookworm | ok 2025-08-24 00:20:46.491829 | 2025-08-24 00:20:46.491915 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-24 00:20:46.518894 | debian-bookworm | ok 2025-08-24 00:20:46.523085 | 2025-08-24 00:20:46.523367 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-24 00:20:46.778329 | debian-bookworm -> localhost | ok 2025-08-24 00:20:46.784949 | 2025-08-24 00:20:46.785035 | TASK [validate-host : Collect information about the host] 2025-08-24 00:20:47.827318 | debian-bookworm | ok 2025-08-24 00:20:47.835567 | 2025-08-24 00:20:47.835643 | TASK [validate-host : Sanitize hostname] 2025-08-24 00:20:47.903477 | debian-bookworm | ok 2025-08-24 00:20:47.935462 | 2025-08-24 00:20:47.935562 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-24 00:20:48.382646 | debian-bookworm -> localhost | changed 2025-08-24 00:20:48.387396 | 2025-08-24 00:20:48.387477 | TASK [validate-host : Collect information about zuul worker] 2025-08-24 00:20:48.774381 | debian-bookworm | ok 2025-08-24 00:20:48.778204 | 2025-08-24 00:20:48.778290 | TASK [validate-host : Write out all zuul information for each host] 2025-08-24 00:20:49.305489 | debian-bookworm -> localhost | changed 2025-08-24 00:20:49.312906 | 2025-08-24 00:20:49.312979 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-24 00:20:49.571516 | debian-bookworm | ok 2025-08-24 00:20:49.575823 | 2025-08-24 00:20:49.575893 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-24 00:20:50.429639 | debian-bookworm | changed: 2025-08-24 00:20:50.429806 | debian-bookworm | cd+++++++++ src/ 2025-08-24 00:20:50.429839 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-24 00:20:50.429863 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-24 00:20:50.429884 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-08-24 00:20:50.429904 | debian-bookworm | =6.1 2025-08-24 00:21:11.860156 | debian-bookworm | Downloading cachetools-6.1.0-py3-none-any.whl (11 kB) 2025-08-24 00:21:11.890797 | debian-bookworm | Collecting chardet>=5.2 2025-08-24 00:21:11.899143 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-08-24 00:21:11.918175 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.8 MB/s eta 0:00:00 2025-08-24 00:21:11.950846 | debian-bookworm | Collecting colorama>=0.4.6 2025-08-24 00:21:11.958875 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-08-24 00:21:12.007810 | debian-bookworm | Collecting filelock>=3.18 2025-08-24 00:21:12.016292 | debian-bookworm | Downloading filelock-3.19.1-py3-none-any.whl (15 kB) 2025-08-24 00:21:12.065211 | debian-bookworm | Collecting packaging>=25 2025-08-24 00:21:12.073497 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-08-24 00:21:12.082258 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.7 MB/s eta 0:00:00 2025-08-24 00:21:12.124805 | debian-bookworm | Collecting platformdirs>=4.3.8 2025-08-24 00:21:12.133216 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-08-24 00:21:12.170494 | debian-bookworm | Collecting pluggy>=1.6 2025-08-24 00:21:12.178891 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-08-24 00:21:12.214356 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-08-24 00:21:12.222245 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-08-24 00:21:12.345838 | debian-bookworm | Collecting virtualenv>=20.31.2 2025-08-24 00:21:12.354014 | debian-bookworm | Downloading virtualenv-20.34.0-py3-none-any.whl (6.0 MB) 2025-08-24 00:21:12.616860 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 23.1 MB/s eta 0:00:00 2025-08-24 00:21:12.715713 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-08-24 00:21:12.724339 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-08-24 00:21:12.750557 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.5 MB/s eta 0:00:00 2025-08-24 00:21:12.899804 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-08-24 00:21:13.761510 | debian-bookworm | Successfully installed cachetools-6.1.0 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.19.1 packaging-25.0 platformdirs-4.3.8 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.28.4 virtualenv-20.34.0 2025-08-24 00:21:14.299323 | debian-bookworm | ok: Runtime: 0:00:02.816121 2025-08-24 00:21:14.305347 | 2025-08-24 00:21:14.305469 | TASK [ensure-tox : Export installed tox_executable path] 2025-08-24 00:21:14.340056 | debian-bookworm | ok 2025-08-24 00:21:14.344955 | 2025-08-24 00:21:14.345068 | TASK [ensure-tox : Output tox version] 2025-08-24 00:21:14.851855 | 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-24 00:21:14.869773 | debian-bookworm | 4.28.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-08-24 00:21:15.372006 | debian-bookworm | ok: Runtime: 0:00:00.295864 2025-08-24 00:21:15.378562 | 2025-08-24 00:21:15.378681 | TASK [ensure-tox : Make global symlink] 2025-08-24 00:21:15.402664 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:15.409373 | 2025-08-24 00:21:15.409464 | PLAY RECAP 2025-08-24 00:21:15.409517 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-08-24 00:21:15.409543 | 2025-08-24 00:21:15.562030 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-08-24 00:21:15.563712 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-08-24 00:21:16.368887 | 2025-08-24 00:21:16.369047 | PLAY [all] 2025-08-24 00:21:16.384850 | 2025-08-24 00:21:16.384991 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-08-24 00:21:16.892292 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-08-24 00:21:16.947987 | debian-bookworm | ok: Runtime: 0:00:00.027239 2025-08-24 00:21:16.957997 | 2025-08-24 00:21:16.958239 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-08-24 00:21:17.496935 | debian-bookworm | ok: Runtime: 0:00:00.005489 2025-08-24 00:21:17.503252 | 2025-08-24 00:21:17.503390 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-08-24 00:21:17.796987 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-08-24 00:21:17.800093 | debian-bookworm | sudo: a password is required 2025-08-24 00:21:18.034569 | debian-bookworm | ok: Runtime: 0:00:00.026716 2025-08-24 00:21:18.053425 | 2025-08-24 00:21:18.053569 | TASK [tox : Check to see if the constraints file exists] 2025-08-24 00:21:18.088562 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:18.098576 | 2025-08-24 00:21:18.098712 | TASK [tox : Fail if constraints file is missing] 2025-08-24 00:21:18.125099 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:18.138787 | 2025-08-24 00:21:18.138992 | TASK [tox : Record file location] 2025-08-24 00:21:18.163659 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:18.177157 | 2025-08-24 00:21:18.177371 | TASK [tox : Install tox siblings] 2025-08-24 00:21:18.204399 | debian-bookworm | ok 2025-08-24 00:21:18.215134 | debian-bookworm | included: /var/lib/zuul/builds/d4408f15e48f4010be934dff4fb3336d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-08-24 00:21:18.220937 | 2025-08-24 00:21:18.221045 | TASK [tox : Run tox without tests] 2025-08-24 00:21:19.311494 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-08-24 00:21:32.002714 | debian-bookworm | test: OK (13.24 seconds) 2025-08-24 00:21:32.002777 | debian-bookworm | congratulations :) (13.31 seconds) 2025-08-24 00:21:32.261526 | debian-bookworm | ok: Runtime: 0:00:13.549632 2025-08-24 00:21:32.275117 | 2025-08-24 00:21:32.275332 | TASK [tox : Create a tempfile to save tox showconfig] 2025-08-24 00:21:32.675323 | debian-bookworm | changed 2025-08-24 00:21:32.682537 | 2025-08-24 00:21:32.682666 | TASK [tox : Get tox envlist config] 2025-08-24 00:21:33.718102 | debian-bookworm | ok: Runtime: 0:00:00.346310 2025-08-24 00:21:33.730135 | 2025-08-24 00:21:33.730319 | TASK [tox : Install any sibling python packages] 2025-08-24 00:21:34.184317 | debian-bookworm | ok: No setup.cfg, no action needed 2025-08-24 00:21:34.194300 | 2025-08-24 00:21:34.194472 | TASK [tox : Remove tempfile] 2025-08-24 00:21:34.636425 | debian-bookworm | changed 2025-08-24 00:21:34.642260 | 2025-08-24 00:21:34.642373 | TASK [tox : Emit tox command] 2025-08-24 00:21:34.691630 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-08-24 00:21:34.697025 | 2025-08-24 00:21:34.697146 | TASK [tox : Run tox] 2025-08-24 00:21:35.299407 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-08-24 00:21:35.864104 | 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-24 00:21:35.864161 | debian-bookworm | from pkg_resources import get_distribution, DistributionNotFound 2025-08-24 00:21:36.182372 | debian-bookworm | ............... 2025-08-24 00:21:36.182427 | debian-bookworm | ---------------------------------------------------------------------- 2025-08-24 00:21:36.182434 | debian-bookworm | Ran 15 tests in 0.177s 2025-08-24 00:21:36.182440 | debian-bookworm | 2025-08-24 00:21:36.182462 | debian-bookworm | OK 2025-08-24 00:21:36.303133 | debian-bookworm | test: OK (1.04=setup[0.04]+cmd[1.00] seconds) 2025-08-24 00:21:36.303199 | debian-bookworm | congratulations :) (1.12 seconds) 2025-08-24 00:21:36.761734 | debian-bookworm | ok: Runtime: 0:00:01.352542 2025-08-24 00:21:36.775312 | 2025-08-24 00:21:36.775488 | TASK [tox : Look for output] 2025-08-24 00:21:37.185059 | debian-bookworm | ok 2025-08-24 00:21:37.204573 | 2025-08-24 00:21:37.204722 | TASK [tox : Return file comments to Zuul] 2025-08-24 00:21:37.239018 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:37.245464 | 2025-08-24 00:21:37.245552 | PLAY RECAP 2025-08-24 00:21:37.245606 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-08-24 00:21:37.245632 | 2025-08-24 00:21:37.395356 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-08-24 00:21:37.399359 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-08-24 00:21:38.152485 | 2025-08-24 00:21:38.152634 | PLAY [all] 2025-08-24 00:21:38.167843 | 2025-08-24 00:21:38.167983 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-08-24 00:21:38.223657 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:38.236463 | 2025-08-24 00:21:38.236674 | TASK [fetch-tox-output : Set tox log path for single node] 2025-08-24 00:21:38.293371 | debian-bookworm | ok 2025-08-24 00:21:38.302199 | 2025-08-24 00:21:38.302365 | TASK [fetch-tox-output : Ensure local tox dir] 2025-08-24 00:21:38.768874 | debian-bookworm -> localhost | changed 2025-08-24 00:21:38.783182 | 2025-08-24 00:21:38.783354 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-08-24 00:21:38.838226 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:38.844046 | 2025-08-24 00:21:38.844168 | TASK [fetch-tox-output : Set envlist fact] 2025-08-24 00:21:38.886132 | debian-bookworm | ok 2025-08-24 00:21:38.894066 | 2025-08-24 00:21:38.894175 | TASK [fetch-tox-output : Get tox version] 2025-08-24 00:21:39.532611 | 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-24 00:21:39.549537 | debian-bookworm | 4.28.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-08-24 00:21:39.935600 | debian-bookworm | ok: Runtime: 0:00:00.250316 2025-08-24 00:21:39.950414 | 2025-08-24 00:21:39.950597 | TASK [fetch-tox-output : Find all default environments] 2025-08-24 00:21:40.485555 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:40.498898 | 2025-08-24 00:21:40.499077 | TASK [fetch-tox-output : Set envlist fact] 2025-08-24 00:21:40.534600 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:40.545360 | 2025-08-24 00:21:40.545524 | TASK [fetch-tox-output : Find all default environments] 2025-08-24 00:21:41.077780 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:41.085823 | 2025-08-24 00:21:41.085970 | TASK [fetch-tox-output : Set envlist fact] 2025-08-24 00:21:41.110974 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:41.130989 | 2025-08-24 00:21:41.131144 | LOOP [fetch-tox-output : Copy tox logs] 2025-08-24 00:21:41.197797 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:41.220785 | 2025-08-24 00:21:41.221117 | LOOP [fetch-tox-output : Collect tox logs] 2025-08-24 00:21:42.057650 | debian-bookworm | changed: 2025-08-24 00:21:42.057959 | debian-bookworm | created directory /var/lib/zuul/builds/d4408f15e48f4010be934dff4fb3336d/work/logs/tox/test 2025-08-24 00:21:42.058021 | debian-bookworm | cd+++++++++ ./ 2025-08-24 00:21:42.058065 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-08-24 00:21:42.058111 | 2025-08-24 00:21:42.078821 | 2025-08-24 00:21:42.078986 | PLAY RECAP 2025-08-24 00:21:42.079067 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-08-24 00:21:42.079108 | 2025-08-24 00:21:42.209685 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-08-24 00:21:42.211121 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-08-24 00:21:42.965470 | 2025-08-24 00:21:42.965636 | PLAY [all] 2025-08-24 00:21:42.981530 | 2025-08-24 00:21:42.981681 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-08-24 00:21:43.211814 | debian-bookworm | changed: non-zero return code 2025-08-24 00:21:43.220192 | 2025-08-24 00:21:43.220399 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-08-24 00:21:43.245484 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:43.261786 | 2025-08-24 00:21:43.261944 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-08-24 00:21:43.296562 | 2025-08-24 00:21:43.296768 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-08-24 00:21:43.347560 | 2025-08-24 00:21:43.347927 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-08-24 00:21:43.373036 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:43.386256 | 2025-08-24 00:21:43.386448 | LOOP [fetch-subunit-output : Generate subunit file] 2025-08-24 00:21:43.421609 | 2025-08-24 00:21:43.421798 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-08-24 00:21:43.445375 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:43.451576 | 2025-08-24 00:21:43.451691 | TASK [fetch-subunit-output : Remove the temporary file] 2025-08-24 00:21:43.475122 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:43.480773 | 2025-08-24 00:21:43.480876 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-08-24 00:21:43.504250 | debian-bookworm | skipping: Conditional result was False 2025-08-24 00:21:43.510443 | 2025-08-24 00:21:43.510520 | PLAY RECAP 2025-08-24 00:21:43.510570 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-08-24 00:21:43.510595 | 2025-08-24 00:21:43.630012 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-08-24 00:21:43.631172 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-24 00:21:44.398713 | 2025-08-24 00:21:44.398905 | PLAY [Base post] 2025-08-24 00:21:44.412496 | 2025-08-24 00:21:44.412628 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-24 00:21:44.954028 | debian-bookworm | changed 2025-08-24 00:21:44.960589 | 2025-08-24 00:21:44.960704 | PLAY RECAP 2025-08-24 00:21:44.960766 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-24 00:21:44.960827 | 2025-08-24 00:21:45.084729 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-24 00:21:45.085847 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-24 00:21:45.877393 | 2025-08-24 00:21:45.877574 | PLAY [Base post-logs] 2025-08-24 00:21:45.889245 | 2025-08-24 00:21:45.889401 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-24 00:21:46.341042 | localhost | changed 2025-08-24 00:21:46.351067 | 2025-08-24 00:21:46.351243 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-24 00:21:46.397306 | localhost | ok 2025-08-24 00:21:46.400324 | 2025-08-24 00:21:46.400420 | TASK [Set zuul-log-path fact] 2025-08-24 00:21:46.425776 | localhost | ok 2025-08-24 00:21:46.433659 | 2025-08-24 00:21:46.433763 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-24 00:21:46.470711 | localhost | ok 2025-08-24 00:21:46.477357 | 2025-08-24 00:21:46.477519 | TASK [upload-logs : Create log directories] 2025-08-24 00:21:46.974100 | localhost | changed 2025-08-24 00:21:46.978000 | 2025-08-24 00:21:46.978122 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-24 00:21:47.482357 | localhost -> localhost | ok: Runtime: 0:00:00.007506 2025-08-24 00:21:47.490268 | 2025-08-24 00:21:47.490420 | TASK [upload-logs : Upload logs to log server] 2025-08-24 00:21:48.027608 | localhost | Output suppressed because no_log was given 2025-08-24 00:21:48.029499 | 2025-08-24 00:21:48.029609 | LOOP [upload-logs : Compress console log and json output] 2025-08-24 00:21:48.077105 | localhost | skipping: Conditional result was False 2025-08-24 00:21:48.082127 | localhost | skipping: Conditional result was False 2025-08-24 00:21:48.089525 | 2025-08-24 00:21:48.089737 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-24 00:21:48.135905 | localhost | skipping: Conditional result was False 2025-08-24 00:21:48.136518 | 2025-08-24 00:21:48.139871 | localhost | skipping: Conditional result was False 2025-08-24 00:21:48.149810 | 2025-08-24 00:21:48.149919 | LOOP [upload-logs : Upload console log and json output]