2025-07-06 00:23:18.046119 | Job console starting 2025-07-06 00:23:18.057230 | Updating git repos 2025-07-06 00:23:18.215972 | Cloning repos into workspace 2025-07-06 00:23:18.279896 | Restoring repo states 2025-07-06 00:23:18.317324 | Merging changes 2025-07-06 00:23:18.832379 | Checking out repos 2025-07-06 00:23:18.854112 | Preparing playbooks 2025-07-06 00:23:19.381778 | Running Ansible setup 2025-07-06 00:23:23.867796 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-06 00:23:24.653200 | 2025-07-06 00:23:24.653385 | PLAY [Base pre] 2025-07-06 00:23:24.669853 | 2025-07-06 00:23:24.669987 | TASK [Setup log path fact] 2025-07-06 00:23:24.699470 | debian-bookworm | ok 2025-07-06 00:23:24.714921 | 2025-07-06 00:23:24.715058 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-06 00:23:24.762687 | debian-bookworm | ok 2025-07-06 00:23:24.780668 | 2025-07-06 00:23:24.780843 | TASK [emit-job-header : Print job information] 2025-07-06 00:23:24.823542 | # Job Information 2025-07-06 00:23:24.823739 | Ansible Version: 2.16.14 2025-07-06 00:23:24.823776 | Job: tox 2025-07-06 00:23:24.823809 | Pipeline: check 2025-07-06 00:23:24.823833 | Executor: 521e9411259a 2025-07-06 00:23:24.823854 | Triggered by: https://github.com/osism/openstack-image-manager/pull/918 2025-07-06 00:23:24.823877 | Event ID: f9ebf0c0-59fe-11f0-8264-533b1ee4520a 2025-07-06 00:23:24.828849 | 2025-07-06 00:23:24.828968 | LOOP [emit-job-header : Print node information] 2025-07-06 00:23:24.962974 | debian-bookworm | ok: 2025-07-06 00:23:24.963238 | debian-bookworm | # Node Information 2025-07-06 00:23:24.963275 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-06 00:23:24.963319 | debian-bookworm | Hostname: debian 2025-07-06 00:23:24.963343 | debian-bookworm | Username: zuul 2025-07-06 00:23:24.963364 | debian-bookworm | Distro: Debian 12.11 2025-07-06 00:23:24.963395 | debian-bookworm | Provider: regiocloud-a 2025-07-06 00:23:24.963422 | debian-bookworm | Region: 2025-07-06 00:23:24.963443 | debian-bookworm | Label: debian-bookworm 2025-07-06 00:23:24.963463 | debian-bookworm | Product Name: OpenStack Nova 2025-07-06 00:23:24.963484 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feed:92bb 2025-07-06 00:23:24.985990 | 2025-07-06 00:23:24.986140 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-06 00:23:25.549777 | debian-bookworm -> localhost | changed 2025-07-06 00:23:25.564711 | 2025-07-06 00:23:25.565003 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-06 00:23:26.828813 | debian-bookworm -> localhost | changed 2025-07-06 00:23:26.847646 | 2025-07-06 00:23:26.847997 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-06 00:23:27.149633 | debian-bookworm -> localhost | ok 2025-07-06 00:23:27.161195 | 2025-07-06 00:23:27.161393 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-06 00:23:27.191480 | debian-bookworm | ok 2025-07-06 00:23:27.209686 | debian-bookworm | included: /var/lib/zuul/builds/fb1505e96f6841c8842a63e477592e8d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-06 00:23:27.215958 | 2025-07-06 00:23:27.216073 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-06 00:23:30.107385 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-06 00:23:30.107698 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fb1505e96f6841c8842a63e477592e8d/work/fb1505e96f6841c8842a63e477592e8d_id_rsa 2025-07-06 00:23:30.107744 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fb1505e96f6841c8842a63e477592e8d/work/fb1505e96f6841c8842a63e477592e8d_id_rsa.pub 2025-07-06 00:23:30.107821 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-06 00:23:30.107852 | debian-bookworm -> localhost | SHA256:Y27dpAVvab9MkmQ0kPI92ayEBK2BmLdWWxXJ01TH1BE zuul-build-sshkey 2025-07-06 00:23:30.107941 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-06 00:23:30.107984 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-06 00:23:30.108009 | debian-bookworm -> localhost | | o ..o.+o=.EB| 2025-07-06 00:23:30.108032 | debian-bookworm -> localhost | | o o + =.+ . +| 2025-07-06 00:23:30.108054 | debian-bookworm -> localhost | | . o O.oo= | 2025-07-06 00:23:30.108076 | debian-bookworm -> localhost | | o o o+=oo | 2025-07-06 00:23:30.108098 | debian-bookworm -> localhost | | . S .Xo | 2025-07-06 00:23:30.108124 | debian-bookworm -> localhost | | o o X.o | 2025-07-06 00:23:30.108146 | debian-bookworm -> localhost | | o o + o | 2025-07-06 00:23:30.108167 | debian-bookworm -> localhost | | . + . | 2025-07-06 00:23:30.108228 | debian-bookworm -> localhost | | o | 2025-07-06 00:23:30.108252 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-06 00:23:30.108332 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.325238 2025-07-06 00:23:30.116133 | 2025-07-06 00:23:30.116734 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-06 00:23:30.146620 | debian-bookworm | ok 2025-07-06 00:23:30.157941 | debian-bookworm | included: /var/lib/zuul/builds/fb1505e96f6841c8842a63e477592e8d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-06 00:23:30.169590 | 2025-07-06 00:23:30.169763 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-06 00:23:30.194418 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:23:30.200978 | 2025-07-06 00:23:30.201524 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-06 00:23:31.046614 | debian-bookworm | changed 2025-07-06 00:23:31.054297 | 2025-07-06 00:23:31.054547 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-06 00:23:31.313671 | debian-bookworm | ok 2025-07-06 00:23:31.327123 | 2025-07-06 00:23:31.327261 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-06 00:23:32.035457 | debian-bookworm | changed 2025-07-06 00:23:32.056923 | 2025-07-06 00:23:32.057097 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-06 00:23:32.695973 | debian-bookworm | changed 2025-07-06 00:23:32.717864 | 2025-07-06 00:23:32.718030 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-06 00:23:32.742466 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:23:32.749281 | 2025-07-06 00:23:32.749449 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-06 00:23:33.396115 | debian-bookworm -> localhost | changed 2025-07-06 00:23:33.417185 | 2025-07-06 00:23:33.417554 | TASK [add-build-sshkey : Add back temp key] 2025-07-06 00:23:33.858997 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fb1505e96f6841c8842a63e477592e8d/work/fb1505e96f6841c8842a63e477592e8d_id_rsa (zuul-build-sshkey) 2025-07-06 00:23:33.859269 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012716 2025-07-06 00:23:33.870801 | 2025-07-06 00:23:33.870956 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-06 00:23:34.361126 | debian-bookworm | ok 2025-07-06 00:23:34.370220 | 2025-07-06 00:23:34.370857 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-06 00:23:34.419770 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:23:34.438734 | 2025-07-06 00:23:34.438939 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-06 00:23:34.902442 | debian-bookworm | ok 2025-07-06 00:23:34.921236 | 2025-07-06 00:23:34.921415 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-06 00:23:34.972067 | debian-bookworm | ok 2025-07-06 00:23:34.984228 | 2025-07-06 00:23:34.984444 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-06 00:23:35.344462 | debian-bookworm -> localhost | ok 2025-07-06 00:23:35.352540 | 2025-07-06 00:23:35.352666 | TASK [validate-host : Collect information about the host] 2025-07-06 00:23:36.471959 | debian-bookworm | ok 2025-07-06 00:23:36.484260 | 2025-07-06 00:23:36.484393 | TASK [validate-host : Sanitize hostname] 2025-07-06 00:23:36.564249 | debian-bookworm | ok 2025-07-06 00:23:36.609259 | 2025-07-06 00:23:36.609402 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-06 00:23:37.209403 | debian-bookworm -> localhost | changed 2025-07-06 00:23:37.215929 | 2025-07-06 00:23:37.216070 | TASK [validate-host : Collect information about zuul worker] 2025-07-06 00:23:37.800472 | debian-bookworm | ok 2025-07-06 00:23:37.816603 | 2025-07-06 00:23:37.817269 | TASK [validate-host : Write out all zuul information for each host] 2025-07-06 00:23:38.299074 | debian-bookworm -> localhost | changed 2025-07-06 00:23:38.308116 | 2025-07-06 00:23:38.308204 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-06 00:23:38.583058 | debian-bookworm | ok 2025-07-06 00:23:38.592355 | 2025-07-06 00:23:38.592456 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-06 00:23:39.709088 | debian-bookworm | changed: 2025-07-06 00:23:39.709959 | debian-bookworm | cd+++++++++ src/ 2025-07-06 00:23:39.710002 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-06 00:23:39.710027 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-06 00:23:39.710050 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-07-06 00:23:39.710071 | debian-bookworm | =5.5.1 2025-07-06 00:24:02.616009 | debian-bookworm | Downloading cachetools-6.1.0-py3-none-any.whl (11 kB) 2025-07-06 00:24:02.648089 | debian-bookworm | Collecting chardet>=5.2 2025-07-06 00:24:02.656171 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-07-06 00:24:02.672916 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 14.3 MB/s eta 0:00:00 2025-07-06 00:24:02.705471 | debian-bookworm | Collecting colorama>=0.4.6 2025-07-06 00:24:02.713382 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-07-06 00:24:02.778614 | debian-bookworm | Collecting filelock>=3.16.1 2025-07-06 00:24:02.787039 | debian-bookworm | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-07-06 00:24:02.847510 | debian-bookworm | Collecting packaging>=24.2 2025-07-06 00:24:02.855128 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-07-06 00:24:02.864301 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.0 MB/s eta 0:00:00 2025-07-06 00:24:02.904736 | debian-bookworm | Collecting platformdirs>=4.3.6 2025-07-06 00:24:02.912669 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-07-06 00:24:02.949730 | debian-bookworm | Collecting pluggy>=1.5 2025-07-06 00:24:02.957425 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-07-06 00:24:02.997310 | debian-bookworm | Collecting pyproject-api>=1.8 2025-07-06 00:24:03.005185 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-07-06 00:24:03.124811 | debian-bookworm | Collecting virtualenv>=20.31 2025-07-06 00:24:03.133609 | debian-bookworm | Downloading virtualenv-20.31.2-py3-none-any.whl (6.1 MB) 2025-07-06 00:24:03.379356 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.1/6.1 MB 25.3 MB/s eta 0:00:00 2025-07-06 00:24:03.507712 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-07-06 00:24:03.515494 | debian-bookworm | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-07-06 00:24:03.538729 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 23.3 MB/s eta 0:00:00 2025-07-06 00:24:03.695589 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-07-06 00:24:04.533909 | debian-bookworm | Successfully installed cachetools-6.1.0 chardet-5.2.0 colorama-0.4.6 distlib-0.3.9 filelock-3.18.0 packaging-25.0 platformdirs-4.3.8 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.27.0 virtualenv-20.31.2 2025-07-06 00:24:05.089766 | debian-bookworm | ok: Runtime: 0:00:02.793624 2025-07-06 00:24:05.102894 | 2025-07-06 00:24:05.103061 | TASK [ensure-tox : Export installed tox_executable path] 2025-07-06 00:24:05.151311 | debian-bookworm | ok 2025-07-06 00:24:05.159074 | 2025-07-06 00:24:05.159223 | TASK [ensure-tox : Output tox version] 2025-07-06 00:24:05.664751 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-07-06 00:24:05.682813 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-07-06 00:24:06.190265 | debian-bookworm | ok: Runtime: 0:00:00.289323 2025-07-06 00:24:06.196514 | 2025-07-06 00:24:06.196634 | TASK [ensure-tox : Make global symlink] 2025-07-06 00:24:06.220757 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:06.227694 | 2025-07-06 00:24:06.227781 | PLAY RECAP 2025-07-06 00:24:06.227833 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-07-06 00:24:06.227857 | 2025-07-06 00:24:06.368544 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-07-06 00:24:06.370367 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-07-06 00:24:07.143128 | 2025-07-06 00:24:07.143301 | PLAY [all] 2025-07-06 00:24:07.160104 | 2025-07-06 00:24:07.160266 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-07-06 00:24:07.614598 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-07-06 00:24:07.689986 | debian-bookworm | ok: Runtime: 0:00:00.026966 2025-07-06 00:24:07.697292 | 2025-07-06 00:24:07.697457 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-07-06 00:24:08.227492 | debian-bookworm | ok: Runtime: 0:00:00.007121 2025-07-06 00:24:08.241777 | 2025-07-06 00:24:08.241969 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-07-06 00:24:08.530904 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-07-06 00:24:08.532327 | debian-bookworm | sudo: a password is required 2025-07-06 00:24:08.775585 | debian-bookworm | ok: Runtime: 0:00:00.019467 2025-07-06 00:24:08.791550 | 2025-07-06 00:24:08.791683 | TASK [tox : Check to see if the constraints file exists] 2025-07-06 00:24:08.818556 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:08.832812 | 2025-07-06 00:24:08.832994 | TASK [tox : Fail if constraints file is missing] 2025-07-06 00:24:08.858424 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:08.887390 | 2025-07-06 00:24:08.887596 | TASK [tox : Record file location] 2025-07-06 00:24:08.939348 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:08.947643 | 2025-07-06 00:24:08.947781 | TASK [tox : Install tox siblings] 2025-07-06 00:24:08.979828 | debian-bookworm | ok 2025-07-06 00:24:08.988478 | debian-bookworm | included: /var/lib/zuul/builds/fb1505e96f6841c8842a63e477592e8d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-07-06 00:24:08.994584 | 2025-07-06 00:24:08.994692 | TASK [tox : Run tox without tests] 2025-07-06 00:24:10.170587 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-07-06 00:24:24.192316 | debian-bookworm | test: OK (14.64 seconds) 2025-07-06 00:24:24.192395 | debian-bookworm | congratulations :) (14.71 seconds) 2025-07-06 00:24:24.531970 | debian-bookworm | ok: Runtime: 0:00:14.958706 2025-07-06 00:24:24.547164 | 2025-07-06 00:24:24.547433 | TASK [tox : Create a tempfile to save tox showconfig] 2025-07-06 00:24:24.973433 | debian-bookworm | changed 2025-07-06 00:24:24.988549 | 2025-07-06 00:24:24.988812 | TASK [tox : Get tox envlist config] 2025-07-06 00:24:26.036476 | debian-bookworm | ok: Runtime: 0:00:00.342580 2025-07-06 00:24:26.052593 | 2025-07-06 00:24:26.052812 | TASK [tox : Install any sibling python packages] 2025-07-06 00:24:26.551554 | debian-bookworm | ok: No setup.cfg, no action needed 2025-07-06 00:24:26.557424 | 2025-07-06 00:24:26.557552 | TASK [tox : Remove tempfile] 2025-07-06 00:24:27.007560 | debian-bookworm | changed 2025-07-06 00:24:27.015741 | 2025-07-06 00:24:27.015883 | TASK [tox : Emit tox command] 2025-07-06 00:24:27.062408 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-07-06 00:24:27.070173 | 2025-07-06 00:24:27.070358 | TASK [tox : Run tox] 2025-07-06 00:24:27.732432 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-07-06 00:24:28.201792 | 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-07-06 00:24:28.201848 | debian-bookworm | from pkg_resources import get_distribution, DistributionNotFound 2025-07-06 00:24:28.520260 | debian-bookworm | ............... 2025-07-06 00:24:28.520315 | debian-bookworm | ---------------------------------------------------------------------- 2025-07-06 00:24:28.520323 | debian-bookworm | Ran 15 tests in 0.174s 2025-07-06 00:24:28.520329 | debian-bookworm | 2025-07-06 00:24:28.520347 | debian-bookworm | OK 2025-07-06 00:24:28.634561 | debian-bookworm | test: OK (0.94=setup[0.04]+cmd[0.90] seconds) 2025-07-06 00:24:28.634609 | debian-bookworm | congratulations :) (1.01 seconds) 2025-07-06 00:24:29.140607 | debian-bookworm | ok: Runtime: 0:00:01.258407 2025-07-06 00:24:29.152984 | 2025-07-06 00:24:29.153144 | TASK [tox : Look for output] 2025-07-06 00:24:29.587539 | debian-bookworm | ok 2025-07-06 00:24:29.606404 | 2025-07-06 00:24:29.606533 | TASK [tox : Return file comments to Zuul] 2025-07-06 00:24:29.642648 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:29.657730 | 2025-07-06 00:24:29.657864 | PLAY RECAP 2025-07-06 00:24:29.657945 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-07-06 00:24:29.657987 | 2025-07-06 00:24:29.793462 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-07-06 00:24:29.794856 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-07-06 00:24:30.577778 | 2025-07-06 00:24:30.577954 | PLAY [all] 2025-07-06 00:24:30.594573 | 2025-07-06 00:24:30.594746 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-07-06 00:24:30.650861 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:30.664717 | 2025-07-06 00:24:30.664967 | TASK [fetch-tox-output : Set tox log path for single node] 2025-07-06 00:24:30.713148 | debian-bookworm | ok 2025-07-06 00:24:30.722286 | 2025-07-06 00:24:30.722513 | TASK [fetch-tox-output : Ensure local tox dir] 2025-07-06 00:24:31.235792 | debian-bookworm -> localhost | changed 2025-07-06 00:24:31.251640 | 2025-07-06 00:24:31.251795 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-07-06 00:24:31.307292 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:31.320965 | 2025-07-06 00:24:31.321144 | TASK [fetch-tox-output : Set envlist fact] 2025-07-06 00:24:31.367845 | debian-bookworm | ok 2025-07-06 00:24:31.378002 | 2025-07-06 00:24:31.378137 | TASK [fetch-tox-output : Get tox version] 2025-07-06 00:24:32.076306 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-07-06 00:24:32.094797 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-07-06 00:24:32.415292 | debian-bookworm | ok: Runtime: 0:00:00.298229 2025-07-06 00:24:32.429995 | 2025-07-06 00:24:32.430186 | TASK [fetch-tox-output : Find all default environments] 2025-07-06 00:24:32.969227 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:32.975423 | 2025-07-06 00:24:32.975557 | TASK [fetch-tox-output : Set envlist fact] 2025-07-06 00:24:33.009890 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:33.017310 | 2025-07-06 00:24:33.017475 | TASK [fetch-tox-output : Find all default environments] 2025-07-06 00:24:33.554645 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:33.568221 | 2025-07-06 00:24:33.568413 | TASK [fetch-tox-output : Set envlist fact] 2025-07-06 00:24:33.603509 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:33.610160 | 2025-07-06 00:24:33.610385 | LOOP [fetch-tox-output : Copy tox logs] 2025-07-06 00:24:33.655021 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:33.671868 | 2025-07-06 00:24:33.672042 | LOOP [fetch-tox-output : Collect tox logs] 2025-07-06 00:24:34.503333 | debian-bookworm | changed: 2025-07-06 00:24:34.503577 | debian-bookworm | created directory /var/lib/zuul/builds/fb1505e96f6841c8842a63e477592e8d/work/logs/tox/test 2025-07-06 00:24:34.503618 | debian-bookworm | cd+++++++++ ./ 2025-07-06 00:24:34.503646 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-07-06 00:24:34.503677 | 2025-07-06 00:24:34.525921 | 2025-07-06 00:24:34.526050 | PLAY RECAP 2025-07-06 00:24:34.526128 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-07-06 00:24:34.526167 | 2025-07-06 00:24:34.646925 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-07-06 00:24:34.649566 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-07-06 00:24:35.427818 | 2025-07-06 00:24:35.427978 | PLAY [all] 2025-07-06 00:24:35.443501 | 2025-07-06 00:24:35.443643 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-07-06 00:24:35.686995 | debian-bookworm | changed: non-zero return code 2025-07-06 00:24:35.697060 | 2025-07-06 00:24:35.697244 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-07-06 00:24:35.733208 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:35.746456 | 2025-07-06 00:24:35.746635 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-07-06 00:24:35.784560 | 2025-07-06 00:24:35.784818 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-07-06 00:24:35.816835 | 2025-07-06 00:24:35.817024 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-07-06 00:24:35.841033 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:35.850795 | 2025-07-06 00:24:35.851012 | LOOP [fetch-subunit-output : Generate subunit file] 2025-07-06 00:24:35.886284 | 2025-07-06 00:24:35.886583 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-07-06 00:24:35.911402 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:35.923252 | 2025-07-06 00:24:35.923495 | TASK [fetch-subunit-output : Remove the temporary file] 2025-07-06 00:24:35.948396 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:35.960390 | 2025-07-06 00:24:35.960542 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-07-06 00:24:35.985761 | debian-bookworm | skipping: Conditional result was False 2025-07-06 00:24:35.997480 | 2025-07-06 00:24:35.997582 | PLAY RECAP 2025-07-06 00:24:35.997649 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-07-06 00:24:35.997685 | 2025-07-06 00:24:36.127098 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-07-06 00:24:36.128200 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-07-06 00:24:36.893507 | 2025-07-06 00:24:36.893673 | PLAY [Base post] 2025-07-06 00:24:36.907530 | 2025-07-06 00:24:36.907673 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-07-06 00:24:37.523917 | debian-bookworm | changed 2025-07-06 00:24:37.533604 | 2025-07-06 00:24:37.533739 | PLAY RECAP 2025-07-06 00:24:37.533817 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-07-06 00:24:37.533897 | 2025-07-06 00:24:37.654010 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-07-06 00:24:37.655505 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-07-06 00:24:38.455140 | 2025-07-06 00:24:38.455307 | PLAY [Base post-logs] 2025-07-06 00:24:38.469352 | 2025-07-06 00:24:38.469617 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-07-06 00:24:38.960000 | localhost | changed 2025-07-06 00:24:38.980654 | 2025-07-06 00:24:38.980872 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-07-06 00:24:39.019955 | localhost | ok 2025-07-06 00:24:39.026280 | 2025-07-06 00:24:39.026452 | TASK [Set zuul-log-path fact] 2025-07-06 00:24:39.054950 | localhost | ok 2025-07-06 00:24:39.069636 | 2025-07-06 00:24:39.069791 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-06 00:24:39.107954 | localhost | ok 2025-07-06 00:24:39.114920 | 2025-07-06 00:24:39.115095 | TASK [upload-logs : Create log directories] 2025-07-06 00:24:39.669243 | localhost | changed 2025-07-06 00:24:39.674102 | 2025-07-06 00:24:39.674356 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-07-06 00:24:40.210633 | localhost -> localhost | ok: Runtime: 0:00:00.008251 2025-07-06 00:24:40.220026 | 2025-07-06 00:24:40.220214 | TASK [upload-logs : Upload logs to log server] 2025-07-06 00:24:40.806478 | localhost | Output suppressed because no_log was given 2025-07-06 00:24:40.808491 | 2025-07-06 00:24:40.808604 | LOOP [upload-logs : Compress console log and json output] 2025-07-06 00:24:40.854986 | localhost | skipping: Conditional result was False 2025-07-06 00:24:40.862927 | localhost | skipping: Conditional result was False 2025-07-06 00:24:40.879470 | 2025-07-06 00:24:40.879739 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-06 00:24:40.926100 | localhost | skipping: Conditional result was False 2025-07-06 00:24:40.926454 | 2025-07-06 00:24:40.933673 | localhost | skipping: Conditional result was False 2025-07-06 00:24:40.949535 | 2025-07-06 00:24:40.949755 | LOOP [upload-logs : Upload console log and json output]