2025-05-13 12:08:06.751148 | Job console starting 2025-05-13 12:08:06.763947 | Updating git repos 2025-05-13 12:08:06.815555 | Cloning repos into workspace 2025-05-13 12:08:06.881002 | Restoring repo states 2025-05-13 12:08:06.909828 | Merging changes 2025-05-13 12:08:06.909844 | Checking out repos 2025-05-13 12:08:06.974348 | Preparing playbooks 2025-05-13 12:08:08.069533 | Running Ansible setup 2025-05-13 12:08:13.862309 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-13 12:08:15.132982 | 2025-05-13 12:08:15.133120 | PLAY [Base pre] 2025-05-13 12:08:15.192344 | 2025-05-13 12:08:15.192454 | TASK [Setup log path fact] 2025-05-13 12:08:15.230403 | ubuntu-noble | ok 2025-05-13 12:08:15.257291 | 2025-05-13 12:08:15.257439 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-13 12:08:15.314242 | ubuntu-noble | ok 2025-05-13 12:08:15.332896 | 2025-05-13 12:08:15.332999 | TASK [emit-job-header : Print job information] 2025-05-13 12:08:15.380471 | # Job Information 2025-05-13 12:08:15.380618 | Ansible Version: 2.16.14 2025-05-13 12:08:15.380647 | Job: cfg-generics-tox-check 2025-05-13 12:08:15.380673 | Pipeline: periodic-daily 2025-05-13 12:08:15.380692 | Executor: 521e9411259a 2025-05-13 12:08:15.380709 | Triggered by: https://github.com/osism/cfg-generics 2025-05-13 12:08:15.380727 | Event ID: 73ccf5ea0e2342619f75ff90800c4b26 2025-05-13 12:08:15.384605 | 2025-05-13 12:08:15.384683 | LOOP [emit-job-header : Print node information] 2025-05-13 12:08:15.510782 | ubuntu-noble | ok: 2025-05-13 12:08:15.511067 | ubuntu-noble | # Node Information 2025-05-13 12:08:15.511103 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-05-13 12:08:15.511124 | ubuntu-noble | Hostname: ubuntu 2025-05-13 12:08:15.511143 | ubuntu-noble | Username: zuul 2025-05-13 12:08:15.511160 | ubuntu-noble | Distro: Ubuntu 24.04 2025-05-13 12:08:15.511186 | ubuntu-noble | Provider: regiocloud-a 2025-05-13 12:08:15.511208 | ubuntu-noble | Region: 2025-05-13 12:08:15.511225 | ubuntu-noble | Label: ubuntu-noble 2025-05-13 12:08:15.511241 | ubuntu-noble | Product Name: OpenStack Nova 2025-05-13 12:08:15.511257 | ubuntu-noble | Interface IP: 81.163.193.139 2025-05-13 12:08:15.528801 | 2025-05-13 12:08:15.528908 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-13 12:08:16.452359 | ubuntu-noble -> localhost | changed 2025-05-13 12:08:16.458717 | 2025-05-13 12:08:16.458846 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-13 12:08:18.774234 | ubuntu-noble -> localhost | changed 2025-05-13 12:08:18.783001 | 2025-05-13 12:08:18.783111 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-13 12:08:19.243345 | ubuntu-noble -> localhost | ok 2025-05-13 12:08:19.248376 | 2025-05-13 12:08:19.248467 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-13 12:08:19.285378 | ubuntu-noble | ok 2025-05-13 12:08:19.321838 | ubuntu-noble | included: /var/lib/zuul/builds/06018a85edf8426abbe93dec3114e40a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-13 12:08:19.361392 | 2025-05-13 12:08:19.361490 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-13 12:08:21.332231 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-05-13 12:08:21.332433 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/06018a85edf8426abbe93dec3114e40a/work/06018a85edf8426abbe93dec3114e40a_id_rsa 2025-05-13 12:08:21.332464 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/06018a85edf8426abbe93dec3114e40a/work/06018a85edf8426abbe93dec3114e40a_id_rsa.pub 2025-05-13 12:08:21.332485 | ubuntu-noble -> localhost | The key fingerprint is: 2025-05-13 12:08:21.332504 | ubuntu-noble -> localhost | SHA256:1D7Fj+vk0sjcVY4Zk7Ob8mMSWqZYuw+qj+Vvzl9x5uk zuul-build-sshkey 2025-05-13 12:08:21.332521 | ubuntu-noble -> localhost | The key's randomart image is: 2025-05-13 12:08:21.332539 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-05-13 12:08:21.332566 | ubuntu-noble -> localhost | | | 2025-05-13 12:08:21.332584 | ubuntu-noble -> localhost | | . . | 2025-05-13 12:08:21.332601 | ubuntu-noble -> localhost | | . . o . | 2025-05-13 12:08:21.332617 | ubuntu-noble -> localhost | | . . . o= .| 2025-05-13 12:08:21.332633 | ubuntu-noble -> localhost | | S o . oXo| 2025-05-13 12:08:21.332652 | ubuntu-noble -> localhost | | ..+.==o| 2025-05-13 12:08:21.332669 | ubuntu-noble -> localhost | | .=.Xoo.+.| 2025-05-13 12:08:21.332685 | ubuntu-noble -> localhost | | +.oX==.* | 2025-05-13 12:08:21.332701 | ubuntu-noble -> localhost | | oo++====.E | 2025-05-13 12:08:21.332717 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-05-13 12:08:21.332771 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.927007 2025-05-13 12:08:21.338314 | 2025-05-13 12:08:21.338407 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-13 12:08:21.356127 | ubuntu-noble | ok 2025-05-13 12:08:21.370449 | ubuntu-noble | included: /var/lib/zuul/builds/06018a85edf8426abbe93dec3114e40a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-13 12:08:21.377973 | 2025-05-13 12:08:21.378071 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-13 12:08:21.409330 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:08:21.414203 | 2025-05-13 12:08:21.414283 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-13 12:08:22.111132 | ubuntu-noble | changed 2025-05-13 12:08:22.116497 | 2025-05-13 12:08:22.116585 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-13 12:08:22.459761 | ubuntu-noble | ok 2025-05-13 12:08:22.464173 | 2025-05-13 12:08:22.464248 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-13 12:08:23.324077 | ubuntu-noble | changed 2025-05-13 12:08:23.329307 | 2025-05-13 12:08:23.329396 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-13 12:08:24.091794 | ubuntu-noble | changed 2025-05-13 12:08:24.098779 | 2025-05-13 12:08:24.098918 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-13 12:08:24.122296 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:08:24.127118 | 2025-05-13 12:08:24.127200 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-13 12:08:24.737769 | ubuntu-noble -> localhost | changed 2025-05-13 12:08:24.753142 | 2025-05-13 12:08:24.753770 | TASK [add-build-sshkey : Add back temp key] 2025-05-13 12:08:25.581329 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/06018a85edf8426abbe93dec3114e40a/work/06018a85edf8426abbe93dec3114e40a_id_rsa (zuul-build-sshkey) 2025-05-13 12:08:25.581628 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.024195 2025-05-13 12:08:25.589877 | 2025-05-13 12:08:25.589969 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-13 12:08:26.172426 | ubuntu-noble | ok 2025-05-13 12:08:26.178442 | 2025-05-13 12:08:26.178535 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-13 12:08:26.256862 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:08:26.269804 | 2025-05-13 12:08:26.269907 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-13 12:08:27.100044 | ubuntu-noble | ok 2025-05-13 12:08:27.113267 | 2025-05-13 12:08:27.131028 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-13 12:08:27.190124 | ubuntu-noble | ok 2025-05-13 12:08:27.194992 | 2025-05-13 12:08:27.195089 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-13 12:08:27.895721 | ubuntu-noble -> localhost | ok 2025-05-13 12:08:27.903629 | 2025-05-13 12:08:27.903720 | TASK [validate-host : Collect information about the host] 2025-05-13 12:08:29.306110 | ubuntu-noble | ok 2025-05-13 12:08:29.316994 | 2025-05-13 12:08:29.317096 | TASK [validate-host : Sanitize hostname] 2025-05-13 12:08:29.400949 | ubuntu-noble | ok 2025-05-13 12:08:29.405267 | 2025-05-13 12:08:29.405345 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-13 12:08:30.334032 | ubuntu-noble -> localhost | changed 2025-05-13 12:08:30.338659 | 2025-05-13 12:08:30.338738 | TASK [validate-host : Collect information about zuul worker] 2025-05-13 12:08:31.063653 | ubuntu-noble | ok 2025-05-13 12:08:31.067701 | 2025-05-13 12:08:31.067786 | TASK [validate-host : Write out all zuul information for each host] 2025-05-13 12:08:32.270453 | ubuntu-noble -> localhost | changed 2025-05-13 12:08:32.352939 | 2025-05-13 12:08:32.353045 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-13 12:08:32.729764 | ubuntu-noble | ok 2025-05-13 12:08:32.734210 | 2025-05-13 12:08:32.734283 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-13 12:08:33.680662 | ubuntu-noble | changed: 2025-05-13 12:08:33.680815 | ubuntu-noble | cd+++++++++ src/ 2025-05-13 12:08:33.680843 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-05-13 12:08:33.680863 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-05-13 12:08:33.680881 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-generics/ 2025-05-13 12:08:33.680898 | ubuntu-noble | =5.5.1 (from tox) 2025-05-13 12:09:04.258983 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl.metadata (5.4 kB) 2025-05-13 12:09:04.299714 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2025-05-13 12:09:04.315415 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2025-05-13 12:09:04.371296 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2025-05-13 12:09:04.386562 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-05-13 12:09:04.464842 | ubuntu-noble | Collecting filelock>=3.16.1 (from tox) 2025-05-13 12:09:04.478966 | ubuntu-noble | Downloading filelock-3.18.0-py3-none-any.whl.metadata (2.9 kB) 2025-05-13 12:09:04.549245 | ubuntu-noble | Collecting packaging>=24.2 (from tox) 2025-05-13 12:09:04.563733 | ubuntu-noble | Downloading packaging-25.0-py3-none-any.whl.metadata (3.3 kB) 2025-05-13 12:09:04.643863 | ubuntu-noble | Collecting platformdirs>=4.3.6 (from tox) 2025-05-13 12:09:04.658865 | ubuntu-noble | Downloading platformdirs-4.3.8-py3-none-any.whl.metadata (12 kB) 2025-05-13 12:09:04.719204 | ubuntu-noble | Collecting pluggy>=1.5 (from tox) 2025-05-13 12:09:04.733392 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl.metadata (4.8 kB) 2025-05-13 12:09:04.793656 | ubuntu-noble | Collecting pyproject-api>=1.8 (from tox) 2025-05-13 12:09:04.808550 | ubuntu-noble | Downloading pyproject_api-1.9.1-py3-none-any.whl.metadata (2.7 kB) 2025-05-13 12:09:04.948283 | ubuntu-noble | Collecting virtualenv>=20.29.1 (from tox) 2025-05-13 12:09:04.973268 | ubuntu-noble | Downloading virtualenv-20.31.2-py3-none-any.whl.metadata (4.5 kB) 2025-05-13 12:09:05.099023 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.29.1->tox) 2025-05-13 12:09:05.112781 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl.metadata (5.2 kB) 2025-05-13 12:09:05.154253 | ubuntu-noble | Downloading tox-4.25.0-py3-none-any.whl (172 kB) 2025-05-13 12:09:05.192135 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 172.4/172.4 kB 4.9 MB/s eta 0:00:00 2025-05-13 12:09:05.206597 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl (10 kB) 2025-05-13 12:09:05.231925 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-05-13 12:09:05.251406 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 15.4 MB/s eta 0:00:00 2025-05-13 12:09:05.267441 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-05-13 12:09:05.294139 | ubuntu-noble | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-05-13 12:09:05.330524 | ubuntu-noble | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-05-13 12:09:05.353183 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 3.3 MB/s eta 0:00:00 2025-05-13 12:09:05.369152 | ubuntu-noble | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-05-13 12:09:05.396667 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl (20 kB) 2025-05-13 12:09:05.426638 | ubuntu-noble | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-05-13 12:09:05.455193 | ubuntu-noble | Downloading virtualenv-20.31.2-py3-none-any.whl (6.1 MB) 2025-05-13 12:09:05.761453 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.1/6.1 MB 20.1 MB/s eta 0:00:00 2025-05-13 12:09:05.777284 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-05-13 12:09:05.812734 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 15.3 MB/s eta 0:00:00 2025-05-13 12:09:05.918301 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-05-13 12:09:07.033630 | ubuntu-noble | Successfully installed cachetools-5.5.2 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.5.0 pyproject-api-1.9.1 tox-4.25.0 virtualenv-20.31.2 2025-05-13 12:09:07.552391 | ubuntu-noble | ok: Runtime: 0:00:03.863456 2025-05-13 12:09:07.557999 | 2025-05-13 12:09:07.558095 | TASK [ensure-tox : Export installed tox_executable path] 2025-05-13 12:09:07.698939 | ubuntu-noble | ok 2025-05-13 12:09:07.712123 | 2025-05-13 12:09:07.712247 | TASK [ensure-tox : Output tox version] 2025-05-13 12:09:08.472236 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-05-13 12:09:08.489559 | ubuntu-noble | 4.25.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-05-13 12:09:08.785015 | ubuntu-noble | ok: Runtime: 0:00:00.367497 2025-05-13 12:09:08.794646 | 2025-05-13 12:09:08.794761 | TASK [ensure-tox : Make global symlink] 2025-05-13 12:09:08.852606 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:09:08.865449 | 2025-05-13 12:09:08.865670 | PLAY RECAP 2025-05-13 12:09:08.865794 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-05-13 12:09:08.865870 | 2025-05-13 12:09:09.156558 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-05-13 12:09:09.157485 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-05-13 12:09:10.649667 | 2025-05-13 12:09:10.649796 | PLAY [all] 2025-05-13 12:09:10.676998 | 2025-05-13 12:09:10.677116 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-05-13 12:09:11.242103 | ubuntu-noble | ok: Runtime: 0:00:00.017060 2025-05-13 12:09:11.249565 | 2025-05-13 12:09:11.249689 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-05-13 12:09:11.811145 | ubuntu-noble | ok: Runtime: 0:00:00.007567 2025-05-13 12:09:11.816681 | 2025-05-13 12:09:11.816863 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-05-13 12:09:12.220811 | ubuntu-noble | sudo: a password is required 2025-05-13 12:09:12.370261 | ubuntu-noble | ok: Runtime: 0:00:00.022583 2025-05-13 12:09:12.378391 | 2025-05-13 12:09:12.378482 | TASK [tox : Check to see if the constraints file exists] 2025-05-13 12:09:12.437263 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:09:12.443183 | 2025-05-13 12:09:12.443272 | TASK [tox : Fail if constraints file is missing] 2025-05-13 12:09:12.486931 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:09:12.492011 | 2025-05-13 12:09:12.492104 | TASK [tox : Record file location] 2025-05-13 12:09:12.515666 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:09:12.520292 | 2025-05-13 12:09:12.520374 | TASK [tox : Install tox siblings] 2025-05-13 12:09:12.559499 | ubuntu-noble | ok 2025-05-13 12:09:12.572218 | ubuntu-noble | included: /var/lib/zuul/builds/06018a85edf8426abbe93dec3114e40a/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-05-13 12:09:12.585855 | 2025-05-13 12:09:12.586707 | TASK [tox : Run tox without tests] 2025-05-13 12:09:13.269874 | ubuntu-noble | ROOT: 180 D setup logging to DEBUG on pid 1338 [tox/report.py:222] 2025-05-13 12:09:13.348030 | ubuntu-noble | check: 259 D created app data folder /home/zuul/.local/share/virtualenv [virtualenv/app_data/__init__.py:42] 2025-05-13 12:09:13.350926 | ubuntu-noble | check: 262 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:76] 2025-05-13 12:09:13.351886 | ubuntu-noble | check: 263 D get interpreter info via cmd: /usr/bin/python3.12 /home/zuul/.local/tox/lib/python3.12/site-packages/virtualenv/discovery/py_info.py nhCAxarJEwVrFxXCq7WPoQFkB1ChNpnv YTNsae4CaUyEr25AvqUi9bPIUaObiOno [virtualenv/discovery/cached_py_info.py:117] 2025-05-13 12:09:13.430819 | ubuntu-noble | check: 342 D wrote python info of /usr/bin/python3.12 at /home/zuul/.local/share/virtualenv/py_info/2/f0d7a494a3f776233427cb85a7e198c7cf4913b50a203c6febc678cc4f5bf265.json [virtualenv/app_data/via_disk_folder.py:152] 2025-05-13 12:09:13.431998 | ubuntu-noble | check: 343 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-05-13 12:09:13.432440 | ubuntu-noble | check: 343 I proposed PythonInfo(spec=CPython3.12.3.final.0-64, system=/usr/bin/python3.12, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.12.3 (main, Feb 4 2025, 14:48:35) [GCC 13.3.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:83] 2025-05-13 12:09:13.432661 | ubuntu-noble | check: 344 D accepted PythonInfo(spec=CPython3.12.3.final.0-64, system=/usr/bin/python3.12, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.12.3 (main, Feb 4 2025, 14:48:35) [GCC 13.3.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:85] 2025-05-13 12:09:13.473655 | ubuntu-noble | check: 384 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/cfg-generics/.tox/check, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:52] 2025-05-13 12:09:13.473924 | ubuntu-noble | check: 385 D create folder /home/zuul/src/github.com/osism/cfg-generics/.tox/check/bin [virtualenv/util/path/_sync.py:14] 2025-05-13 12:09:13.474078 | ubuntu-noble | check: 385 D create folder /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.12/site-packages [virtualenv/util/path/_sync.py:14] 2025-05-13 12:09:13.474409 | ubuntu-noble | check: 385 D write /home/zuul/src/github.com/osism/cfg-generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-05-13 12:09:13.474495 | ubuntu-noble | check: 386 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.474545 | ubuntu-noble | check: 386 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.474604 | ubuntu-noble | check: 386 D version_info = 3.12.3.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.474650 | ubuntu-noble | check: 386 D virtualenv = 20.31.2 [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.474712 | ubuntu-noble | check: 386 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.474806 | ubuntu-noble | check: 386 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.474824 | ubuntu-noble | check: 386 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.474944 | ubuntu-noble | check: 386 D base-executable = /usr/bin/python3.12 [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.475260 | ubuntu-noble | check: 386 D symlink /usr/bin/python3.12 to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/bin/python [virtualenv/util/path/_sync.py:34] 2025-05-13 12:09:13.475631 | ubuntu-noble | check: 387 D create virtualenv import hook file /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.12/site-packages/_virtualenv.pth [virtualenv/create/via_global_ref/api.py:93] 2025-05-13 12:09:13.475835 | ubuntu-noble | check: 387 D create /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.12/site-packages/_virtualenv.py [virtualenv/create/via_global_ref/api.py:96] 2025-05-13 12:09:13.476295 | ubuntu-noble | check: 387 D ============================== target debug ============================== [virtualenv/run/session.py:54] 2025-05-13 12:09:13.476570 | ubuntu-noble | check: 388 D debug via /home/zuul/src/github.com/osism/cfg-generics/.tox/check/bin/python /home/zuul/.local/tox/lib/python3.12/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:215] 2025-05-13 12:09:13.524845 | ubuntu-noble | check: 387 D { 2025-05-13 12:09:13.524894 | ubuntu-noble | "sys": { 2025-05-13 12:09:13.524900 | ubuntu-noble | "executable": "/home/zuul/src/github.com/osism/cfg-generics/.tox/check/bin/python", 2025-05-13 12:09:13.524905 | ubuntu-noble | "_base_executable": "/usr/bin/python3.12", 2025-05-13 12:09:13.524910 | ubuntu-noble | "prefix": "/home/zuul/src/github.com/osism/cfg-generics/.tox/check", 2025-05-13 12:09:13.524915 | ubuntu-noble | "base_prefix": "/usr", 2025-05-13 12:09:13.524920 | ubuntu-noble | "real_prefix": null, 2025-05-13 12:09:13.524924 | ubuntu-noble | "exec_prefix": "/home/zuul/src/github.com/osism/cfg-generics/.tox/check", 2025-05-13 12:09:13.524928 | ubuntu-noble | "base_exec_prefix": "/usr", 2025-05-13 12:09:13.524932 | ubuntu-noble | "path": [ 2025-05-13 12:09:13.524938 | ubuntu-noble | "/usr/lib/python312.zip", 2025-05-13 12:09:13.524941 | ubuntu-noble | "/usr/lib/python3.12", 2025-05-13 12:09:13.524945 | ubuntu-noble | "/usr/lib/python3.12/lib-dynload", 2025-05-13 12:09:13.524949 | ubuntu-noble | "/home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.12/site-packages" 2025-05-13 12:09:13.524952 | ubuntu-noble | ], 2025-05-13 12:09:13.524956 | ubuntu-noble | "meta_path": [ 2025-05-13 12:09:13.524960 | ubuntu-noble | "", 2025-05-13 12:09:13.524964 | ubuntu-noble | "", 2025-05-13 12:09:13.524968 | ubuntu-noble | "", 2025-05-13 12:09:13.524971 | ubuntu-noble | "" 2025-05-13 12:09:13.524975 | ubuntu-noble | ], 2025-05-13 12:09:13.524979 | ubuntu-noble | "fs_encoding": "utf-8", 2025-05-13 12:09:13.524982 | ubuntu-noble | "io_encoding": "utf-8" 2025-05-13 12:09:13.524986 | ubuntu-noble | }, 2025-05-13 12:09:13.524990 | ubuntu-noble | "version": "3.12.3 (main, Feb 4 2025, 14:48:35) [GCC 13.3.0]", 2025-05-13 12:09:13.524994 | ubuntu-noble | "makefile_filename": "/usr/lib/python3.12/config-3.12-x86_64-linux-gnu/Makefile", 2025-05-13 12:09:13.524997 | ubuntu-noble | "os": "", 2025-05-13 12:09:13.525001 | ubuntu-noble | "site": "", 2025-05-13 12:09:13.525005 | ubuntu-noble | "datetime": "", 2025-05-13 12:09:13.525008 | ubuntu-noble | "math": "", 2025-05-13 12:09:13.525012 | ubuntu-noble | "json": "" 2025-05-13 12:09:13.525016 | ubuntu-noble | } [virtualenv/run/session.py:55] 2025-05-13 12:09:13.525337 | ubuntu-noble | check: 436 I add seed packages via FromAppData(download=False, pip=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv) [virtualenv/run/session.py:59] 2025-05-13 12:09:13.527163 | ubuntu-noble | check: 438 D install pip from wheel /home/zuul/.local/tox/lib/python3.12/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-05-13 12:09:13.527901 | ubuntu-noble | check: 439 D build install image for pip-25.1.1-py3-none-any.whl to /home/zuul/.local/share/virtualenv/wheel/3.12/image/1/CopyPipInstall/pip-25.1.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2025-05-13 12:09:13.621626 | ubuntu-noble | check: 533 D copy /home/zuul/.local/share/virtualenv/wheel/3.12/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/check/lib/python3.12/site-packages/pip-25.1.1.virtualenv [virtualenv/util/path/_sync.py:42] 2025-05-13 12:09:13.621878 | ubuntu-noble | check: 533 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.12/image/1/CopyPipInstall/pip-25.1.1-py3-none-any/pip to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.12/site-packages/pip [virtualenv/util/path/_sync.py:42] 2025-05-13 12:09:13.668843 | ubuntu-noble | check: 579 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.12/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/check/lib/python3.12/site-packages/pip-25.1.1.dist-info [virtualenv/util/path/_sync.py:42] 2025-05-13 12:09:13.669467 | ubuntu-noble | check: 580 D generated console scripts pip3.12 pip-3.12 pip3 pip [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-05-13 12:09:13.670889 | ubuntu-noble | check: 581 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65] 2025-05-13 12:09:13.704010 | ubuntu-noble | check: 615 D write /home/zuul/src/github.com/osism/cfg-generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-05-13 12:09:13.704130 | ubuntu-noble | check: 615 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.704295 | ubuntu-noble | check: 615 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.704404 | ubuntu-noble | check: 615 D version_info = 3.12.3.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.704530 | ubuntu-noble | check: 616 D virtualenv = 20.31.2 [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.704718 | ubuntu-noble | check: 616 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.704837 | ubuntu-noble | check: 616 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.705000 | ubuntu-noble | check: 616 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.705246 | ubuntu-noble | check: 616 D base-executable = /usr/bin/python3.12 [virtualenv/create/pyenv_cfg.py:40] 2025-05-13 12:09:13.719816 | ubuntu-noble | check: 629 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:434] 2025-05-13 12:09:15.029437 | ubuntu-noble | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2025-05-13 12:09:15.108419 | ubuntu-noble | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2025-05-13 12:09:15.208123 | ubuntu-noble | Collecting PyYAML==6.0.2 (from -r requirements.txt (line 2)) 2025-05-13 12:09:15.221197 | ubuntu-noble | Downloading PyYAML-6.0.2-cp312-cp312-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (2.1 kB) 2025-05-13 12:09:15.309226 | ubuntu-noble | Collecting ansible==11.5.0 (from -r requirements.txt (line 3)) 2025-05-13 12:09:15.321361 | ubuntu-noble | Downloading ansible-11.5.0-py3-none-any.whl.metadata (8.1 kB) 2025-05-13 12:09:15.363484 | ubuntu-noble | Collecting packaging==25.0 (from -r requirements.txt (line 4)) 2025-05-13 12:09:15.366047 | ubuntu-noble | Using cached packaging-25.0-py3-none-any.whl.metadata (3.3 kB) 2025-05-13 12:09:15.484478 | ubuntu-noble | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2025-05-13 12:09:15.594114 | ubuntu-noble | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2025-05-13 12:09:15.616047 | ubuntu-noble | Installing build dependencies: started 2025-05-13 12:09:16.817137 | ubuntu-noble | Installing build dependencies: finished with status 'done' 2025-05-13 12:09:16.819342 | ubuntu-noble | Getting requirements to build wheel: started 2025-05-13 12:09:17.279935 | ubuntu-noble | Getting requirements to build wheel: finished with status 'done' 2025-05-13 12:09:17.283218 | ubuntu-noble | Preparing metadata (pyproject.toml): started 2025-05-13 12:09:17.552948 | ubuntu-noble | Preparing metadata (pyproject.toml): finished with status 'done' 2025-05-13 12:09:17.686241 | ubuntu-noble | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2025-05-13 12:09:17.791816 | ubuntu-noble | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2025-05-13 12:09:17.857833 | ubuntu-noble | Collecting requests==2.32.3 (from -r requirements.txt (line 7)) 2025-05-13 12:09:17.869247 | ubuntu-noble | Downloading requests-2.32.3-py3-none-any.whl.metadata (4.6 kB) 2025-05-13 12:09:17.905190 | ubuntu-noble | Collecting tabulate==0.9.0 (from -r requirements.txt (line 8)) 2025-05-13 12:09:17.917472 | ubuntu-noble | Downloading tabulate-0.9.0-py3-none-any.whl.metadata (34 kB) 2025-05-13 12:09:18.041126 | ubuntu-noble | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2025-05-13 12:09:18.053627 | ubuntu-noble | Downloading MarkupSafe-3.0.2-cp312-cp312-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (4.0 kB) 2025-05-13 12:09:18.172583 | ubuntu-noble | Collecting ansible-core~=2.18.5 (from ansible==11.5.0->-r requirements.txt (line 3)) 2025-05-13 12:09:18.186809 | ubuntu-noble | Downloading ansible_core-2.18.5-py3-none-any.whl.metadata (7.7 kB) 2025-05-13 12:09:18.231723 | ubuntu-noble | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-05-13 12:09:18.242755 | ubuntu-noble | Downloading click-8.2.0-py3-none-any.whl.metadata (2.5 kB) 2025-05-13 12:09:18.306025 | ubuntu-noble | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-05-13 12:09:18.307903 | ubuntu-noble | Using cached colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-05-13 12:09:18.343579 | ubuntu-noble | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-05-13 12:09:18.355235 | ubuntu-noble | Downloading fasteners-0.19-py3-none-any.whl.metadata (4.9 kB) 2025-05-13 12:09:18.403641 | ubuntu-noble | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-05-13 12:09:18.416220 | ubuntu-noble | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2025-05-13 12:09:18.555211 | ubuntu-noble | Collecting charset-normalizer<4,>=2 (from requests==2.32.3->-r requirements.txt (line 7)) 2025-05-13 12:09:18.566741 | ubuntu-noble | Downloading charset_normalizer-3.4.2-cp312-cp312-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (35 kB) 2025-05-13 12:09:18.611204 | ubuntu-noble | Collecting idna<4,>=2.5 (from requests==2.32.3->-r requirements.txt (line 7)) 2025-05-13 12:09:18.622891 | ubuntu-noble | Downloading idna-3.10-py3-none-any.whl.metadata (10 kB) 2025-05-13 12:09:18.683501 | ubuntu-noble | Collecting urllib3<3,>=1.21.1 (from requests==2.32.3->-r requirements.txt (line 7)) 2025-05-13 12:09:18.694977 | ubuntu-noble | Downloading urllib3-2.4.0-py3-none-any.whl.metadata (6.5 kB) 2025-05-13 12:09:18.744133 | ubuntu-noble | Collecting certifi>=2017.4.17 (from requests==2.32.3->-r requirements.txt (line 7)) 2025-05-13 12:09:18.755412 | ubuntu-noble | Downloading certifi-2025.4.26-py3-none-any.whl.metadata (2.5 kB) 2025-05-13 12:09:19.057081 | ubuntu-noble | Collecting cryptography (from ansible-core~=2.18.5->ansible==11.5.0->-r requirements.txt (line 3)) 2025-05-13 12:09:19.068170 | ubuntu-noble | Downloading cryptography-44.0.3-cp39-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2025-05-13 12:09:19.131301 | ubuntu-noble | Collecting resolvelib<1.1.0,>=0.5.3 (from ansible-core~=2.18.5->ansible==11.5.0->-r requirements.txt (line 3)) 2025-05-13 12:09:19.145182 | ubuntu-noble | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2025-05-13 12:09:19.381233 | ubuntu-noble | Collecting cffi>=1.12 (from cryptography->ansible-core~=2.18.5->ansible==11.5.0->-r requirements.txt (line 3)) 2025-05-13 12:09:19.394773 | ubuntu-noble | Downloading cffi-1.17.1-cp312-cp312-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB) 2025-05-13 12:09:19.446061 | ubuntu-noble | Collecting pycparser (from cffi>=1.12->cryptography->ansible-core~=2.18.5->ansible==11.5.0->-r requirements.txt (line 3)) 2025-05-13 12:09:19.459274 | ubuntu-noble | Downloading pycparser-2.22-py3-none-any.whl.metadata (943 bytes) 2025-05-13 12:09:19.489389 | ubuntu-noble | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-05-13 12:09:19.524391 | ubuntu-noble | Downloading PyYAML-6.0.2-cp312-cp312-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (767 kB) 2025-05-13 12:09:19.590466 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 767.5/767.5 kB 9.7 MB/s eta 0:00:00 2025-05-13 12:09:19.606976 | ubuntu-noble | Downloading ansible-11.5.0-py3-none-any.whl (55.5 MB) 2025-05-13 12:09:21.374361 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 55.5/55.5 MB 31.3 MB/s eta 0:00:00 2025-05-13 12:09:21.376393 | ubuntu-noble | Using cached packaging-25.0-py3-none-any.whl (66 kB) 2025-05-13 12:09:21.492669 | ubuntu-noble | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2025-05-13 12:09:21.519962 | ubuntu-noble | Downloading requests-2.32.3-py3-none-any.whl (64 kB) 2025-05-13 12:09:21.543761 | ubuntu-noble | Downloading tabulate-0.9.0-py3-none-any.whl (35 kB) 2025-05-13 12:09:21.569940 | ubuntu-noble | Downloading ansible_core-2.18.5-py3-none-any.whl (2.2 MB) 2025-05-13 12:09:21.678384 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 20.2 MB/s eta 0:00:00 2025-05-13 12:09:21.692978 | ubuntu-noble | Downloading charset_normalizer-3.4.2-cp312-cp312-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (148 kB) 2025-05-13 12:09:21.723367 | ubuntu-noble | Downloading idna-3.10-py3-none-any.whl (70 kB) 2025-05-13 12:09:21.747507 | ubuntu-noble | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2025-05-13 12:09:21.783849 | ubuntu-noble | Downloading urllib3-2.4.0-py3-none-any.whl (128 kB) 2025-05-13 12:09:21.806354 | ubuntu-noble | Downloading certifi-2025.4.26-py3-none-any.whl (159 kB) 2025-05-13 12:09:21.840889 | ubuntu-noble | Downloading MarkupSafe-3.0.2-cp312-cp312-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (23 kB) 2025-05-13 12:09:21.865038 | ubuntu-noble | Downloading click-8.2.0-py3-none-any.whl (102 kB) 2025-05-13 12:09:21.892006 | ubuntu-noble | Using cached colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-05-13 12:09:21.906042 | ubuntu-noble | Downloading cryptography-44.0.3-cp39-abi3-manylinux_2_34_x86_64.whl (4.2 MB) 2025-05-13 12:09:22.071386 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.2/4.2 MB 25.2 MB/s eta 0:00:00 2025-05-13 12:09:22.086647 | ubuntu-noble | Downloading cffi-1.17.1-cp312-cp312-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (479 kB) 2025-05-13 12:09:22.128146 | ubuntu-noble | Downloading fasteners-0.19-py3-none-any.whl (18 kB) 2025-05-13 12:09:22.155795 | ubuntu-noble | Downloading pycparser-2.22-py3-none-any.whl (117 kB) 2025-05-13 12:09:22.180513 | ubuntu-noble | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2025-05-13 12:09:22.523361 | ubuntu-noble | Building wheels for collected packages: pwgen 2025-05-13 12:09:22.524635 | ubuntu-noble | Building wheel for pwgen (pyproject.toml): started 2025-05-13 12:09:22.830207 | ubuntu-noble | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2025-05-13 12:09:22.830975 | ubuntu-noble | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3795 sha256=ee0c38073de692ef8c54e33012747f08660e294eb0800dc8b0b1d8cba8e940f1 2025-05-13 12:09:22.831363 | ubuntu-noble | Stored in directory: /home/zuul/.cache/pip/wheels/8e/56/bf/a88cd4e5b84752858d6db0c914d636211570e8a1e73b53b5dd 2025-05-13 12:09:22.833582 | ubuntu-noble | Successfully built pwgen 2025-05-13 12:09:23.031470 | ubuntu-noble | 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-05-13 12:09:53.378734 | ubuntu-noble | 2025-05-13 12:09:53.383475 | ubuntu-noble | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.2 PyYAML-6.0.2 ansible-11.5.0 ansible-core-2.18.5 certifi-2025.4.26 cffi-1.17.1 charset-normalizer-3.4.2 click-8.2.0 colorama-0.4.6 cryptography-44.0.3 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.3 resolvelib-1.0.1 sh-2.2.2 tabulate-0.9.0 urllib3-2.4.0 2025-05-13 12:09:53.540184 | ubuntu-noble | check: 40450 I exit 0 (39.82 seconds) /home/zuul/src/github.com/osism/cfg-generics> python -I -m pip install -r requirements.txt pid=1349 [tox/execute/api.py:294] 2025-05-13 12:09:53.541029 | ubuntu-noble | check: OK (40.20 seconds) 2025-05-13 12:09:53.541047 | ubuntu-noble | congratulations :) (40.27 seconds) 2025-05-13 12:09:53.669394 | ubuntu-noble | ok: Runtime: 0:00:40.539448 2025-05-13 12:09:53.684941 | 2025-05-13 12:09:53.685097 | TASK [tox : Create a tempfile to save tox showconfig] 2025-05-13 12:09:54.112458 | ubuntu-noble | changed 2025-05-13 12:09:54.120222 | 2025-05-13 12:09:54.120350 | TASK [tox : Get tox envlist config] 2025-05-13 12:09:55.151308 | ubuntu-noble | ok: Runtime: 0:00:00.332022 2025-05-13 12:09:55.157284 | 2025-05-13 12:09:55.157408 | TASK [tox : Install any sibling python packages] 2025-05-13 12:09:55.604733 | ubuntu-noble | ok: No setup.cfg, no action needed 2025-05-13 12:09:55.609932 | 2025-05-13 12:09:55.610039 | TASK [tox : Remove tempfile] 2025-05-13 12:09:56.064385 | ubuntu-noble | changed 2025-05-13 12:09:56.074863 | 2025-05-13 12:09:56.075006 | TASK [tox : Emit tox command] 2025-05-13 12:09:56.129346 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2025-05-13 12:09:56.137712 | 2025-05-13 12:09:56.137901 | TASK [tox : Run tox] 2025-05-13 12:09:56.673759 | ubuntu-noble | ROOT: 155 D setup logging to DEBUG on pid 1503 [tox/report.py:222] 2025-05-13 12:09:56.746523 | ubuntu-noble | check: 227 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:76] 2025-05-13 12:09:56.747126 | ubuntu-noble | check: 228 D got python info of /usr/bin/python3.12 from /home/zuul/.local/share/virtualenv/py_info/2/f0d7a494a3f776233427cb85a7e198c7cf4913b50a203c6febc678cc4f5bf265.json [virtualenv/app_data/via_disk_folder.py:132] 2025-05-13 12:09:56.748096 | ubuntu-noble | check: 229 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-05-13 12:09:56.748261 | ubuntu-noble | check: 229 I proposed PythonInfo(spec=CPython3.12.3.final.0-64, system=/usr/bin/python3.12, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.12.3 (main, Feb 4 2025, 14:48:35) [GCC 13.3.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:83] 2025-05-13 12:09:56.748291 | ubuntu-noble | check: 229 D accepted PythonInfo(spec=CPython3.12.3.final.0-64, system=/usr/bin/python3.12, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.12.3 (main, Feb 4 2025, 14:48:35) [GCC 13.3.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:85] 2025-05-13 12:09:56.780011 | ubuntu-noble | check: 261 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:434] 2025-05-13 12:09:56.849204 | ubuntu-noble | check: 330 I exit 0 (0.07 seconds) /home/zuul/src/github.com/osism/cfg-generics> python3 src/check-inventory-sorting.py pid=1510 [tox/execute/api.py:294] 2025-05-13 12:09:56.849877 | ubuntu-noble | check: OK (0.11=setup[0.04]+cmd[0.07] seconds) 2025-05-13 12:09:56.849894 | ubuntu-noble | congratulations :) (0.18 seconds) 2025-05-13 12:09:57.210335 | ubuntu-noble | ok: Runtime: 0:00:00.404486 2025-05-13 12:09:57.216290 | 2025-05-13 12:09:57.216417 | TASK [tox : Look for output] 2025-05-13 12:09:57.670630 | ubuntu-noble | ok 2025-05-13 12:09:57.686652 | 2025-05-13 12:09:57.686872 | TASK [tox : Return file comments to Zuul] 2025-05-13 12:09:57.731693 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:09:57.742701 | 2025-05-13 12:09:57.742817 | PLAY RECAP 2025-05-13 12:09:57.742897 | ubuntu-noble | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-05-13 12:09:57.742925 | 2025-05-13 12:09:57.900554 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-05-13 12:09:57.905358 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-05-13 12:09:58.755751 | 2025-05-13 12:09:58.755956 | PLAY [all] 2025-05-13 12:09:58.772336 | 2025-05-13 12:09:58.772496 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-05-13 12:09:58.828808 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:09:58.845434 | 2025-05-13 12:09:58.845750 | TASK [fetch-tox-output : Set tox log path for single node] 2025-05-13 12:09:58.890444 | ubuntu-noble | ok 2025-05-13 12:09:58.897831 | 2025-05-13 12:09:58.897980 | TASK [fetch-tox-output : Ensure local tox dir] 2025-05-13 12:09:59.446727 | ubuntu-noble -> localhost | changed 2025-05-13 12:09:59.459248 | 2025-05-13 12:09:59.462969 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-05-13 12:09:59.528721 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:09:59.538496 | 2025-05-13 12:09:59.538678 | TASK [fetch-tox-output : Set envlist fact] 2025-05-13 12:09:59.598539 | ubuntu-noble | ok 2025-05-13 12:09:59.608558 | 2025-05-13 12:09:59.608728 | TASK [fetch-tox-output : Get tox version] 2025-05-13 12:10:00.357985 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-05-13 12:10:00.374668 | ubuntu-noble | 4.25.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-05-13 12:10:00.649871 | ubuntu-noble | ok: Runtime: 0:00:00.320032 2025-05-13 12:10:00.661546 | 2025-05-13 12:10:00.661723 | TASK [fetch-tox-output : Find all default environments] 2025-05-13 12:10:01.193636 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:10:01.207428 | 2025-05-13 12:10:01.207613 | TASK [fetch-tox-output : Set envlist fact] 2025-05-13 12:10:01.243722 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:10:01.257520 | 2025-05-13 12:10:01.257842 | TASK [fetch-tox-output : Find all default environments] 2025-05-13 12:10:01.790649 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:10:01.803144 | 2025-05-13 12:10:01.803354 | TASK [fetch-tox-output : Set envlist fact] 2025-05-13 12:10:01.849394 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:10:01.862814 | 2025-05-13 12:10:01.863050 | LOOP [fetch-tox-output : Copy tox logs] 2025-05-13 12:10:01.932109 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:10:01.951854 | 2025-05-13 12:10:01.952044 | LOOP [fetch-tox-output : Collect tox logs] 2025-05-13 12:10:02.796258 | ubuntu-noble | changed: 2025-05-13 12:10:02.796677 | ubuntu-noble | created directory /var/lib/zuul/builds/06018a85edf8426abbe93dec3114e40a/work/logs/tox/check 2025-05-13 12:10:02.796753 | ubuntu-noble | cd+++++++++ ./ 2025-05-13 12:10:02.796859 | ubuntu-noble | >f+++++++++ 1-commands[0].log 2025-05-13 12:10:02.796908 | 2025-05-13 12:10:02.824898 | 2025-05-13 12:10:02.825100 | PLAY RECAP 2025-05-13 12:10:02.825238 | ubuntu-noble | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-05-13 12:10:02.825306 | 2025-05-13 12:10:03.005240 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-05-13 12:10:03.007925 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-05-13 12:10:03.795575 | 2025-05-13 12:10:03.795741 | PLAY [all] 2025-05-13 12:10:03.812499 | 2025-05-13 12:10:03.812652 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-05-13 12:10:04.060507 | ubuntu-noble | changed: non-zero return code 2025-05-13 12:10:04.068997 | 2025-05-13 12:10:04.069195 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-05-13 12:10:04.095698 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:10:04.103320 | 2025-05-13 12:10:04.103476 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-05-13 12:10:04.155170 | 2025-05-13 12:10:04.155821 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-05-13 12:10:04.206590 | 2025-05-13 12:10:04.207030 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-05-13 12:10:04.232231 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:10:04.245074 | 2025-05-13 12:10:04.245232 | LOOP [fetch-subunit-output : Generate subunit file] 2025-05-13 12:10:04.285600 | 2025-05-13 12:10:04.285985 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-05-13 12:10:04.311643 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:10:04.318195 | 2025-05-13 12:10:04.318327 | TASK [fetch-subunit-output : Remove the temporary file] 2025-05-13 12:10:04.342624 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:10:04.349249 | 2025-05-13 12:10:04.349403 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-05-13 12:10:04.381053 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 12:10:04.416888 | 2025-05-13 12:10:04.417410 | PLAY RECAP 2025-05-13 12:10:04.417542 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-05-13 12:10:04.417581 | 2025-05-13 12:10:04.641460 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-05-13 12:10:04.643484 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-05-13 12:10:05.725966 | 2025-05-13 12:10:05.726215 | PLAY [Base post] 2025-05-13 12:10:05.740578 | 2025-05-13 12:10:05.740739 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-05-13 12:10:06.605948 | ubuntu-noble | changed 2025-05-13 12:10:06.639502 | 2025-05-13 12:10:06.639675 | PLAY RECAP 2025-05-13 12:10:06.639741 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-05-13 12:10:06.639849 | 2025-05-13 12:10:06.891639 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-05-13 12:10:06.892858 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-05-13 12:10:07.886997 | 2025-05-13 12:10:07.887263 | PLAY [Base post-logs] 2025-05-13 12:10:07.901003 | 2025-05-13 12:10:07.901224 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-05-13 12:10:08.575415 | localhost | changed 2025-05-13 12:10:08.595647 | 2025-05-13 12:10:08.595924 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-05-13 12:10:08.663641 | localhost | ok 2025-05-13 12:10:08.667397 | 2025-05-13 12:10:08.667528 | TASK [Set zuul-log-path fact] 2025-05-13 12:10:08.704039 | localhost | ok 2025-05-13 12:10:08.713217 | 2025-05-13 12:10:08.713375 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-13 12:10:08.773387 | localhost | ok 2025-05-13 12:10:08.777408 | 2025-05-13 12:10:08.777558 | TASK [upload-logs : Create log directories] 2025-05-13 12:10:09.615789 | localhost | changed 2025-05-13 12:10:09.618318 | 2025-05-13 12:10:09.618407 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-05-13 12:10:10.130036 | localhost -> localhost | ok: Runtime: 0:00:00.005738 2025-05-13 12:10:10.136324 | 2025-05-13 12:10:10.136467 | TASK [upload-logs : Upload logs to log server] 2025-05-13 12:10:10.719232 | localhost | Output suppressed because no_log was given 2025-05-13 12:10:10.720866 | 2025-05-13 12:10:10.720954 | LOOP [upload-logs : Compress console log and json output] 2025-05-13 12:10:10.767050 | localhost | skipping: Conditional result was False 2025-05-13 12:10:10.774496 | localhost | skipping: Conditional result was False 2025-05-13 12:10:10.787344 | 2025-05-13 12:10:10.787466 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-13 12:10:10.860320 | localhost | skipping: Conditional result was False 2025-05-13 12:10:10.860574 | 2025-05-13 12:10:10.867157 | localhost | skipping: Conditional result was False 2025-05-13 12:10:10.873622 | 2025-05-13 12:10:10.873739 | LOOP [upload-logs : Upload console log and json output]