2026-09-30 03:05:58.775128 | Job console starting 2026-09-30 03:05:58.782236 | Updating git repos 2026-09-30 03:05:58.838505 | Cloning repos into workspace 2026-09-30 03:05:58.924706 | Restoring repo states 2026-09-30 03:05:58.956023 | Merging changes 2026-09-30 03:05:58.956037 | Checking out repos 2026-09-30 03:05:59.034596 | Preparing playbooks 2026-09-30 03:06:00.283130 | Running Ansible setup 2026-09-30 03:06:05.084795 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-30 03:06:06.194050 | 2026-09-30 03:06:06.194171 | PLAY [Base pre] 2026-09-30 03:06:06.229580 | 2026-09-30 03:06:06.229685 | TASK [Setup log path fact] 2026-09-30 03:06:06.246216 | debian-bookworm | ok 2026-09-30 03:06:06.260754 | 2026-09-30 03:06:06.260857 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-30 03:06:06.288177 | debian-bookworm | ok 2026-09-30 03:06:06.296126 | 2026-09-30 03:06:06.296202 | TASK [emit-job-header : Print job information] 2026-09-30 03:06:06.324796 | # Job Information 2026-09-30 03:06:06.324934 | Ansible Version: 2.16.14 2026-09-30 03:06:06.324963 | Job: generics-tox-check 2026-09-30 03:06:06.324990 | Pipeline: periodic-daily 2026-09-30 03:06:06.325008 | Executor: 521e9411259a 2026-09-30 03:06:06.325025 | Triggered by: https://github.com/osism/generics 2026-09-30 03:06:06.325043 | Event ID: 5ae99242a098472483c037807f5961a1 2026-09-30 03:06:06.328988 | 2026-09-30 03:06:06.329059 | LOOP [emit-job-header : Print node information] 2026-09-30 03:06:06.434989 | debian-bookworm | ok: 2026-09-30 03:06:06.435148 | debian-bookworm | # Node Information 2026-09-30 03:06:06.435179 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-30 03:06:06.435202 | debian-bookworm | Hostname: debian 2026-09-30 03:06:06.435221 | debian-bookworm | Username: zuul 2026-09-30 03:06:06.435240 | debian-bookworm | Distro: Debian 12.15 2026-09-30 03:06:06.435261 | debian-bookworm | Provider: regiocloud-a 2026-09-30 03:06:06.435280 | debian-bookworm | Region: 2026-09-30 03:06:06.435299 | debian-bookworm | Label: debian-bookworm 2026-09-30 03:06:06.435318 | debian-bookworm | Product Name: OpenStack Nova 2026-09-30 03:06:06.435336 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef6:f702 2026-09-30 03:06:06.451623 | 2026-09-30 03:06:06.460373 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-30 03:06:07.004553 | debian-bookworm -> localhost | changed 2026-09-30 03:06:07.010271 | 2026-09-30 03:06:07.010361 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-30 03:06:08.375446 | debian-bookworm -> localhost | changed 2026-09-30 03:06:08.384103 | 2026-09-30 03:06:08.384185 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-30 03:06:08.970312 | debian-bookworm -> localhost | ok 2026-09-30 03:06:08.977077 | 2026-09-30 03:06:08.977172 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-30 03:06:09.023330 | debian-bookworm | ok 2026-09-30 03:06:09.041400 | debian-bookworm | included: /var/lib/zuul/builds/fd64a5acf6b248d7ac7437515cd0dbe9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-30 03:06:09.049588 | 2026-09-30 03:06:09.049691 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-30 03:06:11.062369 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-30 03:06:11.062562 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fd64a5acf6b248d7ac7437515cd0dbe9/work/fd64a5acf6b248d7ac7437515cd0dbe9_id_rsa 2026-09-30 03:06:11.062600 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fd64a5acf6b248d7ac7437515cd0dbe9/work/fd64a5acf6b248d7ac7437515cd0dbe9_id_rsa.pub 2026-09-30 03:06:11.062626 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-30 03:06:11.062649 | debian-bookworm -> localhost | SHA256:4mQ9yKwO2OGJKXKE9gP0RtY1ks+WN1ayFwbSXdOdt3s zuul-build-sshkey 2026-09-30 03:06:11.062670 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-30 03:06:11.062701 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-30 03:06:11.062723 | debian-bookworm -> localhost | | ..+..o .o. o| 2026-09-30 03:06:11.062745 | debian-bookworm -> localhost | | ..o oo = .oo| 2026-09-30 03:06:11.062765 | debian-bookworm -> localhost | | . o .o . = . o| 2026-09-30 03:06:11.062785 | debian-bookworm -> localhost | |..+ o B = . . | 2026-09-30 03:06:11.062805 | debian-bookworm -> localhost | |.ooo O S o .| 2026-09-30 03:06:11.062828 | debian-bookworm -> localhost | |.B+o = . . .E| 2026-09-30 03:06:11.062849 | debian-bookworm -> localhost | |* *o. . .| 2026-09-30 03:06:11.062880 | debian-bookworm -> localhost | |o. o. | 2026-09-30 03:06:11.062903 | debian-bookworm -> localhost | | . | 2026-09-30 03:06:11.062923 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-30 03:06:11.062975 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.385270 2026-09-30 03:06:11.069077 | 2026-09-30 03:06:11.069168 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-30 03:06:11.128703 | debian-bookworm | ok 2026-09-30 03:06:11.138461 | debian-bookworm | included: /var/lib/zuul/builds/fd64a5acf6b248d7ac7437515cd0dbe9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-30 03:06:11.150671 | 2026-09-30 03:06:11.150749 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-30 03:06:11.163257 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:06:11.167856 | 2026-09-30 03:06:11.167942 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-30 03:06:11.812185 | debian-bookworm | changed 2026-09-30 03:06:11.819118 | 2026-09-30 03:06:11.819223 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-30 03:06:12.099386 | debian-bookworm | ok 2026-09-30 03:06:12.105026 | 2026-09-30 03:06:12.105118 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-30 03:06:12.671057 | debian-bookworm | changed 2026-09-30 03:06:12.680806 | 2026-09-30 03:06:12.681077 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-30 03:06:13.307548 | debian-bookworm | changed 2026-09-30 03:06:13.314825 | 2026-09-30 03:06:13.314930 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-30 03:06:13.328549 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:06:13.335052 | 2026-09-30 03:06:13.335160 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-30 03:06:13.789962 | debian-bookworm -> localhost | changed 2026-09-30 03:06:13.798757 | 2026-09-30 03:06:13.798835 | TASK [add-build-sshkey : Add back temp key] 2026-09-30 03:06:14.185495 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fd64a5acf6b248d7ac7437515cd0dbe9/work/fd64a5acf6b248d7ac7437515cd0dbe9_id_rsa (zuul-build-sshkey) 2026-09-30 03:06:14.185715 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016115 2026-09-30 03:06:14.193138 | 2026-09-30 03:06:14.193225 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-30 03:06:14.558982 | debian-bookworm | ok 2026-09-30 03:06:14.563846 | 2026-09-30 03:06:14.563940 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-30 03:06:14.611854 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:06:14.621837 | 2026-09-30 03:06:14.621961 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-30 03:06:15.002782 | debian-bookworm | ok 2026-09-30 03:06:15.015028 | 2026-09-30 03:06:15.015120 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-30 03:06:15.041711 | debian-bookworm | ok 2026-09-30 03:06:15.045629 | 2026-09-30 03:06:15.045699 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-30 03:06:15.250950 | debian-bookworm -> localhost | ok 2026-09-30 03:06:15.256302 | 2026-09-30 03:06:15.256380 | TASK [validate-host : Collect information about the host] 2026-09-30 03:06:16.360952 | debian-bookworm | ok 2026-09-30 03:06:16.376606 | 2026-09-30 03:06:16.376708 | TASK [validate-host : Sanitize hostname] 2026-09-30 03:06:16.510590 | debian-bookworm | ok 2026-09-30 03:06:16.514426 | 2026-09-30 03:06:16.514502 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-30 03:06:17.084406 | debian-bookworm -> localhost | changed 2026-09-30 03:06:17.089718 | 2026-09-30 03:06:17.089806 | TASK [validate-host : Collect information about zuul worker] 2026-09-30 03:06:17.471026 | debian-bookworm | ok 2026-09-30 03:06:17.476332 | 2026-09-30 03:06:17.476421 | TASK [validate-host : Write out all zuul information for each host] 2026-09-30 03:06:18.014247 | debian-bookworm -> localhost | changed 2026-09-30 03:06:18.023411 | 2026-09-30 03:06:18.023503 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-30 03:06:18.297005 | debian-bookworm | ok 2026-09-30 03:06:18.302441 | 2026-09-30 03:06:18.302534 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-30 03:06:19.418703 | debian-bookworm | changed: 2026-09-30 03:06:19.418908 | debian-bookworm | cd+++++++++ src/ 2026-09-30 03:06:19.418948 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-30 03:06:19.418971 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-30 03:06:19.418992 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-09-30 03:06:19.419011 | debian-bookworm | =7.0.3 2026-09-30 03:06:57.381787 | debian-bookworm | Downloading cachetools-7.2.0-py3-none-any.whl (16 kB) 2026-09-30 03:06:57.422455 | debian-bookworm | Collecting colorama>=0.4.6 2026-09-30 03:06:57.434344 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-09-30 03:06:57.504953 | debian-bookworm | Collecting filelock>=3.25 2026-09-30 03:06:57.516479 | debian-bookworm | Downloading filelock-4.0.7-py3-none-any.whl (109 kB) 2026-09-30 03:06:57.525995 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 109.2/109.2 kB 14.7 MB/s eta 0:00:00 2026-09-30 03:06:57.570099 | debian-bookworm | Collecting packaging>=26 2026-09-30 03:06:57.581681 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-09-30 03:06:57.593109 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 15.7 MB/s eta 0:00:00 2026-09-30 03:06:57.651013 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-09-30 03:06:57.662621 | debian-bookworm | Downloading platformdirs-4.12.2-py3-none-any.whl (32 kB) 2026-09-30 03:06:57.701700 | debian-bookworm | Collecting pluggy>=1.6 2026-09-30 03:06:57.712694 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-09-30 03:06:57.751033 | debian-bookworm | Collecting pyproject-api>=1.10 2026-09-30 03:06:57.761971 | debian-bookworm | Downloading pyproject_api-1.11.2-py3-none-any.whl (13 kB) 2026-09-30 03:06:57.801293 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-09-30 03:06:57.812394 | debian-bookworm | Downloading python_discovery-1.6.1-py3-none-any.whl (38 kB) 2026-09-30 03:06:57.853718 | debian-bookworm | Collecting tomli-w>=1.2 2026-09-30 03:06:57.865047 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-09-30 03:06:57.921634 | debian-bookworm | Collecting typing-extensions>=4.15 2026-09-30 03:06:57.933327 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-09-30 03:06:57.945936 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 3.8 MB/s eta 0:00:00 2026-09-30 03:06:58.080959 | debian-bookworm | Collecting virtualenv>=21.1 2026-09-30 03:06:58.092630 | debian-bookworm | Downloading virtualenv-21.14.1-py3-none-any.whl (5.5 MB) 2026-09-30 03:06:58.359341 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 20.9 MB/s eta 0:00:00 2026-09-30 03:06:58.459120 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-09-30 03:06:58.471063 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-09-30 03:06:58.490802 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 28.7 MB/s eta 0:00:00 2026-09-30 03:06:58.631600 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-09-30 03:06:59.708052 | debian-bookworm | Successfully installed cachetools-7.2.0 colorama-0.4.6 distlib-0.4.3 filelock-4.0.7 packaging-26.3 platformdirs-4.12.2 pluggy-1.6.0 pyproject-api-1.11.2 python-discovery-1.6.1 tomli-w-1.2.0 tox-4.64.5 typing-extensions-4.16.0 virtualenv-21.14.1 2026-09-30 03:07:00.302781 | debian-bookworm | ok: Runtime: 0:00:03.270066 2026-09-30 03:07:00.308783 | 2026-09-30 03:07:00.308899 | TASK [ensure-tox : Export installed tox_executable path] 2026-09-30 03:07:00.356540 | debian-bookworm | ok 2026-09-30 03:07:00.361372 | 2026-09-30 03:07:00.361464 | TASK [ensure-tox : Output tox version] 2026-09-30 03:07:01.006224 | 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-30 03:07:01.032073 | debian-bookworm | 4.64.5 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-30 03:07:01.429502 | debian-bookworm | ok: Runtime: 0:00:00.406743 2026-09-30 03:07:01.433968 | 2026-09-30 03:07:01.434039 | TASK [ensure-tox : Make global symlink] 2026-09-30 03:07:01.466356 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:01.478434 | 2026-09-30 03:07:01.478502 | PLAY RECAP 2026-09-30 03:07:01.478547 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-09-30 03:07:01.478569 | 2026-09-30 03:07:01.618666 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-09-30 03:07:01.619468 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-30 03:07:02.586953 | 2026-09-30 03:07:02.587085 | PLAY [all] 2026-09-30 03:07:02.620358 | 2026-09-30 03:07:02.620486 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-09-30 03:07:03.148183 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-30 03:07:03.190092 | debian-bookworm | ok: Runtime: 0:00:00.021554 2026-09-30 03:07:03.201923 | 2026-09-30 03:07:03.209663 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-09-30 03:07:03.763543 | debian-bookworm | ok: Runtime: 0:00:00.003855 2026-09-30 03:07:03.768180 | 2026-09-30 03:07:03.768263 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-09-30 03:07:04.076381 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-30 03:07:04.076558 | debian-bookworm | sudo: a password is required 2026-09-30 03:07:04.308388 | debian-bookworm | ok: Runtime: 0:00:00.016219 2026-09-30 03:07:04.334504 | 2026-09-30 03:07:04.334605 | TASK [tox : Check to see if the constraints file exists] 2026-09-30 03:07:04.364383 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:04.375410 | 2026-09-30 03:07:04.375510 | TASK [tox : Fail if constraints file is missing] 2026-09-30 03:07:04.413043 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:04.423797 | 2026-09-30 03:07:04.424788 | TASK [tox : Record file location] 2026-09-30 03:07:04.501763 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:04.511732 | 2026-09-30 03:07:04.511863 | TASK [tox : Install tox siblings] 2026-09-30 03:07:04.546262 | debian-bookworm | ok 2026-09-30 03:07:04.559073 | debian-bookworm | included: /var/lib/zuul/builds/fd64a5acf6b248d7ac7437515cd0dbe9/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-09-30 03:07:04.566592 | 2026-09-30 03:07:04.566692 | TASK [tox : Run tox without tests] 2026-09-30 03:07:05.200534 | debian-bookworm | ROOT: 259 D setup logging to DEBUG on pid 1584 [tox/report.py:249] 2026-09-30 03:07:05.238758 | debian-bookworm | check: 297 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-30 03:07:05.242289 | debian-bookworm | check: 301 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-30 03:07:05.246827 | debian-bookworm | check: 305 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 085e9ba0afa9d0e09a55e65832958a25 7a0c2c16b5a500bff65210db2af0c83a [python_discovery/_cached_py_info.py:223] 2026-09-30 03:07:05.297824 | debian-bookworm | check: 356 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-30 03:07:05.298383 | debian-bookworm | check: 357 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-30 03:07:05.298599 | debian-bookworm | check: 357 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-30 03:07:05.298808 | debian-bookworm | check: 357 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-30 03:07:05.300811 | debian-bookworm | check: 359 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-30 03:07:05.300935 | debian-bookworm | check: 360 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-30 03:07:05.338127 | debian-bookworm | check: 397 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/generics/.tox/check, clear=False, no_vcs_ignore=False, venv_redirect=False, global=False) [virtualenv/run/session.py:77] 2026-09-30 03:07:05.338374 | debian-bookworm | check: 397 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/bin [virtualenv/util/path/_sync.py:22] 2026-09-30 03:07:05.338641 | debian-bookworm | check: 397 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/include [virtualenv/util/path/_sync.py:22] 2026-09-30 03:07:05.338748 | debian-bookworm | check: 397 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:22] 2026-09-30 03:07:05.338926 | debian-bookworm | check: 398 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-30 03:07:05.339029 | debian-bookworm | check: 398 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339073 | debian-bookworm | check: 398 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339121 | debian-bookworm | check: 398 D python-version = 3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339202 | debian-bookworm | check: 398 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339241 | debian-bookworm | check: 398 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339292 | debian-bookworm | check: 398 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339383 | debian-bookworm | check: 398 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/check [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339539 | debian-bookworm | check: 398 D virtualenv = 21.14.1 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339622 | debian-bookworm | check: 398 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339704 | debian-bookworm | check: 398 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339773 | debian-bookworm | check: 398 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.339833 | debian-bookworm | check: 399 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.340131 | debian-bookworm | check: 399 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/generics/.tox/check/bin/python [virtualenv/util/path/_sync.py:42] 2026-09-30 03:07:05.340687 | debian-bookworm | check: 399 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-09-30 03:07:05.340971 | debian-bookworm | check: 400 D debug via /home/zuul/src/github.com/osism/generics/.tox/check/bin/python /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:316] 2026-09-30 03:07:05.379171 | debian-bookworm | check: 399 D { 2026-09-30 03:07:05.379222 | debian-bookworm | "sys": { 2026-09-30 03:07:05.379230 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check/bin/python", 2026-09-30 03:07:05.379242 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-09-30 03:07:05.379250 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-09-30 03:07:05.379259 | debian-bookworm | "base_prefix": "/usr", 2026-09-30 03:07:05.379267 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-09-30 03:07:05.379275 | debian-bookworm | "base_exec_prefix": "/usr", 2026-09-30 03:07:05.379281 | debian-bookworm | "path": [ 2026-09-30 03:07:05.379288 | debian-bookworm | "/usr/lib/python311.zip", 2026-09-30 03:07:05.379294 | debian-bookworm | "/usr/lib/python3.11", 2026-09-30 03:07:05.379300 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-09-30 03:07:05.379307 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages" 2026-09-30 03:07:05.379313 | debian-bookworm | ], 2026-09-30 03:07:05.379319 | debian-bookworm | "meta_path": [ 2026-09-30 03:07:05.379326 | debian-bookworm | "", 2026-09-30 03:07:05.379333 | debian-bookworm | "", 2026-09-30 03:07:05.379339 | debian-bookworm | "" 2026-09-30 03:07:05.379348 | debian-bookworm | ], 2026-09-30 03:07:05.379357 | debian-bookworm | "fs_encoding": "utf-8", 2026-09-30 03:07:05.379364 | debian-bookworm | "io_encoding": "utf-8" 2026-09-30 03:07:05.379371 | debian-bookworm | }, 2026-09-30 03:07:05.379377 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-09-30 03:07:05.379384 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-09-30 03:07:05.379395 | debian-bookworm | "os": "", 2026-09-30 03:07:05.379402 | debian-bookworm | "site": "", 2026-09-30 03:07:05.379409 | debian-bookworm | "datetime": "", 2026-09-30 03:07:05.379416 | debian-bookworm | "math": "", 2026-09-30 03:07:05.379424 | debian-bookworm | "json": "" 2026-09-30 03:07:05.379440 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-09-30 03:07:05.379453 | debian-bookworm | check: 438 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-30 03:07:05.385231 | debian-bookworm | check: 444 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-30 03:07:05.385667 | debian-bookworm | check: 444 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-30 03:07:05.387203 | debian-bookworm | check: 446 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-30 03:07:05.387494 | debian-bookworm | check: 446 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-30 03:07:05.683268 | debian-bookworm | check: 742 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/check/lib/python3.11/site-packages/setuptools [virtualenv/util/path/_sync.py:50] 2026-09-30 03:07:05.750069 | debian-bookworm | check: 809 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/check/lib/python3.11/site-packages/pip [virtualenv/util/path/_sync.py:50] 2026-09-30 03:07:05.780991 | debian-bookworm | check: 840 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/check/lib/python3.11/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:50] 2026-09-30 03:07:05.782068 | debian-bookworm | check: 841 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/check/lib/python3.11/site-packages/setuptools-84.0.0.virtualenv [virtualenv/util/path/_sync.py:50] 2026-09-30 03:07:05.782655 | debian-bookworm | check: 841 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/check/lib/python3.11/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:50] 2026-09-30 03:07:05.783380 | debian-bookworm | check: 842 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/check/lib/python3.11/site-packages/setuptools-84.0.0.dist-info [virtualenv/util/path/_sync.py:50] 2026-09-30 03:07:05.785903 | debian-bookworm | check: 845 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-30 03:07:05.819650 | debian-bookworm | check: 878 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/check/lib/python3.11/site-packages/pip-26.2.1.dist-info [virtualenv/util/path/_sync.py:50] 2026-09-30 03:07:05.825536 | debian-bookworm | check: 884 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/check/lib/python3.11/site-packages/pip-26.2.1.virtualenv [virtualenv/util/path/_sync.py:50] 2026-09-30 03:07:05.826375 | debian-bookworm | check: 885 D generated console scripts pip3 pip pip3.11 pip-3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-30 03:07:05.826626 | debian-bookworm | check: 885 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-09-30 03:07:05.833218 | debian-bookworm | check: 892 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-30 03:07:05.833266 | debian-bookworm | check: 892 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.833295 | debian-bookworm | check: 892 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.833362 | debian-bookworm | check: 892 D python-version = 3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.833406 | debian-bookworm | check: 892 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.833506 | debian-bookworm | check: 892 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.833649 | debian-bookworm | check: 892 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.833704 | debian-bookworm | check: 892 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/check [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.833774 | debian-bookworm | check: 892 D virtualenv = 21.14.1 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.833819 | debian-bookworm | check: 893 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.833881 | debian-bookworm | check: 893 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.833935 | debian-bookworm | check: 893 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.834004 | debian-bookworm | check: 893 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-30 03:07:05.839102 | debian-bookworm | check: 898 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:500] 2026-09-30 03:07:07.259027 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2026-09-30 03:07:07.381620 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2026-09-30 03:07:07.499379 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2026-09-30 03:07:07.510934 | debian-bookworm | Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.4 kB) 2026-09-30 03:07:07.589026 | debian-bookworm | Collecting ansible==12.3.0 (from -r requirements.txt (line 3)) 2026-09-30 03:07:07.601783 | debian-bookworm | Downloading ansible-12.3.0-py3-none-any.whl.metadata (8.1 kB) 2026-09-30 03:07:07.661576 | debian-bookworm | Collecting packaging==26.3 (from -r requirements.txt (line 4)) 2026-09-30 03:07:07.674046 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl.metadata (3.5 kB) 2026-09-30 03:07:07.803417 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2026-09-30 03:07:07.816112 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2026-09-30 03:07:07.830120 | debian-bookworm | Installing build dependencies: started 2026-09-30 03:07:09.185235 | debian-bookworm | Installing build dependencies: finished with status 'done' 2026-09-30 03:07:09.185284 | debian-bookworm | Getting requirements to build wheel: started 2026-09-30 03:07:09.687300 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2026-09-30 03:07:09.687340 | debian-bookworm | Preparing metadata (pyproject.toml): started 2026-09-30 03:07:09.930652 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2026-09-30 03:07:10.049051 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2026-09-30 03:07:10.061617 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2026-09-30 03:07:10.112202 | debian-bookworm | Collecting requests==2.34.2 (from -r requirements.txt (line 7)) 2026-09-30 03:07:10.123488 | debian-bookworm | Downloading requests-2.34.2-py3-none-any.whl.metadata (4.8 kB) 2026-09-30 03:07:10.161160 | debian-bookworm | Collecting tabulate==0.10.0 (from -r requirements.txt (line 8)) 2026-09-30 03:07:10.173367 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl.metadata (40 kB) 2026-09-30 03:07:10.286165 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2026-09-30 03:07:10.298298 | debian-bookworm | Downloading markupsafe-3.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.7 kB) 2026-09-30 03:07:10.390663 | debian-bookworm | Collecting ansible-core~=2.19.5 (from ansible==12.3.0->-r requirements.txt (line 3)) 2026-09-30 03:07:10.405336 | debian-bookworm | Downloading ansible_core-2.19.13-py3-none-any.whl.metadata (7.7 kB) 2026-09-30 03:07:10.457902 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-09-30 03:07:10.471030 | debian-bookworm | Downloading click-8.5.0-py3-none-any.whl.metadata (2.6 kB) 2026-09-30 03:07:10.511705 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-09-30 03:07:10.524025 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-09-30 03:07:10.560080 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-09-30 03:07:10.571333 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2026-09-30 03:07:10.608905 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-09-30 03:07:10.620823 | debian-bookworm | Downloading sh-2.4.0-py3-none-any.whl.metadata (3.8 kB) 2026-09-30 03:07:10.787331 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-09-30 03:07:10.799025 | debian-bookworm | Downloading charset_normalizer-3.5.1-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (45 kB) 2026-09-30 03:07:10.902641 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-09-30 03:07:10.913096 | debian-bookworm | Downloading idna-3.20-py3-none-any.whl.metadata (7.2 kB) 2026-09-30 03:07:10.988337 | debian-bookworm | Collecting urllib3<3,>=1.26 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-09-30 03:07:10.999920 | debian-bookworm | Downloading urllib3-2.8.0-py3-none-any.whl.metadata (7.4 kB) 2026-09-30 03:07:11.058044 | debian-bookworm | Collecting certifi>=2023.5.7 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-09-30 03:07:11.068967 | debian-bookworm | Downloading certifi-2026.7.22-py3-none-any.whl.metadata (2.5 kB) 2026-09-30 03:07:11.371047 | debian-bookworm | Collecting cryptography (from ansible-core~=2.19.5->ansible==12.3.0->-r requirements.txt (line 3)) 2026-09-30 03:07:11.383177 | debian-bookworm | Downloading cryptography-50.0.1-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (4.3 kB) 2026-09-30 03:07:11.423840 | debian-bookworm | Collecting resolvelib<2.0.0,>=0.5.3 (from ansible-core~=2.19.5->ansible==12.3.0->-r requirements.txt (line 3)) 2026-09-30 03:07:11.435817 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl.metadata (3.7 kB) 2026-09-30 03:07:11.571740 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core~=2.19.5->ansible==12.3.0->-r requirements.txt (line 3)) 2026-09-30 03:07:11.584316 | debian-bookworm | Downloading cffi-2.1.1-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.5 kB) 2026-09-30 03:07:11.617843 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core~=2.19.5->ansible==12.3.0->-r requirements.txt (line 3)) 2026-09-30 03:07:11.628918 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl.metadata (8.2 kB) 2026-09-30 03:07:11.656824 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-09-30 03:07:11.687640 | debian-bookworm | Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB) 2026-09-30 03:07:11.810535 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 5.8 MB/s 0:00:00 2026-09-30 03:07:11.822327 | debian-bookworm | Downloading ansible-12.3.0-py3-none-any.whl (54.4 MB) 2026-09-30 03:07:13.105614 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.4/54.4 MB 42.9 MB/s 0:00:01 2026-09-30 03:07:13.116970 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-09-30 03:07:13.137705 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2026-09-30 03:07:13.159773 | debian-bookworm | Downloading requests-2.34.2-py3-none-any.whl (73 kB) 2026-09-30 03:07:13.181341 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl (39 kB) 2026-09-30 03:07:13.202572 | debian-bookworm | Downloading ansible_core-2.19.13-py3-none-any.whl (2.4 MB) 2026-09-30 03:07:13.268356 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 35.1 MB/s 0:00:00 2026-09-30 03:07:13.279922 | debian-bookworm | Downloading charset_normalizer-3.5.1-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (262 kB) 2026-09-30 03:07:13.302251 | debian-bookworm | Downloading idna-3.20-py3-none-any.whl (69 kB) 2026-09-30 03:07:13.321279 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl (18 kB) 2026-09-30 03:07:13.340779 | debian-bookworm | Downloading urllib3-2.8.0-py3-none-any.whl (135 kB) 2026-09-30 03:07:13.365546 | debian-bookworm | Downloading certifi-2026.7.22-py3-none-any.whl (136 kB) 2026-09-30 03:07:13.387971 | debian-bookworm | Downloading markupsafe-3.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (22 kB) 2026-09-30 03:07:13.405768 | debian-bookworm | Downloading click-8.5.0-py3-none-any.whl (125 kB) 2026-09-30 03:07:13.424487 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-09-30 03:07:13.442465 | debian-bookworm | Downloading cryptography-50.0.1-cp311-abi3-manylinux_2_34_x86_64.whl (4.7 MB) 2026-09-30 03:07:13.561766 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.7/4.7 MB 40.4 MB/s 0:00:00 2026-09-30 03:07:13.573237 | debian-bookworm | Downloading cffi-2.1.1-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (217 kB) 2026-09-30 03:07:13.597697 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2026-09-30 03:07:13.616878 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-09-30 03:07:13.638151 | debian-bookworm | Downloading sh-2.4.0-py3-none-any.whl (48 kB) 2026-09-30 03:07:13.923026 | debian-bookworm | Building wheels for collected packages: pwgen 2026-09-30 03:07:13.924109 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2026-09-30 03:07:14.243015 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2026-09-30 03:07:14.243870 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3795 sha256=f432f7d166a2fdd3c279b2e6aa62b1116b900796f3b3b785e07cbeb2cbd859b0 2026-09-30 03:07:14.244225 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2026-09-30 03:07:14.247411 | debian-bookworm | Successfully built pwgen 2026-09-30 03:07:14.510055 | debian-bookworm | Installing collected packages: pwgen, urllib3, tabulate, sh, resolvelib, PyYAML, pycparser, packaging, MarkupSafe, idna, fasteners, colorama, click, charset_normalizer, certifi, requests, python-gilt, Jinja2, cffi, cryptography, ansible-core, ansible 2026-09-30 03:07:44.410820 | debian-bookworm | 2026-09-30 03:07:44.412694 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-12.3.0 ansible-core-2.19.13 certifi-2026.7.22 cffi-2.1.1 charset_normalizer-3.5.1 click-8.5.0 colorama-0.4.6 cryptography-50.0.1 fasteners-0.20 idna-3.20 packaging-26.3 pwgen-0.8.2.post0 pycparser-3.0 python-gilt-1.2.3 requests-2.34.2 resolvelib-1.2.1 sh-2.4.0 tabulate-0.10.0 urllib3-2.8.0 2026-09-30 03:07:44.624706 | debian-bookworm | check: 39683 I exit 0 (38.78 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1597 [tox/execute/api.py:337] 2026-09-30 03:07:44.626190 | debian-bookworm | check: OK (39.39 seconds) 2026-09-30 03:07:44.626239 | debian-bookworm | congratulations :) (39.43 seconds) 2026-09-30 03:07:45.148948 | debian-bookworm | ok: Runtime: 0:00:39.800412 2026-09-30 03:07:45.165004 | 2026-09-30 03:07:45.165138 | TASK [tox : Create a tempfile to save tox showconfig] 2026-09-30 03:07:45.558270 | debian-bookworm | changed 2026-09-30 03:07:45.563617 | 2026-09-30 03:07:45.563707 | TASK [tox : Detect tox version] 2026-09-30 03:07:46.162477 | debian-bookworm | 4.64.5 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-30 03:07:46.596125 | debian-bookworm | ok: Runtime: 0:00:00.373492 2026-09-30 03:07:46.615267 | 2026-09-30 03:07:46.615401 | TASK [tox : Get tox envlist config] 2026-09-30 03:07:47.652688 | debian-bookworm | ok: Runtime: 0:00:00.427821 2026-09-30 03:07:47.662728 | 2026-09-30 03:07:47.662891 | TASK [tox : Install any sibling python packages] 2026-09-30 03:07:48.125839 | debian-bookworm | ok: No setup.cfg, no action needed 2026-09-30 03:07:48.134439 | 2026-09-30 03:07:48.134569 | TASK [tox : Remove tempfile] 2026-09-30 03:07:48.606480 | debian-bookworm | changed 2026-09-30 03:07:48.612075 | 2026-09-30 03:07:48.612192 | TASK [tox : Emit tox command] 2026-09-30 03:07:48.664645 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2026-09-30 03:07:48.672929 | 2026-09-30 03:07:48.673086 | TASK [tox : Run tox] 2026-09-30 03:07:49.292921 | debian-bookworm | ROOT: 261 D setup logging to DEBUG on pid 1759 [tox/report.py:249] 2026-09-30 03:07:49.331935 | debian-bookworm | check: 300 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-30 03:07:49.334771 | debian-bookworm | check: 303 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-30 03:07:49.339606 | debian-bookworm | check: 308 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-30 03:07:49.340159 | debian-bookworm | check: 308 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-30 03:07:49.340323 | debian-bookworm | check: 308 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-30 03:07:49.340418 | debian-bookworm | check: 308 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-30 03:07:49.342632 | debian-bookworm | check: 311 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-30 03:07:49.342777 | debian-bookworm | check: 311 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-30 03:07:49.383323 | debian-bookworm | check: 351 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:500] 2026-09-30 03:07:49.496483 | debian-bookworm | check: 464 I exit 0 (0.11 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-inventory-sorting.py pid=1766 [tox/execute/api.py:337] 2026-09-30 03:07:49.497721 | debian-bookworm | check: OK (0.17=setup[0.06]+cmd[0.11] seconds) 2026-09-30 03:07:49.497784 | debian-bookworm | congratulations :) (0.21 seconds) 2026-09-30 03:07:49.704199 | debian-bookworm | ok: Runtime: 0:00:00.566191 2026-09-30 03:07:49.714497 | 2026-09-30 03:07:49.714608 | TASK [tox : Look for output] 2026-09-30 03:07:50.139166 | debian-bookworm | ok 2026-09-30 03:07:50.153130 | 2026-09-30 03:07:50.153248 | TASK [tox : Return file comments to Zuul] 2026-09-30 03:07:50.197415 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:50.204664 | 2026-09-30 03:07:50.204757 | PLAY RECAP 2026-09-30 03:07:50.204828 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-30 03:07:50.204855 | 2026-09-30 03:07:50.378280 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-30 03:07:50.380879 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-30 03:07:51.301023 | 2026-09-30 03:07:51.301191 | PLAY [all] 2026-09-30 03:07:51.319282 | 2026-09-30 03:07:51.319423 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-09-30 03:07:51.395668 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:51.402587 | 2026-09-30 03:07:51.402737 | TASK [fetch-tox-output : Set tox log path for single node] 2026-09-30 03:07:51.442716 | debian-bookworm | ok 2026-09-30 03:07:51.449442 | 2026-09-30 03:07:51.449711 | TASK [fetch-tox-output : Ensure local tox dir] 2026-09-30 03:07:52.166637 | debian-bookworm -> localhost | changed 2026-09-30 03:07:52.182240 | 2026-09-30 03:07:52.182374 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-09-30 03:07:52.257683 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:52.264674 | 2026-09-30 03:07:52.264814 | TASK [fetch-tox-output : Set envlist fact] 2026-09-30 03:07:52.337132 | debian-bookworm | ok 2026-09-30 03:07:52.350029 | 2026-09-30 03:07:52.350152 | TASK [fetch-tox-output : Get tox version] 2026-09-30 03:07:53.154822 | 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-30 03:07:53.173068 | debian-bookworm | 4.64.5 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-30 03:07:53.404355 | debian-bookworm | ok: Runtime: 0:00:00.358032 2026-09-30 03:07:53.410152 | 2026-09-30 03:07:53.410269 | TASK [fetch-tox-output : Find all default environments] 2026-09-30 03:07:53.941421 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:53.948115 | 2026-09-30 03:07:53.948404 | TASK [fetch-tox-output : Set envlist fact] 2026-09-30 03:07:53.995366 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:54.001619 | 2026-09-30 03:07:54.001740 | TASK [fetch-tox-output : Find all default environments] 2026-09-30 03:07:54.583670 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:54.595557 | 2026-09-30 03:07:54.595688 | TASK [fetch-tox-output : Set envlist fact] 2026-09-30 03:07:54.645509 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:54.665871 | 2026-09-30 03:07:54.666276 | LOOP [fetch-tox-output : Copy tox logs] 2026-09-30 03:07:54.806753 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:54.822982 | 2026-09-30 03:07:54.823119 | LOOP [fetch-tox-output : Collect tox logs] 2026-09-30 03:07:55.805419 | debian-bookworm | changed: 2026-09-30 03:07:55.805600 | debian-bookworm | created directory /var/lib/zuul/builds/fd64a5acf6b248d7ac7437515cd0dbe9/work/logs/tox/check 2026-09-30 03:07:55.805635 | debian-bookworm | cd+++++++++ ./ 2026-09-30 03:07:55.805660 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-09-30 03:07:55.805689 | 2026-09-30 03:07:55.819101 | 2026-09-30 03:07:55.819173 | PLAY RECAP 2026-09-30 03:07:55.819213 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-09-30 03:07:55.819233 | 2026-09-30 03:07:55.909594 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-30 03:07:55.910345 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-30 03:07:56.635442 | 2026-09-30 03:07:56.635648 | PLAY [all] 2026-09-30 03:07:56.661899 | 2026-09-30 03:07:56.662011 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-09-30 03:07:56.884429 | debian-bookworm | changed: non-zero return code 2026-09-30 03:07:56.889317 | 2026-09-30 03:07:56.889637 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-09-30 03:07:56.917324 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:56.927568 | 2026-09-30 03:07:56.927656 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-09-30 03:07:56.956746 | 2026-09-30 03:07:56.956909 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-09-30 03:07:56.996669 | 2026-09-30 03:07:56.996833 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-09-30 03:07:57.029428 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:57.034145 | 2026-09-30 03:07:57.034227 | LOOP [fetch-subunit-output : Generate subunit file] 2026-09-30 03:07:57.062208 | 2026-09-30 03:07:57.062352 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-09-30 03:07:57.075167 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:57.079828 | 2026-09-30 03:07:57.079905 | TASK [fetch-subunit-output : Remove the temporary file] 2026-09-30 03:07:57.102013 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:57.106940 | 2026-09-30 03:07:57.107020 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-09-30 03:07:57.129339 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:07:57.134315 | 2026-09-30 03:07:57.134370 | PLAY RECAP 2026-09-30 03:07:57.134412 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-09-30 03:07:57.134432 | 2026-09-30 03:07:57.304614 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-30 03:07:57.305923 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-30 03:07:58.322866 | 2026-09-30 03:07:58.322978 | PLAY [Base post-fetch] 2026-09-30 03:07:58.334175 | 2026-09-30 03:07:58.334276 | TASK [diagnose-network : Ensure log directory exists] 2026-09-30 03:07:58.714549 | debian-bookworm | ok 2026-09-30 03:07:58.720685 | 2026-09-30 03:07:58.720804 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-09-30 03:08:10.402725 | debian-bookworm | ok: Runtime: 0:00:05.850210 2026-09-30 03:08:10.408223 | 2026-09-30 03:08:10.408310 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-09-30 03:08:16.449503 | debian-bookworm | ok: Runtime: 0:00:00.005323 2026-09-30 03:08:16.457403 | 2026-09-30 03:08:16.457525 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-09-30 03:08:22.347998 | debian-bookworm | ok: Runtime: 0:00:00.004910 2026-09-30 03:08:22.356455 | 2026-09-30 03:08:22.356580 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)] 2026-09-30 03:08:22.891220 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:08:22.897975 | 2026-09-30 03:08:22.898077 | TASK [diagnose-network : Abort the pre-run on a fully isolated node] 2026-09-30 03:08:22.962550 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:08:22.973459 | 2026-09-30 03:08:22.973565 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-30 03:08:23.037171 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:08:23.042614 | 2026-09-30 03:08:23.042706 | TASK [fetch-output : Set log path for single node] 2026-09-30 03:08:23.071866 | debian-bookworm | ok 2026-09-30 03:08:23.076897 | 2026-09-30 03:08:23.076978 | LOOP [fetch-output : Ensure local output dirs] 2026-09-30 03:08:23.366718 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/fd64a5acf6b248d7ac7437515cd0dbe9/work/logs" 2026-09-30 03:08:23.609037 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/fd64a5acf6b248d7ac7437515cd0dbe9/work/artifacts" 2026-09-30 03:08:23.832856 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/fd64a5acf6b248d7ac7437515cd0dbe9/work/docs" 2026-09-30 03:08:23.849939 | 2026-09-30 03:08:23.850032 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-30 03:08:24.604093 | debian-bookworm | changed: 2026-09-30 03:08:24.604382 | debian-bookworm | .d..t...... ./ 2026-09-30 03:08:24.604433 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-30 03:08:24.604468 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-30 03:08:24.604499 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-30 03:08:24.604528 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-30 03:08:24.604558 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-30 03:08:24.604610 | debian-bookworm | changed: All items complete 2026-09-30 03:08:24.604643 | 2026-09-30 03:08:25.182581 | debian-bookworm | changed: .d..t...... ./ 2026-09-30 03:08:25.718703 | debian-bookworm | changed: .d..t...... ./ 2026-09-30 03:08:25.741286 | 2026-09-30 03:08:25.741412 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-30 03:08:25.765641 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:08:25.769358 | debian-bookworm | skipping: Conditional result was False 2026-09-30 03:08:25.783582 | 2026-09-30 03:08:25.783664 | PLAY RECAP 2026-09-30 03:08:25.783720 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-30 03:08:25.783745 | 2026-09-30 03:08:25.924362 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-30 03:08:25.925405 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-30 03:08:26.727273 | 2026-09-30 03:08:26.727434 | PLAY [Base post] 2026-09-30 03:08:26.747729 | 2026-09-30 03:08:26.747909 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-30 03:08:27.315567 | debian-bookworm | changed 2026-09-30 03:08:27.324554 | 2026-09-30 03:08:27.324678 | PLAY RECAP 2026-09-30 03:08:27.324769 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-30 03:08:27.324857 | 2026-09-30 03:08:27.465047 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-30 03:08:27.466203 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-30 03:08:28.330209 | 2026-09-30 03:08:28.330383 | PLAY [Base post-logs] 2026-09-30 03:08:28.341105 | 2026-09-30 03:08:28.341268 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-30 03:08:29.005259 | localhost | changed 2026-09-30 03:08:29.019592 | 2026-09-30 03:08:29.029668 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-30 03:08:29.107332 | localhost | ok 2026-09-30 03:08:29.110711 | 2026-09-30 03:08:29.110846 | TASK [Set zuul-log-path fact] 2026-09-30 03:08:29.156705 | localhost | ok 2026-09-30 03:08:29.169250 | 2026-09-30 03:08:29.169384 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-30 03:08:29.248591 | localhost | ok 2026-09-30 03:08:29.256149 | 2026-09-30 03:08:29.256260 | TASK [upload-logs : Create log directories] 2026-09-30 03:08:30.474159 | localhost | changed 2026-09-30 03:08:30.477276 | 2026-09-30 03:08:30.477361 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-30 03:08:31.552146 | localhost -> localhost | ok: Runtime: 0:00:00.035201 2026-09-30 03:08:31.555582 | 2026-09-30 03:08:31.555669 | TASK [upload-logs : Upload logs to log server] 2026-09-30 03:08:32.428989 | localhost | Output suppressed because no_log was given 2026-09-30 03:08:32.430598 | 2026-09-30 03:08:32.430710 | LOOP [upload-logs : Compress console log and json output] 2026-09-30 03:08:32.495080 | localhost | skipping: Conditional result was False 2026-09-30 03:08:32.500580 | localhost | skipping: Conditional result was False 2026-09-30 03:08:32.506030 | 2026-09-30 03:08:32.506117 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-30 03:08:32.547760 | localhost | skipping: Conditional result was False 2026-09-30 03:08:32.548003 | 2026-09-30 03:08:32.552569 | localhost | skipping: Conditional result was False 2026-09-30 03:08:32.561094 | 2026-09-30 03:08:32.561183 | LOOP [upload-logs : Upload console log and json output]