2025-10-05 18:13:55.804108 | Job console starting 2025-10-05 18:13:55.824931 | Updating git repos 2025-10-05 18:13:55.887647 | Cloning repos into workspace 2025-10-05 18:13:55.926420 | Restoring repo states 2025-10-05 18:13:55.948183 | Merging changes 2025-10-05 18:13:56.444973 | Checking out repos 2025-10-05 18:13:56.528649 | Preparing playbooks 2025-10-05 18:13:57.567679 | Running Ansible setup 2025-10-05 18:14:03.246318 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-05 18:14:04.292650 | 2025-10-05 18:14:04.292774 | PLAY [Base pre] 2025-10-05 18:14:04.339333 | 2025-10-05 18:14:04.339459 | TASK [Setup log path fact] 2025-10-05 18:14:04.377179 | debian-bookworm | ok 2025-10-05 18:14:04.419422 | 2025-10-05 18:14:04.419559 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-05 18:14:04.468436 | debian-bookworm | ok 2025-10-05 18:14:04.489749 | 2025-10-05 18:14:04.489859 | TASK [emit-job-header : Print job information] 2025-10-05 18:14:04.538302 | # Job Information 2025-10-05 18:14:04.538461 | Ansible Version: 2.16.14 2025-10-05 18:14:04.538495 | Job: cfg-generics-tox-test-stable-legacy 2025-10-05 18:14:04.538529 | Pipeline: check 2025-10-05 18:14:04.538552 | Executor: 521e9411259a 2025-10-05 18:14:04.538572 | Triggered by: https://github.com/osism/generics/pull/554 2025-10-05 18:14:04.538594 | Event ID: ecd493a0-a216-11f0-841c-0afa28862eb3 2025-10-05 18:14:04.551319 | 2025-10-05 18:14:04.551436 | LOOP [emit-job-header : Print node information] 2025-10-05 18:14:04.740699 | debian-bookworm | ok: 2025-10-05 18:14:04.740861 | debian-bookworm | # Node Information 2025-10-05 18:14:04.740895 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-05 18:14:04.740921 | debian-bookworm | Hostname: debian 2025-10-05 18:14:04.740943 | debian-bookworm | Username: zuul 2025-10-05 18:14:04.740965 | debian-bookworm | Distro: Debian 12.12 2025-10-05 18:14:04.740989 | debian-bookworm | Provider: regiocloud-a 2025-10-05 18:14:04.741022 | debian-bookworm | Region: 2025-10-05 18:14:04.741044 | debian-bookworm | Label: debian-bookworm 2025-10-05 18:14:04.741065 | debian-bookworm | Product Name: OpenStack Nova 2025-10-05 18:14:04.741085 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3b:b416 2025-10-05 18:14:04.761723 | 2025-10-05 18:14:04.761833 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-05 18:14:05.589706 | debian-bookworm -> localhost | changed 2025-10-05 18:14:05.595333 | 2025-10-05 18:14:05.595415 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-05 18:14:07.139322 | debian-bookworm -> localhost | changed 2025-10-05 18:14:07.147982 | 2025-10-05 18:14:07.148102 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-05 18:14:07.548882 | debian-bookworm -> localhost | ok 2025-10-05 18:14:07.554684 | 2025-10-05 18:14:07.554781 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-05 18:14:07.582709 | debian-bookworm | ok 2025-10-05 18:14:07.630607 | debian-bookworm | included: /var/lib/zuul/builds/0760e502ae7f46479d41127232824812/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-05 18:14:07.640059 | 2025-10-05 18:14:07.640155 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-05 18:14:09.718869 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-05 18:14:09.719050 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0760e502ae7f46479d41127232824812/work/0760e502ae7f46479d41127232824812_id_rsa 2025-10-05 18:14:09.719083 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0760e502ae7f46479d41127232824812/work/0760e502ae7f46479d41127232824812_id_rsa.pub 2025-10-05 18:14:09.719105 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-05 18:14:09.719126 | debian-bookworm -> localhost | SHA256:SiirUGf/Pxnf1b+hgfCOK07AWI2SrQTYyUsVRlu8lH0 zuul-build-sshkey 2025-10-05 18:14:09.719154 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-05 18:14:09.719172 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-05 18:14:09.719189 | debian-bookworm -> localhost | |.+ +=o.o | 2025-10-05 18:14:09.719206 | debian-bookworm -> localhost | |. *.oo* . E | 2025-10-05 18:14:09.719223 | debian-bookworm -> localhost | | . =.= o . | 2025-10-05 18:14:09.719239 | debian-bookworm -> localhost | | o *.. | 2025-10-05 18:14:09.719255 | debian-bookworm -> localhost | | oo+o. S. .| 2025-10-05 18:14:09.719274 | debian-bookworm -> localhost | | . = o.. + . o| 2025-10-05 18:14:09.719292 | debian-bookworm -> localhost | |. . o. * o o.| 2025-10-05 18:14:09.719308 | debian-bookworm -> localhost | |.. .o = . + o| 2025-10-05 18:14:09.719325 | debian-bookworm -> localhost | |. ..o+oo . ..| 2025-10-05 18:14:09.719341 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-05 18:14:09.719382 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.454892 2025-10-05 18:14:09.725155 | 2025-10-05 18:14:09.725233 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-05 18:14:09.761779 | debian-bookworm | ok 2025-10-05 18:14:09.768895 | debian-bookworm | included: /var/lib/zuul/builds/0760e502ae7f46479d41127232824812/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-05 18:14:09.793826 | 2025-10-05 18:14:09.793897 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-05 18:14:09.834681 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:14:09.839589 | 2025-10-05 18:14:09.839658 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-05 18:14:10.702156 | debian-bookworm | changed 2025-10-05 18:14:10.712534 | 2025-10-05 18:14:10.712607 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-05 18:14:10.966588 | debian-bookworm | ok 2025-10-05 18:14:10.971674 | 2025-10-05 18:14:10.971745 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-05 18:14:11.647981 | debian-bookworm | changed 2025-10-05 18:14:11.654044 | 2025-10-05 18:14:11.654126 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-05 18:14:12.236358 | debian-bookworm | changed 2025-10-05 18:14:12.242428 | 2025-10-05 18:14:12.242516 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-05 18:14:12.254965 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:14:12.260212 | 2025-10-05 18:14:12.260286 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-05 18:14:12.677942 | debian-bookworm -> localhost | changed 2025-10-05 18:14:12.687429 | 2025-10-05 18:14:12.687520 | TASK [add-build-sshkey : Add back temp key] 2025-10-05 18:14:13.011494 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0760e502ae7f46479d41127232824812/work/0760e502ae7f46479d41127232824812_id_rsa (zuul-build-sshkey) 2025-10-05 18:14:13.011738 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023995 2025-10-05 18:14:13.020555 | 2025-10-05 18:14:13.020652 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-05 18:14:13.423750 | debian-bookworm | ok 2025-10-05 18:14:13.428566 | 2025-10-05 18:14:13.428655 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-05 18:14:13.471133 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:14:13.481113 | 2025-10-05 18:14:13.481220 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-05 18:14:13.884927 | debian-bookworm | ok 2025-10-05 18:14:13.902991 | 2025-10-05 18:14:13.903111 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-05 18:14:13.941508 | debian-bookworm | ok 2025-10-05 18:14:13.946608 | 2025-10-05 18:14:13.946700 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-05 18:14:14.257475 | debian-bookworm -> localhost | ok 2025-10-05 18:14:14.263834 | 2025-10-05 18:14:14.263921 | TASK [validate-host : Collect information about the host] 2025-10-05 18:14:15.442398 | debian-bookworm | ok 2025-10-05 18:14:15.453630 | 2025-10-05 18:14:15.453735 | TASK [validate-host : Sanitize hostname] 2025-10-05 18:14:15.534014 | debian-bookworm | ok 2025-10-05 18:14:15.565266 | 2025-10-05 18:14:15.565364 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-05 18:14:16.206346 | debian-bookworm -> localhost | changed 2025-10-05 18:14:16.211909 | 2025-10-05 18:14:16.212010 | TASK [validate-host : Collect information about zuul worker] 2025-10-05 18:14:16.575608 | debian-bookworm | ok 2025-10-05 18:14:16.579802 | 2025-10-05 18:14:16.579878 | TASK [validate-host : Write out all zuul information for each host] 2025-10-05 18:14:17.295482 | debian-bookworm -> localhost | changed 2025-10-05 18:14:17.304666 | 2025-10-05 18:14:17.304748 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-05 18:14:17.556869 | debian-bookworm | ok 2025-10-05 18:14:17.561149 | 2025-10-05 18:14:17.561222 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-05 18:14:18.455212 | debian-bookworm | changed: 2025-10-05 18:14:18.455366 | debian-bookworm | cd+++++++++ src/ 2025-10-05 18:14:18.455394 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-05 18:14:18.455414 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-05 18:14:18.455431 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2025-10-05 18:14:18.455447 | debian-bookworm | =6.1 2025-10-05 18:14:40.452566 | debian-bookworm | Downloading cachetools-6.2.0-py3-none-any.whl (11 kB) 2025-10-05 18:14:40.482079 | debian-bookworm | Collecting chardet>=5.2 2025-10-05 18:14:40.494926 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-10-05 18:14:40.511804 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 14.2 MB/s eta 0:00:00 2025-10-05 18:14:40.546316 | debian-bookworm | Collecting colorama>=0.4.6 2025-10-05 18:14:40.554683 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-05 18:14:40.602634 | debian-bookworm | Collecting filelock>=3.18 2025-10-05 18:14:40.610258 | debian-bookworm | Downloading filelock-3.19.1-py3-none-any.whl (15 kB) 2025-10-05 18:14:40.656044 | debian-bookworm | Collecting packaging>=25 2025-10-05 18:14:40.663854 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-05 18:14:40.673164 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 8.8 MB/s eta 0:00:00 2025-10-05 18:14:40.716212 | debian-bookworm | Collecting platformdirs>=4.3.8 2025-10-05 18:14:40.724255 | debian-bookworm | Downloading platformdirs-4.4.0-py3-none-any.whl (18 kB) 2025-10-05 18:14:40.761666 | debian-bookworm | Collecting pluggy>=1.6 2025-10-05 18:14:40.769581 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-10-05 18:14:40.809582 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-10-05 18:14:40.822186 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-10-05 18:14:40.950861 | debian-bookworm | Collecting virtualenv>=20.31.2 2025-10-05 18:14:40.958563 | debian-bookworm | Downloading virtualenv-20.34.0-py3-none-any.whl (6.0 MB) 2025-10-05 18:14:41.220582 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 23.2 MB/s eta 0:00:00 2025-10-05 18:14:41.328526 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-10-05 18:14:41.336498 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-10-05 18:14:41.362386 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.6 MB/s eta 0:00:00 2025-10-05 18:14:41.515230 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-10-05 18:14:42.408489 | debian-bookworm | Successfully installed cachetools-6.2.0 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.19.1 packaging-25.0 platformdirs-4.4.0 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.30.3 virtualenv-20.34.0 2025-10-05 18:14:42.947824 | debian-bookworm | ok: Runtime: 0:00:02.812079 2025-10-05 18:14:42.954854 | 2025-10-05 18:14:42.954970 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-05 18:14:42.989015 | debian-bookworm | ok 2025-10-05 18:14:42.993828 | 2025-10-05 18:14:42.993934 | TASK [ensure-tox : Output tox version] 2025-10-05 18:14:43.553005 | 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-05 18:14:43.571123 | debian-bookworm | 4.30.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-05 18:14:44.046893 | debian-bookworm | ok: Runtime: 0:00:00.304483 2025-10-05 18:14:44.052736 | 2025-10-05 18:14:44.052841 | TASK [ensure-tox : Make global symlink] 2025-10-05 18:14:44.094330 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:14:44.101054 | 2025-10-05 18:14:44.101145 | PLAY RECAP 2025-10-05 18:14:44.101200 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-05 18:14:44.101224 | 2025-10-05 18:14:44.401238 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-10-05 18:14:44.402320 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-05 18:14:45.591490 | 2025-10-05 18:14:45.591610 | PLAY [all] 2025-10-05 18:14:45.612910 | 2025-10-05 18:14:45.613055 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-10-05 18:14:46.042459 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-05 18:14:46.148541 | debian-bookworm | ok: Runtime: 0:00:00.030349 2025-10-05 18:14:46.153806 | 2025-10-05 18:14:46.153909 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-10-05 18:14:46.679263 | debian-bookworm | ok: Runtime: 0:00:00.006574 2025-10-05 18:14:46.684797 | 2025-10-05 18:14:46.684889 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-10-05 18:14:46.957324 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-05 18:14:46.959002 | debian-bookworm | sudo: a password is required 2025-10-05 18:14:47.210296 | debian-bookworm | ok: Runtime: 0:00:00.017622 2025-10-05 18:14:47.228804 | 2025-10-05 18:14:47.228933 | TASK [tox : Check to see if the constraints file exists] 2025-10-05 18:14:47.252496 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:14:47.258947 | 2025-10-05 18:14:47.259076 | TASK [tox : Fail if constraints file is missing] 2025-10-05 18:14:47.281710 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:14:47.287206 | 2025-10-05 18:14:47.287292 | TASK [tox : Record file location] 2025-10-05 18:14:47.309827 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:14:47.315134 | 2025-10-05 18:14:47.315219 | TASK [tox : Install tox siblings] 2025-10-05 18:14:47.332892 | debian-bookworm | ok 2025-10-05 18:14:47.340446 | debian-bookworm | included: /var/lib/zuul/builds/0760e502ae7f46479d41127232824812/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-10-05 18:14:47.345615 | 2025-10-05 18:14:47.345696 | TASK [tox : Run tox without tests] 2025-10-05 18:14:47.836624 | debian-bookworm | ROOT: 184 D setup logging to DEBUG on pid 1421 [tox/report.py:222] 2025-10-05 18:14:47.865268 | debian-bookworm | test: 213 D created app data folder /home/zuul/.local/share/virtualenv [virtualenv/app_data/__init__.py:42] 2025-10-05 18:14:47.868138 | debian-bookworm | test: 216 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:77] 2025-10-05 18:14:47.869136 | debian-bookworm | test: 217 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/discovery/py_info.py yPWvMlbcT8tEoHqNHF0PapukEKFf1q6q EJZSKyvw3MICpcgREqfHYh1VIMOkjTZJ [virtualenv/discovery/cached_py_info.py:145] 2025-10-05 18:14:47.937921 | debian-bookworm | test: 286 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-05 18:14:47.938404 | debian-bookworm | test: 286 D filesystem is case-sensitive [virtualenv/discovery/info.py:20] 2025-10-05 18:14:47.938590 | debian-bookworm | test: 287 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:84] 2025-10-05 18:14:47.938696 | debian-bookworm | test: 287 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:86] 2025-10-05 18:14:47.939920 | debian-bookworm | test: 288 D symlink on filesystem does work [virtualenv/info.py:50] 2025-10-05 18:14:47.940048 | debian-bookworm | test: 288 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-10-05 18:14:47.968330 | debian-bookworm | test: 316 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/generics/.tox/test, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:52] 2025-10-05 18:14:47.968586 | debian-bookworm | test: 317 D create folder /home/zuul/src/github.com/osism/generics/.tox/test/bin [virtualenv/util/path/_sync.py:14] 2025-10-05 18:14:47.968727 | debian-bookworm | test: 317 D create folder /home/zuul/src/github.com/osism/generics/.tox/test/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:14] 2025-10-05 18:14:47.968924 | debian-bookworm | test: 317 D write /home/zuul/src/github.com/osism/generics/.tox/test/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-10-05 18:14:47.969008 | debian-bookworm | test: 317 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:47.969210 | debian-bookworm | test: 317 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:47.969258 | debian-bookworm | test: 317 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:47.969306 | debian-bookworm | test: 317 D virtualenv = 20.34.0 [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:47.969358 | debian-bookworm | test: 317 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:47.969418 | debian-bookworm | test: 317 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:47.969472 | debian-bookworm | test: 318 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:47.969541 | debian-bookworm | test: 318 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:47.969808 | debian-bookworm | test: 318 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/generics/.tox/test/bin/python [virtualenv/util/path/_sync.py:34] 2025-10-05 18:14:47.970124 | debian-bookworm | test: 318 D create virtualenv import hook file /home/zuul/src/github.com/osism/generics/.tox/test/lib/python3.11/site-packages/_virtualenv.pth [virtualenv/create/via_global_ref/api.py:98] 2025-10-05 18:14:47.970311 | debian-bookworm | test: 318 D create /home/zuul/src/github.com/osism/generics/.tox/test/lib/python3.11/site-packages/_virtualenv.py [virtualenv/create/via_global_ref/api.py:101] 2025-10-05 18:14:47.970713 | debian-bookworm | test: 319 D ============================== target debug ============================== [virtualenv/run/session.py:54] 2025-10-05 18:14:47.970947 | debian-bookworm | test: 319 D debug via /home/zuul/src/github.com/osism/generics/.tox/test/bin/python /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:215] 2025-10-05 18:14:48.005177 | debian-bookworm | test: 319 D { 2025-10-05 18:14:48.005214 | debian-bookworm | "sys": { 2025-10-05 18:14:48.005219 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/test/bin/python", 2025-10-05 18:14:48.005224 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2025-10-05 18:14:48.005229 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/test", 2025-10-05 18:14:48.005234 | debian-bookworm | "base_prefix": "/usr", 2025-10-05 18:14:48.005241 | debian-bookworm | "real_prefix": null, 2025-10-05 18:14:48.005245 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/test", 2025-10-05 18:14:48.005249 | debian-bookworm | "base_exec_prefix": "/usr", 2025-10-05 18:14:48.005254 | debian-bookworm | "path": [ 2025-10-05 18:14:48.005257 | debian-bookworm | "/usr/lib/python311.zip", 2025-10-05 18:14:48.005262 | debian-bookworm | "/usr/lib/python3.11", 2025-10-05 18:14:48.005267 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2025-10-05 18:14:48.005270 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/test/lib/python3.11/site-packages" 2025-10-05 18:14:48.005274 | debian-bookworm | ], 2025-10-05 18:14:48.005278 | debian-bookworm | "meta_path": [ 2025-10-05 18:14:48.005282 | debian-bookworm | "", 2025-10-05 18:14:48.005286 | debian-bookworm | "", 2025-10-05 18:14:48.005291 | debian-bookworm | "", 2025-10-05 18:14:48.005295 | debian-bookworm | "" 2025-10-05 18:14:48.005298 | debian-bookworm | ], 2025-10-05 18:14:48.005302 | debian-bookworm | "fs_encoding": "utf-8", 2025-10-05 18:14:48.005306 | debian-bookworm | "io_encoding": "utf-8" 2025-10-05 18:14:48.005310 | debian-bookworm | }, 2025-10-05 18:14:48.005314 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2025-10-05 18:14:48.005318 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2025-10-05 18:14:48.005322 | debian-bookworm | "os": "", 2025-10-05 18:14:48.005326 | debian-bookworm | "site": "", 2025-10-05 18:14:48.005330 | debian-bookworm | "datetime": "", 2025-10-05 18:14:48.005334 | debian-bookworm | "math": "", 2025-10-05 18:14:48.005337 | debian-bookworm | "json": "" 2025-10-05 18:14:48.005341 | debian-bookworm | } [virtualenv/run/session.py:55] 2025-10-05 18:14:48.005502 | debian-bookworm | test: 353 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-05 18:14:48.007761 | debian-bookworm | test: 356 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-05 18:14:48.008131 | debian-bookworm | test: 356 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-05 18:14:48.009928 | debian-bookworm | test: 358 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-05 18:14:48.010442 | debian-bookworm | test: 358 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-05 18:14:48.231655 | debian-bookworm | test: 580 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/test/lib/python3.11/site-packages/pip-25.2.virtualenv [virtualenv/util/path/_sync.py:42] 2025-10-05 18:14:48.232329 | debian-bookworm | test: 580 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/test/lib/python3.11/site-packages/pip [virtualenv/util/path/_sync.py:42] 2025-10-05 18:14:48.252744 | debian-bookworm | test: 601 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/test/lib/python3.11/site-packages/setuptools-80.9.0.dist-info [virtualenv/util/path/_sync.py:42] 2025-10-05 18:14:48.255899 | debian-bookworm | test: 604 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/test/lib/python3.11/site-packages/pkg_resources [virtualenv/util/path/_sync.py:42] 2025-10-05 18:14:48.263131 | debian-bookworm | test: 611 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/test/lib/python3.11/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:42] 2025-10-05 18:14:48.264185 | debian-bookworm | test: 612 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/test/lib/python3.11/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:42] 2025-10-05 18:14:48.264671 | debian-bookworm | test: 613 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/test/lib/python3.11/site-packages/setuptools [virtualenv/util/path/_sync.py:42] 2025-10-05 18:14:48.405349 | debian-bookworm | test: 753 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/test/lib/python3.11/site-packages/pip-25.2.dist-info [virtualenv/util/path/_sync.py:42] 2025-10-05 18:14:48.420480 | debian-bookworm | test: 768 D generated console scripts pip pip-3.11 pip3 pip3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-10-05 18:14:48.423349 | debian-bookworm | test: 771 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/test/lib/python3.11/site-packages/setuptools-80.9.0.virtualenv [virtualenv/util/path/_sync.py:42] 2025-10-05 18:14:48.423604 | debian-bookworm | test: 772 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-10-05 18:14:48.423903 | debian-bookworm | test: 772 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65] 2025-10-05 18:14:48.431124 | debian-bookworm | test: 779 D write /home/zuul/src/github.com/osism/generics/.tox/test/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-10-05 18:14:48.431254 | debian-bookworm | test: 779 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:48.431338 | debian-bookworm | test: 779 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:48.431417 | debian-bookworm | test: 779 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:48.431491 | debian-bookworm | test: 780 D virtualenv = 20.34.0 [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:48.431556 | debian-bookworm | test: 780 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:48.431664 | debian-bookworm | test: 780 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:48.431757 | debian-bookworm | test: 780 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:48.431864 | debian-bookworm | test: 780 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-10-05 18:14:48.438851 | debian-bookworm | test: 787 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:463] 2025-10-05 18:14:49.551972 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2025-10-05 18:14:49.612021 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2025-10-05 18:14:49.704504 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2025-10-05 18:14:49.713858 | 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-05 18:14:49.783874 | debian-bookworm | Collecting ansible==12.0.0 (from -r requirements.txt (line 3)) 2025-10-05 18:14:49.793417 | debian-bookworm | Downloading ansible-12.0.0-py3-none-any.whl.metadata (8.0 kB) 2025-10-05 18:14:49.828196 | debian-bookworm | Collecting packaging==25.0 (from -r requirements.txt (line 4)) 2025-10-05 18:14:49.844595 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl.metadata (3.3 kB) 2025-10-05 18:14:49.881035 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2025-10-05 18:14:49.902335 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2025-10-05 18:14:49.923162 | debian-bookworm | Installing build dependencies: started 2025-10-05 18:14:51.093351 | debian-bookworm | Installing build dependencies: finished with status 'done' 2025-10-05 18:14:51.094954 | debian-bookworm | Getting requirements to build wheel: started 2025-10-05 18:14:51.541249 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2025-10-05 18:14:51.543614 | debian-bookworm | Preparing metadata (pyproject.toml): started 2025-10-05 18:14:51.770838 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2025-10-05 18:14:51.808953 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2025-10-05 18:14:51.820586 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2025-10-05 18:14:51.877674 | debian-bookworm | Collecting requests==2.32.5 (from -r requirements.txt (line 7)) 2025-10-05 18:14:51.885685 | debian-bookworm | Downloading requests-2.32.5-py3-none-any.whl.metadata (4.9 kB) 2025-10-05 18:14:51.917308 | debian-bookworm | Collecting tabulate==0.9.0 (from -r requirements.txt (line 8)) 2025-10-05 18:14:51.927021 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl.metadata (34 kB) 2025-10-05 18:14:52.024556 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2025-10-05 18:14:52.033080 | 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-05 18:14:52.100430 | debian-bookworm | Collecting ansible-core~=2.19.1 (from ansible==12.0.0->-r requirements.txt (line 3)) 2025-10-05 18:14:52.114486 | debian-bookworm | Downloading ansible_core-2.19.2-py3-none-any.whl.metadata (7.7 kB) 2025-10-05 18:14:52.155173 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-10-05 18:14:52.163436 | debian-bookworm | Downloading click-8.3.0-py3-none-any.whl.metadata (2.6 kB) 2025-10-05 18:14:52.209720 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-10-05 18:14:52.218965 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-10-05 18:14:52.257387 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-10-05 18:14:52.267251 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2025-10-05 18:14:52.315208 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-10-05 18:14:52.326564 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2025-10-05 18:14:52.444995 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-10-05 18:14:52.454018 | debian-bookworm | Downloading charset_normalizer-3.4.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (36 kB) 2025-10-05 18:14:52.489488 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-10-05 18:14:52.498786 | debian-bookworm | Downloading idna-3.10-py3-none-any.whl.metadata (10 kB) 2025-10-05 18:14:52.546854 | debian-bookworm | Collecting urllib3<3,>=1.21.1 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-10-05 18:14:52.555770 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl.metadata (6.5 kB) 2025-10-05 18:14:52.596122 | debian-bookworm | Collecting certifi>=2017.4.17 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-10-05 18:14:52.604822 | debian-bookworm | Downloading certifi-2025.10.5-py3-none-any.whl.metadata (2.5 kB) 2025-10-05 18:14:52.907696 | debian-bookworm | Collecting cryptography (from ansible-core~=2.19.1->ansible==12.0.0->-r requirements.txt (line 3)) 2025-10-05 18:14:52.918409 | debian-bookworm | Downloading cryptography-46.0.2-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2025-10-05 18:14:52.958362 | debian-bookworm | Collecting resolvelib<2.0.0,>=0.5.3 (from ansible-core~=2.19.1->ansible==12.0.0->-r requirements.txt (line 3)) 2025-10-05 18:14:52.966337 | debian-bookworm | Downloading resolvelib-1.2.0-py3-none-any.whl.metadata (3.7 kB) 2025-10-05 18:14:53.124314 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core~=2.19.1->ansible==12.0.0->-r requirements.txt (line 3)) 2025-10-05 18:14:53.133333 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2025-10-05 18:14:53.227835 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core~=2.19.1->ansible==12.0.0->-r requirements.txt (line 3)) 2025-10-05 18:14:53.237121 | debian-bookworm | Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes) 2025-10-05 18:14:53.262830 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-10-05 18:14:53.286529 | 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-05 18:14:53.328874 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 21.9 MB/s 0:00:00 2025-10-05 18:14:53.343900 | debian-bookworm | Downloading ansible-12.0.0-py3-none-any.whl (51.8 MB) 2025-10-05 18:14:55.102675 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 51.8/51.8 MB 29.6 MB/s 0:00:01 2025-10-05 18:14:55.111726 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-05 18:14:55.134686 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2025-10-05 18:14:55.152318 | debian-bookworm | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2025-10-05 18:14:55.171839 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl (35 kB) 2025-10-05 18:14:55.197386 | debian-bookworm | Downloading ansible_core-2.19.2-py3-none-any.whl (2.4 MB) 2025-10-05 18:14:55.291866 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 26.4 MB/s 0:00:00 2025-10-05 18:14:55.304501 | debian-bookworm | Downloading charset_normalizer-3.4.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (150 kB) 2025-10-05 18:14:55.328160 | debian-bookworm | Downloading idna-3.10-py3-none-any.whl (70 kB) 2025-10-05 18:14:55.349776 | debian-bookworm | Downloading resolvelib-1.2.0-py3-none-any.whl (18 kB) 2025-10-05 18:14:55.369845 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl (129 kB) 2025-10-05 18:14:55.394546 | debian-bookworm | Downloading certifi-2025.10.5-py3-none-any.whl (163 kB) 2025-10-05 18:14:55.415690 | 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-05 18:14:55.434584 | debian-bookworm | Downloading click-8.3.0-py3-none-any.whl (107 kB) 2025-10-05 18:14:55.455939 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-05 18:14:55.476586 | debian-bookworm | Downloading cryptography-46.0.2-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2025-10-05 18:14:55.695862 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 20.6 MB/s 0:00:00 2025-10-05 18:14:55.705963 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2025-10-05 18:14:55.738667 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2025-10-05 18:14:55.758601 | debian-bookworm | Downloading pycparser-2.23-py3-none-any.whl (118 kB) 2025-10-05 18:14:55.787753 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2025-10-05 18:14:56.044081 | debian-bookworm | Building wheels for collected packages: pwgen 2025-10-05 18:14:56.045478 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2025-10-05 18:14:56.337264 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2025-10-05 18:14:56.338080 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3797 sha256=5308292e9a82ea325843ad1d6a77612f37af606c5a1cc9587d17463a5644bdc0 2025-10-05 18:14:56.338541 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2025-10-05 18:14:56.340642 | debian-bookworm | Successfully built pwgen 2025-10-05 18:14:56.551020 | debian-bookworm | Installing collected packages: pwgen, urllib3, tabulate, sh, resolvelib, PyYAML, pycparser, packaging, MarkupSafe, idna, fasteners, colorama, click, charset_normalizer, certifi, requests, python-gilt, Jinja2, cffi, cryptography, ansible-core, ansible 2025-10-05 18:15:19.659320 | debian-bookworm | 2025-10-05 18:15:19.661379 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-12.0.0 ansible-core-2.19.2 certifi-2025.10.5 cffi-2.0.0 charset_normalizer-3.4.3 click-8.3.0 colorama-0.4.6 cryptography-46.0.2 fasteners-0.20 idna-3.10 packaging-25.0 pwgen-0.8.2.post0 pycparser-2.23 python-gilt-1.2.3 requests-2.32.5 resolvelib-1.2.0 sh-2.2.2 tabulate-0.9.0 urllib3-2.5.0 2025-10-05 18:15:19.785536 | debian-bookworm | test: 32133 I exit 0 (31.34 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1434 [tox/execute/api.py:294] 2025-10-05 18:15:19.787421 | debian-bookworm | test: OK (31.93 seconds) 2025-10-05 18:15:19.787468 | debian-bookworm | congratulations :) (31.95 seconds) 2025-10-05 18:15:19.887529 | debian-bookworm | ok: Runtime: 0:00:32.195629 2025-10-05 18:15:19.901588 | 2025-10-05 18:15:19.901736 | TASK [tox : Create a tempfile to save tox showconfig] 2025-10-05 18:15:20.278443 | debian-bookworm | changed 2025-10-05 18:15:20.284645 | 2025-10-05 18:15:20.284757 | TASK [tox : Get tox envlist config] 2025-10-05 18:15:21.312933 | debian-bookworm | ok: Runtime: 0:00:00.343118 2025-10-05 18:15:21.322645 | 2025-10-05 18:15:21.322802 | TASK [tox : Install any sibling python packages] 2025-10-05 18:15:21.776542 | debian-bookworm | ok: No setup.cfg, no action needed 2025-10-05 18:15:21.785599 | 2025-10-05 18:15:21.785741 | TASK [tox : Remove tempfile] 2025-10-05 18:15:22.183801 | debian-bookworm | changed 2025-10-05 18:15:22.191632 | 2025-10-05 18:15:22.191754 | TASK [tox : Emit tox command] 2025-10-05 18:15:22.246203 | /home/zuul/.local/tox/bin/tox -etest -vv --skip-missing-interpreters=false 2025-10-05 18:15:22.254153 | 2025-10-05 18:15:22.254284 | TASK [tox : Run tox] 2025-10-05 18:15:22.778246 | debian-bookworm | ROOT: 171 D setup logging to DEBUG on pid 1589 [tox/report.py:222] 2025-10-05 18:15:22.809686 | debian-bookworm | test: 202 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:77] 2025-10-05 18:15:22.810516 | debian-bookworm | test: 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-05 18:15:22.811386 | debian-bookworm | test: 204 D filesystem is case-sensitive [virtualenv/discovery/info.py:20] 2025-10-05 18:15:22.811551 | debian-bookworm | test: 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:84] 2025-10-05 18:15:22.811621 | debian-bookworm | test: 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:86] 2025-10-05 18:15:22.812744 | debian-bookworm | test: 205 D symlink on filesystem does work [virtualenv/info.py:50] 2025-10-05 18:15:22.812894 | debian-bookworm | test: 205 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-10-05 18:15:22.842593 | debian-bookworm | test: 235 W commands[0]> python3 src/render-images.py [tox/tox_env/api.py:463] 2025-10-05 18:15:23.389112 | debian-bookworm | test: 782 I exit 0 (0.54 seconds) /home/zuul/src/github.com/osism/generics> python3 src/render-images.py pid=1596 [tox/execute/api.py:294] 2025-10-05 18:15:23.389459 | debian-bookworm | test: 782 W commands[1]> cat images.yml [tox/tox_env/api.py:463] 2025-10-05 18:15:23.394351 | debian-bookworm | --- 2025-10-05 18:15:23.394371 | debian-bookworm | # DO NOT EDIT THIS FILE BY HAND -- YOUR CHANGES WILL BE OVERWRITTEN 2025-10-05 18:15:23.394376 | debian-bookworm | 2025-10-05 18:15:23.394381 | debian-bookworm | adminer_tag: "5.1.0" 2025-10-05 18:15:23.394385 | debian-bookworm | adminer_image: "{{ docker_registry }}/library/adminer:{{ adminer_tag }}" 2025-10-05 18:15:23.394389 | debian-bookworm | 2025-10-05 18:15:23.394394 | debian-bookworm | ara_server_tag: "1.7.2" 2025-10-05 18:15:23.394398 | debian-bookworm | ara_server_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/ara-server:{{ ara_server_tag }}" 2025-10-05 18:15:23.394402 | debian-bookworm | 2025-10-05 18:15:23.394411 | debian-bookworm | ara_server_mariadb_tag: "11.7.2" 2025-10-05 18:15:23.394415 | debian-bookworm | ara_server_mariadb_image: "{{ docker_registry }}/library/mariadb:{{ ara_server_mariadb_tag }}" 2025-10-05 18:15:23.394419 | debian-bookworm | 2025-10-05 18:15:23.394423 | debian-bookworm | netbox_tag: "v4.2.2" 2025-10-05 18:15:23.394427 | debian-bookworm | netbox_image: "{{ docker_registry_netbox|default('quay.io') }}/osism/netbox:{{ netbox_tag }}" 2025-10-05 18:15:23.394431 | debian-bookworm | 2025-10-05 18:15:23.394434 | debian-bookworm | netbox_redis_tag: "7.4.2-alpine" 2025-10-05 18:15:23.394438 | debian-bookworm | netbox_redis_image: "{{ docker_registry }}/library/redis:{{ netbox_redis_tag }}" 2025-10-05 18:15:23.394442 | debian-bookworm | 2025-10-05 18:15:23.394446 | debian-bookworm | nginx_tag: "1.27.4-alpine" 2025-10-05 18:15:23.394450 | debian-bookworm | nginx_image: "{{ docker_registry }}/library/nginx:{{ nginx_tag }}" 2025-10-05 18:15:23.394454 | debian-bookworm | 2025-10-05 18:15:23.394457 | debian-bookworm | pgautoupgrade_tag: "16-alpine" 2025-10-05 18:15:23.394461 | debian-bookworm | pgautoupgrade_image: "{{ docker_registry }}/pgautoupgrade/pgautoupgrade:{{ pgautoupgrade_tag }}" 2025-10-05 18:15:23.394465 | debian-bookworm | 2025-10-05 18:15:23.394469 | debian-bookworm | phpmyadmin_tag: "5.2.2" 2025-10-05 18:15:23.394473 | debian-bookworm | phpmyadmin_image: "{{ docker_registry }}/phpmyadmin/phpmyadmin:{{ phpmyadmin_tag }}" 2025-10-05 18:15:23.394477 | debian-bookworm | 2025-10-05 18:15:23.394481 | debian-bookworm | postgres_tag: "16.8-alpine" 2025-10-05 18:15:23.395112 | debian-bookworm | postgres_image: "{{ docker_registry }}/library/postgres:{{ postgres_tag }}" 2025-10-05 18:15:23.395125 | debian-bookworm | 2025-10-05 18:15:23.395130 | debian-bookworm | manager_redis_tag: "7.4.2-alpine" 2025-10-05 18:15:23.395134 | debian-bookworm | manager_redis_image: "{{ docker_registry }}/library/redis:{{ manager_redis_tag }}" 2025-10-05 18:15:23.395138 | debian-bookworm | 2025-10-05 18:15:23.395142 | debian-bookworm | registry_tag: "3.0" 2025-10-05 18:15:23.395146 | debian-bookworm | registry_image: "{{ docker_registry }}/library/registry:{{ registry_tag }}" 2025-10-05 18:15:23.395150 | debian-bookworm | 2025-10-05 18:15:23.395163 | debian-bookworm | osism_ansible_tag: "0.20250408.0" 2025-10-05 18:15:23.395167 | debian-bookworm | osism_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/osism-ansible:{{ osism_ansible_tag }}" 2025-10-05 18:15:23.395171 | debian-bookworm | 2025-10-05 18:15:23.395175 | debian-bookworm | osism_kubernetes_tag: "0.20250408.0" 2025-10-05 18:15:23.395179 | debian-bookworm | osism_kubernetes_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/osism-kubernetes:{{ osism_kubernetes_tag }}" 2025-10-05 18:15:23.395183 | debian-bookworm | 2025-10-05 18:15:23.395187 | debian-bookworm | inventory_reconciler_tag: "0.20250408.0" 2025-10-05 18:15:23.395191 | debian-bookworm | inventory_reconciler_image: "{{ docker_registry_ansible }}/osism/inventory-reconciler:{{ inventory_reconciler_tag }}" 2025-10-05 18:15:23.395195 | debian-bookworm | 2025-10-05 18:15:23.395199 | debian-bookworm | osism_tag: "0.20250407.0" 2025-10-05 18:15:23.395202 | debian-bookworm | osism_image: "{{ docker_registry_ansible }}/osism/osism:{{ osism_tag }}" 2025-10-05 18:15:23.395206 | debian-bookworm | 2025-10-05 18:15:23.395210 | debian-bookworm | osism_frontend_tag: "0.20250407.0" 2025-10-05 18:15:23.395214 | debian-bookworm | osism_frontend_image: "{{ docker_registry_ansible }}/osism/osism-frontend:{{ osism_frontend_tag }}" 2025-10-05 18:15:23.395218 | debian-bookworm | 2025-10-05 18:15:23.395393 | debian-bookworm | osism_netbox_tag: "0.20250407.0" 2025-10-05 18:15:23.395399 | debian-bookworm | osism_netbox_image: "{{ docker_registry_ansible }}/osism/osism-netbox:{{ osism_netbox_tag }}" 2025-10-05 18:15:23.395403 | debian-bookworm | 2025-10-05 18:15:23.395407 | debian-bookworm | vault_tag: "1.19.1" 2025-10-05 18:15:23.395411 | debian-bookworm | vault_image: "{{ docker_registry }}/hashicorp/vault:{{ vault_tag }}" 2025-10-05 18:15:23.395415 | debian-bookworm | 2025-10-05 18:15:23.395419 | debian-bookworm | traefik_tag: "v3.3.5" 2025-10-05 18:15:23.395422 | debian-bookworm | traefik_image: "{{ docker_registry }}/library/traefik:{{ traefik_tag }}" 2025-10-05 18:15:23.395426 | debian-bookworm | 2025-10-05 18:15:23.395430 | debian-bookworm | ceph_ansible_tag: "{{ ceph_version|default(manager_version) }}" 2025-10-05 18:15:23.395434 | debian-bookworm | ceph_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/ceph-ansible:{{ ceph_ansible_tag }}" 2025-10-05 18:15:23.395438 | debian-bookworm | 2025-10-05 18:15:23.395441 | debian-bookworm | kolla_ansible_tag: "{{ openstack_version|default(manager_version) }}" 2025-10-05 18:15:23.395445 | debian-bookworm | kolla_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/kolla-ansible:{{ kolla_ansible_tag }}" 2025-10-05 18:15:23.396420 | debian-bookworm | test: 789 I exit 0 (0.01 seconds) /home/zuul/src/github.com/osism/generics> cat images.yml pid=1601 [tox/execute/api.py:294] 2025-10-05 18:15:23.397320 | debian-bookworm | test: OK (0.59=setup[0.04]+cmd[0.54,0.01] seconds) 2025-10-05 18:15:23.397332 | debian-bookworm | congratulations :) (0.62 seconds) 2025-10-05 18:15:23.816950 | debian-bookworm | ok: Runtime: 0:00:00.878928 2025-10-05 18:15:23.823456 | 2025-10-05 18:15:23.823567 | TASK [tox : Look for output] 2025-10-05 18:15:24.180598 | debian-bookworm | ok 2025-10-05 18:15:24.200906 | 2025-10-05 18:15:24.201056 | TASK [tox : Return file comments to Zuul] 2025-10-05 18:15:24.235209 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:24.242296 | 2025-10-05 18:15:24.242395 | PLAY RECAP 2025-10-05 18:15:24.242450 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-05 18:15:24.242473 | 2025-10-05 18:15:24.404681 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-05 18:15:24.405800 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-05 18:15:25.150250 | 2025-10-05 18:15:25.150412 | PLAY [all] 2025-10-05 18:15:25.169545 | 2025-10-05 18:15:25.169718 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-10-05 18:15:25.224532 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:25.230391 | 2025-10-05 18:15:25.230543 | TASK [fetch-tox-output : Set tox log path for single node] 2025-10-05 18:15:25.269477 | debian-bookworm | ok 2025-10-05 18:15:25.275240 | 2025-10-05 18:15:25.275346 | TASK [fetch-tox-output : Ensure local tox dir] 2025-10-05 18:15:25.718779 | debian-bookworm -> localhost | changed 2025-10-05 18:15:25.733197 | 2025-10-05 18:15:25.733343 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-10-05 18:15:25.787736 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:25.794903 | 2025-10-05 18:15:25.795076 | TASK [fetch-tox-output : Set envlist fact] 2025-10-05 18:15:25.825114 | debian-bookworm | ok 2025-10-05 18:15:25.832490 | 2025-10-05 18:15:25.832608 | TASK [fetch-tox-output : Get tox version] 2025-10-05 18:15:26.460253 | 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-05 18:15:26.477545 | debian-bookworm | 4.30.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-05 18:15:26.863644 | debian-bookworm | ok: Runtime: 0:00:00.258983 2025-10-05 18:15:26.879060 | 2025-10-05 18:15:26.879187 | TASK [fetch-tox-output : Find all default environments] 2025-10-05 18:15:27.406495 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:27.413920 | 2025-10-05 18:15:27.414105 | TASK [fetch-tox-output : Set envlist fact] 2025-10-05 18:15:27.440175 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:27.446468 | 2025-10-05 18:15:27.446585 | TASK [fetch-tox-output : Find all default environments] 2025-10-05 18:15:27.976844 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:28.007411 | 2025-10-05 18:15:28.007569 | TASK [fetch-tox-output : Set envlist fact] 2025-10-05 18:15:28.042601 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:28.053243 | 2025-10-05 18:15:28.053403 | LOOP [fetch-tox-output : Copy tox logs] 2025-10-05 18:15:28.127884 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:28.139534 | 2025-10-05 18:15:28.139661 | LOOP [fetch-tox-output : Collect tox logs] 2025-10-05 18:15:28.932989 | debian-bookworm | changed: 2025-10-05 18:15:28.933212 | debian-bookworm | created directory /var/lib/zuul/builds/0760e502ae7f46479d41127232824812/work/logs/tox/test 2025-10-05 18:15:28.933256 | debian-bookworm | cd+++++++++ ./ 2025-10-05 18:15:28.933287 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-10-05 18:15:28.933317 | debian-bookworm | >f+++++++++ 2-commands[1].log 2025-10-05 18:15:28.933351 | 2025-10-05 18:15:28.952771 | 2025-10-05 18:15:28.952886 | PLAY RECAP 2025-10-05 18:15:28.952949 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-05 18:15:28.953028 | 2025-10-05 18:15:29.116715 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-05 18:15:29.117782 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-05 18:15:29.883560 | 2025-10-05 18:15:29.883730 | PLAY [all] 2025-10-05 18:15:29.901332 | 2025-10-05 18:15:29.901493 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-10-05 18:15:30.130544 | debian-bookworm | changed: non-zero return code 2025-10-05 18:15:30.137023 | 2025-10-05 18:15:30.137168 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-10-05 18:15:30.161344 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:30.167131 | 2025-10-05 18:15:30.167272 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-10-05 18:15:30.198346 | 2025-10-05 18:15:30.198540 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-10-05 18:15:30.229668 | 2025-10-05 18:15:30.229864 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-10-05 18:15:30.253592 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:30.259630 | 2025-10-05 18:15:30.259748 | LOOP [fetch-subunit-output : Generate subunit file] 2025-10-05 18:15:30.288748 | 2025-10-05 18:15:30.288946 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-10-05 18:15:30.312498 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:30.318538 | 2025-10-05 18:15:30.318680 | TASK [fetch-subunit-output : Remove the temporary file] 2025-10-05 18:15:30.352488 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:30.359350 | 2025-10-05 18:15:30.359494 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-10-05 18:15:30.385354 | debian-bookworm | skipping: Conditional result was False 2025-10-05 18:15:30.392096 | 2025-10-05 18:15:30.392198 | PLAY RECAP 2025-10-05 18:15:30.392250 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-05 18:15:30.392276 | 2025-10-05 18:15:30.527212 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-05 18:15:30.528332 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-05 18:15:31.283013 | 2025-10-05 18:15:31.283194 | PLAY [Base post] 2025-10-05 18:15:31.296617 | 2025-10-05 18:15:31.296753 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-05 18:15:31.878615 | debian-bookworm | changed 2025-10-05 18:15:31.884954 | 2025-10-05 18:15:31.885108 | PLAY RECAP 2025-10-05 18:15:31.885172 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-05 18:15:31.885234 | 2025-10-05 18:15:32.007020 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-05 18:15:32.008069 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-05 18:15:32.800778 | 2025-10-05 18:15:32.800937 | PLAY [Base post-logs] 2025-10-05 18:15:32.817581 | 2025-10-05 18:15:32.817735 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-05 18:15:33.290585 | localhost | changed 2025-10-05 18:15:33.301048 | 2025-10-05 18:15:33.301201 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-05 18:15:33.326502 | localhost | ok 2025-10-05 18:15:33.329601 | 2025-10-05 18:15:33.329698 | TASK [Set zuul-log-path fact] 2025-10-05 18:15:33.344197 | localhost | ok 2025-10-05 18:15:33.352007 | 2025-10-05 18:15:33.352118 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-05 18:15:33.387159 | localhost | ok 2025-10-05 18:15:33.390280 | 2025-10-05 18:15:33.390384 | TASK [upload-logs : Create log directories] 2025-10-05 18:15:33.857857 | localhost | changed 2025-10-05 18:15:33.860694 | 2025-10-05 18:15:33.860802 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-05 18:15:34.443062 | localhost -> localhost | ok: Runtime: 0:00:00.003991 2025-10-05 18:15:34.450624 | 2025-10-05 18:15:34.450790 | TASK [upload-logs : Upload logs to log server] 2025-10-05 18:15:34.985323 | localhost | Output suppressed because no_log was given 2025-10-05 18:15:34.988740 | 2025-10-05 18:15:34.988885 | LOOP [upload-logs : Compress console log and json output] 2025-10-05 18:15:35.032386 | localhost | skipping: Conditional result was False 2025-10-05 18:15:35.037046 | localhost | skipping: Conditional result was False 2025-10-05 18:15:35.045613 | 2025-10-05 18:15:35.046147 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-05 18:15:35.090277 | localhost | skipping: Conditional result was False 2025-10-05 18:15:35.090512 | 2025-10-05 18:15:35.095593 | localhost | skipping: Conditional result was False 2025-10-05 18:15:35.101149 | 2025-10-05 18:15:35.101237 | LOOP [upload-logs : Upload console log and json output]