2025-12-11 03:19:28.501951 | Job console starting 2025-12-11 03:19:28.530230 | Updating git repos 2025-12-11 03:19:28.582549 | Cloning repos into workspace 2025-12-11 03:19:28.662425 | Restoring repo states 2025-12-11 03:19:28.718189 | Merging changes 2025-12-11 03:19:28.718215 | Checking out repos 2025-12-11 03:19:28.792637 | Preparing playbooks 2025-12-11 03:19:30.140087 | Running Ansible setup 2025-12-11 03:19:36.170760 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-11 03:19:39.002033 | 2025-12-11 03:19:39.002227 | PLAY [Base pre] 2025-12-11 03:19:39.165363 | 2025-12-11 03:19:39.166540 | TASK [Setup log path fact] 2025-12-11 03:19:39.306260 | debian-bookworm | ok 2025-12-11 03:19:39.453910 | 2025-12-11 03:19:39.454091 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-11 03:19:39.624023 | debian-bookworm | ok 2025-12-11 03:19:39.697399 | 2025-12-11 03:19:39.697587 | TASK [emit-job-header : Print job information] 2025-12-11 03:19:39.803113 | # Job Information 2025-12-11 03:19:39.803332 | Ansible Version: 2.16.14 2025-12-11 03:19:39.803369 | Job: tox 2025-12-11 03:19:39.803402 | Pipeline: periodic-daily 2025-12-11 03:19:39.803425 | Executor: 521e9411259a 2025-12-11 03:19:39.803445 | Triggered by: https://github.com/osism/openstack-image-manager 2025-12-11 03:19:39.803467 | Event ID: 5f651ba2a42a48d59364d31796ba080f 2025-12-11 03:19:39.826139 | 2025-12-11 03:19:39.826298 | LOOP [emit-job-header : Print node information] 2025-12-11 03:19:40.195385 | debian-bookworm | ok: 2025-12-11 03:19:40.197161 | debian-bookworm | # Node Information 2025-12-11 03:19:40.198751 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-11 03:19:40.198798 | debian-bookworm | Hostname: debian 2025-12-11 03:19:40.198823 | debian-bookworm | Username: zuul 2025-12-11 03:19:40.199341 | debian-bookworm | Distro: Debian 12.12 2025-12-11 03:19:40.199380 | debian-bookworm | Provider: regiocloud-a 2025-12-11 03:19:40.199405 | debian-bookworm | Region: 2025-12-11 03:19:40.199427 | debian-bookworm | Label: debian-bookworm 2025-12-11 03:19:40.199447 | debian-bookworm | Product Name: OpenStack Nova 2025-12-11 03:19:40.199468 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe91:d199 2025-12-11 03:19:40.243053 | 2025-12-11 03:19:40.252333 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-11 03:19:42.861583 | debian-bookworm -> localhost | changed 2025-12-11 03:19:42.875417 | 2025-12-11 03:19:42.875588 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-11 03:19:47.348253 | debian-bookworm -> localhost | changed 2025-12-11 03:19:47.360187 | 2025-12-11 03:19:47.360329 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-11 03:19:48.101253 | debian-bookworm -> localhost | ok 2025-12-11 03:19:48.108466 | 2025-12-11 03:19:48.108640 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-11 03:19:48.181933 | debian-bookworm | ok 2025-12-11 03:19:48.272890 | debian-bookworm | included: /var/lib/zuul/builds/d1973395c91b42d7b9939ccb0e2d60a1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-11 03:19:48.303126 | 2025-12-11 03:19:48.303272 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-11 03:19:54.769422 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-11 03:19:54.769729 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d1973395c91b42d7b9939ccb0e2d60a1/work/d1973395c91b42d7b9939ccb0e2d60a1_id_rsa 2025-12-11 03:19:54.769773 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d1973395c91b42d7b9939ccb0e2d60a1/work/d1973395c91b42d7b9939ccb0e2d60a1_id_rsa.pub 2025-12-11 03:19:54.769800 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-11 03:19:54.769825 | debian-bookworm -> localhost | SHA256:FO+BfQdMwQhqAkbxrRNJbSuFGcN6zAZQtNbjbOutQ+I zuul-build-sshkey 2025-12-11 03:19:54.769847 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-11 03:19:54.769882 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-11 03:19:54.769904 | debian-bookworm -> localhost | |.=Bo+= o. =+. | 2025-12-11 03:19:54.769925 | debian-bookworm -> localhost | | ..*+++. =. o. | 2025-12-11 03:19:54.769945 | debian-bookworm -> localhost | | o=Bo+.o + . . | 2025-12-11 03:19:54.769963 | debian-bookworm -> localhost | | ..o**.. . o . | 2025-12-11 03:19:54.769983 | debian-bookworm -> localhost | | o*. S . | 2025-12-11 03:19:54.770006 | debian-bookworm -> localhost | | ...o | 2025-12-11 03:19:54.770027 | debian-bookworm -> localhost | | . o. | 2025-12-11 03:19:54.770046 | debian-bookworm -> localhost | | E... | 2025-12-11 03:19:54.770067 | debian-bookworm -> localhost | | oo. | 2025-12-11 03:19:54.770088 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-11 03:19:54.770149 | debian-bookworm -> localhost | ok: Runtime: 0:00:04.651756 2025-12-11 03:19:54.780497 | 2025-12-11 03:19:54.780642 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-11 03:19:54.875363 | debian-bookworm | ok 2025-12-11 03:19:54.898303 | debian-bookworm | included: /var/lib/zuul/builds/d1973395c91b42d7b9939ccb0e2d60a1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-11 03:19:54.957132 | 2025-12-11 03:19:54.957290 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-11 03:19:55.031156 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:19:55.038580 | 2025-12-11 03:19:55.038724 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-11 03:19:57.156248 | debian-bookworm | changed 2025-12-11 03:19:57.225950 | 2025-12-11 03:19:57.226093 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-11 03:19:57.658627 | debian-bookworm | ok 2025-12-11 03:19:57.775047 | 2025-12-11 03:19:57.775253 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-11 03:19:58.777916 | debian-bookworm | changed 2025-12-11 03:19:58.827760 | 2025-12-11 03:19:58.835605 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-11 03:19:59.923714 | debian-bookworm | changed 2025-12-11 03:19:59.945516 | 2025-12-11 03:19:59.945654 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-11 03:19:59.999390 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:20:00.019978 | 2025-12-11 03:20:00.020126 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-11 03:20:02.159620 | debian-bookworm -> localhost | changed 2025-12-11 03:20:02.176896 | 2025-12-11 03:20:02.177049 | TASK [add-build-sshkey : Add back temp key] 2025-12-11 03:20:03.715761 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d1973395c91b42d7b9939ccb0e2d60a1/work/d1973395c91b42d7b9939ccb0e2d60a1_id_rsa (zuul-build-sshkey) 2025-12-11 03:20:03.716099 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.052680 2025-12-11 03:20:03.732842 | 2025-12-11 03:20:03.732980 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-11 03:20:04.684812 | debian-bookworm | ok 2025-12-11 03:20:04.690550 | 2025-12-11 03:20:04.690675 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-11 03:20:04.729607 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:20:04.742195 | 2025-12-11 03:20:04.742337 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-11 03:20:06.081239 | debian-bookworm | ok 2025-12-11 03:20:06.147514 | 2025-12-11 03:20:06.147706 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-11 03:20:06.209749 | debian-bookworm | ok 2025-12-11 03:20:06.252237 | 2025-12-11 03:20:06.252393 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-11 03:20:07.411165 | debian-bookworm -> localhost | ok 2025-12-11 03:20:07.418701 | 2025-12-11 03:20:07.418906 | TASK [validate-host : Collect information about the host] 2025-12-11 03:20:09.172815 | debian-bookworm | ok 2025-12-11 03:20:09.203845 | 2025-12-11 03:20:09.204003 | TASK [validate-host : Sanitize hostname] 2025-12-11 03:20:09.533626 | debian-bookworm | ok 2025-12-11 03:20:09.702627 | 2025-12-11 03:20:09.702777 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-11 03:20:11.646097 | debian-bookworm -> localhost | changed 2025-12-11 03:20:11.663053 | 2025-12-11 03:20:11.663214 | TASK [validate-host : Collect information about zuul worker] 2025-12-11 03:20:12.405274 | debian-bookworm | ok 2025-12-11 03:20:12.410486 | 2025-12-11 03:20:12.410620 | TASK [validate-host : Write out all zuul information for each host] 2025-12-11 03:20:14.074020 | debian-bookworm -> localhost | changed 2025-12-11 03:20:14.085909 | 2025-12-11 03:20:14.086058 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-11 03:20:14.464866 | debian-bookworm | ok 2025-12-11 03:20:14.471372 | 2025-12-11 03:20:14.471522 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-11 03:20:16.394057 | debian-bookworm | changed: 2025-12-11 03:20:16.394368 | debian-bookworm | cd+++++++++ src/ 2025-12-11 03:20:16.394532 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-11 03:20:16.394569 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-11 03:20:16.394602 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-11 03:20:16.394636 | debian-bookworm | =6.2 2025-12-11 03:20:42.580161 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-12-11 03:20:42.624792 | debian-bookworm | Collecting chardet>=5.2 2025-12-11 03:20:42.638925 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-11 03:20:42.651238 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 23.0 MB/s eta 0:00:00 2025-12-11 03:20:42.690269 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-11 03:20:42.703981 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-11 03:20:42.776170 | debian-bookworm | Collecting filelock>=3.20 2025-12-11 03:20:42.791773 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-12-11 03:20:42.861196 | debian-bookworm | Collecting packaging>=25 2025-12-11 03:20:42.874997 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-11 03:20:42.883923 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.4 MB/s eta 0:00:00 2025-12-11 03:20:42.943415 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-11 03:20:42.957355 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-11 03:20:43.001587 | debian-bookworm | Collecting pluggy>=1.6 2025-12-11 03:20:43.015590 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-11 03:20:43.059208 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-11 03:20:43.073610 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-11 03:20:43.229040 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-11 03:20:43.242954 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-11 03:20:43.514265 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 22.6 MB/s eta 0:00:00 2025-12-11 03:20:43.622442 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-11 03:20:43.636026 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-11 03:20:43.667661 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 17.2 MB/s eta 0:00:00 2025-12-11 03:20:43.826448 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-11 03:20:44.705690 | debian-bookworm | Successfully installed cachetools-6.2.2 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-12-11 03:20:44.910353 | debian-bookworm | ok: Runtime: 0:00:03.133233 2025-12-11 03:20:44.916804 | 2025-12-11 03:20:44.916939 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-11 03:20:44.997781 | debian-bookworm | ok 2025-12-11 03:20:45.006966 | 2025-12-11 03:20:45.007103 | TASK [ensure-tox : Output tox version] 2025-12-11 03:20:45.580766 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-11 03:20:45.599310 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-11 03:20:46.076912 | debian-bookworm | ok: Runtime: 0:00:00.303487 2025-12-11 03:20:46.083366 | 2025-12-11 03:20:46.083593 | TASK [ensure-tox : Make global symlink] 2025-12-11 03:20:46.107966 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:20:46.119055 | 2025-12-11 03:20:46.119168 | PLAY RECAP 2025-12-11 03:20:46.119225 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-11 03:20:46.119250 | 2025-12-11 03:20:46.363920 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-11 03:20:46.365101 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-11 03:20:47.458735 | 2025-12-11 03:20:47.459034 | PLAY [all] 2025-12-11 03:20:47.477618 | 2025-12-11 03:20:47.477787 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-11 03:20:48.109217 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-11 03:20:48.513140 | debian-bookworm | ok: Runtime: 0:00:00.030289 2025-12-11 03:20:48.519210 | 2025-12-11 03:20:48.519355 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-11 03:20:49.110055 | debian-bookworm | ok: Runtime: 0:00:00.005435 2025-12-11 03:20:49.117635 | 2025-12-11 03:20:49.117776 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-11 03:20:49.425342 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-11 03:20:49.427948 | debian-bookworm | sudo: a password is required 2025-12-11 03:20:49.667881 | debian-bookworm | ok: Runtime: 0:00:00.025797 2025-12-11 03:20:49.687666 | 2025-12-11 03:20:49.687871 | TASK [tox : Check to see if the constraints file exists] 2025-12-11 03:20:49.723114 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:20:49.731321 | 2025-12-11 03:20:49.731501 | TASK [tox : Fail if constraints file is missing] 2025-12-11 03:20:49.757501 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:20:49.766615 | 2025-12-11 03:20:49.766786 | TASK [tox : Record file location] 2025-12-11 03:20:49.794197 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:20:49.802440 | 2025-12-11 03:20:49.802629 | TASK [tox : Install tox siblings] 2025-12-11 03:20:49.836604 | debian-bookworm | ok 2025-12-11 03:20:49.846295 | debian-bookworm | included: /var/lib/zuul/builds/d1973395c91b42d7b9939ccb0e2d60a1/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-11 03:20:49.852447 | 2025-12-11 03:20:49.852612 | TASK [tox : Run tox without tests] 2025-12-11 03:20:51.001115 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-11 03:21:05.543958 | debian-bookworm | test: OK (15.16 seconds) 2025-12-11 03:21:05.544039 | debian-bookworm | congratulations :) (15.18 seconds) 2025-12-11 03:21:05.891777 | debian-bookworm | ok: Runtime: 0:00:15.450022 2025-12-11 03:21:05.899018 | 2025-12-11 03:21:05.899213 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-11 03:21:06.454623 | debian-bookworm | changed 2025-12-11 03:21:06.462542 | 2025-12-11 03:21:06.462684 | TASK [tox : Get tox envlist config] 2025-12-11 03:21:07.529245 | debian-bookworm | ok: Runtime: 0:00:00.308637 2025-12-11 03:21:07.538539 | 2025-12-11 03:21:07.538739 | TASK [tox : Install any sibling python packages] 2025-12-11 03:21:08.449656 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-11 03:21:08.461094 | 2025-12-11 03:21:08.461654 | TASK [tox : Remove tempfile] 2025-12-11 03:21:09.544374 | debian-bookworm | changed 2025-12-11 03:21:09.559007 | 2025-12-11 03:21:09.559348 | TASK [tox : Emit tox command] 2025-12-11 03:21:09.623131 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-11 03:21:09.636669 | 2025-12-11 03:21:09.636848 | TASK [tox : Run tox] 2025-12-11 03:21:10.581489 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-11 03:21:11.236045 | debian-bookworm | ............... 2025-12-11 03:21:11.236140 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-11 03:21:11.236173 | debian-bookworm | Ran 15 tests in 0.173s 2025-12-11 03:21:11.236188 | debian-bookworm | 2025-12-11 03:21:11.236206 | debian-bookworm | OK 2025-12-11 03:21:11.352838 | debian-bookworm | test: OK (0.82=setup[0.05]+cmd[0.77] seconds) 2025-12-11 03:21:11.352957 | debian-bookworm | congratulations :) (0.85 seconds) 2025-12-11 03:21:11.858695 | debian-bookworm | ok: Runtime: 0:00:01.159788 2025-12-11 03:21:11.865388 | 2025-12-11 03:21:11.865574 | TASK [tox : Look for output] 2025-12-11 03:21:12.390888 | debian-bookworm | ok 2025-12-11 03:21:12.423494 | 2025-12-11 03:21:12.423653 | TASK [tox : Return file comments to Zuul] 2025-12-11 03:21:12.493876 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:12.502382 | 2025-12-11 03:21:12.502509 | PLAY RECAP 2025-12-11 03:21:12.502583 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-11 03:21:12.502609 | 2025-12-11 03:21:12.909448 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-11 03:21:12.910626 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-11 03:21:14.683286 | 2025-12-11 03:21:14.684625 | PLAY [all] 2025-12-11 03:21:14.705767 | 2025-12-11 03:21:14.705941 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-11 03:21:14.847810 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:14.854441 | 2025-12-11 03:21:14.854650 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-11 03:21:14.919705 | debian-bookworm | ok 2025-12-11 03:21:14.925156 | 2025-12-11 03:21:14.925284 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-11 03:21:16.444539 | debian-bookworm -> localhost | changed 2025-12-11 03:21:16.453379 | 2025-12-11 03:21:16.453564 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-11 03:21:16.622671 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:16.630161 | 2025-12-11 03:21:16.630309 | TASK [fetch-tox-output : Set envlist fact] 2025-12-11 03:21:16.765161 | debian-bookworm | ok 2025-12-11 03:21:16.772024 | 2025-12-11 03:21:16.772152 | TASK [fetch-tox-output : Get tox version] 2025-12-11 03:21:17.836952 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-11 03:21:17.856588 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-11 03:21:18.336355 | debian-bookworm | ok: Runtime: 0:00:00.306842 2025-12-11 03:21:18.342798 | 2025-12-11 03:21:18.343003 | TASK [fetch-tox-output : Find all default environments] 2025-12-11 03:21:18.919080 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:18.926029 | 2025-12-11 03:21:18.926172 | TASK [fetch-tox-output : Set envlist fact] 2025-12-11 03:21:18.986708 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:18.994528 | 2025-12-11 03:21:18.994671 | TASK [fetch-tox-output : Find all default environments] 2025-12-11 03:21:19.621959 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:19.628280 | 2025-12-11 03:21:19.628411 | TASK [fetch-tox-output : Set envlist fact] 2025-12-11 03:21:19.683294 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:19.690516 | 2025-12-11 03:21:19.690668 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-11 03:21:19.806103 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:19.815484 | 2025-12-11 03:21:19.815629 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-11 03:21:21.534873 | debian-bookworm | changed: 2025-12-11 03:21:21.535074 | debian-bookworm | created directory /var/lib/zuul/builds/d1973395c91b42d7b9939ccb0e2d60a1/work/logs/tox/test 2025-12-11 03:21:21.535108 | debian-bookworm | cd+++++++++ ./ 2025-12-11 03:21:21.535134 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-11 03:21:21.535166 | 2025-12-11 03:21:21.549597 | 2025-12-11 03:21:21.549713 | PLAY RECAP 2025-12-11 03:21:21.549769 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-11 03:21:21.549794 | 2025-12-11 03:21:21.740360 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-11 03:21:21.741524 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-11 03:21:25.350031 | 2025-12-11 03:21:25.350229 | PLAY [all] 2025-12-11 03:21:25.396011 | 2025-12-11 03:21:25.396185 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-11 03:21:25.813621 | debian-bookworm | changed: non-zero return code 2025-12-11 03:21:25.826624 | 2025-12-11 03:21:25.826805 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-11 03:21:25.908841 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:25.917160 | 2025-12-11 03:21:25.917322 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-11 03:21:25.975450 | 2025-12-11 03:21:25.976084 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-11 03:21:26.063303 | 2025-12-11 03:21:26.063556 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-11 03:21:26.111970 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:26.120986 | 2025-12-11 03:21:26.121156 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-11 03:21:26.169776 | 2025-12-11 03:21:26.170007 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-11 03:21:26.217098 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:26.225327 | 2025-12-11 03:21:26.235082 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-11 03:21:26.351509 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:26.359374 | 2025-12-11 03:21:26.359553 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-11 03:21:26.407684 | debian-bookworm | skipping: Conditional result was False 2025-12-11 03:21:26.419065 | 2025-12-11 03:21:26.419187 | PLAY RECAP 2025-12-11 03:21:26.419247 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-11 03:21:26.419275 | 2025-12-11 03:21:26.944782 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-11 03:21:26.946324 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-11 03:21:30.093301 | 2025-12-11 03:21:30.093516 | PLAY [Base post] 2025-12-11 03:21:30.155059 | 2025-12-11 03:21:30.155240 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-11 03:21:31.955857 | debian-bookworm | changed 2025-12-11 03:21:31.987785 | 2025-12-11 03:21:31.987944 | PLAY RECAP 2025-12-11 03:21:31.988016 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-11 03:21:31.988081 | 2025-12-11 03:21:32.497064 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-11 03:21:32.498054 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-11 03:21:33.850130 | 2025-12-11 03:21:33.850279 | PLAY [Base post-logs] 2025-12-11 03:21:33.882589 | 2025-12-11 03:21:33.882726 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-11 03:21:34.537505 | localhost | changed 2025-12-11 03:21:34.547004 | 2025-12-11 03:21:34.547153 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-11 03:21:34.601711 | localhost | ok 2025-12-11 03:21:34.604818 | 2025-12-11 03:21:34.604916 | TASK [Set zuul-log-path fact] 2025-12-11 03:21:34.629631 | localhost | ok 2025-12-11 03:21:34.640874 | 2025-12-11 03:21:34.641004 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-11 03:21:34.685892 | localhost | ok 2025-12-11 03:21:34.688774 | 2025-12-11 03:21:34.688872 | TASK [upload-logs : Create log directories] 2025-12-11 03:21:35.679604 | localhost | changed 2025-12-11 03:21:35.682117 | 2025-12-11 03:21:35.682203 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-11 03:21:36.619569 | localhost -> localhost | ok: Runtime: 0:00:00.005802 2025-12-11 03:21:36.624228 | 2025-12-11 03:21:36.624399 | TASK [upload-logs : Upload logs to log server] 2025-12-11 03:21:37.635258 | localhost | Output suppressed because no_log was given 2025-12-11 03:21:37.636901 | 2025-12-11 03:21:37.636982 | LOOP [upload-logs : Compress console log and json output] 2025-12-11 03:21:37.873327 | localhost | skipping: Conditional result was False 2025-12-11 03:21:37.914046 | localhost | skipping: Conditional result was False 2025-12-11 03:21:37.921533 | 2025-12-11 03:21:37.921662 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-11 03:21:38.067029 | localhost | skipping: Conditional result was False 2025-12-11 03:21:38.067260 | 2025-12-11 03:21:38.096621 | localhost | skipping: Conditional result was False 2025-12-11 03:21:38.116076 | 2025-12-11 03:21:38.116188 | LOOP [upload-logs : Upload console log and json output]