2025-11-09 14:54:17.738708 | Job console starting 2025-11-09 14:54:17.769483 | Updating git repos 2025-11-09 14:54:17.847664 | Cloning repos into workspace 2025-11-09 14:54:17.904104 | Restoring repo states 2025-11-09 14:54:17.913531 | Merging changes 2025-11-09 14:54:18.442191 | Checking out repos 2025-11-09 14:54:18.514965 | Preparing playbooks 2025-11-09 14:54:19.346944 | Running Ansible setup 2025-11-09 14:54:25.242535 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-09 14:54:26.229110 | 2025-11-09 14:54:26.229240 | PLAY [Base pre] 2025-11-09 14:54:26.256903 | 2025-11-09 14:54:26.257024 | TASK [Setup log path fact] 2025-11-09 14:54:26.294979 | debian-bookworm | ok 2025-11-09 14:54:26.321322 | 2025-11-09 14:54:26.321451 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-09 14:54:26.370331 | debian-bookworm | ok 2025-11-09 14:54:26.380587 | 2025-11-09 14:54:26.380681 | TASK [emit-job-header : Print job information] 2025-11-09 14:54:26.428567 | # Job Information 2025-11-09 14:54:26.428734 | Ansible Version: 2.16.14 2025-11-09 14:54:26.428796 | Job: tox 2025-11-09 14:54:26.428831 | Pipeline: check 2025-11-09 14:54:26.428854 | Executor: 521e9411259a 2025-11-09 14:54:26.428876 | Triggered by: https://github.com/osism/openstack-image-manager/pull/985 2025-11-09 14:54:26.428898 | Event ID: f24e2500-bd7b-11f0-8959-393673c4c684 2025-11-09 14:54:26.434149 | 2025-11-09 14:54:26.434249 | LOOP [emit-job-header : Print node information] 2025-11-09 14:54:26.581079 | debian-bookworm | ok: 2025-11-09 14:54:26.581265 | debian-bookworm | # Node Information 2025-11-09 14:54:26.581299 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-09 14:54:26.581325 | debian-bookworm | Hostname: debian 2025-11-09 14:54:26.581347 | debian-bookworm | Username: zuul 2025-11-09 14:54:26.581368 | debian-bookworm | Distro: Debian 12.12 2025-11-09 14:54:26.581392 | debian-bookworm | Provider: regiocloud-a 2025-11-09 14:54:26.581412 | debian-bookworm | Region: 2025-11-09 14:54:26.581434 | debian-bookworm | Label: debian-bookworm 2025-11-09 14:54:26.581455 | debian-bookworm | Product Name: OpenStack Nova 2025-11-09 14:54:26.581475 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe25:af45 2025-11-09 14:54:26.607395 | 2025-11-09 14:54:26.607514 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-09 14:54:27.135516 | debian-bookworm -> localhost | changed 2025-11-09 14:54:27.142215 | 2025-11-09 14:54:27.142316 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-09 14:54:28.317929 | debian-bookworm -> localhost | changed 2025-11-09 14:54:28.329194 | 2025-11-09 14:54:28.329288 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-09 14:54:28.618581 | debian-bookworm -> localhost | ok 2025-11-09 14:54:28.623792 | 2025-11-09 14:54:28.623882 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-09 14:54:28.650756 | debian-bookworm | ok 2025-11-09 14:54:28.670781 | debian-bookworm | included: /var/lib/zuul/builds/28ffec1070a142149c4249b88cf7b076/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-09 14:54:28.687643 | 2025-11-09 14:54:28.687714 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-09 14:54:30.261415 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-09 14:54:30.261600 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/28ffec1070a142149c4249b88cf7b076/work/28ffec1070a142149c4249b88cf7b076_id_rsa 2025-11-09 14:54:30.261632 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/28ffec1070a142149c4249b88cf7b076/work/28ffec1070a142149c4249b88cf7b076_id_rsa.pub 2025-11-09 14:54:30.261655 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-09 14:54:30.261677 | debian-bookworm -> localhost | SHA256:oVNMUBAvpyCivYY5vCTjH9is4E72bSWX8g/ZmlXbwds zuul-build-sshkey 2025-11-09 14:54:30.261695 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-09 14:54:30.261721 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-09 14:54:30.261750 | debian-bookworm -> localhost | | +=o | 2025-11-09 14:54:30.261770 | debian-bookworm -> localhost | | + | 2025-11-09 14:54:30.261787 | debian-bookworm -> localhost | |. . . . * | 2025-11-09 14:54:30.261803 | debian-bookworm -> localhost | |.o . . * . . | 2025-11-09 14:54:30.261819 | debian-bookworm -> localhost | |. . + S . o | 2025-11-09 14:54:30.261840 | debian-bookworm -> localhost | |.o+. o =o . o + | 2025-11-09 14:54:30.261857 | debian-bookworm -> localhost | |B*o+ *o o . o E | 2025-11-09 14:54:30.261873 | debian-bookworm -> localhost | |O++ o. .= | 2025-11-09 14:54:30.261890 | debian-bookworm -> localhost | |.*.o.. o.. | 2025-11-09 14:54:30.261906 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-09 14:54:30.261957 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.907853 2025-11-09 14:54:30.267394 | 2025-11-09 14:54:30.267474 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-09 14:54:30.284215 | debian-bookworm | ok 2025-11-09 14:54:30.293291 | debian-bookworm | included: /var/lib/zuul/builds/28ffec1070a142149c4249b88cf7b076/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-09 14:54:30.300373 | 2025-11-09 14:54:30.300441 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-09 14:54:30.313192 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:54:30.318095 | 2025-11-09 14:54:30.318171 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-09 14:54:30.905408 | debian-bookworm | changed 2025-11-09 14:54:30.911445 | 2025-11-09 14:54:30.911533 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-09 14:54:31.189867 | debian-bookworm | ok 2025-11-09 14:54:31.197817 | 2025-11-09 14:54:31.197925 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-09 14:54:31.886199 | debian-bookworm | changed 2025-11-09 14:54:31.893976 | 2025-11-09 14:54:31.894065 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-09 14:54:32.542367 | debian-bookworm | changed 2025-11-09 14:54:32.547601 | 2025-11-09 14:54:32.547685 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-09 14:54:32.580447 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:54:32.586470 | 2025-11-09 14:54:32.586563 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-09 14:54:33.060201 | debian-bookworm -> localhost | changed 2025-11-09 14:54:33.070729 | 2025-11-09 14:54:33.076150 | TASK [add-build-sshkey : Add back temp key] 2025-11-09 14:54:33.463568 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/28ffec1070a142149c4249b88cf7b076/work/28ffec1070a142149c4249b88cf7b076_id_rsa (zuul-build-sshkey) 2025-11-09 14:54:33.463912 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019102 2025-11-09 14:54:33.475168 | 2025-11-09 14:54:33.475280 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-09 14:54:33.875845 | debian-bookworm | ok 2025-11-09 14:54:33.879854 | 2025-11-09 14:54:33.879925 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-09 14:54:33.916315 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:54:33.933557 | 2025-11-09 14:54:33.933645 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-09 14:54:34.335053 | debian-bookworm | ok 2025-11-09 14:54:34.344305 | 2025-11-09 14:54:34.344382 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-09 14:54:34.370765 | debian-bookworm | ok 2025-11-09 14:54:34.374761 | 2025-11-09 14:54:34.374847 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-09 14:54:34.750495 | debian-bookworm -> localhost | ok 2025-11-09 14:54:34.756662 | 2025-11-09 14:54:34.756764 | TASK [validate-host : Collect information about the host] 2025-11-09 14:54:35.829949 | debian-bookworm | ok 2025-11-09 14:54:35.845524 | 2025-11-09 14:54:35.845619 | TASK [validate-host : Sanitize hostname] 2025-11-09 14:54:35.952566 | debian-bookworm | ok 2025-11-09 14:54:36.001449 | 2025-11-09 14:54:36.001552 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-09 14:54:36.615944 | debian-bookworm -> localhost | changed 2025-11-09 14:54:36.624248 | 2025-11-09 14:54:36.624363 | TASK [validate-host : Collect information about zuul worker] 2025-11-09 14:54:37.016508 | debian-bookworm | ok 2025-11-09 14:54:37.020923 | 2025-11-09 14:54:37.021011 | TASK [validate-host : Write out all zuul information for each host] 2025-11-09 14:54:37.611892 | debian-bookworm -> localhost | changed 2025-11-09 14:54:37.620729 | 2025-11-09 14:54:37.620827 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-09 14:54:37.897592 | debian-bookworm | ok 2025-11-09 14:54:37.902686 | 2025-11-09 14:54:37.902780 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-09 14:54:38.758866 | debian-bookworm | changed: 2025-11-09 14:54:38.759030 | debian-bookworm | cd+++++++++ src/ 2025-11-09 14:54:38.759064 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-09 14:54:38.759089 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-09 14:54:38.759111 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-09 14:54:38.759131 | debian-bookworm | =6.2 2025-11-09 14:55:00.565922 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-11-09 14:55:00.621833 | debian-bookworm | Collecting chardet>=5.2 2025-11-09 14:55:00.638123 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-09 14:55:00.648670 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 25.6 MB/s eta 0:00:00 2025-11-09 14:55:00.688569 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-09 14:55:00.703515 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-09 14:55:00.768280 | debian-bookworm | Collecting filelock>=3.20 2025-11-09 14:55:00.783092 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-09 14:55:00.835832 | debian-bookworm | Collecting packaging>=25 2025-11-09 14:55:00.850147 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-09 14:55:00.857317 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 12.8 MB/s eta 0:00:00 2025-11-09 14:55:00.904029 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-09 14:55:00.918140 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-09 14:55:00.968457 | debian-bookworm | Collecting pluggy>=1.6 2025-11-09 14:55:00.982228 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-09 14:55:01.031290 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-09 14:55:01.054136 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-09 14:55:01.222347 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-09 14:55:01.236385 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-09 14:55:01.522646 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 21.3 MB/s eta 0:00:00 2025-11-09 14:55:01.623630 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-09 14:55:01.637051 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-09 14:55:01.662838 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.0 MB/s eta 0:00:00 2025-11-09 14:55:01.797202 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-09 14:55:02.629898 | debian-bookworm | Successfully installed cachetools-6.2.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.0 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-11-09 14:55:03.019364 | debian-bookworm | ok: Runtime: 0:00:02.966564 2025-11-09 14:55:03.025499 | 2025-11-09 14:55:03.025612 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-09 14:55:03.056987 | debian-bookworm | ok 2025-11-09 14:55:03.062029 | 2025-11-09 14:55:03.062137 | TASK [ensure-tox : Output tox version] 2025-11-09 14:55:03.551491 | 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-11-09 14:55:03.569653 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-09 14:55:04.090568 | debian-bookworm | ok: Runtime: 0:00:00.264489 2025-11-09 14:55:04.102635 | 2025-11-09 14:55:04.102908 | TASK [ensure-tox : Make global symlink] 2025-11-09 14:55:04.129978 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:04.137627 | 2025-11-09 14:55:04.137740 | PLAY RECAP 2025-11-09 14:55:04.137799 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-09 14:55:04.137824 | 2025-11-09 14:55:04.313968 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-09 14:55:04.315137 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-09 14:55:05.054353 | 2025-11-09 14:55:05.054567 | PLAY [all] 2025-11-09 14:55:05.071749 | 2025-11-09 14:55:05.071910 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-09 14:55:05.561726 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-09 14:55:05.610215 | debian-bookworm | ok: Runtime: 0:00:00.025066 2025-11-09 14:55:05.620059 | 2025-11-09 14:55:05.620214 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-09 14:55:06.150872 | debian-bookworm | ok: Runtime: 0:00:00.006179 2025-11-09 14:55:06.164223 | 2025-11-09 14:55:06.164387 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-09 14:55:06.425828 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-09 14:55:06.427239 | debian-bookworm | sudo: a password is required 2025-11-09 14:55:06.695891 | debian-bookworm | ok: Runtime: 0:00:00.017448 2025-11-09 14:55:06.716256 | 2025-11-09 14:55:06.716415 | TASK [tox : Check to see if the constraints file exists] 2025-11-09 14:55:06.752738 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:06.765247 | 2025-11-09 14:55:06.765423 | TASK [tox : Fail if constraints file is missing] 2025-11-09 14:55:06.792216 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:06.802962 | 2025-11-09 14:55:06.803158 | TASK [tox : Record file location] 2025-11-09 14:55:06.828522 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:06.841420 | 2025-11-09 14:55:06.841586 | TASK [tox : Install tox siblings] 2025-11-09 14:55:06.865857 | debian-bookworm | ok 2025-11-09 14:55:06.875917 | debian-bookworm | included: /var/lib/zuul/builds/28ffec1070a142149c4249b88cf7b076/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-09 14:55:06.881449 | 2025-11-09 14:55:06.881556 | TASK [tox : Run tox without tests] 2025-11-09 14:55:07.823516 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-09 14:55:20.767987 | debian-bookworm | test: OK (13.38 seconds) 2025-11-09 14:55:20.768066 | debian-bookworm | congratulations :) (13.41 seconds) 2025-11-09 14:55:20.916293 | debian-bookworm | ok: Runtime: 0:00:13.653918 2025-11-09 14:55:20.929623 | 2025-11-09 14:55:20.929796 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-09 14:55:21.326031 | debian-bookworm | changed 2025-11-09 14:55:21.331352 | 2025-11-09 14:55:21.331457 | TASK [tox : Get tox envlist config] 2025-11-09 14:55:22.360515 | debian-bookworm | ok: Runtime: 0:00:00.290444 2025-11-09 14:55:22.373872 | 2025-11-09 14:55:22.374028 | TASK [tox : Install any sibling python packages] 2025-11-09 14:55:22.806941 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-09 14:55:22.815456 | 2025-11-09 14:55:22.815589 | TASK [tox : Remove tempfile] 2025-11-09 14:55:23.247282 | debian-bookworm | changed 2025-11-09 14:55:23.257074 | 2025-11-09 14:55:23.257220 | TASK [tox : Emit tox command] 2025-11-09 14:55:23.314998 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-09 14:55:23.323109 | 2025-11-09 14:55:23.323245 | TASK [tox : Run tox] 2025-11-09 14:55:23.913289 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-09 14:55:24.490454 | debian-bookworm | ............... 2025-11-09 14:55:24.490490 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-09 14:55:24.490504 | debian-bookworm | Ran 15 tests in 0.165s 2025-11-09 14:55:24.490509 | debian-bookworm | 2025-11-09 14:55:24.490515 | debian-bookworm | OK 2025-11-09 14:55:24.552416 | debian-bookworm | test: OK (0.68=setup[0.04]+cmd[0.64] seconds) 2025-11-09 14:55:24.552472 | debian-bookworm | congratulations :) (0.70 seconds) 2025-11-09 14:55:24.887847 | debian-bookworm | ok: Runtime: 0:00:00.948508 2025-11-09 14:55:24.898111 | 2025-11-09 14:55:24.898318 | TASK [tox : Look for output] 2025-11-09 14:55:25.292264 | debian-bookworm | ok 2025-11-09 14:55:25.317992 | 2025-11-09 14:55:25.318192 | TASK [tox : Return file comments to Zuul] 2025-11-09 14:55:25.354347 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:25.368019 | 2025-11-09 14:55:25.368157 | PLAY RECAP 2025-11-09 14:55:25.368244 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-09 14:55:25.368285 | 2025-11-09 14:55:25.499243 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-09 14:55:25.500386 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-09 14:55:26.201923 | 2025-11-09 14:55:26.202079 | PLAY [all] 2025-11-09 14:55:26.216928 | 2025-11-09 14:55:26.217058 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-09 14:55:26.282697 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:26.289420 | 2025-11-09 14:55:26.289569 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-09 14:55:26.329743 | debian-bookworm | ok 2025-11-09 14:55:26.335075 | 2025-11-09 14:55:26.335181 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-09 14:55:26.817320 | debian-bookworm -> localhost | changed 2025-11-09 14:55:26.825557 | 2025-11-09 14:55:26.825670 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-09 14:55:26.871833 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:26.879916 | 2025-11-09 14:55:26.880054 | TASK [fetch-tox-output : Set envlist fact] 2025-11-09 14:55:26.926882 | debian-bookworm | ok 2025-11-09 14:55:26.935918 | 2025-11-09 14:55:26.936047 | TASK [fetch-tox-output : Get tox version] 2025-11-09 14:55:27.623718 | 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-11-09 14:55:27.642053 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-09 14:55:27.968063 | debian-bookworm | ok: Runtime: 0:00:00.287186 2025-11-09 14:55:27.980620 | 2025-11-09 14:55:27.980813 | TASK [fetch-tox-output : Find all default environments] 2025-11-09 14:55:28.513814 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:28.520142 | 2025-11-09 14:55:28.520278 | TASK [fetch-tox-output : Set envlist fact] 2025-11-09 14:55:28.554630 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:28.561055 | 2025-11-09 14:55:28.561167 | TASK [fetch-tox-output : Find all default environments] 2025-11-09 14:55:29.090181 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:29.096577 | 2025-11-09 14:55:29.096739 | TASK [fetch-tox-output : Set envlist fact] 2025-11-09 14:55:29.131022 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:29.140638 | 2025-11-09 14:55:29.140840 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-09 14:55:29.201560 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:29.214927 | 2025-11-09 14:55:29.215075 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-09 14:55:29.986609 | debian-bookworm | changed: 2025-11-09 14:55:29.986947 | debian-bookworm | created directory /var/lib/zuul/builds/28ffec1070a142149c4249b88cf7b076/work/logs/tox/test 2025-11-09 14:55:29.987009 | debian-bookworm | cd+++++++++ ./ 2025-11-09 14:55:29.987053 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-09 14:55:29.987121 | 2025-11-09 14:55:30.000061 | 2025-11-09 14:55:30.000153 | PLAY RECAP 2025-11-09 14:55:30.000208 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-09 14:55:30.000233 | 2025-11-09 14:55:30.128681 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-09 14:55:30.129777 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-09 14:55:30.845105 | 2025-11-09 14:55:30.845255 | PLAY [all] 2025-11-09 14:55:30.861383 | 2025-11-09 14:55:30.861506 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-09 14:55:31.100054 | debian-bookworm | changed: non-zero return code 2025-11-09 14:55:31.108567 | 2025-11-09 14:55:31.108790 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-09 14:55:31.144164 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:31.158218 | 2025-11-09 14:55:31.159188 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-09 14:55:31.200631 | 2025-11-09 14:55:31.200968 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-09 14:55:31.250514 | 2025-11-09 14:55:31.250787 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-09 14:55:31.276629 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:31.289465 | 2025-11-09 14:55:31.289621 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-09 14:55:31.323580 | 2025-11-09 14:55:31.323857 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-09 14:55:31.348025 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:31.357382 | 2025-11-09 14:55:31.357566 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-09 14:55:31.381587 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:31.391934 | 2025-11-09 14:55:31.392078 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-09 14:55:31.419313 | debian-bookworm | skipping: Conditional result was False 2025-11-09 14:55:31.427274 | 2025-11-09 14:55:31.427435 | PLAY RECAP 2025-11-09 14:55:31.427573 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-09 14:55:31.427606 | 2025-11-09 14:55:31.574984 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-09 14:55:31.577766 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-09 14:55:32.344814 | 2025-11-09 14:55:32.344976 | PLAY [Base post] 2025-11-09 14:55:32.358644 | 2025-11-09 14:55:32.358795 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-09 14:55:32.917923 | debian-bookworm | changed 2025-11-09 14:55:32.926435 | 2025-11-09 14:55:32.926564 | PLAY RECAP 2025-11-09 14:55:32.926642 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-09 14:55:32.926734 | 2025-11-09 14:55:33.043119 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-09 14:55:33.045882 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-09 14:55:33.893119 | 2025-11-09 14:55:33.893327 | PLAY [Base post-logs] 2025-11-09 14:55:33.904431 | 2025-11-09 14:55:33.904570 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-09 14:55:34.387784 | localhost | changed 2025-11-09 14:55:34.399399 | 2025-11-09 14:55:34.399570 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-09 14:55:34.427502 | localhost | ok 2025-11-09 14:55:34.430936 | 2025-11-09 14:55:34.431037 | TASK [Set zuul-log-path fact] 2025-11-09 14:55:34.447618 | localhost | ok 2025-11-09 14:55:34.456888 | 2025-11-09 14:55:34.457016 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-09 14:55:34.483429 | localhost | ok 2025-11-09 14:55:34.487530 | 2025-11-09 14:55:34.487647 | TASK [upload-logs : Create log directories] 2025-11-09 14:55:35.002407 | localhost | changed 2025-11-09 14:55:35.008207 | 2025-11-09 14:55:35.008371 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-09 14:55:35.491468 | localhost -> localhost | ok: Runtime: 0:00:00.007732 2025-11-09 14:55:35.495735 | 2025-11-09 14:55:35.495847 | TASK [upload-logs : Upload logs to log server] 2025-11-09 14:55:36.048351 | localhost | Output suppressed because no_log was given 2025-11-09 14:55:36.050640 | 2025-11-09 14:55:36.050785 | LOOP [upload-logs : Compress console log and json output] 2025-11-09 14:55:36.110932 | localhost | skipping: Conditional result was False 2025-11-09 14:55:36.116059 | localhost | skipping: Conditional result was False 2025-11-09 14:55:36.123520 | 2025-11-09 14:55:36.123751 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-09 14:55:36.183476 | localhost | skipping: Conditional result was False 2025-11-09 14:55:36.184064 | 2025-11-09 14:55:36.187747 | localhost | skipping: Conditional result was False 2025-11-09 14:55:36.195847 | 2025-11-09 14:55:36.196079 | LOOP [upload-logs : Upload console log and json output]