2025-11-20 18:10:04.260577 | Job console starting 2025-11-20 18:10:04.286894 | Updating git repos 2025-11-20 18:10:04.348581 | Cloning repos into workspace 2025-11-20 18:10:04.460774 | Restoring repo states 2025-11-20 18:10:04.476284 | Merging changes 2025-11-20 18:10:05.023182 | Checking out repos 2025-11-20 18:10:05.112068 | Preparing playbooks 2025-11-20 18:10:06.044229 | Running Ansible setup 2025-11-20 18:10:13.073442 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-20 18:10:14.660979 | 2025-11-20 18:10:14.661113 | PLAY [Base pre] 2025-11-20 18:10:14.697561 | 2025-11-20 18:10:14.697695 | TASK [Setup log path fact] 2025-11-20 18:10:14.736626 | debian-bookworm | ok 2025-11-20 18:10:14.761210 | 2025-11-20 18:10:14.761353 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-20 18:10:14.816871 | debian-bookworm | ok 2025-11-20 18:10:14.836472 | 2025-11-20 18:10:14.836583 | TASK [emit-job-header : Print job information] 2025-11-20 18:10:14.879712 | # Job Information 2025-11-20 18:10:14.880018 | Ansible Version: 2.16.14 2025-11-20 18:10:14.880059 | Job: tox 2025-11-20 18:10:14.880093 | Pipeline: check 2025-11-20 18:10:14.880116 | Executor: 521e9411259a 2025-11-20 18:10:14.880138 | Triggered by: https://github.com/osism/openstack-image-manager/pull/998 2025-11-20 18:10:14.880160 | Event ID: 1cad6b30-c63c-11f0-8e86-a5a41ddd5961 2025-11-20 18:10:14.885221 | 2025-11-20 18:10:14.885328 | LOOP [emit-job-header : Print node information] 2025-11-20 18:10:15.090531 | debian-bookworm | ok: 2025-11-20 18:10:15.090857 | debian-bookworm | # Node Information 2025-11-20 18:10:15.090902 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-20 18:10:15.090929 | debian-bookworm | Hostname: debian 2025-11-20 18:10:15.090950 | debian-bookworm | Username: zuul 2025-11-20 18:10:15.090970 | debian-bookworm | Distro: Debian 12.12 2025-11-20 18:10:15.090993 | debian-bookworm | Provider: regiocloud-a 2025-11-20 18:10:15.091014 | debian-bookworm | Region: 2025-11-20 18:10:15.091035 | debian-bookworm | Label: debian-bookworm 2025-11-20 18:10:15.091054 | debian-bookworm | Product Name: OpenStack Nova 2025-11-20 18:10:15.091073 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe67:e216 2025-11-20 18:10:15.111473 | 2025-11-20 18:10:15.111585 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-20 18:10:16.022702 | debian-bookworm -> localhost | changed 2025-11-20 18:10:16.030903 | 2025-11-20 18:10:16.031017 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-20 18:10:18.353244 | debian-bookworm -> localhost | changed 2025-11-20 18:10:18.363787 | 2025-11-20 18:10:18.363919 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-20 18:10:19.216502 | debian-bookworm -> localhost | ok 2025-11-20 18:10:19.222341 | 2025-11-20 18:10:19.222443 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-20 18:10:19.250214 | debian-bookworm | ok 2025-11-20 18:10:19.284516 | debian-bookworm | included: /var/lib/zuul/builds/fc765b58aa7442bf895176d1521d9095/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-20 18:10:19.307810 | 2025-11-20 18:10:19.307923 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-20 18:10:21.943956 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-20 18:10:21.945180 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fc765b58aa7442bf895176d1521d9095/work/fc765b58aa7442bf895176d1521d9095_id_rsa 2025-11-20 18:10:21.945241 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fc765b58aa7442bf895176d1521d9095/work/fc765b58aa7442bf895176d1521d9095_id_rsa.pub 2025-11-20 18:10:21.945266 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-20 18:10:21.945288 | debian-bookworm -> localhost | SHA256:baWKYbKCnPLIGnoP0MD1fyFxA5EJo9/awW2bLVuNJDo zuul-build-sshkey 2025-11-20 18:10:21.945307 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-20 18:10:21.945334 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-20 18:10:21.945353 | debian-bookworm -> localhost | | . o.+=o | 2025-11-20 18:10:21.945371 | debian-bookworm -> localhost | |. . o .oo . | 2025-11-20 18:10:21.945388 | debian-bookworm -> localhost | |.. . . . . . | 2025-11-20 18:10:21.945404 | debian-bookworm -> localhost | | o . + o..o | 2025-11-20 18:10:21.945421 | debian-bookworm -> localhost | |. . ..o=S=+. | 2025-11-20 18:10:21.945440 | debian-bookworm -> localhost | |.o. +oo=o* o | 2025-11-20 18:10:21.945457 | debian-bookworm -> localhost | |+oo ...E.+ + . | 2025-11-20 18:10:21.945474 | debian-bookworm -> localhost | |++.o . + | 2025-11-20 18:10:21.945492 | debian-bookworm -> localhost | |=o... . | 2025-11-20 18:10:21.945508 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-20 18:10:21.945555 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.392998 2025-11-20 18:10:21.950771 | 2025-11-20 18:10:21.950880 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-20 18:10:21.991758 | debian-bookworm | ok 2025-11-20 18:10:22.007525 | debian-bookworm | included: /var/lib/zuul/builds/fc765b58aa7442bf895176d1521d9095/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-20 18:10:22.029166 | 2025-11-20 18:10:22.029266 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-20 18:10:22.062119 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:10:22.067101 | 2025-11-20 18:10:22.067195 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-20 18:10:22.872628 | debian-bookworm | changed 2025-11-20 18:10:22.878215 | 2025-11-20 18:10:22.878316 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-20 18:10:23.152578 | debian-bookworm | ok 2025-11-20 18:10:23.158538 | 2025-11-20 18:10:23.158627 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-20 18:10:23.880387 | debian-bookworm | changed 2025-11-20 18:10:23.891866 | 2025-11-20 18:10:23.891982 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-20 18:10:24.633718 | debian-bookworm | changed 2025-11-20 18:10:24.645523 | 2025-11-20 18:10:24.645632 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-20 18:10:24.691107 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:10:24.696949 | 2025-11-20 18:10:24.697049 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-20 18:10:25.650516 | debian-bookworm -> localhost | changed 2025-11-20 18:10:25.661094 | 2025-11-20 18:10:25.661184 | TASK [add-build-sshkey : Add back temp key] 2025-11-20 18:10:26.255757 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fc765b58aa7442bf895176d1521d9095/work/fc765b58aa7442bf895176d1521d9095_id_rsa (zuul-build-sshkey) 2025-11-20 18:10:26.255953 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025027 2025-11-20 18:10:26.262278 | 2025-11-20 18:10:26.262368 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-20 18:10:26.725010 | debian-bookworm | ok 2025-11-20 18:10:26.729212 | 2025-11-20 18:10:26.729296 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-20 18:10:26.772716 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:10:26.789500 | 2025-11-20 18:10:26.789598 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-20 18:10:27.345361 | debian-bookworm | ok 2025-11-20 18:10:27.353865 | 2025-11-20 18:10:27.353951 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-20 18:10:27.399344 | debian-bookworm | ok 2025-11-20 18:10:27.403648 | 2025-11-20 18:10:27.403737 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-20 18:10:27.820907 | debian-bookworm -> localhost | ok 2025-11-20 18:10:27.826608 | 2025-11-20 18:10:27.826691 | TASK [validate-host : Collect information about the host] 2025-11-20 18:10:29.094256 | debian-bookworm | ok 2025-11-20 18:10:29.125166 | 2025-11-20 18:10:29.125273 | TASK [validate-host : Sanitize hostname] 2025-11-20 18:10:29.390362 | debian-bookworm | ok 2025-11-20 18:10:29.440525 | 2025-11-20 18:10:29.440638 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-20 18:10:30.447390 | debian-bookworm -> localhost | changed 2025-11-20 18:10:30.453628 | 2025-11-20 18:10:30.453750 | TASK [validate-host : Collect information about zuul worker] 2025-11-20 18:10:31.072662 | debian-bookworm | ok 2025-11-20 18:10:31.078006 | 2025-11-20 18:10:31.078177 | TASK [validate-host : Write out all zuul information for each host] 2025-11-20 18:10:32.468719 | debian-bookworm -> localhost | changed 2025-11-20 18:10:32.485956 | 2025-11-20 18:10:32.486103 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-20 18:10:32.782513 | debian-bookworm | ok 2025-11-20 18:10:32.792167 | 2025-11-20 18:10:32.792292 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-20 18:10:33.997349 | debian-bookworm | changed: 2025-11-20 18:10:33.997493 | debian-bookworm | cd+++++++++ src/ 2025-11-20 18:10:33.997521 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-20 18:10:33.997540 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-20 18:10:33.997558 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-20 18:10:33.997575 | debian-bookworm | =6.2 2025-11-20 18:10:58.706427 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-11-20 18:10:58.748871 | debian-bookworm | Collecting chardet>=5.2 2025-11-20 18:10:58.762966 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-20 18:10:58.774531 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 24.2 MB/s eta 0:00:00 2025-11-20 18:10:58.827779 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-20 18:10:58.841902 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-20 18:10:58.900408 | debian-bookworm | Collecting filelock>=3.20 2025-11-20 18:10:58.917726 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-20 18:10:58.988968 | debian-bookworm | Collecting packaging>=25 2025-11-20 18:10:59.007117 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-20 18:10:59.147695 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 632.6 kB/s eta 0:00:00 2025-11-20 18:10:59.213187 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-20 18:10:59.227124 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-20 18:10:59.273049 | debian-bookworm | Collecting pluggy>=1.6 2025-11-20 18:10:59.287018 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-20 18:10:59.338314 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-20 18:10:59.352635 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-20 18:10:59.487221 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-20 18:10:59.502463 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-20 18:10:59.818013 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 19.4 MB/s eta 0:00:00 2025-11-20 18:10:59.948079 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-20 18:10:59.962614 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-20 18:10:59.989493 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 19.6 MB/s eta 0:00:00 2025-11-20 18:11:00.139897 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-20 18:11:01.110379 | 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-20 18:11:01.561271 | debian-bookworm | ok: Runtime: 0:00:03.420298 2025-11-20 18:11:01.567636 | 2025-11-20 18:11:01.567767 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-20 18:11:01.617841 | debian-bookworm | ok 2025-11-20 18:11:01.623971 | 2025-11-20 18:11:01.624098 | TASK [ensure-tox : Output tox version] 2025-11-20 18:11:02.153374 | 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-20 18:11:02.172213 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-20 18:11:02.657019 | debian-bookworm | ok: Runtime: 0:00:00.312179 2025-11-20 18:11:02.663171 | 2025-11-20 18:11:02.663296 | TASK [ensure-tox : Make global symlink] 2025-11-20 18:11:02.742074 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:02.751973 | 2025-11-20 18:11:02.752088 | PLAY RECAP 2025-11-20 18:11:02.752142 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-20 18:11:02.752167 | 2025-11-20 18:11:03.028898 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-20 18:11:03.030032 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-20 18:11:04.352610 | 2025-11-20 18:11:04.352783 | PLAY [all] 2025-11-20 18:11:04.369380 | 2025-11-20 18:11:04.369602 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-20 18:11:05.084372 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-20 18:11:05.416833 | debian-bookworm | ok: Runtime: 0:00:00.028167 2025-11-20 18:11:05.424221 | 2025-11-20 18:11:05.424363 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-20 18:11:06.090014 | debian-bookworm | ok: Runtime: 0:00:00.006669 2025-11-20 18:11:06.110262 | 2025-11-20 18:11:06.110411 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-20 18:11:06.465740 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-20 18:11:06.469783 | debian-bookworm | sudo: a password is required 2025-11-20 18:11:06.677587 | debian-bookworm | ok: Runtime: 0:00:00.024837 2025-11-20 18:11:06.688633 | 2025-11-20 18:11:06.688777 | TASK [tox : Check to see if the constraints file exists] 2025-11-20 18:11:06.735190 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:06.749337 | 2025-11-20 18:11:06.749525 | TASK [tox : Fail if constraints file is missing] 2025-11-20 18:11:06.780420 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:06.787053 | 2025-11-20 18:11:06.787191 | TASK [tox : Record file location] 2025-11-20 18:11:06.835029 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:06.843146 | 2025-11-20 18:11:06.843291 | TASK [tox : Install tox siblings] 2025-11-20 18:11:06.903156 | debian-bookworm | ok 2025-11-20 18:11:06.932294 | debian-bookworm | included: /var/lib/zuul/builds/fc765b58aa7442bf895176d1521d9095/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-20 18:11:06.941315 | 2025-11-20 18:11:06.941463 | TASK [tox : Run tox without tests] 2025-11-20 18:11:08.120968 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-20 18:11:21.787865 | debian-bookworm | test: OK (14.28 seconds) 2025-11-20 18:11:21.787902 | debian-bookworm | congratulations :) (14.31 seconds) 2025-11-20 18:11:21.998132 | debian-bookworm | ok: Runtime: 0:00:14.564166 2025-11-20 18:11:22.008333 | 2025-11-20 18:11:22.008467 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-20 18:11:22.407716 | debian-bookworm | changed 2025-11-20 18:11:22.415738 | 2025-11-20 18:11:22.415915 | TASK [tox : Get tox envlist config] 2025-11-20 18:11:23.454293 | debian-bookworm | ok: Runtime: 0:00:00.284565 2025-11-20 18:11:23.468071 | 2025-11-20 18:11:23.468299 | TASK [tox : Install any sibling python packages] 2025-11-20 18:11:23.932703 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-20 18:11:23.938986 | 2025-11-20 18:11:23.939114 | TASK [tox : Remove tempfile] 2025-11-20 18:11:24.380475 | debian-bookworm | changed 2025-11-20 18:11:24.390150 | 2025-11-20 18:11:24.390294 | TASK [tox : Emit tox command] 2025-11-20 18:11:24.440719 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-20 18:11:24.445773 | 2025-11-20 18:11:24.445875 | TASK [tox : Run tox] 2025-11-20 18:11:25.023711 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-20 18:11:25.603797 | debian-bookworm | ............... 2025-11-20 18:11:25.603833 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-20 18:11:25.603845 | debian-bookworm | Ran 15 tests in 0.168s 2025-11-20 18:11:25.603850 | debian-bookworm | 2025-11-20 18:11:25.603857 | debian-bookworm | OK 2025-11-20 18:11:25.665544 | debian-bookworm | test: OK (0.68=setup[0.04]+cmd[0.64] seconds) 2025-11-20 18:11:25.665586 | debian-bookworm | congratulations :) (0.71 seconds) 2025-11-20 18:11:26.010515 | debian-bookworm | ok: Runtime: 0:00:00.949168 2025-11-20 18:11:26.017243 | 2025-11-20 18:11:26.017362 | TASK [tox : Look for output] 2025-11-20 18:11:26.393157 | debian-bookworm | ok 2025-11-20 18:11:26.413566 | 2025-11-20 18:11:26.413731 | TASK [tox : Return file comments to Zuul] 2025-11-20 18:11:26.450263 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:26.463079 | 2025-11-20 18:11:26.463202 | PLAY RECAP 2025-11-20 18:11:26.463271 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-20 18:11:26.463305 | 2025-11-20 18:11:26.610342 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-20 18:11:26.611486 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-20 18:11:27.372260 | 2025-11-20 18:11:27.372438 | PLAY [all] 2025-11-20 18:11:27.391677 | 2025-11-20 18:11:27.391973 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-20 18:11:27.460916 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:27.477424 | 2025-11-20 18:11:27.477765 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-20 18:11:27.527540 | debian-bookworm | ok 2025-11-20 18:11:27.535434 | 2025-11-20 18:11:27.535650 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-20 18:11:28.074259 | debian-bookworm -> localhost | changed 2025-11-20 18:11:28.096250 | 2025-11-20 18:11:28.096520 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-20 18:11:28.156797 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:28.169279 | 2025-11-20 18:11:28.169493 | TASK [fetch-tox-output : Set envlist fact] 2025-11-20 18:11:28.218243 | debian-bookworm | ok 2025-11-20 18:11:28.227271 | 2025-11-20 18:11:28.227431 | TASK [fetch-tox-output : Get tox version] 2025-11-20 18:11:28.910008 | 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-20 18:11:28.927693 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-20 18:11:29.258597 | debian-bookworm | ok: Runtime: 0:00:00.269888 2025-11-20 18:11:29.264932 | 2025-11-20 18:11:29.265089 | TASK [fetch-tox-output : Find all default environments] 2025-11-20 18:11:29.825391 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:29.831681 | 2025-11-20 18:11:29.831820 | TASK [fetch-tox-output : Set envlist fact] 2025-11-20 18:11:29.876556 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:29.902743 | 2025-11-20 18:11:29.903052 | TASK [fetch-tox-output : Find all default environments] 2025-11-20 18:11:30.449393 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:30.460936 | 2025-11-20 18:11:30.461155 | TASK [fetch-tox-output : Set envlist fact] 2025-11-20 18:11:30.485962 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:30.494108 | 2025-11-20 18:11:30.494296 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-20 18:11:30.554301 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:30.567466 | 2025-11-20 18:11:30.567630 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-20 18:11:31.379327 | debian-bookworm | changed: 2025-11-20 18:11:31.379521 | debian-bookworm | created directory /var/lib/zuul/builds/fc765b58aa7442bf895176d1521d9095/work/logs/tox/test 2025-11-20 18:11:31.379559 | debian-bookworm | cd+++++++++ ./ 2025-11-20 18:11:31.379584 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-20 18:11:31.379614 | 2025-11-20 18:11:31.395227 | 2025-11-20 18:11:31.395376 | PLAY RECAP 2025-11-20 18:11:31.395459 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-20 18:11:31.395503 | 2025-11-20 18:11:31.546925 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-20 18:11:31.548040 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-20 18:11:32.376662 | 2025-11-20 18:11:32.376882 | PLAY [all] 2025-11-20 18:11:32.397043 | 2025-11-20 18:11:32.397221 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-20 18:11:32.611732 | debian-bookworm | changed: non-zero return code 2025-11-20 18:11:32.624403 | 2025-11-20 18:11:32.624595 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-20 18:11:32.649532 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:32.655728 | 2025-11-20 18:11:32.655872 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-20 18:11:32.686945 | 2025-11-20 18:11:32.687183 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-20 18:11:32.718628 | 2025-11-20 18:11:32.718863 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-20 18:11:32.743430 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:32.760419 | 2025-11-20 18:11:32.760614 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-20 18:11:32.828839 | 2025-11-20 18:11:32.829080 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-20 18:11:32.853699 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:32.866635 | 2025-11-20 18:11:32.866826 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-20 18:11:32.893422 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:32.900459 | 2025-11-20 18:11:32.900597 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-20 18:11:32.936300 | debian-bookworm | skipping: Conditional result was False 2025-11-20 18:11:32.945632 | 2025-11-20 18:11:32.945736 | PLAY RECAP 2025-11-20 18:11:32.945789 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-20 18:11:32.945814 | 2025-11-20 18:11:33.175760 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-20 18:11:33.176886 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-20 18:11:34.128675 | 2025-11-20 18:11:34.128864 | PLAY [Base post] 2025-11-20 18:11:34.145991 | 2025-11-20 18:11:34.146176 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-20 18:11:34.729214 | debian-bookworm | changed 2025-11-20 18:11:34.737559 | 2025-11-20 18:11:34.737692 | PLAY RECAP 2025-11-20 18:11:34.737757 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-20 18:11:34.737818 | 2025-11-20 18:11:34.876208 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-20 18:11:34.877317 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-20 18:11:35.772570 | 2025-11-20 18:11:35.772756 | PLAY [Base post-logs] 2025-11-20 18:11:35.784504 | 2025-11-20 18:11:35.784671 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-20 18:11:36.544917 | localhost | changed 2025-11-20 18:11:36.562812 | 2025-11-20 18:11:36.563115 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-20 18:11:36.602323 | localhost | ok 2025-11-20 18:11:36.609205 | 2025-11-20 18:11:36.609373 | TASK [Set zuul-log-path fact] 2025-11-20 18:11:36.627201 | localhost | ok 2025-11-20 18:11:36.638531 | 2025-11-20 18:11:36.638743 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-20 18:11:36.664586 | localhost | ok 2025-11-20 18:11:36.667899 | 2025-11-20 18:11:36.668008 | TASK [upload-logs : Create log directories] 2025-11-20 18:11:37.266150 | localhost | changed 2025-11-20 18:11:37.271739 | 2025-11-20 18:11:37.271925 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-20 18:11:37.835349 | localhost -> localhost | ok: Runtime: 0:00:00.004891 2025-11-20 18:11:37.840994 | 2025-11-20 18:11:37.843587 | TASK [upload-logs : Upload logs to log server] 2025-11-20 18:11:38.501315 | localhost | Output suppressed because no_log was given 2025-11-20 18:11:38.503779 | 2025-11-20 18:11:38.503910 | LOOP [upload-logs : Compress console log and json output] 2025-11-20 18:11:38.554085 | localhost | skipping: Conditional result was False 2025-11-20 18:11:38.560345 | localhost | skipping: Conditional result was False 2025-11-20 18:11:38.573333 | 2025-11-20 18:11:38.573514 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-20 18:11:38.626614 | localhost | skipping: Conditional result was False 2025-11-20 18:11:38.627082 | 2025-11-20 18:11:38.635034 | localhost | skipping: Conditional result was False 2025-11-20 18:11:38.642309 | 2025-11-20 18:11:38.642438 | LOOP [upload-logs : Upload console log and json output]