2025-07-16 03:07:51.792873 | Job console starting 2025-07-16 03:07:51.803336 | Updating git repos 2025-07-16 03:07:51.846966 | Cloning repos into workspace 2025-07-16 03:07:51.907821 | Restoring repo states 2025-07-16 03:07:51.949184 | Merging changes 2025-07-16 03:07:51.949201 | Checking out repos 2025-07-16 03:07:52.033138 | Preparing playbooks 2025-07-16 03:07:52.896306 | Running Ansible setup 2025-07-16 03:07:59.041696 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-16 03:08:00.095671 | 2025-07-16 03:08:00.095830 | PLAY [Base pre] 2025-07-16 03:08:00.128529 | 2025-07-16 03:08:00.128689 | TASK [Setup log path fact] 2025-07-16 03:08:00.170008 | debian-bookworm | ok 2025-07-16 03:08:00.196393 | 2025-07-16 03:08:00.196609 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-16 03:08:00.228638 | debian-bookworm | ok 2025-07-16 03:08:00.239948 | 2025-07-16 03:08:00.240079 | TASK [emit-job-header : Print job information] 2025-07-16 03:08:00.281598 | # Job Information 2025-07-16 03:08:00.281788 | Ansible Version: 2.16.14 2025-07-16 03:08:00.281824 | Job: cfg-generics-tox-test-stable-legacy 2025-07-16 03:08:00.281858 | Pipeline: periodic-daily 2025-07-16 03:08:00.281881 | Executor: 521e9411259a 2025-07-16 03:08:00.281902 | Triggered by: https://github.com/osism/cfg-generics 2025-07-16 03:08:00.281925 | Event ID: 0f1a22c75c5a4c88b683fb9fcb64a14b 2025-07-16 03:08:00.290435 | 2025-07-16 03:08:00.290613 | LOOP [emit-job-header : Print node information] 2025-07-16 03:08:00.483341 | debian-bookworm | ok: 2025-07-16 03:08:00.487705 | debian-bookworm | # Node Information 2025-07-16 03:08:00.487808 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-16 03:08:00.487839 | debian-bookworm | Hostname: debian 2025-07-16 03:08:00.487863 | debian-bookworm | Username: zuul 2025-07-16 03:08:00.487884 | debian-bookworm | Distro: Debian 12.11 2025-07-16 03:08:00.487910 | debian-bookworm | Provider: regiocloud-a 2025-07-16 03:08:00.487931 | debian-bookworm | Region: 2025-07-16 03:08:00.487954 | debian-bookworm | Label: debian-bookworm 2025-07-16 03:08:00.487974 | debian-bookworm | Product Name: OpenStack Nova 2025-07-16 03:08:00.487993 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef1:d0cc 2025-07-16 03:08:00.508947 | 2025-07-16 03:08:00.509110 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-16 03:08:01.317046 | debian-bookworm -> localhost | changed 2025-07-16 03:08:01.325045 | 2025-07-16 03:08:01.325187 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-16 03:08:02.857672 | debian-bookworm -> localhost | changed 2025-07-16 03:08:02.870523 | 2025-07-16 03:08:02.870632 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-16 03:08:03.177414 | debian-bookworm -> localhost | ok 2025-07-16 03:08:03.183311 | 2025-07-16 03:08:03.183413 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-16 03:08:03.221951 | debian-bookworm | ok 2025-07-16 03:08:03.252409 | debian-bookworm | included: /var/lib/zuul/builds/c3e790bcab764281843e47e29b740018/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-16 03:08:03.258381 | 2025-07-16 03:08:03.258506 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-16 03:08:04.580600 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-16 03:08:04.580805 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c3e790bcab764281843e47e29b740018/work/c3e790bcab764281843e47e29b740018_id_rsa 2025-07-16 03:08:04.580847 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c3e790bcab764281843e47e29b740018/work/c3e790bcab764281843e47e29b740018_id_rsa.pub 2025-07-16 03:08:04.580874 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-16 03:08:04.580899 | debian-bookworm -> localhost | SHA256:StbBGXY4dQ6i/1HknGvsE1hl0qwOPdsZmhk/X2ZQdS8 zuul-build-sshkey 2025-07-16 03:08:04.580933 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-16 03:08:04.580956 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-16 03:08:04.580977 | debian-bookworm -> localhost | | +o+ +oo +| 2025-07-16 03:08:04.580999 | debian-bookworm -> localhost | | +o= B =o +| 2025-07-16 03:08:04.581019 | debian-bookworm -> localhost | | . +. .B.E..| 2025-07-16 03:08:04.581039 | debian-bookworm -> localhost | | o ..==.o. | 2025-07-16 03:08:04.581059 | debian-bookworm -> localhost | | o S oo=X + | 2025-07-16 03:08:04.581082 | debian-bookworm -> localhost | | o . . +*.= +| 2025-07-16 03:08:04.581103 | debian-bookworm -> localhost | | . . o =.| 2025-07-16 03:08:04.581123 | debian-bookworm -> localhost | | . .| 2025-07-16 03:08:04.581145 | debian-bookworm -> localhost | | | 2025-07-16 03:08:04.581166 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-16 03:08:04.581221 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.485038 2025-07-16 03:08:04.587437 | 2025-07-16 03:08:04.587571 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-16 03:08:04.605862 | debian-bookworm | ok 2025-07-16 03:08:04.615382 | debian-bookworm | included: /var/lib/zuul/builds/c3e790bcab764281843e47e29b740018/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-16 03:08:04.624021 | 2025-07-16 03:08:04.624126 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-16 03:08:04.637360 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:08:04.650860 | 2025-07-16 03:08:04.651019 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-16 03:08:05.289352 | debian-bookworm | changed 2025-07-16 03:08:05.298015 | 2025-07-16 03:08:05.298118 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-16 03:08:05.568220 | debian-bookworm | ok 2025-07-16 03:08:05.575787 | 2025-07-16 03:08:05.575904 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-16 03:08:06.260650 | debian-bookworm | changed 2025-07-16 03:08:06.267679 | 2025-07-16 03:08:06.267772 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-16 03:08:06.937213 | debian-bookworm | changed 2025-07-16 03:08:06.949801 | 2025-07-16 03:08:06.949922 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-16 03:08:07.007328 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:08:07.013688 | 2025-07-16 03:08:07.013808 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-16 03:08:08.137092 | debian-bookworm -> localhost | changed 2025-07-16 03:08:08.154213 | 2025-07-16 03:08:08.158932 | TASK [add-build-sshkey : Add back temp key] 2025-07-16 03:08:08.933288 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c3e790bcab764281843e47e29b740018/work/c3e790bcab764281843e47e29b740018_id_rsa (zuul-build-sshkey) 2025-07-16 03:08:08.933520 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011864 2025-07-16 03:08:08.941078 | 2025-07-16 03:08:08.941167 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-16 03:08:09.339075 | debian-bookworm | ok 2025-07-16 03:08:09.347386 | 2025-07-16 03:08:09.347501 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-16 03:08:09.371251 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:08:09.382503 | 2025-07-16 03:08:09.382607 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-16 03:08:09.820056 | debian-bookworm | ok 2025-07-16 03:08:09.845309 | 2025-07-16 03:08:09.847311 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-16 03:08:09.890236 | debian-bookworm | ok 2025-07-16 03:08:09.899882 | 2025-07-16 03:08:09.900655 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-16 03:08:10.459426 | debian-bookworm -> localhost | ok 2025-07-16 03:08:10.466345 | 2025-07-16 03:08:10.466489 | TASK [validate-host : Collect information about the host] 2025-07-16 03:08:11.719781 | debian-bookworm | ok 2025-07-16 03:08:11.760271 | 2025-07-16 03:08:11.760380 | TASK [validate-host : Sanitize hostname] 2025-07-16 03:08:11.904310 | debian-bookworm | ok 2025-07-16 03:08:11.997763 | 2025-07-16 03:08:11.997877 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-16 03:08:13.280496 | debian-bookworm -> localhost | changed 2025-07-16 03:08:13.286625 | 2025-07-16 03:08:13.286754 | TASK [validate-host : Collect information about zuul worker] 2025-07-16 03:08:13.844036 | debian-bookworm | ok 2025-07-16 03:08:13.849088 | 2025-07-16 03:08:13.849209 | TASK [validate-host : Write out all zuul information for each host] 2025-07-16 03:08:14.808781 | debian-bookworm -> localhost | changed 2025-07-16 03:08:14.822265 | 2025-07-16 03:08:14.822377 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-16 03:08:15.114446 | debian-bookworm | ok 2025-07-16 03:08:15.119785 | 2025-07-16 03:08:15.119892 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-16 03:08:16.194683 | debian-bookworm | changed: 2025-07-16 03:08:16.198904 | debian-bookworm | cd+++++++++ src/ 2025-07-16 03:08:16.198977 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-16 03:08:16.199005 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-16 03:08:16.199029 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-generics/ 2025-07-16 03:08:16.199050 | debian-bookworm | =5.5.1 2025-07-16 03:08:39.404600 | debian-bookworm | Downloading cachetools-6.1.0-py3-none-any.whl (11 kB) 2025-07-16 03:08:39.434839 | debian-bookworm | Collecting chardet>=5.2 2025-07-16 03:08:39.442864 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-07-16 03:08:39.459885 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 14.2 MB/s eta 0:00:00 2025-07-16 03:08:39.493599 | debian-bookworm | Collecting colorama>=0.4.6 2025-07-16 03:08:39.501699 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-07-16 03:08:39.555752 | debian-bookworm | Collecting filelock>=3.16.1 2025-07-16 03:08:39.563548 | debian-bookworm | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-07-16 03:08:39.616259 | debian-bookworm | Collecting packaging>=24.2 2025-07-16 03:08:39.624086 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-07-16 03:08:39.634728 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.2 MB/s eta 0:00:00 2025-07-16 03:08:39.677806 | debian-bookworm | Collecting platformdirs>=4.3.6 2025-07-16 03:08:39.685808 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-07-16 03:08:39.733222 | debian-bookworm | Collecting pluggy>=1.5 2025-07-16 03:08:39.741060 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-07-16 03:08:39.780639 | debian-bookworm | Collecting pyproject-api>=1.8 2025-07-16 03:08:39.788190 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-07-16 03:08:39.924790 | debian-bookworm | Collecting virtualenv>=20.31 2025-07-16 03:08:39.932911 | debian-bookworm | Downloading virtualenv-20.31.2-py3-none-any.whl (6.1 MB) 2025-07-16 03:08:40.175001 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.1/6.1 MB 25.4 MB/s eta 0:00:00 2025-07-16 03:08:40.284147 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-07-16 03:08:40.291892 | debian-bookworm | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-07-16 03:08:40.314941 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 23.6 MB/s eta 0:00:00 2025-07-16 03:08:40.480807 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-07-16 03:08:41.364986 | 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-16 03:08:41.850264 | debian-bookworm | ok: Runtime: 0:00:02.910501 2025-07-16 03:08:41.855014 | 2025-07-16 03:08:41.855094 | TASK [ensure-tox : Export installed tox_executable path] 2025-07-16 03:08:41.903199 | debian-bookworm | ok 2025-07-16 03:08:41.907198 | 2025-07-16 03:08:41.907275 | TASK [ensure-tox : Output tox version] 2025-07-16 03:08:42.450739 | 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-16 03:08:42.469604 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-07-16 03:08:42.936779 | debian-bookworm | ok: Runtime: 0:00:00.314485 2025-07-16 03:08:42.941365 | 2025-07-16 03:08:42.941464 | TASK [ensure-tox : Make global symlink] 2025-07-16 03:08:42.974309 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:08:42.979995 | 2025-07-16 03:08:42.980067 | PLAY RECAP 2025-07-16 03:08:42.980487 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-07-16 03:08:42.980529 | 2025-07-16 03:08:43.070757 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-07-16 03:08:43.071610 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-07-16 03:08:43.925897 | 2025-07-16 03:08:43.926005 | PLAY [all] 2025-07-16 03:08:43.952751 | 2025-07-16 03:08:43.952863 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-07-16 03:08:44.584252 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-07-16 03:08:44.978765 | debian-bookworm | ok: Runtime: 0:00:00.026735 2025-07-16 03:08:44.983392 | 2025-07-16 03:08:44.983494 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-07-16 03:08:45.542494 | debian-bookworm | ok: Runtime: 0:00:00.007605 2025-07-16 03:08:45.547255 | 2025-07-16 03:08:45.547336 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-07-16 03:08:45.908443 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-07-16 03:08:45.910536 | debian-bookworm | sudo: a password is required 2025-07-16 03:08:46.098440 | debian-bookworm | ok: Runtime: 0:00:00.019817 2025-07-16 03:08:46.107976 | 2025-07-16 03:08:46.108067 | TASK [tox : Check to see if the constraints file exists] 2025-07-16 03:08:46.165558 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:08:46.171367 | 2025-07-16 03:08:46.171472 | TASK [tox : Fail if constraints file is missing] 2025-07-16 03:08:46.225093 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:08:46.241973 | 2025-07-16 03:08:46.242079 | TASK [tox : Record file location] 2025-07-16 03:08:46.298971 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:08:46.305632 | 2025-07-16 03:08:46.305736 | TASK [tox : Install tox siblings] 2025-07-16 03:08:46.348914 | debian-bookworm | ok 2025-07-16 03:08:46.369267 | debian-bookworm | included: /var/lib/zuul/builds/c3e790bcab764281843e47e29b740018/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-07-16 03:08:46.386224 | 2025-07-16 03:08:46.386333 | TASK [tox : Run tox without tests] 2025-07-16 03:08:46.923462 | debian-bookworm | ROOT: 152 D setup logging to DEBUG on pid 1421 [tox/report.py:222] 2025-07-16 03:08:46.997639 | debian-bookworm | test: 226 D created app data folder /home/zuul/.local/share/virtualenv [virtualenv/app_data/__init__.py:42] 2025-07-16 03:08:47.000563 | debian-bookworm | test: 229 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:76] 2025-07-16 03:08:47.001496 | debian-bookworm | test: 230 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/discovery/py_info.py No3L1P8Fdx4fR1XSdvsPLiGr89q3xdzP gbyJU6jTxbP9W8LPoyiLVTOKB6Bd2NrY [virtualenv/discovery/cached_py_info.py:117] 2025-07-16 03:08:47.073785 | debian-bookworm | test: 302 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-16 03:08:47.074926 | debian-bookworm | test: 304 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-07-16 03:08:47.075353 | debian-bookworm | test: 304 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-16 03:08:47.075608 | debian-bookworm | test: 304 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-16 03:08:47.114677 | debian-bookworm | test: 343 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-16 03:08:47.114932 | debian-bookworm | test: 344 D create folder /home/zuul/src/github.com/osism/cfg-generics/.tox/test/bin [virtualenv/util/path/_sync.py:14] 2025-07-16 03:08:47.115098 | debian-bookworm | test: 344 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-16 03:08:47.115375 | debian-bookworm | test: 344 D write /home/zuul/src/github.com/osism/cfg-generics/.tox/test/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-07-16 03:08:47.115449 | debian-bookworm | test: 344 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.115513 | debian-bookworm | test: 344 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.115550 | debian-bookworm | test: 344 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.115597 | debian-bookworm | test: 345 D virtualenv = 20.31.2 [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.115644 | debian-bookworm | test: 345 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.115717 | debian-bookworm | test: 345 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.115761 | debian-bookworm | test: 345 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.115826 | debian-bookworm | test: 345 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.116091 | debian-bookworm | test: 345 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-16 03:08:47.116491 | debian-bookworm | test: 345 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-16 03:08:47.116636 | debian-bookworm | test: 346 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-16 03:08:47.117097 | debian-bookworm | test: 346 D ============================== target debug ============================== [virtualenv/run/session.py:54] 2025-07-16 03:08:47.117364 | debian-bookworm | test: 346 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-16 03:08:47.155490 | debian-bookworm | test: 346 D { 2025-07-16 03:08:47.155534 | debian-bookworm | "sys": { 2025-07-16 03:08:47.155541 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/cfg-generics/.tox/test/bin/python", 2025-07-16 03:08:47.155547 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2025-07-16 03:08:47.155553 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/cfg-generics/.tox/test", 2025-07-16 03:08:47.155559 | debian-bookworm | "base_prefix": "/usr", 2025-07-16 03:08:47.155565 | debian-bookworm | "real_prefix": null, 2025-07-16 03:08:47.155569 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/cfg-generics/.tox/test", 2025-07-16 03:08:47.155575 | debian-bookworm | "base_exec_prefix": "/usr", 2025-07-16 03:08:47.155579 | debian-bookworm | "path": [ 2025-07-16 03:08:47.155585 | debian-bookworm | "/usr/lib/python311.zip", 2025-07-16 03:08:47.155590 | debian-bookworm | "/usr/lib/python3.11", 2025-07-16 03:08:47.155594 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2025-07-16 03:08:47.155598 | debian-bookworm | "/home/zuul/src/github.com/osism/cfg-generics/.tox/test/lib/python3.11/site-packages" 2025-07-16 03:08:47.155602 | debian-bookworm | ], 2025-07-16 03:08:47.155606 | debian-bookworm | "meta_path": [ 2025-07-16 03:08:47.155610 | debian-bookworm | "", 2025-07-16 03:08:47.155614 | debian-bookworm | "", 2025-07-16 03:08:47.155619 | debian-bookworm | "", 2025-07-16 03:08:47.155623 | debian-bookworm | "" 2025-07-16 03:08:47.155627 | debian-bookworm | ], 2025-07-16 03:08:47.155631 | debian-bookworm | "fs_encoding": "utf-8", 2025-07-16 03:08:47.155634 | debian-bookworm | "io_encoding": "utf-8" 2025-07-16 03:08:47.155638 | debian-bookworm | }, 2025-07-16 03:08:47.155643 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2025-07-16 03:08:47.155646 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2025-07-16 03:08:47.155650 | debian-bookworm | "os": "", 2025-07-16 03:08:47.155654 | debian-bookworm | "site": "", 2025-07-16 03:08:47.155658 | debian-bookworm | "datetime": "", 2025-07-16 03:08:47.155662 | debian-bookworm | "math": "", 2025-07-16 03:08:47.155666 | debian-bookworm | "json": "" 2025-07-16 03:08:47.155669 | debian-bookworm | } [virtualenv/run/session.py:55] 2025-07-16 03:08:47.155830 | 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-16 03:08:47.157952 | debian-bookworm | test: 387 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-16 03:08:47.160459 | debian-bookworm | test: 388 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-16 03:08:47.162912 | 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-07-16 03:08:47.164883 | debian-bookworm | test: 394 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-16 03:08:47.376457 | debian-bookworm | test: 605 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-16 03:08:47.377137 | debian-bookworm | test: 606 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-16 03:08:47.386779 | debian-bookworm | test: 616 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-16 03:08:47.387955 | debian-bookworm | test: 617 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-16 03:08:47.409623 | debian-bookworm | test: 638 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-16 03:08:47.612872 | debian-bookworm | test: 842 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-16 03:08:47.613408 | debian-bookworm | test: 842 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-16 03:08:47.618934 | debian-bookworm | test: 848 D generated console scripts pip3 pip pip-3.11 pip3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-07-16 03:08:47.624797 | debian-bookworm | test: 854 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-16 03:08:47.625138 | debian-bookworm | test: 854 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-16 03:08:47.626083 | debian-bookworm | test: 855 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-07-16 03:08:47.626863 | debian-bookworm | test: 855 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65] 2025-07-16 03:08:47.632687 | debian-bookworm | test: 862 D write /home/zuul/src/github.com/osism/cfg-generics/.tox/test/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-07-16 03:08:47.632819 | debian-bookworm | test: 862 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.632898 | debian-bookworm | test: 862 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.632965 | debian-bookworm | test: 862 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.633030 | debian-bookworm | test: 862 D virtualenv = 20.31.2 [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.633094 | debian-bookworm | test: 862 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.633170 | debian-bookworm | test: 862 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.633272 | debian-bookworm | test: 862 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.633362 | debian-bookworm | test: 862 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-07-16 03:08:47.638444 | debian-bookworm | test: 867 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:459] 2025-07-16 03:08:48.802241 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2025-07-16 03:08:48.863852 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2025-07-16 03:08:48.958051 | debian-bookworm | Collecting PyYAML==6.0.2 (from -r requirements.txt (line 2)) 2025-07-16 03:08:48.966421 | debian-bookworm | Downloading PyYAML-6.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (2.1 kB) 2025-07-16 03:08:49.033663 | debian-bookworm | Collecting ansible==11.7.0 (from -r requirements.txt (line 3)) 2025-07-16 03:08:49.041684 | debian-bookworm | Downloading ansible-11.7.0-py3-none-any.whl.metadata (8.1 kB) 2025-07-16 03:08:49.097104 | debian-bookworm | Collecting packaging==25.0 (from -r requirements.txt (line 4)) 2025-07-16 03:08:49.106881 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl.metadata (3.3 kB) 2025-07-16 03:08:49.138462 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2025-07-16 03:08:49.148674 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2025-07-16 03:08:49.163629 | debian-bookworm | Installing build dependencies: started 2025-07-16 03:08:50.304544 | debian-bookworm | Installing build dependencies: finished with status 'done' 2025-07-16 03:08:50.305744 | debian-bookworm | Getting requirements to build wheel: started 2025-07-16 03:08:50.667666 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2025-07-16 03:08:50.668601 | debian-bookworm | Preparing metadata (pyproject.toml): started 2025-07-16 03:08:50.871612 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2025-07-16 03:08:50.905630 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2025-07-16 03:08:50.915795 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2025-07-16 03:08:50.977522 | debian-bookworm | Collecting requests==2.32.4 (from -r requirements.txt (line 7)) 2025-07-16 03:08:50.985000 | debian-bookworm | Downloading requests-2.32.4-py3-none-any.whl.metadata (4.9 kB) 2025-07-16 03:08:51.013656 | debian-bookworm | Collecting tabulate==0.9.0 (from -r requirements.txt (line 8)) 2025-07-16 03:08:51.021210 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl.metadata (34 kB) 2025-07-16 03:08:51.095996 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2025-07-16 03:08:51.103686 | debian-bookworm | Downloading MarkupSafe-3.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (4.0 kB) 2025-07-16 03:08:51.155745 | debian-bookworm | Collecting ansible-core~=2.18.6 (from ansible==11.7.0->-r requirements.txt (line 3)) 2025-07-16 03:08:51.163720 | debian-bookworm | Downloading ansible_core-2.18.7-py3-none-any.whl.metadata (7.7 kB) 2025-07-16 03:08:51.194409 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-07-16 03:08:51.201131 | debian-bookworm | Downloading click-8.2.1-py3-none-any.whl.metadata (2.5 kB) 2025-07-16 03:08:51.227217 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-07-16 03:08:51.233907 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-07-16 03:08:51.260278 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-07-16 03:08:51.268107 | debian-bookworm | Downloading fasteners-0.19-py3-none-any.whl.metadata (4.9 kB) 2025-07-16 03:08:51.299258 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-07-16 03:08:51.306633 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2025-07-16 03:08:51.406374 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-07-16 03:08:51.413627 | debian-bookworm | Downloading charset_normalizer-3.4.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (35 kB) 2025-07-16 03:08:51.454638 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-07-16 03:08:51.462958 | debian-bookworm | Downloading idna-3.10-py3-none-any.whl.metadata (10 kB) 2025-07-16 03:08:51.522521 | debian-bookworm | Collecting urllib3<3,>=1.21.1 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-07-16 03:08:51.530527 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl.metadata (6.5 kB) 2025-07-16 03:08:51.581543 | debian-bookworm | Collecting certifi>=2017.4.17 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-07-16 03:08:51.589165 | debian-bookworm | Downloading certifi-2025.7.14-py3-none-any.whl.metadata (2.4 kB) 2025-07-16 03:08:51.797362 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.6->ansible==11.7.0->-r requirements.txt (line 3)) 2025-07-16 03:08:51.804958 | debian-bookworm | Downloading cryptography-45.0.5-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2025-07-16 03:08:52.048982 | 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-16 03:08:52.057642 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2025-07-16 03:08:52.212564 | debian-bookworm | Collecting cffi>=1.14 (from cryptography->ansible-core~=2.18.6->ansible==11.7.0->-r requirements.txt (line 3)) 2025-07-16 03:08:52.220213 | debian-bookworm | Downloading cffi-1.17.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB) 2025-07-16 03:08:52.245971 | 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-16 03:08:52.253425 | debian-bookworm | Downloading pycparser-2.22-py3-none-any.whl.metadata (943 bytes) 2025-07-16 03:08:52.273487 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-07-16 03:08:52.299118 | debian-bookworm | Downloading PyYAML-6.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (762 kB) 2025-07-16 03:08:52.334370 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 763.0/763.0 kB 21.8 MB/s eta 0:00:00 2025-07-16 03:08:52.345185 | debian-bookworm | Downloading ansible-11.7.0-py3-none-any.whl (55.8 MB) 2025-07-16 03:08:54.213967 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 55.8/55.8 MB 29.9 MB/s eta 0:00:00 2025-07-16 03:08:54.222391 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-07-16 03:08:54.239182 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2025-07-16 03:08:54.253518 | debian-bookworm | Downloading requests-2.32.4-py3-none-any.whl (64 kB) 2025-07-16 03:08:54.269650 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl (35 kB) 2025-07-16 03:08:54.291895 | debian-bookworm | Downloading ansible_core-2.18.7-py3-none-any.whl (2.2 MB) 2025-07-16 03:08:54.418582 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 17.3 MB/s eta 0:00:00 2025-07-16 03:08:54.429790 | debian-bookworm | Downloading charset_normalizer-3.4.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (147 kB) 2025-07-16 03:08:54.449767 | debian-bookworm | Downloading idna-3.10-py3-none-any.whl (70 kB) 2025-07-16 03:08:54.473332 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2025-07-16 03:08:54.491807 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl (129 kB) 2025-07-16 03:08:54.512900 | debian-bookworm | Downloading certifi-2025.7.14-py3-none-any.whl (162 kB) 2025-07-16 03:08:54.538230 | debian-bookworm | Downloading MarkupSafe-3.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (23 kB) 2025-07-16 03:08:54.557566 | debian-bookworm | Downloading click-8.2.1-py3-none-any.whl (102 kB) 2025-07-16 03:08:54.578348 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-07-16 03:08:54.597903 | debian-bookworm | Downloading cryptography-45.0.5-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2025-07-16 03:08:54.811473 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 21.1 MB/s eta 0:00:00 2025-07-16 03:08:54.821203 | debian-bookworm | Downloading cffi-1.17.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (467 kB) 2025-07-16 03:08:54.859999 | debian-bookworm | Downloading fasteners-0.19-py3-none-any.whl (18 kB) 2025-07-16 03:08:54.879170 | debian-bookworm | Downloading pycparser-2.22-py3-none-any.whl (117 kB) 2025-07-16 03:08:54.898845 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2025-07-16 03:08:55.188728 | debian-bookworm | Building wheels for collected packages: pwgen 2025-07-16 03:08:55.189779 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2025-07-16 03:08:55.482872 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2025-07-16 03:08:55.484411 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3797 sha256=10fc6fe0c5bc7b7429a80c6ae573ec64230e7db2c4feaeab815d0f8b7122c78c 2025-07-16 03:08:55.484941 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2025-07-16 03:08:55.489472 | debian-bookworm | Successfully built pwgen 2025-07-16 03:08:55.729773 | 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-16 03:09:24.018198 | debian-bookworm | 2025-07-16 03:09:24.019692 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.2 PyYAML-6.0.2 ansible-11.7.0 ansible-core-2.18.7 certifi-2025.7.14 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-16 03:09:24.169924 | debian-bookworm | test: 37399 I exit 0 (36.53 seconds) /home/zuul/src/github.com/osism/cfg-generics> python -I -m pip install -r requirements.txt pid=1434 [tox/execute/api.py:294] 2025-07-16 03:09:24.171173 | debian-bookworm | test: OK (37.18 seconds) 2025-07-16 03:09:24.171219 | debian-bookworm | congratulations :) (37.25 seconds) 2025-07-16 03:09:24.462750 | debian-bookworm | ok: Runtime: 0:00:37.487537 2025-07-16 03:09:24.470192 | 2025-07-16 03:09:24.470310 | TASK [tox : Create a tempfile to save tox showconfig] 2025-07-16 03:09:25.103890 | debian-bookworm | changed 2025-07-16 03:09:25.120464 | 2025-07-16 03:09:25.120606 | TASK [tox : Get tox envlist config] 2025-07-16 03:09:26.230343 | debian-bookworm | ok: Runtime: 0:00:00.302614 2025-07-16 03:09:26.234794 | 2025-07-16 03:09:26.235060 | TASK [tox : Install any sibling python packages] 2025-07-16 03:09:27.121475 | debian-bookworm | ok: No setup.cfg, no action needed 2025-07-16 03:09:27.125902 | 2025-07-16 03:09:27.125983 | TASK [tox : Remove tempfile] 2025-07-16 03:09:27.835971 | debian-bookworm | changed 2025-07-16 03:09:27.840412 | 2025-07-16 03:09:27.840488 | TASK [tox : Emit tox command] 2025-07-16 03:09:27.906264 | /home/zuul/.local/tox/bin/tox -etest -vv --skip-missing-interpreters=false 2025-07-16 03:09:27.910285 | 2025-07-16 03:09:27.910392 | TASK [tox : Run tox] 2025-07-16 03:09:28.607887 | debian-bookworm | ROOT: 129 D setup logging to DEBUG on pid 1589 [tox/report.py:222] 2025-07-16 03:09:28.687816 | debian-bookworm | test: 208 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:76] 2025-07-16 03:09:28.689078 | debian-bookworm | test: 210 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-16 03:09:28.690355 | debian-bookworm | test: 211 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-07-16 03:09:28.690614 | debian-bookworm | test: 211 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-16 03:09:28.690738 | debian-bookworm | test: 212 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-16 03:09:28.724250 | debian-bookworm | test: 245 W commands[0]> python3 src/render-images.py [tox/tox_env/api.py:459] 2025-07-16 03:09:29.223017 | debian-bookworm | test: 744 I exit 0 (0.50 seconds) /home/zuul/src/github.com/osism/cfg-generics> python3 src/render-images.py pid=1596 [tox/execute/api.py:294] 2025-07-16 03:09:29.223334 | debian-bookworm | test: 744 W commands[1]> cat images.yml [tox/tox_env/api.py:459] 2025-07-16 03:09:29.227016 | debian-bookworm | --- 2025-07-16 03:09:29.227076 | debian-bookworm | # DO NOT EDIT THIS FILE BY HAND -- YOUR CHANGES WILL BE OVERWRITTEN 2025-07-16 03:09:29.227089 | debian-bookworm | 2025-07-16 03:09:29.227099 | debian-bookworm | adminer_tag: "5.1.0" 2025-07-16 03:09:29.227109 | debian-bookworm | adminer_image: "{{ docker_registry }}/library/adminer:{{ adminer_tag }}" 2025-07-16 03:09:29.227118 | debian-bookworm | 2025-07-16 03:09:29.227126 | debian-bookworm | ara_server_tag: "1.7.2" 2025-07-16 03:09:29.227134 | debian-bookworm | ara_server_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/ara-server:{{ ara_server_tag }}" 2025-07-16 03:09:29.227143 | debian-bookworm | 2025-07-16 03:09:29.227152 | debian-bookworm | ara_server_mariadb_tag: "11.7.2" 2025-07-16 03:09:29.227160 | debian-bookworm | ara_server_mariadb_image: "{{ docker_registry }}/library/mariadb:{{ ara_server_mariadb_tag }}" 2025-07-16 03:09:29.227169 | debian-bookworm | 2025-07-16 03:09:29.227176 | debian-bookworm | netbox_tag: "v4.2.2" 2025-07-16 03:09:29.227184 | debian-bookworm | netbox_image: "{{ docker_registry_netbox|default('quay.io') }}/osism/netbox:{{ netbox_tag }}" 2025-07-16 03:09:29.227192 | debian-bookworm | 2025-07-16 03:09:29.227200 | debian-bookworm | netbox_redis_tag: "7.4.2-alpine" 2025-07-16 03:09:29.227208 | debian-bookworm | netbox_redis_image: "{{ docker_registry }}/library/redis:{{ netbox_redis_tag }}" 2025-07-16 03:09:29.227216 | debian-bookworm | 2025-07-16 03:09:29.227224 | debian-bookworm | nginx_tag: "1.27.4-alpine" 2025-07-16 03:09:29.227232 | debian-bookworm | nginx_image: "{{ docker_registry }}/library/nginx:{{ nginx_tag }}" 2025-07-16 03:09:29.227240 | debian-bookworm | 2025-07-16 03:09:29.227254 | debian-bookworm | pgautoupgrade_tag: "16-alpine" 2025-07-16 03:09:29.227263 | debian-bookworm | pgautoupgrade_image: "{{ docker_registry }}/pgautoupgrade/pgautoupgrade:{{ pgautoupgrade_tag }}" 2025-07-16 03:09:29.227270 | debian-bookworm | 2025-07-16 03:09:29.227279 | debian-bookworm | phpmyadmin_tag: "5.2.2" 2025-07-16 03:09:29.227287 | debian-bookworm | phpmyadmin_image: "{{ docker_registry }}/phpmyadmin/phpmyadmin:{{ phpmyadmin_tag }}" 2025-07-16 03:09:29.227295 | debian-bookworm | 2025-07-16 03:09:29.227303 | debian-bookworm | postgres_tag: "16.8-alpine" 2025-07-16 03:09:29.227970 | debian-bookworm | postgres_image: "{{ docker_registry }}/library/postgres:{{ postgres_tag }}" 2025-07-16 03:09:29.227996 | debian-bookworm | 2025-07-16 03:09:29.228005 | debian-bookworm | manager_redis_tag: "7.4.2-alpine" 2025-07-16 03:09:29.228013 | debian-bookworm | manager_redis_image: "{{ docker_registry }}/library/redis:{{ manager_redis_tag }}" 2025-07-16 03:09:29.228021 | debian-bookworm | 2025-07-16 03:09:29.228029 | debian-bookworm | registry_tag: "3.0" 2025-07-16 03:09:29.228037 | debian-bookworm | registry_image: "{{ docker_registry }}/library/registry:{{ registry_tag }}" 2025-07-16 03:09:29.228045 | debian-bookworm | 2025-07-16 03:09:29.228053 | debian-bookworm | osism_ansible_tag: "0.20250408.0" 2025-07-16 03:09:29.228061 | debian-bookworm | osism_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/osism-ansible:{{ osism_ansible_tag }}" 2025-07-16 03:09:29.228083 | debian-bookworm | 2025-07-16 03:09:29.228092 | debian-bookworm | osism_kubernetes_tag: "0.20250408.0" 2025-07-16 03:09:29.228100 | debian-bookworm | osism_kubernetes_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/osism-kubernetes:{{ osism_kubernetes_tag }}" 2025-07-16 03:09:29.228108 | debian-bookworm | 2025-07-16 03:09:29.228116 | debian-bookworm | inventory_reconciler_tag: "0.20250408.0" 2025-07-16 03:09:29.228124 | debian-bookworm | inventory_reconciler_image: "{{ docker_registry_ansible }}/osism/inventory-reconciler:{{ inventory_reconciler_tag }}" 2025-07-16 03:09:29.228132 | debian-bookworm | 2025-07-16 03:09:29.228140 | debian-bookworm | osism_tag: "0.20250407.0" 2025-07-16 03:09:29.228148 | debian-bookworm | osism_image: "{{ docker_registry_ansible }}/osism/osism:{{ osism_tag }}" 2025-07-16 03:09:29.228156 | debian-bookworm | 2025-07-16 03:09:29.228164 | debian-bookworm | osism_netbox_tag: "0.20250407.0" 2025-07-16 03:09:29.228172 | debian-bookworm | osism_netbox_image: "{{ docker_registry_ansible }}/osism/osism-netbox:{{ osism_netbox_tag }}" 2025-07-16 03:09:29.228180 | debian-bookworm | 2025-07-16 03:09:29.228188 | debian-bookworm | vault_tag: "1.19.1" 2025-07-16 03:09:29.228202 | debian-bookworm | vault_image: "{{ docker_registry }}/hashicorp/vault:{{ vault_tag }}" 2025-07-16 03:09:29.228210 | debian-bookworm | 2025-07-16 03:09:29.228218 | debian-bookworm | traefik_tag: "v3.3.5" 2025-07-16 03:09:29.228228 | debian-bookworm | traefik_image: "{{ docker_registry }}/library/traefik:{{ traefik_tag }}" 2025-07-16 03:09:29.228236 | debian-bookworm | 2025-07-16 03:09:29.228244 | debian-bookworm | ceph_ansible_tag: "{{ ceph_version|default(manager_version) }}" 2025-07-16 03:09:29.228252 | debian-bookworm | ceph_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/ceph-ansible:{{ ceph_ansible_tag }}" 2025-07-16 03:09:29.228260 | debian-bookworm | 2025-07-16 03:09:29.228268 | debian-bookworm | kolla_ansible_tag: "{{ openstack_version|default(manager_version) }}" 2025-07-16 03:09:29.228276 | debian-bookworm | kolla_ansible_image: "{{ docker_registry_ansible|default('quay.io') }}/osism/kolla-ansible:{{ kolla_ansible_tag }}" 2025-07-16 03:09:29.228909 | debian-bookworm | test: 750 I exit 0 (0.00 seconds) /home/zuul/src/github.com/osism/cfg-generics> cat images.yml pid=1601 [tox/execute/api.py:294] 2025-07-16 03:09:29.229724 | debian-bookworm | test: OK (0.56=setup[0.06]+cmd[0.50,0.00] seconds) 2025-07-16 03:09:29.229751 | debian-bookworm | congratulations :) (0.62 seconds) 2025-07-16 03:09:29.611574 | debian-bookworm | ok: Runtime: 0:00:00.828808 2025-07-16 03:09:29.616853 | 2025-07-16 03:09:29.616930 | TASK [tox : Look for output] 2025-07-16 03:09:30.185286 | debian-bookworm | ok 2025-07-16 03:09:30.197989 | 2025-07-16 03:09:30.198077 | TASK [tox : Return file comments to Zuul] 2025-07-16 03:09:30.231543 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:30.237006 | 2025-07-16 03:09:30.237073 | PLAY RECAP 2025-07-16 03:09:30.237115 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-07-16 03:09:30.237134 | 2025-07-16 03:09:30.598966 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-07-16 03:09:30.599765 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-07-16 03:09:31.934532 | 2025-07-16 03:09:31.935402 | PLAY [all] 2025-07-16 03:09:31.978413 | 2025-07-16 03:09:31.978765 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-07-16 03:09:32.055868 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:32.063245 | 2025-07-16 03:09:32.063389 | TASK [fetch-tox-output : Set tox log path for single node] 2025-07-16 03:09:32.237169 | debian-bookworm | ok 2025-07-16 03:09:32.245748 | 2025-07-16 03:09:32.245850 | TASK [fetch-tox-output : Ensure local tox dir] 2025-07-16 03:09:33.904330 | debian-bookworm -> localhost | changed 2025-07-16 03:09:33.922423 | 2025-07-16 03:09:33.923236 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-07-16 03:09:34.006653 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:34.012914 | 2025-07-16 03:09:34.013007 | TASK [fetch-tox-output : Set envlist fact] 2025-07-16 03:09:34.097037 | debian-bookworm | ok 2025-07-16 03:09:34.101494 | 2025-07-16 03:09:34.101582 | TASK [fetch-tox-output : Get tox version] 2025-07-16 03:09:34.758085 | 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-16 03:09:34.775457 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-07-16 03:09:35.148418 | debian-bookworm | ok: Runtime: 0:00:00.268379 2025-07-16 03:09:35.153649 | 2025-07-16 03:09:35.153747 | TASK [fetch-tox-output : Find all default environments] 2025-07-16 03:09:35.723934 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:35.731618 | 2025-07-16 03:09:35.731728 | TASK [fetch-tox-output : Set envlist fact] 2025-07-16 03:09:35.776271 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:35.781713 | 2025-07-16 03:09:35.781812 | TASK [fetch-tox-output : Find all default environments] 2025-07-16 03:09:36.339311 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:36.344956 | 2025-07-16 03:09:36.345058 | TASK [fetch-tox-output : Set envlist fact] 2025-07-16 03:09:36.398398 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:36.405533 | 2025-07-16 03:09:36.405648 | LOOP [fetch-tox-output : Copy tox logs] 2025-07-16 03:09:36.478645 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:36.489938 | 2025-07-16 03:09:36.490047 | LOOP [fetch-tox-output : Collect tox logs] 2025-07-16 03:09:37.616316 | debian-bookworm | changed: 2025-07-16 03:09:37.616547 | debian-bookworm | created directory /var/lib/zuul/builds/c3e790bcab764281843e47e29b740018/work/logs/tox/test 2025-07-16 03:09:37.616587 | debian-bookworm | cd+++++++++ ./ 2025-07-16 03:09:37.616613 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-07-16 03:09:37.616637 | debian-bookworm | >f+++++++++ 2-commands[1].log 2025-07-16 03:09:37.616662 | 2025-07-16 03:09:37.633108 | 2025-07-16 03:09:37.633189 | PLAY RECAP 2025-07-16 03:09:37.633237 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-07-16 03:09:37.633263 | 2025-07-16 03:09:38.052024 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-07-16 03:09:38.053085 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-07-16 03:09:39.082209 | 2025-07-16 03:09:39.082328 | PLAY [all] 2025-07-16 03:09:39.099335 | 2025-07-16 03:09:39.099470 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-07-16 03:09:39.361298 | debian-bookworm | changed: non-zero return code 2025-07-16 03:09:39.371964 | 2025-07-16 03:09:39.372099 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-07-16 03:09:39.422140 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:39.433093 | 2025-07-16 03:09:39.433212 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-07-16 03:09:39.481220 | 2025-07-16 03:09:39.481493 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-07-16 03:09:39.527830 | 2025-07-16 03:09:39.527999 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-07-16 03:09:39.563380 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:39.569061 | 2025-07-16 03:09:39.569157 | LOOP [fetch-subunit-output : Generate subunit file] 2025-07-16 03:09:39.597686 | 2025-07-16 03:09:39.597872 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-07-16 03:09:39.654515 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:39.661242 | 2025-07-16 03:09:39.661360 | TASK [fetch-subunit-output : Remove the temporary file] 2025-07-16 03:09:39.704699 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:39.710718 | 2025-07-16 03:09:39.710826 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-07-16 03:09:39.745440 | debian-bookworm | skipping: Conditional result was False 2025-07-16 03:09:39.752450 | 2025-07-16 03:09:39.752523 | PLAY RECAP 2025-07-16 03:09:39.752572 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-07-16 03:09:39.752598 | 2025-07-16 03:09:39.916826 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-07-16 03:09:39.917815 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-07-16 03:09:41.672091 | 2025-07-16 03:09:41.672223 | PLAY [Base post] 2025-07-16 03:09:41.731255 | 2025-07-16 03:09:41.731404 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-07-16 03:09:42.469552 | debian-bookworm | changed 2025-07-16 03:09:42.475965 | 2025-07-16 03:09:42.476476 | PLAY RECAP 2025-07-16 03:09:42.476556 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-07-16 03:09:42.476643 | 2025-07-16 03:09:42.649875 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-07-16 03:09:42.650822 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-07-16 03:09:44.429464 | 2025-07-16 03:09:44.429595 | PLAY [Base post-logs] 2025-07-16 03:09:44.456046 | 2025-07-16 03:09:44.456169 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-07-16 03:09:45.534875 | localhost | changed 2025-07-16 03:09:45.543425 | 2025-07-16 03:09:45.544089 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-07-16 03:09:45.593981 | localhost | ok 2025-07-16 03:09:45.597198 | 2025-07-16 03:09:45.597284 | TASK [Set zuul-log-path fact] 2025-07-16 03:09:45.623821 | localhost | ok 2025-07-16 03:09:45.638574 | 2025-07-16 03:09:45.638723 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-16 03:09:45.728088 | localhost | ok 2025-07-16 03:09:45.731140 | 2025-07-16 03:09:45.731238 | TASK [upload-logs : Create log directories] 2025-07-16 03:09:46.476921 | localhost | changed 2025-07-16 03:09:46.479688 | 2025-07-16 03:09:46.479786 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-07-16 03:09:47.216711 | localhost -> localhost | ok: Runtime: 0:00:00.006392 2025-07-16 03:09:47.220596 | 2025-07-16 03:09:47.220697 | TASK [upload-logs : Upload logs to log server] 2025-07-16 03:09:48.298139 | localhost | Output suppressed because no_log was given 2025-07-16 03:09:48.299774 | 2025-07-16 03:09:48.299848 | LOOP [upload-logs : Compress console log and json output] 2025-07-16 03:09:48.353288 | localhost | skipping: Conditional result was False 2025-07-16 03:09:48.366499 | localhost | skipping: Conditional result was False 2025-07-16 03:09:48.371128 | 2025-07-16 03:09:48.371210 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-16 03:09:48.487501 | localhost | skipping: Conditional result was False 2025-07-16 03:09:48.487721 | 2025-07-16 03:09:48.497972 | localhost | skipping: Conditional result was False 2025-07-16 03:09:48.503648 | 2025-07-16 03:09:48.503739 | LOOP [upload-logs : Upload console log and json output]