2026-03-22 00:30:39.886378 | Job console starting 2026-03-22 00:30:39.901007 | Updating git repos 2026-03-22 00:30:39.929406 | Cloning repos into workspace 2026-03-22 00:30:39.982772 | Restoring repo states 2026-03-22 00:30:39.993738 | Merging changes 2026-03-22 00:30:40.629829 | Checking out repos 2026-03-22 00:30:40.676534 | Preparing playbooks 2026-03-22 00:30:41.344087 | Running Ansible setup 2026-03-22 00:30:45.684077 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-22 00:30:46.436762 | 2026-03-22 00:30:46.436937 | PLAY [Base pre] 2026-03-22 00:30:46.453399 | 2026-03-22 00:30:46.453540 | TASK [Setup log path fact] 2026-03-22 00:30:46.483359 | debian-bookworm | ok 2026-03-22 00:30:46.498982 | 2026-03-22 00:30:46.499133 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-22 00:30:46.541839 | debian-bookworm | ok 2026-03-22 00:30:46.552508 | 2026-03-22 00:30:46.552623 | TASK [emit-job-header : Print job information] 2026-03-22 00:30:46.608771 | # Job Information 2026-03-22 00:30:46.609059 | Ansible Version: 2.16.14 2026-03-22 00:30:46.609119 | Job: tox 2026-03-22 00:30:46.609175 | Pipeline: check 2026-03-22 00:30:46.609216 | Executor: 521e9411259a 2026-03-22 00:30:46.609252 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1189 2026-03-22 00:30:46.609342 | Event ID: 89155230-2585-11f1-8074-058e86125574 2026-03-22 00:30:46.616557 | 2026-03-22 00:30:46.616707 | LOOP [emit-job-header : Print node information] 2026-03-22 00:30:46.751374 | debian-bookworm | ok: 2026-03-22 00:30:46.751727 | debian-bookworm | # Node Information 2026-03-22 00:30:46.751795 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-22 00:30:46.751840 | debian-bookworm | Hostname: debian 2026-03-22 00:30:46.751878 | debian-bookworm | Username: zuul 2026-03-22 00:30:46.751914 | debian-bookworm | Distro: Debian 12.13 2026-03-22 00:30:46.751956 | debian-bookworm | Provider: regiocloud-a 2026-03-22 00:30:46.751993 | debian-bookworm | Region: 2026-03-22 00:30:46.752030 | debian-bookworm | Label: debian-bookworm 2026-03-22 00:30:46.752065 | debian-bookworm | Product Name: OpenStack Nova 2026-03-22 00:30:46.752100 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb7:8ab 2026-03-22 00:30:46.768787 | 2026-03-22 00:30:46.768908 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-22 00:30:47.331036 | debian-bookworm -> localhost | changed 2026-03-22 00:30:47.347902 | 2026-03-22 00:30:47.348075 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-22 00:30:48.448714 | debian-bookworm -> localhost | changed 2026-03-22 00:30:48.468736 | 2026-03-22 00:30:48.468880 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-22 00:30:48.759050 | debian-bookworm -> localhost | ok 2026-03-22 00:30:48.774025 | 2026-03-22 00:30:48.774204 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-22 00:30:48.821213 | debian-bookworm | ok 2026-03-22 00:30:48.844757 | debian-bookworm | included: /var/lib/zuul/builds/988aa1cc143a49ec82d780978e2f3400/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-22 00:30:48.851010 | 2026-03-22 00:30:48.851122 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-22 00:30:50.448243 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-22 00:30:50.448542 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/988aa1cc143a49ec82d780978e2f3400/work/988aa1cc143a49ec82d780978e2f3400_id_rsa 2026-03-22 00:30:50.448582 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/988aa1cc143a49ec82d780978e2f3400/work/988aa1cc143a49ec82d780978e2f3400_id_rsa.pub 2026-03-22 00:30:50.448608 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-22 00:30:50.448635 | debian-bookworm -> localhost | SHA256:UrEOMjFp/LzuwcUtahE13+y+tCNxPfTcc5FmpaaFA5A zuul-build-sshkey 2026-03-22 00:30:50.448658 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-22 00:30:50.448692 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-22 00:30:50.448713 | debian-bookworm -> localhost | | .o. =o | 2026-03-22 00:30:50.448734 | debian-bookworm -> localhost | | +o .E=.o .| 2026-03-22 00:30:50.448754 | debian-bookworm -> localhost | | .ooo o ..o. .o| 2026-03-22 00:30:50.448774 | debian-bookworm -> localhost | | oo* . .o == | 2026-03-22 00:30:50.448793 | debian-bookworm -> localhost | | o.S . .Booo| 2026-03-22 00:30:50.448822 | debian-bookworm -> localhost | | ..= ...o o.=| 2026-03-22 00:30:50.448843 | debian-bookworm -> localhost | | .= oo .o| 2026-03-22 00:30:50.448862 | debian-bookworm -> localhost | | ... ...o | 2026-03-22 00:30:50.448883 | debian-bookworm -> localhost | | .. .o. | 2026-03-22 00:30:50.448903 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-22 00:30:50.448961 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.027588 2026-03-22 00:30:50.455759 | 2026-03-22 00:30:50.455881 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-22 00:30:50.485077 | debian-bookworm | ok 2026-03-22 00:30:50.495339 | debian-bookworm | included: /var/lib/zuul/builds/988aa1cc143a49ec82d780978e2f3400/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-22 00:30:50.504880 | 2026-03-22 00:30:50.505011 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-22 00:30:50.530621 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:30:50.537717 | 2026-03-22 00:30:50.537837 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-22 00:30:51.223159 | debian-bookworm | changed 2026-03-22 00:30:51.230545 | 2026-03-22 00:30:51.230677 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-22 00:30:51.513049 | debian-bookworm | ok 2026-03-22 00:30:51.526305 | 2026-03-22 00:30:51.526491 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-22 00:30:52.230757 | debian-bookworm | changed 2026-03-22 00:30:52.239542 | 2026-03-22 00:30:52.239710 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-22 00:30:52.946817 | debian-bookworm | changed 2026-03-22 00:30:52.956108 | 2026-03-22 00:30:52.956244 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-22 00:30:52.982329 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:30:52.994532 | 2026-03-22 00:30:52.994703 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-22 00:30:53.467016 | debian-bookworm -> localhost | changed 2026-03-22 00:30:53.486120 | 2026-03-22 00:30:53.486342 | TASK [add-build-sshkey : Add back temp key] 2026-03-22 00:30:53.818552 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/988aa1cc143a49ec82d780978e2f3400/work/988aa1cc143a49ec82d780978e2f3400_id_rsa (zuul-build-sshkey) 2026-03-22 00:30:53.819509 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011849 2026-03-22 00:30:53.840794 | 2026-03-22 00:30:53.840936 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-22 00:30:54.320682 | debian-bookworm | ok 2026-03-22 00:30:54.327482 | 2026-03-22 00:30:54.327638 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-22 00:30:54.363354 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:30:54.384306 | 2026-03-22 00:30:54.384481 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-22 00:30:54.838218 | debian-bookworm | ok 2026-03-22 00:30:54.852495 | 2026-03-22 00:30:54.852619 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-22 00:30:54.900000 | debian-bookworm | ok 2026-03-22 00:30:54.905468 | 2026-03-22 00:30:54.905579 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-22 00:30:55.202956 | debian-bookworm -> localhost | ok 2026-03-22 00:30:55.210010 | 2026-03-22 00:30:55.210133 | TASK [validate-host : Collect information about the host] 2026-03-22 00:30:56.332215 | debian-bookworm | ok 2026-03-22 00:30:56.347142 | 2026-03-22 00:30:56.347308 | TASK [validate-host : Sanitize hostname] 2026-03-22 00:30:56.477228 | debian-bookworm | ok 2026-03-22 00:30:56.551983 | 2026-03-22 00:30:56.552162 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-22 00:30:57.253149 | debian-bookworm -> localhost | changed 2026-03-22 00:30:57.259616 | 2026-03-22 00:30:57.259728 | TASK [validate-host : Collect information about zuul worker] 2026-03-22 00:30:57.711796 | debian-bookworm | ok 2026-03-22 00:30:57.718799 | 2026-03-22 00:30:57.718983 | TASK [validate-host : Write out all zuul information for each host] 2026-03-22 00:30:58.363572 | debian-bookworm -> localhost | changed 2026-03-22 00:30:58.374330 | 2026-03-22 00:30:58.374483 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-22 00:30:58.677633 | debian-bookworm | ok 2026-03-22 00:30:58.684480 | 2026-03-22 00:30:58.684610 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-22 00:30:59.547953 | debian-bookworm | changed: 2026-03-22 00:30:59.548267 | debian-bookworm | cd+++++++++ src/ 2026-03-22 00:30:59.548329 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-22 00:30:59.548371 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-22 00:30:59.548409 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-03-22 00:30:59.548444 | debian-bookworm | =7.0.3 2026-03-22 00:31:21.790584 | debian-bookworm | Downloading cachetools-7.0.5-py3-none-any.whl (13 kB) 2026-03-22 00:31:21.887028 | debian-bookworm | Collecting colorama>=0.4.6 2026-03-22 00:31:21.900432 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-03-22 00:31:21.962171 | debian-bookworm | Collecting filelock>=3.25 2026-03-22 00:31:21.975330 | debian-bookworm | Downloading filelock-3.25.2-py3-none-any.whl (26 kB) 2026-03-22 00:31:22.024790 | debian-bookworm | Collecting packaging>=26 2026-03-22 00:31:22.037985 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-22 00:31:22.045676 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 12.7 MB/s eta 0:00:00 2026-03-22 00:31:22.093954 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-03-22 00:31:22.106824 | debian-bookworm | Downloading platformdirs-4.9.4-py3-none-any.whl (21 kB) 2026-03-22 00:31:22.171929 | debian-bookworm | Collecting pluggy>=1.6 2026-03-22 00:31:22.185909 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-22 00:31:22.340981 | debian-bookworm | Collecting pyproject-api>=1.10 2026-03-22 00:31:22.354872 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-03-22 00:31:22.390367 | debian-bookworm | Collecting tomli-w>=1.2 2026-03-22 00:31:22.403879 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-03-22 00:31:22.665489 | debian-bookworm | Collecting virtualenv>=21.1 2026-03-22 00:31:22.679944 | debian-bookworm | Downloading virtualenv-21.2.0-py3-none-any.whl (5.8 MB) 2026-03-22 00:31:22.903236 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 26.8 MB/s eta 0:00:00 2026-03-22 00:31:22.982753 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-03-22 00:31:22.995850 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-03-22 00:31:23.017242 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 25.3 MB/s eta 0:00:00 2026-03-22 00:31:23.079760 | debian-bookworm | Collecting python-discovery>=1 2026-03-22 00:31:23.094517 | debian-bookworm | Downloading python_discovery-1.2.0-py3-none-any.whl (31 kB) 2026-03-22 00:31:23.256119 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-03-22 00:31:23.990068 | debian-bookworm | Successfully installed cachetools-7.0.5 colorama-0.4.6 distlib-0.4.0 filelock-3.25.2 packaging-26.0 platformdirs-4.9.4 pluggy-1.6.0 pyproject-api-1.10.0 python-discovery-1.2.0 tomli-w-1.2.0 tox-4.50.3 virtualenv-21.2.0 2026-03-22 00:31:24.218625 | debian-bookworm | ok: Runtime: 0:00:03.150441 2026-03-22 00:31:24.233554 | 2026-03-22 00:31:24.233730 | TASK [ensure-tox : Export installed tox_executable path] 2026-03-22 00:31:24.293936 | debian-bookworm | ok 2026-03-22 00:31:24.300634 | 2026-03-22 00:31:24.300769 | TASK [ensure-tox : Output tox version] 2026-03-22 00:31:24.828235 | 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-22 00:31:24.847189 | debian-bookworm | 4.50.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-22 00:31:25.336410 | debian-bookworm | ok: Runtime: 0:00:00.312738 2026-03-22 00:31:25.343594 | 2026-03-22 00:31:25.343732 | TASK [ensure-tox : Make global symlink] 2026-03-22 00:31:25.369089 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:25.387265 | 2026-03-22 00:31:25.387471 | PLAY RECAP 2026-03-22 00:31:25.387575 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-03-22 00:31:25.387619 | 2026-03-22 00:31:25.538361 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-03-22 00:31:25.542360 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-22 00:31:26.328851 | 2026-03-22 00:31:26.329017 | PLAY [all] 2026-03-22 00:31:26.344653 | 2026-03-22 00:31:26.344793 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-03-22 00:31:26.871669 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-22 00:31:27.378251 | debian-bookworm | ok: Runtime: 0:00:00.031270 2026-03-22 00:31:27.384556 | 2026-03-22 00:31:27.384694 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-03-22 00:31:27.914703 | debian-bookworm | ok: Runtime: 0:00:00.007011 2026-03-22 00:31:27.926901 | 2026-03-22 00:31:27.927056 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-03-22 00:31:28.225085 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-22 00:31:28.226570 | debian-bookworm | sudo: a password is required 2026-03-22 00:31:28.459350 | debian-bookworm | ok: Runtime: 0:00:00.018322 2026-03-22 00:31:28.481047 | 2026-03-22 00:31:28.481201 | TASK [tox : Check to see if the constraints file exists] 2026-03-22 00:31:28.519531 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:28.533467 | 2026-03-22 00:31:28.533653 | TASK [tox : Fail if constraints file is missing] 2026-03-22 00:31:28.580509 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:28.597205 | 2026-03-22 00:31:28.597486 | TASK [tox : Record file location] 2026-03-22 00:31:28.634471 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:28.646979 | 2026-03-22 00:31:28.647135 | TASK [tox : Install tox siblings] 2026-03-22 00:31:28.675135 | debian-bookworm | ok 2026-03-22 00:31:28.686908 | debian-bookworm | included: /var/lib/zuul/builds/988aa1cc143a49ec82d780978e2f3400/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-03-22 00:31:28.692910 | 2026-03-22 00:31:28.693016 | TASK [tox : Run tox without tests] 2026-03-22 00:31:29.824861 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-03-22 00:31:44.633723 | debian-bookworm | test: OK (15.39 seconds) 2026-03-22 00:31:44.633808 | debian-bookworm | congratulations :) (15.42 seconds) 2026-03-22 00:31:44.741907 | debian-bookworm | ok: Runtime: 0:00:15.700862 2026-03-22 00:31:44.750937 | 2026-03-22 00:31:44.751086 | TASK [tox : Create a tempfile to save tox showconfig] 2026-03-22 00:31:45.169818 | debian-bookworm | changed 2026-03-22 00:31:45.175357 | 2026-03-22 00:31:45.175467 | TASK [tox : Get tox envlist config] 2026-03-22 00:31:46.222378 | debian-bookworm | ok: Runtime: 0:00:00.353207 2026-03-22 00:31:46.236629 | 2026-03-22 00:31:46.236820 | TASK [tox : Install any sibling python packages] 2026-03-22 00:31:46.691889 | debian-bookworm | ok: No setup.cfg, no action needed 2026-03-22 00:31:46.700516 | 2026-03-22 00:31:46.700647 | TASK [tox : Remove tempfile] 2026-03-22 00:31:47.164331 | debian-bookworm | changed 2026-03-22 00:31:47.173010 | 2026-03-22 00:31:47.173142 | TASK [tox : Emit tox command] 2026-03-22 00:31:47.230740 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-03-22 00:31:47.239603 | 2026-03-22 00:31:47.239742 | TASK [tox : Run tox] 2026-03-22 00:31:47.874145 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-03-22 00:31:48.610932 | debian-bookworm | ............... 2026-03-22 00:31:48.610982 | debian-bookworm | ---------------------------------------------------------------------- 2026-03-22 00:31:48.610999 | debian-bookworm | Ran 15 tests in 0.171s 2026-03-22 00:31:48.611004 | debian-bookworm | 2026-03-22 00:31:48.611011 | debian-bookworm | OK 2026-03-22 00:31:48.700868 | debian-bookworm | test: OK (0.87=setup[0.05]+cmd[0.82] seconds) 2026-03-22 00:31:48.700931 | debian-bookworm | congratulations :) (0.90 seconds) 2026-03-22 00:31:48.820709 | debian-bookworm | ok: Runtime: 0:00:01.185738 2026-03-22 00:31:48.835375 | 2026-03-22 00:31:48.835558 | TASK [tox : Look for output] 2026-03-22 00:31:49.236771 | debian-bookworm | ok 2026-03-22 00:31:49.256403 | 2026-03-22 00:31:49.256591 | TASK [tox : Return file comments to Zuul] 2026-03-22 00:31:49.302605 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:49.316935 | 2026-03-22 00:31:49.317098 | PLAY RECAP 2026-03-22 00:31:49.317186 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-03-22 00:31:49.317247 | 2026-03-22 00:31:49.507469 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-22 00:31:49.508755 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-22 00:31:50.280421 | 2026-03-22 00:31:50.280582 | PLAY [all] 2026-03-22 00:31:50.295900 | 2026-03-22 00:31:50.296155 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-03-22 00:31:50.353601 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:50.367811 | 2026-03-22 00:31:50.368012 | TASK [fetch-tox-output : Set tox log path for single node] 2026-03-22 00:31:50.425511 | debian-bookworm | ok 2026-03-22 00:31:50.433765 | 2026-03-22 00:31:50.433916 | TASK [fetch-tox-output : Ensure local tox dir] 2026-03-22 00:31:50.945710 | debian-bookworm -> localhost | changed 2026-03-22 00:31:50.958165 | 2026-03-22 00:31:50.958373 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-03-22 00:31:51.007745 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:51.019340 | 2026-03-22 00:31:51.019528 | TASK [fetch-tox-output : Set envlist fact] 2026-03-22 00:31:51.056472 | debian-bookworm | ok 2026-03-22 00:31:51.064855 | 2026-03-22 00:31:51.064989 | TASK [fetch-tox-output : Get tox version] 2026-03-22 00:31:51.728084 | 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-22 00:31:51.746856 | debian-bookworm | 4.50.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-22 00:31:52.097042 | debian-bookworm | ok: Runtime: 0:00:00.300988 2026-03-22 00:31:52.110675 | 2026-03-22 00:31:52.110905 | TASK [fetch-tox-output : Find all default environments] 2026-03-22 00:31:52.647324 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:52.662112 | 2026-03-22 00:31:52.662320 | TASK [fetch-tox-output : Set envlist fact] 2026-03-22 00:31:52.697958 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:52.709714 | 2026-03-22 00:31:52.709868 | TASK [fetch-tox-output : Find all default environments] 2026-03-22 00:31:53.241550 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:53.257055 | 2026-03-22 00:31:53.257270 | TASK [fetch-tox-output : Set envlist fact] 2026-03-22 00:31:53.293477 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:53.301021 | 2026-03-22 00:31:53.301134 | LOOP [fetch-tox-output : Copy tox logs] 2026-03-22 00:31:53.348058 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:53.362863 | 2026-03-22 00:31:53.362979 | LOOP [fetch-tox-output : Collect tox logs] 2026-03-22 00:31:54.216224 | debian-bookworm | changed: 2026-03-22 00:31:54.216635 | debian-bookworm | created directory /var/lib/zuul/builds/988aa1cc143a49ec82d780978e2f3400/work/logs/tox/test 2026-03-22 00:31:54.216725 | debian-bookworm | cd+++++++++ ./ 2026-03-22 00:31:54.216788 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-03-22 00:31:54.216856 | 2026-03-22 00:31:54.234423 | 2026-03-22 00:31:54.234591 | PLAY RECAP 2026-03-22 00:31:54.234670 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-03-22 00:31:54.234706 | 2026-03-22 00:31:54.397553 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-22 00:31:54.400067 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-22 00:31:55.149333 | 2026-03-22 00:31:55.149497 | PLAY [all] 2026-03-22 00:31:55.166522 | 2026-03-22 00:31:55.166739 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-22 00:31:55.409875 | debian-bookworm | changed: non-zero return code 2026-03-22 00:31:55.418638 | 2026-03-22 00:31:55.418820 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-22 00:31:55.446222 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:55.462480 | 2026-03-22 00:31:55.462650 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-22 00:31:55.511440 | 2026-03-22 00:31:55.511744 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-22 00:31:55.563485 | 2026-03-22 00:31:55.563786 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-22 00:31:55.589473 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:55.603702 | 2026-03-22 00:31:55.603921 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-22 00:31:55.642298 | 2026-03-22 00:31:55.642673 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-22 00:31:55.659263 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:55.669256 | 2026-03-22 00:31:55.669409 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-22 00:31:55.684878 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:55.695416 | 2026-03-22 00:31:55.695679 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-22 00:31:55.711717 | debian-bookworm | skipping: Conditional result was False 2026-03-22 00:31:55.721905 | 2026-03-22 00:31:55.722010 | PLAY RECAP 2026-03-22 00:31:55.722081 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-22 00:31:55.722121 | 2026-03-22 00:31:55.852687 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-22 00:31:55.855001 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-22 00:31:56.610991 | 2026-03-22 00:31:56.611165 | PLAY [Base post] 2026-03-22 00:31:56.624887 | 2026-03-22 00:31:56.625016 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-22 00:31:57.186241 | debian-bookworm | changed 2026-03-22 00:31:57.198633 | 2026-03-22 00:31:57.198772 | PLAY RECAP 2026-03-22 00:31:57.198866 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-22 00:31:57.198940 | 2026-03-22 00:31:57.321598 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-22 00:31:57.324365 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-22 00:31:58.109901 | 2026-03-22 00:31:58.110076 | PLAY [Base post-logs] 2026-03-22 00:31:58.121498 | 2026-03-22 00:31:58.121646 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-22 00:31:58.615241 | localhost | changed 2026-03-22 00:31:58.625668 | 2026-03-22 00:31:58.625820 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-22 00:31:58.662046 | localhost | ok 2026-03-22 00:31:58.665331 | 2026-03-22 00:31:58.665434 | TASK [Set zuul-log-path fact] 2026-03-22 00:31:58.691242 | localhost | ok 2026-03-22 00:31:58.699776 | 2026-03-22 00:31:58.699893 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-22 00:31:58.736120 | localhost | ok 2026-03-22 00:31:58.741282 | 2026-03-22 00:31:58.741440 | TASK [upload-logs : Create log directories] 2026-03-22 00:31:59.297069 | localhost | changed 2026-03-22 00:31:59.300488 | 2026-03-22 00:31:59.300609 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-22 00:31:59.845707 | localhost -> localhost | ok: Runtime: 0:00:00.004967 2026-03-22 00:31:59.853838 | 2026-03-22 00:31:59.854167 | TASK [upload-logs : Upload logs to log server] 2026-03-22 00:32:00.470350 | localhost | Output suppressed because no_log was given 2026-03-22 00:32:00.473411 | 2026-03-22 00:32:00.473578 | LOOP [upload-logs : Compress console log and json output] 2026-03-22 00:32:00.535615 | localhost | skipping: Conditional result was False 2026-03-22 00:32:00.542027 | localhost | skipping: Conditional result was False 2026-03-22 00:32:00.559009 | 2026-03-22 00:32:00.559283 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-22 00:32:00.612607 | localhost | skipping: Conditional result was False 2026-03-22 00:32:00.613420 | 2026-03-22 00:32:00.616550 | localhost | skipping: Conditional result was False 2026-03-22 00:32:00.631958 | 2026-03-22 00:32:00.632101 | LOOP [upload-logs : Upload console log and json output]