2025-11-16 03:09:27.887529 | Job console starting 2025-11-16 03:09:27.899528 | Updating git repos 2025-11-16 03:09:27.943323 | Cloning repos into workspace 2025-11-16 03:09:27.998247 | Restoring repo states 2025-11-16 03:09:28.010922 | Merging changes 2025-11-16 03:09:28.011001 | Checking out repos 2025-11-16 03:09:28.074064 | Preparing playbooks 2025-11-16 03:09:29.462573 | Running Ansible setup 2025-11-16 03:09:36.564818 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-16 03:09:37.339245 | 2025-11-16 03:09:37.339361 | PLAY [Base pre] 2025-11-16 03:09:37.351913 | 2025-11-16 03:09:37.352038 | TASK [Setup log path fact] 2025-11-16 03:09:37.368662 | debian-bookworm | ok 2025-11-16 03:09:37.386958 | 2025-11-16 03:09:37.387146 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-16 03:09:37.415419 | debian-bookworm | ok 2025-11-16 03:09:37.432115 | 2025-11-16 03:09:37.432213 | TASK [emit-job-header : Print job information] 2025-11-16 03:09:37.467569 | # Job Information 2025-11-16 03:09:37.467705 | Ansible Version: 2.16.14 2025-11-16 03:09:37.467734 | Job: tox 2025-11-16 03:09:37.467760 | Pipeline: periodic-daily 2025-11-16 03:09:37.467778 | Executor: 521e9411259a 2025-11-16 03:09:37.467795 | Triggered by: https://github.com/osism/openstack-image-manager 2025-11-16 03:09:37.467908 | Event ID: d19d9673b5754cf9bef5b272d362b202 2025-11-16 03:09:37.471887 | 2025-11-16 03:09:37.471978 | LOOP [emit-job-header : Print node information] 2025-11-16 03:09:37.584862 | debian-bookworm | ok: 2025-11-16 03:09:37.585016 | debian-bookworm | # Node Information 2025-11-16 03:09:37.585045 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-16 03:09:37.585065 | debian-bookworm | Hostname: debian 2025-11-16 03:09:37.585083 | debian-bookworm | Username: zuul 2025-11-16 03:09:37.585099 | debian-bookworm | Distro: Debian 12.12 2025-11-16 03:09:37.585119 | debian-bookworm | Provider: regiocloud-a 2025-11-16 03:09:37.585136 | debian-bookworm | Region: 2025-11-16 03:09:37.585153 | debian-bookworm | Label: debian-bookworm 2025-11-16 03:09:37.585169 | debian-bookworm | Product Name: OpenStack Nova 2025-11-16 03:09:37.585186 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe28:55c8 2025-11-16 03:09:37.594172 | 2025-11-16 03:09:37.594263 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-16 03:09:38.160099 | debian-bookworm -> localhost | changed 2025-11-16 03:09:38.165761 | 2025-11-16 03:09:38.165857 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-16 03:09:39.421880 | debian-bookworm -> localhost | changed 2025-11-16 03:09:39.430947 | 2025-11-16 03:09:39.431048 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-16 03:09:39.748817 | debian-bookworm -> localhost | ok 2025-11-16 03:09:39.754906 | 2025-11-16 03:09:39.755020 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-16 03:09:39.793437 | debian-bookworm | ok 2025-11-16 03:09:39.827024 | debian-bookworm | included: /var/lib/zuul/builds/4dbf314bc8b947e8922ee12f39b19dac/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-16 03:09:39.833787 | 2025-11-16 03:09:39.833889 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-16 03:09:41.518292 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-16 03:09:41.518576 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4dbf314bc8b947e8922ee12f39b19dac/work/4dbf314bc8b947e8922ee12f39b19dac_id_rsa 2025-11-16 03:09:41.518632 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4dbf314bc8b947e8922ee12f39b19dac/work/4dbf314bc8b947e8922ee12f39b19dac_id_rsa.pub 2025-11-16 03:09:41.518669 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-16 03:09:41.518703 | debian-bookworm -> localhost | SHA256:mUfNe9x6xcLXCIUmNDy5gVMrlHJkOUVUbPz+uEngbJg zuul-build-sshkey 2025-11-16 03:09:41.518732 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-16 03:09:41.518769 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-16 03:09:41.518797 | debian-bookworm -> localhost | | .+@B=... | 2025-11-16 03:09:41.518825 | debian-bookworm -> localhost | | .oB *=*. | 2025-11-16 03:09:41.518879 | debian-bookworm -> localhost | | o.ooB+. | 2025-11-16 03:09:41.518908 | debian-bookworm -> localhost | | =. =.+.| 2025-11-16 03:09:41.518935 | debian-bookworm -> localhost | | S . o.* *| 2025-11-16 03:09:41.518979 | debian-bookworm -> localhost | | . = o.+.| 2025-11-16 03:09:41.519008 | debian-bookworm -> localhost | | E + oo.| 2025-11-16 03:09:41.519035 | debian-bookworm -> localhost | | . ..o.| 2025-11-16 03:09:41.519062 | debian-bookworm -> localhost | | o. | 2025-11-16 03:09:41.519088 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-16 03:09:41.519153 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.005330 2025-11-16 03:09:41.527630 | 2025-11-16 03:09:41.527730 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-16 03:09:41.559122 | debian-bookworm | ok 2025-11-16 03:09:41.568429 | debian-bookworm | included: /var/lib/zuul/builds/4dbf314bc8b947e8922ee12f39b19dac/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-16 03:09:41.577175 | 2025-11-16 03:09:41.577268 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-16 03:09:41.600271 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:09:41.606474 | 2025-11-16 03:09:41.606566 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-16 03:09:42.236805 | debian-bookworm | changed 2025-11-16 03:09:42.246210 | 2025-11-16 03:09:42.246318 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-16 03:09:42.498151 | debian-bookworm | ok 2025-11-16 03:09:42.506274 | 2025-11-16 03:09:42.506417 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-16 03:09:43.080867 | debian-bookworm | changed 2025-11-16 03:09:43.087438 | 2025-11-16 03:09:43.087540 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-16 03:09:43.716863 | debian-bookworm | changed 2025-11-16 03:09:43.725349 | 2025-11-16 03:09:43.725480 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-16 03:09:43.776484 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:09:43.783110 | 2025-11-16 03:09:43.783234 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-16 03:09:44.483560 | debian-bookworm -> localhost | changed 2025-11-16 03:09:44.501016 | 2025-11-16 03:09:44.501124 | TASK [add-build-sshkey : Add back temp key] 2025-11-16 03:09:44.842611 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4dbf314bc8b947e8922ee12f39b19dac/work/4dbf314bc8b947e8922ee12f39b19dac_id_rsa (zuul-build-sshkey) 2025-11-16 03:09:44.842818 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009843 2025-11-16 03:09:44.850903 | 2025-11-16 03:09:44.851019 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-16 03:09:45.199498 | debian-bookworm | ok 2025-11-16 03:09:45.208324 | 2025-11-16 03:09:45.208438 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-16 03:09:45.262049 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:09:45.273334 | 2025-11-16 03:09:45.273436 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-16 03:09:45.821744 | debian-bookworm | ok 2025-11-16 03:09:45.837058 | 2025-11-16 03:09:45.837166 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-16 03:09:45.866422 | debian-bookworm | ok 2025-11-16 03:09:45.873260 | 2025-11-16 03:09:45.873359 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-16 03:09:46.153517 | debian-bookworm -> localhost | ok 2025-11-16 03:09:46.161632 | 2025-11-16 03:09:46.161728 | TASK [validate-host : Collect information about the host] 2025-11-16 03:09:47.172455 | debian-bookworm | ok 2025-11-16 03:09:47.182629 | 2025-11-16 03:09:47.182728 | TASK [validate-host : Sanitize hostname] 2025-11-16 03:09:47.271701 | debian-bookworm | ok 2025-11-16 03:09:47.312671 | 2025-11-16 03:09:47.312777 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-16 03:09:47.958326 | debian-bookworm -> localhost | changed 2025-11-16 03:09:47.966746 | 2025-11-16 03:09:47.966888 | TASK [validate-host : Collect information about zuul worker] 2025-11-16 03:09:48.386551 | debian-bookworm | ok 2025-11-16 03:09:48.392453 | 2025-11-16 03:09:48.392558 | TASK [validate-host : Write out all zuul information for each host] 2025-11-16 03:09:49.285390 | debian-bookworm -> localhost | changed 2025-11-16 03:09:49.301120 | 2025-11-16 03:09:49.301252 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-16 03:09:49.587520 | debian-bookworm | ok 2025-11-16 03:09:49.600194 | 2025-11-16 03:09:49.600325 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-16 03:09:50.943801 | debian-bookworm | changed: 2025-11-16 03:09:50.944056 | debian-bookworm | cd+++++++++ src/ 2025-11-16 03:09:50.944096 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-16 03:09:50.944557 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-16 03:09:50.944585 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-16 03:09:50.944606 | debian-bookworm | =6.2 2025-11-16 03:10:16.999028 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-11-16 03:10:17.044452 | debian-bookworm | Collecting chardet>=5.2 2025-11-16 03:10:17.061634 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-16 03:10:17.077670 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 20.7 MB/s eta 0:00:00 2025-11-16 03:10:17.126344 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-16 03:10:17.140995 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-16 03:10:17.202413 | debian-bookworm | Collecting filelock>=3.20 2025-11-16 03:10:17.218028 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-16 03:10:17.285275 | debian-bookworm | Collecting packaging>=25 2025-11-16 03:10:17.299005 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-16 03:10:17.307375 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.7 MB/s eta 0:00:00 2025-11-16 03:10:17.354373 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-16 03:10:17.367942 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-16 03:10:17.412466 | debian-bookworm | Collecting pluggy>=1.6 2025-11-16 03:10:17.425819 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-16 03:10:17.467027 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-16 03:10:17.481427 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-16 03:10:17.613495 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-16 03:10:17.627164 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-16 03:10:17.888355 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 23.4 MB/s eta 0:00:00 2025-11-16 03:10:17.991540 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-16 03:10:18.004586 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-16 03:10:18.045197 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 12.5 MB/s eta 0:00:00 2025-11-16 03:10:18.189103 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-16 03:10:19.220628 | 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-16 03:10:19.398930 | debian-bookworm | ok: Runtime: 0:00:03.196777 2025-11-16 03:10:19.404828 | 2025-11-16 03:10:19.404964 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-16 03:10:19.445983 | debian-bookworm | ok 2025-11-16 03:10:19.458114 | 2025-11-16 03:10:19.458231 | TASK [ensure-tox : Output tox version] 2025-11-16 03:10:20.029085 | 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-16 03:10:20.047402 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-16 03:10:20.514020 | debian-bookworm | ok: Runtime: 0:00:00.289761 2025-11-16 03:10:20.519391 | 2025-11-16 03:10:20.519481 | TASK [ensure-tox : Make global symlink] 2025-11-16 03:10:20.545158 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:20.551486 | 2025-11-16 03:10:20.551558 | PLAY RECAP 2025-11-16 03:10:20.551607 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-16 03:10:20.551632 | 2025-11-16 03:10:20.679128 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-16 03:10:20.680137 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-16 03:10:21.503226 | 2025-11-16 03:10:21.503381 | PLAY [all] 2025-11-16 03:10:21.532600 | 2025-11-16 03:10:21.532725 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-16 03:10:22.061366 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-16 03:10:22.559777 | debian-bookworm | ok: Runtime: 0:00:00.026814 2025-11-16 03:10:22.576259 | 2025-11-16 03:10:22.576522 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-16 03:10:23.116785 | debian-bookworm | ok: Runtime: 0:00:00.007386 2025-11-16 03:10:23.129091 | 2025-11-16 03:10:23.129235 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-16 03:10:23.449138 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-16 03:10:23.453466 | debian-bookworm | sudo: a password is required 2025-11-16 03:10:23.660484 | debian-bookworm | ok: Runtime: 0:00:00.024431 2025-11-16 03:10:23.682137 | 2025-11-16 03:10:23.682248 | TASK [tox : Check to see if the constraints file exists] 2025-11-16 03:10:23.705521 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:23.711843 | 2025-11-16 03:10:23.711963 | TASK [tox : Fail if constraints file is missing] 2025-11-16 03:10:23.745071 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:23.751999 | 2025-11-16 03:10:23.752102 | TASK [tox : Record file location] 2025-11-16 03:10:23.775012 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:23.780558 | 2025-11-16 03:10:23.780658 | TASK [tox : Install tox siblings] 2025-11-16 03:10:23.799563 | debian-bookworm | ok 2025-11-16 03:10:23.807408 | debian-bookworm | included: /var/lib/zuul/builds/4dbf314bc8b947e8922ee12f39b19dac/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-16 03:10:23.812928 | 2025-11-16 03:10:23.813043 | TASK [tox : Run tox without tests] 2025-11-16 03:10:24.836781 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-16 03:10:39.149671 | debian-bookworm | test: OK (14.79 seconds) 2025-11-16 03:10:39.149749 | debian-bookworm | congratulations :) (14.82 seconds) 2025-11-16 03:10:39.352496 | debian-bookworm | ok: Runtime: 0:00:15.095573 2025-11-16 03:10:39.359211 | 2025-11-16 03:10:39.359329 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-16 03:10:40.047415 | debian-bookworm | changed 2025-11-16 03:10:40.052984 | 2025-11-16 03:10:40.053113 | TASK [tox : Get tox envlist config] 2025-11-16 03:10:41.127987 | debian-bookworm | ok: Runtime: 0:00:00.343011 2025-11-16 03:10:41.142198 | 2025-11-16 03:10:41.143145 | TASK [tox : Install any sibling python packages] 2025-11-16 03:10:42.163321 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-16 03:10:42.169866 | 2025-11-16 03:10:42.170001 | TASK [tox : Remove tempfile] 2025-11-16 03:10:43.012913 | debian-bookworm | changed 2025-11-16 03:10:43.025622 | 2025-11-16 03:10:43.025803 | TASK [tox : Emit tox command] 2025-11-16 03:10:43.101598 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-16 03:10:43.107320 | 2025-11-16 03:10:43.107447 | TASK [tox : Run tox] 2025-11-16 03:10:43.924176 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-16 03:10:44.544915 | debian-bookworm | ............... 2025-11-16 03:10:44.544964 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-16 03:10:44.544978 | debian-bookworm | Ran 15 tests in 0.177s 2025-11-16 03:10:44.544983 | debian-bookworm | 2025-11-16 03:10:44.544991 | debian-bookworm | OK 2025-11-16 03:10:44.634756 | debian-bookworm | test: OK (0.75=setup[0.05]+cmd[0.71] seconds) 2025-11-16 03:10:44.634812 | debian-bookworm | congratulations :) (0.79 seconds) 2025-11-16 03:10:44.780428 | debian-bookworm | ok: Runtime: 0:00:01.079055 2025-11-16 03:10:44.800639 | 2025-11-16 03:10:44.800784 | TASK [tox : Look for output] 2025-11-16 03:10:45.277796 | debian-bookworm | ok 2025-11-16 03:10:45.347584 | 2025-11-16 03:10:45.347758 | TASK [tox : Return file comments to Zuul] 2025-11-16 03:10:45.484498 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:45.507427 | 2025-11-16 03:10:45.507560 | PLAY RECAP 2025-11-16 03:10:45.507622 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-16 03:10:45.507651 | 2025-11-16 03:10:46.110871 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-16 03:10:46.112223 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-16 03:10:47.152228 | 2025-11-16 03:10:47.152405 | PLAY [all] 2025-11-16 03:10:47.194267 | 2025-11-16 03:10:47.194438 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-16 03:10:47.311291 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:47.317956 | 2025-11-16 03:10:47.318129 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-16 03:10:47.361160 | debian-bookworm | ok 2025-11-16 03:10:47.369653 | 2025-11-16 03:10:47.369802 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-16 03:10:48.109310 | debian-bookworm -> localhost | changed 2025-11-16 03:10:48.118805 | 2025-11-16 03:10:48.119015 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-16 03:10:48.184405 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:48.191504 | 2025-11-16 03:10:48.191657 | TASK [fetch-tox-output : Set envlist fact] 2025-11-16 03:10:48.241867 | debian-bookworm | ok 2025-11-16 03:10:48.247910 | 2025-11-16 03:10:48.248080 | TASK [fetch-tox-output : Get tox version] 2025-11-16 03:10:48.999937 | 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-16 03:10:49.019540 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-16 03:10:49.295711 | debian-bookworm | ok: Runtime: 0:00:00.289656 2025-11-16 03:10:49.303465 | 2025-11-16 03:10:49.303613 | TASK [fetch-tox-output : Find all default environments] 2025-11-16 03:10:49.881357 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:49.893476 | 2025-11-16 03:10:49.893626 | TASK [fetch-tox-output : Set envlist fact] 2025-11-16 03:10:49.940169 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:49.947265 | 2025-11-16 03:10:49.947407 | TASK [fetch-tox-output : Find all default environments] 2025-11-16 03:10:50.501392 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:50.508398 | 2025-11-16 03:10:50.508560 | TASK [fetch-tox-output : Set envlist fact] 2025-11-16 03:10:50.553487 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:50.566805 | 2025-11-16 03:10:50.569630 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-16 03:10:50.633417 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:50.645127 | 2025-11-16 03:10:50.645261 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-16 03:10:52.371737 | debian-bookworm | changed: 2025-11-16 03:10:52.372056 | debian-bookworm | created directory /var/lib/zuul/builds/4dbf314bc8b947e8922ee12f39b19dac/work/logs/tox/test 2025-11-16 03:10:52.372105 | debian-bookworm | cd+++++++++ ./ 2025-11-16 03:10:52.372131 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-16 03:10:52.372163 | 2025-11-16 03:10:52.389612 | 2025-11-16 03:10:52.389714 | PLAY RECAP 2025-11-16 03:10:52.389769 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-16 03:10:52.389794 | 2025-11-16 03:10:52.561725 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-16 03:10:52.563705 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-16 03:10:53.462434 | 2025-11-16 03:10:53.462604 | PLAY [all] 2025-11-16 03:10:53.490556 | 2025-11-16 03:10:53.490723 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-16 03:10:53.753105 | debian-bookworm | changed: non-zero return code 2025-11-16 03:10:53.767170 | 2025-11-16 03:10:53.767352 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-16 03:10:53.791761 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:53.798118 | 2025-11-16 03:10:53.798272 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-16 03:10:53.840432 | 2025-11-16 03:10:53.840647 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-16 03:10:53.893284 | 2025-11-16 03:10:53.893486 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-16 03:10:53.937753 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:53.944410 | 2025-11-16 03:10:53.944538 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-16 03:10:53.983230 | 2025-11-16 03:10:53.983535 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-16 03:10:54.040440 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:54.046688 | 2025-11-16 03:10:54.046874 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-16 03:10:54.101342 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:54.108124 | 2025-11-16 03:10:54.108269 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-16 03:10:54.154481 | debian-bookworm | skipping: Conditional result was False 2025-11-16 03:10:54.162657 | 2025-11-16 03:10:54.162769 | PLAY RECAP 2025-11-16 03:10:54.162827 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-16 03:10:54.162893 | 2025-11-16 03:10:54.393525 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-16 03:10:54.395455 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-16 03:10:55.537395 | 2025-11-16 03:10:55.537577 | PLAY [Base post] 2025-11-16 03:10:55.557958 | 2025-11-16 03:10:55.558119 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-16 03:10:56.149786 | debian-bookworm | changed 2025-11-16 03:10:56.163538 | 2025-11-16 03:10:56.163683 | PLAY RECAP 2025-11-16 03:10:56.163757 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-16 03:10:56.163822 | 2025-11-16 03:10:56.429987 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-16 03:10:56.432761 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-16 03:10:57.588839 | 2025-11-16 03:10:57.589063 | PLAY [Base post-logs] 2025-11-16 03:10:57.601220 | 2025-11-16 03:10:57.601400 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-16 03:10:58.229714 | localhost | changed 2025-11-16 03:10:58.241180 | 2025-11-16 03:10:58.241349 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-16 03:10:58.267621 | localhost | ok 2025-11-16 03:10:58.277875 | 2025-11-16 03:10:58.278067 | TASK [Set zuul-log-path fact] 2025-11-16 03:10:58.306343 | localhost | ok 2025-11-16 03:10:58.320039 | 2025-11-16 03:10:58.320176 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-16 03:10:58.381544 | localhost | ok 2025-11-16 03:10:58.384682 | 2025-11-16 03:10:58.384787 | TASK [upload-logs : Create log directories] 2025-11-16 03:10:59.084652 | localhost | changed 2025-11-16 03:10:59.089031 | 2025-11-16 03:10:59.089182 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-16 03:10:59.751354 | localhost -> localhost | ok: Runtime: 0:00:00.011360 2025-11-16 03:10:59.755657 | 2025-11-16 03:10:59.755778 | TASK [upload-logs : Upload logs to log server] 2025-11-16 03:11:00.554086 | localhost | Output suppressed because no_log was given 2025-11-16 03:11:00.556129 | 2025-11-16 03:11:00.556243 | LOOP [upload-logs : Compress console log and json output] 2025-11-16 03:11:00.622127 | localhost | skipping: Conditional result was False 2025-11-16 03:11:00.629399 | localhost | skipping: Conditional result was False 2025-11-16 03:11:00.638404 | 2025-11-16 03:11:00.638631 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-16 03:11:00.685779 | localhost | skipping: Conditional result was False 2025-11-16 03:11:00.686137 | 2025-11-16 03:11:00.693681 | localhost | skipping: Conditional result was False 2025-11-16 03:11:00.700701 | 2025-11-16 03:11:00.700864 | LOOP [upload-logs : Upload console log and json output]