2026-01-18 00:20:41.633593 | Job console starting 2026-01-18 00:20:41.652709 | Updating git repos 2026-01-18 00:20:41.928127 | Cloning repos into workspace 2026-01-18 00:20:42.024740 | Restoring repo states 2026-01-18 00:20:42.051499 | Merging changes 2026-01-18 00:20:42.802685 | Checking out repos 2026-01-18 00:20:42.860276 | Preparing playbooks 2026-01-18 00:20:44.239530 | Running Ansible setup 2026-01-18 00:20:48.589113 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-18 00:20:49.431723 | 2026-01-18 00:20:49.431836 | PLAY [Base pre] 2026-01-18 00:20:49.460990 | 2026-01-18 00:20:49.461100 | TASK [Setup log path fact] 2026-01-18 00:20:49.506066 | debian-bookworm | ok 2026-01-18 00:20:49.528760 | 2026-01-18 00:20:49.528909 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-18 00:20:49.558021 | debian-bookworm | ok 2026-01-18 00:20:49.567543 | 2026-01-18 00:20:49.567639 | TASK [emit-job-header : Print job information] 2026-01-18 00:20:49.654502 | # Job Information 2026-01-18 00:20:49.654945 | Ansible Version: 2.16.14 2026-01-18 00:20:49.654992 | Job: tox 2026-01-18 00:20:49.655026 | Pipeline: check 2026-01-18 00:20:49.655175 | Executor: 521e9411259a 2026-01-18 00:20:49.655204 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1092 2026-01-18 00:20:49.655229 | Event ID: 7f52afd0-f403-11f0-8122-7249133ad9d2 2026-01-18 00:20:49.661918 | 2026-01-18 00:20:49.662196 | LOOP [emit-job-header : Print node information] 2026-01-18 00:20:49.863869 | debian-bookworm | ok: 2026-01-18 00:20:49.864375 | debian-bookworm | # Node Information 2026-01-18 00:20:49.864415 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-18 00:20:49.864438 | debian-bookworm | Hostname: debian 2026-01-18 00:20:49.864457 | debian-bookworm | Username: zuul 2026-01-18 00:20:49.864478 | debian-bookworm | Distro: Debian 12.13 2026-01-18 00:20:49.864498 | debian-bookworm | Provider: regiocloud-a 2026-01-18 00:20:49.864516 | debian-bookworm | Region: 2026-01-18 00:20:49.864533 | debian-bookworm | Label: debian-bookworm 2026-01-18 00:20:49.864550 | debian-bookworm | Product Name: OpenStack Nova 2026-01-18 00:20:49.864566 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedc:89bf 2026-01-18 00:20:49.886803 | 2026-01-18 00:20:49.886961 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-18 00:20:50.480501 | debian-bookworm -> localhost | changed 2026-01-18 00:20:50.486135 | 2026-01-18 00:20:50.486224 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-18 00:20:52.239489 | debian-bookworm -> localhost | changed 2026-01-18 00:20:52.248119 | 2026-01-18 00:20:52.248214 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-18 00:20:52.700469 | debian-bookworm -> localhost | ok 2026-01-18 00:20:52.707215 | 2026-01-18 00:20:52.707324 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-18 00:20:52.748955 | debian-bookworm | ok 2026-01-18 00:20:52.765635 | debian-bookworm | included: /var/lib/zuul/builds/41abc3b518f744729b5185f8f50a54a7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-18 00:20:52.770827 | 2026-01-18 00:20:52.770939 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-18 00:20:54.753219 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-18 00:20:54.753480 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/41abc3b518f744729b5185f8f50a54a7/work/41abc3b518f744729b5185f8f50a54a7_id_rsa 2026-01-18 00:20:54.753538 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/41abc3b518f744729b5185f8f50a54a7/work/41abc3b518f744729b5185f8f50a54a7_id_rsa.pub 2026-01-18 00:20:54.753571 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-18 00:20:54.753602 | debian-bookworm -> localhost | SHA256:s6FcFQ+hSKgcBDH5xA+/NtrVd1OHxtx2/0qQuOWD9YY zuul-build-sshkey 2026-01-18 00:20:54.753630 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-18 00:20:54.753671 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-18 00:20:54.753699 | debian-bookworm -> localhost | |+*. .. +. | 2026-01-18 00:20:54.753725 | debian-bookworm -> localhost | |..= .. . . + | 2026-01-18 00:20:54.753750 | debian-bookworm -> localhost | | + * . . . .o o | 2026-01-18 00:20:54.753774 | debian-bookworm -> localhost | | + o . . .* =| 2026-01-18 00:20:54.753798 | debian-bookworm -> localhost | | . .S . =o oo| 2026-01-18 00:20:54.753828 | debian-bookworm -> localhost | | +..o.+.*o+ .| 2026-01-18 00:20:54.753887 | debian-bookworm -> localhost | | + oo ..o.E.+ .| 2026-01-18 00:20:54.753913 | debian-bookworm -> localhost | | . . + .| 2026-01-18 00:20:54.753939 | debian-bookworm -> localhost | | .. | 2026-01-18 00:20:54.753964 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-18 00:20:54.754023 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.570809 2026-01-18 00:20:54.761126 | 2026-01-18 00:20:54.761221 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-18 00:20:54.789087 | debian-bookworm | ok 2026-01-18 00:20:54.801169 | debian-bookworm | included: /var/lib/zuul/builds/41abc3b518f744729b5185f8f50a54a7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-18 00:20:54.808607 | 2026-01-18 00:20:54.808684 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-18 00:20:54.821306 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:20:54.827272 | 2026-01-18 00:20:54.827369 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-18 00:20:55.451600 | debian-bookworm | changed 2026-01-18 00:20:55.455906 | 2026-01-18 00:20:55.455983 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-18 00:20:55.701904 | debian-bookworm | ok 2026-01-18 00:20:55.720617 | 2026-01-18 00:20:55.720835 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-18 00:20:56.513080 | debian-bookworm | changed 2026-01-18 00:20:56.520593 | 2026-01-18 00:20:56.520691 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-18 00:20:57.193678 | debian-bookworm | changed 2026-01-18 00:20:57.198141 | 2026-01-18 00:20:57.198220 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-18 00:20:57.232338 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:20:57.238367 | 2026-01-18 00:20:57.238449 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-18 00:20:57.681215 | debian-bookworm -> localhost | changed 2026-01-18 00:20:57.690631 | 2026-01-18 00:20:57.690720 | TASK [add-build-sshkey : Add back temp key] 2026-01-18 00:20:58.206755 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/41abc3b518f744729b5185f8f50a54a7/work/41abc3b518f744729b5185f8f50a54a7_id_rsa (zuul-build-sshkey) 2026-01-18 00:20:58.206958 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025042 2026-01-18 00:20:58.222557 | 2026-01-18 00:20:58.222646 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-18 00:20:58.764283 | debian-bookworm | ok 2026-01-18 00:20:58.774081 | 2026-01-18 00:20:58.774183 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-18 00:20:58.828726 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:20:58.844472 | 2026-01-18 00:20:58.844571 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-18 00:20:59.304173 | debian-bookworm | ok 2026-01-18 00:20:59.324273 | 2026-01-18 00:20:59.324589 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-18 00:20:59.389557 | debian-bookworm | ok 2026-01-18 00:20:59.395419 | 2026-01-18 00:20:59.395517 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-18 00:20:59.835175 | debian-bookworm -> localhost | ok 2026-01-18 00:20:59.841209 | 2026-01-18 00:20:59.841304 | TASK [validate-host : Collect information about the host] 2026-01-18 00:21:01.043826 | debian-bookworm | ok 2026-01-18 00:21:01.062197 | 2026-01-18 00:21:01.062286 | TASK [validate-host : Sanitize hostname] 2026-01-18 00:21:01.233748 | debian-bookworm | ok 2026-01-18 00:21:01.294782 | 2026-01-18 00:21:01.294923 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-18 00:21:02.159043 | debian-bookworm -> localhost | changed 2026-01-18 00:21:02.163767 | 2026-01-18 00:21:02.163847 | TASK [validate-host : Collect information about zuul worker] 2026-01-18 00:21:02.664077 | debian-bookworm | ok 2026-01-18 00:21:02.669836 | 2026-01-18 00:21:02.669985 | TASK [validate-host : Write out all zuul information for each host] 2026-01-18 00:21:03.552532 | debian-bookworm -> localhost | changed 2026-01-18 00:21:03.580117 | 2026-01-18 00:21:03.580215 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-18 00:21:03.899712 | debian-bookworm | ok 2026-01-18 00:21:03.905665 | 2026-01-18 00:21:03.905752 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-18 00:21:05.840601 | debian-bookworm | changed: 2026-01-18 00:21:05.840765 | debian-bookworm | cd+++++++++ src/ 2026-01-18 00:21:05.840800 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-18 00:21:05.840826 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-18 00:21:05.840861 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-18 00:21:05.840884 | debian-bookworm | =6.2.4 2026-01-18 00:21:31.740539 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-18 00:21:31.791527 | debian-bookworm | Collecting chardet>=5.2 2026-01-18 00:21:31.805048 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-18 00:21:31.816929 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 24.7 MB/s eta 0:00:00 2026-01-18 00:21:31.880148 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-18 00:21:31.893029 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-18 00:21:31.978181 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-18 00:21:31.992796 | debian-bookworm | Downloading filelock-3.20.3-py3-none-any.whl (16 kB) 2026-01-18 00:21:32.122955 | debian-bookworm | Collecting packaging>=25 2026-01-18 00:21:32.135733 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2026-01-18 00:21:32.143905 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.7 MB/s eta 0:00:00 2026-01-18 00:21:32.194555 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-18 00:21:32.206894 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-18 00:21:32.270295 | debian-bookworm | Collecting pluggy>=1.6 2026-01-18 00:21:32.284957 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-18 00:21:32.347748 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-18 00:21:32.361112 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-18 00:21:32.503739 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-18 00:21:32.516575 | debian-bookworm | Downloading virtualenv-20.36.1-py3-none-any.whl (6.0 MB) 2026-01-18 00:21:32.756824 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 25.4 MB/s eta 0:00:00 2026-01-18 00:21:32.864980 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-18 00:21:32.877210 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-18 00:21:32.908849 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 16.2 MB/s eta 0:00:00 2026-01-18 00:21:33.063338 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-18 00:21:33.904570 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.3 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.34.1 virtualenv-20.36.1 2026-01-18 00:21:34.098341 | debian-bookworm | ok: Runtime: 0:00:03.192741 2026-01-18 00:21:34.109982 | 2026-01-18 00:21:34.110116 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-18 00:21:34.207627 | debian-bookworm | ok 2026-01-18 00:21:34.216005 | 2026-01-18 00:21:34.216666 | TASK [ensure-tox : Output tox version] 2026-01-18 00:21:34.839975 | 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-18 00:21:34.858844 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-18 00:21:35.254391 | debian-bookworm | ok: Runtime: 0:00:00.315747 2026-01-18 00:21:35.259796 | 2026-01-18 00:21:35.259914 | TASK [ensure-tox : Make global symlink] 2026-01-18 00:21:35.283071 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:35.299075 | 2026-01-18 00:21:35.299171 | PLAY RECAP 2026-01-18 00:21:35.299228 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-18 00:21:35.299257 | 2026-01-18 00:21:35.642426 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-18 00:21:35.643571 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-18 00:21:37.261734 | 2026-01-18 00:21:37.261876 | PLAY [all] 2026-01-18 00:21:37.276549 | 2026-01-18 00:21:37.276676 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-18 00:21:37.824172 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-18 00:21:38.334660 | debian-bookworm | ok: Runtime: 0:00:00.029829 2026-01-18 00:21:38.340596 | 2026-01-18 00:21:38.340722 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-18 00:21:38.900367 | debian-bookworm | ok: Runtime: 0:00:00.007024 2026-01-18 00:21:38.912487 | 2026-01-18 00:21:38.912594 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-18 00:21:39.288898 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-18 00:21:39.290654 | debian-bookworm | sudo: a password is required 2026-01-18 00:21:39.480655 | debian-bookworm | ok: Runtime: 0:00:00.022909 2026-01-18 00:21:39.499223 | 2026-01-18 00:21:39.500053 | TASK [tox : Check to see if the constraints file exists] 2026-01-18 00:21:39.590734 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:39.598098 | 2026-01-18 00:21:39.598218 | TASK [tox : Fail if constraints file is missing] 2026-01-18 00:21:39.666898 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:39.673104 | 2026-01-18 00:21:39.673209 | TASK [tox : Record file location] 2026-01-18 00:21:39.706425 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:39.712387 | 2026-01-18 00:21:39.712488 | TASK [tox : Install tox siblings] 2026-01-18 00:21:39.743129 | debian-bookworm | ok 2026-01-18 00:21:39.792488 | debian-bookworm | included: /var/lib/zuul/builds/41abc3b518f744729b5185f8f50a54a7/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-18 00:21:39.822694 | 2026-01-18 00:21:39.822819 | TASK [tox : Run tox without tests] 2026-01-18 00:21:41.131307 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-18 00:21:55.378010 | debian-bookworm | test: OK (14.82 seconds) 2026-01-18 00:21:55.378072 | debian-bookworm | congratulations :) (14.85 seconds) 2026-01-18 00:21:55.489476 | debian-bookworm | ok: Runtime: 0:00:15.148949 2026-01-18 00:21:55.496455 | 2026-01-18 00:21:55.496582 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-18 00:21:55.936285 | debian-bookworm | changed 2026-01-18 00:21:55.941924 | 2026-01-18 00:21:55.942042 | TASK [tox : Get tox envlist config] 2026-01-18 00:21:57.065786 | debian-bookworm | ok: Runtime: 0:00:00.343605 2026-01-18 00:21:57.072042 | 2026-01-18 00:21:57.072167 | TASK [tox : Install any sibling python packages] 2026-01-18 00:21:57.946106 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-18 00:21:57.952229 | 2026-01-18 00:21:57.952325 | TASK [tox : Remove tempfile] 2026-01-18 00:21:58.590922 | debian-bookworm | changed 2026-01-18 00:21:58.595492 | 2026-01-18 00:21:58.595577 | TASK [tox : Emit tox command] 2026-01-18 00:21:58.635972 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-18 00:21:58.640157 | 2026-01-18 00:21:58.640244 | TASK [tox : Run tox] 2026-01-18 00:21:59.278089 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-18 00:21:59.904552 | debian-bookworm | ............... 2026-01-18 00:21:59.904623 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-18 00:21:59.904640 | debian-bookworm | Ran 15 tests in 0.167s 2026-01-18 00:21:59.904646 | debian-bookworm | 2026-01-18 00:21:59.904654 | debian-bookworm | OK 2026-01-18 00:21:59.991193 | debian-bookworm | test: OK (0.76=setup[0.04]+cmd[0.71] seconds) 2026-01-18 00:21:59.991268 | debian-bookworm | congratulations :) (0.79 seconds) 2026-01-18 00:22:00.217636 | debian-bookworm | ok: Runtime: 0:00:01.082922 2026-01-18 00:22:00.223036 | 2026-01-18 00:22:00.223121 | TASK [tox : Look for output] 2026-01-18 00:22:00.674588 | debian-bookworm | ok 2026-01-18 00:22:00.708550 | 2026-01-18 00:22:00.708654 | TASK [tox : Return file comments to Zuul] 2026-01-18 00:22:00.789202 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:00.794261 | 2026-01-18 00:22:00.794326 | PLAY RECAP 2026-01-18 00:22:00.794368 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-18 00:22:00.794389 | 2026-01-18 00:22:01.020846 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-18 00:22:01.022651 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-18 00:22:02.344865 | 2026-01-18 00:22:02.344984 | PLAY [all] 2026-01-18 00:22:02.359418 | 2026-01-18 00:22:02.359529 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-18 00:22:02.403909 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:02.409341 | 2026-01-18 00:22:02.409451 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-18 00:22:02.449560 | debian-bookworm | ok 2026-01-18 00:22:02.453596 | 2026-01-18 00:22:02.453672 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-18 00:22:03.318036 | debian-bookworm -> localhost | changed 2026-01-18 00:22:03.324317 | 2026-01-18 00:22:03.324403 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-18 00:22:03.367103 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:03.373519 | 2026-01-18 00:22:03.373663 | TASK [fetch-tox-output : Set envlist fact] 2026-01-18 00:22:03.420580 | debian-bookworm | ok 2026-01-18 00:22:03.425598 | 2026-01-18 00:22:03.425685 | TASK [fetch-tox-output : Get tox version] 2026-01-18 00:22:04.093898 | 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-18 00:22:04.112955 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-18 00:22:04.451591 | debian-bookworm | ok: Runtime: 0:00:00.312366 2026-01-18 00:22:04.460055 | 2026-01-18 00:22:04.460190 | TASK [fetch-tox-output : Find all default environments] 2026-01-18 00:22:04.997444 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:05.005810 | 2026-01-18 00:22:05.005964 | TASK [fetch-tox-output : Set envlist fact] 2026-01-18 00:22:05.041232 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:05.058735 | 2026-01-18 00:22:05.059643 | TASK [fetch-tox-output : Find all default environments] 2026-01-18 00:22:05.602380 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:05.607116 | 2026-01-18 00:22:05.607203 | TASK [fetch-tox-output : Set envlist fact] 2026-01-18 00:22:05.629922 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:05.635322 | 2026-01-18 00:22:05.635401 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-18 00:22:05.735489 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:05.748504 | 2026-01-18 00:22:05.748599 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-18 00:22:06.788325 | debian-bookworm | changed: 2026-01-18 00:22:06.788590 | debian-bookworm | created directory /var/lib/zuul/builds/41abc3b518f744729b5185f8f50a54a7/work/logs/tox/test 2026-01-18 00:22:06.788629 | debian-bookworm | cd+++++++++ ./ 2026-01-18 00:22:06.788652 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-18 00:22:06.788679 | 2026-01-18 00:22:06.822698 | 2026-01-18 00:22:06.822781 | PLAY RECAP 2026-01-18 00:22:06.822845 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-18 00:22:06.822883 | 2026-01-18 00:22:06.905885 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-18 00:22:06.906670 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-18 00:22:07.691705 | 2026-01-18 00:22:07.691838 | PLAY [all] 2026-01-18 00:22:07.708605 | 2026-01-18 00:22:07.708732 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-18 00:22:07.951475 | debian-bookworm | changed: non-zero return code 2026-01-18 00:22:07.956740 | 2026-01-18 00:22:07.956846 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-18 00:22:07.992050 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:07.998077 | 2026-01-18 00:22:07.998190 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-18 00:22:08.051300 | 2026-01-18 00:22:08.051473 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-18 00:22:08.085521 | 2026-01-18 00:22:08.085687 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-18 00:22:08.118450 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:08.124147 | 2026-01-18 00:22:08.124249 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-18 00:22:08.162483 | 2026-01-18 00:22:08.162657 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-18 00:22:08.195871 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:08.201367 | 2026-01-18 00:22:08.201461 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-18 00:22:08.214403 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:08.219925 | 2026-01-18 00:22:08.220012 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-18 00:22:08.242895 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:22:08.248945 | 2026-01-18 00:22:08.249019 | PLAY RECAP 2026-01-18 00:22:08.249069 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-18 00:22:08.249094 | 2026-01-18 00:22:08.337881 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-18 00:22:08.338826 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-18 00:22:08.996619 | 2026-01-18 00:22:08.996757 | PLAY [Base post] 2026-01-18 00:22:09.008741 | 2026-01-18 00:22:09.008907 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-18 00:22:09.595361 | debian-bookworm | changed 2026-01-18 00:22:09.607129 | 2026-01-18 00:22:09.607311 | PLAY RECAP 2026-01-18 00:22:09.607383 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-18 00:22:09.607445 | 2026-01-18 00:22:09.749726 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-18 00:22:09.760437 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-18 00:22:11.049772 | 2026-01-18 00:22:11.049934 | PLAY [Base post-logs] 2026-01-18 00:22:11.087403 | 2026-01-18 00:22:11.087530 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-18 00:22:11.906419 | localhost | changed 2026-01-18 00:22:11.919452 | 2026-01-18 00:22:11.919583 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-18 00:22:11.998115 | localhost | ok 2026-01-18 00:22:12.001001 | 2026-01-18 00:22:12.001085 | TASK [Set zuul-log-path fact] 2026-01-18 00:22:12.035526 | localhost | ok 2026-01-18 00:22:12.043989 | 2026-01-18 00:22:12.044089 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-18 00:22:12.069296 | localhost | ok 2026-01-18 00:22:12.072324 | 2026-01-18 00:22:12.072416 | TASK [upload-logs : Create log directories] 2026-01-18 00:22:12.827018 | localhost | changed 2026-01-18 00:22:12.829120 | 2026-01-18 00:22:12.829192 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-18 00:22:13.593921 | localhost -> localhost | ok: Runtime: 0:00:00.004051 2026-01-18 00:22:13.597749 | 2026-01-18 00:22:13.597843 | TASK [upload-logs : Upload logs to log server] 2026-01-18 00:22:14.366224 | localhost | Output suppressed because no_log was given 2026-01-18 00:22:14.368590 | 2026-01-18 00:22:14.368683 | LOOP [upload-logs : Compress console log and json output] 2026-01-18 00:22:14.515109 | localhost | skipping: Conditional result was False 2026-01-18 00:22:14.543339 | localhost | skipping: Conditional result was False 2026-01-18 00:22:14.547980 | 2026-01-18 00:22:14.548105 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-18 00:22:14.610474 | localhost | skipping: Conditional result was False 2026-01-18 00:22:14.610694 | 2026-01-18 00:22:14.630216 | localhost | skipping: Conditional result was False 2026-01-18 00:22:14.654039 | 2026-01-18 00:22:14.654153 | LOOP [upload-logs : Upload console log and json output]