2025-12-09 03:09:05.731681 | Job console starting 2025-12-09 03:09:05.742421 | Updating git repos 2025-12-09 03:09:05.798140 | Cloning repos into workspace 2025-12-09 03:09:05.860525 | Restoring repo states 2025-12-09 03:09:05.910748 | Merging changes 2025-12-09 03:09:05.910773 | Checking out repos 2025-12-09 03:09:06.003316 | Preparing playbooks 2025-12-09 03:09:07.510191 | Running Ansible setup 2025-12-09 03:09:15.522941 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-09 03:09:17.441533 | 2025-12-09 03:09:17.441665 | PLAY [Base pre] 2025-12-09 03:09:17.470152 | 2025-12-09 03:09:17.470276 | TASK [Setup log path fact] 2025-12-09 03:09:17.507296 | debian-bookworm | ok 2025-12-09 03:09:17.533097 | 2025-12-09 03:09:17.533231 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-09 03:09:17.591808 | debian-bookworm | ok 2025-12-09 03:09:17.633447 | 2025-12-09 03:09:17.633566 | TASK [emit-job-header : Print job information] 2025-12-09 03:09:17.693832 | # Job Information 2025-12-09 03:09:17.694028 | Ansible Version: 2.16.14 2025-12-09 03:09:17.694065 | Job: cfg-generics-tox-check 2025-12-09 03:09:17.694098 | Pipeline: periodic-daily 2025-12-09 03:09:17.694165 | Executor: 521e9411259a 2025-12-09 03:09:17.694188 | Triggered by: https://github.com/osism/generics 2025-12-09 03:09:17.694209 | Event ID: 4a524d3b4dd44b0184ce7c1da2d8daf0 2025-12-09 03:09:17.712842 | 2025-12-09 03:09:17.712978 | LOOP [emit-job-header : Print node information] 2025-12-09 03:09:18.021708 | debian-bookworm | ok: 2025-12-09 03:09:18.021922 | debian-bookworm | # Node Information 2025-12-09 03:09:18.021957 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-09 03:09:18.021981 | debian-bookworm | Hostname: debian 2025-12-09 03:09:18.022003 | debian-bookworm | Username: zuul 2025-12-09 03:09:18.022023 | debian-bookworm | Distro: Debian 12.12 2025-12-09 03:09:18.022046 | debian-bookworm | Provider: regiocloud-a 2025-12-09 03:09:18.022066 | debian-bookworm | Region: 2025-12-09 03:09:18.022087 | debian-bookworm | Label: debian-bookworm 2025-12-09 03:09:18.022106 | debian-bookworm | Product Name: OpenStack Nova 2025-12-09 03:09:18.022125 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe74:3c8a 2025-12-09 03:09:18.055635 | 2025-12-09 03:09:18.055738 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-09 03:09:19.230797 | debian-bookworm -> localhost | changed 2025-12-09 03:09:19.236642 | 2025-12-09 03:09:19.236743 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-09 03:09:21.545102 | debian-bookworm -> localhost | changed 2025-12-09 03:09:21.554531 | 2025-12-09 03:09:21.554664 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-09 03:09:22.345196 | debian-bookworm -> localhost | ok 2025-12-09 03:09:22.351423 | 2025-12-09 03:09:22.351517 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-09 03:09:22.389097 | debian-bookworm | ok 2025-12-09 03:09:22.407271 | debian-bookworm | included: /var/lib/zuul/builds/79ca98078a5440799caf8531a586ecbc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-09 03:09:22.428290 | 2025-12-09 03:09:22.428386 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-09 03:09:24.703607 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-09 03:09:24.703774 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/79ca98078a5440799caf8531a586ecbc/work/79ca98078a5440799caf8531a586ecbc_id_rsa 2025-12-09 03:09:24.703807 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/79ca98078a5440799caf8531a586ecbc/work/79ca98078a5440799caf8531a586ecbc_id_rsa.pub 2025-12-09 03:09:24.703830 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-09 03:09:24.703852 | debian-bookworm -> localhost | SHA256:2uKWMREv/5CztO+fpTJpXTM/atX/5TTTx6cFyoqHyow zuul-build-sshkey 2025-12-09 03:09:24.703871 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-09 03:09:24.703921 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-09 03:09:24.703945 | debian-bookworm -> localhost | | | 2025-12-09 03:09:24.703964 | debian-bookworm -> localhost | | . | 2025-12-09 03:09:24.703981 | debian-bookworm -> localhost | | o | 2025-12-09 03:09:24.703998 | debian-bookworm -> localhost | | o . | 2025-12-09 03:09:24.704014 | debian-bookworm -> localhost | | +S. . .| 2025-12-09 03:09:24.704037 | debian-bookworm -> localhost | | oo* . .++o| 2025-12-09 03:09:24.704054 | debian-bookworm -> localhost | | o=.B oo.o*X| 2025-12-09 03:09:24.704070 | debian-bookworm -> localhost | | =o.+.B..= *O| 2025-12-09 03:09:24.704087 | debian-bookworm -> localhost | | E.=..=++=.o =| 2025-12-09 03:09:24.704103 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-09 03:09:24.704145 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.258012 2025-12-09 03:09:24.709609 | 2025-12-09 03:09:24.709688 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-09 03:09:24.772343 | debian-bookworm | ok 2025-12-09 03:09:24.787557 | debian-bookworm | included: /var/lib/zuul/builds/79ca98078a5440799caf8531a586ecbc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-09 03:09:24.801477 | 2025-12-09 03:09:24.801573 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-09 03:09:24.842842 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:09:24.847717 | 2025-12-09 03:09:24.847811 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-09 03:09:25.464460 | debian-bookworm | changed 2025-12-09 03:09:25.473263 | 2025-12-09 03:09:25.473357 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-09 03:09:25.739201 | debian-bookworm | ok 2025-12-09 03:09:25.743723 | 2025-12-09 03:09:25.743857 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-09 03:09:26.393817 | debian-bookworm | changed 2025-12-09 03:09:26.404402 | 2025-12-09 03:09:26.404507 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-09 03:09:27.099117 | debian-bookworm | changed 2025-12-09 03:09:27.104596 | 2025-12-09 03:09:27.104692 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-09 03:09:27.173218 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:09:27.179097 | 2025-12-09 03:09:27.179203 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-09 03:09:27.722321 | debian-bookworm -> localhost | changed 2025-12-09 03:09:27.731726 | 2025-12-09 03:09:27.731817 | TASK [add-build-sshkey : Add back temp key] 2025-12-09 03:09:28.197668 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/79ca98078a5440799caf8531a586ecbc/work/79ca98078a5440799caf8531a586ecbc_id_rsa (zuul-build-sshkey) 2025-12-09 03:09:28.197846 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032376 2025-12-09 03:09:28.204803 | 2025-12-09 03:09:28.204885 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-09 03:09:28.683537 | debian-bookworm | ok 2025-12-09 03:09:28.691394 | 2025-12-09 03:09:28.692695 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-09 03:09:28.716388 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:09:28.732645 | 2025-12-09 03:09:28.732754 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-09 03:09:29.212861 | debian-bookworm | ok 2025-12-09 03:09:29.232192 | 2025-12-09 03:09:29.232303 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-09 03:09:29.270613 | debian-bookworm | ok 2025-12-09 03:09:29.293493 | 2025-12-09 03:09:29.293603 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-09 03:09:29.694874 | debian-bookworm -> localhost | ok 2025-12-09 03:09:29.701157 | 2025-12-09 03:09:29.701263 | TASK [validate-host : Collect information about the host] 2025-12-09 03:09:30.925718 | debian-bookworm | ok 2025-12-09 03:09:30.936476 | 2025-12-09 03:09:30.936589 | TASK [validate-host : Sanitize hostname] 2025-12-09 03:09:31.027148 | debian-bookworm | ok 2025-12-09 03:09:31.064172 | 2025-12-09 03:09:31.064282 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-09 03:09:31.788636 | debian-bookworm -> localhost | changed 2025-12-09 03:09:31.807032 | 2025-12-09 03:09:31.807194 | TASK [validate-host : Collect information about zuul worker] 2025-12-09 03:09:32.355928 | debian-bookworm | ok 2025-12-09 03:09:32.368036 | 2025-12-09 03:09:32.368186 | TASK [validate-host : Write out all zuul information for each host] 2025-12-09 03:09:33.755602 | debian-bookworm -> localhost | changed 2025-12-09 03:09:33.766017 | 2025-12-09 03:09:33.766153 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-09 03:09:34.065021 | debian-bookworm | ok 2025-12-09 03:09:34.071077 | 2025-12-09 03:09:34.071200 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-09 03:09:35.205618 | debian-bookworm | changed: 2025-12-09 03:09:35.205826 | debian-bookworm | cd+++++++++ src/ 2025-12-09 03:09:35.205861 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-09 03:09:35.205886 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-09 03:09:35.205949 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2025-12-09 03:09:35.205971 | debian-bookworm | =6.2 2025-12-09 03:10:00.707363 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-12-09 03:10:00.756722 | debian-bookworm | Collecting chardet>=5.2 2025-12-09 03:10:00.770152 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-09 03:10:00.781274 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 25.9 MB/s eta 0:00:00 2025-12-09 03:10:00.823106 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-09 03:10:00.835611 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-09 03:10:00.892839 | debian-bookworm | Collecting filelock>=3.20 2025-12-09 03:10:00.904429 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-12-09 03:10:00.955228 | debian-bookworm | Collecting packaging>=25 2025-12-09 03:10:00.967125 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-09 03:10:00.975364 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.6 MB/s eta 0:00:00 2025-12-09 03:10:01.024438 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-09 03:10:01.038470 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-09 03:10:01.094729 | debian-bookworm | Collecting pluggy>=1.6 2025-12-09 03:10:01.106508 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-09 03:10:01.147970 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-09 03:10:01.160287 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-09 03:10:01.289853 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-09 03:10:01.303380 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-09 03:10:01.561654 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 23.9 MB/s eta 0:00:00 2025-12-09 03:10:01.671064 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-09 03:10:01.684107 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-09 03:10:01.706881 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 23.8 MB/s eta 0:00:00 2025-12-09 03:10:01.855279 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-09 03:10:02.658541 | debian-bookworm | Successfully installed cachetools-6.2.2 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-12-09 03:10:02.996109 | debian-bookworm | ok: Runtime: 0:00:02.940118 2025-12-09 03:10:03.003431 | 2025-12-09 03:10:03.003580 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-09 03:10:03.067561 | debian-bookworm | ok 2025-12-09 03:10:03.074647 | 2025-12-09 03:10:03.074784 | TASK [ensure-tox : Output tox version] 2025-12-09 03:10:03.735605 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-09 03:10:03.753700 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-09 03:10:04.129556 | debian-bookworm | ok: Runtime: 0:00:00.302655 2025-12-09 03:10:04.136761 | 2025-12-09 03:10:04.137365 | TASK [ensure-tox : Make global symlink] 2025-12-09 03:10:04.163498 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:04.171068 | 2025-12-09 03:10:04.171173 | PLAY RECAP 2025-12-09 03:10:04.171232 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-09 03:10:04.171257 | 2025-12-09 03:10:04.386751 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-09 03:10:04.387970 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-09 03:10:06.067682 | 2025-12-09 03:10:06.067878 | PLAY [all] 2025-12-09 03:10:06.202036 | 2025-12-09 03:10:06.202234 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-09 03:10:07.546480 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-09 03:10:07.871565 | debian-bookworm | ok: Runtime: 0:00:00.032719 2025-12-09 03:10:07.928358 | 2025-12-09 03:10:07.929763 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-09 03:10:08.572652 | debian-bookworm | ok: Runtime: 0:00:00.007689 2025-12-09 03:10:08.580096 | 2025-12-09 03:10:08.580233 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-09 03:10:09.352880 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-09 03:10:09.355722 | debian-bookworm | sudo: a password is required 2025-12-09 03:10:09.690602 | debian-bookworm | ok: Runtime: 0:00:00.018701 2025-12-09 03:10:09.700968 | 2025-12-09 03:10:09.701070 | TASK [tox : Check to see if the constraints file exists] 2025-12-09 03:10:09.786549 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:09.792523 | 2025-12-09 03:10:09.792640 | TASK [tox : Fail if constraints file is missing] 2025-12-09 03:10:09.831283 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:09.846198 | 2025-12-09 03:10:09.846331 | TASK [tox : Record file location] 2025-12-09 03:10:09.939118 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:09.944784 | 2025-12-09 03:10:09.944903 | TASK [tox : Install tox siblings] 2025-12-09 03:10:10.050147 | debian-bookworm | ok 2025-12-09 03:10:10.063497 | debian-bookworm | included: /var/lib/zuul/builds/79ca98078a5440799caf8531a586ecbc/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-09 03:10:10.089630 | 2025-12-09 03:10:10.089752 | TASK [tox : Run tox without tests] 2025-12-09 03:10:10.828439 | debian-bookworm | ROOT: 183 D setup logging to DEBUG on pid 1426 [tox/report.py:225] 2025-12-09 03:10:10.856715 | debian-bookworm | check: 212 D created app data folder /home/zuul/.local/share/virtualenv [virtualenv/app_data/__init__.py:42] 2025-12-09 03:10:10.859500 | debian-bookworm | check: 215 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:78] 2025-12-09 03:10:10.860449 | debian-bookworm | check: 216 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/discovery/py_info.py oktuMyFbhOMOcgjOPOwqzMS8Blcfag1Q SiXgSsgM1y6XZaSmNRro1ZLC9BkeTDTc [virtualenv/discovery/cached_py_info.py:128] 2025-12-09 03:10:10.925652 | debian-bookworm | check: 281 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-12-09 03:10:10.926740 | debian-bookworm | check: 282 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-12-09 03:10:10.927202 | debian-bookworm | check: 282 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:85] 2025-12-09 03:10:10.927523 | debian-bookworm | check: 283 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:87] 2025-12-09 03:10:10.930992 | debian-bookworm | check: 286 D symlink on filesystem does work [virtualenv/info.py:50] 2025-12-09 03:10:10.966336 | debian-bookworm | check: 321 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/generics/.tox/check, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:52] 2025-12-09 03:10:10.966580 | debian-bookworm | check: 322 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/bin [virtualenv/util/path/_sync.py:14] 2025-12-09 03:10:10.966731 | debian-bookworm | check: 322 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:14] 2025-12-09 03:10:10.966911 | debian-bookworm | check: 322 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-12-09 03:10:10.967017 | debian-bookworm | check: 322 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:10.967067 | debian-bookworm | check: 322 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:10.967150 | debian-bookworm | check: 322 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:10.967169 | debian-bookworm | check: 322 D virtualenv = 20.35.4 [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:10.967287 | debian-bookworm | check: 322 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:10.967324 | debian-bookworm | check: 323 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:10.967331 | debian-bookworm | check: 323 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:10.967389 | debian-bookworm | check: 323 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:10.967648 | debian-bookworm | check: 323 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/generics/.tox/check/bin/python [virtualenv/util/path/_sync.py:34] 2025-12-09 03:10:10.967957 | debian-bookworm | check: 323 D create virtualenv import hook file /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/_virtualenv.pth [virtualenv/create/via_global_ref/api.py:98] 2025-12-09 03:10:10.968091 | debian-bookworm | check: 323 D create /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/_virtualenv.py [virtualenv/create/via_global_ref/api.py:101] 2025-12-09 03:10:10.968504 | debian-bookworm | check: 324 D ============================== target debug ============================== [virtualenv/run/session.py:54] 2025-12-09 03:10:10.968742 | debian-bookworm | check: 324 D debug via /home/zuul/src/github.com/osism/generics/.tox/check/bin/python /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:215] 2025-12-09 03:10:11.002675 | debian-bookworm | check: 324 D { 2025-12-09 03:10:11.002715 | debian-bookworm | "sys": { 2025-12-09 03:10:11.002720 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check/bin/python", 2025-12-09 03:10:11.002725 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2025-12-09 03:10:11.002730 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2025-12-09 03:10:11.002735 | debian-bookworm | "base_prefix": "/usr", 2025-12-09 03:10:11.002741 | debian-bookworm | "real_prefix": null, 2025-12-09 03:10:11.002747 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2025-12-09 03:10:11.002751 | debian-bookworm | "base_exec_prefix": "/usr", 2025-12-09 03:10:11.002756 | debian-bookworm | "path": [ 2025-12-09 03:10:11.002759 | debian-bookworm | "/usr/lib/python311.zip", 2025-12-09 03:10:11.002764 | debian-bookworm | "/usr/lib/python3.11", 2025-12-09 03:10:11.002769 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2025-12-09 03:10:11.002773 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages" 2025-12-09 03:10:11.002777 | debian-bookworm | ], 2025-12-09 03:10:11.002781 | debian-bookworm | "meta_path": [ 2025-12-09 03:10:11.002785 | debian-bookworm | "", 2025-12-09 03:10:11.002789 | debian-bookworm | "", 2025-12-09 03:10:11.002793 | debian-bookworm | "", 2025-12-09 03:10:11.002797 | debian-bookworm | "" 2025-12-09 03:10:11.002801 | debian-bookworm | ], 2025-12-09 03:10:11.002804 | debian-bookworm | "fs_encoding": "utf-8", 2025-12-09 03:10:11.002808 | debian-bookworm | "io_encoding": "utf-8" 2025-12-09 03:10:11.002812 | debian-bookworm | }, 2025-12-09 03:10:11.002816 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2025-12-09 03:10:11.002820 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2025-12-09 03:10:11.002824 | debian-bookworm | "os": "", 2025-12-09 03:10:11.002828 | debian-bookworm | "site": "", 2025-12-09 03:10:11.002832 | debian-bookworm | "datetime": "", 2025-12-09 03:10:11.002836 | debian-bookworm | "math": "", 2025-12-09 03:10:11.002840 | debian-bookworm | "json": "" 2025-12-09 03:10:11.002844 | debian-bookworm | } [virtualenv/run/session.py:55] 2025-12-09 03:10:11.003046 | debian-bookworm | check: 358 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-12-09 03:10:11.004838 | debian-bookworm | check: 360 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-25.3-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51] 2025-12-09 03:10:11.009179 | debian-bookworm | check: 361 D build install image for pip-25.3-py3-none-any.whl to /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.3-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2025-12-09 03:10:11.010236 | debian-bookworm | check: 365 D install setuptools from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/setuptools-80.9.0-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51] 2025-12-09 03:10:11.012347 | debian-bookworm | check: 367 D build install image for setuptools-80.9.0-py3-none-any.whl to /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2025-12-09 03:10:11.236266 | debian-bookworm | check: 591 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.3-py3-none-any/pip-25.3.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-25.3.virtualenv [virtualenv/util/path/_sync.py:42] 2025-12-09 03:10:11.237502 | debian-bookworm | check: 593 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.3-py3-none-any/pip to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip [virtualenv/util/path/_sync.py:42] 2025-12-09 03:10:11.272237 | debian-bookworm | check: 627 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools-80.9.0.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/setuptools-80.9.0.dist-info [virtualenv/util/path/_sync.py:42] 2025-12-09 03:10:11.274893 | debian-bookworm | check: 630 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/pkg_resources to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pkg_resources [virtualenv/util/path/_sync.py:42] 2025-12-09 03:10:11.283996 | debian-bookworm | check: 639 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/distutils-precedence.pth to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:42] 2025-12-09 03:10:11.284368 | debian-bookworm | check: 640 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/_distutils_hack to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:42] 2025-12-09 03:10:11.285278 | debian-bookworm | check: 640 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools-80.9.0.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/setuptools-80.9.0.virtualenv [virtualenv/util/path/_sync.py:42] 2025-12-09 03:10:11.285551 | debian-bookworm | check: 641 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/setuptools [virtualenv/util/path/_sync.py:42] 2025-12-09 03:10:11.437316 | debian-bookworm | check: 792 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.3-py3-none-any/pip-25.3.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-25.3.dist-info [virtualenv/util/path/_sync.py:42] 2025-12-09 03:10:11.449605 | debian-bookworm | check: 805 D generated console scripts pip3.11 pip3 pip-3.11 pip [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-12-09 03:10:11.457960 | debian-bookworm | check: 813 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-12-09 03:10:11.459346 | debian-bookworm | check: 814 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65] 2025-12-09 03:10:11.468440 | debian-bookworm | check: 824 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-12-09 03:10:11.468712 | debian-bookworm | check: 824 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:11.468892 | debian-bookworm | check: 824 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:11.469048 | debian-bookworm | check: 824 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:11.469296 | debian-bookworm | check: 824 D virtualenv = 20.35.4 [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:11.469456 | debian-bookworm | check: 825 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:11.469638 | debian-bookworm | check: 825 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:11.469809 | debian-bookworm | check: 825 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:11.470007 | debian-bookworm | check: 825 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-12-09 03:10:11.478606 | debian-bookworm | check: 834 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:464] 2025-12-09 03:10:12.537035 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2025-12-09 03:10:12.648806 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2025-12-09 03:10:12.792538 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2025-12-09 03:10:12.806987 | debian-bookworm | Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.4 kB) 2025-12-09 03:10:12.891533 | debian-bookworm | Collecting ansible==11.12.0 (from -r requirements.txt (line 3)) 2025-12-09 03:10:12.906136 | debian-bookworm | Downloading ansible-11.12.0-py3-none-any.whl.metadata (8.1 kB) 2025-12-09 03:10:12.959685 | debian-bookworm | Collecting packaging==25.0 (from -r requirements.txt (line 4)) 2025-12-09 03:10:12.974587 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl.metadata (3.3 kB) 2025-12-09 03:10:13.113033 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2025-12-09 03:10:13.129445 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2025-12-09 03:10:13.149437 | debian-bookworm | Installing build dependencies: started 2025-12-09 03:10:14.468875 | debian-bookworm | Installing build dependencies: finished with status 'done' 2025-12-09 03:10:14.469816 | debian-bookworm | Getting requirements to build wheel: started 2025-12-09 03:10:14.882957 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2025-12-09 03:10:14.883997 | debian-bookworm | Preparing metadata (pyproject.toml): started 2025-12-09 03:10:15.141650 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2025-12-09 03:10:15.278291 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2025-12-09 03:10:15.293970 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2025-12-09 03:10:15.355999 | debian-bookworm | Collecting requests==2.32.5 (from -r requirements.txt (line 7)) 2025-12-09 03:10:15.369996 | debian-bookworm | Downloading requests-2.32.5-py3-none-any.whl.metadata (4.9 kB) 2025-12-09 03:10:15.420204 | debian-bookworm | Collecting tabulate==0.9.0 (from -r requirements.txt (line 8)) 2025-12-09 03:10:15.435729 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl.metadata (34 kB) 2025-12-09 03:10:15.569035 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2025-12-09 03:10:15.582880 | debian-bookworm | Downloading markupsafe-3.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.7 kB) 2025-12-09 03:10:15.683365 | debian-bookworm | Collecting ansible-core~=2.18.11 (from ansible==11.12.0->-r requirements.txt (line 3)) 2025-12-09 03:10:15.697643 | debian-bookworm | Downloading ansible_core-2.18.11-py3-none-any.whl.metadata (7.7 kB) 2025-12-09 03:10:15.749001 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-12-09 03:10:15.762696 | debian-bookworm | Downloading click-8.3.1-py3-none-any.whl.metadata (2.6 kB) 2025-12-09 03:10:15.804971 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-12-09 03:10:15.819464 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-12-09 03:10:15.864103 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-12-09 03:10:15.878972 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2025-12-09 03:10:15.930168 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-12-09 03:10:15.945160 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2025-12-09 03:10:16.092848 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-12-09 03:10:16.107232 | debian-bookworm | Downloading charset_normalizer-3.4.4-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (37 kB) 2025-12-09 03:10:16.146573 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-12-09 03:10:16.160122 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl.metadata (8.4 kB) 2025-12-09 03:10:16.216847 | debian-bookworm | Collecting urllib3<3,>=1.21.1 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-12-09 03:10:16.230341 | debian-bookworm | Downloading urllib3-2.6.1-py3-none-any.whl.metadata (6.6 kB) 2025-12-09 03:10:16.274888 | debian-bookworm | Collecting certifi>=2017.4.17 (from requests==2.32.5->-r requirements.txt (line 7)) 2025-12-09 03:10:16.288510 | debian-bookworm | Downloading certifi-2025.11.12-py3-none-any.whl.metadata (2.5 kB) 2025-12-09 03:10:16.604821 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2025-12-09 03:10:16.618499 | debian-bookworm | Downloading cryptography-46.0.3-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2025-12-09 03:10:16.658774 | debian-bookworm | Collecting resolvelib<1.1.0,>=0.5.3 (from ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2025-12-09 03:10:16.671925 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2025-12-09 03:10:16.856506 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2025-12-09 03:10:16.872498 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2025-12-09 03:10:16.905755 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core~=2.18.11->ansible==11.12.0->-r requirements.txt (line 3)) 2025-12-09 03:10:16.919108 | debian-bookworm | Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes) 2025-12-09 03:10:16.946128 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-12-09 03:10:17.053918 | debian-bookworm | Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB) 2025-12-09 03:10:17.107474 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 14.6 MB/s 0:00:00 2025-12-09 03:10:17.123595 | debian-bookworm | Downloading ansible-11.12.0-py3-none-any.whl (57.4 MB) 2025-12-09 03:10:18.992786 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.4/57.4 MB 30.7 MB/s 0:00:01 2025-12-09 03:10:19.009150 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-09 03:10:19.098785 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2025-12-09 03:10:19.126163 | debian-bookworm | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2025-12-09 03:10:19.152134 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl (35 kB) 2025-12-09 03:10:19.179658 | debian-bookworm | Downloading ansible_core-2.18.11-py3-none-any.whl (2.2 MB) 2025-12-09 03:10:19.287513 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 19.9 MB/s 0:00:00 2025-12-09 03:10:19.304687 | debian-bookworm | Downloading charset_normalizer-3.4.4-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (151 kB) 2025-12-09 03:10:19.332950 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl (71 kB) 2025-12-09 03:10:19.359984 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2025-12-09 03:10:19.388986 | debian-bookworm | Downloading urllib3-2.6.1-py3-none-any.whl (131 kB) 2025-12-09 03:10:19.417733 | debian-bookworm | Downloading certifi-2025.11.12-py3-none-any.whl (159 kB) 2025-12-09 03:10:19.446714 | debian-bookworm | Downloading markupsafe-3.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (22 kB) 2025-12-09 03:10:19.473607 | debian-bookworm | Downloading click-8.3.1-py3-none-any.whl (108 kB) 2025-12-09 03:10:19.500546 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-09 03:10:19.525566 | debian-bookworm | Downloading cryptography-46.0.3-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2025-12-09 03:10:19.724592 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 22.6 MB/s 0:00:00 2025-12-09 03:10:19.737765 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2025-12-09 03:10:19.767406 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2025-12-09 03:10:19.793163 | debian-bookworm | Downloading pycparser-2.23-py3-none-any.whl (118 kB) 2025-12-09 03:10:19.818698 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2025-12-09 03:10:20.110245 | debian-bookworm | Building wheels for collected packages: pwgen 2025-12-09 03:10:20.111482 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2025-12-09 03:10:20.388228 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2025-12-09 03:10:20.389828 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3797 sha256=3737f88e4a5730bc63d038bec6197c09c747c042618ad6428ad0ec40ee2ab1b9 2025-12-09 03:10:20.390490 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2025-12-09 03:10:20.395726 | debian-bookworm | Successfully built pwgen 2025-12-09 03:10:20.641361 | 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-12-09 03:10:47.683625 | debian-bookworm | 2025-12-09 03:10:47.686395 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-11.12.0 ansible-core-2.18.11 certifi-2025.11.12 cffi-2.0.0 charset_normalizer-3.4.4 click-8.3.1 colorama-0.4.6 cryptography-46.0.3 fasteners-0.20 idna-3.11 packaging-25.0 pwgen-0.8.2.post0 pycparser-2.23 python-gilt-1.2.3 requests-2.32.5 resolvelib-1.0.1 sh-2.2.2 tabulate-0.9.0 urllib3-2.6.1 2025-12-09 03:10:47.836829 | debian-bookworm | check: 37191 I exit 0 (36.36 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1439 [tox/execute/api.py:295] 2025-12-09 03:10:47.837503 | debian-bookworm | check: OK (36.98 seconds) 2025-12-09 03:10:47.837545 | debian-bookworm | congratulations :) (37.01 seconds) 2025-12-09 03:10:48.224121 | debian-bookworm | ok: Runtime: 0:00:37.267817 2025-12-09 03:10:48.232789 | 2025-12-09 03:10:48.232963 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-09 03:10:48.726036 | debian-bookworm | changed 2025-12-09 03:10:48.735296 | 2025-12-09 03:10:48.735441 | TASK [tox : Get tox envlist config] 2025-12-09 03:10:49.783944 | debian-bookworm | ok: Runtime: 0:00:00.278806 2025-12-09 03:10:49.791039 | 2025-12-09 03:10:49.791178 | TASK [tox : Install any sibling python packages] 2025-12-09 03:10:50.469476 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-09 03:10:50.480014 | 2025-12-09 03:10:50.480157 | TASK [tox : Remove tempfile] 2025-12-09 03:10:51.451707 | debian-bookworm | changed 2025-12-09 03:10:51.485520 | 2025-12-09 03:10:51.485691 | TASK [tox : Emit tox command] 2025-12-09 03:10:51.551899 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2025-12-09 03:10:51.565141 | 2025-12-09 03:10:51.565285 | TASK [tox : Run tox] 2025-12-09 03:10:52.439133 | debian-bookworm | ROOT: 214 D setup logging to DEBUG on pid 1594 [tox/report.py:225] 2025-12-09 03:10:52.473483 | debian-bookworm | check: 248 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:78] 2025-12-09 03:10:52.474414 | debian-bookworm | check: 249 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-12-09 03:10:52.475134 | debian-bookworm | check: 250 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-12-09 03:10:52.475270 | debian-bookworm | check: 250 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:85] 2025-12-09 03:10:52.475370 | debian-bookworm | check: 250 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:87] 2025-12-09 03:10:52.476655 | debian-bookworm | check: 251 D symlink on filesystem does work [virtualenv/info.py:50] 2025-12-09 03:10:52.514658 | debian-bookworm | check: 289 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:464] 2025-12-09 03:10:52.578855 | debian-bookworm | check: 353 I exit 0 (0.06 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-inventory-sorting.py pid=1601 [tox/execute/api.py:295] 2025-12-09 03:10:52.579490 | debian-bookworm | check: OK (0.11=setup[0.05]+cmd[0.06] seconds) 2025-12-09 03:10:52.579508 | debian-bookworm | congratulations :) (0.14 seconds) 2025-12-09 03:10:52.851274 | debian-bookworm | ok: Runtime: 0:00:00.429123 2025-12-09 03:10:52.857680 | 2025-12-09 03:10:52.857803 | TASK [tox : Look for output] 2025-12-09 03:10:53.289043 | debian-bookworm | ok 2025-12-09 03:10:53.306008 | 2025-12-09 03:10:53.306160 | TASK [tox : Return file comments to Zuul] 2025-12-09 03:10:53.344493 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:53.354201 | 2025-12-09 03:10:53.354340 | PLAY RECAP 2025-12-09 03:10:53.354401 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-09 03:10:53.354437 | 2025-12-09 03:10:53.611437 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-09 03:10:53.612592 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-09 03:10:55.140167 | 2025-12-09 03:10:55.140350 | PLAY [all] 2025-12-09 03:10:55.165975 | 2025-12-09 03:10:55.166148 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-09 03:10:55.245713 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:55.253248 | 2025-12-09 03:10:55.253433 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-09 03:10:55.355808 | debian-bookworm | ok 2025-12-09 03:10:55.376702 | 2025-12-09 03:10:55.376892 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-09 03:10:56.820219 | debian-bookworm -> localhost | changed 2025-12-09 03:10:56.830640 | 2025-12-09 03:10:56.830808 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-09 03:10:56.957439 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:56.963782 | 2025-12-09 03:10:56.963983 | TASK [fetch-tox-output : Set envlist fact] 2025-12-09 03:10:57.089897 | debian-bookworm | ok 2025-12-09 03:10:57.099807 | 2025-12-09 03:10:57.099998 | TASK [fetch-tox-output : Get tox version] 2025-12-09 03:10:58.140605 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-09 03:10:58.158980 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-09 03:10:58.688619 | debian-bookworm | ok: Runtime: 0:00:00.278748 2025-12-09 03:10:58.694957 | 2025-12-09 03:10:58.695094 | TASK [fetch-tox-output : Find all default environments] 2025-12-09 03:10:59.248407 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:59.258186 | 2025-12-09 03:10:59.258348 | TASK [fetch-tox-output : Set envlist fact] 2025-12-09 03:10:59.307503 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:59.317781 | 2025-12-09 03:10:59.317935 | TASK [fetch-tox-output : Find all default environments] 2025-12-09 03:10:59.882409 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:59.890441 | 2025-12-09 03:10:59.890600 | TASK [fetch-tox-output : Set envlist fact] 2025-12-09 03:10:59.936908 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:10:59.956543 | 2025-12-09 03:10:59.956692 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-09 03:11:00.111692 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:11:00.124723 | 2025-12-09 03:11:00.124890 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-09 03:11:01.799010 | debian-bookworm | changed: 2025-12-09 03:11:01.799279 | debian-bookworm | created directory /var/lib/zuul/builds/79ca98078a5440799caf8531a586ecbc/work/logs/tox/check 2025-12-09 03:11:01.799319 | debian-bookworm | cd+++++++++ ./ 2025-12-09 03:11:01.799345 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-09 03:11:01.799377 | 2025-12-09 03:11:01.823110 | 2025-12-09 03:11:01.823215 | PLAY RECAP 2025-12-09 03:11:01.823273 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-09 03:11:01.823297 | 2025-12-09 03:11:02.528162 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-09 03:11:02.529904 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-09 03:11:04.994335 | 2025-12-09 03:11:04.994526 | PLAY [all] 2025-12-09 03:11:05.277573 | 2025-12-09 03:11:05.277774 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-09 03:11:05.847989 | debian-bookworm | changed: non-zero return code 2025-12-09 03:11:05.871703 | 2025-12-09 03:11:05.871974 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-09 03:11:05.936379 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:11:05.944332 | 2025-12-09 03:11:05.944518 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-09 03:11:06.047733 | 2025-12-09 03:11:06.047993 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-09 03:11:06.123514 | 2025-12-09 03:11:06.123737 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-09 03:11:06.217575 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:11:06.224568 | 2025-12-09 03:11:06.224716 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-09 03:11:06.293032 | 2025-12-09 03:11:06.293375 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-09 03:11:06.365320 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:11:06.372986 | 2025-12-09 03:11:06.373148 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-09 03:11:06.422162 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:11:06.429676 | 2025-12-09 03:11:06.429863 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-09 03:11:06.517155 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:11:06.540521 | 2025-12-09 03:11:06.540647 | PLAY RECAP 2025-12-09 03:11:06.540713 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-09 03:11:06.540744 | 2025-12-09 03:11:07.135972 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-09 03:11:07.137060 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-09 03:11:10.127775 | 2025-12-09 03:11:10.128014 | PLAY [Base post] 2025-12-09 03:11:10.178558 | 2025-12-09 03:11:10.178735 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-09 03:11:11.399632 | debian-bookworm | changed 2025-12-09 03:11:11.484074 | 2025-12-09 03:11:11.484240 | PLAY RECAP 2025-12-09 03:11:11.484313 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-09 03:11:11.484375 | 2025-12-09 03:11:12.931763 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-09 03:11:12.932902 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-09 03:11:16.511673 | 2025-12-09 03:11:16.527550 | PLAY [Base post-logs] 2025-12-09 03:11:16.594204 | 2025-12-09 03:11:16.594394 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-09 03:11:18.511058 | localhost | changed 2025-12-09 03:11:18.586025 | 2025-12-09 03:11:18.586238 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-09 03:11:18.741662 | localhost | ok 2025-12-09 03:11:18.745752 | 2025-12-09 03:11:18.746767 | TASK [Set zuul-log-path fact] 2025-12-09 03:11:18.809328 | localhost | ok 2025-12-09 03:11:18.844529 | 2025-12-09 03:11:18.844711 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-09 03:11:18.947547 | localhost | ok 2025-12-09 03:11:18.951111 | 2025-12-09 03:11:18.951231 | TASK [upload-logs : Create log directories] 2025-12-09 03:11:20.381502 | localhost | changed 2025-12-09 03:11:20.397349 | 2025-12-09 03:11:20.397494 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-09 03:11:21.708241 | localhost -> localhost | ok: Runtime: 0:00:00.020186 2025-12-09 03:11:21.712693 | 2025-12-09 03:11:21.712876 | TASK [upload-logs : Upload logs to log server] 2025-12-09 03:11:22.961509 | localhost | Output suppressed because no_log was given 2025-12-09 03:11:22.963607 | 2025-12-09 03:11:22.963717 | LOOP [upload-logs : Compress console log and json output] 2025-12-09 03:11:23.062395 | localhost | skipping: Conditional result was False 2025-12-09 03:11:23.079959 | localhost | skipping: Conditional result was False 2025-12-09 03:11:23.093133 | 2025-12-09 03:11:23.093283 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-09 03:11:23.204268 | localhost | skipping: Conditional result was False 2025-12-09 03:11:23.204583 | 2025-12-09 03:11:23.210751 | localhost | skipping: Conditional result was False 2025-12-09 03:11:23.214598 | 2025-12-09 03:11:23.214732 | LOOP [upload-logs : Upload console log and json output]