2025-12-21 00:21:22.850778 | Job console starting 2025-12-21 00:21:22.863558 | Updating git repos 2025-12-21 00:21:22.912461 | Cloning repos into workspace 2025-12-21 00:21:23.084770 | Restoring repo states 2025-12-21 00:21:23.099750 | Merging changes 2025-12-21 00:21:23.915876 | Checking out repos 2025-12-21 00:21:24.002737 | Preparing playbooks 2025-12-21 00:21:25.105589 | Running Ansible setup 2025-12-21 00:21:34.185626 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-21 00:21:38.184287 | 2025-12-21 00:21:38.184468 | PLAY [Base pre] 2025-12-21 00:21:38.243903 | 2025-12-21 00:21:38.244140 | TASK [Setup log path fact] 2025-12-21 00:21:38.299436 | debian-bookworm | ok 2025-12-21 00:21:38.403438 | 2025-12-21 00:21:38.403638 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-21 00:21:38.505279 | debian-bookworm | ok 2025-12-21 00:21:38.519958 | 2025-12-21 00:21:38.520168 | TASK [emit-job-header : Print job information] 2025-12-21 00:21:38.624677 | # Job Information 2025-12-21 00:21:38.624868 | Ansible Version: 2.16.14 2025-12-21 00:21:38.624903 | Job: tox 2025-12-21 00:21:38.624935 | Pipeline: check 2025-12-21 00:21:38.624958 | Executor: 521e9411259a 2025-12-21 00:21:38.624992 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1050 2025-12-21 00:21:38.625015 | Event ID: b89b1f00-de02-11f0-9845-92f791269a54 2025-12-21 00:21:38.630355 | 2025-12-21 00:21:38.630487 | LOOP [emit-job-header : Print node information] 2025-12-21 00:21:38.834717 | debian-bookworm | ok: 2025-12-21 00:21:38.835136 | debian-bookworm | # Node Information 2025-12-21 00:21:38.835184 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-21 00:21:38.835212 | debian-bookworm | Hostname: debian 2025-12-21 00:21:38.835235 | debian-bookworm | Username: zuul 2025-12-21 00:21:38.835257 | debian-bookworm | Distro: Debian 12.12 2025-12-21 00:21:38.835282 | debian-bookworm | Provider: regiocloud-a 2025-12-21 00:21:38.835303 | debian-bookworm | Region: 2025-12-21 00:21:38.835325 | debian-bookworm | Label: debian-bookworm 2025-12-21 00:21:38.835346 | debian-bookworm | Product Name: OpenStack Nova 2025-12-21 00:21:38.835365 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5a:2fb6 2025-12-21 00:21:38.858719 | 2025-12-21 00:21:38.881622 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-21 00:21:40.473471 | debian-bookworm -> localhost | changed 2025-12-21 00:21:40.481605 | 2025-12-21 00:21:40.481796 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-21 00:21:45.143398 | debian-bookworm -> localhost | changed 2025-12-21 00:21:45.192498 | 2025-12-21 00:21:45.192676 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-21 00:21:46.016957 | debian-bookworm -> localhost | ok 2025-12-21 00:21:46.024868 | 2025-12-21 00:21:46.025053 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-21 00:21:46.076357 | debian-bookworm | ok 2025-12-21 00:21:46.173818 | debian-bookworm | included: /var/lib/zuul/builds/acb6aeac008449728f5ced85d19bd814/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-21 00:21:46.217042 | 2025-12-21 00:21:46.217186 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-21 00:21:50.388209 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-21 00:21:50.388518 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/acb6aeac008449728f5ced85d19bd814/work/acb6aeac008449728f5ced85d19bd814_id_rsa 2025-12-21 00:21:50.388563 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/acb6aeac008449728f5ced85d19bd814/work/acb6aeac008449728f5ced85d19bd814_id_rsa.pub 2025-12-21 00:21:50.388589 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-21 00:21:50.388616 | debian-bookworm -> localhost | SHA256:+HK3c6d5iGza9/IHvLt0kiv6NxVIx14DiRDuU8s7e1E zuul-build-sshkey 2025-12-21 00:21:50.388639 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-21 00:21:50.388677 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-21 00:21:50.388699 | debian-bookworm -> localhost | | oo ..+ | 2025-12-21 00:21:50.388721 | debian-bookworm -> localhost | | . . o +.| 2025-12-21 00:21:50.388742 | debian-bookworm -> localhost | | . .. + o| 2025-12-21 00:21:50.388762 | debian-bookworm -> localhost | | .. o .. E | 2025-12-21 00:21:50.388782 | debian-bookworm -> localhost | | . So o .. .| 2025-12-21 00:21:50.388807 | debian-bookworm -> localhost | | . . ..o..| 2025-12-21 00:21:50.388832 | debian-bookworm -> localhost | | . o..+ .=+.| 2025-12-21 00:21:50.388869 | debian-bookworm -> localhost | | o o=.O+*+.| 2025-12-21 00:21:50.388892 | debian-bookworm -> localhost | | .o+B=X*= | 2025-12-21 00:21:50.388913 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-21 00:21:50.388986 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.914326 2025-12-21 00:21:50.403935 | 2025-12-21 00:21:50.404100 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-21 00:21:50.457715 | debian-bookworm | ok 2025-12-21 00:21:50.481432 | debian-bookworm | included: /var/lib/zuul/builds/acb6aeac008449728f5ced85d19bd814/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-21 00:21:50.540876 | 2025-12-21 00:21:50.541036 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-21 00:21:50.633491 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:21:50.640696 | 2025-12-21 00:21:50.640844 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-21 00:21:51.991086 | debian-bookworm | changed 2025-12-21 00:21:51.996707 | 2025-12-21 00:21:51.996833 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-21 00:21:52.318737 | debian-bookworm | ok 2025-12-21 00:21:52.391097 | 2025-12-21 00:21:52.391329 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-21 00:21:53.170277 | debian-bookworm | changed 2025-12-21 00:21:53.186148 | 2025-12-21 00:21:53.186301 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-21 00:21:54.108458 | debian-bookworm | changed 2025-12-21 00:21:54.123117 | 2025-12-21 00:21:54.123282 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-21 00:21:54.178383 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:21:54.196895 | 2025-12-21 00:21:54.197072 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-21 00:21:56.056682 | debian-bookworm -> localhost | changed 2025-12-21 00:21:56.085826 | 2025-12-21 00:21:56.085961 | TASK [add-build-sshkey : Add back temp key] 2025-12-21 00:21:56.834720 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/acb6aeac008449728f5ced85d19bd814/work/acb6aeac008449728f5ced85d19bd814_id_rsa (zuul-build-sshkey) 2025-12-21 00:21:56.835140 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017220 2025-12-21 00:21:56.846731 | 2025-12-21 00:21:56.846896 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-21 00:21:57.442544 | debian-bookworm | ok 2025-12-21 00:21:57.449821 | 2025-12-21 00:21:57.449959 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-21 00:21:57.494517 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:21:57.508191 | 2025-12-21 00:21:57.508402 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-21 00:21:58.436660 | debian-bookworm | ok 2025-12-21 00:21:58.477797 | 2025-12-21 00:21:58.477950 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-21 00:21:58.539129 | debian-bookworm | ok 2025-12-21 00:21:58.556754 | 2025-12-21 00:21:58.556910 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-21 00:21:59.176932 | debian-bookworm -> localhost | ok 2025-12-21 00:21:59.184024 | 2025-12-21 00:21:59.184158 | TASK [validate-host : Collect information about the host] 2025-12-21 00:22:00.626161 | debian-bookworm | ok 2025-12-21 00:22:00.648773 | 2025-12-21 00:22:00.648918 | TASK [validate-host : Sanitize hostname] 2025-12-21 00:22:00.819785 | debian-bookworm | ok 2025-12-21 00:22:00.892491 | 2025-12-21 00:22:00.892721 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-21 00:22:02.358141 | debian-bookworm -> localhost | changed 2025-12-21 00:22:02.368799 | 2025-12-21 00:22:02.371100 | TASK [validate-host : Collect information about zuul worker] 2025-12-21 00:22:03.035876 | debian-bookworm | ok 2025-12-21 00:22:03.045088 | 2025-12-21 00:22:03.045235 | TASK [validate-host : Write out all zuul information for each host] 2025-12-21 00:22:04.145955 | debian-bookworm -> localhost | changed 2025-12-21 00:22:04.163040 | 2025-12-21 00:22:04.163177 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-21 00:22:04.443572 | debian-bookworm | ok 2025-12-21 00:22:04.450851 | 2025-12-21 00:22:04.450998 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-21 00:22:05.531264 | debian-bookworm | changed: 2025-12-21 00:22:05.531469 | debian-bookworm | cd+++++++++ src/ 2025-12-21 00:22:05.531504 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-21 00:22:05.531528 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-21 00:22:05.531548 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-21 00:22:05.531569 | debian-bookworm | =6.2 2025-12-21 00:22:27.531085 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2025-12-21 00:22:27.578724 | debian-bookworm | Collecting chardet>=5.2 2025-12-21 00:22:27.591759 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-21 00:22:27.614319 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.6 MB/s eta 0:00:00 2025-12-21 00:22:27.673793 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-21 00:22:27.688142 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-21 00:22:27.755066 | debian-bookworm | Collecting filelock>=3.20 2025-12-21 00:22:27.766653 | debian-bookworm | Downloading filelock-3.20.1-py3-none-any.whl (16 kB) 2025-12-21 00:22:27.818260 | debian-bookworm | Collecting packaging>=25 2025-12-21 00:22:27.829437 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-21 00:22:27.838148 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.7 MB/s eta 0:00:00 2025-12-21 00:22:27.891388 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-21 00:22:27.903146 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-21 00:22:27.948488 | debian-bookworm | Collecting pluggy>=1.6 2025-12-21 00:22:27.959990 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-21 00:22:28.002740 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-21 00:22:28.015168 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-21 00:22:28.147722 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-21 00:22:28.161250 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-21 00:22:28.472441 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 19.6 MB/s eta 0:00:00 2025-12-21 00:22:28.599617 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-21 00:22:28.611868 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-21 00:22:28.642757 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.7 MB/s eta 0:00:00 2025-12-21 00:22:28.800184 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-21 00:22:29.663032 | 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-21 00:22:29.879718 | debian-bookworm | ok: Runtime: 0:00:03.130959 2025-12-21 00:22:29.886259 | 2025-12-21 00:22:29.886395 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-21 00:22:29.981491 | debian-bookworm | ok 2025-12-21 00:22:29.992616 | 2025-12-21 00:22:29.992762 | TASK [ensure-tox : Output tox version] 2025-12-21 00:22:30.699969 | 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-21 00:22:30.718411 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-21 00:22:31.097496 | debian-bookworm | ok: Runtime: 0:00:00.301509 2025-12-21 00:22:31.104748 | 2025-12-21 00:22:31.104876 | TASK [ensure-tox : Make global symlink] 2025-12-21 00:22:31.171903 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:31.180162 | 2025-12-21 00:22:31.180268 | PLAY RECAP 2025-12-21 00:22:31.180323 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-21 00:22:31.180348 | 2025-12-21 00:22:32.040710 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-21 00:22:32.042072 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-21 00:22:33.722258 | 2025-12-21 00:22:33.722444 | PLAY [all] 2025-12-21 00:22:33.786949 | 2025-12-21 00:22:33.787270 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-21 00:22:34.882540 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-21 00:22:35.368442 | debian-bookworm | ok: Runtime: 0:00:00.027656 2025-12-21 00:22:35.375124 | 2025-12-21 00:22:35.375285 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-21 00:22:35.930007 | debian-bookworm | ok: Runtime: 0:00:00.006658 2025-12-21 00:22:35.951637 | 2025-12-21 00:22:35.951806 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-21 00:22:36.314506 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-21 00:22:36.316202 | debian-bookworm | sudo: a password is required 2025-12-21 00:22:36.515845 | debian-bookworm | ok: Runtime: 0:00:00.018339 2025-12-21 00:22:36.526947 | 2025-12-21 00:22:36.527123 | TASK [tox : Check to see if the constraints file exists] 2025-12-21 00:22:36.588586 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:36.596728 | 2025-12-21 00:22:36.596875 | TASK [tox : Fail if constraints file is missing] 2025-12-21 00:22:36.665771 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:36.672770 | 2025-12-21 00:22:36.672910 | TASK [tox : Record file location] 2025-12-21 00:22:36.753761 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:36.760534 | 2025-12-21 00:22:36.760670 | TASK [tox : Install tox siblings] 2025-12-21 00:22:36.815672 | debian-bookworm | ok 2025-12-21 00:22:36.847112 | debian-bookworm | included: /var/lib/zuul/builds/acb6aeac008449728f5ced85d19bd814/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-21 00:22:36.872372 | 2025-12-21 00:22:36.872537 | TASK [tox : Run tox without tests] 2025-12-21 00:22:38.008909 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-21 00:22:52.001029 | debian-bookworm | test: OK (14.55 seconds) 2025-12-21 00:22:52.001152 | debian-bookworm | congratulations :) (14.58 seconds) 2025-12-21 00:22:52.455409 | debian-bookworm | ok: Runtime: 0:00:14.866815 2025-12-21 00:22:52.461962 | 2025-12-21 00:22:52.462108 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-21 00:22:53.255547 | debian-bookworm | changed 2025-12-21 00:22:53.272123 | 2025-12-21 00:22:53.272277 | TASK [tox : Get tox envlist config] 2025-12-21 00:22:54.428731 | debian-bookworm | ok: Runtime: 0:00:00.357720 2025-12-21 00:22:54.434596 | 2025-12-21 00:22:54.434726 | TASK [tox : Install any sibling python packages] 2025-12-21 00:22:55.284035 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-21 00:22:55.291484 | 2025-12-21 00:22:55.291626 | TASK [tox : Remove tempfile] 2025-12-21 00:22:55.853646 | debian-bookworm | changed 2025-12-21 00:22:55.859751 | 2025-12-21 00:22:55.859872 | TASK [tox : Emit tox command] 2025-12-21 00:22:55.938509 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-21 00:22:55.944082 | 2025-12-21 00:22:55.944212 | TASK [tox : Run tox] 2025-12-21 00:22:56.571807 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-21 00:22:57.159758 | debian-bookworm | ............... 2025-12-21 00:22:57.159797 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-21 00:22:57.159811 | debian-bookworm | Ran 15 tests in 0.163s 2025-12-21 00:22:57.159816 | debian-bookworm | 2025-12-21 00:22:57.159823 | debian-bookworm | OK 2025-12-21 00:22:57.226191 | debian-bookworm | test: OK (0.69=setup[0.04]+cmd[0.65] seconds) 2025-12-21 00:22:57.226248 | debian-bookworm | congratulations :) (0.72 seconds) 2025-12-21 00:22:57.532853 | debian-bookworm | ok: Runtime: 0:00:00.980943 2025-12-21 00:22:57.539946 | 2025-12-21 00:22:57.540371 | TASK [tox : Look for output] 2025-12-21 00:22:57.979633 | debian-bookworm | ok 2025-12-21 00:22:57.998506 | 2025-12-21 00:22:57.998659 | TASK [tox : Return file comments to Zuul] 2025-12-21 00:22:58.034254 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:58.042571 | 2025-12-21 00:22:58.042678 | PLAY RECAP 2025-12-21 00:22:58.042735 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-21 00:22:58.042761 | 2025-12-21 00:22:58.257751 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-21 00:22:58.259051 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-21 00:22:59.297748 | 2025-12-21 00:22:59.297921 | PLAY [all] 2025-12-21 00:22:59.320306 | 2025-12-21 00:22:59.320470 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-21 00:22:59.370130 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:59.380689 | 2025-12-21 00:22:59.380926 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-21 00:22:59.425697 | debian-bookworm | ok 2025-12-21 00:22:59.432722 | 2025-12-21 00:22:59.432874 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-21 00:22:59.971893 | debian-bookworm -> localhost | changed 2025-12-21 00:22:59.980345 | 2025-12-21 00:22:59.980485 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-21 00:23:00.024693 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:00.030715 | 2025-12-21 00:23:00.030856 | TASK [fetch-tox-output : Set envlist fact] 2025-12-21 00:23:00.074089 | debian-bookworm | ok 2025-12-21 00:23:00.080028 | 2025-12-21 00:23:00.080141 | TASK [fetch-tox-output : Get tox version] 2025-12-21 00:23:00.743672 | 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-21 00:23:00.761949 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-21 00:23:01.110346 | debian-bookworm | ok: Runtime: 0:00:00.278567 2025-12-21 00:23:01.120008 | 2025-12-21 00:23:01.120146 | TASK [fetch-tox-output : Find all default environments] 2025-12-21 00:23:01.669311 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:01.681652 | 2025-12-21 00:23:01.681801 | TASK [fetch-tox-output : Set envlist fact] 2025-12-21 00:23:01.718275 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:01.724963 | 2025-12-21 00:23:01.725123 | TASK [fetch-tox-output : Find all default environments] 2025-12-21 00:23:02.255142 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:02.261926 | 2025-12-21 00:23:02.262127 | TASK [fetch-tox-output : Set envlist fact] 2025-12-21 00:23:02.287168 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:02.298460 | 2025-12-21 00:23:02.298602 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-21 00:23:02.350054 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:02.363634 | 2025-12-21 00:23:02.363788 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-21 00:23:03.208503 | debian-bookworm | changed: 2025-12-21 00:23:03.208697 | debian-bookworm | created directory /var/lib/zuul/builds/acb6aeac008449728f5ced85d19bd814/work/logs/tox/test 2025-12-21 00:23:03.208731 | debian-bookworm | cd+++++++++ ./ 2025-12-21 00:23:03.208757 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-21 00:23:03.208787 | 2025-12-21 00:23:03.217816 | 2025-12-21 00:23:03.217921 | PLAY RECAP 2025-12-21 00:23:03.218010 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-21 00:23:03.218041 | 2025-12-21 00:23:03.402416 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-21 00:23:03.403653 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-21 00:23:04.234348 | 2025-12-21 00:23:04.234521 | PLAY [all] 2025-12-21 00:23:04.251592 | 2025-12-21 00:23:04.251751 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-21 00:23:04.462817 | debian-bookworm | changed: non-zero return code 2025-12-21 00:23:04.470679 | 2025-12-21 00:23:04.470921 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-21 00:23:04.497633 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:04.504537 | 2025-12-21 00:23:04.504680 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-21 00:23:04.538080 | 2025-12-21 00:23:04.538297 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-21 00:23:04.572336 | 2025-12-21 00:23:04.573690 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-21 00:23:04.609679 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:04.625354 | 2025-12-21 00:23:04.625520 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-21 00:23:04.666066 | 2025-12-21 00:23:04.666461 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-21 00:23:04.692898 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:04.700667 | 2025-12-21 00:23:04.700815 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-21 00:23:04.726261 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:04.738742 | 2025-12-21 00:23:04.739020 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-21 00:23:04.779896 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:23:04.793297 | 2025-12-21 00:23:04.793443 | PLAY RECAP 2025-12-21 00:23:04.793526 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-21 00:23:04.793569 | 2025-12-21 00:23:04.988321 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-21 00:23:04.989634 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-21 00:23:05.985727 | 2025-12-21 00:23:05.985940 | PLAY [Base post] 2025-12-21 00:23:06.012471 | 2025-12-21 00:23:06.012712 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-21 00:23:06.590231 | debian-bookworm | changed 2025-12-21 00:23:06.601932 | 2025-12-21 00:23:06.602178 | PLAY RECAP 2025-12-21 00:23:06.602310 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-21 00:23:06.602418 | 2025-12-21 00:23:06.749829 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-21 00:23:06.752171 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-21 00:23:07.616691 | 2025-12-21 00:23:07.616876 | PLAY [Base post-logs] 2025-12-21 00:23:07.629263 | 2025-12-21 00:23:07.629430 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-21 00:23:08.126950 | localhost | changed 2025-12-21 00:23:08.151819 | 2025-12-21 00:23:08.152105 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-21 00:23:08.180758 | localhost | ok 2025-12-21 00:23:08.184688 | 2025-12-21 00:23:08.184814 | TASK [Set zuul-log-path fact] 2025-12-21 00:23:08.201738 | localhost | ok 2025-12-21 00:23:08.211722 | 2025-12-21 00:23:08.211850 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-21 00:23:08.237414 | localhost | ok 2025-12-21 00:23:08.246506 | 2025-12-21 00:23:08.246700 | TASK [upload-logs : Create log directories] 2025-12-21 00:23:08.808604 | localhost | changed 2025-12-21 00:23:08.813289 | 2025-12-21 00:23:08.813460 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-21 00:23:09.377327 | localhost -> localhost | ok: Runtime: 0:00:00.008378 2025-12-21 00:23:09.390082 | 2025-12-21 00:23:09.390265 | TASK [upload-logs : Upload logs to log server] 2025-12-21 00:23:09.989288 | localhost | Output suppressed because no_log was given 2025-12-21 00:23:09.992283 | 2025-12-21 00:23:09.992444 | LOOP [upload-logs : Compress console log and json output] 2025-12-21 00:23:10.051470 | localhost | skipping: Conditional result was False 2025-12-21 00:23:10.058540 | localhost | skipping: Conditional result was False 2025-12-21 00:23:10.062436 | 2025-12-21 00:23:10.062582 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-21 00:23:10.121141 | localhost | skipping: Conditional result was False 2025-12-21 00:23:10.121579 | 2025-12-21 00:23:10.127077 | localhost | skipping: Conditional result was False 2025-12-21 00:23:10.130935 | 2025-12-21 00:23:10.131074 | LOOP [upload-logs : Upload console log and json output]