2026-04-14 03:04:32.302464 | Job console starting 2026-04-14 03:04:32.310761 | Updating git repos 2026-04-14 03:04:32.357634 | Cloning repos into workspace 2026-04-14 03:04:32.445038 | Restoring repo states 2026-04-14 03:04:32.479736 | Merging changes 2026-04-14 03:04:32.479755 | Checking out repos 2026-04-14 03:04:32.551688 | Preparing playbooks 2026-04-14 03:04:33.746731 | Running Ansible setup 2026-04-14 03:04:41.286480 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-14 03:04:42.630123 | 2026-04-14 03:04:42.630273 | PLAY [Base pre] 2026-04-14 03:04:42.649668 | 2026-04-14 03:04:42.649792 | TASK [Setup log path fact] 2026-04-14 03:04:42.670899 | debian-bookworm | ok 2026-04-14 03:04:42.704935 | 2026-04-14 03:04:42.705921 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-14 03:04:42.769483 | debian-bookworm | ok 2026-04-14 03:04:42.788087 | 2026-04-14 03:04:42.788200 | TASK [emit-job-header : Print job information] 2026-04-14 03:04:42.890042 | # Job Information 2026-04-14 03:04:42.890204 | Ansible Version: 2.16.14 2026-04-14 03:04:42.890238 | Job: cfg-generics-tox-check 2026-04-14 03:04:42.890271 | Pipeline: periodic-daily 2026-04-14 03:04:42.890293 | Executor: 521e9411259a 2026-04-14 03:04:42.890313 | Triggered by: https://github.com/osism/generics 2026-04-14 03:04:42.890334 | Event ID: f87ee89ab20a45b591b2804b740c48a7 2026-04-14 03:04:42.900020 | 2026-04-14 03:04:42.900903 | LOOP [emit-job-header : Print node information] 2026-04-14 03:04:43.080611 | debian-bookworm | ok: 2026-04-14 03:04:43.080765 | debian-bookworm | # Node Information 2026-04-14 03:04:43.080794 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-14 03:04:43.080815 | debian-bookworm | Hostname: debian 2026-04-14 03:04:43.080834 | debian-bookworm | Username: zuul 2026-04-14 03:04:43.080852 | debian-bookworm | Distro: Debian 12.13 2026-04-14 03:04:43.080875 | debian-bookworm | Provider: regiocloud-a 2026-04-14 03:04:43.080895 | debian-bookworm | Region: 2026-04-14 03:04:43.080915 | debian-bookworm | Label: debian-bookworm 2026-04-14 03:04:43.080934 | debian-bookworm | Product Name: OpenStack Nova 2026-04-14 03:04:43.080952 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8e:61c2 2026-04-14 03:04:43.097368 | 2026-04-14 03:04:43.097475 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-14 03:04:43.997931 | debian-bookworm -> localhost | changed 2026-04-14 03:04:44.015836 | 2026-04-14 03:04:44.015951 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-14 03:04:45.704771 | debian-bookworm -> localhost | changed 2026-04-14 03:04:45.722218 | 2026-04-14 03:04:45.722341 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-14 03:04:46.019916 | debian-bookworm -> localhost | ok 2026-04-14 03:04:46.032643 | 2026-04-14 03:04:46.032794 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-14 03:04:46.061890 | debian-bookworm | ok 2026-04-14 03:04:46.088178 | debian-bookworm | included: /var/lib/zuul/builds/baf762c8388a44568fc7a042b28a6438/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-14 03:04:46.096131 | 2026-04-14 03:04:46.096224 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-14 03:04:48.641623 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-14 03:04:48.641837 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/baf762c8388a44568fc7a042b28a6438/work/baf762c8388a44568fc7a042b28a6438_id_rsa 2026-04-14 03:04:48.641875 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/baf762c8388a44568fc7a042b28a6438/work/baf762c8388a44568fc7a042b28a6438_id_rsa.pub 2026-04-14 03:04:48.641901 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-14 03:04:48.641926 | debian-bookworm -> localhost | SHA256:6zyugRXR5cEVh9k2jdzxGS5y8Vd3JYBXhUwZtPJrxWg zuul-build-sshkey 2026-04-14 03:04:48.641948 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-14 03:04:48.641996 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-14 03:04:48.642023 | debian-bookworm -> localhost | | .. ooo+&B@O| 2026-04-14 03:04:48.642046 | debian-bookworm -> localhost | | ...o.+.&oX| 2026-04-14 03:04:48.642066 | debian-bookworm -> localhost | | . .o.+.=o| 2026-04-14 03:04:48.642087 | debian-bookworm -> localhost | | . oo.o.| 2026-04-14 03:04:48.642107 | debian-bookworm -> localhost | | . S E o| 2026-04-14 03:04:48.642135 | debian-bookworm -> localhost | | o . . o | 2026-04-14 03:04:48.642156 | debian-bookworm -> localhost | | . . . o | 2026-04-14 03:04:48.642176 | debian-bookworm -> localhost | | +. . | 2026-04-14 03:04:48.642196 | debian-bookworm -> localhost | | .o+. | 2026-04-14 03:04:48.642216 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-14 03:04:48.642272 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.949308 2026-04-14 03:04:48.648706 | 2026-04-14 03:04:48.648802 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-14 03:04:48.698386 | debian-bookworm | ok 2026-04-14 03:04:48.718474 | debian-bookworm | included: /var/lib/zuul/builds/baf762c8388a44568fc7a042b28a6438/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-14 03:04:48.762787 | 2026-04-14 03:04:48.762929 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-14 03:04:48.820118 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:04:48.826366 | 2026-04-14 03:04:48.826478 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-14 03:04:49.557208 | debian-bookworm | changed 2026-04-14 03:04:49.562231 | 2026-04-14 03:04:49.562324 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-14 03:04:49.860181 | debian-bookworm | ok 2026-04-14 03:04:49.864904 | 2026-04-14 03:04:49.864998 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-14 03:04:50.626609 | debian-bookworm | changed 2026-04-14 03:04:50.643845 | 2026-04-14 03:04:50.643980 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-14 03:04:51.401032 | debian-bookworm | changed 2026-04-14 03:04:51.411008 | 2026-04-14 03:04:51.411125 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-14 03:04:51.437545 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:04:51.446984 | 2026-04-14 03:04:51.447102 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-14 03:04:52.210288 | debian-bookworm -> localhost | changed 2026-04-14 03:04:52.224420 | 2026-04-14 03:04:52.224579 | TASK [add-build-sshkey : Add back temp key] 2026-04-14 03:04:53.831523 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/baf762c8388a44568fc7a042b28a6438/work/baf762c8388a44568fc7a042b28a6438_id_rsa (zuul-build-sshkey) 2026-04-14 03:04:53.831952 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.064168 2026-04-14 03:04:53.848713 | 2026-04-14 03:04:53.848875 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-14 03:04:54.873753 | debian-bookworm | ok 2026-04-14 03:04:54.880302 | 2026-04-14 03:04:54.880398 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-14 03:04:54.937754 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:04:54.963216 | 2026-04-14 03:04:54.963326 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-14 03:04:55.555034 | debian-bookworm | ok 2026-04-14 03:04:55.571986 | 2026-04-14 03:04:55.572094 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-14 03:04:55.627488 | debian-bookworm | ok 2026-04-14 03:04:55.631843 | 2026-04-14 03:04:55.631922 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-14 03:04:56.323987 | debian-bookworm -> localhost | ok 2026-04-14 03:04:56.330701 | 2026-04-14 03:04:56.330808 | TASK [validate-host : Collect information about the host] 2026-04-14 03:04:57.736000 | debian-bookworm | ok 2026-04-14 03:04:57.758417 | 2026-04-14 03:04:57.758532 | TASK [validate-host : Sanitize hostname] 2026-04-14 03:04:58.103178 | debian-bookworm | ok 2026-04-14 03:04:58.214395 | 2026-04-14 03:04:58.214513 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-14 03:04:59.391330 | debian-bookworm -> localhost | changed 2026-04-14 03:04:59.396377 | 2026-04-14 03:04:59.396477 | TASK [validate-host : Collect information about zuul worker] 2026-04-14 03:04:59.886041 | debian-bookworm | ok 2026-04-14 03:04:59.889989 | 2026-04-14 03:04:59.890074 | TASK [validate-host : Write out all zuul information for each host] 2026-04-14 03:05:00.832447 | debian-bookworm -> localhost | changed 2026-04-14 03:05:00.842045 | 2026-04-14 03:05:00.842131 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-14 03:05:01.145014 | debian-bookworm | ok 2026-04-14 03:05:01.149540 | 2026-04-14 03:05:01.149634 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-14 03:05:02.495552 | debian-bookworm | changed: 2026-04-14 03:05:02.495717 | debian-bookworm | cd+++++++++ src/ 2026-04-14 03:05:02.495746 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-14 03:05:02.495766 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-14 03:05:02.495784 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-04-14 03:05:02.495801 | debian-bookworm | =7.0.3 2026-04-14 03:05:31.111355 | debian-bookworm | Downloading cachetools-7.0.5-py3-none-any.whl (13 kB) 2026-04-14 03:05:31.166615 | debian-bookworm | Collecting colorama>=0.4.6 2026-04-14 03:05:31.179092 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-04-14 03:05:31.283815 | debian-bookworm | Collecting filelock>=3.25 2026-04-14 03:05:31.295955 | debian-bookworm | Downloading filelock-3.25.2-py3-none-any.whl (26 kB) 2026-04-14 03:05:31.354994 | debian-bookworm | Collecting packaging>=26 2026-04-14 03:05:31.366676 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-04-14 03:05:31.377225 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 9.2 MB/s eta 0:00:00 2026-04-14 03:05:31.431922 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-04-14 03:05:31.443743 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-04-14 03:05:31.502756 | debian-bookworm | Collecting pluggy>=1.6 2026-04-14 03:05:31.514250 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-04-14 03:05:31.561583 | debian-bookworm | Collecting pyproject-api>=1.10 2026-04-14 03:05:31.573287 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-04-14 03:05:31.612080 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-04-14 03:05:31.623803 | debian-bookworm | Downloading python_discovery-1.2.2-py3-none-any.whl (31 kB) 2026-04-14 03:05:31.667413 | debian-bookworm | Collecting tomli-w>=1.2 2026-04-14 03:05:31.679224 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-04-14 03:05:31.828096 | debian-bookworm | Collecting virtualenv>=21.1 2026-04-14 03:05:31.844459 | debian-bookworm | Downloading virtualenv-21.2.3-py3-none-any.whl (5.8 MB) 2026-04-14 03:05:32.138292 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 20.2 MB/s eta 0:00:00 2026-04-14 03:05:32.248617 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-04-14 03:05:32.261455 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-04-14 03:05:32.294180 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.1 MB/s eta 0:00:00 2026-04-14 03:05:32.408671 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-04-14 03:05:33.151669 | debian-bookworm | Successfully installed cachetools-7.0.5 colorama-0.4.6 distlib-0.4.0 filelock-3.25.2 packaging-26.0 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.52.1 virtualenv-21.2.3 2026-04-14 03:05:33.756361 | debian-bookworm | ok: Runtime: 0:00:03.184801 2026-04-14 03:05:33.763539 | 2026-04-14 03:05:33.763720 | TASK [ensure-tox : Export installed tox_executable path] 2026-04-14 03:05:33.817824 | debian-bookworm | ok 2026-04-14 03:05:33.823616 | 2026-04-14 03:05:33.823752 | TASK [ensure-tox : Output tox version] 2026-04-14 03:05:34.406618 | 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-04-14 03:05:34.425737 | debian-bookworm | 4.52.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-04-14 03:05:34.881621 | debian-bookworm | ok: Runtime: 0:00:00.320138 2026-04-14 03:05:34.894891 | 2026-04-14 03:05:34.895100 | TASK [ensure-tox : Make global symlink] 2026-04-14 03:05:34.924046 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:05:34.935271 | 2026-04-14 03:05:34.935470 | PLAY RECAP 2026-04-14 03:05:34.935548 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-04-14 03:05:34.935579 | 2026-04-14 03:05:35.228955 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-04-14 03:05:35.230610 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-04-14 03:05:36.253338 | 2026-04-14 03:05:36.253565 | PLAY [all] 2026-04-14 03:05:36.272262 | 2026-04-14 03:05:36.272464 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-04-14 03:05:36.831116 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-04-14 03:05:37.306349 | debian-bookworm | ok: Runtime: 0:00:00.029476 2026-04-14 03:05:37.326323 | 2026-04-14 03:05:37.326547 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-04-14 03:05:37.861940 | debian-bookworm | ok: Runtime: 0:00:00.006781 2026-04-14 03:05:37.876349 | 2026-04-14 03:05:37.876559 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-04-14 03:05:38.196372 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-04-14 03:05:38.200160 | debian-bookworm | sudo: a password is required 2026-04-14 03:05:38.421108 | debian-bookworm | ok: Runtime: 0:00:00.026218 2026-04-14 03:05:38.450073 | 2026-04-14 03:05:38.450399 | TASK [tox : Check to see if the constraints file exists] 2026-04-14 03:05:38.490370 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:05:38.497961 | 2026-04-14 03:05:38.498112 | TASK [tox : Fail if constraints file is missing] 2026-04-14 03:05:38.523674 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:05:38.530898 | 2026-04-14 03:05:38.531047 | TASK [tox : Record file location] 2026-04-14 03:05:38.576216 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:05:38.582825 | 2026-04-14 03:05:38.582989 | TASK [tox : Install tox siblings] 2026-04-14 03:05:38.615542 | debian-bookworm | ok 2026-04-14 03:05:38.625617 | debian-bookworm | included: /var/lib/zuul/builds/baf762c8388a44568fc7a042b28a6438/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-04-14 03:05:38.631590 | 2026-04-14 03:05:38.631760 | TASK [tox : Run tox without tests] 2026-04-14 03:05:39.166451 | debian-bookworm | ROOT: 198 D setup logging to DEBUG on pid 1428 [tox/report.py:229] 2026-04-14 03:05:39.196797 | debian-bookworm | check: 228 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-04-14 03:05:39.199321 | debian-bookworm | check: 231 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:62] 2026-04-14 03:05:39.204919 | debian-bookworm | check: 236 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/python_discovery/_py_info.py 5cb76e56a6b9955f5bbefde056cc70b1 3e4b033a7c2ba445638a1d18fa12fcae [python_discovery/_cached_py_info.py:198] 2026-04-14 03:05:39.281381 | debian-bookworm | check: 313 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-04-14 03:05:39.282040 | debian-bookworm | check: 314 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-04-14 03:05:39.282235 | debian-bookworm | check: 314 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-04-14 03:05:39.282353 | debian-bookworm | check: 314 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-04-14 03:05:39.284225 | debian-bookworm | check: 316 D symlink on filesystem does work [virtualenv/info.py:51] 2026-04-14 03:05:39.284398 | debian-bookworm | check: 316 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-04-14 03:05:39.314658 | 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-04-14 03:05:39.314957 | debian-bookworm | check: 346 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/bin [virtualenv/util/path/_sync.py:18] 2026-04-14 03:05:39.315119 | debian-bookworm | check: 347 D create folder /home/zuul/src/github.com/osism/generics/.tox/check/include [virtualenv/util/path/_sync.py:18] 2026-04-14 03:05:39.315214 | 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-04-14 03:05:39.315424 | debian-bookworm | check: 347 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-04-14 03:05:39.315506 | debian-bookworm | check: 347 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.315568 | debian-bookworm | check: 347 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.315618 | debian-bookworm | check: 347 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.315669 | debian-bookworm | check: 347 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.315717 | debian-bookworm | check: 347 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.315784 | 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-04-14 03:05:39.315830 | debian-bookworm | check: 347 D virtualenv = 21.2.3 [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.315881 | debian-bookworm | check: 347 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.315928 | debian-bookworm | check: 347 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.315974 | debian-bookworm | check: 348 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.316026 | debian-bookworm | check: 348 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.316325 | 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-04-14 03:05:39.316688 | 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-04-14 03:05:39.316877 | debian-bookworm | check: 348 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-04-14 03:05:39.317314 | debian-bookworm | check: 349 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-04-14 03:05:39.317798 | 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-04-14 03:05:39.367077 | debian-bookworm | check: 349 D { 2026-04-14 03:05:39.367128 | debian-bookworm | "sys": { 2026-04-14 03:05:39.367135 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check/bin/python", 2026-04-14 03:05:39.367141 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-04-14 03:05:39.367146 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-04-14 03:05:39.367152 | debian-bookworm | "base_prefix": "/usr", 2026-04-14 03:05:39.367158 | debian-bookworm | "real_prefix": null, 2026-04-14 03:05:39.367163 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check", 2026-04-14 03:05:39.367167 | debian-bookworm | "base_exec_prefix": "/usr", 2026-04-14 03:05:39.367171 | debian-bookworm | "path": [ 2026-04-14 03:05:39.367175 | debian-bookworm | "/usr/lib/python311.zip", 2026-04-14 03:05:39.367179 | debian-bookworm | "/usr/lib/python3.11", 2026-04-14 03:05:39.367184 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-04-14 03:05:39.367188 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages" 2026-04-14 03:05:39.367192 | debian-bookworm | ], 2026-04-14 03:05:39.367196 | debian-bookworm | "meta_path": [ 2026-04-14 03:05:39.367200 | debian-bookworm | "", 2026-04-14 03:05:39.367204 | debian-bookworm | "", 2026-04-14 03:05:39.367209 | debian-bookworm | "", 2026-04-14 03:05:39.367218 | debian-bookworm | "" 2026-04-14 03:05:39.367222 | debian-bookworm | ], 2026-04-14 03:05:39.367226 | debian-bookworm | "fs_encoding": "utf-8", 2026-04-14 03:05:39.367230 | debian-bookworm | "io_encoding": "utf-8" 2026-04-14 03:05:39.367234 | debian-bookworm | }, 2026-04-14 03:05:39.367238 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2026-04-14 03:05:39.367242 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-04-14 03:05:39.367246 | debian-bookworm | "os": "", 2026-04-14 03:05:39.367250 | debian-bookworm | "site": "", 2026-04-14 03:05:39.367254 | debian-bookworm | "datetime": "", 2026-04-14 03:05:39.367258 | debian-bookworm | "math": "", 2026-04-14 03:05:39.367262 | debian-bookworm | "json": "" 2026-04-14 03:05:39.367266 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-04-14 03:05:39.367406 | debian-bookworm | check: 399 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-04-14 03:05:39.369031 | debian-bookworm | check: 400 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-26.0.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-04-14 03:05:39.373292 | debian-bookworm | check: 401 D build install image for pip-26.0.1-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.0.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:53] 2026-04-14 03:05:39.373587 | debian-bookworm | check: 405 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-04-14 03:05:39.376118 | debian-bookworm | check: 407 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:53] 2026-04-14 03:05:39.599162 | debian-bookworm | check: 631 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.0.1-py3-none-any/pip-26.0.1.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-26.0.1.dist-info [virtualenv/util/path/_sync.py:46] 2026-04-14 03:05:39.613920 | debian-bookworm | check: 645 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-04-14 03:05:39.628506 | debian-bookworm | check: 660 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.0.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-04-14 03:05:39.759270 | debian-bookworm | check: 791 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-04-14 03:05:39.760445 | debian-bookworm | check: 792 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-04-14 03:05:39.765389 | debian-bookworm | check: 797 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-04-14 03:05:39.765855 | debian-bookworm | check: 797 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-04-14 03:05:39.766861 | debian-bookworm | check: 798 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2026-04-14 03:05:39.774829 | debian-bookworm | check: 806 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.0.1-py3-none-any/pip-26.0.1.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check/lib/python3.11/site-packages/pip-26.0.1.virtualenv [virtualenv/util/path/_sync.py:46] 2026-04-14 03:05:39.775525 | debian-bookworm | check: 807 D generated console scripts pip3.11 pip pip3 pip-3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2026-04-14 03:05:39.775911 | debian-bookworm | check: 807 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:90] 2026-04-14 03:05:39.782311 | debian-bookworm | check: 814 D write /home/zuul/src/github.com/osism/generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-04-14 03:05:39.782383 | debian-bookworm | check: 814 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.782449 | debian-bookworm | check: 814 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.782509 | debian-bookworm | check: 814 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.782554 | debian-bookworm | check: 814 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.782608 | debian-bookworm | check: 814 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.782667 | debian-bookworm | check: 814 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-04-14 03:05:39.782717 | debian-bookworm | check: 814 D virtualenv = 21.2.3 [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.782802 | debian-bookworm | check: 814 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.782854 | debian-bookworm | check: 814 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.782908 | debian-bookworm | check: 814 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.782961 | debian-bookworm | check: 815 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-04-14 03:05:39.788201 | debian-bookworm | check: 820 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:515] 2026-04-14 03:05:40.903086 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2026-04-14 03:05:41.028373 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2026-04-14 03:05:41.158017 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2026-04-14 03:05:41.170105 | 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-04-14 03:05:41.266465 | debian-bookworm | Collecting ansible==11.13.0 (from -r requirements.txt (line 3)) 2026-04-14 03:05:41.281062 | debian-bookworm | Downloading ansible-11.13.0-py3-none-any.whl.metadata (8.2 kB) 2026-04-14 03:05:41.336695 | debian-bookworm | Collecting packaging==26.0 (from -r requirements.txt (line 4)) 2026-04-14 03:05:41.350103 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-04-14 03:05:41.498854 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2026-04-14 03:05:41.513149 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2026-04-14 03:05:41.533490 | debian-bookworm | Installing build dependencies: started 2026-04-14 03:05:42.832388 | debian-bookworm | Installing build dependencies: finished with status 'done' 2026-04-14 03:05:42.832759 | debian-bookworm | Getting requirements to build wheel: started 2026-04-14 03:05:43.258341 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2026-04-14 03:05:43.259439 | debian-bookworm | Preparing metadata (pyproject.toml): started 2026-04-14 03:05:43.518063 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2026-04-14 03:05:43.558803 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2026-04-14 03:05:43.572786 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2026-04-14 03:05:43.647619 | debian-bookworm | Collecting requests==2.33.0 (from -r requirements.txt (line 7)) 2026-04-14 03:05:43.661968 | debian-bookworm | Downloading requests-2.33.0-py3-none-any.whl.metadata (5.1 kB) 2026-04-14 03:05:43.711104 | debian-bookworm | Collecting tabulate==0.10.0 (from -r requirements.txt (line 8)) 2026-04-14 03:05:43.724973 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl.metadata (40 kB) 2026-04-14 03:05:43.840487 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2026-04-14 03:05:43.851780 | 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-04-14 03:05:43.945109 | debian-bookworm | Collecting ansible-core~=2.18.12 (from ansible==11.13.0->-r requirements.txt (line 3)) 2026-04-14 03:05:43.958163 | debian-bookworm | Downloading ansible_core-2.18.15-py3-none-any.whl.metadata (7.7 kB) 2026-04-14 03:05:44.020860 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-04-14 03:05:44.032926 | debian-bookworm | Downloading click-8.3.2-py3-none-any.whl.metadata (2.6 kB) 2026-04-14 03:05:44.082830 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-04-14 03:05:44.095285 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-04-14 03:05:44.140409 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-04-14 03:05:44.153549 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2026-04-14 03:05:44.253010 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-04-14 03:05:44.265224 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2026-04-14 03:05:44.445072 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.33.0->-r requirements.txt (line 7)) 2026-04-14 03:05:44.456773 | 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-04-14 03:05:44.505180 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.33.0->-r requirements.txt (line 7)) 2026-04-14 03:05:44.517337 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl.metadata (8.4 kB) 2026-04-14 03:05:44.569844 | debian-bookworm | Collecting urllib3<3,>=1.26 (from requests==2.33.0->-r requirements.txt (line 7)) 2026-04-14 03:05:44.581331 | debian-bookworm | Downloading urllib3-2.6.3-py3-none-any.whl.metadata (6.9 kB) 2026-04-14 03:05:44.644621 | debian-bookworm | Collecting certifi>=2023.5.7 (from requests==2.33.0->-r requirements.txt (line 7)) 2026-04-14 03:05:44.656821 | debian-bookworm | Downloading certifi-2026.2.25-py3-none-any.whl.metadata (2.5 kB) 2026-04-14 03:05:45.012794 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.12->ansible==11.13.0->-r requirements.txt (line 3)) 2026-04-14 03:05:45.024165 | debian-bookworm | Downloading cryptography-46.0.7-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2026-04-14 03:05:45.081164 | 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-04-14 03:05:45.094500 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2026-04-14 03:05:45.268646 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core~=2.18.12->ansible==11.13.0->-r requirements.txt (line 3)) 2026-04-14 03:05:45.279829 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2026-04-14 03:05:45.326533 | 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-04-14 03:05:45.340836 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl.metadata (8.2 kB) 2026-04-14 03:05:45.374547 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-04-14 03:05:45.408446 | 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-04-14 03:05:45.465143 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 12.5 MB/s 0:00:00 2026-04-14 03:05:45.479616 | debian-bookworm | Downloading ansible-11.13.0-py3-none-any.whl (57.6 MB) 2026-04-14 03:05:49.731844 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.6/57.6 MB 13.5 MB/s 0:00:04 2026-04-14 03:05:49.745213 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-04-14 03:05:49.769245 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2026-04-14 03:05:49.798478 | debian-bookworm | Downloading requests-2.33.0-py3-none-any.whl (65 kB) 2026-04-14 03:05:49.822541 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl (39 kB) 2026-04-14 03:05:49.850526 | debian-bookworm | Downloading ansible_core-2.18.15-py3-none-any.whl (2.2 MB) 2026-04-14 03:05:49.952155 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 21.2 MB/s 0:00:00 2026-04-14 03:05:49.966714 | 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-04-14 03:05:49.997907 | debian-bookworm | Downloading idna-3.11-py3-none-any.whl (71 kB) 2026-04-14 03:05:50.025238 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2026-04-14 03:05:50.050382 | debian-bookworm | Downloading urllib3-2.6.3-py3-none-any.whl (131 kB) 2026-04-14 03:05:50.075823 | debian-bookworm | Downloading certifi-2026.2.25-py3-none-any.whl (153 kB) 2026-04-14 03:05:50.103003 | 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-04-14 03:05:50.127741 | debian-bookworm | Downloading click-8.3.2-py3-none-any.whl (108 kB) 2026-04-14 03:05:50.153213 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-04-14 03:05:50.176924 | debian-bookworm | Downloading cryptography-46.0.7-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2026-04-14 03:05:50.355819 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 24.8 MB/s 0:00:00 2026-04-14 03:05:50.370488 | debian-bookworm | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2026-04-14 03:05:50.397752 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2026-04-14 03:05:50.422967 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-04-14 03:05:50.448365 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2026-04-14 03:05:50.779334 | debian-bookworm | Building wheels for collected packages: pwgen 2026-04-14 03:05:50.780252 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2026-04-14 03:05:51.081512 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2026-04-14 03:05:51.082714 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3796 sha256=10aff84565ae3321510ec13d49b3597c2d906eb18633dfa655f9bdc17abe4a4c 2026-04-14 03:05:51.083130 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2026-04-14 03:05:51.087704 | debian-bookworm | Successfully built pwgen 2026-04-14 03:05:51.358579 | 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-04-14 03:06:21.840991 | debian-bookworm | 2026-04-14 03:06:21.844438 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-11.13.0 ansible-core-2.18.15 certifi-2026.2.25 cffi-2.0.0 charset_normalizer-3.4.7 click-8.3.2 colorama-0.4.6 cryptography-46.0.7 fasteners-0.20 idna-3.11 packaging-26.0 pwgen-0.8.2.post0 pycparser-3.0 python-gilt-1.2.3 requests-2.33.0 resolvelib-1.0.1 sh-2.2.2 tabulate-0.10.0 urllib3-2.6.3 2026-04-14 03:06:22.235447 | debian-bookworm | check: 43265 I exit 0 (42.44 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1441 [tox/execute/api.py:311] 2026-04-14 03:06:22.240323 | debian-bookworm | check: OK (43.04 seconds) 2026-04-14 03:06:22.240367 | debian-bookworm | congratulations :) (43.07 seconds) 2026-04-14 03:06:22.724466 | debian-bookworm | ok: Runtime: 0:00:43.395067 2026-04-14 03:06:22.734476 | 2026-04-14 03:06:22.734609 | TASK [tox : Create a tempfile to save tox showconfig] 2026-04-14 03:06:23.663955 | debian-bookworm | changed 2026-04-14 03:06:23.672409 | 2026-04-14 03:06:23.672526 | TASK [tox : Get tox envlist config] 2026-04-14 03:06:24.722456 | debian-bookworm | ok: Runtime: 0:00:00.407146 2026-04-14 03:06:24.733129 | 2026-04-14 03:06:24.733517 | TASK [tox : Install any sibling python packages] 2026-04-14 03:06:25.468477 | debian-bookworm | ok: No setup.cfg, no action needed 2026-04-14 03:06:25.477424 | 2026-04-14 03:06:25.477546 | TASK [tox : Remove tempfile] 2026-04-14 03:06:26.169246 | debian-bookworm | changed 2026-04-14 03:06:26.177941 | 2026-04-14 03:06:26.178191 | TASK [tox : Emit tox command] 2026-04-14 03:06:26.245656 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2026-04-14 03:06:26.251469 | 2026-04-14 03:06:26.265620 | TASK [tox : Run tox] 2026-04-14 03:06:26.982714 | debian-bookworm | ROOT: 259 D setup logging to DEBUG on pid 1597 [tox/report.py:229] 2026-04-14 03:06:27.027192 | debian-bookworm | check: 305 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-04-14 03:06:27.031867 | debian-bookworm | check: 310 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:62] 2026-04-14 03:06:27.039505 | debian-bookworm | check: 317 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-04-14 03:06:27.041504 | debian-bookworm | check: 319 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-04-14 03:06:27.041544 | debian-bookworm | check: 320 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-04-14 03:06:27.041584 | debian-bookworm | check: 320 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-04-14 03:06:27.044941 | debian-bookworm | check: 323 D symlink on filesystem does work [virtualenv/info.py:51] 2026-04-14 03:06:27.045774 | debian-bookworm | check: 324 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-04-14 03:06:27.089251 | debian-bookworm | check: 368 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:515] 2026-04-14 03:06:27.272768 | debian-bookworm | check: 551 I exit 0 (0.18 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-inventory-sorting.py pid=1604 [tox/execute/api.py:311] 2026-04-14 03:06:27.274769 | debian-bookworm | check: OK (0.25=setup[0.07]+cmd[0.18] seconds) 2026-04-14 03:06:27.274827 | debian-bookworm | congratulations :) (0.30 seconds) 2026-04-14 03:06:27.854439 | debian-bookworm | ok: Runtime: 0:00:00.725734 2026-04-14 03:06:27.860604 | 2026-04-14 03:06:27.860730 | TASK [tox : Look for output] 2026-04-14 03:06:28.406936 | debian-bookworm | ok 2026-04-14 03:06:28.453498 | 2026-04-14 03:06:28.453816 | TASK [tox : Return file comments to Zuul] 2026-04-14 03:06:28.534013 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:28.544023 | 2026-04-14 03:06:28.544161 | PLAY RECAP 2026-04-14 03:06:28.544222 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-04-14 03:06:28.544278 | 2026-04-14 03:06:29.324721 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-04-14 03:06:29.325947 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-04-14 03:06:31.834956 | 2026-04-14 03:06:31.835115 | PLAY [all] 2026-04-14 03:06:31.864993 | 2026-04-14 03:06:31.865147 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-04-14 03:06:32.013876 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:32.019024 | 2026-04-14 03:06:32.019166 | TASK [fetch-tox-output : Set tox log path for single node] 2026-04-14 03:06:32.077085 | debian-bookworm | ok 2026-04-14 03:06:32.081481 | 2026-04-14 03:06:32.081708 | TASK [fetch-tox-output : Ensure local tox dir] 2026-04-14 03:06:33.691313 | debian-bookworm -> localhost | changed 2026-04-14 03:06:33.699983 | 2026-04-14 03:06:33.700098 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-04-14 03:06:33.835873 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:33.841010 | 2026-04-14 03:06:33.841117 | TASK [fetch-tox-output : Set envlist fact] 2026-04-14 03:06:33.995830 | debian-bookworm | ok 2026-04-14 03:06:34.015668 | 2026-04-14 03:06:34.015841 | TASK [fetch-tox-output : Get tox version] 2026-04-14 03:06:35.404974 | 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-04-14 03:06:35.425209 | debian-bookworm | 4.52.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-04-14 03:06:35.576637 | debian-bookworm | ok: Runtime: 0:00:00.385572 2026-04-14 03:06:35.581552 | 2026-04-14 03:06:35.581643 | TASK [fetch-tox-output : Find all default environments] 2026-04-14 03:06:36.149410 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:36.154608 | 2026-04-14 03:06:36.154738 | TASK [fetch-tox-output : Set envlist fact] 2026-04-14 03:06:36.198651 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:36.204237 | 2026-04-14 03:06:36.204331 | TASK [fetch-tox-output : Find all default environments] 2026-04-14 03:06:36.791178 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:36.796835 | 2026-04-14 03:06:36.796939 | TASK [fetch-tox-output : Set envlist fact] 2026-04-14 03:06:36.864486 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:36.870422 | 2026-04-14 03:06:36.870521 | LOOP [fetch-tox-output : Copy tox logs] 2026-04-14 03:06:36.932517 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:36.946048 | 2026-04-14 03:06:36.946157 | LOOP [fetch-tox-output : Collect tox logs] 2026-04-14 03:06:38.789974 | debian-bookworm | changed: 2026-04-14 03:06:38.790254 | debian-bookworm | created directory /var/lib/zuul/builds/baf762c8388a44568fc7a042b28a6438/work/logs/tox/check 2026-04-14 03:06:38.790287 | debian-bookworm | cd+++++++++ ./ 2026-04-14 03:06:38.790309 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-04-14 03:06:38.790335 | 2026-04-14 03:06:38.805651 | 2026-04-14 03:06:38.805760 | PLAY RECAP 2026-04-14 03:06:38.805806 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-04-14 03:06:38.805828 | 2026-04-14 03:06:39.396871 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-04-14 03:06:39.397704 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-04-14 03:06:41.386712 | 2026-04-14 03:06:41.386934 | PLAY [all] 2026-04-14 03:06:41.501643 | 2026-04-14 03:06:41.501827 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-04-14 03:06:41.918430 | debian-bookworm | changed: non-zero return code 2026-04-14 03:06:41.930452 | 2026-04-14 03:06:41.930600 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-04-14 03:06:41.993948 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:42.000806 | 2026-04-14 03:06:42.000925 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-04-14 03:06:42.059606 | 2026-04-14 03:06:42.059892 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-04-14 03:06:42.126226 | 2026-04-14 03:06:42.126419 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-04-14 03:06:42.199160 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:42.205288 | 2026-04-14 03:06:42.205403 | LOOP [fetch-subunit-output : Generate subunit file] 2026-04-14 03:06:42.254621 | 2026-04-14 03:06:42.254842 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-04-14 03:06:42.289633 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:42.295626 | 2026-04-14 03:06:42.295746 | TASK [fetch-subunit-output : Remove the temporary file] 2026-04-14 03:06:42.341166 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:42.347893 | 2026-04-14 03:06:42.347996 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-04-14 03:06:42.412009 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:06:42.427046 | 2026-04-14 03:06:42.427140 | PLAY RECAP 2026-04-14 03:06:42.427193 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-04-14 03:06:42.427228 | 2026-04-14 03:06:43.274716 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-04-14 03:06:43.275735 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-14 03:06:46.579147 | 2026-04-14 03:06:46.579277 | PLAY [Base post] 2026-04-14 03:06:46.627242 | 2026-04-14 03:06:46.627352 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-14 03:06:48.028614 | debian-bookworm | changed 2026-04-14 03:06:48.033543 | 2026-04-14 03:06:48.033617 | PLAY RECAP 2026-04-14 03:06:48.033665 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-14 03:06:48.033740 | 2026-04-14 03:06:48.375761 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-14 03:06:48.376758 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-14 03:06:50.822582 | 2026-04-14 03:06:50.822741 | PLAY [Base post-logs] 2026-04-14 03:06:50.867529 | 2026-04-14 03:06:50.867669 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-14 03:06:52.113763 | localhost | changed 2026-04-14 03:06:52.123185 | 2026-04-14 03:06:52.123302 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-14 03:06:52.176287 | localhost | ok 2026-04-14 03:06:52.179569 | 2026-04-14 03:06:52.179648 | TASK [Set zuul-log-path fact] 2026-04-14 03:06:52.194110 | localhost | ok 2026-04-14 03:06:52.227559 | 2026-04-14 03:06:52.228101 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-14 03:06:52.299641 | localhost | ok 2026-04-14 03:06:52.302812 | 2026-04-14 03:06:52.302908 | TASK [upload-logs : Create log directories] 2026-04-14 03:06:53.462568 | localhost | changed 2026-04-14 03:06:53.466669 | 2026-04-14 03:06:53.466765 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-14 03:06:54.218774 | localhost -> localhost | ok: Runtime: 0:00:00.004723 2026-04-14 03:06:54.223604 | 2026-04-14 03:06:54.223693 | TASK [upload-logs : Upload logs to log server] 2026-04-14 03:06:54.988862 | localhost | Output suppressed because no_log was given 2026-04-14 03:06:54.990559 | 2026-04-14 03:06:54.990652 | LOOP [upload-logs : Compress console log and json output] 2026-04-14 03:06:55.089419 | localhost | skipping: Conditional result was False 2026-04-14 03:06:55.103520 | localhost | skipping: Conditional result was False 2026-04-14 03:06:55.107847 | 2026-04-14 03:06:55.107969 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-14 03:06:55.249768 | localhost | skipping: Conditional result was False 2026-04-14 03:06:55.250085 | 2026-04-14 03:06:55.269750 | localhost | skipping: Conditional result was False 2026-04-14 03:06:55.274937 | 2026-04-14 03:06:55.275054 | LOOP [upload-logs : Upload console log and json output]