2026-09-09 15:23:44.442265 | Job console starting 2026-09-09 15:23:44.460129 | Updating git repos 2026-09-09 15:23:44.507921 | Cloning repos into workspace 2026-09-09 15:23:44.563707 | Restoring repo states 2026-09-09 15:23:44.601776 | Merging changes 2026-09-09 15:23:45.289612 | Checking out repos 2026-09-09 15:23:45.383874 | Preparing playbooks 2026-09-09 15:23:47.137038 | Running Ansible setup 2026-09-09 15:23:52.824449 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-09 15:23:54.062371 | 2026-09-09 15:23:54.062495 | PLAY [Base pre] 2026-09-09 15:23:54.079703 | 2026-09-09 15:23:54.079784 | TASK [Setup log path fact] 2026-09-09 15:23:54.096700 | debian-bookworm | ok 2026-09-09 15:23:54.108898 | 2026-09-09 15:23:54.108982 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-09 15:23:54.145366 | debian-bookworm | ok 2026-09-09 15:23:54.153207 | 2026-09-09 15:23:54.153280 | TASK [emit-job-header : Print job information] 2026-09-09 15:23:54.211772 | # Job Information 2026-09-09 15:23:54.212010 | Ansible Version: 2.16.14 2026-09-09 15:23:54.212041 | Job: generics-tox-check 2026-09-09 15:23:54.212067 | Pipeline: check 2026-09-09 15:23:54.212086 | Executor: 521e9411259a 2026-09-09 15:23:54.212102 | Triggered by: https://github.com/osism/generics/pull/619 2026-09-09 15:23:54.212121 | Event ID: 6bca0450-ac62-11f1-9654-c8ba61afac19 2026-09-09 15:23:54.216428 | 2026-09-09 15:23:54.216526 | LOOP [emit-job-header : Print node information] 2026-09-09 15:23:54.374808 | debian-bookworm | ok: 2026-09-09 15:23:54.375067 | debian-bookworm | # Node Information 2026-09-09 15:23:54.375099 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-09 15:23:54.375120 | debian-bookworm | Hostname: debian 2026-09-09 15:23:54.375140 | debian-bookworm | Username: zuul 2026-09-09 15:23:54.375157 | debian-bookworm | Distro: Debian 12.15 2026-09-09 15:23:54.375181 | debian-bookworm | Provider: regiocloud-a 2026-09-09 15:23:54.375199 | debian-bookworm | Region: 2026-09-09 15:23:54.375218 | debian-bookworm | Label: debian-bookworm 2026-09-09 15:23:54.375235 | debian-bookworm | Product Name: OpenStack Nova 2026-09-09 15:23:54.375251 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee3:cadd 2026-09-09 15:23:54.392671 | 2026-09-09 15:23:54.392777 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-09 15:23:55.137393 | debian-bookworm -> localhost | changed 2026-09-09 15:23:55.143458 | 2026-09-09 15:23:55.143541 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-09 15:23:57.678610 | debian-bookworm -> localhost | changed 2026-09-09 15:23:57.688477 | 2026-09-09 15:23:57.688564 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-09 15:23:58.448052 | debian-bookworm -> localhost | ok 2026-09-09 15:23:58.452935 | 2026-09-09 15:23:58.453021 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-09 15:23:58.501336 | debian-bookworm | ok 2026-09-09 15:23:58.528513 | debian-bookworm | included: /var/lib/zuul/builds/301e46fe49f941319b195cc2e4491ac5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-09 15:23:58.543778 | 2026-09-09 15:23:58.543898 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-09 15:24:01.192931 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-09 15:24:01.193094 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/301e46fe49f941319b195cc2e4491ac5/work/301e46fe49f941319b195cc2e4491ac5_id_rsa 2026-09-09 15:24:01.193125 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/301e46fe49f941319b195cc2e4491ac5/work/301e46fe49f941319b195cc2e4491ac5_id_rsa.pub 2026-09-09 15:24:01.193146 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-09 15:24:01.193166 | debian-bookworm -> localhost | SHA256:u5aEXpBOaSKyWUIcRA6sOX3edeBMyZvmnxA5eElMiDY zuul-build-sshkey 2026-09-09 15:24:01.193184 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-09 15:24:01.193210 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-09 15:24:01.193228 | debian-bookworm -> localhost | |*+. . =.. | 2026-09-09 15:24:01.193245 | debian-bookworm -> localhost | |o+ E . B | 2026-09-09 15:24:01.193262 | debian-bookworm -> localhost | |o+ . . O * | 2026-09-09 15:24:01.193278 | debian-bookworm -> localhost | |* + o B & . | 2026-09-09 15:24:01.193294 | debian-bookworm -> localhost | | B + * BS+ | 2026-09-09 15:24:01.193313 | debian-bookworm -> localhost | |o . + =. | 2026-09-09 15:24:01.193329 | debian-bookworm -> localhost | | . o.+ . | 2026-09-09 15:24:01.193346 | debian-bookworm -> localhost | | . o.o | 2026-09-09 15:24:01.193363 | debian-bookworm -> localhost | | .. | 2026-09-09 15:24:01.193380 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-09 15:24:01.193420 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.661428 2026-09-09 15:24:01.198489 | 2026-09-09 15:24:01.198564 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-09 15:24:01.244956 | debian-bookworm | ok 2026-09-09 15:24:01.256906 | debian-bookworm | included: /var/lib/zuul/builds/301e46fe49f941319b195cc2e4491ac5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-09 15:24:01.291900 | 2026-09-09 15:24:01.291987 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-09 15:24:01.340758 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:24:01.345499 | 2026-09-09 15:24:01.345587 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-09 15:24:01.925679 | debian-bookworm | changed 2026-09-09 15:24:01.929897 | 2026-09-09 15:24:01.929966 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-09 15:24:02.202674 | debian-bookworm | ok 2026-09-09 15:24:02.207100 | 2026-09-09 15:24:02.207180 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-09 15:24:02.919461 | debian-bookworm | changed 2026-09-09 15:24:02.923718 | 2026-09-09 15:24:02.923799 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-09 15:24:03.618774 | debian-bookworm | changed 2026-09-09 15:24:03.623286 | 2026-09-09 15:24:03.623366 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-09 15:24:03.646490 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:24:03.651062 | 2026-09-09 15:24:03.651131 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-09 15:24:04.039280 | debian-bookworm -> localhost | changed 2026-09-09 15:24:04.050358 | 2026-09-09 15:24:04.050452 | TASK [add-build-sshkey : Add back temp key] 2026-09-09 15:24:04.409209 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/301e46fe49f941319b195cc2e4491ac5/work/301e46fe49f941319b195cc2e4491ac5_id_rsa (zuul-build-sshkey) 2026-09-09 15:24:04.409762 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016265 2026-09-09 15:24:04.423814 | 2026-09-09 15:24:04.423913 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-09 15:24:04.753569 | debian-bookworm | ok 2026-09-09 15:24:04.758661 | 2026-09-09 15:24:04.758744 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-09 15:24:04.781942 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:24:04.802950 | 2026-09-09 15:24:04.803086 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-09 15:24:05.209853 | debian-bookworm | ok 2026-09-09 15:24:05.231448 | 2026-09-09 15:24:05.231568 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-09 15:24:05.262507 | debian-bookworm | ok 2026-09-09 15:24:05.268509 | 2026-09-09 15:24:05.268596 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-09 15:24:05.625950 | debian-bookworm -> localhost | ok 2026-09-09 15:24:05.632092 | 2026-09-09 15:24:05.632179 | TASK [validate-host : Collect information about the host] 2026-09-09 15:24:07.234746 | debian-bookworm | ok 2026-09-09 15:24:07.267932 | 2026-09-09 15:24:07.268037 | TASK [validate-host : Sanitize hostname] 2026-09-09 15:24:07.440407 | debian-bookworm | ok 2026-09-09 15:24:07.453156 | 2026-09-09 15:24:07.453254 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-09 15:24:08.548028 | debian-bookworm -> localhost | changed 2026-09-09 15:24:08.552687 | 2026-09-09 15:24:08.552769 | TASK [validate-host : Collect information about zuul worker] 2026-09-09 15:24:08.934372 | debian-bookworm | ok 2026-09-09 15:24:08.938385 | 2026-09-09 15:24:08.938471 | TASK [validate-host : Write out all zuul information for each host] 2026-09-09 15:24:09.852376 | debian-bookworm -> localhost | changed 2026-09-09 15:24:09.859972 | 2026-09-09 15:24:09.860052 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-09 15:24:10.138021 | debian-bookworm | ok 2026-09-09 15:24:10.142332 | 2026-09-09 15:24:10.142402 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-09 15:24:11.250190 | debian-bookworm | changed: 2026-09-09 15:24:11.250335 | debian-bookworm | cd+++++++++ src/ 2026-09-09 15:24:11.250364 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-09 15:24:11.250384 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-09 15:24:11.250401 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-09-09 15:24:11.250418 | debian-bookworm | =7.0.3 2026-09-09 15:24:48.255196 | debian-bookworm | Downloading cachetools-7.1.8-py3-none-any.whl (16 kB) 2026-09-09 15:24:48.321882 | debian-bookworm | Collecting colorama>=0.4.6 2026-09-09 15:24:48.339098 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-09-09 15:24:48.417073 | debian-bookworm | Collecting filelock>=3.25 2026-09-09 15:24:48.431638 | debian-bookworm | Downloading filelock-3.32.6-py3-none-any.whl (100 kB) 2026-09-09 15:24:48.450261 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 7.3 MB/s eta 0:00:00 2026-09-09 15:24:48.514991 | debian-bookworm | Collecting packaging>=26 2026-09-09 15:24:48.529995 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-09-09 15:24:48.549062 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 8.5 MB/s eta 0:00:00 2026-09-09 15:24:48.624511 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-09-09 15:24:48.639179 | debian-bookworm | Downloading platformdirs-4.11.8-py3-none-any.whl (24 kB) 2026-09-09 15:24:48.684111 | debian-bookworm | Collecting pluggy>=1.6 2026-09-09 15:24:48.698756 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-09-09 15:24:48.760357 | debian-bookworm | Collecting pyproject-api>=1.10 2026-09-09 15:24:48.776024 | debian-bookworm | Downloading pyproject_api-1.11.0-py3-none-any.whl (13 kB) 2026-09-09 15:24:48.820110 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-09-09 15:24:48.834787 | debian-bookworm | Downloading python_discovery-1.6.0-py3-none-any.whl (38 kB) 2026-09-09 15:24:48.875320 | debian-bookworm | Collecting tomli-w>=1.2 2026-09-09 15:24:48.889704 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-09-09 15:24:48.937894 | debian-bookworm | Collecting typing-extensions>=4.15 2026-09-09 15:24:48.954353 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-09-09 15:24:48.961939 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 7.3 MB/s eta 0:00:00 2026-09-09 15:24:49.104633 | debian-bookworm | Collecting virtualenv>=21.1 2026-09-09 15:24:49.121945 | debian-bookworm | Downloading virtualenv-21.7.9-py3-none-any.whl (5.3 MB) 2026-09-09 15:24:49.443333 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.3/5.3 MB 16.9 MB/s eta 0:00:00 2026-09-09 15:24:49.533846 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-09-09 15:24:49.548891 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-09-09 15:24:49.573406 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 25.8 MB/s eta 0:00:00 2026-09-09 15:24:49.693288 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-09-09 15:24:50.647301 | debian-bookworm | Successfully installed cachetools-7.1.8 colorama-0.4.6 distlib-0.4.3 filelock-3.32.6 packaging-26.3 platformdirs-4.11.8 pluggy-1.6.0 pyproject-api-1.11.0 python-discovery-1.6.0 tomli-w-1.2.0 tox-4.61.4 typing-extensions-4.16.0 virtualenv-21.7.9 2026-09-09 15:24:51.046598 | debian-bookworm | ok: Runtime: 0:00:03.446501 2026-09-09 15:24:51.060283 | 2026-09-09 15:24:51.060450 | TASK [ensure-tox : Export installed tox_executable path] 2026-09-09 15:24:51.111087 | debian-bookworm | ok 2026-09-09 15:24:51.118258 | 2026-09-09 15:24:51.118395 | TASK [ensure-tox : Output tox version] 2026-09-09 15:24:51.715686 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-09-09 15:24:51.746878 | debian-bookworm | 4.61.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-09 15:24:52.163919 | debian-bookworm | ok: Runtime: 0:00:00.382213 2026-09-09 15:24:52.170326 | 2026-09-09 15:24:52.170450 | TASK [ensure-tox : Make global symlink] 2026-09-09 15:24:52.205653 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:24:52.213070 | 2026-09-09 15:24:52.213156 | PLAY RECAP 2026-09-09 15:24:52.213218 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-09-09 15:24:52.213245 | 2026-09-09 15:24:52.361054 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-09-09 15:24:52.364344 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-09 15:24:53.183949 | 2026-09-09 15:24:53.184118 | PLAY [all] 2026-09-09 15:24:53.201236 | 2026-09-09 15:24:53.201379 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-09-09 15:24:53.781880 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-09 15:24:54.240470 | debian-bookworm | ok: Runtime: 0:00:00.031794 2026-09-09 15:24:54.246707 | 2026-09-09 15:24:54.246860 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-09-09 15:24:54.782459 | debian-bookworm | ok: Runtime: 0:00:00.007516 2026-09-09 15:24:54.789101 | 2026-09-09 15:24:54.789227 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-09-09 15:24:55.157896 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-09 15:24:55.159430 | debian-bookworm | sudo: a password is required 2026-09-09 15:24:55.359615 | debian-bookworm | ok: Runtime: 0:00:00.019485 2026-09-09 15:24:55.369931 | 2026-09-09 15:24:55.370039 | TASK [tox : Check to see if the constraints file exists] 2026-09-09 15:24:55.395258 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:24:55.401341 | 2026-09-09 15:24:55.401452 | TASK [tox : Fail if constraints file is missing] 2026-09-09 15:24:55.425917 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:24:55.433159 | 2026-09-09 15:24:55.433297 | TASK [tox : Record file location] 2026-09-09 15:24:55.459954 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:24:55.467718 | 2026-09-09 15:24:55.467893 | TASK [tox : Install tox siblings] 2026-09-09 15:24:55.492982 | debian-bookworm | ok 2026-09-09 15:24:55.504621 | debian-bookworm | included: /var/lib/zuul/builds/301e46fe49f941319b195cc2e4491ac5/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-09-09 15:24:55.510506 | 2026-09-09 15:24:55.510615 | TASK [tox : Run tox without tests] 2026-09-09 15:24:56.048971 | debian-bookworm | ROOT: 204 D setup logging to DEBUG on pid 1601 [tox/report.py:242] 2026-09-09 15:24:56.079159 | debian-bookworm | check: 234 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-09 15:24:56.081763 | debian-bookworm | check: 237 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-09 15:24:56.085239 | debian-bookworm | check: 240 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 c42291ded942244c350d8fef419ed316 1ad321503a2868f0e83f5a98e1eaa986 [python_discovery/_cached_py_info.py:223] 2026-09-09 15:24:56.147714 | debian-bookworm | check: 302 D wrote python info of /usr/bin/python3.11 at /home/zuul/.cache/virtualenv/py_info/5/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:159] 2026-09-09 15:24:56.148680 | debian-bookworm | check: 304 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-09 15:24:56.149133 | 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, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:140] 2026-09-09 15:24:56.149435 | 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, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:144] 2026-09-09 15:24:56.153717 | debian-bookworm | check: 309 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-09 15:24:56.154043 | debian-bookworm | check: 309 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-09 15:24:56.189728 | debian-bookworm | check: 345 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-09-09 15:24:56.189991 | debian-bookworm | check: 345 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/bin [virtualenv/util/path/_sync.py:22] 2026-09-09 15:24:56.190144 | debian-bookworm | check: 345 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/include [virtualenv/util/path/_sync.py:22] 2026-09-09 15:24:56.190223 | debian-bookworm | check: 345 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-09 15:24:56.190439 | debian-bookworm | check: 345 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-09-09 15:24:56.190507 | debian-bookworm | check: 345 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.190564 | debian-bookworm | check: 346 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.190615 | debian-bookworm | check: 346 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.190671 | debian-bookworm | check: 346 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.190718 | debian-bookworm | check: 346 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.190769 | debian-bookworm | check: 346 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-09-09 15:24:56.190817 | debian-bookworm | check: 346 D virtualenv = 21.7.9 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.190865 | debian-bookworm | check: 346 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.190925 | debian-bookworm | check: 346 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.190972 | debian-bookworm | check: 346 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.191016 | debian-bookworm | check: 346 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.191292 | debian-bookworm | check: 346 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-09 15:24:56.191710 | debian-bookworm | check: 347 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-09-09 15:24:56.191955 | debian-bookworm | check: 347 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:265] 2026-09-09 15:24:56.229284 | debian-bookworm | check: 347 D { 2026-09-09 15:24:56.229335 | debian-bookworm | "sys": { 2026-09-09 15:24:56.229346 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check/bin/python", 2026-09-09 15:24:56.229355 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-09-09 15:24:56.229361 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-09-09 15:24:56.229367 | debian-bookworm | "base_prefix": "/usr", 2026-09-09 15:24:56.229371 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-09-09 15:24:56.229376 | debian-bookworm | "base_exec_prefix": "/usr", 2026-09-09 15:24:56.229380 | debian-bookworm | "path": [ 2026-09-09 15:24:56.229384 | debian-bookworm | "/usr/lib/python311.zip", 2026-09-09 15:24:56.229388 | debian-bookworm | "/usr/lib/python3.11", 2026-09-09 15:24:56.229392 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-09-09 15:24:56.229396 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages" 2026-09-09 15:24:56.229400 | debian-bookworm | ], 2026-09-09 15:24:56.229404 | debian-bookworm | "meta_path": [ 2026-09-09 15:24:56.229408 | debian-bookworm | "", 2026-09-09 15:24:56.229412 | debian-bookworm | "", 2026-09-09 15:24:56.229416 | debian-bookworm | "" 2026-09-09 15:24:56.229420 | debian-bookworm | ], 2026-09-09 15:24:56.229424 | debian-bookworm | "fs_encoding": "utf-8", 2026-09-09 15:24:56.229428 | debian-bookworm | "io_encoding": "utf-8" 2026-09-09 15:24:56.229432 | debian-bookworm | }, 2026-09-09 15:24:56.229436 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-09-09 15:24:56.229440 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-09-09 15:24:56.229444 | debian-bookworm | "os": "", 2026-09-09 15:24:56.229448 | debian-bookworm | "site": "", 2026-09-09 15:24:56.229452 | debian-bookworm | "datetime": "", 2026-09-09 15:24:56.229460 | debian-bookworm | "math": "", 2026-09-09 15:24:56.229464 | debian-bookworm | "json": "" 2026-09-09 15:24:56.229468 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-09-09 15:24:56.229606 | debian-bookworm | check: 384 I add seed packages via FromAppData(download=False, pip=bundle, setuptools=bundle, via=copy, app_data_dir=/home/zuul/.cache/virtualenv) [virtualenv/run/session.py:84] 2026-09-09 15:24:56.236281 | debian-bookworm | check: 391 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-26.2.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-09-09 15:24:56.240506 | debian-bookworm | check: 392 D build install image for pip-26.2.1-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.2.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-09-09 15:24:56.240879 | debian-bookworm | check: 396 D install setuptools from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/setuptools-84.0.0-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-09-09 15:24:56.243963 | debian-bookworm | check: 399 D build install image for setuptools-84.0.0-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-09-09 15:24:56.552373 | debian-bookworm | check: 707 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-09 15:24:56.628795 | debian-bookworm | check: 784 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-09 15:24:56.629302 | debian-bookworm | check: 784 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-09 15:24:56.673938 | debian-bookworm | check: 829 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-09 15:24:56.674817 | debian-bookworm | check: 830 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-09 15:24:56.675189 | debian-bookworm | check: 830 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-09 15:24:56.675580 | debian-bookworm | check: 831 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-09 15:24:56.677410 | debian-bookworm | check: 832 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-09 15:24:56.708998 | debian-bookworm | check: 864 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-09 15:24:56.713194 | debian-bookworm | check: 868 D generated console scripts pip-3.11 pip3 pip pip3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-09 15:24:56.713966 | debian-bookworm | check: 869 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-09-09 15:24:56.724998 | debian-bookworm | check: 880 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-09-09 15:24:56.725151 | debian-bookworm | check: 880 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.725286 | debian-bookworm | check: 880 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.725412 | debian-bookworm | check: 880 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.725530 | debian-bookworm | check: 880 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.725663 | debian-bookworm | check: 881 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.725771 | debian-bookworm | check: 881 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-09-09 15:24:56.725915 | debian-bookworm | check: 881 D virtualenv = 21.7.9 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.726032 | debian-bookworm | check: 881 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.726155 | debian-bookworm | check: 881 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.726276 | debian-bookworm | check: 881 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.726397 | debian-bookworm | check: 881 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-09-09 15:24:56.735485 | debian-bookworm | check: 890 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:485] 2026-09-09 15:24:57.822419 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2026-09-09 15:24:57.952299 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2026-09-09 15:24:58.075855 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2026-09-09 15:24:58.094091 | 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-09 15:24:58.175916 | debian-bookworm | Collecting ansible==12.3.0 (from -r requirements.txt (line 3)) 2026-09-09 15:24:58.205636 | debian-bookworm | Downloading ansible-12.3.0-py3-none-any.whl.metadata (8.1 kB) 2026-09-09 15:24:58.263145 | debian-bookworm | Collecting packaging==26.3 (from -r requirements.txt (line 4)) 2026-09-09 15:24:58.280015 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl.metadata (3.5 kB) 2026-09-09 15:24:58.326100 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2026-09-09 15:24:58.352441 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2026-09-09 15:24:58.368757 | debian-bookworm | Installing build dependencies: started 2026-09-09 15:24:59.526625 | debian-bookworm | Installing build dependencies: finished with status 'done' 2026-09-09 15:24:59.526663 | debian-bookworm | Getting requirements to build wheel: started 2026-09-09 15:24:59.916939 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2026-09-09 15:24:59.916971 | debian-bookworm | Preparing metadata (pyproject.toml): started 2026-09-09 15:25:00.124162 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2026-09-09 15:25:00.164036 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2026-09-09 15:25:00.181399 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2026-09-09 15:25:00.254999 | debian-bookworm | Collecting requests==2.34.2 (from -r requirements.txt (line 7)) 2026-09-09 15:25:00.269575 | debian-bookworm | Downloading requests-2.34.2-py3-none-any.whl.metadata (4.8 kB) 2026-09-09 15:25:00.317930 | debian-bookworm | Collecting tabulate==0.10.0 (from -r requirements.txt (line 8)) 2026-09-09 15:25:00.334411 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl.metadata (40 kB) 2026-09-09 15:25:00.453232 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2026-09-09 15:25:00.467661 | 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-09 15:25:00.540729 | debian-bookworm | Collecting ansible-core~=2.19.5 (from ansible==12.3.0->-r requirements.txt (line 3)) 2026-09-09 15:25:00.555649 | debian-bookworm | Downloading ansible_core-2.19.13-py3-none-any.whl.metadata (7.7 kB) 2026-09-09 15:25:00.615348 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-09-09 15:25:00.629704 | debian-bookworm | Downloading click-8.5.0-py3-none-any.whl.metadata (2.6 kB) 2026-09-09 15:25:00.679361 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-09-09 15:25:00.694974 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-09-09 15:25:00.755616 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-09-09 15:25:00.773609 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2026-09-09 15:25:00.837220 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-09-09 15:25:00.858277 | debian-bookworm | Downloading sh-2.4.0-py3-none-any.whl.metadata (3.8 kB) 2026-09-09 15:25:01.057752 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-09-09 15:25:01.073001 | 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-09 15:25:01.125716 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-09-09 15:25:01.142088 | debian-bookworm | Downloading idna-3.19-py3-none-any.whl.metadata (9.2 kB) 2026-09-09 15:25:01.209144 | debian-bookworm | Collecting urllib3<3,>=1.26 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-09-09 15:25:01.225809 | debian-bookworm | Downloading urllib3-2.7.0-py3-none-any.whl.metadata (6.9 kB) 2026-09-09 15:25:01.284819 | debian-bookworm | Collecting certifi>=2023.5.7 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-09-09 15:25:01.300063 | debian-bookworm | Downloading certifi-2026.7.22-py3-none-any.whl.metadata (2.5 kB) 2026-09-09 15:25:01.574791 | debian-bookworm | Collecting cryptography (from ansible-core~=2.19.5->ansible==12.3.0->-r requirements.txt (line 3)) 2026-09-09 15:25:01.589527 | debian-bookworm | Downloading cryptography-50.0.1-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (4.3 kB) 2026-09-09 15:25:01.640490 | 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-09 15:25:01.658016 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl.metadata (3.7 kB) 2026-09-09 15:25:01.808422 | 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-09 15:25:01.827365 | debian-bookworm | Downloading cffi-2.1.1-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.5 kB) 2026-09-09 15:25:01.920953 | 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-09 15:25:01.938266 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl.metadata (8.2 kB) 2026-09-09 15:25:01.973760 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-09-09 15:25:02.014261 | 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-09 15:25:02.056168 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 20.5 MB/s 0:00:00 2026-09-09 15:25:02.075193 | debian-bookworm | Downloading ansible-12.3.0-py3-none-any.whl (54.4 MB) 2026-09-09 15:25:03.517049 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.4/54.4 MB 37.7 MB/s 0:00:01 2026-09-09 15:25:03.532892 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-09-09 15:25:03.559722 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2026-09-09 15:25:03.583424 | debian-bookworm | Downloading requests-2.34.2-py3-none-any.whl (73 kB) 2026-09-09 15:25:03.621774 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl (39 kB) 2026-09-09 15:25:03.653167 | debian-bookworm | Downloading ansible_core-2.19.13-py3-none-any.whl (2.4 MB) 2026-09-09 15:25:03.737488 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 28.4 MB/s 0:00:00 2026-09-09 15:25:03.756637 | 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-09 15:25:03.793246 | debian-bookworm | Downloading idna-3.19-py3-none-any.whl (68 kB) 2026-09-09 15:25:03.821331 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl (18 kB) 2026-09-09 15:25:03.848967 | debian-bookworm | Downloading urllib3-2.7.0-py3-none-any.whl (131 kB) 2026-09-09 15:25:03.877944 | debian-bookworm | Downloading certifi-2026.7.22-py3-none-any.whl (136 kB) 2026-09-09 15:25:03.906950 | 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-09 15:25:03.933703 | debian-bookworm | Downloading click-8.5.0-py3-none-any.whl (125 kB) 2026-09-09 15:25:03.962114 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-09-09 15:25:03.987337 | debian-bookworm | Downloading cryptography-50.0.1-cp311-abi3-manylinux_2_34_x86_64.whl (4.7 MB) 2026-09-09 15:25:04.164603 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.7/4.7 MB 26.9 MB/s 0:00:00 2026-09-09 15:25:04.182696 | debian-bookworm | Downloading cffi-2.1.1-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (217 kB) 2026-09-09 15:25:04.225117 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2026-09-09 15:25:04.264651 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-09-09 15:25:04.296449 | debian-bookworm | Downloading sh-2.4.0-py3-none-any.whl (48 kB) 2026-09-09 15:25:04.577286 | debian-bookworm | Building wheels for collected packages: pwgen 2026-09-09 15:25:04.578186 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2026-09-09 15:25:04.853047 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2026-09-09 15:25:04.854528 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3795 sha256=3eacf275fef7cd8efdfe665780e9af27dcc3b8d5955fdf0251d84a78057501fc 2026-09-09 15:25:04.855196 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2026-09-09 15:25:04.859449 | debian-bookworm | Successfully built pwgen 2026-09-09 15:25:05.060564 | 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-09 15:25:30.673016 | debian-bookworm | 2026-09-09 15:25:30.676913 | 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.19 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.7.0 2026-09-09 15:25:30.811084 | debian-bookworm | check: 34966 I exit 0 (34.07 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1614 [tox/execute/api.py:309] 2026-09-09 15:25:30.812463 | debian-bookworm | check: OK (34.74 seconds) 2026-09-09 15:25:30.812528 | debian-bookworm | congratulations :) (34.77 seconds) 2026-09-09 15:25:31.061962 | debian-bookworm | ok: Runtime: 0:00:35.054776 2026-09-09 15:25:31.078733 | 2026-09-09 15:25:31.078946 | TASK [tox : Create a tempfile to save tox showconfig] 2026-09-09 15:25:31.481294 | debian-bookworm | changed 2026-09-09 15:25:31.488153 | 2026-09-09 15:25:31.488288 | TASK [tox : Detect tox version] 2026-09-09 15:25:32.016604 | debian-bookworm | 4.61.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-09 15:25:32.518624 | debian-bookworm | ok: Runtime: 0:00:00.295441 2026-09-09 15:25:32.527276 | 2026-09-09 15:25:32.527428 | TASK [tox : Get tox envlist config] 2026-09-09 15:25:33.557219 | debian-bookworm | ok: Runtime: 0:00:00.336715 2026-09-09 15:25:33.569618 | 2026-09-09 15:25:33.569805 | TASK [tox : Install any sibling python packages] 2026-09-09 15:25:34.030173 | debian-bookworm | ok: No setup.cfg, no action needed 2026-09-09 15:25:34.036497 | 2026-09-09 15:25:34.036624 | TASK [tox : Remove tempfile] 2026-09-09 15:25:34.523262 | debian-bookworm | changed 2026-09-09 15:25:34.529011 | 2026-09-09 15:25:34.529118 | TASK [tox : Emit tox command] 2026-09-09 15:25:34.568899 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2026-09-09 15:25:34.575326 | 2026-09-09 15:25:34.575441 | TASK [tox : Run tox] 2026-09-09 15:25:35.074500 | debian-bookworm | ROOT: 205 D setup logging to DEBUG on pid 1776 [tox/report.py:242] 2026-09-09 15:25:35.104218 | debian-bookworm | check: 235 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-09 15:25:35.106767 | debian-bookworm | check: 238 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-09 15:25:35.110297 | debian-bookworm | check: 241 D got python info of /usr/bin/python3.11 from /home/zuul/.cache/virtualenv/py_info/5/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:139] 2026-09-09 15:25:35.110646 | debian-bookworm | check: 242 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-09 15:25:35.110788 | debian-bookworm | check: 242 I proposed PythonInfo(spec=CPython3.11.2.final.0-64-x86_64, system=/usr/bin/python3.11, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:140] 2026-09-09 15:25:35.110878 | debian-bookworm | check: 242 D accepted PythonInfo(spec=CPython3.11.2.final.0-64-x86_64, system=/usr/bin/python3.11, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:144] 2026-09-09 15:25:35.112303 | debian-bookworm | check: 243 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-09 15:25:35.112408 | debian-bookworm | check: 243 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-09 15:25:35.143330 | debian-bookworm | check: 274 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:485] 2026-09-09 15:25:35.248462 | debian-bookworm | check: 379 I exit 0 (0.10 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-inventory-sorting.py pid=1783 [tox/execute/api.py:309] 2026-09-09 15:25:35.249707 | debian-bookworm | check: OK (0.15=setup[0.05]+cmd[0.10] seconds) 2026-09-09 15:25:35.249727 | debian-bookworm | congratulations :) (0.18 seconds) 2026-09-09 15:25:35.607403 | debian-bookworm | ok: Runtime: 0:00:00.465008 2026-09-09 15:25:35.620739 | 2026-09-09 15:25:35.620935 | TASK [tox : Look for output] 2026-09-09 15:25:36.018499 | debian-bookworm | ok 2026-09-09 15:25:36.048330 | 2026-09-09 15:25:36.048466 | TASK [tox : Return file comments to Zuul] 2026-09-09 15:25:36.108291 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:36.116543 | 2026-09-09 15:25:36.116626 | PLAY RECAP 2026-09-09 15:25:36.116684 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-09 15:25:36.116721 | 2026-09-09 15:25:36.294644 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-09 15:25:36.295973 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-09 15:25:37.040541 | 2026-09-09 15:25:37.040698 | PLAY [all] 2026-09-09 15:25:37.055909 | 2026-09-09 15:25:37.056040 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-09-09 15:25:37.101305 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:37.113714 | 2026-09-09 15:25:37.113976 | TASK [fetch-tox-output : Set tox log path for single node] 2026-09-09 15:25:37.147494 | debian-bookworm | ok 2026-09-09 15:25:37.153966 | 2026-09-09 15:25:37.154080 | TASK [fetch-tox-output : Ensure local tox dir] 2026-09-09 15:25:37.634283 | debian-bookworm -> localhost | changed 2026-09-09 15:25:37.643831 | 2026-09-09 15:25:37.643971 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-09-09 15:25:37.699131 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:37.705909 | 2026-09-09 15:25:37.706025 | TASK [fetch-tox-output : Set envlist fact] 2026-09-09 15:25:37.745589 | debian-bookworm | ok 2026-09-09 15:25:37.751591 | 2026-09-09 15:25:37.751689 | TASK [fetch-tox-output : Get tox version] 2026-09-09 15:25:38.450230 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-09-09 15:25:38.468657 | debian-bookworm | 4.61.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-09 15:25:38.791164 | debian-bookworm | ok: Runtime: 0:00:00.303996 2026-09-09 15:25:38.797030 | 2026-09-09 15:25:38.797139 | TASK [fetch-tox-output : Find all default environments] 2026-09-09 15:25:39.326338 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:39.336587 | 2026-09-09 15:25:39.336805 | TASK [fetch-tox-output : Set envlist fact] 2026-09-09 15:25:39.362200 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:39.371942 | 2026-09-09 15:25:39.372081 | TASK [fetch-tox-output : Find all default environments] 2026-09-09 15:25:39.900830 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:39.907276 | 2026-09-09 15:25:39.907392 | TASK [fetch-tox-output : Set envlist fact] 2026-09-09 15:25:39.941726 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:39.949834 | 2026-09-09 15:25:39.949938 | LOOP [fetch-tox-output : Copy tox logs] 2026-09-09 15:25:39.994038 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:40.009224 | 2026-09-09 15:25:40.009372 | LOOP [fetch-tox-output : Collect tox logs] 2026-09-09 15:25:40.737156 | debian-bookworm | changed: 2026-09-09 15:25:40.737346 | debian-bookworm | created directory /var/lib/zuul/builds/301e46fe49f941319b195cc2e4491ac5/work/logs/tox/check 2026-09-09 15:25:40.737380 | debian-bookworm | cd+++++++++ ./ 2026-09-09 15:25:40.737405 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-09-09 15:25:40.737434 | 2026-09-09 15:25:40.751305 | 2026-09-09 15:25:40.751392 | PLAY RECAP 2026-09-09 15:25:40.751446 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-09-09 15:25:40.751471 | 2026-09-09 15:25:40.880640 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-09 15:25:40.881661 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-09 15:25:41.658360 | 2026-09-09 15:25:41.658519 | PLAY [all] 2026-09-09 15:25:41.676526 | 2026-09-09 15:25:41.676674 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-09-09 15:25:42.026031 | debian-bookworm | changed: non-zero return code 2026-09-09 15:25:42.038825 | 2026-09-09 15:25:42.039100 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-09-09 15:25:42.083862 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:42.090503 | 2026-09-09 15:25:42.090620 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-09-09 15:25:42.131119 | 2026-09-09 15:25:42.131318 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-09-09 15:25:42.194388 | 2026-09-09 15:25:42.194591 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-09-09 15:25:42.218611 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:42.225217 | 2026-09-09 15:25:42.225329 | LOOP [fetch-subunit-output : Generate subunit file] 2026-09-09 15:25:42.254790 | 2026-09-09 15:25:42.254978 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-09-09 15:25:42.299839 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:42.306116 | 2026-09-09 15:25:42.306233 | TASK [fetch-subunit-output : Remove the temporary file] 2026-09-09 15:25:42.330213 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:42.335916 | 2026-09-09 15:25:42.336026 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-09-09 15:25:42.369799 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:25:42.376376 | 2026-09-09 15:25:42.376455 | PLAY RECAP 2026-09-09 15:25:42.376509 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-09-09 15:25:42.376535 | 2026-09-09 15:25:42.512811 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-09 15:25:42.513923 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-09 15:25:43.313445 | 2026-09-09 15:25:43.317676 | PLAY [Base post-fetch] 2026-09-09 15:25:43.331809 | 2026-09-09 15:25:43.331938 | TASK [diagnose-network : Ensure log directory exists] 2026-09-09 15:25:43.739950 | debian-bookworm | ok 2026-09-09 15:25:43.750220 | 2026-09-09 15:25:43.750386 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-09-09 15:25:55.497379 | debian-bookworm | ok: Runtime: 0:00:06.006781 2026-09-09 15:25:55.508466 | 2026-09-09 15:25:55.509191 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-09-09 15:26:01.516147 | debian-bookworm | ok: Runtime: 0:00:00.008131 2026-09-09 15:26:01.524408 | 2026-09-09 15:26:01.524565 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-09-09 15:26:07.502815 | debian-bookworm | ok: Runtime: 0:00:00.007290 2026-09-09 15:26:07.517126 | 2026-09-09 15:26:07.517232 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-09 15:26:07.561298 | debian-bookworm | skipping: Conditional result was False 2026-09-09 15:26:07.576125 | 2026-09-09 15:26:07.576406 | TASK [fetch-output : Set log path for single node] 2026-09-09 15:26:07.628323 | debian-bookworm | ok 2026-09-09 15:26:07.635268 | 2026-09-09 15:26:07.635396 | LOOP [fetch-output : Ensure local output dirs] 2026-09-09 15:26:07.928165 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/301e46fe49f941319b195cc2e4491ac5/work/logs" 2026-09-09 15:26:08.197398 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/301e46fe49f941319b195cc2e4491ac5/work/artifacts" 2026-09-09 15:26:08.462100 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/301e46fe49f941319b195cc2e4491ac5/work/docs" 2026-09-09 15:26:08.476471 | 2026-09-09 15:26:08.476704 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-09 15:26:09.251897 | debian-bookworm | changed: 2026-09-09 15:26:09.252191 | debian-bookworm | .d..t...... ./ 2026-09-09 15:26:09.252237 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-09 15:26:09.252272 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-09 15:26:09.252302 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-09 15:26:09.252331 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-09 15:26:09.252361 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-09 15:26:09.252522 | debian-bookworm | changed: All items complete 2026-09-09 15:26:09.252556 | 2026-09-09 15:26:09.842239 | debian-bookworm | changed: .d..t...... ./ 2026-09-09 15:26:10.427195 | debian-bookworm | changed: .d..t...... ./ 2026-09-09 15:26:10.446486 | 2026-09-09 15:26:10.446597 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-09 15:26:10.767660 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.005230 2026-09-09 15:26:11.067098 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011095 2026-09-09 15:26:11.079969 | 2026-09-09 15:26:11.080069 | PLAY RECAP 2026-09-09 15:26:11.080137 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-09 15:26:11.080167 | 2026-09-09 15:26:11.206148 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-09 15:26:11.208848 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-09 15:26:11.983700 | 2026-09-09 15:26:11.983888 | PLAY [Base post] 2026-09-09 15:26:11.998352 | 2026-09-09 15:26:11.998485 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-09 15:26:12.593932 | debian-bookworm | changed 2026-09-09 15:26:12.603766 | 2026-09-09 15:26:12.603895 | PLAY RECAP 2026-09-09 15:26:12.603974 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-09 15:26:12.604050 | 2026-09-09 15:26:12.727738 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-09 15:26:12.729171 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-09 15:26:13.556397 | 2026-09-09 15:26:13.556557 | PLAY [Base post-logs] 2026-09-09 15:26:13.566929 | 2026-09-09 15:26:13.567064 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-09 15:26:14.061443 | localhost | changed 2026-09-09 15:26:14.071901 | 2026-09-09 15:26:14.072049 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-09 15:26:14.098687 | localhost | ok 2026-09-09 15:26:14.102161 | 2026-09-09 15:26:14.102259 | TASK [Set zuul-log-path fact] 2026-09-09 15:26:14.118680 | localhost | ok 2026-09-09 15:26:14.127737 | 2026-09-09 15:26:14.127910 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-09 15:26:14.164682 | localhost | ok 2026-09-09 15:26:14.169504 | 2026-09-09 15:26:14.169681 | TASK [upload-logs : Create log directories] 2026-09-09 15:26:14.723009 | localhost | changed 2026-09-09 15:26:14.726308 | 2026-09-09 15:26:14.726428 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-09 15:26:15.284638 | localhost -> localhost | ok: Runtime: 0:00:00.005210 2026-09-09 15:26:15.291990 | 2026-09-09 15:26:15.292154 | TASK [upload-logs : Upload logs to log server] 2026-09-09 15:26:15.896117 | localhost | Output suppressed because no_log was given 2026-09-09 15:26:15.898417 | 2026-09-09 15:26:15.898533 | LOOP [upload-logs : Compress console log and json output] 2026-09-09 15:26:15.960319 | localhost | skipping: Conditional result was False 2026-09-09 15:26:15.968308 | localhost | skipping: Conditional result was False 2026-09-09 15:26:15.980962 | 2026-09-09 15:26:15.981109 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-09 15:26:16.029351 | localhost | skipping: Conditional result was False 2026-09-09 15:26:16.029683 | 2026-09-09 15:26:16.036480 | localhost | skipping: Conditional result was False 2026-09-09 15:26:16.040906 | 2026-09-09 15:26:16.041053 | LOOP [upload-logs : Upload console log and json output]