2025-12-24 00:18:13.967322 | Job console starting 2025-12-24 00:18:14.011971 | Updating git repos 2025-12-24 00:18:14.080012 | Cloning repos into workspace 2025-12-24 00:18:14.194156 | Restoring repo states 2025-12-24 00:18:14.215619 | Merging changes 2025-12-24 00:18:14.752308 | Checking out repos 2025-12-24 00:18:14.864660 | Preparing playbooks 2025-12-24 00:18:16.235018 | Running Ansible setup 2025-12-24 00:18:21.561442 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-24 00:18:22.562162 | 2025-12-24 00:18:22.562335 | PLAY [Base pre] 2025-12-24 00:18:22.583631 | 2025-12-24 00:18:22.583901 | TASK [Setup log path fact] 2025-12-24 00:18:22.615536 | debian-bookworm | ok 2025-12-24 00:18:22.644100 | 2025-12-24 00:18:22.644281 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-24 00:18:22.683626 | debian-bookworm | ok 2025-12-24 00:18:22.694163 | 2025-12-24 00:18:22.694320 | TASK [emit-job-header : Print job information] 2025-12-24 00:18:22.734184 | # Job Information 2025-12-24 00:18:22.734398 | Ansible Version: 2.16.14 2025-12-24 00:18:22.734436 | Job: tox 2025-12-24 00:18:22.734470 | Pipeline: check 2025-12-24 00:18:22.734493 | Executor: 521e9411259a 2025-12-24 00:18:22.734515 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1053 2025-12-24 00:18:22.734537 | Event ID: 03bcfc30-e05e-11f0-865c-c4d5595a35a5 2025-12-24 00:18:22.740955 | 2025-12-24 00:18:22.741101 | LOOP [emit-job-header : Print node information] 2025-12-24 00:18:22.855867 | debian-bookworm | ok: 2025-12-24 00:18:22.856136 | debian-bookworm | # Node Information 2025-12-24 00:18:22.856173 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-24 00:18:22.856199 | debian-bookworm | Hostname: debian 2025-12-24 00:18:22.856221 | debian-bookworm | Username: zuul 2025-12-24 00:18:22.856241 | debian-bookworm | Distro: Debian 12.12 2025-12-24 00:18:22.856264 | debian-bookworm | Provider: regiocloud-a 2025-12-24 00:18:22.856285 | debian-bookworm | Region: 2025-12-24 00:18:22.856306 | debian-bookworm | Label: debian-bookworm 2025-12-24 00:18:22.856327 | debian-bookworm | Product Name: OpenStack Nova 2025-12-24 00:18:22.856347 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fece:1576 2025-12-24 00:18:22.877820 | 2025-12-24 00:18:22.877977 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-24 00:18:23.643474 | debian-bookworm -> localhost | changed 2025-12-24 00:18:23.651499 | 2025-12-24 00:18:23.651699 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-24 00:18:25.088007 | debian-bookworm -> localhost | changed 2025-12-24 00:18:25.100029 | 2025-12-24 00:18:25.100165 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-24 00:18:25.621139 | debian-bookworm -> localhost | ok 2025-12-24 00:18:25.627907 | 2025-12-24 00:18:25.628049 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-24 00:18:25.658001 | debian-bookworm | ok 2025-12-24 00:18:25.692498 | debian-bookworm | included: /var/lib/zuul/builds/1dea599220c249a7bb72ac3ae339c22a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-24 00:18:25.699180 | 2025-12-24 00:18:25.699311 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-24 00:18:27.150374 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-24 00:18:27.151169 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1dea599220c249a7bb72ac3ae339c22a/work/1dea599220c249a7bb72ac3ae339c22a_id_rsa 2025-12-24 00:18:27.151306 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1dea599220c249a7bb72ac3ae339c22a/work/1dea599220c249a7bb72ac3ae339c22a_id_rsa.pub 2025-12-24 00:18:27.151382 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-24 00:18:27.151453 | debian-bookworm -> localhost | SHA256:0a4MiBtasvsCIjA2FX1j+Tk6Wc187v4yPW5zAIImp+A zuul-build-sshkey 2025-12-24 00:18:27.151511 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-24 00:18:27.151650 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-24 00:18:27.151716 | debian-bookworm -> localhost | | .o . | 2025-12-24 00:18:27.151777 | debian-bookworm -> localhost | | . . = . | 2025-12-24 00:18:27.151826 | debian-bookworm -> localhost | | . o +.* | 2025-12-24 00:18:27.151869 | debian-bookworm -> localhost | |oo .... +B.+.. | 2025-12-24 00:18:27.151911 | debian-bookworm -> localhost | |+.=....=S o.o. | 2025-12-24 00:18:27.151967 | debian-bookworm -> localhost | |+= oE .* . .. | 2025-12-24 00:18:27.152011 | debian-bookworm -> localhost | |* . + . .. | 2025-12-24 00:18:27.152053 | debian-bookworm -> localhost | |.. + =.| 2025-12-24 00:18:27.152096 | debian-bookworm -> localhost | |.o. ..*o+| 2025-12-24 00:18:27.152138 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-24 00:18:27.152250 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.778183 2025-12-24 00:18:27.164192 | 2025-12-24 00:18:27.164334 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-24 00:18:27.194478 | debian-bookworm | ok 2025-12-24 00:18:27.204782 | debian-bookworm | included: /var/lib/zuul/builds/1dea599220c249a7bb72ac3ae339c22a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-24 00:18:27.214595 | 2025-12-24 00:18:27.214721 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-24 00:18:27.239052 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:18:27.248255 | 2025-12-24 00:18:27.248393 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-24 00:18:27.970150 | debian-bookworm | changed 2025-12-24 00:18:27.978058 | 2025-12-24 00:18:27.979050 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-24 00:18:28.290047 | debian-bookworm | ok 2025-12-24 00:18:28.298499 | 2025-12-24 00:18:28.298663 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-24 00:18:28.965506 | debian-bookworm | changed 2025-12-24 00:18:28.976290 | 2025-12-24 00:18:28.976447 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-24 00:18:29.714271 | debian-bookworm | changed 2025-12-24 00:18:29.728989 | 2025-12-24 00:18:29.729134 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-24 00:18:29.755587 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:18:29.762874 | 2025-12-24 00:18:29.763024 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-24 00:18:30.569944 | debian-bookworm -> localhost | changed 2025-12-24 00:18:30.612386 | 2025-12-24 00:18:30.614214 | TASK [add-build-sshkey : Add back temp key] 2025-12-24 00:18:31.182231 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1dea599220c249a7bb72ac3ae339c22a/work/1dea599220c249a7bb72ac3ae339c22a_id_rsa (zuul-build-sshkey) 2025-12-24 00:18:31.182489 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013999 2025-12-24 00:18:31.193865 | 2025-12-24 00:18:31.194121 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-24 00:18:31.675807 | debian-bookworm | ok 2025-12-24 00:18:31.683441 | 2025-12-24 00:18:31.683599 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-24 00:18:31.707762 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:18:31.720575 | 2025-12-24 00:18:31.720715 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-24 00:18:32.193866 | debian-bookworm | ok 2025-12-24 00:18:32.212620 | 2025-12-24 00:18:32.212764 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-24 00:18:32.273784 | debian-bookworm | ok 2025-12-24 00:18:32.283985 | 2025-12-24 00:18:32.284203 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-24 00:18:32.684524 | debian-bookworm -> localhost | ok 2025-12-24 00:18:32.694153 | 2025-12-24 00:18:32.694344 | TASK [validate-host : Collect information about the host] 2025-12-24 00:18:33.896532 | debian-bookworm | ok 2025-12-24 00:18:33.920674 | 2025-12-24 00:18:33.920828 | TASK [validate-host : Sanitize hostname] 2025-12-24 00:18:34.073155 | debian-bookworm | ok 2025-12-24 00:18:34.141183 | 2025-12-24 00:18:34.141334 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-24 00:18:35.159524 | debian-bookworm -> localhost | changed 2025-12-24 00:18:35.169436 | 2025-12-24 00:18:35.169667 | TASK [validate-host : Collect information about zuul worker] 2025-12-24 00:18:35.667465 | debian-bookworm | ok 2025-12-24 00:18:35.672765 | 2025-12-24 00:18:35.672894 | TASK [validate-host : Write out all zuul information for each host] 2025-12-24 00:18:36.529887 | debian-bookworm -> localhost | changed 2025-12-24 00:18:36.543331 | 2025-12-24 00:18:36.544791 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-24 00:18:36.835603 | debian-bookworm | ok 2025-12-24 00:18:36.846822 | 2025-12-24 00:18:36.852643 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-24 00:18:37.949417 | debian-bookworm | changed: 2025-12-24 00:18:37.949689 | debian-bookworm | cd+++++++++ src/ 2025-12-24 00:18:37.949727 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-24 00:18:37.949752 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-24 00:18:37.949774 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-24 00:18:37.949794 | debian-bookworm | =6.2 2025-12-24 00:19:01.749151 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2025-12-24 00:19:01.793621 | debian-bookworm | Collecting chardet>=5.2 2025-12-24 00:19:01.805664 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-24 00:19:01.816570 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 25.8 MB/s eta 0:00:00 2025-12-24 00:19:01.877169 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-24 00:19:01.889664 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-24 00:19:01.948406 | debian-bookworm | Collecting filelock>=3.20 2025-12-24 00:19:01.959743 | debian-bookworm | Downloading filelock-3.20.1-py3-none-any.whl (16 kB) 2025-12-24 00:19:02.008894 | debian-bookworm | Collecting packaging>=25 2025-12-24 00:19:02.020501 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-24 00:19:02.028606 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.9 MB/s eta 0:00:00 2025-12-24 00:19:02.075224 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-24 00:19:02.088254 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-24 00:19:02.143876 | debian-bookworm | Collecting pluggy>=1.6 2025-12-24 00:19:02.155384 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-24 00:19:02.211136 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-24 00:19:02.224048 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-24 00:19:02.406396 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-24 00:19:02.418760 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-24 00:19:02.649356 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 26.7 MB/s eta 0:00:00 2025-12-24 00:19:02.765129 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-24 00:19:02.777146 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-24 00:19:02.797553 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 27.0 MB/s eta 0:00:00 2025-12-24 00:19:02.948489 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-24 00:19:03.832603 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.1 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-24 00:19:04.062555 | debian-bookworm | ok: Runtime: 0:00:03.103294 2025-12-24 00:19:04.079287 | 2025-12-24 00:19:04.079433 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-24 00:19:04.116649 | debian-bookworm | ok 2025-12-24 00:19:04.122974 | 2025-12-24 00:19:04.123097 | TASK [ensure-tox : Output tox version] 2025-12-24 00:19:04.693101 | 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-24 00:19:04.711834 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-24 00:19:05.173836 | debian-bookworm | ok: Runtime: 0:00:00.302590 2025-12-24 00:19:05.186190 | 2025-12-24 00:19:05.186353 | TASK [ensure-tox : Make global symlink] 2025-12-24 00:19:05.212362 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:05.224528 | 2025-12-24 00:19:05.224702 | PLAY RECAP 2025-12-24 00:19:05.224788 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-24 00:19:05.224830 | 2025-12-24 00:19:05.439666 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-24 00:19:05.449109 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-24 00:19:06.356080 | 2025-12-24 00:19:06.356278 | PLAY [all] 2025-12-24 00:19:06.372793 | 2025-12-24 00:19:06.372949 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-24 00:19:06.927699 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-24 00:19:07.414749 | debian-bookworm | ok: Runtime: 0:00:00.027519 2025-12-24 00:19:07.421193 | 2025-12-24 00:19:07.421353 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-24 00:19:07.951882 | debian-bookworm | ok: Runtime: 0:00:00.006684 2025-12-24 00:19:07.958339 | 2025-12-24 00:19:07.958650 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-24 00:19:08.282342 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-24 00:19:08.284276 | debian-bookworm | sudo: a password is required 2025-12-24 00:19:08.505962 | debian-bookworm | ok: Runtime: 0:00:00.019243 2025-12-24 00:19:08.518212 | 2025-12-24 00:19:08.518355 | TASK [tox : Check to see if the constraints file exists] 2025-12-24 00:19:08.554767 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:08.565519 | 2025-12-24 00:19:08.565733 | TASK [tox : Fail if constraints file is missing] 2025-12-24 00:19:08.593830 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:08.602038 | 2025-12-24 00:19:08.602199 | TASK [tox : Record file location] 2025-12-24 00:19:08.628946 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:08.635067 | 2025-12-24 00:19:08.635204 | TASK [tox : Install tox siblings] 2025-12-24 00:19:08.677357 | debian-bookworm | ok 2025-12-24 00:19:08.688875 | debian-bookworm | included: /var/lib/zuul/builds/1dea599220c249a7bb72ac3ae339c22a/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-24 00:19:08.695623 | 2025-12-24 00:19:08.695755 | TASK [tox : Run tox without tests] 2025-12-24 00:19:09.911831 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-24 00:19:23.755010 | debian-bookworm | test: OK (14.47 seconds) 2025-12-24 00:19:23.755111 | debian-bookworm | congratulations :) (14.50 seconds) 2025-12-24 00:19:24.246366 | debian-bookworm | ok: Runtime: 0:00:14.776577 2025-12-24 00:19:24.260304 | 2025-12-24 00:19:24.260505 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-24 00:19:24.679270 | debian-bookworm | changed 2025-12-24 00:19:24.687763 | 2025-12-24 00:19:24.687954 | TASK [tox : Get tox envlist config] 2025-12-24 00:19:25.723401 | debian-bookworm | ok: Runtime: 0:00:00.293086 2025-12-24 00:19:25.735148 | 2025-12-24 00:19:25.736068 | TASK [tox : Install any sibling python packages] 2025-12-24 00:19:26.179395 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-24 00:19:26.188908 | 2025-12-24 00:19:26.189064 | TASK [tox : Remove tempfile] 2025-12-24 00:19:26.641814 | debian-bookworm | changed 2025-12-24 00:19:26.654183 | 2025-12-24 00:19:26.654383 | TASK [tox : Emit tox command] 2025-12-24 00:19:26.706783 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-24 00:19:26.713450 | 2025-12-24 00:19:26.713647 | TASK [tox : Run tox] 2025-12-24 00:19:27.394631 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-24 00:19:28.028848 | debian-bookworm | ............... 2025-12-24 00:19:28.028903 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-24 00:19:28.028919 | debian-bookworm | Ran 15 tests in 0.172s 2025-12-24 00:19:28.028924 | debian-bookworm | 2025-12-24 00:19:28.028931 | debian-bookworm | OK 2025-12-24 00:19:28.127715 | debian-bookworm | test: OK (0.78=setup[0.04]+cmd[0.73] seconds) 2025-12-24 00:19:28.127833 | debian-bookworm | congratulations :) (0.80 seconds) 2025-12-24 00:19:28.291369 | debian-bookworm | ok: Runtime: 0:00:01.096430 2025-12-24 00:19:28.301647 | 2025-12-24 00:19:28.301829 | TASK [tox : Look for output] 2025-12-24 00:19:28.761007 | debian-bookworm | ok 2025-12-24 00:19:28.787994 | 2025-12-24 00:19:28.788256 | TASK [tox : Return file comments to Zuul] 2025-12-24 00:19:28.823566 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:28.832674 | 2025-12-24 00:19:28.832811 | PLAY RECAP 2025-12-24 00:19:28.832882 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-24 00:19:28.832912 | 2025-12-24 00:19:28.987120 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-24 00:19:28.990033 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-24 00:19:29.826212 | 2025-12-24 00:19:29.826389 | PLAY [all] 2025-12-24 00:19:29.845169 | 2025-12-24 00:19:29.845423 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-24 00:19:29.896740 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:29.905783 | 2025-12-24 00:19:29.905986 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-24 00:19:29.953911 | debian-bookworm | ok 2025-12-24 00:19:29.964323 | 2025-12-24 00:19:29.964527 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-24 00:19:30.594252 | debian-bookworm -> localhost | changed 2025-12-24 00:19:30.610528 | 2025-12-24 00:19:30.610731 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-24 00:19:30.678544 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:30.685808 | 2025-12-24 00:19:30.685960 | TASK [fetch-tox-output : Set envlist fact] 2025-12-24 00:19:30.736411 | debian-bookworm | ok 2025-12-24 00:19:30.743501 | 2025-12-24 00:19:30.743698 | TASK [fetch-tox-output : Get tox version] 2025-12-24 00:19:31.462785 | 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-24 00:19:31.482391 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-24 00:19:31.778289 | debian-bookworm | ok: Runtime: 0:00:00.313994 2025-12-24 00:19:31.793929 | 2025-12-24 00:19:31.794198 | TASK [fetch-tox-output : Find all default environments] 2025-12-24 00:19:32.329875 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:32.341566 | 2025-12-24 00:19:32.341791 | TASK [fetch-tox-output : Set envlist fact] 2025-12-24 00:19:32.380952 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:32.394529 | 2025-12-24 00:19:32.394787 | TASK [fetch-tox-output : Find all default environments] 2025-12-24 00:19:32.934035 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:32.941009 | 2025-12-24 00:19:32.941153 | TASK [fetch-tox-output : Set envlist fact] 2025-12-24 00:19:32.975425 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:32.983495 | 2025-12-24 00:19:32.984537 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-24 00:19:33.065216 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:33.079306 | 2025-12-24 00:19:33.079458 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-24 00:19:34.021238 | debian-bookworm | changed: 2025-12-24 00:19:34.021535 | debian-bookworm | created directory /var/lib/zuul/builds/1dea599220c249a7bb72ac3ae339c22a/work/logs/tox/test 2025-12-24 00:19:34.021617 | debian-bookworm | cd+++++++++ ./ 2025-12-24 00:19:34.021664 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-24 00:19:34.021721 | 2025-12-24 00:19:34.034106 | 2025-12-24 00:19:34.034224 | PLAY RECAP 2025-12-24 00:19:34.034277 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-24 00:19:34.034303 | 2025-12-24 00:19:34.201331 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-24 00:19:34.202561 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-24 00:19:35.001881 | 2025-12-24 00:19:35.002055 | PLAY [all] 2025-12-24 00:19:35.019219 | 2025-12-24 00:19:35.019499 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-24 00:19:35.242369 | debian-bookworm | changed: non-zero return code 2025-12-24 00:19:35.248859 | 2025-12-24 00:19:35.249020 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-24 00:19:35.273399 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:35.279666 | 2025-12-24 00:19:35.279804 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-24 00:19:35.310501 | 2025-12-24 00:19:35.310738 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-24 00:19:35.342238 | 2025-12-24 00:19:35.342444 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-24 00:19:35.366871 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:35.373485 | 2025-12-24 00:19:35.373668 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-24 00:19:35.409774 | 2025-12-24 00:19:35.410007 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-24 00:19:35.441512 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:35.456617 | 2025-12-24 00:19:35.456784 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-24 00:19:35.493445 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:35.507678 | 2025-12-24 00:19:35.508330 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-24 00:19:35.545259 | debian-bookworm | skipping: Conditional result was False 2025-12-24 00:19:35.552615 | 2025-12-24 00:19:35.552726 | PLAY RECAP 2025-12-24 00:19:35.552782 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-24 00:19:35.552807 | 2025-12-24 00:19:35.703731 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-24 00:19:35.704937 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-24 00:19:36.503405 | 2025-12-24 00:19:36.503645 | PLAY [Base post] 2025-12-24 00:19:36.519725 | 2025-12-24 00:19:36.519897 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-24 00:19:37.127803 | debian-bookworm | changed 2025-12-24 00:19:37.136819 | 2025-12-24 00:19:37.136983 | PLAY RECAP 2025-12-24 00:19:37.137050 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-24 00:19:37.137113 | 2025-12-24 00:19:37.309909 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-24 00:19:37.311428 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-24 00:19:38.117004 | 2025-12-24 00:19:38.117178 | PLAY [Base post-logs] 2025-12-24 00:19:38.128455 | 2025-12-24 00:19:38.128651 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-24 00:19:38.656459 | localhost | changed 2025-12-24 00:19:38.675908 | 2025-12-24 00:19:38.676116 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-24 00:19:38.705675 | localhost | ok 2025-12-24 00:19:38.712612 | 2025-12-24 00:19:38.712775 | TASK [Set zuul-log-path fact] 2025-12-24 00:19:38.730791 | localhost | ok 2025-12-24 00:19:38.743418 | 2025-12-24 00:19:38.743634 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-24 00:19:38.770393 | localhost | ok 2025-12-24 00:19:38.774968 | 2025-12-24 00:19:38.775106 | TASK [upload-logs : Create log directories] 2025-12-24 00:19:39.350958 | localhost | changed 2025-12-24 00:19:39.355288 | 2025-12-24 00:19:39.355445 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-24 00:19:39.909176 | localhost -> localhost | ok: Runtime: 0:00:00.005708 2025-12-24 00:19:39.914540 | 2025-12-24 00:19:39.914689 | TASK [upload-logs : Upload logs to log server] 2025-12-24 00:19:40.546035 | localhost | Output suppressed because no_log was given 2025-12-24 00:19:40.548686 | 2025-12-24 00:19:40.548827 | LOOP [upload-logs : Compress console log and json output] 2025-12-24 00:19:40.600901 | localhost | skipping: Conditional result was False 2025-12-24 00:19:40.605640 | localhost | skipping: Conditional result was False 2025-12-24 00:19:40.617396 | 2025-12-24 00:19:40.617562 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-24 00:19:40.667046 | localhost | skipping: Conditional result was False 2025-12-24 00:19:40.667904 | 2025-12-24 00:19:40.672310 | localhost | skipping: Conditional result was False 2025-12-24 00:19:40.685998 | 2025-12-24 00:19:40.686132 | LOOP [upload-logs : Upload console log and json output]