2025-12-12 00:23:03.278455 | Job console starting 2025-12-12 00:23:03.294899 | Updating git repos 2025-12-12 00:23:03.323940 | Cloning repos into workspace 2025-12-12 00:23:03.390627 | Restoring repo states 2025-12-12 00:23:03.408065 | Merging changes 2025-12-12 00:23:03.913231 | Checking out repos 2025-12-12 00:23:03.960241 | Preparing playbooks 2025-12-12 00:23:04.543704 | Running Ansible setup 2025-12-12 00:23:09.196661 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-12 00:23:10.014731 | 2025-12-12 00:23:10.015082 | PLAY [Base pre] 2025-12-12 00:23:10.032525 | 2025-12-12 00:23:10.032679 | TASK [Setup log path fact] 2025-12-12 00:23:10.052535 | debian-bookworm | ok 2025-12-12 00:23:10.068489 | 2025-12-12 00:23:10.068654 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-12 00:23:10.111482 | debian-bookworm | ok 2025-12-12 00:23:10.123048 | 2025-12-12 00:23:10.123183 | TASK [emit-job-header : Print job information] 2025-12-12 00:23:10.173250 | # Job Information 2025-12-12 00:23:10.173437 | Ansible Version: 2.16.14 2025-12-12 00:23:10.173473 | Job: tox 2025-12-12 00:23:10.173506 | Pipeline: check 2025-12-12 00:23:10.173529 | Executor: 521e9411259a 2025-12-12 00:23:10.173549 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1032 2025-12-12 00:23:10.173571 | Event ID: 0e8508a0-d6f0-11f0-87d7-545fd204f0e6 2025-12-12 00:23:10.180133 | 2025-12-12 00:23:10.180278 | LOOP [emit-job-header : Print node information] 2025-12-12 00:23:10.306395 | debian-bookworm | ok: 2025-12-12 00:23:10.306722 | debian-bookworm | # Node Information 2025-12-12 00:23:10.306782 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-12 00:23:10.306820 | debian-bookworm | Hostname: debian 2025-12-12 00:23:10.306892 | debian-bookworm | Username: zuul 2025-12-12 00:23:10.306941 | debian-bookworm | Distro: Debian 12.12 2025-12-12 00:23:10.306997 | debian-bookworm | Provider: regiocloud-a 2025-12-12 00:23:10.307032 | debian-bookworm | Region: 2025-12-12 00:23:10.307063 | debian-bookworm | Label: debian-bookworm 2025-12-12 00:23:10.307093 | debian-bookworm | Product Name: OpenStack Nova 2025-12-12 00:23:10.307122 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0e:77f6 2025-12-12 00:23:10.327762 | 2025-12-12 00:23:10.327938 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-12 00:23:10.835228 | debian-bookworm -> localhost | changed 2025-12-12 00:23:10.856563 | 2025-12-12 00:23:10.856820 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-12 00:23:12.042602 | debian-bookworm -> localhost | changed 2025-12-12 00:23:12.059099 | 2025-12-12 00:23:12.059269 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-12 00:23:12.360528 | debian-bookworm -> localhost | ok 2025-12-12 00:23:12.375871 | 2025-12-12 00:23:12.376122 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-12 00:23:12.415576 | debian-bookworm | ok 2025-12-12 00:23:12.437524 | debian-bookworm | included: /var/lib/zuul/builds/d7c476034d9d4d2d9dac749c485c72f1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-12 00:23:12.444504 | 2025-12-12 00:23:12.444657 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-12 00:23:13.374746 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-12 00:23:13.375748 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d7c476034d9d4d2d9dac749c485c72f1/work/d7c476034d9d4d2d9dac749c485c72f1_id_rsa 2025-12-12 00:23:13.375853 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d7c476034d9d4d2d9dac749c485c72f1/work/d7c476034d9d4d2d9dac749c485c72f1_id_rsa.pub 2025-12-12 00:23:13.375902 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-12 00:23:13.375947 | debian-bookworm -> localhost | SHA256:YdOu5c2L5E7As2Dn0GibKhIKIjH+1xPqXBfenSbgL/c zuul-build-sshkey 2025-12-12 00:23:13.376008 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-12 00:23:13.376064 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-12 00:23:13.376102 | debian-bookworm -> localhost | | | 2025-12-12 00:23:13.376138 | debian-bookworm -> localhost | | . | 2025-12-12 00:23:13.376171 | debian-bookworm -> localhost | | + . | 2025-12-12 00:23:13.376203 | debian-bookworm -> localhost | |o = + | 2025-12-12 00:23:13.376235 | debian-bookworm -> localhost | |.o * Soo | 2025-12-12 00:23:13.376280 | debian-bookworm -> localhost | |=. o OoB+o. . | 2025-12-12 00:23:13.376317 | debian-bookworm -> localhost | |=.. =.=++oo+ | 2025-12-12 00:23:13.376350 | debian-bookworm -> localhost | |o ...+.o.=.oo. | 2025-12-12 00:23:13.376384 | debian-bookworm -> localhost | | . .+o ..*.oE | 2025-12-12 00:23:13.376417 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-12 00:23:13.376507 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.381801 2025-12-12 00:23:13.391415 | 2025-12-12 00:23:13.391545 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-12 00:23:13.421707 | debian-bookworm | ok 2025-12-12 00:23:13.432557 | debian-bookworm | included: /var/lib/zuul/builds/d7c476034d9d4d2d9dac749c485c72f1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-12 00:23:13.442200 | 2025-12-12 00:23:13.442309 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-12 00:23:13.467638 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:23:13.485207 | 2025-12-12 00:23:13.485386 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-12 00:23:14.132220 | debian-bookworm | changed 2025-12-12 00:23:14.139334 | 2025-12-12 00:23:14.139482 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-12 00:23:14.379480 | debian-bookworm | ok 2025-12-12 00:23:14.389535 | 2025-12-12 00:23:14.389682 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-12 00:23:15.173268 | debian-bookworm | changed 2025-12-12 00:23:15.191291 | 2025-12-12 00:23:15.191448 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-12 00:23:15.924898 | debian-bookworm | changed 2025-12-12 00:23:15.937496 | 2025-12-12 00:23:15.937671 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-12 00:23:15.969720 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:23:15.977603 | 2025-12-12 00:23:15.977736 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-12 00:23:16.465919 | debian-bookworm -> localhost | changed 2025-12-12 00:23:16.478266 | 2025-12-12 00:23:16.478419 | TASK [add-build-sshkey : Add back temp key] 2025-12-12 00:23:16.866492 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d7c476034d9d4d2d9dac749c485c72f1/work/d7c476034d9d4d2d9dac749c485c72f1_id_rsa (zuul-build-sshkey) 2025-12-12 00:23:16.867339 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015867 2025-12-12 00:23:16.877857 | 2025-12-12 00:23:16.878079 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-12 00:23:17.336861 | debian-bookworm | ok 2025-12-12 00:23:17.346780 | 2025-12-12 00:23:17.347385 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-12 00:23:17.384050 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:23:17.402330 | 2025-12-12 00:23:17.402482 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-12 00:23:17.863908 | debian-bookworm | ok 2025-12-12 00:23:17.878353 | 2025-12-12 00:23:17.878494 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-12 00:23:17.909211 | debian-bookworm | ok 2025-12-12 00:23:17.922853 | 2025-12-12 00:23:17.923035 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-12 00:23:18.251326 | debian-bookworm -> localhost | ok 2025-12-12 00:23:18.260839 | 2025-12-12 00:23:18.260981 | TASK [validate-host : Collect information about the host] 2025-12-12 00:23:19.470727 | debian-bookworm | ok 2025-12-12 00:23:19.498566 | 2025-12-12 00:23:19.498766 | TASK [validate-host : Sanitize hostname] 2025-12-12 00:23:19.628236 | debian-bookworm | ok 2025-12-12 00:23:19.687907 | 2025-12-12 00:23:19.688131 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-12 00:23:20.334284 | debian-bookworm -> localhost | changed 2025-12-12 00:23:20.353016 | 2025-12-12 00:23:20.353173 | TASK [validate-host : Collect information about zuul worker] 2025-12-12 00:23:20.824330 | debian-bookworm | ok 2025-12-12 00:23:20.830327 | 2025-12-12 00:23:20.830459 | TASK [validate-host : Write out all zuul information for each host] 2025-12-12 00:23:21.690449 | debian-bookworm -> localhost | changed 2025-12-12 00:23:21.705813 | 2025-12-12 00:23:21.705950 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-12 00:23:22.020858 | debian-bookworm | ok 2025-12-12 00:23:22.033115 | 2025-12-12 00:23:22.033288 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-12 00:23:23.157039 | debian-bookworm | changed: 2025-12-12 00:23:23.157255 | debian-bookworm | cd+++++++++ src/ 2025-12-12 00:23:23.157292 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-12 00:23:23.157318 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-12 00:23:23.157340 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-12 00:23:23.157360 | debian-bookworm | =6.2 2025-12-12 00:23:46.243405 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-12-12 00:23:46.301160 | debian-bookworm | Collecting chardet>=5.2 2025-12-12 00:23:46.317112 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-12 00:23:46.341462 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 9.3 MB/s eta 0:00:00 2025-12-12 00:23:46.405082 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-12 00:23:46.423526 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-12 00:23:46.531884 | debian-bookworm | Collecting filelock>=3.20 2025-12-12 00:23:46.548429 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-12-12 00:23:46.615992 | debian-bookworm | Collecting packaging>=25 2025-12-12 00:23:46.631713 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-12 00:23:46.645391 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.1 MB/s eta 0:00:00 2025-12-12 00:23:46.709021 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-12 00:23:46.724685 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-12 00:23:46.768983 | debian-bookworm | Collecting pluggy>=1.6 2025-12-12 00:23:46.785914 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-12 00:23:46.847992 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-12 00:23:46.865073 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-12 00:23:47.005995 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-12 00:23:47.022167 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-12 00:23:47.393898 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 16.4 MB/s eta 0:00:00 2025-12-12 00:23:47.510259 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-12 00:23:47.526033 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-12 00:23:47.551664 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.3 MB/s eta 0:00:00 2025-12-12 00:23:47.711587 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-12 00:23:48.582155 | 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.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-12-12 00:23:49.099388 | debian-bookworm | ok: Runtime: 0:00:03.367371 2025-12-12 00:23:49.110029 | 2025-12-12 00:23:49.110189 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-12 00:23:49.169730 | debian-bookworm | ok 2025-12-12 00:23:49.179949 | 2025-12-12 00:23:49.180134 | TASK [ensure-tox : Output tox version] 2025-12-12 00:23:49.710184 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-12 00:23:49.730298 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-12 00:23:50.212877 | debian-bookworm | ok: Runtime: 0:00:00.302732 2025-12-12 00:23:50.224310 | 2025-12-12 00:23:50.224487 | TASK [ensure-tox : Make global symlink] 2025-12-12 00:23:50.251297 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:23:50.265991 | 2025-12-12 00:23:50.266128 | PLAY RECAP 2025-12-12 00:23:50.266213 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-12 00:23:50.266253 | 2025-12-12 00:23:50.411610 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-12 00:23:50.412987 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-12 00:23:51.237340 | 2025-12-12 00:23:51.237520 | PLAY [all] 2025-12-12 00:23:51.253933 | 2025-12-12 00:23:51.254149 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-12 00:23:51.733915 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-12 00:23:51.789561 | debian-bookworm | ok: Runtime: 0:00:00.025411 2025-12-12 00:23:51.798409 | 2025-12-12 00:23:51.798593 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-12 00:23:52.337067 | debian-bookworm | ok: Runtime: 0:00:00.006831 2025-12-12 00:23:52.351212 | 2025-12-12 00:23:52.351410 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-12 00:23:52.668488 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-12 00:23:52.672600 | debian-bookworm | sudo: a password is required 2025-12-12 00:23:52.894278 | debian-bookworm | ok: Runtime: 0:00:00.026260 2025-12-12 00:23:52.913435 | 2025-12-12 00:23:52.913587 | TASK [tox : Check to see if the constraints file exists] 2025-12-12 00:23:52.960170 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:23:52.972523 | 2025-12-12 00:23:52.972681 | TASK [tox : Fail if constraints file is missing] 2025-12-12 00:23:53.009623 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:23:53.017488 | 2025-12-12 00:23:53.017816 | TASK [tox : Record file location] 2025-12-12 00:23:53.062172 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:23:53.068351 | 2025-12-12 00:23:53.068477 | TASK [tox : Install tox siblings] 2025-12-12 00:23:53.099172 | debian-bookworm | ok 2025-12-12 00:23:53.107917 | debian-bookworm | included: /var/lib/zuul/builds/d7c476034d9d4d2d9dac749c485c72f1/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-12 00:23:53.113703 | 2025-12-12 00:23:53.113823 | TASK [tox : Run tox without tests] 2025-12-12 00:23:54.205753 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-12 00:24:09.607215 | debian-bookworm | test: OK (15.95 seconds) 2025-12-12 00:24:09.607276 | debian-bookworm | congratulations :) (15.98 seconds) 2025-12-12 00:24:10.159906 | debian-bookworm | ok: Runtime: 0:00:16.262226 2025-12-12 00:24:10.173582 | 2025-12-12 00:24:10.173774 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-12 00:24:10.694628 | debian-bookworm | changed 2025-12-12 00:24:10.702072 | 2025-12-12 00:24:10.702193 | TASK [tox : Get tox envlist config] 2025-12-12 00:24:11.734382 | debian-bookworm | ok: Runtime: 0:00:00.354898 2025-12-12 00:24:11.746562 | 2025-12-12 00:24:11.746730 | TASK [tox : Install any sibling python packages] 2025-12-12 00:24:12.230144 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-12 00:24:12.239899 | 2025-12-12 00:24:12.240042 | TASK [tox : Remove tempfile] 2025-12-12 00:24:12.713458 | debian-bookworm | changed 2025-12-12 00:24:12.723939 | 2025-12-12 00:24:12.724133 | TASK [tox : Emit tox command] 2025-12-12 00:24:12.780237 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-12 00:24:12.788003 | 2025-12-12 00:24:12.788143 | TASK [tox : Run tox] 2025-12-12 00:24:13.446267 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-12 00:24:14.077969 | debian-bookworm | ............... 2025-12-12 00:24:14.078011 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-12 00:24:14.078024 | debian-bookworm | Ran 15 tests in 0.171s 2025-12-12 00:24:14.078029 | debian-bookworm | 2025-12-12 00:24:14.078035 | debian-bookworm | OK 2025-12-12 00:24:14.144893 | debian-bookworm | test: OK (0.74=setup[0.04]+cmd[0.70] seconds) 2025-12-12 00:24:14.144937 | debian-bookworm | congratulations :) (0.77 seconds) 2025-12-12 00:24:14.362428 | debian-bookworm | ok: Runtime: 0:00:01.057358 2025-12-12 00:24:14.370578 | 2025-12-12 00:24:14.370730 | TASK [tox : Look for output] 2025-12-12 00:24:14.771090 | debian-bookworm | ok 2025-12-12 00:24:14.784872 | 2025-12-12 00:24:14.785059 | TASK [tox : Return file comments to Zuul] 2025-12-12 00:24:14.829625 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:14.839919 | 2025-12-12 00:24:14.840121 | PLAY RECAP 2025-12-12 00:24:14.840211 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-12 00:24:14.840267 | 2025-12-12 00:24:14.988352 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-12 00:24:14.990094 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-12 00:24:15.776599 | 2025-12-12 00:24:15.776781 | PLAY [all] 2025-12-12 00:24:15.793004 | 2025-12-12 00:24:15.793163 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-12 00:24:15.860208 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:15.866627 | 2025-12-12 00:24:15.866792 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-12 00:24:15.907731 | debian-bookworm | ok 2025-12-12 00:24:15.915837 | 2025-12-12 00:24:15.916049 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-12 00:24:16.479399 | debian-bookworm -> localhost | changed 2025-12-12 00:24:16.487615 | 2025-12-12 00:24:16.487759 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-12 00:24:16.546375 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:16.558795 | 2025-12-12 00:24:16.559084 | TASK [fetch-tox-output : Set envlist fact] 2025-12-12 00:24:16.605804 | debian-bookworm | ok 2025-12-12 00:24:16.615508 | 2025-12-12 00:24:16.615654 | TASK [fetch-tox-output : Get tox version] 2025-12-12 00:24:17.458411 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-12 00:24:17.477069 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-12 00:24:17.653752 | debian-bookworm | ok: Runtime: 0:00:00.321902 2025-12-12 00:24:17.685197 | 2025-12-12 00:24:17.685353 | TASK [fetch-tox-output : Find all default environments] 2025-12-12 00:24:18.269547 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:18.279473 | 2025-12-12 00:24:18.279676 | TASK [fetch-tox-output : Set envlist fact] 2025-12-12 00:24:18.305468 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:18.317062 | 2025-12-12 00:24:18.317252 | TASK [fetch-tox-output : Find all default environments] 2025-12-12 00:24:18.850749 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:18.857487 | 2025-12-12 00:24:18.857623 | TASK [fetch-tox-output : Set envlist fact] 2025-12-12 00:24:18.946086 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:18.954387 | 2025-12-12 00:24:18.954557 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-12 00:24:19.032378 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:19.051468 | 2025-12-12 00:24:19.051623 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-12 00:24:20.133194 | debian-bookworm | changed: 2025-12-12 00:24:20.133411 | debian-bookworm | created directory /var/lib/zuul/builds/d7c476034d9d4d2d9dac749c485c72f1/work/logs/tox/test 2025-12-12 00:24:20.133447 | debian-bookworm | cd+++++++++ ./ 2025-12-12 00:24:20.133473 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-12 00:24:20.133502 | 2025-12-12 00:24:20.145490 | 2025-12-12 00:24:20.145597 | PLAY RECAP 2025-12-12 00:24:20.145649 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-12 00:24:20.145674 | 2025-12-12 00:24:20.327556 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-12 00:24:20.328773 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-12 00:24:21.664267 | 2025-12-12 00:24:21.664430 | PLAY [all] 2025-12-12 00:24:21.684046 | 2025-12-12 00:24:21.684211 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-12 00:24:21.932686 | debian-bookworm | changed: non-zero return code 2025-12-12 00:24:21.939772 | 2025-12-12 00:24:21.939936 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-12 00:24:21.965514 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:21.974791 | 2025-12-12 00:24:21.975674 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-12 00:24:22.008313 | 2025-12-12 00:24:22.008538 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-12 00:24:22.064948 | 2025-12-12 00:24:22.065197 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-12 00:24:22.089625 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:22.096569 | 2025-12-12 00:24:22.096713 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-12 00:24:22.144762 | 2025-12-12 00:24:22.145053 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-12 00:24:22.170663 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:22.176667 | 2025-12-12 00:24:22.176794 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-12 00:24:22.201366 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:22.207836 | 2025-12-12 00:24:22.208046 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-12 00:24:22.233593 | debian-bookworm | skipping: Conditional result was False 2025-12-12 00:24:22.240644 | 2025-12-12 00:24:22.240744 | PLAY RECAP 2025-12-12 00:24:22.240860 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-12 00:24:22.240888 | 2025-12-12 00:24:22.387515 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-12 00:24:22.388822 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-12 00:24:23.198950 | 2025-12-12 00:24:23.199149 | PLAY [Base post] 2025-12-12 00:24:23.213914 | 2025-12-12 00:24:23.214091 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-12 00:24:23.775684 | debian-bookworm | changed 2025-12-12 00:24:23.782590 | 2025-12-12 00:24:23.782723 | PLAY RECAP 2025-12-12 00:24:23.782790 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-12 00:24:23.782887 | 2025-12-12 00:24:23.934147 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-12 00:24:23.935278 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-12 00:24:24.751520 | 2025-12-12 00:24:24.751719 | PLAY [Base post-logs] 2025-12-12 00:24:24.762868 | 2025-12-12 00:24:24.763042 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-12 00:24:25.277656 | localhost | changed 2025-12-12 00:24:25.291948 | 2025-12-12 00:24:25.292189 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-12 00:24:25.331419 | localhost | ok 2025-12-12 00:24:25.337471 | 2025-12-12 00:24:25.337653 | TASK [Set zuul-log-path fact] 2025-12-12 00:24:25.357559 | localhost | ok 2025-12-12 00:24:25.370178 | 2025-12-12 00:24:25.370371 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-12 00:24:25.408133 | localhost | ok 2025-12-12 00:24:25.412147 | 2025-12-12 00:24:25.412349 | TASK [upload-logs : Create log directories] 2025-12-12 00:24:25.987269 | localhost | changed 2025-12-12 00:24:25.990281 | 2025-12-12 00:24:25.990396 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-12 00:24:26.541070 | localhost -> localhost | ok: Runtime: 0:00:00.007576 2025-12-12 00:24:26.551732 | 2025-12-12 00:24:26.552056 | TASK [upload-logs : Upload logs to log server] 2025-12-12 00:24:27.161492 | localhost | Output suppressed because no_log was given 2025-12-12 00:24:27.164201 | 2025-12-12 00:24:27.164332 | LOOP [upload-logs : Compress console log and json output] 2025-12-12 00:24:27.227303 | localhost | skipping: Conditional result was False 2025-12-12 00:24:27.230132 | localhost | skipping: Conditional result was False 2025-12-12 00:24:27.244006 | 2025-12-12 00:24:27.244201 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-12 00:24:27.296299 | localhost | skipping: Conditional result was False 2025-12-12 00:24:27.296601 | 2025-12-12 00:24:27.301518 | localhost | skipping: Conditional result was False 2025-12-12 00:24:27.312745 | 2025-12-12 00:24:27.313540 | LOOP [upload-logs : Upload console log and json output]