2026-09-09 13:29:22.278083 | Job console starting 2026-09-09 13:29:22.345837 | Updating git repos 2026-09-09 13:29:22.387754 | Cloning repos into workspace 2026-09-09 13:29:22.432449 | Restoring repo states 2026-09-09 13:29:22.443145 | Merging changes 2026-09-09 13:29:23.544788 | Checking out repos 2026-09-09 13:29:23.635332 | Preparing playbooks 2026-09-09 13:29:25.494288 | Running Ansible setup 2026-09-09 13:29:32.370895 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-09 13:29:34.339357 | 2026-09-09 13:29:34.339471 | PLAY [Base pre] 2026-09-09 13:29:34.373615 | 2026-09-09 13:29:34.373729 | TASK [Setup log path fact] 2026-09-09 13:29:34.399536 | debian-bookworm | ok 2026-09-09 13:29:34.432496 | 2026-09-09 13:29:34.432615 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-09 13:29:34.526800 | debian-bookworm | ok 2026-09-09 13:29:34.554764 | 2026-09-09 13:29:34.554869 | TASK [emit-job-header : Print job information] 2026-09-09 13:29:34.630362 | # Job Information 2026-09-09 13:29:34.630565 | Ansible Version: 2.16.14 2026-09-09 13:29:34.630598 | Job: generics-tox-seed 2026-09-09 13:29:34.630627 | Pipeline: check 2026-09-09 13:29:34.630650 | Executor: 521e9411259a 2026-09-09 13:29:34.630667 | Triggered by: https://github.com/osism/generics/pull/618 2026-09-09 13:29:34.630685 | Event ID: 70bdf8f0-ac52-11f1-9d60-60d3b59f7553 2026-09-09 13:29:34.637200 | 2026-09-09 13:29:34.637303 | LOOP [emit-job-header : Print node information] 2026-09-09 13:29:34.898317 | debian-bookworm | ok: 2026-09-09 13:29:34.898553 | debian-bookworm | # Node Information 2026-09-09 13:29:34.898590 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-09 13:29:34.898617 | debian-bookworm | Hostname: debian 2026-09-09 13:29:34.898640 | debian-bookworm | Username: zuul 2026-09-09 13:29:34.898661 | debian-bookworm | Distro: Debian 12.15 2026-09-09 13:29:34.898686 | debian-bookworm | Provider: regiocloud-a 2026-09-09 13:29:34.898708 | debian-bookworm | Region: 2026-09-09 13:29:34.898730 | debian-bookworm | Label: debian-bookworm 2026-09-09 13:29:34.898750 | debian-bookworm | Product Name: OpenStack Nova 2026-09-09 13:29:34.898771 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe91:920f 2026-09-09 13:29:34.916864 | 2026-09-09 13:29:34.916961 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-09 13:29:36.216377 | debian-bookworm -> localhost | changed 2026-09-09 13:29:36.222801 | 2026-09-09 13:29:36.222931 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-09 13:29:38.333890 | debian-bookworm -> localhost | changed 2026-09-09 13:29:38.353724 | 2026-09-09 13:29:38.354235 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-09 13:29:38.970755 | debian-bookworm -> localhost | ok 2026-09-09 13:29:38.975671 | 2026-09-09 13:29:38.975764 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-09 13:29:39.016356 | debian-bookworm | ok 2026-09-09 13:29:39.045328 | debian-bookworm | included: /var/lib/zuul/builds/59d2078bee954b088062752480dd1e93/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-09 13:29:39.056005 | 2026-09-09 13:29:39.056093 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-09 13:29:41.480665 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-09 13:29:41.480820 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/59d2078bee954b088062752480dd1e93/work/59d2078bee954b088062752480dd1e93_id_rsa 2026-09-09 13:29:41.480850 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/59d2078bee954b088062752480dd1e93/work/59d2078bee954b088062752480dd1e93_id_rsa.pub 2026-09-09 13:29:41.480871 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-09 13:29:41.480891 | debian-bookworm -> localhost | SHA256:rLkY3JTDZ73jP/a69Xp7AYhxYUtnuQHOQa8OrWOBJMA zuul-build-sshkey 2026-09-09 13:29:41.480908 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-09 13:29:41.480935 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-09 13:29:41.480953 | debian-bookworm -> localhost | | .. .Boo. | 2026-09-09 13:29:41.480971 | debian-bookworm -> localhost | | E. .=.*o | 2026-09-09 13:29:41.480988 | debian-bookworm -> localhost | | . . ++..o | 2026-09-09 13:29:41.481004 | debian-bookworm -> localhost | | .oo.o...o | 2026-09-09 13:29:41.481020 | debian-bookworm -> localhost | | =.So.o . | 2026-09-09 13:29:41.481038 | debian-bookworm -> localhost | | . o * =. . | 2026-09-09 13:29:41.481054 | debian-bookworm -> localhost | | o + +o. . .| 2026-09-09 13:29:41.481070 | debian-bookworm -> localhost | | o .....o. .o| 2026-09-09 13:29:41.481086 | debian-bookworm -> localhost | | . . .o+=o++| 2026-09-09 13:29:41.481103 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-09 13:29:41.481141 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.342464 2026-09-09 13:29:41.486572 | 2026-09-09 13:29:41.486827 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-09 13:29:41.513035 | debian-bookworm | ok 2026-09-09 13:29:41.521942 | debian-bookworm | included: /var/lib/zuul/builds/59d2078bee954b088062752480dd1e93/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-09 13:29:41.528625 | 2026-09-09 13:29:41.528697 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-09 13:29:41.544669 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:29:41.549123 | 2026-09-09 13:29:41.549193 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-09 13:29:42.104408 | debian-bookworm | changed 2026-09-09 13:29:42.109756 | 2026-09-09 13:29:42.109837 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-09 13:29:42.334847 | debian-bookworm | ok 2026-09-09 13:29:42.339410 | 2026-09-09 13:29:42.339493 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-09 13:29:43.009123 | debian-bookworm | changed 2026-09-09 13:29:43.016491 | 2026-09-09 13:29:43.016691 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-09 13:29:43.635742 | debian-bookworm | changed 2026-09-09 13:29:43.650505 | 2026-09-09 13:29:43.650609 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-09 13:29:43.688964 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:29:43.694733 | 2026-09-09 13:29:43.694828 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-09 13:29:44.724906 | debian-bookworm -> localhost | changed 2026-09-09 13:29:44.733344 | 2026-09-09 13:29:44.733455 | TASK [add-build-sshkey : Add back temp key] 2026-09-09 13:29:45.380147 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/59d2078bee954b088062752480dd1e93/work/59d2078bee954b088062752480dd1e93_id_rsa (zuul-build-sshkey) 2026-09-09 13:29:45.380326 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.035476 2026-09-09 13:29:45.387145 | 2026-09-09 13:29:45.387227 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-09 13:29:45.757002 | debian-bookworm | ok 2026-09-09 13:29:45.770467 | 2026-09-09 13:29:45.770554 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-09 13:29:45.804955 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:29:45.813087 | 2026-09-09 13:29:45.813164 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-09 13:29:46.394276 | debian-bookworm | ok 2026-09-09 13:29:46.405688 | 2026-09-09 13:29:46.405774 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-09 13:29:46.472927 | debian-bookworm | ok 2026-09-09 13:29:46.481412 | 2026-09-09 13:29:46.481504 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-09 13:29:46.880073 | debian-bookworm -> localhost | ok 2026-09-09 13:29:46.885422 | 2026-09-09 13:29:46.885509 | TASK [validate-host : Collect information about the host] 2026-09-09 13:29:48.001643 | debian-bookworm | ok 2026-09-09 13:29:48.010981 | 2026-09-09 13:29:48.011068 | TASK [validate-host : Sanitize hostname] 2026-09-09 13:29:48.110607 | debian-bookworm | ok 2026-09-09 13:29:48.114147 | 2026-09-09 13:29:48.114218 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-09 13:29:48.783381 | debian-bookworm -> localhost | changed 2026-09-09 13:29:48.788031 | 2026-09-09 13:29:48.788113 | TASK [validate-host : Collect information about zuul worker] 2026-09-09 13:29:49.322692 | debian-bookworm | ok 2026-09-09 13:29:49.330497 | 2026-09-09 13:29:49.330635 | TASK [validate-host : Write out all zuul information for each host] 2026-09-09 13:29:50.088369 | debian-bookworm -> localhost | changed 2026-09-09 13:29:50.096002 | 2026-09-09 13:29:50.096092 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-09 13:29:50.384831 | debian-bookworm | ok 2026-09-09 13:29:50.389245 | 2026-09-09 13:29:50.389325 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-09 13:29:51.529755 | debian-bookworm | changed: 2026-09-09 13:29:51.529913 | debian-bookworm | cd+++++++++ src/ 2026-09-09 13:29:51.529947 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-09 13:29:51.529972 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-09 13:29:51.529995 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-09-09 13:29:51.530016 | debian-bookworm | =7.0.3 2026-09-09 13:30:32.333642 | debian-bookworm | Downloading cachetools-7.1.8-py3-none-any.whl (16 kB) 2026-09-09 13:30:32.395724 | debian-bookworm | Collecting colorama>=0.4.6 2026-09-09 13:30:32.413750 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-09-09 13:30:32.521124 | debian-bookworm | Collecting filelock>=3.25 2026-09-09 13:30:32.537362 | debian-bookworm | Downloading filelock-3.32.6-py3-none-any.whl (100 kB) 2026-09-09 13:30:32.550514 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 10.1 MB/s eta 0:00:00 2026-09-09 13:30:32.607381 | debian-bookworm | Collecting packaging>=26 2026-09-09 13:30:32.624020 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-09-09 13:30:32.636661 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 16.0 MB/s eta 0:00:00 2026-09-09 13:30:32.700596 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-09-09 13:30:32.718228 | debian-bookworm | Downloading platformdirs-4.11.8-py3-none-any.whl (24 kB) 2026-09-09 13:30:32.778878 | debian-bookworm | Collecting pluggy>=1.6 2026-09-09 13:30:32.795920 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-09-09 13:30:32.862191 | debian-bookworm | Collecting pyproject-api>=1.10 2026-09-09 13:30:32.879429 | debian-bookworm | Downloading pyproject_api-1.11.0-py3-none-any.whl (13 kB) 2026-09-09 13:30:32.927574 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-09-09 13:30:32.945304 | debian-bookworm | Downloading python_discovery-1.6.0-py3-none-any.whl (38 kB) 2026-09-09 13:30:33.001277 | debian-bookworm | Collecting tomli-w>=1.2 2026-09-09 13:30:33.017395 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-09-09 13:30:33.107714 | debian-bookworm | Collecting typing-extensions>=4.15 2026-09-09 13:30:33.126546 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-09-09 13:30:33.149829 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 2.6 MB/s eta 0:00:00 2026-09-09 13:30:33.322757 | debian-bookworm | Collecting virtualenv>=21.1 2026-09-09 13:30:33.338788 | debian-bookworm | Downloading virtualenv-21.7.9-py3-none-any.whl (5.3 MB) 2026-09-09 13:30:33.521864 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.3/5.3 MB 29.9 MB/s eta 0:00:00 2026-09-09 13:30:33.616207 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-09-09 13:30:33.632202 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-09-09 13:30:33.647343 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 42.7 MB/s eta 0:00:00 2026-09-09 13:30:33.755470 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-09-09 13:30:34.839142 | debian-bookworm | Successfully installed cachetools-7.1.8 colorama-0.4.6 distlib-0.4.3 filelock-3.32.6 packaging-26.3 platformdirs-4.11.8 pluggy-1.6.0 pyproject-api-1.11.0 python-discovery-1.6.0 tomli-w-1.2.0 tox-4.61.4 typing-extensions-4.16.0 virtualenv-21.7.9 2026-09-09 13:30:35.490446 | debian-bookworm | ok: Runtime: 0:00:03.800454 2026-09-09 13:30:35.496670 | 2026-09-09 13:30:35.496789 | TASK [ensure-tox : Export installed tox_executable path] 2026-09-09 13:30:35.529272 | debian-bookworm | ok 2026-09-09 13:30:35.534835 | 2026-09-09 13:30:35.534965 | TASK [ensure-tox : Output tox version] 2026-09-09 13:30:36.161608 | 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-09-09 13:30:36.182907 | debian-bookworm | 4.61.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-09 13:30:36.567816 | debian-bookworm | ok: Runtime: 0:00:00.418422 2026-09-09 13:30:36.573631 | 2026-09-09 13:30:36.573739 | TASK [ensure-tox : Make global symlink] 2026-09-09 13:30:36.613881 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:36.624036 | 2026-09-09 13:30:36.624141 | PLAY RECAP 2026-09-09 13:30:36.624196 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-09-09 13:30:36.624221 | 2026-09-09 13:30:36.766598 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-09-09 13:30:36.767697 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-09 13:30:37.603054 | 2026-09-09 13:30:37.603222 | PLAY [all] 2026-09-09 13:30:37.618989 | 2026-09-09 13:30:37.619129 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-09-09 13:30:38.292013 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-09 13:30:38.650688 | debian-bookworm | ok: Runtime: 0:00:00.032251 2026-09-09 13:30:38.659204 | 2026-09-09 13:30:38.659517 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-09-09 13:30:39.197536 | debian-bookworm | ok: Runtime: 0:00:00.006951 2026-09-09 13:30:39.210890 | 2026-09-09 13:30:39.211063 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-09-09 13:30:39.503665 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-09 13:30:39.505726 | debian-bookworm | sudo: a password is required 2026-09-09 13:30:39.746160 | debian-bookworm | ok: Runtime: 0:00:00.023133 2026-09-09 13:30:39.756432 | 2026-09-09 13:30:39.756538 | TASK [tox : Check to see if the constraints file exists] 2026-09-09 13:30:39.791300 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:39.800255 | 2026-09-09 13:30:39.800436 | TASK [tox : Fail if constraints file is missing] 2026-09-09 13:30:39.838342 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:39.844900 | 2026-09-09 13:30:39.845011 | TASK [tox : Record file location] 2026-09-09 13:30:39.868570 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:39.875054 | 2026-09-09 13:30:39.875163 | TASK [tox : Install tox siblings] 2026-09-09 13:30:39.935196 | debian-bookworm | ok 2026-09-09 13:30:39.947717 | debian-bookworm | included: /var/lib/zuul/builds/59d2078bee954b088062752480dd1e93/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-09-09 13:30:39.955654 | 2026-09-09 13:30:39.956175 | TASK [tox : Run tox without tests] 2026-09-09 13:30:40.635773 | debian-bookworm | ROOT: 250 D setup logging to DEBUG on pid 1793 [tox/report.py:242] 2026-09-09 13:30:40.669756 | debian-bookworm | seed: 284 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-09 13:30:40.672755 | debian-bookworm | seed: 287 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-09 13:30:40.677377 | debian-bookworm | seed: 291 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/python_discovery/_py_info_collect.py 3be36af8dd65162928fb196f341d738e ce930a674227fdab9c2e898059e2d472 [python_discovery/_cached_py_info.py:223] 2026-09-09 13:30:40.750095 | debian-bookworm | seed: 364 D wrote python info of /usr/bin/python3.11 at /home/zuul/.cache/virtualenv/py_info/5/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:159] 2026-09-09 13:30:40.751338 | debian-bookworm | seed: 365 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-09 13:30:40.751701 | debian-bookworm | seed: 366 I proposed PythonInfo(spec=CPython3.11.2.final.0-64-x86_64, system=/usr/bin/python3.11, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:140] 2026-09-09 13:30:40.752016 | debian-bookworm | seed: 366 D accepted PythonInfo(spec=CPython3.11.2.final.0-64-x86_64, system=/usr/bin/python3.11, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:144] 2026-09-09 13:30:40.756756 | debian-bookworm | seed: 371 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-09 13:30:40.757173 | debian-bookworm | seed: 371 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-09 13:30:40.798303 | debian-bookworm | seed: 412 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/generics/.tox/seed, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:77] 2026-09-09 13:30:40.798574 | debian-bookworm | seed: 413 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/bin [virtualenv/util/path/_sync.py:22] 2026-09-09 13:30:40.798748 | debian-bookworm | seed: 413 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/include [virtualenv/util/path/_sync.py:22] 2026-09-09 13:30:40.798855 | debian-bookworm | seed: 413 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:22] 2026-09-09 13:30:40.799098 | debian-bookworm | seed: 413 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-09-09 13:30:40.799190 | debian-bookworm | seed: 413 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.799251 | debian-bookworm | seed: 413 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.799304 | debian-bookworm | seed: 413 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.799357 | debian-bookworm | seed: 414 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.799407 | debian-bookworm | seed: 414 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.799463 | debian-bookworm | seed: 414 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/seed [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.799515 | debian-bookworm | seed: 414 D virtualenv = 21.7.9 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.799566 | debian-bookworm | seed: 414 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.799617 | debian-bookworm | seed: 414 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.799666 | debian-bookworm | seed: 414 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.799718 | debian-bookworm | seed: 414 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:40.800044 | debian-bookworm | seed: 414 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/generics/.tox/seed/bin/python [virtualenv/util/path/_sync.py:42] 2026-09-09 13:30:40.800587 | debian-bookworm | seed: 415 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-09-09 13:30:40.800909 | debian-bookworm | seed: 415 D debug via /home/zuul/src/github.com/osism/generics/.tox/seed/bin/python /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:265] 2026-09-09 13:30:40.846393 | debian-bookworm | seed: 415 D { 2026-09-09 13:30:40.846480 | debian-bookworm | "sys": { 2026-09-09 13:30:40.846492 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/seed/bin/python", 2026-09-09 13:30:40.846501 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-09-09 13:30:40.846512 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-09 13:30:40.846521 | debian-bookworm | "base_prefix": "/usr", 2026-09-09 13:30:40.846531 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-09 13:30:40.846538 | debian-bookworm | "base_exec_prefix": "/usr", 2026-09-09 13:30:40.846545 | debian-bookworm | "path": [ 2026-09-09 13:30:40.846552 | debian-bookworm | "/usr/lib/python311.zip", 2026-09-09 13:30:40.846559 | debian-bookworm | "/usr/lib/python3.11", 2026-09-09 13:30:40.846566 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-09-09 13:30:40.846573 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages" 2026-09-09 13:30:40.846580 | debian-bookworm | ], 2026-09-09 13:30:40.846588 | debian-bookworm | "meta_path": [ 2026-09-09 13:30:40.846595 | debian-bookworm | "", 2026-09-09 13:30:40.846603 | debian-bookworm | "", 2026-09-09 13:30:40.846610 | debian-bookworm | "" 2026-09-09 13:30:40.846617 | debian-bookworm | ], 2026-09-09 13:30:40.846623 | debian-bookworm | "fs_encoding": "utf-8", 2026-09-09 13:30:40.846631 | debian-bookworm | "io_encoding": "utf-8" 2026-09-09 13:30:40.846638 | debian-bookworm | }, 2026-09-09 13:30:40.846644 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-09-09 13:30:40.846652 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-09-09 13:30:40.846658 | debian-bookworm | "os": "", 2026-09-09 13:30:40.846665 | debian-bookworm | "site": "", 2026-09-09 13:30:40.846679 | debian-bookworm | "datetime": "", 2026-09-09 13:30:40.846686 | debian-bookworm | "math": "", 2026-09-09 13:30:40.846693 | debian-bookworm | "json": "" 2026-09-09 13:30:40.846700 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-09-09 13:30:40.846845 | debian-bookworm | seed: 461 I add seed packages via FromAppData(download=False, pip=bundle, setuptools=bundle, via=copy, app_data_dir=/home/zuul/.cache/virtualenv) [virtualenv/run/session.py:84] 2026-09-09 13:30:40.857229 | debian-bookworm | seed: 471 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-26.2.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-09-09 13:30:40.858835 | debian-bookworm | seed: 473 D build install image for pip-26.2.1-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.2.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-09-09 13:30:40.865502 | debian-bookworm | seed: 479 D install setuptools from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/setuptools-84.0.0-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-09-09 13:30:40.868431 | debian-bookworm | seed: 482 D build install image for setuptools-84.0.0-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-09-09 13:30:41.248946 | debian-bookworm | seed: 863 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any/setuptools to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/setuptools [virtualenv/util/path/_sync.py:50] 2026-09-09 13:30:41.367348 | debian-bookworm | seed: 981 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.2.1-py3-none-any/pip-26.2.1.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/pip-26.2.1.virtualenv [virtualenv/util/path/_sync.py:50] 2026-09-09 13:30:41.368327 | debian-bookworm | seed: 982 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.2.1-py3-none-any/pip to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/pip [virtualenv/util/path/_sync.py:50] 2026-09-09 13:30:41.415690 | debian-bookworm | seed: 1030 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any/_distutils_hack to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:50] 2026-09-09 13:30:41.416823 | debian-bookworm | seed: 1031 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any/distutils-precedence.pth to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:50] 2026-09-09 13:30:41.418048 | debian-bookworm | seed: 1032 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any/setuptools-84.0.0.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/setuptools-84.0.0.virtualenv [virtualenv/util/path/_sync.py:50] 2026-09-09 13:30:41.419436 | debian-bookworm | seed: 1033 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any/setuptools-84.0.0.dist-info to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/setuptools-84.0.0.dist-info [virtualenv/util/path/_sync.py:50] 2026-09-09 13:30:41.426825 | debian-bookworm | seed: 1041 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-09 13:30:41.457899 | debian-bookworm | seed: 1072 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.2.1-py3-none-any/pip-26.2.1.dist-info to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/pip-26.2.1.dist-info [virtualenv/util/path/_sync.py:50] 2026-09-09 13:30:41.463132 | debian-bookworm | seed: 1077 D generated console scripts pip3.11 pip pip-3.11 pip3 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-09 13:30:41.463926 | debian-bookworm | seed: 1078 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-09-09 13:30:41.471000 | debian-bookworm | seed: 1085 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-09-09 13:30:41.471194 | debian-bookworm | seed: 1085 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.471275 | debian-bookworm | seed: 1085 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.471341 | debian-bookworm | seed: 1086 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.471403 | debian-bookworm | seed: 1086 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.471479 | debian-bookworm | seed: 1086 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.471546 | debian-bookworm | seed: 1086 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/seed [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.471610 | debian-bookworm | seed: 1086 D virtualenv = 21.7.9 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.471671 | debian-bookworm | seed: 1086 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.471736 | debian-bookworm | seed: 1086 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.471800 | debian-bookworm | seed: 1086 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.471861 | debian-bookworm | seed: 1086 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 13:30:41.475320 | debian-bookworm | seed: OK (0.81 seconds) 2026-09-09 13:30:41.475388 | debian-bookworm | congratulations :) (0.84 seconds) 2026-09-09 13:30:41.986944 | debian-bookworm | ok: Runtime: 0:00:01.253472 2026-09-09 13:30:42.000743 | 2026-09-09 13:30:42.000964 | TASK [tox : Create a tempfile to save tox showconfig] 2026-09-09 13:30:42.438670 | debian-bookworm | changed 2026-09-09 13:30:42.445629 | 2026-09-09 13:30:42.445738 | TASK [tox : Detect tox version] 2026-09-09 13:30:43.091984 | debian-bookworm | 4.61.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-09 13:30:43.481424 | debian-bookworm | ok: Runtime: 0:00:00.394764 2026-09-09 13:30:43.493045 | 2026-09-09 13:30:43.493199 | TASK [tox : Get tox envlist config] 2026-09-09 13:30:44.528059 | debian-bookworm | ok: Runtime: 0:00:00.447706 2026-09-09 13:30:44.541103 | 2026-09-09 13:30:44.541266 | TASK [tox : Install any sibling python packages] 2026-09-09 13:30:45.043030 | debian-bookworm | ok: No setup.cfg, no action needed 2026-09-09 13:30:45.051359 | 2026-09-09 13:30:45.051513 | TASK [tox : Remove tempfile] 2026-09-09 13:30:45.581695 | debian-bookworm | changed 2026-09-09 13:30:45.587207 | 2026-09-09 13:30:45.587311 | TASK [tox : Emit tox command] 2026-09-09 13:30:45.642163 | /home/zuul/.local/tox/bin/tox -eseed -vv --skip-missing-interpreters=false 2026-09-09 13:30:45.650222 | 2026-09-09 13:30:45.650383 | TASK [tox : Run tox] 2026-09-09 13:30:46.276620 | debian-bookworm | ROOT: 254 D setup logging to DEBUG on pid 1833 [tox/report.py:242] 2026-09-09 13:30:46.313765 | debian-bookworm | seed: 291 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-09 13:30:46.317878 | debian-bookworm | seed: 296 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-09 13:30:46.322637 | debian-bookworm | seed: 300 D got python info of /usr/bin/python3.11 from /home/zuul/.cache/virtualenv/py_info/5/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:139] 2026-09-09 13:30:46.323256 | debian-bookworm | seed: 301 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-09 13:30:46.323363 | debian-bookworm | seed: 301 I proposed PythonInfo(spec=CPython3.11.2.final.0-64-x86_64, system=/usr/bin/python3.11, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:140] 2026-09-09 13:30:46.323429 | debian-bookworm | seed: 301 D accepted PythonInfo(spec=CPython3.11.2.final.0-64-x86_64, system=/usr/bin/python3.11, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:144] 2026-09-09 13:30:46.325435 | debian-bookworm | seed: 303 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-09 13:30:46.325503 | debian-bookworm | seed: 303 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-09 13:30:46.362376 | debian-bookworm | seed: 340 W commands[0]> bash src/test-seed.sh [tox/tox_env/api.py:485] 2026-09-09 13:30:47.010697 | debian-bookworm | PASS=44 FAIL=0 2026-09-09 13:30:47.012677 | debian-bookworm | seed: 991 I exit 0 (0.65 seconds) /home/zuul/src/github.com/osism/generics> bash src/test-seed.sh pid=1840 [tox/execute/api.py:309] 2026-09-09 13:30:47.014044 | debian-bookworm | seed: OK (0.70=setup[0.06]+cmd[0.65] seconds) 2026-09-09 13:30:47.014134 | debian-bookworm | congratulations :) (0.74 seconds) 2026-09-09 13:30:47.183450 | debian-bookworm | ok: Runtime: 0:00:01.125977 2026-09-09 13:30:47.197509 | 2026-09-09 13:30:47.197725 | TASK [tox : Look for output] 2026-09-09 13:30:47.649113 | debian-bookworm | ok 2026-09-09 13:30:47.665956 | 2026-09-09 13:30:47.666077 | TASK [tox : Return file comments to Zuul] 2026-09-09 13:30:47.710249 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:47.724254 | 2026-09-09 13:30:47.724389 | PLAY RECAP 2026-09-09 13:30:47.724473 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-09 13:30:47.724512 | 2026-09-09 13:30:47.854331 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-09 13:30:47.855415 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-09 13:30:48.612838 | 2026-09-09 13:30:48.612999 | PLAY [all] 2026-09-09 13:30:48.629752 | 2026-09-09 13:30:48.629897 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-09-09 13:30:48.689260 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:48.695090 | 2026-09-09 13:30:48.695227 | TASK [fetch-tox-output : Set tox log path for single node] 2026-09-09 13:30:48.733894 | debian-bookworm | ok 2026-09-09 13:30:48.738943 | 2026-09-09 13:30:48.739048 | TASK [fetch-tox-output : Ensure local tox dir] 2026-09-09 13:30:49.227805 | debian-bookworm -> localhost | changed 2026-09-09 13:30:49.235882 | 2026-09-09 13:30:49.236004 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-09-09 13:30:49.300847 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:49.313073 | 2026-09-09 13:30:49.313238 | TASK [fetch-tox-output : Set envlist fact] 2026-09-09 13:30:49.369229 | debian-bookworm | ok 2026-09-09 13:30:49.377594 | 2026-09-09 13:30:49.377727 | TASK [fetch-tox-output : Get tox version] 2026-09-09 13:30:50.217603 | 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-09-09 13:30:50.239112 | debian-bookworm | 4.61.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-09 13:30:50.413812 | debian-bookworm | ok: Runtime: 0:00:00.398520 2026-09-09 13:30:50.419703 | 2026-09-09 13:30:50.419832 | TASK [fetch-tox-output : Find all default environments] 2026-09-09 13:30:50.955442 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:50.961719 | 2026-09-09 13:30:50.961846 | TASK [fetch-tox-output : Set envlist fact] 2026-09-09 13:30:50.986618 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:51.013713 | 2026-09-09 13:30:51.013862 | TASK [fetch-tox-output : Find all default environments] 2026-09-09 13:30:51.562558 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:51.574821 | 2026-09-09 13:30:51.574994 | TASK [fetch-tox-output : Set envlist fact] 2026-09-09 13:30:51.600059 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:51.607779 | 2026-09-09 13:30:51.607916 | LOOP [fetch-tox-output : Copy tox logs] 2026-09-09 13:30:51.674482 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:51.684382 | 2026-09-09 13:30:51.684523 | LOOP [fetch-tox-output : Collect tox logs] 2026-09-09 13:30:52.497772 | debian-bookworm | changed: 2026-09-09 13:30:52.497967 | debian-bookworm | created directory /var/lib/zuul/builds/59d2078bee954b088062752480dd1e93/work/logs/tox/seed 2026-09-09 13:30:52.498002 | debian-bookworm | cd+++++++++ ./ 2026-09-09 13:30:52.498027 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-09-09 13:30:52.498055 | 2026-09-09 13:30:52.505265 | 2026-09-09 13:30:52.505354 | PLAY RECAP 2026-09-09 13:30:52.505425 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-09-09 13:30:52.505449 | 2026-09-09 13:30:52.634593 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-09 13:30:52.635617 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-09 13:30:53.470732 | 2026-09-09 13:30:53.470897 | PLAY [all] 2026-09-09 13:30:53.487646 | 2026-09-09 13:30:53.487788 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-09-09 13:30:53.704154 | debian-bookworm | changed: non-zero return code 2026-09-09 13:30:53.712130 | 2026-09-09 13:30:53.712322 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-09-09 13:30:53.736613 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:53.742731 | 2026-09-09 13:30:53.742851 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-09-09 13:30:53.773996 | 2026-09-09 13:30:53.774196 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-09-09 13:30:53.806224 | 2026-09-09 13:30:53.806439 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-09-09 13:30:53.830641 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:53.836939 | 2026-09-09 13:30:53.837061 | LOOP [fetch-subunit-output : Generate subunit file] 2026-09-09 13:30:53.869784 | 2026-09-09 13:30:53.869985 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-09-09 13:30:53.884396 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:53.892386 | 2026-09-09 13:30:53.892502 | TASK [fetch-subunit-output : Remove the temporary file] 2026-09-09 13:30:53.916103 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:53.921997 | 2026-09-09 13:30:53.922100 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-09-09 13:30:53.935868 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:30:53.942814 | 2026-09-09 13:30:53.942900 | PLAY RECAP 2026-09-09 13:30:53.942952 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-09-09 13:30:53.942977 | 2026-09-09 13:30:54.068738 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-09 13:30:54.069815 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-09 13:30:55.011942 | 2026-09-09 13:30:55.012115 | PLAY [Base post-fetch] 2026-09-09 13:30:55.027746 | 2026-09-09 13:30:55.027900 | TASK [diagnose-network : Ensure log directory exists] 2026-09-09 13:30:55.485961 | debian-bookworm | ok 2026-09-09 13:30:55.494548 | 2026-09-09 13:30:55.494733 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-09-09 13:31:07.312346 | debian-bookworm | ok: Runtime: 0:00:06.070774 2026-09-09 13:31:07.319417 | 2026-09-09 13:31:07.319542 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-09-09 13:31:13.388874 | debian-bookworm | ok: Runtime: 0:00:00.011130 2026-09-09 13:31:13.395253 | 2026-09-09 13:31:13.395433 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-09-09 13:31:19.371586 | debian-bookworm | ok: Runtime: 0:00:00.008505 2026-09-09 13:31:19.382113 | 2026-09-09 13:31:19.382230 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-09 13:31:19.426112 | debian-bookworm | skipping: Conditional result was False 2026-09-09 13:31:19.432458 | 2026-09-09 13:31:19.432582 | TASK [fetch-output : Set log path for single node] 2026-09-09 13:31:19.476515 | debian-bookworm | ok 2026-09-09 13:31:19.482766 | 2026-09-09 13:31:19.482884 | LOOP [fetch-output : Ensure local output dirs] 2026-09-09 13:31:19.796714 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/59d2078bee954b088062752480dd1e93/work/logs" 2026-09-09 13:31:20.058789 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/59d2078bee954b088062752480dd1e93/work/artifacts" 2026-09-09 13:31:20.321682 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/59d2078bee954b088062752480dd1e93/work/docs" 2026-09-09 13:31:20.335934 | 2026-09-09 13:31:20.336097 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-09 13:31:21.116829 | debian-bookworm | changed: 2026-09-09 13:31:21.117067 | debian-bookworm | .d..t...... ./ 2026-09-09 13:31:21.117115 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-09 13:31:21.117140 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-09 13:31:21.117162 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-09 13:31:21.117182 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-09 13:31:21.117202 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-09 13:31:21.117244 | debian-bookworm | changed: All items complete 2026-09-09 13:31:21.117271 | 2026-09-09 13:31:21.639700 | debian-bookworm | changed: .d..t...... ./ 2026-09-09 13:31:22.231192 | debian-bookworm | changed: .d..t...... ./ 2026-09-09 13:31:22.247425 | 2026-09-09 13:31:22.247571 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-09 13:31:22.601757 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006523 2026-09-09 13:31:22.911508 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009965 2026-09-09 13:31:22.926131 | 2026-09-09 13:31:22.926253 | PLAY RECAP 2026-09-09 13:31:22.926325 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-09 13:31:22.926362 | 2026-09-09 13:31:23.066577 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-09 13:31:23.067617 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-09 13:31:23.774501 | 2026-09-09 13:31:23.774647 | PLAY [Base post] 2026-09-09 13:31:23.789985 | 2026-09-09 13:31:23.790111 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-09 13:31:24.393544 | debian-bookworm | changed 2026-09-09 13:31:24.402891 | 2026-09-09 13:31:24.403017 | PLAY RECAP 2026-09-09 13:31:24.403103 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-09 13:31:24.403191 | 2026-09-09 13:31:24.518326 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-09 13:31:24.519412 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-09 13:31:25.364421 | 2026-09-09 13:31:25.364593 | PLAY [Base post-logs] 2026-09-09 13:31:25.375989 | 2026-09-09 13:31:25.376127 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-09 13:31:25.819344 | localhost | changed 2026-09-09 13:31:25.843633 | 2026-09-09 13:31:25.843904 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-09 13:31:25.869856 | localhost | ok 2026-09-09 13:31:25.872977 | 2026-09-09 13:31:25.873084 | TASK [Set zuul-log-path fact] 2026-09-09 13:31:25.888255 | localhost | ok 2026-09-09 13:31:25.896107 | 2026-09-09 13:31:25.896219 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-09 13:31:25.921213 | localhost | ok 2026-09-09 13:31:25.924260 | 2026-09-09 13:31:25.924365 | TASK [upload-logs : Create log directories] 2026-09-09 13:31:26.681261 | localhost | changed 2026-09-09 13:31:26.684253 | 2026-09-09 13:31:26.684363 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-09 13:31:27.275091 | localhost -> localhost | ok: Runtime: 0:00:00.009573 2026-09-09 13:31:27.279399 | 2026-09-09 13:31:27.279528 | TASK [upload-logs : Upload logs to log server] 2026-09-09 13:31:27.923961 | localhost | Output suppressed because no_log was given 2026-09-09 13:31:27.926073 | 2026-09-09 13:31:27.926177 | LOOP [upload-logs : Compress console log and json output] 2026-09-09 13:31:27.972218 | localhost | skipping: Conditional result was False 2026-09-09 13:31:27.980285 | localhost | skipping: Conditional result was False 2026-09-09 13:31:27.997632 | 2026-09-09 13:31:27.997893 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-09 13:31:28.049114 | localhost | skipping: Conditional result was False 2026-09-09 13:31:28.049367 | 2026-09-09 13:31:28.059489 | localhost | skipping: Conditional result was False 2026-09-09 13:31:28.066740 | 2026-09-09 13:31:28.066854 | LOOP [upload-logs : Upload console log and json output]