2025-09-16 03:17:41.388692 | Job console starting 2025-09-16 03:17:41.397124 | Updating git repos 2025-09-16 03:17:41.413837 | Cloning repos into workspace 2025-09-16 03:17:41.528236 | Restoring repo states 2025-09-16 03:17:41.547322 | Merging changes 2025-09-16 03:17:41.547335 | Checking out repos 2025-09-16 03:17:41.609832 | Preparing playbooks 2025-09-16 03:17:42.780753 | Running Ansible setup 2025-09-16 03:17:48.801832 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-16 03:17:49.597268 | 2025-09-16 03:17:49.597385 | PLAY [Base pre] 2025-09-16 03:17:49.626914 | 2025-09-16 03:17:49.627021 | TASK [Setup log path fact] 2025-09-16 03:17:49.653701 | debian-bookworm | ok 2025-09-16 03:17:49.673824 | 2025-09-16 03:17:49.673935 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-16 03:17:49.703609 | debian-bookworm | ok 2025-09-16 03:17:49.720377 | 2025-09-16 03:17:49.720482 | TASK [emit-job-header : Print job information] 2025-09-16 03:17:49.757376 | # Job Information 2025-09-16 03:17:49.757517 | Ansible Version: 2.16.14 2025-09-16 03:17:49.757545 | Job: tox 2025-09-16 03:17:49.757572 | Pipeline: periodic-daily 2025-09-16 03:17:49.757590 | Executor: 521e9411259a 2025-09-16 03:17:49.757607 | Triggered by: https://github.com/osism/openstack-image-manager 2025-09-16 03:17:49.757624 | Event ID: 794d14bb9da24a6e86b26ec269b1a7e7 2025-09-16 03:17:49.761640 | 2025-09-16 03:17:49.761721 | LOOP [emit-job-header : Print node information] 2025-09-16 03:17:49.921089 | debian-bookworm | ok: 2025-09-16 03:17:49.921277 | debian-bookworm | # Node Information 2025-09-16 03:17:49.921309 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-16 03:17:49.921330 | debian-bookworm | Hostname: debian 2025-09-16 03:17:49.921348 | debian-bookworm | Username: zuul 2025-09-16 03:17:49.921365 | debian-bookworm | Distro: Debian 12.12 2025-09-16 03:17:49.921418 | debian-bookworm | Provider: regiocloud-a 2025-09-16 03:17:49.925348 | debian-bookworm | Region: 2025-09-16 03:17:49.925380 | debian-bookworm | Label: debian-bookworm 2025-09-16 03:17:49.925400 | debian-bookworm | Product Name: OpenStack Nova 2025-09-16 03:17:49.925418 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9a:3669 2025-09-16 03:17:49.938020 | 2025-09-16 03:17:49.938112 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-16 03:17:50.681405 | debian-bookworm -> localhost | changed 2025-09-16 03:17:50.687102 | 2025-09-16 03:17:50.687190 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-16 03:17:51.682440 | debian-bookworm -> localhost | changed 2025-09-16 03:17:51.695723 | 2025-09-16 03:17:51.695838 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-16 03:17:52.022117 | debian-bookworm -> localhost | ok 2025-09-16 03:17:52.028199 | 2025-09-16 03:17:52.028300 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-16 03:17:52.046607 | debian-bookworm | ok 2025-09-16 03:17:52.065867 | debian-bookworm | included: /var/lib/zuul/builds/91026ed84ed54e9abf6d547476afa54c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-16 03:17:52.071726 | 2025-09-16 03:17:52.071845 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-16 03:17:53.077478 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-16 03:17:53.077646 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/91026ed84ed54e9abf6d547476afa54c/work/91026ed84ed54e9abf6d547476afa54c_id_rsa 2025-09-16 03:17:53.077678 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/91026ed84ed54e9abf6d547476afa54c/work/91026ed84ed54e9abf6d547476afa54c_id_rsa.pub 2025-09-16 03:17:53.077700 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-16 03:17:53.077720 | debian-bookworm -> localhost | SHA256:qHGl4qFQ54yjY6Jk6hUszJkVkCxm10fxc4pJ+ao7Elk zuul-build-sshkey 2025-09-16 03:17:53.077739 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-16 03:17:53.077776 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-16 03:17:53.077795 | debian-bookworm -> localhost | |..o.. .o. | 2025-09-16 03:17:53.077813 | debian-bookworm -> localhost | |.= ... .o | 2025-09-16 03:17:53.077830 | debian-bookworm -> localhost | |+ o.. .o.o . | 2025-09-16 03:17:53.077846 | debian-bookworm -> localhost | |o.== E.++ + | 2025-09-16 03:17:53.077862 | debian-bookworm -> localhost | |.*ooO +oSo | 2025-09-16 03:17:53.077882 | debian-bookworm -> localhost | | o.*.* . | 2025-09-16 03:17:53.077899 | debian-bookworm -> localhost | |++..+ . | 2025-09-16 03:17:53.077915 | debian-bookworm -> localhost | |B... .. | 2025-09-16 03:17:53.077933 | debian-bookworm -> localhost | |+. .oo | 2025-09-16 03:17:53.077949 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-16 03:17:53.077988 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.475078 2025-09-16 03:17:53.083190 | 2025-09-16 03:17:53.083276 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-16 03:17:53.119605 | debian-bookworm | ok 2025-09-16 03:17:53.127019 | debian-bookworm | included: /var/lib/zuul/builds/91026ed84ed54e9abf6d547476afa54c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-16 03:17:53.144707 | 2025-09-16 03:17:53.144808 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-16 03:17:53.202047 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:17:53.206889 | 2025-09-16 03:17:53.206968 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-16 03:17:53.889763 | debian-bookworm | changed 2025-09-16 03:17:53.895719 | 2025-09-16 03:17:53.895828 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-16 03:17:54.155267 | debian-bookworm | ok 2025-09-16 03:17:54.161214 | 2025-09-16 03:17:54.161305 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-16 03:17:54.791028 | debian-bookworm | changed 2025-09-16 03:17:54.800087 | 2025-09-16 03:17:54.800186 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-16 03:17:55.499518 | debian-bookworm | changed 2025-09-16 03:17:55.509799 | 2025-09-16 03:17:55.510144 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-16 03:17:55.545357 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:17:55.551494 | 2025-09-16 03:17:55.551586 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-16 03:17:56.496444 | debian-bookworm -> localhost | changed 2025-09-16 03:17:56.519158 | 2025-09-16 03:17:56.519251 | TASK [add-build-sshkey : Add back temp key] 2025-09-16 03:17:57.383201 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/91026ed84ed54e9abf6d547476afa54c/work/91026ed84ed54e9abf6d547476afa54c_id_rsa (zuul-build-sshkey) 2025-09-16 03:17:57.383389 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.035710 2025-09-16 03:17:57.390139 | 2025-09-16 03:17:57.390215 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-16 03:17:57.827231 | debian-bookworm | ok 2025-09-16 03:17:57.838918 | 2025-09-16 03:17:57.839005 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-16 03:17:57.871565 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:17:57.882719 | 2025-09-16 03:17:57.882828 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-16 03:17:58.448850 | debian-bookworm | ok 2025-09-16 03:17:58.457580 | 2025-09-16 03:17:58.457663 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-16 03:17:58.486558 | debian-bookworm | ok 2025-09-16 03:17:58.490627 | 2025-09-16 03:17:58.490695 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-16 03:17:59.112863 | debian-bookworm -> localhost | ok 2025-09-16 03:17:59.119007 | 2025-09-16 03:17:59.119100 | TASK [validate-host : Collect information about the host] 2025-09-16 03:18:00.756860 | debian-bookworm | ok 2025-09-16 03:18:00.807775 | 2025-09-16 03:18:00.807886 | TASK [validate-host : Sanitize hostname] 2025-09-16 03:18:00.987399 | debian-bookworm | ok 2025-09-16 03:18:01.057029 | 2025-09-16 03:18:01.057128 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-16 03:18:01.680069 | debian-bookworm -> localhost | changed 2025-09-16 03:18:01.690688 | 2025-09-16 03:18:01.690781 | TASK [validate-host : Collect information about zuul worker] 2025-09-16 03:18:02.166557 | debian-bookworm | ok 2025-09-16 03:18:02.171613 | 2025-09-16 03:18:02.171876 | TASK [validate-host : Write out all zuul information for each host] 2025-09-16 03:18:03.107639 | debian-bookworm -> localhost | changed 2025-09-16 03:18:03.115383 | 2025-09-16 03:18:03.115464 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-16 03:18:03.414105 | debian-bookworm | ok 2025-09-16 03:18:03.418697 | 2025-09-16 03:18:03.418790 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-16 03:18:04.328036 | debian-bookworm | changed: 2025-09-16 03:18:04.328194 | debian-bookworm | cd+++++++++ src/ 2025-09-16 03:18:04.328222 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-16 03:18:04.328242 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-16 03:18:04.328260 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-09-16 03:18:04.328277 | debian-bookworm | =6.1 2025-09-16 03:18:28.058491 | debian-bookworm | Downloading cachetools-6.2.0-py3-none-any.whl (11 kB) 2025-09-16 03:18:28.090687 | debian-bookworm | Collecting chardet>=5.2 2025-09-16 03:18:28.098440 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-09-16 03:18:28.120161 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 12.3 MB/s eta 0:00:00 2025-09-16 03:18:28.176858 | debian-bookworm | Collecting colorama>=0.4.6 2025-09-16 03:18:28.184796 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-09-16 03:18:28.235386 | debian-bookworm | Collecting filelock>=3.18 2025-09-16 03:18:28.242949 | debian-bookworm | Downloading filelock-3.19.1-py3-none-any.whl (15 kB) 2025-09-16 03:18:28.317327 | debian-bookworm | Collecting packaging>=25 2025-09-16 03:18:28.324878 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-09-16 03:18:28.335176 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.5 MB/s eta 0:00:00 2025-09-16 03:18:28.392513 | debian-bookworm | Collecting platformdirs>=4.3.8 2025-09-16 03:18:28.400490 | debian-bookworm | Downloading platformdirs-4.4.0-py3-none-any.whl (18 kB) 2025-09-16 03:18:28.439983 | debian-bookworm | Collecting pluggy>=1.6 2025-09-16 03:18:28.447875 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-09-16 03:18:28.511362 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-09-16 03:18:28.519507 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-09-16 03:18:28.718884 | debian-bookworm | Collecting virtualenv>=20.31.2 2025-09-16 03:18:28.727333 | debian-bookworm | Downloading virtualenv-20.34.0-py3-none-any.whl (6.0 MB) 2025-09-16 03:18:28.977612 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 24.4 MB/s eta 0:00:00 2025-09-16 03:18:29.080694 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-09-16 03:18:29.088470 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-09-16 03:18:29.115723 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.9 MB/s eta 0:00:00 2025-09-16 03:18:29.274560 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-09-16 03:18:30.252278 | debian-bookworm | Successfully installed cachetools-6.2.0 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.19.1 packaging-25.0 platformdirs-4.4.0 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.30.2 virtualenv-20.34.0 2025-09-16 03:18:30.516984 | debian-bookworm | ok: Runtime: 0:00:03.162587 2025-09-16 03:18:30.522377 | 2025-09-16 03:18:30.522465 | TASK [ensure-tox : Export installed tox_executable path] 2025-09-16 03:18:30.582404 | debian-bookworm | ok 2025-09-16 03:18:30.589380 | 2025-09-16 03:18:30.589488 | TASK [ensure-tox : Output tox version] 2025-09-16 03:18:31.230951 | 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-09-16 03:18:31.251977 | debian-bookworm | 4.30.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-09-16 03:18:31.660900 | debian-bookworm | ok: Runtime: 0:00:00.351603 2025-09-16 03:18:31.666375 | 2025-09-16 03:18:31.666471 | TASK [ensure-tox : Make global symlink] 2025-09-16 03:18:31.710023 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:31.717455 | 2025-09-16 03:18:31.717556 | PLAY RECAP 2025-09-16 03:18:31.717612 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-09-16 03:18:31.717637 | 2025-09-16 03:18:31.961931 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-09-16 03:18:31.965690 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-09-16 03:18:33.033643 | 2025-09-16 03:18:33.033913 | PLAY [all] 2025-09-16 03:18:33.051527 | 2025-09-16 03:18:33.051673 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-09-16 03:18:33.513982 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-09-16 03:18:33.585279 | debian-bookworm | ok: Runtime: 0:00:00.032124 2025-09-16 03:18:33.600124 | 2025-09-16 03:18:33.600333 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-09-16 03:18:34.134948 | debian-bookworm | ok: Runtime: 0:00:00.006680 2025-09-16 03:18:34.141932 | 2025-09-16 03:18:34.142056 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-09-16 03:18:34.447041 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-09-16 03:18:34.448337 | debian-bookworm | sudo: a password is required 2025-09-16 03:18:34.674387 | debian-bookworm | ok: Runtime: 0:00:00.021447 2025-09-16 03:18:34.700373 | 2025-09-16 03:18:34.700527 | TASK [tox : Check to see if the constraints file exists] 2025-09-16 03:18:34.743473 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:34.754192 | 2025-09-16 03:18:34.754444 | TASK [tox : Fail if constraints file is missing] 2025-09-16 03:18:34.795547 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:34.802056 | 2025-09-16 03:18:34.802188 | TASK [tox : Record file location] 2025-09-16 03:18:34.846206 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:34.853770 | 2025-09-16 03:18:34.853911 | TASK [tox : Install tox siblings] 2025-09-16 03:18:34.899704 | debian-bookworm | ok 2025-09-16 03:18:34.910077 | debian-bookworm | included: /var/lib/zuul/builds/91026ed84ed54e9abf6d547476afa54c/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-09-16 03:18:34.915910 | 2025-09-16 03:18:34.916019 | TASK [tox : Run tox without tests] 2025-09-16 03:18:35.879147 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-09-16 03:18:47.398535 | debian-bookworm | test: OK (11.96 seconds) 2025-09-16 03:18:47.398655 | debian-bookworm | congratulations :) (11.99 seconds) 2025-09-16 03:18:47.479219 | debian-bookworm | ok: Runtime: 0:00:12.247713 2025-09-16 03:18:47.486370 | 2025-09-16 03:18:47.486484 | TASK [tox : Create a tempfile to save tox showconfig] 2025-09-16 03:18:47.879222 | debian-bookworm | changed 2025-09-16 03:18:47.884689 | 2025-09-16 03:18:47.884811 | TASK [tox : Get tox envlist config] 2025-09-16 03:18:48.928392 | debian-bookworm | ok: Runtime: 0:00:00.290540 2025-09-16 03:18:48.934493 | 2025-09-16 03:18:48.934609 | TASK [tox : Install any sibling python packages] 2025-09-16 03:18:49.379412 | debian-bookworm | ok: No setup.cfg, no action needed 2025-09-16 03:18:49.387952 | 2025-09-16 03:18:49.388092 | TASK [tox : Remove tempfile] 2025-09-16 03:18:49.787045 | debian-bookworm | changed 2025-09-16 03:18:49.796281 | 2025-09-16 03:18:49.796422 | TASK [tox : Emit tox command] 2025-09-16 03:18:49.845460 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-09-16 03:18:49.850930 | 2025-09-16 03:18:49.851045 | TASK [tox : Run tox] 2025-09-16 03:18:50.398937 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-09-16 03:18:51.023395 | debian-bookworm | ............... 2025-09-16 03:18:51.023437 | debian-bookworm | ---------------------------------------------------------------------- 2025-09-16 03:18:51.023452 | debian-bookworm | Ran 15 tests in 0.173s 2025-09-16 03:18:51.023457 | debian-bookworm | 2025-09-16 03:18:51.023464 | debian-bookworm | OK 2025-09-16 03:18:51.085101 | debian-bookworm | test: OK (0.72=setup[0.04]+cmd[0.68] seconds) 2025-09-16 03:18:51.085160 | debian-bookworm | congratulations :) (0.75 seconds) 2025-09-16 03:18:51.416199 | debian-bookworm | ok: Runtime: 0:00:00.990286 2025-09-16 03:18:51.422070 | 2025-09-16 03:18:51.422278 | TASK [tox : Look for output] 2025-09-16 03:18:51.823014 | debian-bookworm | ok 2025-09-16 03:18:51.842892 | 2025-09-16 03:18:51.843050 | TASK [tox : Return file comments to Zuul] 2025-09-16 03:18:51.871012 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:51.878819 | 2025-09-16 03:18:51.878943 | PLAY RECAP 2025-09-16 03:18:51.878996 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-09-16 03:18:51.879022 | 2025-09-16 03:18:52.008224 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-09-16 03:18:52.009395 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-09-16 03:18:52.809160 | 2025-09-16 03:18:52.809334 | PLAY [all] 2025-09-16 03:18:52.836373 | 2025-09-16 03:18:52.836534 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-09-16 03:18:52.906630 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:52.912513 | 2025-09-16 03:18:52.912657 | TASK [fetch-tox-output : Set tox log path for single node] 2025-09-16 03:18:52.971820 | debian-bookworm | ok 2025-09-16 03:18:52.977150 | 2025-09-16 03:18:52.977267 | TASK [fetch-tox-output : Ensure local tox dir] 2025-09-16 03:18:54.004617 | debian-bookworm -> localhost | changed 2025-09-16 03:18:54.012786 | 2025-09-16 03:18:54.012909 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-09-16 03:18:54.082397 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:54.088818 | 2025-09-16 03:18:54.088962 | TASK [fetch-tox-output : Set envlist fact] 2025-09-16 03:18:54.128081 | debian-bookworm | ok 2025-09-16 03:18:54.133865 | 2025-09-16 03:18:54.133974 | TASK [fetch-tox-output : Get tox version] 2025-09-16 03:18:54.960138 | 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-09-16 03:18:54.977694 | debian-bookworm | 4.30.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-09-16 03:18:55.194387 | debian-bookworm | ok: Runtime: 0:00:00.258656 2025-09-16 03:18:55.198849 | 2025-09-16 03:18:55.198928 | TASK [fetch-tox-output : Find all default environments] 2025-09-16 03:18:55.773154 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:55.777851 | 2025-09-16 03:18:55.777938 | TASK [fetch-tox-output : Set envlist fact] 2025-09-16 03:18:55.821809 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:55.826309 | 2025-09-16 03:18:55.826388 | TASK [fetch-tox-output : Find all default environments] 2025-09-16 03:18:56.355815 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:56.360457 | 2025-09-16 03:18:56.360539 | TASK [fetch-tox-output : Set envlist fact] 2025-09-16 03:18:56.403370 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:56.409434 | 2025-09-16 03:18:56.409512 | LOOP [fetch-tox-output : Copy tox logs] 2025-09-16 03:18:56.464602 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:56.478109 | 2025-09-16 03:18:56.478199 | LOOP [fetch-tox-output : Collect tox logs] 2025-09-16 03:18:57.364523 | debian-bookworm | changed: 2025-09-16 03:18:57.364729 | debian-bookworm | created directory /var/lib/zuul/builds/91026ed84ed54e9abf6d547476afa54c/work/logs/tox/test 2025-09-16 03:18:57.364778 | debian-bookworm | cd+++++++++ ./ 2025-09-16 03:18:57.364804 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-09-16 03:18:57.364833 | 2025-09-16 03:18:57.381133 | 2025-09-16 03:18:57.381211 | PLAY RECAP 2025-09-16 03:18:57.381257 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-09-16 03:18:57.381282 | 2025-09-16 03:18:57.566857 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-09-16 03:18:57.567785 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-09-16 03:18:58.435513 | 2025-09-16 03:18:58.435653 | PLAY [all] 2025-09-16 03:18:58.467332 | 2025-09-16 03:18:58.467463 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-09-16 03:18:58.687225 | debian-bookworm | changed: non-zero return code 2025-09-16 03:18:58.692460 | 2025-09-16 03:18:58.692559 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-09-16 03:18:58.705638 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:58.711144 | 2025-09-16 03:18:58.711234 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-09-16 03:18:58.731063 | 2025-09-16 03:18:58.731289 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-09-16 03:18:58.773639 | 2025-09-16 03:18:58.773817 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-09-16 03:18:58.797159 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:58.802696 | 2025-09-16 03:18:58.802798 | LOOP [fetch-subunit-output : Generate subunit file] 2025-09-16 03:18:58.823486 | 2025-09-16 03:18:58.823640 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-09-16 03:18:58.848194 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:58.854847 | 2025-09-16 03:18:58.854939 | TASK [fetch-subunit-output : Remove the temporary file] 2025-09-16 03:18:58.867685 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:58.873783 | 2025-09-16 03:18:58.873870 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-09-16 03:18:58.886444 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:18:58.892589 | 2025-09-16 03:18:58.892651 | PLAY RECAP 2025-09-16 03:18:58.892697 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-09-16 03:18:58.892723 | 2025-09-16 03:18:58.981441 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-09-16 03:18:58.982420 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-16 03:18:59.724889 | 2025-09-16 03:18:59.725018 | PLAY [Base post] 2025-09-16 03:18:59.736787 | 2025-09-16 03:18:59.736898 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-16 03:19:00.269083 | debian-bookworm | changed 2025-09-16 03:19:00.281293 | 2025-09-16 03:19:00.281390 | PLAY RECAP 2025-09-16 03:19:00.281450 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-16 03:19:00.281511 | 2025-09-16 03:19:00.366163 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-16 03:19:00.367248 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-16 03:19:01.305431 | 2025-09-16 03:19:01.305542 | PLAY [Base post-logs] 2025-09-16 03:19:01.318929 | 2025-09-16 03:19:01.319027 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-16 03:19:01.745326 | localhost | changed 2025-09-16 03:19:01.760565 | 2025-09-16 03:19:01.760721 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-16 03:19:01.786592 | localhost | ok 2025-09-16 03:19:01.789604 | 2025-09-16 03:19:01.789691 | TASK [Set zuul-log-path fact] 2025-09-16 03:19:01.803847 | localhost | ok 2025-09-16 03:19:01.811065 | 2025-09-16 03:19:01.811155 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-16 03:19:01.845511 | localhost | ok 2025-09-16 03:19:01.848465 | 2025-09-16 03:19:01.848556 | TASK [upload-logs : Create log directories] 2025-09-16 03:19:02.261074 | localhost | changed 2025-09-16 03:19:02.263802 | 2025-09-16 03:19:02.263892 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-16 03:19:02.686966 | localhost -> localhost | ok: Runtime: 0:00:00.003856 2025-09-16 03:19:02.690426 | 2025-09-16 03:19:02.690518 | TASK [upload-logs : Upload logs to log server] 2025-09-16 03:19:03.172132 | localhost | Output suppressed because no_log was given 2025-09-16 03:19:03.173880 | 2025-09-16 03:19:03.173972 | LOOP [upload-logs : Compress console log and json output] 2025-09-16 03:19:03.229714 | localhost | skipping: Conditional result was False 2025-09-16 03:19:03.235075 | localhost | skipping: Conditional result was False 2025-09-16 03:19:03.245225 | 2025-09-16 03:19:03.245376 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-16 03:19:03.287503 | localhost | skipping: Conditional result was False 2025-09-16 03:19:03.287907 | 2025-09-16 03:19:03.291843 | localhost | skipping: Conditional result was False 2025-09-16 03:19:03.302956 | 2025-09-16 03:19:03.303071 | LOOP [upload-logs : Upload console log and json output]