2025-07-09 19:30:16.069185 | Job console starting 2025-07-09 19:30:16.103393 | Updating git repos 2025-07-09 19:30:16.191447 | Cloning repos into workspace 2025-07-09 19:30:16.279534 | Restoring repo states 2025-07-09 19:30:16.304834 | Merging changes 2025-07-09 19:30:16.858474 | Checking out repos 2025-07-09 19:30:16.958146 | Preparing playbooks 2025-07-09 19:30:17.815391 | Running Ansible setup 2025-07-09 19:30:26.693837 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-09 19:30:28.515426 | 2025-07-09 19:30:28.515541 | PLAY [Base pre] 2025-07-09 19:30:28.604704 | 2025-07-09 19:30:28.604822 | TASK [Setup log path fact] 2025-07-09 19:30:28.685022 | debian-bookworm | ok 2025-07-09 19:30:28.754153 | 2025-07-09 19:30:28.756493 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-09 19:30:28.861701 | debian-bookworm | ok 2025-07-09 19:30:28.884606 | 2025-07-09 19:30:28.884707 | TASK [emit-job-header : Print job information] 2025-07-09 19:30:28.956963 | # Job Information 2025-07-09 19:30:28.957129 | Ansible Version: 2.16.14 2025-07-09 19:30:28.957159 | Job: cfg-generics-tox-test-latest 2025-07-09 19:30:28.957186 | Pipeline: check 2025-07-09 19:30:28.957205 | Executor: 521e9411259a 2025-07-09 19:30:28.957222 | Triggered by: https://github.com/osism/cfg-generics/pull/548 2025-07-09 19:30:28.957321 | Event ID: 18592f10-5cfb-11f0-9ee6-7dbfff339466 2025-07-09 19:30:28.963645 | 2025-07-09 19:30:28.963922 | LOOP [emit-job-header : Print node information] 2025-07-09 19:30:29.376129 | debian-bookworm | ok: 2025-07-09 19:30:29.377174 | debian-bookworm | # Node Information 2025-07-09 19:30:29.377653 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-09 19:30:29.377965 | debian-bookworm | Hostname: debian 2025-07-09 19:30:29.378285 | debian-bookworm | Username: zuul 2025-07-09 19:30:29.378469 | debian-bookworm | Distro: Debian 12.11 2025-07-09 19:30:29.378767 | debian-bookworm | Provider: regiocloud-a 2025-07-09 19:30:29.379112 | debian-bookworm | Region: 2025-07-09 19:30:29.379342 | debian-bookworm | Label: debian-bookworm 2025-07-09 19:30:29.379663 | debian-bookworm | Product Name: OpenStack Nova 2025-07-09 19:30:29.379842 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefc:c425 2025-07-09 19:30:29.400026 | 2025-07-09 19:30:29.400113 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-09 19:30:30.784481 | debian-bookworm -> localhost | changed 2025-07-09 19:30:30.791604 | 2025-07-09 19:30:30.791703 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-09 19:30:32.937488 | debian-bookworm -> localhost | changed 2025-07-09 19:30:32.954427 | 2025-07-09 19:30:32.954559 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-09 19:30:33.544660 | debian-bookworm -> localhost | ok 2025-07-09 19:30:33.550498 | 2025-07-09 19:30:33.550595 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-09 19:30:33.590582 | debian-bookworm | ok 2025-07-09 19:30:33.660669 | debian-bookworm | included: /var/lib/zuul/builds/39f5382707fa4b039ccd3d4a27ccbe3b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-09 19:30:33.717504 | 2025-07-09 19:30:33.717612 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-09 19:30:36.445646 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-09 19:30:36.445834 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/39f5382707fa4b039ccd3d4a27ccbe3b/work/39f5382707fa4b039ccd3d4a27ccbe3b_id_rsa 2025-07-09 19:30:36.445874 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/39f5382707fa4b039ccd3d4a27ccbe3b/work/39f5382707fa4b039ccd3d4a27ccbe3b_id_rsa.pub 2025-07-09 19:30:36.445901 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-09 19:30:36.445928 | debian-bookworm -> localhost | SHA256:/092y7OBn8Tw8wjntso+58EFLBRnTXjXY36mTv+26Ok zuul-build-sshkey 2025-07-09 19:30:36.445951 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-09 19:30:36.445981 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-09 19:30:36.446003 | debian-bookworm -> localhost | | o.o+o| 2025-07-09 19:30:36.446025 | debian-bookworm -> localhost | | . +.o=| 2025-07-09 19:30:36.446046 | debian-bookworm -> localhost | | . =.o| 2025-07-09 19:30:36.446066 | debian-bookworm -> localhost | | . oo| 2025-07-09 19:30:36.446086 | debian-bookworm -> localhost | | S . oo| 2025-07-09 19:30:36.446111 | debian-bookworm -> localhost | | . .B. | 2025-07-09 19:30:36.446132 | debian-bookworm -> localhost | | . .+*B.| 2025-07-09 19:30:36.446152 | debian-bookworm -> localhost | | o.*X=O| 2025-07-09 19:30:36.446174 | debian-bookworm -> localhost | | .BE*XB| 2025-07-09 19:30:36.446194 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-09 19:30:36.446253 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.803776 2025-07-09 19:30:36.455592 | 2025-07-09 19:30:36.455703 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-09 19:30:36.474442 | debian-bookworm | ok 2025-07-09 19:30:36.490703 | debian-bookworm | included: /var/lib/zuul/builds/39f5382707fa4b039ccd3d4a27ccbe3b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-09 19:30:36.499505 | 2025-07-09 19:30:36.499602 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-09 19:30:36.522723 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:30:36.528356 | 2025-07-09 19:30:36.528452 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-09 19:30:37.179262 | debian-bookworm | changed 2025-07-09 19:30:37.191097 | 2025-07-09 19:30:37.191204 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-09 19:30:37.455269 | debian-bookworm | ok 2025-07-09 19:30:37.461344 | 2025-07-09 19:30:37.461452 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-09 19:30:38.131999 | debian-bookworm | changed 2025-07-09 19:30:38.138553 | 2025-07-09 19:30:38.138654 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-09 19:30:38.791307 | debian-bookworm | changed 2025-07-09 19:30:38.805751 | 2025-07-09 19:30:38.805848 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-09 19:30:38.839054 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:30:38.846285 | 2025-07-09 19:30:38.846395 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-09 19:30:39.469480 | debian-bookworm -> localhost | changed 2025-07-09 19:30:39.480182 | 2025-07-09 19:30:39.480309 | TASK [add-build-sshkey : Add back temp key] 2025-07-09 19:30:39.957865 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/39f5382707fa4b039ccd3d4a27ccbe3b/work/39f5382707fa4b039ccd3d4a27ccbe3b_id_rsa (zuul-build-sshkey) 2025-07-09 19:30:39.958067 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015132 2025-07-09 19:30:39.965607 | 2025-07-09 19:30:39.965709 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-09 19:30:40.347463 | debian-bookworm | ok 2025-07-09 19:30:40.352322 | 2025-07-09 19:30:40.352423 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-09 19:30:40.385596 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:30:40.396060 | 2025-07-09 19:30:40.396157 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-09 19:30:40.809520 | debian-bookworm | ok 2025-07-09 19:30:40.832425 | 2025-07-09 19:30:40.832654 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-09 19:30:40.876149 | debian-bookworm | ok 2025-07-09 19:30:40.881393 | 2025-07-09 19:30:40.881498 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-09 19:30:41.328645 | debian-bookworm -> localhost | ok 2025-07-09 19:30:41.335858 | 2025-07-09 19:30:41.335962 | TASK [validate-host : Collect information about the host] 2025-07-09 19:30:42.492563 | debian-bookworm | ok 2025-07-09 19:30:42.509518 | 2025-07-09 19:30:42.509611 | TASK [validate-host : Sanitize hostname] 2025-07-09 19:30:42.610104 | debian-bookworm | ok 2025-07-09 19:30:42.647998 | 2025-07-09 19:30:42.648102 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-09 19:30:43.295576 | debian-bookworm -> localhost | changed 2025-07-09 19:30:43.300841 | 2025-07-09 19:30:43.300931 | TASK [validate-host : Collect information about zuul worker] 2025-07-09 19:30:43.728836 | debian-bookworm | ok 2025-07-09 19:30:43.733472 | 2025-07-09 19:30:43.733578 | TASK [validate-host : Write out all zuul information for each host] 2025-07-09 19:30:44.454159 | debian-bookworm -> localhost | changed 2025-07-09 19:30:44.476623 | 2025-07-09 19:30:44.476729 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-09 19:30:44.798573 | debian-bookworm | ok 2025-07-09 19:30:44.803667 | 2025-07-09 19:30:44.803754 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-09 19:30:45.585809 | debian-bookworm | changed: 2025-07-09 19:30:45.586030 | debian-bookworm | cd+++++++++ src/ 2025-07-09 19:30:45.586081 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-09 19:30:45.586116 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-09 19:30:45.586147 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-generics/ 2025-07-09 19:30:45.586176 | debian-bookworm | =5.5.1 2025-07-09 19:31:08.488807 | debian-bookworm | Downloading cachetools-6.1.0-py3-none-any.whl (11 kB) 2025-07-09 19:31:08.548248 | debian-bookworm | Collecting chardet>=5.2 2025-07-09 19:31:08.556396 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-07-09 19:31:08.579208 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.5 MB/s eta 0:00:00 2025-07-09 19:31:08.662454 | debian-bookworm | Collecting colorama>=0.4.6 2025-07-09 19:31:08.672478 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-07-09 19:31:08.739288 | debian-bookworm | Collecting filelock>=3.16.1 2025-07-09 19:31:08.747640 | debian-bookworm | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-07-09 19:31:08.798104 | debian-bookworm | Collecting packaging>=24.2 2025-07-09 19:31:08.808866 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-07-09 19:31:08.821496 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 6.0 MB/s eta 0:00:00 2025-07-09 19:31:08.880342 | debian-bookworm | Collecting platformdirs>=4.3.6 2025-07-09 19:31:08.889023 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-07-09 19:31:08.928887 | debian-bookworm | Collecting pluggy>=1.5 2025-07-09 19:31:08.937709 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-07-09 19:31:09.017833 | debian-bookworm | Collecting pyproject-api>=1.8 2025-07-09 19:31:09.033143 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-07-09 19:31:09.206798 | debian-bookworm | Collecting virtualenv>=20.31 2025-07-09 19:31:09.215443 | debian-bookworm | Downloading virtualenv-20.31.2-py3-none-any.whl (6.1 MB) 2025-07-09 19:31:09.479155 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.1/6.1 MB 23.4 MB/s eta 0:00:00 2025-07-09 19:31:09.599488 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-07-09 19:31:09.611176 | debian-bookworm | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-07-09 19:31:09.633669 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 23.5 MB/s eta 0:00:00 2025-07-09 19:31:09.797909 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-07-09 19:31:10.596553 | debian-bookworm | Successfully installed cachetools-6.1.0 chardet-5.2.0 colorama-0.4.6 distlib-0.3.9 filelock-3.18.0 packaging-25.0 platformdirs-4.3.8 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.27.0 virtualenv-20.31.2 2025-07-09 19:31:10.899420 | debian-bookworm | ok: Runtime: 0:00:03.075501 2025-07-09 19:31:10.905668 | 2025-07-09 19:31:10.905784 | TASK [ensure-tox : Export installed tox_executable path] 2025-07-09 19:31:10.967315 | debian-bookworm | ok 2025-07-09 19:31:10.977559 | 2025-07-09 19:31:10.977698 | TASK [ensure-tox : Output tox version] 2025-07-09 19:31:11.535573 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-07-09 19:31:11.554240 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-07-09 19:31:12.036888 | debian-bookworm | ok: Runtime: 0:00:00.306342 2025-07-09 19:31:12.042737 | 2025-07-09 19:31:12.042873 | TASK [ensure-tox : Make global symlink] 2025-07-09 19:31:12.067400 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:31:12.075517 | 2025-07-09 19:31:12.075626 | PLAY RECAP 2025-07-09 19:31:12.075681 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-07-09 19:31:12.075704 | 2025-07-09 19:31:12.277130 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-07-09 19:31:12.278359 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-07-09 19:31:13.292800 | 2025-07-09 19:31:13.292973 | PLAY [all] 2025-07-09 19:31:13.330754 | 2025-07-09 19:31:13.330956 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-07-09 19:31:13.831319 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-07-09 19:31:13.873501 | debian-bookworm | ok: Runtime: 0:00:00.023886 2025-07-09 19:31:13.883541 | 2025-07-09 19:31:13.884738 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-07-09 19:31:14.435398 | debian-bookworm | ok: Runtime: 0:00:00.007150 2025-07-09 19:31:14.449461 | 2025-07-09 19:31:14.449647 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-07-09 19:31:14.746569 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-07-09 19:31:14.746715 | debian-bookworm | sudo: a password is required 2025-07-09 19:31:14.987510 | debian-bookworm | ok: Runtime: 0:00:00.017059 2025-07-09 19:31:15.007325 | 2025-07-09 19:31:15.007490 | TASK [tox : Check to see if the constraints file exists] 2025-07-09 19:31:15.042406 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:31:15.048873 | 2025-07-09 19:31:15.049007 | TASK [tox : Fail if constraints file is missing] 2025-07-09 19:31:15.083485 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:31:15.094082 | 2025-07-09 19:31:15.094283 | TASK [tox : Record file location] 2025-07-09 19:31:15.129209 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:31:15.140680 | 2025-07-09 19:31:15.140864 | TASK [tox : Install tox siblings] 2025-07-09 19:31:15.179847 | debian-bookworm | ok 2025-07-09 19:31:15.191799 | debian-bookworm | included: /var/lib/zuul/builds/39f5382707fa4b039ccd3d4a27ccbe3b/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-07-09 19:31:15.198756 | 2025-07-09 19:31:15.198934 | TASK [tox : Run tox without tests] 2025-07-09 19:31:15.671823 | debian-bookworm | ROOT: 144 D setup logging to DEBUG on pid 1449 [tox/report.py:222] 2025-07-09 19:31:15.746799 | debian-bookworm | test: 219 D created app data folder /home/zuul/.local/share/virtualenv [virtualenv/app_data/__init__.py:42] 2025-07-09 19:31:15.749704 | debian-bookworm | test: 222 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:76] 2025-07-09 19:31:15.750640 | debian-bookworm | test: 223 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/discovery/py_info.py eXcbrBguzhkVSxxzALELMfuaayONjkZO rdy3g2CJPksCUNSvquwU5emybxHixIlW [virtualenv/discovery/cached_py_info.py:117] 2025-07-09 19:31:15.824198 | debian-bookworm | test: 296 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-07-09 19:31:15.824968 | debian-bookworm | test: 297 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-07-09 19:31:15.825289 | debian-bookworm | test: 298 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:83] 2025-07-09 19:31:15.825480 | debian-bookworm | test: 298 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:85] 2025-07-09 19:31:15.860105 | debian-bookworm | test: 332 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/cfg-generics/.tox/test, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:52] 2025-07-09 19:31:15.860356 | debian-bookworm | test: 333 D create folder /home/zuul/src/github.com/osism/cfg-generics/.tox/test/bin [virtualenv/util/path/_sync.py:14] 2025-07-09 19:31:15.860533 | debian-bookworm | test: 333 D create folder /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:14] 2025-07-09 19:31:15.860764 | debian-bookworm | test: 333 D write /home/zuul/src/github.com/osism/cfg-generics/.tox/test/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-07-09 19:31:15.860835 | debian-bookworm | test: 333 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:15.860890 | debian-bookworm | test: 333 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:15.860940 | debian-bookworm | test: 333 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:15.860988 | debian-bookworm | test: 334 D virtualenv = 20.31.2 [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:15.861034 | debian-bookworm | test: 334 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:15.861091 | debian-bookworm | test: 334 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:15.861148 | debian-bookworm | test: 334 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:15.861215 | debian-bookworm | test: 334 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:15.861496 | debian-bookworm | test: 334 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/cfg-generics/.tox/test/bin/python [virtualenv/util/path/_sync.py:34] 2025-07-09 19:31:15.861855 | debian-bookworm | test: 334 D create virtualenv import hook file /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/_virtualenv.pth [virtualenv/create/via_global_ref/api.py:93] 2025-07-09 19:31:15.861994 | debian-bookworm | test: 334 D create /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/_virtualenv.py [virtualenv/create/via_global_ref/api.py:96] 2025-07-09 19:31:15.862384 | debian-bookworm | test: 335 D ============================== target debug ============================== [virtualenv/run/session.py:54] 2025-07-09 19:31:15.862704 | debian-bookworm | test: 335 D debug via /home/zuul/src/github.com/osism/cfg-generics/.tox/test/bin/python /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:215] 2025-07-09 19:31:15.910966 | debian-bookworm | test: 335 D { 2025-07-09 19:31:15.911027 | debian-bookworm | "sys": { 2025-07-09 19:31:15.911033 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/cfg-generics/.tox/test/bin/python", 2025-07-09 19:31:15.911039 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2025-07-09 19:31:15.911045 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/cfg-generics/.tox/test", 2025-07-09 19:31:15.911050 | debian-bookworm | "base_prefix": "/usr", 2025-07-09 19:31:15.911056 | debian-bookworm | "real_prefix": null, 2025-07-09 19:31:15.911061 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/cfg-generics/.tox/test", 2025-07-09 19:31:15.911067 | debian-bookworm | "base_exec_prefix": "/usr", 2025-07-09 19:31:15.911071 | debian-bookworm | "path": [ 2025-07-09 19:31:15.911077 | debian-bookworm | "/usr/lib/python311.zip", 2025-07-09 19:31:15.911081 | debian-bookworm | "/usr/lib/python3.11", 2025-07-09 19:31:15.911085 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2025-07-09 19:31:15.911090 | debian-bookworm | "/home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages" 2025-07-09 19:31:15.911094 | debian-bookworm | ], 2025-07-09 19:31:15.911099 | debian-bookworm | "meta_path": [ 2025-07-09 19:31:15.911103 | debian-bookworm | "", 2025-07-09 19:31:15.911107 | debian-bookworm | "", 2025-07-09 19:31:15.911112 | debian-bookworm | "", 2025-07-09 19:31:15.911117 | debian-bookworm | "" 2025-07-09 19:31:15.911121 | debian-bookworm | ], 2025-07-09 19:31:15.911125 | debian-bookworm | "fs_encoding": "utf-8", 2025-07-09 19:31:15.911129 | debian-bookworm | "io_encoding": "utf-8" 2025-07-09 19:31:15.911134 | debian-bookworm | }, 2025-07-09 19:31:15.911138 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2025-07-09 19:31:15.911142 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2025-07-09 19:31:15.911147 | debian-bookworm | "os": "", 2025-07-09 19:31:15.911151 | debian-bookworm | "site": "", 2025-07-09 19:31:15.911155 | debian-bookworm | "datetime": "", 2025-07-09 19:31:15.911160 | debian-bookworm | "math": "", 2025-07-09 19:31:15.911164 | debian-bookworm | "json": "" 2025-07-09 19:31:15.911168 | debian-bookworm | } [virtualenv/run/session.py:55] 2025-07-09 19:31:15.911397 | debian-bookworm | test: 384 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-07-09 19:31:15.913365 | debian-bookworm | test: 386 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-25.1.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51] 2025-07-09 19:31:15.914646 | debian-bookworm | test: 387 D build install image for pip-25.1.1-py3-none-any.whl to /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.1.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2025-07-09 19:31:15.918192 | debian-bookworm | test: 390 D install setuptools from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/setuptools-80.3.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51] 2025-07-09 19:31:15.920948 | debian-bookworm | test: 393 D build install image for setuptools-80.3.1-py3-none-any.whl to /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.3.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2025-07-09 19:31:16.131247 | debian-bookworm | test: 604 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.1.1-py3-none-any/pip to /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/pip [virtualenv/util/path/_sync.py:42] 2025-07-09 19:31:16.197580 | debian-bookworm | test: 670 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.3.1-py3-none-any/distutils-precedence.pth to /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:42] 2025-07-09 19:31:16.198186 | debian-bookworm | test: 671 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.3.1-py3-none-any/setuptools to /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/setuptools [virtualenv/util/path/_sync.py:42] 2025-07-09 19:31:16.328383 | debian-bookworm | test: 801 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.1.1-py3-none-any/pip-25.1.1.dist-info to /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/pip-25.1.1.dist-info [virtualenv/util/path/_sync.py:42] 2025-07-09 19:31:16.332887 | debian-bookworm | test: 805 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.1.1-py3-none-any/pip-25.1.1.virtualenv to /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/pip-25.1.1.virtualenv [virtualenv/util/path/_sync.py:42] 2025-07-09 19:31:16.334866 | debian-bookworm | test: 807 D generated console scripts pip3 pip pip-3.11 pip3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-07-09 19:31:16.347685 | debian-bookworm | test: 820 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.3.1-py3-none-any/setuptools-80.3.1.virtualenv to /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/setuptools-80.3.1.virtualenv [virtualenv/util/path/_sync.py:42] 2025-07-09 19:31:16.347977 | debian-bookworm | test: 820 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.3.1-py3-none-any/setuptools-80.3.1.dist-info to /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/setuptools-80.3.1.dist-info [virtualenv/util/path/_sync.py:42] 2025-07-09 19:31:16.348800 | debian-bookworm | test: 821 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.3.1-py3-none-any/pkg_resources to /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/pkg_resources [virtualenv/util/path/_sync.py:42] 2025-07-09 19:31:16.351270 | debian-bookworm | test: 824 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.3.1-py3-none-any/_distutils_hack to /home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:42] 2025-07-09 19:31:16.351753 | debian-bookworm | test: 824 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-07-09 19:31:16.352397 | debian-bookworm | test: 825 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65] 2025-07-09 19:31:16.358186 | debian-bookworm | test: 831 D write /home/zuul/src/github.com/osism/cfg-generics/.tox/test/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-07-09 19:31:16.358305 | debian-bookworm | test: 831 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:16.358381 | debian-bookworm | test: 831 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:16.358523 | debian-bookworm | test: 831 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:16.358591 | debian-bookworm | test: 831 D virtualenv = 20.31.2 [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:16.358652 | debian-bookworm | test: 831 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:16.358734 | debian-bookworm | test: 831 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:16.358804 | debian-bookworm | test: 831 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:16.358884 | debian-bookworm | test: 831 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-07-09 19:31:16.363787 | debian-bookworm | test: 836 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:459] 2025-07-09 19:31:17.487735 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2025-07-09 19:31:17.554986 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2025-07-09 19:31:17.653782 | debian-bookworm | Collecting PyYAML==6.0.2 (from -r requirements.txt (line 2)) 2025-07-09 19:31:17.662713 | debian-bookworm | Downloading PyYAML-6.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (2.1 kB) 2025-07-09 19:31:17.728998 | debian-bookworm | Collecting ansible==11.7.0 (from -r requirements.txt (line 3)) 2025-07-09 19:31:17.739201 | debian-bookworm | Downloading ansible-11.7.0-py3-none-any.whl.metadata (8.1 kB) 2025-07-09 19:31:17.777828 | debian-bookworm | Collecting packaging==25.0 (from -r requirements.txt (line 4)) 2025-07-09 19:31:17.786844 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl.metadata (3.3 kB) 2025-07-09 19:31:17.839536 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2025-07-09 19:31:17.853475 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2025-07-09 19:31:17.872580 | debian-bookworm | Installing build dependencies: started 2025-07-09 19:31:19.058834 | debian-bookworm | Installing build dependencies: finished with status 'done' 2025-07-09 19:31:19.059399 | debian-bookworm | Getting requirements to build wheel: started 2025-07-09 19:31:19.502767 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2025-07-09 19:31:19.505471 | debian-bookworm | Preparing metadata (pyproject.toml): started 2025-07-09 19:31:19.748929 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2025-07-09 19:31:19.792739 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2025-07-09 19:31:19.803556 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2025-07-09 19:31:19.865633 | debian-bookworm | Collecting requests==2.32.4 (from -r requirements.txt (line 7)) 2025-07-09 19:31:19.874335 | debian-bookworm | Downloading requests-2.32.4-py3-none-any.whl.metadata (4.9 kB) 2025-07-09 19:31:19.933698 | debian-bookworm | Collecting tabulate==0.9.0 (from -r requirements.txt (line 8)) 2025-07-09 19:31:19.943649 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl.metadata (34 kB) 2025-07-09 19:31:20.059669 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2025-07-09 19:31:20.068373 | debian-bookworm | Downloading MarkupSafe-3.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (4.0 kB) 2025-07-09 19:31:20.188356 | debian-bookworm | Collecting ansible-core~=2.18.6 (from ansible==11.7.0->-r requirements.txt (line 3)) 2025-07-09 19:31:20.197800 | debian-bookworm | Downloading ansible_core-2.18.6-py3-none-any.whl.metadata (7.7 kB) 2025-07-09 19:31:20.327237 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-07-09 19:31:20.336171 | debian-bookworm | Downloading click-8.2.1-py3-none-any.whl.metadata (2.5 kB) 2025-07-09 19:31:20.432521 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-07-09 19:31:20.441890 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-07-09 19:31:20.505924 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-07-09 19:31:20.517046 | debian-bookworm | Downloading fasteners-0.19-py3-none-any.whl.metadata (4.9 kB) 2025-07-09 19:31:20.566661 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-07-09 19:31:20.576457 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2025-07-09 19:31:20.701837 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-07-09 19:31:20.710541 | debian-bookworm | Downloading charset_normalizer-3.4.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (35 kB) 2025-07-09 19:31:20.754933 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-07-09 19:31:20.763592 | debian-bookworm | Downloading idna-3.10-py3-none-any.whl.metadata (10 kB) 2025-07-09 19:31:20.811128 | debian-bookworm | Collecting urllib3<3,>=1.21.1 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-07-09 19:31:20.820174 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl.metadata (6.5 kB) 2025-07-09 19:31:20.859820 | debian-bookworm | Collecting certifi>=2017.4.17 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-07-09 19:31:20.868387 | debian-bookworm | Downloading certifi-2025.7.9-py3-none-any.whl.metadata (2.4 kB) 2025-07-09 19:31:21.166061 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.6->ansible==11.7.0->-r requirements.txt (line 3)) 2025-07-09 19:31:21.174781 | debian-bookworm | Downloading cryptography-45.0.5-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2025-07-09 19:31:21.292673 | debian-bookworm | Collecting resolvelib<1.1.0,>=0.5.3 (from ansible-core~=2.18.6->ansible==11.7.0->-r requirements.txt (line 3)) 2025-07-09 19:31:21.302379 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2025-07-09 19:31:21.491657 | debian-bookworm | Collecting cffi>=1.14 (from cryptography->ansible-core~=2.18.6->ansible==11.7.0->-r requirements.txt (line 3)) 2025-07-09 19:31:21.501952 | debian-bookworm | Downloading cffi-1.17.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB) 2025-07-09 19:31:21.533709 | debian-bookworm | Collecting pycparser (from cffi>=1.14->cryptography->ansible-core~=2.18.6->ansible==11.7.0->-r requirements.txt (line 3)) 2025-07-09 19:31:21.546999 | debian-bookworm | Downloading pycparser-2.22-py3-none-any.whl.metadata (943 bytes) 2025-07-09 19:31:21.573959 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-07-09 19:31:21.613263 | debian-bookworm | Downloading PyYAML-6.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (762 kB) 2025-07-09 19:31:21.657196 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 763.0/763.0 kB 15.9 MB/s eta 0:00:00 2025-07-09 19:31:21.668801 | debian-bookworm | Downloading ansible-11.7.0-py3-none-any.whl (55.8 MB) 2025-07-09 19:31:23.522816 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 55.8/55.8 MB 30.1 MB/s eta 0:00:00 2025-07-09 19:31:23.535349 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-07-09 19:31:23.559373 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2025-07-09 19:31:23.577041 | debian-bookworm | Downloading requests-2.32.4-py3-none-any.whl (64 kB) 2025-07-09 19:31:23.595170 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl (35 kB) 2025-07-09 19:31:23.618188 | debian-bookworm | Downloading ansible_core-2.18.6-py3-none-any.whl (2.2 MB) 2025-07-09 19:31:23.755132 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 15.7 MB/s eta 0:00:00 2025-07-09 19:31:23.766372 | debian-bookworm | Downloading charset_normalizer-3.4.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (147 kB) 2025-07-09 19:31:23.789669 | debian-bookworm | Downloading idna-3.10-py3-none-any.whl (70 kB) 2025-07-09 19:31:23.808127 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2025-07-09 19:31:23.825127 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl (129 kB) 2025-07-09 19:31:23.846765 | debian-bookworm | Downloading certifi-2025.7.9-py3-none-any.whl (159 kB) 2025-07-09 19:31:23.873873 | debian-bookworm | Downloading MarkupSafe-3.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (23 kB) 2025-07-09 19:31:23.897138 | debian-bookworm | Downloading click-8.2.1-py3-none-any.whl (102 kB) 2025-07-09 19:31:23.917900 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-07-09 19:31:23.939405 | debian-bookworm | Downloading cryptography-45.0.5-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2025-07-09 19:31:24.142619 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 22.5 MB/s eta 0:00:00 2025-07-09 19:31:24.152625 | debian-bookworm | Downloading cffi-1.17.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (467 kB) 2025-07-09 19:31:24.191563 | debian-bookworm | Downloading fasteners-0.19-py3-none-any.whl (18 kB) 2025-07-09 19:31:24.211455 | debian-bookworm | Downloading pycparser-2.22-py3-none-any.whl (117 kB) 2025-07-09 19:31:24.234765 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2025-07-09 19:31:24.533372 | debian-bookworm | Building wheels for collected packages: pwgen 2025-07-09 19:31:24.534777 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2025-07-09 19:31:24.838994 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2025-07-09 19:31:24.840948 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3797 sha256=3e61c9ab13dfe690bd35fd70aad0e575207f5c574d6c59418a30c3d01808d7dd 2025-07-09 19:31:24.841819 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2025-07-09 19:31:24.846303 | debian-bookworm | Successfully built pwgen 2025-07-09 19:31:25.092880 | 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-07-09 19:31:52.577601 | debian-bookworm | 2025-07-09 19:31:52.579358 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.2 PyYAML-6.0.2 ansible-11.7.0 ansible-core-2.18.6 certifi-2025.7.9 cffi-1.17.1 charset_normalizer-3.4.2 click-8.2.1 colorama-0.4.6 cryptography-45.0.5 fasteners-0.19 idna-3.10 packaging-25.0 pwgen-0.8.2.post0 pycparser-2.22 python-gilt-1.2.3 requests-2.32.4 resolvelib-1.0.1 sh-2.2.2 tabulate-0.9.0 urllib3-2.5.0 2025-07-09 19:31:52.711885 | debian-bookworm | test: 37184 I exit 0 (36.35 seconds) /home/zuul/src/github.com/osism/cfg-generics> python -I -m pip install -r requirements.txt pid=1462 [tox/execute/api.py:294] 2025-07-09 19:31:52.714486 | debian-bookworm | test: OK (36.97 seconds) 2025-07-09 19:31:52.714557 | debian-bookworm | congratulations :) (37.04 seconds) 2025-07-09 19:31:52.780745 | debian-bookworm | ok: Runtime: 0:00:37.247929 2025-07-09 19:31:52.788821 | 2025-07-09 19:31:52.788924 | TASK [tox : Create a tempfile to save tox showconfig] 2025-07-09 19:31:53.522343 | debian-bookworm | changed 2025-07-09 19:31:53.531320 | 2025-07-09 19:31:53.531436 | TASK [tox : Get tox envlist config] 2025-07-09 19:31:54.622436 | debian-bookworm | ok: Runtime: 0:00:00.302135 2025-07-09 19:31:54.629182 | 2025-07-09 19:31:54.629344 | TASK [tox : Install any sibling python packages] 2025-07-09 19:31:55.280084 | debian-bookworm | ok: No setup.cfg, no action needed 2025-07-09 19:31:55.296337 | 2025-07-09 19:31:55.296446 | TASK [tox : Remove tempfile] 2025-07-09 19:31:56.236250 | debian-bookworm | changed 2025-07-09 19:31:56.243457 | 2025-07-09 19:31:56.243552 | TASK [tox : Emit tox command] 2025-07-09 19:31:56.301306 | /home/zuul/.local/tox/bin/tox -etest -vv --skip-missing-interpreters=false 2025-07-09 19:31:56.306317 | 2025-07-09 19:31:56.309101 | TASK [tox : Run tox] 2025-07-09 19:31:56.953021 | debian-bookworm | ROOT: 137 D setup logging to DEBUG on pid 1620 [tox/report.py:222] 2025-07-09 19:31:57.025990 | debian-bookworm | test: 210 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:76] 2025-07-09 19:31:57.026788 | debian-bookworm | test: 211 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-07-09 19:31:57.027767 | debian-bookworm | test: 212 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-07-09 19:31:57.027926 | debian-bookworm | test: 212 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:83] 2025-07-09 19:31:57.027988 | debian-bookworm | test: 213 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:85] 2025-07-09 19:31:57.060567 | debian-bookworm | test: 245 W commands[0]> python3 src/render-images.py [tox/tox_env/api.py:459] 2025-07-09 19:31:57.885521 | debian-bookworm | test: 1070 I exit 0 (0.82 seconds) /home/zuul/src/github.com/osism/cfg-generics> python3 src/render-images.py pid=1627 [tox/execute/api.py:294] 2025-07-09 19:31:57.886139 | debian-bookworm | test: 1071 W commands[1]> cat images.yml [tox/tox_env/api.py:459] 2025-07-09 19:31:57.890374 | debian-bookworm | --- 2025-07-09 19:31:57.890476 | debian-bookworm | # DO NOT EDIT THIS FILE BY HAND -- YOUR CHANGES WILL BE OVERWRITTEN 2025-07-09 19:31:57.890492 | debian-bookworm | 2025-07-09 19:31:57.890510 | debian-bookworm | adminer_tag: "5.3.0" 2025-07-09 19:31:57.890520 | debian-bookworm | adminer_image: "{{ docker_registry }}/library/adminer:{{ adminer_tag }}" 2025-07-09 19:31:57.890530 | debian-bookworm | 2025-07-09 19:31:57.890538 | debian-bookworm | ara_server_tag: "1.7.2" 2025-07-09 19:31:57.890548 | debian-bookworm | ara_server_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/ara-server:{{ ara_server_tag }}" 2025-07-09 19:31:57.890557 | debian-bookworm | 2025-07-09 19:31:57.890566 | debian-bookworm | ara_server_mariadb_tag: "11.8.2" 2025-07-09 19:31:57.890575 | debian-bookworm | ara_server_mariadb_image: "{{ docker_registry }}/library/mariadb:{{ ara_server_mariadb_tag }}" 2025-07-09 19:31:57.890583 | debian-bookworm | 2025-07-09 19:31:57.890591 | debian-bookworm | netbox_tag: "v4.3.3" 2025-07-09 19:31:57.890600 | debian-bookworm | netbox_image: "{{ docker_registry_netbox|default('quay.io') }}/osism/netbox:{{ netbox_tag }}" 2025-07-09 19:31:57.890609 | debian-bookworm | 2025-07-09 19:31:57.890617 | debian-bookworm | netbox_redis_tag: "7.4.5-alpine" 2025-07-09 19:31:57.890625 | debian-bookworm | netbox_redis_image: "{{ docker_registry }}/library/redis:{{ netbox_redis_tag }}" 2025-07-09 19:31:57.890633 | debian-bookworm | 2025-07-09 19:31:57.890641 | debian-bookworm | nginx_tag: "1.29.0-alpine" 2025-07-09 19:31:57.890650 | debian-bookworm | nginx_image: "{{ docker_registry }}/library/nginx:{{ nginx_tag }}" 2025-07-09 19:31:57.890658 | debian-bookworm | 2025-07-09 19:31:57.890674 | debian-bookworm | pgautoupgrade_tag: "16-alpine" 2025-07-09 19:31:57.890683 | debian-bookworm | pgautoupgrade_image: "{{ docker_registry }}/pgautoupgrade/pgautoupgrade:{{ pgautoupgrade_tag }}" 2025-07-09 19:31:57.890691 | debian-bookworm | 2025-07-09 19:31:57.890700 | debian-bookworm | phpmyadmin_tag: "5.2.2" 2025-07-09 19:31:57.890708 | debian-bookworm | phpmyadmin_image: "{{ docker_registry }}/phpmyadmin/phpmyadmin:{{ phpmyadmin_tag }}" 2025-07-09 19:31:57.890716 | debian-bookworm | 2025-07-09 19:31:57.890724 | debian-bookworm | postgres_tag: "16.9-alpine" 2025-07-09 19:31:57.891612 | debian-bookworm | postgres_image: "{{ docker_registry }}/library/postgres:{{ postgres_tag }}" 2025-07-09 19:31:57.891642 | debian-bookworm | 2025-07-09 19:31:57.891651 | debian-bookworm | manager_redis_tag: "7.4.5-alpine" 2025-07-09 19:31:57.891661 | debian-bookworm | manager_redis_image: "{{ docker_registry }}/library/redis:{{ manager_redis_tag }}" 2025-07-09 19:31:57.891669 | debian-bookworm | 2025-07-09 19:31:57.891677 | debian-bookworm | registry_tag: "3.0" 2025-07-09 19:31:57.891685 | debian-bookworm | registry_image: "{{ docker_registry }}/library/registry:{{ registry_tag }}" 2025-07-09 19:31:57.891694 | debian-bookworm | 2025-07-09 19:31:57.891702 | debian-bookworm | osism_ansible_tag: "{{ osism_ansible_version|default('latest') }}" 2025-07-09 19:31:57.891710 | debian-bookworm | osism_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/osism-ansible:{{ osism_ansible_tag }}" 2025-07-09 19:31:57.891734 | debian-bookworm | 2025-07-09 19:31:57.891742 | debian-bookworm | osism_kubernetes_tag: "{{ osism_kubernetes_version|default('latest') }}" 2025-07-09 19:31:57.891751 | debian-bookworm | osism_kubernetes_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/osism-kubernetes:{{ osism_kubernetes_tag }}" 2025-07-09 19:31:57.891760 | debian-bookworm | 2025-07-09 19:31:57.891768 | debian-bookworm | inventory_reconciler_tag: "{{ inventory_reconciler_version|default('latest') }}" 2025-07-09 19:31:57.891777 | debian-bookworm | inventory_reconciler_image: "{{ docker_registry_ansible }}/osism/inventory-reconciler:{{ inventory_reconciler_tag }}" 2025-07-09 19:31:57.891785 | debian-bookworm | 2025-07-09 19:31:57.891793 | debian-bookworm | osism_tag: "{{ osism_version|default('latest') }}" 2025-07-09 19:31:57.891802 | debian-bookworm | osism_image: "{{ docker_registry_ansible }}/osism/osism:{{ osism_tag }}" 2025-07-09 19:31:57.891810 | debian-bookworm | 2025-07-09 19:31:57.891907 | debian-bookworm | osism_netbox_tag: "{{ osism_version|default('latest') }}" 2025-07-09 19:31:57.891917 | debian-bookworm | osism_netbox_image: "{{ docker_registry_ansible }}/osism/osism-netbox:{{ osism_netbox_tag }}" 2025-07-09 19:31:57.891926 | debian-bookworm | 2025-07-09 19:31:57.891934 | debian-bookworm | vault_tag: "1.20.0" 2025-07-09 19:31:57.891943 | debian-bookworm | vault_image: "{{ docker_registry }}/hashicorp/vault:{{ vault_tag }}" 2025-07-09 19:31:57.891951 | debian-bookworm | 2025-07-09 19:31:57.891959 | debian-bookworm | traefik_tag: "v3.4.3" 2025-07-09 19:31:57.891969 | debian-bookworm | traefik_image: "{{ docker_registry }}/library/traefik:{{ traefik_tag }}" 2025-07-09 19:31:57.891977 | debian-bookworm | 2025-07-09 19:31:57.891986 | debian-bookworm | ceph_ansible_tag: "{{ ceph_version|default('quincy') }}" 2025-07-09 19:31:57.891994 | debian-bookworm | ceph_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/ceph-ansible:{{ ceph_ansible_tag }}" 2025-07-09 19:31:57.892003 | debian-bookworm | 2025-07-09 19:31:57.892011 | debian-bookworm | kolla_ansible_tag: "{{ openstack_version|default('2024.2') }}" 2025-07-09 19:31:57.892019 | debian-bookworm | kolla_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/kolla-ansible:{{ kolla_ansible_tag }}" 2025-07-09 19:31:57.892903 | debian-bookworm | test: 1077 I exit 0 (0.01 seconds) /home/zuul/src/github.com/osism/cfg-generics> cat images.yml pid=1632 [tox/execute/api.py:294] 2025-07-09 19:31:57.894067 | debian-bookworm | test: OK (0.87=setup[0.04]+cmd[0.82,0.01] seconds) 2025-07-09 19:31:57.894098 | debian-bookworm | congratulations :) (0.94 seconds) 2025-07-09 19:31:58.432636 | debian-bookworm | ok: Runtime: 0:00:01.183131 2025-07-09 19:31:58.438955 | 2025-07-09 19:31:58.439059 | TASK [tox : Look for output] 2025-07-09 19:31:58.866576 | debian-bookworm | ok 2025-07-09 19:31:58.885796 | 2025-07-09 19:31:58.885915 | TASK [tox : Return file comments to Zuul] 2025-07-09 19:31:58.918359 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:31:58.924895 | 2025-07-09 19:31:58.924966 | PLAY RECAP 2025-07-09 19:31:58.925019 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-07-09 19:31:58.925041 | 2025-07-09 19:31:59.136094 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-07-09 19:31:59.136927 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-07-09 19:31:59.927777 | 2025-07-09 19:31:59.927900 | PLAY [all] 2025-07-09 19:31:59.952792 | 2025-07-09 19:31:59.952919 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-07-09 19:32:00.031873 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:00.038116 | 2025-07-09 19:32:00.038265 | TASK [fetch-tox-output : Set tox log path for single node] 2025-07-09 19:32:00.100184 | debian-bookworm | ok 2025-07-09 19:32:00.107692 | 2025-07-09 19:32:00.107797 | TASK [fetch-tox-output : Ensure local tox dir] 2025-07-09 19:32:00.926038 | debian-bookworm -> localhost | changed 2025-07-09 19:32:00.933268 | 2025-07-09 19:32:00.933366 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-07-09 19:32:01.007260 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:01.013548 | 2025-07-09 19:32:01.013658 | TASK [fetch-tox-output : Set envlist fact] 2025-07-09 19:32:01.061832 | debian-bookworm | ok 2025-07-09 19:32:01.067689 | 2025-07-09 19:32:01.067778 | TASK [fetch-tox-output : Get tox version] 2025-07-09 19:32:01.804867 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-07-09 19:32:01.822978 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-07-09 19:32:02.113547 | debian-bookworm | ok: Runtime: 0:00:00.286948 2025-07-09 19:32:02.118725 | 2025-07-09 19:32:02.118816 | TASK [fetch-tox-output : Find all default environments] 2025-07-09 19:32:02.657704 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:02.663328 | 2025-07-09 19:32:02.663433 | TASK [fetch-tox-output : Set envlist fact] 2025-07-09 19:32:02.697063 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:02.703598 | 2025-07-09 19:32:02.703700 | TASK [fetch-tox-output : Find all default environments] 2025-07-09 19:32:03.231046 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:03.236547 | 2025-07-09 19:32:03.236639 | TASK [fetch-tox-output : Set envlist fact] 2025-07-09 19:32:03.259939 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:03.267441 | 2025-07-09 19:32:03.267616 | LOOP [fetch-tox-output : Copy tox logs] 2025-07-09 19:32:03.313420 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:03.331775 | 2025-07-09 19:32:03.331904 | LOOP [fetch-tox-output : Collect tox logs] 2025-07-09 19:32:04.106751 | debian-bookworm | changed: 2025-07-09 19:32:04.106950 | debian-bookworm | created directory /var/lib/zuul/builds/39f5382707fa4b039ccd3d4a27ccbe3b/work/logs/tox/test 2025-07-09 19:32:04.107018 | debian-bookworm | cd+++++++++ ./ 2025-07-09 19:32:04.107047 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-07-09 19:32:04.107071 | debian-bookworm | >f+++++++++ 2-commands[1].log 2025-07-09 19:32:04.107098 | 2025-07-09 19:32:04.128402 | 2025-07-09 19:32:04.128489 | PLAY RECAP 2025-07-09 19:32:04.128539 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-07-09 19:32:04.128564 | 2025-07-09 19:32:04.276729 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-07-09 19:32:04.278788 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-07-09 19:32:05.242032 | 2025-07-09 19:32:05.242158 | PLAY [all] 2025-07-09 19:32:05.281176 | 2025-07-09 19:32:05.292844 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-07-09 19:32:05.579071 | debian-bookworm | changed: non-zero return code 2025-07-09 19:32:05.584468 | 2025-07-09 19:32:05.584576 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-07-09 19:32:05.597505 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:05.603531 | 2025-07-09 19:32:05.603646 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-07-09 19:32:05.623872 | 2025-07-09 19:32:05.624175 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-07-09 19:32:05.654323 | 2025-07-09 19:32:05.654484 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-07-09 19:32:05.677383 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:05.686875 | 2025-07-09 19:32:05.687009 | LOOP [fetch-subunit-output : Generate subunit file] 2025-07-09 19:32:05.705781 | 2025-07-09 19:32:05.706024 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-07-09 19:32:05.720015 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:05.732918 | 2025-07-09 19:32:05.733032 | TASK [fetch-subunit-output : Remove the temporary file] 2025-07-09 19:32:05.746566 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:05.752918 | 2025-07-09 19:32:05.753028 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-07-09 19:32:05.766679 | debian-bookworm | skipping: Conditional result was False 2025-07-09 19:32:05.772556 | 2025-07-09 19:32:05.772628 | PLAY RECAP 2025-07-09 19:32:05.772675 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-07-09 19:32:05.772700 | 2025-07-09 19:32:05.961052 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-07-09 19:32:05.962035 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-07-09 19:32:06.992501 | 2025-07-09 19:32:06.992678 | PLAY [Base post] 2025-07-09 19:32:07.008809 | 2025-07-09 19:32:07.008979 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-07-09 19:32:07.747867 | debian-bookworm | changed 2025-07-09 19:32:07.762620 | 2025-07-09 19:32:07.762772 | PLAY RECAP 2025-07-09 19:32:07.762867 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-07-09 19:32:07.762935 | 2025-07-09 19:32:07.913435 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-07-09 19:32:07.914516 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-07-09 19:32:08.855799 | 2025-07-09 19:32:08.855986 | PLAY [Base post-logs] 2025-07-09 19:32:08.889347 | 2025-07-09 19:32:08.889519 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-07-09 19:32:09.644967 | localhost | changed 2025-07-09 19:32:09.657687 | 2025-07-09 19:32:09.657863 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-07-09 19:32:09.710083 | localhost | ok 2025-07-09 19:32:09.713175 | 2025-07-09 19:32:09.713297 | TASK [Set zuul-log-path fact] 2025-07-09 19:32:09.758737 | localhost | ok 2025-07-09 19:32:09.765412 | 2025-07-09 19:32:09.765516 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-09 19:32:09.819556 | localhost | ok 2025-07-09 19:32:09.822147 | 2025-07-09 19:32:09.822259 | TASK [upload-logs : Create log directories] 2025-07-09 19:32:10.506854 | localhost | changed 2025-07-09 19:32:10.511362 | 2025-07-09 19:32:10.511452 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-07-09 19:32:11.177679 | localhost -> localhost | ok: Runtime: 0:00:00.007970 2025-07-09 19:32:11.182352 | 2025-07-09 19:32:11.182443 | TASK [upload-logs : Upload logs to log server] 2025-07-09 19:32:11.674665 | localhost | Output suppressed because no_log was given 2025-07-09 19:32:11.676402 | 2025-07-09 19:32:11.676491 | LOOP [upload-logs : Compress console log and json output] 2025-07-09 19:32:11.720861 | localhost | skipping: Conditional result was False 2025-07-09 19:32:11.726591 | localhost | skipping: Conditional result was False 2025-07-09 19:32:11.734410 | 2025-07-09 19:32:11.734543 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-09 19:32:11.790809 | localhost | skipping: Conditional result was False 2025-07-09 19:32:11.791082 | 2025-07-09 19:32:11.796056 | localhost | skipping: Conditional result was False 2025-07-09 19:32:11.800581 | 2025-07-09 19:32:11.800696 | LOOP [upload-logs : Upload console log and json output]