2025-10-05 00:19:26.736021 | Job console starting 2025-10-05 00:19:26.747524 | Updating git repos 2025-10-05 00:19:26.768163 | Cloning repos into workspace 2025-10-05 00:19:26.867409 | Restoring repo states 2025-10-05 00:19:26.876778 | Merging changes 2025-10-05 00:19:27.418255 | Checking out repos 2025-10-05 00:19:27.467758 | Preparing playbooks 2025-10-05 00:19:27.932824 | Running Ansible setup 2025-10-05 00:19:33.305180 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-05 00:19:34.512790 | 2025-10-05 00:19:34.512963 | PLAY [Base pre] 2025-10-05 00:19:34.529728 | 2025-10-05 00:19:34.529869 | TASK [Setup log path fact] 2025-10-05 00:19:34.550744 | debian-bookworm | ok 2025-10-05 00:19:34.573886 | 2025-10-05 00:19:34.574048 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-05 00:19:34.606022 | debian-bookworm | ok 2025-10-05 00:19:34.618156 | 2025-10-05 00:19:34.618282 | TASK [emit-job-header : Print job information] 2025-10-05 00:19:34.678652 | # Job Information 2025-10-05 00:19:34.678881 | Ansible Version: 2.16.14 2025-10-05 00:19:34.678920 | Job: tox 2025-10-05 00:19:34.678951 | Pipeline: check 2025-10-05 00:19:34.678974 | Executor: 521e9411259a 2025-10-05 00:19:34.678996 | Triggered by: https://github.com/osism/openstack-image-manager/pull/918 2025-10-05 00:19:34.679017 | Event ID: c997a5d0-a180-11f0-85ca-8c5d3738fad7 2025-10-05 00:19:34.684823 | 2025-10-05 00:19:34.685147 | LOOP [emit-job-header : Print node information] 2025-10-05 00:19:34.880743 | debian-bookworm | ok: 2025-10-05 00:19:34.881020 | debian-bookworm | # Node Information 2025-10-05 00:19:34.881060 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-05 00:19:34.881085 | debian-bookworm | Hostname: debian 2025-10-05 00:19:34.881107 | debian-bookworm | Username: zuul 2025-10-05 00:19:34.881127 | debian-bookworm | Distro: Debian 12.12 2025-10-05 00:19:34.881154 | debian-bookworm | Provider: regiocloud-a 2025-10-05 00:19:34.881175 | debian-bookworm | Region: 2025-10-05 00:19:34.881196 | debian-bookworm | Label: debian-bookworm 2025-10-05 00:19:34.881215 | debian-bookworm | Product Name: OpenStack Nova 2025-10-05 00:19:34.881233 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe00:b229 2025-10-05 00:19:34.910236 | 2025-10-05 00:19:34.910403 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-05 00:19:35.485455 | debian-bookworm -> localhost | changed 2025-10-05 00:19:35.498740 | 2025-10-05 00:19:35.498932 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-05 00:19:36.679215 | debian-bookworm -> localhost | changed 2025-10-05 00:19:36.690529 | 2025-10-05 00:19:36.690627 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-05 00:19:36.957539 | debian-bookworm -> localhost | ok 2025-10-05 00:19:36.963257 | 2025-10-05 00:19:36.963384 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-05 00:19:36.981176 | debian-bookworm | ok 2025-10-05 00:19:37.011434 | debian-bookworm | included: /var/lib/zuul/builds/e1b502c699de4d14854a99d16a5f822d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-05 00:19:37.017412 | 2025-10-05 00:19:37.017511 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-05 00:19:37.961925 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-05 00:19:37.962091 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e1b502c699de4d14854a99d16a5f822d/work/e1b502c699de4d14854a99d16a5f822d_id_rsa 2025-10-05 00:19:37.962124 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e1b502c699de4d14854a99d16a5f822d/work/e1b502c699de4d14854a99d16a5f822d_id_rsa.pub 2025-10-05 00:19:37.962147 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-05 00:19:37.962168 | debian-bookworm -> localhost | SHA256:l5ZFLh08Sji69WhKDhH7/lqZ+JBtjiwTbo18c4KUIwM zuul-build-sshkey 2025-10-05 00:19:37.962187 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-05 00:19:37.962212 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-05 00:19:37.962230 | debian-bookworm -> localhost | | . .o | 2025-10-05 00:19:37.962248 | debian-bookworm -> localhost | | . o .+o. | 2025-10-05 00:19:37.962265 | debian-bookworm -> localhost | | o . o..+. | 2025-10-05 00:19:37.962281 | debian-bookworm -> localhost | |E o . . .= | 2025-10-05 00:19:37.962309 | debian-bookworm -> localhost | | . + oSo= | 2025-10-05 00:19:37.962333 | debian-bookworm -> localhost | | o * ++o=. | 2025-10-05 00:19:37.962351 | debian-bookworm -> localhost | | * @+o* | 2025-10-05 00:19:37.962369 | debian-bookworm -> localhost | | O.OB. | 2025-10-05 00:19:37.962386 | debian-bookworm -> localhost | | . ++*+ | 2025-10-05 00:19:37.962402 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-05 00:19:37.962448 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.562117 2025-10-05 00:19:37.967534 | 2025-10-05 00:19:37.967604 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-05 00:19:37.983884 | debian-bookworm | ok 2025-10-05 00:19:37.991361 | debian-bookworm | included: /var/lib/zuul/builds/e1b502c699de4d14854a99d16a5f822d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-05 00:19:37.998247 | 2025-10-05 00:19:37.998320 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-05 00:19:38.010524 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:19:38.014947 | 2025-10-05 00:19:38.015016 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-05 00:19:38.657553 | debian-bookworm | changed 2025-10-05 00:19:38.665814 | 2025-10-05 00:19:38.665969 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-05 00:19:38.933769 | debian-bookworm | ok 2025-10-05 00:19:38.942733 | 2025-10-05 00:19:38.942874 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-05 00:19:39.601843 | debian-bookworm | changed 2025-10-05 00:19:39.607200 | 2025-10-05 00:19:39.607274 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-05 00:19:40.271146 | debian-bookworm | changed 2025-10-05 00:19:40.282846 | 2025-10-05 00:19:40.282946 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-05 00:19:40.306005 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:19:40.315138 | 2025-10-05 00:19:40.315233 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-05 00:19:40.766101 | debian-bookworm -> localhost | changed 2025-10-05 00:19:40.776504 | 2025-10-05 00:19:40.776596 | TASK [add-build-sshkey : Add back temp key] 2025-10-05 00:19:41.082351 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e1b502c699de4d14854a99d16a5f822d/work/e1b502c699de4d14854a99d16a5f822d_id_rsa (zuul-build-sshkey) 2025-10-05 00:19:41.082571 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009510 2025-10-05 00:19:41.090794 | 2025-10-05 00:19:41.090921 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-05 00:19:41.514734 | debian-bookworm | ok 2025-10-05 00:19:41.519927 | 2025-10-05 00:19:41.520016 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-05 00:19:41.542827 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:19:41.553602 | 2025-10-05 00:19:41.553709 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-05 00:19:41.965079 | debian-bookworm | ok 2025-10-05 00:19:41.975456 | 2025-10-05 00:19:41.975559 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-05 00:19:42.003357 | debian-bookworm | ok 2025-10-05 00:19:42.008075 | 2025-10-05 00:19:42.008160 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-05 00:19:42.267433 | debian-bookworm -> localhost | ok 2025-10-05 00:19:42.273632 | 2025-10-05 00:19:42.273719 | TASK [validate-host : Collect information about the host] 2025-10-05 00:19:43.428598 | debian-bookworm | ok 2025-10-05 00:19:43.438473 | 2025-10-05 00:19:43.438563 | TASK [validate-host : Sanitize hostname] 2025-10-05 00:19:43.608966 | debian-bookworm | ok 2025-10-05 00:19:43.661182 | 2025-10-05 00:19:43.668718 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-05 00:19:44.759503 | debian-bookworm -> localhost | changed 2025-10-05 00:19:44.764834 | 2025-10-05 00:19:44.764925 | TASK [validate-host : Collect information about zuul worker] 2025-10-05 00:19:45.198279 | debian-bookworm | ok 2025-10-05 00:19:45.205815 | 2025-10-05 00:19:45.205908 | TASK [validate-host : Write out all zuul information for each host] 2025-10-05 00:19:46.038123 | debian-bookworm -> localhost | changed 2025-10-05 00:19:46.047054 | 2025-10-05 00:19:46.047152 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-05 00:19:46.335631 | debian-bookworm | ok 2025-10-05 00:19:46.340272 | 2025-10-05 00:19:46.340365 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-05 00:19:47.510917 | debian-bookworm | changed: 2025-10-05 00:19:47.511067 | debian-bookworm | cd+++++++++ src/ 2025-10-05 00:19:47.511095 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-05 00:19:47.511115 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-05 00:19:47.511133 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-05 00:19:47.511149 | debian-bookworm | =6.1 2025-10-05 00:20:10.432426 | debian-bookworm | Downloading cachetools-6.2.0-py3-none-any.whl (11 kB) 2025-10-05 00:20:10.501235 | debian-bookworm | Collecting chardet>=5.2 2025-10-05 00:20:10.509218 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-10-05 00:20:10.530713 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.1 MB/s eta 0:00:00 2025-10-05 00:20:10.590646 | debian-bookworm | Collecting colorama>=0.4.6 2025-10-05 00:20:10.599065 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-05 00:20:10.651374 | debian-bookworm | Collecting filelock>=3.18 2025-10-05 00:20:10.658826 | debian-bookworm | Downloading filelock-3.19.1-py3-none-any.whl (15 kB) 2025-10-05 00:20:10.701211 | debian-bookworm | Collecting packaging>=25 2025-10-05 00:20:10.708684 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-05 00:20:10.718581 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.2 MB/s eta 0:00:00 2025-10-05 00:20:10.771372 | debian-bookworm | Collecting platformdirs>=4.3.8 2025-10-05 00:20:10.779068 | debian-bookworm | Downloading platformdirs-4.4.0-py3-none-any.whl (18 kB) 2025-10-05 00:20:10.813635 | debian-bookworm | Collecting pluggy>=1.6 2025-10-05 00:20:10.820864 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-10-05 00:20:10.853417 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-10-05 00:20:10.861614 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-10-05 00:20:10.980136 | debian-bookworm | Collecting virtualenv>=20.31.2 2025-10-05 00:20:10.987491 | debian-bookworm | Downloading virtualenv-20.34.0-py3-none-any.whl (6.0 MB) 2025-10-05 00:20:11.225923 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 25.6 MB/s eta 0:00:00 2025-10-05 00:20:11.340808 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-10-05 00:20:11.348161 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-10-05 00:20:11.369297 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 25.3 MB/s eta 0:00:00 2025-10-05 00:20:11.508739 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-10-05 00:20:12.348996 | debian-bookworm | Successfully installed cachetools-6.2.0 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.19.1 packaging-25.0 platformdirs-4.4.0 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.30.3 virtualenv-20.34.0 2025-10-05 00:20:12.472460 | debian-bookworm | ok: Runtime: 0:00:02.735725 2025-10-05 00:20:12.478615 | 2025-10-05 00:20:12.478728 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-05 00:20:12.530938 | debian-bookworm | ok 2025-10-05 00:20:12.536407 | 2025-10-05 00:20:12.536637 | TASK [ensure-tox : Output tox version] 2025-10-05 00:20:13.009509 | 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-10-05 00:20:13.026793 | debian-bookworm | 4.30.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-05 00:20:13.093757 | debian-bookworm | ok: Runtime: 0:00:00.257686 2025-10-05 00:20:13.099432 | 2025-10-05 00:20:13.099559 | TASK [ensure-tox : Make global symlink] 2025-10-05 00:20:13.140285 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:13.151646 | 2025-10-05 00:20:13.151756 | PLAY RECAP 2025-10-05 00:20:13.151829 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-05 00:20:13.151860 | 2025-10-05 00:20:13.363914 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-10-05 00:20:13.365016 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-05 00:20:14.895960 | 2025-10-05 00:20:14.896143 | PLAY [all] 2025-10-05 00:20:14.937206 | 2025-10-05 00:20:14.937416 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-10-05 00:20:15.586265 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-05 00:20:15.996799 | debian-bookworm | ok: Runtime: 0:00:00.021971 2025-10-05 00:20:16.005896 | 2025-10-05 00:20:16.006008 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-10-05 00:20:16.562323 | debian-bookworm | ok: Runtime: 0:00:00.005848 2025-10-05 00:20:16.568613 | 2025-10-05 00:20:16.568710 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-10-05 00:20:16.855593 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-05 00:20:16.857234 | debian-bookworm | sudo: a password is required 2025-10-05 00:20:17.095758 | debian-bookworm | ok: Runtime: 0:00:00.022478 2025-10-05 00:20:17.105401 | 2025-10-05 00:20:17.105496 | TASK [tox : Check to see if the constraints file exists] 2025-10-05 00:20:17.152863 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:17.159680 | 2025-10-05 00:20:17.159783 | TASK [tox : Fail if constraints file is missing] 2025-10-05 00:20:17.205462 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:17.217195 | 2025-10-05 00:20:17.217328 | TASK [tox : Record file location] 2025-10-05 00:20:17.240296 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:17.245834 | 2025-10-05 00:20:17.245920 | TASK [tox : Install tox siblings] 2025-10-05 00:20:17.275024 | debian-bookworm | ok 2025-10-05 00:20:17.282686 | debian-bookworm | included: /var/lib/zuul/builds/e1b502c699de4d14854a99d16a5f822d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-10-05 00:20:17.302339 | 2025-10-05 00:20:17.302441 | TASK [tox : Run tox without tests] 2025-10-05 00:20:18.371615 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-10-05 00:20:31.703893 | debian-bookworm | test: OK (13.87 seconds) 2025-10-05 00:20:31.704050 | debian-bookworm | congratulations :) (13.90 seconds) 2025-10-05 00:20:31.840427 | debian-bookworm | ok: Runtime: 0:00:14.185848 2025-10-05 00:20:31.853810 | 2025-10-05 00:20:31.853997 | TASK [tox : Create a tempfile to save tox showconfig] 2025-10-05 00:20:32.250920 | debian-bookworm | changed 2025-10-05 00:20:32.256085 | 2025-10-05 00:20:32.256194 | TASK [tox : Get tox envlist config] 2025-10-05 00:20:33.285746 | debian-bookworm | ok: Runtime: 0:00:00.327296 2025-10-05 00:20:33.298705 | 2025-10-05 00:20:33.298904 | TASK [tox : Install any sibling python packages] 2025-10-05 00:20:33.753059 | debian-bookworm | ok: No setup.cfg, no action needed 2025-10-05 00:20:33.761776 | 2025-10-05 00:20:33.761892 | TASK [tox : Remove tempfile] 2025-10-05 00:20:34.201334 | debian-bookworm | changed 2025-10-05 00:20:34.216172 | 2025-10-05 00:20:34.216398 | TASK [tox : Emit tox command] 2025-10-05 00:20:34.273600 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-10-05 00:20:34.282115 | 2025-10-05 00:20:34.282253 | TASK [tox : Run tox] 2025-10-05 00:20:34.896199 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-10-05 00:20:35.555159 | debian-bookworm | ............... 2025-10-05 00:20:35.555210 | debian-bookworm | ---------------------------------------------------------------------- 2025-10-05 00:20:35.555225 | debian-bookworm | Ran 15 tests in 0.179s 2025-10-05 00:20:35.555230 | debian-bookworm | 2025-10-05 00:20:35.555237 | debian-bookworm | OK 2025-10-05 00:20:35.644028 | debian-bookworm | test: OK (0.79=setup[0.04]+cmd[0.74] seconds) 2025-10-05 00:20:35.644084 | debian-bookworm | congratulations :) (0.82 seconds) 2025-10-05 00:20:35.845673 | debian-bookworm | ok: Runtime: 0:00:01.102533 2025-10-05 00:20:35.857578 | 2025-10-05 00:20:35.857815 | TASK [tox : Look for output] 2025-10-05 00:20:36.265387 | debian-bookworm | ok 2025-10-05 00:20:36.290730 | 2025-10-05 00:20:36.290917 | TASK [tox : Return file comments to Zuul] 2025-10-05 00:20:36.326321 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:36.339348 | 2025-10-05 00:20:36.339467 | PLAY RECAP 2025-10-05 00:20:36.339545 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-05 00:20:36.339585 | 2025-10-05 00:20:36.469685 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-05 00:20:36.472472 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-05 00:20:37.221953 | 2025-10-05 00:20:37.222110 | PLAY [all] 2025-10-05 00:20:37.237720 | 2025-10-05 00:20:37.237849 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-10-05 00:20:37.294459 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:37.304261 | 2025-10-05 00:20:37.304450 | TASK [fetch-tox-output : Set tox log path for single node] 2025-10-05 00:20:37.339925 | debian-bookworm | ok 2025-10-05 00:20:37.347978 | 2025-10-05 00:20:37.348110 | TASK [fetch-tox-output : Ensure local tox dir] 2025-10-05 00:20:37.827883 | debian-bookworm -> localhost | changed 2025-10-05 00:20:37.837298 | 2025-10-05 00:20:37.837431 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-10-05 00:20:37.881395 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:37.887335 | 2025-10-05 00:20:37.887450 | TASK [fetch-tox-output : Set envlist fact] 2025-10-05 00:20:37.925735 | debian-bookworm | ok 2025-10-05 00:20:37.933370 | 2025-10-05 00:20:37.933555 | TASK [fetch-tox-output : Get tox version] 2025-10-05 00:20:38.685349 | 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-10-05 00:20:38.703671 | debian-bookworm | 4.30.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-05 00:20:38.973764 | debian-bookworm | ok: Runtime: 0:00:00.298461 2025-10-05 00:20:38.987339 | 2025-10-05 00:20:38.987614 | TASK [fetch-tox-output : Find all default environments] 2025-10-05 00:20:39.523378 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:39.529717 | 2025-10-05 00:20:39.529843 | TASK [fetch-tox-output : Set envlist fact] 2025-10-05 00:20:39.567782 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:39.577849 | 2025-10-05 00:20:39.577994 | TASK [fetch-tox-output : Find all default environments] 2025-10-05 00:20:40.107806 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:40.120422 | 2025-10-05 00:20:40.120588 | TASK [fetch-tox-output : Set envlist fact] 2025-10-05 00:20:40.156135 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:40.169967 | 2025-10-05 00:20:40.170120 | LOOP [fetch-tox-output : Copy tox logs] 2025-10-05 00:20:40.217730 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:40.239050 | 2025-10-05 00:20:40.239216 | LOOP [fetch-tox-output : Collect tox logs] 2025-10-05 00:20:41.096406 | debian-bookworm | changed: 2025-10-05 00:20:41.096633 | debian-bookworm | created directory /var/lib/zuul/builds/e1b502c699de4d14854a99d16a5f822d/work/logs/tox/test 2025-10-05 00:20:41.096668 | debian-bookworm | cd+++++++++ ./ 2025-10-05 00:20:41.096692 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-10-05 00:20:41.096720 | 2025-10-05 00:20:41.112395 | 2025-10-05 00:20:41.112494 | PLAY RECAP 2025-10-05 00:20:41.112550 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-05 00:20:41.112575 | 2025-10-05 00:20:41.237614 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-05 00:20:41.240139 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-05 00:20:41.957549 | 2025-10-05 00:20:41.957700 | PLAY [all] 2025-10-05 00:20:41.981823 | 2025-10-05 00:20:41.981959 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-10-05 00:20:42.220330 | debian-bookworm | changed: non-zero return code 2025-10-05 00:20:42.228455 | 2025-10-05 00:20:42.228614 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-10-05 00:20:42.258348 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:42.272921 | 2025-10-05 00:20:42.273203 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-10-05 00:20:42.312734 | 2025-10-05 00:20:42.313017 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-10-05 00:20:42.354581 | 2025-10-05 00:20:42.354876 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-10-05 00:20:42.379752 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:42.394598 | 2025-10-05 00:20:42.394795 | LOOP [fetch-subunit-output : Generate subunit file] 2025-10-05 00:20:42.432230 | 2025-10-05 00:20:42.432445 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-10-05 00:20:42.456042 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:42.461856 | 2025-10-05 00:20:42.461963 | TASK [fetch-subunit-output : Remove the temporary file] 2025-10-05 00:20:42.486110 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:42.496001 | 2025-10-05 00:20:42.496132 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-10-05 00:20:42.520015 | debian-bookworm | skipping: Conditional result was False 2025-10-05 00:20:42.533489 | 2025-10-05 00:20:42.533596 | PLAY RECAP 2025-10-05 00:20:42.533667 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-05 00:20:42.533704 | 2025-10-05 00:20:42.658347 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-05 00:20:42.659433 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-05 00:20:43.378395 | 2025-10-05 00:20:43.378547 | PLAY [Base post] 2025-10-05 00:20:43.392252 | 2025-10-05 00:20:43.392400 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-05 00:20:43.932304 | debian-bookworm | changed 2025-10-05 00:20:43.942944 | 2025-10-05 00:20:43.943214 | PLAY RECAP 2025-10-05 00:20:43.943433 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-05 00:20:43.943611 | 2025-10-05 00:20:44.073456 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-05 00:20:44.079915 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-05 00:20:44.883239 | 2025-10-05 00:20:44.883468 | PLAY [Base post-logs] 2025-10-05 00:20:44.897587 | 2025-10-05 00:20:44.897733 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-05 00:20:45.351453 | localhost | changed 2025-10-05 00:20:45.365021 | 2025-10-05 00:20:45.365161 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-05 00:20:45.392057 | localhost | ok 2025-10-05 00:20:45.396388 | 2025-10-05 00:20:45.396491 | TASK [Set zuul-log-path fact] 2025-10-05 00:20:45.416686 | localhost | ok 2025-10-05 00:20:45.439379 | 2025-10-05 00:20:45.440840 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-05 00:20:45.478119 | localhost | ok 2025-10-05 00:20:45.481840 | 2025-10-05 00:20:45.481947 | TASK [upload-logs : Create log directories] 2025-10-05 00:20:45.975575 | localhost | changed 2025-10-05 00:20:45.979764 | 2025-10-05 00:20:45.979885 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-05 00:20:46.481419 | localhost -> localhost | ok: Runtime: 0:00:00.007305 2025-10-05 00:20:46.490115 | 2025-10-05 00:20:46.490350 | TASK [upload-logs : Upload logs to log server] 2025-10-05 00:20:47.045639 | localhost | Output suppressed because no_log was given 2025-10-05 00:20:47.048789 | 2025-10-05 00:20:47.048944 | LOOP [upload-logs : Compress console log and json output] 2025-10-05 00:20:47.101797 | localhost | skipping: Conditional result was False 2025-10-05 00:20:47.107715 | localhost | skipping: Conditional result was False 2025-10-05 00:20:47.119930 | 2025-10-05 00:20:47.120162 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-05 00:20:47.164145 | localhost | skipping: Conditional result was False 2025-10-05 00:20:47.164412 | 2025-10-05 00:20:47.169148 | localhost | skipping: Conditional result was False 2025-10-05 00:20:47.181544 | 2025-10-05 00:20:47.181754 | LOOP [upload-logs : Upload console log and json output]