2025-12-06 00:17:09.420855 | Job console starting 2025-12-06 00:17:09.450077 | Updating git repos 2025-12-06 00:17:09.477528 | Cloning repos into workspace 2025-12-06 00:17:09.548365 | Restoring repo states 2025-12-06 00:17:09.576431 | Merging changes 2025-12-06 00:17:10.072075 | Checking out repos 2025-12-06 00:17:10.148882 | Preparing playbooks 2025-12-06 00:17:11.073026 | Running Ansible setup 2025-12-06 00:17:16.414229 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-06 00:17:17.376382 | 2025-12-06 00:17:17.376564 | PLAY [Base pre] 2025-12-06 00:17:17.395964 | 2025-12-06 00:17:17.396127 | TASK [Setup log path fact] 2025-12-06 00:17:17.416461 | debian-bookworm | ok 2025-12-06 00:17:17.433782 | 2025-12-06 00:17:17.433953 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-06 00:17:17.465397 | debian-bookworm | ok 2025-12-06 00:17:17.478067 | 2025-12-06 00:17:17.478208 | TASK [emit-job-header : Print job information] 2025-12-06 00:17:17.517953 | # Job Information 2025-12-06 00:17:17.518212 | Ansible Version: 2.16.14 2025-12-06 00:17:17.518275 | Job: tox 2025-12-06 00:17:17.518348 | Pipeline: check 2025-12-06 00:17:17.518374 | Executor: 521e9411259a 2025-12-06 00:17:17.518396 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1019 2025-12-06 00:17:17.518419 | Event ID: e1cc0090-d238-11f0-955b-0ea56643bccc 2025-12-06 00:17:17.523750 | 2025-12-06 00:17:17.523903 | LOOP [emit-job-header : Print node information] 2025-12-06 00:17:17.699242 | debian-bookworm | ok: 2025-12-06 00:17:17.699586 | debian-bookworm | # Node Information 2025-12-06 00:17:17.699630 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-06 00:17:17.699656 | debian-bookworm | Hostname: debian 2025-12-06 00:17:17.699678 | debian-bookworm | Username: zuul 2025-12-06 00:17:17.699699 | debian-bookworm | Distro: Debian 12.12 2025-12-06 00:17:17.699723 | debian-bookworm | Provider: regiocloud-a 2025-12-06 00:17:17.699744 | debian-bookworm | Region: 2025-12-06 00:17:17.699797 | debian-bookworm | Label: debian-bookworm 2025-12-06 00:17:17.699818 | debian-bookworm | Product Name: OpenStack Nova 2025-12-06 00:17:17.699838 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed7:c342 2025-12-06 00:17:17.724701 | 2025-12-06 00:17:17.724874 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-06 00:17:18.423469 | debian-bookworm -> localhost | changed 2025-12-06 00:17:18.431242 | 2025-12-06 00:17:18.431382 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-06 00:17:20.109847 | debian-bookworm -> localhost | changed 2025-12-06 00:17:20.122748 | 2025-12-06 00:17:20.122966 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-06 00:17:20.619860 | debian-bookworm -> localhost | ok 2025-12-06 00:17:20.626293 | 2025-12-06 00:17:20.626415 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-06 00:17:20.667115 | debian-bookworm | ok 2025-12-06 00:17:20.686376 | debian-bookworm | included: /var/lib/zuul/builds/1964c5774e174bd1a514a64b4f29225a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-06 00:17:20.692924 | 2025-12-06 00:17:20.693040 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-06 00:17:22.325187 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-06 00:17:22.325463 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1964c5774e174bd1a514a64b4f29225a/work/1964c5774e174bd1a514a64b4f29225a_id_rsa 2025-12-06 00:17:22.325506 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1964c5774e174bd1a514a64b4f29225a/work/1964c5774e174bd1a514a64b4f29225a_id_rsa.pub 2025-12-06 00:17:22.325531 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-06 00:17:22.325557 | debian-bookworm -> localhost | SHA256:tQX2CL0GZ3ZUzAPlyfTIEhHxaK8DwYBYasLa59OfDw0 zuul-build-sshkey 2025-12-06 00:17:22.325580 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-06 00:17:22.325614 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-06 00:17:22.325636 | debian-bookworm -> localhost | | o..o.o.BX+ | 2025-12-06 00:17:22.325657 | debian-bookworm -> localhost | | . ... .==+.O++ | 2025-12-06 00:17:22.325676 | debian-bookworm -> localhost | | o o ==o* B..| 2025-12-06 00:17:22.325695 | debian-bookworm -> localhost | | o o .o= o | 2025-12-06 00:17:22.325714 | debian-bookworm -> localhost | |. . . E.o . | 2025-12-06 00:17:22.325736 | debian-bookworm -> localhost | | o . o . . | 2025-12-06 00:17:22.325776 | debian-bookworm -> localhost | | o . . . o | 2025-12-06 00:17:22.325797 | debian-bookworm -> localhost | | . . o . | 2025-12-06 00:17:22.325818 | debian-bookworm -> localhost | | o.. | 2025-12-06 00:17:22.325837 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-06 00:17:22.325887 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.607203 2025-12-06 00:17:22.335942 | 2025-12-06 00:17:22.336136 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-06 00:17:22.369860 | debian-bookworm | ok 2025-12-06 00:17:22.383995 | debian-bookworm | included: /var/lib/zuul/builds/1964c5774e174bd1a514a64b4f29225a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-06 00:17:22.396054 | 2025-12-06 00:17:22.396203 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-06 00:17:22.420674 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:17:22.427481 | 2025-12-06 00:17:22.427618 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-06 00:17:23.164544 | debian-bookworm | changed 2025-12-06 00:17:23.171159 | 2025-12-06 00:17:23.171295 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-06 00:17:23.469247 | debian-bookworm | ok 2025-12-06 00:17:23.475540 | 2025-12-06 00:17:23.475661 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-06 00:17:24.150608 | debian-bookworm | changed 2025-12-06 00:17:24.163022 | 2025-12-06 00:17:24.163166 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-06 00:17:24.817820 | debian-bookworm | changed 2025-12-06 00:17:24.824917 | 2025-12-06 00:17:24.834999 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-06 00:17:24.880318 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:17:24.886991 | 2025-12-06 00:17:24.887113 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-06 00:17:25.396685 | debian-bookworm -> localhost | changed 2025-12-06 00:17:25.408685 | 2025-12-06 00:17:25.408849 | TASK [add-build-sshkey : Add back temp key] 2025-12-06 00:17:25.839213 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1964c5774e174bd1a514a64b4f29225a/work/1964c5774e174bd1a514a64b4f29225a_id_rsa (zuul-build-sshkey) 2025-12-06 00:17:25.839546 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011995 2025-12-06 00:17:25.850441 | 2025-12-06 00:17:25.850590 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-06 00:17:26.289649 | debian-bookworm | ok 2025-12-06 00:17:26.301368 | 2025-12-06 00:17:26.301530 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-06 00:17:26.326664 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:17:26.338626 | 2025-12-06 00:17:26.338791 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-06 00:17:26.819823 | debian-bookworm | ok 2025-12-06 00:17:26.836267 | 2025-12-06 00:17:26.836423 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-06 00:17:26.866419 | debian-bookworm | ok 2025-12-06 00:17:26.871749 | 2025-12-06 00:17:26.871916 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-06 00:17:27.201565 | debian-bookworm -> localhost | ok 2025-12-06 00:17:27.208861 | 2025-12-06 00:17:27.208992 | TASK [validate-host : Collect information about the host] 2025-12-06 00:17:28.428970 | debian-bookworm | ok 2025-12-06 00:17:28.439838 | 2025-12-06 00:17:28.440000 | TASK [validate-host : Sanitize hostname] 2025-12-06 00:17:28.572913 | debian-bookworm | ok 2025-12-06 00:17:28.620575 | 2025-12-06 00:17:28.620721 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-06 00:17:29.532989 | debian-bookworm -> localhost | changed 2025-12-06 00:17:29.571047 | 2025-12-06 00:17:29.571206 | TASK [validate-host : Collect information about zuul worker] 2025-12-06 00:17:30.249662 | debian-bookworm | ok 2025-12-06 00:17:30.256301 | 2025-12-06 00:17:30.256448 | TASK [validate-host : Write out all zuul information for each host] 2025-12-06 00:17:30.887282 | debian-bookworm -> localhost | changed 2025-12-06 00:17:30.899618 | 2025-12-06 00:17:30.899815 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-06 00:17:31.217182 | debian-bookworm | ok 2025-12-06 00:17:31.223806 | 2025-12-06 00:17:31.223935 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-06 00:17:32.331325 | debian-bookworm | changed: 2025-12-06 00:17:32.331611 | debian-bookworm | cd+++++++++ src/ 2025-12-06 00:17:32.331659 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-06 00:17:32.331691 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-06 00:17:32.331719 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-06 00:17:32.331745 | debian-bookworm | =6.2 2025-12-06 00:17:57.030120 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-12-06 00:17:57.066551 | debian-bookworm | Collecting chardet>=5.2 2025-12-06 00:17:57.079146 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-06 00:17:57.097770 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 12.8 MB/s eta 0:00:00 2025-12-06 00:17:57.152736 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-06 00:17:57.165186 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-06 00:17:57.225509 | debian-bookworm | Collecting filelock>=3.20 2025-12-06 00:17:57.237509 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-12-06 00:17:57.288214 | debian-bookworm | Collecting packaging>=25 2025-12-06 00:17:57.300311 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-06 00:17:57.310319 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.2 MB/s eta 0:00:00 2025-12-06 00:17:57.370700 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-06 00:17:57.383328 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-06 00:17:57.442402 | debian-bookworm | Collecting pluggy>=1.6 2025-12-06 00:17:57.454515 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-06 00:17:57.500969 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-06 00:17:57.513862 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-06 00:17:57.650358 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-06 00:17:57.662524 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-06 00:17:57.944486 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 21.6 MB/s eta 0:00:00 2025-12-06 00:17:58.050640 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-06 00:17:58.062676 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-06 00:17:58.104327 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 13.1 MB/s eta 0:00:00 2025-12-06 00:17:58.272559 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-06 00:17:59.203536 | 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-06 00:17:59.829621 | debian-bookworm | ok: Runtime: 0:00:03.195147 2025-12-06 00:17:59.836272 | 2025-12-06 00:17:59.836400 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-06 00:17:59.912554 | debian-bookworm | ok 2025-12-06 00:17:59.918332 | 2025-12-06 00:17:59.918456 | TASK [ensure-tox : Output tox version] 2025-12-06 00:18:00.480851 | 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-06 00:18:00.501391 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-06 00:18:00.950909 | debian-bookworm | ok: Runtime: 0:00:00.331849 2025-12-06 00:18:00.958919 | 2025-12-06 00:18:00.959058 | TASK [ensure-tox : Make global symlink] 2025-12-06 00:18:00.993885 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:01.011593 | 2025-12-06 00:18:01.011776 | PLAY RECAP 2025-12-06 00:18:01.011872 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-06 00:18:01.011915 | 2025-12-06 00:18:01.168084 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-06 00:18:01.171357 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-06 00:18:01.958512 | 2025-12-06 00:18:01.958686 | PLAY [all] 2025-12-06 00:18:01.974827 | 2025-12-06 00:18:01.975047 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-06 00:18:02.465232 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-06 00:18:02.521122 | debian-bookworm | ok: Runtime: 0:00:00.023019 2025-12-06 00:18:02.528193 | 2025-12-06 00:18:02.528348 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-06 00:18:03.072962 | debian-bookworm | ok: Runtime: 0:00:00.006221 2025-12-06 00:18:03.080332 | 2025-12-06 00:18:03.080489 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-06 00:18:03.407069 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-06 00:18:03.410126 | debian-bookworm | sudo: a password is required 2025-12-06 00:18:03.613398 | debian-bookworm | ok: Runtime: 0:00:00.023640 2025-12-06 00:18:03.629071 | 2025-12-06 00:18:03.629204 | TASK [tox : Check to see if the constraints file exists] 2025-12-06 00:18:03.665448 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:03.673081 | 2025-12-06 00:18:03.673214 | TASK [tox : Fail if constraints file is missing] 2025-12-06 00:18:03.718477 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:03.730425 | 2025-12-06 00:18:03.730589 | TASK [tox : Record file location] 2025-12-06 00:18:03.766164 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:03.779954 | 2025-12-06 00:18:03.780256 | TASK [tox : Install tox siblings] 2025-12-06 00:18:03.818425 | debian-bookworm | ok 2025-12-06 00:18:03.838489 | debian-bookworm | included: /var/lib/zuul/builds/1964c5774e174bd1a514a64b4f29225a/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-06 00:18:03.847211 | 2025-12-06 00:18:03.847660 | TASK [tox : Run tox without tests] 2025-12-06 00:18:05.039859 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-06 00:18:19.596911 | debian-bookworm | test: OK (15.15 seconds) 2025-12-06 00:18:19.596989 | debian-bookworm | congratulations :) (15.18 seconds) 2025-12-06 00:18:19.915460 | debian-bookworm | ok: Runtime: 0:00:15.466804 2025-12-06 00:18:19.929817 | 2025-12-06 00:18:19.929992 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-06 00:18:20.348149 | debian-bookworm | changed 2025-12-06 00:18:20.356946 | 2025-12-06 00:18:20.357093 | TASK [tox : Get tox envlist config] 2025-12-06 00:18:21.393729 | debian-bookworm | ok: Runtime: 0:00:00.343847 2025-12-06 00:18:21.400108 | 2025-12-06 00:18:21.400242 | TASK [tox : Install any sibling python packages] 2025-12-06 00:18:21.866024 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-06 00:18:21.874930 | 2025-12-06 00:18:21.875140 | TASK [tox : Remove tempfile] 2025-12-06 00:18:22.302459 | debian-bookworm | changed 2025-12-06 00:18:22.312071 | 2025-12-06 00:18:22.312241 | TASK [tox : Emit tox command] 2025-12-06 00:18:22.367027 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-06 00:18:22.375499 | 2025-12-06 00:18:22.375672 | TASK [tox : Run tox] 2025-12-06 00:18:23.019645 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-06 00:18:23.658394 | debian-bookworm | ............... 2025-12-06 00:18:23.658445 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-06 00:18:23.658461 | debian-bookworm | Ran 15 tests in 0.171s 2025-12-06 00:18:23.658466 | debian-bookworm | 2025-12-06 00:18:23.658473 | debian-bookworm | OK 2025-12-06 00:18:23.747014 | debian-bookworm | test: OK (0.77=setup[0.05]+cmd[0.72] seconds) 2025-12-06 00:18:23.747138 | debian-bookworm | congratulations :) (0.80 seconds) 2025-12-06 00:18:23.951672 | debian-bookworm | ok: Runtime: 0:00:01.098566 2025-12-06 00:18:23.961106 | 2025-12-06 00:18:23.961256 | TASK [tox : Look for output] 2025-12-06 00:18:24.375745 | debian-bookworm | ok 2025-12-06 00:18:24.394199 | 2025-12-06 00:18:24.394370 | TASK [tox : Return file comments to Zuul] 2025-12-06 00:18:24.430789 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:24.440442 | 2025-12-06 00:18:24.440565 | PLAY RECAP 2025-12-06 00:18:24.440634 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-06 00:18:24.440680 | 2025-12-06 00:18:24.582782 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-06 00:18:24.583988 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-06 00:18:25.333703 | 2025-12-06 00:18:25.333942 | PLAY [all] 2025-12-06 00:18:25.350121 | 2025-12-06 00:18:25.350269 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-06 00:18:25.406282 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:25.416142 | 2025-12-06 00:18:25.416401 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-06 00:18:25.462552 | debian-bookworm | ok 2025-12-06 00:18:25.470293 | 2025-12-06 00:18:25.470436 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-06 00:18:26.013667 | debian-bookworm -> localhost | changed 2025-12-06 00:18:26.026430 | 2025-12-06 00:18:26.026571 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-06 00:18:26.081978 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:26.096294 | 2025-12-06 00:18:26.096485 | TASK [fetch-tox-output : Set envlist fact] 2025-12-06 00:18:26.143948 | debian-bookworm | ok 2025-12-06 00:18:26.153441 | 2025-12-06 00:18:26.153606 | TASK [fetch-tox-output : Get tox version] 2025-12-06 00:18:26.978973 | 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-06 00:18:26.998531 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-06 00:18:27.187100 | debian-bookworm | ok: Runtime: 0:00:00.412967 2025-12-06 00:18:27.193047 | 2025-12-06 00:18:27.193168 | TASK [fetch-tox-output : Find all default environments] 2025-12-06 00:18:27.727613 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:27.741387 | 2025-12-06 00:18:27.741610 | TASK [fetch-tox-output : Set envlist fact] 2025-12-06 00:18:27.788113 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:27.802375 | 2025-12-06 00:18:27.802598 | TASK [fetch-tox-output : Find all default environments] 2025-12-06 00:18:28.339687 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:28.355925 | 2025-12-06 00:18:28.356153 | TASK [fetch-tox-output : Set envlist fact] 2025-12-06 00:18:28.392181 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:28.407578 | 2025-12-06 00:18:28.407825 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-06 00:18:28.467060 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:28.488382 | 2025-12-06 00:18:28.488573 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-06 00:18:29.351967 | debian-bookworm | changed: 2025-12-06 00:18:29.352200 | debian-bookworm | created directory /var/lib/zuul/builds/1964c5774e174bd1a514a64b4f29225a/work/logs/tox/test 2025-12-06 00:18:29.352242 | debian-bookworm | cd+++++++++ ./ 2025-12-06 00:18:29.352269 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-06 00:18:29.352303 | 2025-12-06 00:18:29.376660 | 2025-12-06 00:18:29.376881 | PLAY RECAP 2025-12-06 00:18:29.377002 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-06 00:18:29.377060 | 2025-12-06 00:18:29.522411 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-06 00:18:29.525354 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-06 00:18:30.438775 | 2025-12-06 00:18:30.438969 | PLAY [all] 2025-12-06 00:18:30.455204 | 2025-12-06 00:18:30.455360 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-06 00:18:30.685921 | debian-bookworm | changed: non-zero return code 2025-12-06 00:18:30.695929 | 2025-12-06 00:18:30.696165 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-06 00:18:30.732620 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:30.746062 | 2025-12-06 00:18:30.746262 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-06 00:18:30.785095 | 2025-12-06 00:18:30.785403 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-06 00:18:30.826426 | 2025-12-06 00:18:30.826724 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-06 00:18:30.853127 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:30.866327 | 2025-12-06 00:18:30.866506 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-06 00:18:30.906260 | 2025-12-06 00:18:30.906665 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-06 00:18:30.943683 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:30.961840 | 2025-12-06 00:18:30.962020 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-06 00:18:30.986857 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:30.995043 | 2025-12-06 00:18:30.995241 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-06 00:18:31.020951 | debian-bookworm | skipping: Conditional result was False 2025-12-06 00:18:31.028025 | 2025-12-06 00:18:31.028117 | PLAY RECAP 2025-12-06 00:18:31.028168 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-06 00:18:31.028194 | 2025-12-06 00:18:31.195575 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-06 00:18:31.196915 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-06 00:18:32.029284 | 2025-12-06 00:18:32.029478 | PLAY [Base post] 2025-12-06 00:18:32.044564 | 2025-12-06 00:18:32.044735 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-06 00:18:32.855457 | debian-bookworm | changed 2025-12-06 00:18:32.866282 | 2025-12-06 00:18:32.866478 | PLAY RECAP 2025-12-06 00:18:32.866589 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-06 00:18:32.866682 | 2025-12-06 00:18:33.021120 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-06 00:18:33.023062 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-06 00:18:33.856121 | 2025-12-06 00:18:33.856313 | PLAY [Base post-logs] 2025-12-06 00:18:33.867627 | 2025-12-06 00:18:33.867831 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-06 00:18:34.364956 | localhost | changed 2025-12-06 00:18:34.387202 | 2025-12-06 00:18:34.387453 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-06 00:18:34.417998 | localhost | ok 2025-12-06 00:18:34.426268 | 2025-12-06 00:18:34.426459 | TASK [Set zuul-log-path fact] 2025-12-06 00:18:34.456124 | localhost | ok 2025-12-06 00:18:34.473673 | 2025-12-06 00:18:34.473911 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-06 00:18:34.513529 | localhost | ok 2025-12-06 00:18:34.523046 | 2025-12-06 00:18:34.523352 | TASK [upload-logs : Create log directories] 2025-12-06 00:18:35.055553 | localhost | changed 2025-12-06 00:18:35.061464 | 2025-12-06 00:18:35.061687 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-06 00:18:35.598364 | localhost -> localhost | ok: Runtime: 0:00:00.006825 2025-12-06 00:18:35.610084 | 2025-12-06 00:18:35.610310 | TASK [upload-logs : Upload logs to log server] 2025-12-06 00:18:36.215566 | localhost | Output suppressed because no_log was given 2025-12-06 00:18:36.217492 | 2025-12-06 00:18:36.217602 | LOOP [upload-logs : Compress console log and json output] 2025-12-06 00:18:36.274324 | localhost | skipping: Conditional result was False 2025-12-06 00:18:36.279476 | localhost | skipping: Conditional result was False 2025-12-06 00:18:36.293065 | 2025-12-06 00:18:36.293348 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-06 00:18:36.342902 | localhost | skipping: Conditional result was False 2025-12-06 00:18:36.343484 | 2025-12-06 00:18:36.347387 | localhost | skipping: Conditional result was False 2025-12-06 00:18:36.356133 | 2025-12-06 00:18:36.356564 | LOOP [upload-logs : Upload console log and json output]