2026-01-08 00:19:15.880992 | Job console starting 2026-01-08 00:19:15.894598 | Updating git repos 2026-01-08 00:19:15.917916 | Cloning repos into workspace 2026-01-08 00:19:16.024492 | Restoring repo states 2026-01-08 00:19:16.039517 | Merging changes 2026-01-08 00:19:16.779177 | Checking out repos 2026-01-08 00:19:16.828497 | Preparing playbooks 2026-01-08 00:19:18.060360 | Running Ansible setup 2026-01-08 00:19:26.482316 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-08 00:19:28.252436 | 2026-01-08 00:19:28.252700 | PLAY [Base pre] 2026-01-08 00:19:28.318129 | 2026-01-08 00:19:28.318299 | TASK [Setup log path fact] 2026-01-08 00:19:28.369316 | debian-bookworm | ok 2026-01-08 00:19:28.400137 | 2026-01-08 00:19:28.400317 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-08 00:19:28.482953 | debian-bookworm | ok 2026-01-08 00:19:28.508062 | 2026-01-08 00:19:28.508216 | TASK [emit-job-header : Print job information] 2026-01-08 00:19:28.618738 | # Job Information 2026-01-08 00:19:28.618973 | Ansible Version: 2.16.14 2026-01-08 00:19:28.619012 | Job: tox 2026-01-08 00:19:28.619046 | Pipeline: check 2026-01-08 00:19:28.619070 | Executor: 521e9411259a 2026-01-08 00:19:28.619091 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1077 2026-01-08 00:19:28.619113 | Event ID: a4e9f0c0-ec27-11f0-85ff-7fc3471d39b5 2026-01-08 00:19:28.624482 | 2026-01-08 00:19:28.624632 | LOOP [emit-job-header : Print node information] 2026-01-08 00:19:28.929174 | debian-bookworm | ok: 2026-01-08 00:19:28.934947 | debian-bookworm | # Node Information 2026-01-08 00:19:28.935052 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-08 00:19:28.935083 | debian-bookworm | Hostname: debian 2026-01-08 00:19:28.935107 | debian-bookworm | Username: zuul 2026-01-08 00:19:28.935129 | debian-bookworm | Distro: Debian 12.12 2026-01-08 00:19:28.935153 | debian-bookworm | Provider: regiocloud-a 2026-01-08 00:19:28.935175 | debian-bookworm | Region: 2026-01-08 00:19:28.935197 | debian-bookworm | Label: debian-bookworm 2026-01-08 00:19:28.935218 | debian-bookworm | Product Name: OpenStack Nova 2026-01-08 00:19:28.935238 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe38:38f8 2026-01-08 00:19:28.955261 | 2026-01-08 00:19:28.955402 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-08 00:19:30.391723 | debian-bookworm -> localhost | changed 2026-01-08 00:19:30.399653 | 2026-01-08 00:19:30.399796 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-08 00:19:33.363015 | debian-bookworm -> localhost | changed 2026-01-08 00:19:33.382166 | 2026-01-08 00:19:33.382356 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-08 00:19:33.763419 | debian-bookworm -> localhost | ok 2026-01-08 00:19:33.775519 | 2026-01-08 00:19:33.775695 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-08 00:19:33.825852 | debian-bookworm | ok 2026-01-08 00:19:33.869760 | debian-bookworm | included: /var/lib/zuul/builds/6bd3458865a64eb7a3a2a040a9393674/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-08 00:19:33.876503 | 2026-01-08 00:19:33.876655 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-08 00:19:35.551442 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-08 00:19:35.551729 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6bd3458865a64eb7a3a2a040a9393674/work/6bd3458865a64eb7a3a2a040a9393674_id_rsa 2026-01-08 00:19:35.551770 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6bd3458865a64eb7a3a2a040a9393674/work/6bd3458865a64eb7a3a2a040a9393674_id_rsa.pub 2026-01-08 00:19:35.551797 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-08 00:19:35.551833 | debian-bookworm -> localhost | SHA256:AsH7deZ2SUuGRAf5MO1+2FHtuw6999LhTr9DTsgtYH4 zuul-build-sshkey 2026-01-08 00:19:35.551861 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-08 00:19:35.551896 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-08 00:19:35.551918 | debian-bookworm -> localhost | | .. .o+. .| 2026-01-08 00:19:35.551942 | debian-bookworm -> localhost | | .. =.. o| 2026-01-08 00:19:35.551973 | debian-bookworm -> localhost | | .. . * o | 2026-01-08 00:19:35.552006 | debian-bookworm -> localhost | | .. . +o* . .| 2026-01-08 00:19:35.552039 | debian-bookworm -> localhost | | ...S+o=o=o..| 2026-01-08 00:19:35.552072 | debian-bookworm -> localhost | | .. o.*E+* | 2026-01-08 00:19:35.552100 | debian-bookworm -> localhost | | . ..o*+o| 2026-01-08 00:19:35.552130 | debian-bookworm -> localhost | | +==| 2026-01-08 00:19:35.552153 | debian-bookworm -> localhost | | o*B| 2026-01-08 00:19:35.552174 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-08 00:19:35.552231 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.617686 2026-01-08 00:19:35.559510 | 2026-01-08 00:19:35.559715 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-08 00:19:35.637173 | debian-bookworm | ok 2026-01-08 00:19:35.671912 | debian-bookworm | included: /var/lib/zuul/builds/6bd3458865a64eb7a3a2a040a9393674/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-08 00:19:35.689051 | 2026-01-08 00:19:35.689192 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-08 00:19:35.713931 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:19:35.720299 | 2026-01-08 00:19:35.720430 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-08 00:19:36.472044 | debian-bookworm | changed 2026-01-08 00:19:36.482024 | 2026-01-08 00:19:36.482236 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-08 00:19:36.795817 | debian-bookworm | ok 2026-01-08 00:19:36.802069 | 2026-01-08 00:19:36.802215 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-08 00:19:37.500643 | debian-bookworm | changed 2026-01-08 00:19:37.508302 | 2026-01-08 00:19:37.508446 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-08 00:19:38.274494 | debian-bookworm | changed 2026-01-08 00:19:38.283498 | 2026-01-08 00:19:38.283720 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-08 00:19:38.308581 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:19:38.315542 | 2026-01-08 00:19:38.315738 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-08 00:19:38.845758 | debian-bookworm -> localhost | changed 2026-01-08 00:19:38.859050 | 2026-01-08 00:19:38.859199 | TASK [add-build-sshkey : Add back temp key] 2026-01-08 00:19:39.284969 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6bd3458865a64eb7a3a2a040a9393674/work/6bd3458865a64eb7a3a2a040a9393674_id_rsa (zuul-build-sshkey) 2026-01-08 00:19:39.285224 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012737 2026-01-08 00:19:39.295690 | 2026-01-08 00:19:39.295826 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-08 00:19:39.857465 | debian-bookworm | ok 2026-01-08 00:19:39.870242 | 2026-01-08 00:19:39.870390 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-08 00:19:39.915004 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:19:39.931806 | 2026-01-08 00:19:39.931955 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-08 00:19:40.509408 | debian-bookworm | ok 2026-01-08 00:19:40.521120 | 2026-01-08 00:19:40.521255 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-08 00:19:40.550622 | debian-bookworm | ok 2026-01-08 00:19:40.556309 | 2026-01-08 00:19:40.556427 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-08 00:19:40.945197 | debian-bookworm -> localhost | ok 2026-01-08 00:19:40.951909 | 2026-01-08 00:19:40.952028 | TASK [validate-host : Collect information about the host] 2026-01-08 00:19:42.267906 | debian-bookworm | ok 2026-01-08 00:19:42.278385 | 2026-01-08 00:19:42.278512 | TASK [validate-host : Sanitize hostname] 2026-01-08 00:19:42.390286 | debian-bookworm | ok 2026-01-08 00:19:42.458373 | 2026-01-08 00:19:42.458509 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-08 00:19:43.816608 | debian-bookworm -> localhost | changed 2026-01-08 00:19:43.822941 | 2026-01-08 00:19:43.823081 | TASK [validate-host : Collect information about zuul worker] 2026-01-08 00:19:44.443398 | debian-bookworm | ok 2026-01-08 00:19:44.456825 | 2026-01-08 00:19:44.457841 | TASK [validate-host : Write out all zuul information for each host] 2026-01-08 00:19:45.638716 | debian-bookworm -> localhost | changed 2026-01-08 00:19:45.659408 | 2026-01-08 00:19:45.659698 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-08 00:19:45.956889 | debian-bookworm | ok 2026-01-08 00:19:45.967936 | 2026-01-08 00:19:45.968126 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-08 00:19:47.037035 | debian-bookworm | changed: 2026-01-08 00:19:47.037439 | debian-bookworm | cd+++++++++ src/ 2026-01-08 00:19:47.037483 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-08 00:19:47.037509 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-08 00:19:47.037581 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-08 00:19:47.037606 | debian-bookworm | =6.2.4 2026-01-08 00:20:10.937674 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-08 00:20:10.978432 | debian-bookworm | Collecting chardet>=5.2 2026-01-08 00:20:10.991320 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-08 00:20:11.012831 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 10.7 MB/s eta 0:00:00 2026-01-08 00:20:11.066704 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-08 00:20:11.079254 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-08 00:20:11.152156 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-08 00:20:11.163761 | debian-bookworm | Downloading filelock-3.20.2-py3-none-any.whl (16 kB) 2026-01-08 00:20:11.220465 | debian-bookworm | Collecting packaging>=25 2026-01-08 00:20:11.232136 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2026-01-08 00:20:11.243479 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.2 MB/s eta 0:00:00 2026-01-08 00:20:11.313914 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-08 00:20:11.325762 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-08 00:20:11.388113 | debian-bookworm | Collecting pluggy>=1.6 2026-01-08 00:20:11.400095 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-08 00:20:11.467110 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-08 00:20:11.479816 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-08 00:20:11.633729 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-08 00:20:11.646316 | debian-bookworm | Downloading virtualenv-20.36.0-py3-none-any.whl (6.0 MB) 2026-01-08 00:20:11.952706 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 19.8 MB/s eta 0:00:00 2026-01-08 00:20:12.059182 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-08 00:20:12.070506 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-08 00:20:12.094765 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 22.1 MB/s eta 0:00:00 2026-01-08 00:20:12.253966 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-08 00:20:13.105982 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.2 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.33.0 virtualenv-20.36.0 2026-01-08 00:20:13.299916 | debian-bookworm | ok: Runtime: 0:00:03.204536 2026-01-08 00:20:13.306090 | 2026-01-08 00:20:13.306211 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-08 00:20:13.336945 | debian-bookworm | ok 2026-01-08 00:20:13.343023 | 2026-01-08 00:20:13.343152 | TASK [ensure-tox : Output tox version] 2026-01-08 00:20:13.886271 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-01-08 00:20:13.905025 | debian-bookworm | 4.33.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-08 00:20:14.376617 | debian-bookworm | ok: Runtime: 0:00:00.321071 2026-01-08 00:20:14.406788 | 2026-01-08 00:20:14.409442 | TASK [ensure-tox : Make global symlink] 2026-01-08 00:20:14.462378 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:14.474491 | 2026-01-08 00:20:14.474631 | PLAY RECAP 2026-01-08 00:20:14.474687 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-08 00:20:14.474711 | 2026-01-08 00:20:14.667278 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-08 00:20:14.668679 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-08 00:20:15.485183 | 2026-01-08 00:20:15.485355 | PLAY [all] 2026-01-08 00:20:15.502359 | 2026-01-08 00:20:15.502519 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-08 00:20:15.994947 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-08 00:20:16.063715 | debian-bookworm | ok: Runtime: 0:00:00.024882 2026-01-08 00:20:16.069519 | 2026-01-08 00:20:16.069718 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-08 00:20:16.600422 | debian-bookworm | ok: Runtime: 0:00:00.008272 2026-01-08 00:20:16.613305 | 2026-01-08 00:20:16.613488 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-08 00:20:16.940539 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-08 00:20:16.944418 | debian-bookworm | sudo: a password is required 2026-01-08 00:20:17.169973 | debian-bookworm | ok: Runtime: 0:00:00.025561 2026-01-08 00:20:17.201059 | 2026-01-08 00:20:17.201212 | TASK [tox : Check to see if the constraints file exists] 2026-01-08 00:20:17.226350 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:17.238622 | 2026-01-08 00:20:17.238821 | TASK [tox : Fail if constraints file is missing] 2026-01-08 00:20:17.296429 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:17.306905 | 2026-01-08 00:20:17.307132 | TASK [tox : Record file location] 2026-01-08 00:20:17.331737 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:17.342160 | 2026-01-08 00:20:17.342427 | TASK [tox : Install tox siblings] 2026-01-08 00:20:17.390112 | debian-bookworm | ok 2026-01-08 00:20:17.401659 | debian-bookworm | included: /var/lib/zuul/builds/6bd3458865a64eb7a3a2a040a9393674/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-08 00:20:17.407939 | 2026-01-08 00:20:17.408077 | TASK [tox : Run tox without tests] 2026-01-08 00:20:18.520243 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-08 00:20:33.639829 | debian-bookworm | test: OK (15.67 seconds) 2026-01-08 00:20:33.639880 | debian-bookworm | congratulations :) (15.70 seconds) 2026-01-08 00:20:33.952210 | debian-bookworm | ok: Runtime: 0:00:15.975735 2026-01-08 00:20:33.962275 | 2026-01-08 00:20:33.962439 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-08 00:20:34.507503 | debian-bookworm | changed 2026-01-08 00:20:34.516815 | 2026-01-08 00:20:34.516972 | TASK [tox : Get tox envlist config] 2026-01-08 00:20:35.553724 | debian-bookworm | ok: Runtime: 0:00:00.362775 2026-01-08 00:20:35.567271 | 2026-01-08 00:20:35.567449 | TASK [tox : Install any sibling python packages] 2026-01-08 00:20:36.133453 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-08 00:20:36.144758 | 2026-01-08 00:20:36.144935 | TASK [tox : Remove tempfile] 2026-01-08 00:20:36.620074 | debian-bookworm | changed 2026-01-08 00:20:36.631182 | 2026-01-08 00:20:36.631370 | TASK [tox : Emit tox command] 2026-01-08 00:20:36.684320 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-08 00:20:36.691698 | 2026-01-08 00:20:36.691874 | TASK [tox : Run tox] 2026-01-08 00:20:37.366188 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-08 00:20:38.019480 | debian-bookworm | ............... 2026-01-08 00:20:38.019542 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-08 00:20:38.019559 | debian-bookworm | Ran 15 tests in 0.170s 2026-01-08 00:20:38.019565 | debian-bookworm | 2026-01-08 00:20:38.019574 | debian-bookworm | OK 2026-01-08 00:20:38.121083 | debian-bookworm | test: OK (0.80=setup[0.05]+cmd[0.75] seconds) 2026-01-08 00:20:38.121161 | debian-bookworm | congratulations :) (0.83 seconds) 2026-01-08 00:20:38.260640 | debian-bookworm | ok: Runtime: 0:00:01.175755 2026-01-08 00:20:38.271198 | 2026-01-08 00:20:38.271347 | TASK [tox : Look for output] 2026-01-08 00:20:38.697577 | debian-bookworm | ok 2026-01-08 00:20:38.717422 | 2026-01-08 00:20:38.717596 | TASK [tox : Return file comments to Zuul] 2026-01-08 00:20:38.762975 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:38.778903 | 2026-01-08 00:20:38.779062 | PLAY RECAP 2026-01-08 00:20:38.779147 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-08 00:20:38.779188 | 2026-01-08 00:20:38.939103 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-08 00:20:38.942269 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-08 00:20:39.743740 | 2026-01-08 00:20:39.743957 | PLAY [all] 2026-01-08 00:20:39.761994 | 2026-01-08 00:20:39.762256 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-08 00:20:39.828476 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:39.835192 | 2026-01-08 00:20:39.835354 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-08 00:20:39.892733 | debian-bookworm | ok 2026-01-08 00:20:39.901276 | 2026-01-08 00:20:39.901482 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-08 00:20:40.454590 | debian-bookworm -> localhost | changed 2026-01-08 00:20:40.463383 | 2026-01-08 00:20:40.463560 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-08 00:20:40.518969 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:40.532817 | 2026-01-08 00:20:40.533083 | TASK [fetch-tox-output : Set envlist fact] 2026-01-08 00:20:40.582346 | debian-bookworm | ok 2026-01-08 00:20:40.592267 | 2026-01-08 00:20:40.592429 | TASK [fetch-tox-output : Get tox version] 2026-01-08 00:20:41.284871 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-01-08 00:20:41.302057 | debian-bookworm | 4.33.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-08 00:20:41.631515 | debian-bookworm | ok: Runtime: 0:00:00.260473 2026-01-08 00:20:41.646476 | 2026-01-08 00:20:41.646732 | TASK [fetch-tox-output : Find all default environments] 2026-01-08 00:20:42.183821 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:42.196188 | 2026-01-08 00:20:42.196388 | TASK [fetch-tox-output : Set envlist fact] 2026-01-08 00:20:42.232266 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:42.248058 | 2026-01-08 00:20:42.248259 | TASK [fetch-tox-output : Find all default environments] 2026-01-08 00:20:42.785821 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:42.800451 | 2026-01-08 00:20:42.800674 | TASK [fetch-tox-output : Set envlist fact] 2026-01-08 00:20:42.837493 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:42.859840 | 2026-01-08 00:20:42.860013 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-08 00:20:42.922796 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:42.948905 | 2026-01-08 00:20:42.949202 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-08 00:20:43.810314 | debian-bookworm | changed: 2026-01-08 00:20:43.810600 | debian-bookworm | created directory /var/lib/zuul/builds/6bd3458865a64eb7a3a2a040a9393674/work/logs/tox/test 2026-01-08 00:20:43.810653 | debian-bookworm | cd+++++++++ ./ 2026-01-08 00:20:43.810691 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-08 00:20:43.810735 | 2026-01-08 00:20:43.832116 | 2026-01-08 00:20:43.832356 | PLAY RECAP 2026-01-08 00:20:43.832941 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-08 00:20:43.833021 | 2026-01-08 00:20:43.995385 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-08 00:20:43.998159 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-08 00:20:44.763217 | 2026-01-08 00:20:44.763402 | PLAY [all] 2026-01-08 00:20:44.781224 | 2026-01-08 00:20:44.781398 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-08 00:20:45.064012 | debian-bookworm | changed: non-zero return code 2026-01-08 00:20:45.073955 | 2026-01-08 00:20:45.074204 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-08 00:20:45.105066 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:45.118101 | 2026-01-08 00:20:45.118279 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-08 00:20:45.156305 | 2026-01-08 00:20:45.158955 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-08 00:20:45.213264 | 2026-01-08 00:20:45.213610 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-08 00:20:45.239495 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:45.251512 | 2026-01-08 00:20:45.251853 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-08 00:20:45.289385 | 2026-01-08 00:20:45.289728 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-08 00:20:45.325215 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:45.338861 | 2026-01-08 00:20:45.339059 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-08 00:20:45.364578 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:45.378772 | 2026-01-08 00:20:45.378994 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-08 00:20:45.404344 | debian-bookworm | skipping: Conditional result was False 2026-01-08 00:20:45.419053 | 2026-01-08 00:20:45.419210 | PLAY RECAP 2026-01-08 00:20:45.419345 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-08 00:20:45.419387 | 2026-01-08 00:20:45.573787 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-08 00:20:45.575355 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-08 00:20:46.384137 | 2026-01-08 00:20:46.384318 | PLAY [Base post] 2026-01-08 00:20:46.399742 | 2026-01-08 00:20:46.399906 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-08 00:20:47.110047 | debian-bookworm | changed 2026-01-08 00:20:47.122257 | 2026-01-08 00:20:47.122423 | PLAY RECAP 2026-01-08 00:20:47.122520 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-08 00:20:47.122646 | 2026-01-08 00:20:47.268556 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-08 00:20:47.270626 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-08 00:20:48.105277 | 2026-01-08 00:20:48.105509 | PLAY [Base post-logs] 2026-01-08 00:20:48.117226 | 2026-01-08 00:20:48.117386 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-08 00:20:48.659443 | localhost | changed 2026-01-08 00:20:48.677753 | 2026-01-08 00:20:48.677943 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-08 00:20:48.705801 | localhost | ok 2026-01-08 00:20:48.709209 | 2026-01-08 00:20:48.709314 | TASK [Set zuul-log-path fact] 2026-01-08 00:20:48.737313 | localhost | ok 2026-01-08 00:20:48.753937 | 2026-01-08 00:20:48.754136 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-08 00:20:48.792152 | localhost | ok 2026-01-08 00:20:48.798445 | 2026-01-08 00:20:48.798769 | TASK [upload-logs : Create log directories] 2026-01-08 00:20:49.366484 | localhost | changed 2026-01-08 00:20:49.370933 | 2026-01-08 00:20:49.371080 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-08 00:20:49.961320 | localhost -> localhost | ok: Runtime: 0:00:00.007823 2026-01-08 00:20:49.970769 | 2026-01-08 00:20:49.971015 | TASK [upload-logs : Upload logs to log server] 2026-01-08 00:20:50.635932 | localhost | Output suppressed because no_log was given 2026-01-08 00:20:50.638921 | 2026-01-08 00:20:50.639082 | LOOP [upload-logs : Compress console log and json output] 2026-01-08 00:20:50.704095 | localhost | skipping: Conditional result was False 2026-01-08 00:20:50.709453 | localhost | skipping: Conditional result was False 2026-01-08 00:20:50.722912 | 2026-01-08 00:20:50.723158 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-08 00:20:50.801764 | localhost | skipping: Conditional result was False 2026-01-08 00:20:50.802309 | 2026-01-08 00:20:50.816673 | localhost | skipping: Conditional result was False 2026-01-08 00:20:50.828135 | 2026-01-08 00:20:50.828623 | LOOP [upload-logs : Upload console log and json output]