2025-12-07 03:03:56.767616 | Job console starting 2025-12-07 03:03:56.795168 | Updating git repos 2025-12-07 03:03:56.875443 | Cloning repos into workspace 2025-12-07 03:03:57.005699 | Restoring repo states 2025-12-07 03:03:57.056191 | Merging changes 2025-12-07 03:03:57.056256 | Checking out repos 2025-12-07 03:03:57.198895 | Preparing playbooks 2025-12-07 03:03:58.631609 | Running Ansible setup 2025-12-07 03:04:07.887461 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-07 03:04:09.638589 | 2025-12-07 03:04:09.639886 | PLAY [Base pre] 2025-12-07 03:04:09.658589 | 2025-12-07 03:04:09.658732 | TASK [Setup log path fact] 2025-12-07 03:04:09.679733 | debian-bookworm | ok 2025-12-07 03:04:09.720047 | 2025-12-07 03:04:09.720270 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-07 03:04:09.763404 | debian-bookworm | ok 2025-12-07 03:04:09.786657 | 2025-12-07 03:04:09.786807 | TASK [emit-job-header : Print job information] 2025-12-07 03:04:09.902062 | # Job Information 2025-12-07 03:04:09.902457 | Ansible Version: 2.16.14 2025-12-07 03:04:09.902507 | Job: tox 2025-12-07 03:04:09.902546 | Pipeline: periodic-daily 2025-12-07 03:04:09.902574 | Executor: 521e9411259a 2025-12-07 03:04:09.902596 | Triggered by: https://github.com/osism/openstack-image-manager 2025-12-07 03:04:09.902619 | Event ID: edb9b53c6c1e4780a7f671b7c68fa35a 2025-12-07 03:04:09.933043 | 2025-12-07 03:04:09.933196 | LOOP [emit-job-header : Print node information] 2025-12-07 03:04:10.214467 | debian-bookworm | ok: 2025-12-07 03:04:10.214749 | debian-bookworm | # Node Information 2025-12-07 03:04:10.214791 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-07 03:04:10.214817 | debian-bookworm | Hostname: debian 2025-12-07 03:04:10.214874 | debian-bookworm | Username: zuul 2025-12-07 03:04:10.214896 | debian-bookworm | Distro: Debian 12.12 2025-12-07 03:04:10.214988 | debian-bookworm | Provider: regiocloud-a 2025-12-07 03:04:10.215013 | debian-bookworm | Region: 2025-12-07 03:04:10.215036 | debian-bookworm | Label: debian-bookworm 2025-12-07 03:04:10.215057 | debian-bookworm | Product Name: OpenStack Nova 2025-12-07 03:04:10.215078 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef1:ff20 2025-12-07 03:04:10.235053 | 2025-12-07 03:04:10.235223 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-07 03:04:11.488648 | debian-bookworm -> localhost | changed 2025-12-07 03:04:11.500479 | 2025-12-07 03:04:11.500677 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-07 03:04:13.957941 | debian-bookworm -> localhost | changed 2025-12-07 03:04:13.989302 | 2025-12-07 03:04:13.989454 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-07 03:04:15.103020 | debian-bookworm -> localhost | ok 2025-12-07 03:04:15.109940 | 2025-12-07 03:04:15.110082 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-07 03:04:15.145936 | debian-bookworm | ok 2025-12-07 03:04:15.174086 | debian-bookworm | included: /var/lib/zuul/builds/e4211ce49b3f45229ee2a066c2e88487/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-07 03:04:15.180999 | 2025-12-07 03:04:15.181128 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-07 03:04:18.019989 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-07 03:04:18.020272 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e4211ce49b3f45229ee2a066c2e88487/work/e4211ce49b3f45229ee2a066c2e88487_id_rsa 2025-12-07 03:04:18.020313 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e4211ce49b3f45229ee2a066c2e88487/work/e4211ce49b3f45229ee2a066c2e88487_id_rsa.pub 2025-12-07 03:04:18.020341 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-07 03:04:18.020381 | debian-bookworm -> localhost | SHA256:xXsFF76VOjzemjkm+i6AMoohQcn4wXKFKTD76BcZjl4 zuul-build-sshkey 2025-12-07 03:04:18.020406 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-07 03:04:18.020440 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-07 03:04:18.020463 | debian-bookworm -> localhost | |*..+. . o. | 2025-12-07 03:04:18.020486 | debian-bookworm -> localhost | |+** . + .| 2025-12-07 03:04:18.020508 | debian-bookworm -> localhost | |o= o o o..| 2025-12-07 03:04:18.020529 | debian-bookworm -> localhost | |.o+ o . ....o | 2025-12-07 03:04:18.020549 | debian-bookworm -> localhost | |.o.E . S . .=. | 2025-12-07 03:04:18.020573 | debian-bookworm -> localhost | |= .o.. . .. + | 2025-12-07 03:04:18.020595 | debian-bookworm -> localhost | |o+..o . . . | 2025-12-07 03:04:18.020616 | debian-bookworm -> localhost | |... . . o+ | 2025-12-07 03:04:18.020637 | debian-bookworm -> localhost | | .=oo+. | 2025-12-07 03:04:18.020657 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-07 03:04:18.020716 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.939072 2025-12-07 03:04:18.028024 | 2025-12-07 03:04:18.028157 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-07 03:04:18.103886 | debian-bookworm | ok 2025-12-07 03:04:18.129552 | debian-bookworm | included: /var/lib/zuul/builds/e4211ce49b3f45229ee2a066c2e88487/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-07 03:04:18.164085 | 2025-12-07 03:04:18.164273 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-07 03:04:18.233713 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:04:18.240688 | 2025-12-07 03:04:18.240816 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-07 03:04:19.291916 | debian-bookworm | changed 2025-12-07 03:04:19.303987 | 2025-12-07 03:04:19.304126 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-07 03:04:19.625488 | debian-bookworm | ok 2025-12-07 03:04:19.635670 | 2025-12-07 03:04:19.635810 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-07 03:04:20.446074 | debian-bookworm | changed 2025-12-07 03:04:20.453291 | 2025-12-07 03:04:20.453435 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-07 03:04:21.292263 | debian-bookworm | changed 2025-12-07 03:04:21.310349 | 2025-12-07 03:04:21.310498 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-07 03:04:21.411961 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:04:21.424911 | 2025-12-07 03:04:21.425083 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-07 03:04:22.493353 | debian-bookworm -> localhost | changed 2025-12-07 03:04:22.507025 | 2025-12-07 03:04:22.507184 | TASK [add-build-sshkey : Add back temp key] 2025-12-07 03:04:23.528583 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e4211ce49b3f45229ee2a066c2e88487/work/e4211ce49b3f45229ee2a066c2e88487_id_rsa (zuul-build-sshkey) 2025-12-07 03:04:23.528847 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.033399 2025-12-07 03:04:23.537812 | 2025-12-07 03:04:23.537954 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-07 03:04:24.442076 | debian-bookworm | ok 2025-12-07 03:04:24.456377 | 2025-12-07 03:04:24.456537 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-07 03:04:24.570367 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:04:24.595668 | 2025-12-07 03:04:24.595824 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-07 03:04:25.608272 | debian-bookworm | ok 2025-12-07 03:04:25.664671 | 2025-12-07 03:04:25.664829 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-07 03:04:25.798795 | debian-bookworm | ok 2025-12-07 03:04:25.816350 | 2025-12-07 03:04:25.816485 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-07 03:04:27.395317 | debian-bookworm -> localhost | ok 2025-12-07 03:04:27.408138 | 2025-12-07 03:04:27.408316 | TASK [validate-host : Collect information about the host] 2025-12-07 03:04:29.263437 | debian-bookworm | ok 2025-12-07 03:04:29.290989 | 2025-12-07 03:04:29.291143 | TASK [validate-host : Sanitize hostname] 2025-12-07 03:04:29.770357 | debian-bookworm | ok 2025-12-07 03:04:29.979827 | 2025-12-07 03:04:29.986004 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-07 03:04:31.323348 | debian-bookworm -> localhost | changed 2025-12-07 03:04:31.332408 | 2025-12-07 03:04:31.332545 | TASK [validate-host : Collect information about zuul worker] 2025-12-07 03:04:32.043250 | debian-bookworm | ok 2025-12-07 03:04:32.048297 | 2025-12-07 03:04:32.048415 | TASK [validate-host : Write out all zuul information for each host] 2025-12-07 03:04:33.076510 | debian-bookworm -> localhost | changed 2025-12-07 03:04:33.097768 | 2025-12-07 03:04:33.097920 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-07 03:04:33.422503 | debian-bookworm | ok 2025-12-07 03:04:33.446335 | 2025-12-07 03:04:33.446479 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-07 03:04:34.977038 | debian-bookworm | changed: 2025-12-07 03:04:34.977305 | debian-bookworm | cd+++++++++ src/ 2025-12-07 03:04:34.977346 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-07 03:04:34.977370 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-07 03:04:34.977392 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-07 03:04:34.977412 | debian-bookworm | =6.2 2025-12-07 03:04:59.128982 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-12-07 03:04:59.176174 | debian-bookworm | Collecting chardet>=5.2 2025-12-07 03:04:59.188988 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-07 03:04:59.200936 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 23.8 MB/s eta 0:00:00 2025-12-07 03:04:59.240430 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-07 03:04:59.251583 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-07 03:04:59.320505 | debian-bookworm | Collecting filelock>=3.20 2025-12-07 03:04:59.331959 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-12-07 03:04:59.384272 | debian-bookworm | Collecting packaging>=25 2025-12-07 03:04:59.395313 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-07 03:04:59.402541 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 12.1 MB/s eta 0:00:00 2025-12-07 03:04:59.455789 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-07 03:04:59.467069 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-07 03:04:59.507754 | debian-bookworm | Collecting pluggy>=1.6 2025-12-07 03:04:59.518560 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-07 03:04:59.673308 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-07 03:04:59.686372 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-07 03:04:59.821078 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-07 03:04:59.833452 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-07 03:05:00.073366 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 25.6 MB/s eta 0:00:00 2025-12-07 03:05:00.177404 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-07 03:05:00.189890 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-07 03:05:00.217375 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.3 MB/s eta 0:00:00 2025-12-07 03:05:00.354118 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-07 03:05:01.158566 | 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-07 03:05:01.599270 | debian-bookworm | ok: Runtime: 0:00:02.775100 2025-12-07 03:05:01.612615 | 2025-12-07 03:05:01.612753 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-07 03:05:01.694911 | debian-bookworm | ok 2025-12-07 03:05:01.709580 | 2025-12-07 03:05:01.709726 | TASK [ensure-tox : Output tox version] 2025-12-07 03:05:02.594540 | 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-07 03:05:02.611768 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-07 03:05:02.891372 | debian-bookworm | ok: Runtime: 0:00:00.258320 2025-12-07 03:05:02.909974 | 2025-12-07 03:05:02.910149 | TASK [ensure-tox : Make global symlink] 2025-12-07 03:05:03.030312 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:03.038058 | 2025-12-07 03:05:03.038155 | PLAY RECAP 2025-12-07 03:05:03.038212 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-07 03:05:03.038282 | 2025-12-07 03:05:03.705962 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-07 03:05:03.707128 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-07 03:05:06.211600 | 2025-12-07 03:05:06.211844 | PLAY [all] 2025-12-07 03:05:06.300305 | 2025-12-07 03:05:06.300498 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-07 03:05:07.537858 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-07 03:05:07.843163 | debian-bookworm | ok: Runtime: 0:00:00.029811 2025-12-07 03:05:07.850773 | 2025-12-07 03:05:07.850973 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-07 03:05:08.418793 | debian-bookworm | ok: Runtime: 0:00:00.006727 2025-12-07 03:05:08.427575 | 2025-12-07 03:05:08.427710 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-07 03:05:08.973065 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-07 03:05:08.974401 | debian-bookworm | sudo: a password is required 2025-12-07 03:05:09.050190 | debian-bookworm | ok: Runtime: 0:00:00.018773 2025-12-07 03:05:09.061292 | 2025-12-07 03:05:09.061430 | TASK [tox : Check to see if the constraints file exists] 2025-12-07 03:05:09.096226 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:09.103345 | 2025-12-07 03:05:09.103487 | TASK [tox : Fail if constraints file is missing] 2025-12-07 03:05:09.148021 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:09.155222 | 2025-12-07 03:05:09.155382 | TASK [tox : Record file location] 2025-12-07 03:05:09.192869 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:09.201180 | 2025-12-07 03:05:09.201333 | TASK [tox : Install tox siblings] 2025-12-07 03:05:09.238393 | debian-bookworm | ok 2025-12-07 03:05:09.251075 | debian-bookworm | included: /var/lib/zuul/builds/e4211ce49b3f45229ee2a066c2e88487/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-07 03:05:09.280511 | 2025-12-07 03:05:09.280697 | TASK [tox : Run tox without tests] 2025-12-07 03:05:10.501949 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-07 03:05:25.141717 | debian-bookworm | test: OK (15.25 seconds) 2025-12-07 03:05:25.141786 | debian-bookworm | congratulations :) (15.28 seconds) 2025-12-07 03:05:25.343216 | debian-bookworm | ok: Runtime: 0:00:15.565946 2025-12-07 03:05:25.349634 | 2025-12-07 03:05:25.349751 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-07 03:05:25.815547 | debian-bookworm | changed 2025-12-07 03:05:25.820911 | 2025-12-07 03:05:25.821189 | TASK [tox : Get tox envlist config] 2025-12-07 03:05:26.861116 | debian-bookworm | ok: Runtime: 0:00:00.358926 2025-12-07 03:05:26.867378 | 2025-12-07 03:05:26.867511 | TASK [tox : Install any sibling python packages] 2025-12-07 03:05:27.348430 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-07 03:05:27.363392 | 2025-12-07 03:05:27.363536 | TASK [tox : Remove tempfile] 2025-12-07 03:05:27.839141 | debian-bookworm | changed 2025-12-07 03:05:27.849533 | 2025-12-07 03:05:27.849680 | TASK [tox : Emit tox command] 2025-12-07 03:05:27.929717 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-07 03:05:27.935225 | 2025-12-07 03:05:27.935370 | TASK [tox : Run tox] 2025-12-07 03:05:28.572547 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-07 03:05:29.222238 | debian-bookworm | ............... 2025-12-07 03:05:29.225073 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-07 03:05:29.225126 | debian-bookworm | Ran 15 tests in 0.178s 2025-12-07 03:05:29.225142 | debian-bookworm | 2025-12-07 03:05:29.225161 | debian-bookworm | OK 2025-12-07 03:05:29.332941 | debian-bookworm | test: OK (0.80=setup[0.05]+cmd[0.75] seconds) 2025-12-07 03:05:29.333022 | debian-bookworm | congratulations :) (0.83 seconds) 2025-12-07 03:05:29.507533 | debian-bookworm | ok: Runtime: 0:00:01.134985 2025-12-07 03:05:29.515966 | 2025-12-07 03:05:29.516106 | TASK [tox : Look for output] 2025-12-07 03:05:29.934881 | debian-bookworm | ok 2025-12-07 03:05:29.977150 | 2025-12-07 03:05:29.977331 | TASK [tox : Return file comments to Zuul] 2025-12-07 03:05:30.058507 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:30.067475 | 2025-12-07 03:05:30.067590 | PLAY RECAP 2025-12-07 03:05:30.067648 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-07 03:05:30.067675 | 2025-12-07 03:05:30.306139 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-07 03:05:30.307416 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-07 03:05:31.467333 | 2025-12-07 03:05:31.467511 | PLAY [all] 2025-12-07 03:05:31.484765 | 2025-12-07 03:05:31.484929 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-07 03:05:31.540633 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:31.546823 | 2025-12-07 03:05:31.547233 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-07 03:05:31.586209 | debian-bookworm | ok 2025-12-07 03:05:31.596523 | 2025-12-07 03:05:31.596670 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-07 03:05:32.137628 | debian-bookworm -> localhost | changed 2025-12-07 03:05:32.145629 | 2025-12-07 03:05:32.145762 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-07 03:05:32.191322 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:32.198477 | 2025-12-07 03:05:32.198614 | TASK [fetch-tox-output : Set envlist fact] 2025-12-07 03:05:32.239163 | debian-bookworm | ok 2025-12-07 03:05:32.245210 | 2025-12-07 03:05:32.245383 | TASK [fetch-tox-output : Get tox version] 2025-12-07 03:05:33.051587 | 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-07 03:05:33.068982 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-07 03:05:33.280192 | debian-bookworm | ok: Runtime: 0:00:00.355386 2025-12-07 03:05:33.286897 | 2025-12-07 03:05:33.287035 | TASK [fetch-tox-output : Find all default environments] 2025-12-07 03:05:33.817502 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:33.826893 | 2025-12-07 03:05:33.827079 | TASK [fetch-tox-output : Set envlist fact] 2025-12-07 03:05:33.875500 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:33.884586 | 2025-12-07 03:05:33.884755 | TASK [fetch-tox-output : Find all default environments] 2025-12-07 03:05:34.438561 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:34.458165 | 2025-12-07 03:05:34.458336 | TASK [fetch-tox-output : Set envlist fact] 2025-12-07 03:05:34.497430 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:34.512424 | 2025-12-07 03:05:34.512573 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-07 03:05:34.600061 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:34.615540 | 2025-12-07 03:05:34.615701 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-07 03:05:35.725208 | debian-bookworm | changed: 2025-12-07 03:05:35.727338 | debian-bookworm | created directory /var/lib/zuul/builds/e4211ce49b3f45229ee2a066c2e88487/work/logs/tox/test 2025-12-07 03:05:35.727419 | debian-bookworm | cd+++++++++ ./ 2025-12-07 03:05:35.727449 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-07 03:05:35.727482 | 2025-12-07 03:05:35.756344 | 2025-12-07 03:05:35.756470 | PLAY RECAP 2025-12-07 03:05:35.756660 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-07 03:05:35.756698 | 2025-12-07 03:05:36.124996 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-07 03:05:36.131796 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-07 03:05:37.524530 | 2025-12-07 03:05:37.525862 | PLAY [all] 2025-12-07 03:05:37.546191 | 2025-12-07 03:05:37.546395 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-07 03:05:37.895605 | debian-bookworm | changed: non-zero return code 2025-12-07 03:05:37.944384 | 2025-12-07 03:05:37.944616 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-07 03:05:37.969533 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:37.976371 | 2025-12-07 03:05:37.976520 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-07 03:05:38.038820 | 2025-12-07 03:05:38.039106 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-07 03:05:38.107681 | 2025-12-07 03:05:38.107897 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-07 03:05:38.164479 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:38.175542 | 2025-12-07 03:05:38.175697 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-07 03:05:38.238683 | 2025-12-07 03:05:38.238934 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-07 03:05:38.286114 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:38.297827 | 2025-12-07 03:05:38.298631 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-07 03:05:38.355974 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:38.366326 | 2025-12-07 03:05:38.366784 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-07 03:05:38.418431 | debian-bookworm | skipping: Conditional result was False 2025-12-07 03:05:38.439342 | 2025-12-07 03:05:38.439453 | PLAY RECAP 2025-12-07 03:05:38.439506 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-07 03:05:38.439531 | 2025-12-07 03:05:38.701014 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-07 03:05:38.702266 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-07 03:05:39.947133 | 2025-12-07 03:05:39.947341 | PLAY [Base post] 2025-12-07 03:05:39.962077 | 2025-12-07 03:05:39.962262 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-07 03:05:40.562421 | debian-bookworm | changed 2025-12-07 03:05:40.572032 | 2025-12-07 03:05:40.572172 | PLAY RECAP 2025-12-07 03:05:40.572265 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-07 03:05:40.572330 | 2025-12-07 03:05:40.726547 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-07 03:05:40.728022 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-07 03:05:41.658813 | 2025-12-07 03:05:41.659038 | PLAY [Base post-logs] 2025-12-07 03:05:41.690029 | 2025-12-07 03:05:41.690216 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-07 03:05:42.337895 | localhost | changed 2025-12-07 03:05:42.350347 | 2025-12-07 03:05:42.350530 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-07 03:05:42.376826 | localhost | ok 2025-12-07 03:05:42.381737 | 2025-12-07 03:05:42.381955 | TASK [Set zuul-log-path fact] 2025-12-07 03:05:42.398414 | localhost | ok 2025-12-07 03:05:42.407487 | 2025-12-07 03:05:42.407677 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-07 03:05:42.445326 | localhost | ok 2025-12-07 03:05:42.448668 | 2025-12-07 03:05:42.449052 | TASK [upload-logs : Create log directories] 2025-12-07 03:05:42.957338 | localhost | changed 2025-12-07 03:05:42.960751 | 2025-12-07 03:05:42.960865 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-07 03:05:43.737618 | localhost -> localhost | ok: Runtime: 0:00:00.011317 2025-12-07 03:05:43.741868 | 2025-12-07 03:05:43.741998 | TASK [upload-logs : Upload logs to log server] 2025-12-07 03:05:44.837758 | localhost | Output suppressed because no_log was given 2025-12-07 03:05:44.839778 | 2025-12-07 03:05:44.839891 | LOOP [upload-logs : Compress console log and json output] 2025-12-07 03:05:44.898156 | localhost | skipping: Conditional result was False 2025-12-07 03:05:44.904814 | localhost | skipping: Conditional result was False 2025-12-07 03:05:44.908853 | 2025-12-07 03:05:44.909007 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-07 03:05:44.963445 | localhost | skipping: Conditional result was False 2025-12-07 03:05:44.963764 | 2025-12-07 03:05:44.969420 | localhost | skipping: Conditional result was False 2025-12-07 03:05:44.976940 | 2025-12-07 03:05:44.977082 | LOOP [upload-logs : Upload console log and json output]