2025-11-14 20:07:00.049373 | Job console starting 2025-11-14 20:07:00.083395 | Updating git repos 2025-11-14 20:07:00.173450 | Cloning repos into workspace 2025-11-14 20:07:00.247331 | Restoring repo states 2025-11-14 20:07:00.271276 | Merging changes 2025-11-14 20:07:00.825472 | Checking out repos 2025-11-14 20:07:00.859138 | Preparing playbooks 2025-11-14 20:07:01.827617 | Running Ansible setup 2025-11-14 20:07:07.155832 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-14 20:07:08.380924 | 2025-11-14 20:07:08.381096 | PLAY [Base pre] 2025-11-14 20:07:08.417493 | 2025-11-14 20:07:08.417699 | TASK [Setup log path fact] 2025-11-14 20:07:08.457712 | debian-bookworm | ok 2025-11-14 20:07:08.491461 | 2025-11-14 20:07:08.491654 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-14 20:07:08.553914 | debian-bookworm | ok 2025-11-14 20:07:08.574353 | 2025-11-14 20:07:08.574509 | TASK [emit-job-header : Print job information] 2025-11-14 20:07:08.651818 | # Job Information 2025-11-14 20:07:08.652022 | Ansible Version: 2.16.14 2025-11-14 20:07:08.652059 | Job: tox 2025-11-14 20:07:08.652092 | Pipeline: check 2025-11-14 20:07:08.652115 | Executor: 521e9411259a 2025-11-14 20:07:08.652135 | Triggered by: https://github.com/osism/openstack-image-manager/pull/993 2025-11-14 20:07:08.652155 | Event ID: 746db4c0-c195-11f0-9c18-83ae58d49cb9 2025-11-14 20:07:08.658146 | 2025-11-14 20:07:08.658282 | LOOP [emit-job-header : Print node information] 2025-11-14 20:07:08.879048 | debian-bookworm | ok: 2025-11-14 20:07:08.879265 | debian-bookworm | # Node Information 2025-11-14 20:07:08.879301 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-14 20:07:08.879326 | debian-bookworm | Hostname: debian 2025-11-14 20:07:08.879348 | debian-bookworm | Username: zuul 2025-11-14 20:07:08.879369 | debian-bookworm | Distro: Debian 12.12 2025-11-14 20:07:08.879392 | debian-bookworm | Provider: regiocloud-a 2025-11-14 20:07:08.879412 | debian-bookworm | Region: 2025-11-14 20:07:08.879432 | debian-bookworm | Label: debian-bookworm 2025-11-14 20:07:08.879452 | debian-bookworm | Product Name: OpenStack Nova 2025-11-14 20:07:08.879470 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe39:2e31 2025-11-14 20:07:08.892686 | 2025-11-14 20:07:08.893650 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-14 20:07:09.577446 | debian-bookworm -> localhost | changed 2025-11-14 20:07:09.584857 | 2025-11-14 20:07:09.584996 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-14 20:07:10.984724 | debian-bookworm -> localhost | changed 2025-11-14 20:07:10.996859 | 2025-11-14 20:07:10.997000 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-14 20:07:11.600040 | debian-bookworm -> localhost | ok 2025-11-14 20:07:11.607523 | 2025-11-14 20:07:11.607707 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-14 20:07:11.648471 | debian-bookworm | ok 2025-11-14 20:07:11.686812 | debian-bookworm | included: /var/lib/zuul/builds/501bfcf49cb84ca7ba163eeaa8ba676b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-14 20:07:11.693228 | 2025-11-14 20:07:11.693341 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-14 20:07:13.549696 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-14 20:07:13.549928 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/501bfcf49cb84ca7ba163eeaa8ba676b/work/501bfcf49cb84ca7ba163eeaa8ba676b_id_rsa 2025-11-14 20:07:13.549967 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/501bfcf49cb84ca7ba163eeaa8ba676b/work/501bfcf49cb84ca7ba163eeaa8ba676b_id_rsa.pub 2025-11-14 20:07:13.549993 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-14 20:07:13.550019 | debian-bookworm -> localhost | SHA256:vpbFjXGg3IBqd0Nw9Hm8og66Mfy88AW1O94njMMQ98w zuul-build-sshkey 2025-11-14 20:07:13.550042 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-14 20:07:13.550077 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-14 20:07:13.550100 | debian-bookworm -> localhost | | .+o | 2025-11-14 20:07:13.550122 | debian-bookworm -> localhost | | ..o..o | 2025-11-14 20:07:13.550142 | debian-bookworm -> localhost | | . o.+o.o | 2025-11-14 20:07:13.550163 | debian-bookworm -> localhost | | o o.*.o... | 2025-11-14 20:07:13.550183 | debian-bookworm -> localhost | | . ..+S*.=. | 2025-11-14 20:07:13.550211 | debian-bookworm -> localhost | | . .o oE.. | 2025-11-14 20:07:13.550232 | debian-bookworm -> localhost | | = .o*= | 2025-11-14 20:07:13.550254 | debian-bookworm -> localhost | | O =*+o . | 2025-11-14 20:07:13.550275 | debian-bookworm -> localhost | | o.=o+..o | 2025-11-14 20:07:13.550296 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-14 20:07:13.550346 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.756130 2025-11-14 20:07:13.557093 | 2025-11-14 20:07:13.557207 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-14 20:07:13.604328 | debian-bookworm | ok 2025-11-14 20:07:13.620141 | debian-bookworm | included: /var/lib/zuul/builds/501bfcf49cb84ca7ba163eeaa8ba676b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-14 20:07:13.630174 | 2025-11-14 20:07:13.630316 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-14 20:07:13.654915 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:07:13.661295 | 2025-11-14 20:07:13.661425 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-14 20:07:14.289582 | debian-bookworm | changed 2025-11-14 20:07:14.295990 | 2025-11-14 20:07:14.297479 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-14 20:07:14.550641 | debian-bookworm | ok 2025-11-14 20:07:14.556721 | 2025-11-14 20:07:14.556880 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-14 20:07:15.232407 | debian-bookworm | changed 2025-11-14 20:07:15.245582 | 2025-11-14 20:07:15.245762 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-14 20:07:15.932113 | debian-bookworm | changed 2025-11-14 20:07:15.938204 | 2025-11-14 20:07:15.938325 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-14 20:07:15.973660 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:07:15.980185 | 2025-11-14 20:07:15.980306 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-14 20:07:16.778348 | debian-bookworm -> localhost | changed 2025-11-14 20:07:16.789648 | 2025-11-14 20:07:16.789775 | TASK [add-build-sshkey : Add back temp key] 2025-11-14 20:07:17.219063 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/501bfcf49cb84ca7ba163eeaa8ba676b/work/501bfcf49cb84ca7ba163eeaa8ba676b_id_rsa (zuul-build-sshkey) 2025-11-14 20:07:17.219329 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017158 2025-11-14 20:07:17.228107 | 2025-11-14 20:07:17.228233 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-14 20:07:17.744016 | debian-bookworm | ok 2025-11-14 20:07:17.751949 | 2025-11-14 20:07:17.752072 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-14 20:07:17.789945 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:07:17.836726 | 2025-11-14 20:07:17.836887 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-14 20:07:18.331889 | debian-bookworm | ok 2025-11-14 20:07:18.343817 | 2025-11-14 20:07:18.343956 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-14 20:07:18.398759 | debian-bookworm | ok 2025-11-14 20:07:18.411798 | 2025-11-14 20:07:18.411948 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-14 20:07:18.785383 | debian-bookworm -> localhost | ok 2025-11-14 20:07:18.794327 | 2025-11-14 20:07:18.794441 | TASK [validate-host : Collect information about the host] 2025-11-14 20:07:19.933994 | debian-bookworm | ok 2025-11-14 20:07:19.944772 | 2025-11-14 20:07:19.944900 | TASK [validate-host : Sanitize hostname] 2025-11-14 20:07:20.057626 | debian-bookworm | ok 2025-11-14 20:07:20.106301 | 2025-11-14 20:07:20.106426 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-14 20:07:21.001488 | debian-bookworm -> localhost | changed 2025-11-14 20:07:21.007821 | 2025-11-14 20:07:21.007948 | TASK [validate-host : Collect information about zuul worker] 2025-11-14 20:07:21.423608 | debian-bookworm | ok 2025-11-14 20:07:21.428717 | 2025-11-14 20:07:21.428839 | TASK [validate-host : Write out all zuul information for each host] 2025-11-14 20:07:22.299160 | debian-bookworm -> localhost | changed 2025-11-14 20:07:22.319944 | 2025-11-14 20:07:22.320089 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-14 20:07:22.613876 | debian-bookworm | ok 2025-11-14 20:07:22.621434 | 2025-11-14 20:07:22.621554 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-14 20:07:23.727845 | debian-bookworm | changed: 2025-11-14 20:07:23.728058 | debian-bookworm | cd+++++++++ src/ 2025-11-14 20:07:23.728094 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-14 20:07:23.728118 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-14 20:07:23.728140 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-14 20:07:23.728161 | debian-bookworm | =6.2 2025-11-14 20:07:45.864334 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-11-14 20:07:45.905796 | debian-bookworm | Collecting chardet>=5.2 2025-11-14 20:07:45.921684 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-14 20:07:45.940757 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 12.2 MB/s eta 0:00:00 2025-11-14 20:07:45.978925 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-14 20:07:45.992031 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-14 20:07:46.050577 | debian-bookworm | Collecting filelock>=3.20 2025-11-14 20:07:46.064809 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-14 20:07:46.132544 | debian-bookworm | Collecting packaging>=25 2025-11-14 20:07:46.147335 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-14 20:07:46.157867 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.5 MB/s eta 0:00:00 2025-11-14 20:07:46.215102 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-14 20:07:46.237009 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-14 20:07:46.299570 | debian-bookworm | Collecting pluggy>=1.6 2025-11-14 20:07:46.312796 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-14 20:07:46.387088 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-14 20:07:46.404928 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-14 20:07:46.550786 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-14 20:07:46.569951 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-14 20:07:47.160563 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 10.2 MB/s eta 0:00:00 2025-11-14 20:07:47.264149 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-14 20:07:47.490493 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-14 20:07:47.511715 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 27.8 MB/s eta 0:00:00 2025-11-14 20:07:47.656459 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-14 20:07:48.561241 | 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-14 20:07:48.785507 | debian-bookworm | ok: Runtime: 0:00:03.642337 2025-11-14 20:07:48.792004 | 2025-11-14 20:07:48.792124 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-14 20:07:48.833152 | debian-bookworm | ok 2025-11-14 20:07:48.838303 | 2025-11-14 20:07:48.838417 | TASK [ensure-tox : Output tox version] 2025-11-14 20:07:49.340068 | 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-14 20:07:49.358262 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-14 20:07:49.870041 | debian-bookworm | ok: Runtime: 0:00:00.294610 2025-11-14 20:07:49.884299 | 2025-11-14 20:07:49.884437 | TASK [ensure-tox : Make global symlink] 2025-11-14 20:07:49.911602 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:07:49.920014 | 2025-11-14 20:07:49.920130 | PLAY RECAP 2025-11-14 20:07:49.920193 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-14 20:07:49.920221 | 2025-11-14 20:07:50.125045 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-14 20:07:50.127807 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-14 20:07:51.022885 | 2025-11-14 20:07:51.023059 | PLAY [all] 2025-11-14 20:07:51.039392 | 2025-11-14 20:07:51.039539 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-14 20:07:51.482776 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-14 20:07:51.569995 | debian-bookworm | ok: Runtime: 0:00:00.030280 2025-11-14 20:07:51.584274 | 2025-11-14 20:07:51.584488 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-14 20:07:52.122306 | debian-bookworm | ok: Runtime: 0:00:00.006456 2025-11-14 20:07:52.128755 | 2025-11-14 20:07:52.128875 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-14 20:07:52.433440 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-14 20:07:52.435156 | debian-bookworm | sudo: a password is required 2025-11-14 20:07:52.661218 | debian-bookworm | ok: Runtime: 0:00:00.017854 2025-11-14 20:07:52.679825 | 2025-11-14 20:07:52.679955 | TASK [tox : Check to see if the constraints file exists] 2025-11-14 20:07:52.715385 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:07:52.729552 | 2025-11-14 20:07:52.729767 | TASK [tox : Fail if constraints file is missing] 2025-11-14 20:07:52.765159 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:07:52.777497 | 2025-11-14 20:07:52.777695 | TASK [tox : Record file location] 2025-11-14 20:07:52.820658 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:07:52.834601 | 2025-11-14 20:07:52.834823 | TASK [tox : Install tox siblings] 2025-11-14 20:07:52.871692 | debian-bookworm | ok 2025-11-14 20:07:52.884566 | debian-bookworm | included: /var/lib/zuul/builds/501bfcf49cb84ca7ba163eeaa8ba676b/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-14 20:07:52.890478 | 2025-11-14 20:07:52.890595 | TASK [tox : Run tox without tests] 2025-11-14 20:07:54.047950 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-14 20:08:07.860565 | debian-bookworm | test: OK (14.45 seconds) 2025-11-14 20:08:07.860614 | debian-bookworm | congratulations :) (14.48 seconds) 2025-11-14 20:08:07.968963 | debian-bookworm | ok: Runtime: 0:00:14.750981 2025-11-14 20:08:07.977589 | 2025-11-14 20:08:07.977757 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-14 20:08:08.397277 | debian-bookworm | changed 2025-11-14 20:08:08.406542 | 2025-11-14 20:08:08.406730 | TASK [tox : Get tox envlist config] 2025-11-14 20:08:09.441930 | debian-bookworm | ok: Runtime: 0:00:00.336804 2025-11-14 20:08:09.455697 | 2025-11-14 20:08:09.455893 | TASK [tox : Install any sibling python packages] 2025-11-14 20:08:09.920990 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-14 20:08:09.930364 | 2025-11-14 20:08:09.930537 | TASK [tox : Remove tempfile] 2025-11-14 20:08:10.369259 | debian-bookworm | changed 2025-11-14 20:08:10.376917 | 2025-11-14 20:08:10.377074 | TASK [tox : Emit tox command] 2025-11-14 20:08:10.432779 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-14 20:08:10.441201 | 2025-11-14 20:08:10.441353 | TASK [tox : Run tox] 2025-11-14 20:08:11.054274 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-14 20:08:11.696308 | debian-bookworm | ............... 2025-11-14 20:08:11.696356 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-14 20:08:11.696371 | debian-bookworm | Ran 15 tests in 0.166s 2025-11-14 20:08:11.696376 | debian-bookworm | 2025-11-14 20:08:11.696383 | debian-bookworm | OK 2025-11-14 20:08:11.781302 | debian-bookworm | test: OK (0.77=setup[0.04]+cmd[0.72] seconds) 2025-11-14 20:08:11.781364 | debian-bookworm | congratulations :) (0.79 seconds) 2025-11-14 20:08:12.019563 | debian-bookworm | ok: Runtime: 0:00:01.062180 2025-11-14 20:08:12.030140 | 2025-11-14 20:08:12.030278 | TASK [tox : Look for output] 2025-11-14 20:08:12.430480 | debian-bookworm | ok 2025-11-14 20:08:12.452178 | 2025-11-14 20:08:12.452356 | TASK [tox : Return file comments to Zuul] 2025-11-14 20:08:12.493286 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:12.507111 | 2025-11-14 20:08:12.507243 | PLAY RECAP 2025-11-14 20:08:12.507325 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-14 20:08:12.507366 | 2025-11-14 20:08:12.649845 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-14 20:08:12.651831 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-14 20:08:13.427567 | 2025-11-14 20:08:13.427775 | PLAY [all] 2025-11-14 20:08:13.443302 | 2025-11-14 20:08:13.443456 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-14 20:08:13.499536 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:13.510202 | 2025-11-14 20:08:13.510400 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-14 20:08:13.567892 | debian-bookworm | ok 2025-11-14 20:08:13.576035 | 2025-11-14 20:08:13.576194 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-14 20:08:14.088015 | debian-bookworm -> localhost | changed 2025-11-14 20:08:14.096424 | 2025-11-14 20:08:14.096571 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-14 20:08:14.140923 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:14.146982 | 2025-11-14 20:08:14.147122 | TASK [fetch-tox-output : Set envlist fact] 2025-11-14 20:08:14.205589 | debian-bookworm | ok 2025-11-14 20:08:14.214746 | 2025-11-14 20:08:14.214946 | TASK [fetch-tox-output : Get tox version] 2025-11-14 20:08:14.899186 | 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-14 20:08:14.916917 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-14 20:08:15.249548 | debian-bookworm | ok: Runtime: 0:00:00.281753 2025-11-14 20:08:15.262466 | 2025-11-14 20:08:15.262654 | TASK [fetch-tox-output : Find all default environments] 2025-11-14 20:08:15.796842 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:15.803215 | 2025-11-14 20:08:15.803354 | TASK [fetch-tox-output : Set envlist fact] 2025-11-14 20:08:15.838173 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:15.852037 | 2025-11-14 20:08:15.852225 | TASK [fetch-tox-output : Find all default environments] 2025-11-14 20:08:16.389045 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:16.397795 | 2025-11-14 20:08:16.397956 | TASK [fetch-tox-output : Set envlist fact] 2025-11-14 20:08:16.433069 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:16.447833 | 2025-11-14 20:08:16.448018 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-14 20:08:16.493726 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:16.518803 | 2025-11-14 20:08:16.519031 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-14 20:08:17.288242 | debian-bookworm | changed: 2025-11-14 20:08:17.288446 | debian-bookworm | created directory /var/lib/zuul/builds/501bfcf49cb84ca7ba163eeaa8ba676b/work/logs/tox/test 2025-11-14 20:08:17.288481 | debian-bookworm | cd+++++++++ ./ 2025-11-14 20:08:17.288506 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-14 20:08:17.288535 | 2025-11-14 20:08:17.304861 | 2025-11-14 20:08:17.304981 | PLAY RECAP 2025-11-14 20:08:17.305043 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-14 20:08:17.305073 | 2025-11-14 20:08:17.439294 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-14 20:08:17.442104 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-14 20:08:18.242265 | 2025-11-14 20:08:18.242424 | PLAY [all] 2025-11-14 20:08:18.259406 | 2025-11-14 20:08:18.259553 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-14 20:08:18.510940 | debian-bookworm | changed: non-zero return code 2025-11-14 20:08:18.519983 | 2025-11-14 20:08:18.520178 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-14 20:08:18.556070 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:18.565989 | 2025-11-14 20:08:18.566147 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-14 20:08:18.605387 | 2025-11-14 20:08:18.605716 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-14 20:08:18.641408 | 2025-11-14 20:08:18.641615 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-14 20:08:18.667380 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:18.679558 | 2025-11-14 20:08:18.679772 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-14 20:08:18.713200 | 2025-11-14 20:08:18.713487 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-14 20:08:18.737203 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:18.744142 | 2025-11-14 20:08:18.744273 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-14 20:08:18.768148 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:18.777583 | 2025-11-14 20:08:18.777765 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-14 20:08:18.802336 | debian-bookworm | skipping: Conditional result was False 2025-11-14 20:08:18.820475 | 2025-11-14 20:08:18.820671 | PLAY RECAP 2025-11-14 20:08:18.820789 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-14 20:08:18.820844 | 2025-11-14 20:08:18.948255 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-14 20:08:18.950146 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-14 20:08:19.784324 | 2025-11-14 20:08:19.784489 | PLAY [Base post] 2025-11-14 20:08:19.798220 | 2025-11-14 20:08:19.798353 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-14 20:08:20.404836 | debian-bookworm | changed 2025-11-14 20:08:20.417422 | 2025-11-14 20:08:20.417611 | PLAY RECAP 2025-11-14 20:08:20.417736 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-14 20:08:20.417845 | 2025-11-14 20:08:20.546001 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-14 20:08:20.547342 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-14 20:08:21.341233 | 2025-11-14 20:08:21.341411 | PLAY [Base post-logs] 2025-11-14 20:08:21.352369 | 2025-11-14 20:08:21.352551 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-14 20:08:21.847323 | localhost | changed 2025-11-14 20:08:21.862014 | 2025-11-14 20:08:21.862202 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-14 20:08:21.890769 | localhost | ok 2025-11-14 20:08:21.897907 | 2025-11-14 20:08:21.898101 | TASK [Set zuul-log-path fact] 2025-11-14 20:08:21.915241 | localhost | ok 2025-11-14 20:08:21.926999 | 2025-11-14 20:08:21.927148 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-14 20:08:21.954057 | localhost | ok 2025-11-14 20:08:21.959415 | 2025-11-14 20:08:21.959582 | TASK [upload-logs : Create log directories] 2025-11-14 20:08:22.502159 | localhost | changed 2025-11-14 20:08:22.508679 | 2025-11-14 20:08:22.508888 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-14 20:08:23.053939 | localhost -> localhost | ok: Runtime: 0:00:00.007740 2025-11-14 20:08:23.062076 | 2025-11-14 20:08:23.062259 | TASK [upload-logs : Upload logs to log server] 2025-11-14 20:08:23.639607 | localhost | Output suppressed because no_log was given 2025-11-14 20:08:23.643239 | 2025-11-14 20:08:23.643437 | LOOP [upload-logs : Compress console log and json output] 2025-11-14 20:08:23.700789 | localhost | skipping: Conditional result was False 2025-11-14 20:08:23.705493 | localhost | skipping: Conditional result was False 2025-11-14 20:08:23.718963 | 2025-11-14 20:08:23.719343 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-14 20:08:23.767389 | localhost | skipping: Conditional result was False 2025-11-14 20:08:23.768040 | 2025-11-14 20:08:23.772480 | localhost | skipping: Conditional result was False 2025-11-14 20:08:23.785482 | 2025-11-14 20:08:23.785817 | LOOP [upload-logs : Upload console log and json output]