2026-06-08 16:58:08.877010 | Job console starting 2026-06-08 16:58:08.901228 | Updating git repos 2026-06-08 16:58:08.958967 | Cloning repos into workspace 2026-06-08 16:58:09.021695 | Restoring repo states 2026-06-08 16:58:09.037152 | Merging changes 2026-06-08 16:58:09.619732 | Checking out repos 2026-06-08 16:58:09.682587 | Preparing playbooks 2026-06-08 16:58:11.093668 | Running Ansible setup 2026-06-08 16:58:17.268782 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-08 16:58:18.340822 | 2026-06-08 16:58:18.340995 | PLAY [Base pre] 2026-06-08 16:58:18.360089 | 2026-06-08 16:58:18.360295 | TASK [Setup log path fact] 2026-06-08 16:58:18.391867 | debian-bookworm | ok 2026-06-08 16:58:18.417921 | 2026-06-08 16:58:18.418091 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 16:58:18.490346 | debian-bookworm | ok 2026-06-08 16:58:18.501800 | 2026-06-08 16:58:18.501944 | TASK [emit-job-header : Print job information] 2026-06-08 16:58:18.580237 | # Job Information 2026-06-08 16:58:18.580450 | Ansible Version: 2.16.14 2026-06-08 16:58:18.580486 | Job: tox 2026-06-08 16:58:18.580519 | Pipeline: check 2026-06-08 16:58:18.580542 | Executor: 521e9411259a 2026-06-08 16:58:18.580563 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1233 2026-06-08 16:58:18.580585 | Event ID: 34497880-635b-11f1-8e90-5bf47e96101f 2026-06-08 16:58:18.588787 | 2026-06-08 16:58:18.588954 | LOOP [emit-job-header : Print node information] 2026-06-08 16:58:18.810925 | debian-bookworm | ok: 2026-06-08 16:58:18.811137 | debian-bookworm | # Node Information 2026-06-08 16:58:18.811172 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-08 16:58:18.811199 | debian-bookworm | Hostname: debian 2026-06-08 16:58:18.811236 | debian-bookworm | Username: zuul 2026-06-08 16:58:18.811258 | debian-bookworm | Distro: Debian 12.14 2026-06-08 16:58:18.811284 | debian-bookworm | Provider: regiocloud-a 2026-06-08 16:58:18.811307 | debian-bookworm | Region: 2026-06-08 16:58:18.811329 | debian-bookworm | Label: debian-bookworm 2026-06-08 16:58:18.811350 | debian-bookworm | Product Name: OpenStack Nova 2026-06-08 16:58:18.811370 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe90:b110 2026-06-08 16:58:18.831677 | 2026-06-08 16:58:18.831829 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-08 16:58:19.664973 | debian-bookworm -> localhost | changed 2026-06-08 16:58:19.674151 | 2026-06-08 16:58:19.674329 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-08 16:58:21.190456 | debian-bookworm -> localhost | changed 2026-06-08 16:58:21.203247 | 2026-06-08 16:58:21.203361 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-08 16:58:21.567829 | debian-bookworm -> localhost | ok 2026-06-08 16:58:21.573932 | 2026-06-08 16:58:21.574024 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-08 16:58:21.613421 | debian-bookworm | ok 2026-06-08 16:58:21.642935 | debian-bookworm | included: /var/lib/zuul/builds/85d4219ac0ea4ea5a01b9a367f755759/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-08 16:58:21.650054 | 2026-06-08 16:58:21.650149 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-08 16:58:23.240025 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-08 16:58:23.240268 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/85d4219ac0ea4ea5a01b9a367f755759/work/85d4219ac0ea4ea5a01b9a367f755759_id_rsa 2026-06-08 16:58:23.240311 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/85d4219ac0ea4ea5a01b9a367f755759/work/85d4219ac0ea4ea5a01b9a367f755759_id_rsa.pub 2026-06-08 16:58:23.240339 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-08 16:58:23.240364 | debian-bookworm -> localhost | SHA256:qnxgRAyoDw6prayZahm0PcNjEEtNGusj9kps4pmnueE zuul-build-sshkey 2026-06-08 16:58:23.240388 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-08 16:58:23.240423 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-08 16:58:23.240447 | debian-bookworm -> localhost | | o++ | 2026-06-08 16:58:23.240470 | debian-bookworm -> localhost | |.o+.o | 2026-06-08 16:58:23.240491 | debian-bookworm -> localhost | |o+o. | 2026-06-08 16:58:23.240511 | debian-bookworm -> localhost | |*+ . | 2026-06-08 16:58:23.240531 | debian-bookworm -> localhost | |*B=. S | 2026-06-08 16:58:23.240557 | debian-bookworm -> localhost | |=+=Bo . | 2026-06-08 16:58:23.240579 | debian-bookworm -> localhost | |o*+o+.. | 2026-06-08 16:58:23.240600 | debian-bookworm -> localhost | |B**o .. | 2026-06-08 16:58:23.240621 | debian-bookworm -> localhost | |OE+ o. | 2026-06-08 16:58:23.240641 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-08 16:58:23.240693 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.703514 2026-06-08 16:58:23.248668 | 2026-06-08 16:58:23.248756 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-08 16:58:23.287728 | debian-bookworm | ok 2026-06-08 16:58:23.298772 | debian-bookworm | included: /var/lib/zuul/builds/85d4219ac0ea4ea5a01b9a367f755759/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-08 16:58:23.318387 | 2026-06-08 16:58:23.318469 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-08 16:58:23.358525 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:58:23.364109 | 2026-06-08 16:58:23.364197 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-08 16:58:24.208953 | debian-bookworm | changed 2026-06-08 16:58:24.214771 | 2026-06-08 16:58:24.214920 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-08 16:58:24.493296 | debian-bookworm | ok 2026-06-08 16:58:24.499995 | 2026-06-08 16:58:24.500129 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-08 16:58:25.264143 | debian-bookworm | changed 2026-06-08 16:58:25.271642 | 2026-06-08 16:58:25.271763 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-08 16:58:25.972863 | debian-bookworm | changed 2026-06-08 16:58:25.982793 | 2026-06-08 16:58:25.983050 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-08 16:58:26.018608 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:58:26.026871 | 2026-06-08 16:58:26.027032 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-08 16:58:26.607813 | debian-bookworm -> localhost | changed 2026-06-08 16:58:26.625553 | 2026-06-08 16:58:26.625706 | TASK [add-build-sshkey : Add back temp key] 2026-06-08 16:58:27.113009 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/85d4219ac0ea4ea5a01b9a367f755759/work/85d4219ac0ea4ea5a01b9a367f755759_id_rsa (zuul-build-sshkey) 2026-06-08 16:58:27.113390 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016424 2026-06-08 16:58:27.122102 | 2026-06-08 16:58:27.122251 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-08 16:58:27.600623 | debian-bookworm | ok 2026-06-08 16:58:27.614430 | 2026-06-08 16:58:27.614577 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-08 16:58:27.669683 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:58:27.681569 | 2026-06-08 16:58:27.681716 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-08 16:58:28.212719 | debian-bookworm | ok 2026-06-08 16:58:28.238242 | 2026-06-08 16:58:28.238451 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-08 16:58:28.296308 | debian-bookworm | ok 2026-06-08 16:58:28.306460 | 2026-06-08 16:58:28.306627 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-08 16:58:28.710729 | debian-bookworm -> localhost | ok 2026-06-08 16:58:28.718195 | 2026-06-08 16:58:28.718362 | TASK [validate-host : Collect information about the host] 2026-06-08 16:58:30.029867 | debian-bookworm | ok 2026-06-08 16:58:30.043742 | 2026-06-08 16:58:30.043896 | TASK [validate-host : Sanitize hostname] 2026-06-08 16:58:30.182567 | debian-bookworm | ok 2026-06-08 16:58:30.298906 | 2026-06-08 16:58:30.299067 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-08 16:58:31.314756 | debian-bookworm -> localhost | changed 2026-06-08 16:58:31.320827 | 2026-06-08 16:58:31.320950 | TASK [validate-host : Collect information about zuul worker] 2026-06-08 16:58:31.808737 | debian-bookworm | ok 2026-06-08 16:58:31.821297 | 2026-06-08 16:58:31.821913 | TASK [validate-host : Write out all zuul information for each host] 2026-06-08 16:58:32.512427 | debian-bookworm -> localhost | changed 2026-06-08 16:58:32.537949 | 2026-06-08 16:58:32.538090 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-08 16:58:32.825809 | debian-bookworm | ok 2026-06-08 16:58:32.834093 | 2026-06-08 16:58:32.834261 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-08 16:58:33.871185 | debian-bookworm | changed: 2026-06-08 16:58:33.871420 | debian-bookworm | cd+++++++++ src/ 2026-06-08 16:58:33.871456 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-08 16:58:33.871483 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-08 16:58:33.871505 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-08 16:58:33.871526 | debian-bookworm | =7.0.3 2026-06-08 16:59:00.208442 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-06-08 16:59:00.286871 | debian-bookworm | Collecting colorama>=0.4.6 2026-06-08 16:59:00.301325 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-08 16:59:00.389310 | debian-bookworm | Collecting filelock>=3.25 2026-06-08 16:59:00.402199 | debian-bookworm | Downloading filelock-3.29.1-py3-none-any.whl (40 kB) 2026-06-08 16:59:00.411662 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 40.8/40.8 kB 5.3 MB/s eta 0:00:00 2026-06-08 16:59:00.472756 | debian-bookworm | Collecting packaging>=26 2026-06-08 16:59:00.485008 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-08 16:59:00.498512 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 10.1 MB/s eta 0:00:00 2026-06-08 16:59:00.555347 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-06-08 16:59:00.567726 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-06-08 16:59:00.616249 | debian-bookworm | Collecting pluggy>=1.6 2026-06-08 16:59:00.628714 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-08 16:59:00.685728 | debian-bookworm | Collecting pyproject-api>=1.10 2026-06-08 16:59:00.698618 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-06-08 16:59:00.745885 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-06-08 16:59:00.758986 | debian-bookworm | Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB) 2026-06-08 16:59:00.809906 | debian-bookworm | Collecting tomli-w>=1.2 2026-06-08 16:59:00.823766 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-06-08 16:59:00.974770 | debian-bookworm | Collecting virtualenv>=21.1 2026-06-08 16:59:00.987640 | debian-bookworm | Downloading virtualenv-21.4.2-py3-none-any.whl (7.6 MB) 2026-06-08 16:59:01.389406 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 19.2 MB/s eta 0:00:00 2026-06-08 16:59:01.507977 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-06-08 16:59:01.521784 | debian-bookworm | Downloading distlib-0.4.2-py2.py3-none-any.whl (470 kB) 2026-06-08 16:59:01.555879 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.5/470.5 kB 15.8 MB/s eta 0:00:00 2026-06-08 16:59:01.675806 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-06-08 16:59:02.565776 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.2 filelock-3.29.1 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.1 virtualenv-21.4.2 2026-06-08 16:59:03.028263 | debian-bookworm | ok: Runtime: 0:00:03.443805 2026-06-08 16:59:03.041855 | 2026-06-08 16:59:03.042043 | TASK [ensure-tox : Export installed tox_executable path] 2026-06-08 16:59:03.076400 | debian-bookworm | ok 2026-06-08 16:59:03.084727 | 2026-06-08 16:59:03.084848 | TASK [ensure-tox : Output tox version] 2026-06-08 16:59:03.630598 | 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-06-08 16:59:03.648587 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-08 16:59:04.114473 | debian-bookworm | ok: Runtime: 0:00:00.331442 2026-06-08 16:59:04.121130 | 2026-06-08 16:59:04.121278 | TASK [ensure-tox : Make global symlink] 2026-06-08 16:59:04.145797 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:04.152642 | 2026-06-08 16:59:04.152731 | PLAY RECAP 2026-06-08 16:59:04.152785 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-06-08 16:59:04.152812 | 2026-06-08 16:59:04.308785 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-06-08 16:59:04.312947 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-08 16:59:05.166005 | 2026-06-08 16:59:05.166183 | PLAY [all] 2026-06-08 16:59:05.189884 | 2026-06-08 16:59:05.190058 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-06-08 16:59:05.695111 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-08 16:59:05.761494 | debian-bookworm | ok: Runtime: 0:00:00.031737 2026-06-08 16:59:05.770251 | 2026-06-08 16:59:05.770411 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-06-08 16:59:06.306232 | debian-bookworm | ok: Runtime: 0:00:00.006462 2026-06-08 16:59:06.323599 | 2026-06-08 16:59:06.323789 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-06-08 16:59:06.618046 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-08 16:59:06.622476 | debian-bookworm | sudo: a password is required 2026-06-08 16:59:06.863357 | debian-bookworm | ok: Runtime: 0:00:00.027372 2026-06-08 16:59:06.881835 | 2026-06-08 16:59:06.881955 | TASK [tox : Check to see if the constraints file exists] 2026-06-08 16:59:06.907370 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:06.913679 | 2026-06-08 16:59:06.913802 | TASK [tox : Fail if constraints file is missing] 2026-06-08 16:59:06.938725 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:06.944976 | 2026-06-08 16:59:06.945095 | TASK [tox : Record file location] 2026-06-08 16:59:06.970417 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:06.977294 | 2026-06-08 16:59:06.977436 | TASK [tox : Install tox siblings] 2026-06-08 16:59:07.010266 | debian-bookworm | ok 2026-06-08 16:59:07.020579 | debian-bookworm | included: /var/lib/zuul/builds/85d4219ac0ea4ea5a01b9a367f755759/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-06-08 16:59:07.026484 | 2026-06-08 16:59:07.026605 | TASK [tox : Run tox without tests] 2026-06-08 16:59:08.302636 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-06-08 16:59:21.879943 | debian-bookworm | test: OK (14.28 seconds) 2026-06-08 16:59:21.880001 | debian-bookworm | congratulations :) (14.30 seconds) 2026-06-08 16:59:22.066685 | debian-bookworm | ok: Runtime: 0:00:14.613542 2026-06-08 16:59:22.083336 | 2026-06-08 16:59:22.083596 | TASK [tox : Create a tempfile to save tox showconfig] 2026-06-08 16:59:22.547083 | debian-bookworm | changed 2026-06-08 16:59:22.553769 | 2026-06-08 16:59:22.553935 | TASK [tox : Detect tox version] 2026-06-08 16:59:23.153904 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-08 16:59:23.587390 | debian-bookworm | ok: Runtime: 0:00:00.362634 2026-06-08 16:59:23.600712 | 2026-06-08 16:59:23.600930 | TASK [tox : Get tox envlist config] 2026-06-08 16:59:24.637941 | debian-bookworm | ok: Runtime: 0:00:00.389334 2026-06-08 16:59:24.652119 | 2026-06-08 16:59:24.652329 | TASK [tox : Install any sibling python packages] 2026-06-08 16:59:25.121288 | debian-bookworm | ok: No setup.cfg, no action needed 2026-06-08 16:59:25.130040 | 2026-06-08 16:59:25.130269 | TASK [tox : Remove tempfile] 2026-06-08 16:59:25.688665 | debian-bookworm | changed 2026-06-08 16:59:25.694650 | 2026-06-08 16:59:25.694776 | TASK [tox : Emit tox command] 2026-06-08 16:59:25.751801 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-06-08 16:59:25.762271 | 2026-06-08 16:59:25.762456 | TASK [tox : Run tox] 2026-06-08 16:59:26.392315 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-06-08 16:59:27.219836 | debian-bookworm | ............... 2026-06-08 16:59:27.219885 | debian-bookworm | ---------------------------------------------------------------------- 2026-06-08 16:59:27.219897 | debian-bookworm | Ran 15 tests in 0.200s 2026-06-08 16:59:27.219902 | debian-bookworm | 2026-06-08 16:59:27.219909 | debian-bookworm | OK 2026-06-08 16:59:27.321149 | debian-bookworm | test: OK (0.98=setup[0.05]+cmd[0.93] seconds) 2026-06-08 16:59:27.321212 | debian-bookworm | congratulations :) (1.01 seconds) 2026-06-08 16:59:27.801991 | debian-bookworm | ok: Runtime: 0:00:01.322539 2026-06-08 16:59:27.815653 | 2026-06-08 16:59:27.815845 | TASK [tox : Look for output] 2026-06-08 16:59:28.226765 | debian-bookworm | ok 2026-06-08 16:59:28.242615 | 2026-06-08 16:59:28.242857 | TASK [tox : Return file comments to Zuul] 2026-06-08 16:59:28.278722 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:28.291652 | 2026-06-08 16:59:28.291808 | PLAY RECAP 2026-06-08 16:59:28.291912 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-06-08 16:59:28.291959 | 2026-06-08 16:59:28.436242 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-08 16:59:28.437425 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-08 16:59:29.231674 | 2026-06-08 16:59:29.231890 | PLAY [all] 2026-06-08 16:59:29.248904 | 2026-06-08 16:59:29.249085 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-06-08 16:59:29.315572 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:29.323135 | 2026-06-08 16:59:29.323379 | TASK [fetch-tox-output : Set tox log path for single node] 2026-06-08 16:59:29.377684 | debian-bookworm | ok 2026-06-08 16:59:29.386062 | 2026-06-08 16:59:29.386272 | TASK [fetch-tox-output : Ensure local tox dir] 2026-06-08 16:59:29.910108 | debian-bookworm -> localhost | changed 2026-06-08 16:59:29.928792 | 2026-06-08 16:59:29.929020 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-06-08 16:59:29.986296 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:30.002217 | 2026-06-08 16:59:30.002528 | TASK [fetch-tox-output : Set envlist fact] 2026-06-08 16:59:30.049657 | debian-bookworm | ok 2026-06-08 16:59:30.058003 | 2026-06-08 16:59:30.058129 | TASK [fetch-tox-output : Get tox version] 2026-06-08 16:59:30.855176 | 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-06-08 16:59:30.873377 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-08 16:59:31.089957 | debian-bookworm | ok: Runtime: 0:00:00.362917 2026-06-08 16:59:31.104593 | 2026-06-08 16:59:31.104807 | TASK [fetch-tox-output : Find all default environments] 2026-06-08 16:59:31.640220 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:31.656842 | 2026-06-08 16:59:31.657023 | TASK [fetch-tox-output : Set envlist fact] 2026-06-08 16:59:31.695147 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:31.706690 | 2026-06-08 16:59:31.706912 | TASK [fetch-tox-output : Find all default environments] 2026-06-08 16:59:32.244605 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:32.251358 | 2026-06-08 16:59:32.251486 | TASK [fetch-tox-output : Set envlist fact] 2026-06-08 16:59:32.306915 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:32.322166 | 2026-06-08 16:59:32.322412 | LOOP [fetch-tox-output : Copy tox logs] 2026-06-08 16:59:32.389114 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:32.404807 | 2026-06-08 16:59:32.404966 | LOOP [fetch-tox-output : Collect tox logs] 2026-06-08 16:59:33.250936 | debian-bookworm | changed: 2026-06-08 16:59:33.251170 | debian-bookworm | created directory /var/lib/zuul/builds/85d4219ac0ea4ea5a01b9a367f755759/work/logs/tox/test 2026-06-08 16:59:33.251226 | debian-bookworm | cd+++++++++ ./ 2026-06-08 16:59:33.251252 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-06-08 16:59:33.251281 | 2026-06-08 16:59:33.258442 | 2026-06-08 16:59:33.258531 | PLAY RECAP 2026-06-08 16:59:33.258583 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-06-08 16:59:33.258606 | 2026-06-08 16:59:33.391929 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-08 16:59:33.392996 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-08 16:59:34.154597 | 2026-06-08 16:59:34.154761 | PLAY [all] 2026-06-08 16:59:34.170858 | 2026-06-08 16:59:34.171000 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-08 16:59:34.412411 | debian-bookworm | changed: non-zero return code 2026-06-08 16:59:34.424086 | 2026-06-08 16:59:34.424335 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-08 16:59:34.460899 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:34.473144 | 2026-06-08 16:59:34.473358 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-08 16:59:34.518537 | 2026-06-08 16:59:34.518872 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-08 16:59:34.563721 | 2026-06-08 16:59:34.563946 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-08 16:59:34.587945 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:34.594255 | 2026-06-08 16:59:34.594378 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-08 16:59:34.637080 | 2026-06-08 16:59:34.637350 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-08 16:59:34.662088 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:34.672047 | 2026-06-08 16:59:34.672215 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-08 16:59:34.708266 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:34.717704 | 2026-06-08 16:59:34.717859 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-08 16:59:34.743275 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:34.751644 | 2026-06-08 16:59:34.751773 | PLAY RECAP 2026-06-08 16:59:34.751832 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-08 16:59:34.751859 | 2026-06-08 16:59:34.920150 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-08 16:59:34.921296 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-08 16:59:35.659935 | 2026-06-08 16:59:35.660111 | PLAY [Base post-fetch] 2026-06-08 16:59:35.675473 | 2026-06-08 16:59:35.675626 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-08 16:59:35.732530 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:59:35.746679 | 2026-06-08 16:59:35.746949 | TASK [fetch-output : Set log path for single node] 2026-06-08 16:59:35.794801 | debian-bookworm | ok 2026-06-08 16:59:35.802951 | 2026-06-08 16:59:35.803102 | LOOP [fetch-output : Ensure local output dirs] 2026-06-08 16:59:36.296313 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/85d4219ac0ea4ea5a01b9a367f755759/work/logs" 2026-06-08 16:59:36.569697 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/85d4219ac0ea4ea5a01b9a367f755759/work/artifacts" 2026-06-08 16:59:36.858754 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/85d4219ac0ea4ea5a01b9a367f755759/work/docs" 2026-06-08 16:59:36.878169 | 2026-06-08 16:59:36.878391 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-08 16:59:37.651714 | debian-bookworm | changed: 2026-06-08 16:59:37.652017 | debian-bookworm | .d..t...... ./ 2026-06-08 16:59:37.652054 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-08 16:59:37.652083 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-08 16:59:37.652110 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-08 16:59:37.652153 | debian-bookworm | changed: All items complete 2026-06-08 16:59:37.652232 | 2026-06-08 16:59:38.314526 | debian-bookworm | changed: .d..t...... ./ 2026-06-08 16:59:38.907672 | debian-bookworm | changed: .d..t...... ./ 2026-06-08 16:59:38.930258 | 2026-06-08 16:59:38.930421 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-08 16:59:39.523001 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007702 2026-06-08 16:59:39.811136 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009844 2026-06-08 16:59:39.822285 | 2026-06-08 16:59:39.822416 | PLAY RECAP 2026-06-08 16:59:39.822476 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-08 16:59:39.822503 | 2026-06-08 16:59:39.973445 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-08 16:59:39.974587 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 16:59:40.753969 | 2026-06-08 16:59:40.754348 | PLAY [Base post] 2026-06-08 16:59:40.769739 | 2026-06-08 16:59:40.769896 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-08 16:59:41.413485 | debian-bookworm | changed 2026-06-08 16:59:41.420724 | 2026-06-08 16:59:41.420838 | PLAY RECAP 2026-06-08 16:59:41.420903 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-08 16:59:41.420971 | 2026-06-08 16:59:41.550671 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 16:59:41.551833 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-08 16:59:42.444301 | 2026-06-08 16:59:42.444826 | PLAY [Base post-logs] 2026-06-08 16:59:42.458055 | 2026-06-08 16:59:42.458238 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-08 16:59:43.002551 | localhost | changed 2026-06-08 16:59:43.019913 | 2026-06-08 16:59:43.020172 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-08 16:59:43.060557 | localhost | ok 2026-06-08 16:59:43.066062 | 2026-06-08 16:59:43.066422 | TASK [Set zuul-log-path fact] 2026-06-08 16:59:43.094728 | localhost | ok 2026-06-08 16:59:43.105991 | 2026-06-08 16:59:43.106260 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 16:59:43.147146 | localhost | ok 2026-06-08 16:59:43.157753 | 2026-06-08 16:59:43.157961 | TASK [upload-logs : Create log directories] 2026-06-08 16:59:43.730982 | localhost | changed 2026-06-08 16:59:43.736961 | 2026-06-08 16:59:43.737132 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-08 16:59:44.311257 | localhost -> localhost | ok: Runtime: 0:00:00.007568 2026-06-08 16:59:44.315801 | 2026-06-08 16:59:44.315939 | TASK [upload-logs : Upload logs to log server] 2026-06-08 16:59:44.932574 | localhost | Output suppressed because no_log was given 2026-06-08 16:59:44.937106 | 2026-06-08 16:59:44.937315 | LOOP [upload-logs : Compress console log and json output] 2026-06-08 16:59:45.002029 | localhost | skipping: Conditional result was False 2026-06-08 16:59:45.007504 | localhost | skipping: Conditional result was False 2026-06-08 16:59:45.020125 | 2026-06-08 16:59:45.020424 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-08 16:59:45.071710 | localhost | skipping: Conditional result was False 2026-06-08 16:59:45.072384 | 2026-06-08 16:59:45.076901 | localhost | skipping: Conditional result was False 2026-06-08 16:59:45.089615 | 2026-06-08 16:59:45.089861 | LOOP [upload-logs : Upload console log and json output]