2025-06-10 16:29:12.705421 | Job console starting 2025-06-10 16:29:12.727289 | Updating git repos 2025-06-10 16:29:12.764779 | Cloning repos into workspace 2025-06-10 16:29:12.794058 | Restoring repo states 2025-06-10 16:29:12.807202 | Merging changes 2025-06-10 16:29:13.351038 | Checking out repos 2025-06-10 16:29:13.402460 | Preparing playbooks 2025-06-10 16:29:14.029205 | Running Ansible setup 2025-06-10 16:29:18.377190 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-10 16:29:19.181656 | 2025-06-10 16:29:19.181828 | PLAY [Base pre] 2025-06-10 16:29:19.201471 | 2025-06-10 16:29:19.201614 | TASK [Setup log path fact] 2025-06-10 16:29:19.222478 | debian-bookworm | ok 2025-06-10 16:29:19.244836 | 2025-06-10 16:29:19.245015 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-10 16:29:19.285247 | debian-bookworm | ok 2025-06-10 16:29:19.299512 | 2025-06-10 16:29:19.299650 | TASK [emit-job-header : Print job information] 2025-06-10 16:29:19.356063 | # Job Information 2025-06-10 16:29:19.356344 | Ansible Version: 2.16.14 2025-06-10 16:29:19.356472 | Job: cfg-generics-tox-test-latest 2025-06-10 16:29:19.356519 | Pipeline: check 2025-06-10 16:29:19.356548 | Executor: 521e9411259a 2025-06-10 16:29:19.356576 | Triggered by: https://github.com/osism/cfg-generics/pull/395 2025-06-10 16:29:19.356606 | Event ID: e06f7b80-4617-11f0-86cb-1c03dacfa18a 2025-06-10 16:29:19.365223 | 2025-06-10 16:29:19.365367 | LOOP [emit-job-header : Print node information] 2025-06-10 16:29:19.491431 | debian-bookworm | ok: 2025-06-10 16:29:19.491761 | debian-bookworm | # Node Information 2025-06-10 16:29:19.491805 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-10 16:29:19.491831 | debian-bookworm | Hostname: debian 2025-06-10 16:29:19.491854 | debian-bookworm | Username: zuul 2025-06-10 16:29:19.491875 | debian-bookworm | Distro: Debian 12.11 2025-06-10 16:29:19.491918 | debian-bookworm | Provider: regiocloud-a 2025-06-10 16:29:19.491941 | debian-bookworm | Region: 2025-06-10 16:29:19.491962 | debian-bookworm | Label: debian-bookworm 2025-06-10 16:29:19.491983 | debian-bookworm | Product Name: OpenStack Nova 2025-06-10 16:29:19.492002 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5f:92 2025-06-10 16:29:19.514441 | 2025-06-10 16:29:19.514737 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-10 16:29:20.061330 | debian-bookworm -> localhost | changed 2025-06-10 16:29:20.070344 | 2025-06-10 16:29:20.070570 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-10 16:29:21.339930 | debian-bookworm -> localhost | changed 2025-06-10 16:29:21.364642 | 2025-06-10 16:29:21.364962 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-10 16:29:21.694665 | debian-bookworm -> localhost | ok 2025-06-10 16:29:21.712037 | 2025-06-10 16:29:21.712193 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-10 16:29:21.755772 | debian-bookworm | ok 2025-06-10 16:29:21.776520 | debian-bookworm | included: /var/lib/zuul/builds/a2a3540ba1464981852a304a221029bc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-10 16:29:21.783118 | 2025-06-10 16:29:21.783228 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-10 16:29:22.763712 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-10 16:29:22.764221 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a2a3540ba1464981852a304a221029bc/work/a2a3540ba1464981852a304a221029bc_id_rsa 2025-06-10 16:29:22.764359 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a2a3540ba1464981852a304a221029bc/work/a2a3540ba1464981852a304a221029bc_id_rsa.pub 2025-06-10 16:29:22.764461 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-10 16:29:22.764538 | debian-bookworm -> localhost | SHA256:zUUUCXyR2V66u5HJ1UqJoCawYfCcO/xD/4J6OyHI9fQ zuul-build-sshkey 2025-06-10 16:29:22.764591 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-10 16:29:22.764662 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-10 16:29:22.764713 | debian-bookworm -> localhost | | . ..o=B | 2025-06-10 16:29:22.764761 | debian-bookworm -> localhost | | + . ..= . .| 2025-06-10 16:29:22.764807 | debian-bookworm -> localhost | | B .... o | 2025-06-10 16:29:22.764854 | debian-bookworm -> localhost | | o.=. + o .o..| 2025-06-10 16:29:22.764954 | debian-bookworm -> localhost | | . o=oo.S o . o.o| 2025-06-10 16:29:22.765048 | debian-bookworm -> localhost | | o .+o+E o.= | 2025-06-10 16:29:22.765133 | debian-bookworm -> localhost | | .oo. *. | 2025-06-10 16:29:22.765188 | debian-bookworm -> localhost | | +... .. | 2025-06-10 16:29:22.765237 | debian-bookworm -> localhost | | .o.o .. .. | 2025-06-10 16:29:22.765285 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-10 16:29:22.765475 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.454333 2025-06-10 16:29:22.778826 | 2025-06-10 16:29:22.779058 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-10 16:29:22.816220 | debian-bookworm | ok 2025-06-10 16:29:22.832824 | debian-bookworm | included: /var/lib/zuul/builds/a2a3540ba1464981852a304a221029bc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-10 16:29:22.843148 | 2025-06-10 16:29:22.843284 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-10 16:29:22.869344 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:29:22.880404 | 2025-06-10 16:29:22.880615 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-10 16:29:23.588680 | debian-bookworm | changed 2025-06-10 16:29:23.598855 | 2025-06-10 16:29:23.599018 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-10 16:29:23.904412 | debian-bookworm | ok 2025-06-10 16:29:23.912294 | 2025-06-10 16:29:23.912416 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-10 16:29:24.636807 | debian-bookworm | changed 2025-06-10 16:29:24.654125 | 2025-06-10 16:29:24.654279 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-10 16:29:25.333584 | debian-bookworm | changed 2025-06-10 16:29:25.339961 | 2025-06-10 16:29:25.340095 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-10 16:29:25.368593 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:29:25.388342 | 2025-06-10 16:29:25.388566 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-10 16:29:25.911755 | debian-bookworm -> localhost | changed 2025-06-10 16:29:25.928838 | 2025-06-10 16:29:25.929004 | TASK [add-build-sshkey : Add back temp key] 2025-06-10 16:29:26.294532 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a2a3540ba1464981852a304a221029bc/work/a2a3540ba1464981852a304a221029bc_id_rsa (zuul-build-sshkey) 2025-06-10 16:29:26.295235 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013597 2025-06-10 16:29:26.309448 | 2025-06-10 16:29:26.309612 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-10 16:29:26.743867 | debian-bookworm | ok 2025-06-10 16:29:26.750782 | 2025-06-10 16:29:26.750952 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-10 16:29:26.786259 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:29:26.804322 | 2025-06-10 16:29:26.804510 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-10 16:29:27.275650 | debian-bookworm | ok 2025-06-10 16:29:27.300427 | 2025-06-10 16:29:27.300635 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-10 16:29:27.362999 | debian-bookworm | ok 2025-06-10 16:29:27.370683 | 2025-06-10 16:29:27.370820 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-10 16:29:27.670670 | debian-bookworm -> localhost | ok 2025-06-10 16:29:27.685002 | 2025-06-10 16:29:27.685181 | TASK [validate-host : Collect information about the host] 2025-06-10 16:29:28.813490 | debian-bookworm | ok 2025-06-10 16:29:28.826062 | 2025-06-10 16:29:28.826233 | TASK [validate-host : Sanitize hostname] 2025-06-10 16:29:28.990126 | debian-bookworm | ok 2025-06-10 16:29:29.051477 | 2025-06-10 16:29:29.051662 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-10 16:29:29.796810 | debian-bookworm -> localhost | changed 2025-06-10 16:29:29.804971 | 2025-06-10 16:29:29.805116 | TASK [validate-host : Collect information about zuul worker] 2025-06-10 16:29:30.230393 | debian-bookworm | ok 2025-06-10 16:29:30.239539 | 2025-06-10 16:29:30.239680 | TASK [validate-host : Write out all zuul information for each host] 2025-06-10 16:29:31.119220 | debian-bookworm -> localhost | changed 2025-06-10 16:29:31.136405 | 2025-06-10 16:29:31.136542 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-10 16:29:31.435183 | debian-bookworm | ok 2025-06-10 16:29:31.443145 | 2025-06-10 16:29:31.454126 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-10 16:29:32.502464 | debian-bookworm | changed: 2025-06-10 16:29:32.502927 | debian-bookworm | cd+++++++++ src/ 2025-06-10 16:29:32.503002 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-10 16:29:32.503041 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-10 16:29:32.503077 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-generics/ 2025-06-10 16:29:32.503111 | debian-bookworm | =5.5.1 2025-06-10 16:29:56.311011 | debian-bookworm | Downloading cachetools-6.0.0-py3-none-any.whl (10 kB) 2025-06-10 16:29:56.340071 | debian-bookworm | Collecting chardet>=5.2 2025-06-10 16:29:56.347575 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-06-10 16:29:56.418891 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 2.9 MB/s eta 0:00:00 2025-06-10 16:29:56.461745 | debian-bookworm | Collecting colorama>=0.4.6 2025-06-10 16:29:56.471080 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-06-10 16:29:56.516416 | debian-bookworm | Collecting filelock>=3.16.1 2025-06-10 16:29:56.523783 | debian-bookworm | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-06-10 16:29:56.565582 | debian-bookworm | Collecting packaging>=24.2 2025-06-10 16:29:56.572826 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-06-10 16:29:56.579732 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 12.5 MB/s eta 0:00:00 2025-06-10 16:29:56.617998 | debian-bookworm | Collecting platformdirs>=4.3.6 2025-06-10 16:29:56.625977 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-06-10 16:29:56.658910 | debian-bookworm | Collecting pluggy>=1.5 2025-06-10 16:29:56.666236 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-06-10 16:29:56.698568 | debian-bookworm | Collecting pyproject-api>=1.8 2025-06-10 16:29:56.706480 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-06-10 16:29:56.821892 | debian-bookworm | Collecting virtualenv>=20.31 2025-06-10 16:29:56.830129 | debian-bookworm | Downloading virtualenv-20.31.2-py3-none-any.whl (6.1 MB) 2025-06-10 16:29:57.078994 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.1/6.1 MB 24.6 MB/s eta 0:00:00 2025-06-10 16:29:57.186311 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-06-10 16:29:57.193852 | debian-bookworm | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-06-10 16:29:57.213328 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 27.0 MB/s eta 0:00:00 2025-06-10 16:29:57.365355 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-06-10 16:29:58.114020 | debian-bookworm | Successfully installed cachetools-6.0.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.26.0 virtualenv-20.31.2 2025-06-10 16:29:58.355715 | debian-bookworm | ok: Runtime: 0:00:02.589700 2025-06-10 16:29:58.379827 | 2025-06-10 16:29:58.381233 | TASK [ensure-tox : Export installed tox_executable path] 2025-06-10 16:29:58.424005 | debian-bookworm | ok 2025-06-10 16:29:58.433733 | 2025-06-10 16:29:58.433853 | TASK [ensure-tox : Output tox version] 2025-06-10 16:29:58.955054 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-06-10 16:29:58.972084 | debian-bookworm | 4.26.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-06-10 16:29:59.480992 | debian-bookworm | ok: Runtime: 0:00:00.255983 2025-06-10 16:29:59.529262 | 2025-06-10 16:29:59.530074 | TASK [ensure-tox : Make global symlink] 2025-06-10 16:29:59.597790 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:29:59.627609 | 2025-06-10 16:29:59.628339 | PLAY RECAP 2025-06-10 16:29:59.629086 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-06-10 16:29:59.629619 | 2025-06-10 16:29:59.953689 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-06-10 16:29:59.954982 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-06-10 16:30:02.599287 | 2025-06-10 16:30:02.599539 | PLAY [all] 2025-06-10 16:30:02.658405 | 2025-06-10 16:30:02.658632 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-06-10 16:30:03.875949 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-06-10 16:30:04.227522 | debian-bookworm | ok: Runtime: 0:00:00.033278 2025-06-10 16:30:04.269431 | 2025-06-10 16:30:04.269624 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-06-10 16:30:04.869962 | debian-bookworm | ok: Runtime: 0:00:00.005331 2025-06-10 16:30:04.876980 | 2025-06-10 16:30:04.877140 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-06-10 16:30:05.321847 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-06-10 16:30:05.323747 | debian-bookworm | sudo: a password is required 2025-06-10 16:30:05.439472 | debian-bookworm | ok: Runtime: 0:00:00.020828 2025-06-10 16:30:05.455255 | 2025-06-10 16:30:05.455463 | TASK [tox : Check to see if the constraints file exists] 2025-06-10 16:30:05.518054 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:05.537758 | 2025-06-10 16:30:05.538042 | TASK [tox : Fail if constraints file is missing] 2025-06-10 16:30:05.699488 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:05.707697 | 2025-06-10 16:30:05.707862 | TASK [tox : Record file location] 2025-06-10 16:30:05.789116 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:05.796577 | 2025-06-10 16:30:05.796764 | TASK [tox : Install tox siblings] 2025-06-10 16:30:05.854283 | debian-bookworm | ok 2025-06-10 16:30:05.864978 | debian-bookworm | included: /var/lib/zuul/builds/a2a3540ba1464981852a304a221029bc/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-06-10 16:30:05.870990 | 2025-06-10 16:30:05.871186 | TASK [tox : Run tox without tests] 2025-06-10 16:30:06.533134 | debian-bookworm | ROOT: 145 D setup logging to DEBUG on pid 1423 [tox/report.py:222] 2025-06-10 16:30:06.606504 | debian-bookworm | test: 218 D created app data folder /home/zuul/.local/share/virtualenv [virtualenv/app_data/__init__.py:42] 2025-06-10 16:30:06.609261 | debian-bookworm | test: 221 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:76] 2025-06-10 16:30:06.610191 | debian-bookworm | test: 222 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/discovery/py_info.py ctUchf4bj2g0ZosYVyFT1HMDIb4HsbWs GE5twrQtv2rsrfqL8VaI1cZenBMokFVF [virtualenv/discovery/cached_py_info.py:117] 2025-06-10 16:30:06.684026 | 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-06-10 16:30:06.684739 | debian-bookworm | test: 297 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-06-10 16:30:06.685202 | debian-bookworm | test: 297 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-06-10 16:30:06.685499 | 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-06-10 16:30:06.727373 | debian-bookworm | test: 339 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-06-10 16:30:06.727598 | debian-bookworm | test: 340 D create folder /home/zuul/src/github.com/osism/cfg-generics/.tox/test/bin [virtualenv/util/path/_sync.py:14] 2025-06-10 16:30:06.727866 | debian-bookworm | test: 340 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-06-10 16:30:06.728112 | debian-bookworm | test: 340 D write /home/zuul/src/github.com/osism/cfg-generics/.tox/test/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-06-10 16:30:06.728173 | debian-bookworm | test: 340 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:06.728228 | debian-bookworm | test: 340 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:06.728276 | debian-bookworm | test: 341 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:06.728321 | debian-bookworm | test: 341 D virtualenv = 20.31.2 [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:06.728368 | debian-bookworm | test: 341 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:06.728425 | debian-bookworm | test: 341 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:06.728480 | debian-bookworm | test: 341 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:06.728548 | debian-bookworm | test: 341 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:06.728841 | debian-bookworm | test: 341 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-06-10 16:30:06.729170 | debian-bookworm | test: 341 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-06-10 16:30:06.729308 | debian-bookworm | test: 342 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-06-10 16:30:06.729717 | debian-bookworm | test: 342 D ============================== target debug ============================== [virtualenv/run/session.py:54] 2025-06-10 16:30:06.729970 | debian-bookworm | test: 342 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-06-10 16:30:06.776493 | debian-bookworm | test: 342 D { 2025-06-10 16:30:06.776561 | debian-bookworm | "sys": { 2025-06-10 16:30:06.776567 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/cfg-generics/.tox/test/bin/python", 2025-06-10 16:30:06.776572 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2025-06-10 16:30:06.776579 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/cfg-generics/.tox/test", 2025-06-10 16:30:06.776585 | debian-bookworm | "base_prefix": "/usr", 2025-06-10 16:30:06.776591 | debian-bookworm | "real_prefix": null, 2025-06-10 16:30:06.776596 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/cfg-generics/.tox/test", 2025-06-10 16:30:06.776603 | debian-bookworm | "base_exec_prefix": "/usr", 2025-06-10 16:30:06.776607 | debian-bookworm | "path": [ 2025-06-10 16:30:06.776613 | debian-bookworm | "/usr/lib/python311.zip", 2025-06-10 16:30:06.776618 | debian-bookworm | "/usr/lib/python3.11", 2025-06-10 16:30:06.776621 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2025-06-10 16:30:06.776626 | debian-bookworm | "/home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages" 2025-06-10 16:30:06.776630 | debian-bookworm | ], 2025-06-10 16:30:06.776634 | debian-bookworm | "meta_path": [ 2025-06-10 16:30:06.776638 | debian-bookworm | "", 2025-06-10 16:30:06.776642 | debian-bookworm | "", 2025-06-10 16:30:06.776647 | debian-bookworm | "", 2025-06-10 16:30:06.776651 | debian-bookworm | "" 2025-06-10 16:30:06.776655 | debian-bookworm | ], 2025-06-10 16:30:06.776659 | debian-bookworm | "fs_encoding": "utf-8", 2025-06-10 16:30:06.776663 | debian-bookworm | "io_encoding": "utf-8" 2025-06-10 16:30:06.776667 | debian-bookworm | }, 2025-06-10 16:30:06.776671 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2025-06-10 16:30:06.776676 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2025-06-10 16:30:06.776680 | debian-bookworm | "os": "", 2025-06-10 16:30:06.776684 | debian-bookworm | "site": "", 2025-06-10 16:30:06.776687 | debian-bookworm | "datetime": "", 2025-06-10 16:30:06.776704 | debian-bookworm | "math": "", 2025-06-10 16:30:06.776708 | debian-bookworm | "json": "" 2025-06-10 16:30:06.776712 | debian-bookworm | } [virtualenv/run/session.py:55] 2025-06-10 16:30:06.776933 | debian-bookworm | test: 389 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-06-10 16:30:06.779115 | debian-bookworm | test: 391 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-06-10 16:30:06.780363 | debian-bookworm | test: 392 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-06-10 16:30:06.781984 | debian-bookworm | test: 394 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-06-10 16:30:06.782365 | debian-bookworm | test: 395 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-06-10 16:30:07.039711 | debian-bookworm | test: 652 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-06-10 16:30:07.066903 | debian-bookworm | test: 679 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-06-10 16:30:07.067767 | debian-bookworm | test: 680 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-06-10 16:30:07.070425 | debian-bookworm | test: 683 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-06-10 16:30:07.075052 | debian-bookworm | test: 687 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-06-10 16:30:07.077587 | debian-bookworm | test: 690 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-06-10 16:30:07.078989 | debian-bookworm | test: 691 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-06-10 16:30:07.081231 | debian-bookworm | test: 693 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-06-10 16:30:07.264287 | debian-bookworm | test: 876 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-06-10 16:30:07.269422 | debian-bookworm | test: 882 D generated console scripts pip pip3 pip3.11 pip-3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-06-10 16:30:07.276642 | debian-bookworm | test: 889 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-06-10 16:30:07.277368 | debian-bookworm | test: 889 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65] 2025-06-10 16:30:07.282498 | debian-bookworm | test: 895 D write /home/zuul/src/github.com/osism/cfg-generics/.tox/test/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-06-10 16:30:07.282621 | debian-bookworm | test: 895 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:07.282717 | debian-bookworm | test: 895 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:07.282784 | debian-bookworm | test: 895 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:07.282844 | debian-bookworm | test: 895 D virtualenv = 20.31.2 [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:07.282902 | debian-bookworm | test: 895 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:07.282973 | debian-bookworm | test: 895 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:07.283038 | debian-bookworm | test: 895 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:07.283118 | debian-bookworm | test: 895 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-06-10 16:30:07.288388 | debian-bookworm | test: 901 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:435] 2025-06-10 16:30:08.464983 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2025-06-10 16:30:08.527169 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2025-06-10 16:30:08.619466 | debian-bookworm | Collecting PyYAML==6.0.2 (from -r requirements.txt (line 2)) 2025-06-10 16:30:08.628651 | debian-bookworm | Downloading PyYAML-6.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (2.1 kB) 2025-06-10 16:30:08.706335 | debian-bookworm | Collecting ansible==11.6.0 (from -r requirements.txt (line 3)) 2025-06-10 16:30:08.719592 | debian-bookworm | Downloading ansible-11.6.0-py3-none-any.whl.metadata (8.1 kB) 2025-06-10 16:30:08.776163 | debian-bookworm | Collecting packaging==25.0 (from -r requirements.txt (line 4)) 2025-06-10 16:30:08.785121 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl.metadata (3.3 kB) 2025-06-10 16:30:08.837544 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2025-06-10 16:30:08.849459 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2025-06-10 16:30:08.868213 | debian-bookworm | Installing build dependencies: started 2025-06-10 16:30:10.038317 | debian-bookworm | Installing build dependencies: finished with status 'done' 2025-06-10 16:30:10.039044 | debian-bookworm | Getting requirements to build wheel: started 2025-06-10 16:30:10.450336 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2025-06-10 16:30:10.451741 | debian-bookworm | Preparing metadata (pyproject.toml): started 2025-06-10 16:30:10.684978 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2025-06-10 16:30:10.737526 | debian-bookworm | Collecting python-gilt==2.2.4 (from -r requirements.txt (line 6)) 2025-06-10 16:30:10.748755 | debian-bookworm | Downloading python_gilt-2.2.4-py3-none-manylinux2014_x86_64.manylinux_2_17_x86_64.musllinux_1_1_x86_64.whl.metadata (3.0 kB) 2025-06-10 16:30:10.838256 | debian-bookworm | Collecting requests==2.32.4 (from -r requirements.txt (line 7)) 2025-06-10 16:30:10.850410 | debian-bookworm | Downloading requests-2.32.4-py3-none-any.whl.metadata (4.9 kB) 2025-06-10 16:30:10.906008 | debian-bookworm | Collecting tabulate==0.9.0 (from -r requirements.txt (line 8)) 2025-06-10 16:30:10.916814 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl.metadata (34 kB) 2025-06-10 16:30:11.012455 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2025-06-10 16:30:11.021203 | debian-bookworm | Downloading MarkupSafe-3.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (4.0 kB) 2025-06-10 16:30:11.103479 | debian-bookworm | Collecting ansible-core~=2.18.6 (from ansible==11.6.0->-r requirements.txt (line 3)) 2025-06-10 16:30:11.118464 | debian-bookworm | Downloading ansible_core-2.18.6-py3-none-any.whl.metadata (7.7 kB) 2025-06-10 16:30:11.265775 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-06-10 16:30:11.275076 | debian-bookworm | Downloading charset_normalizer-3.4.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (35 kB) 2025-06-10 16:30:11.313063 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-06-10 16:30:11.322509 | debian-bookworm | Downloading idna-3.10-py3-none-any.whl.metadata (10 kB) 2025-06-10 16:30:11.390314 | debian-bookworm | Collecting urllib3<3,>=1.21.1 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-06-10 16:30:11.398690 | debian-bookworm | Downloading urllib3-2.4.0-py3-none-any.whl.metadata (6.5 kB) 2025-06-10 16:30:11.444930 | debian-bookworm | Collecting certifi>=2017.4.17 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-06-10 16:30:11.453258 | debian-bookworm | Downloading certifi-2025.4.26-py3-none-any.whl.metadata (2.5 kB) 2025-06-10 16:30:11.717385 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.6->ansible==11.6.0->-r requirements.txt (line 3)) 2025-06-10 16:30:11.726056 | debian-bookworm | Downloading cryptography-45.0.4-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2025-06-10 16:30:11.763708 | debian-bookworm | Collecting resolvelib<1.1.0,>=0.5.3 (from ansible-core~=2.18.6->ansible==11.6.0->-r requirements.txt (line 3)) 2025-06-10 16:30:11.771474 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2025-06-10 16:30:11.968479 | debian-bookworm | Collecting cffi>=1.14 (from cryptography->ansible-core~=2.18.6->ansible==11.6.0->-r requirements.txt (line 3)) 2025-06-10 16:30:11.977839 | debian-bookworm | Downloading cffi-1.17.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB) 2025-06-10 16:30:12.022774 | debian-bookworm | Collecting pycparser (from cffi>=1.14->cryptography->ansible-core~=2.18.6->ansible==11.6.0->-r requirements.txt (line 3)) 2025-06-10 16:30:12.033026 | debian-bookworm | Downloading pycparser-2.22-py3-none-any.whl.metadata (943 bytes) 2025-06-10 16:30:12.056402 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-06-10 16:30:12.085112 | debian-bookworm | Downloading PyYAML-6.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (762 kB) 2025-06-10 16:30:12.125252 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 763.0/763.0 kB 20.9 MB/s eta 0:00:00 2025-06-10 16:30:12.142127 | debian-bookworm | Downloading ansible-11.6.0-py3-none-any.whl (55.5 MB) 2025-06-10 16:30:14.101935 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 55.5/55.5 MB 28.4 MB/s eta 0:00:00 2025-06-10 16:30:14.111068 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-06-10 16:30:14.188365 | debian-bookworm | Downloading python_gilt-2.2.4-py3-none-manylinux2014_x86_64.manylinux_2_17_x86_64.musllinux_1_1_x86_64.whl (3.3 MB) 2025-06-10 16:30:14.351333 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 3.3/3.3 MB 20.6 MB/s eta 0:00:00 2025-06-10 16:30:14.362130 | debian-bookworm | Downloading requests-2.32.4-py3-none-any.whl (64 kB) 2025-06-10 16:30:14.382254 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl (35 kB) 2025-06-10 16:30:14.402641 | debian-bookworm | Downloading ansible_core-2.18.6-py3-none-any.whl (2.2 MB) 2025-06-10 16:30:14.506775 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 21.4 MB/s eta 0:00:00 2025-06-10 16:30:14.517489 | debian-bookworm | Downloading charset_normalizer-3.4.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (147 kB) 2025-06-10 16:30:14.538479 | debian-bookworm | Downloading idna-3.10-py3-none-any.whl (70 kB) 2025-06-10 16:30:14.557800 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2025-06-10 16:30:14.577512 | debian-bookworm | Downloading urllib3-2.4.0-py3-none-any.whl (128 kB) 2025-06-10 16:30:14.603378 | debian-bookworm | Downloading certifi-2025.4.26-py3-none-any.whl (159 kB) 2025-06-10 16:30:14.624944 | debian-bookworm | Downloading MarkupSafe-3.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (23 kB) 2025-06-10 16:30:14.645576 | debian-bookworm | Downloading cryptography-45.0.4-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2025-06-10 16:30:14.834711 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 23.9 MB/s eta 0:00:00 2025-06-10 16:30:14.844544 | debian-bookworm | Downloading cffi-1.17.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (467 kB) 2025-06-10 16:30:14.879488 | debian-bookworm | Downloading pycparser-2.22-py3-none-any.whl (117 kB) 2025-06-10 16:30:15.187074 | debian-bookworm | Building wheels for collected packages: pwgen 2025-06-10 16:30:15.188356 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2025-06-10 16:30:15.477770 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2025-06-10 16:30:15.479511 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3797 sha256=14e9c6ee8603b3f5d10a22a527cd1ba8af9f5afbba240afac9bc4c3bc67e9917 2025-06-10 16:30:15.480278 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2025-06-10 16:30:15.485554 | debian-bookworm | Successfully built pwgen 2025-06-10 16:30:15.732778 | debian-bookworm | Installing collected packages: resolvelib, python-gilt, pwgen, urllib3, tabulate, PyYAML, pycparser, packaging, MarkupSafe, idna, charset_normalizer, certifi, requests, Jinja2, cffi, cryptography, ansible-core, ansible 2025-06-10 16:30:41.255736 | debian-bookworm | 2025-06-10 16:30:41.257879 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.2 PyYAML-6.0.2 ansible-11.6.0 ansible-core-2.18.6 certifi-2025.4.26 cffi-1.17.1 charset_normalizer-3.4.2 cryptography-45.0.4 idna-3.10 packaging-25.0 pwgen-0.8.2.post0 pycparser-2.22 python-gilt-2.2.4 requests-2.32.4 resolvelib-1.0.1 tabulate-0.9.0 urllib3-2.4.0 2025-06-10 16:30:41.408467 | debian-bookworm | test: 35020 I exit 0 (34.12 seconds) /home/zuul/src/github.com/osism/cfg-generics> python -I -m pip install -r requirements.txt pid=1436 [tox/execute/api.py:294] 2025-06-10 16:30:41.411696 | debian-bookworm | test: OK (34.81 seconds) 2025-06-10 16:30:41.411784 | debian-bookworm | congratulations :) (34.88 seconds) 2025-06-10 16:30:41.926215 | debian-bookworm | ok: Runtime: 0:00:35.101338 2025-06-10 16:30:41.942274 | 2025-06-10 16:30:41.942523 | TASK [tox : Create a tempfile to save tox showconfig] 2025-06-10 16:30:42.332326 | debian-bookworm | changed 2025-06-10 16:30:42.338588 | 2025-06-10 16:30:42.338714 | TASK [tox : Get tox envlist config] 2025-06-10 16:30:43.372000 | debian-bookworm | ok: Runtime: 0:00:00.289710 2025-06-10 16:30:43.387345 | 2025-06-10 16:30:43.387582 | TASK [tox : Install any sibling python packages] 2025-06-10 16:30:43.833651 | debian-bookworm | ok: No setup.cfg, no action needed 2025-06-10 16:30:43.839351 | 2025-06-10 16:30:43.839471 | TASK [tox : Remove tempfile] 2025-06-10 16:30:44.281737 | debian-bookworm | changed 2025-06-10 16:30:44.290686 | 2025-06-10 16:30:44.290828 | TASK [tox : Emit tox command] 2025-06-10 16:30:44.338901 | /home/zuul/.local/tox/bin/tox -etest -vv --skip-missing-interpreters=false 2025-06-10 16:30:44.347807 | 2025-06-10 16:30:44.348001 | TASK [tox : Run tox] 2025-06-10 16:30:44.848164 | debian-bookworm | ROOT: 140 D setup logging to DEBUG on pid 1582 [tox/report.py:222] 2025-06-10 16:30:44.921850 | debian-bookworm | test: 214 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:76] 2025-06-10 16:30:44.922610 | debian-bookworm | test: 215 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-06-10 16:30:44.923496 | debian-bookworm | test: 215 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-06-10 16:30:44.923692 | debian-bookworm | test: 216 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-06-10 16:30:44.923756 | debian-bookworm | test: 216 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-06-10 16:30:44.956007 | debian-bookworm | test: 248 W commands[0]> python3 src/render-images.py [tox/tox_env/api.py:435] 2025-06-10 16:30:45.850032 | debian-bookworm | test: 1142 I exit 0 (0.89 seconds) /home/zuul/src/github.com/osism/cfg-generics> python3 src/render-images.py pid=1589 [tox/execute/api.py:294] 2025-06-10 16:30:45.850606 | debian-bookworm | test: 1143 W commands[1]> cat images.yml [tox/tox_env/api.py:435] 2025-06-10 16:30:45.853220 | debian-bookworm | --- 2025-06-10 16:30:45.853264 | debian-bookworm | # DO NOT EDIT THIS FILE BY HAND -- YOUR CHANGES WILL BE OVERWRITTEN 2025-06-10 16:30:45.853277 | debian-bookworm | 2025-06-10 16:30:45.853288 | debian-bookworm | adminer_tag: "5.3.0" 2025-06-10 16:30:45.853319 | debian-bookworm | adminer_image: "{{ docker_registry }}/library/adminer:{{ adminer_tag }}" 2025-06-10 16:30:45.853327 | debian-bookworm | 2025-06-10 16:30:45.853336 | debian-bookworm | ara_server_tag: "1.7.2" 2025-06-10 16:30:45.853345 | debian-bookworm | ara_server_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/ara-server:{{ ara_server_tag }}" 2025-06-10 16:30:45.853354 | debian-bookworm | 2025-06-10 16:30:45.853362 | debian-bookworm | ara_server_mariadb_tag: "11.7.2" 2025-06-10 16:30:45.853371 | debian-bookworm | ara_server_mariadb_image: "{{ docker_registry }}/library/mariadb:{{ ara_server_mariadb_tag }}" 2025-06-10 16:30:45.853380 | debian-bookworm | 2025-06-10 16:30:45.853389 | debian-bookworm | netbox_tag: "v4.2.2" 2025-06-10 16:30:45.853398 | debian-bookworm | netbox_image: "{{ docker_registry_netbox|default('quay.io') }}/osism/netbox:{{ netbox_tag }}" 2025-06-10 16:30:45.853406 | debian-bookworm | 2025-06-10 16:30:45.853414 | debian-bookworm | netbox_redis_tag: "7.4.4-alpine" 2025-06-10 16:30:45.853422 | debian-bookworm | netbox_redis_image: "{{ docker_registry }}/library/redis:{{ netbox_redis_tag }}" 2025-06-10 16:30:45.853431 | debian-bookworm | 2025-06-10 16:30:45.853439 | debian-bookworm | nginx_tag: "1.28.0-alpine" 2025-06-10 16:30:45.853447 | debian-bookworm | nginx_image: "{{ docker_registry }}/library/nginx:{{ nginx_tag }}" 2025-06-10 16:30:45.853455 | debian-bookworm | 2025-06-10 16:30:45.853464 | debian-bookworm | pgautoupgrade_tag: "16-alpine" 2025-06-10 16:30:45.853472 | debian-bookworm | pgautoupgrade_image: "{{ docker_registry }}/pgautoupgrade/pgautoupgrade:{{ pgautoupgrade_tag }}" 2025-06-10 16:30:45.853480 | debian-bookworm | 2025-06-10 16:30:45.853488 | debian-bookworm | phpmyadmin_tag: "5.2.2" 2025-06-10 16:30:45.853497 | debian-bookworm | phpmyadmin_image: "{{ docker_registry }}/phpmyadmin/phpmyadmin:{{ phpmyadmin_tag }}" 2025-06-10 16:30:45.853505 | debian-bookworm | 2025-06-10 16:30:45.853513 | debian-bookworm | postgres_tag: "16.9-alpine" 2025-06-10 16:30:45.855851 | debian-bookworm | postgres_image: "{{ docker_registry }}/library/postgres:{{ postgres_tag }}" 2025-06-10 16:30:45.855923 | debian-bookworm | 2025-06-10 16:30:45.855936 | debian-bookworm | manager_redis_tag: "7.4.4-alpine" 2025-06-10 16:30:45.855949 | debian-bookworm | manager_redis_image: "{{ docker_registry }}/library/redis:{{ manager_redis_tag }}" 2025-06-10 16:30:45.855960 | debian-bookworm | 2025-06-10 16:30:45.855971 | debian-bookworm | registry_tag: "3.0" 2025-06-10 16:30:45.855982 | debian-bookworm | registry_image: "{{ docker_registry }}/library/registry:{{ registry_tag }}" 2025-06-10 16:30:45.855992 | debian-bookworm | 2025-06-10 16:30:45.856001 | debian-bookworm | osism_ansible_tag: "{{ osism_ansible_version|default('latest') }}" 2025-06-10 16:30:45.856012 | debian-bookworm | osism_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/osism-ansible:{{ osism_ansible_tag }}" 2025-06-10 16:30:45.856043 | debian-bookworm | 2025-06-10 16:30:45.856053 | debian-bookworm | osism_kubernetes_tag: "{{ osism_kubernetes_version|default('latest') }}" 2025-06-10 16:30:45.856063 | debian-bookworm | osism_kubernetes_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/osism-kubernetes:{{ osism_kubernetes_tag }}" 2025-06-10 16:30:45.856074 | debian-bookworm | 2025-06-10 16:30:45.856084 | debian-bookworm | inventory_reconciler_tag: "{{ inventory_reconciler_version|default('latest') }}" 2025-06-10 16:30:45.856094 | debian-bookworm | inventory_reconciler_image: "{{ docker_registry_ansible }}/osism/inventory-reconciler:{{ inventory_reconciler_tag }}" 2025-06-10 16:30:45.856105 | debian-bookworm | 2025-06-10 16:30:45.856116 | debian-bookworm | osism_tag: "{{ osism_version|default('latest') }}" 2025-06-10 16:30:45.856126 | debian-bookworm | osism_image: "{{ docker_registry_ansible }}/osism/osism:{{ osism_tag }}" 2025-06-10 16:30:45.856135 | debian-bookworm | 2025-06-10 16:30:45.856515 | debian-bookworm | osism_netbox_tag: "{{ osism_version|default('latest') }}" 2025-06-10 16:30:45.856538 | debian-bookworm | osism_netbox_image: "{{ docker_registry_ansible }}/osism/osism-netbox:{{ osism_netbox_tag }}" 2025-06-10 16:30:45.856547 | debian-bookworm | 2025-06-10 16:30:45.856556 | debian-bookworm | vault_tag: "1.19.5" 2025-06-10 16:30:45.856566 | debian-bookworm | vault_image: "{{ docker_registry }}/hashicorp/vault:{{ vault_tag }}" 2025-06-10 16:30:45.856575 | debian-bookworm | 2025-06-10 16:30:45.856583 | debian-bookworm | traefik_tag: "v3.4.1" 2025-06-10 16:30:45.856596 | debian-bookworm | traefik_image: "{{ docker_registry }}/library/traefik:{{ traefik_tag }}" 2025-06-10 16:30:45.856605 | debian-bookworm | 2025-06-10 16:30:45.856614 | debian-bookworm | ceph_ansible_tag: "{{ ceph_version|default('quincy') }}" 2025-06-10 16:30:45.856623 | debian-bookworm | ceph_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/ceph-ansible:{{ ceph_ansible_tag }}" 2025-06-10 16:30:45.856632 | debian-bookworm | 2025-06-10 16:30:45.856641 | debian-bookworm | kolla_ansible_tag: "{{ openstack_version|default('2024.2') }}" 2025-06-10 16:30:45.856650 | debian-bookworm | kolla_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/kolla-ansible:{{ kolla_ansible_tag }}" 2025-06-10 16:30:45.858572 | debian-bookworm | test: 1150 I exit 0 (0.01 seconds) /home/zuul/src/github.com/osism/cfg-generics> cat images.yml pid=1594 [tox/execute/api.py:294] 2025-06-10 16:30:45.859214 | debian-bookworm | test: OK (0.94=setup[0.04]+cmd[0.89,0.01] seconds) 2025-06-10 16:30:45.859246 | debian-bookworm | congratulations :) (1.01 seconds) 2025-06-10 16:30:46.416636 | debian-bookworm | ok: Runtime: 0:00:01.243825 2025-06-10 16:30:46.430101 | 2025-06-10 16:30:46.430248 | TASK [tox : Look for output] 2025-06-10 16:30:46.881940 | debian-bookworm | ok 2025-06-10 16:30:46.899585 | 2025-06-10 16:30:46.899734 | TASK [tox : Return file comments to Zuul] 2025-06-10 16:30:46.933974 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:46.945275 | 2025-06-10 16:30:46.945385 | PLAY RECAP 2025-06-10 16:30:46.945462 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-06-10 16:30:46.945498 | 2025-06-10 16:30:47.057643 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-06-10 16:30:47.058769 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-06-10 16:30:47.742170 | 2025-06-10 16:30:47.742289 | PLAY [all] 2025-06-10 16:30:47.756312 | 2025-06-10 16:30:47.756418 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-06-10 16:30:47.822015 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:47.828580 | 2025-06-10 16:30:47.828712 | TASK [fetch-tox-output : Set tox log path for single node] 2025-06-10 16:30:47.861297 | debian-bookworm | ok 2025-06-10 16:30:47.867717 | 2025-06-10 16:30:47.867831 | TASK [fetch-tox-output : Ensure local tox dir] 2025-06-10 16:30:48.327728 | debian-bookworm -> localhost | changed 2025-06-10 16:30:48.334989 | 2025-06-10 16:30:48.335084 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-06-10 16:30:48.388259 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:48.399822 | 2025-06-10 16:30:48.399985 | TASK [fetch-tox-output : Set envlist fact] 2025-06-10 16:30:48.440488 | debian-bookworm | ok 2025-06-10 16:30:48.446363 | 2025-06-10 16:30:48.446470 | TASK [fetch-tox-output : Get tox version] 2025-06-10 16:30:49.098593 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-06-10 16:30:49.117298 | debian-bookworm | 4.26.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-06-10 16:30:49.477319 | debian-bookworm | ok: Runtime: 0:00:00.297517 2025-06-10 16:30:49.491348 | 2025-06-10 16:30:49.491489 | TASK [fetch-tox-output : Find all default environments] 2025-06-10 16:30:50.026787 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:50.033956 | 2025-06-10 16:30:50.034088 | TASK [fetch-tox-output : Set envlist fact] 2025-06-10 16:30:50.068967 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:50.082574 | 2025-06-10 16:30:50.082747 | TASK [fetch-tox-output : Find all default environments] 2025-06-10 16:30:50.615586 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:50.629249 | 2025-06-10 16:30:50.629428 | TASK [fetch-tox-output : Set envlist fact] 2025-06-10 16:30:50.665196 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:50.680361 | 2025-06-10 16:30:50.680551 | LOOP [fetch-tox-output : Copy tox logs] 2025-06-10 16:30:50.728847 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:50.747127 | 2025-06-10 16:30:50.747314 | LOOP [fetch-tox-output : Collect tox logs] 2025-06-10 16:30:51.508579 | debian-bookworm | changed: 2025-06-10 16:30:51.508790 | debian-bookworm | created directory /var/lib/zuul/builds/a2a3540ba1464981852a304a221029bc/work/logs/tox/test 2025-06-10 16:30:51.508825 | debian-bookworm | cd+++++++++ ./ 2025-06-10 16:30:51.508851 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-06-10 16:30:51.508875 | debian-bookworm | >f+++++++++ 2-commands[1].log 2025-06-10 16:30:51.508914 | 2025-06-10 16:30:51.526634 | 2025-06-10 16:30:51.526768 | PLAY RECAP 2025-06-10 16:30:51.526908 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-06-10 16:30:51.526959 | 2025-06-10 16:30:51.632705 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-06-10 16:30:51.633763 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-06-10 16:30:52.348947 | 2025-06-10 16:30:52.349089 | PLAY [all] 2025-06-10 16:30:52.363132 | 2025-06-10 16:30:52.363244 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-06-10 16:30:52.603326 | debian-bookworm | changed: non-zero return code 2025-06-10 16:30:52.612583 | 2025-06-10 16:30:52.612765 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-06-10 16:30:52.638183 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:52.650212 | 2025-06-10 16:30:52.650401 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-06-10 16:30:52.700673 | 2025-06-10 16:30:52.700966 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-06-10 16:30:52.751830 | 2025-06-10 16:30:52.752153 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-06-10 16:30:52.777493 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:52.787594 | 2025-06-10 16:30:52.787738 | LOOP [fetch-subunit-output : Generate subunit file] 2025-06-10 16:30:52.825949 | 2025-06-10 16:30:52.826316 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-06-10 16:30:52.852177 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:52.865345 | 2025-06-10 16:30:52.865537 | TASK [fetch-subunit-output : Remove the temporary file] 2025-06-10 16:30:52.891304 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:52.907032 | 2025-06-10 16:30:52.907213 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-06-10 16:30:52.942580 | debian-bookworm | skipping: Conditional result was False 2025-06-10 16:30:52.957854 | 2025-06-10 16:30:52.958035 | PLAY RECAP 2025-06-10 16:30:52.958127 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-06-10 16:30:52.958171 | 2025-06-10 16:30:53.076497 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-06-10 16:30:53.077880 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-10 16:30:53.814498 | 2025-06-10 16:30:53.814664 | PLAY [Base post] 2025-06-10 16:30:53.829296 | 2025-06-10 16:30:53.829448 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-06-10 16:30:54.410773 | debian-bookworm | changed 2025-06-10 16:30:54.419572 | 2025-06-10 16:30:54.419704 | PLAY RECAP 2025-06-10 16:30:54.419835 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-06-10 16:30:54.419924 | 2025-06-10 16:30:54.548689 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-10 16:30:54.551825 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-06-10 16:30:55.504512 | 2025-06-10 16:30:55.504738 | PLAY [Base post-logs] 2025-06-10 16:30:55.517869 | 2025-06-10 16:30:55.518093 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-06-10 16:30:56.005680 | localhost | changed 2025-06-10 16:30:56.024220 | 2025-06-10 16:30:56.024425 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-06-10 16:30:56.052168 | localhost | ok 2025-06-10 16:30:56.056115 | 2025-06-10 16:30:56.056235 | TASK [Set zuul-log-path fact] 2025-06-10 16:30:56.073154 | localhost | ok 2025-06-10 16:30:56.087532 | 2025-06-10 16:30:56.087696 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-10 16:30:56.135379 | localhost | ok 2025-06-10 16:30:56.142043 | 2025-06-10 16:30:56.142217 | TASK [upload-logs : Create log directories] 2025-06-10 16:30:56.702906 | localhost | changed 2025-06-10 16:30:56.708627 | 2025-06-10 16:30:56.708744 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-06-10 16:30:57.250827 | localhost -> localhost | ok: Runtime: 0:00:00.008808 2025-06-10 16:30:57.258137 | 2025-06-10 16:30:57.258365 | TASK [upload-logs : Upload logs to log server] 2025-06-10 16:30:57.858525 | localhost | Output suppressed because no_log was given 2025-06-10 16:30:57.863221 | 2025-06-10 16:30:57.863419 | LOOP [upload-logs : Compress console log and json output] 2025-06-10 16:30:57.923973 | localhost | skipping: Conditional result was False 2025-06-10 16:30:57.929649 | localhost | skipping: Conditional result was False 2025-06-10 16:30:57.935639 | 2025-06-10 16:30:57.935839 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-10 16:30:57.986993 | localhost | skipping: Conditional result was False 2025-06-10 16:30:57.987611 | 2025-06-10 16:30:57.991033 | localhost | skipping: Conditional result was False 2025-06-10 16:30:58.000226 | 2025-06-10 16:30:58.000483 | LOOP [upload-logs : Upload console log and json output]