2025-11-13 18:33:28.139311 | Job console starting 2025-11-13 18:33:28.155456 | Updating git repos 2025-11-13 18:33:28.202513 | Cloning repos into workspace 2025-11-13 18:33:28.329902 | Restoring repo states 2025-11-13 18:33:28.348954 | Merging changes 2025-11-13 18:33:28.841040 | Checking out repos 2025-11-13 18:33:28.893513 | Preparing playbooks 2025-11-13 18:33:29.828745 | Running Ansible setup 2025-11-13 18:33:35.645178 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-13 18:33:36.924310 | 2025-11-13 18:33:36.924479 | PLAY [Base pre] 2025-11-13 18:33:36.950649 | 2025-11-13 18:33:36.950803 | TASK [Setup log path fact] 2025-11-13 18:33:36.991369 | debian-bookworm | ok 2025-11-13 18:33:37.018413 | 2025-11-13 18:33:37.018575 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-13 18:33:37.071452 | debian-bookworm | ok 2025-11-13 18:33:37.090584 | 2025-11-13 18:33:37.090737 | TASK [emit-job-header : Print job information] 2025-11-13 18:33:37.162459 | # Job Information 2025-11-13 18:33:37.162650 | Ansible Version: 2.16.14 2025-11-13 18:33:37.162685 | Job: tox 2025-11-13 18:33:37.162718 | Pipeline: check 2025-11-13 18:33:37.162740 | Executor: 521e9411259a 2025-11-13 18:33:37.162761 | Triggered by: https://github.com/osism/openstack-image-manager/pull/992 2025-11-13 18:33:37.162783 | Event ID: 39b49d70-c0bf-11f0-9bcf-5367ff8a616f 2025-11-13 18:33:37.168002 | 2025-11-13 18:33:37.168172 | LOOP [emit-job-header : Print node information] 2025-11-13 18:33:37.333838 | debian-bookworm | ok: 2025-11-13 18:33:37.334098 | debian-bookworm | # Node Information 2025-11-13 18:33:37.334139 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-13 18:33:37.334165 | debian-bookworm | Hostname: debian 2025-11-13 18:33:37.334188 | debian-bookworm | Username: zuul 2025-11-13 18:33:37.334209 | debian-bookworm | Distro: Debian 12.12 2025-11-13 18:33:37.334234 | debian-bookworm | Provider: regiocloud-a 2025-11-13 18:33:37.334256 | debian-bookworm | Region: 2025-11-13 18:33:37.334277 | debian-bookworm | Label: debian-bookworm 2025-11-13 18:33:37.334296 | debian-bookworm | Product Name: OpenStack Nova 2025-11-13 18:33:37.334316 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee5:e5fe 2025-11-13 18:33:37.348116 | 2025-11-13 18:33:37.348274 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-13 18:33:38.336250 | debian-bookworm -> localhost | changed 2025-11-13 18:33:38.344943 | 2025-11-13 18:33:38.345104 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-13 18:33:39.957485 | debian-bookworm -> localhost | changed 2025-11-13 18:33:39.970197 | 2025-11-13 18:33:39.970344 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-13 18:33:40.511599 | debian-bookworm -> localhost | ok 2025-11-13 18:33:40.518125 | 2025-11-13 18:33:40.518284 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-13 18:33:40.558330 | debian-bookworm | ok 2025-11-13 18:33:40.598373 | debian-bookworm | included: /var/lib/zuul/builds/f8feddcfdd7c45dbaa82126ea593913c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-13 18:33:40.615334 | 2025-11-13 18:33:40.615466 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-13 18:33:43.026897 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-13 18:33:43.027156 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f8feddcfdd7c45dbaa82126ea593913c/work/f8feddcfdd7c45dbaa82126ea593913c_id_rsa 2025-11-13 18:33:43.027198 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f8feddcfdd7c45dbaa82126ea593913c/work/f8feddcfdd7c45dbaa82126ea593913c_id_rsa.pub 2025-11-13 18:33:43.027225 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-13 18:33:43.027253 | debian-bookworm -> localhost | SHA256:ufsDzj4qGmdO7wTZxrmwUb1W+UU7QiDSmaprEWBFdU0 zuul-build-sshkey 2025-11-13 18:33:43.027277 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-13 18:33:43.027314 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-13 18:33:43.027336 | debian-bookworm -> localhost | | oo.o.o=E.. . | 2025-11-13 18:33:43.027358 | debian-bookworm -> localhost | | o ++..o . . | 2025-11-13 18:33:43.027378 | debian-bookworm -> localhost | | . . ... o . + | 2025-11-13 18:33:43.027397 | debian-bookworm -> localhost | | .=.. + . o . | 2025-11-13 18:33:43.027416 | debian-bookworm -> localhost | | =o= S . | 2025-11-13 18:33:43.027444 | debian-bookworm -> localhost | | o* o.. | 2025-11-13 18:33:43.027467 | debian-bookworm -> localhost | | . =ooo.. | 2025-11-13 18:33:43.027487 | debian-bookworm -> localhost | | *+o +.. | 2025-11-13 18:33:43.027508 | debian-bookworm -> localhost | | .o.o+ooo.. | 2025-11-13 18:33:43.027529 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-13 18:33:43.027587 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.569844 2025-11-13 18:33:43.034903 | 2025-11-13 18:33:43.035058 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-13 18:33:43.097816 | debian-bookworm | ok 2025-11-13 18:33:43.108847 | debian-bookworm | included: /var/lib/zuul/builds/f8feddcfdd7c45dbaa82126ea593913c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-13 18:33:43.119138 | 2025-11-13 18:33:43.119250 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-13 18:33:43.143447 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:33:43.150200 | 2025-11-13 18:33:43.150318 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-13 18:33:43.856902 | debian-bookworm | changed 2025-11-13 18:33:43.862564 | 2025-11-13 18:33:43.862672 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-13 18:33:44.128906 | debian-bookworm | ok 2025-11-13 18:33:44.134978 | 2025-11-13 18:33:44.135130 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-13 18:33:44.823769 | debian-bookworm | changed 2025-11-13 18:33:44.832189 | 2025-11-13 18:33:44.832352 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-13 18:33:45.495489 | debian-bookworm | changed 2025-11-13 18:33:45.511949 | 2025-11-13 18:33:45.512143 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-13 18:33:45.577181 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:33:45.585264 | 2025-11-13 18:33:45.585429 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-13 18:33:46.210937 | debian-bookworm -> localhost | changed 2025-11-13 18:33:46.229477 | 2025-11-13 18:33:46.229645 | TASK [add-build-sshkey : Add back temp key] 2025-11-13 18:33:46.680228 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f8feddcfdd7c45dbaa82126ea593913c/work/f8feddcfdd7c45dbaa82126ea593913c_id_rsa (zuul-build-sshkey) 2025-11-13 18:33:46.680483 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015064 2025-11-13 18:33:46.689187 | 2025-11-13 18:33:46.689329 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-13 18:33:47.117597 | debian-bookworm | ok 2025-11-13 18:33:47.134103 | 2025-11-13 18:33:47.134312 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-13 18:33:47.158753 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:33:47.169753 | 2025-11-13 18:33:47.169884 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-13 18:33:47.666649 | debian-bookworm | ok 2025-11-13 18:33:47.677763 | 2025-11-13 18:33:47.677893 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-13 18:33:47.707401 | debian-bookworm | ok 2025-11-13 18:33:47.712659 | 2025-11-13 18:33:47.712780 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-13 18:33:48.052532 | debian-bookworm -> localhost | ok 2025-11-13 18:33:48.059342 | 2025-11-13 18:33:48.059471 | TASK [validate-host : Collect information about the host] 2025-11-13 18:33:49.254940 | debian-bookworm | ok 2025-11-13 18:33:49.276898 | 2025-11-13 18:33:49.277040 | TASK [validate-host : Sanitize hostname] 2025-11-13 18:33:49.388669 | debian-bookworm | ok 2025-11-13 18:33:49.439253 | 2025-11-13 18:33:49.439386 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-13 18:33:50.172736 | debian-bookworm -> localhost | changed 2025-11-13 18:33:50.183708 | 2025-11-13 18:33:50.183860 | TASK [validate-host : Collect information about zuul worker] 2025-11-13 18:33:50.647254 | debian-bookworm | ok 2025-11-13 18:33:50.652755 | 2025-11-13 18:33:50.652870 | TASK [validate-host : Write out all zuul information for each host] 2025-11-13 18:33:51.587675 | debian-bookworm -> localhost | changed 2025-11-13 18:33:51.599275 | 2025-11-13 18:33:51.599411 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-13 18:33:51.899278 | debian-bookworm | ok 2025-11-13 18:33:51.905290 | 2025-11-13 18:33:51.905424 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-13 18:33:53.038412 | debian-bookworm | changed: 2025-11-13 18:33:53.038621 | debian-bookworm | cd+++++++++ src/ 2025-11-13 18:33:53.038658 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-13 18:33:53.038682 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-13 18:33:53.038705 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-13 18:33:53.038726 | debian-bookworm | =6.2 2025-11-13 18:34:15.336019 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-11-13 18:34:15.386642 | debian-bookworm | Collecting chardet>=5.2 2025-11-13 18:34:15.403782 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-13 18:34:15.417326 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 23.4 MB/s eta 0:00:00 2025-11-13 18:34:15.475180 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-13 18:34:15.491524 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-13 18:34:15.568047 | debian-bookworm | Collecting filelock>=3.20 2025-11-13 18:34:15.585343 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-13 18:34:15.658676 | debian-bookworm | Collecting packaging>=25 2025-11-13 18:34:15.678602 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-13 18:34:15.687132 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.2 MB/s eta 0:00:00 2025-11-13 18:34:15.751645 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-13 18:34:15.766537 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-13 18:34:15.815136 | debian-bookworm | Collecting pluggy>=1.6 2025-11-13 18:34:15.832553 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-13 18:34:15.880458 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-13 18:34:15.895407 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-13 18:34:16.032021 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-13 18:34:16.047277 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-13 18:34:16.351951 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 20.0 MB/s eta 0:00:00 2025-11-13 18:34:16.458047 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-13 18:34:16.480533 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-13 18:34:16.508583 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.0 MB/s eta 0:00:00 2025-11-13 18:34:16.661338 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-13 18:34:17.577681 | debian-bookworm | Successfully installed cachetools-6.2.2 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.32.0 virtualenv-20.35.4 2025-11-13 18:34:17.738371 | debian-bookworm | ok: Runtime: 0:00:03.202470 2025-11-13 18:34:17.744374 | 2025-11-13 18:34:17.744498 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-13 18:34:17.802339 | debian-bookworm | ok 2025-11-13 18:34:17.807504 | 2025-11-13 18:34:17.807624 | TASK [ensure-tox : Output tox version] 2025-11-13 18:34:18.340008 | 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-11-13 18:34:18.358823 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-13 18:34:18.837674 | debian-bookworm | ok: Runtime: 0:00:00.313685 2025-11-13 18:34:18.848155 | 2025-11-13 18:34:18.848307 | TASK [ensure-tox : Make global symlink] 2025-11-13 18:34:18.875192 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:18.887839 | 2025-11-13 18:34:18.887939 | PLAY RECAP 2025-11-13 18:34:18.887992 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-13 18:34:18.888203 | 2025-11-13 18:34:19.085256 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-13 18:34:19.086499 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-13 18:34:19.879768 | 2025-11-13 18:34:19.879940 | PLAY [all] 2025-11-13 18:34:19.896697 | 2025-11-13 18:34:19.896850 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-13 18:34:20.355775 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-13 18:34:20.435670 | debian-bookworm | ok: Runtime: 0:00:00.026630 2025-11-13 18:34:20.447687 | 2025-11-13 18:34:20.447876 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-13 18:34:20.987544 | debian-bookworm | ok: Runtime: 0:00:00.009950 2025-11-13 18:34:20.996502 | 2025-11-13 18:34:20.996642 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-13 18:34:21.338691 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-13 18:34:21.343155 | debian-bookworm | sudo: a password is required 2025-11-13 18:34:21.527146 | debian-bookworm | ok: Runtime: 0:00:00.055595 2025-11-13 18:34:21.542090 | 2025-11-13 18:34:21.542228 | TASK [tox : Check to see if the constraints file exists] 2025-11-13 18:34:21.567778 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:21.582984 | 2025-11-13 18:34:21.583221 | TASK [tox : Fail if constraints file is missing] 2025-11-13 18:34:21.609356 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:21.621769 | 2025-11-13 18:34:21.622026 | TASK [tox : Record file location] 2025-11-13 18:34:21.663729 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:21.669720 | 2025-11-13 18:34:21.669833 | TASK [tox : Install tox siblings] 2025-11-13 18:34:21.710164 | debian-bookworm | ok 2025-11-13 18:34:21.722278 | debian-bookworm | included: /var/lib/zuul/builds/f8feddcfdd7c45dbaa82126ea593913c/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-13 18:34:21.728286 | 2025-11-13 18:34:21.728430 | TASK [tox : Run tox without tests] 2025-11-13 18:34:22.926584 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-13 18:34:37.450247 | debian-bookworm | test: OK (15.17 seconds) 2025-11-13 18:34:37.450332 | debian-bookworm | congratulations :) (15.21 seconds) 2025-11-13 18:34:37.772727 | debian-bookworm | ok: Runtime: 0:00:15.501645 2025-11-13 18:34:37.785891 | 2025-11-13 18:34:37.786069 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-13 18:34:38.278345 | debian-bookworm | changed 2025-11-13 18:34:38.286369 | 2025-11-13 18:34:38.286524 | TASK [tox : Get tox envlist config] 2025-11-13 18:34:39.320652 | debian-bookworm | ok: Runtime: 0:00:00.340935 2025-11-13 18:34:39.337354 | 2025-11-13 18:34:39.337569 | TASK [tox : Install any sibling python packages] 2025-11-13 18:34:39.791135 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-13 18:34:39.800902 | 2025-11-13 18:34:39.801099 | TASK [tox : Remove tempfile] 2025-11-13 18:34:40.246650 | debian-bookworm | changed 2025-11-13 18:34:40.252662 | 2025-11-13 18:34:40.252773 | TASK [tox : Emit tox command] 2025-11-13 18:34:40.305328 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-13 18:34:40.314278 | 2025-11-13 18:34:40.314430 | TASK [tox : Run tox] 2025-11-13 18:34:40.956462 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-13 18:34:41.592911 | debian-bookworm | ............... 2025-11-13 18:34:41.592967 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-13 18:34:41.592984 | debian-bookworm | Ran 15 tests in 0.171s 2025-11-13 18:34:41.592989 | debian-bookworm | 2025-11-13 18:34:41.592996 | debian-bookworm | OK 2025-11-13 18:34:41.678165 | debian-bookworm | test: OK (0.76=setup[0.04]+cmd[0.72] seconds) 2025-11-13 18:34:41.678234 | debian-bookworm | congratulations :) (0.79 seconds) 2025-11-13 18:34:41.880669 | debian-bookworm | ok: Runtime: 0:00:01.086748 2025-11-13 18:34:41.894148 | 2025-11-13 18:34:41.894311 | TASK [tox : Look for output] 2025-11-13 18:34:42.278307 | debian-bookworm | ok 2025-11-13 18:34:42.295972 | 2025-11-13 18:34:42.296178 | TASK [tox : Return file comments to Zuul] 2025-11-13 18:34:42.331562 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:42.345249 | 2025-11-13 18:34:42.345376 | PLAY RECAP 2025-11-13 18:34:42.345453 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-13 18:34:42.345494 | 2025-11-13 18:34:42.500403 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-13 18:34:42.503425 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-13 18:34:43.341253 | 2025-11-13 18:34:43.341414 | PLAY [all] 2025-11-13 18:34:43.357079 | 2025-11-13 18:34:43.357223 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-13 18:34:43.411970 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:43.418228 | 2025-11-13 18:34:43.418380 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-13 18:34:43.472563 | debian-bookworm | ok 2025-11-13 18:34:43.481149 | 2025-11-13 18:34:43.481321 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-13 18:34:43.976975 | debian-bookworm -> localhost | changed 2025-11-13 18:34:43.993688 | 2025-11-13 18:34:43.993855 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-13 18:34:44.049271 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:44.063141 | 2025-11-13 18:34:44.063405 | TASK [fetch-tox-output : Set envlist fact] 2025-11-13 18:34:44.110391 | debian-bookworm | ok 2025-11-13 18:34:44.121337 | 2025-11-13 18:34:44.121511 | TASK [fetch-tox-output : Get tox version] 2025-11-13 18:34:44.819653 | 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-11-13 18:34:44.838277 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-13 18:34:45.154453 | debian-bookworm | ok: Runtime: 0:00:00.291328 2025-11-13 18:34:45.160261 | 2025-11-13 18:34:45.160374 | TASK [fetch-tox-output : Find all default environments] 2025-11-13 18:34:45.688527 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:45.708858 | 2025-11-13 18:34:45.709696 | TASK [fetch-tox-output : Set envlist fact] 2025-11-13 18:34:45.750428 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:45.758963 | 2025-11-13 18:34:45.759099 | TASK [fetch-tox-output : Find all default environments] 2025-11-13 18:34:46.292013 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:46.305833 | 2025-11-13 18:34:46.306031 | TASK [fetch-tox-output : Set envlist fact] 2025-11-13 18:34:46.341502 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:46.356231 | 2025-11-13 18:34:46.356418 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-13 18:34:46.411407 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:46.427498 | 2025-11-13 18:34:46.427666 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-13 18:34:47.247231 | debian-bookworm | changed: 2025-11-13 18:34:47.247560 | debian-bookworm | created directory /var/lib/zuul/builds/f8feddcfdd7c45dbaa82126ea593913c/work/logs/tox/test 2025-11-13 18:34:47.247623 | debian-bookworm | cd+++++++++ ./ 2025-11-13 18:34:47.247651 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-13 18:34:47.247687 | 2025-11-13 18:34:47.270244 | 2025-11-13 18:34:47.270386 | PLAY RECAP 2025-11-13 18:34:47.270471 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-13 18:34:47.270511 | 2025-11-13 18:34:47.418083 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-13 18:34:47.421060 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-13 18:34:48.171671 | 2025-11-13 18:34:48.171845 | PLAY [all] 2025-11-13 18:34:48.189509 | 2025-11-13 18:34:48.189669 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-13 18:34:48.429426 | debian-bookworm | changed: non-zero return code 2025-11-13 18:34:48.438414 | 2025-11-13 18:34:48.438602 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-13 18:34:48.463839 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:48.478484 | 2025-11-13 18:34:48.478659 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-13 18:34:48.517546 | 2025-11-13 18:34:48.517848 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-13 18:34:48.569232 | 2025-11-13 18:34:48.569548 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-13 18:34:48.596127 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:48.609575 | 2025-11-13 18:34:48.609731 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-13 18:34:48.648418 | 2025-11-13 18:34:48.648733 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-13 18:34:48.673987 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:48.689733 | 2025-11-13 18:34:48.690114 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-13 18:34:48.718258 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:48.730518 | 2025-11-13 18:34:48.730681 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-13 18:34:48.756119 | debian-bookworm | skipping: Conditional result was False 2025-11-13 18:34:48.769610 | 2025-11-13 18:34:48.769734 | PLAY RECAP 2025-11-13 18:34:48.769825 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-13 18:34:48.769871 | 2025-11-13 18:34:48.903262 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-13 18:34:48.904409 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-13 18:34:49.665109 | 2025-11-13 18:34:49.665284 | PLAY [Base post] 2025-11-13 18:34:49.679994 | 2025-11-13 18:34:49.680150 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-13 18:34:50.259162 | debian-bookworm | changed 2025-11-13 18:34:50.269102 | 2025-11-13 18:34:50.269247 | PLAY RECAP 2025-11-13 18:34:50.269327 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-13 18:34:50.269404 | 2025-11-13 18:34:50.400974 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-13 18:34:50.404495 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-13 18:34:51.218151 | 2025-11-13 18:34:51.218325 | PLAY [Base post-logs] 2025-11-13 18:34:51.229372 | 2025-11-13 18:34:51.229523 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-13 18:34:51.768233 | localhost | changed 2025-11-13 18:34:51.786790 | 2025-11-13 18:34:51.787113 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-13 18:34:51.816219 | localhost | ok 2025-11-13 18:34:51.822522 | 2025-11-13 18:34:51.822678 | TASK [Set zuul-log-path fact] 2025-11-13 18:34:51.839953 | localhost | ok 2025-11-13 18:34:51.850181 | 2025-11-13 18:34:51.850305 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-13 18:34:51.897276 | localhost | ok 2025-11-13 18:34:51.903169 | 2025-11-13 18:34:51.903330 | TASK [upload-logs : Create log directories] 2025-11-13 18:34:52.413401 | localhost | changed 2025-11-13 18:34:52.417904 | 2025-11-13 18:34:52.418137 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-13 18:34:52.930755 | localhost -> localhost | ok: Runtime: 0:00:00.008203 2025-11-13 18:34:52.935104 | 2025-11-13 18:34:52.935231 | TASK [upload-logs : Upload logs to log server] 2025-11-13 18:34:53.533329 | localhost | Output suppressed because no_log was given 2025-11-13 18:34:53.536384 | 2025-11-13 18:34:53.536692 | LOOP [upload-logs : Compress console log and json output] 2025-11-13 18:34:53.594152 | localhost | skipping: Conditional result was False 2025-11-13 18:34:53.602336 | localhost | skipping: Conditional result was False 2025-11-13 18:34:53.619440 | 2025-11-13 18:34:53.619676 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-13 18:34:53.684182 | localhost | skipping: Conditional result was False 2025-11-13 18:34:53.684827 | 2025-11-13 18:34:53.689919 | localhost | skipping: Conditional result was False 2025-11-13 18:34:53.705810 | 2025-11-13 18:34:53.706096 | LOOP [upload-logs : Upload console log and json output]