2026-03-01 00:25:38.406466 | Job console starting 2026-03-01 00:25:38.425904 | Updating git repos 2026-03-01 00:25:38.499926 | Cloning repos into workspace 2026-03-01 00:25:38.593372 | Restoring repo states 2026-03-01 00:25:38.600455 | Merging changes 2026-03-01 00:25:39.204452 | Checking out repos 2026-03-01 00:25:39.264340 | Preparing playbooks 2026-03-01 00:25:40.138021 | Running Ansible setup 2026-03-01 00:25:46.220313 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-01 00:25:47.621974 | 2026-03-01 00:25:47.622163 | PLAY [Base pre] 2026-03-01 00:25:47.656826 | 2026-03-01 00:25:47.656996 | TASK [Setup log path fact] 2026-03-01 00:25:47.727823 | debian-bookworm | ok 2026-03-01 00:25:47.749910 | 2026-03-01 00:25:47.750044 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-01 00:25:47.798536 | debian-bookworm | ok 2026-03-01 00:25:47.808896 | 2026-03-01 00:25:47.808990 | TASK [emit-job-header : Print job information] 2026-03-01 00:25:47.882281 | # Job Information 2026-03-01 00:25:47.882425 | Ansible Version: 2.16.14 2026-03-01 00:25:47.882453 | Job: tox 2026-03-01 00:25:47.882480 | Pipeline: check 2026-03-01 00:25:47.882499 | Executor: 521e9411259a 2026-03-01 00:25:47.882516 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1156 2026-03-01 00:25:47.882535 | Event ID: 26b19cb0-1505-11f1-9c16-b9ad7b7c827d 2026-03-01 00:25:47.886726 | 2026-03-01 00:25:47.886856 | LOOP [emit-job-header : Print node information] 2026-03-01 00:25:48.056386 | debian-bookworm | ok: 2026-03-01 00:25:48.056545 | debian-bookworm | # Node Information 2026-03-01 00:25:48.056579 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-01 00:25:48.056604 | debian-bookworm | Hostname: debian 2026-03-01 00:25:48.056626 | debian-bookworm | Username: zuul 2026-03-01 00:25:48.056646 | debian-bookworm | Distro: Debian 12.13 2026-03-01 00:25:48.056670 | debian-bookworm | Provider: regiocloud-a 2026-03-01 00:25:48.056691 | debian-bookworm | Region: 2026-03-01 00:25:48.056711 | debian-bookworm | Label: debian-bookworm 2026-03-01 00:25:48.056731 | debian-bookworm | Product Name: OpenStack Nova 2026-03-01 00:25:48.056752 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe03:ae7d 2026-03-01 00:25:48.073138 | 2026-03-01 00:25:48.073248 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-01 00:25:48.828455 | debian-bookworm -> localhost | changed 2026-03-01 00:25:48.834300 | 2026-03-01 00:25:48.834390 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-01 00:25:50.639306 | debian-bookworm -> localhost | changed 2026-03-01 00:25:50.648924 | 2026-03-01 00:25:50.649013 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-01 00:25:51.547360 | debian-bookworm -> localhost | ok 2026-03-01 00:25:51.552992 | 2026-03-01 00:25:51.553079 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-01 00:25:51.604954 | debian-bookworm | ok 2026-03-01 00:25:51.658638 | debian-bookworm | included: /var/lib/zuul/builds/2e86e67d7ebd4bd694802de1bb058d57/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-01 00:25:51.674518 | 2026-03-01 00:25:51.674625 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-01 00:25:56.507915 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-01 00:25:56.508121 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2e86e67d7ebd4bd694802de1bb058d57/work/2e86e67d7ebd4bd694802de1bb058d57_id_rsa 2026-03-01 00:25:56.508160 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2e86e67d7ebd4bd694802de1bb058d57/work/2e86e67d7ebd4bd694802de1bb058d57_id_rsa.pub 2026-03-01 00:25:56.508186 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-01 00:25:56.508210 | debian-bookworm -> localhost | SHA256:DLA3wg01nr6ADObYgsgvHnF0Lst1m1K/LpV87HeCn4c zuul-build-sshkey 2026-03-01 00:25:56.508231 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-01 00:25:56.508262 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-01 00:25:56.508283 | debian-bookworm -> localhost | | o.o | 2026-03-01 00:25:56.508305 | debian-bookworm -> localhost | | . * o | 2026-03-01 00:25:56.508325 | debian-bookworm -> localhost | |.. .+.B | 2026-03-01 00:25:56.508344 | debian-bookworm -> localhost | |B+..o+ + | 2026-03-01 00:25:56.508364 | debian-bookworm -> localhost | |=++o.o.oS o | 2026-03-01 00:25:56.508391 | debian-bookworm -> localhost | | .= +.o.++ o | 2026-03-01 00:25:56.508413 | debian-bookworm -> localhost | | o + ..o..o . . | 2026-03-01 00:25:56.508434 | debian-bookworm -> localhost | |. o .. .o E.o | 2026-03-01 00:25:56.508455 | debian-bookworm -> localhost | | . oo oo+ | 2026-03-01 00:25:56.508476 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-01 00:25:56.508522 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.739627 2026-03-01 00:25:56.514485 | 2026-03-01 00:25:56.514570 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-01 00:25:56.552665 | debian-bookworm | ok 2026-03-01 00:25:56.569142 | debian-bookworm | included: /var/lib/zuul/builds/2e86e67d7ebd4bd694802de1bb058d57/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-01 00:25:56.593384 | 2026-03-01 00:25:56.593482 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-01 00:25:56.627627 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:25:56.634332 | 2026-03-01 00:25:56.634437 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-01 00:25:57.310994 | debian-bookworm | changed 2026-03-01 00:25:57.316231 | 2026-03-01 00:25:57.316319 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-01 00:25:57.548694 | debian-bookworm | ok 2026-03-01 00:25:57.555159 | 2026-03-01 00:25:57.555266 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-01 00:25:58.149460 | debian-bookworm | changed 2026-03-01 00:25:58.156039 | 2026-03-01 00:25:58.156133 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-01 00:25:58.817581 | debian-bookworm | changed 2026-03-01 00:25:58.828281 | 2026-03-01 00:25:58.828445 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-01 00:25:58.877367 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:25:58.883623 | 2026-03-01 00:25:58.883728 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-01 00:25:59.900570 | debian-bookworm -> localhost | changed 2026-03-01 00:25:59.941286 | 2026-03-01 00:25:59.941774 | TASK [add-build-sshkey : Add back temp key] 2026-03-01 00:26:00.583529 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2e86e67d7ebd4bd694802de1bb058d57/work/2e86e67d7ebd4bd694802de1bb058d57_id_rsa (zuul-build-sshkey) 2026-03-01 00:26:00.583749 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013417 2026-03-01 00:26:00.591401 | 2026-03-01 00:26:00.591496 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-01 00:26:01.142244 | debian-bookworm | ok 2026-03-01 00:26:01.151500 | 2026-03-01 00:26:01.151595 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-01 00:26:01.211818 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:26:01.222129 | 2026-03-01 00:26:01.222231 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-01 00:26:01.788873 | debian-bookworm | ok 2026-03-01 00:26:01.809479 | 2026-03-01 00:26:01.809590 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-01 00:26:01.857634 | debian-bookworm | ok 2026-03-01 00:26:01.862894 | 2026-03-01 00:26:01.862991 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-01 00:26:02.503910 | debian-bookworm -> localhost | ok 2026-03-01 00:26:02.510131 | 2026-03-01 00:26:02.510224 | TASK [validate-host : Collect information about the host] 2026-03-01 00:26:03.845770 | debian-bookworm | ok 2026-03-01 00:26:03.877427 | 2026-03-01 00:26:03.877605 | TASK [validate-host : Sanitize hostname] 2026-03-01 00:26:04.073070 | debian-bookworm | ok 2026-03-01 00:26:04.154149 | 2026-03-01 00:26:04.154256 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-01 00:26:05.675467 | debian-bookworm -> localhost | changed 2026-03-01 00:26:05.681422 | 2026-03-01 00:26:05.681532 | TASK [validate-host : Collect information about zuul worker] 2026-03-01 00:26:06.227679 | debian-bookworm | ok 2026-03-01 00:26:06.232227 | 2026-03-01 00:26:06.232311 | TASK [validate-host : Write out all zuul information for each host] 2026-03-01 00:26:07.743646 | debian-bookworm -> localhost | changed 2026-03-01 00:26:07.760284 | 2026-03-01 00:26:07.760372 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-01 00:26:08.051922 | debian-bookworm | ok 2026-03-01 00:26:08.060455 | 2026-03-01 00:26:08.060538 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-01 00:26:09.105982 | debian-bookworm | changed: 2026-03-01 00:26:09.106156 | debian-bookworm | cd+++++++++ src/ 2026-03-01 00:26:09.106191 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-01 00:26:09.106216 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-01 00:26:09.106239 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-03-01 00:26:09.106260 | debian-bookworm | =7.0.1 2026-03-01 00:26:31.172608 | debian-bookworm | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-03-01 00:26:31.213504 | debian-bookworm | Collecting colorama>=0.4.6 2026-03-01 00:26:31.225224 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-03-01 00:26:31.294921 | debian-bookworm | Collecting filelock>=3.24.3 2026-03-01 00:26:31.310580 | debian-bookworm | Downloading filelock-3.24.3-py3-none-any.whl (24 kB) 2026-03-01 00:26:31.365476 | debian-bookworm | Collecting packaging>=26 2026-03-01 00:26:31.377615 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-01 00:26:31.390391 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 10.3 MB/s eta 0:00:00 2026-03-01 00:26:31.449324 | debian-bookworm | Collecting platformdirs>=4.9.2 2026-03-01 00:26:31.460843 | debian-bookworm | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-03-01 00:26:31.498214 | debian-bookworm | Collecting pluggy>=1.6 2026-03-01 00:26:31.509665 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-01 00:26:31.558090 | debian-bookworm | Collecting pyproject-api>=1.10 2026-03-01 00:26:31.570825 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-03-01 00:26:31.704353 | debian-bookworm | Collecting virtualenv>=20.39 2026-03-01 00:26:31.716185 | debian-bookworm | Downloading virtualenv-21.1.0-py3-none-any.whl (5.8 MB) 2026-03-01 00:26:31.986232 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 21.8 MB/s eta 0:00:00 2026-03-01 00:26:32.057492 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-03-01 00:26:32.069242 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-03-01 00:26:32.088124 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 28.8 MB/s eta 0:00:00 2026-03-01 00:26:32.126351 | debian-bookworm | Collecting python-discovery>=1 2026-03-01 00:26:32.137752 | debian-bookworm | Downloading python_discovery-1.1.0-py3-none-any.whl (30 kB) 2026-03-01 00:26:32.256397 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-03-01 00:26:32.952926 | debian-bookworm | Successfully installed cachetools-7.0.1 colorama-0.4.6 distlib-0.4.0 filelock-3.24.3 packaging-26.0 platformdirs-4.9.2 pluggy-1.6.0 pyproject-api-1.10.0 python-discovery-1.1.0 tox-4.46.3 virtualenv-21.1.0 2026-03-01 00:26:33.170380 | debian-bookworm | ok: Runtime: 0:00:02.629650 2026-03-01 00:26:33.183736 | 2026-03-01 00:26:33.183891 | TASK [ensure-tox : Export installed tox_executable path] 2026-03-01 00:26:33.283965 | debian-bookworm | ok 2026-03-01 00:26:33.294574 | 2026-03-01 00:26:33.294948 | TASK [ensure-tox : Output tox version] 2026-03-01 00:26:33.937580 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-03-01 00:26:33.955346 | debian-bookworm | 4.46.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-01 00:26:34.378324 | debian-bookworm | ok: Runtime: 0:00:00.275278 2026-03-01 00:26:34.395131 | 2026-03-01 00:26:34.395480 | TASK [ensure-tox : Make global symlink] 2026-03-01 00:26:34.441208 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:26:34.449511 | 2026-03-01 00:26:34.449608 | PLAY RECAP 2026-03-01 00:26:34.449664 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-03-01 00:26:34.449833 | 2026-03-01 00:26:34.792443 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-03-01 00:26:34.793560 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-01 00:26:36.859058 | 2026-03-01 00:26:36.859192 | PLAY [all] 2026-03-01 00:26:36.879409 | 2026-03-01 00:26:36.879533 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-03-01 00:26:37.691824 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-01 00:26:37.918275 | debian-bookworm | ok: Runtime: 0:00:00.026910 2026-03-01 00:26:37.924057 | 2026-03-01 00:26:37.924165 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-03-01 00:26:38.505144 | debian-bookworm | ok: Runtime: 0:00:00.006964 2026-03-01 00:26:38.510985 | 2026-03-01 00:26:38.511089 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-03-01 00:26:38.865338 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-01 00:26:38.866870 | debian-bookworm | sudo: a password is required 2026-03-01 00:26:39.085162 | debian-bookworm | ok: Runtime: 0:00:00.018725 2026-03-01 00:26:39.100025 | 2026-03-01 00:26:39.100128 | TASK [tox : Check to see if the constraints file exists] 2026-03-01 00:26:39.133828 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:26:39.140817 | 2026-03-01 00:26:39.140932 | TASK [tox : Fail if constraints file is missing] 2026-03-01 00:26:39.177606 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:26:39.184147 | 2026-03-01 00:26:39.184252 | TASK [tox : Record file location] 2026-03-01 00:26:39.219412 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:26:39.225207 | 2026-03-01 00:26:39.225319 | TASK [tox : Install tox siblings] 2026-03-01 00:26:39.275783 | debian-bookworm | ok 2026-03-01 00:26:39.301241 | debian-bookworm | included: /var/lib/zuul/builds/2e86e67d7ebd4bd694802de1bb058d57/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-03-01 00:26:39.319909 | 2026-03-01 00:26:39.320026 | TASK [tox : Run tox without tests] 2026-03-01 00:26:40.369385 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-03-01 00:26:53.228551 | debian-bookworm | test: OK (13.29 seconds) 2026-03-01 00:26:53.228588 | debian-bookworm | congratulations :) (13.32 seconds) 2026-03-01 00:26:53.383169 | debian-bookworm | ok: Runtime: 0:00:13.573469 2026-03-01 00:26:53.389446 | 2026-03-01 00:26:53.389549 | TASK [tox : Create a tempfile to save tox showconfig] 2026-03-01 00:26:53.802190 | debian-bookworm | changed 2026-03-01 00:26:53.817009 | 2026-03-01 00:26:53.819321 | TASK [tox : Get tox envlist config] 2026-03-01 00:26:54.856557 | debian-bookworm | ok: Runtime: 0:00:00.295120 2026-03-01 00:26:54.862547 | 2026-03-01 00:26:54.862662 | TASK [tox : Install any sibling python packages] 2026-03-01 00:26:55.318159 | debian-bookworm | ok: No setup.cfg, no action needed 2026-03-01 00:26:55.331497 | 2026-03-01 00:26:55.331662 | TASK [tox : Remove tempfile] 2026-03-01 00:26:55.747166 | debian-bookworm | changed 2026-03-01 00:26:55.754158 | 2026-03-01 00:26:55.754288 | TASK [tox : Emit tox command] 2026-03-01 00:26:55.831402 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-03-01 00:26:55.839909 | 2026-03-01 00:26:55.840034 | TASK [tox : Run tox] 2026-03-01 00:26:56.582115 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-03-01 00:26:57.158233 | debian-bookworm | ............... 2026-03-01 00:26:57.158270 | debian-bookworm | ---------------------------------------------------------------------- 2026-03-01 00:26:57.158282 | debian-bookworm | Ran 15 tests in 0.163s 2026-03-01 00:26:57.158288 | debian-bookworm | 2026-03-01 00:26:57.158294 | debian-bookworm | OK 2026-03-01 00:26:57.216438 | debian-bookworm | test: OK (0.67=setup[0.04]+cmd[0.63] seconds) 2026-03-01 00:26:57.216483 | debian-bookworm | congratulations :) (0.70 seconds) 2026-03-01 00:26:57.500372 | debian-bookworm | ok: Runtime: 0:00:00.953672 2026-03-01 00:26:57.504865 | 2026-03-01 00:26:57.504938 | TASK [tox : Look for output] 2026-03-01 00:26:57.902259 | debian-bookworm | ok 2026-03-01 00:26:57.912828 | 2026-03-01 00:26:57.922863 | TASK [tox : Return file comments to Zuul] 2026-03-01 00:26:57.986632 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:26:57.992470 | 2026-03-01 00:26:57.992533 | PLAY RECAP 2026-03-01 00:26:57.992574 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-03-01 00:26:57.992594 | 2026-03-01 00:26:58.126897 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-01 00:26:58.127954 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-01 00:26:58.908485 | 2026-03-01 00:26:58.908616 | PLAY [all] 2026-03-01 00:26:58.933132 | 2026-03-01 00:26:58.933254 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-03-01 00:26:58.987008 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:26:58.992678 | 2026-03-01 00:26:58.992824 | TASK [fetch-tox-output : Set tox log path for single node] 2026-03-01 00:26:59.040561 | debian-bookworm | ok 2026-03-01 00:26:59.045709 | 2026-03-01 00:26:59.045832 | TASK [fetch-tox-output : Ensure local tox dir] 2026-03-01 00:26:59.528268 | debian-bookworm -> localhost | changed 2026-03-01 00:26:59.535548 | 2026-03-01 00:26:59.535655 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-03-01 00:26:59.589048 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:26:59.594439 | 2026-03-01 00:26:59.594541 | TASK [fetch-tox-output : Set envlist fact] 2026-03-01 00:26:59.642723 | debian-bookworm | ok 2026-03-01 00:26:59.648479 | 2026-03-01 00:26:59.648567 | TASK [fetch-tox-output : Get tox version] 2026-03-01 00:27:00.304341 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-03-01 00:27:00.321741 | debian-bookworm | 4.46.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-01 00:27:00.687569 | debian-bookworm | ok: Runtime: 0:00:00.256039 2026-03-01 00:27:00.693962 | 2026-03-01 00:27:00.694127 | TASK [fetch-tox-output : Find all default environments] 2026-03-01 00:27:01.243607 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:27:01.253341 | 2026-03-01 00:27:01.253514 | TASK [fetch-tox-output : Set envlist fact] 2026-03-01 00:27:01.278806 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:27:01.286368 | 2026-03-01 00:27:01.286508 | TASK [fetch-tox-output : Find all default environments] 2026-03-01 00:27:01.823959 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:27:01.834356 | 2026-03-01 00:27:01.834517 | TASK [fetch-tox-output : Set envlist fact] 2026-03-01 00:27:01.860143 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:27:01.867941 | 2026-03-01 00:27:01.868172 | LOOP [fetch-tox-output : Copy tox logs] 2026-03-01 00:27:01.917758 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:27:01.931757 | 2026-03-01 00:27:01.931903 | LOOP [fetch-tox-output : Collect tox logs] 2026-03-01 00:27:02.728449 | debian-bookworm | changed: 2026-03-01 00:27:02.728666 | debian-bookworm | created directory /var/lib/zuul/builds/2e86e67d7ebd4bd694802de1bb058d57/work/logs/tox/test 2026-03-01 00:27:02.728704 | debian-bookworm | cd+++++++++ ./ 2026-03-01 00:27:02.728730 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-03-01 00:27:02.728761 | 2026-03-01 00:27:02.739020 | 2026-03-01 00:27:02.739138 | PLAY RECAP 2026-03-01 00:27:02.739194 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-03-01 00:27:02.739220 | 2026-03-01 00:27:02.902627 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-01 00:27:02.904190 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-01 00:27:03.726408 | 2026-03-01 00:27:03.726570 | PLAY [all] 2026-03-01 00:27:03.744208 | 2026-03-01 00:27:03.744363 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-01 00:27:03.960491 | debian-bookworm | changed: non-zero return code 2026-03-01 00:27:03.966344 | 2026-03-01 00:27:03.966482 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-01 00:27:03.991230 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:27:03.998035 | 2026-03-01 00:27:03.998167 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-01 00:27:04.028727 | 2026-03-01 00:27:04.028978 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-01 00:27:04.060302 | 2026-03-01 00:27:04.060500 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-01 00:27:04.084472 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:27:04.093789 | 2026-03-01 00:27:04.093952 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-01 00:27:04.127904 | 2026-03-01 00:27:04.128139 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-01 00:27:04.152397 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:27:04.163359 | 2026-03-01 00:27:04.163516 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-01 00:27:04.188250 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:27:04.194691 | 2026-03-01 00:27:04.194860 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-01 00:27:04.229402 | debian-bookworm | skipping: Conditional result was False 2026-03-01 00:27:04.239828 | 2026-03-01 00:27:04.239942 | PLAY RECAP 2026-03-01 00:27:04.239998 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-01 00:27:04.240023 | 2026-03-01 00:27:04.379949 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-01 00:27:04.381063 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-01 00:27:05.193201 | 2026-03-01 00:27:05.193377 | PLAY [Base post] 2026-03-01 00:27:05.209286 | 2026-03-01 00:27:05.209450 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-01 00:27:05.776556 | debian-bookworm | changed 2026-03-01 00:27:05.783577 | 2026-03-01 00:27:05.783701 | PLAY RECAP 2026-03-01 00:27:05.783781 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-01 00:27:05.783847 | 2026-03-01 00:27:05.975975 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-01 00:27:05.977031 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-01 00:27:06.922890 | 2026-03-01 00:27:06.923082 | PLAY [Base post-logs] 2026-03-01 00:27:06.934418 | 2026-03-01 00:27:06.934564 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-01 00:27:07.468715 | localhost | changed 2026-03-01 00:27:07.479075 | 2026-03-01 00:27:07.479227 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-01 00:27:07.518527 | localhost | ok 2026-03-01 00:27:07.521760 | 2026-03-01 00:27:07.521889 | TASK [Set zuul-log-path fact] 2026-03-01 00:27:07.557460 | localhost | ok 2026-03-01 00:27:07.565733 | 2026-03-01 00:27:07.565893 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-01 00:27:07.632078 | localhost | ok 2026-03-01 00:27:07.635443 | 2026-03-01 00:27:07.635555 | TASK [upload-logs : Create log directories] 2026-03-01 00:27:08.416398 | localhost | changed 2026-03-01 00:27:08.423825 | 2026-03-01 00:27:08.423957 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-01 00:27:09.217933 | localhost -> localhost | ok: Runtime: 0:00:00.010714 2026-03-01 00:27:09.221442 | 2026-03-01 00:27:09.221535 | TASK [upload-logs : Upload logs to log server] 2026-03-01 00:27:09.958473 | localhost | Output suppressed because no_log was given 2026-03-01 00:27:09.960855 | 2026-03-01 00:27:09.960947 | LOOP [upload-logs : Compress console log and json output] 2026-03-01 00:27:10.007436 | localhost | skipping: Conditional result was False 2026-03-01 00:27:10.013515 | localhost | skipping: Conditional result was False 2026-03-01 00:27:10.016746 | 2026-03-01 00:27:10.017487 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-01 00:27:10.087946 | localhost | skipping: Conditional result was False 2026-03-01 00:27:10.088269 | 2026-03-01 00:27:10.098523 | localhost | skipping: Conditional result was False 2026-03-01 00:27:10.105908 | 2026-03-01 00:27:10.106010 | LOOP [upload-logs : Upload console log and json output]