2026-09-29 03:04:38.689247 | Job console starting 2026-09-29 03:04:38.698530 | Updating git repos 2026-09-29 03:04:38.716147 | Cloning repos into workspace 2026-09-29 03:04:38.759292 | Restoring repo states 2026-09-29 03:04:38.784669 | Merging changes 2026-09-29 03:04:38.784684 | Checking out repos 2026-09-29 03:04:38.806446 | Preparing playbooks 2026-09-29 03:04:39.790066 | Running Ansible setup 2026-09-29 03:04:44.615437 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-29 03:04:46.061006 | 2026-09-29 03:04:46.061144 | PLAY [Base pre] 2026-09-29 03:04:46.100249 | 2026-09-29 03:04:46.100376 | TASK [Setup log path fact] 2026-09-29 03:04:46.159821 | debian-bookworm | ok 2026-09-29 03:04:46.189528 | 2026-09-29 03:04:46.212280 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-29 03:04:46.250320 | debian-bookworm | ok 2026-09-29 03:04:46.269998 | 2026-09-29 03:04:46.270112 | TASK [emit-job-header : Print job information] 2026-09-29 03:04:46.345452 | # Job Information 2026-09-29 03:04:46.345669 | Ansible Version: 2.16.14 2026-09-29 03:04:46.345733 | Job: generics-tox-seed 2026-09-29 03:04:46.345770 | Pipeline: periodic-daily 2026-09-29 03:04:46.345793 | Executor: 521e9411259a 2026-09-29 03:04:46.345814 | Triggered by: https://github.com/osism/generics 2026-09-29 03:04:46.345836 | Event ID: b70e394fcd4c479d99af4c2178a7f96d 2026-09-29 03:04:46.350623 | 2026-09-29 03:04:46.350734 | LOOP [emit-job-header : Print node information] 2026-09-29 03:04:46.588812 | debian-bookworm | ok: 2026-09-29 03:04:46.588957 | debian-bookworm | # Node Information 2026-09-29 03:04:46.588984 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-29 03:04:46.589005 | debian-bookworm | Hostname: debian 2026-09-29 03:04:46.589023 | debian-bookworm | Username: zuul 2026-09-29 03:04:46.589040 | debian-bookworm | Distro: Debian 12.15 2026-09-29 03:04:46.589061 | debian-bookworm | Provider: regiocloud-a 2026-09-29 03:04:46.589079 | debian-bookworm | Region: 2026-09-29 03:04:46.589096 | debian-bookworm | Label: debian-bookworm 2026-09-29 03:04:46.589112 | debian-bookworm | Product Name: OpenStack Nova 2026-09-29 03:04:46.589128 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe98:d9b3 2026-09-29 03:04:46.600598 | 2026-09-29 03:04:46.600775 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-29 03:04:47.632841 | debian-bookworm -> localhost | changed 2026-09-29 03:04:47.639331 | 2026-09-29 03:04:47.639422 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-29 03:04:49.067434 | debian-bookworm -> localhost | changed 2026-09-29 03:04:49.086146 | 2026-09-29 03:04:49.086249 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-29 03:04:50.056729 | debian-bookworm -> localhost | ok 2026-09-29 03:04:50.062078 | 2026-09-29 03:04:50.062173 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-29 03:04:50.092781 | debian-bookworm | ok 2026-09-29 03:04:50.110317 | debian-bookworm | included: /var/lib/zuul/builds/e157b9ded8d64d8190c0dd7c6fe3f8e8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-29 03:04:50.117398 | 2026-09-29 03:04:50.117481 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-29 03:04:51.653459 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-29 03:04:51.653648 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e157b9ded8d64d8190c0dd7c6fe3f8e8/work/e157b9ded8d64d8190c0dd7c6fe3f8e8_id_rsa 2026-09-29 03:04:51.653684 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e157b9ded8d64d8190c0dd7c6fe3f8e8/work/e157b9ded8d64d8190c0dd7c6fe3f8e8_id_rsa.pub 2026-09-29 03:04:51.653717 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-29 03:04:51.653739 | debian-bookworm -> localhost | SHA256:RixMmVVm0dhd8Lf773jDyVcVZOsFOSSRVoSoQDVah2k zuul-build-sshkey 2026-09-29 03:04:51.653758 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-29 03:04:51.653786 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-29 03:04:51.653805 | debian-bookworm -> localhost | | .o==+**oOB*.| 2026-09-29 03:04:51.653824 | debian-bookworm -> localhost | | o++E=o *.=+.| 2026-09-29 03:04:51.653841 | debian-bookworm -> localhost | | +oo. . o=| 2026-09-29 03:04:51.653858 | debian-bookworm -> localhost | | o. . =| 2026-09-29 03:04:51.653874 | debian-bookworm -> localhost | | S o.| 2026-09-29 03:04:51.653897 | debian-bookworm -> localhost | | . o| 2026-09-29 03:04:51.653913 | debian-bookworm -> localhost | | o.o| 2026-09-29 03:04:51.653929 | debian-bookworm -> localhost | | *+| 2026-09-29 03:04:51.653949 | debian-bookworm -> localhost | | .oB| 2026-09-29 03:04:51.653965 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-29 03:04:51.654009 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.700122 2026-09-29 03:04:51.662196 | 2026-09-29 03:04:51.662275 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-29 03:04:51.708910 | debian-bookworm | ok 2026-09-29 03:04:51.717883 | debian-bookworm | included: /var/lib/zuul/builds/e157b9ded8d64d8190c0dd7c6fe3f8e8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-29 03:04:51.733630 | 2026-09-29 03:04:51.733862 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-29 03:04:51.766838 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:04:51.771782 | 2026-09-29 03:04:51.771862 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-29 03:04:52.797089 | debian-bookworm | changed 2026-09-29 03:04:52.801600 | 2026-09-29 03:04:52.801680 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-29 03:04:53.104377 | debian-bookworm | ok 2026-09-29 03:04:53.112890 | 2026-09-29 03:04:53.112972 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-29 03:04:54.000889 | debian-bookworm | changed 2026-09-29 03:04:54.006360 | 2026-09-29 03:04:54.006440 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-29 03:04:54.760034 | debian-bookworm | changed 2026-09-29 03:04:54.764746 | 2026-09-29 03:04:54.764821 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-29 03:04:54.790653 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:04:54.795818 | 2026-09-29 03:04:54.795895 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-29 03:04:55.216990 | debian-bookworm -> localhost | changed 2026-09-29 03:04:55.226208 | 2026-09-29 03:04:55.226283 | TASK [add-build-sshkey : Add back temp key] 2026-09-29 03:04:55.572366 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e157b9ded8d64d8190c0dd7c6fe3f8e8/work/e157b9ded8d64d8190c0dd7c6fe3f8e8_id_rsa (zuul-build-sshkey) 2026-09-29 03:04:55.572551 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011788 2026-09-29 03:04:55.581161 | 2026-09-29 03:04:55.581250 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-29 03:04:56.005161 | debian-bookworm | ok 2026-09-29 03:04:56.014381 | 2026-09-29 03:04:56.014486 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-29 03:04:56.057869 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:04:56.069047 | 2026-09-29 03:04:56.069146 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-29 03:04:56.522016 | debian-bookworm | ok 2026-09-29 03:04:56.535279 | 2026-09-29 03:04:56.535391 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-29 03:04:56.562747 | debian-bookworm | ok 2026-09-29 03:04:56.567027 | 2026-09-29 03:04:56.567105 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-29 03:04:56.810315 | debian-bookworm -> localhost | ok 2026-09-29 03:04:56.816594 | 2026-09-29 03:04:56.816680 | TASK [validate-host : Collect information about the host] 2026-09-29 03:04:59.024396 | debian-bookworm | ok 2026-09-29 03:04:59.046581 | 2026-09-29 03:04:59.046853 | TASK [validate-host : Sanitize hostname] 2026-09-29 03:04:59.236024 | debian-bookworm | ok 2026-09-29 03:04:59.247042 | 2026-09-29 03:04:59.247122 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-29 03:05:00.068263 | debian-bookworm -> localhost | changed 2026-09-29 03:05:00.073318 | 2026-09-29 03:05:00.073394 | TASK [validate-host : Collect information about zuul worker] 2026-09-29 03:05:00.776079 | debian-bookworm | ok 2026-09-29 03:05:00.779892 | 2026-09-29 03:05:00.779971 | TASK [validate-host : Write out all zuul information for each host] 2026-09-29 03:05:01.264384 | debian-bookworm -> localhost | changed 2026-09-29 03:05:01.274189 | 2026-09-29 03:05:01.274278 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-29 03:05:01.608659 | debian-bookworm | ok 2026-09-29 03:05:01.618346 | 2026-09-29 03:05:01.618455 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-29 03:05:02.379567 | debian-bookworm | changed: 2026-09-29 03:05:02.379771 | debian-bookworm | cd+++++++++ src/ 2026-09-29 03:05:02.379805 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-29 03:05:02.379830 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-29 03:05:02.379851 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-09-29 03:05:02.379871 | debian-bookworm | =7.0.3 2026-09-29 03:05:41.590439 | debian-bookworm | Downloading cachetools-7.2.0-py3-none-any.whl (16 kB) 2026-09-29 03:05:41.656845 | debian-bookworm | Collecting colorama>=0.4.6 2026-09-29 03:05:41.672507 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-09-29 03:05:41.760334 | debian-bookworm | Collecting filelock>=3.25 2026-09-29 03:05:41.775934 | debian-bookworm | Downloading filelock-4.0.6-py3-none-any.whl (109 kB) 2026-09-29 03:05:41.790826 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 109.1/109.1 kB 10.4 MB/s eta 0:00:00 2026-09-29 03:05:41.847848 | debian-bookworm | Collecting packaging>=26 2026-09-29 03:05:41.863185 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-09-29 03:05:41.879202 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 10.6 MB/s eta 0:00:00 2026-09-29 03:05:41.961817 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-09-29 03:05:41.977334 | debian-bookworm | Downloading platformdirs-4.12.1-py3-none-any.whl (33 kB) 2026-09-29 03:05:42.028178 | debian-bookworm | Collecting pluggy>=1.6 2026-09-29 03:05:42.043029 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-09-29 03:05:42.093477 | debian-bookworm | Collecting pyproject-api>=1.10 2026-09-29 03:05:42.109086 | debian-bookworm | Downloading pyproject_api-1.11.2-py3-none-any.whl (13 kB) 2026-09-29 03:05:42.180366 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-09-29 03:05:42.195621 | debian-bookworm | Downloading python_discovery-1.6.1-py3-none-any.whl (38 kB) 2026-09-29 03:05:42.253965 | debian-bookworm | Collecting tomli-w>=1.2 2026-09-29 03:05:42.269491 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-09-29 03:05:42.357808 | debian-bookworm | Collecting typing-extensions>=4.15 2026-09-29 03:05:42.374615 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-09-29 03:05:42.388103 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 4.3 MB/s eta 0:00:00 2026-09-29 03:05:42.543403 | debian-bookworm | Collecting virtualenv>=21.1 2026-09-29 03:05:42.557755 | debian-bookworm | Downloading virtualenv-21.13.0-py3-none-any.whl (5.5 MB) 2026-09-29 03:05:42.876982 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 17.5 MB/s eta 0:00:00 2026-09-29 03:05:42.987125 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-09-29 03:05:43.001756 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-09-29 03:05:43.026892 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 21.9 MB/s eta 0:00:00 2026-09-29 03:05:43.168776 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-09-29 03:05:44.340925 | debian-bookworm | Successfully installed cachetools-7.2.0 colorama-0.4.6 distlib-0.4.3 filelock-4.0.6 packaging-26.3 platformdirs-4.12.1 pluggy-1.6.0 pyproject-api-1.11.2 python-discovery-1.6.1 tomli-w-1.2.0 tox-4.64.4 typing-extensions-4.16.0 virtualenv-21.13.0 2026-09-29 03:05:44.700662 | debian-bookworm | ok: Runtime: 0:00:04.040636 2026-09-29 03:05:44.708155 | 2026-09-29 03:05:44.708263 | TASK [ensure-tox : Export installed tox_executable path] 2026-09-29 03:05:44.752375 | debian-bookworm | ok 2026-09-29 03:05:44.762847 | 2026-09-29 03:05:44.763018 | TASK [ensure-tox : Output tox version] 2026-09-29 03:05:45.353530 | 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-29 03:05:45.374763 | debian-bookworm | 4.64.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-29 03:05:45.798820 | debian-bookworm | ok: Runtime: 0:00:00.391996 2026-09-29 03:05:45.815256 | 2026-09-29 03:05:45.815393 | TASK [ensure-tox : Make global symlink] 2026-09-29 03:05:45.861086 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:05:45.873485 | 2026-09-29 03:05:45.873599 | PLAY RECAP 2026-09-29 03:05:45.873692 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-09-29 03:05:45.873721 | 2026-09-29 03:05:46.120807 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-09-29 03:05:46.122050 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-29 03:05:46.928623 | 2026-09-29 03:05:46.928827 | PLAY [all] 2026-09-29 03:05:46.944673 | 2026-09-29 03:05:46.944814 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-09-29 03:05:47.493523 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-29 03:05:47.982838 | debian-bookworm | ok: Runtime: 0:00:00.035855 2026-09-29 03:05:47.988995 | 2026-09-29 03:05:47.989135 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-09-29 03:05:48.524587 | debian-bookworm | ok: Runtime: 0:00:00.008623 2026-09-29 03:05:48.533624 | 2026-09-29 03:05:48.533808 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-09-29 03:05:48.920820 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-29 03:05:48.922497 | debian-bookworm | sudo: a password is required 2026-09-29 03:05:49.096575 | debian-bookworm | ok: Runtime: 0:00:00.024369 2026-09-29 03:05:49.117709 | 2026-09-29 03:05:49.117856 | TASK [tox : Check to see if the constraints file exists] 2026-09-29 03:05:49.183981 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:05:49.199794 | 2026-09-29 03:05:49.200181 | TASK [tox : Fail if constraints file is missing] 2026-09-29 03:05:49.256783 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:05:49.264518 | 2026-09-29 03:05:49.264691 | TASK [tox : Record file location] 2026-09-29 03:05:49.329692 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:05:49.349832 | 2026-09-29 03:05:49.350268 | TASK [tox : Install tox siblings] 2026-09-29 03:05:49.404767 | debian-bookworm | ok 2026-09-29 03:05:49.423386 | debian-bookworm | included: /var/lib/zuul/builds/e157b9ded8d64d8190c0dd7c6fe3f8e8/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-09-29 03:05:49.432617 | 2026-09-29 03:05:49.432755 | TASK [tox : Run tox without tests] 2026-09-29 03:05:50.057682 | debian-bookworm | ROOT: 244 D setup logging to DEBUG on pid 1584 [tox/report.py:249] 2026-09-29 03:05:50.093056 | debian-bookworm | seed: 279 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-29 03:05:50.096060 | debian-bookworm | seed: 282 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-29 03:05:50.100856 | debian-bookworm | seed: 287 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 514d6f8113995ecae6c4ed2f66c5ffa5 7dfc7f86098da0f34308eb8c68ee15a0 [python_discovery/_cached_py_info.py:223] 2026-09-29 03:05:50.170954 | debian-bookworm | seed: 357 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-29 03:05:50.171914 | debian-bookworm | seed: 358 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-29 03:05:50.172291 | debian-bookworm | seed: 359 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-29 03:05:50.172586 | debian-bookworm | seed: 359 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-29 03:05:50.176899 | debian-bookworm | seed: 363 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-29 03:05:50.177202 | debian-bookworm | seed: 364 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-29 03:05:50.218206 | debian-bookworm | seed: 405 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/generics/.tox/seed, clear=False, no_vcs_ignore=False, venv_redirect=False, global=False) [virtualenv/run/session.py:77] 2026-09-29 03:05:50.218481 | debian-bookworm | seed: 405 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/bin [virtualenv/util/path/_sync.py:22] 2026-09-29 03:05:50.218637 | debian-bookworm | seed: 405 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/include [virtualenv/util/path/_sync.py:22] 2026-09-29 03:05:50.218734 | debian-bookworm | seed: 405 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-29 03:05:50.218971 | debian-bookworm | seed: 406 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-29 03:05:50.219082 | debian-bookworm | seed: 406 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219143 | debian-bookworm | seed: 406 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219187 | debian-bookworm | seed: 406 D python-version = 3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219254 | debian-bookworm | seed: 406 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219291 | debian-bookworm | seed: 406 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219340 | debian-bookworm | seed: 406 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219393 | debian-bookworm | seed: 406 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/seed [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219445 | debian-bookworm | seed: 406 D virtualenv = 21.13.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219495 | debian-bookworm | seed: 406 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219546 | debian-bookworm | seed: 406 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219593 | debian-bookworm | seed: 406 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219644 | debian-bookworm | seed: 406 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.219953 | debian-bookworm | seed: 407 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-29 03:05:50.220463 | debian-bookworm | seed: 407 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-09-29 03:05:50.220735 | debian-bookworm | seed: 407 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:316] 2026-09-29 03:05:50.254791 | debian-bookworm | seed: 407 D { 2026-09-29 03:05:50.254880 | debian-bookworm | "sys": { 2026-09-29 03:05:50.254889 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/seed/bin/python", 2026-09-29 03:05:50.254901 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-09-29 03:05:50.254914 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-29 03:05:50.254922 | debian-bookworm | "base_prefix": "/usr", 2026-09-29 03:05:50.254930 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-29 03:05:50.254936 | debian-bookworm | "base_exec_prefix": "/usr", 2026-09-29 03:05:50.254942 | debian-bookworm | "path": [ 2026-09-29 03:05:50.254949 | debian-bookworm | "/usr/lib/python311.zip", 2026-09-29 03:05:50.254955 | debian-bookworm | "/usr/lib/python3.11", 2026-09-29 03:05:50.254961 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-09-29 03:05:50.254967 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages" 2026-09-29 03:05:50.254974 | debian-bookworm | ], 2026-09-29 03:05:50.254981 | debian-bookworm | "meta_path": [ 2026-09-29 03:05:50.254987 | debian-bookworm | "", 2026-09-29 03:05:50.254994 | debian-bookworm | "", 2026-09-29 03:05:50.255001 | debian-bookworm | "" 2026-09-29 03:05:50.255007 | debian-bookworm | ], 2026-09-29 03:05:50.255015 | debian-bookworm | "fs_encoding": "utf-8", 2026-09-29 03:05:50.255020 | debian-bookworm | "io_encoding": "utf-8" 2026-09-29 03:05:50.255024 | debian-bookworm | }, 2026-09-29 03:05:50.255029 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-09-29 03:05:50.255033 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-09-29 03:05:50.255037 | debian-bookworm | "os": "", 2026-09-29 03:05:50.255042 | debian-bookworm | "site": "", 2026-09-29 03:05:50.255046 | debian-bookworm | "datetime": "", 2026-09-29 03:05:50.255050 | debian-bookworm | "math": "", 2026-09-29 03:05:50.255059 | debian-bookworm | "json": "" 2026-09-29 03:05:50.255064 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-09-29 03:05:50.255290 | debian-bookworm | seed: 442 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-29 03:05:50.261409 | debian-bookworm | seed: 448 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-29 03:05:50.262157 | debian-bookworm | seed: 449 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-29 03:05:50.263743 | debian-bookworm | seed: 450 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-29 03:05:50.264252 | debian-bookworm | seed: 451 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-29 03:05:50.596420 | debian-bookworm | seed: 783 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-29 03:05:50.597109 | debian-bookworm | seed: 784 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-29 03:05:50.598309 | debian-bookworm | seed: 785 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-29 03:05:50.600078 | debian-bookworm | seed: 786 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-29 03:05:50.748115 | debian-bookworm | seed: 935 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-29 03:05:50.748835 | debian-bookworm | seed: 935 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-29 03:05:50.769915 | debian-bookworm | seed: 956 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-29 03:05:50.773807 | debian-bookworm | seed: 960 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-29 03:05:50.807498 | debian-bookworm | seed: 994 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-29 03:05:50.812126 | debian-bookworm | seed: 999 D generated console scripts pip3.11 pip pip3 pip-3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-29 03:05:50.812665 | debian-bookworm | seed: 999 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-09-29 03:05:50.822606 | debian-bookworm | seed: 1009 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-29 03:05:50.822718 | debian-bookworm | seed: 1009 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.822825 | debian-bookworm | seed: 1009 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.822925 | debian-bookworm | seed: 1010 D python-version = 3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.823020 | debian-bookworm | seed: 1010 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.823133 | debian-bookworm | seed: 1010 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.823228 | debian-bookworm | seed: 1010 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.823310 | debian-bookworm | seed: 1010 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/seed [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.823398 | debian-bookworm | seed: 1010 D virtualenv = 21.13.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.823493 | debian-bookworm | seed: 1010 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.823589 | debian-bookworm | seed: 1010 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.823679 | debian-bookworm | seed: 1010 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.823771 | debian-bookworm | seed: 1010 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-29 03:05:50.828780 | debian-bookworm | seed: OK (0.74 seconds) 2026-09-29 03:05:50.828814 | debian-bookworm | congratulations :) (0.77 seconds) 2026-09-29 03:05:51.003106 | debian-bookworm | ok: Runtime: 0:00:01.147740 2026-09-29 03:05:51.013909 | 2026-09-29 03:05:51.014037 | TASK [tox : Create a tempfile to save tox showconfig] 2026-09-29 03:05:51.780148 | debian-bookworm | changed 2026-09-29 03:05:51.785407 | 2026-09-29 03:05:51.785683 | TASK [tox : Detect tox version] 2026-09-29 03:05:52.463528 | debian-bookworm | 4.64.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-29 03:05:52.817575 | debian-bookworm | ok: Runtime: 0:00:00.453423 2026-09-29 03:05:52.823964 | 2026-09-29 03:05:52.824097 | TASK [tox : Get tox envlist config] 2026-09-29 03:05:53.875935 | debian-bookworm | ok: Runtime: 0:00:00.496759 2026-09-29 03:05:53.888569 | 2026-09-29 03:05:53.888746 | TASK [tox : Install any sibling python packages] 2026-09-29 03:05:54.407085 | debian-bookworm | ok: No setup.cfg, no action needed 2026-09-29 03:05:54.423365 | 2026-09-29 03:05:54.423504 | TASK [tox : Remove tempfile] 2026-09-29 03:05:55.061918 | debian-bookworm | changed 2026-09-29 03:05:55.080545 | 2026-09-29 03:05:55.080689 | TASK [tox : Emit tox command] 2026-09-29 03:05:55.150191 | /home/zuul/.local/tox/bin/tox -eseed -vv --skip-missing-interpreters=false 2026-09-29 03:05:55.155206 | 2026-09-29 03:05:55.155329 | TASK [tox : Run tox] 2026-09-29 03:05:55.711844 | debian-bookworm | ROOT: 246 D setup logging to DEBUG on pid 1624 [tox/report.py:249] 2026-09-29 03:05:55.748274 | debian-bookworm | seed: 282 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-29 03:05:55.751628 | debian-bookworm | seed: 285 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-29 03:05:55.756634 | debian-bookworm | seed: 290 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-29 03:05:55.757139 | debian-bookworm | seed: 291 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-29 03:05:55.757286 | debian-bookworm | seed: 291 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-29 03:05:55.757373 | debian-bookworm | seed: 291 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-29 03:05:55.759247 | debian-bookworm | seed: 293 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-29 03:05:55.759458 | debian-bookworm | seed: 293 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-29 03:05:55.793305 | debian-bookworm | seed: 327 W commands[0]> bash src/test-seed.sh [tox/tox_env/api.py:496] 2026-09-29 03:05:56.406834 | debian-bookworm | PASS=44 FAIL=0 2026-09-29 03:05:56.408895 | debian-bookworm | seed: 943 I exit 0 (0.61 seconds) /home/zuul/src/github.com/osism/generics> bash src/test-seed.sh pid=1631 [tox/execute/api.py:337] 2026-09-29 03:05:56.410003 | debian-bookworm | seed: OK (0.67=setup[0.05]+cmd[0.61] seconds) 2026-09-29 03:05:56.410030 | debian-bookworm | congratulations :) (0.70 seconds) 2026-09-29 03:05:56.697717 | debian-bookworm | ok: Runtime: 0:00:01.055271 2026-09-29 03:05:56.703204 | 2026-09-29 03:05:56.703290 | TASK [tox : Look for output] 2026-09-29 03:05:57.194864 | debian-bookworm | ok 2026-09-29 03:05:57.219112 | 2026-09-29 03:05:57.219209 | TASK [tox : Return file comments to Zuul] 2026-09-29 03:05:57.263504 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:05:57.278549 | 2026-09-29 03:05:57.278614 | PLAY RECAP 2026-09-29 03:05:57.278723 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-29 03:05:57.278745 | 2026-09-29 03:05:57.411105 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-29 03:05:57.412039 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-29 03:05:58.483017 | 2026-09-29 03:05:58.483136 | PLAY [all] 2026-09-29 03:05:58.516118 | 2026-09-29 03:05:58.516225 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-09-29 03:05:58.600813 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:05:58.605710 | 2026-09-29 03:05:58.605829 | TASK [fetch-tox-output : Set tox log path for single node] 2026-09-29 03:05:58.653472 | debian-bookworm | ok 2026-09-29 03:05:58.659562 | 2026-09-29 03:05:58.659666 | TASK [fetch-tox-output : Ensure local tox dir] 2026-09-29 03:05:59.321456 | debian-bookworm -> localhost | changed 2026-09-29 03:05:59.331917 | 2026-09-29 03:05:59.332022 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-09-29 03:05:59.481838 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:05:59.494417 | 2026-09-29 03:05:59.494529 | TASK [fetch-tox-output : Set envlist fact] 2026-09-29 03:05:59.530368 | debian-bookworm | ok 2026-09-29 03:05:59.539191 | 2026-09-29 03:05:59.539278 | TASK [fetch-tox-output : Get tox version] 2026-09-29 03:06:00.316794 | 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-29 03:06:00.336801 | debian-bookworm | 4.64.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-29 03:06:00.576830 | debian-bookworm | ok: Runtime: 0:00:00.360116 2026-09-29 03:06:00.581519 | 2026-09-29 03:06:00.581623 | TASK [fetch-tox-output : Find all default environments] 2026-09-29 03:06:01.153361 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:01.158276 | 2026-09-29 03:06:01.158360 | TASK [fetch-tox-output : Set envlist fact] 2026-09-29 03:06:01.201227 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:01.205776 | 2026-09-29 03:06:01.205852 | TASK [fetch-tox-output : Find all default environments] 2026-09-29 03:06:01.755217 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:01.767782 | 2026-09-29 03:06:01.767906 | TASK [fetch-tox-output : Set envlist fact] 2026-09-29 03:06:01.816436 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:01.834677 | 2026-09-29 03:06:01.834793 | LOOP [fetch-tox-output : Copy tox logs] 2026-09-29 03:06:01.948774 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:01.960598 | 2026-09-29 03:06:01.960754 | LOOP [fetch-tox-output : Collect tox logs] 2026-09-29 03:06:03.025207 | debian-bookworm | changed: 2026-09-29 03:06:03.025424 | debian-bookworm | created directory /var/lib/zuul/builds/e157b9ded8d64d8190c0dd7c6fe3f8e8/work/logs/tox/seed 2026-09-29 03:06:03.025460 | debian-bookworm | cd+++++++++ ./ 2026-09-29 03:06:03.025485 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-09-29 03:06:03.025516 | 2026-09-29 03:06:03.032645 | 2026-09-29 03:06:03.032728 | PLAY RECAP 2026-09-29 03:06:03.032772 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-09-29 03:06:03.032792 | 2026-09-29 03:06:03.200467 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-29 03:06:03.201297 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-29 03:06:04.112322 | 2026-09-29 03:06:04.112428 | PLAY [all] 2026-09-29 03:06:04.123656 | 2026-09-29 03:06:04.123741 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-09-29 03:06:04.345938 | debian-bookworm | changed: non-zero return code 2026-09-29 03:06:04.352358 | 2026-09-29 03:06:04.352454 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-09-29 03:06:04.375281 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:04.383372 | 2026-09-29 03:06:04.383525 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-09-29 03:06:04.433952 | 2026-09-29 03:06:04.434103 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-09-29 03:06:04.490938 | 2026-09-29 03:06:04.491207 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-09-29 03:06:04.525332 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:04.531558 | 2026-09-29 03:06:04.531663 | LOOP [fetch-subunit-output : Generate subunit file] 2026-09-29 03:06:04.558928 | 2026-09-29 03:06:04.559076 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-09-29 03:06:04.613849 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:04.619756 | 2026-09-29 03:06:04.619843 | TASK [fetch-subunit-output : Remove the temporary file] 2026-09-29 03:06:04.655636 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:04.660378 | 2026-09-29 03:06:04.660457 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-09-29 03:06:04.685500 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:04.690651 | 2026-09-29 03:06:04.690711 | PLAY RECAP 2026-09-29 03:06:04.690754 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-09-29 03:06:04.690776 | 2026-09-29 03:06:04.796545 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-29 03:06:04.799245 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-29 03:06:06.225431 | 2026-09-29 03:06:06.227819 | PLAY [Base post-fetch] 2026-09-29 03:06:06.279757 | 2026-09-29 03:06:06.281677 | TASK [diagnose-network : Ensure log directory exists] 2026-09-29 03:06:06.891333 | debian-bookworm | ok 2026-09-29 03:06:06.900781 | 2026-09-29 03:06:06.900915 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-09-29 03:06:18.834816 | debian-bookworm | ok: Runtime: 0:00:08.480269 2026-09-29 03:06:18.844473 | 2026-09-29 03:06:18.844578 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-09-29 03:06:24.935803 | debian-bookworm | ok: Runtime: 0:00:00.005318 2026-09-29 03:06:24.940933 | 2026-09-29 03:06:24.941027 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-09-29 03:06:31.107476 | debian-bookworm | ok: Runtime: 0:00:00.008111 2026-09-29 03:06:31.113219 | 2026-09-29 03:06:31.113307 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)] 2026-09-29 03:06:31.643934 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:31.661038 | 2026-09-29 03:06:31.661165 | TASK [diagnose-network : Abort the pre-run on a fully isolated node] 2026-09-29 03:06:31.708734 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:31.724222 | 2026-09-29 03:06:31.724323 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-29 03:06:31.770016 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:31.776510 | 2026-09-29 03:06:31.776620 | TASK [fetch-output : Set log path for single node] 2026-09-29 03:06:31.805671 | debian-bookworm | ok 2026-09-29 03:06:31.812101 | 2026-09-29 03:06:31.812189 | LOOP [fetch-output : Ensure local output dirs] 2026-09-29 03:06:32.221345 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/e157b9ded8d64d8190c0dd7c6fe3f8e8/work/logs" 2026-09-29 03:06:32.495738 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e157b9ded8d64d8190c0dd7c6fe3f8e8/work/artifacts" 2026-09-29 03:06:32.820247 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e157b9ded8d64d8190c0dd7c6fe3f8e8/work/docs" 2026-09-29 03:06:32.843011 | 2026-09-29 03:06:32.843164 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-29 03:06:33.602844 | debian-bookworm | changed: 2026-09-29 03:06:33.603178 | debian-bookworm | .d..t...... ./ 2026-09-29 03:06:33.603222 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-29 03:06:33.603247 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-29 03:06:33.603366 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-29 03:06:33.603396 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-29 03:06:33.603418 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-29 03:06:33.603493 | debian-bookworm | changed: All items complete 2026-09-29 03:06:33.603523 | 2026-09-29 03:06:34.133893 | debian-bookworm | changed: .d..t...... ./ 2026-09-29 03:06:34.751955 | debian-bookworm | changed: .d..t...... ./ 2026-09-29 03:06:34.772403 | 2026-09-29 03:06:34.772506 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-29 03:06:34.822246 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:34.830296 | debian-bookworm | skipping: Conditional result was False 2026-09-29 03:06:34.839363 | 2026-09-29 03:06:34.839433 | PLAY RECAP 2026-09-29 03:06:34.839482 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-29 03:06:34.839506 | 2026-09-29 03:06:34.954868 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-29 03:06:34.955886 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-29 03:06:35.802649 | 2026-09-29 03:06:35.802885 | PLAY [Base post] 2026-09-29 03:06:35.821496 | 2026-09-29 03:06:35.821671 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-29 03:06:36.349175 | debian-bookworm | changed 2026-09-29 03:06:36.355701 | 2026-09-29 03:06:36.355786 | PLAY RECAP 2026-09-29 03:06:36.355844 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-29 03:06:36.355936 | 2026-09-29 03:06:36.444047 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-29 03:06:36.445046 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-29 03:06:37.227052 | 2026-09-29 03:06:37.227163 | PLAY [Base post-logs] 2026-09-29 03:06:37.243499 | 2026-09-29 03:06:37.243613 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-29 03:06:37.995148 | localhost | changed 2026-09-29 03:06:38.002998 | 2026-09-29 03:06:38.003098 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-29 03:06:38.027461 | localhost | ok 2026-09-29 03:06:38.029732 | 2026-09-29 03:06:38.029800 | TASK [Set zuul-log-path fact] 2026-09-29 03:06:38.043050 | localhost | ok 2026-09-29 03:06:38.049186 | 2026-09-29 03:06:38.049261 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-29 03:06:38.072844 | localhost | ok 2026-09-29 03:06:38.075123 | 2026-09-29 03:06:38.075191 | TASK [upload-logs : Create log directories] 2026-09-29 03:06:38.610746 | localhost | changed 2026-09-29 03:06:38.613212 | 2026-09-29 03:06:38.613296 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-29 03:06:39.090703 | localhost -> localhost | ok: Runtime: 0:00:00.005177 2026-09-29 03:06:39.094621 | 2026-09-29 03:06:39.094728 | TASK [upload-logs : Upload logs to log server] 2026-09-29 03:06:39.630147 | localhost | Output suppressed because no_log was given 2026-09-29 03:06:39.631887 | 2026-09-29 03:06:39.631982 | LOOP [upload-logs : Compress console log and json output] 2026-09-29 03:06:39.676239 | localhost | skipping: Conditional result was False 2026-09-29 03:06:39.681873 | localhost | skipping: Conditional result was False 2026-09-29 03:06:39.688780 | 2026-09-29 03:06:39.688884 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-29 03:06:39.742753 | localhost | skipping: Conditional result was False 2026-09-29 03:06:39.742991 | 2026-09-29 03:06:39.744665 | localhost | skipping: Conditional result was False 2026-09-29 03:06:39.756002 | 2026-09-29 03:06:39.756107 | LOOP [upload-logs : Upload console log and json output]