2026-05-29 03:02:50.459714 | Job console starting 2026-05-29 03:02:50.484836 | Updating git repos 2026-05-29 03:02:50.579360 | Cloning repos into workspace 2026-05-29 03:02:50.654239 | Restoring repo states 2026-05-29 03:02:50.690632 | Merging changes 2026-05-29 03:02:50.690652 | Checking out repos 2026-05-29 03:02:50.828828 | Preparing playbooks 2026-05-29 03:02:53.334762 | Running Ansible setup 2026-05-29 03:02:58.436543 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-29 03:02:59.342450 | 2026-05-29 03:02:59.349330 | PLAY [Base pre] 2026-05-29 03:02:59.374018 | 2026-05-29 03:02:59.374131 | TASK [Setup log path fact] 2026-05-29 03:02:59.401337 | debian-bookworm | ok 2026-05-29 03:02:59.428483 | 2026-05-29 03:02:59.429248 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 03:02:59.476304 | debian-bookworm | ok 2026-05-29 03:02:59.503620 | 2026-05-29 03:02:59.504393 | TASK [emit-job-header : Print job information] 2026-05-29 03:02:59.624187 | # Job Information 2026-05-29 03:02:59.624339 | Ansible Version: 2.16.14 2026-05-29 03:02:59.624369 | Job: tox 2026-05-29 03:02:59.624396 | Pipeline: periodic-daily 2026-05-29 03:02:59.624425 | Executor: 521e9411259a 2026-05-29 03:02:59.624442 | Triggered by: https://github.com/osism/openstack-image-manager 2026-05-29 03:02:59.624460 | Event ID: fe15f41f09784e5a887bd60f514324e6 2026-05-29 03:02:59.628495 | 2026-05-29 03:02:59.628697 | LOOP [emit-job-header : Print node information] 2026-05-29 03:02:59.928449 | debian-bookworm | ok: 2026-05-29 03:02:59.928675 | debian-bookworm | # Node Information 2026-05-29 03:02:59.928711 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-29 03:02:59.928737 | debian-bookworm | Hostname: debian 2026-05-29 03:02:59.928759 | debian-bookworm | Username: zuul 2026-05-29 03:02:59.928780 | debian-bookworm | Distro: Debian 12.14 2026-05-29 03:02:59.928811 | debian-bookworm | Provider: regiocloud-a 2026-05-29 03:02:59.928837 | debian-bookworm | Region: 2026-05-29 03:02:59.928859 | debian-bookworm | Label: debian-bookworm 2026-05-29 03:02:59.928880 | debian-bookworm | Product Name: OpenStack Nova 2026-05-29 03:02:59.928900 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedf:7554 2026-05-29 03:02:59.944708 | 2026-05-29 03:02:59.944808 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-29 03:03:00.944565 | debian-bookworm -> localhost | changed 2026-05-29 03:03:00.950347 | 2026-05-29 03:03:00.950475 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-29 03:03:02.419198 | debian-bookworm -> localhost | changed 2026-05-29 03:03:02.427991 | 2026-05-29 03:03:02.428086 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-29 03:03:02.768981 | debian-bookworm -> localhost | ok 2026-05-29 03:03:02.773955 | 2026-05-29 03:03:02.774045 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-29 03:03:02.792018 | debian-bookworm | ok 2026-05-29 03:03:02.829931 | debian-bookworm | included: /var/lib/zuul/builds/c95623c9a7cc41e590607d0fddf87a84/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-29 03:03:02.849957 | 2026-05-29 03:03:02.850053 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-29 03:03:04.167555 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-29 03:03:04.167716 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c95623c9a7cc41e590607d0fddf87a84/work/c95623c9a7cc41e590607d0fddf87a84_id_rsa 2026-05-29 03:03:04.167746 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c95623c9a7cc41e590607d0fddf87a84/work/c95623c9a7cc41e590607d0fddf87a84_id_rsa.pub 2026-05-29 03:03:04.167768 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-29 03:03:04.167787 | debian-bookworm -> localhost | SHA256:tKdjQOj0XBrZq2ntVgTydAB/gXDIjk3rQFcjGnzeKdU zuul-build-sshkey 2026-05-29 03:03:04.167805 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-29 03:03:04.167831 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-29 03:03:04.167849 | debian-bookworm -> localhost | | ...+==+. | 2026-05-29 03:03:04.167866 | debian-bookworm -> localhost | | o+B*=.E. | 2026-05-29 03:03:04.167883 | debian-bookworm -> localhost | | .+O+B=+. | 2026-05-29 03:03:04.167899 | debian-bookworm -> localhost | | oo+*=++. | 2026-05-29 03:03:04.167916 | debian-bookworm -> localhost | | .o=.S.. | 2026-05-29 03:03:04.168017 | debian-bookworm -> localhost | | .= o. | 2026-05-29 03:03:04.168041 | debian-bookworm -> localhost | | + =. | 2026-05-29 03:03:04.168059 | debian-bookworm -> localhost | | . o.. | 2026-05-29 03:03:04.168078 | debian-bookworm -> localhost | | .. | 2026-05-29 03:03:04.168096 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-29 03:03:04.168143 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.608342 2026-05-29 03:03:04.173332 | 2026-05-29 03:03:04.173426 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-29 03:03:04.203609 | debian-bookworm | ok 2026-05-29 03:03:04.217974 | debian-bookworm | included: /var/lib/zuul/builds/c95623c9a7cc41e590607d0fddf87a84/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-29 03:03:04.225462 | 2026-05-29 03:03:04.225543 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-29 03:03:04.248152 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:03:04.253520 | 2026-05-29 03:03:04.253760 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-29 03:03:04.941250 | debian-bookworm | changed 2026-05-29 03:03:04.945552 | 2026-05-29 03:03:04.945623 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-29 03:03:05.239683 | debian-bookworm | ok 2026-05-29 03:03:05.245092 | 2026-05-29 03:03:05.245186 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-29 03:03:06.046046 | debian-bookworm | changed 2026-05-29 03:03:06.054190 | 2026-05-29 03:03:06.054295 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-29 03:03:06.865738 | debian-bookworm | changed 2026-05-29 03:03:06.898117 | 2026-05-29 03:03:06.898789 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-29 03:03:06.945862 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:03:06.976966 | 2026-05-29 03:03:06.977700 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-29 03:03:07.677345 | debian-bookworm -> localhost | changed 2026-05-29 03:03:07.685886 | 2026-05-29 03:03:07.685970 | TASK [add-build-sshkey : Add back temp key] 2026-05-29 03:03:08.532592 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c95623c9a7cc41e590607d0fddf87a84/work/c95623c9a7cc41e590607d0fddf87a84_id_rsa (zuul-build-sshkey) 2026-05-29 03:03:08.532783 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.043782 2026-05-29 03:03:08.539102 | 2026-05-29 03:03:08.539187 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-29 03:03:08.987589 | debian-bookworm | ok 2026-05-29 03:03:08.994822 | 2026-05-29 03:03:08.994961 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-29 03:03:09.038767 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:03:09.047792 | 2026-05-29 03:03:09.047889 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-29 03:03:09.494785 | debian-bookworm | ok 2026-05-29 03:03:09.510531 | 2026-05-29 03:03:09.510634 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-29 03:03:09.549243 | debian-bookworm | ok 2026-05-29 03:03:09.554333 | 2026-05-29 03:03:09.554453 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-29 03:03:09.892535 | debian-bookworm -> localhost | ok 2026-05-29 03:03:09.903791 | 2026-05-29 03:03:09.903919 | TASK [validate-host : Collect information about the host] 2026-05-29 03:03:10.977296 | debian-bookworm | ok 2026-05-29 03:03:10.998102 | 2026-05-29 03:03:10.998208 | TASK [validate-host : Sanitize hostname] 2026-05-29 03:03:11.189512 | debian-bookworm | ok 2026-05-29 03:03:11.262568 | 2026-05-29 03:03:11.262677 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-29 03:03:12.126370 | debian-bookworm -> localhost | changed 2026-05-29 03:03:12.132340 | 2026-05-29 03:03:12.132449 | TASK [validate-host : Collect information about zuul worker] 2026-05-29 03:03:12.728346 | debian-bookworm | ok 2026-05-29 03:03:12.732974 | 2026-05-29 03:03:12.733069 | TASK [validate-host : Write out all zuul information for each host] 2026-05-29 03:03:13.885712 | debian-bookworm -> localhost | changed 2026-05-29 03:03:13.899475 | 2026-05-29 03:03:13.899638 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-29 03:03:14.214195 | debian-bookworm | ok 2026-05-29 03:03:14.220247 | 2026-05-29 03:03:14.220348 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-29 03:03:15.157803 | debian-bookworm | changed: 2026-05-29 03:03:15.157957 | debian-bookworm | cd+++++++++ src/ 2026-05-29 03:03:15.157986 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-29 03:03:15.158005 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-29 03:03:15.158024 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-29 03:03:15.158041 | debian-bookworm | =7.0.3 2026-05-29 03:03:41.290707 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-05-29 03:03:41.337747 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-29 03:03:41.348858 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-29 03:03:41.409532 | debian-bookworm | Collecting filelock>=3.25 2026-05-29 03:03:41.420653 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-29 03:03:41.481347 | debian-bookworm | Collecting packaging>=26 2026-05-29 03:03:41.492212 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-29 03:03:41.502832 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 11.8 MB/s eta 0:00:00 2026-05-29 03:03:41.551301 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-29 03:03:41.562608 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-05-29 03:03:41.604110 | debian-bookworm | Collecting pluggy>=1.6 2026-05-29 03:03:41.615104 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-29 03:03:41.664373 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-29 03:03:41.675759 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-05-29 03:03:41.735736 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-29 03:03:41.747494 | debian-bookworm | Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB) 2026-05-29 03:03:41.785423 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-29 03:03:41.796340 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-29 03:03:41.939196 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-29 03:03:41.953242 | debian-bookworm | Downloading virtualenv-21.4.1-py3-none-any.whl (7.6 MB) 2026-05-29 03:03:42.594789 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 11.9 MB/s eta 0:00:00 2026-05-29 03:03:42.703887 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-29 03:03:42.715813 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-29 03:03:42.742170 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 19.6 MB/s eta 0:00:00 2026-05-29 03:03:42.846738 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-29 03:03:43.552295 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.0 filelock-3.29.0 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.0 tomli-w-1.2.0 tox-4.55.0 virtualenv-21.4.1 2026-05-29 03:03:43.766637 | debian-bookworm | ok: Runtime: 0:00:03.130523 2026-05-29 03:03:43.773207 | 2026-05-29 03:03:43.773329 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-29 03:03:43.814897 | debian-bookworm | ok 2026-05-29 03:03:43.822709 | 2026-05-29 03:03:43.830901 | TASK [ensure-tox : Output tox version] 2026-05-29 03:03:44.467872 | 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-05-29 03:03:44.485457 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-29 03:03:44.895587 | debian-bookworm | ok: Runtime: 0:00:00.329158 2026-05-29 03:03:44.901596 | 2026-05-29 03:03:44.901711 | TASK [ensure-tox : Make global symlink] 2026-05-29 03:03:44.967968 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:03:44.975123 | 2026-05-29 03:03:44.975231 | PLAY RECAP 2026-05-29 03:03:44.975290 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-29 03:03:44.975316 | 2026-05-29 03:03:45.495350 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-29 03:03:45.496484 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-29 03:03:46.704387 | 2026-05-29 03:03:46.704506 | PLAY [all] 2026-05-29 03:03:46.718449 | 2026-05-29 03:03:46.718563 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-29 03:03:47.346176 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-29 03:03:47.758259 | debian-bookworm | ok: Runtime: 0:00:00.028856 2026-05-29 03:03:47.764637 | 2026-05-29 03:03:47.764745 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-29 03:03:48.322807 | debian-bookworm | ok: Runtime: 0:00:00.008696 2026-05-29 03:03:48.328495 | 2026-05-29 03:03:48.328602 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-29 03:03:48.639300 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-29 03:03:48.640796 | debian-bookworm | sudo: a password is required 2026-05-29 03:03:48.881670 | debian-bookworm | ok: Runtime: 0:00:00.019552 2026-05-29 03:03:48.891086 | 2026-05-29 03:03:48.891176 | TASK [tox : Check to see if the constraints file exists] 2026-05-29 03:03:48.939186 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:03:48.944238 | 2026-05-29 03:03:48.944331 | TASK [tox : Fail if constraints file is missing] 2026-05-29 03:03:48.987436 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:03:48.992319 | 2026-05-29 03:03:48.992421 | TASK [tox : Record file location] 2026-05-29 03:03:49.035574 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:03:49.040253 | 2026-05-29 03:03:49.040361 | TASK [tox : Install tox siblings] 2026-05-29 03:03:49.078823 | debian-bookworm | ok 2026-05-29 03:03:49.096711 | debian-bookworm | included: /var/lib/zuul/builds/c95623c9a7cc41e590607d0fddf87a84/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-29 03:03:49.101210 | 2026-05-29 03:03:49.101292 | TASK [tox : Run tox without tests] 2026-05-29 03:03:50.515282 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-05-29 03:04:03.370678 | debian-bookworm | test: OK (13.63 seconds) 2026-05-29 03:04:03.370711 | debian-bookworm | congratulations :) (13.66 seconds) 2026-05-29 03:04:03.657607 | debian-bookworm | ok: Runtime: 0:00:13.946262 2026-05-29 03:04:03.664050 | 2026-05-29 03:04:03.664243 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-29 03:04:04.228507 | debian-bookworm | changed 2026-05-29 03:04:04.234300 | 2026-05-29 03:04:04.234440 | TASK [tox : Detect tox version] 2026-05-29 03:04:04.831902 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-29 03:04:05.289969 | debian-bookworm | ok: Runtime: 0:00:00.317414 2026-05-29 03:04:05.296008 | 2026-05-29 03:04:05.296132 | TASK [tox : Get tox envlist config] 2026-05-29 03:04:06.362512 | debian-bookworm | ok: Runtime: 0:00:00.312577 2026-05-29 03:04:06.368494 | 2026-05-29 03:04:06.368605 | TASK [tox : Install any sibling python packages] 2026-05-29 03:04:06.885832 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-29 03:04:06.892867 | 2026-05-29 03:04:06.892964 | TASK [tox : Remove tempfile] 2026-05-29 03:04:07.569963 | debian-bookworm | changed 2026-05-29 03:04:07.592107 | 2026-05-29 03:04:07.592391 | TASK [tox : Emit tox command] 2026-05-29 03:04:07.670284 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-05-29 03:04:07.679166 | 2026-05-29 03:04:07.679420 | TASK [tox : Run tox] 2026-05-29 03:04:08.305312 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-05-29 03:04:08.976180 | debian-bookworm | ............... 2026-05-29 03:04:08.976219 | debian-bookworm | ---------------------------------------------------------------------- 2026-05-29 03:04:08.976639 | debian-bookworm | Ran 15 tests in 0.166s 2026-05-29 03:04:08.976652 | debian-bookworm | 2026-05-29 03:04:08.976660 | debian-bookworm | OK 2026-05-29 03:04:09.045884 | debian-bookworm | test: OK (0.78=setup[0.04]+cmd[0.74] seconds) 2026-05-29 03:04:09.045941 | debian-bookworm | congratulations :) (0.81 seconds) 2026-05-29 03:04:09.247596 | debian-bookworm | ok: Runtime: 0:00:01.078437 2026-05-29 03:04:09.253637 | 2026-05-29 03:04:09.253732 | TASK [tox : Look for output] 2026-05-29 03:04:09.683629 | debian-bookworm | ok 2026-05-29 03:04:09.732398 | 2026-05-29 03:04:09.732577 | TASK [tox : Return file comments to Zuul] 2026-05-29 03:04:09.796770 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:09.804027 | 2026-05-29 03:04:09.804112 | PLAY RECAP 2026-05-29 03:04:09.804167 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-29 03:04:09.804191 | 2026-05-29 03:04:10.034956 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-29 03:04:10.035944 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-29 03:04:11.560633 | 2026-05-29 03:04:11.560752 | PLAY [all] 2026-05-29 03:04:11.583796 | 2026-05-29 03:04:11.584098 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-29 03:04:11.698428 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:11.703137 | 2026-05-29 03:04:11.703256 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-29 03:04:11.750739 | debian-bookworm | ok 2026-05-29 03:04:11.755498 | 2026-05-29 03:04:11.755602 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-29 03:04:12.553949 | debian-bookworm -> localhost | changed 2026-05-29 03:04:12.561267 | 2026-05-29 03:04:12.561384 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-29 03:04:12.631823 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:12.637277 | 2026-05-29 03:04:12.637393 | TASK [fetch-tox-output : Set envlist fact] 2026-05-29 03:04:12.705724 | debian-bookworm | ok 2026-05-29 03:04:12.711446 | 2026-05-29 03:04:12.711550 | TASK [fetch-tox-output : Get tox version] 2026-05-29 03:04:13.504322 | 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-05-29 03:04:13.520722 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-29 03:04:13.800566 | debian-bookworm | ok: Runtime: 0:00:00.268817 2026-05-29 03:04:13.805072 | 2026-05-29 03:04:13.805163 | TASK [fetch-tox-output : Find all default environments] 2026-05-29 03:04:14.349071 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:14.354056 | 2026-05-29 03:04:14.354151 | TASK [fetch-tox-output : Set envlist fact] 2026-05-29 03:04:14.387264 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:14.392479 | 2026-05-29 03:04:14.392562 | TASK [fetch-tox-output : Find all default environments] 2026-05-29 03:04:14.922211 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:14.927872 | 2026-05-29 03:04:14.927980 | TASK [fetch-tox-output : Set envlist fact] 2026-05-29 03:04:14.961169 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:14.975911 | 2026-05-29 03:04:14.976028 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-29 03:04:15.050053 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:15.059276 | 2026-05-29 03:04:15.059395 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-29 03:04:16.542473 | debian-bookworm | changed: 2026-05-29 03:04:16.542663 | debian-bookworm | created directory /var/lib/zuul/builds/c95623c9a7cc41e590607d0fddf87a84/work/logs/tox/test 2026-05-29 03:04:16.542730 | debian-bookworm | cd+++++++++ ./ 2026-05-29 03:04:16.542759 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-29 03:04:16.542790 | 2026-05-29 03:04:16.558853 | 2026-05-29 03:04:16.558941 | PLAY RECAP 2026-05-29 03:04:16.558989 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-29 03:04:16.559014 | 2026-05-29 03:04:16.757351 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-29 03:04:16.758557 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-29 03:04:18.059161 | 2026-05-29 03:04:18.059297 | PLAY [all] 2026-05-29 03:04:18.100334 | 2026-05-29 03:04:18.100469 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-29 03:04:18.382817 | debian-bookworm | changed: non-zero return code 2026-05-29 03:04:18.389334 | 2026-05-29 03:04:18.389499 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-29 03:04:18.431521 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:18.437808 | 2026-05-29 03:04:18.437919 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-29 03:04:18.488833 | 2026-05-29 03:04:18.489010 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-29 03:04:18.549819 | 2026-05-29 03:04:18.549991 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-29 03:04:18.593479 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:18.599882 | 2026-05-29 03:04:18.599991 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-29 03:04:18.654822 | 2026-05-29 03:04:18.655135 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-29 03:04:18.688655 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:18.695573 | 2026-05-29 03:04:18.695690 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-29 03:04:18.719373 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:18.725291 | 2026-05-29 03:04:18.725417 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-29 03:04:18.768744 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:18.775192 | 2026-05-29 03:04:18.775279 | PLAY RECAP 2026-05-29 03:04:18.775345 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-29 03:04:18.775371 | 2026-05-29 03:04:19.116407 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-29 03:04:19.117353 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-29 03:04:20.249527 | 2026-05-29 03:04:20.249645 | PLAY [Base post-fetch] 2026-05-29 03:04:20.262221 | 2026-05-29 03:04:20.262342 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-29 03:04:20.347286 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:20.352002 | 2026-05-29 03:04:20.352123 | TASK [fetch-output : Set log path for single node] 2026-05-29 03:04:20.399475 | debian-bookworm | ok 2026-05-29 03:04:20.403663 | 2026-05-29 03:04:20.403752 | LOOP [fetch-output : Ensure local output dirs] 2026-05-29 03:04:20.959646 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/c95623c9a7cc41e590607d0fddf87a84/work/logs" 2026-05-29 03:04:21.311540 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c95623c9a7cc41e590607d0fddf87a84/work/artifacts" 2026-05-29 03:04:21.994873 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c95623c9a7cc41e590607d0fddf87a84/work/docs" 2026-05-29 03:04:22.026844 | 2026-05-29 03:04:22.026948 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-29 03:04:23.082005 | debian-bookworm | changed: 2026-05-29 03:04:23.082198 | debian-bookworm | .d..t...... ./ 2026-05-29 03:04:23.082229 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-29 03:04:23.082257 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-29 03:04:23.082280 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-29 03:04:23.082322 | debian-bookworm | changed: All items complete 2026-05-29 03:04:23.082342 | 2026-05-29 03:04:24.099621 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 03:04:25.021440 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 03:04:25.049335 | 2026-05-29 03:04:25.049434 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-29 03:04:25.075586 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:25.080194 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:25.091333 | 2026-05-29 03:04:25.091409 | PLAY RECAP 2026-05-29 03:04:25.091450 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-29 03:04:25.091471 | 2026-05-29 03:04:25.189780 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-29 03:04:25.190654 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 03:04:26.194971 | 2026-05-29 03:04:26.195092 | PLAY [Base post] 2026-05-29 03:04:26.209844 | 2026-05-29 03:04:26.209958 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-29 03:04:26.703434 | debian-bookworm | changed 2026-05-29 03:04:26.710204 | 2026-05-29 03:04:26.710328 | PLAY RECAP 2026-05-29 03:04:26.710389 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-29 03:04:26.710448 | 2026-05-29 03:04:26.844956 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 03:04:26.845769 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-29 03:04:28.037450 | 2026-05-29 03:04:28.037571 | PLAY [Base post-logs] 2026-05-29 03:04:28.070568 | 2026-05-29 03:04:28.070697 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-29 03:04:28.877938 | localhost | changed 2026-05-29 03:04:28.886946 | 2026-05-29 03:04:28.887068 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-29 03:04:28.921809 | localhost | ok 2026-05-29 03:04:28.924649 | 2026-05-29 03:04:28.924729 | TASK [Set zuul-log-path fact] 2026-05-29 03:04:28.938476 | localhost | ok 2026-05-29 03:04:28.944994 | 2026-05-29 03:04:28.945078 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 03:04:28.968803 | localhost | ok 2026-05-29 03:04:28.971165 | 2026-05-29 03:04:28.971239 | TASK [upload-logs : Create log directories] 2026-05-29 03:04:29.778699 | localhost | changed 2026-05-29 03:04:29.781425 | 2026-05-29 03:04:29.781516 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-29 03:04:30.768195 | localhost -> localhost | ok: Runtime: 0:00:00.017252 2026-05-29 03:04:30.771896 | 2026-05-29 03:04:30.772049 | TASK [upload-logs : Upload logs to log server] 2026-05-29 03:04:31.530539 | localhost | Output suppressed because no_log was given 2026-05-29 03:04:31.532168 | 2026-05-29 03:04:31.532252 | LOOP [upload-logs : Compress console log and json output] 2026-05-29 03:04:31.613724 | localhost | skipping: Conditional result was False 2026-05-29 03:04:31.627169 | localhost | skipping: Conditional result was False 2026-05-29 03:04:31.638523 | 2026-05-29 03:04:31.638640 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-29 03:04:31.738667 | localhost | skipping: Conditional result was False 2026-05-29 03:04:31.739261 | 2026-05-29 03:04:31.757982 | localhost | skipping: Conditional result was False 2026-05-29 03:04:31.765362 | 2026-05-29 03:04:31.765481 | LOOP [upload-logs : Upload console log and json output]