2026-05-08 03:04:27.445537 | Job console starting 2026-05-08 03:04:27.454487 | Updating git repos 2026-05-08 03:04:27.541479 | Cloning repos into workspace 2026-05-08 03:04:27.637288 | Restoring repo states 2026-05-08 03:04:27.652116 | Merging changes 2026-05-08 03:04:27.652139 | Checking out repos 2026-05-08 03:04:27.797622 | Preparing playbooks 2026-05-08 03:04:28.843737 | Running Ansible setup 2026-05-08 03:04:33.005142 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-08 03:04:33.893831 | 2026-05-08 03:04:33.894152 | PLAY [Base pre] 2026-05-08 03:04:33.935050 | 2026-05-08 03:04:33.935220 | TASK [Setup log path fact] 2026-05-08 03:04:33.981592 | debian-bookworm | ok 2026-05-08 03:04:34.033724 | 2026-05-08 03:04:34.033952 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 03:04:34.078263 | debian-bookworm | ok 2026-05-08 03:04:34.107183 | 2026-05-08 03:04:34.107382 | TASK [emit-job-header : Print job information] 2026-05-08 03:04:34.180516 | # Job Information 2026-05-08 03:04:34.180734 | Ansible Version: 2.16.14 2026-05-08 03:04:34.180773 | Job: cfg-generics-tox-check 2026-05-08 03:04:34.180806 | Pipeline: periodic-daily 2026-05-08 03:04:34.180830 | Executor: 521e9411259a 2026-05-08 03:04:34.180851 | Triggered by: https://github.com/osism/generics 2026-05-08 03:04:34.180872 | Event ID: a512db72a8454d1f94568d4cb203e2fb 2026-05-08 03:04:34.187301 | 2026-05-08 03:04:34.187617 | LOOP [emit-job-header : Print node information] 2026-05-08 03:04:34.337025 | debian-bookworm | ok: 2026-05-08 03:04:34.337255 | debian-bookworm | # Node Information 2026-05-08 03:04:34.337295 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-08 03:04:34.337322 | debian-bookworm | Hostname: debian 2026-05-08 03:04:34.337346 | debian-bookworm | Username: zuul 2026-05-08 03:04:34.337368 | debian-bookworm | Distro: Debian 12.13 2026-05-08 03:04:34.338151 | debian-bookworm | Provider: regiocloud-a 2026-05-08 03:04:34.338277 | debian-bookworm | Region: 2026-05-08 03:04:34.338310 | debian-bookworm | Label: debian-bookworm 2026-05-08 03:04:34.338336 | debian-bookworm | Product Name: OpenStack Nova 2026-05-08 03:04:34.338360 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb6:91c6 2026-05-08 03:04:34.377892 | 2026-05-08 03:04:34.378075 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-08 03:04:35.013012 | debian-bookworm -> localhost | changed 2026-05-08 03:04:35.033015 | 2026-05-08 03:04:35.033167 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-08 03:04:36.615580 | debian-bookworm -> localhost | changed 2026-05-08 03:04:36.636936 | 2026-05-08 03:04:36.637214 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-08 03:04:37.207900 | debian-bookworm -> localhost | ok 2026-05-08 03:04:37.215336 | 2026-05-08 03:04:37.215472 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-08 03:04:37.271106 | debian-bookworm | ok 2026-05-08 03:04:37.311592 | debian-bookworm | included: /var/lib/zuul/builds/9537765358fc4b18a6e2620aafce8ace/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-08 03:04:37.321276 | 2026-05-08 03:04:37.321417 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-08 03:04:38.638301 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-08 03:04:38.638541 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9537765358fc4b18a6e2620aafce8ace/work/9537765358fc4b18a6e2620aafce8ace_id_rsa 2026-05-08 03:04:38.638578 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9537765358fc4b18a6e2620aafce8ace/work/9537765358fc4b18a6e2620aafce8ace_id_rsa.pub 2026-05-08 03:04:38.638604 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-08 03:04:38.638626 | debian-bookworm -> localhost | SHA256:WK++wrUpJ8WTGKtEF0HdPgFmdXBCH6i0+0GJzDlN/DY zuul-build-sshkey 2026-05-08 03:04:38.638649 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-08 03:04:38.638683 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-08 03:04:38.638706 | debian-bookworm -> localhost | | .oo+*=o+ | 2026-05-08 03:04:38.638728 | debian-bookworm -> localhost | | .oo *= . | 2026-05-08 03:04:38.638749 | debian-bookworm -> localhost | | =.O +. | 2026-05-08 03:04:38.638769 | debian-bookworm -> localhost | | . ooO.* E | 2026-05-08 03:04:38.638789 | debian-bookworm -> localhost | | . ..=S=.o . | 2026-05-08 03:04:38.638819 | debian-bookworm -> localhost | | . o B.. | 2026-05-08 03:04:38.638859 | debian-bookworm -> localhost | | . o o.= . | 2026-05-08 03:04:38.638880 | debian-bookworm -> localhost | | . =.+ . | 2026-05-08 03:04:38.638901 | debian-bookworm -> localhost | | =o. | 2026-05-08 03:04:38.638921 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-08 03:04:38.638994 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.645176 2026-05-08 03:04:38.646433 | 2026-05-08 03:04:38.646584 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-08 03:04:38.700268 | debian-bookworm | ok 2026-05-08 03:04:38.718172 | debian-bookworm | included: /var/lib/zuul/builds/9537765358fc4b18a6e2620aafce8ace/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-08 03:04:38.737932 | 2026-05-08 03:04:38.738107 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-08 03:04:38.783712 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:04:38.790965 | 2026-05-08 03:04:38.791131 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-08 03:04:39.552027 | debian-bookworm | changed 2026-05-08 03:04:39.561427 | 2026-05-08 03:04:39.561579 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-08 03:04:39.835259 | debian-bookworm | ok 2026-05-08 03:04:39.841716 | 2026-05-08 03:04:39.841841 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-08 03:04:40.512151 | debian-bookworm | changed 2026-05-08 03:04:40.519939 | 2026-05-08 03:04:40.520114 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-08 03:04:41.180379 | debian-bookworm | changed 2026-05-08 03:04:41.186696 | 2026-05-08 03:04:41.186814 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-08 03:04:41.211371 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:04:41.218439 | 2026-05-08 03:04:41.218570 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-08 03:04:41.751758 | debian-bookworm -> localhost | changed 2026-05-08 03:04:41.766550 | 2026-05-08 03:04:41.766826 | TASK [add-build-sshkey : Add back temp key] 2026-05-08 03:04:42.251556 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9537765358fc4b18a6e2620aafce8ace/work/9537765358fc4b18a6e2620aafce8ace_id_rsa (zuul-build-sshkey) 2026-05-08 03:04:42.251871 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016564 2026-05-08 03:04:42.263103 | 2026-05-08 03:04:42.263241 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-08 03:04:42.697340 | debian-bookworm | ok 2026-05-08 03:04:42.706352 | 2026-05-08 03:04:42.706482 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-08 03:04:42.752319 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:04:42.773558 | 2026-05-08 03:04:42.773824 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-08 03:04:43.318769 | debian-bookworm | ok 2026-05-08 03:04:43.335931 | 2026-05-08 03:04:43.336094 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-08 03:04:43.366162 | debian-bookworm | ok 2026-05-08 03:04:43.371509 | 2026-05-08 03:04:43.371641 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-08 03:04:43.774894 | debian-bookworm -> localhost | ok 2026-05-08 03:04:43.783788 | 2026-05-08 03:04:43.783916 | TASK [validate-host : Collect information about the host] 2026-05-08 03:04:45.137525 | debian-bookworm | ok 2026-05-08 03:04:45.160619 | 2026-05-08 03:04:45.160786 | TASK [validate-host : Sanitize hostname] 2026-05-08 03:04:45.365661 | debian-bookworm | ok 2026-05-08 03:04:45.493729 | 2026-05-08 03:04:45.494087 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-08 03:04:46.631225 | debian-bookworm -> localhost | changed 2026-05-08 03:04:46.637444 | 2026-05-08 03:04:46.637563 | TASK [validate-host : Collect information about zuul worker] 2026-05-08 03:04:47.078705 | debian-bookworm | ok 2026-05-08 03:04:47.085633 | 2026-05-08 03:04:47.085807 | TASK [validate-host : Write out all zuul information for each host] 2026-05-08 03:04:47.736764 | debian-bookworm -> localhost | changed 2026-05-08 03:04:47.746792 | 2026-05-08 03:04:47.747134 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-08 03:04:48.046734 | debian-bookworm | ok 2026-05-08 03:04:48.059100 | 2026-05-08 03:04:48.059232 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-08 03:04:49.169388 | debian-bookworm | changed: 2026-05-08 03:04:49.169739 | debian-bookworm | cd+++++++++ src/ 2026-05-08 03:04:49.169785 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-08 03:04:49.169857 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-08 03:04:49.169884 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-05-08 03:04:49.169905 | debian-bookworm | =7.0.3 2026-05-08 03:05:14.495123 | debian-bookworm | Downloading cachetools-7.1.1-py3-none-any.whl (16 kB) 2026-05-08 03:05:14.536204 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-08 03:05:14.547974 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-08 03:05:14.605507 | debian-bookworm | Collecting filelock>=3.25 2026-05-08 03:05:14.616853 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-08 03:05:14.683101 | debian-bookworm | Collecting packaging>=26 2026-05-08 03:05:14.694231 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-08 03:05:14.705237 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 11.2 MB/s eta 0:00:00 2026-05-08 03:05:14.753834 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-08 03:05:14.765145 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-05-08 03:05:14.810156 | debian-bookworm | Collecting pluggy>=1.6 2026-05-08 03:05:14.821673 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-08 03:05:14.859450 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-08 03:05:14.871442 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-08 03:05:14.920517 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-08 03:05:14.933053 | debian-bookworm | Downloading python_discovery-1.3.0-py3-none-any.whl (33 kB) 2026-05-08 03:05:14.973629 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-08 03:05:14.985733 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-08 03:05:15.135524 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-08 03:05:15.147180 | debian-bookworm | Downloading virtualenv-21.3.1-py3-none-any.whl (7.6 MB) 2026-05-08 03:05:15.525614 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 20.3 MB/s eta 0:00:00 2026-05-08 03:05:15.650482 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-08 03:05:15.662219 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-08 03:05:15.688184 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.0 MB/s eta 0:00:00 2026-05-08 03:05:15.792857 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-08 03:05:16.566804 | debian-bookworm | Successfully installed cachetools-7.1.1 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.3.0 tomli-w-1.2.0 tox-4.53.1 virtualenv-21.3.1 2026-05-08 03:05:16.868589 | debian-bookworm | ok: Runtime: 0:00:03.060049 2026-05-08 03:05:16.875611 | 2026-05-08 03:05:16.875738 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-08 03:05:16.949721 | debian-bookworm | ok 2026-05-08 03:05:16.958570 | 2026-05-08 03:05:16.958706 | TASK [ensure-tox : Output tox version] 2026-05-08 03:05:17.595647 | 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-08 03:05:17.612859 | debian-bookworm | 4.53.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-08 03:05:18.020735 | debian-bookworm | ok: Runtime: 0:00:00.305906 2026-05-08 03:05:18.029205 | 2026-05-08 03:05:18.029356 | TASK [ensure-tox : Make global symlink] 2026-05-08 03:05:18.054619 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:05:18.062217 | 2026-05-08 03:05:18.062326 | PLAY RECAP 2026-05-08 03:05:18.062429 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-08 03:05:18.062458 | 2026-05-08 03:05:18.240435 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-08 03:05:18.241545 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-08 03:05:19.138174 | 2026-05-08 03:05:19.138755 | PLAY [all] 2026-05-08 03:05:19.172697 | 2026-05-08 03:05:19.172821 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-08 03:05:19.714325 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-08 03:05:19.766341 | debian-bookworm | ok: Runtime: 0:00:00.023670 2026-05-08 03:05:19.771677 | 2026-05-08 03:05:19.771790 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-08 03:05:20.338083 | debian-bookworm | ok: Runtime: 0:00:00.007123 2026-05-08 03:05:20.343829 | 2026-05-08 03:05:20.343931 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-08 03:05:20.696138 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-08 03:05:20.697908 | debian-bookworm | sudo: a password is required 2026-05-08 03:05:20.897141 | debian-bookworm | ok: Runtime: 0:00:00.033283 2026-05-08 03:05:20.906779 | 2026-05-08 03:05:20.906897 | TASK [tox : Check to see if the constraints file exists] 2026-05-08 03:05:20.930388 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:05:20.936316 | 2026-05-08 03:05:20.936421 | TASK [tox : Fail if constraints file is missing] 2026-05-08 03:05:20.969639 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:05:20.975531 | 2026-05-08 03:05:20.975630 | TASK [tox : Record file location] 2026-05-08 03:05:21.019203 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:05:21.024823 | 2026-05-08 03:05:21.024937 | TASK [tox : Install tox siblings] 2026-05-08 03:05:21.044337 | debian-bookworm | ok 2026-05-08 03:05:21.053266 | debian-bookworm | included: /var/lib/zuul/builds/9537765358fc4b18a6e2620aafce8ace/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-08 03:05:21.058809 | 2026-05-08 03:05:21.058924 | TASK [tox : Run tox without tests] 2026-05-08 03:05:21.604434 | debian-bookworm | ROOT: 200 D setup logging to DEBUG on pid 1467 [tox/report.py:229] 2026-05-08 03:05:21.633419 | debian-bookworm | check: 229 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-05-08 03:05:21.636054 | debian-bookworm | check: 231 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-05-08 03:05:21.640041 | debian-bookworm | check: 235 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/python_discovery/_py_info.py ba6de6b2cbd6fa2b8b9c2f1742da1e72 e840beb8e15d025227b1769700fbad91 [python_discovery/_cached_py_info.py:198] 2026-05-08 03:05:21.709198 | debian-bookworm | check: 304 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-08 03:05:21.710646 | debian-bookworm | check: 306 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-05-08 03:05:21.711094 | debian-bookworm | check: 306 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:140] 2026-05-08 03:05:21.711396 | debian-bookworm | check: 307 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:144] 2026-05-08 03:05:21.715194 | debian-bookworm | check: 311 D symlink on filesystem does work [virtualenv/info.py:51] 2026-05-08 03:05:21.715602 | debian-bookworm | check: 311 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-05-08 03:05:21.750796 | debian-bookworm | check: 346 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-08 03:05:21.751138 | debian-bookworm | check: 347 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/bin [virtualenv/util/path/_sync.py:18] 2026-05-08 03:05:21.751289 | debian-bookworm | check: 347 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/include [virtualenv/util/path/_sync.py:18] 2026-05-08 03:05:21.751371 | debian-bookworm | check: 347 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-08 03:05:21.751601 | debian-bookworm | check: 347 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-05-08 03:05:21.751679 | debian-bookworm | check: 347 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:21.751739 | debian-bookworm | check: 347 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:21.751788 | debian-bookworm | check: 347 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:21.751842 | debian-bookworm | check: 347 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:21.751890 | debian-bookworm | check: 347 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:21.751941 | debian-bookworm | check: 347 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-08 03:05:21.751989 | debian-bookworm | check: 348 D virtualenv = 21.3.1 [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:21.752040 | debian-bookworm | check: 348 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:21.752088 | debian-bookworm | check: 348 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:21.752134 | debian-bookworm | check: 348 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:21.752178 | debian-bookworm | check: 348 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:21.752481 | debian-bookworm | check: 348 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-08 03:05:21.752852 | debian-bookworm | check: 348 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-08 03:05:21.752978 | debian-bookworm | check: 349 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-08 03:05:21.753395 | debian-bookworm | check: 349 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-05-08 03:05:21.753659 | debian-bookworm | check: 349 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-08 03:05:21.807140 | debian-bookworm | check: 349 D { 2026-05-08 03:05:21.807189 | debian-bookworm | "sys": { 2026-05-08 03:05:21.807197 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check/bin/python", 2026-05-08 03:05:21.807204 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-05-08 03:05:21.807210 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-05-08 03:05:21.807216 | debian-bookworm | "base_prefix": "/usr", 2026-05-08 03:05:21.807224 | debian-bookworm | "real_prefix": null, 2026-05-08 03:05:21.807230 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-05-08 03:05:21.807235 | debian-bookworm | "base_exec_prefix": "/usr", 2026-05-08 03:05:21.807240 | debian-bookworm | "path": [ 2026-05-08 03:05:21.807244 | debian-bookworm | "/usr/lib/python311.zip", 2026-05-08 03:05:21.807249 | debian-bookworm | "/usr/lib/python3.11", 2026-05-08 03:05:21.807254 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-05-08 03:05:21.807259 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages" 2026-05-08 03:05:21.807264 | debian-bookworm | ], 2026-05-08 03:05:21.807269 | debian-bookworm | "meta_path": [ 2026-05-08 03:05:21.807274 | debian-bookworm | "", 2026-05-08 03:05:21.807278 | debian-bookworm | "", 2026-05-08 03:05:21.807284 | debian-bookworm | "", 2026-05-08 03:05:21.807295 | debian-bookworm | "" 2026-05-08 03:05:21.807300 | debian-bookworm | ], 2026-05-08 03:05:21.807305 | debian-bookworm | "fs_encoding": "utf-8", 2026-05-08 03:05:21.807310 | debian-bookworm | "io_encoding": "utf-8" 2026-05-08 03:05:21.807314 | debian-bookworm | }, 2026-05-08 03:05:21.807319 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2026-05-08 03:05:21.807324 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-05-08 03:05:21.807329 | debian-bookworm | "os": "", 2026-05-08 03:05:21.807334 | debian-bookworm | "site": "", 2026-05-08 03:05:21.807339 | debian-bookworm | "datetime": "", 2026-05-08 03:05:21.807344 | debian-bookworm | "math": "", 2026-05-08 03:05:21.807348 | debian-bookworm | "json": "" 2026-05-08 03:05:21.807353 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-05-08 03:05:21.807521 | debian-bookworm | check: 403 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-08 03:05:21.816876 | debian-bookworm | check: 412 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-26.1.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-05-08 03:05:21.821005 | debian-bookworm | check: 413 D build install image for pip-26.1.1-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-05-08 03:05:21.821720 | debian-bookworm | check: 417 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-08 03:05:21.825152 | debian-bookworm | check: 421 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-08 03:05:22.283509 | debian-bookworm | check: 879 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1.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-08 03:05:22.312620 | debian-bookworm | check: 908 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-08 03:05:22.455082 | debian-bookworm | check: 1050 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-08 03:05:22.456025 | debian-bookworm | check: 1052 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-08 03:05:22.457115 | debian-bookworm | check: 1053 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1.1-py3-none-any/pip-26.1.1.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-26.1.1.virtualenv [virtualenv/util/path/_sync.py:46] 2026-05-08 03:05:22.457744 | debian-bookworm | check: 1053 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1.1-py3-none-any/pip-26.1.1.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-26.1.1.dist-info [virtualenv/util/path/_sync.py:46] 2026-05-08 03:05:22.458360 | debian-bookworm | check: 1054 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-08 03:05:22.458853 | debian-bookworm | check: 1054 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-08 03:05:22.459226 | debian-bookworm | check: 1055 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-05-08 03:05:22.463272 | debian-bookworm | check: 1059 D generated console scripts pip-3.11 pip3.11 pip pip3 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-05-08 03:05:22.463639 | debian-bookworm | check: 1059 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-05-08 03:05:22.469572 | debian-bookworm | check: 1065 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-05-08 03:05:22.469636 | debian-bookworm | check: 1065 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:22.469690 | debian-bookworm | check: 1065 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:22.469740 | debian-bookworm | check: 1065 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:22.469779 | debian-bookworm | check: 1065 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:22.469828 | debian-bookworm | check: 1065 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:22.469876 | debian-bookworm | check: 1065 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-08 03:05:22.469920 | debian-bookworm | check: 1065 D virtualenv = 21.3.1 [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:22.469969 | debian-bookworm | check: 1066 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:22.470018 | debian-bookworm | check: 1066 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:22.470063 | debian-bookworm | check: 1066 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:22.470110 | debian-bookworm | check: 1066 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-05-08 03:05:22.474455 | debian-bookworm | check: 1070 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:485] 2026-05-08 03:05:23.598278 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2026-05-08 03:05:23.710754 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2026-05-08 03:05:23.876302 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2026-05-08 03:05:23.888235 | 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-08 03:05:23.973786 | debian-bookworm | Collecting ansible==11.13.0 (from -r requirements.txt (line 3)) 2026-05-08 03:05:23.986528 | debian-bookworm | Downloading ansible-11.13.0-py3-none-any.whl.metadata (8.2 kB) 2026-05-08 03:05:24.030457 | debian-bookworm | Collecting packaging==26.2 (from -r requirements.txt (line 4)) 2026-05-08 03:05:24.042311 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl.metadata (3.5 kB) 2026-05-08 03:05:24.183162 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2026-05-08 03:05:24.197444 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2026-05-08 03:05:24.219841 | debian-bookworm | Installing build dependencies: started 2026-05-08 03:05:25.411270 | debian-bookworm | Installing build dependencies: finished with status 'done' 2026-05-08 03:05:25.411683 | debian-bookworm | Getting requirements to build wheel: started 2026-05-08 03:05:25.840030 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2026-05-08 03:05:25.842840 | debian-bookworm | Preparing metadata (pyproject.toml): started 2026-05-08 03:05:26.081137 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2026-05-08 03:05:26.225654 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2026-05-08 03:05:26.240313 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2026-05-08 03:05:26.303600 | debian-bookworm | Collecting requests==2.33.1 (from -r requirements.txt (line 7)) 2026-05-08 03:05:26.315151 | debian-bookworm | Downloading requests-2.33.1-py3-none-any.whl.metadata (4.8 kB) 2026-05-08 03:05:26.350707 | debian-bookworm | Collecting tabulate==0.10.0 (from -r requirements.txt (line 8)) 2026-05-08 03:05:26.363163 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl.metadata (40 kB) 2026-05-08 03:05:26.472353 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2026-05-08 03:05:26.483599 | 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-08 03:05:26.572412 | debian-bookworm | Collecting ansible-core~=2.18.12 (from ansible==11.13.0->-r requirements.txt (line 3)) 2026-05-08 03:05:26.584729 | debian-bookworm | Downloading ansible_core-2.18.16-py3-none-any.whl.metadata (7.7 kB) 2026-05-08 03:05:26.637674 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-05-08 03:05:26.649626 | debian-bookworm | Downloading click-8.3.3-py3-none-any.whl.metadata (2.6 kB) 2026-05-08 03:05:26.689094 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-05-08 03:05:26.700432 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-05-08 03:05:26.755014 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-05-08 03:05:26.767762 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2026-05-08 03:05:26.813859 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-05-08 03:05:26.825741 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2026-05-08 03:05:26.982661 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.33.1->-r requirements.txt (line 7)) 2026-05-08 03:05:26.994546 | 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-08 03:05:27.031908 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.33.1->-r requirements.txt (line 7)) 2026-05-08 03:05:27.042930 | debian-bookworm | Downloading idna-3.13-py3-none-any.whl.metadata (8.0 kB) 2026-05-08 03:05:27.123337 | debian-bookworm | Collecting urllib3<3,>=1.26 (from requests==2.33.1->-r requirements.txt (line 7)) 2026-05-08 03:05:27.134627 | debian-bookworm | Downloading urllib3-2.7.0-py3-none-any.whl.metadata (6.9 kB) 2026-05-08 03:05:27.185751 | debian-bookworm | Collecting certifi>=2023.5.7 (from requests==2.33.1->-r requirements.txt (line 7)) 2026-05-08 03:05:27.197680 | debian-bookworm | Downloading certifi-2026.4.22-py3-none-any.whl.metadata (2.5 kB) 2026-05-08 03:05:27.456875 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.12->ansible==11.13.0->-r requirements.txt (line 3)) 2026-05-08 03:05:27.468404 | debian-bookworm | Downloading cryptography-48.0.0-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (4.3 kB) 2026-05-08 03:05:27.505910 | 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-08 03:05:27.518168 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2026-05-08 03:05:27.703533 | 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-08 03:05:27.715162 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2026-05-08 03:05:27.752965 | 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-08 03:05:27.764246 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl.metadata (8.2 kB) 2026-05-08 03:05:27.787730 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-05-08 03:05:27.816952 | 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-08 03:05:27.866807 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 23.5 MB/s 0:00:00 2026-05-08 03:05:27.880762 | debian-bookworm | Downloading ansible-11.13.0-py3-none-any.whl (57.6 MB) 2026-05-08 03:05:33.320486 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.6/57.6 MB 10.6 MB/s 0:00:05 2026-05-08 03:05:33.332763 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-08 03:05:33.403988 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2026-05-08 03:05:33.427791 | debian-bookworm | Downloading requests-2.33.1-py3-none-any.whl (64 kB) 2026-05-08 03:05:33.451871 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl (39 kB) 2026-05-08 03:05:33.476665 | debian-bookworm | Downloading ansible_core-2.18.16-py3-none-any.whl (2.2 MB) 2026-05-08 03:05:33.633125 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 18.5 MB/s 0:00:00 2026-05-08 03:05:33.649551 | 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-08 03:05:33.677979 | debian-bookworm | Downloading idna-3.13-py3-none-any.whl (68 kB) 2026-05-08 03:05:33.707186 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2026-05-08 03:05:33.739357 | debian-bookworm | Downloading urllib3-2.7.0-py3-none-any.whl (131 kB) 2026-05-08 03:05:33.774622 | debian-bookworm | Downloading certifi-2026.4.22-py3-none-any.whl (135 kB) 2026-05-08 03:05:33.810440 | 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-08 03:05:33.838998 | debian-bookworm | Downloading click-8.3.3-py3-none-any.whl (110 kB) 2026-05-08 03:05:33.863726 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-08 03:05:33.888986 | debian-bookworm | Downloading cryptography-48.0.0-cp311-abi3-manylinux_2_34_x86_64.whl (4.7 MB) 2026-05-08 03:05:34.128324 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.7/4.7 MB 19.4 MB/s 0:00:00 2026-05-08 03:05:34.141321 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2026-05-08 03:05:34.167699 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2026-05-08 03:05:34.190613 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-05-08 03:05:34.213971 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2026-05-08 03:05:34.502519 | debian-bookworm | Building wheels for collected packages: pwgen 2026-05-08 03:05:34.504008 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2026-05-08 03:05:34.782247 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2026-05-08 03:05:34.784593 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3796 sha256=3737ed1b89a65dc2f6dbf8de8388ff997834bf5a19ed9f5d8368f1d327936f4a 2026-05-08 03:05:34.785804 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2026-05-08 03:05:34.791488 | debian-bookworm | Successfully built pwgen 2026-05-08 03:05:35.026402 | 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-08 03:06:02.508774 | debian-bookworm | 2026-05-08 03:06:02.511002 | 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-48.0.0 fasteners-0.20 idna-3.13 packaging-26.2 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.7.0 2026-05-08 03:06:02.623563 | debian-bookworm | check: 41219 I exit 0 (40.15 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1480 [tox/execute/api.py:311] 2026-05-08 03:06:02.624471 | debian-bookworm | check: OK (41.00 seconds) 2026-05-08 03:06:02.624494 | debian-bookworm | congratulations :) (41.02 seconds) 2026-05-08 03:06:03.110448 | debian-bookworm | ok: Runtime: 0:00:41.300140 2026-05-08 03:06:03.116263 | 2026-05-08 03:06:03.116339 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-08 03:06:03.899078 | debian-bookworm | changed 2026-05-08 03:06:03.903328 | 2026-05-08 03:06:03.903410 | TASK [tox : Detect tox version] 2026-05-08 03:06:04.614758 | debian-bookworm | 4.53.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-08 03:06:04.992598 | debian-bookworm | ok: Runtime: 0:00:00.263054 2026-05-08 03:06:04.998857 | 2026-05-08 03:06:04.998939 | TASK [tox : Get tox envlist config] 2026-05-08 03:06:06.138214 | debian-bookworm | ok: Runtime: 0:00:00.346856 2026-05-08 03:06:06.143548 | 2026-05-08 03:06:06.143631 | TASK [tox : Install any sibling python packages] 2026-05-08 03:06:07.247201 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-08 03:06:07.254049 | 2026-05-08 03:06:07.256558 | TASK [tox : Remove tempfile] 2026-05-08 03:06:08.189544 | debian-bookworm | changed 2026-05-08 03:06:08.194067 | 2026-05-08 03:06:08.194168 | TASK [tox : Emit tox command] 2026-05-08 03:06:08.285622 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2026-05-08 03:06:08.290153 | 2026-05-08 03:06:08.290253 | TASK [tox : Run tox] 2026-05-08 03:06:08.903975 | debian-bookworm | ROOT: 213 D setup logging to DEBUG on pid 1644 [tox/report.py:229] 2026-05-08 03:06:08.931844 | debian-bookworm | check: 241 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-05-08 03:06:08.934380 | debian-bookworm | check: 243 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-05-08 03:06:08.938008 | debian-bookworm | check: 247 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-08 03:06:08.939099 | debian-bookworm | check: 248 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-05-08 03:06:08.939280 | debian-bookworm | check: 248 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:140] 2026-05-08 03:06:08.939392 | debian-bookworm | check: 249 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:144] 2026-05-08 03:06:08.941074 | debian-bookworm | check: 250 D symlink on filesystem does work [virtualenv/info.py:51] 2026-05-08 03:06:08.941272 | debian-bookworm | check: 250 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-05-08 03:06:08.974696 | debian-bookworm | check: 284 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:485] 2026-05-08 03:06:09.088231 | debian-bookworm | check: 397 I exit 0 (0.11 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-inventory-sorting.py pid=1651 [tox/execute/api.py:311] 2026-05-08 03:06:09.094951 | debian-bookworm | check: OK (0.16=setup[0.05]+cmd[0.11] seconds) 2026-05-08 03:06:09.094995 | debian-bookworm | congratulations :) (0.19 seconds) 2026-05-08 03:06:09.336808 | debian-bookworm | ok: Runtime: 0:00:00.500726 2026-05-08 03:06:09.343759 | 2026-05-08 03:06:09.343842 | TASK [tox : Look for output] 2026-05-08 03:06:10.024442 | debian-bookworm | ok 2026-05-08 03:06:10.049231 | 2026-05-08 03:06:10.049411 | TASK [tox : Return file comments to Zuul] 2026-05-08 03:06:10.139343 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:10.149712 | 2026-05-08 03:06:10.149790 | PLAY RECAP 2026-05-08 03:06:10.149837 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-08 03:06:10.149857 | 2026-05-08 03:06:10.632038 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-08 03:06:10.633905 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-08 03:06:11.951754 | 2026-05-08 03:06:11.951883 | PLAY [all] 2026-05-08 03:06:11.989973 | 2026-05-08 03:06:11.991230 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-08 03:06:12.087835 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:12.095366 | 2026-05-08 03:06:12.095489 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-08 03:06:12.255334 | debian-bookworm | ok 2026-05-08 03:06:12.259350 | 2026-05-08 03:06:12.259434 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-08 03:06:13.474144 | debian-bookworm -> localhost | changed 2026-05-08 03:06:13.481736 | 2026-05-08 03:06:13.481831 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-08 03:06:13.577894 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:13.590066 | 2026-05-08 03:06:13.590182 | TASK [fetch-tox-output : Set envlist fact] 2026-05-08 03:06:13.668549 | debian-bookworm | ok 2026-05-08 03:06:13.674816 | 2026-05-08 03:06:13.674927 | TASK [fetch-tox-output : Get tox version] 2026-05-08 03:06:14.611734 | 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-08 03:06:14.629242 | debian-bookworm | 4.53.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-08 03:06:14.743595 | debian-bookworm | ok: Runtime: 0:00:00.308283 2026-05-08 03:06:14.748079 | 2026-05-08 03:06:14.750904 | TASK [fetch-tox-output : Find all default environments] 2026-05-08 03:06:15.289234 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:15.293967 | 2026-05-08 03:06:15.294079 | TASK [fetch-tox-output : Set envlist fact] 2026-05-08 03:06:15.317366 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:15.322013 | 2026-05-08 03:06:15.322109 | TASK [fetch-tox-output : Find all default environments] 2026-05-08 03:06:15.860729 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:15.865482 | 2026-05-08 03:06:15.865573 | TASK [fetch-tox-output : Set envlist fact] 2026-05-08 03:06:15.918867 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:15.924623 | 2026-05-08 03:06:15.924711 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-08 03:06:15.998199 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:16.014518 | 2026-05-08 03:06:16.014620 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-08 03:06:17.379775 | debian-bookworm | changed: 2026-05-08 03:06:17.379938 | debian-bookworm | created directory /var/lib/zuul/builds/9537765358fc4b18a6e2620aafce8ace/work/logs/tox/check 2026-05-08 03:06:17.379973 | debian-bookworm | cd+++++++++ ./ 2026-05-08 03:06:17.380011 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-08 03:06:17.380039 | 2026-05-08 03:06:17.393234 | 2026-05-08 03:06:17.393301 | PLAY RECAP 2026-05-08 03:06:17.393344 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-08 03:06:17.393364 | 2026-05-08 03:06:17.552294 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-08 03:06:17.553034 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-08 03:06:18.629608 | 2026-05-08 03:06:18.629730 | PLAY [all] 2026-05-08 03:06:18.662219 | 2026-05-08 03:06:18.662344 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-08 03:06:18.999808 | debian-bookworm | changed: non-zero return code 2026-05-08 03:06:19.012739 | 2026-05-08 03:06:19.012877 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-08 03:06:19.061797 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:19.067951 | 2026-05-08 03:06:19.068106 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-08 03:06:19.117826 | 2026-05-08 03:06:19.117976 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-08 03:06:19.159805 | 2026-05-08 03:06:19.160041 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-08 03:06:19.193124 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:19.198330 | 2026-05-08 03:06:19.198675 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-08 03:06:19.252401 | 2026-05-08 03:06:19.252564 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-08 03:06:19.276194 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:19.281093 | 2026-05-08 03:06:19.281185 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-08 03:06:19.304226 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:19.309220 | 2026-05-08 03:06:19.309314 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-08 03:06:19.342705 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:19.350755 | 2026-05-08 03:06:19.350824 | PLAY RECAP 2026-05-08 03:06:19.350880 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-08 03:06:19.350900 | 2026-05-08 03:06:19.460345 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-08 03:06:19.470771 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-08 03:06:20.255366 | 2026-05-08 03:06:20.255482 | PLAY [Base post-fetch] 2026-05-08 03:06:20.286181 | 2026-05-08 03:06:20.286313 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-08 03:06:20.367246 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:20.372437 | 2026-05-08 03:06:20.372572 | TASK [fetch-output : Set log path for single node] 2026-05-08 03:06:20.444883 | debian-bookworm | ok 2026-05-08 03:06:20.449962 | 2026-05-08 03:06:20.450068 | LOOP [fetch-output : Ensure local output dirs] 2026-05-08 03:06:21.182711 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/9537765358fc4b18a6e2620aafce8ace/work/logs" 2026-05-08 03:06:21.760078 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9537765358fc4b18a6e2620aafce8ace/work/artifacts" 2026-05-08 03:06:22.382799 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9537765358fc4b18a6e2620aafce8ace/work/docs" 2026-05-08 03:06:22.399257 | 2026-05-08 03:06:22.399367 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-08 03:06:23.471071 | debian-bookworm | changed: 2026-05-08 03:06:23.476408 | debian-bookworm | .d..t...... ./ 2026-05-08 03:06:23.476481 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-08 03:06:23.476523 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-08 03:06:23.476556 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-08 03:06:23.476599 | debian-bookworm | changed: All items complete 2026-05-08 03:06:23.476626 | 2026-05-08 03:06:24.028780 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 03:06:24.675043 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 03:06:24.697379 | 2026-05-08 03:06:24.697496 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-08 03:06:24.721290 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:24.726044 | debian-bookworm | skipping: Conditional result was False 2026-05-08 03:06:24.737798 | 2026-05-08 03:06:24.737878 | PLAY RECAP 2026-05-08 03:06:24.737926 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-08 03:06:24.737951 | 2026-05-08 03:06:24.878287 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-08 03:06:24.879374 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 03:06:25.810029 | 2026-05-08 03:06:25.810213 | PLAY [Base post] 2026-05-08 03:06:25.824878 | 2026-05-08 03:06:25.825085 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-08 03:06:26.455107 | debian-bookworm | changed 2026-05-08 03:06:26.464578 | 2026-05-08 03:06:26.464725 | PLAY RECAP 2026-05-08 03:06:26.464797 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-08 03:06:26.464863 | 2026-05-08 03:06:26.735762 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 03:06:26.736850 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-08 03:06:28.157863 | 2026-05-08 03:06:28.158101 | PLAY [Base post-logs] 2026-05-08 03:06:28.195303 | 2026-05-08 03:06:28.195498 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-08 03:06:29.070317 | localhost | changed 2026-05-08 03:06:29.091134 | 2026-05-08 03:06:29.091489 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-08 03:06:29.128884 | localhost | ok 2026-05-08 03:06:29.132248 | 2026-05-08 03:06:29.132361 | TASK [Set zuul-log-path fact] 2026-05-08 03:06:29.172494 | localhost | ok 2026-05-08 03:06:29.182161 | 2026-05-08 03:06:29.182309 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 03:06:29.220656 | localhost | ok 2026-05-08 03:06:29.233432 | 2026-05-08 03:06:29.233571 | TASK [upload-logs : Create log directories] 2026-05-08 03:06:30.118141 | localhost | changed 2026-05-08 03:06:30.121012 | 2026-05-08 03:06:30.121127 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-08 03:06:30.667219 | localhost -> localhost | ok: Runtime: 0:00:00.007672 2026-05-08 03:06:30.671466 | 2026-05-08 03:06:30.671588 | TASK [upload-logs : Upload logs to log server] 2026-05-08 03:06:31.362175 | localhost | Output suppressed because no_log was given 2026-05-08 03:06:31.364321 | 2026-05-08 03:06:31.364444 | LOOP [upload-logs : Compress console log and json output] 2026-05-08 03:06:31.418924 | localhost | skipping: Conditional result was False 2026-05-08 03:06:31.426026 | localhost | skipping: Conditional result was False 2026-05-08 03:06:31.432615 | 2026-05-08 03:06:31.432753 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-08 03:06:31.482662 | localhost | skipping: Conditional result was False 2026-05-08 03:06:31.483005 | 2026-05-08 03:06:31.492905 | localhost | skipping: Conditional result was False 2026-05-08 03:06:31.499745 | 2026-05-08 03:06:31.499868 | LOOP [upload-logs : Upload console log and json output]