2025-10-20 09:32:24.427880 | Job console starting 2025-10-20 09:32:24.447114 | Updating git repos 2025-10-20 09:32:24.492990 | Cloning repos into workspace 2025-10-20 09:32:24.531483 | Restoring repo states 2025-10-20 09:32:24.540745 | Merging changes 2025-10-20 09:32:25.071299 | Checking out repos 2025-10-20 09:32:25.139690 | Preparing playbooks 2025-10-20 09:32:25.823552 | Running Ansible setup 2025-10-20 09:32:31.080682 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-20 09:32:32.132484 | 2025-10-20 09:32:32.132642 | PLAY [Base pre] 2025-10-20 09:32:32.174303 | 2025-10-20 09:32:32.174461 | TASK [Setup log path fact] 2025-10-20 09:32:32.224450 | debian-bookworm | ok 2025-10-20 09:32:32.249708 | 2025-10-20 09:32:32.249871 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-20 09:32:32.305749 | debian-bookworm | ok 2025-10-20 09:32:32.315580 | 2025-10-20 09:32:32.315699 | TASK [emit-job-header : Print job information] 2025-10-20 09:32:32.411330 | # Job Information 2025-10-20 09:32:32.411517 | Ansible Version: 2.16.14 2025-10-20 09:32:32.411551 | Job: tox 2025-10-20 09:32:32.411582 | Pipeline: check 2025-10-20 09:32:32.411605 | Executor: 521e9411259a 2025-10-20 09:32:32.411625 | Triggered by: https://github.com/osism/openstack-image-manager/pull/974 2025-10-20 09:32:32.411646 | Event ID: aa092b80-ad97-11f0-8d46-42d5aece58df 2025-10-20 09:32:32.416766 | 2025-10-20 09:32:32.416883 | LOOP [emit-job-header : Print node information] 2025-10-20 09:32:32.621644 | debian-bookworm | ok: 2025-10-20 09:32:32.621928 | debian-bookworm | # Node Information 2025-10-20 09:32:32.621966 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-20 09:32:32.621991 | debian-bookworm | Hostname: debian 2025-10-20 09:32:32.622013 | debian-bookworm | Username: zuul 2025-10-20 09:32:32.622034 | debian-bookworm | Distro: Debian 12.12 2025-10-20 09:32:32.622062 | debian-bookworm | Provider: regiocloud-a 2025-10-20 09:32:32.622085 | debian-bookworm | Region: 2025-10-20 09:32:32.622107 | debian-bookworm | Label: debian-bookworm 2025-10-20 09:32:32.622150 | debian-bookworm | Product Name: OpenStack Nova 2025-10-20 09:32:32.622172 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe73:6d57 2025-10-20 09:32:32.646195 | 2025-10-20 09:32:32.646332 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-20 09:32:33.418716 | debian-bookworm -> localhost | changed 2025-10-20 09:32:33.425613 | 2025-10-20 09:32:33.426324 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-20 09:32:34.816574 | debian-bookworm -> localhost | changed 2025-10-20 09:32:34.825014 | 2025-10-20 09:32:34.825096 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-20 09:32:35.202020 | debian-bookworm -> localhost | ok 2025-10-20 09:32:35.206811 | 2025-10-20 09:32:35.206917 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-20 09:32:35.243250 | debian-bookworm | ok 2025-10-20 09:32:35.265340 | debian-bookworm | included: /var/lib/zuul/builds/b3fa202f83304b2793340406da66867b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-20 09:32:35.276969 | 2025-10-20 09:32:35.277057 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-20 09:32:37.191262 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-20 09:32:37.191425 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b3fa202f83304b2793340406da66867b/work/b3fa202f83304b2793340406da66867b_id_rsa 2025-10-20 09:32:37.191457 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b3fa202f83304b2793340406da66867b/work/b3fa202f83304b2793340406da66867b_id_rsa.pub 2025-10-20 09:32:37.191479 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-20 09:32:37.191500 | debian-bookworm -> localhost | SHA256:8x1H/OZfrhS5Jv/q3qllqv0RzbNy6KLK7xpLHOKwnrE zuul-build-sshkey 2025-10-20 09:32:37.191518 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-20 09:32:37.191545 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-20 09:32:37.191564 | debian-bookworm -> localhost | | | 2025-10-20 09:32:37.191581 | debian-bookworm -> localhost | | . | 2025-10-20 09:32:37.191598 | debian-bookworm -> localhost | | o | 2025-10-20 09:32:37.191614 | debian-bookworm -> localhost | | . +.| 2025-10-20 09:32:37.191629 | debian-bookworm -> localhost | | . . .S . +o=| 2025-10-20 09:32:37.191647 | debian-bookworm -> localhost | | + o .o . o.=+| 2025-10-20 09:32:37.191664 | debian-bookworm -> localhost | | o . + . oo+*o| 2025-10-20 09:32:37.191679 | debian-bookworm -> localhost | | . + o o .o=*o=| 2025-10-20 09:32:37.191696 | debian-bookworm -> localhost | | E ==+..oBO*=| 2025-10-20 09:32:37.191712 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-20 09:32:37.191751 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.180236 2025-10-20 09:32:37.196692 | 2025-10-20 09:32:37.196765 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-20 09:32:37.223252 | debian-bookworm | ok 2025-10-20 09:32:37.230648 | debian-bookworm | included: /var/lib/zuul/builds/b3fa202f83304b2793340406da66867b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-20 09:32:37.237555 | 2025-10-20 09:32:37.237622 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-20 09:32:37.259875 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:32:37.264337 | 2025-10-20 09:32:37.264407 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-20 09:32:37.828372 | debian-bookworm | changed 2025-10-20 09:32:37.833612 | 2025-10-20 09:32:37.833696 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-20 09:32:38.106354 | debian-bookworm | ok 2025-10-20 09:32:38.115354 | 2025-10-20 09:32:38.115525 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-20 09:32:38.742260 | debian-bookworm | changed 2025-10-20 09:32:38.749427 | 2025-10-20 09:32:38.749511 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-20 09:32:39.358663 | debian-bookworm | changed 2025-10-20 09:32:39.363114 | 2025-10-20 09:32:39.363201 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-20 09:32:39.376269 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:32:39.380971 | 2025-10-20 09:32:39.381042 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-20 09:32:39.862539 | debian-bookworm -> localhost | changed 2025-10-20 09:32:39.883543 | 2025-10-20 09:32:39.883643 | TASK [add-build-sshkey : Add back temp key] 2025-10-20 09:32:40.377296 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b3fa202f83304b2793340406da66867b/work/b3fa202f83304b2793340406da66867b_id_rsa (zuul-build-sshkey) 2025-10-20 09:32:40.377504 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014422 2025-10-20 09:32:40.385885 | 2025-10-20 09:32:40.385980 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-20 09:32:40.763304 | debian-bookworm | ok 2025-10-20 09:32:40.767375 | 2025-10-20 09:32:40.767449 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-20 09:32:40.790021 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:32:40.798096 | 2025-10-20 09:32:40.798209 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-20 09:32:41.211469 | debian-bookworm | ok 2025-10-20 09:32:41.220449 | 2025-10-20 09:32:41.220535 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-20 09:32:41.246809 | debian-bookworm | ok 2025-10-20 09:32:41.250850 | 2025-10-20 09:32:41.250928 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-20 09:32:41.700721 | debian-bookworm -> localhost | ok 2025-10-20 09:32:41.705767 | 2025-10-20 09:32:41.705838 | TASK [validate-host : Collect information about the host] 2025-10-20 09:32:42.794167 | debian-bookworm | ok 2025-10-20 09:32:42.805364 | 2025-10-20 09:32:42.805458 | TASK [validate-host : Sanitize hostname] 2025-10-20 09:32:42.930982 | debian-bookworm | ok 2025-10-20 09:32:42.991943 | 2025-10-20 09:32:42.992055 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-20 09:32:43.568835 | debian-bookworm -> localhost | changed 2025-10-20 09:32:43.574786 | 2025-10-20 09:32:43.574900 | TASK [validate-host : Collect information about zuul worker] 2025-10-20 09:32:44.024242 | debian-bookworm | ok 2025-10-20 09:32:44.048024 | 2025-10-20 09:32:44.048161 | TASK [validate-host : Write out all zuul information for each host] 2025-10-20 09:32:44.608038 | debian-bookworm -> localhost | changed 2025-10-20 09:32:44.616834 | 2025-10-20 09:32:44.616923 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-20 09:32:44.878326 | debian-bookworm | ok 2025-10-20 09:32:44.883512 | 2025-10-20 09:32:44.883598 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-20 09:32:45.718066 | debian-bookworm | changed: 2025-10-20 09:32:45.718255 | debian-bookworm | cd+++++++++ src/ 2025-10-20 09:32:45.718291 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-20 09:32:45.718315 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-20 09:32:45.718337 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-20 09:32:45.718357 | debian-bookworm | =6.2 2025-10-20 09:33:08.712079 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-10-20 09:33:08.759460 | debian-bookworm | Collecting chardet>=5.2 2025-10-20 09:33:08.776136 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-10-20 09:33:08.791087 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 21.5 MB/s eta 0:00:00 2025-10-20 09:33:08.836778 | debian-bookworm | Collecting colorama>=0.4.6 2025-10-20 09:33:08.851596 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-20 09:33:08.917259 | debian-bookworm | Collecting filelock>=3.20 2025-10-20 09:33:08.932308 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-10-20 09:33:08.998992 | debian-bookworm | Collecting packaging>=25 2025-10-20 09:33:09.013118 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-20 09:33:09.021583 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.3 MB/s eta 0:00:00 2025-10-20 09:33:09.068092 | debian-bookworm | Collecting platformdirs>=4.5 2025-10-20 09:33:09.082313 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-10-20 09:33:09.137192 | debian-bookworm | Collecting pluggy>=1.6 2025-10-20 09:33:09.152198 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-10-20 09:33:09.206485 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-10-20 09:33:09.222138 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-10-20 09:33:09.361714 | debian-bookworm | Collecting virtualenv>=20.34 2025-10-20 09:33:09.376091 | debian-bookworm | Downloading virtualenv-20.35.3-py3-none-any.whl (6.0 MB) 2025-10-20 09:33:09.600868 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 27.2 MB/s eta 0:00:00 2025-10-20 09:33:09.712547 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-10-20 09:33:09.728040 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-10-20 09:33:09.746752 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 32.4 MB/s eta 0:00:00 2025-10-20 09:33:09.903509 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-10-20 09:33:10.824430 | 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.31.0 virtualenv-20.35.3 2025-10-20 09:33:11.101694 | debian-bookworm | ok: Runtime: 0:00:03.096779 2025-10-20 09:33:11.107926 | 2025-10-20 09:33:11.108042 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-20 09:33:11.139273 | debian-bookworm | ok 2025-10-20 09:33:11.144277 | 2025-10-20 09:33:11.144388 | TASK [ensure-tox : Output tox version] 2025-10-20 09:33:11.686598 | 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-10-20 09:33:11.705968 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-20 09:33:12.173927 | debian-bookworm | ok: Runtime: 0:00:00.321412 2025-10-20 09:33:12.179923 | 2025-10-20 09:33:12.180032 | TASK [ensure-tox : Make global symlink] 2025-10-20 09:33:12.204494 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:12.211525 | 2025-10-20 09:33:12.211617 | PLAY RECAP 2025-10-20 09:33:12.211675 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-20 09:33:12.211701 | 2025-10-20 09:33:12.343919 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-10-20 09:33:12.345150 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-20 09:33:13.116873 | 2025-10-20 09:33:13.117077 | PLAY [all] 2025-10-20 09:33:13.162951 | 2025-10-20 09:33:13.163186 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-10-20 09:33:13.637313 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-20 09:33:13.696815 | debian-bookworm | ok: Runtime: 0:00:00.025031 2025-10-20 09:33:13.704247 | 2025-10-20 09:33:13.704395 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-10-20 09:33:14.234257 | debian-bookworm | ok: Runtime: 0:00:00.007695 2025-10-20 09:33:14.247115 | 2025-10-20 09:33:14.247418 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-10-20 09:33:14.607585 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-20 09:33:14.609291 | debian-bookworm | sudo: a password is required 2025-10-20 09:33:14.793919 | debian-bookworm | ok: Runtime: 0:00:00.019266 2025-10-20 09:33:14.812270 | 2025-10-20 09:33:14.812405 | TASK [tox : Check to see if the constraints file exists] 2025-10-20 09:33:14.847510 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:14.860396 | 2025-10-20 09:33:14.860570 | TASK [tox : Fail if constraints file is missing] 2025-10-20 09:33:14.885801 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:14.899489 | 2025-10-20 09:33:14.899728 | TASK [tox : Record file location] 2025-10-20 09:33:14.924872 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:14.939100 | 2025-10-20 09:33:14.939317 | TASK [tox : Install tox siblings] 2025-10-20 09:33:14.965646 | debian-bookworm | ok 2025-10-20 09:33:14.976734 | debian-bookworm | included: /var/lib/zuul/builds/b3fa202f83304b2793340406da66867b/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-10-20 09:33:14.982701 | 2025-10-20 09:33:14.982806 | TASK [tox : Run tox without tests] 2025-10-20 09:33:16.173281 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-10-20 09:33:29.896575 | debian-bookworm | test: OK (14.35 seconds) 2025-10-20 09:33:29.896659 | debian-bookworm | congratulations :) (14.38 seconds) 2025-10-20 09:33:30.018211 | debian-bookworm | ok: Runtime: 0:00:14.675613 2025-10-20 09:33:30.030286 | 2025-10-20 09:33:30.030446 | TASK [tox : Create a tempfile to save tox showconfig] 2025-10-20 09:33:30.449944 | debian-bookworm | changed 2025-10-20 09:33:30.457659 | 2025-10-20 09:33:30.457785 | TASK [tox : Get tox envlist config] 2025-10-20 09:33:31.489817 | debian-bookworm | ok: Runtime: 0:00:00.365260 2025-10-20 09:33:31.503732 | 2025-10-20 09:33:31.503896 | TASK [tox : Install any sibling python packages] 2025-10-20 09:33:31.970912 | debian-bookworm | ok: No setup.cfg, no action needed 2025-10-20 09:33:31.976767 | 2025-10-20 09:33:31.976871 | TASK [tox : Remove tempfile] 2025-10-20 09:33:32.405396 | debian-bookworm | changed 2025-10-20 09:33:32.416578 | 2025-10-20 09:33:32.416722 | TASK [tox : Emit tox command] 2025-10-20 09:33:32.473725 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-10-20 09:33:32.482014 | 2025-10-20 09:33:32.482192 | TASK [tox : Run tox] 2025-10-20 09:33:33.106963 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-10-20 09:33:33.740375 | debian-bookworm | ............... 2025-10-20 09:33:33.740424 | debian-bookworm | ---------------------------------------------------------------------- 2025-10-20 09:33:33.740439 | debian-bookworm | Ran 15 tests in 0.170s 2025-10-20 09:33:33.740445 | debian-bookworm | 2025-10-20 09:33:33.740452 | debian-bookworm | OK 2025-10-20 09:33:33.828166 | debian-bookworm | test: OK (0.76=setup[0.04]+cmd[0.72] seconds) 2025-10-20 09:33:33.828235 | debian-bookworm | congratulations :) (0.79 seconds) 2025-10-20 09:33:34.047848 | debian-bookworm | ok: Runtime: 0:00:01.085378 2025-10-20 09:33:34.059916 | 2025-10-20 09:33:34.060076 | TASK [tox : Look for output] 2025-10-20 09:33:34.463565 | debian-bookworm | ok 2025-10-20 09:33:34.481254 | 2025-10-20 09:33:34.481388 | TASK [tox : Return file comments to Zuul] 2025-10-20 09:33:34.525695 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:34.540225 | 2025-10-20 09:33:34.540346 | PLAY RECAP 2025-10-20 09:33:34.540440 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-20 09:33:34.540485 | 2025-10-20 09:33:34.666945 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-20 09:33:34.669638 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-20 09:33:35.410463 | 2025-10-20 09:33:35.410622 | PLAY [all] 2025-10-20 09:33:35.425652 | 2025-10-20 09:33:35.425783 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-10-20 09:33:35.481527 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:35.496338 | 2025-10-20 09:33:35.496557 | TASK [fetch-tox-output : Set tox log path for single node] 2025-10-20 09:33:35.527541 | debian-bookworm | ok 2025-10-20 09:33:35.532539 | 2025-10-20 09:33:35.532649 | TASK [fetch-tox-output : Ensure local tox dir] 2025-10-20 09:33:35.991068 | debian-bookworm -> localhost | changed 2025-10-20 09:33:35.999153 | 2025-10-20 09:33:35.999275 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-10-20 09:33:36.053537 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:36.066977 | 2025-10-20 09:33:36.067170 | TASK [fetch-tox-output : Set envlist fact] 2025-10-20 09:33:36.096396 | debian-bookworm | ok 2025-10-20 09:33:36.101903 | 2025-10-20 09:33:36.102000 | TASK [fetch-tox-output : Get tox version] 2025-10-20 09:33:36.763367 | 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-10-20 09:33:36.782247 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-20 09:33:37.133344 | debian-bookworm | ok: Runtime: 0:00:00.287106 2025-10-20 09:33:37.142936 | 2025-10-20 09:33:37.143089 | TASK [fetch-tox-output : Find all default environments] 2025-10-20 09:33:37.675026 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:37.684884 | 2025-10-20 09:33:37.685044 | TASK [fetch-tox-output : Set envlist fact] 2025-10-20 09:33:37.719269 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:37.724881 | 2025-10-20 09:33:37.724987 | TASK [fetch-tox-output : Find all default environments] 2025-10-20 09:33:38.254671 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:38.268285 | 2025-10-20 09:33:38.268453 | TASK [fetch-tox-output : Set envlist fact] 2025-10-20 09:33:38.303562 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:38.317579 | 2025-10-20 09:33:38.317763 | LOOP [fetch-tox-output : Copy tox logs] 2025-10-20 09:33:38.368620 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:38.386943 | 2025-10-20 09:33:38.387111 | LOOP [fetch-tox-output : Collect tox logs] 2025-10-20 09:33:39.175428 | debian-bookworm | changed: 2025-10-20 09:33:39.175661 | debian-bookworm | created directory /var/lib/zuul/builds/b3fa202f83304b2793340406da66867b/work/logs/tox/test 2025-10-20 09:33:39.175703 | debian-bookworm | cd+++++++++ ./ 2025-10-20 09:33:39.175735 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-10-20 09:33:39.175772 | 2025-10-20 09:33:39.189852 | 2025-10-20 09:33:39.189949 | PLAY RECAP 2025-10-20 09:33:39.189997 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-20 09:33:39.190020 | 2025-10-20 09:33:39.312779 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-20 09:33:39.313843 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-20 09:33:40.046311 | 2025-10-20 09:33:40.046554 | PLAY [all] 2025-10-20 09:33:40.062092 | 2025-10-20 09:33:40.062249 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-10-20 09:33:40.269951 | debian-bookworm | changed: non-zero return code 2025-10-20 09:33:40.278023 | 2025-10-20 09:33:40.278237 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-10-20 09:33:40.302821 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:40.312844 | 2025-10-20 09:33:40.313012 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-10-20 09:33:40.348590 | 2025-10-20 09:33:40.348864 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-10-20 09:33:40.382398 | 2025-10-20 09:33:40.382641 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-10-20 09:33:40.409767 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:40.418524 | 2025-10-20 09:33:40.418663 | LOOP [fetch-subunit-output : Generate subunit file] 2025-10-20 09:33:40.456484 | 2025-10-20 09:33:40.456751 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-10-20 09:33:40.480748 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:40.488981 | 2025-10-20 09:33:40.489120 | TASK [fetch-subunit-output : Remove the temporary file] 2025-10-20 09:33:40.513090 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:40.519846 | 2025-10-20 09:33:40.519974 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-10-20 09:33:40.543316 | debian-bookworm | skipping: Conditional result was False 2025-10-20 09:33:40.551983 | 2025-10-20 09:33:40.552081 | PLAY RECAP 2025-10-20 09:33:40.552192 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-20 09:33:40.552229 | 2025-10-20 09:33:40.686285 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-20 09:33:40.687379 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-20 09:33:41.400050 | 2025-10-20 09:33:41.400229 | PLAY [Base post] 2025-10-20 09:33:41.414608 | 2025-10-20 09:33:41.414745 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-20 09:33:41.986413 | debian-bookworm | changed 2025-10-20 09:33:41.996718 | 2025-10-20 09:33:41.996854 | PLAY RECAP 2025-10-20 09:33:41.996937 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-20 09:33:41.997022 | 2025-10-20 09:33:42.131538 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-20 09:33:42.133863 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-20 09:33:42.919610 | 2025-10-20 09:33:42.919784 | PLAY [Base post-logs] 2025-10-20 09:33:42.931171 | 2025-10-20 09:33:42.931316 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-20 09:33:43.417317 | localhost | changed 2025-10-20 09:33:43.440682 | 2025-10-20 09:33:43.441166 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-20 09:33:43.482386 | localhost | ok 2025-10-20 09:33:43.489160 | 2025-10-20 09:33:43.489296 | TASK [Set zuul-log-path fact] 2025-10-20 09:33:43.507929 | localhost | ok 2025-10-20 09:33:43.522898 | 2025-10-20 09:33:43.523038 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-20 09:33:43.549158 | localhost | ok 2025-10-20 09:33:43.554099 | 2025-10-20 09:33:43.554244 | TASK [upload-logs : Create log directories] 2025-10-20 09:33:44.070970 | localhost | changed 2025-10-20 09:33:44.074250 | 2025-10-20 09:33:44.074372 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-20 09:33:44.565079 | localhost -> localhost | ok: Runtime: 0:00:00.004327 2025-10-20 09:33:44.569241 | 2025-10-20 09:33:44.569363 | TASK [upload-logs : Upload logs to log server] 2025-10-20 09:33:45.121810 | localhost | Output suppressed because no_log was given 2025-10-20 09:33:45.123854 | 2025-10-20 09:33:45.123962 | LOOP [upload-logs : Compress console log and json output] 2025-10-20 09:33:45.172725 | localhost | skipping: Conditional result was False 2025-10-20 09:33:45.176326 | localhost | skipping: Conditional result was False 2025-10-20 09:33:45.183784 | 2025-10-20 09:33:45.183944 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-20 09:33:45.228486 | localhost | skipping: Conditional result was False 2025-10-20 09:33:45.228769 | 2025-10-20 09:33:45.233417 | localhost | skipping: Conditional result was False 2025-10-20 09:33:45.247396 | 2025-10-20 09:33:45.247617 | LOOP [upload-logs : Upload console log and json output]