2026-07-08 03:06:12.941185 | Job console starting 2026-07-08 03:06:12.951710 | Updating git repos 2026-07-08 03:06:13.024122 | Cloning repos into workspace 2026-07-08 03:06:13.136501 | Restoring repo states 2026-07-08 03:06:13.166862 | Merging changes 2026-07-08 03:06:13.166884 | Checking out repos 2026-07-08 03:06:13.311907 | Preparing playbooks 2026-07-08 03:06:15.030481 | Running Ansible setup 2026-07-08 03:06:22.281422 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-08 03:06:24.520798 | 2026-07-08 03:06:24.520953 | PLAY [Base pre] 2026-07-08 03:06:24.628016 | 2026-07-08 03:06:24.628158 | TASK [Setup log path fact] 2026-07-08 03:06:24.675288 | debian-bookworm | ok 2026-07-08 03:06:24.710434 | 2026-07-08 03:06:24.710582 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-08 03:06:24.781341 | debian-bookworm | ok 2026-07-08 03:06:24.837346 | 2026-07-08 03:06:24.838571 | TASK [emit-job-header : Print job information] 2026-07-08 03:06:24.936852 | # Job Information 2026-07-08 03:06:24.937709 | Ansible Version: 2.16.14 2026-07-08 03:06:24.937960 | Job: tox 2026-07-08 03:06:24.938016 | Pipeline: periodic-daily 2026-07-08 03:06:24.938043 | Executor: 521e9411259a 2026-07-08 03:06:24.938065 | Triggered by: https://github.com/osism/openstack-image-manager 2026-07-08 03:06:24.938088 | Event ID: 02578de8c3b24bdfb2ccc1ec2fe9060a 2026-07-08 03:06:24.948205 | 2026-07-08 03:06:24.962964 | LOOP [emit-job-header : Print node information] 2026-07-08 03:06:25.246852 | debian-bookworm | ok: 2026-07-08 03:06:25.247078 | debian-bookworm | # Node Information 2026-07-08 03:06:25.247113 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-08 03:06:25.247138 | debian-bookworm | Hostname: debian 2026-07-08 03:06:25.247161 | debian-bookworm | Username: zuul 2026-07-08 03:06:25.247181 | debian-bookworm | Distro: Debian 12.14 2026-07-08 03:06:25.247221 | debian-bookworm | Provider: regiocloud-a 2026-07-08 03:06:25.247244 | debian-bookworm | Region: 2026-07-08 03:06:25.247266 | debian-bookworm | Label: debian-bookworm 2026-07-08 03:06:25.247286 | debian-bookworm | Product Name: OpenStack Nova 2026-07-08 03:06:25.247305 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef6:d34 2026-07-08 03:06:25.259557 | 2026-07-08 03:06:25.259674 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-08 03:06:26.229884 | debian-bookworm -> localhost | changed 2026-07-08 03:06:26.238504 | 2026-07-08 03:06:26.238620 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-08 03:06:27.929854 | debian-bookworm -> localhost | changed 2026-07-08 03:06:27.954371 | 2026-07-08 03:06:27.954555 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-08 03:06:28.509394 | debian-bookworm -> localhost | ok 2026-07-08 03:06:28.519977 | 2026-07-08 03:06:28.520104 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-08 03:06:28.633685 | debian-bookworm | ok 2026-07-08 03:06:28.678151 | debian-bookworm | included: /var/lib/zuul/builds/db611c8299cb49099d270060cc7ee86d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-08 03:06:28.701768 | 2026-07-08 03:06:28.701929 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-08 03:06:32.432050 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-08 03:06:32.432255 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/db611c8299cb49099d270060cc7ee86d/work/db611c8299cb49099d270060cc7ee86d_id_rsa 2026-07-08 03:06:32.432294 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/db611c8299cb49099d270060cc7ee86d/work/db611c8299cb49099d270060cc7ee86d_id_rsa.pub 2026-07-08 03:06:32.432320 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-08 03:06:32.432342 | debian-bookworm -> localhost | SHA256:Awyk5HKNJChDYfRQy7xyDVToQfE6IbeNB+R/am3OyvU zuul-build-sshkey 2026-07-08 03:06:32.432364 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-08 03:06:32.432400 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-08 03:06:32.432434 | debian-bookworm -> localhost | |=**B*. | 2026-07-08 03:06:32.432466 | debian-bookworm -> localhost | |==O*oo | 2026-07-08 03:06:32.432495 | debian-bookworm -> localhost | |oo*@o.o | 2026-07-08 03:06:32.432526 | debian-bookworm -> localhost | | oo.% . | 2026-07-08 03:06:32.432557 | debian-bookworm -> localhost | | . B = .S | 2026-07-08 03:06:32.432592 | debian-bookworm -> localhost | | o o + . | 2026-07-08 03:06:32.432626 | debian-bookworm -> localhost | | o + | 2026-07-08 03:06:32.432659 | debian-bookworm -> localhost | | o = . | 2026-07-08 03:06:32.432692 | debian-bookworm -> localhost | | o.o E | 2026-07-08 03:06:32.432726 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-08 03:06:32.432811 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.551842 2026-07-08 03:06:32.442234 | 2026-07-08 03:06:32.442347 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-08 03:06:32.480752 | debian-bookworm | ok 2026-07-08 03:06:32.494497 | debian-bookworm | included: /var/lib/zuul/builds/db611c8299cb49099d270060cc7ee86d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-08 03:06:32.502984 | 2026-07-08 03:06:32.503168 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-08 03:06:32.526368 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:06:32.532284 | 2026-07-08 03:06:32.532372 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-08 03:06:33.267712 | debian-bookworm | changed 2026-07-08 03:06:33.273692 | 2026-07-08 03:06:33.273795 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-08 03:06:33.534577 | debian-bookworm | ok 2026-07-08 03:06:33.540728 | 2026-07-08 03:06:33.540833 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-08 03:06:34.243956 | debian-bookworm | changed 2026-07-08 03:06:34.249342 | 2026-07-08 03:06:34.249446 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-08 03:06:34.955942 | debian-bookworm | changed 2026-07-08 03:06:34.961489 | 2026-07-08 03:06:34.961582 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-08 03:06:34.985001 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:06:34.991347 | 2026-07-08 03:06:34.991435 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-08 03:06:35.513890 | debian-bookworm -> localhost | changed 2026-07-08 03:06:35.525072 | 2026-07-08 03:06:35.525179 | TASK [add-build-sshkey : Add back temp key] 2026-07-08 03:06:35.995439 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/db611c8299cb49099d270060cc7ee86d/work/db611c8299cb49099d270060cc7ee86d_id_rsa (zuul-build-sshkey) 2026-07-08 03:06:35.995702 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015115 2026-07-08 03:06:36.003884 | 2026-07-08 03:06:36.003985 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-08 03:06:36.720451 | debian-bookworm | ok 2026-07-08 03:06:36.737145 | 2026-07-08 03:06:36.737374 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-08 03:06:36.835315 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:06:36.870036 | 2026-07-08 03:06:36.870249 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-08 03:06:37.667554 | debian-bookworm | ok 2026-07-08 03:06:37.686352 | 2026-07-08 03:06:37.686521 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-08 03:06:37.769349 | debian-bookworm | ok 2026-07-08 03:06:37.775137 | 2026-07-08 03:06:37.775279 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-08 03:06:38.165574 | debian-bookworm -> localhost | ok 2026-07-08 03:06:38.178483 | 2026-07-08 03:06:38.178628 | TASK [validate-host : Collect information about the host] 2026-07-08 03:06:39.455478 | debian-bookworm | ok 2026-07-08 03:06:39.483524 | 2026-07-08 03:06:39.483642 | TASK [validate-host : Sanitize hostname] 2026-07-08 03:06:39.626216 | debian-bookworm | ok 2026-07-08 03:06:39.631547 | 2026-07-08 03:06:39.631650 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-08 03:06:40.203969 | debian-bookworm -> localhost | changed 2026-07-08 03:06:40.209881 | 2026-07-08 03:06:40.209969 | TASK [validate-host : Collect information about zuul worker] 2026-07-08 03:06:40.615300 | debian-bookworm | ok 2026-07-08 03:06:40.622219 | 2026-07-08 03:06:40.622327 | TASK [validate-host : Write out all zuul information for each host] 2026-07-08 03:06:42.051942 | debian-bookworm -> localhost | changed 2026-07-08 03:06:42.093049 | 2026-07-08 03:06:42.093525 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-08 03:06:42.400879 | debian-bookworm | ok 2026-07-08 03:06:42.410163 | 2026-07-08 03:06:42.410298 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-08 03:06:43.917365 | debian-bookworm | changed: 2026-07-08 03:06:43.917602 | debian-bookworm | cd+++++++++ src/ 2026-07-08 03:06:43.917637 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-08 03:06:43.917661 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-08 03:06:43.917684 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-08 03:06:43.917705 | debian-bookworm | =7.0.3 2026-07-08 03:07:25.660863 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-08 03:07:25.703426 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-08 03:07:25.715413 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-08 03:07:25.781915 | debian-bookworm | Collecting filelock>=3.25 2026-07-08 03:07:25.793206 | debian-bookworm | Downloading filelock-3.29.6-py3-none-any.whl (45 kB) 2026-07-08 03:07:25.801866 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.5/45.5 kB 6.5 MB/s eta 0:00:00 2026-07-08 03:07:25.847586 | debian-bookworm | Collecting packaging>=26 2026-07-08 03:07:25.858937 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-08 03:07:25.870033 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 12.1 MB/s eta 0:00:00 2026-07-08 03:07:25.920995 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-08 03:07:25.933321 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-07-08 03:07:25.977843 | debian-bookworm | Collecting pluggy>=1.6 2026-07-08 03:07:25.990094 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-08 03:07:26.043727 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-08 03:07:26.058957 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-08 03:07:26.108164 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-07-08 03:07:26.119295 | debian-bookworm | Downloading python_discovery-1.4.3-py3-none-any.whl (33 kB) 2026-07-08 03:07:26.177326 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-08 03:07:26.190656 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-08 03:07:26.361092 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-08 03:07:26.372611 | debian-bookworm | Downloading virtualenv-21.6.0-py3-none-any.whl (5.5 MB) 2026-07-08 03:07:26.639443 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 21.1 MB/s eta 0:00:00 2026-07-08 03:07:26.746411 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-08 03:07:26.758133 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-08 03:07:26.783778 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 22.5 MB/s eta 0:00:00 2026-07-08 03:07:26.894129 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-08 03:07:27.728719 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.29.6 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.3 tomli-w-1.2.0 tox-4.56.2 virtualenv-21.6.0 2026-07-08 03:07:27.993249 | debian-bookworm | ok: Runtime: 0:00:03.051011 2026-07-08 03:07:28.000475 | 2026-07-08 03:07:28.000572 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-08 03:07:28.141200 | debian-bookworm | ok 2026-07-08 03:07:28.150351 | 2026-07-08 03:07:28.150464 | TASK [ensure-tox : Output tox version] 2026-07-08 03:07:28.973120 | 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-07-08 03:07:28.991465 | debian-bookworm | 4.56.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-08 03:07:29.237044 | debian-bookworm | ok: Runtime: 0:00:00.344363 2026-07-08 03:07:29.243267 | 2026-07-08 03:07:29.243355 | TASK [ensure-tox : Make global symlink] 2026-07-08 03:07:29.292972 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:07:29.303004 | 2026-07-08 03:07:29.303085 | PLAY RECAP 2026-07-08 03:07:29.303140 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-08 03:07:29.303179 | 2026-07-08 03:07:30.120683 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-08 03:07:30.121806 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-08 03:07:31.879295 | 2026-07-08 03:07:31.881834 | PLAY [all] 2026-07-08 03:07:31.910539 | 2026-07-08 03:07:31.910671 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-08 03:07:32.487236 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-08 03:07:32.549550 | debian-bookworm | ok: Runtime: 0:00:00.032506 2026-07-08 03:07:32.559723 | 2026-07-08 03:07:32.559839 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-08 03:07:33.095403 | debian-bookworm | ok: Runtime: 0:00:00.007372 2026-07-08 03:07:33.102671 | 2026-07-08 03:07:33.102864 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-08 03:07:33.437789 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-08 03:07:33.441425 | debian-bookworm | sudo: a password is required 2026-07-08 03:07:33.665713 | debian-bookworm | ok: Runtime: 0:00:00.028797 2026-07-08 03:07:33.684635 | 2026-07-08 03:07:33.684736 | TASK [tox : Check to see if the constraints file exists] 2026-07-08 03:07:33.719036 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:07:33.726628 | 2026-07-08 03:07:33.727082 | TASK [tox : Fail if constraints file is missing] 2026-07-08 03:07:33.752060 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:07:33.758097 | 2026-07-08 03:07:33.758212 | TASK [tox : Record file location] 2026-07-08 03:07:33.782653 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:07:33.789065 | 2026-07-08 03:07:33.789157 | TASK [tox : Install tox siblings] 2026-07-08 03:07:33.841450 | debian-bookworm | ok 2026-07-08 03:07:33.856543 | debian-bookworm | included: /var/lib/zuul/builds/db611c8299cb49099d270060cc7ee86d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-08 03:07:33.867033 | 2026-07-08 03:07:33.867148 | TASK [tox : Run tox without tests] 2026-07-08 03:07:35.290837 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-08 03:07:49.398810 | debian-bookworm | test: OK (14.90 seconds) 2026-07-08 03:07:49.398876 | debian-bookworm | congratulations :) (14.93 seconds) 2026-07-08 03:07:49.929290 | debian-bookworm | ok: Runtime: 0:00:15.271831 2026-07-08 03:07:49.936267 | 2026-07-08 03:07:49.936415 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-08 03:07:50.406641 | debian-bookworm | changed 2026-07-08 03:07:50.422742 | 2026-07-08 03:07:50.422974 | TASK [tox : Detect tox version] 2026-07-08 03:07:51.093085 | debian-bookworm | 4.56.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-08 03:07:51.506319 | debian-bookworm | ok: Runtime: 0:00:00.369308 2026-07-08 03:07:51.514955 | 2026-07-08 03:07:51.515080 | TASK [tox : Get tox envlist config] 2026-07-08 03:07:52.579767 | debian-bookworm | ok: Runtime: 0:00:00.416225 2026-07-08 03:07:52.587026 | 2026-07-08 03:07:52.587184 | TASK [tox : Install any sibling python packages] 2026-07-08 03:07:53.239527 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-08 03:07:53.246781 | 2026-07-08 03:07:53.247008 | TASK [tox : Remove tempfile] 2026-07-08 03:07:53.804564 | debian-bookworm | changed 2026-07-08 03:07:53.810583 | 2026-07-08 03:07:53.810706 | TASK [tox : Emit tox command] 2026-07-08 03:07:53.883583 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-08 03:07:53.888996 | 2026-07-08 03:07:53.889126 | TASK [tox : Run tox] 2026-07-08 03:07:54.535378 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-08 03:07:55.271010 | debian-bookworm | .......................... 2026-07-08 03:07:55.271064 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-08 03:07:55.271108 | debian-bookworm | Ran 26 tests in 0.234s 2026-07-08 03:07:55.271115 | debian-bookworm | 2026-07-08 03:07:55.271122 | debian-bookworm | OK 2026-07-08 03:07:55.370946 | debian-bookworm | test: OK (0.88=setup[0.05]+cmd[0.83] seconds) 2026-07-08 03:07:55.371015 | debian-bookworm | congratulations :) (0.91 seconds) 2026-07-08 03:07:55.946827 | debian-bookworm | ok: Runtime: 0:00:01.228359 2026-07-08 03:07:55.963459 | 2026-07-08 03:07:55.963624 | TASK [tox : Look for output] 2026-07-08 03:07:56.419426 | debian-bookworm | ok 2026-07-08 03:07:56.436614 | 2026-07-08 03:07:56.436797 | TASK [tox : Return file comments to Zuul] 2026-07-08 03:07:56.491809 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:07:56.503134 | 2026-07-08 03:07:56.503290 | PLAY RECAP 2026-07-08 03:07:56.503352 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-08 03:07:56.503378 | 2026-07-08 03:07:56.833356 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-08 03:07:56.836096 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-08 03:07:58.089904 | 2026-07-08 03:07:58.090112 | PLAY [all] 2026-07-08 03:07:58.115378 | 2026-07-08 03:07:58.115559 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-08 03:07:58.206104 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:07:58.213119 | 2026-07-08 03:07:58.213320 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-08 03:07:58.262186 | debian-bookworm | ok 2026-07-08 03:07:58.269198 | 2026-07-08 03:07:58.269337 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-08 03:07:59.123952 | debian-bookworm -> localhost | changed 2026-07-08 03:07:59.133292 | 2026-07-08 03:07:59.133442 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-08 03:07:59.234008 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:07:59.242307 | 2026-07-08 03:07:59.242455 | TASK [fetch-tox-output : Set envlist fact] 2026-07-08 03:07:59.309947 | debian-bookworm | ok 2026-07-08 03:07:59.321664 | 2026-07-08 03:07:59.321821 | TASK [fetch-tox-output : Get tox version] 2026-07-08 03:08:00.317047 | 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-07-08 03:08:00.334256 | debian-bookworm | 4.56.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-08 03:08:00.887484 | debian-bookworm | ok: Runtime: 0:00:00.319094 2026-07-08 03:08:00.894172 | 2026-07-08 03:08:00.894319 | TASK [fetch-tox-output : Find all default environments] 2026-07-08 03:08:01.506774 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:01.513299 | 2026-07-08 03:08:01.513396 | TASK [fetch-tox-output : Set envlist fact] 2026-07-08 03:08:01.567041 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:01.572501 | 2026-07-08 03:08:01.572596 | TASK [fetch-tox-output : Find all default environments] 2026-07-08 03:08:02.100370 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:02.106734 | 2026-07-08 03:08:02.107963 | TASK [fetch-tox-output : Set envlist fact] 2026-07-08 03:08:02.174522 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:02.184497 | 2026-07-08 03:08:02.184600 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-08 03:08:02.278604 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:02.287534 | 2026-07-08 03:08:02.287649 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-08 03:08:03.561560 | debian-bookworm | changed: 2026-07-08 03:08:03.561754 | debian-bookworm | created directory /var/lib/zuul/builds/db611c8299cb49099d270060cc7ee86d/work/logs/tox/test 2026-07-08 03:08:03.561791 | debian-bookworm | cd+++++++++ ./ 2026-07-08 03:08:03.561816 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-08 03:08:03.561845 | 2026-07-08 03:08:03.579950 | 2026-07-08 03:08:03.580054 | PLAY RECAP 2026-07-08 03:08:03.581467 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-08 03:08:03.581553 | 2026-07-08 03:08:03.837586 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-08 03:08:03.839329 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-08 03:08:04.822711 | 2026-07-08 03:08:04.822969 | PLAY [all] 2026-07-08 03:08:04.857222 | 2026-07-08 03:08:04.857398 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-08 03:08:05.193312 | debian-bookworm | changed: non-zero return code 2026-07-08 03:08:05.223715 | 2026-07-08 03:08:05.223857 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-08 03:08:05.250023 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:05.255312 | 2026-07-08 03:08:05.255435 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-08 03:08:05.409335 | 2026-07-08 03:08:05.409487 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-08 03:08:05.601002 | 2026-07-08 03:08:05.601213 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-08 03:08:05.651042 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:05.663374 | 2026-07-08 03:08:05.663480 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-08 03:08:05.723235 | 2026-07-08 03:08:05.723400 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-08 03:08:05.773308 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:05.779965 | 2026-07-08 03:08:05.780100 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-08 03:08:05.808802 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:05.822221 | 2026-07-08 03:08:05.822370 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-08 03:08:05.872052 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:05.880032 | 2026-07-08 03:08:05.880115 | PLAY RECAP 2026-07-08 03:08:05.880193 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-08 03:08:05.880221 | 2026-07-08 03:08:06.084747 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-08 03:08:06.086630 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-08 03:08:08.039996 | 2026-07-08 03:08:08.041101 | PLAY [Base post-fetch] 2026-07-08 03:08:08.108867 | 2026-07-08 03:08:08.109552 | TASK [diagnose-network : Ensure log directory exists] 2026-07-08 03:08:08.624383 | debian-bookworm | ok 2026-07-08 03:08:08.648068 | 2026-07-08 03:08:08.648267 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-08 03:08:21.597572 | debian-bookworm | ok: Runtime: 0:00:06.010771 2026-07-08 03:08:21.604747 | 2026-07-08 03:08:21.604841 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-08 03:08:27.808395 | debian-bookworm | ok: Runtime: 0:00:00.006167 2026-07-08 03:08:27.815838 | 2026-07-08 03:08:27.815972 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-08 03:08:34.024826 | debian-bookworm | ok: Runtime: 0:00:00.005957 2026-07-08 03:08:34.045782 | 2026-07-08 03:08:34.045896 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-08 03:08:34.099258 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:34.107856 | 2026-07-08 03:08:34.107954 | TASK [fetch-output : Set log path for single node] 2026-07-08 03:08:34.147380 | debian-bookworm | ok 2026-07-08 03:08:34.151397 | 2026-07-08 03:08:34.151479 | LOOP [fetch-output : Ensure local output dirs] 2026-07-08 03:08:34.660744 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/db611c8299cb49099d270060cc7ee86d/work/logs" 2026-07-08 03:08:34.885799 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/db611c8299cb49099d270060cc7ee86d/work/artifacts" 2026-07-08 03:08:35.146031 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/db611c8299cb49099d270060cc7ee86d/work/docs" 2026-07-08 03:08:35.156236 | 2026-07-08 03:08:35.156344 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-08 03:08:36.088567 | debian-bookworm | changed: 2026-07-08 03:08:36.088807 | debian-bookworm | .d..t...... ./ 2026-07-08 03:08:36.088842 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-08 03:08:36.088867 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-08 03:08:36.088889 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-08 03:08:36.088910 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-08 03:08:36.088931 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-08 03:08:36.088971 | debian-bookworm | changed: All items complete 2026-07-08 03:08:36.089008 | 2026-07-08 03:08:36.806504 | debian-bookworm | changed: .d..t...... ./ 2026-07-08 03:08:37.400651 | debian-bookworm | changed: .d..t...... ./ 2026-07-08 03:08:37.416621 | 2026-07-08 03:08:37.416786 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-08 03:08:37.453060 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:37.463901 | debian-bookworm | skipping: Conditional result was False 2026-07-08 03:08:37.474533 | 2026-07-08 03:08:37.474646 | PLAY RECAP 2026-07-08 03:08:37.474701 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-08 03:08:37.474726 | 2026-07-08 03:08:37.594451 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-08 03:08:37.595505 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-08 03:08:38.689458 | 2026-07-08 03:08:38.689665 | PLAY [Base post] 2026-07-08 03:08:38.717027 | 2026-07-08 03:08:38.717219 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-08 03:08:39.388123 | debian-bookworm | changed 2026-07-08 03:08:39.406587 | 2026-07-08 03:08:39.406759 | PLAY RECAP 2026-07-08 03:08:39.406856 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-08 03:08:39.406922 | 2026-07-08 03:08:39.657912 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-08 03:08:39.659229 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-08 03:08:40.963704 | 2026-07-08 03:08:40.963976 | PLAY [Base post-logs] 2026-07-08 03:08:40.977854 | 2026-07-08 03:08:40.978021 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-08 03:08:41.764659 | localhost | changed 2026-07-08 03:08:41.779389 | 2026-07-08 03:08:41.779586 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-08 03:08:41.817790 | localhost | ok 2026-07-08 03:08:41.822510 | 2026-07-08 03:08:41.822635 | TASK [Set zuul-log-path fact] 2026-07-08 03:08:41.850487 | localhost | ok 2026-07-08 03:08:41.861994 | 2026-07-08 03:08:41.862175 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-08 03:08:41.888942 | localhost | ok 2026-07-08 03:08:41.892637 | 2026-07-08 03:08:41.892753 | TASK [upload-logs : Create log directories] 2026-07-08 03:08:42.613402 | localhost | changed 2026-07-08 03:08:42.620224 | 2026-07-08 03:08:42.620359 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-08 03:08:43.231177 | localhost -> localhost | ok: Runtime: 0:00:00.008129 2026-07-08 03:08:43.240879 | 2026-07-08 03:08:43.241016 | TASK [upload-logs : Upload logs to log server] 2026-07-08 03:08:44.021694 | localhost | Output suppressed because no_log was given 2026-07-08 03:08:44.025056 | 2026-07-08 03:08:44.025209 | LOOP [upload-logs : Compress console log and json output] 2026-07-08 03:08:44.096254 | localhost | skipping: Conditional result was False 2026-07-08 03:08:44.107916 | localhost | skipping: Conditional result was False 2026-07-08 03:08:44.120845 | 2026-07-08 03:08:44.121000 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-08 03:08:44.199400 | localhost | skipping: Conditional result was False 2026-07-08 03:08:44.199769 | 2026-07-08 03:08:44.207106 | localhost | skipping: Conditional result was False 2026-07-08 03:08:44.213939 | 2026-07-08 03:08:44.214067 | LOOP [upload-logs : Upload console log and json output]