2025-12-26 03:17:28.091905 | Job console starting 2025-12-26 03:17:28.101884 | Updating git repos 2025-12-26 03:17:28.167482 | Cloning repos into workspace 2025-12-26 03:17:28.304003 | Restoring repo states 2025-12-26 03:17:28.336196 | Merging changes 2025-12-26 03:17:28.336216 | Checking out repos 2025-12-26 03:17:28.426891 | Preparing playbooks 2025-12-26 03:17:29.521099 | Running Ansible setup 2025-12-26 03:17:37.274430 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-26 03:17:39.189512 | 2025-12-26 03:17:39.189688 | PLAY [Base pre] 2025-12-26 03:17:39.209778 | 2025-12-26 03:17:39.209956 | TASK [Setup log path fact] 2025-12-26 03:17:39.266464 | debian-bookworm | ok 2025-12-26 03:17:39.295943 | 2025-12-26 03:17:39.296121 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-26 03:17:39.343683 | debian-bookworm | ok 2025-12-26 03:17:39.377129 | 2025-12-26 03:17:39.377340 | TASK [emit-job-header : Print job information] 2025-12-26 03:17:39.476707 | # Job Information 2025-12-26 03:17:39.477004 | Ansible Version: 2.16.14 2025-12-26 03:17:39.477045 | Job: tox 2025-12-26 03:17:39.477082 | Pipeline: periodic-daily 2025-12-26 03:17:39.477109 | Executor: 521e9411259a 2025-12-26 03:17:39.477129 | Triggered by: https://github.com/osism/openstack-image-manager 2025-12-26 03:17:39.477151 | Event ID: 75edb56357924aa7b1e710838955dcca 2025-12-26 03:17:39.488562 | 2025-12-26 03:17:39.490994 | LOOP [emit-job-header : Print node information] 2025-12-26 03:17:39.804982 | debian-bookworm | ok: 2025-12-26 03:17:39.805289 | debian-bookworm | # Node Information 2025-12-26 03:17:39.805377 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-26 03:17:39.805405 | debian-bookworm | Hostname: debian 2025-12-26 03:17:39.805428 | debian-bookworm | Username: zuul 2025-12-26 03:17:39.805449 | debian-bookworm | Distro: Debian 12.12 2025-12-26 03:17:39.805473 | debian-bookworm | Provider: regiocloud-a 2025-12-26 03:17:39.805494 | debian-bookworm | Region: 2025-12-26 03:17:39.805596 | debian-bookworm | Label: debian-bookworm 2025-12-26 03:17:39.805624 | debian-bookworm | Product Name: OpenStack Nova 2025-12-26 03:17:39.805645 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fecb:e5a0 2025-12-26 03:17:39.834968 | 2025-12-26 03:17:39.835138 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-26 03:17:41.493420 | debian-bookworm -> localhost | changed 2025-12-26 03:17:41.501816 | 2025-12-26 03:17:41.501962 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-26 03:17:44.370216 | debian-bookworm -> localhost | changed 2025-12-26 03:17:44.386241 | 2025-12-26 03:17:44.386421 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-26 03:17:45.192118 | debian-bookworm -> localhost | ok 2025-12-26 03:17:45.199685 | 2025-12-26 03:17:45.199849 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-26 03:17:45.254447 | debian-bookworm | ok 2025-12-26 03:17:45.342773 | debian-bookworm | included: /var/lib/zuul/builds/613c55b2bc4b48cd94708693bb3b1167/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-26 03:17:45.376262 | 2025-12-26 03:17:45.376449 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-26 03:17:48.226682 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-26 03:17:48.227244 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/613c55b2bc4b48cd94708693bb3b1167/work/613c55b2bc4b48cd94708693bb3b1167_id_rsa 2025-12-26 03:17:48.230511 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/613c55b2bc4b48cd94708693bb3b1167/work/613c55b2bc4b48cd94708693bb3b1167_id_rsa.pub 2025-12-26 03:17:48.230661 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-26 03:17:48.230714 | debian-bookworm -> localhost | SHA256:oyvY0b/XAk4ad++jenNPzmtQIOtYwOrRuXBTJG/+RU8 zuul-build-sshkey 2025-12-26 03:17:48.230750 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-26 03:17:48.230803 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-26 03:17:48.230941 | debian-bookworm -> localhost | | .... | 2025-12-26 03:17:48.230969 | debian-bookworm -> localhost | | ooo . | 2025-12-26 03:17:48.230991 | debian-bookworm -> localhost | | o +oo .. E| 2025-12-26 03:17:48.231012 | debian-bookworm -> localhost | | + =oo ..o | 2025-12-26 03:17:48.231032 | debian-bookworm -> localhost | | o +S*. .. .| 2025-12-26 03:17:48.231062 | debian-bookworm -> localhost | | . +.*.o... | 2025-12-26 03:17:48.231083 | debian-bookworm -> localhost | | o ..B o o... | 2025-12-26 03:17:48.231104 | debian-bookworm -> localhost | | . o ..o = =+. | 2025-12-26 03:17:48.231126 | debian-bookworm -> localhost | | .. o=.*.+=. | 2025-12-26 03:17:48.231149 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-26 03:17:48.231223 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.579901 2025-12-26 03:17:48.247156 | 2025-12-26 03:17:48.248062 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-26 03:17:48.363595 | debian-bookworm | ok 2025-12-26 03:17:48.434015 | debian-bookworm | included: /var/lib/zuul/builds/613c55b2bc4b48cd94708693bb3b1167/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-26 03:17:48.470242 | 2025-12-26 03:17:48.470431 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-26 03:17:48.509542 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:17:48.538615 | 2025-12-26 03:17:48.538770 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-26 03:17:49.861514 | debian-bookworm | changed 2025-12-26 03:17:49.898762 | 2025-12-26 03:17:49.898940 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-26 03:17:50.314173 | debian-bookworm | ok 2025-12-26 03:17:50.354277 | 2025-12-26 03:17:50.354471 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-26 03:17:51.330252 | debian-bookworm | changed 2025-12-26 03:17:51.386278 | 2025-12-26 03:17:51.386502 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-26 03:17:52.213082 | debian-bookworm | changed 2025-12-26 03:17:52.241926 | 2025-12-26 03:17:52.242077 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-26 03:17:52.296062 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:17:52.324280 | 2025-12-26 03:17:52.324463 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-26 03:17:53.921518 | debian-bookworm -> localhost | changed 2025-12-26 03:17:53.958151 | 2025-12-26 03:17:53.958320 | TASK [add-build-sshkey : Add back temp key] 2025-12-26 03:17:55.094164 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/613c55b2bc4b48cd94708693bb3b1167/work/613c55b2bc4b48cd94708693bb3b1167_id_rsa (zuul-build-sshkey) 2025-12-26 03:17:55.094465 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.035093 2025-12-26 03:17:55.102981 | 2025-12-26 03:17:55.107323 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-26 03:17:55.860192 | debian-bookworm | ok 2025-12-26 03:17:55.867598 | 2025-12-26 03:17:55.867736 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-26 03:17:55.954764 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:17:55.973279 | 2025-12-26 03:17:55.973472 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-26 03:17:56.971336 | debian-bookworm | ok 2025-12-26 03:17:57.001054 | 2025-12-26 03:17:57.030894 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-26 03:17:57.102417 | debian-bookworm | ok 2025-12-26 03:17:57.114456 | 2025-12-26 03:17:57.114613 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-26 03:17:58.473365 | debian-bookworm -> localhost | ok 2025-12-26 03:17:58.482342 | 2025-12-26 03:17:58.482483 | TASK [validate-host : Collect information about the host] 2025-12-26 03:18:00.608200 | debian-bookworm | ok 2025-12-26 03:18:00.643132 | 2025-12-26 03:18:00.643288 | TASK [validate-host : Sanitize hostname] 2025-12-26 03:18:00.961318 | debian-bookworm | ok 2025-12-26 03:18:01.175115 | 2025-12-26 03:18:01.175303 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-26 03:18:02.635124 | debian-bookworm -> localhost | changed 2025-12-26 03:18:02.656733 | 2025-12-26 03:18:02.663160 | TASK [validate-host : Collect information about zuul worker] 2025-12-26 03:18:03.329641 | debian-bookworm | ok 2025-12-26 03:18:03.334863 | 2025-12-26 03:18:03.334997 | TASK [validate-host : Write out all zuul information for each host] 2025-12-26 03:18:04.874641 | debian-bookworm -> localhost | changed 2025-12-26 03:18:04.893125 | 2025-12-26 03:18:04.893270 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-26 03:18:05.257300 | debian-bookworm | ok 2025-12-26 03:18:05.267771 | 2025-12-26 03:18:05.267924 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-26 03:18:08.303970 | debian-bookworm | changed: 2025-12-26 03:18:08.304208 | debian-bookworm | cd+++++++++ src/ 2025-12-26 03:18:08.304243 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-26 03:18:08.304268 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-26 03:18:08.304329 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-26 03:18:08.304353 | debian-bookworm | =6.2 2025-12-26 03:18:37.989659 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2025-12-26 03:18:38.026080 | debian-bookworm | Collecting chardet>=5.2 2025-12-26 03:18:38.038879 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-26 03:18:38.064356 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 9.7 MB/s eta 0:00:00 2025-12-26 03:18:38.109684 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-26 03:18:38.122592 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-26 03:18:38.198663 | debian-bookworm | Collecting filelock>=3.20 2025-12-26 03:18:38.211470 | debian-bookworm | Downloading filelock-3.20.1-py3-none-any.whl (16 kB) 2025-12-26 03:18:38.274062 | debian-bookworm | Collecting packaging>=25 2025-12-26 03:18:38.286254 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-26 03:18:38.299094 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 8.4 MB/s eta 0:00:00 2025-12-26 03:18:38.362585 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-26 03:18:38.374795 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-26 03:18:38.430419 | debian-bookworm | Collecting pluggy>=1.6 2025-12-26 03:18:38.443467 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-26 03:18:38.499637 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-26 03:18:38.513519 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-26 03:18:38.646969 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-26 03:18:38.659421 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-26 03:18:38.986904 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 18.6 MB/s eta 0:00:00 2025-12-26 03:18:39.092280 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-26 03:18:39.106224 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-26 03:18:39.134217 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 23.7 MB/s eta 0:00:00 2025-12-26 03:18:39.371088 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-26 03:18:40.251951 | 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-26 03:18:40.795398 | debian-bookworm | ok: Runtime: 0:00:03.289764 2025-12-26 03:18:40.810405 | 2025-12-26 03:18:40.810554 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-26 03:18:40.947042 | debian-bookworm | ok 2025-12-26 03:18:40.977557 | 2025-12-26 03:18:40.978223 | TASK [ensure-tox : Output tox version] 2025-12-26 03:18:41.708185 | 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-26 03:18:41.727101 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-26 03:18:42.132649 | debian-bookworm | ok: Runtime: 0:00:00.309836 2025-12-26 03:18:42.143885 | 2025-12-26 03:18:42.144011 | TASK [ensure-tox : Make global symlink] 2025-12-26 03:18:42.184649 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:18:42.195215 | 2025-12-26 03:18:42.195368 | PLAY RECAP 2025-12-26 03:18:42.195439 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-26 03:18:42.195469 | 2025-12-26 03:18:42.639173 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-26 03:18:42.640338 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-26 03:18:44.722574 | 2025-12-26 03:18:44.722747 | PLAY [all] 2025-12-26 03:18:44.788813 | 2025-12-26 03:18:44.788992 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-26 03:18:45.688254 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-26 03:18:45.891396 | debian-bookworm | ok: Runtime: 0:00:00.023979 2025-12-26 03:18:45.897804 | 2025-12-26 03:18:45.897947 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-26 03:18:46.477866 | debian-bookworm | ok: Runtime: 0:00:00.007573 2025-12-26 03:18:46.486026 | 2025-12-26 03:18:46.486182 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-26 03:18:46.928312 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-26 03:18:46.932136 | debian-bookworm | sudo: a password is required 2025-12-26 03:18:47.069457 | debian-bookworm | ok: Runtime: 0:00:00.025274 2025-12-26 03:18:47.092086 | 2025-12-26 03:18:47.092235 | TASK [tox : Check to see if the constraints file exists] 2025-12-26 03:18:47.173167 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:18:47.180487 | 2025-12-26 03:18:47.180622 | TASK [tox : Fail if constraints file is missing] 2025-12-26 03:18:47.283443 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:18:47.291429 | 2025-12-26 03:18:47.291585 | TASK [tox : Record file location] 2025-12-26 03:18:47.359892 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:18:47.367007 | 2025-12-26 03:18:47.367155 | TASK [tox : Install tox siblings] 2025-12-26 03:18:47.431797 | debian-bookworm | ok 2025-12-26 03:18:47.448573 | debian-bookworm | included: /var/lib/zuul/builds/613c55b2bc4b48cd94708693bb3b1167/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-26 03:18:47.455497 | 2025-12-26 03:18:47.455635 | TASK [tox : Run tox without tests] 2025-12-26 03:18:48.774928 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-26 03:19:02.787205 | debian-bookworm | test: OK (14.57 seconds) 2025-12-26 03:19:02.787355 | debian-bookworm | congratulations :) (14.60 seconds) 2025-12-26 03:19:03.013145 | debian-bookworm | ok: Runtime: 0:00:14.895062 2025-12-26 03:19:03.019190 | 2025-12-26 03:19:03.019342 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-26 03:19:04.719709 | debian-bookworm | changed 2025-12-26 03:19:04.732158 | 2025-12-26 03:19:04.732438 | TASK [tox : Get tox envlist config] 2025-12-26 03:19:05.813006 | debian-bookworm | ok: Runtime: 0:00:00.370223 2025-12-26 03:19:05.826149 | 2025-12-26 03:19:05.826343 | TASK [tox : Install any sibling python packages] 2025-12-26 03:19:06.973764 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-26 03:19:06.984669 | 2025-12-26 03:19:06.984869 | TASK [tox : Remove tempfile] 2025-12-26 03:19:07.968505 | debian-bookworm | changed 2025-12-26 03:19:07.978006 | 2025-12-26 03:19:07.978148 | TASK [tox : Emit tox command] 2025-12-26 03:19:08.020382 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-26 03:19:08.025988 | 2025-12-26 03:19:08.026140 | TASK [tox : Run tox] 2025-12-26 03:19:08.852955 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-26 03:19:09.504361 | debian-bookworm | ............... 2025-12-26 03:19:09.504412 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-26 03:19:09.504427 | debian-bookworm | Ran 15 tests in 0.169s 2025-12-26 03:19:09.504433 | debian-bookworm | 2025-12-26 03:19:09.504442 | debian-bookworm | OK 2025-12-26 03:19:09.608392 | debian-bookworm | test: OK (0.80=setup[0.05]+cmd[0.75] seconds) 2025-12-26 03:19:09.608495 | debian-bookworm | congratulations :) (0.83 seconds) 2025-12-26 03:19:10.142947 | debian-bookworm | ok: Runtime: 0:00:01.119916 2025-12-26 03:19:10.151851 | 2025-12-26 03:19:10.152781 | TASK [tox : Look for output] 2025-12-26 03:19:10.837052 | debian-bookworm | ok 2025-12-26 03:19:10.936154 | 2025-12-26 03:19:10.936340 | TASK [tox : Return file comments to Zuul] 2025-12-26 03:19:11.032616 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:11.043696 | 2025-12-26 03:19:11.043837 | PLAY RECAP 2025-12-26 03:19:11.044820 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-26 03:19:11.044911 | 2025-12-26 03:19:11.497420 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-26 03:19:11.498685 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-26 03:19:14.122500 | 2025-12-26 03:19:14.122689 | PLAY [all] 2025-12-26 03:19:14.141865 | 2025-12-26 03:19:14.142055 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-26 03:19:14.339343 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:14.347817 | 2025-12-26 03:19:14.348039 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-26 03:19:14.430090 | debian-bookworm | ok 2025-12-26 03:19:14.439244 | 2025-12-26 03:19:14.439433 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-26 03:19:15.447528 | debian-bookworm -> localhost | changed 2025-12-26 03:19:15.456041 | 2025-12-26 03:19:15.456182 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-26 03:19:15.538151 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:15.545414 | 2025-12-26 03:19:15.545565 | TASK [fetch-tox-output : Set envlist fact] 2025-12-26 03:19:15.595995 | debian-bookworm | ok 2025-12-26 03:19:15.615962 | 2025-12-26 03:19:15.616105 | TASK [fetch-tox-output : Get tox version] 2025-12-26 03:19:16.825832 | 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-26 03:19:16.843975 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-26 03:19:17.223451 | debian-bookworm | ok: Runtime: 0:00:00.296391 2025-12-26 03:19:17.229159 | 2025-12-26 03:19:17.229317 | TASK [fetch-tox-output : Find all default environments] 2025-12-26 03:19:17.777727 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:17.784520 | 2025-12-26 03:19:17.784675 | TASK [fetch-tox-output : Set envlist fact] 2025-12-26 03:19:17.819297 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:17.829007 | 2025-12-26 03:19:17.829204 | TASK [fetch-tox-output : Find all default environments] 2025-12-26 03:19:18.360980 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:18.367364 | 2025-12-26 03:19:18.367509 | TASK [fetch-tox-output : Set envlist fact] 2025-12-26 03:19:18.393081 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:18.400856 | 2025-12-26 03:19:18.401016 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-26 03:19:18.460344 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:18.478153 | 2025-12-26 03:19:18.478686 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-26 03:19:19.514319 | debian-bookworm | changed: 2025-12-26 03:19:19.514533 | debian-bookworm | created directory /var/lib/zuul/builds/613c55b2bc4b48cd94708693bb3b1167/work/logs/tox/test 2025-12-26 03:19:19.514568 | debian-bookworm | cd+++++++++ ./ 2025-12-26 03:19:19.514594 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-26 03:19:19.514627 | 2025-12-26 03:19:19.532098 | 2025-12-26 03:19:19.532281 | PLAY RECAP 2025-12-26 03:19:19.532342 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-26 03:19:19.532367 | 2025-12-26 03:19:19.711222 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-26 03:19:19.712425 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-26 03:19:20.866907 | 2025-12-26 03:19:20.867083 | PLAY [all] 2025-12-26 03:19:20.887100 | 2025-12-26 03:19:20.887290 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-26 03:19:21.156699 | debian-bookworm | changed: non-zero return code 2025-12-26 03:19:21.162942 | 2025-12-26 03:19:21.163103 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-26 03:19:21.187759 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:21.194212 | 2025-12-26 03:19:21.194382 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-26 03:19:21.250885 | 2025-12-26 03:19:21.251237 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-26 03:19:21.306035 | 2025-12-26 03:19:21.306240 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-26 03:19:21.332556 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:21.339927 | 2025-12-26 03:19:21.340074 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-26 03:19:21.372901 | 2025-12-26 03:19:21.373204 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-26 03:19:21.398244 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:21.408966 | 2025-12-26 03:19:21.409195 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-26 03:19:21.467150 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:21.499362 | 2025-12-26 03:19:21.499519 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-26 03:19:21.529655 | debian-bookworm | skipping: Conditional result was False 2025-12-26 03:19:21.537358 | 2025-12-26 03:19:21.537461 | PLAY RECAP 2025-12-26 03:19:21.537515 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-26 03:19:21.537540 | 2025-12-26 03:19:21.909132 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-26 03:19:21.910243 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-26 03:19:22.774927 | 2025-12-26 03:19:22.775117 | PLAY [Base post] 2025-12-26 03:19:22.790887 | 2025-12-26 03:19:22.791046 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-26 03:19:23.393529 | debian-bookworm | changed 2025-12-26 03:19:23.402557 | 2025-12-26 03:19:23.402730 | PLAY RECAP 2025-12-26 03:19:23.402802 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-26 03:19:23.402892 | 2025-12-26 03:19:23.573504 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-26 03:19:23.574642 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-26 03:19:24.466379 | 2025-12-26 03:19:24.466567 | PLAY [Base post-logs] 2025-12-26 03:19:24.478050 | 2025-12-26 03:19:24.478216 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-26 03:19:24.947830 | localhost | changed 2025-12-26 03:19:24.963907 | 2025-12-26 03:19:24.964085 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-26 03:19:24.990238 | localhost | ok 2025-12-26 03:19:24.994076 | 2025-12-26 03:19:24.994193 | TASK [Set zuul-log-path fact] 2025-12-26 03:19:25.010130 | localhost | ok 2025-12-26 03:19:25.021322 | 2025-12-26 03:19:25.021469 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-26 03:19:25.059698 | localhost | ok 2025-12-26 03:19:25.063351 | 2025-12-26 03:19:25.063479 | TASK [upload-logs : Create log directories] 2025-12-26 03:19:25.713791 | localhost | changed 2025-12-26 03:19:25.719978 | 2025-12-26 03:19:25.720108 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-26 03:19:26.357849 | localhost -> localhost | ok: Runtime: 0:00:00.010953 2025-12-26 03:19:26.367296 | 2025-12-26 03:19:26.367481 | TASK [upload-logs : Upload logs to log server] 2025-12-26 03:19:26.972855 | localhost | Output suppressed because no_log was given 2025-12-26 03:19:26.974739 | 2025-12-26 03:19:26.974902 | LOOP [upload-logs : Compress console log and json output] 2025-12-26 03:19:27.034194 | localhost | skipping: Conditional result was False 2025-12-26 03:19:27.039891 | localhost | skipping: Conditional result was False 2025-12-26 03:19:27.046810 | 2025-12-26 03:19:27.047033 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-26 03:19:27.112914 | localhost | skipping: Conditional result was False 2025-12-26 03:19:27.113622 | 2025-12-26 03:19:27.116988 | localhost | skipping: Conditional result was False 2025-12-26 03:19:27.131471 | 2025-12-26 03:19:27.131910 | LOOP [upload-logs : Upload console log and json output]