2026-02-23 03:02:59.630060 | Job console starting 2026-02-23 03:02:59.662392 | Updating git repos 2026-02-23 03:02:59.756567 | Cloning repos into workspace 2026-02-23 03:02:59.819130 | Restoring repo states 2026-02-23 03:02:59.835994 | Merging changes 2026-02-23 03:02:59.836016 | Checking out repos 2026-02-23 03:02:59.923954 | Preparing playbooks 2026-02-23 03:03:00.933352 | Running Ansible setup 2026-02-23 03:03:06.455448 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-23 03:03:07.236860 | 2026-02-23 03:03:07.237031 | PLAY [Base pre] 2026-02-23 03:03:07.254027 | 2026-02-23 03:03:07.254185 | TASK [Setup log path fact] 2026-02-23 03:03:07.284493 | debian-bookworm | ok 2026-02-23 03:03:07.300208 | 2026-02-23 03:03:07.300351 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-23 03:03:07.341847 | debian-bookworm | ok 2026-02-23 03:03:07.352114 | 2026-02-23 03:03:07.352249 | TASK [emit-job-header : Print job information] 2026-02-23 03:03:07.400451 | # Job Information 2026-02-23 03:03:07.400824 | Ansible Version: 2.16.14 2026-02-23 03:03:07.400893 | Job: cfg-generics-tox-check 2026-02-23 03:03:07.400952 | Pipeline: periodic-daily 2026-02-23 03:03:07.400993 | Executor: 521e9411259a 2026-02-23 03:03:07.401030 | Triggered by: https://github.com/osism/generics 2026-02-23 03:03:07.401068 | Event ID: de41460c7cb64539bd118f16aff08b7d 2026-02-23 03:03:07.408902 | 2026-02-23 03:03:07.409058 | LOOP [emit-job-header : Print node information] 2026-02-23 03:03:07.536482 | debian-bookworm | ok: 2026-02-23 03:03:07.536720 | debian-bookworm | # Node Information 2026-02-23 03:03:07.536765 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-02-23 03:03:07.536796 | debian-bookworm | Hostname: debian 2026-02-23 03:03:07.536824 | debian-bookworm | Username: zuul 2026-02-23 03:03:07.536852 | debian-bookworm | Distro: Debian 12.13 2026-02-23 03:03:07.536884 | debian-bookworm | Provider: regiocloud-a 2026-02-23 03:03:07.536913 | debian-bookworm | Region: 2026-02-23 03:03:07.536940 | debian-bookworm | Label: debian-bookworm 2026-02-23 03:03:07.536965 | debian-bookworm | Product Name: OpenStack Nova 2026-02-23 03:03:07.536991 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea6:96d5 2026-02-23 03:03:07.554301 | 2026-02-23 03:03:07.554443 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-23 03:03:08.076642 | debian-bookworm -> localhost | changed 2026-02-23 03:03:08.084410 | 2026-02-23 03:03:08.084550 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-23 03:03:09.205741 | debian-bookworm -> localhost | changed 2026-02-23 03:03:09.224703 | 2026-02-23 03:03:09.224910 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-23 03:03:09.533167 | debian-bookworm -> localhost | ok 2026-02-23 03:03:09.541122 | 2026-02-23 03:03:09.541251 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-23 03:03:09.570648 | debian-bookworm | ok 2026-02-23 03:03:09.588851 | debian-bookworm | included: /var/lib/zuul/builds/7bee5a94dcfa4075b42d11995a583ab5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-23 03:03:09.595183 | 2026-02-23 03:03:09.595290 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-23 03:03:12.371767 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-02-23 03:03:12.372274 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7bee5a94dcfa4075b42d11995a583ab5/work/7bee5a94dcfa4075b42d11995a583ab5_id_rsa 2026-02-23 03:03:12.372382 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7bee5a94dcfa4075b42d11995a583ab5/work/7bee5a94dcfa4075b42d11995a583ab5_id_rsa.pub 2026-02-23 03:03:12.372459 | debian-bookworm -> localhost | The key fingerprint is: 2026-02-23 03:03:12.372572 | debian-bookworm -> localhost | SHA256:60up0KjRASvKxcWcVV0q9vWeY7jAMlANm4C4Km2OMQ8 zuul-build-sshkey 2026-02-23 03:03:12.372640 | debian-bookworm -> localhost | The key's randomart image is: 2026-02-23 03:03:12.372724 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-02-23 03:03:12.372790 | debian-bookworm -> localhost | | . .o.o. .. | 2026-02-23 03:03:12.372854 | debian-bookworm -> localhost | | .o.o . =.. | 2026-02-23 03:03:12.372913 | debian-bookworm -> localhost | | . .= * o . | 2026-02-23 03:03:12.372968 | debian-bookworm -> localhost | | .+. o o . . | 2026-02-23 03:03:12.373024 | debian-bookworm -> localhost | |..oo. .S . . | 2026-02-23 03:03:12.373101 | debian-bookworm -> localhost | |Eo+. + .o. o .| 2026-02-23 03:03:12.373164 | debian-bookworm -> localhost | |oX. + . +o o . = | 2026-02-23 03:03:12.373221 | debian-bookworm -> localhost | |. oo . + o . o .| 2026-02-23 03:03:12.373280 | debian-bookworm -> localhost | | . . o. . | 2026-02-23 03:03:12.373339 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-02-23 03:03:12.373482 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.222039 2026-02-23 03:03:12.397023 | 2026-02-23 03:03:12.397155 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-23 03:03:12.435971 | debian-bookworm | ok 2026-02-23 03:03:12.446611 | debian-bookworm | included: /var/lib/zuul/builds/7bee5a94dcfa4075b42d11995a583ab5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-23 03:03:12.456080 | 2026-02-23 03:03:12.456200 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-23 03:03:12.481119 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:03:12.495254 | 2026-02-23 03:03:12.495387 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-23 03:03:13.188634 | debian-bookworm | changed 2026-02-23 03:03:13.194793 | 2026-02-23 03:03:13.195212 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-23 03:03:13.479913 | debian-bookworm | ok 2026-02-23 03:03:13.489767 | 2026-02-23 03:03:13.489900 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-23 03:03:14.174074 | debian-bookworm | changed 2026-02-23 03:03:14.185465 | 2026-02-23 03:03:14.185625 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-23 03:03:14.970589 | debian-bookworm | changed 2026-02-23 03:03:14.976580 | 2026-02-23 03:03:14.976691 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-23 03:03:15.001371 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:03:15.011401 | 2026-02-23 03:03:15.011561 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-23 03:03:15.573274 | debian-bookworm -> localhost | changed 2026-02-23 03:03:15.584911 | 2026-02-23 03:03:15.585825 | TASK [add-build-sshkey : Add back temp key] 2026-02-23 03:03:16.108423 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7bee5a94dcfa4075b42d11995a583ab5/work/7bee5a94dcfa4075b42d11995a583ab5_id_rsa (zuul-build-sshkey) 2026-02-23 03:03:16.108977 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010385 2026-02-23 03:03:16.125956 | 2026-02-23 03:03:16.126122 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-23 03:03:16.529255 | debian-bookworm | ok 2026-02-23 03:03:16.533247 | 2026-02-23 03:03:16.533321 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-23 03:03:16.576962 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:03:16.585291 | 2026-02-23 03:03:16.585370 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-23 03:03:16.987413 | debian-bookworm | ok 2026-02-23 03:03:16.998722 | 2026-02-23 03:03:16.998818 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-23 03:03:17.025902 | debian-bookworm | ok 2026-02-23 03:03:17.029977 | 2026-02-23 03:03:17.030054 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-23 03:03:17.295190 | debian-bookworm -> localhost | ok 2026-02-23 03:03:17.300345 | 2026-02-23 03:03:17.300421 | TASK [validate-host : Collect information about the host] 2026-02-23 03:03:18.347601 | debian-bookworm | ok 2026-02-23 03:03:18.364911 | 2026-02-23 03:03:18.365017 | TASK [validate-host : Sanitize hostname] 2026-02-23 03:03:18.540907 | debian-bookworm | ok 2026-02-23 03:03:18.578243 | 2026-02-23 03:03:18.578364 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-23 03:03:19.118132 | debian-bookworm -> localhost | changed 2026-02-23 03:03:19.123835 | 2026-02-23 03:03:19.123933 | TASK [validate-host : Collect information about zuul worker] 2026-02-23 03:03:19.525270 | debian-bookworm | ok 2026-02-23 03:03:19.529792 | 2026-02-23 03:03:19.529897 | TASK [validate-host : Write out all zuul information for each host] 2026-02-23 03:03:20.115079 | debian-bookworm -> localhost | changed 2026-02-23 03:03:20.124129 | 2026-02-23 03:03:20.124217 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-23 03:03:20.425224 | debian-bookworm | ok 2026-02-23 03:03:20.431937 | 2026-02-23 03:03:20.432023 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-23 03:03:21.285294 | debian-bookworm | changed: 2026-02-23 03:03:21.285495 | debian-bookworm | cd+++++++++ src/ 2026-02-23 03:03:21.285548 | debian-bookworm | cd+++++++++ src/github.com/ 2026-02-23 03:03:21.285572 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-02-23 03:03:21.285595 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-02-23 03:03:21.285615 | debian-bookworm | =7.0.1 2026-02-23 03:03:45.020060 | debian-bookworm | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-23 03:03:45.068363 | debian-bookworm | Collecting chardet>=5.2 2026-02-23 03:03:45.084036 | debian-bookworm | Downloading chardet-6.0.0.post1-py3-none-any.whl (627 kB) 2026-02-23 03:03:45.137593 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 627.2/627.2 kB 12.9 MB/s eta 0:00:00 2026-02-23 03:03:45.195840 | debian-bookworm | Collecting colorama>=0.4.6 2026-02-23 03:03:45.208653 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-23 03:03:45.281900 | debian-bookworm | Collecting filelock>=3.24 2026-02-23 03:03:45.293616 | debian-bookworm | Downloading filelock-3.24.3-py3-none-any.whl (24 kB) 2026-02-23 03:03:45.369107 | debian-bookworm | Collecting packaging>=26 2026-02-23 03:03:45.380936 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-23 03:03:45.390584 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 10.5 MB/s eta 0:00:00 2026-02-23 03:03:45.466615 | debian-bookworm | Collecting platformdirs>=4.9.1 2026-02-23 03:03:45.478994 | debian-bookworm | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-23 03:03:45.521173 | debian-bookworm | Collecting pluggy>=1.6 2026-02-23 03:03:45.532687 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-23 03:03:45.598148 | debian-bookworm | Collecting pyproject-api>=1.10 2026-02-23 03:03:45.612787 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-23 03:03:45.772302 | debian-bookworm | Collecting virtualenv>=20.36.1 2026-02-23 03:03:45.784447 | debian-bookworm | Downloading virtualenv-20.38.0-py3-none-any.whl (5.8 MB) 2026-02-23 03:03:46.052727 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 22.3 MB/s eta 0:00:00 2026-02-23 03:03:46.178039 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-02-23 03:03:46.190042 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-23 03:03:46.220025 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.0 MB/s eta 0:00:00 2026-02-23 03:03:46.394503 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-23 03:03:48.450309 | debian-bookworm | Successfully installed cachetools-7.0.1 chardet-6.0.0.post1 colorama-0.4.6 distlib-0.4.0 filelock-3.24.3 packaging-26.0 platformdirs-4.9.2 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.44.0 virtualenv-20.38.0 2026-02-23 03:03:48.775201 | debian-bookworm | ok: Runtime: 0:00:04.532925 2026-02-23 03:03:48.780201 | 2026-02-23 03:03:48.780281 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-23 03:03:48.838599 | debian-bookworm | ok 2026-02-23 03:03:48.842695 | 2026-02-23 03:03:48.842771 | TASK [ensure-tox : Output tox version] 2026-02-23 03:03:49.507633 | 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-02-23 03:03:49.530235 | debian-bookworm | 4.44.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-02-23 03:03:49.868214 | debian-bookworm | ok: Runtime: 0:00:00.474634 2026-02-23 03:03:49.873670 | 2026-02-23 03:03:49.873762 | TASK [ensure-tox : Make global symlink] 2026-02-23 03:03:49.896793 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:03:49.903008 | 2026-02-23 03:03:49.903083 | PLAY RECAP 2026-02-23 03:03:49.903136 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-23 03:03:49.903161 | 2026-02-23 03:03:50.133592 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-23 03:03:50.134528 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-02-23 03:03:51.185495 | 2026-02-23 03:03:51.185653 | PLAY [all] 2026-02-23 03:03:51.199931 | 2026-02-23 03:03:51.200049 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-02-23 03:03:51.956667 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-02-23 03:03:52.228420 | debian-bookworm | ok: Runtime: 0:00:00.032258 2026-02-23 03:03:52.233726 | 2026-02-23 03:03:52.233835 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-02-23 03:03:52.771805 | debian-bookworm | ok: Runtime: 0:00:00.008313 2026-02-23 03:03:52.777457 | 2026-02-23 03:03:52.777586 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-02-23 03:03:53.183770 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-02-23 03:03:53.183877 | debian-bookworm | sudo: a password is required 2026-02-23 03:03:53.356186 | debian-bookworm | ok: Runtime: 0:00:00.025471 2026-02-23 03:03:53.366795 | 2026-02-23 03:03:53.366931 | TASK [tox : Check to see if the constraints file exists] 2026-02-23 03:03:53.400243 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:03:53.405892 | 2026-02-23 03:03:53.405991 | TASK [tox : Fail if constraints file is missing] 2026-02-23 03:03:53.461447 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:03:53.467332 | 2026-02-23 03:03:53.467441 | TASK [tox : Record file location] 2026-02-23 03:03:53.519364 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:03:53.525197 | 2026-02-23 03:03:53.525310 | TASK [tox : Install tox siblings] 2026-02-23 03:03:53.555518 | debian-bookworm | ok 2026-02-23 03:03:53.568998 | debian-bookworm | included: /var/lib/zuul/builds/7bee5a94dcfa4075b42d11995a583ab5/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-02-23 03:03:53.579134 | 2026-02-23 03:03:53.583712 | TASK [tox : Run tox without tests] 2026-02-23 03:03:54.331898 | debian-bookworm | ROOT: 276 D setup logging to DEBUG on pid 1417 [tox/report.py:229] 2026-02-23 03:03:54.364467 | debian-bookworm | check: 308 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:59] 2026-02-23 03:03:54.367220 | debian-bookworm | check: 311 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:79] 2026-02-23 03:03:54.368283 | debian-bookworm | check: 312 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/discovery/py_info.py DfZX5LkzGVpI4Wnl1dagWC9iqsYLdFfm L3CXxxMhDFolJDupyz14xEpm2pP1mUy5 [virtualenv/discovery/cached_py_info.py:136] 2026-02-23 03:03:54.449928 | debian-bookworm | check: 394 D wrote python info of /usr/bin/python3.11 at /home/zuul/.cache/virtualenv/py_info/3/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:154] 2026-02-23 03:03:54.451337 | debian-bookworm | check: 395 D filesystem is case-sensitive [virtualenv/info.py:27] 2026-02-23 03:03:54.451825 | debian-bookworm | check: 396 I proposed PythonInfo(spec=CPython3.11.2.final.0-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) [virtualenv/discovery/builtin.py:86] 2026-02-23 03:03:54.452110 | debian-bookworm | check: 396 D accepted PythonInfo(spec=CPython3.11.2.final.0-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) [virtualenv/discovery/builtin.py:88] 2026-02-23 03:03:54.455143 | debian-bookworm | check: 399 D symlink on filesystem does work [virtualenv/info.py:50] 2026-02-23 03:03:54.492783 | debian-bookworm | check: 437 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:76] 2026-02-23 03:03:54.493176 | debian-bookworm | check: 437 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/bin [virtualenv/util/path/_sync.py:14] 2026-02-23 03:03:54.493354 | debian-bookworm | check: 437 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/include [virtualenv/util/path/_sync.py:14] 2026-02-23 03:03:54.493455 | debian-bookworm | check: 438 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:14] 2026-02-23 03:03:54.493671 | debian-bookworm | check: 438 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:37] 2026-02-23 03:03:54.493773 | debian-bookworm | check: 438 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494016 | debian-bookworm | check: 438 D implementation = CPython [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494109 | debian-bookworm | check: 438 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494126 | debian-bookworm | check: 438 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494154 | debian-bookworm | check: 438 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494166 | debian-bookworm | check: 438 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/check [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494179 | debian-bookworm | check: 438 D virtualenv = 20.38.0 [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494190 | debian-bookworm | check: 438 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494200 | debian-bookworm | check: 438 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494214 | debian-bookworm | check: 438 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494228 | debian-bookworm | check: 438 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:54.494578 | debian-bookworm | check: 439 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/generics/.tox/check/bin/python [virtualenv/util/path/_sync.py:34] 2026-02-23 03:03:54.494876 | debian-bookworm | check: 439 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:107] 2026-02-23 03:03:54.495057 | debian-bookworm | check: 439 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:110] 2026-02-23 03:03:54.495506 | debian-bookworm | check: 440 D ============================== target debug ============================== [virtualenv/run/session.py:78] 2026-02-23 03:03:54.495965 | debian-bookworm | check: 440 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:242] 2026-02-23 03:03:54.545139 | debian-bookworm | check: 440 D { 2026-02-23 03:03:54.545203 | debian-bookworm | "sys": { 2026-02-23 03:03:54.545209 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check/bin/python", 2026-02-23 03:03:54.545217 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-02-23 03:03:54.545224 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-02-23 03:03:54.545230 | debian-bookworm | "base_prefix": "/usr", 2026-02-23 03:03:54.545238 | debian-bookworm | "real_prefix": null, 2026-02-23 03:03:54.545243 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-02-23 03:03:54.545247 | debian-bookworm | "base_exec_prefix": "/usr", 2026-02-23 03:03:54.545251 | debian-bookworm | "path": [ 2026-02-23 03:03:54.545255 | debian-bookworm | "/usr/lib/python311.zip", 2026-02-23 03:03:54.545259 | debian-bookworm | "/usr/lib/python3.11", 2026-02-23 03:03:54.545263 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-02-23 03:03:54.545267 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages" 2026-02-23 03:03:54.545271 | debian-bookworm | ], 2026-02-23 03:03:54.545275 | debian-bookworm | "meta_path": [ 2026-02-23 03:03:54.545279 | debian-bookworm | "", 2026-02-23 03:03:54.545283 | debian-bookworm | "", 2026-02-23 03:03:54.545287 | debian-bookworm | "", 2026-02-23 03:03:54.545298 | debian-bookworm | "" 2026-02-23 03:03:54.545302 | debian-bookworm | ], 2026-02-23 03:03:54.545306 | debian-bookworm | "fs_encoding": "utf-8", 2026-02-23 03:03:54.545310 | debian-bookworm | "io_encoding": "utf-8" 2026-02-23 03:03:54.545314 | debian-bookworm | }, 2026-02-23 03:03:54.545318 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2026-02-23 03:03:54.545322 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-02-23 03:03:54.545326 | debian-bookworm | "os": "", 2026-02-23 03:03:54.545330 | debian-bookworm | "site": "", 2026-02-23 03:03:54.545334 | debian-bookworm | "datetime": "", 2026-02-23 03:03:54.545338 | debian-bookworm | "math": "", 2026-02-23 03:03:54.545342 | debian-bookworm | "json": "" 2026-02-23 03:03:54.545346 | debian-bookworm | } [virtualenv/run/session.py:79] 2026-02-23 03:03:54.545569 | debian-bookworm | check: 489 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:83] 2026-02-23 03:03:54.547793 | debian-bookworm | check: 492 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:51] 2026-02-23 03:03:54.551707 | debian-bookworm | check: 493 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:49] 2026-02-23 03:03:54.553286 | debian-bookworm | check: 497 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:51] 2026-02-23 03:03:54.555884 | debian-bookworm | check: 500 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:49] 2026-02-23 03:03:54.778731 | debian-bookworm | check: 723 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:42] 2026-02-23 03:03:54.808358 | debian-bookworm | check: 752 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:42] 2026-02-23 03:03:54.971551 | debian-bookworm | check: 915 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:42] 2026-02-23 03:03:54.976104 | debian-bookworm | check: 920 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:42] 2026-02-23 03:03:54.977178 | debian-bookworm | check: 921 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:42] 2026-02-23 03:03:54.977559 | debian-bookworm | check: 922 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:42] 2026-02-23 03:03:54.977847 | debian-bookworm | check: 922 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2026-02-23 03:03:54.988852 | debian-bookworm | check: 933 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:42] 2026-02-23 03:03:54.993462 | debian-bookworm | check: 937 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:42] 2026-02-23 03:03:54.994330 | debian-bookworm | check: 938 D generated console scripts pip-3.11 pip3 pip pip3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2026-02-23 03:03:54.994786 | debian-bookworm | check: 939 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:89] 2026-02-23 03:03:55.001154 | debian-bookworm | check: 945 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:37] 2026-02-23 03:03:55.001200 | debian-bookworm | check: 945 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.001228 | debian-bookworm | check: 945 D implementation = CPython [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.001256 | debian-bookworm | check: 945 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.001331 | debian-bookworm | check: 945 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.001346 | debian-bookworm | check: 945 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.001416 | debian-bookworm | check: 945 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/check [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.001436 | debian-bookworm | check: 946 D virtualenv = 20.38.0 [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.001495 | debian-bookworm | check: 946 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.001539 | debian-bookworm | check: 946 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.001589 | debian-bookworm | check: 946 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.001639 | debian-bookworm | check: 946 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:47] 2026-02-23 03:03:55.007279 | debian-bookworm | check: 951 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:475] 2026-02-23 03:03:56.235110 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2026-02-23 03:03:56.353039 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2026-02-23 03:03:56.487893 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2026-02-23 03:03:56.500843 | 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-02-23 03:03:56.600041 | debian-bookworm | Collecting ansible==11.12.0 (from -r requirements.txt (line 3)) 2026-02-23 03:03:56.614646 | debian-bookworm | Downloading ansible-11.12.0-py3-none-any.whl.metadata (8.1 kB) 2026-02-23 03:03:56.658493 | debian-bookworm | Collecting packaging==26.0 (from -r requirements.txt (line 4)) 2026-02-23 03:03:56.670445 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-23 03:03:56.803249 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2026-02-23 03:03:56.817778 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2026-02-23 03:03:56.839940 | debian-bookworm | Installing build dependencies: started 2026-02-23 03:03:58.172920 | debian-bookworm | Installing build dependencies: finished with status 'done' 2026-02-23 03:03:58.173775 | debian-bookworm | Getting requirements to build wheel: started 2026-02-23 03:03:58.735252 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2026-02-23 03:03:58.737848 | debian-bookworm | Preparing metadata (pyproject.toml): started 2026-02-23 03:03:58.998286 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2026-02-23 03:03:59.139089 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2026-02-23 03:03:59.152739 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2026-02-23 03:03:59.243112 | debian-bookworm | Collecting requests==2.32.5 (from -r requirements.txt (line 7)) 2026-02-23 03:03:59.256562 | debian-bookworm | Downloading requests-2.32.5-py3-none-any.whl.metadata (4.9 kB) 2026-02-23 03:03:59.298312 | debian-bookworm | Collecting tabulate==0.9.0 (from -r requirements.txt (line 8)) 2026-02-23 03:03:59.311453 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl.metadata (34 kB) 2026-02-23 03:03:59.439719 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2026-02-23 03:03:59.451496 | 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-02-23 03:03:59.543314 | debian-bookworm | Collecting ansible-core~=2.18.11 (from ansible==11.12.0->-r requirements.txt (line 3)) 2026-02-23 03:03:59.555881 | debian-bookworm | Downloading ansible_core-2.18.13-py3-none-any.whl.metadata (7.7 kB) 2026-02-23 03:03:59.624003 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-02-23 03:03:59.636756 | debian-bookworm | Downloading click-8.3.1-py3-none-any.whl.metadata (2.6 kB) 2026-02-23 03:03:59.684377 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-02-23 03:03:59.696417 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-23 03:03:59.751238 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-02-23 03:03:59.764240 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2026-02-23 03:03:59.827284 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-02-23 03:03:59.842233 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2026-02-23 03:04:00.013908 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.32.5->-r requirements.txt (line 7)) 2026-02-23 03:04:00.027789 | debian-bookworm | Downloading charset_normalizer-3.4.4-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (37 kB) 2026-02-23 03:04:00.088612 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.32.5->-r requirements.txt (line 7)) 2026-02-23 03:04:00.101391 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl.metadata (8.4 kB) 2026-02-23 03:04:00.194568 | debian-bookworm | Collecting urllib3<3,>=1.21.1 (from requests==2.32.5->-r requirements.txt (line 7)) 2026-02-23 03:04:00.206838 | debian-bookworm | Downloading urllib3-2.6.3-py3-none-any.whl.metadata (6.9 kB) 2026-02-23 03:04:00.280561 | debian-bookworm | Collecting certifi>=2017.4.17 (from requests==2.32.5->-r requirements.txt (line 7)) 2026-02-23 03:04:00.293798 | debian-bookworm | Downloading certifi-2026.1.4-py3-none-any.whl.metadata (2.5 kB) 2026-02-23 03:04:00.749968 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2026-02-23 03:04:00.761766 | debian-bookworm | Downloading cryptography-46.0.5-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2026-02-23 03:04:00.824091 | debian-bookworm | Collecting resolvelib<1.1.0,>=0.5.3 (from ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2026-02-23 03:04:00.835764 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2026-02-23 03:04:01.114876 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2026-02-23 03:04:01.127363 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2026-02-23 03:04:01.176394 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2026-02-23 03:04:01.189536 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl.metadata (8.2 kB) 2026-02-23 03:04:01.219344 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-02-23 03:04:01.255133 | 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-02-23 03:04:01.298585 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 18.2 MB/s 0:00:00 2026-02-23 03:04:01.314306 | debian-bookworm | Downloading ansible-11.12.0-py3-none-any.whl (57.4 MB) 2026-02-23 03:04:03.232902 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.4/57.4 MB 29.9 MB/s 0:00:01 2026-02-23 03:04:03.243235 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-23 03:04:03.278331 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2026-02-23 03:04:03.299845 | debian-bookworm | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2026-02-23 03:04:03.320190 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl (35 kB) 2026-02-23 03:04:03.342554 | debian-bookworm | Downloading ansible_core-2.18.13-py3-none-any.whl (2.2 MB) 2026-02-23 03:04:03.423682 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 27.1 MB/s 0:00:00 2026-02-23 03:04:03.437465 | debian-bookworm | Downloading charset_normalizer-3.4.4-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (151 kB) 2026-02-23 03:04:03.464698 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl (71 kB) 2026-02-23 03:04:03.488537 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2026-02-23 03:04:03.516437 | debian-bookworm | Downloading urllib3-2.6.3-py3-none-any.whl (131 kB) 2026-02-23 03:04:03.543850 | debian-bookworm | Downloading certifi-2026.1.4-py3-none-any.whl (152 kB) 2026-02-23 03:04:03.571019 | 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-02-23 03:04:03.596892 | debian-bookworm | Downloading click-8.3.1-py3-none-any.whl (108 kB) 2026-02-23 03:04:03.623194 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-23 03:04:03.664942 | debian-bookworm | Downloading cryptography-46.0.5-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2026-02-23 03:04:03.863923 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 22.0 MB/s 0:00:00 2026-02-23 03:04:03.878133 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2026-02-23 03:04:03.916680 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2026-02-23 03:04:03.942228 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-02-23 03:04:03.973145 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2026-02-23 03:04:04.312181 | debian-bookworm | Building wheels for collected packages: pwgen 2026-02-23 03:04:04.316334 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2026-02-23 03:04:04.628307 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2026-02-23 03:04:04.629883 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3796 sha256=bae1afe7896d4df3b361118904f94a7bb9d88175ecef598ee87431acdec2cfac 2026-02-23 03:04:04.629922 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2026-02-23 03:04:04.629933 | debian-bookworm | Successfully built pwgen 2026-02-23 03:04:04.877534 | debian-bookworm | Installing collected packages: resolvelib, pwgen, urllib3, tabulate, sh, PyYAML, pycparser, packaging, MarkupSafe, idna, fasteners, colorama, click, charset_normalizer, certifi, requests, python-gilt, Jinja2, cffi, cryptography, ansible-core, ansible 2026-02-23 03:04:33.311190 | debian-bookworm | 2026-02-23 03:04:33.313070 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-11.12.0 ansible-core-2.18.13 certifi-2026.1.4 cffi-2.0.0 charset_normalizer-3.4.4 click-8.3.1 colorama-0.4.6 cryptography-46.0.5 fasteners-0.20 idna-3.11 packaging-26.0 pwgen-0.8.2.post0 pycparser-3.0 python-gilt-1.2.3 requests-2.32.5 resolvelib-1.0.1 sh-2.2.2 tabulate-0.9.0 urllib3-2.6.3 2026-02-23 03:04:33.447451 | debian-bookworm | check: 39391 I exit 0 (38.44 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1430 [tox/execute/api.py:311] 2026-02-23 03:04:33.451698 | debian-bookworm | check: OK (39.09 seconds) 2026-02-23 03:04:33.451727 | debian-bookworm | congratulations :) (39.12 seconds) 2026-02-23 03:04:33.678085 | debian-bookworm | ok: Runtime: 0:00:39.492626 2026-02-23 03:04:33.685006 | 2026-02-23 03:04:33.685093 | TASK [tox : Create a tempfile to save tox showconfig] 2026-02-23 03:04:34.152927 | debian-bookworm | changed 2026-02-23 03:04:34.165466 | 2026-02-23 03:04:34.165599 | TASK [tox : Get tox envlist config] 2026-02-23 03:04:35.222121 | debian-bookworm | ok: Runtime: 0:00:00.372367 2026-02-23 03:04:35.228153 | 2026-02-23 03:04:35.228373 | TASK [tox : Install any sibling python packages] 2026-02-23 03:04:35.762305 | debian-bookworm | ok: No setup.cfg, no action needed 2026-02-23 03:04:35.768710 | 2026-02-23 03:04:35.768806 | TASK [tox : Remove tempfile] 2026-02-23 03:04:36.214112 | debian-bookworm | changed 2026-02-23 03:04:36.228550 | 2026-02-23 03:04:36.228688 | TASK [tox : Emit tox command] 2026-02-23 03:04:36.303863 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2026-02-23 03:04:36.310828 | 2026-02-23 03:04:36.310977 | TASK [tox : Run tox] 2026-02-23 03:04:36.974271 | debian-bookworm | ROOT: 259 D setup logging to DEBUG on pid 1583 [tox/report.py:229] 2026-02-23 03:04:37.006632 | debian-bookworm | check: 291 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:59] 2026-02-23 03:04:37.009472 | debian-bookworm | check: 294 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:79] 2026-02-23 03:04:37.010440 | debian-bookworm | check: 295 D got python info of /usr/bin/python3.11 from /home/zuul/.cache/virtualenv/py_info/3/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:134] 2026-02-23 03:04:37.011417 | debian-bookworm | check: 296 D filesystem is case-sensitive [virtualenv/info.py:27] 2026-02-23 03:04:37.011603 | debian-bookworm | check: 296 I proposed PythonInfo(spec=CPython3.11.2.final.0-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) [virtualenv/discovery/builtin.py:86] 2026-02-23 03:04:37.011679 | debian-bookworm | check: 297 D accepted PythonInfo(spec=CPython3.11.2.final.0-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) [virtualenv/discovery/builtin.py:88] 2026-02-23 03:04:37.012947 | debian-bookworm | check: 298 D symlink on filesystem does work [virtualenv/info.py:50] 2026-02-23 03:04:37.046075 | debian-bookworm | check: 331 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:475] 2026-02-23 03:04:37.116595 | debian-bookworm | check: 401 I exit 0 (0.07 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-inventory-sorting.py pid=1590 [tox/execute/api.py:311] 2026-02-23 03:04:37.118082 | debian-bookworm | check: OK (0.11=setup[0.05]+cmd[0.07] seconds) 2026-02-23 03:04:37.118106 | debian-bookworm | congratulations :) (0.15 seconds) 2026-02-23 03:04:37.406861 | debian-bookworm | ok: Runtime: 0:00:00.519968 2026-02-23 03:04:37.413723 | 2026-02-23 03:04:37.413845 | TASK [tox : Look for output] 2026-02-23 03:04:38.054775 | debian-bookworm | ok 2026-02-23 03:04:38.101586 | 2026-02-23 03:04:38.101770 | TASK [tox : Return file comments to Zuul] 2026-02-23 03:04:38.216350 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:38.225120 | 2026-02-23 03:04:38.225244 | PLAY RECAP 2026-02-23 03:04:38.225311 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-02-23 03:04:38.225339 | 2026-02-23 03:04:38.633153 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-02-23 03:04:38.635863 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-23 03:04:40.192792 | 2026-02-23 03:04:40.193786 | PLAY [all] 2026-02-23 03:04:40.266275 | 2026-02-23 03:04:40.267178 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-23 03:04:40.387844 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:40.397048 | 2026-02-23 03:04:40.397373 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-23 03:04:40.471188 | debian-bookworm | ok 2026-02-23 03:04:40.482728 | 2026-02-23 03:04:40.482908 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-23 03:04:41.559341 | debian-bookworm -> localhost | changed 2026-02-23 03:04:41.567643 | 2026-02-23 03:04:41.567840 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-23 03:04:41.665241 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:41.671440 | 2026-02-23 03:04:41.671603 | TASK [fetch-tox-output : Set envlist fact] 2026-02-23 03:04:41.730165 | debian-bookworm | ok 2026-02-23 03:04:41.735425 | 2026-02-23 03:04:41.735551 | TASK [fetch-tox-output : Get tox version] 2026-02-23 03:04:42.806860 | 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-02-23 03:04:42.825875 | debian-bookworm | 4.44.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-02-23 03:04:43.303257 | debian-bookworm | ok: Runtime: 0:00:00.382730 2026-02-23 03:04:43.310987 | 2026-02-23 03:04:43.311104 | TASK [fetch-tox-output : Find all default environments] 2026-02-23 03:04:43.839125 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:43.844975 | 2026-02-23 03:04:43.845091 | TASK [fetch-tox-output : Set envlist fact] 2026-02-23 03:04:43.878371 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:43.884057 | 2026-02-23 03:04:43.884167 | TASK [fetch-tox-output : Find all default environments] 2026-02-23 03:04:44.455783 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:44.461263 | 2026-02-23 03:04:44.461362 | TASK [fetch-tox-output : Set envlist fact] 2026-02-23 03:04:44.484322 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:44.490390 | 2026-02-23 03:04:44.490494 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-23 03:04:44.535109 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:44.550061 | 2026-02-23 03:04:44.550176 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-23 03:04:45.512391 | debian-bookworm | changed: 2026-02-23 03:04:45.512625 | debian-bookworm | created directory /var/lib/zuul/builds/7bee5a94dcfa4075b42d11995a583ab5/work/logs/tox/check 2026-02-23 03:04:45.512664 | debian-bookworm | cd+++++++++ ./ 2026-02-23 03:04:45.512689 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-02-23 03:04:45.512719 | 2026-02-23 03:04:45.523630 | 2026-02-23 03:04:45.523750 | PLAY RECAP 2026-02-23 03:04:45.523804 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-23 03:04:45.523828 | 2026-02-23 03:04:45.760990 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-23 03:04:45.762107 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-23 03:04:46.761143 | 2026-02-23 03:04:46.761315 | PLAY [all] 2026-02-23 03:04:46.783853 | 2026-02-23 03:04:46.784113 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-23 03:04:47.165060 | debian-bookworm | changed: non-zero return code 2026-02-23 03:04:47.229666 | 2026-02-23 03:04:47.229929 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-23 03:04:47.275692 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:47.295247 | 2026-02-23 03:04:47.295430 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-23 03:04:47.369449 | 2026-02-23 03:04:47.369732 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-23 03:04:47.475589 | 2026-02-23 03:04:47.475829 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-23 03:04:47.547223 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:47.554942 | 2026-02-23 03:04:47.555102 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-23 03:04:47.608833 | 2026-02-23 03:04:47.609057 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-23 03:04:47.643470 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:47.653776 | 2026-02-23 03:04:47.653923 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-23 03:04:47.718887 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:47.726331 | 2026-02-23 03:04:47.726599 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-23 03:04:47.774971 | debian-bookworm | skipping: Conditional result was False 2026-02-23 03:04:47.787230 | 2026-02-23 03:04:47.787394 | PLAY RECAP 2026-02-23 03:04:47.787457 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-23 03:04:47.787484 | 2026-02-23 03:04:48.245741 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-23 03:04:48.247222 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-23 03:04:49.754450 | 2026-02-23 03:04:49.754593 | PLAY [Base post] 2026-02-23 03:04:49.787487 | 2026-02-23 03:04:49.787608 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-23 03:04:50.479380 | debian-bookworm | changed 2026-02-23 03:04:50.486532 | 2026-02-23 03:04:50.486622 | PLAY RECAP 2026-02-23 03:04:50.486675 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-23 03:04:50.486726 | 2026-02-23 03:04:50.918128 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-23 03:04:50.919118 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-23 03:04:53.003942 | 2026-02-23 03:04:53.012759 | PLAY [Base post-logs] 2026-02-23 03:04:53.033060 | 2026-02-23 03:04:53.033210 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-23 03:04:53.763934 | localhost | changed 2026-02-23 03:04:53.792791 | 2026-02-23 03:04:53.793002 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-23 03:04:53.843406 | localhost | ok 2026-02-23 03:04:53.845792 | 2026-02-23 03:04:53.845864 | TASK [Set zuul-log-path fact] 2026-02-23 03:04:53.870400 | localhost | ok 2026-02-23 03:04:53.878465 | 2026-02-23 03:04:53.878601 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-23 03:04:53.926086 | localhost | ok 2026-02-23 03:04:53.928492 | 2026-02-23 03:04:53.928759 | TASK [upload-logs : Create log directories] 2026-02-23 03:04:54.554757 | localhost | changed 2026-02-23 03:04:54.558122 | 2026-02-23 03:04:54.558208 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-23 03:04:55.624735 | localhost -> localhost | ok: Runtime: 0:00:00.018663 2026-02-23 03:04:55.628056 | 2026-02-23 03:04:55.628139 | TASK [upload-logs : Upload logs to log server] 2026-02-23 03:04:56.781884 | localhost | Output suppressed because no_log was given 2026-02-23 03:04:56.784200 | 2026-02-23 03:04:56.784282 | LOOP [upload-logs : Compress console log and json output] 2026-02-23 03:04:56.930602 | localhost | skipping: Conditional result was False 2026-02-23 03:04:56.954022 | localhost | skipping: Conditional result was False 2026-02-23 03:04:56.958084 | 2026-02-23 03:04:56.958201 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-23 03:04:57.013753 | localhost | skipping: Conditional result was False 2026-02-23 03:04:57.014007 | 2026-02-23 03:04:57.020363 | localhost | skipping: Conditional result was False 2026-02-23 03:04:57.028958 | 2026-02-23 03:04:57.029047 | LOOP [upload-logs : Upload console log and json output]