2026-01-25 00:20:52.102285 | Job console starting 2026-01-25 00:20:52.123431 | Updating git repos 2026-01-25 00:20:52.201030 | Cloning repos into workspace 2026-01-25 00:20:52.300452 | Restoring repo states 2026-01-25 00:20:52.320264 | Merging changes 2026-01-25 00:20:52.782585 | Checking out repos 2026-01-25 00:20:52.879781 | Preparing playbooks 2026-01-25 00:20:53.739504 | Running Ansible setup 2026-01-25 00:20:59.663102 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-25 00:21:01.558561 | 2026-01-25 00:21:01.558677 | PLAY [Base pre] 2026-01-25 00:21:01.595713 | 2026-01-25 00:21:01.606303 | TASK [Setup log path fact] 2026-01-25 00:21:01.633004 | debian-bookworm | ok 2026-01-25 00:21:01.652519 | 2026-01-25 00:21:01.652634 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-25 00:21:01.703663 | debian-bookworm | ok 2026-01-25 00:21:01.711560 | 2026-01-25 00:21:01.711654 | TASK [emit-job-header : Print job information] 2026-01-25 00:21:01.760086 | # Job Information 2026-01-25 00:21:01.760215 | Ansible Version: 2.16.14 2026-01-25 00:21:01.760243 | Job: tox 2026-01-25 00:21:01.760268 | Pipeline: check 2026-01-25 00:21:01.760286 | Executor: 521e9411259a 2026-01-25 00:21:01.760303 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1107 2026-01-25 00:21:01.760322 | Event ID: af02be70-f983-11f0-842d-d765904c1358 2026-01-25 00:21:01.764299 | 2026-01-25 00:21:01.764465 | LOOP [emit-job-header : Print node information] 2026-01-25 00:21:01.845238 | debian-bookworm | ok: 2026-01-25 00:21:01.845403 | debian-bookworm | # Node Information 2026-01-25 00:21:01.845435 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-25 00:21:01.845456 | debian-bookworm | Hostname: debian 2026-01-25 00:21:01.845475 | debian-bookworm | Username: zuul 2026-01-25 00:21:01.845492 | debian-bookworm | Distro: Debian 12.13 2026-01-25 00:21:01.845511 | debian-bookworm | Provider: regiocloud-a 2026-01-25 00:21:01.845529 | debian-bookworm | Region: 2026-01-25 00:21:01.845546 | debian-bookworm | Label: debian-bookworm 2026-01-25 00:21:01.845563 | debian-bookworm | Product Name: OpenStack Nova 2026-01-25 00:21:01.845579 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1c:215b 2026-01-25 00:21:01.856021 | 2026-01-25 00:21:01.856183 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-25 00:21:02.732331 | debian-bookworm -> localhost | changed 2026-01-25 00:21:02.739449 | 2026-01-25 00:21:02.739552 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-25 00:21:04.511452 | debian-bookworm -> localhost | changed 2026-01-25 00:21:04.523575 | 2026-01-25 00:21:04.523678 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-25 00:21:05.058151 | debian-bookworm -> localhost | ok 2026-01-25 00:21:05.064760 | 2026-01-25 00:21:05.064866 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-25 00:21:05.104125 | debian-bookworm | ok 2026-01-25 00:21:05.146069 | debian-bookworm | included: /var/lib/zuul/builds/840ceb3088504b26b5b152b0ca9c17ca/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-25 00:21:05.153597 | 2026-01-25 00:21:05.153684 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-25 00:21:09.646294 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-25 00:21:09.646478 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/840ceb3088504b26b5b152b0ca9c17ca/work/840ceb3088504b26b5b152b0ca9c17ca_id_rsa 2026-01-25 00:21:09.646513 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/840ceb3088504b26b5b152b0ca9c17ca/work/840ceb3088504b26b5b152b0ca9c17ca_id_rsa.pub 2026-01-25 00:21:09.646537 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-25 00:21:09.646560 | debian-bookworm -> localhost | SHA256:EZF7Ch+1IM4IxHmfUS73jOschKDEGiwANAOMfK5yKLU zuul-build-sshkey 2026-01-25 00:21:09.646580 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-25 00:21:09.646610 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-25 00:21:09.646629 | debian-bookworm -> localhost | |@*.. .+o | 2026-01-25 00:21:09.646649 | debian-bookworm -> localhost | |++*.. o.o.. | 2026-01-25 00:21:09.646667 | debian-bookworm -> localhost | |o.=o.=.+++ . | 2026-01-25 00:21:09.646685 | debian-bookworm -> localhost | |.+.o..*+o=o | 2026-01-25 00:21:09.646701 | debian-bookworm -> localhost | |.oo. .oS+o | 2026-01-25 00:21:09.646722 | debian-bookworm -> localhost | |+.E .o. | 2026-01-25 00:21:09.646739 | debian-bookworm -> localhost | |o. o | 2026-01-25 00:21:09.646756 | debian-bookworm -> localhost | | o . | 2026-01-25 00:21:09.646773 | debian-bookworm -> localhost | | o | 2026-01-25 00:21:09.646790 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-25 00:21:09.646868 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.329508 2026-01-25 00:21:09.659546 | 2026-01-25 00:21:09.659634 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-25 00:21:09.703878 | debian-bookworm | ok 2026-01-25 00:21:09.737762 | debian-bookworm | included: /var/lib/zuul/builds/840ceb3088504b26b5b152b0ca9c17ca/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-25 00:21:09.762725 | 2026-01-25 00:21:09.762820 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-25 00:21:09.830481 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:21:09.835766 | 2026-01-25 00:21:09.835859 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-25 00:21:10.581423 | debian-bookworm | changed 2026-01-25 00:21:10.585824 | 2026-01-25 00:21:10.585905 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-25 00:21:10.858036 | debian-bookworm | ok 2026-01-25 00:21:10.863311 | 2026-01-25 00:21:10.863412 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-25 00:21:11.567411 | debian-bookworm | changed 2026-01-25 00:21:11.573872 | 2026-01-25 00:21:11.573965 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-25 00:21:12.343875 | debian-bookworm | changed 2026-01-25 00:21:12.349316 | 2026-01-25 00:21:12.349438 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-25 00:21:12.393963 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:21:12.400415 | 2026-01-25 00:21:12.400508 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-25 00:21:13.445128 | debian-bookworm -> localhost | changed 2026-01-25 00:21:13.453834 | 2026-01-25 00:21:13.453921 | TASK [add-build-sshkey : Add back temp key] 2026-01-25 00:21:14.139464 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/840ceb3088504b26b5b152b0ca9c17ca/work/840ceb3088504b26b5b152b0ca9c17ca_id_rsa (zuul-build-sshkey) 2026-01-25 00:21:14.139642 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024091 2026-01-25 00:21:14.146074 | 2026-01-25 00:21:14.146156 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-25 00:21:14.794441 | debian-bookworm | ok 2026-01-25 00:21:14.799874 | 2026-01-25 00:21:14.799974 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-25 00:21:14.855146 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:21:14.885104 | 2026-01-25 00:21:14.885221 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-25 00:21:15.466886 | debian-bookworm | ok 2026-01-25 00:21:15.481911 | 2026-01-25 00:21:15.482005 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-25 00:21:15.511704 | debian-bookworm | ok 2026-01-25 00:21:15.516478 | 2026-01-25 00:21:15.516556 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-25 00:21:16.059789 | debian-bookworm -> localhost | ok 2026-01-25 00:21:16.066040 | 2026-01-25 00:21:16.066144 | TASK [validate-host : Collect information about the host] 2026-01-25 00:21:17.711351 | debian-bookworm | ok 2026-01-25 00:21:17.732145 | 2026-01-25 00:21:17.732267 | TASK [validate-host : Sanitize hostname] 2026-01-25 00:21:17.872086 | debian-bookworm | ok 2026-01-25 00:21:17.948413 | 2026-01-25 00:21:17.948525 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-25 00:21:19.337801 | debian-bookworm -> localhost | changed 2026-01-25 00:21:19.344118 | 2026-01-25 00:21:19.344216 | TASK [validate-host : Collect information about zuul worker] 2026-01-25 00:21:19.920536 | debian-bookworm | ok 2026-01-25 00:21:19.924921 | 2026-01-25 00:21:19.925003 | TASK [validate-host : Write out all zuul information for each host] 2026-01-25 00:21:20.842188 | debian-bookworm -> localhost | changed 2026-01-25 00:21:20.852109 | 2026-01-25 00:21:20.852206 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-25 00:21:21.197188 | debian-bookworm | ok 2026-01-25 00:21:21.212439 | 2026-01-25 00:21:21.213344 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-25 00:21:22.593256 | debian-bookworm | changed: 2026-01-25 00:21:22.593433 | debian-bookworm | cd+++++++++ src/ 2026-01-25 00:21:22.593468 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-25 00:21:22.593492 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-25 00:21:22.593514 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-25 00:21:22.593534 | debian-bookworm | =6.2.4 2026-01-25 00:21:45.863995 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-25 00:21:45.899126 | debian-bookworm | Collecting chardet>=5.2 2026-01-25 00:21:45.911472 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-25 00:21:45.922408 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 25.5 MB/s eta 0:00:00 2026-01-25 00:21:45.959537 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-25 00:21:45.971168 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-25 00:21:46.026013 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-25 00:21:46.039068 | debian-bookworm | Downloading filelock-3.20.3-py3-none-any.whl (16 kB) 2026-01-25 00:21:46.106647 | debian-bookworm | Collecting packaging>=25 2026-01-25 00:21:46.118433 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-01-25 00:21:46.131718 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 8.3 MB/s eta 0:00:00 2026-01-25 00:21:46.196653 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-25 00:21:46.208175 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-25 00:21:46.263322 | debian-bookworm | Collecting pluggy>=1.6 2026-01-25 00:21:46.274910 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-25 00:21:46.429508 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-25 00:21:46.441514 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-25 00:21:46.593853 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-25 00:21:46.609108 | debian-bookworm | Downloading virtualenv-20.36.1-py3-none-any.whl (6.0 MB) 2026-01-25 00:21:46.923608 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 19.5 MB/s eta 0:00:00 2026-01-25 00:21:47.029581 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-25 00:21:47.042078 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-25 00:21:47.067849 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.9 MB/s eta 0:00:00 2026-01-25 00:21:47.215811 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-25 00:21:48.211985 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.3 packaging-26.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.34.1 virtualenv-20.36.1 2026-01-25 00:21:48.758021 | debian-bookworm | ok: Runtime: 0:00:03.266627 2026-01-25 00:21:48.764327 | 2026-01-25 00:21:48.764467 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-25 00:21:48.799644 | debian-bookworm | ok 2026-01-25 00:21:48.804668 | 2026-01-25 00:21:48.804787 | TASK [ensure-tox : Output tox version] 2026-01-25 00:21:49.454197 | 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-01-25 00:21:49.473680 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-25 00:21:49.879921 | debian-bookworm | ok: Runtime: 0:00:00.317613 2026-01-25 00:21:49.884656 | 2026-01-25 00:21:49.884727 | TASK [ensure-tox : Make global symlink] 2026-01-25 00:21:49.917461 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:21:49.922587 | 2026-01-25 00:21:49.922643 | PLAY RECAP 2026-01-25 00:21:49.922686 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-25 00:21:49.922706 | 2026-01-25 00:21:50.210320 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-25 00:21:50.211309 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-25 00:21:51.952407 | 2026-01-25 00:21:51.952537 | PLAY [all] 2026-01-25 00:21:51.989807 | 2026-01-25 00:21:51.989938 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-25 00:21:52.720375 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-25 00:21:53.037699 | debian-bookworm | ok: Runtime: 0:00:00.025495 2026-01-25 00:21:53.050794 | 2026-01-25 00:21:53.050963 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-25 00:21:53.632247 | debian-bookworm | ok: Runtime: 0:00:00.008412 2026-01-25 00:21:53.637950 | 2026-01-25 00:21:53.638038 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-25 00:21:54.090014 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-25 00:21:54.091870 | debian-bookworm | sudo: a password is required 2026-01-25 00:21:54.199479 | debian-bookworm | ok: Runtime: 0:00:00.019143 2026-01-25 00:21:54.212416 | 2026-01-25 00:21:54.212517 | TASK [tox : Check to see if the constraints file exists] 2026-01-25 00:21:54.247824 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:21:54.252555 | 2026-01-25 00:21:54.252644 | TASK [tox : Fail if constraints file is missing] 2026-01-25 00:21:54.286374 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:21:54.291284 | 2026-01-25 00:21:54.291362 | TASK [tox : Record file location] 2026-01-25 00:21:54.314395 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:21:54.319039 | 2026-01-25 00:21:54.319124 | TASK [tox : Install tox siblings] 2026-01-25 00:21:54.367532 | debian-bookworm | ok 2026-01-25 00:21:54.380098 | debian-bookworm | included: /var/lib/zuul/builds/840ceb3088504b26b5b152b0ca9c17ca/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-25 00:21:54.393698 | 2026-01-25 00:21:54.393810 | TASK [tox : Run tox without tests] 2026-01-25 00:21:55.782315 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-25 00:22:10.162387 | debian-bookworm | test: OK (14.99 seconds) 2026-01-25 00:22:10.162500 | debian-bookworm | congratulations :) (15.02 seconds) 2026-01-25 00:22:10.487010 | debian-bookworm | ok: Runtime: 0:00:15.318169 2026-01-25 00:22:10.496992 | 2026-01-25 00:22:10.497087 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-25 00:22:10.859127 | debian-bookworm | changed 2026-01-25 00:22:10.864309 | 2026-01-25 00:22:10.864430 | TASK [tox : Get tox envlist config] 2026-01-25 00:22:11.902293 | debian-bookworm | ok: Runtime: 0:00:00.292922 2026-01-25 00:22:11.906728 | 2026-01-25 00:22:11.906810 | TASK [tox : Install any sibling python packages] 2026-01-25 00:22:12.385331 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-25 00:22:12.395760 | 2026-01-25 00:22:12.401294 | TASK [tox : Remove tempfile] 2026-01-25 00:22:12.780997 | debian-bookworm | changed 2026-01-25 00:22:12.786515 | 2026-01-25 00:22:12.786603 | TASK [tox : Emit tox command] 2026-01-25 00:22:12.842942 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-25 00:22:12.847062 | 2026-01-25 00:22:12.847146 | TASK [tox : Run tox] 2026-01-25 00:22:13.598925 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-25 00:22:14.177939 | debian-bookworm | ............... 2026-01-25 00:22:14.177981 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-25 00:22:14.177994 | debian-bookworm | Ran 15 tests in 0.163s 2026-01-25 00:22:14.177999 | debian-bookworm | 2026-01-25 00:22:14.178007 | debian-bookworm | OK 2026-01-25 00:22:14.237297 | debian-bookworm | test: OK (0.68=setup[0.04]+cmd[0.64] seconds) 2026-01-25 00:22:14.237358 | debian-bookworm | congratulations :) (0.71 seconds) 2026-01-25 00:22:14.449462 | debian-bookworm | ok: Runtime: 0:00:00.979553 2026-01-25 00:22:14.455646 | 2026-01-25 00:22:14.455965 | TASK [tox : Look for output] 2026-01-25 00:22:15.211015 | debian-bookworm | ok 2026-01-25 00:22:15.272004 | 2026-01-25 00:22:15.272124 | TASK [tox : Return file comments to Zuul] 2026-01-25 00:22:15.345039 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:15.354970 | 2026-01-25 00:22:15.355054 | PLAY RECAP 2026-01-25 00:22:15.355318 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-25 00:22:15.355354 | 2026-01-25 00:22:15.765348 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-25 00:22:15.767379 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-25 00:22:17.509622 | 2026-01-25 00:22:17.509733 | PLAY [all] 2026-01-25 00:22:17.521974 | 2026-01-25 00:22:17.522081 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-25 00:22:17.565490 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:17.570083 | 2026-01-25 00:22:17.570191 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-25 00:22:17.609379 | debian-bookworm | ok 2026-01-25 00:22:17.614027 | 2026-01-25 00:22:17.614109 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-25 00:22:18.677494 | debian-bookworm -> localhost | changed 2026-01-25 00:22:18.684244 | 2026-01-25 00:22:18.684338 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-25 00:22:18.848811 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:18.860256 | 2026-01-25 00:22:18.860358 | TASK [fetch-tox-output : Set envlist fact] 2026-01-25 00:22:18.907193 | debian-bookworm | ok 2026-01-25 00:22:18.911692 | 2026-01-25 00:22:18.911772 | TASK [fetch-tox-output : Get tox version] 2026-01-25 00:22:19.892811 | 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-01-25 00:22:19.911105 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-25 00:22:20.008224 | debian-bookworm | ok: Runtime: 0:00:00.297155 2026-01-25 00:22:20.013491 | 2026-01-25 00:22:20.013591 | TASK [fetch-tox-output : Find all default environments] 2026-01-25 00:22:20.570657 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:20.576779 | 2026-01-25 00:22:20.576887 | TASK [fetch-tox-output : Set envlist fact] 2026-01-25 00:22:20.610298 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:20.617547 | 2026-01-25 00:22:20.617664 | TASK [fetch-tox-output : Find all default environments] 2026-01-25 00:22:21.163567 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:21.168156 | 2026-01-25 00:22:21.168246 | TASK [fetch-tox-output : Set envlist fact] 2026-01-25 00:22:21.224444 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:21.233855 | 2026-01-25 00:22:21.233963 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-25 00:22:21.316517 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:21.326570 | 2026-01-25 00:22:21.326895 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-25 00:22:22.587229 | debian-bookworm | changed: 2026-01-25 00:22:22.587369 | debian-bookworm | created directory /var/lib/zuul/builds/840ceb3088504b26b5b152b0ca9c17ca/work/logs/tox/test 2026-01-25 00:22:22.587420 | debian-bookworm | cd+++++++++ ./ 2026-01-25 00:22:22.587443 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-25 00:22:22.587467 | 2026-01-25 00:22:22.596113 | 2026-01-25 00:22:22.596193 | PLAY RECAP 2026-01-25 00:22:22.596240 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-25 00:22:22.596264 | 2026-01-25 00:22:22.888406 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-25 00:22:22.889330 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-25 00:22:25.342776 | 2026-01-25 00:22:25.342921 | PLAY [all] 2026-01-25 00:22:25.379779 | 2026-01-25 00:22:25.379905 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-25 00:22:25.677356 | debian-bookworm | changed: non-zero return code 2026-01-25 00:22:25.682892 | 2026-01-25 00:22:25.683008 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-25 00:22:25.739638 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:25.745358 | 2026-01-25 00:22:25.745483 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-25 00:22:25.859551 | 2026-01-25 00:22:25.859704 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-25 00:22:25.918744 | 2026-01-25 00:22:25.918912 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-25 00:22:25.952670 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:25.957450 | 2026-01-25 00:22:25.957543 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-25 00:22:25.991590 | 2026-01-25 00:22:25.991773 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-25 00:22:26.015054 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:26.020505 | 2026-01-25 00:22:26.020614 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-25 00:22:26.044059 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:26.049698 | 2026-01-25 00:22:26.049805 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-25 00:22:26.073230 | debian-bookworm | skipping: Conditional result was False 2026-01-25 00:22:26.079453 | 2026-01-25 00:22:26.079529 | PLAY RECAP 2026-01-25 00:22:26.079575 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-25 00:22:26.079600 | 2026-01-25 00:22:26.300168 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-25 00:22:26.301230 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-25 00:22:27.182697 | 2026-01-25 00:22:27.182826 | PLAY [Base post] 2026-01-25 00:22:27.211660 | 2026-01-25 00:22:27.211780 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-25 00:22:28.104086 | debian-bookworm | changed 2026-01-25 00:22:28.116066 | 2026-01-25 00:22:28.116193 | PLAY RECAP 2026-01-25 00:22:28.116264 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-25 00:22:28.116329 | 2026-01-25 00:22:28.360015 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-25 00:22:28.360835 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-25 00:22:30.290340 | 2026-01-25 00:22:30.290505 | PLAY [Base post-logs] 2026-01-25 00:22:30.316814 | 2026-01-25 00:22:30.316943 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-25 00:22:31.239971 | localhost | changed 2026-01-25 00:22:31.249015 | 2026-01-25 00:22:31.249148 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-25 00:22:31.287171 | localhost | ok 2026-01-25 00:22:31.289962 | 2026-01-25 00:22:31.290047 | TASK [Set zuul-log-path fact] 2026-01-25 00:22:31.324744 | localhost | ok 2026-01-25 00:22:31.332159 | 2026-01-25 00:22:31.332259 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-25 00:22:31.372185 | localhost | ok 2026-01-25 00:22:31.376230 | 2026-01-25 00:22:31.376329 | TASK [upload-logs : Create log directories] 2026-01-25 00:22:32.506880 | localhost | changed 2026-01-25 00:22:32.509002 | 2026-01-25 00:22:32.509080 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-25 00:22:33.247800 | localhost -> localhost | ok: Runtime: 0:00:00.005253 2026-01-25 00:22:33.250904 | 2026-01-25 00:22:33.250990 | TASK [upload-logs : Upload logs to log server] 2026-01-25 00:22:33.970978 | localhost | Output suppressed because no_log was given 2026-01-25 00:22:33.977572 | 2026-01-25 00:22:33.978913 | LOOP [upload-logs : Compress console log and json output] 2026-01-25 00:22:34.096964 | localhost | skipping: Conditional result was False 2026-01-25 00:22:34.113768 | localhost | skipping: Conditional result was False 2026-01-25 00:22:34.127370 | 2026-01-25 00:22:34.127488 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-25 00:22:34.203545 | localhost | skipping: Conditional result was False 2026-01-25 00:22:34.205087 | 2026-01-25 00:22:34.209157 | localhost | skipping: Conditional result was False 2026-01-25 00:22:34.220075 | 2026-01-25 00:22:34.220169 | LOOP [upload-logs : Upload console log and json output]