2026-09-24 23:41:02.699465 | Job console starting 2026-09-24 23:41:02.713951 | Updating git repos 2026-09-24 23:41:02.779462 | Cloning repos into workspace 2026-09-24 23:41:02.856624 | Restoring repo states 2026-09-24 23:41:02.877481 | Merging changes 2026-09-24 23:41:03.775012 | Checking out repos 2026-09-24 23:41:03.886716 | Preparing playbooks 2026-09-24 23:41:06.177724 | Running Ansible setup 2026-09-24 23:41:14.435901 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-24 23:41:15.290547 | 2026-09-24 23:41:15.290655 | PLAY [Base pre] 2026-09-24 23:41:15.305852 | 2026-09-24 23:41:15.306001 | TASK [Setup log path fact] 2026-09-24 23:41:15.323460 | debian-bookworm | ok 2026-09-24 23:41:15.338111 | 2026-09-24 23:41:15.338216 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-24 23:41:15.365602 | debian-bookworm | ok 2026-09-24 23:41:15.375407 | 2026-09-24 23:41:15.375501 | TASK [emit-job-header : Print job information] 2026-09-24 23:41:15.425058 | # Job Information 2026-09-24 23:41:15.425189 | Ansible Version: 2.16.14 2026-09-24 23:41:15.425219 | Job: generics-tox-seed 2026-09-24 23:41:15.425245 | Pipeline: check 2026-09-24 23:41:15.425265 | Executor: 521e9411259a 2026-09-24 23:41:15.425282 | Triggered by: https://github.com/osism/generics/pull/609 2026-09-24 23:41:15.425300 | Event ID: 484199b0-b871-11f1-96bd-da83bc875806 2026-09-24 23:41:15.429499 | 2026-09-24 23:41:15.429585 | LOOP [emit-job-header : Print node information] 2026-09-24 23:41:15.571457 | debian-bookworm | ok: 2026-09-24 23:41:15.571700 | debian-bookworm | # Node Information 2026-09-24 23:41:15.571736 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-24 23:41:15.571757 | debian-bookworm | Hostname: debian 2026-09-24 23:41:15.571776 | debian-bookworm | Username: zuul 2026-09-24 23:41:15.571793 | debian-bookworm | Distro: Debian 12.15 2026-09-24 23:41:15.571813 | debian-bookworm | Provider: regiocloud-a 2026-09-24 23:41:15.571830 | debian-bookworm | Region: 2026-09-24 23:41:15.571847 | debian-bookworm | Label: debian-bookworm 2026-09-24 23:41:15.571863 | debian-bookworm | Product Name: OpenStack Nova 2026-09-24 23:41:15.571879 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe75:75de 2026-09-24 23:41:15.582905 | 2026-09-24 23:41:15.583013 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-24 23:41:16.393460 | debian-bookworm -> localhost | changed 2026-09-24 23:41:16.401783 | 2026-09-24 23:41:16.402234 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-24 23:41:17.744942 | debian-bookworm -> localhost | changed 2026-09-24 23:41:17.754103 | 2026-09-24 23:41:17.754197 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-24 23:41:18.324767 | debian-bookworm -> localhost | ok 2026-09-24 23:41:18.330313 | 2026-09-24 23:41:18.330398 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-24 23:41:18.359024 | debian-bookworm | ok 2026-09-24 23:41:18.373483 | debian-bookworm | included: /var/lib/zuul/builds/0ce7f7a48b3d42d585ae96e22759c083/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-24 23:41:18.378822 | 2026-09-24 23:41:18.378896 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-24 23:41:20.048754 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-24 23:41:20.049013 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0ce7f7a48b3d42d585ae96e22759c083/work/0ce7f7a48b3d42d585ae96e22759c083_id_rsa 2026-09-24 23:41:20.049065 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0ce7f7a48b3d42d585ae96e22759c083/work/0ce7f7a48b3d42d585ae96e22759c083_id_rsa.pub 2026-09-24 23:41:20.049092 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-24 23:41:20.049116 | debian-bookworm -> localhost | SHA256:2IsxHxa59VbYDtQcG6xYZuAdRYhUCr7xS5o0c5fIst4 zuul-build-sshkey 2026-09-24 23:41:20.049139 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-24 23:41:20.049169 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-24 23:41:20.049191 | debian-bookworm -> localhost | | ..o++B=. | 2026-09-24 23:41:20.049213 | debian-bookworm -> localhost | | . +.+=++o | 2026-09-24 23:41:20.049232 | debian-bookworm -> localhost | | = +=+.+ | 2026-09-24 23:41:20.049252 | debian-bookworm -> localhost | | o O.o.= | 2026-09-24 23:41:20.049271 | debian-bookworm -> localhost | | + S * = . | 2026-09-24 23:41:20.049297 | debian-bookworm -> localhost | | B % + | 2026-09-24 23:41:20.049317 | debian-bookworm -> localhost | | . * . | 2026-09-24 23:41:20.049337 | debian-bookworm -> localhost | | . . | 2026-09-24 23:41:20.049359 | debian-bookworm -> localhost | | . E | 2026-09-24 23:41:20.049379 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-24 23:41:20.049438 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.007539 2026-09-24 23:41:20.056120 | 2026-09-24 23:41:20.056218 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-24 23:41:20.085475 | debian-bookworm | ok 2026-09-24 23:41:20.096563 | debian-bookworm | included: /var/lib/zuul/builds/0ce7f7a48b3d42d585ae96e22759c083/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-24 23:41:20.115004 | 2026-09-24 23:41:20.115112 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-24 23:41:20.128625 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:41:20.135297 | 2026-09-24 23:41:20.135399 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-24 23:41:20.843716 | debian-bookworm | changed 2026-09-24 23:41:20.849095 | 2026-09-24 23:41:20.849190 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-24 23:41:21.150232 | debian-bookworm | ok 2026-09-24 23:41:21.163978 | 2026-09-24 23:41:21.164102 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-24 23:41:22.091323 | debian-bookworm | changed 2026-09-24 23:41:22.105112 | 2026-09-24 23:41:22.105204 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-24 23:41:23.020443 | debian-bookworm | changed 2026-09-24 23:41:23.025949 | 2026-09-24 23:41:23.026083 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-24 23:41:23.038939 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:41:23.044965 | 2026-09-24 23:41:23.045062 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-24 23:41:23.845955 | debian-bookworm -> localhost | changed 2026-09-24 23:41:23.854561 | 2026-09-24 23:41:23.854643 | TASK [add-build-sshkey : Add back temp key] 2026-09-24 23:41:24.506232 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0ce7f7a48b3d42d585ae96e22759c083/work/0ce7f7a48b3d42d585ae96e22759c083_id_rsa (zuul-build-sshkey) 2026-09-24 23:41:24.506415 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025860 2026-09-24 23:41:24.512479 | 2026-09-24 23:41:24.512551 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-24 23:41:25.086438 | debian-bookworm | ok 2026-09-24 23:41:25.090598 | 2026-09-24 23:41:25.090668 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-24 23:41:25.127050 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:41:25.135740 | 2026-09-24 23:41:25.135821 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-24 23:41:25.681636 | debian-bookworm | ok 2026-09-24 23:41:25.690454 | 2026-09-24 23:41:25.690531 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-24 23:41:25.717628 | debian-bookworm | ok 2026-09-24 23:41:25.721558 | 2026-09-24 23:41:25.721636 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-24 23:41:26.626042 | debian-bookworm -> localhost | ok 2026-09-24 23:41:26.631447 | 2026-09-24 23:41:26.631520 | TASK [validate-host : Collect information about the host] 2026-09-24 23:41:28.067109 | debian-bookworm | ok 2026-09-24 23:41:28.077179 | 2026-09-24 23:41:28.077255 | TASK [validate-host : Sanitize hostname] 2026-09-24 23:41:28.253245 | debian-bookworm | ok 2026-09-24 23:41:28.258514 | 2026-09-24 23:41:28.258603 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-24 23:41:29.082867 | debian-bookworm -> localhost | changed 2026-09-24 23:41:29.087695 | 2026-09-24 23:41:29.087774 | TASK [validate-host : Collect information about zuul worker] 2026-09-24 23:41:29.581939 | debian-bookworm | ok 2026-09-24 23:41:29.586610 | 2026-09-24 23:41:29.586689 | TASK [validate-host : Write out all zuul information for each host] 2026-09-24 23:41:30.508191 | debian-bookworm -> localhost | changed 2026-09-24 23:41:30.515583 | 2026-09-24 23:41:30.515658 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-24 23:41:30.838277 | debian-bookworm | ok 2026-09-24 23:41:30.842703 | 2026-09-24 23:41:30.842785 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-24 23:41:32.095909 | debian-bookworm | changed: 2026-09-24 23:41:32.096079 | debian-bookworm | cd+++++++++ src/ 2026-09-24 23:41:32.096110 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-24 23:41:32.096131 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-24 23:41:32.096148 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-09-24 23:41:32.096165 | debian-bookworm | =7.0.3 2026-09-24 23:42:10.966485 | debian-bookworm | Downloading cachetools-7.2.0-py3-none-any.whl (16 kB) 2026-09-24 23:42:11.034572 | debian-bookworm | Collecting colorama>=0.4.6 2026-09-24 23:42:11.047082 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-09-24 23:42:11.132773 | debian-bookworm | Collecting filelock>=3.25 2026-09-24 23:42:11.146878 | debian-bookworm | Downloading filelock-4.0.3-py3-none-any.whl (108 kB) 2026-09-24 23:42:11.164905 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 108.4/108.4 kB 8.9 MB/s eta 0:00:00 2026-09-24 23:42:11.227049 | debian-bookworm | Collecting packaging>=26 2026-09-24 23:42:11.239288 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-09-24 23:42:11.259263 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 7.9 MB/s eta 0:00:00 2026-09-24 23:42:11.349260 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-09-24 23:42:11.361689 | debian-bookworm | Downloading platformdirs-4.11.12-py3-none-any.whl (24 kB) 2026-09-24 23:42:11.414330 | debian-bookworm | Collecting pluggy>=1.6 2026-09-24 23:42:11.428239 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-09-24 23:42:11.494530 | debian-bookworm | Collecting pyproject-api>=1.10 2026-09-24 23:42:11.508189 | debian-bookworm | Downloading pyproject_api-1.11.2-py3-none-any.whl (13 kB) 2026-09-24 23:42:11.567863 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-09-24 23:42:11.579544 | debian-bookworm | Downloading python_discovery-1.6.1-py3-none-any.whl (38 kB) 2026-09-24 23:42:11.631695 | debian-bookworm | Collecting tomli-w>=1.2 2026-09-24 23:42:11.643536 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-09-24 23:42:11.720231 | debian-bookworm | Collecting typing-extensions>=4.15 2026-09-24 23:42:11.731912 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-09-24 23:42:11.742617 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 5.7 MB/s eta 0:00:00 2026-09-24 23:42:11.913302 | debian-bookworm | Collecting virtualenv>=21.1 2026-09-24 23:42:11.926920 | debian-bookworm | Downloading virtualenv-21.12.1-py3-none-any.whl (5.5 MB) 2026-09-24 23:42:12.238117 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 18.0 MB/s eta 0:00:00 2026-09-24 23:42:12.346525 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-09-24 23:42:12.358555 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-09-24 23:42:12.436288 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 6.5 MB/s eta 0:00:00 2026-09-24 23:42:12.560386 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-09-24 23:42:13.676858 | debian-bookworm | Successfully installed cachetools-7.2.0 colorama-0.4.6 distlib-0.4.3 filelock-4.0.3 packaging-26.3 platformdirs-4.11.12 pluggy-1.6.0 pyproject-api-1.11.2 python-discovery-1.6.1 tomli-w-1.2.0 tox-4.64.2 typing-extensions-4.16.0 virtualenv-21.12.1 2026-09-24 23:42:14.265791 | debian-bookworm | ok: Runtime: 0:00:03.923107 2026-09-24 23:42:14.273161 | 2026-09-24 23:42:14.273253 | TASK [ensure-tox : Export installed tox_executable path] 2026-09-24 23:42:14.322769 | debian-bookworm | ok 2026-09-24 23:42:14.329075 | 2026-09-24 23:42:14.329167 | TASK [ensure-tox : Output tox version] 2026-09-24 23:42:14.849748 | 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-24 23:42:14.870106 | debian-bookworm | 4.64.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-24 23:42:15.363592 | debian-bookworm | ok: Runtime: 0:00:00.398227 2026-09-24 23:42:15.372259 | 2026-09-24 23:42:15.372412 | TASK [ensure-tox : Make global symlink] 2026-09-24 23:42:15.399077 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:15.408918 | 2026-09-24 23:42:15.409013 | PLAY RECAP 2026-09-24 23:42:15.409141 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-09-24 23:42:15.409175 | 2026-09-24 23:42:15.599447 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-09-24 23:42:15.600623 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-24 23:42:16.471952 | 2026-09-24 23:42:16.472126 | PLAY [all] 2026-09-24 23:42:16.501850 | 2026-09-24 23:42:16.501993 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-09-24 23:42:17.162802 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-24 23:42:17.536782 | debian-bookworm | ok: Runtime: 0:00:00.034032 2026-09-24 23:42:17.544337 | 2026-09-24 23:42:17.544481 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-09-24 23:42:18.074127 | debian-bookworm | ok: Runtime: 0:00:00.006698 2026-09-24 23:42:18.087897 | 2026-09-24 23:42:18.088095 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-09-24 23:42:18.369139 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-24 23:42:18.369274 | debian-bookworm | sudo: a password is required 2026-09-24 23:42:18.628843 | debian-bookworm | ok: Runtime: 0:00:00.026113 2026-09-24 23:42:18.639673 | 2026-09-24 23:42:18.639797 | TASK [tox : Check to see if the constraints file exists] 2026-09-24 23:42:18.689065 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:18.695736 | 2026-09-24 23:42:18.695862 | TASK [tox : Fail if constraints file is missing] 2026-09-24 23:42:18.776900 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:18.783916 | 2026-09-24 23:42:18.784081 | TASK [tox : Record file location] 2026-09-24 23:42:18.809225 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:18.815332 | 2026-09-24 23:42:18.815460 | TASK [tox : Install tox siblings] 2026-09-24 23:42:18.847822 | debian-bookworm | ok 2026-09-24 23:42:18.858023 | debian-bookworm | included: /var/lib/zuul/builds/0ce7f7a48b3d42d585ae96e22759c083/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-09-24 23:42:18.863767 | 2026-09-24 23:42:18.863875 | TASK [tox : Run tox without tests] 2026-09-24 23:42:19.406824 | debian-bookworm | ROOT: 232 D setup logging to DEBUG on pid 1581 [tox/report.py:249] 2026-09-24 23:42:19.440393 | debian-bookworm | seed: 265 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-24 23:42:19.443155 | debian-bookworm | seed: 268 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-24 23:42:19.447343 | debian-bookworm | seed: 273 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 16a166dc664692a9872107a9572ed0f0 b2e49160a761f6cd45c02ae9e1dcfde9 [python_discovery/_cached_py_info.py:223] 2026-09-24 23:42:19.533338 | debian-bookworm | seed: 358 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-24 23:42:19.534616 | debian-bookworm | seed: 360 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-24 23:42:19.534955 | debian-bookworm | seed: 360 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-24 23:42:19.535287 | debian-bookworm | seed: 360 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-24 23:42:19.539563 | debian-bookworm | seed: 365 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-24 23:42:19.539832 | debian-bookworm | seed: 365 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-24 23:42:19.580809 | debian-bookworm | seed: 406 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-24 23:42:19.581071 | debian-bookworm | seed: 406 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/bin [virtualenv/util/path/_sync.py:22] 2026-09-24 23:42:19.581215 | debian-bookworm | seed: 407 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/include [virtualenv/util/path/_sync.py:22] 2026-09-24 23:42:19.581307 | debian-bookworm | seed: 407 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-24 23:42:19.581541 | debian-bookworm | seed: 407 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-24 23:42:19.581661 | debian-bookworm | seed: 407 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.581723 | debian-bookworm | seed: 407 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.581763 | debian-bookworm | seed: 407 D python-version = 3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.581829 | debian-bookworm | seed: 407 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.581879 | debian-bookworm | seed: 407 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.581929 | debian-bookworm | seed: 407 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.581984 | debian-bookworm | seed: 407 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-24 23:42:19.582039 | debian-bookworm | seed: 407 D virtualenv = 21.12.1 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.582088 | debian-bookworm | seed: 407 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.582138 | debian-bookworm | seed: 408 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.582185 | debian-bookworm | seed: 408 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.582233 | debian-bookworm | seed: 408 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:19.582552 | debian-bookworm | seed: 408 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-24 23:42:19.583027 | debian-bookworm | seed: 408 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-09-24 23:42:19.583559 | debian-bookworm | seed: 409 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-24 23:42:19.625941 | debian-bookworm | seed: 408 D { 2026-09-24 23:42:19.626033 | debian-bookworm | "sys": { 2026-09-24 23:42:19.626039 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/seed/bin/python", 2026-09-24 23:42:19.626050 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-09-24 23:42:19.626058 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-24 23:42:19.626065 | debian-bookworm | "base_prefix": "/usr", 2026-09-24 23:42:19.626071 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-24 23:42:19.626075 | debian-bookworm | "base_exec_prefix": "/usr", 2026-09-24 23:42:19.626080 | debian-bookworm | "path": [ 2026-09-24 23:42:19.626084 | debian-bookworm | "/usr/lib/python311.zip", 2026-09-24 23:42:19.626088 | debian-bookworm | "/usr/lib/python3.11", 2026-09-24 23:42:19.626092 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-09-24 23:42:19.626096 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages" 2026-09-24 23:42:19.626101 | debian-bookworm | ], 2026-09-24 23:42:19.626105 | debian-bookworm | "meta_path": [ 2026-09-24 23:42:19.626109 | debian-bookworm | "", 2026-09-24 23:42:19.626114 | debian-bookworm | "", 2026-09-24 23:42:19.626118 | debian-bookworm | "" 2026-09-24 23:42:19.626122 | debian-bookworm | ], 2026-09-24 23:42:19.626126 | debian-bookworm | "fs_encoding": "utf-8", 2026-09-24 23:42:19.626130 | debian-bookworm | "io_encoding": "utf-8" 2026-09-24 23:42:19.626134 | debian-bookworm | }, 2026-09-24 23:42:19.626138 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-09-24 23:42:19.626142 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-09-24 23:42:19.626146 | debian-bookworm | "os": "", 2026-09-24 23:42:19.626150 | debian-bookworm | "site": "", 2026-09-24 23:42:19.626153 | debian-bookworm | "datetime": "", 2026-09-24 23:42:19.626157 | debian-bookworm | "math": "", 2026-09-24 23:42:19.626167 | debian-bookworm | "json": "" 2026-09-24 23:42:19.626172 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-09-24 23:42:19.626520 | debian-bookworm | seed: 451 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-24 23:42:19.637874 | debian-bookworm | seed: 463 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-24 23:42:19.645107 | debian-bookworm | seed: 465 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-24 23:42:19.646630 | debian-bookworm | seed: 472 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-24 23:42:19.649155 | debian-bookworm | seed: 474 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-24 23:42:20.037929 | debian-bookworm | seed: 863 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-24 23:42:20.038767 | debian-bookworm | seed: 864 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-24 23:42:20.043954 | debian-bookworm | seed: 869 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-24 23:42:20.045974 | debian-bookworm | seed: 871 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-24 23:42:20.160977 | debian-bookworm | seed: 986 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-24 23:42:20.257998 | debian-bookworm | seed: 1083 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-24 23:42:20.259050 | debian-bookworm | seed: 1084 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-24 23:42:20.288170 | debian-bookworm | seed: 1113 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-24 23:42:20.292819 | debian-bookworm | seed: 1118 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-24 23:42:20.294029 | debian-bookworm | seed: 1119 D generated console scripts pip pip-3.11 pip3 pip3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-24 23:42:20.294910 | debian-bookworm | seed: 1120 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-09-24 23:42:20.307486 | debian-bookworm | seed: 1133 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-24 23:42:20.307605 | debian-bookworm | seed: 1133 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.307615 | debian-bookworm | seed: 1133 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.307771 | debian-bookworm | seed: 1133 D python-version = 3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.307993 | debian-bookworm | seed: 1133 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.308154 | debian-bookworm | seed: 1133 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.308311 | debian-bookworm | seed: 1134 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.308377 | debian-bookworm | seed: 1134 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-24 23:42:20.308517 | debian-bookworm | seed: 1134 D virtualenv = 21.12.1 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.308616 | debian-bookworm | seed: 1134 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.308709 | debian-bookworm | seed: 1134 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.308805 | debian-bookworm | seed: 1134 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.309119 | debian-bookworm | seed: 1134 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-24 23:42:20.313346 | debian-bookworm | seed: OK (0.88 seconds) 2026-09-24 23:42:20.313422 | debian-bookworm | congratulations :) (0.91 seconds) 2026-09-24 23:42:20.892225 | debian-bookworm | ok: Runtime: 0:00:01.264382 2026-09-24 23:42:20.908540 | 2026-09-24 23:42:20.908701 | TASK [tox : Create a tempfile to save tox showconfig] 2026-09-24 23:42:21.515061 | debian-bookworm | changed 2026-09-24 23:42:21.523378 | 2026-09-24 23:42:21.523523 | TASK [tox : Detect tox version] 2026-09-24 23:42:22.126120 | debian-bookworm | 4.64.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-24 23:42:22.555672 | debian-bookworm | ok: Runtime: 0:00:00.435530 2026-09-24 23:42:22.567677 | 2026-09-24 23:42:22.567840 | TASK [tox : Get tox envlist config] 2026-09-24 23:42:23.601309 | debian-bookworm | ok: Runtime: 0:00:00.427355 2026-09-24 23:42:23.607172 | 2026-09-24 23:42:23.607287 | TASK [tox : Install any sibling python packages] 2026-09-24 23:42:24.127999 | debian-bookworm | ok: No setup.cfg, no action needed 2026-09-24 23:42:24.135499 | 2026-09-24 23:42:24.135617 | TASK [tox : Remove tempfile] 2026-09-24 23:42:24.598308 | debian-bookworm | changed 2026-09-24 23:42:24.604031 | 2026-09-24 23:42:24.604186 | TASK [tox : Emit tox command] 2026-09-24 23:42:24.651052 | /home/zuul/.local/tox/bin/tox -eseed -vv --skip-missing-interpreters=false 2026-09-24 23:42:24.659536 | 2026-09-24 23:42:24.659674 | TASK [tox : Run tox] 2026-09-24 23:42:25.156801 | debian-bookworm | ROOT: 242 D setup logging to DEBUG on pid 1621 [tox/report.py:249] 2026-09-24 23:42:25.189309 | debian-bookworm | seed: 275 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-24 23:42:25.192097 | debian-bookworm | seed: 278 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-24 23:42:25.196451 | debian-bookworm | seed: 282 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-24 23:42:25.197055 | debian-bookworm | seed: 283 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-24 23:42:25.197157 | debian-bookworm | seed: 283 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-24 23:42:25.197204 | debian-bookworm | seed: 283 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-24 23:42:25.199033 | debian-bookworm | seed: 285 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-24 23:42:25.199108 | debian-bookworm | seed: 285 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-24 23:42:25.231748 | debian-bookworm | seed: 317 W commands[0]> bash src/test-seed.sh [tox/tox_env/api.py:496] 2026-09-24 23:42:25.926736 | debian-bookworm | PASS=44 FAIL=0 2026-09-24 23:42:25.928918 | debian-bookworm | seed: 1015 I exit 0 (0.70 seconds) /home/zuul/src/github.com/osism/generics> bash src/test-seed.sh pid=1628 [tox/execute/api.py:337] 2026-09-24 23:42:25.930248 | debian-bookworm | seed: OK (0.74=setup[0.05]+cmd[0.70] seconds) 2026-09-24 23:42:25.930283 | debian-bookworm | congratulations :) (0.78 seconds) 2026-09-24 23:42:26.189272 | debian-bookworm | ok: Runtime: 0:00:01.189380 2026-09-24 23:42:26.199736 | 2026-09-24 23:42:26.199839 | TASK [tox : Look for output] 2026-09-24 23:42:26.720614 | debian-bookworm | ok 2026-09-24 23:42:26.736890 | 2026-09-24 23:42:26.737013 | TASK [tox : Return file comments to Zuul] 2026-09-24 23:42:26.772584 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:26.782153 | 2026-09-24 23:42:26.782247 | PLAY RECAP 2026-09-24 23:42:26.782302 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-24 23:42:26.782327 | 2026-09-24 23:42:27.044805 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-24 23:42:27.046053 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-24 23:42:28.427066 | 2026-09-24 23:42:28.427228 | PLAY [all] 2026-09-24 23:42:28.445911 | 2026-09-24 23:42:28.446103 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-09-24 23:42:28.511611 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:28.517677 | 2026-09-24 23:42:28.517821 | TASK [fetch-tox-output : Set tox log path for single node] 2026-09-24 23:42:28.567058 | debian-bookworm | ok 2026-09-24 23:42:28.574159 | 2026-09-24 23:42:28.574276 | TASK [fetch-tox-output : Ensure local tox dir] 2026-09-24 23:42:29.055355 | debian-bookworm -> localhost | changed 2026-09-24 23:42:29.063752 | 2026-09-24 23:42:29.063849 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-09-24 23:42:29.137312 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:29.142918 | 2026-09-24 23:42:29.143013 | TASK [fetch-tox-output : Set envlist fact] 2026-09-24 23:42:29.206892 | debian-bookworm | ok 2026-09-24 23:42:29.218388 | 2026-09-24 23:42:29.218484 | TASK [fetch-tox-output : Get tox version] 2026-09-24 23:42:29.933617 | 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-24 23:42:29.953380 | debian-bookworm | 4.64.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-24 23:42:30.266705 | debian-bookworm | ok: Runtime: 0:00:00.360083 2026-09-24 23:42:30.272097 | 2026-09-24 23:42:30.272189 | TASK [fetch-tox-output : Find all default environments] 2026-09-24 23:42:30.825147 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:30.830232 | 2026-09-24 23:42:30.830313 | TASK [fetch-tox-output : Set envlist fact] 2026-09-24 23:42:30.863456 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:30.869763 | 2026-09-24 23:42:30.869853 | TASK [fetch-tox-output : Find all default environments] 2026-09-24 23:42:31.403812 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:31.408635 | 2026-09-24 23:42:31.408733 | TASK [fetch-tox-output : Set envlist fact] 2026-09-24 23:42:31.451576 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:31.456615 | 2026-09-24 23:42:31.456692 | LOOP [fetch-tox-output : Copy tox logs] 2026-09-24 23:42:31.586877 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:31.595160 | 2026-09-24 23:42:31.595244 | LOOP [fetch-tox-output : Collect tox logs] 2026-09-24 23:42:32.813801 | debian-bookworm | changed: 2026-09-24 23:42:32.813941 | debian-bookworm | created directory /var/lib/zuul/builds/0ce7f7a48b3d42d585ae96e22759c083/work/logs/tox/seed 2026-09-24 23:42:32.813969 | debian-bookworm | cd+++++++++ ./ 2026-09-24 23:42:32.813989 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-09-24 23:42:32.814011 | 2026-09-24 23:42:32.827359 | 2026-09-24 23:42:32.827427 | PLAY RECAP 2026-09-24 23:42:32.827468 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-09-24 23:42:32.827488 | 2026-09-24 23:42:33.026482 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-24 23:42:33.027320 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-24 23:42:34.439324 | 2026-09-24 23:42:34.439440 | PLAY [all] 2026-09-24 23:42:34.487026 | 2026-09-24 23:42:34.487167 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-09-24 23:42:34.790245 | debian-bookworm | changed: non-zero return code 2026-09-24 23:42:34.794637 | 2026-09-24 23:42:34.794730 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-09-24 23:42:34.819095 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:34.824063 | 2026-09-24 23:42:34.824149 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-09-24 23:42:34.851867 | 2026-09-24 23:42:34.852019 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-09-24 23:42:34.890365 | 2026-09-24 23:42:34.890516 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-09-24 23:42:34.913473 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:34.918457 | 2026-09-24 23:42:34.918538 | LOOP [fetch-subunit-output : Generate subunit file] 2026-09-24 23:42:34.955840 | 2026-09-24 23:42:34.955994 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-09-24 23:42:34.988868 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:34.993670 | 2026-09-24 23:42:34.993752 | TASK [fetch-subunit-output : Remove the temporary file] 2026-09-24 23:42:35.016302 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:35.021512 | 2026-09-24 23:42:35.021680 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-09-24 23:42:35.058947 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:42:35.064210 | 2026-09-24 23:42:35.064272 | PLAY RECAP 2026-09-24 23:42:35.064314 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-09-24 23:42:35.064334 | 2026-09-24 23:42:35.312705 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-24 23:42:35.313463 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-24 23:42:36.175950 | 2026-09-24 23:42:36.176094 | PLAY [Base post-fetch] 2026-09-24 23:42:36.201998 | 2026-09-24 23:42:36.202121 | TASK [diagnose-network : Ensure log directory exists] 2026-09-24 23:42:36.803915 | debian-bookworm | ok 2026-09-24 23:42:36.810137 | 2026-09-24 23:42:36.810247 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-09-24 23:42:49.027893 | debian-bookworm | ok: Runtime: 0:00:06.019742 2026-09-24 23:42:49.039294 | 2026-09-24 23:42:49.039433 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-09-24 23:42:55.220433 | debian-bookworm | ok: Runtime: 0:00:00.009909 2026-09-24 23:42:55.229179 | 2026-09-24 23:42:55.229341 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-09-24 23:43:01.317397 | debian-bookworm | ok: Runtime: 0:00:00.009208 2026-09-24 23:43:01.325103 | 2026-09-24 23:43:01.325282 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)] 2026-09-24 23:43:01.856438 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:43:01.864265 | 2026-09-24 23:43:01.864414 | TASK [diagnose-network : Abort the pre-run on a fully isolated node] 2026-09-24 23:43:01.920847 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:43:01.932194 | 2026-09-24 23:43:01.932324 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-24 23:43:01.976989 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:43:01.983802 | 2026-09-24 23:43:01.983961 | TASK [fetch-output : Set log path for single node] 2026-09-24 23:43:02.039136 | debian-bookworm | ok 2026-09-24 23:43:02.049824 | 2026-09-24 23:43:02.049951 | LOOP [fetch-output : Ensure local output dirs] 2026-09-24 23:43:02.362926 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/0ce7f7a48b3d42d585ae96e22759c083/work/logs" 2026-09-24 23:43:02.660733 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0ce7f7a48b3d42d585ae96e22759c083/work/artifacts" 2026-09-24 23:43:02.996993 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0ce7f7a48b3d42d585ae96e22759c083/work/docs" 2026-09-24 23:43:03.010236 | 2026-09-24 23:43:03.010459 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-24 23:43:04.138969 | debian-bookworm | changed: 2026-09-24 23:43:04.139205 | debian-bookworm | .d..t...... ./ 2026-09-24 23:43:04.139242 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-24 23:43:04.139267 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-24 23:43:04.139289 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-24 23:43:04.139313 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-24 23:43:04.139335 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-24 23:43:04.139374 | debian-bookworm | changed: All items complete 2026-09-24 23:43:04.139400 | 2026-09-24 23:43:04.794235 | debian-bookworm | changed: .d..t...... ./ 2026-09-24 23:43:05.454184 | debian-bookworm | changed: .d..t...... ./ 2026-09-24 23:43:05.476786 | 2026-09-24 23:43:05.476896 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-24 23:43:05.759427 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.020334 2026-09-24 23:43:06.010858 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.004941 2026-09-24 23:43:06.025681 | 2026-09-24 23:43:06.025764 | PLAY RECAP 2026-09-24 23:43:06.025812 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-24 23:43:06.025837 | 2026-09-24 23:43:06.116909 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-24 23:43:06.117819 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-24 23:43:06.960953 | 2026-09-24 23:43:06.961107 | PLAY [Base post] 2026-09-24 23:43:06.974066 | 2026-09-24 23:43:06.974168 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-24 23:43:07.508874 | debian-bookworm | changed 2026-09-24 23:43:07.516267 | 2026-09-24 23:43:07.516358 | PLAY RECAP 2026-09-24 23:43:07.516418 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-24 23:43:07.516480 | 2026-09-24 23:43:07.603113 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-24 23:43:07.603999 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-24 23:43:08.319168 | 2026-09-24 23:43:08.319281 | PLAY [Base post-logs] 2026-09-24 23:43:08.332532 | 2026-09-24 23:43:08.332631 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-24 23:43:08.804555 | localhost | changed 2026-09-24 23:43:08.821192 | 2026-09-24 23:43:08.821308 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-24 23:43:08.875601 | localhost | ok 2026-09-24 23:43:08.878692 | 2026-09-24 23:43:08.878811 | TASK [Set zuul-log-path fact] 2026-09-24 23:43:08.912954 | localhost | ok 2026-09-24 23:43:08.920170 | 2026-09-24 23:43:08.921910 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-24 23:43:08.948215 | localhost | ok 2026-09-24 23:43:08.952693 | 2026-09-24 23:43:08.952823 | TASK [upload-logs : Create log directories] 2026-09-24 23:43:09.493623 | localhost | changed 2026-09-24 23:43:09.496270 | 2026-09-24 23:43:09.496358 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-24 23:43:10.045335 | localhost -> localhost | ok: Runtime: 0:00:00.005311 2026-09-24 23:43:10.048858 | 2026-09-24 23:43:10.048946 | TASK [upload-logs : Upload logs to log server] 2026-09-24 23:43:10.590185 | localhost | Output suppressed because no_log was given 2026-09-24 23:43:10.591896 | 2026-09-24 23:43:10.591987 | LOOP [upload-logs : Compress console log and json output] 2026-09-24 23:43:10.632586 | localhost | skipping: Conditional result was False 2026-09-24 23:43:10.637866 | localhost | skipping: Conditional result was False 2026-09-24 23:43:10.647814 | 2026-09-24 23:43:10.647900 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-24 23:43:10.691431 | localhost | skipping: Conditional result was False 2026-09-24 23:43:10.691658 | 2026-09-24 23:43:10.692325 | localhost | skipping: Conditional result was False 2026-09-24 23:43:10.695007 | 2026-09-24 23:43:10.695128 | LOOP [upload-logs : Upload console log and json output]