2026-03-27 14:06:47.888405 | Job console starting 2026-03-27 14:06:47.909668 | Updating git repos 2026-03-27 14:06:47.948283 | Cloning repos into workspace 2026-03-27 14:06:47.991522 | Restoring repo states 2026-03-27 14:06:48.011344 | Merging changes 2026-03-27 14:06:48.570315 | Checking out repos 2026-03-27 14:06:48.629598 | Preparing playbooks 2026-03-27 14:06:49.349055 | Running Ansible setup 2026-03-27 14:06:55.203313 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-27 14:06:56.564763 | 2026-03-27 14:06:56.564875 | PLAY [Base pre] 2026-03-27 14:06:56.592675 | 2026-03-27 14:06:56.592793 | TASK [Setup log path fact] 2026-03-27 14:06:56.619959 | debian-bookworm | ok 2026-03-27 14:06:56.644804 | 2026-03-27 14:06:56.644927 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-27 14:06:56.693159 | debian-bookworm | ok 2026-03-27 14:06:56.701033 | 2026-03-27 14:06:56.701123 | TASK [emit-job-header : Print job information] 2026-03-27 14:06:56.762658 | # Job Information 2026-03-27 14:06:56.762995 | Ansible Version: 2.16.14 2026-03-27 14:06:56.763033 | Job: cfg-generics-tox-check 2026-03-27 14:06:56.763061 | Pipeline: check 2026-03-27 14:06:56.763080 | Executor: 521e9411259a 2026-03-27 14:06:56.763096 | Triggered by: https://github.com/osism/generics/pull/575 2026-03-27 14:06:56.763114 | Event ID: 2c2e3a40-29e6-11f1-9858-1beb3cf86775 2026-03-27 14:06:56.767031 | 2026-03-27 14:06:56.767116 | LOOP [emit-job-header : Print node information] 2026-03-27 14:06:57.025285 | debian-bookworm | ok: 2026-03-27 14:06:57.025498 | debian-bookworm | # Node Information 2026-03-27 14:06:57.025537 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-27 14:06:57.025563 | debian-bookworm | Hostname: debian 2026-03-27 14:06:57.025612 | debian-bookworm | Username: zuul 2026-03-27 14:06:57.025637 | debian-bookworm | Distro: Debian 12.13 2026-03-27 14:06:57.025661 | debian-bookworm | Provider: regiocloud-a 2026-03-27 14:06:57.025690 | debian-bookworm | Region: 2026-03-27 14:06:57.025711 | debian-bookworm | Label: debian-bookworm 2026-03-27 14:06:57.025731 | debian-bookworm | Product Name: OpenStack Nova 2026-03-27 14:06:57.025751 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe75:3f57 2026-03-27 14:06:57.043031 | 2026-03-27 14:06:57.043126 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-27 14:06:58.170749 | debian-bookworm -> localhost | changed 2026-03-27 14:06:58.180717 | 2026-03-27 14:06:58.180824 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-27 14:07:01.303089 | debian-bookworm -> localhost | changed 2026-03-27 14:07:01.317127 | 2026-03-27 14:07:01.317238 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-27 14:07:02.006935 | debian-bookworm -> localhost | ok 2026-03-27 14:07:02.011788 | 2026-03-27 14:07:02.011875 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-27 14:07:02.068694 | debian-bookworm | ok 2026-03-27 14:07:02.108347 | debian-bookworm | included: /var/lib/zuul/builds/243d1f63bfe14d82978aacc99a67a846/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-27 14:07:02.115862 | 2026-03-27 14:07:02.115954 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-27 14:07:05.308832 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-27 14:07:05.308993 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/243d1f63bfe14d82978aacc99a67a846/work/243d1f63bfe14d82978aacc99a67a846_id_rsa 2026-03-27 14:07:05.309023 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/243d1f63bfe14d82978aacc99a67a846/work/243d1f63bfe14d82978aacc99a67a846_id_rsa.pub 2026-03-27 14:07:05.309045 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-27 14:07:05.309065 | debian-bookworm -> localhost | SHA256:sgH912LmWt02O9PEOw3rCtTe+7vSGnd7PtLxUG1s4ww zuul-build-sshkey 2026-03-27 14:07:05.309083 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-27 14:07:05.309109 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-27 14:07:05.309128 | debian-bookworm -> localhost | | | 2026-03-27 14:07:05.309146 | debian-bookworm -> localhost | | . | 2026-03-27 14:07:05.309163 | debian-bookworm -> localhost | | . . ..| 2026-03-27 14:07:05.309180 | debian-bookworm -> localhost | | . . o E .*| 2026-03-27 14:07:05.309196 | debian-bookworm -> localhost | | o S * o +=.| 2026-03-27 14:07:05.309216 | debian-bookworm -> localhost | | + * + oo+o| 2026-03-27 14:07:05.309232 | debian-bookworm -> localhost | | . + o.BB*| 2026-03-27 14:07:05.309249 | debian-bookworm -> localhost | | o . +*XB| 2026-03-27 14:07:05.309265 | debian-bookworm -> localhost | | . .+BOO| 2026-03-27 14:07:05.309281 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-27 14:07:05.309322 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.785524 2026-03-27 14:07:05.314429 | 2026-03-27 14:07:05.314513 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-27 14:07:05.361163 | debian-bookworm | ok 2026-03-27 14:07:05.368522 | debian-bookworm | included: /var/lib/zuul/builds/243d1f63bfe14d82978aacc99a67a846/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-27 14:07:05.396612 | 2026-03-27 14:07:05.396703 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-27 14:07:05.424784 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:07:05.429558 | 2026-03-27 14:07:05.429667 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-27 14:07:06.243204 | debian-bookworm | changed 2026-03-27 14:07:06.247421 | 2026-03-27 14:07:06.247492 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-27 14:07:06.529374 | debian-bookworm | ok 2026-03-27 14:07:06.533938 | 2026-03-27 14:07:06.534017 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-27 14:07:07.269807 | debian-bookworm | changed 2026-03-27 14:07:07.277533 | 2026-03-27 14:07:07.277664 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-27 14:07:07.987275 | debian-bookworm | changed 2026-03-27 14:07:07.994012 | 2026-03-27 14:07:07.994117 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-27 14:07:08.020992 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:07:08.026721 | 2026-03-27 14:07:08.026811 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-27 14:07:08.502289 | debian-bookworm -> localhost | changed 2026-03-27 14:07:08.511014 | 2026-03-27 14:07:08.511106 | TASK [add-build-sshkey : Add back temp key] 2026-03-27 14:07:08.879506 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/243d1f63bfe14d82978aacc99a67a846/work/243d1f63bfe14d82978aacc99a67a846_id_rsa (zuul-build-sshkey) 2026-03-27 14:07:08.879709 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022814 2026-03-27 14:07:08.885836 | 2026-03-27 14:07:08.885923 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-27 14:07:09.469357 | debian-bookworm | ok 2026-03-27 14:07:09.473344 | 2026-03-27 14:07:09.473416 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-27 14:07:09.528221 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:07:09.537811 | 2026-03-27 14:07:09.537898 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-27 14:07:10.046451 | debian-bookworm | ok 2026-03-27 14:07:10.063445 | 2026-03-27 14:07:10.063553 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-27 14:07:10.122914 | debian-bookworm | ok 2026-03-27 14:07:10.127773 | 2026-03-27 14:07:10.127863 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-27 14:07:10.843156 | debian-bookworm -> localhost | ok 2026-03-27 14:07:10.850407 | 2026-03-27 14:07:10.850505 | TASK [validate-host : Collect information about the host] 2026-03-27 14:07:12.452821 | debian-bookworm | ok 2026-03-27 14:07:12.475153 | 2026-03-27 14:07:12.475252 | TASK [validate-host : Sanitize hostname] 2026-03-27 14:07:12.645566 | debian-bookworm | ok 2026-03-27 14:07:12.717355 | 2026-03-27 14:07:12.717461 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-27 14:07:13.222775 | debian-bookworm -> localhost | changed 2026-03-27 14:07:13.228334 | 2026-03-27 14:07:13.228429 | TASK [validate-host : Collect information about zuul worker] 2026-03-27 14:07:13.671488 | debian-bookworm | ok 2026-03-27 14:07:13.676057 | 2026-03-27 14:07:13.676147 | TASK [validate-host : Write out all zuul information for each host] 2026-03-27 14:07:14.406995 | debian-bookworm -> localhost | changed 2026-03-27 14:07:14.417686 | 2026-03-27 14:07:14.417791 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-27 14:07:14.702090 | debian-bookworm | ok 2026-03-27 14:07:14.708638 | 2026-03-27 14:07:14.708735 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-27 14:07:15.753170 | debian-bookworm | changed: 2026-03-27 14:07:15.753332 | debian-bookworm | cd+++++++++ src/ 2026-03-27 14:07:15.753365 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-27 14:07:15.753388 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-27 14:07:15.753409 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-03-27 14:07:15.753430 | debian-bookworm | =7.0.3 2026-03-27 14:07:39.271847 | debian-bookworm | Downloading cachetools-7.0.5-py3-none-any.whl (13 kB) 2026-03-27 14:07:39.332512 | debian-bookworm | Collecting colorama>=0.4.6 2026-03-27 14:07:39.350050 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-03-27 14:07:39.413132 | debian-bookworm | Collecting filelock>=3.25 2026-03-27 14:07:39.429335 | debian-bookworm | Downloading filelock-3.25.2-py3-none-any.whl (26 kB) 2026-03-27 14:07:39.480781 | debian-bookworm | Collecting packaging>=26 2026-03-27 14:07:39.496160 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-27 14:07:39.505716 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 10.4 MB/s eta 0:00:00 2026-03-27 14:07:39.554482 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-03-27 14:07:39.571724 | debian-bookworm | Downloading platformdirs-4.9.4-py3-none-any.whl (21 kB) 2026-03-27 14:07:39.614937 | debian-bookworm | Collecting pluggy>=1.6 2026-03-27 14:07:39.629948 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-27 14:07:39.668673 | debian-bookworm | Collecting pyproject-api>=1.10 2026-03-27 14:07:39.686744 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-03-27 14:07:39.732649 | debian-bookworm | Collecting tomli-w>=1.2 2026-03-27 14:07:39.748433 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-03-27 14:07:39.884473 | debian-bookworm | Collecting virtualenv>=21.1 2026-03-27 14:07:39.900354 | debian-bookworm | Downloading virtualenv-21.2.0-py3-none-any.whl (5.8 MB) 2026-03-27 14:07:40.153372 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 23.5 MB/s eta 0:00:00 2026-03-27 14:07:40.236750 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-03-27 14:07:40.252410 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-03-27 14:07:40.280217 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.7 MB/s eta 0:00:00 2026-03-27 14:07:40.322823 | debian-bookworm | Collecting python-discovery>=1 2026-03-27 14:07:40.338222 | debian-bookworm | Downloading python_discovery-1.2.1-py3-none-any.whl (31 kB) 2026-03-27 14:07:40.457576 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-03-27 14:07:41.179549 | debian-bookworm | Successfully installed cachetools-7.0.5 colorama-0.4.6 distlib-0.4.0 filelock-3.25.2 packaging-26.0 platformdirs-4.9.4 pluggy-1.6.0 pyproject-api-1.10.0 python-discovery-1.2.1 tomli-w-1.2.0 tox-4.50.3 virtualenv-21.2.0 2026-03-27 14:07:41.590274 | debian-bookworm | ok: Runtime: 0:00:02.973693 2026-03-27 14:07:41.597073 | 2026-03-27 14:07:41.597283 | TASK [ensure-tox : Export installed tox_executable path] 2026-03-27 14:07:41.690071 | debian-bookworm | ok 2026-03-27 14:07:41.701765 | 2026-03-27 14:07:41.701975 | TASK [ensure-tox : Output tox version] 2026-03-27 14:07:42.366211 | 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-03-27 14:07:42.384574 | debian-bookworm | 4.50.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-27 14:07:42.754915 | debian-bookworm | ok: Runtime: 0:00:00.296716 2026-03-27 14:07:42.759280 | 2026-03-27 14:07:42.759348 | TASK [ensure-tox : Make global symlink] 2026-03-27 14:07:42.782228 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:07:42.788137 | 2026-03-27 14:07:42.788198 | PLAY RECAP 2026-03-27 14:07:42.788241 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-03-27 14:07:42.788262 | 2026-03-27 14:07:42.937228 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-03-27 14:07:42.937992 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-27 14:07:44.602889 | 2026-03-27 14:07:44.603006 | PLAY [all] 2026-03-27 14:07:44.643788 | 2026-03-27 14:07:44.643910 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-03-27 14:07:45.420122 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-27 14:07:45.720279 | debian-bookworm | ok: Runtime: 0:00:00.027423 2026-03-27 14:07:45.724769 | 2026-03-27 14:07:45.724861 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-03-27 14:07:46.288340 | debian-bookworm | ok: Runtime: 0:00:00.007705 2026-03-27 14:07:46.292937 | 2026-03-27 14:07:46.293018 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-03-27 14:07:46.770626 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-27 14:07:46.774498 | debian-bookworm | sudo: a password is required 2026-03-27 14:07:46.876202 | debian-bookworm | ok: Runtime: 0:00:00.025687 2026-03-27 14:07:46.885692 | 2026-03-27 14:07:46.885773 | TASK [tox : Check to see if the constraints file exists] 2026-03-27 14:07:46.961374 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:07:46.966137 | 2026-03-27 14:07:46.966221 | TASK [tox : Fail if constraints file is missing] 2026-03-27 14:07:47.059583 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:07:47.065667 | 2026-03-27 14:07:47.065774 | TASK [tox : Record file location] 2026-03-27 14:07:47.130822 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:07:47.136097 | 2026-03-27 14:07:47.136195 | TASK [tox : Install tox siblings] 2026-03-27 14:07:47.200553 | debian-bookworm | ok 2026-03-27 14:07:47.214575 | debian-bookworm | included: /var/lib/zuul/builds/243d1f63bfe14d82978aacc99a67a846/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-03-27 14:07:47.228695 | 2026-03-27 14:07:47.228795 | TASK [tox : Run tox without tests] 2026-03-27 14:07:47.787827 | debian-bookworm | ROOT: 189 D setup logging to DEBUG on pid 1420 [tox/report.py:229] 2026-03-27 14:07:47.817338 | debian-bookworm | check: 218 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-03-27 14:07:47.819941 | debian-bookworm | check: 221 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:62] 2026-03-27 14:07:47.825248 | debian-bookworm | check: 226 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/python_discovery/_py_info.py 8f73efe36f4e0cf24884f8cca1750db4 07b1c54edafea820bc47fa4d1d578eb6 [python_discovery/_cached_py_info.py:198] 2026-03-27 14:07:47.901162 | debian-bookworm | check: 302 D wrote python info of /usr/bin/python3.11 at /home/zuul/.cache/virtualenv/py_info/4/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:159] 2026-03-27 14:07:47.902564 | debian-bookworm | check: 304 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-03-27 14:07:47.902932 | debian-bookworm | check: 304 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, Apr 28 2025, 14:11:48) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:71] 2026-03-27 14:07:47.903224 | debian-bookworm | check: 304 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, Apr 28 2025, 14:11:48) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:75] 2026-03-27 14:07:47.906196 | debian-bookworm | check: 307 D symlink on filesystem does work [virtualenv/info.py:51] 2026-03-27 14:07:47.906560 | debian-bookworm | check: 308 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-03-27 14:07:47.945616 | debian-bookworm | check: 347 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/generics/.tox/check, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:77] 2026-03-27 14:07:47.945919 | debian-bookworm | check: 347 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/bin [virtualenv/util/path/_sync.py:18] 2026-03-27 14:07:47.946066 | debian-bookworm | check: 347 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/include [virtualenv/util/path/_sync.py:18] 2026-03-27 14:07:47.946161 | debian-bookworm | check: 347 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:18] 2026-03-27 14:07:47.946357 | debian-bookworm | check: 348 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-03-27 14:07:47.946473 | debian-bookworm | check: 348 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.946519 | debian-bookworm | check: 348 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.946566 | debian-bookworm | check: 348 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.946617 | debian-bookworm | check: 348 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.946665 | debian-bookworm | check: 348 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.946719 | debian-bookworm | check: 348 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/check [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.946766 | debian-bookworm | check: 348 D virtualenv = 21.2.0 [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.946816 | debian-bookworm | check: 348 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.946863 | debian-bookworm | check: 348 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.946908 | debian-bookworm | check: 348 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.946954 | debian-bookworm | check: 348 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:47.947215 | debian-bookworm | check: 348 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/generics/.tox/check/bin/python [virtualenv/util/path/_sync.py:38] 2026-03-27 14:07:47.947552 | debian-bookworm | check: 349 D create virtualenv import hook file /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/_virtualenv.pth [virtualenv/create/via_global_ref/api.py:118] 2026-03-27 14:07:47.947687 | debian-bookworm | check: 349 D create /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/_virtualenv.py [virtualenv/create/via_global_ref/api.py:121] 2026-03-27 14:07:47.948098 | debian-bookworm | check: 349 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-03-27 14:07:47.948345 | debian-bookworm | check: 350 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:263] 2026-03-27 14:07:47.988700 | debian-bookworm | check: 349 D { 2026-03-27 14:07:47.988743 | debian-bookworm | "sys": { 2026-03-27 14:07:47.988750 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check/bin/python", 2026-03-27 14:07:47.988756 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-03-27 14:07:47.988761 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-03-27 14:07:47.988766 | debian-bookworm | "base_prefix": "/usr", 2026-03-27 14:07:47.988773 | debian-bookworm | "real_prefix": null, 2026-03-27 14:07:47.988777 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-03-27 14:07:47.988781 | debian-bookworm | "base_exec_prefix": "/usr", 2026-03-27 14:07:47.988785 | debian-bookworm | "path": [ 2026-03-27 14:07:47.988790 | debian-bookworm | "/usr/lib/python311.zip", 2026-03-27 14:07:47.988794 | debian-bookworm | "/usr/lib/python3.11", 2026-03-27 14:07:47.988798 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-03-27 14:07:47.988802 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages" 2026-03-27 14:07:47.988807 | debian-bookworm | ], 2026-03-27 14:07:47.988811 | debian-bookworm | "meta_path": [ 2026-03-27 14:07:47.988815 | debian-bookworm | "", 2026-03-27 14:07:47.988819 | debian-bookworm | "", 2026-03-27 14:07:47.988823 | debian-bookworm | "", 2026-03-27 14:07:47.988834 | debian-bookworm | "" 2026-03-27 14:07:47.988838 | debian-bookworm | ], 2026-03-27 14:07:47.988842 | debian-bookworm | "fs_encoding": "utf-8", 2026-03-27 14:07:47.988846 | debian-bookworm | "io_encoding": "utf-8" 2026-03-27 14:07:47.988850 | debian-bookworm | }, 2026-03-27 14:07:47.988854 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2026-03-27 14:07:47.988858 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-03-27 14:07:47.988862 | debian-bookworm | "os": "", 2026-03-27 14:07:47.988865 | debian-bookworm | "site": "", 2026-03-27 14:07:47.988896 | debian-bookworm | "datetime": "", 2026-03-27 14:07:47.988900 | debian-bookworm | "math": "", 2026-03-27 14:07:47.988904 | debian-bookworm | "json": "" 2026-03-27 14:07:47.988908 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-03-27 14:07:47.989104 | debian-bookworm | check: 390 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-03-27 14:07:47.990969 | debian-bookworm | check: 392 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-26.0.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-03-27 14:07:47.992955 | debian-bookworm | check: 393 D build install image for pip-26.0.1-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.0.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:53] 2026-03-27 14:07:47.997397 | debian-bookworm | check: 398 D install setuptools from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/setuptools-82.0.0-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-03-27 14:07:47.999799 | debian-bookworm | check: 401 D build install image for setuptools-82.0.0-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.0.0-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:53] 2026-03-27 14:07:48.143967 | debian-bookworm | check: 545 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.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:46] 2026-03-27 14:07:48.145191 | debian-bookworm | check: 546 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.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:46] 2026-03-27 14:07:48.206993 | debian-bookworm | check: 608 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.0.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:46] 2026-03-27 14:07:48.284579 | debian-bookworm | check: 686 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.0.0-py3-none-any/setuptools-82.0.0.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/setuptools-82.0.0.virtualenv [virtualenv/util/path/_sync.py:46] 2026-03-27 14:07:48.285612 | debian-bookworm | check: 687 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.0.0-py3-none-any/setuptools-82.0.0.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/setuptools-82.0.0.dist-info [virtualenv/util/path/_sync.py:46] 2026-03-27 14:07:48.289560 | debian-bookworm | check: 691 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.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:46] 2026-03-27 14:07:48.290529 | debian-bookworm | check: 692 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2026-03-27 14:07:48.301728 | debian-bookworm | check: 703 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.0.1-py3-none-any/pip-26.0.1.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-26.0.1.dist-info [virtualenv/util/path/_sync.py:46] 2026-03-27 14:07:48.305588 | debian-bookworm | check: 707 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.0.1-py3-none-any/pip-26.0.1.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-26.0.1.virtualenv [virtualenv/util/path/_sync.py:46] 2026-03-27 14:07:48.306213 | debian-bookworm | check: 707 D generated console scripts pip3 pip-3.11 pip pip3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2026-03-27 14:07:48.306710 | debian-bookworm | check: 708 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:90] 2026-03-27 14:07:48.316213 | debian-bookworm | check: 717 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-03-27 14:07:48.316381 | debian-bookworm | check: 718 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.316532 | debian-bookworm | check: 718 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.316650 | debian-bookworm | check: 718 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.316764 | debian-bookworm | check: 718 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.316926 | debian-bookworm | check: 718 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.317038 | debian-bookworm | check: 718 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/check [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.317147 | debian-bookworm | check: 718 D virtualenv = 21.2.0 [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.317261 | debian-bookworm | check: 719 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.317387 | debian-bookworm | check: 719 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.317534 | debian-bookworm | check: 719 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.317654 | debian-bookworm | check: 719 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-03-27 14:07:48.325283 | debian-bookworm | check: 727 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:515] 2026-03-27 14:07:49.355080 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2026-03-27 14:07:49.456793 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2026-03-27 14:07:49.558217 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2026-03-27 14:07:49.569451 | 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-03-27 14:07:49.649300 | debian-bookworm | Collecting ansible==12.2.0 (from -r requirements.txt (line 3)) 2026-03-27 14:07:49.661192 | debian-bookworm | Downloading ansible-12.2.0-py3-none-any.whl.metadata (8.0 kB) 2026-03-27 14:07:49.711773 | debian-bookworm | Collecting packaging==26.0 (from -r requirements.txt (line 4)) 2026-03-27 14:07:49.724431 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-03-27 14:07:49.878031 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2026-03-27 14:07:49.892927 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2026-03-27 14:07:49.912286 | debian-bookworm | Installing build dependencies: started 2026-03-27 14:07:51.124947 | debian-bookworm | Installing build dependencies: finished with status 'done' 2026-03-27 14:07:51.126134 | debian-bookworm | Getting requirements to build wheel: started 2026-03-27 14:07:51.538168 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2026-03-27 14:07:51.540732 | debian-bookworm | Preparing metadata (pyproject.toml): started 2026-03-27 14:07:51.764687 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2026-03-27 14:07:51.907319 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2026-03-27 14:07:51.922479 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2026-03-27 14:07:51.983251 | debian-bookworm | Collecting requests==2.33.0 (from -r requirements.txt (line 7)) 2026-03-27 14:07:51.994863 | debian-bookworm | Downloading requests-2.33.0-py3-none-any.whl.metadata (5.1 kB) 2026-03-27 14:07:52.030345 | debian-bookworm | Collecting tabulate==0.10.0 (from -r requirements.txt (line 8)) 2026-03-27 14:07:52.042129 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl.metadata (40 kB) 2026-03-27 14:07:52.144652 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2026-03-27 14:07:52.156205 | 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-03-27 14:07:52.226804 | debian-bookworm | Collecting ansible-core~=2.19.4 (from ansible==12.2.0->-r requirements.txt (line 3)) 2026-03-27 14:07:52.238847 | debian-bookworm | Downloading ansible_core-2.19.8-py3-none-any.whl.metadata (7.7 kB) 2026-03-27 14:07:52.294836 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-03-27 14:07:52.305978 | debian-bookworm | Downloading click-8.3.1-py3-none-any.whl.metadata (2.6 kB) 2026-03-27 14:07:52.343628 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-03-27 14:07:52.354780 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-03-27 14:07:52.391798 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-03-27 14:07:52.404414 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2026-03-27 14:07:52.456348 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-03-27 14:07:52.470832 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2026-03-27 14:07:52.623740 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.33.0->-r requirements.txt (line 7)) 2026-03-27 14:07:52.635533 | debian-bookworm | Downloading charset_normalizer-3.4.6-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (40 kB) 2026-03-27 14:07:52.671556 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.33.0->-r requirements.txt (line 7)) 2026-03-27 14:07:52.683322 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl.metadata (8.4 kB) 2026-03-27 14:07:52.725929 | debian-bookworm | Collecting urllib3<3,>=1.26 (from requests==2.33.0->-r requirements.txt (line 7)) 2026-03-27 14:07:52.736766 | debian-bookworm | Downloading urllib3-2.6.3-py3-none-any.whl.metadata (6.9 kB) 2026-03-27 14:07:52.774584 | debian-bookworm | Collecting certifi>=2023.5.7 (from requests==2.33.0->-r requirements.txt (line 7)) 2026-03-27 14:07:52.785390 | debian-bookworm | Downloading certifi-2026.2.25-py3-none-any.whl.metadata (2.5 kB) 2026-03-27 14:07:53.076592 | debian-bookworm | Collecting cryptography (from ansible-core~=2.19.4->ansible==12.2.0->-r requirements.txt (line 3)) 2026-03-27 14:07:53.087721 | debian-bookworm | Downloading cryptography-46.0.6-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2026-03-27 14:07:53.125843 | debian-bookworm | Collecting resolvelib<2.0.0,>=0.5.3 (from ansible-core~=2.19.4->ansible==12.2.0->-r requirements.txt (line 3)) 2026-03-27 14:07:53.136953 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl.metadata (3.7 kB) 2026-03-27 14:07:53.281721 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core~=2.19.4->ansible==12.2.0->-r requirements.txt (line 3)) 2026-03-27 14:07:53.293013 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2026-03-27 14:07:53.325962 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core~=2.19.4->ansible==12.2.0->-r requirements.txt (line 3)) 2026-03-27 14:07:53.337174 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl.metadata (8.2 kB) 2026-03-27 14:07:53.360553 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-03-27 14:07:53.398927 | 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-03-27 14:07:53.713791 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 1.8 MB/s 0:00:00 2026-03-27 14:07:53.729988 | debian-bookworm | Downloading ansible-12.2.0-py3-none-any.whl (53.6 MB) 2026-03-27 14:07:55.522202 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 53.6/53.6 MB 30.1 MB/s 0:00:01 2026-03-27 14:07:55.534931 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-27 14:07:55.559586 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2026-03-27 14:07:55.582448 | debian-bookworm | Downloading requests-2.33.0-py3-none-any.whl (65 kB) 2026-03-27 14:07:55.609592 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl (39 kB) 2026-03-27 14:07:55.632788 | debian-bookworm | Downloading ansible_core-2.19.8-py3-none-any.whl (2.4 MB) 2026-03-27 14:07:55.773480 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 18.2 MB/s 0:00:00 2026-03-27 14:07:55.788072 | debian-bookworm | Downloading charset_normalizer-3.4.6-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (204 kB) 2026-03-27 14:07:55.819646 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl (71 kB) 2026-03-27 14:07:55.844669 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl (18 kB) 2026-03-27 14:07:55.867609 | debian-bookworm | Downloading urllib3-2.6.3-py3-none-any.whl (131 kB) 2026-03-27 14:07:55.894174 | debian-bookworm | Downloading certifi-2026.2.25-py3-none-any.whl (153 kB) 2026-03-27 14:07:55.925607 | 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-03-27 14:07:55.952203 | debian-bookworm | Downloading click-8.3.1-py3-none-any.whl (108 kB) 2026-03-27 14:07:55.977999 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-03-27 14:07:56.002101 | debian-bookworm | Downloading cryptography-46.0.6-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2026-03-27 14:07:56.269300 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 17.0 MB/s 0:00:00 2026-03-27 14:07:56.284474 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2026-03-27 14:07:56.318858 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2026-03-27 14:07:56.341159 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-03-27 14:07:56.365158 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2026-03-27 14:07:56.629951 | debian-bookworm | Building wheels for collected packages: pwgen 2026-03-27 14:07:56.631350 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2026-03-27 14:07:56.907617 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2026-03-27 14:07:56.909555 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3796 sha256=0951ec6c7153acf282708bd5d03a5683035c878aff9193c5b4888052b19d7ab5 2026-03-27 14:07:56.910786 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2026-03-27 14:07:56.915633 | debian-bookworm | Successfully built pwgen 2026-03-27 14:07:57.145895 | 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-03-27 14:08:21.076685 | debian-bookworm | 2026-03-27 14:08:21.079373 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-12.2.0 ansible-core-2.19.8 certifi-2026.2.25 cffi-2.0.0 charset_normalizer-3.4.6 click-8.3.1 colorama-0.4.6 cryptography-46.0.6 fasteners-0.20 idna-3.11 packaging-26.0 pwgen-0.8.2.post0 pycparser-3.0 python-gilt-1.2.3 requests-2.33.0 resolvelib-1.2.1 sh-2.2.2 tabulate-0.10.0 urllib3-2.6.3 2026-03-27 14:08:21.196784 | debian-bookworm | check: 33598 I exit 0 (32.87 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1433 [tox/execute/api.py:311] 2026-03-27 14:08:21.200966 | debian-bookworm | check: OK (33.38 seconds) 2026-03-27 14:08:21.201029 | debian-bookworm | congratulations :) (33.41 seconds) 2026-03-27 14:08:21.311439 | debian-bookworm | ok: Runtime: 0:00:33.665764 2026-03-27 14:08:21.335221 | 2026-03-27 14:08:21.335802 | TASK [tox : Create a tempfile to save tox showconfig] 2026-03-27 14:08:21.914038 | debian-bookworm | changed 2026-03-27 14:08:21.924394 | 2026-03-27 14:08:21.924538 | TASK [tox : Get tox envlist config] 2026-03-27 14:08:22.987771 | debian-bookworm | ok: Runtime: 0:00:00.301139 2026-03-27 14:08:22.993961 | 2026-03-27 14:08:22.994083 | TASK [tox : Install any sibling python packages] 2026-03-27 14:08:23.489866 | debian-bookworm | ok: No setup.cfg, no action needed 2026-03-27 14:08:23.496476 | 2026-03-27 14:08:23.496606 | TASK [tox : Remove tempfile] 2026-03-27 14:08:24.055948 | debian-bookworm | changed 2026-03-27 14:08:24.088722 | 2026-03-27 14:08:24.088874 | TASK [tox : Emit tox command] 2026-03-27 14:08:24.210656 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2026-03-27 14:08:24.218675 | 2026-03-27 14:08:24.218816 | TASK [tox : Run tox] 2026-03-27 14:08:25.026441 | debian-bookworm | ROOT: 170 D setup logging to DEBUG on pid 1590 [tox/report.py:229] 2026-03-27 14:08:25.052925 | debian-bookworm | check: 197 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-03-27 14:08:25.055210 | debian-bookworm | check: 199 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:62] 2026-03-27 14:08:25.058349 | debian-bookworm | check: 202 D got python info of /usr/bin/python3.11 from /home/zuul/.cache/virtualenv/py_info/4/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:139] 2026-03-27 14:08:25.059156 | debian-bookworm | check: 203 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-03-27 14:08:25.059382 | debian-bookworm | check: 203 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, Apr 28 2025, 14:11:48) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:71] 2026-03-27 14:08:25.059469 | debian-bookworm | check: 203 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, Apr 28 2025, 14:11:48) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:75] 2026-03-27 14:08:25.060462 | debian-bookworm | check: 204 D symlink on filesystem does work [virtualenv/info.py:51] 2026-03-27 14:08:25.060564 | debian-bookworm | check: 204 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-03-27 14:08:25.088671 | debian-bookworm | check: 233 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:515] 2026-03-27 14:08:25.183798 | debian-bookworm | check: 328 I exit 0 (0.09 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-inventory-sorting.py pid=1597 [tox/execute/api.py:311] 2026-03-27 14:08:25.184808 | debian-bookworm | check: OK (0.13=setup[0.04]+cmd[0.09] seconds) 2026-03-27 14:08:25.184824 | debian-bookworm | congratulations :) (0.16 seconds) 2026-03-27 14:08:25.465698 | debian-bookworm | ok: Runtime: 0:00:00.405531 2026-03-27 14:08:25.471882 | 2026-03-27 14:08:25.472011 | TASK [tox : Look for output] 2026-03-27 14:08:26.291892 | debian-bookworm | ok 2026-03-27 14:08:26.341457 | 2026-03-27 14:08:26.341624 | TASK [tox : Return file comments to Zuul] 2026-03-27 14:08:26.514891 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:26.522528 | 2026-03-27 14:08:26.522626 | PLAY RECAP 2026-03-27 14:08:26.522730 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-03-27 14:08:26.522756 | 2026-03-27 14:08:26.931027 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-27 14:08:26.932092 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-27 14:08:29.093258 | 2026-03-27 14:08:29.093378 | PLAY [all] 2026-03-27 14:08:29.123200 | 2026-03-27 14:08:29.123312 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-03-27 14:08:29.196959 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:29.201541 | 2026-03-27 14:08:29.201650 | TASK [fetch-tox-output : Set tox log path for single node] 2026-03-27 14:08:29.238766 | debian-bookworm | ok 2026-03-27 14:08:29.244277 | 2026-03-27 14:08:29.245100 | TASK [fetch-tox-output : Ensure local tox dir] 2026-03-27 14:08:30.275798 | debian-bookworm -> localhost | changed 2026-03-27 14:08:30.283517 | 2026-03-27 14:08:30.283619 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-03-27 14:08:30.393661 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:30.399555 | 2026-03-27 14:08:30.399672 | TASK [fetch-tox-output : Set envlist fact] 2026-03-27 14:08:30.464339 | debian-bookworm | ok 2026-03-27 14:08:30.471441 | 2026-03-27 14:08:30.471540 | TASK [fetch-tox-output : Get tox version] 2026-03-27 14:08:31.458270 | 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-03-27 14:08:31.476517 | debian-bookworm | 4.50.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-27 14:08:31.560547 | debian-bookworm | ok: Runtime: 0:00:00.282398 2026-03-27 14:08:31.565860 | 2026-03-27 14:08:31.565958 | TASK [fetch-tox-output : Find all default environments] 2026-03-27 14:08:32.106299 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:32.111288 | 2026-03-27 14:08:32.111380 | TASK [fetch-tox-output : Set envlist fact] 2026-03-27 14:08:32.161122 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:32.165625 | 2026-03-27 14:08:32.165718 | TASK [fetch-tox-output : Find all default environments] 2026-03-27 14:08:32.728039 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:32.732647 | 2026-03-27 14:08:32.732728 | TASK [fetch-tox-output : Set envlist fact] 2026-03-27 14:08:32.755580 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:32.764228 | 2026-03-27 14:08:32.764318 | LOOP [fetch-tox-output : Copy tox logs] 2026-03-27 14:08:32.876457 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:32.903313 | 2026-03-27 14:08:32.903419 | LOOP [fetch-tox-output : Collect tox logs] 2026-03-27 14:08:33.751562 | debian-bookworm | changed: 2026-03-27 14:08:33.751741 | debian-bookworm | created directory /var/lib/zuul/builds/243d1f63bfe14d82978aacc99a67a846/work/logs/tox/check 2026-03-27 14:08:33.751799 | debian-bookworm | cd+++++++++ ./ 2026-03-27 14:08:33.751821 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-03-27 14:08:33.751847 | 2026-03-27 14:08:33.767955 | 2026-03-27 14:08:33.768030 | PLAY RECAP 2026-03-27 14:08:33.768080 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-03-27 14:08:33.768104 | 2026-03-27 14:08:33.933721 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-27 14:08:33.934578 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-27 14:08:34.843472 | 2026-03-27 14:08:34.843585 | PLAY [all] 2026-03-27 14:08:34.864596 | 2026-03-27 14:08:34.864763 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-27 14:08:35.128964 | debian-bookworm | changed: non-zero return code 2026-03-27 14:08:35.135251 | 2026-03-27 14:08:35.135372 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-27 14:08:35.175063 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:35.181498 | 2026-03-27 14:08:35.181618 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-27 14:08:35.213340 | 2026-03-27 14:08:35.213629 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-27 14:08:35.246146 | 2026-03-27 14:08:35.246317 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-27 14:08:35.271323 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:35.285010 | 2026-03-27 14:08:35.285256 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-27 14:08:35.344408 | 2026-03-27 14:08:35.344664 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-27 14:08:35.362099 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:35.370675 | 2026-03-27 14:08:35.370762 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-27 14:08:35.383752 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:35.389095 | 2026-03-27 14:08:35.389189 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-27 14:08:35.416491 | debian-bookworm | skipping: Conditional result was False 2026-03-27 14:08:35.429036 | 2026-03-27 14:08:35.429120 | PLAY RECAP 2026-03-27 14:08:35.429168 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-27 14:08:35.429193 | 2026-03-27 14:08:35.523528 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-27 14:08:35.525239 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-27 14:08:36.976368 | 2026-03-27 14:08:36.976497 | PLAY [Base post] 2026-03-27 14:08:37.007730 | 2026-03-27 14:08:37.007857 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-27 14:08:37.698215 | debian-bookworm | changed 2026-03-27 14:08:37.711749 | 2026-03-27 14:08:37.711852 | PLAY RECAP 2026-03-27 14:08:37.711918 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-27 14:08:37.711981 | 2026-03-27 14:08:37.896325 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-27 14:08:37.897329 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-27 14:08:40.002478 | 2026-03-27 14:08:40.002611 | PLAY [Base post-logs] 2026-03-27 14:08:40.066616 | 2026-03-27 14:08:40.066762 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-27 14:08:41.023486 | localhost | changed 2026-03-27 14:08:41.032694 | 2026-03-27 14:08:41.032832 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-27 14:08:41.075186 | localhost | ok 2026-03-27 14:08:41.078103 | 2026-03-27 14:08:41.078196 | TASK [Set zuul-log-path fact] 2026-03-27 14:08:41.102792 | localhost | ok 2026-03-27 14:08:41.110480 | 2026-03-27 14:08:41.110591 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-27 14:08:41.150192 | localhost | ok 2026-03-27 14:08:41.152561 | 2026-03-27 14:08:41.152648 | TASK [upload-logs : Create log directories] 2026-03-27 14:08:41.923075 | localhost | changed 2026-03-27 14:08:41.926971 | 2026-03-27 14:08:41.927309 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-27 14:08:42.829361 | localhost -> localhost | ok: Runtime: 0:00:00.038632 2026-03-27 14:08:42.833344 | 2026-03-27 14:08:42.833437 | TASK [upload-logs : Upload logs to log server] 2026-03-27 14:08:43.962134 | localhost | Output suppressed because no_log was given 2026-03-27 14:08:43.963568 | 2026-03-27 14:08:43.963682 | LOOP [upload-logs : Compress console log and json output] 2026-03-27 14:08:44.023528 | localhost | skipping: Conditional result was False 2026-03-27 14:08:44.032145 | localhost | skipping: Conditional result was False 2026-03-27 14:08:44.039686 | 2026-03-27 14:08:44.039782 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-27 14:08:44.098699 | localhost | skipping: Conditional result was False 2026-03-27 14:08:44.098982 | 2026-03-27 14:08:44.103962 | localhost | skipping: Conditional result was False 2026-03-27 14:08:44.115096 | 2026-03-27 14:08:44.115188 | LOOP [upload-logs : Upload console log and json output]