2026-05-02 03:04:35.885337 | Job console starting 2026-05-02 03:04:35.895125 | Updating git repos 2026-05-02 03:04:35.988169 | Cloning repos into workspace 2026-05-02 03:04:36.210650 | Restoring repo states 2026-05-02 03:04:36.271812 | Merging changes 2026-05-02 03:04:36.271831 | Checking out repos 2026-05-02 03:04:36.373424 | Preparing playbooks 2026-05-02 03:04:37.695260 | Running Ansible setup 2026-05-02 03:04:45.616751 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-02 03:04:47.132448 | 2026-05-02 03:04:47.132567 | PLAY [Base pre] 2026-05-02 03:04:47.145946 | 2026-05-02 03:04:47.146051 | TASK [Setup log path fact] 2026-05-02 03:04:47.173706 | debian-bookworm | ok 2026-05-02 03:04:47.188953 | 2026-05-02 03:04:47.189105 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-02 03:04:47.216017 | debian-bookworm | ok 2026-05-02 03:04:47.224535 | 2026-05-02 03:04:47.224636 | TASK [emit-job-header : Print job information] 2026-05-02 03:04:47.256785 | # Job Information 2026-05-02 03:04:47.256997 | Ansible Version: 2.16.14 2026-05-02 03:04:47.257028 | Job: cfg-generics-tox-check 2026-05-02 03:04:47.257062 | Pipeline: periodic-daily 2026-05-02 03:04:47.257095 | Executor: 521e9411259a 2026-05-02 03:04:47.257113 | Triggered by: https://github.com/osism/generics 2026-05-02 03:04:47.257131 | Event ID: 5da70fab809947e486c8a9d7a4af4304 2026-05-02 03:04:47.261641 | 2026-05-02 03:04:47.261741 | LOOP [emit-job-header : Print node information] 2026-05-02 03:04:47.395472 | debian-bookworm | ok: 2026-05-02 03:04:47.395685 | debian-bookworm | # Node Information 2026-05-02 03:04:47.395715 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-02 03:04:47.395736 | debian-bookworm | Hostname: debian 2026-05-02 03:04:47.395754 | debian-bookworm | Username: zuul 2026-05-02 03:04:47.395771 | debian-bookworm | Distro: Debian 12.13 2026-05-02 03:04:47.395795 | debian-bookworm | Provider: regiocloud-a 2026-05-02 03:04:47.395817 | debian-bookworm | Region: 2026-05-02 03:04:47.395835 | debian-bookworm | Label: debian-bookworm 2026-05-02 03:04:47.395850 | debian-bookworm | Product Name: OpenStack Nova 2026-05-02 03:04:47.395866 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef0:31a9 2026-05-02 03:04:47.412982 | 2026-05-02 03:04:47.413093 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-02 03:04:48.097143 | debian-bookworm -> localhost | changed 2026-05-02 03:04:48.104218 | 2026-05-02 03:04:48.104334 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-02 03:04:49.321899 | debian-bookworm -> localhost | changed 2026-05-02 03:04:49.331415 | 2026-05-02 03:04:49.332464 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-02 03:04:49.666992 | debian-bookworm -> localhost | ok 2026-05-02 03:04:49.672059 | 2026-05-02 03:04:49.672183 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-02 03:04:49.728216 | debian-bookworm | ok 2026-05-02 03:04:49.750363 | debian-bookworm | included: /var/lib/zuul/builds/0ea9eab181e54345a758301db25f3559/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-02 03:04:49.764098 | 2026-05-02 03:04:49.764197 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-02 03:04:52.186749 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-02 03:04:52.191021 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0ea9eab181e54345a758301db25f3559/work/0ea9eab181e54345a758301db25f3559_id_rsa 2026-05-02 03:04:52.191102 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0ea9eab181e54345a758301db25f3559/work/0ea9eab181e54345a758301db25f3559_id_rsa.pub 2026-05-02 03:04:52.191133 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-02 03:04:52.191159 | debian-bookworm -> localhost | SHA256:UnrMSNSVldkv6D9tHmoXSz5FvG96uwNsEz7oRrbrdRk zuul-build-sshkey 2026-05-02 03:04:52.191182 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-02 03:04:52.191212 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-02 03:04:52.191239 | debian-bookworm -> localhost | | .. ..o.+ | 2026-05-02 03:04:52.191262 | debian-bookworm -> localhost | | . . . o . | 2026-05-02 03:04:52.191283 | debian-bookworm -> localhost | | . . . o | 2026-05-02 03:04:52.191303 | debian-bookworm -> localhost | | . * ... +| 2026-05-02 03:04:52.191322 | debian-bookworm -> localhost | | + S .+ .E.| 2026-05-02 03:04:52.191348 | debian-bookworm -> localhost | | o +.B ++| 2026-05-02 03:04:52.191368 | debian-bookworm -> localhost | | + oo*==| 2026-05-02 03:04:52.191388 | debian-bookworm -> localhost | | +..=*B| 2026-05-02 03:04:52.191408 | debian-bookworm -> localhost | | ooo.oX*| 2026-05-02 03:04:52.191429 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-02 03:04:52.191496 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.921558 2026-05-02 03:04:52.202016 | 2026-05-02 03:04:52.202148 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-02 03:04:52.262341 | debian-bookworm | ok 2026-05-02 03:04:52.278051 | debian-bookworm | included: /var/lib/zuul/builds/0ea9eab181e54345a758301db25f3559/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-02 03:04:52.299018 | 2026-05-02 03:04:52.299286 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-02 03:04:52.324732 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:04:52.338278 | 2026-05-02 03:04:52.338406 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-02 03:04:53.243856 | debian-bookworm | changed 2026-05-02 03:04:53.253261 | 2026-05-02 03:04:53.253365 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-02 03:04:53.552610 | debian-bookworm | ok 2026-05-02 03:04:53.560798 | 2026-05-02 03:04:53.560997 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-02 03:04:54.201939 | debian-bookworm | changed 2026-05-02 03:04:54.218849 | 2026-05-02 03:04:54.219019 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-02 03:04:54.960822 | debian-bookworm | changed 2026-05-02 03:04:54.968167 | 2026-05-02 03:04:54.968278 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-02 03:04:54.991847 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:04:54.998286 | 2026-05-02 03:04:54.998384 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-02 03:04:55.560373 | debian-bookworm -> localhost | changed 2026-05-02 03:04:55.581807 | 2026-05-02 03:04:55.581950 | TASK [add-build-sshkey : Add back temp key] 2026-05-02 03:04:55.898603 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0ea9eab181e54345a758301db25f3559/work/0ea9eab181e54345a758301db25f3559_id_rsa (zuul-build-sshkey) 2026-05-02 03:04:55.898852 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014823 2026-05-02 03:04:55.909360 | 2026-05-02 03:04:55.909479 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-02 03:04:56.333290 | debian-bookworm | ok 2026-05-02 03:04:56.342244 | 2026-05-02 03:04:56.342418 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-02 03:04:56.388705 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:04:56.401891 | 2026-05-02 03:04:56.402042 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-02 03:04:56.887433 | debian-bookworm | ok 2026-05-02 03:04:56.902387 | 2026-05-02 03:04:56.902547 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-02 03:04:56.936634 | debian-bookworm | ok 2026-05-02 03:04:56.942852 | 2026-05-02 03:04:56.943002 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-02 03:04:57.265211 | debian-bookworm -> localhost | ok 2026-05-02 03:04:57.275190 | 2026-05-02 03:04:57.275510 | TASK [validate-host : Collect information about the host] 2026-05-02 03:04:58.490212 | debian-bookworm | ok 2026-05-02 03:04:58.503332 | 2026-05-02 03:04:58.503480 | TASK [validate-host : Sanitize hostname] 2026-05-02 03:04:58.647479 | debian-bookworm | ok 2026-05-02 03:04:58.707292 | 2026-05-02 03:04:58.707460 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-02 03:04:59.300821 | debian-bookworm -> localhost | changed 2026-05-02 03:04:59.308344 | 2026-05-02 03:04:59.308504 | TASK [validate-host : Collect information about zuul worker] 2026-05-02 03:04:59.750999 | debian-bookworm | ok 2026-05-02 03:04:59.758327 | 2026-05-02 03:04:59.758483 | TASK [validate-host : Write out all zuul information for each host] 2026-05-02 03:05:00.598818 | debian-bookworm -> localhost | changed 2026-05-02 03:05:00.609846 | 2026-05-02 03:05:00.609996 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-02 03:05:00.883029 | debian-bookworm | ok 2026-05-02 03:05:00.889674 | 2026-05-02 03:05:00.889820 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-02 03:05:02.123198 | debian-bookworm | changed: 2026-05-02 03:05:02.123466 | debian-bookworm | cd+++++++++ src/ 2026-05-02 03:05:02.123803 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-02 03:05:02.123848 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-02 03:05:02.123874 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-05-02 03:05:02.123942 | debian-bookworm | =7.0.3 2026-05-02 03:05:28.507292 | debian-bookworm | Downloading cachetools-7.1.0-py3-none-any.whl (16 kB) 2026-05-02 03:05:28.595517 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-02 03:05:28.607186 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-02 03:05:28.678081 | debian-bookworm | Collecting filelock>=3.25 2026-05-02 03:05:28.689397 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-02 03:05:28.740455 | debian-bookworm | Collecting packaging>=26 2026-05-02 03:05:28.751850 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-02 03:05:28.762585 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 12.3 MB/s eta 0:00:00 2026-05-02 03:05:28.812702 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-02 03:05:28.823812 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-05-02 03:05:28.863185 | debian-bookworm | Collecting pluggy>=1.6 2026-05-02 03:05:28.874014 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-02 03:05:28.912495 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-02 03:05:28.924380 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-02 03:05:28.958215 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-02 03:05:28.968798 | debian-bookworm | Downloading python_discovery-1.2.2-py3-none-any.whl (31 kB) 2026-05-02 03:05:28.999873 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-02 03:05:29.011445 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-02 03:05:29.142939 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-02 03:05:29.154113 | debian-bookworm | Downloading virtualenv-21.3.0-py3-none-any.whl (7.6 MB) 2026-05-02 03:05:29.484900 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 23.3 MB/s eta 0:00:00 2026-05-02 03:05:29.609405 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-02 03:05:29.621696 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-02 03:05:29.648437 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 19.8 MB/s eta 0:00:00 2026-05-02 03:05:29.755943 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-02 03:05:30.717677 | debian-bookworm | Successfully installed cachetools-7.1.0 colorama-0.4.6 distlib-0.4.0 filelock-3.29.0 packaging-26.2 platformdirs-4.9.6 pluggy-1.6.0 pyproject-api-1.10.0 python-discovery-1.2.2 tomli-w-1.2.0 tox-4.53.0 virtualenv-21.3.0 2026-05-02 03:05:30.896931 | debian-bookworm | ok: Runtime: 0:00:03.214012 2026-05-02 03:05:30.901717 | 2026-05-02 03:05:30.901803 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-02 03:05:30.941016 | debian-bookworm | ok 2026-05-02 03:05:30.953703 | 2026-05-02 03:05:30.953804 | TASK [ensure-tox : Output tox version] 2026-05-02 03:05:31.632151 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-05-02 03:05:31.651142 | debian-bookworm | 4.53.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-02 03:05:32.056525 | debian-bookworm | ok: Runtime: 0:00:00.323510 2026-05-02 03:05:32.067910 | 2026-05-02 03:05:32.068009 | TASK [ensure-tox : Make global symlink] 2026-05-02 03:05:32.103876 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:05:32.111692 | 2026-05-02 03:05:32.111779 | PLAY RECAP 2026-05-02 03:05:32.111848 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-02 03:05:32.111878 | 2026-05-02 03:05:32.380329 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-02 03:05:32.382216 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-02 03:05:33.522681 | 2026-05-02 03:05:33.522822 | PLAY [all] 2026-05-02 03:05:33.539254 | 2026-05-02 03:05:33.539393 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-02 03:05:34.104466 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-02 03:05:34.571232 | debian-bookworm | ok: Runtime: 0:00:00.030118 2026-05-02 03:05:34.577441 | 2026-05-02 03:05:34.577566 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-02 03:05:35.136975 | debian-bookworm | ok: Runtime: 0:00:00.006249 2026-05-02 03:05:35.146961 | 2026-05-02 03:05:35.147213 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-02 03:05:35.482545 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-02 03:05:35.484093 | debian-bookworm | sudo: a password is required 2026-05-02 03:05:35.696084 | debian-bookworm | ok: Runtime: 0:00:00.018544 2026-05-02 03:05:35.706223 | 2026-05-02 03:05:35.706340 | TASK [tox : Check to see if the constraints file exists] 2026-05-02 03:05:35.764873 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:05:35.771788 | 2026-05-02 03:05:35.771955 | TASK [tox : Fail if constraints file is missing] 2026-05-02 03:05:35.797402 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:05:35.805192 | 2026-05-02 03:05:35.805357 | TASK [tox : Record file location] 2026-05-02 03:05:35.859361 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:05:35.868481 | 2026-05-02 03:05:35.868634 | TASK [tox : Install tox siblings] 2026-05-02 03:05:35.900680 | debian-bookworm | ok 2026-05-02 03:05:35.918306 | debian-bookworm | included: /var/lib/zuul/builds/0ea9eab181e54345a758301db25f3559/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-02 03:05:35.924418 | 2026-05-02 03:05:35.924558 | TASK [tox : Run tox without tests] 2026-05-02 03:05:36.468726 | debian-bookworm | ROOT: 202 D setup logging to DEBUG on pid 1475 [tox/report.py:229] 2026-05-02 03:05:36.499082 | debian-bookworm | check: 233 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-05-02 03:05:36.501696 | debian-bookworm | check: 235 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:62] 2026-05-02 03:05:36.505616 | debian-bookworm | check: 239 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/python_discovery/_py_info.py 618776c0dfd70049126c780f705da217 b28cace00d978365f351deb3ad37eff4 [python_discovery/_cached_py_info.py:198] 2026-05-02 03:05:36.585092 | debian-bookworm | check: 319 D wrote python info of /usr/bin/python3.11 at /home/zuul/.cache/virtualenv/py_info/4/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:159] 2026-05-02 03:05:36.586511 | debian-bookworm | check: 320 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-05-02 03:05:36.586891 | debian-bookworm | check: 321 I proposed PythonInfo(spec=CPython3.11.2.final.0-64-x86_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) [python_discovery/_discovery.py:71] 2026-05-02 03:05:36.587251 | debian-bookworm | check: 321 D accepted PythonInfo(spec=CPython3.11.2.final.0-64-x86_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) [python_discovery/_discovery.py:75] 2026-05-02 03:05:36.591069 | debian-bookworm | check: 325 D symlink on filesystem does work [virtualenv/info.py:51] 2026-05-02 03:05:36.591432 | debian-bookworm | check: 325 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-05-02 03:05:36.628167 | debian-bookworm | check: 362 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:77] 2026-05-02 03:05:36.628560 | debian-bookworm | check: 362 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/bin [virtualenv/util/path/_sync.py:18] 2026-05-02 03:05:36.628717 | debian-bookworm | check: 363 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/include [virtualenv/util/path/_sync.py:18] 2026-05-02 03:05:36.628815 | debian-bookworm | check: 363 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:18] 2026-05-02 03:05:36.629021 | debian-bookworm | check: 363 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-05-02 03:05:36.629109 | debian-bookworm | check: 363 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.629159 | debian-bookworm | check: 363 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.629224 | debian-bookworm | check: 363 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.629278 | debian-bookworm | check: 363 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.629327 | debian-bookworm | check: 363 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.629378 | debian-bookworm | check: 363 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/check [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.629424 | debian-bookworm | check: 363 D virtualenv = 21.3.0 [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.629475 | debian-bookworm | check: 363 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.629523 | debian-bookworm | check: 363 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.629568 | debian-bookworm | check: 363 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.629614 | debian-bookworm | check: 364 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:36.630114 | debian-bookworm | check: 364 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/generics/.tox/check/bin/python [virtualenv/util/path/_sync.py:38] 2026-05-02 03:05:36.630538 | debian-bookworm | check: 364 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:118] 2026-05-02 03:05:36.630689 | debian-bookworm | check: 365 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:121] 2026-05-02 03:05:36.631141 | debian-bookworm | check: 365 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-05-02 03:05:36.631412 | debian-bookworm | check: 365 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:265] 2026-05-02 03:05:36.676782 | debian-bookworm | check: 365 D { 2026-05-02 03:05:36.676825 | debian-bookworm | "sys": { 2026-05-02 03:05:36.676833 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check/bin/python", 2026-05-02 03:05:36.676838 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-05-02 03:05:36.676844 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-05-02 03:05:36.676849 | debian-bookworm | "base_prefix": "/usr", 2026-05-02 03:05:36.676855 | debian-bookworm | "real_prefix": null, 2026-05-02 03:05:36.676859 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-05-02 03:05:36.676863 | debian-bookworm | "base_exec_prefix": "/usr", 2026-05-02 03:05:36.676867 | debian-bookworm | "path": [ 2026-05-02 03:05:36.676871 | debian-bookworm | "/usr/lib/python311.zip", 2026-05-02 03:05:36.676875 | debian-bookworm | "/usr/lib/python3.11", 2026-05-02 03:05:36.676879 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-05-02 03:05:36.676884 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages" 2026-05-02 03:05:36.676888 | debian-bookworm | ], 2026-05-02 03:05:36.676892 | debian-bookworm | "meta_path": [ 2026-05-02 03:05:36.676896 | debian-bookworm | "", 2026-05-02 03:05:36.676900 | debian-bookworm | "", 2026-05-02 03:05:36.676904 | debian-bookworm | "", 2026-05-02 03:05:36.676914 | debian-bookworm | "" 2026-05-02 03:05:36.676918 | debian-bookworm | ], 2026-05-02 03:05:36.676922 | debian-bookworm | "fs_encoding": "utf-8", 2026-05-02 03:05:36.676926 | debian-bookworm | "io_encoding": "utf-8" 2026-05-02 03:05:36.676930 | debian-bookworm | }, 2026-05-02 03:05:36.676934 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2026-05-02 03:05:36.676938 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-05-02 03:05:36.676942 | debian-bookworm | "os": "", 2026-05-02 03:05:36.676946 | debian-bookworm | "site": "", 2026-05-02 03:05:36.676950 | debian-bookworm | "datetime": "", 2026-05-02 03:05:36.676954 | debian-bookworm | "math": "", 2026-05-02 03:05:36.676958 | debian-bookworm | "json": "" 2026-05-02 03:05:36.676962 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-05-02 03:05:36.677051 | debian-bookworm | check: 411 I add seed packages via FromAppData(download=False, pip=bundle, setuptools=bundle, via=copy, app_data_dir=/home/zuul/.cache/virtualenv) [virtualenv/run/session.py:84] 2026-05-02 03:05:36.685282 | debian-bookworm | check: 419 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-26.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-05-02 03:05:36.689333 | debian-bookworm | check: 420 D build install image for pip-26.1-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-05-02 03:05:36.689697 | debian-bookworm | check: 423 D install setuptools from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/setuptools-82.0.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-05-02 03:05:36.693021 | debian-bookworm | check: 427 D build install image for setuptools-82.0.1-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.0.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-05-02 03:05:37.067955 | debian-bookworm | check: 802 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.0.1-py3-none-any/setuptools-82.0.1.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/setuptools-82.0.1.virtualenv [virtualenv/util/path/_sync.py:46] 2026-05-02 03:05:37.068219 | debian-bookworm | check: 802 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.0.1-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:46] 2026-05-02 03:05:37.068604 | debian-bookworm | check: 802 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.0.1-py3-none-any/setuptools-82.0.1.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/setuptools-82.0.1.dist-info [virtualenv/util/path/_sync.py:46] 2026-05-02 03:05:37.069705 | debian-bookworm | check: 804 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.0.1-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:46] 2026-05-02 03:05:37.139043 | debian-bookworm | check: 873 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1-py3-none-any/pip-26.1.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-26.1.dist-info [virtualenv/util/path/_sync.py:46] 2026-05-02 03:05:37.154549 | debian-bookworm | check: 888 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1-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:46] 2026-05-02 03:05:37.204143 | debian-bookworm | check: 938 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-82.0.1-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:46] 2026-05-02 03:05:37.205585 | debian-bookworm | check: 939 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-05-02 03:05:37.234800 | debian-bookworm | check: 969 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1-py3-none-any/pip-26.1.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-26.1.virtualenv [virtualenv/util/path/_sync.py:46] 2026-05-02 03:05:37.235590 | debian-bookworm | check: 969 D generated console scripts pip-3.11 pip pip3 pip3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-05-02 03:05:37.236159 | debian-bookworm | check: 970 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-05-02 03:05:37.247106 | debian-bookworm | check: 981 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-05-02 03:05:37.247315 | debian-bookworm | check: 981 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.247452 | debian-bookworm | check: 981 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.247572 | debian-bookworm | check: 981 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.247677 | debian-bookworm | check: 982 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.247834 | debian-bookworm | check: 982 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.247988 | debian-bookworm | check: 982 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/check [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.248102 | debian-bookworm | check: 982 D virtualenv = 21.3.0 [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.248234 | debian-bookworm | check: 982 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.248356 | debian-bookworm | check: 982 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.248466 | debian-bookworm | check: 982 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.248582 | debian-bookworm | check: 982 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-05-02 03:05:37.256944 | debian-bookworm | check: 991 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:515] 2026-05-02 03:05:38.359334 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2026-05-02 03:05:38.490625 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2026-05-02 03:05:38.589086 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2026-05-02 03:05:38.600569 | 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) 2026-05-02 03:05:38.761619 | debian-bookworm | Collecting ansible==11.13.0 (from -r requirements.txt (line 3)) 2026-05-02 03:05:38.773934 | debian-bookworm | Downloading ansible-11.13.0-py3-none-any.whl.metadata (8.2 kB) 2026-05-02 03:05:38.822441 | debian-bookworm | Collecting packaging==26.1 (from -r requirements.txt (line 4)) 2026-05-02 03:05:38.838253 | debian-bookworm | Downloading packaging-26.1-py3-none-any.whl.metadata (3.5 kB) 2026-05-02 03:05:38.979440 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2026-05-02 03:05:38.994265 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2026-05-02 03:05:39.015452 | debian-bookworm | Installing build dependencies: started 2026-05-02 03:05:40.189802 | debian-bookworm | Installing build dependencies: finished with status 'done' 2026-05-02 03:05:40.189896 | debian-bookworm | Getting requirements to build wheel: started 2026-05-02 03:05:40.615504 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2026-05-02 03:05:40.615575 | debian-bookworm | Preparing metadata (pyproject.toml): started 2026-05-02 03:05:40.844330 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2026-05-02 03:05:40.981642 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2026-05-02 03:05:40.994896 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2026-05-02 03:05:41.052504 | debian-bookworm | Collecting requests==2.33.1 (from -r requirements.txt (line 7)) 2026-05-02 03:05:41.064580 | debian-bookworm | Downloading requests-2.33.1-py3-none-any.whl.metadata (4.8 kB) 2026-05-02 03:05:41.103630 | debian-bookworm | Collecting tabulate==0.10.0 (from -r requirements.txt (line 8)) 2026-05-02 03:05:41.116976 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl.metadata (40 kB) 2026-05-02 03:05:41.240758 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2026-05-02 03:05:41.253005 | 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) 2026-05-02 03:05:41.444356 | debian-bookworm | Collecting ansible-core~=2.18.12 (from ansible==11.13.0->-r requirements.txt (line 3)) 2026-05-02 03:05:41.458169 | debian-bookworm | Downloading ansible_core-2.18.16-py3-none-any.whl.metadata (7.7 kB) 2026-05-02 03:05:41.514247 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-05-02 03:05:41.525998 | debian-bookworm | Downloading click-8.3.3-py3-none-any.whl.metadata (2.6 kB) 2026-05-02 03:05:41.565191 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-05-02 03:05:41.576953 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-05-02 03:05:41.624383 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-05-02 03:05:41.637655 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2026-05-02 03:05:41.689307 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-05-02 03:05:41.702184 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2026-05-02 03:05:41.885115 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.33.1->-r requirements.txt (line 7)) 2026-05-02 03:05:41.896487 | debian-bookworm | Downloading charset_normalizer-3.4.7-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (40 kB) 2026-05-02 03:05:41.936454 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.33.1->-r requirements.txt (line 7)) 2026-05-02 03:05:41.947370 | debian-bookworm | Downloading idna-3.13-py3-none-any.whl.metadata (8.0 kB) 2026-05-02 03:05:41.992663 | debian-bookworm | Collecting urllib3<3,>=1.26 (from requests==2.33.1->-r requirements.txt (line 7)) 2026-05-02 03:05:42.003860 | debian-bookworm | Downloading urllib3-2.6.3-py3-none-any.whl.metadata (6.9 kB) 2026-05-02 03:05:42.066291 | debian-bookworm | Collecting certifi>=2023.5.7 (from requests==2.33.1->-r requirements.txt (line 7)) 2026-05-02 03:05:42.078081 | debian-bookworm | Downloading certifi-2026.4.22-py3-none-any.whl.metadata (2.5 kB) 2026-05-02 03:05:42.331411 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.12->ansible==11.13.0->-r requirements.txt (line 3)) 2026-05-02 03:05:42.342960 | debian-bookworm | Downloading cryptography-47.0.0-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (4.5 kB) 2026-05-02 03:05:42.377146 | debian-bookworm | Collecting resolvelib<1.1.0,>=0.5.3 (from ansible-core~=2.18.12->ansible==11.13.0->-r requirements.txt (line 3)) 2026-05-02 03:05:42.388959 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2026-05-02 03:05:42.560165 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core~=2.18.12->ansible==11.13.0->-r requirements.txt (line 3)) 2026-05-02 03:05:42.571524 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2026-05-02 03:05:42.603361 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core~=2.18.12->ansible==11.13.0->-r requirements.txt (line 3)) 2026-05-02 03:05:42.614461 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl.metadata (8.2 kB) 2026-05-02 03:05:42.638308 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-05-02 03:05:42.669609 | 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) 2026-05-02 03:05:42.729491 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 14.8 MB/s 0:00:00 2026-05-02 03:05:42.742076 | debian-bookworm | Downloading ansible-11.13.0-py3-none-any.whl (57.6 MB) 2026-05-02 03:05:45.838321 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.6/57.6 MB 18.6 MB/s 0:00:03 2026-05-02 03:05:45.851661 | debian-bookworm | Downloading packaging-26.1-py3-none-any.whl (95 kB) 2026-05-02 03:05:45.926361 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2026-05-02 03:05:45.949354 | debian-bookworm | Downloading requests-2.33.1-py3-none-any.whl (64 kB) 2026-05-02 03:05:45.972857 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl (39 kB) 2026-05-02 03:05:45.997649 | debian-bookworm | Downloading ansible_core-2.18.16-py3-none-any.whl (2.2 MB) 2026-05-02 03:05:46.100515 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 21.1 MB/s 0:00:00 2026-05-02 03:05:46.113790 | debian-bookworm | Downloading charset_normalizer-3.4.7-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (214 kB) 2026-05-02 03:05:46.140350 | debian-bookworm | Downloading idna-3.13-py3-none-any.whl (68 kB) 2026-05-02 03:05:46.164165 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2026-05-02 03:05:46.204495 | debian-bookworm | Downloading urllib3-2.6.3-py3-none-any.whl (131 kB) 2026-05-02 03:05:46.231178 | debian-bookworm | Downloading certifi-2026.4.22-py3-none-any.whl (135 kB) 2026-05-02 03:05:46.256985 | 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) 2026-05-02 03:05:46.280944 | debian-bookworm | Downloading click-8.3.3-py3-none-any.whl (110 kB) 2026-05-02 03:05:46.306096 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-02 03:05:46.329973 | debian-bookworm | Downloading cryptography-47.0.0-cp311-abi3-manylinux_2_34_x86_64.whl (4.7 MB) 2026-05-02 03:05:46.536486 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.7/4.7 MB 22.9 MB/s 0:00:00 2026-05-02 03:05:46.671370 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2026-05-02 03:05:46.763476 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2026-05-02 03:05:46.786913 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-05-02 03:05:46.810482 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2026-05-02 03:05:47.099615 | debian-bookworm | Building wheels for collected packages: pwgen 2026-05-02 03:05:47.100942 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2026-05-02 03:05:47.376155 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2026-05-02 03:05:47.379308 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3796 sha256=265a7c9c0df565350ba0b4eef68400d97f9279acbe8642b1fd966b00c4463bac 2026-05-02 03:05:47.379328 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2026-05-02 03:05:47.383095 | debian-bookworm | Successfully built pwgen 2026-05-02 03:05:47.609725 | 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 2026-05-02 03:06:12.301942 | debian-bookworm | 2026-05-02 03:06:12.304470 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-11.13.0 ansible-core-2.18.16 certifi-2026.4.22 cffi-2.0.0 charset_normalizer-3.4.7 click-8.3.3 colorama-0.4.6 cryptography-47.0.0 fasteners-0.20 idna-3.13 packaging-26.1 pwgen-0.8.2.post0 pycparser-3.0 python-gilt-1.2.3 requests-2.33.1 resolvelib-1.0.1 sh-2.2.2 tabulate-0.10.0 urllib3-2.6.3 2026-05-02 03:06:12.409923 | debian-bookworm | check: 36144 I exit 0 (35.15 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1488 [tox/execute/api.py:311] 2026-05-02 03:06:12.410845 | debian-bookworm | check: OK (35.92 seconds) 2026-05-02 03:06:12.410876 | debian-bookworm | congratulations :) (35.94 seconds) 2026-05-02 03:06:12.482898 | debian-bookworm | ok: Runtime: 0:00:36.215213 2026-05-02 03:06:12.508146 | 2026-05-02 03:06:12.508399 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-02 03:06:13.020292 | debian-bookworm | changed 2026-05-02 03:06:13.056635 | 2026-05-02 03:06:13.056834 | TASK [tox : Get tox envlist config] 2026-05-02 03:06:14.166341 | debian-bookworm | ok: Runtime: 0:00:00.313175 2026-05-02 03:06:14.173486 | 2026-05-02 03:06:14.173673 | TASK [tox : Install any sibling python packages] 2026-05-02 03:06:15.264988 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-02 03:06:15.286051 | 2026-05-02 03:06:15.286243 | TASK [tox : Remove tempfile] 2026-05-02 03:06:15.893911 | debian-bookworm | changed 2026-05-02 03:06:15.902616 | 2026-05-02 03:06:15.902763 | TASK [tox : Emit tox command] 2026-05-02 03:06:15.981167 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2026-05-02 03:06:15.987049 | 2026-05-02 03:06:15.987197 | TASK [tox : Run tox] 2026-05-02 03:06:16.884830 | debian-bookworm | ROOT: 203 D setup logging to DEBUG on pid 1640 [tox/report.py:229] 2026-05-02 03:06:16.915332 | debian-bookworm | check: 233 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-05-02 03:06:16.918017 | debian-bookworm | check: 236 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:62] 2026-05-02 03:06:16.921749 | debian-bookworm | check: 240 D got python info of /usr/bin/python3.11 from /home/zuul/.cache/virtualenv/py_info/4/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:139] 2026-05-02 03:06:16.922769 | debian-bookworm | check: 241 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-05-02 03:06:16.922912 | debian-bookworm | check: 241 I proposed PythonInfo(spec=CPython3.11.2.final.0-64-x86_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) [python_discovery/_discovery.py:71] 2026-05-02 03:06:16.923037 | debian-bookworm | check: 241 D accepted PythonInfo(spec=CPython3.11.2.final.0-64-x86_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) [python_discovery/_discovery.py:75] 2026-05-02 03:06:16.924607 | debian-bookworm | check: 242 D symlink on filesystem does work [virtualenv/info.py:51] 2026-05-02 03:06:16.924712 | debian-bookworm | check: 243 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-05-02 03:06:16.958279 | debian-bookworm | check: 276 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:515] 2026-05-02 03:06:17.071355 | debian-bookworm | check: 389 I exit 0 (0.11 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-inventory-sorting.py pid=1647 [tox/execute/api.py:311] 2026-05-02 03:06:17.072324 | debian-bookworm | check: OK (0.16=setup[0.05]+cmd[0.11] seconds) 2026-05-02 03:06:17.072348 | debian-bookworm | congratulations :) (0.19 seconds) 2026-05-02 03:06:17.208033 | debian-bookworm | ok: Runtime: 0:00:00.500025 2026-05-02 03:06:17.216252 | 2026-05-02 03:06:17.216349 | TASK [tox : Look for output] 2026-05-02 03:06:17.893456 | debian-bookworm | ok 2026-05-02 03:06:17.917111 | 2026-05-02 03:06:17.917242 | TASK [tox : Return file comments to Zuul] 2026-05-02 03:06:17.969837 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:17.977530 | 2026-05-02 03:06:17.977624 | PLAY RECAP 2026-05-02 03:06:17.977678 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-02 03:06:17.977704 | 2026-05-02 03:06:18.257622 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-02 03:06:18.258582 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-02 03:06:19.728684 | 2026-05-02 03:06:19.728893 | PLAY [all] 2026-05-02 03:06:19.774146 | 2026-05-02 03:06:19.774347 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-02 03:06:19.960446 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:19.968081 | 2026-05-02 03:06:19.968306 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-02 03:06:20.031168 | debian-bookworm | ok 2026-05-02 03:06:20.046355 | 2026-05-02 03:06:20.046557 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-02 03:06:21.011874 | debian-bookworm -> localhost | changed 2026-05-02 03:06:21.021339 | 2026-05-02 03:06:21.021481 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-02 03:06:21.126670 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:21.140994 | 2026-05-02 03:06:21.141231 | TASK [fetch-tox-output : Set envlist fact] 2026-05-02 03:06:21.205554 | debian-bookworm | ok 2026-05-02 03:06:21.226615 | 2026-05-02 03:06:21.226749 | TASK [fetch-tox-output : Get tox version] 2026-05-02 03:06:22.294016 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-05-02 03:06:22.313333 | debian-bookworm | 4.53.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-02 03:06:22.842159 | debian-bookworm | ok: Runtime: 0:00:00.319046 2026-05-02 03:06:22.848436 | 2026-05-02 03:06:22.848573 | TASK [fetch-tox-output : Find all default environments] 2026-05-02 03:06:23.450522 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:23.456308 | 2026-05-02 03:06:23.456422 | TASK [fetch-tox-output : Set envlist fact] 2026-05-02 03:06:23.511146 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:23.525438 | 2026-05-02 03:06:23.525583 | TASK [fetch-tox-output : Find all default environments] 2026-05-02 03:06:24.130567 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:24.136163 | 2026-05-02 03:06:24.136273 | TASK [fetch-tox-output : Set envlist fact] 2026-05-02 03:06:24.171513 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:24.177595 | 2026-05-02 03:06:24.177699 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-02 03:06:24.286695 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:24.298465 | 2026-05-02 03:06:24.298587 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-02 03:06:26.006750 | debian-bookworm | changed: 2026-05-02 03:06:26.007051 | debian-bookworm | created directory /var/lib/zuul/builds/0ea9eab181e54345a758301db25f3559/work/logs/tox/check 2026-05-02 03:06:26.007097 | debian-bookworm | cd+++++++++ ./ 2026-05-02 03:06:26.007124 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-02 03:06:26.007153 | 2026-05-02 03:06:26.023603 | 2026-05-02 03:06:26.023691 | PLAY RECAP 2026-05-02 03:06:26.023742 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-02 03:06:26.023767 | 2026-05-02 03:06:26.153739 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-02 03:06:26.154535 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-02 03:06:27.372976 | 2026-05-02 03:06:27.373127 | PLAY [all] 2026-05-02 03:06:27.412773 | 2026-05-02 03:06:27.412903 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-02 03:06:27.775601 | debian-bookworm | changed: non-zero return code 2026-05-02 03:06:27.780244 | 2026-05-02 03:06:27.780361 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-02 03:06:27.826809 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:27.831660 | 2026-05-02 03:06:27.831766 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-02 03:06:27.861332 | 2026-05-02 03:06:27.861550 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-02 03:06:27.933411 | 2026-05-02 03:06:27.933571 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-02 03:06:27.966891 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:27.971899 | 2026-05-02 03:06:27.972186 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-02 03:06:28.027309 | 2026-05-02 03:06:28.027479 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-02 03:06:28.043844 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:28.048947 | 2026-05-02 03:06:28.049056 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-02 03:06:28.107724 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:28.115988 | 2026-05-02 03:06:28.116143 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-02 03:06:28.177981 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:28.184683 | 2026-05-02 03:06:28.184768 | PLAY RECAP 2026-05-02 03:06:28.184818 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-02 03:06:28.184843 | 2026-05-02 03:06:28.495114 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-02 03:06:28.496059 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-02 03:06:29.702623 | 2026-05-02 03:06:29.702770 | PLAY [Base post-fetch] 2026-05-02 03:06:29.733847 | 2026-05-02 03:06:29.733992 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-02 03:06:29.857646 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:29.864791 | 2026-05-02 03:06:29.864941 | TASK [fetch-output : Set log path for single node] 2026-05-02 03:06:29.914936 | debian-bookworm | ok 2026-05-02 03:06:29.921165 | 2026-05-02 03:06:29.921275 | LOOP [fetch-output : Ensure local output dirs] 2026-05-02 03:06:31.890184 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/0ea9eab181e54345a758301db25f3559/work/logs" 2026-05-02 03:06:33.305872 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0ea9eab181e54345a758301db25f3559/work/artifacts" 2026-05-02 03:06:34.969599 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0ea9eab181e54345a758301db25f3559/work/docs" 2026-05-02 03:06:34.990753 | 2026-05-02 03:06:35.038430 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-02 03:06:36.816139 | debian-bookworm | changed: 2026-05-02 03:06:36.816785 | debian-bookworm | .d..t...... ./ 2026-05-02 03:06:36.816955 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-02 03:06:36.817083 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-02 03:06:36.817122 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-02 03:06:36.817169 | debian-bookworm | changed: All items complete 2026-05-02 03:06:36.817213 | 2026-05-02 03:06:37.876446 | debian-bookworm | changed: .d..t...... ./ 2026-05-02 03:06:39.041788 | debian-bookworm | changed: .d..t...... ./ 2026-05-02 03:06:39.056317 | 2026-05-02 03:06:39.056435 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-02 03:06:39.087467 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:39.091587 | debian-bookworm | skipping: Conditional result was False 2026-05-02 03:06:39.098753 | 2026-05-02 03:06:39.098827 | PLAY RECAP 2026-05-02 03:06:39.098898 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-02 03:06:39.098923 | 2026-05-02 03:06:39.450685 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-02 03:06:39.451488 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-02 03:06:40.418147 | 2026-05-02 03:06:40.418282 | PLAY [Base post] 2026-05-02 03:06:40.446812 | 2026-05-02 03:06:40.446971 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-02 03:06:41.150822 | debian-bookworm | changed 2026-05-02 03:06:41.161964 | 2026-05-02 03:06:41.162199 | PLAY RECAP 2026-05-02 03:06:41.162279 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-02 03:06:41.162348 | 2026-05-02 03:06:41.341583 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-02 03:06:41.342506 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-02 03:06:42.564772 | 2026-05-02 03:06:42.564900 | PLAY [Base post-logs] 2026-05-02 03:06:42.579902 | 2026-05-02 03:06:42.580046 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-02 03:06:43.789456 | localhost | changed 2026-05-02 03:06:43.806943 | 2026-05-02 03:06:43.807155 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-02 03:06:43.848097 | localhost | ok 2026-05-02 03:06:43.855490 | 2026-05-02 03:06:43.855635 | TASK [Set zuul-log-path fact] 2026-05-02 03:06:43.889228 | localhost | ok 2026-05-02 03:06:43.907847 | 2026-05-02 03:06:43.908038 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-02 03:06:43.966557 | localhost | ok 2026-05-02 03:06:43.971740 | 2026-05-02 03:06:43.971923 | TASK [upload-logs : Create log directories] 2026-05-02 03:06:44.981190 | localhost | changed 2026-05-02 03:06:44.985886 | 2026-05-02 03:06:44.986034 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-02 03:06:45.993097 | localhost -> localhost | ok: Runtime: 0:00:00.012966 2026-05-02 03:06:45.998789 | 2026-05-02 03:06:45.998960 | TASK [upload-logs : Upload logs to log server] 2026-05-02 03:06:47.594899 | localhost | Output suppressed because no_log was given 2026-05-02 03:06:47.597423 | 2026-05-02 03:06:47.597553 | LOOP [upload-logs : Compress console log and json output] 2026-05-02 03:06:47.692244 | localhost | skipping: Conditional result was False 2026-05-02 03:06:47.702535 | localhost | skipping: Conditional result was False 2026-05-02 03:06:47.706754 | 2026-05-02 03:06:47.706938 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-02 03:06:47.785858 | localhost | skipping: Conditional result was False 2026-05-02 03:06:47.786206 | 2026-05-02 03:06:47.795210 | localhost | skipping: Conditional result was False 2026-05-02 03:06:47.806472 | 2026-05-02 03:06:47.806617 | LOOP [upload-logs : Upload console log and json output]