2025-12-28 00:21:58.164636 | Job console starting 2025-12-28 00:21:58.195338 | Updating git repos 2025-12-28 00:21:58.312109 | Cloning repos into workspace 2025-12-28 00:21:58.389920 | Restoring repo states 2025-12-28 00:21:58.415053 | Merging changes 2025-12-28 00:21:59.199769 | Checking out repos 2025-12-28 00:21:59.292765 | Preparing playbooks 2025-12-28 00:22:00.684090 | Running Ansible setup 2025-12-28 00:22:12.083284 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-28 00:22:14.785985 | 2025-12-28 00:22:14.786169 | PLAY [Base pre] 2025-12-28 00:22:14.848626 | 2025-12-28 00:22:14.848837 | TASK [Setup log path fact] 2025-12-28 00:22:14.896425 | debian-bookworm | ok 2025-12-28 00:22:14.940918 | 2025-12-28 00:22:14.941113 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-28 00:22:15.013377 | debian-bookworm | ok 2025-12-28 00:22:15.068572 | 2025-12-28 00:22:15.068783 | TASK [emit-job-header : Print job information] 2025-12-28 00:22:15.242078 | # Job Information 2025-12-28 00:22:15.242299 | Ansible Version: 2.16.14 2025-12-28 00:22:15.242495 | Job: tox 2025-12-28 00:22:15.242536 | Pipeline: check 2025-12-28 00:22:15.242560 | Executor: 521e9411259a 2025-12-28 00:22:15.242581 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1059 2025-12-28 00:22:15.242603 | Event ID: fd6ae4a0-e382-11f0-98f4-faa24852da64 2025-12-28 00:22:15.248009 | 2025-12-28 00:22:15.248143 | LOOP [emit-job-header : Print node information] 2025-12-28 00:22:15.540160 | debian-bookworm | ok: 2025-12-28 00:22:15.540446 | debian-bookworm | # Node Information 2025-12-28 00:22:15.540485 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-28 00:22:15.540509 | debian-bookworm | Hostname: debian 2025-12-28 00:22:15.540531 | debian-bookworm | Username: zuul 2025-12-28 00:22:15.540551 | debian-bookworm | Distro: Debian 12.12 2025-12-28 00:22:15.540575 | debian-bookworm | Provider: regiocloud-a 2025-12-28 00:22:15.547022 | debian-bookworm | Region: 2025-12-28 00:22:15.547163 | debian-bookworm | Label: debian-bookworm 2025-12-28 00:22:15.547196 | debian-bookworm | Product Name: OpenStack Nova 2025-12-28 00:22:15.547220 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe60:f35f 2025-12-28 00:22:15.568361 | 2025-12-28 00:22:15.568513 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-28 00:22:17.348605 | debian-bookworm -> localhost | changed 2025-12-28 00:22:17.364183 | 2025-12-28 00:22:17.364332 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-28 00:22:21.858098 | debian-bookworm -> localhost | changed 2025-12-28 00:22:21.897538 | 2025-12-28 00:22:21.897764 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-28 00:22:22.452860 | debian-bookworm -> localhost | ok 2025-12-28 00:22:22.459811 | 2025-12-28 00:22:22.459959 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-28 00:22:22.531203 | debian-bookworm | ok 2025-12-28 00:22:22.587100 | debian-bookworm | included: /var/lib/zuul/builds/1bdcee0042a443e6b2813e1f16ddf28c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-28 00:22:22.597584 | 2025-12-28 00:22:22.597738 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-28 00:22:25.172957 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-28 00:22:25.173192 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1bdcee0042a443e6b2813e1f16ddf28c/work/1bdcee0042a443e6b2813e1f16ddf28c_id_rsa 2025-12-28 00:22:25.173232 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1bdcee0042a443e6b2813e1f16ddf28c/work/1bdcee0042a443e6b2813e1f16ddf28c_id_rsa.pub 2025-12-28 00:22:25.173260 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-28 00:22:25.173286 | debian-bookworm -> localhost | SHA256:VHQUB5hUT1m0aL4BLC+IQA5CqNfC3MmkiQLNMvTBVio zuul-build-sshkey 2025-12-28 00:22:25.173308 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-28 00:22:25.173344 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-28 00:22:25.173366 | debian-bookworm -> localhost | |=*.o.. o+=*oo+o| 2025-12-28 00:22:25.173389 | debian-bookworm -> localhost | |* Bo+ .+. +o .| 2025-12-28 00:22:25.173409 | debian-bookworm -> localhost | |oE.% . .. o o.. | 2025-12-28 00:22:25.173428 | debian-bookworm -> localhost | |+ O * ... o + | 2025-12-28 00:22:25.173447 | debian-bookworm -> localhost | |.. . . .S. . o | 2025-12-28 00:22:25.173473 | debian-bookworm -> localhost | | . o | 2025-12-28 00:22:25.173493 | debian-bookworm -> localhost | | . | 2025-12-28 00:22:25.173512 | debian-bookworm -> localhost | | | 2025-12-28 00:22:25.173532 | debian-bookworm -> localhost | | | 2025-12-28 00:22:25.173552 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-28 00:22:25.173607 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.005068 2025-12-28 00:22:25.180556 | 2025-12-28 00:22:25.180702 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-28 00:22:25.231123 | debian-bookworm | ok 2025-12-28 00:22:25.250388 | debian-bookworm | included: /var/lib/zuul/builds/1bdcee0042a443e6b2813e1f16ddf28c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-28 00:22:25.276729 | 2025-12-28 00:22:25.277033 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-28 00:22:25.337596 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:22:25.353419 | 2025-12-28 00:22:25.353562 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-28 00:22:26.438956 | debian-bookworm | changed 2025-12-28 00:22:26.461838 | 2025-12-28 00:22:26.461975 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-28 00:22:26.794404 | debian-bookworm | ok 2025-12-28 00:22:26.813587 | 2025-12-28 00:22:26.813757 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-28 00:22:27.614108 | debian-bookworm | changed 2025-12-28 00:22:27.628549 | 2025-12-28 00:22:27.628771 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-28 00:22:28.381139 | debian-bookworm | changed 2025-12-28 00:22:28.387194 | 2025-12-28 00:22:28.387320 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-28 00:22:28.422430 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:22:28.433223 | 2025-12-28 00:22:28.433358 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-28 00:22:29.152958 | debian-bookworm -> localhost | changed 2025-12-28 00:22:29.177115 | 2025-12-28 00:22:29.177261 | TASK [add-build-sshkey : Add back temp key] 2025-12-28 00:22:29.765588 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1bdcee0042a443e6b2813e1f16ddf28c/work/1bdcee0042a443e6b2813e1f16ddf28c_id_rsa (zuul-build-sshkey) 2025-12-28 00:22:29.765904 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013272 2025-12-28 00:22:29.777618 | 2025-12-28 00:22:29.777808 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-28 00:22:30.259824 | debian-bookworm | ok 2025-12-28 00:22:30.265047 | 2025-12-28 00:22:30.265170 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-28 00:22:30.311889 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:22:30.323505 | 2025-12-28 00:22:30.323693 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-28 00:22:30.840066 | debian-bookworm | ok 2025-12-28 00:22:30.868252 | 2025-12-28 00:22:30.868399 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-28 00:22:30.955798 | debian-bookworm | ok 2025-12-28 00:22:30.962759 | 2025-12-28 00:22:30.962933 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-28 00:22:31.721208 | debian-bookworm -> localhost | ok 2025-12-28 00:22:31.738963 | 2025-12-28 00:22:31.739124 | TASK [validate-host : Collect information about the host] 2025-12-28 00:22:33.659270 | debian-bookworm | ok 2025-12-28 00:22:33.686510 | 2025-12-28 00:22:33.686679 | TASK [validate-host : Sanitize hostname] 2025-12-28 00:22:33.844516 | debian-bookworm | ok 2025-12-28 00:22:33.930633 | 2025-12-28 00:22:33.930817 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-28 00:22:35.051540 | debian-bookworm -> localhost | changed 2025-12-28 00:22:35.065284 | 2025-12-28 00:22:35.066024 | TASK [validate-host : Collect information about zuul worker] 2025-12-28 00:22:35.774720 | debian-bookworm | ok 2025-12-28 00:22:35.782453 | 2025-12-28 00:22:35.782617 | TASK [validate-host : Write out all zuul information for each host] 2025-12-28 00:22:36.825227 | debian-bookworm -> localhost | changed 2025-12-28 00:22:36.842101 | 2025-12-28 00:22:36.842257 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-28 00:22:37.172386 | debian-bookworm | ok 2025-12-28 00:22:37.181555 | 2025-12-28 00:22:37.181738 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-28 00:22:38.456091 | debian-bookworm | changed: 2025-12-28 00:22:38.459250 | debian-bookworm | cd+++++++++ src/ 2025-12-28 00:22:38.459318 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-28 00:22:38.459346 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-28 00:22:38.459416 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-28 00:22:38.459441 | debian-bookworm | =6.2 2025-12-28 00:23:02.709200 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2025-12-28 00:23:02.754255 | debian-bookworm | Collecting chardet>=5.2 2025-12-28 00:23:02.766508 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-28 00:23:02.798536 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 7.4 MB/s eta 0:00:00 2025-12-28 00:23:02.849239 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-28 00:23:02.861964 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-28 00:23:02.934515 | debian-bookworm | Collecting filelock>=3.20 2025-12-28 00:23:02.946628 | debian-bookworm | Downloading filelock-3.20.1-py3-none-any.whl (16 kB) 2025-12-28 00:23:03.031882 | debian-bookworm | Collecting packaging>=25 2025-12-28 00:23:03.045021 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-28 00:23:03.053792 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.4 MB/s eta 0:00:00 2025-12-28 00:23:03.127047 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-28 00:23:03.138885 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-28 00:23:03.184529 | debian-bookworm | Collecting pluggy>=1.6 2025-12-28 00:23:03.196087 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-28 00:23:03.246563 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-28 00:23:03.259146 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-28 00:23:03.398629 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-28 00:23:03.410417 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-28 00:23:03.734599 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 18.9 MB/s eta 0:00:00 2025-12-28 00:23:03.849978 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-28 00:23:03.861554 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-28 00:23:03.905467 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 12.0 MB/s eta 0:00:00 2025-12-28 00:23:04.054356 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-28 00:23:04.881077 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.1 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-28 00:23:05.409802 | debian-bookworm | ok: Runtime: 0:00:03.194724 2025-12-28 00:23:05.416369 | 2025-12-28 00:23:05.417847 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-28 00:23:05.470261 | debian-bookworm | ok 2025-12-28 00:23:05.484712 | 2025-12-28 00:23:05.484860 | TASK [ensure-tox : Output tox version] 2025-12-28 00:23:06.230310 | 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-28 00:23:06.249731 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-28 00:23:06.581237 | debian-bookworm | ok: Runtime: 0:00:00.351756 2025-12-28 00:23:06.587465 | 2025-12-28 00:23:06.587596 | TASK [ensure-tox : Make global symlink] 2025-12-28 00:23:06.632163 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:06.640675 | 2025-12-28 00:23:06.640785 | PLAY RECAP 2025-12-28 00:23:06.640842 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-28 00:23:06.640867 | 2025-12-28 00:23:06.941289 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-28 00:23:06.942554 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-28 00:23:09.669962 | 2025-12-28 00:23:09.670153 | PLAY [all] 2025-12-28 00:23:09.705575 | 2025-12-28 00:23:09.711079 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-28 00:23:10.888573 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-28 00:23:11.305991 | debian-bookworm | ok: Runtime: 0:00:00.025381 2025-12-28 00:23:11.314618 | 2025-12-28 00:23:11.314998 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-28 00:23:11.919224 | debian-bookworm | ok: Runtime: 0:00:00.007282 2025-12-28 00:23:11.941481 | 2025-12-28 00:23:11.942260 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-28 00:23:12.366805 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-28 00:23:12.368256 | debian-bookworm | sudo: a password is required 2025-12-28 00:23:12.571057 | debian-bookworm | ok: Runtime: 0:00:00.023089 2025-12-28 00:23:12.581656 | 2025-12-28 00:23:12.581786 | TASK [tox : Check to see if the constraints file exists] 2025-12-28 00:23:12.687757 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:12.696315 | 2025-12-28 00:23:12.696462 | TASK [tox : Fail if constraints file is missing] 2025-12-28 00:23:12.734702 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:12.741438 | 2025-12-28 00:23:12.741582 | TASK [tox : Record file location] 2025-12-28 00:23:12.817722 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:12.824295 | 2025-12-28 00:23:12.824446 | TASK [tox : Install tox siblings] 2025-12-28 00:23:12.880901 | debian-bookworm | ok 2025-12-28 00:23:12.907085 | debian-bookworm | included: /var/lib/zuul/builds/1bdcee0042a443e6b2813e1f16ddf28c/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-28 00:23:12.913704 | 2025-12-28 00:23:12.913851 | TASK [tox : Run tox without tests] 2025-12-28 00:23:14.090911 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-28 00:23:28.526960 | debian-bookworm | test: OK (15.00 seconds) 2025-12-28 00:23:28.527037 | debian-bookworm | congratulations :) (15.03 seconds) 2025-12-28 00:23:28.979242 | debian-bookworm | ok: Runtime: 0:00:15.314563 2025-12-28 00:23:28.989343 | 2025-12-28 00:23:28.989469 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-28 00:23:29.595177 | debian-bookworm | changed 2025-12-28 00:23:29.638163 | 2025-12-28 00:23:29.638368 | TASK [tox : Get tox envlist config] 2025-12-28 00:23:30.729822 | debian-bookworm | ok: Runtime: 0:00:00.339346 2025-12-28 00:23:30.763230 | 2025-12-28 00:23:30.763374 | TASK [tox : Install any sibling python packages] 2025-12-28 00:23:31.404074 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-28 00:23:31.419091 | 2025-12-28 00:23:31.419242 | TASK [tox : Remove tempfile] 2025-12-28 00:23:32.122400 | debian-bookworm | changed 2025-12-28 00:23:32.135405 | 2025-12-28 00:23:32.135555 | TASK [tox : Emit tox command] 2025-12-28 00:23:32.209775 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-28 00:23:32.220446 | 2025-12-28 00:23:32.220600 | TASK [tox : Run tox] 2025-12-28 00:23:33.183069 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-28 00:23:33.840643 | debian-bookworm | ............... 2025-12-28 00:23:33.840696 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-28 00:23:33.840710 | debian-bookworm | Ran 15 tests in 0.174s 2025-12-28 00:23:33.840715 | debian-bookworm | 2025-12-28 00:23:33.840723 | debian-bookworm | OK 2025-12-28 00:23:33.927849 | debian-bookworm | test: OK (0.79=setup[0.05]+cmd[0.74] seconds) 2025-12-28 00:23:33.927918 | debian-bookworm | congratulations :) (0.82 seconds) 2025-12-28 00:23:34.438699 | debian-bookworm | ok: Runtime: 0:00:01.136073 2025-12-28 00:23:34.444960 | 2025-12-28 00:23:34.445098 | TASK [tox : Look for output] 2025-12-28 00:23:34.871805 | debian-bookworm | ok 2025-12-28 00:23:34.893022 | 2025-12-28 00:23:34.893181 | TASK [tox : Return file comments to Zuul] 2025-12-28 00:23:34.932600 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:34.939969 | 2025-12-28 00:23:34.940146 | PLAY RECAP 2025-12-28 00:23:34.940205 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-28 00:23:34.940230 | 2025-12-28 00:23:35.117687 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-28 00:23:35.118821 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-28 00:23:36.166005 | 2025-12-28 00:23:36.166213 | PLAY [all] 2025-12-28 00:23:36.190870 | 2025-12-28 00:23:36.191051 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-28 00:23:36.254380 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:36.265022 | 2025-12-28 00:23:36.265225 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-28 00:23:36.315999 | debian-bookworm | ok 2025-12-28 00:23:36.322443 | 2025-12-28 00:23:36.322595 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-28 00:23:36.893312 | debian-bookworm -> localhost | changed 2025-12-28 00:23:36.909860 | 2025-12-28 00:23:36.910048 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-28 00:23:36.966227 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:36.981640 | 2025-12-28 00:23:36.981844 | TASK [fetch-tox-output : Set envlist fact] 2025-12-28 00:23:37.034821 | debian-bookworm | ok 2025-12-28 00:23:37.043590 | 2025-12-28 00:23:37.043747 | TASK [fetch-tox-output : Get tox version] 2025-12-28 00:23:37.778992 | 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-28 00:23:37.802740 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-28 00:23:38.077786 | debian-bookworm | ok: Runtime: 0:00:00.308950 2025-12-28 00:23:38.084398 | 2025-12-28 00:23:38.084523 | TASK [fetch-tox-output : Find all default environments] 2025-12-28 00:23:38.649741 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:38.664374 | 2025-12-28 00:23:38.664560 | TASK [fetch-tox-output : Set envlist fact] 2025-12-28 00:23:38.705323 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:38.718456 | 2025-12-28 00:23:38.718619 | TASK [fetch-tox-output : Find all default environments] 2025-12-28 00:23:39.260886 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:39.276025 | 2025-12-28 00:23:39.276208 | TASK [fetch-tox-output : Set envlist fact] 2025-12-28 00:23:39.313914 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:39.325110 | 2025-12-28 00:23:39.325248 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-28 00:23:39.383826 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:39.402206 | 2025-12-28 00:23:39.402361 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-28 00:23:40.380313 | debian-bookworm | changed: 2025-12-28 00:23:40.380517 | debian-bookworm | created directory /var/lib/zuul/builds/1bdcee0042a443e6b2813e1f16ddf28c/work/logs/tox/test 2025-12-28 00:23:40.380553 | debian-bookworm | cd+++++++++ ./ 2025-12-28 00:23:40.380579 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-28 00:23:40.380611 | 2025-12-28 00:23:40.399532 | 2025-12-28 00:23:40.399719 | PLAY RECAP 2025-12-28 00:23:40.399803 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-28 00:23:40.399844 | 2025-12-28 00:23:40.602381 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-28 00:23:40.603467 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-28 00:23:41.700481 | 2025-12-28 00:23:41.700694 | PLAY [all] 2025-12-28 00:23:41.718698 | 2025-12-28 00:23:41.718948 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-28 00:23:42.004119 | debian-bookworm | changed: non-zero return code 2025-12-28 00:23:42.011574 | 2025-12-28 00:23:42.011798 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-28 00:23:42.041869 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:42.048914 | 2025-12-28 00:23:42.049056 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-28 00:23:42.084909 | 2025-12-28 00:23:42.085120 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-28 00:23:42.137986 | 2025-12-28 00:23:42.138198 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-28 00:23:42.163048 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:42.169689 | 2025-12-28 00:23:42.169825 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-28 00:23:42.243167 | 2025-12-28 00:23:42.243737 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-28 00:23:42.305288 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:42.317029 | 2025-12-28 00:23:42.317180 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-28 00:23:42.352550 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:42.378751 | 2025-12-28 00:23:42.379071 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-28 00:23:42.413315 | debian-bookworm | skipping: Conditional result was False 2025-12-28 00:23:42.438490 | 2025-12-28 00:23:42.438610 | PLAY RECAP 2025-12-28 00:23:42.438689 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-28 00:23:42.438714 | 2025-12-28 00:23:42.583470 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-28 00:23:42.584583 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-28 00:23:43.381520 | 2025-12-28 00:23:43.381720 | PLAY [Base post] 2025-12-28 00:23:43.395796 | 2025-12-28 00:23:43.395944 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-28 00:23:44.016310 | debian-bookworm | changed 2025-12-28 00:23:44.022715 | 2025-12-28 00:23:44.023239 | PLAY RECAP 2025-12-28 00:23:44.023322 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-28 00:23:44.023386 | 2025-12-28 00:23:44.203144 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-28 00:23:44.204687 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-28 00:23:45.116264 | 2025-12-28 00:23:45.116457 | PLAY [Base post-logs] 2025-12-28 00:23:45.128346 | 2025-12-28 00:23:45.128505 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-28 00:23:46.010528 | localhost | changed 2025-12-28 00:23:46.021450 | 2025-12-28 00:23:46.021664 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-28 00:23:46.047609 | localhost | ok 2025-12-28 00:23:46.051247 | 2025-12-28 00:23:46.051350 | TASK [Set zuul-log-path fact] 2025-12-28 00:23:46.070434 | localhost | ok 2025-12-28 00:23:46.080345 | 2025-12-28 00:23:46.080491 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-28 00:23:46.106682 | localhost | ok 2025-12-28 00:23:46.109957 | 2025-12-28 00:23:46.110064 | TASK [upload-logs : Create log directories] 2025-12-28 00:23:46.657240 | localhost | changed 2025-12-28 00:23:46.660138 | 2025-12-28 00:23:46.660253 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-28 00:23:47.242911 | localhost -> localhost | ok: Runtime: 0:00:00.019082 2025-12-28 00:23:47.247690 | 2025-12-28 00:23:47.247828 | TASK [upload-logs : Upload logs to log server] 2025-12-28 00:23:47.870992 | localhost | Output suppressed because no_log was given 2025-12-28 00:23:47.873931 | 2025-12-28 00:23:47.874086 | LOOP [upload-logs : Compress console log and json output] 2025-12-28 00:23:47.939152 | localhost | skipping: Conditional result was False 2025-12-28 00:23:47.944283 | localhost | skipping: Conditional result was False 2025-12-28 00:23:47.956106 | 2025-12-28 00:23:47.956304 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-28 00:23:48.026125 | localhost | skipping: Conditional result was False 2025-12-28 00:23:48.026502 | 2025-12-28 00:23:48.036500 | localhost | skipping: Conditional result was False 2025-12-28 00:23:48.051533 | 2025-12-28 00:23:48.051817 | LOOP [upload-logs : Upload console log and json output]