2026-06-28 03:21:37.101886 | Job console starting 2026-06-28 03:21:37.113426 | Updating git repos 2026-06-28 03:21:37.163722 | Cloning repos into workspace 2026-06-28 03:21:37.256487 | Restoring repo states 2026-06-28 03:21:37.270677 | Merging changes 2026-06-28 03:21:37.270701 | Checking out repos 2026-06-28 03:21:37.378158 | Preparing playbooks 2026-06-28 03:21:38.879054 | Running Ansible setup 2026-06-28 03:21:46.314460 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-28 03:21:47.381198 | 2026-06-28 03:21:47.381402 | PLAY [Base pre] 2026-06-28 03:21:47.420684 | 2026-06-28 03:21:47.420883 | TASK [Setup log path fact] 2026-06-28 03:21:47.458771 | debian-bookworm | ok 2026-06-28 03:21:47.497162 | 2026-06-28 03:21:47.497373 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-28 03:21:47.529161 | debian-bookworm | ok 2026-06-28 03:21:47.550762 | 2026-06-28 03:21:47.550969 | TASK [emit-job-header : Print job information] 2026-06-28 03:21:47.637458 | # Job Information 2026-06-28 03:21:47.637755 | Ansible Version: 2.16.14 2026-06-28 03:21:47.637798 | Job: tox 2026-06-28 03:21:47.637832 | Pipeline: periodic-daily 2026-06-28 03:21:47.637856 | Executor: 521e9411259a 2026-06-28 03:21:47.637877 | Triggered by: https://github.com/osism/openstack-image-manager 2026-06-28 03:21:47.637900 | Event ID: 31ef27f4fb834d12822c44c9d06a5117 2026-06-28 03:21:47.652770 | 2026-06-28 03:21:47.652928 | LOOP [emit-job-header : Print node information] 2026-06-28 03:21:47.839274 | debian-bookworm | ok: 2026-06-28 03:21:47.840221 | debian-bookworm | # Node Information 2026-06-28 03:21:47.840289 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-28 03:21:47.840317 | debian-bookworm | Hostname: debian 2026-06-28 03:21:47.840339 | debian-bookworm | Username: zuul 2026-06-28 03:21:47.840360 | debian-bookworm | Distro: Debian 12.14 2026-06-28 03:21:47.840384 | debian-bookworm | Provider: regiocloud-a 2026-06-28 03:21:47.840404 | debian-bookworm | Region: 2026-06-28 03:21:47.840426 | debian-bookworm | Label: debian-bookworm 2026-06-28 03:21:47.840447 | debian-bookworm | Product Name: OpenStack Nova 2026-06-28 03:21:47.840467 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feda:5f9 2026-06-28 03:21:47.860610 | 2026-06-28 03:21:47.860779 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-28 03:21:48.510351 | debian-bookworm -> localhost | changed 2026-06-28 03:21:48.519059 | 2026-06-28 03:21:48.519216 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-28 03:21:51.534347 | debian-bookworm -> localhost | changed 2026-06-28 03:21:51.563495 | 2026-06-28 03:21:51.565718 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-28 03:21:52.158351 | debian-bookworm -> localhost | ok 2026-06-28 03:21:52.165028 | 2026-06-28 03:21:52.165145 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-28 03:21:52.214532 | debian-bookworm | ok 2026-06-28 03:21:52.243283 | debian-bookworm | included: /var/lib/zuul/builds/6c38d7ef96444bb0b98d40001a79aa4c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-28 03:21:52.261092 | 2026-06-28 03:21:52.261206 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-28 03:21:54.670440 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-28 03:21:54.670685 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6c38d7ef96444bb0b98d40001a79aa4c/work/6c38d7ef96444bb0b98d40001a79aa4c_id_rsa 2026-06-28 03:21:54.670729 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6c38d7ef96444bb0b98d40001a79aa4c/work/6c38d7ef96444bb0b98d40001a79aa4c_id_rsa.pub 2026-06-28 03:21:54.670757 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-28 03:21:54.670783 | debian-bookworm -> localhost | SHA256:hFyVJvRGQmh+9wAouLt/AdmISvwiwlTnPFockNczEHM zuul-build-sshkey 2026-06-28 03:21:54.670806 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-28 03:21:54.670876 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-28 03:21:54.670916 | debian-bookworm -> localhost | | oo++E=.o. | 2026-06-28 03:21:54.670952 | debian-bookworm -> localhost | | .o.=**o+o | 2026-06-28 03:21:54.670987 | debian-bookworm -> localhost | |. .o*B+ ++o | 2026-06-28 03:21:54.671010 | debian-bookworm -> localhost | | +o +*o...o | 2026-06-28 03:21:54.671031 | debian-bookworm -> localhost | |+...o...S. o | 2026-06-28 03:21:54.671056 | debian-bookworm -> localhost | |+o.o . . | 2026-06-28 03:21:54.671091 | debian-bookworm -> localhost | |o .. . | 2026-06-28 03:21:54.671126 | debian-bookworm -> localhost | | . . | 2026-06-28 03:21:54.671150 | debian-bookworm -> localhost | | ... | 2026-06-28 03:21:54.671172 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-28 03:21:54.671228 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.580971 2026-06-28 03:21:54.678411 | 2026-06-28 03:21:54.678507 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-28 03:21:54.698239 | debian-bookworm | ok 2026-06-28 03:21:54.709027 | debian-bookworm | included: /var/lib/zuul/builds/6c38d7ef96444bb0b98d40001a79aa4c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-28 03:21:54.717065 | 2026-06-28 03:21:54.717158 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-28 03:21:54.730853 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:21:54.738887 | 2026-06-28 03:21:54.738995 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-28 03:21:55.374407 | debian-bookworm | changed 2026-06-28 03:21:55.380300 | 2026-06-28 03:21:55.380402 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-28 03:21:55.647914 | debian-bookworm | ok 2026-06-28 03:21:55.658804 | 2026-06-28 03:21:55.658919 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-28 03:21:56.383930 | debian-bookworm | changed 2026-06-28 03:21:56.390730 | 2026-06-28 03:21:56.390855 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-28 03:21:57.020639 | debian-bookworm | changed 2026-06-28 03:21:57.026328 | 2026-06-28 03:21:57.026431 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-28 03:21:57.077854 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:21:57.084800 | 2026-06-28 03:21:57.084929 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-28 03:21:58.103782 | debian-bookworm -> localhost | changed 2026-06-28 03:21:58.124263 | 2026-06-28 03:21:58.124589 | TASK [add-build-sshkey : Add back temp key] 2026-06-28 03:21:58.603205 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6c38d7ef96444bb0b98d40001a79aa4c/work/6c38d7ef96444bb0b98d40001a79aa4c_id_rsa (zuul-build-sshkey) 2026-06-28 03:21:58.604160 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018060 2026-06-28 03:21:58.626304 | 2026-06-28 03:21:58.626447 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-28 03:21:59.057171 | debian-bookworm | ok 2026-06-28 03:21:59.063378 | 2026-06-28 03:21:59.063509 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-28 03:21:59.089086 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:21:59.123425 | 2026-06-28 03:21:59.123649 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-28 03:21:59.629944 | debian-bookworm | ok 2026-06-28 03:21:59.643181 | 2026-06-28 03:21:59.643318 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-28 03:21:59.675424 | debian-bookworm | ok 2026-06-28 03:21:59.682009 | 2026-06-28 03:21:59.682120 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-28 03:22:00.033987 | debian-bookworm -> localhost | ok 2026-06-28 03:22:00.042102 | 2026-06-28 03:22:00.042239 | TASK [validate-host : Collect information about the host] 2026-06-28 03:22:01.236949 | debian-bookworm | ok 2026-06-28 03:22:01.256242 | 2026-06-28 03:22:01.256442 | TASK [validate-host : Sanitize hostname] 2026-06-28 03:22:01.517130 | debian-bookworm | ok 2026-06-28 03:22:01.522675 | 2026-06-28 03:22:01.522794 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-28 03:22:02.259280 | debian-bookworm -> localhost | changed 2026-06-28 03:22:02.266995 | 2026-06-28 03:22:02.267145 | TASK [validate-host : Collect information about zuul worker] 2026-06-28 03:22:02.732831 | debian-bookworm | ok 2026-06-28 03:22:02.740357 | 2026-06-28 03:22:02.740491 | TASK [validate-host : Write out all zuul information for each host] 2026-06-28 03:22:03.511619 | debian-bookworm -> localhost | changed 2026-06-28 03:22:03.530988 | 2026-06-28 03:22:03.531137 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-28 03:22:03.825157 | debian-bookworm | ok 2026-06-28 03:22:03.838490 | 2026-06-28 03:22:03.838711 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-28 03:22:04.785140 | debian-bookworm | changed: 2026-06-28 03:22:04.785377 | debian-bookworm | cd+++++++++ src/ 2026-06-28 03:22:04.785413 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-28 03:22:04.785437 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-28 03:22:04.785459 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-28 03:22:04.785480 | debian-bookworm | =7.0.3 2026-06-28 03:22:41.426067 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-06-28 03:22:41.492367 | debian-bookworm | Collecting colorama>=0.4.6 2026-06-28 03:22:41.503674 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-28 03:22:41.580397 | debian-bookworm | Collecting filelock>=3.25 2026-06-28 03:22:41.591353 | debian-bookworm | Downloading filelock-3.29.4-py3-none-any.whl (42 kB) 2026-06-28 03:22:41.598665 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 42.8/42.8 kB 6.9 MB/s eta 0:00:00 2026-06-28 03:22:41.662418 | debian-bookworm | Collecting packaging>=26 2026-06-28 03:22:41.673529 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-28 03:22:41.683641 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 12.5 MB/s eta 0:00:00 2026-06-28 03:22:41.736151 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-06-28 03:22:41.747099 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-06-28 03:22:41.805073 | debian-bookworm | Collecting pluggy>=1.6 2026-06-28 03:22:41.816418 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-28 03:22:41.865156 | debian-bookworm | Collecting pyproject-api>=1.10 2026-06-28 03:22:41.876173 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-06-28 03:22:41.926742 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-06-28 03:22:41.938487 | debian-bookworm | Downloading python_discovery-1.4.2-py3-none-any.whl (33 kB) 2026-06-28 03:22:41.974719 | debian-bookworm | Collecting tomli-w>=1.2 2026-06-28 03:22:41.985195 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-06-28 03:22:42.124104 | debian-bookworm | Collecting virtualenv>=21.1 2026-06-28 03:22:42.134612 | debian-bookworm | Downloading virtualenv-21.5.1-py3-none-any.whl (4.6 MB) 2026-06-28 03:22:42.393691 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.6/4.6 MB 17.9 MB/s eta 0:00:00 2026-06-28 03:22:42.520196 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-06-28 03:22:42.532066 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-06-28 03:22:42.570603 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 14.2 MB/s eta 0:00:00 2026-06-28 03:22:42.677900 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-06-28 03:22:43.421756 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.29.4 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.2 tomli-w-1.2.0 tox-4.56.1 virtualenv-21.5.1 2026-06-28 03:22:43.724333 | debian-bookworm | ok: Runtime: 0:00:03.019991 2026-06-28 03:22:43.731088 | 2026-06-28 03:22:43.731197 | TASK [ensure-tox : Export installed tox_executable path] 2026-06-28 03:22:43.774322 | debian-bookworm | ok 2026-06-28 03:22:43.781646 | 2026-06-28 03:22:43.781839 | TASK [ensure-tox : Output tox version] 2026-06-28 03:22:44.336207 | 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-28 03:22:44.353152 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-28 03:22:44.823500 | debian-bookworm | ok: Runtime: 0:00:00.325575 2026-06-28 03:22:44.830571 | 2026-06-28 03:22:44.830724 | TASK [ensure-tox : Make global symlink] 2026-06-28 03:22:44.865986 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:22:44.874596 | 2026-06-28 03:22:44.874714 | PLAY RECAP 2026-06-28 03:22:44.874792 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-06-28 03:22:44.874822 | 2026-06-28 03:22:45.101319 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-06-28 03:22:45.102695 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-28 03:22:46.081173 | 2026-06-28 03:22:46.081386 | PLAY [all] 2026-06-28 03:22:46.099465 | 2026-06-28 03:22:46.099681 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-06-28 03:22:46.602267 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-28 03:22:46.646512 | debian-bookworm | ok: Runtime: 0:00:00.027297 2026-06-28 03:22:46.654590 | 2026-06-28 03:22:46.654796 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-06-28 03:22:47.186810 | debian-bookworm | ok: Runtime: 0:00:00.006014 2026-06-28 03:22:47.203027 | 2026-06-28 03:22:47.203284 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-06-28 03:22:47.535043 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-28 03:22:47.536422 | debian-bookworm | sudo: a password is required 2026-06-28 03:22:47.750370 | debian-bookworm | ok: Runtime: 0:00:00.018988 2026-06-28 03:22:47.769906 | 2026-06-28 03:22:47.770053 | TASK [tox : Check to see if the constraints file exists] 2026-06-28 03:22:47.797033 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:22:47.804254 | 2026-06-28 03:22:47.804394 | TASK [tox : Fail if constraints file is missing] 2026-06-28 03:22:47.842318 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:22:47.850725 | 2026-06-28 03:22:47.850918 | TASK [tox : Record file location] 2026-06-28 03:22:47.897143 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:22:47.905110 | 2026-06-28 03:22:47.905265 | TASK [tox : Install tox siblings] 2026-06-28 03:22:47.940172 | debian-bookworm | ok 2026-06-28 03:22:47.950378 | debian-bookworm | included: /var/lib/zuul/builds/6c38d7ef96444bb0b98d40001a79aa4c/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-06-28 03:22:47.958504 | 2026-06-28 03:22:47.958711 | TASK [tox : Run tox without tests] 2026-06-28 03:22:49.192877 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-06-28 03:23:01.635612 | debian-bookworm | test: OK (13.12 seconds) 2026-06-28 03:23:01.635680 | debian-bookworm | congratulations :) (13.15 seconds) 2026-06-28 03:23:01.996121 | debian-bookworm | ok: Runtime: 0:00:13.429200 2026-06-28 03:23:02.002239 | 2026-06-28 03:23:02.002362 | TASK [tox : Create a tempfile to save tox showconfig] 2026-06-28 03:23:02.560676 | debian-bookworm | changed 2026-06-28 03:23:02.566709 | 2026-06-28 03:23:02.566855 | TASK [tox : Detect tox version] 2026-06-28 03:23:03.094830 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-28 03:23:03.607989 | debian-bookworm | ok: Runtime: 0:00:00.287376 2026-06-28 03:23:03.614163 | 2026-06-28 03:23:03.614287 | TASK [tox : Get tox envlist config] 2026-06-28 03:23:04.640401 | debian-bookworm | ok: Runtime: 0:00:00.318377 2026-06-28 03:23:04.652479 | 2026-06-28 03:23:04.652711 | TASK [tox : Install any sibling python packages] 2026-06-28 03:23:05.127187 | debian-bookworm | ok: No setup.cfg, no action needed 2026-06-28 03:23:05.133297 | 2026-06-28 03:23:05.133419 | TASK [tox : Remove tempfile] 2026-06-28 03:23:05.750556 | debian-bookworm | changed 2026-06-28 03:23:05.757817 | 2026-06-28 03:23:05.757941 | TASK [tox : Emit tox command] 2026-06-28 03:23:05.808180 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-06-28 03:23:05.813561 | 2026-06-28 03:23:05.813689 | TASK [tox : Run tox] 2026-06-28 03:23:06.421434 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-06-28 03:23:07.155043 | debian-bookworm | .......................... 2026-06-28 03:23:07.155082 | debian-bookworm | ---------------------------------------------------------------------- 2026-06-28 03:23:07.155093 | debian-bookworm | Ran 26 tests in 0.224s 2026-06-28 03:23:07.155098 | debian-bookworm | 2026-06-28 03:23:07.155103 | debian-bookworm | OK 2026-06-28 03:23:07.225054 | debian-bookworm | test: OK (0.84=setup[0.04]+cmd[0.80] seconds) 2026-06-28 03:23:07.225150 | debian-bookworm | congratulations :) (0.88 seconds) 2026-06-28 03:23:07.355625 | debian-bookworm | ok: Runtime: 0:00:01.178718 2026-06-28 03:23:07.361820 | 2026-06-28 03:23:07.361941 | TASK [tox : Look for output] 2026-06-28 03:23:07.797001 | debian-bookworm | ok 2026-06-28 03:23:07.817829 | 2026-06-28 03:23:07.818007 | TASK [tox : Return file comments to Zuul] 2026-06-28 03:23:07.864847 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:07.873139 | 2026-06-28 03:23:07.873264 | PLAY RECAP 2026-06-28 03:23:07.873323 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-06-28 03:23:07.873349 | 2026-06-28 03:23:08.089549 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-28 03:23:08.091335 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-28 03:23:09.063405 | 2026-06-28 03:23:09.063617 | PLAY [all] 2026-06-28 03:23:09.081603 | 2026-06-28 03:23:09.081791 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-06-28 03:23:09.137204 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:09.144641 | 2026-06-28 03:23:09.144839 | TASK [fetch-tox-output : Set tox log path for single node] 2026-06-28 03:23:09.216847 | debian-bookworm | ok 2026-06-28 03:23:09.223391 | 2026-06-28 03:23:09.223549 | TASK [fetch-tox-output : Ensure local tox dir] 2026-06-28 03:23:09.950212 | debian-bookworm -> localhost | changed 2026-06-28 03:23:09.958892 | 2026-06-28 03:23:09.959050 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-06-28 03:23:10.004191 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:10.010996 | 2026-06-28 03:23:10.011155 | TASK [fetch-tox-output : Set envlist fact] 2026-06-28 03:23:10.053671 | debian-bookworm | ok 2026-06-28 03:23:10.059851 | 2026-06-28 03:23:10.059988 | TASK [fetch-tox-output : Get tox version] 2026-06-28 03:23:10.757077 | 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-28 03:23:10.773949 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-28 03:23:11.091870 | debian-bookworm | ok: Runtime: 0:00:00.292709 2026-06-28 03:23:11.098379 | 2026-06-28 03:23:11.098504 | TASK [fetch-tox-output : Find all default environments] 2026-06-28 03:23:11.635444 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:11.642416 | 2026-06-28 03:23:11.642587 | TASK [fetch-tox-output : Set envlist fact] 2026-06-28 03:23:11.669447 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:11.676823 | 2026-06-28 03:23:11.676985 | TASK [fetch-tox-output : Find all default environments] 2026-06-28 03:23:12.222803 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:12.233738 | 2026-06-28 03:23:12.233900 | TASK [fetch-tox-output : Set envlist fact] 2026-06-28 03:23:12.310596 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:12.328234 | 2026-06-28 03:23:12.328401 | LOOP [fetch-tox-output : Copy tox logs] 2026-06-28 03:23:12.421511 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:12.438689 | 2026-06-28 03:23:12.438982 | LOOP [fetch-tox-output : Collect tox logs] 2026-06-28 03:23:13.843779 | debian-bookworm | changed: 2026-06-28 03:23:13.844014 | debian-bookworm | created directory /var/lib/zuul/builds/6c38d7ef96444bb0b98d40001a79aa4c/work/logs/tox/test 2026-06-28 03:23:13.844049 | debian-bookworm | cd+++++++++ ./ 2026-06-28 03:23:13.844075 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-06-28 03:23:13.844106 | 2026-06-28 03:23:13.858422 | 2026-06-28 03:23:13.858574 | PLAY RECAP 2026-06-28 03:23:13.858638 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-06-28 03:23:13.858663 | 2026-06-28 03:23:14.298697 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-28 03:23:14.300445 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-28 03:23:15.471357 | 2026-06-28 03:23:15.471591 | PLAY [all] 2026-06-28 03:23:15.488420 | 2026-06-28 03:23:15.488619 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-28 03:23:15.757031 | debian-bookworm | changed: non-zero return code 2026-06-28 03:23:15.765960 | 2026-06-28 03:23:15.766179 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-28 03:23:15.809572 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:15.826107 | 2026-06-28 03:23:15.826290 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-28 03:23:15.875047 | 2026-06-28 03:23:15.875331 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-28 03:23:15.928276 | 2026-06-28 03:23:15.928611 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-28 03:23:15.956234 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:15.980674 | 2026-06-28 03:23:15.980888 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-28 03:23:16.030936 | 2026-06-28 03:23:16.031248 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-28 03:23:16.079369 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:16.091805 | 2026-06-28 03:23:16.091987 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-28 03:23:16.119747 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:16.137114 | 2026-06-28 03:23:16.137312 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-28 03:23:16.168877 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:16.176621 | 2026-06-28 03:23:16.176741 | PLAY RECAP 2026-06-28 03:23:16.176801 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-28 03:23:16.176827 | 2026-06-28 03:23:16.352656 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-28 03:23:16.354866 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-28 03:23:17.635089 | 2026-06-28 03:23:17.635295 | PLAY [Base post-fetch] 2026-06-28 03:23:17.653138 | 2026-06-28 03:23:17.653329 | TASK [diagnose-network : Ensure log directory exists] 2026-06-28 03:23:18.177114 | debian-bookworm | ok 2026-06-28 03:23:18.192791 | 2026-06-28 03:23:18.193017 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-06-28 03:23:30.950042 | debian-bookworm | ok: Runtime: 0:00:06.050981 2026-06-28 03:23:30.961397 | 2026-06-28 03:23:30.961638 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-06-28 03:23:37.041509 | debian-bookworm | ok: Runtime: 0:00:00.007690 2026-06-28 03:23:37.050357 | 2026-06-28 03:23:37.050564 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-06-28 03:23:43.191861 | debian-bookworm | ok: Runtime: 0:00:00.008818 2026-06-28 03:23:43.219341 | 2026-06-28 03:23:43.219510 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-28 03:23:43.301376 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:43.307533 | 2026-06-28 03:23:43.307651 | TASK [fetch-output : Set log path for single node] 2026-06-28 03:23:43.368067 | debian-bookworm | ok 2026-06-28 03:23:43.397857 | 2026-06-28 03:23:43.398000 | LOOP [fetch-output : Ensure local output dirs] 2026-06-28 03:23:44.036557 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/6c38d7ef96444bb0b98d40001a79aa4c/work/logs" 2026-06-28 03:23:44.819600 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6c38d7ef96444bb0b98d40001a79aa4c/work/artifacts" 2026-06-28 03:23:45.416453 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6c38d7ef96444bb0b98d40001a79aa4c/work/docs" 2026-06-28 03:23:45.431858 | 2026-06-28 03:23:45.432307 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-28 03:23:46.174149 | debian-bookworm | changed: 2026-06-28 03:23:46.174350 | debian-bookworm | .d..t...... ./ 2026-06-28 03:23:46.174385 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-28 03:23:46.174411 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-28 03:23:46.174442 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-28 03:23:46.174464 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-28 03:23:46.174485 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-28 03:23:46.174561 | debian-bookworm | changed: All items complete 2026-06-28 03:23:46.174595 | 2026-06-28 03:23:46.819284 | debian-bookworm | changed: .d..t...... ./ 2026-06-28 03:23:47.431792 | debian-bookworm | changed: .d..t...... ./ 2026-06-28 03:23:47.443938 | 2026-06-28 03:23:47.444048 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-28 03:23:47.490980 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:47.495330 | debian-bookworm | skipping: Conditional result was False 2026-06-28 03:23:47.505778 | 2026-06-28 03:23:47.505865 | PLAY RECAP 2026-06-28 03:23:47.505916 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-28 03:23:47.505940 | 2026-06-28 03:23:47.735225 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-28 03:23:47.736226 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-28 03:23:48.789360 | 2026-06-28 03:23:48.789504 | PLAY [Base post] 2026-06-28 03:23:48.818618 | 2026-06-28 03:23:48.818760 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-28 03:23:49.554287 | debian-bookworm | changed 2026-06-28 03:23:49.560981 | 2026-06-28 03:23:49.561113 | PLAY RECAP 2026-06-28 03:23:49.561182 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-28 03:23:49.561246 | 2026-06-28 03:23:49.743948 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-28 03:23:49.745705 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-28 03:23:50.788051 | 2026-06-28 03:23:50.788245 | PLAY [Base post-logs] 2026-06-28 03:23:50.802427 | 2026-06-28 03:23:50.802611 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-28 03:23:51.368029 | localhost | changed 2026-06-28 03:23:51.387636 | 2026-06-28 03:23:51.387856 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-28 03:23:51.445616 | localhost | ok 2026-06-28 03:23:51.449256 | 2026-06-28 03:23:51.449385 | TASK [Set zuul-log-path fact] 2026-06-28 03:23:51.468275 | localhost | ok 2026-06-28 03:23:51.480901 | 2026-06-28 03:23:51.481069 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-28 03:23:51.579947 | localhost | ok 2026-06-28 03:23:51.583951 | 2026-06-28 03:23:51.584088 | TASK [upload-logs : Create log directories] 2026-06-28 03:23:52.500575 | localhost | changed 2026-06-28 03:23:52.503954 | 2026-06-28 03:23:52.504083 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-28 03:23:53.164000 | localhost -> localhost | ok: Runtime: 0:00:00.013863 2026-06-28 03:23:53.169852 | 2026-06-28 03:23:53.169999 | TASK [upload-logs : Upload logs to log server] 2026-06-28 03:23:54.189727 | localhost | Output suppressed because no_log was given 2026-06-28 03:23:54.196677 | 2026-06-28 03:23:54.196825 | LOOP [upload-logs : Compress console log and json output] 2026-06-28 03:23:54.260314 | localhost | skipping: Conditional result was False 2026-06-28 03:23:54.264446 | localhost | skipping: Conditional result was False 2026-06-28 03:23:54.274164 | 2026-06-28 03:23:54.274363 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-28 03:23:54.341224 | localhost | skipping: Conditional result was False 2026-06-28 03:23:54.341793 | 2026-06-28 03:23:54.346249 | localhost | skipping: Conditional result was False 2026-06-28 03:23:54.358382 | 2026-06-28 03:23:54.358541 | LOOP [upload-logs : Upload console log and json output]