2025-10-15 03:01:42.995783 | Job console starting 2025-10-15 03:01:43.003388 | Updating git repos 2025-10-15 03:01:43.058424 | Cloning repos into workspace 2025-10-15 03:01:43.116908 | Restoring repo states 2025-10-15 03:01:43.181338 | Merging changes 2025-10-15 03:01:43.183266 | Checking out repos 2025-10-15 03:01:43.397951 | Preparing playbooks 2025-10-15 03:01:44.478127 | Running Ansible setup 2025-10-15 03:01:50.333203 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-15 03:01:51.076699 | 2025-10-15 03:01:51.076807 | PLAY [Base pre] 2025-10-15 03:01:51.095706 | 2025-10-15 03:01:51.095806 | TASK [Setup log path fact] 2025-10-15 03:01:51.122536 | debian-bookworm | ok 2025-10-15 03:01:51.143085 | 2025-10-15 03:01:51.143208 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-15 03:01:51.172075 | debian-bookworm | ok 2025-10-15 03:01:51.180281 | 2025-10-15 03:01:51.180366 | TASK [emit-job-header : Print job information] 2025-10-15 03:01:51.217667 | # Job Information 2025-10-15 03:01:51.217804 | Ansible Version: 2.16.14 2025-10-15 03:01:51.217834 | Job: cfg-generics-tox-check 2025-10-15 03:01:51.217861 | Pipeline: periodic-daily 2025-10-15 03:01:51.217894 | Executor: 521e9411259a 2025-10-15 03:01:51.217912 | Triggered by: https://github.com/osism/generics 2025-10-15 03:01:51.217929 | Event ID: e397d3229453451692cb540118b72224 2025-10-15 03:01:51.221988 | 2025-10-15 03:01:51.222071 | LOOP [emit-job-header : Print node information] 2025-10-15 03:01:51.312588 | debian-bookworm | ok: 2025-10-15 03:01:51.312775 | debian-bookworm | # Node Information 2025-10-15 03:01:51.312805 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-15 03:01:51.312883 | debian-bookworm | Hostname: debian 2025-10-15 03:01:51.312905 | debian-bookworm | Username: zuul 2025-10-15 03:01:51.312923 | debian-bookworm | Distro: Debian 12.12 2025-10-15 03:01:51.312948 | debian-bookworm | Provider: regiocloud-a 2025-10-15 03:01:51.312970 | debian-bookworm | Region: 2025-10-15 03:01:51.312987 | debian-bookworm | Label: debian-bookworm 2025-10-15 03:01:51.313003 | debian-bookworm | Product Name: OpenStack Nova 2025-10-15 03:01:51.313019 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe03:a721 2025-10-15 03:01:51.325074 | 2025-10-15 03:01:51.325173 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-15 03:01:51.907687 | debian-bookworm -> localhost | changed 2025-10-15 03:01:51.913285 | 2025-10-15 03:01:51.913366 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-15 03:01:53.784605 | debian-bookworm -> localhost | changed 2025-10-15 03:01:53.793636 | 2025-10-15 03:01:53.793723 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-15 03:01:54.392459 | debian-bookworm -> localhost | ok 2025-10-15 03:01:54.398186 | 2025-10-15 03:01:54.398281 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-15 03:01:54.426314 | debian-bookworm | ok 2025-10-15 03:01:54.447459 | debian-bookworm | included: /var/lib/zuul/builds/67106b2ddc444f84b49c58e188366d9d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-15 03:01:54.460860 | 2025-10-15 03:01:54.462890 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-15 03:01:56.472181 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-15 03:01:56.472377 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/67106b2ddc444f84b49c58e188366d9d/work/67106b2ddc444f84b49c58e188366d9d_id_rsa 2025-10-15 03:01:56.472416 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/67106b2ddc444f84b49c58e188366d9d/work/67106b2ddc444f84b49c58e188366d9d_id_rsa.pub 2025-10-15 03:01:56.472444 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-15 03:01:56.472469 | debian-bookworm -> localhost | SHA256:E8oeJ6SArAlmpbngvLZFCMe+fSLjEYxje6f/esB/afI zuul-build-sshkey 2025-10-15 03:01:56.472492 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-15 03:01:56.472521 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-15 03:01:56.472543 | debian-bookworm -> localhost | | . | 2025-10-15 03:01:56.472565 | debian-bookworm -> localhost | |.o+ | 2025-10-15 03:01:56.472584 | debian-bookworm -> localhost | |=*+ . . | 2025-10-15 03:01:56.472604 | debian-bookworm -> localhost | |X*o. + . . | 2025-10-15 03:01:56.472624 | debian-bookworm -> localhost | |=*+.o = S | 2025-10-15 03:01:56.472647 | debian-bookworm -> localhost | |..++ + + . | 2025-10-15 03:01:56.472667 | debian-bookworm -> localhost | | +=oo.= . | 2025-10-15 03:01:56.472686 | debian-bookworm -> localhost | |..++oo + + | 2025-10-15 03:01:56.472706 | debian-bookworm -> localhost | | ....o+.=E | 2025-10-15 03:01:56.472726 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-15 03:01:56.472775 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.435167 2025-10-15 03:01:56.478732 | 2025-10-15 03:01:56.478819 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-15 03:01:56.496677 | debian-bookworm | ok 2025-10-15 03:01:56.506030 | debian-bookworm | included: /var/lib/zuul/builds/67106b2ddc444f84b49c58e188366d9d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-15 03:01:56.516620 | 2025-10-15 03:01:56.516709 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-15 03:01:56.529385 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:01:56.536002 | 2025-10-15 03:01:56.536092 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-15 03:01:57.170057 | debian-bookworm | changed 2025-10-15 03:01:57.174275 | 2025-10-15 03:01:57.174350 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-15 03:01:57.416929 | debian-bookworm | ok 2025-10-15 03:01:57.421276 | 2025-10-15 03:01:57.421346 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-15 03:01:58.052743 | debian-bookworm | changed 2025-10-15 03:01:58.062785 | 2025-10-15 03:01:58.062939 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-15 03:01:58.803954 | debian-bookworm | changed 2025-10-15 03:01:58.875268 | 2025-10-15 03:01:58.886971 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-15 03:01:58.932113 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:01:58.940572 | 2025-10-15 03:01:58.940681 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-15 03:01:59.712829 | debian-bookworm -> localhost | changed 2025-10-15 03:01:59.727311 | 2025-10-15 03:01:59.727405 | TASK [add-build-sshkey : Add back temp key] 2025-10-15 03:02:00.331336 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/67106b2ddc444f84b49c58e188366d9d/work/67106b2ddc444f84b49c58e188366d9d_id_rsa (zuul-build-sshkey) 2025-10-15 03:02:00.331544 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.036716 2025-10-15 03:02:00.350060 | 2025-10-15 03:02:00.350241 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-15 03:02:00.828153 | debian-bookworm | ok 2025-10-15 03:02:00.833757 | 2025-10-15 03:02:00.833843 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-15 03:02:00.866806 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:02:00.879206 | 2025-10-15 03:02:00.879290 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-15 03:02:01.320963 | debian-bookworm | ok 2025-10-15 03:02:01.336949 | 2025-10-15 03:02:01.337081 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-15 03:02:01.383741 | debian-bookworm | ok 2025-10-15 03:02:01.392347 | 2025-10-15 03:02:01.392486 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-15 03:02:01.649327 | debian-bookworm -> localhost | ok 2025-10-15 03:02:01.655705 | 2025-10-15 03:02:01.655790 | TASK [validate-host : Collect information about the host] 2025-10-15 03:02:02.700507 | debian-bookworm | ok 2025-10-15 03:02:02.716938 | 2025-10-15 03:02:02.717044 | TASK [validate-host : Sanitize hostname] 2025-10-15 03:02:02.802644 | debian-bookworm | ok 2025-10-15 03:02:02.833173 | 2025-10-15 03:02:02.833271 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-15 03:02:03.253830 | debian-bookworm -> localhost | changed 2025-10-15 03:02:03.262064 | 2025-10-15 03:02:03.262171 | TASK [validate-host : Collect information about zuul worker] 2025-10-15 03:02:03.643287 | debian-bookworm | ok 2025-10-15 03:02:03.651109 | 2025-10-15 03:02:03.651246 | TASK [validate-host : Write out all zuul information for each host] 2025-10-15 03:02:04.180175 | debian-bookworm -> localhost | changed 2025-10-15 03:02:04.188979 | 2025-10-15 03:02:04.189064 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-15 03:02:04.452563 | debian-bookworm | ok 2025-10-15 03:02:04.457950 | 2025-10-15 03:02:04.458041 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-15 03:02:05.340346 | debian-bookworm | changed: 2025-10-15 03:02:05.340517 | debian-bookworm | cd+++++++++ src/ 2025-10-15 03:02:05.340552 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-15 03:02:05.340576 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-15 03:02:05.340598 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2025-10-15 03:02:05.340618 | debian-bookworm | =6.2 2025-10-15 03:02:29.320047 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-10-15 03:02:29.359024 | debian-bookworm | Collecting chardet>=5.2 2025-10-15 03:02:29.371557 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-10-15 03:02:29.391339 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.6 MB/s eta 0:00:00 2025-10-15 03:02:29.437181 | debian-bookworm | Collecting colorama>=0.4.6 2025-10-15 03:02:29.448901 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-15 03:02:29.503407 | debian-bookworm | Collecting filelock>=3.20 2025-10-15 03:02:29.516408 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-10-15 03:02:29.582070 | debian-bookworm | Collecting packaging>=25 2025-10-15 03:02:29.593513 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-15 03:02:29.604142 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.6 MB/s eta 0:00:00 2025-10-15 03:02:29.652039 | debian-bookworm | Collecting platformdirs>=4.5 2025-10-15 03:02:29.665593 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-10-15 03:02:29.730863 | debian-bookworm | Collecting pluggy>=1.6 2025-10-15 03:02:29.744300 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-10-15 03:02:29.812769 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-10-15 03:02:29.825735 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-10-15 03:02:29.979162 | debian-bookworm | Collecting virtualenv>=20.34 2025-10-15 03:02:29.992352 | debian-bookworm | Downloading virtualenv-20.35.3-py3-none-any.whl (6.0 MB) 2025-10-15 03:02:30.286701 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 20.8 MB/s eta 0:00:00 2025-10-15 03:02:30.407635 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-10-15 03:02:30.419478 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-10-15 03:02:30.444825 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.7 MB/s eta 0:00:00 2025-10-15 03:02:30.607584 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-10-15 03:02:31.498848 | debian-bookworm | Successfully installed cachetools-6.2.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.0 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.31.0 virtualenv-20.35.3 2025-10-15 03:02:32.103623 | debian-bookworm | ok: Runtime: 0:00:03.216869 2025-10-15 03:02:32.108261 | 2025-10-15 03:02:32.108345 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-15 03:02:32.146047 | debian-bookworm | ok 2025-10-15 03:02:32.150619 | 2025-10-15 03:02:32.150701 | TASK [ensure-tox : Output tox version] 2025-10-15 03:02:32.713934 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-10-15 03:02:32.733164 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-15 03:02:33.184091 | debian-bookworm | ok: Runtime: 0:00:00.297217 2025-10-15 03:02:33.188527 | 2025-10-15 03:02:33.188598 | TASK [ensure-tox : Make global symlink] 2025-10-15 03:02:33.201283 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:02:33.206223 | 2025-10-15 03:02:33.206279 | PLAY RECAP 2025-10-15 03:02:33.206319 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-15 03:02:33.206339 | 2025-10-15 03:02:33.309957 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-10-15 03:02:33.310719 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-15 03:02:34.185113 | 2025-10-15 03:02:34.185226 | PLAY [all] 2025-10-15 03:02:34.201709 | 2025-10-15 03:02:34.201876 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-10-15 03:02:34.629399 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-15 03:02:34.732502 | debian-bookworm | ok: Runtime: 0:00:00.031925 2025-10-15 03:02:34.739527 | 2025-10-15 03:02:34.739646 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-10-15 03:02:35.276548 | debian-bookworm | ok: Runtime: 0:00:00.008789 2025-10-15 03:02:35.281165 | 2025-10-15 03:02:35.281247 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-10-15 03:02:35.575749 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-15 03:02:35.579672 | debian-bookworm | sudo: a password is required 2025-10-15 03:02:35.829476 | debian-bookworm | ok: Runtime: 0:00:00.026949 2025-10-15 03:02:35.841561 | 2025-10-15 03:02:35.841637 | TASK [tox : Check to see if the constraints file exists] 2025-10-15 03:02:35.867817 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:02:35.879214 | 2025-10-15 03:02:35.879306 | TASK [tox : Fail if constraints file is missing] 2025-10-15 03:02:35.912480 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:02:35.918245 | 2025-10-15 03:02:35.918327 | TASK [tox : Record file location] 2025-10-15 03:02:35.941304 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:02:35.948740 | 2025-10-15 03:02:35.948825 | TASK [tox : Install tox siblings] 2025-10-15 03:02:35.980937 | debian-bookworm | ok 2025-10-15 03:02:35.990214 | debian-bookworm | included: /var/lib/zuul/builds/67106b2ddc444f84b49c58e188366d9d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-10-15 03:02:35.995430 | 2025-10-15 03:02:35.995504 | TASK [tox : Run tox without tests] 2025-10-15 03:02:36.527212 | debian-bookworm | ROOT: 191 D setup logging to DEBUG on pid 1414 [tox/report.py:225] 2025-10-15 03:02:36.560122 | debian-bookworm | check: 224 D created app data folder /home/zuul/.local/share/virtualenv [virtualenv/app_data/__init__.py:42] 2025-10-15 03:02:36.563266 | debian-bookworm | check: 227 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:78] 2025-10-15 03:02:36.564338 | debian-bookworm | check: 229 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/discovery/py_info.py cFS0YYV4iVpX44tcrPbhNf9zAofXkGBC nxut7uquBzLcbRv7dfOJeyvzX0Q3xFLt [virtualenv/discovery/cached_py_info.py:128] 2025-10-15 03:02:36.646627 | debian-bookworm | check: 310 D wrote python info of /usr/bin/python3.11 at /home/zuul/.local/share/virtualenv/py_info/2/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:152] 2025-10-15 03:02:36.647576 | debian-bookworm | check: 312 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-10-15 03:02:36.648125 | debian-bookworm | check: 312 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:85] 2025-10-15 03:02:36.648442 | debian-bookworm | check: 313 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:87] 2025-10-15 03:02:36.651735 | debian-bookworm | check: 316 D symlink on filesystem does work [virtualenv/info.py:50] 2025-10-15 03:02:36.691058 | debian-bookworm | check: 355 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:52] 2025-10-15 03:02:36.691313 | debian-bookworm | check: 356 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/bin [virtualenv/util/path/_sync.py:14] 2025-10-15 03:02:36.691491 | debian-bookworm | check: 356 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:14] 2025-10-15 03:02:36.691673 | debian-bookworm | check: 356 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-10-15 03:02:36.691788 | debian-bookworm | check: 356 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:36.691839 | debian-bookworm | check: 356 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:36.691888 | debian-bookworm | check: 356 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:36.691964 | debian-bookworm | check: 356 D virtualenv = 20.35.3 [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:36.692014 | debian-bookworm | check: 356 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:36.692074 | debian-bookworm | check: 356 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:36.692130 | debian-bookworm | check: 357 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:36.692216 | debian-bookworm | check: 357 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:36.692518 | debian-bookworm | check: 357 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/generics/.tox/check/bin/python [virtualenv/util/path/_sync.py:34] 2025-10-15 03:02:36.692852 | debian-bookworm | check: 357 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:98] 2025-10-15 03:02:36.693005 | debian-bookworm | check: 357 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:101] 2025-10-15 03:02:36.693487 | debian-bookworm | check: 358 D ============================== target debug ============================== [virtualenv/run/session.py:54] 2025-10-15 03:02:36.693743 | debian-bookworm | check: 358 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:215] 2025-10-15 03:02:36.735323 | debian-bookworm | check: 358 D { 2025-10-15 03:02:36.735379 | debian-bookworm | "sys": { 2025-10-15 03:02:36.735384 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check/bin/python", 2025-10-15 03:02:36.735390 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2025-10-15 03:02:36.735396 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2025-10-15 03:02:36.735402 | debian-bookworm | "base_prefix": "/usr", 2025-10-15 03:02:36.735408 | debian-bookworm | "real_prefix": null, 2025-10-15 03:02:36.735415 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2025-10-15 03:02:36.735419 | debian-bookworm | "base_exec_prefix": "/usr", 2025-10-15 03:02:36.735423 | debian-bookworm | "path": [ 2025-10-15 03:02:36.735427 | debian-bookworm | "/usr/lib/python311.zip", 2025-10-15 03:02:36.735433 | debian-bookworm | "/usr/lib/python3.11", 2025-10-15 03:02:36.735437 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2025-10-15 03:02:36.735442 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages" 2025-10-15 03:02:36.735446 | debian-bookworm | ], 2025-10-15 03:02:36.735450 | debian-bookworm | "meta_path": [ 2025-10-15 03:02:36.735454 | debian-bookworm | "", 2025-10-15 03:02:36.735458 | debian-bookworm | "", 2025-10-15 03:02:36.735463 | debian-bookworm | "", 2025-10-15 03:02:36.735467 | debian-bookworm | "" 2025-10-15 03:02:36.735471 | debian-bookworm | ], 2025-10-15 03:02:36.735475 | debian-bookworm | "fs_encoding": "utf-8", 2025-10-15 03:02:36.735479 | debian-bookworm | "io_encoding": "utf-8" 2025-10-15 03:02:36.735482 | debian-bookworm | }, 2025-10-15 03:02:36.735487 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2025-10-15 03:02:36.735491 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2025-10-15 03:02:36.735495 | debian-bookworm | "os": "", 2025-10-15 03:02:36.735498 | debian-bookworm | "site": "", 2025-10-15 03:02:36.735502 | debian-bookworm | "datetime": "", 2025-10-15 03:02:36.735506 | debian-bookworm | "math": "", 2025-10-15 03:02:36.735511 | debian-bookworm | "json": "" 2025-10-15 03:02:36.735515 | debian-bookworm | } [virtualenv/run/session.py:55] 2025-10-15 03:02:36.735755 | debian-bookworm | check: 400 I add seed packages via FromAppData(download=False, pip=bundle, setuptools=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv) [virtualenv/run/session.py:59] 2025-10-15 03:02:36.739233 | debian-bookworm | check: 403 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-25.2-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51] 2025-10-15 03:02:36.740596 | debian-bookworm | check: 405 D install setuptools from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/setuptools-80.9.0-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51] 2025-10-15 03:02:36.741813 | debian-bookworm | check: 406 D build install image for pip-25.2-py3-none-any.whl to /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.2-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2025-10-15 03:02:36.746271 | debian-bookworm | check: 410 D build install image for setuptools-80.9.0-py3-none-any.whl to /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2025-10-15 03:02:36.998024 | debian-bookworm | check: 662 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools-80.9.0.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/setuptools-80.9.0.virtualenv [virtualenv/util/path/_sync.py:42] 2025-10-15 03:02:36.998822 | debian-bookworm | check: 663 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.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] 2025-10-15 03:02:37.000117 | debian-bookworm | check: 664 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.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] 2025-10-15 03:02:37.000453 | debian-bookworm | check: 665 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/pkg_resources to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pkg_resources [virtualenv/util/path/_sync.py:42] 2025-10-15 03:02:37.011357 | debian-bookworm | check: 676 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.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] 2025-10-15 03:02:37.053787 | debian-bookworm | check: 718 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.2-py3-none-any/pip-25.2.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-25.2.virtualenv [virtualenv/util/path/_sync.py:42] 2025-10-15 03:02:37.054875 | debian-bookworm | check: 719 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.2-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] 2025-10-15 03:02:37.228664 | debian-bookworm | check: 893 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools-80.9.0.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/setuptools-80.9.0.dist-info [virtualenv/util/path/_sync.py:42] 2025-10-15 03:02:37.231674 | debian-bookworm | check: 896 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-10-15 03:02:37.236833 | debian-bookworm | check: 901 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.2-py3-none-any/pip-25.2.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-25.2.dist-info [virtualenv/util/path/_sync.py:42] 2025-10-15 03:02:37.241636 | debian-bookworm | check: 906 D generated console scripts pip3 pip-3.11 pip3.11 pip [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-10-15 03:02:37.242122 | debian-bookworm | check: 906 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65] 2025-10-15 03:02:37.248323 | debian-bookworm | check: 913 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-10-15 03:02:37.248397 | debian-bookworm | check: 913 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:37.248457 | debian-bookworm | check: 913 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:37.248499 | debian-bookworm | check: 913 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:37.248547 | debian-bookworm | check: 913 D virtualenv = 20.35.3 [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:37.248594 | debian-bookworm | check: 913 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:37.248649 | debian-bookworm | check: 913 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:37.248705 | debian-bookworm | check: 913 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:37.248786 | debian-bookworm | check: 913 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-10-15 03:02:37.253792 | debian-bookworm | check: 918 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:464] 2025-10-15 03:02:38.395669 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2025-10-15 03:02:38.468314 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2025-10-15 03:02:38.584602 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2025-10-15 03:02:38.597171 | 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) 2025-10-15 03:02:38.673828 | debian-bookworm | Collecting ansible==11.11.0 (from -r requirements.txt (line 3)) 2025-10-15 03:02:38.686880 | debian-bookworm | Downloading ansible-11.11.0-py3-none-any.whl.metadata (8.1 kB) 2025-10-15 03:02:38.735590 | debian-bookworm | Collecting packaging==25.0 (from -r requirements.txt (line 4)) 2025-10-15 03:02:38.748018 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl.metadata (3.3 kB) 2025-10-15 03:02:38.882799 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2025-10-15 03:02:38.897943 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2025-10-15 03:02:38.919705 | debian-bookworm | Installing build dependencies: started 2025-10-15 03:02:40.162590 | debian-bookworm | Installing build dependencies: finished with status 'done' 2025-10-15 03:02:40.163249 | debian-bookworm | Getting requirements to build wheel: started 2025-10-15 03:02:40.593716 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2025-10-15 03:02:40.594864 | debian-bookworm | Preparing metadata (pyproject.toml): started 2025-10-15 03:02:40.842990 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2025-10-15 03:02:40.977806 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2025-10-15 03:02:40.991299 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2025-10-15 03:02:41.064925 | debian-bookworm | Collecting requests==2.32.5 (from -r requirements.txt (line 7)) 2025-10-15 03:02:41.076952 | debian-bookworm | Downloading requests-2.32.5-py3-none-any.whl.metadata (4.9 kB) 2025-10-15 03:02:41.121397 | debian-bookworm | Collecting tabulate==0.9.0 (from -r requirements.txt (line 8)) 2025-10-15 03:02:41.134066 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl.metadata (34 kB) 2025-10-15 03:02:41.248460 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2025-10-15 03:02:41.260467 | 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) 2025-10-15 03:02:41.342774 | debian-bookworm | Collecting ansible-core~=2.18.10 (from ansible==11.11.0->-r requirements.txt (line 3)) 2025-10-15 03:02:41.355061 | debian-bookworm | Downloading ansible_core-2.18.10-py3-none-any.whl.metadata (7.7 kB) 2025-10-15 03:02:41.411695 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-10-15 03:02:41.423442 | debian-bookworm | Downloading click-8.3.0-py3-none-any.whl.metadata (2.6 kB) 2025-10-15 03:02:41.478818 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-10-15 03:02:41.492016 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-10-15 03:02:41.542987 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-10-15 03:02:41.557140 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2025-10-15 03:02:41.711519 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-10-15 03:02:41.725571 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2025-10-15 03:02:41.881553 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-10-15 03:02:41.894730 | 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) 2025-10-15 03:02:41.954918 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-10-15 03:02:41.967073 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl.metadata (8.4 kB) 2025-10-15 03:02:42.030162 | debian-bookworm | Collecting urllib3<3,>=1.21.1 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-10-15 03:02:42.041892 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl.metadata (6.5 kB) 2025-10-15 03:02:42.130193 | debian-bookworm | Collecting certifi>=2017.4.17 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-10-15 03:02:42.142241 | debian-bookworm | Downloading certifi-2025.10.5-py3-none-any.whl.metadata (2.5 kB) 2025-10-15 03:02:42.478222 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.10->ansible==11.11.0->-r requirements.txt (line 3)) 2025-10-15 03:02:42.491636 | debian-bookworm | Downloading cryptography-46.0.2-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2025-10-15 03:02:42.533562 | debian-bookworm | Collecting resolvelib<1.1.0,>=0.5.3 (from ansible-core~=2.18.10->ansible==11.11.0->-r requirements.txt (line 3)) 2025-10-15 03:02:42.546868 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2025-10-15 03:02:42.742683 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core~=2.18.10->ansible==11.11.0->-r requirements.txt (line 3)) 2025-10-15 03:02:42.754625 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2025-10-15 03:02:42.863682 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core~=2.18.10->ansible==11.11.0->-r requirements.txt (line 3)) 2025-10-15 03:02:42.877059 | debian-bookworm | Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes) 2025-10-15 03:02:42.910236 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-10-15 03:02:42.950433 | 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) 2025-10-15 03:02:43.009515 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 11.9 MB/s 0:00:00 2025-10-15 03:02:43.024017 | debian-bookworm | Downloading ansible-11.11.0-py3-none-any.whl (57.1 MB) 2025-10-15 03:02:45.329721 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.1/57.1 MB 24.9 MB/s 0:00:02 2025-10-15 03:02:45.341539 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-15 03:02:45.365943 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2025-10-15 03:02:45.389839 | debian-bookworm | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2025-10-15 03:02:45.413664 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl (35 kB) 2025-10-15 03:02:45.439721 | debian-bookworm | Downloading ansible_core-2.18.10-py3-none-any.whl (2.2 MB) 2025-10-15 03:02:45.539096 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 22.0 MB/s 0:00:00 2025-10-15 03:02:45.552453 | 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) 2025-10-15 03:02:45.576893 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl (71 kB) 2025-10-15 03:02:45.601727 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2025-10-15 03:02:45.626706 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl (129 kB) 2025-10-15 03:02:45.651783 | debian-bookworm | Downloading certifi-2025.10.5-py3-none-any.whl (163 kB) 2025-10-15 03:02:45.678176 | 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) 2025-10-15 03:02:45.705020 | debian-bookworm | Downloading click-8.3.0-py3-none-any.whl (107 kB) 2025-10-15 03:02:45.735348 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-15 03:02:45.759441 | debian-bookworm | Downloading cryptography-46.0.2-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2025-10-15 03:02:45.982605 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 19.7 MB/s 0:00:00 2025-10-15 03:02:45.995563 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2025-10-15 03:02:46.028805 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2025-10-15 03:02:46.053741 | debian-bookworm | Downloading pycparser-2.23-py3-none-any.whl (118 kB) 2025-10-15 03:02:46.080739 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2025-10-15 03:02:46.382595 | debian-bookworm | Building wheels for collected packages: pwgen 2025-10-15 03:02:46.384124 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2025-10-15 03:02:46.675866 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2025-10-15 03:02:46.677388 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3797 sha256=084f12f7d06f6dd8ce3a625fe1a7de1c5b5f834f5c81a50b7e83fef36564542a 2025-10-15 03:02:46.678215 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2025-10-15 03:02:46.683278 | debian-bookworm | Successfully built pwgen 2025-10-15 03:02:46.941951 | 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 2025-10-15 03:03:16.329581 | debian-bookworm | 2025-10-15 03:03:16.332189 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-11.11.0 ansible-core-2.18.10 certifi-2025.10.5 cffi-2.0.0 charset_normalizer-3.4.4 click-8.3.0 colorama-0.4.6 cryptography-46.0.2 fasteners-0.20 idna-3.11 packaging-25.0 pwgen-0.8.2.post0 pycparser-2.23 python-gilt-1.2.3 requests-2.32.5 resolvelib-1.0.1 sh-2.2.2 tabulate-0.9.0 urllib3-2.5.0 2025-10-15 03:03:16.494377 | debian-bookworm | check: 40158 I exit 0 (39.24 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1427 [tox/execute/api.py:295] 2025-10-15 03:03:16.500000 | debian-bookworm | check: OK (39.94 seconds) 2025-10-15 03:03:16.500055 | debian-bookworm | congratulations :) (39.97 seconds) 2025-10-15 03:03:16.586541 | debian-bookworm | ok: Runtime: 0:00:40.238463 2025-10-15 03:03:16.603042 | 2025-10-15 03:03:16.603140 | TASK [tox : Create a tempfile to save tox showconfig] 2025-10-15 03:03:17.098565 | debian-bookworm | changed 2025-10-15 03:03:17.111081 | 2025-10-15 03:03:17.111184 | TASK [tox : Get tox envlist config] 2025-10-15 03:03:18.159640 | debian-bookworm | ok: Runtime: 0:00:00.371060 2025-10-15 03:03:18.165216 | 2025-10-15 03:03:18.165313 | TASK [tox : Install any sibling python packages] 2025-10-15 03:03:18.764213 | debian-bookworm | ok: No setup.cfg, no action needed 2025-10-15 03:03:18.770426 | 2025-10-15 03:03:18.770518 | TASK [tox : Remove tempfile] 2025-10-15 03:03:19.184268 | debian-bookworm | changed 2025-10-15 03:03:19.191059 | 2025-10-15 03:03:19.191149 | TASK [tox : Emit tox command] 2025-10-15 03:03:19.220251 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2025-10-15 03:03:19.225819 | 2025-10-15 03:03:19.225924 | TASK [tox : Run tox] 2025-10-15 03:03:19.737893 | debian-bookworm | ROOT: 172 D setup logging to DEBUG on pid 1582 [tox/report.py:225] 2025-10-15 03:03:19.768125 | debian-bookworm | check: 202 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:78] 2025-10-15 03:03:19.768933 | debian-bookworm | check: 203 D got python info of /usr/bin/python3.11 from /home/zuul/.local/share/virtualenv/py_info/2/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:132] 2025-10-15 03:03:19.769719 | debian-bookworm | check: 204 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-10-15 03:03:19.769873 | debian-bookworm | check: 204 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:85] 2025-10-15 03:03:19.769930 | debian-bookworm | check: 204 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:87] 2025-10-15 03:03:19.770997 | debian-bookworm | check: 205 D symlink on filesystem does work [virtualenv/info.py:50] 2025-10-15 03:03:19.801037 | debian-bookworm | check: 235 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:464] 2025-10-15 03:03:19.858052 | debian-bookworm | check: 292 I exit 0 (0.05 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-inventory-sorting.py pid=1589 [tox/execute/api.py:295] 2025-10-15 03:03:19.859518 | debian-bookworm | check: OK (0.10=setup[0.04]+cmd[0.05] seconds) 2025-10-15 03:03:19.859571 | debian-bookworm | congratulations :) (0.12 seconds) 2025-10-15 03:03:20.289027 | debian-bookworm | ok: Runtime: 0:00:00.395414 2025-10-15 03:03:20.295147 | 2025-10-15 03:03:20.295234 | TASK [tox : Look for output] 2025-10-15 03:03:20.663706 | debian-bookworm | ok 2025-10-15 03:03:20.675981 | 2025-10-15 03:03:20.676080 | TASK [tox : Return file comments to Zuul] 2025-10-15 03:03:20.699193 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:20.704966 | 2025-10-15 03:03:20.705032 | PLAY RECAP 2025-10-15 03:03:20.705081 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-15 03:03:20.705107 | 2025-10-15 03:03:20.795009 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-15 03:03:20.795910 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-15 03:03:21.516173 | 2025-10-15 03:03:21.516291 | PLAY [all] 2025-10-15 03:03:21.529576 | 2025-10-15 03:03:21.529685 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-10-15 03:03:21.577419 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:21.586256 | 2025-10-15 03:03:21.586375 | TASK [fetch-tox-output : Set tox log path for single node] 2025-10-15 03:03:21.614285 | debian-bookworm | ok 2025-10-15 03:03:21.619631 | 2025-10-15 03:03:21.619719 | TASK [fetch-tox-output : Ensure local tox dir] 2025-10-15 03:03:22.007302 | debian-bookworm -> localhost | changed 2025-10-15 03:03:22.023183 | 2025-10-15 03:03:22.023274 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-10-15 03:03:22.077813 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:22.091186 | 2025-10-15 03:03:22.091360 | TASK [fetch-tox-output : Set envlist fact] 2025-10-15 03:03:22.145971 | debian-bookworm | ok 2025-10-15 03:03:22.154075 | 2025-10-15 03:03:22.154196 | TASK [fetch-tox-output : Get tox version] 2025-10-15 03:03:22.831213 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-10-15 03:03:22.850223 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-15 03:03:23.182259 | debian-bookworm | ok: Runtime: 0:00:00.301836 2025-10-15 03:03:23.194863 | 2025-10-15 03:03:23.195021 | TASK [fetch-tox-output : Find all default environments] 2025-10-15 03:03:23.725214 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:23.740296 | 2025-10-15 03:03:23.740482 | TASK [fetch-tox-output : Set envlist fact] 2025-10-15 03:03:23.775373 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:23.786856 | 2025-10-15 03:03:23.787028 | TASK [fetch-tox-output : Find all default environments] 2025-10-15 03:03:24.324994 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:24.338048 | 2025-10-15 03:03:24.338226 | TASK [fetch-tox-output : Set envlist fact] 2025-10-15 03:03:24.365920 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:24.374015 | 2025-10-15 03:03:24.374133 | LOOP [fetch-tox-output : Copy tox logs] 2025-10-15 03:03:24.418552 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:24.427345 | 2025-10-15 03:03:24.427438 | LOOP [fetch-tox-output : Collect tox logs] 2025-10-15 03:03:25.159718 | debian-bookworm | changed: 2025-10-15 03:03:25.159887 | debian-bookworm | created directory /var/lib/zuul/builds/67106b2ddc444f84b49c58e188366d9d/work/logs/tox/check 2025-10-15 03:03:25.159921 | debian-bookworm | cd+++++++++ ./ 2025-10-15 03:03:25.159946 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-10-15 03:03:25.159972 | 2025-10-15 03:03:25.176803 | 2025-10-15 03:03:25.176899 | PLAY RECAP 2025-10-15 03:03:25.176960 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-15 03:03:25.176989 | 2025-10-15 03:03:25.262512 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-15 03:03:25.263678 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-15 03:03:25.908753 | 2025-10-15 03:03:25.908881 | PLAY [all] 2025-10-15 03:03:25.923212 | 2025-10-15 03:03:25.923316 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-10-15 03:03:26.167598 | debian-bookworm | changed: non-zero return code 2025-10-15 03:03:26.173126 | 2025-10-15 03:03:26.173235 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-10-15 03:03:26.196330 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:26.201583 | 2025-10-15 03:03:26.201671 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-10-15 03:03:26.230151 | 2025-10-15 03:03:26.230309 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-10-15 03:03:26.274508 | 2025-10-15 03:03:26.274826 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-10-15 03:03:26.289921 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:26.295560 | 2025-10-15 03:03:26.295651 | LOOP [fetch-subunit-output : Generate subunit file] 2025-10-15 03:03:26.326232 | 2025-10-15 03:03:26.326506 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-10-15 03:03:26.340666 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:26.351182 | 2025-10-15 03:03:26.351275 | TASK [fetch-subunit-output : Remove the temporary file] 2025-10-15 03:03:26.375262 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:26.385749 | 2025-10-15 03:03:26.385843 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-10-15 03:03:26.403044 | debian-bookworm | skipping: Conditional result was False 2025-10-15 03:03:26.409760 | 2025-10-15 03:03:26.409821 | PLAY RECAP 2025-10-15 03:03:26.409914 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-15 03:03:26.409949 | 2025-10-15 03:03:26.512861 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-15 03:03:26.514264 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-15 03:03:27.212754 | 2025-10-15 03:03:27.212888 | PLAY [Base post] 2025-10-15 03:03:27.235590 | 2025-10-15 03:03:27.235707 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-15 03:03:27.796563 | debian-bookworm | changed 2025-10-15 03:03:27.804322 | 2025-10-15 03:03:27.804777 | PLAY RECAP 2025-10-15 03:03:27.805122 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-15 03:03:27.805204 | 2025-10-15 03:03:28.017653 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-15 03:03:28.019288 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-15 03:03:29.972682 | 2025-10-15 03:03:29.972814 | PLAY [Base post-logs] 2025-10-15 03:03:29.986792 | 2025-10-15 03:03:29.986960 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-15 03:03:31.024115 | localhost | changed 2025-10-15 03:03:31.036203 | 2025-10-15 03:03:31.036377 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-15 03:03:31.061150 | localhost | ok 2025-10-15 03:03:31.064501 | 2025-10-15 03:03:31.064600 | TASK [Set zuul-log-path fact] 2025-10-15 03:03:31.090460 | localhost | ok 2025-10-15 03:03:31.098635 | 2025-10-15 03:03:31.098737 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-15 03:03:31.123566 | localhost | ok 2025-10-15 03:03:31.126292 | 2025-10-15 03:03:31.126379 | TASK [upload-logs : Create log directories] 2025-10-15 03:03:31.650628 | localhost | changed 2025-10-15 03:03:31.653279 | 2025-10-15 03:03:31.653366 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-15 03:03:32.156706 | localhost -> localhost | ok: Runtime: 0:00:00.003331 2025-10-15 03:03:32.161032 | 2025-10-15 03:03:32.161127 | TASK [upload-logs : Upload logs to log server] 2025-10-15 03:03:32.989440 | localhost | Output suppressed because no_log was given 2025-10-15 03:03:32.991056 | 2025-10-15 03:03:32.991144 | LOOP [upload-logs : Compress console log and json output] 2025-10-15 03:03:33.067341 | localhost | skipping: Conditional result was False 2025-10-15 03:03:33.071951 | localhost | skipping: Conditional result was False 2025-10-15 03:03:33.076589 | 2025-10-15 03:03:33.076678 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-15 03:03:33.172554 | localhost | skipping: Conditional result was False 2025-10-15 03:03:33.172784 | 2025-10-15 03:03:33.176419 | localhost | skipping: Conditional result was False 2025-10-15 03:03:33.182251 | 2025-10-15 03:03:33.182349 | LOOP [upload-logs : Upload console log and json output]