2025-12-05 03:07:02.507057 | Job console starting 2025-12-05 03:07:02.515536 | Updating git repos 2025-12-05 03:07:02.551080 | Cloning repos into workspace 2025-12-05 03:07:02.591270 | Restoring repo states 2025-12-05 03:07:02.604041 | Merging changes 2025-12-05 03:07:02.604064 | Checking out repos 2025-12-05 03:07:02.714462 | Preparing playbooks 2025-12-05 03:07:03.617233 | Running Ansible setup 2025-12-05 03:07:10.344467 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-05 03:07:11.262656 | 2025-12-05 03:07:11.262900 | PLAY [Base pre] 2025-12-05 03:07:11.283240 | 2025-12-05 03:07:11.283417 | TASK [Setup log path fact] 2025-12-05 03:07:11.335266 | debian-bookworm | ok 2025-12-05 03:07:11.352637 | 2025-12-05 03:07:11.352818 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-05 03:07:11.386609 | debian-bookworm | ok 2025-12-05 03:07:11.409841 | 2025-12-05 03:07:11.409990 | TASK [emit-job-header : Print job information] 2025-12-05 03:07:11.451088 | # Job Information 2025-12-05 03:07:11.451328 | Ansible Version: 2.16.14 2025-12-05 03:07:11.451366 | Job: cfg-generics-tox-check 2025-12-05 03:07:11.451399 | Pipeline: periodic-daily 2025-12-05 03:07:11.451423 | Executor: 521e9411259a 2025-12-05 03:07:11.451444 | Triggered by: https://github.com/osism/generics 2025-12-05 03:07:11.451466 | Event ID: 59c8ca20dbb3491b8c3a7b01020a2d68 2025-12-05 03:07:11.456595 | 2025-12-05 03:07:11.456726 | LOOP [emit-job-header : Print node information] 2025-12-05 03:07:11.585848 | debian-bookworm | ok: 2025-12-05 03:07:11.586243 | debian-bookworm | # Node Information 2025-12-05 03:07:11.586294 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-05 03:07:11.586321 | debian-bookworm | Hostname: debian 2025-12-05 03:07:11.586344 | debian-bookworm | Username: zuul 2025-12-05 03:07:11.586365 | debian-bookworm | Distro: Debian 12.12 2025-12-05 03:07:11.586397 | debian-bookworm | Provider: regiocloud-a 2025-12-05 03:07:11.586422 | debian-bookworm | Region: 2025-12-05 03:07:11.586444 | debian-bookworm | Label: debian-bookworm 2025-12-05 03:07:11.586464 | debian-bookworm | Product Name: OpenStack Nova 2025-12-05 03:07:11.586483 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1e:2733 2025-12-05 03:07:11.610216 | 2025-12-05 03:07:11.610382 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-05 03:07:12.340791 | debian-bookworm -> localhost | changed 2025-12-05 03:07:12.350428 | 2025-12-05 03:07:12.350647 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-05 03:07:13.949767 | debian-bookworm -> localhost | changed 2025-12-05 03:07:13.997778 | 2025-12-05 03:07:13.997933 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-05 03:07:14.419213 | debian-bookworm -> localhost | ok 2025-12-05 03:07:14.425833 | 2025-12-05 03:07:14.425963 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-05 03:07:14.455533 | debian-bookworm | ok 2025-12-05 03:07:14.511267 | debian-bookworm | included: /var/lib/zuul/builds/6a7952e71a7a436c904151d9c45bb9c7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-05 03:07:14.528131 | 2025-12-05 03:07:14.528309 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-05 03:07:15.778342 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-05 03:07:15.778587 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6a7952e71a7a436c904151d9c45bb9c7/work/6a7952e71a7a436c904151d9c45bb9c7_id_rsa 2025-12-05 03:07:15.778644 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6a7952e71a7a436c904151d9c45bb9c7/work/6a7952e71a7a436c904151d9c45bb9c7_id_rsa.pub 2025-12-05 03:07:15.778671 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-05 03:07:15.778696 | debian-bookworm -> localhost | SHA256:JTStw6NHLFF1m6on6S0gFdy8VBec7s9WgkH/KOd8/7s zuul-build-sshkey 2025-12-05 03:07:15.778719 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-05 03:07:15.778755 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-05 03:07:15.778777 | debian-bookworm -> localhost | | . +++o.+o | 2025-12-05 03:07:15.778799 | debian-bookworm -> localhost | | +.+..o+o | 2025-12-05 03:07:15.778819 | debian-bookworm -> localhost | | *.o.oo. | 2025-12-05 03:07:15.779244 | debian-bookworm -> localhost | | o Oo .o . | 2025-12-05 03:07:15.779278 | debian-bookworm -> localhost | | . +So.. o o | 2025-12-05 03:07:15.779304 | debian-bookworm -> localhost | | . o .o + + o| 2025-12-05 03:07:15.779326 | debian-bookworm -> localhost | | . o+ . B o | 2025-12-05 03:07:15.779348 | debian-bookworm -> localhost | | ..+ * .| 2025-12-05 03:07:15.779369 | debian-bookworm -> localhost | | ... . EB| 2025-12-05 03:07:15.779390 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-05 03:07:15.779456 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.472890 2025-12-05 03:07:15.786398 | 2025-12-05 03:07:15.786541 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-05 03:07:15.845404 | debian-bookworm | ok 2025-12-05 03:07:15.863620 | debian-bookworm | included: /var/lib/zuul/builds/6a7952e71a7a436c904151d9c45bb9c7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-05 03:07:15.884353 | 2025-12-05 03:07:15.884504 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-05 03:07:15.929081 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:07:15.936655 | 2025-12-05 03:07:15.936798 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-05 03:07:16.737345 | debian-bookworm | changed 2025-12-05 03:07:16.749377 | 2025-12-05 03:07:16.749595 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-05 03:07:17.055425 | debian-bookworm | ok 2025-12-05 03:07:17.063526 | 2025-12-05 03:07:17.063677 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-05 03:07:17.862820 | debian-bookworm | changed 2025-12-05 03:07:17.870557 | 2025-12-05 03:07:17.870687 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-05 03:07:18.538262 | debian-bookworm | changed 2025-12-05 03:07:18.544302 | 2025-12-05 03:07:18.544433 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-05 03:07:18.568773 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:07:18.575246 | 2025-12-05 03:07:18.575374 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-05 03:07:19.281377 | debian-bookworm -> localhost | changed 2025-12-05 03:07:19.292968 | 2025-12-05 03:07:19.293112 | TASK [add-build-sshkey : Add back temp key] 2025-12-05 03:07:19.980953 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6a7952e71a7a436c904151d9c45bb9c7/work/6a7952e71a7a436c904151d9c45bb9c7_id_rsa (zuul-build-sshkey) 2025-12-05 03:07:19.985243 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017652 2025-12-05 03:07:20.005387 | 2025-12-05 03:07:20.005519 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-05 03:07:20.518971 | debian-bookworm | ok 2025-12-05 03:07:20.524664 | 2025-12-05 03:07:20.524789 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-05 03:07:20.560089 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:07:20.571734 | 2025-12-05 03:07:20.571949 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-05 03:07:21.021379 | debian-bookworm | ok 2025-12-05 03:07:21.033321 | 2025-12-05 03:07:21.033466 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-05 03:07:21.065689 | debian-bookworm | ok 2025-12-05 03:07:21.075643 | 2025-12-05 03:07:21.075798 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-05 03:07:21.470977 | debian-bookworm -> localhost | ok 2025-12-05 03:07:21.479567 | 2025-12-05 03:07:21.479705 | TASK [validate-host : Collect information about the host] 2025-12-05 03:07:22.690428 | debian-bookworm | ok 2025-12-05 03:07:22.707218 | 2025-12-05 03:07:22.707360 | TASK [validate-host : Sanitize hostname] 2025-12-05 03:07:22.884193 | debian-bookworm | ok 2025-12-05 03:07:22.943115 | 2025-12-05 03:07:22.943351 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-05 03:07:23.995308 | debian-bookworm -> localhost | changed 2025-12-05 03:07:24.010885 | 2025-12-05 03:07:24.011656 | TASK [validate-host : Collect information about zuul worker] 2025-12-05 03:07:24.525808 | debian-bookworm | ok 2025-12-05 03:07:24.534106 | 2025-12-05 03:07:24.534327 | TASK [validate-host : Write out all zuul information for each host] 2025-12-05 03:07:25.139977 | debian-bookworm -> localhost | changed 2025-12-05 03:07:25.168186 | 2025-12-05 03:07:25.168362 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-05 03:07:25.460588 | debian-bookworm | ok 2025-12-05 03:07:25.467998 | 2025-12-05 03:07:25.468348 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-05 03:07:26.311538 | debian-bookworm | changed: 2025-12-05 03:07:26.311764 | debian-bookworm | cd+++++++++ src/ 2025-12-05 03:07:26.311800 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-05 03:07:26.311825 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-05 03:07:26.311848 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2025-12-05 03:07:26.311868 | debian-bookworm | =6.2 2025-12-05 03:07:49.249978 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-12-05 03:07:49.286639 | debian-bookworm | Collecting chardet>=5.2 2025-12-05 03:07:49.299214 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-05 03:07:49.323547 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 10.2 MB/s eta 0:00:00 2025-12-05 03:07:49.372281 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-05 03:07:49.384014 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-05 03:07:49.435460 | debian-bookworm | Collecting filelock>=3.20 2025-12-05 03:07:49.446603 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-12-05 03:07:49.494637 | debian-bookworm | Collecting packaging>=25 2025-12-05 03:07:49.505994 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-05 03:07:49.514937 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.5 MB/s eta 0:00:00 2025-12-05 03:07:49.559427 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-05 03:07:49.570596 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-12-05 03:07:49.627827 | debian-bookworm | Collecting pluggy>=1.6 2025-12-05 03:07:49.639396 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-05 03:07:49.685135 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-05 03:07:49.697090 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-05 03:07:49.833340 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-05 03:07:49.845165 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-05 03:07:50.137813 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 20.9 MB/s eta 0:00:00 2025-12-05 03:07:50.241465 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-05 03:07:50.252796 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-05 03:07:50.273632 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 25.5 MB/s eta 0:00:00 2025-12-05 03:07:50.420650 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-05 03:07:51.268489 | debian-bookworm | Successfully installed cachetools-6.2.2 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.32.0 virtualenv-20.35.4 2025-12-05 03:07:51.591297 | debian-bookworm | ok: Runtime: 0:00:03.039081 2025-12-05 03:07:51.605650 | 2025-12-05 03:07:51.605855 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-05 03:07:51.664375 | debian-bookworm | ok 2025-12-05 03:07:51.672053 | 2025-12-05 03:07:51.672395 | TASK [ensure-tox : Output tox version] 2025-12-05 03:07:52.211409 | 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-12-05 03:07:52.230279 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-05 03:07:52.722921 | debian-bookworm | ok: Runtime: 0:00:00.302307 2025-12-05 03:07:52.738411 | 2025-12-05 03:07:52.738576 | TASK [ensure-tox : Make global symlink] 2025-12-05 03:07:52.763529 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:07:52.771084 | 2025-12-05 03:07:52.771219 | PLAY RECAP 2025-12-05 03:07:52.771323 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-05 03:07:52.771352 | 2025-12-05 03:07:52.937061 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-05 03:07:52.938784 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-05 03:07:53.801518 | 2025-12-05 03:07:53.801693 | PLAY [all] 2025-12-05 03:07:53.826158 | 2025-12-05 03:07:53.826567 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-05 03:07:54.364025 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-05 03:07:54.429702 | debian-bookworm | ok: Runtime: 0:00:00.035550 2025-12-05 03:07:54.436740 | 2025-12-05 03:07:54.436886 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-05 03:07:54.979659 | debian-bookworm | ok: Runtime: 0:00:00.007802 2025-12-05 03:07:54.993833 | 2025-12-05 03:07:54.994144 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-05 03:07:55.320436 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-05 03:07:55.324729 | debian-bookworm | sudo: a password is required 2025-12-05 03:07:55.538119 | debian-bookworm | ok: Runtime: 0:00:00.025611 2025-12-05 03:07:55.558155 | 2025-12-05 03:07:55.558362 | TASK [tox : Check to see if the constraints file exists] 2025-12-05 03:07:55.594808 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:07:55.605943 | 2025-12-05 03:07:55.606186 | TASK [tox : Fail if constraints file is missing] 2025-12-05 03:07:55.655186 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:07:55.661707 | 2025-12-05 03:07:55.661844 | TASK [tox : Record file location] 2025-12-05 03:07:55.686691 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:07:55.698821 | 2025-12-05 03:07:55.699049 | TASK [tox : Install tox siblings] 2025-12-05 03:07:55.732045 | debian-bookworm | ok 2025-12-05 03:07:55.741085 | debian-bookworm | included: /var/lib/zuul/builds/6a7952e71a7a436c904151d9c45bb9c7/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-05 03:07:55.747000 | 2025-12-05 03:07:55.747135 | TASK [tox : Run tox without tests] 2025-12-05 03:07:56.314944 | debian-bookworm | ROOT: 209 D setup logging to DEBUG on pid 1413 [tox/report.py:225] 2025-12-05 03:07:56.345005 | debian-bookworm | check: 239 D created app data folder /home/zuul/.local/share/virtualenv [virtualenv/app_data/__init__.py:42] 2025-12-05 03:07:56.347915 | debian-bookworm | check: 242 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:78] 2025-12-05 03:07:56.348835 | debian-bookworm | check: 243 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/discovery/py_info.py gpCHyK5PHG7sClIcz50RxsBOq3iI8kdc G48SjDYzgLxDV7PG8JayxOfQeUW2JjsU [virtualenv/discovery/cached_py_info.py:128] 2025-12-05 03:07:56.422446 | debian-bookworm | check: 317 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-12-05 03:07:56.423525 | debian-bookworm | check: 318 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-12-05 03:07:56.423984 | debian-bookworm | check: 318 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-12-05 03:07:56.424270 | debian-bookworm | check: 319 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-12-05 03:07:56.427457 | debian-bookworm | check: 322 D symlink on filesystem does work [virtualenv/info.py:50] 2025-12-05 03:07:56.463853 | debian-bookworm | check: 358 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-12-05 03:07:56.464119 | debian-bookworm | check: 359 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/bin [virtualenv/util/path/_sync.py:14] 2025-12-05 03:07:56.464278 | debian-bookworm | check: 359 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:14] 2025-12-05 03:07:56.464461 | debian-bookworm | check: 359 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-12-05 03:07:56.464568 | debian-bookworm | check: 359 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.464614 | debian-bookworm | check: 359 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.464666 | debian-bookworm | check: 359 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.464715 | debian-bookworm | check: 359 D virtualenv = 20.35.4 [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.464765 | debian-bookworm | check: 359 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.464838 | debian-bookworm | check: 360 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.464895 | debian-bookworm | check: 360 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.464970 | debian-bookworm | check: 360 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.465254 | debian-bookworm | check: 360 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-12-05 03:07:56.465585 | debian-bookworm | check: 360 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-12-05 03:07:56.465714 | debian-bookworm | check: 360 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-12-05 03:07:56.466262 | debian-bookworm | check: 361 D ============================== target debug ============================== [virtualenv/run/session.py:54] 2025-12-05 03:07:56.466516 | debian-bookworm | check: 361 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-12-05 03:07:56.513060 | debian-bookworm | check: 361 D { 2025-12-05 03:07:56.513108 | debian-bookworm | "sys": { 2025-12-05 03:07:56.513114 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check/bin/python", 2025-12-05 03:07:56.513119 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2025-12-05 03:07:56.513125 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2025-12-05 03:07:56.513131 | debian-bookworm | "base_prefix": "/usr", 2025-12-05 03:07:56.513138 | debian-bookworm | "real_prefix": null, 2025-12-05 03:07:56.513144 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2025-12-05 03:07:56.513149 | debian-bookworm | "base_exec_prefix": "/usr", 2025-12-05 03:07:56.513153 | debian-bookworm | "path": [ 2025-12-05 03:07:56.513157 | debian-bookworm | "/usr/lib/python311.zip", 2025-12-05 03:07:56.513162 | debian-bookworm | "/usr/lib/python3.11", 2025-12-05 03:07:56.513167 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2025-12-05 03:07:56.513171 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages" 2025-12-05 03:07:56.513176 | debian-bookworm | ], 2025-12-05 03:07:56.513180 | debian-bookworm | "meta_path": [ 2025-12-05 03:07:56.513184 | debian-bookworm | "", 2025-12-05 03:07:56.513188 | debian-bookworm | "", 2025-12-05 03:07:56.513193 | debian-bookworm | "", 2025-12-05 03:07:56.513197 | debian-bookworm | "" 2025-12-05 03:07:56.513201 | debian-bookworm | ], 2025-12-05 03:07:56.513205 | debian-bookworm | "fs_encoding": "utf-8", 2025-12-05 03:07:56.513209 | debian-bookworm | "io_encoding": "utf-8" 2025-12-05 03:07:56.513213 | debian-bookworm | }, 2025-12-05 03:07:56.513217 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2025-12-05 03:07:56.513221 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2025-12-05 03:07:56.513225 | debian-bookworm | "os": "", 2025-12-05 03:07:56.513229 | debian-bookworm | "site": "", 2025-12-05 03:07:56.513233 | debian-bookworm | "datetime": "", 2025-12-05 03:07:56.513237 | debian-bookworm | "math": "", 2025-12-05 03:07:56.513241 | debian-bookworm | "json": "" 2025-12-05 03:07:56.513245 | debian-bookworm | } [virtualenv/run/session.py:55] 2025-12-05 03:07:56.513272 | debian-bookworm | check: 408 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-12-05 03:07:56.516197 | debian-bookworm | check: 411 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-25.3-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51] 2025-12-05 03:07:56.517336 | debian-bookworm | check: 412 D build install image for pip-25.3-py3-none-any.whl to /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.3-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2025-12-05 03:07:56.521282 | debian-bookworm | check: 416 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-12-05 03:07:56.522976 | debian-bookworm | check: 418 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-12-05 03:07:56.739855 | debian-bookworm | check: 634 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-12-05 03:07:56.740717 | debian-bookworm | check: 635 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-12-05 03:07:56.741381 | debian-bookworm | check: 636 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-12-05 03:07:56.743054 | debian-bookworm | check: 638 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-12-05 03:07:56.793562 | debian-bookworm | check: 688 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.3-py3-none-any/pip-25.3.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-25.3.virtualenv [virtualenv/util/path/_sync.py:42] 2025-12-05 03:07:56.794240 | debian-bookworm | check: 689 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.3-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-12-05 03:07:56.968985 | debian-bookworm | check: 863 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-12-05 03:07:56.971688 | debian-bookworm | check: 866 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-12-05 03:07:56.981091 | debian-bookworm | check: 876 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-12-05 03:07:56.985396 | debian-bookworm | check: 880 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.3-py3-none-any/pip-25.3.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-25.3.dist-info [virtualenv/util/path/_sync.py:42] 2025-12-05 03:07:56.990999 | debian-bookworm | check: 886 D generated console scripts pip-3.11 pip3 pip3.11 pip [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-12-05 03:07:56.991479 | debian-bookworm | check: 886 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65] 2025-12-05 03:07:56.997730 | debian-bookworm | check: 892 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-12-05 03:07:56.997798 | debian-bookworm | check: 893 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.997906 | debian-bookworm | check: 893 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.997949 | debian-bookworm | check: 893 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.998004 | debian-bookworm | check: 893 D virtualenv = 20.35.4 [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.998045 | debian-bookworm | check: 893 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.998104 | debian-bookworm | check: 893 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.998159 | debian-bookworm | check: 893 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:56.998238 | debian-bookworm | check: 893 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-12-05 03:07:57.003381 | debian-bookworm | check: 898 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:464] 2025-12-05 03:07:58.066519 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2025-12-05 03:07:58.176960 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2025-12-05 03:07:58.303939 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2025-12-05 03:07:58.318949 | 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-12-05 03:07:58.410245 | debian-bookworm | Collecting ansible==11.12.0 (from -r requirements.txt (line 3)) 2025-12-05 03:07:58.426034 | debian-bookworm | Downloading ansible-11.12.0-py3-none-any.whl.metadata (8.1 kB) 2025-12-05 03:07:58.468459 | debian-bookworm | Collecting packaging==25.0 (from -r requirements.txt (line 4)) 2025-12-05 03:07:58.485991 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl.metadata (3.3 kB) 2025-12-05 03:07:58.540826 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2025-12-05 03:07:58.557736 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2025-12-05 03:07:58.577747 | debian-bookworm | Installing build dependencies: started 2025-12-05 03:07:59.951221 | debian-bookworm | Installing build dependencies: finished with status 'done' 2025-12-05 03:07:59.951817 | debian-bookworm | Getting requirements to build wheel: started 2025-12-05 03:08:00.371802 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2025-12-05 03:08:00.374089 | debian-bookworm | Preparing metadata (pyproject.toml): started 2025-12-05 03:08:00.614664 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2025-12-05 03:08:00.659761 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2025-12-05 03:08:00.677282 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2025-12-05 03:08:00.750776 | debian-bookworm | Collecting requests==2.32.5 (from -r requirements.txt (line 7)) 2025-12-05 03:08:00.764544 | debian-bookworm | Downloading requests-2.32.5-py3-none-any.whl.metadata (4.9 kB) 2025-12-05 03:08:00.803073 | debian-bookworm | Collecting tabulate==0.9.0 (from -r requirements.txt (line 8)) 2025-12-05 03:08:00.817927 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl.metadata (34 kB) 2025-12-05 03:08:00.954225 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2025-12-05 03:08:00.968876 | 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-12-05 03:08:01.059801 | debian-bookworm | Collecting ansible-core~=2.18.11 (from ansible==11.12.0->-r requirements.txt (line 3)) 2025-12-05 03:08:01.074530 | debian-bookworm | Downloading ansible_core-2.18.11-py3-none-any.whl.metadata (7.7 kB) 2025-12-05 03:08:01.118935 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-12-05 03:08:01.132382 | debian-bookworm | Downloading click-8.3.1-py3-none-any.whl.metadata (2.6 kB) 2025-12-05 03:08:01.172690 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-12-05 03:08:01.186605 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-12-05 03:08:01.252928 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-12-05 03:08:01.268748 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2025-12-05 03:08:01.324696 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-12-05 03:08:01.339403 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2025-12-05 03:08:01.485528 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-12-05 03:08:01.500169 | 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-12-05 03:08:01.555797 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-12-05 03:08:01.570441 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl.metadata (8.4 kB) 2025-12-05 03:08:01.640761 | debian-bookworm | Collecting urllib3<3,>=1.21.1 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-12-05 03:08:01.654974 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl.metadata (6.5 kB) 2025-12-05 03:08:01.715146 | debian-bookworm | Collecting certifi>=2017.4.17 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-12-05 03:08:01.729502 | debian-bookworm | Downloading certifi-2025.11.12-py3-none-any.whl.metadata (2.5 kB) 2025-12-05 03:08:02.065296 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2025-12-05 03:08:02.079461 | debian-bookworm | Downloading cryptography-46.0.3-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2025-12-05 03:08:02.132644 | 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)) 2025-12-05 03:08:02.147217 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2025-12-05 03:08:02.326765 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2025-12-05 03:08:02.340824 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2025-12-05 03:08:02.379232 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2025-12-05 03:08:02.394360 | debian-bookworm | Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes) 2025-12-05 03:08:02.429491 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-12-05 03:08:02.467365 | 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-12-05 03:08:02.526484 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 13.0 MB/s 0:00:00 2025-12-05 03:08:02.543828 | debian-bookworm | Downloading ansible-11.12.0-py3-none-any.whl (57.4 MB) 2025-12-05 03:08:04.266500 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.4/57.4 MB 33.3 MB/s 0:00:01 2025-12-05 03:08:04.281214 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-05 03:08:04.305922 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2025-12-05 03:08:04.332368 | debian-bookworm | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2025-12-05 03:08:04.357392 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl (35 kB) 2025-12-05 03:08:04.385130 | debian-bookworm | Downloading ansible_core-2.18.11-py3-none-any.whl (2.2 MB) 2025-12-05 03:08:04.486147 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 21.4 MB/s 0:00:00 2025-12-05 03:08:04.503234 | 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-12-05 03:08:04.539464 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl (71 kB) 2025-12-05 03:08:04.568253 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2025-12-05 03:08:04.595150 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl (129 kB) 2025-12-05 03:08:04.622739 | debian-bookworm | Downloading certifi-2025.11.12-py3-none-any.whl (159 kB) 2025-12-05 03:08:04.650472 | 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-12-05 03:08:04.677167 | debian-bookworm | Downloading click-8.3.1-py3-none-any.whl (108 kB) 2025-12-05 03:08:04.704185 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-05 03:08:04.730612 | debian-bookworm | Downloading cryptography-46.0.3-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2025-12-05 03:08:04.921344 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 23.3 MB/s 0:00:00 2025-12-05 03:08:04.937832 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2025-12-05 03:08:04.966995 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2025-12-05 03:08:04.994006 | debian-bookworm | Downloading pycparser-2.23-py3-none-any.whl (118 kB) 2025-12-05 03:08:05.021892 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2025-12-05 03:08:05.312601 | debian-bookworm | Building wheels for collected packages: pwgen 2025-12-05 03:08:05.314209 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2025-12-05 03:08:05.602580 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2025-12-05 03:08:05.604680 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3797 sha256=eab86b18b1d10c82b4d982d81502a369008ac6ee7cd69340565dfd4fe0274bab 2025-12-05 03:08:05.605733 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2025-12-05 03:08:05.611415 | debian-bookworm | Successfully built pwgen 2025-12-05 03:08:05.858854 | 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-12-05 03:08:31.443275 | debian-bookworm | 2025-12-05 03:08:31.449505 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-11.12.0 ansible-core-2.18.11 certifi-2025.11.12 cffi-2.0.0 charset_normalizer-3.4.4 click-8.3.1 colorama-0.4.6 cryptography-46.0.3 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-12-05 03:08:31.610133 | debian-bookworm | check: 35505 I exit 0 (34.60 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1426 [tox/execute/api.py:295] 2025-12-05 03:08:31.612937 | debian-bookworm | check: OK (35.27 seconds) 2025-12-05 03:08:31.612987 | debian-bookworm | congratulations :) (35.30 seconds) 2025-12-05 03:08:31.799297 | debian-bookworm | ok: Runtime: 0:00:35.588626 2025-12-05 03:08:31.817370 | 2025-12-05 03:08:31.817492 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-05 03:08:32.248549 | debian-bookworm | changed 2025-12-05 03:08:32.262230 | 2025-12-05 03:08:32.262420 | TASK [tox : Get tox envlist config] 2025-12-05 03:08:33.295106 | debian-bookworm | ok: Runtime: 0:00:00.296185 2025-12-05 03:08:33.306457 | 2025-12-05 03:08:33.306660 | TASK [tox : Install any sibling python packages] 2025-12-05 03:08:33.817840 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-05 03:08:33.840707 | 2025-12-05 03:08:33.840864 | TASK [tox : Remove tempfile] 2025-12-05 03:08:34.330122 | debian-bookworm | changed 2025-12-05 03:08:34.341091 | 2025-12-05 03:08:34.341252 | TASK [tox : Emit tox command] 2025-12-05 03:08:34.397194 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2025-12-05 03:08:34.406268 | 2025-12-05 03:08:34.406447 | TASK [tox : Run tox] 2025-12-05 03:08:34.956876 | debian-bookworm | ROOT: 167 D setup logging to DEBUG on pid 1581 [tox/report.py:225] 2025-12-05 03:08:34.986851 | debian-bookworm | check: 197 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:78] 2025-12-05 03:08:34.987594 | debian-bookworm | check: 198 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-12-05 03:08:34.988394 | debian-bookworm | check: 199 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-12-05 03:08:34.988545 | debian-bookworm | check: 199 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-12-05 03:08:34.988603 | debian-bookworm | check: 199 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-12-05 03:08:34.989596 | debian-bookworm | check: 200 D symlink on filesystem does work [virtualenv/info.py:50] 2025-12-05 03:08:35.018181 | debian-bookworm | check: 229 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:464] 2025-12-05 03:08:35.085775 | debian-bookworm | check: 296 I exit 0 (0.07 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-inventory-sorting.py pid=1588 [tox/execute/api.py:295] 2025-12-05 03:08:35.087173 | debian-bookworm | check: OK (0.11=setup[0.04]+cmd[0.07] seconds) 2025-12-05 03:08:35.087212 | debian-bookworm | congratulations :) (0.13 seconds) 2025-12-05 03:08:35.493738 | debian-bookworm | ok: Runtime: 0:00:00.383063 2025-12-05 03:08:35.500231 | 2025-12-05 03:08:35.500398 | TASK [tox : Look for output] 2025-12-05 03:08:35.985964 | debian-bookworm | ok 2025-12-05 03:08:36.027964 | 2025-12-05 03:08:36.028154 | TASK [tox : Return file comments to Zuul] 2025-12-05 03:08:36.103951 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:36.111214 | 2025-12-05 03:08:36.111321 | PLAY RECAP 2025-12-05 03:08:36.111378 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-05 03:08:36.111402 | 2025-12-05 03:08:36.333670 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-05 03:08:36.335786 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-05 03:08:37.368721 | 2025-12-05 03:08:37.368894 | PLAY [all] 2025-12-05 03:08:37.412740 | 2025-12-05 03:08:37.412915 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-05 03:08:37.539502 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:37.546121 | 2025-12-05 03:08:37.546282 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-05 03:08:37.585942 | debian-bookworm | ok 2025-12-05 03:08:37.593901 | 2025-12-05 03:08:37.594020 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-05 03:08:38.225863 | debian-bookworm -> localhost | changed 2025-12-05 03:08:38.234004 | 2025-12-05 03:08:38.234160 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-05 03:08:38.298750 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:38.304933 | 2025-12-05 03:08:38.305109 | TASK [fetch-tox-output : Set envlist fact] 2025-12-05 03:08:38.375374 | debian-bookworm | ok 2025-12-05 03:08:38.381416 | 2025-12-05 03:08:38.381539 | TASK [fetch-tox-output : Get tox version] 2025-12-05 03:08:39.206336 | 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-12-05 03:08:39.225260 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-05 03:08:39.424831 | debian-bookworm | ok: Runtime: 0:00:00.311259 2025-12-05 03:08:39.430584 | 2025-12-05 03:08:39.430710 | TASK [fetch-tox-output : Find all default environments] 2025-12-05 03:08:39.982531 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:39.989754 | 2025-12-05 03:08:39.989920 | TASK [fetch-tox-output : Set envlist fact] 2025-12-05 03:08:40.026320 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:40.033193 | 2025-12-05 03:08:40.033321 | TASK [fetch-tox-output : Find all default environments] 2025-12-05 03:08:40.600751 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:40.607246 | 2025-12-05 03:08:40.607513 | TASK [fetch-tox-output : Set envlist fact] 2025-12-05 03:08:40.669029 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:40.676813 | 2025-12-05 03:08:40.676950 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-05 03:08:40.806583 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:40.846238 | 2025-12-05 03:08:40.846440 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-05 03:08:42.434820 | debian-bookworm | changed: 2025-12-05 03:08:42.435093 | debian-bookworm | created directory /var/lib/zuul/builds/6a7952e71a7a436c904151d9c45bb9c7/work/logs/tox/check 2025-12-05 03:08:42.435134 | debian-bookworm | cd+++++++++ ./ 2025-12-05 03:08:42.435161 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-05 03:08:42.435191 | 2025-12-05 03:08:42.449109 | 2025-12-05 03:08:42.449334 | PLAY RECAP 2025-12-05 03:08:42.449478 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-05 03:08:42.449550 | 2025-12-05 03:08:42.950014 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-05 03:08:42.951024 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-05 03:08:45.270092 | 2025-12-05 03:08:45.270300 | PLAY [all] 2025-12-05 03:08:45.338408 | 2025-12-05 03:08:45.338609 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-05 03:08:45.660622 | debian-bookworm | changed: non-zero return code 2025-12-05 03:08:45.680895 | 2025-12-05 03:08:45.681090 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-05 03:08:45.728295 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:45.735198 | 2025-12-05 03:08:45.735345 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-05 03:08:45.805927 | 2025-12-05 03:08:45.806174 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-05 03:08:45.892809 | 2025-12-05 03:08:45.893029 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-05 03:08:45.948060 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:45.956114 | 2025-12-05 03:08:45.956275 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-05 03:08:46.037057 | 2025-12-05 03:08:46.037284 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-05 03:08:46.062726 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:46.068790 | 2025-12-05 03:08:46.068935 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-05 03:08:46.100208 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:46.107067 | 2025-12-05 03:08:46.107244 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-05 03:08:46.152023 | debian-bookworm | skipping: Conditional result was False 2025-12-05 03:08:46.159302 | 2025-12-05 03:08:46.159408 | PLAY RECAP 2025-12-05 03:08:46.159459 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-05 03:08:46.159484 | 2025-12-05 03:08:46.338598 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-05 03:08:46.339729 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-05 03:08:47.471657 | 2025-12-05 03:08:47.471835 | PLAY [Base post] 2025-12-05 03:08:47.508595 | 2025-12-05 03:08:47.508764 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-05 03:08:48.689487 | debian-bookworm | changed 2025-12-05 03:08:48.719332 | 2025-12-05 03:08:48.719486 | PLAY RECAP 2025-12-05 03:08:48.719557 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-05 03:08:48.719624 | 2025-12-05 03:08:49.044139 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-05 03:08:49.045666 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-05 03:08:50.823701 | 2025-12-05 03:08:50.823930 | PLAY [Base post-logs] 2025-12-05 03:08:50.885825 | 2025-12-05 03:08:50.886009 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-05 03:08:51.814075 | localhost | changed 2025-12-05 03:08:51.839156 | 2025-12-05 03:08:51.839374 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-05 03:08:51.926649 | localhost | ok 2025-12-05 03:08:51.930635 | 2025-12-05 03:08:51.930757 | TASK [Set zuul-log-path fact] 2025-12-05 03:08:51.958696 | localhost | ok 2025-12-05 03:08:51.967895 | 2025-12-05 03:08:51.968034 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-05 03:08:52.066061 | localhost | ok 2025-12-05 03:08:52.071140 | 2025-12-05 03:08:52.071373 | TASK [upload-logs : Create log directories] 2025-12-05 03:08:53.254703 | localhost | changed 2025-12-05 03:08:53.257591 | 2025-12-05 03:08:53.257708 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-05 03:08:53.932450 | localhost -> localhost | ok: Runtime: 0:00:00.012953 2025-12-05 03:08:53.936652 | 2025-12-05 03:08:53.936787 | TASK [upload-logs : Upload logs to log server] 2025-12-05 03:08:54.967234 | localhost | Output suppressed because no_log was given 2025-12-05 03:08:54.969171 | 2025-12-05 03:08:54.969289 | LOOP [upload-logs : Compress console log and json output] 2025-12-05 03:08:55.021664 | localhost | skipping: Conditional result was False 2025-12-05 03:08:55.028143 | localhost | skipping: Conditional result was False 2025-12-05 03:08:55.036722 | 2025-12-05 03:08:55.036848 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-05 03:08:55.100775 | localhost | skipping: Conditional result was False 2025-12-05 03:08:55.101113 | 2025-12-05 03:08:55.107434 | localhost | skipping: Conditional result was False 2025-12-05 03:08:55.114218 | 2025-12-05 03:08:55.114347 | LOOP [upload-logs : Upload console log and json output]