2025-06-19 03:25:40.277373 | Job console starting 2025-06-19 03:25:40.299039 | Updating git repos 2025-06-19 03:25:40.324964 | Cloning repos into workspace 2025-06-19 03:25:40.379885 | Restoring repo states 2025-06-19 03:25:40.386769 | Merging changes 2025-06-19 03:25:40.386787 | Checking out repos 2025-06-19 03:25:40.414694 | Preparing playbooks 2025-06-19 03:25:41.022179 | Running Ansible setup 2025-06-19 03:25:45.439465 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-19 03:25:46.479365 | 2025-06-19 03:25:46.479542 | PLAY [Base pre] 2025-06-19 03:25:46.503136 | 2025-06-19 03:25:46.503301 | TASK [Setup log path fact] 2025-06-19 03:25:46.534506 | debian-bookworm | ok 2025-06-19 03:25:46.554097 | 2025-06-19 03:25:46.554271 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-19 03:25:46.596743 | debian-bookworm | ok 2025-06-19 03:25:46.610439 | 2025-06-19 03:25:46.610599 | TASK [emit-job-header : Print job information] 2025-06-19 03:25:46.676319 | # Job Information 2025-06-19 03:25:46.676522 | Ansible Version: 2.16.14 2025-06-19 03:25:46.676558 | Job: tox 2025-06-19 03:25:46.676641 | Pipeline: periodic-daily 2025-06-19 03:25:46.676666 | Executor: 521e9411259a 2025-06-19 03:25:46.676687 | Triggered by: https://github.com/osism/openstack-image-manager 2025-06-19 03:25:46.676710 | Event ID: 4781e8eb0e4d47a798c19de572d2780d 2025-06-19 03:25:46.687613 | 2025-06-19 03:25:46.687802 | LOOP [emit-job-header : Print node information] 2025-06-19 03:25:46.822440 | debian-bookworm | ok: 2025-06-19 03:25:46.822736 | debian-bookworm | # Node Information 2025-06-19 03:25:46.822781 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-19 03:25:46.822814 | debian-bookworm | Hostname: debian 2025-06-19 03:25:46.822957 | debian-bookworm | Username: zuul 2025-06-19 03:25:46.823114 | debian-bookworm | Distro: Debian 12.11 2025-06-19 03:25:46.823157 | debian-bookworm | Provider: regiocloud-a 2025-06-19 03:25:46.823262 | debian-bookworm | Region: 2025-06-19 03:25:46.823293 | debian-bookworm | Label: debian-bookworm 2025-06-19 03:25:46.823320 | debian-bookworm | Product Name: OpenStack Nova 2025-06-19 03:25:46.823345 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe75:4bff 2025-06-19 03:25:46.859358 | 2025-06-19 03:25:46.859516 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-19 03:25:47.403779 | debian-bookworm -> localhost | changed 2025-06-19 03:25:47.435551 | 2025-06-19 03:25:47.435761 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-19 03:25:48.646073 | debian-bookworm -> localhost | changed 2025-06-19 03:25:48.659304 | 2025-06-19 03:25:48.659719 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-19 03:25:48.930531 | debian-bookworm -> localhost | ok 2025-06-19 03:25:48.938065 | 2025-06-19 03:25:48.938213 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-19 03:25:48.976395 | debian-bookworm | ok 2025-06-19 03:25:49.001899 | debian-bookworm | included: /var/lib/zuul/builds/38d1ee214f9d44a39cc2837fe2be759d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-19 03:25:49.010671 | 2025-06-19 03:25:49.010814 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-19 03:25:51.808662 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-19 03:25:51.808945 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/38d1ee214f9d44a39cc2837fe2be759d/work/38d1ee214f9d44a39cc2837fe2be759d_id_rsa 2025-06-19 03:25:51.808991 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/38d1ee214f9d44a39cc2837fe2be759d/work/38d1ee214f9d44a39cc2837fe2be759d_id_rsa.pub 2025-06-19 03:25:51.809416 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-19 03:25:51.809551 | debian-bookworm -> localhost | SHA256:pkZftHvOqXrOVlBLjLMQRuF2WedPbUJ3331Riq++VuQ zuul-build-sshkey 2025-06-19 03:25:51.809698 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-19 03:25:51.809745 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-19 03:25:51.809958 | debian-bookworm -> localhost | | .=o o. o.=| 2025-06-19 03:25:51.811046 | debian-bookworm -> localhost | | o. oo+= oB| 2025-06-19 03:25:51.811161 | debian-bookworm -> localhost | | o.+=..+ O| 2025-06-19 03:25:51.811190 | debian-bookworm -> localhost | | . oo....=.| 2025-06-19 03:25:51.811214 | debian-bookworm -> localhost | | . S o. o. .| 2025-06-19 03:25:51.811248 | debian-bookworm -> localhost | | . + . ...E | 2025-06-19 03:25:51.811270 | debian-bookworm -> localhost | | o . ..o. | 2025-06-19 03:25:51.811291 | debian-bookworm -> localhost | | . .o=.. | 2025-06-19 03:25:51.811313 | debian-bookworm -> localhost | | .=+o*. | 2025-06-19 03:25:51.811335 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-19 03:25:51.811408 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.076524 2025-06-19 03:25:51.833699 | 2025-06-19 03:25:51.834521 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-19 03:25:51.907184 | debian-bookworm | ok 2025-06-19 03:25:51.938493 | debian-bookworm | included: /var/lib/zuul/builds/38d1ee214f9d44a39cc2837fe2be759d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-19 03:25:51.949087 | 2025-06-19 03:25:51.950173 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-19 03:25:51.993067 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:25:52.005414 | 2025-06-19 03:25:52.005663 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-19 03:25:53.159760 | debian-bookworm | changed 2025-06-19 03:25:53.165891 | 2025-06-19 03:25:53.166016 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-19 03:25:53.454630 | debian-bookworm | ok 2025-06-19 03:25:53.467989 | 2025-06-19 03:25:53.468113 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-19 03:25:54.259751 | debian-bookworm | changed 2025-06-19 03:25:54.286274 | 2025-06-19 03:25:54.286385 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-19 03:25:54.960629 | debian-bookworm | changed 2025-06-19 03:25:54.970077 | 2025-06-19 03:25:54.970212 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-19 03:25:54.984388 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:25:54.993616 | 2025-06-19 03:25:54.993776 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-19 03:25:55.435559 | debian-bookworm -> localhost | changed 2025-06-19 03:25:55.450561 | 2025-06-19 03:25:55.450699 | TASK [add-build-sshkey : Add back temp key] 2025-06-19 03:25:56.254932 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/38d1ee214f9d44a39cc2837fe2be759d/work/38d1ee214f9d44a39cc2837fe2be759d_id_rsa (zuul-build-sshkey) 2025-06-19 03:25:56.255165 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024444 2025-06-19 03:25:56.268852 | 2025-06-19 03:25:56.268955 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-19 03:25:56.828871 | debian-bookworm | ok 2025-06-19 03:25:56.837513 | 2025-06-19 03:25:56.837628 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-19 03:25:56.880774 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:25:56.891030 | 2025-06-19 03:25:56.891140 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-19 03:25:57.374249 | debian-bookworm | ok 2025-06-19 03:25:57.385096 | 2025-06-19 03:25:57.385198 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-19 03:25:57.413131 | debian-bookworm | ok 2025-06-19 03:25:57.418704 | 2025-06-19 03:25:57.418804 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-19 03:25:57.694236 | debian-bookworm -> localhost | ok 2025-06-19 03:25:57.700295 | 2025-06-19 03:25:57.700385 | TASK [validate-host : Collect information about the host] 2025-06-19 03:25:58.783711 | debian-bookworm | ok 2025-06-19 03:25:58.803194 | 2025-06-19 03:25:58.803305 | TASK [validate-host : Sanitize hostname] 2025-06-19 03:25:59.036963 | debian-bookworm | ok 2025-06-19 03:25:59.107216 | 2025-06-19 03:25:59.107324 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-19 03:25:59.883236 | debian-bookworm -> localhost | changed 2025-06-19 03:25:59.888867 | 2025-06-19 03:25:59.888967 | TASK [validate-host : Collect information about zuul worker] 2025-06-19 03:26:00.280251 | debian-bookworm | ok 2025-06-19 03:26:00.295922 | 2025-06-19 03:26:00.296041 | TASK [validate-host : Write out all zuul information for each host] 2025-06-19 03:26:01.546717 | debian-bookworm -> localhost | changed 2025-06-19 03:26:01.559614 | 2025-06-19 03:26:01.559816 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-19 03:26:01.842617 | debian-bookworm | ok 2025-06-19 03:26:01.848319 | 2025-06-19 03:26:01.848413 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-19 03:26:02.824375 | debian-bookworm | changed: 2025-06-19 03:26:02.824715 | debian-bookworm | cd+++++++++ src/ 2025-06-19 03:26:02.824773 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-19 03:26:02.824812 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-19 03:26:02.824836 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-06-19 03:26:02.824857 | debian-bookworm | =5.5.1 2025-06-19 03:26:25.157154 | debian-bookworm | Downloading cachetools-6.1.0-py3-none-any.whl (11 kB) 2025-06-19 03:26:25.186327 | debian-bookworm | Collecting chardet>=5.2 2025-06-19 03:26:25.193757 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-06-19 03:26:25.210559 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 13.8 MB/s eta 0:00:00 2025-06-19 03:26:25.248165 | debian-bookworm | Collecting colorama>=0.4.6 2025-06-19 03:26:25.256261 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-06-19 03:26:25.323015 | debian-bookworm | Collecting filelock>=3.16.1 2025-06-19 03:26:25.330647 | debian-bookworm | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-06-19 03:26:25.390484 | debian-bookworm | Collecting packaging>=24.2 2025-06-19 03:26:25.397948 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-06-19 03:26:25.406005 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.6 MB/s eta 0:00:00 2025-06-19 03:26:25.447167 | debian-bookworm | Collecting platformdirs>=4.3.6 2025-06-19 03:26:25.454620 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-06-19 03:26:25.492079 | debian-bookworm | Collecting pluggy>=1.5 2025-06-19 03:26:25.499676 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-06-19 03:26:25.535301 | debian-bookworm | Collecting pyproject-api>=1.8 2025-06-19 03:26:25.542806 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-06-19 03:26:25.665677 | debian-bookworm | Collecting virtualenv>=20.31 2025-06-19 03:26:25.674048 | debian-bookworm | Downloading virtualenv-20.31.2-py3-none-any.whl (6.1 MB) 2025-06-19 03:26:25.966200 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.1/6.1 MB 21.2 MB/s eta 0:00:00 2025-06-19 03:26:26.082423 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-06-19 03:26:26.089540 | debian-bookworm | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-06-19 03:26:26.116891 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.8 MB/s eta 0:00:00 2025-06-19 03:26:26.273517 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-06-19 03:26:27.122181 | 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-06-19 03:26:27.646130 | debian-bookworm | ok: Runtime: 0:00:02.838321 2025-06-19 03:26:27.653696 | 2025-06-19 03:26:27.653832 | TASK [ensure-tox : Export installed tox_executable path] 2025-06-19 03:26:27.684193 | debian-bookworm | ok 2025-06-19 03:26:27.689146 | 2025-06-19 03:26:27.689257 | TASK [ensure-tox : Output tox version] 2025-06-19 03:26:28.217159 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-06-19 03:26:28.235051 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-06-19 03:26:28.718799 | debian-bookworm | ok: Runtime: 0:00:00.299446 2025-06-19 03:26:28.730953 | 2025-06-19 03:26:28.731126 | TASK [ensure-tox : Make global symlink] 2025-06-19 03:26:28.757480 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:28.772503 | 2025-06-19 03:26:28.772649 | PLAY RECAP 2025-06-19 03:26:28.772725 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-06-19 03:26:28.772761 | 2025-06-19 03:26:28.954171 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-06-19 03:26:28.955429 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-06-19 03:26:29.792053 | 2025-06-19 03:26:29.792233 | PLAY [all] 2025-06-19 03:26:29.809508 | 2025-06-19 03:26:29.809704 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-06-19 03:26:30.324154 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-06-19 03:26:30.383228 | debian-bookworm | ok: Runtime: 0:00:00.023222 2025-06-19 03:26:30.389136 | 2025-06-19 03:26:30.389291 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-06-19 03:26:30.918777 | debian-bookworm | ok: Runtime: 0:00:00.006912 2025-06-19 03:26:30.946886 | 2025-06-19 03:26:30.947100 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-06-19 03:26:31.274092 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-06-19 03:26:31.277080 | debian-bookworm | sudo: a password is required 2025-06-19 03:26:31.511926 | debian-bookworm | ok: Runtime: 0:00:00.022999 2025-06-19 03:26:31.522740 | 2025-06-19 03:26:31.522892 | TASK [tox : Check to see if the constraints file exists] 2025-06-19 03:26:31.547644 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:31.554418 | 2025-06-19 03:26:31.554591 | TASK [tox : Fail if constraints file is missing] 2025-06-19 03:26:31.590431 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:31.597503 | 2025-06-19 03:26:31.597689 | TASK [tox : Record file location] 2025-06-19 03:26:31.622285 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:31.628658 | 2025-06-19 03:26:31.628800 | TASK [tox : Install tox siblings] 2025-06-19 03:26:31.660480 | debian-bookworm | ok 2025-06-19 03:26:31.670359 | debian-bookworm | included: /var/lib/zuul/builds/38d1ee214f9d44a39cc2837fe2be759d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-06-19 03:26:31.676253 | 2025-06-19 03:26:31.676376 | TASK [tox : Run tox without tests] 2025-06-19 03:26:32.763009 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-06-19 03:26:46.220930 | debian-bookworm | test: OK (14.01 seconds) 2025-06-19 03:26:46.220966 | debian-bookworm | congratulations :) (14.08 seconds) 2025-06-19 03:26:46.718692 | debian-bookworm | ok: Runtime: 0:00:14.303640 2025-06-19 03:26:46.734364 | 2025-06-19 03:26:46.734531 | TASK [tox : Create a tempfile to save tox showconfig] 2025-06-19 03:26:47.126181 | debian-bookworm | changed 2025-06-19 03:26:47.137981 | 2025-06-19 03:26:47.138425 | TASK [tox : Get tox envlist config] 2025-06-19 03:26:48.170640 | debian-bookworm | ok: Runtime: 0:00:00.299825 2025-06-19 03:26:48.178080 | 2025-06-19 03:26:48.178218 | TASK [tox : Install any sibling python packages] 2025-06-19 03:26:48.626242 | debian-bookworm | ok: No setup.cfg, no action needed 2025-06-19 03:26:48.639367 | 2025-06-19 03:26:48.639848 | TASK [tox : Remove tempfile] 2025-06-19 03:26:49.110815 | debian-bookworm | changed 2025-06-19 03:26:49.120979 | 2025-06-19 03:26:49.121122 | TASK [tox : Emit tox command] 2025-06-19 03:26:49.177645 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-06-19 03:26:49.186256 | 2025-06-19 03:26:49.186421 | TASK [tox : Run tox] 2025-06-19 03:26:49.868636 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-06-19 03:26:50.347343 | 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-06-19 03:26:50.347400 | debian-bookworm | from pkg_resources import get_distribution, DistributionNotFound 2025-06-19 03:26:50.664911 | debian-bookworm | ............... 2025-06-19 03:26:50.664959 | debian-bookworm | ---------------------------------------------------------------------- 2025-06-19 03:26:50.664966 | debian-bookworm | Ran 15 tests in 0.175s 2025-06-19 03:26:50.664973 | debian-bookworm | 2025-06-19 03:26:50.664992 | debian-bookworm | OK 2025-06-19 03:26:50.776593 | debian-bookworm | test: OK (0.95=setup[0.04]+cmd[0.91] seconds) 2025-06-19 03:26:50.776636 | debian-bookworm | congratulations :) (1.02 seconds) 2025-06-19 03:26:51.271133 | debian-bookworm | ok: Runtime: 0:00:01.247613 2025-06-19 03:26:51.277159 | 2025-06-19 03:26:51.277264 | TASK [tox : Look for output] 2025-06-19 03:26:51.684847 | debian-bookworm | ok 2025-06-19 03:26:51.699167 | 2025-06-19 03:26:51.699312 | TASK [tox : Return file comments to Zuul] 2025-06-19 03:26:51.747390 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:51.765242 | 2025-06-19 03:26:51.765408 | PLAY RECAP 2025-06-19 03:26:51.765520 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-06-19 03:26:51.765640 | 2025-06-19 03:26:51.932875 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-06-19 03:26:51.933995 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-06-19 03:26:52.713342 | 2025-06-19 03:26:52.713511 | PLAY [all] 2025-06-19 03:26:52.730525 | 2025-06-19 03:26:52.730723 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-06-19 03:26:52.776032 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:52.785437 | 2025-06-19 03:26:52.785660 | TASK [fetch-tox-output : Set tox log path for single node] 2025-06-19 03:26:52.836172 | debian-bookworm | ok 2025-06-19 03:26:52.845392 | 2025-06-19 03:26:52.845614 | TASK [fetch-tox-output : Ensure local tox dir] 2025-06-19 03:26:53.379477 | debian-bookworm -> localhost | changed 2025-06-19 03:26:53.396731 | 2025-06-19 03:26:53.397073 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-06-19 03:26:53.453331 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:53.471516 | 2025-06-19 03:26:53.471709 | TASK [fetch-tox-output : Set envlist fact] 2025-06-19 03:26:53.527175 | debian-bookworm | ok 2025-06-19 03:26:53.535945 | 2025-06-19 03:26:53.536064 | TASK [fetch-tox-output : Get tox version] 2025-06-19 03:26:54.205071 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-06-19 03:26:54.222933 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-06-19 03:26:54.568106 | debian-bookworm | ok: Runtime: 0:00:00.286815 2025-06-19 03:26:54.581475 | 2025-06-19 03:26:54.581658 | TASK [fetch-tox-output : Find all default environments] 2025-06-19 03:26:55.114688 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:55.128870 | 2025-06-19 03:26:55.129059 | TASK [fetch-tox-output : Set envlist fact] 2025-06-19 03:26:55.164437 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:55.178538 | 2025-06-19 03:26:55.179302 | TASK [fetch-tox-output : Find all default environments] 2025-06-19 03:26:55.712102 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:55.726190 | 2025-06-19 03:26:55.726372 | TASK [fetch-tox-output : Set envlist fact] 2025-06-19 03:26:55.761899 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:55.778088 | 2025-06-19 03:26:55.778302 | LOOP [fetch-tox-output : Copy tox logs] 2025-06-19 03:26:55.835420 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:55.855214 | 2025-06-19 03:26:55.855418 | LOOP [fetch-tox-output : Collect tox logs] 2025-06-19 03:26:56.729084 | debian-bookworm | changed: 2025-06-19 03:26:56.729271 | debian-bookworm | created directory /var/lib/zuul/builds/38d1ee214f9d44a39cc2837fe2be759d/work/logs/tox/test 2025-06-19 03:26:56.729338 | debian-bookworm | cd+++++++++ ./ 2025-06-19 03:26:56.729373 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-06-19 03:26:56.729407 | 2025-06-19 03:26:56.739866 | 2025-06-19 03:26:56.739944 | PLAY RECAP 2025-06-19 03:26:56.739993 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-06-19 03:26:56.740017 | 2025-06-19 03:26:56.835833 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-06-19 03:26:56.836773 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-06-19 03:26:57.498243 | 2025-06-19 03:26:57.498376 | PLAY [all] 2025-06-19 03:26:57.513138 | 2025-06-19 03:26:57.513261 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-06-19 03:26:57.703529 | debian-bookworm | changed: non-zero return code 2025-06-19 03:26:57.709090 | 2025-06-19 03:26:57.709217 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-06-19 03:26:57.732877 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:57.738793 | 2025-06-19 03:26:57.738919 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-06-19 03:26:57.769863 | 2025-06-19 03:26:57.770049 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-06-19 03:26:57.804364 | 2025-06-19 03:26:57.804630 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-06-19 03:26:57.828741 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:57.841920 | 2025-06-19 03:26:57.842070 | LOOP [fetch-subunit-output : Generate subunit file] 2025-06-19 03:26:57.878778 | 2025-06-19 03:26:57.879066 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-06-19 03:26:57.903419 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:57.917061 | 2025-06-19 03:26:57.917236 | TASK [fetch-subunit-output : Remove the temporary file] 2025-06-19 03:26:57.942254 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:57.955137 | 2025-06-19 03:26:57.955296 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-06-19 03:26:57.979959 | debian-bookworm | skipping: Conditional result was False 2025-06-19 03:26:57.994395 | 2025-06-19 03:26:57.994506 | PLAY RECAP 2025-06-19 03:26:57.994604 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-06-19 03:26:57.994662 | 2025-06-19 03:26:58.088621 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-06-19 03:26:58.089608 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-19 03:26:58.762808 | 2025-06-19 03:26:58.762971 | PLAY [Base post] 2025-06-19 03:26:58.775655 | 2025-06-19 03:26:58.775771 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-06-19 03:26:59.305201 | debian-bookworm | changed 2025-06-19 03:26:59.314816 | 2025-06-19 03:26:59.314952 | PLAY RECAP 2025-06-19 03:26:59.315025 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-06-19 03:26:59.315100 | 2025-06-19 03:26:59.396162 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-19 03:26:59.397133 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-06-19 03:27:00.132250 | 2025-06-19 03:27:00.132375 | PLAY [Base post-logs] 2025-06-19 03:27:00.141615 | 2025-06-19 03:27:00.141727 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-06-19 03:27:00.576930 | localhost | changed 2025-06-19 03:27:00.593901 | 2025-06-19 03:27:00.594079 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-06-19 03:27:00.632710 | localhost | ok 2025-06-19 03:27:00.640130 | 2025-06-19 03:27:00.640302 | TASK [Set zuul-log-path fact] 2025-06-19 03:27:00.659460 | localhost | ok 2025-06-19 03:27:00.671475 | 2025-06-19 03:27:00.671614 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-19 03:27:00.707884 | localhost | ok 2025-06-19 03:27:00.711995 | 2025-06-19 03:27:00.712114 | TASK [upload-logs : Create log directories] 2025-06-19 03:27:01.175932 | localhost | changed 2025-06-19 03:27:01.178470 | 2025-06-19 03:27:01.178582 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-06-19 03:27:01.628573 | localhost -> localhost | ok: Runtime: 0:00:00.006807 2025-06-19 03:27:01.637795 | 2025-06-19 03:27:01.638001 | TASK [upload-logs : Upload logs to log server] 2025-06-19 03:27:02.176857 | localhost | Output suppressed because no_log was given 2025-06-19 03:27:02.179538 | 2025-06-19 03:27:02.179661 | LOOP [upload-logs : Compress console log and json output] 2025-06-19 03:27:02.219918 | localhost | skipping: Conditional result was False 2025-06-19 03:27:02.224989 | localhost | skipping: Conditional result was False 2025-06-19 03:27:02.227878 | 2025-06-19 03:27:02.227966 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-19 03:27:02.270381 | localhost | skipping: Conditional result was False 2025-06-19 03:27:02.271770 | 2025-06-19 03:27:02.273800 | localhost | skipping: Conditional result was False 2025-06-19 03:27:02.279830 | 2025-06-19 03:27:02.279990 | LOOP [upload-logs : Upload console log and json output]