2026-07-25 03:05:20.273492 | Job console starting 2026-07-25 03:05:20.312992 | Updating git repos 2026-07-25 03:05:20.341107 | Cloning repos into workspace 2026-07-25 03:05:20.408200 | Restoring repo states 2026-07-25 03:05:20.431081 | Merging changes 2026-07-25 03:05:20.431112 | Checking out repos 2026-07-25 03:05:20.471131 | Preparing playbooks 2026-07-25 03:05:22.005449 | Running Ansible setup 2026-07-25 03:05:28.023885 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-25 03:05:28.921018 | 2026-07-25 03:05:28.921166 | PLAY [Base pre] 2026-07-25 03:05:28.943713 | 2026-07-25 03:05:28.943851 | TASK [Setup log path fact] 2026-07-25 03:05:28.972344 | debian-bookworm | ok 2026-07-25 03:05:29.002441 | 2026-07-25 03:05:29.002594 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-25 03:05:29.030777 | debian-bookworm | ok 2026-07-25 03:05:29.043244 | 2026-07-25 03:05:29.043375 | TASK [emit-job-header : Print job information] 2026-07-25 03:05:29.100524 | # Job Information 2026-07-25 03:05:29.100751 | Ansible Version: 2.16.14 2026-07-25 03:05:29.100795 | Job: generics-tox-check-kolla 2026-07-25 03:05:29.100833 | Pipeline: periodic-daily 2026-07-25 03:05:29.100861 | Executor: 521e9411259a 2026-07-25 03:05:29.100886 | Triggered by: https://github.com/osism/generics 2026-07-25 03:05:29.100911 | Event ID: c24678b72ba449e7b1b9395df6cd3800 2026-07-25 03:05:29.106913 | 2026-07-25 03:05:29.107027 | LOOP [emit-job-header : Print node information] 2026-07-25 03:05:29.312713 | debian-bookworm | ok: 2026-07-25 03:05:29.312877 | debian-bookworm | # Node Information 2026-07-25 03:05:29.312907 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-25 03:05:29.312928 | debian-bookworm | Hostname: debian 2026-07-25 03:05:29.312946 | debian-bookworm | Username: zuul 2026-07-25 03:05:29.312963 | debian-bookworm | Distro: Debian 12.15 2026-07-25 03:05:29.312983 | debian-bookworm | Provider: regiocloud-a 2026-07-25 03:05:29.313000 | debian-bookworm | Region: 2026-07-25 03:05:29.313018 | debian-bookworm | Label: debian-bookworm 2026-07-25 03:05:29.313035 | debian-bookworm | Product Name: OpenStack Nova 2026-07-25 03:05:29.313051 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7d:d263 2026-07-25 03:05:29.329493 | 2026-07-25 03:05:29.329626 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-25 03:05:30.284530 | debian-bookworm -> localhost | changed 2026-07-25 03:05:30.293052 | 2026-07-25 03:05:30.293190 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-25 03:05:32.092086 | debian-bookworm -> localhost | changed 2026-07-25 03:05:32.108822 | 2026-07-25 03:05:32.108956 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-25 03:05:32.999418 | debian-bookworm -> localhost | ok 2026-07-25 03:05:33.005321 | 2026-07-25 03:05:33.005415 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-25 03:05:33.055611 | debian-bookworm | ok 2026-07-25 03:05:33.089020 | debian-bookworm | included: /var/lib/zuul/builds/5d10917d794b4225b19578858bb87d2e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-25 03:05:33.103487 | 2026-07-25 03:05:33.103606 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-25 03:05:36.039945 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-25 03:05:36.040118 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5d10917d794b4225b19578858bb87d2e/work/5d10917d794b4225b19578858bb87d2e_id_rsa 2026-07-25 03:05:36.040149 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5d10917d794b4225b19578858bb87d2e/work/5d10917d794b4225b19578858bb87d2e_id_rsa.pub 2026-07-25 03:05:36.040170 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-25 03:05:36.040190 | debian-bookworm -> localhost | SHA256:uCC7IV2AqQz1ahRWSDs/hOxoEWCWZSjt/4FX0aj4F0Q zuul-build-sshkey 2026-07-25 03:05:36.040208 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-25 03:05:36.040236 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-25 03:05:36.040255 | debian-bookworm -> localhost | |o*O=. .Eo | 2026-07-25 03:05:36.040273 | debian-bookworm -> localhost | |+O== + . | 2026-07-25 03:05:36.040289 | debian-bookworm -> localhost | |=oB o. o . | 2026-07-25 03:05:36.040305 | debian-bookworm -> localhost | |++o*. ..o | 2026-07-25 03:05:36.040322 | debian-bookworm -> localhost | |oo=.=o..S. | 2026-07-25 03:05:36.040345 | debian-bookworm -> localhost | |.o +oo+.. | 2026-07-25 03:05:36.040362 | debian-bookworm -> localhost | |. + o.o | 2026-07-25 03:05:36.040378 | debian-bookworm -> localhost | | . o . | 2026-07-25 03:05:36.040394 | debian-bookworm -> localhost | | . | 2026-07-25 03:05:36.040411 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-25 03:05:36.040447 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.814636 2026-07-25 03:05:36.045734 | 2026-07-25 03:05:36.045819 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-25 03:05:36.083567 | debian-bookworm | ok 2026-07-25 03:05:36.101207 | debian-bookworm | included: /var/lib/zuul/builds/5d10917d794b4225b19578858bb87d2e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-25 03:05:36.125702 | 2026-07-25 03:05:36.125867 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-25 03:05:36.166203 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:05:36.173909 | 2026-07-25 03:05:36.174031 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-25 03:05:37.192383 | debian-bookworm | changed 2026-07-25 03:05:37.196797 | 2026-07-25 03:05:37.196912 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-25 03:05:37.490415 | debian-bookworm | ok 2026-07-25 03:05:37.495088 | 2026-07-25 03:05:37.495176 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-25 03:05:38.197394 | debian-bookworm | changed 2026-07-25 03:05:38.202053 | 2026-07-25 03:05:38.202130 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-25 03:05:38.828489 | debian-bookworm | changed 2026-07-25 03:05:38.836210 | 2026-07-25 03:05:38.836310 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-25 03:05:38.850059 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:05:38.856994 | 2026-07-25 03:05:38.857094 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-25 03:05:39.348818 | debian-bookworm -> localhost | changed 2026-07-25 03:05:39.362380 | 2026-07-25 03:05:39.362495 | TASK [add-build-sshkey : Add back temp key] 2026-07-25 03:05:39.746261 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5d10917d794b4225b19578858bb87d2e/work/5d10917d794b4225b19578858bb87d2e_id_rsa (zuul-build-sshkey) 2026-07-25 03:05:39.746469 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013469 2026-07-25 03:05:39.753984 | 2026-07-25 03:05:39.754085 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-25 03:05:40.354065 | debian-bookworm | ok 2026-07-25 03:05:40.359259 | 2026-07-25 03:05:40.359352 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-25 03:05:40.402518 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:05:40.412467 | 2026-07-25 03:05:40.412558 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-25 03:05:40.918879 | debian-bookworm | ok 2026-07-25 03:05:40.934862 | 2026-07-25 03:05:40.934977 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-25 03:05:40.972806 | debian-bookworm | ok 2026-07-25 03:05:40.980913 | 2026-07-25 03:05:40.981055 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-25 03:05:41.471010 | debian-bookworm -> localhost | ok 2026-07-25 03:05:41.477794 | 2026-07-25 03:05:41.477891 | TASK [validate-host : Collect information about the host] 2026-07-25 03:05:42.696353 | debian-bookworm | ok 2026-07-25 03:05:42.708224 | 2026-07-25 03:05:42.708331 | TASK [validate-host : Sanitize hostname] 2026-07-25 03:05:42.826704 | debian-bookworm | ok 2026-07-25 03:05:42.831441 | 2026-07-25 03:05:42.831526 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-25 03:05:43.347853 | debian-bookworm -> localhost | changed 2026-07-25 03:05:43.354373 | 2026-07-25 03:05:43.354497 | TASK [validate-host : Collect information about zuul worker] 2026-07-25 03:05:43.784612 | debian-bookworm | ok 2026-07-25 03:05:43.790110 | 2026-07-25 03:05:43.790201 | TASK [validate-host : Write out all zuul information for each host] 2026-07-25 03:05:44.545126 | debian-bookworm -> localhost | changed 2026-07-25 03:05:44.554465 | 2026-07-25 03:05:44.554560 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-25 03:05:44.870525 | debian-bookworm | ok 2026-07-25 03:05:44.875928 | 2026-07-25 03:05:44.876021 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-25 03:05:45.765087 | debian-bookworm | changed: 2026-07-25 03:05:45.765273 | debian-bookworm | cd+++++++++ src/ 2026-07-25 03:05:45.765306 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-25 03:05:45.765330 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-25 03:05:45.765352 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-07-25 03:05:45.765372 | debian-bookworm | =7.0.3 2026-07-25 03:06:24.354602 | debian-bookworm | Downloading cachetools-7.1.6-py3-none-any.whl (16 kB) 2026-07-25 03:06:24.410756 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-25 03:06:24.422737 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-25 03:06:24.489939 | debian-bookworm | Collecting filelock>=3.25 2026-07-25 03:06:24.500785 | debian-bookworm | Downloading filelock-3.32.0-py3-none-any.whl (97 kB) 2026-07-25 03:06:24.509842 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 97.7/97.7 kB 14.2 MB/s eta 0:00:00 2026-07-25 03:06:24.567168 | debian-bookworm | Collecting packaging>=26 2026-07-25 03:06:24.577817 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-25 03:06:24.587273 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 14.2 MB/s eta 0:00:00 2026-07-25 03:06:24.655042 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-25 03:06:24.665868 | debian-bookworm | Downloading platformdirs-4.11.0-py3-none-any.whl (23 kB) 2026-07-25 03:06:24.704511 | debian-bookworm | Collecting pluggy>=1.6 2026-07-25 03:06:24.717010 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-25 03:06:24.764663 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-25 03:06:24.775831 | debian-bookworm | Downloading pyproject_api-1.11.0-py3-none-any.whl (13 kB) 2026-07-25 03:06:24.808730 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-25 03:06:24.819267 | debian-bookworm | Downloading python_discovery-1.5.0-py3-none-any.whl (34 kB) 2026-07-25 03:06:24.849745 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-25 03:06:24.860131 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-25 03:06:25.008669 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-25 03:06:25.019820 | debian-bookworm | Downloading virtualenv-21.7.0-py3-none-any.whl (5.5 MB) 2026-07-25 03:06:25.156634 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 41.8 MB/s eta 0:00:00 2026-07-25 03:06:25.247037 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-25 03:06:25.257836 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-25 03:06:25.269721 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 52.1 MB/s eta 0:00:00 2026-07-25 03:06:25.366798 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-25 03:06:26.142141 | debian-bookworm | Successfully installed cachetools-7.1.6 colorama-0.4.6 distlib-0.4.3 filelock-3.32.0 packaging-26.2 platformdirs-4.11.0 pluggy-1.6.0 pyproject-api-1.11.0 python-discovery-1.5.0 tomli-w-1.2.0 tox-4.58.0 virtualenv-21.7.0 2026-07-25 03:06:26.714117 | debian-bookworm | ok: Runtime: 0:00:02.796016 2026-07-25 03:06:26.720276 | 2026-07-25 03:06:26.720385 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-25 03:06:26.780791 | debian-bookworm | ok 2026-07-25 03:06:26.792979 | 2026-07-25 03:06:26.793092 | TASK [ensure-tox : Output tox version] 2026-07-25 03:06:27.366333 | 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-07-25 03:06:27.383899 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-25 03:06:27.841555 | debian-bookworm | ok: Runtime: 0:00:00.339011 2026-07-25 03:06:27.847427 | 2026-07-25 03:06:27.847526 | TASK [ensure-tox : Make global symlink] 2026-07-25 03:06:27.901665 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:06:27.908169 | 2026-07-25 03:06:27.908252 | PLAY RECAP 2026-07-25 03:06:27.908306 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-25 03:06:27.908332 | 2026-07-25 03:06:28.075403 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-25 03:06:28.076395 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-25 03:06:29.485555 | 2026-07-25 03:06:29.485721 | PLAY [all] 2026-07-25 03:06:29.529069 | 2026-07-25 03:06:29.529204 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-25 03:06:30.161930 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-25 03:06:30.560056 | debian-bookworm | ok: Runtime: 0:00:00.032071 2026-07-25 03:06:30.565924 | 2026-07-25 03:06:30.566053 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-25 03:06:31.163070 | debian-bookworm | ok: Runtime: 0:00:00.006061 2026-07-25 03:06:31.184260 | 2026-07-25 03:06:31.184446 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-25 03:06:31.563128 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-25 03:06:31.564703 | debian-bookworm | sudo: a password is required 2026-07-25 03:06:31.748777 | debian-bookworm | ok: Runtime: 0:00:00.022213 2026-07-25 03:06:31.769321 | 2026-07-25 03:06:31.769452 | TASK [tox : Check to see if the constraints file exists] 2026-07-25 03:06:31.853634 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:06:31.873687 | 2026-07-25 03:06:31.874314 | TASK [tox : Fail if constraints file is missing] 2026-07-25 03:06:31.970514 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:06:31.985086 | 2026-07-25 03:06:31.985610 | TASK [tox : Record file location] 2026-07-25 03:06:32.061742 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:06:32.069065 | 2026-07-25 03:06:32.069206 | TASK [tox : Install tox siblings] 2026-07-25 03:06:32.130481 | debian-bookworm | ok 2026-07-25 03:06:32.145422 | debian-bookworm | included: /var/lib/zuul/builds/5d10917d794b4225b19578858bb87d2e/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-25 03:06:32.151928 | 2026-07-25 03:06:32.152054 | TASK [tox : Run tox without tests] 2026-07-25 03:06:32.847764 | debian-bookworm | ROOT: 220 D setup logging to DEBUG on pid 1592 [tox/report.py:229] 2026-07-25 03:06:32.887976 | debian-bookworm | check-kolla: 260 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-07-25 03:06:32.890838 | debian-bookworm | check-kolla: 263 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-07-25 03:06:32.895255 | debian-bookworm | check-kolla: 267 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/python_discovery/_py_info.py db8d608f81b156a12517dc511176236c 2580aa1ef1127a5c3bb5c88451dd853e [python_discovery/_cached_py_info.py:198] 2026-07-25 03:06:32.977711 | debian-bookworm | check-kolla: 349 D wrote python info of /usr/bin/python3.11 at /home/zuul/.cache/virtualenv/py_info/5/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:159] 2026-07-25 03:06:32.978421 | debian-bookworm | check-kolla: 350 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-07-25 03:06:32.978751 | debian-bookworm | check-kolla: 351 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, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:140] 2026-07-25 03:06:32.979143 | debian-bookworm | check-kolla: 351 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, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:144] 2026-07-25 03:06:32.983116 | debian-bookworm | check-kolla: 355 D symlink on filesystem does work [virtualenv/info.py:51] 2026-07-25 03:06:32.983412 | debian-bookworm | check-kolla: 355 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-07-25 03:06:33.019780 | debian-bookworm | check-kolla: 392 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/generics/.tox/check-kolla, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:77] 2026-07-25 03:06:33.020118 | debian-bookworm | check-kolla: 392 D create folder /home/zuul/src/github.com/osism/generics/.tox/check-kolla/bin [virtualenv/util/path/_sync.py:18] 2026-07-25 03:06:33.020276 | debian-bookworm | check-kolla: 392 D create folder /home/zuul/src/github.com/osism/generics/.tox/check-kolla/include [virtualenv/util/path/_sync.py:18] 2026-07-25 03:06:33.020364 | debian-bookworm | check-kolla: 392 D create folder /home/zuul/src/github.com/osism/generics/.tox/check-kolla/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:18] 2026-07-25 03:06:33.020579 | debian-bookworm | check-kolla: 393 D write /home/zuul/src/github.com/osism/generics/.tox/check-kolla/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-07-25 03:06:33.020662 | debian-bookworm | check-kolla: 393 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.020723 | debian-bookworm | check-kolla: 393 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.020779 | debian-bookworm | check-kolla: 393 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.020850 | debian-bookworm | check-kolla: 393 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.020901 | debian-bookworm | check-kolla: 393 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.020958 | debian-bookworm | check-kolla: 393 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/check-kolla [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.021009 | debian-bookworm | check-kolla: 393 D virtualenv = 21.7.0 [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.021064 | debian-bookworm | check-kolla: 393 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.021113 | debian-bookworm | check-kolla: 393 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.021164 | debian-bookworm | check-kolla: 393 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.021216 | debian-bookworm | check-kolla: 393 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.021514 | debian-bookworm | check-kolla: 393 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/generics/.tox/check-kolla/bin/python [virtualenv/util/path/_sync.py:38] 2026-07-25 03:06:33.022048 | debian-bookworm | check-kolla: 394 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-07-25 03:06:33.022300 | debian-bookworm | check-kolla: 394 D debug via /home/zuul/src/github.com/osism/generics/.tox/check-kolla/bin/python /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:265] 2026-07-25 03:06:33.062074 | debian-bookworm | check-kolla: 394 D { 2026-07-25 03:06:33.062113 | debian-bookworm | "sys": { 2026-07-25 03:06:33.062120 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/check-kolla/bin/python", 2026-07-25 03:06:33.062125 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-07-25 03:06:33.062132 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/check-kolla", 2026-07-25 03:06:33.062138 | debian-bookworm | "base_prefix": "/usr", 2026-07-25 03:06:33.062142 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/check-kolla", 2026-07-25 03:06:33.062147 | debian-bookworm | "base_exec_prefix": "/usr", 2026-07-25 03:06:33.062151 | debian-bookworm | "path": [ 2026-07-25 03:06:33.062154 | debian-bookworm | "/usr/lib/python311.zip", 2026-07-25 03:06:33.062158 | debian-bookworm | "/usr/lib/python3.11", 2026-07-25 03:06:33.062162 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-07-25 03:06:33.062166 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/check-kolla/lib/python3.11/site-packages" 2026-07-25 03:06:33.062171 | debian-bookworm | ], 2026-07-25 03:06:33.062175 | debian-bookworm | "meta_path": [ 2026-07-25 03:06:33.062179 | debian-bookworm | "", 2026-07-25 03:06:33.062183 | debian-bookworm | "", 2026-07-25 03:06:33.062187 | debian-bookworm | "" 2026-07-25 03:06:33.062191 | debian-bookworm | ], 2026-07-25 03:06:33.062194 | debian-bookworm | "fs_encoding": "utf-8", 2026-07-25 03:06:33.062198 | debian-bookworm | "io_encoding": "utf-8" 2026-07-25 03:06:33.062202 | debian-bookworm | }, 2026-07-25 03:06:33.062206 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-07-25 03:06:33.062210 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-07-25 03:06:33.062214 | debian-bookworm | "os": "", 2026-07-25 03:06:33.062218 | debian-bookworm | "site": "", 2026-07-25 03:06:33.062222 | debian-bookworm | "datetime": "", 2026-07-25 03:06:33.062232 | debian-bookworm | "math": "", 2026-07-25 03:06:33.062236 | debian-bookworm | "json": "" 2026-07-25 03:06:33.062240 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-07-25 03:06:33.062767 | debian-bookworm | check-kolla: 434 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-07-25 03:06:33.073110 | debian-bookworm | check-kolla: 445 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-26.1.2-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-07-25 03:06:33.074365 | debian-bookworm | check-kolla: 446 D build install image for pip-26.1.2-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1.2-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-07-25 03:06:33.080049 | debian-bookworm | check-kolla: 452 D install setuptools from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/setuptools-83.0.0-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-07-25 03:06:33.082702 | debian-bookworm | check-kolla: 455 D build install image for setuptools-83.0.0-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-83.0.0-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-07-25 03:06:33.499300 | debian-bookworm | check-kolla: 871 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-83.0.0-py3-none-any/setuptools to /home/zuul/src/github.com/osism/generics/.tox/check-kolla/lib/python3.11/site-packages/setuptools [virtualenv/util/path/_sync.py:46] 2026-07-25 03:06:33.580333 | debian-bookworm | check-kolla: 952 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1.2-py3-none-any/pip-26.1.2.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check-kolla/lib/python3.11/site-packages/pip-26.1.2.virtualenv [virtualenv/util/path/_sync.py:46] 2026-07-25 03:06:33.581133 | debian-bookworm | check-kolla: 953 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1.2-py3-none-any/pip to /home/zuul/src/github.com/osism/generics/.tox/check-kolla/lib/python3.11/site-packages/pip [virtualenv/util/path/_sync.py:46] 2026-07-25 03:06:33.679227 | debian-bookworm | check-kolla: 1051 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-83.0.0-py3-none-any/distutils-precedence.pth to /home/zuul/src/github.com/osism/generics/.tox/check-kolla/lib/python3.11/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:46] 2026-07-25 03:06:33.680150 | debian-bookworm | check-kolla: 1052 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-83.0.0-py3-none-any/_distutils_hack to /home/zuul/src/github.com/osism/generics/.tox/check-kolla/lib/python3.11/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:46] 2026-07-25 03:06:33.681251 | debian-bookworm | check-kolla: 1053 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-83.0.0-py3-none-any/setuptools-83.0.0.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/check-kolla/lib/python3.11/site-packages/setuptools-83.0.0.virtualenv [virtualenv/util/path/_sync.py:46] 2026-07-25 03:06:33.681833 | debian-bookworm | check-kolla: 1054 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-83.0.0-py3-none-any/setuptools-83.0.0.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check-kolla/lib/python3.11/site-packages/setuptools-83.0.0.dist-info [virtualenv/util/path/_sync.py:46] 2026-07-25 03:06:33.685601 | debian-bookworm | check-kolla: 1058 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-07-25 03:06:33.702963 | debian-bookworm | check-kolla: 1075 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.1.2-py3-none-any/pip-26.1.2.dist-info to /home/zuul/src/github.com/osism/generics/.tox/check-kolla/lib/python3.11/site-packages/pip-26.1.2.dist-info [virtualenv/util/path/_sync.py:46] 2026-07-25 03:06:33.707476 | debian-bookworm | check-kolla: 1079 D generated console scripts pip3 pip pip3.11 pip-3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-07-25 03:06:33.707953 | debian-bookworm | check-kolla: 1080 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-07-25 03:06:33.718036 | debian-bookworm | check-kolla: 1090 D write /home/zuul/src/github.com/osism/generics/.tox/check-kolla/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:41] 2026-07-25 03:06:33.718203 | debian-bookworm | check-kolla: 1090 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.718348 | debian-bookworm | check-kolla: 1090 D implementation = CPython [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.718477 | debian-bookworm | check-kolla: 1090 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.718605 | debian-bookworm | check-kolla: 1091 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.718737 | debian-bookworm | check-kolla: 1091 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.718872 | debian-bookworm | check-kolla: 1091 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/check-kolla [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.719149 | debian-bookworm | check-kolla: 1091 D virtualenv = 21.7.0 [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.719157 | debian-bookworm | check-kolla: 1091 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.719261 | debian-bookworm | check-kolla: 1091 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.719386 | debian-bookworm | check-kolla: 1091 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.719504 | debian-bookworm | check-kolla: 1092 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:51] 2026-07-25 03:06:33.727097 | debian-bookworm | check-kolla: 1099 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:485] 2026-07-25 03:06:34.946760 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2026-07-25 03:06:35.062251 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2026-07-25 03:06:35.179515 | debian-bookworm | Collecting PyYAML==6.0.3 (from -r requirements.txt (line 2)) 2026-07-25 03:06:35.190785 | 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-07-25 03:06:35.266556 | debian-bookworm | Collecting ansible==12.3.0 (from -r requirements.txt (line 3)) 2026-07-25 03:06:35.278287 | debian-bookworm | Downloading ansible-12.3.0-py3-none-any.whl.metadata (8.1 kB) 2026-07-25 03:06:35.325543 | debian-bookworm | Collecting packaging==26.2 (from -r requirements.txt (line 4)) 2026-07-25 03:06:35.337372 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl.metadata (3.5 kB) 2026-07-25 03:06:35.373981 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2026-07-25 03:06:35.386651 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2026-07-25 03:06:35.400801 | debian-bookworm | Installing build dependencies: started 2026-07-25 03:06:36.656336 | debian-bookworm | Installing build dependencies: finished with status 'done' 2026-07-25 03:06:36.657511 | debian-bookworm | Getting requirements to build wheel: started 2026-07-25 03:06:37.070623 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2026-07-25 03:06:37.070969 | debian-bookworm | Preparing metadata (pyproject.toml): started 2026-07-25 03:06:37.291157 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2026-07-25 03:06:37.319895 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2026-07-25 03:06:37.332443 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2026-07-25 03:06:37.378053 | debian-bookworm | Collecting requests==2.34.2 (from -r requirements.txt (line 7)) 2026-07-25 03:06:37.388603 | debian-bookworm | Downloading requests-2.34.2-py3-none-any.whl.metadata (4.8 kB) 2026-07-25 03:06:37.422170 | debian-bookworm | Collecting tabulate==0.10.0 (from -r requirements.txt (line 8)) 2026-07-25 03:06:37.433958 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl.metadata (40 kB) 2026-07-25 03:06:37.543529 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2026-07-25 03:06:37.554412 | 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-07-25 03:06:37.638271 | debian-bookworm | Collecting ansible-core~=2.19.5 (from ansible==12.3.0->-r requirements.txt (line 3)) 2026-07-25 03:06:37.651242 | debian-bookworm | Downloading ansible_core-2.19.11-py3-none-any.whl.metadata (7.7 kB) 2026-07-25 03:06:37.696195 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-07-25 03:06:37.706864 | debian-bookworm | Downloading click-8.4.2-py3-none-any.whl.metadata (2.6 kB) 2026-07-25 03:06:37.748008 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-07-25 03:06:37.759708 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-07-25 03:06:37.815519 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-07-25 03:06:37.828969 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2026-07-25 03:06:37.889465 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2026-07-25 03:06:37.901436 | debian-bookworm | Downloading sh-2.3.0-py3-none-any.whl.metadata (3.8 kB) 2026-07-25 03:06:38.066156 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-07-25 03:06:38.077130 | debian-bookworm | Downloading charset_normalizer-3.4.9-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (41 kB) 2026-07-25 03:06:38.132112 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-07-25 03:06:38.143893 | debian-bookworm | Downloading idna-3.18-py3-none-any.whl.metadata (6.1 kB) 2026-07-25 03:06:38.208013 | debian-bookworm | Collecting urllib3<3,>=1.26 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-07-25 03:06:38.219101 | debian-bookworm | Downloading urllib3-2.7.0-py3-none-any.whl.metadata (6.9 kB) 2026-07-25 03:06:38.274819 | debian-bookworm | Collecting certifi>=2023.5.7 (from requests==2.34.2->-r requirements.txt (line 7)) 2026-07-25 03:06:38.286289 | debian-bookworm | Downloading certifi-2026.7.22-py3-none-any.whl.metadata (2.5 kB) 2026-07-25 03:06:38.584208 | debian-bookworm | Collecting cryptography (from ansible-core~=2.19.5->ansible==12.3.0->-r requirements.txt (line 3)) 2026-07-25 03:06:38.595079 | debian-bookworm | Downloading cryptography-49.0.0-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (4.3 kB) 2026-07-25 03:06:38.634049 | debian-bookworm | Collecting resolvelib<2.0.0,>=0.5.3 (from ansible-core~=2.19.5->ansible==12.3.0->-r requirements.txt (line 3)) 2026-07-25 03:06:38.645386 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl.metadata (3.7 kB) 2026-07-25 03:06:38.806803 | debian-bookworm | Collecting cffi>=2.0.0 (from cryptography->ansible-core~=2.19.5->ansible==12.3.0->-r requirements.txt (line 3)) 2026-07-25 03:06:38.817765 | debian-bookworm | Downloading cffi-2.1.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.5 kB) 2026-07-25 03:06:38.857844 | debian-bookworm | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core~=2.19.5->ansible==12.3.0->-r requirements.txt (line 3)) 2026-07-25 03:06:38.868400 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl.metadata (8.2 kB) 2026-07-25 03:06:38.889111 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-07-25 03:06:38.917875 | 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-07-25 03:06:38.958532 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 22.4 MB/s 0:00:00 2026-07-25 03:06:38.972229 | debian-bookworm | Downloading ansible-12.3.0-py3-none-any.whl (54.4 MB) 2026-07-25 03:06:40.019316 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.4/54.4 MB 51.9 MB/s 0:00:01 2026-07-25 03:06:40.030335 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-25 03:06:40.051329 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2026-07-25 03:06:40.070023 | debian-bookworm | Downloading requests-2.34.2-py3-none-any.whl (73 kB) 2026-07-25 03:06:40.090829 | debian-bookworm | Downloading tabulate-0.10.0-py3-none-any.whl (39 kB) 2026-07-25 03:06:40.115139 | debian-bookworm | Downloading ansible_core-2.19.11-py3-none-any.whl (2.4 MB) 2026-07-25 03:06:40.262485 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 15.5 MB/s 0:00:00 2026-07-25 03:06:40.276746 | debian-bookworm | Downloading charset_normalizer-3.4.9-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (221 kB) 2026-07-25 03:06:40.303310 | debian-bookworm | Downloading idna-3.18-py3-none-any.whl (65 kB) 2026-07-25 03:06:40.333066 | debian-bookworm | Downloading resolvelib-1.2.1-py3-none-any.whl (18 kB) 2026-07-25 03:06:40.356335 | debian-bookworm | Downloading urllib3-2.7.0-py3-none-any.whl (131 kB) 2026-07-25 03:06:40.383099 | debian-bookworm | Downloading certifi-2026.7.22-py3-none-any.whl (136 kB) 2026-07-25 03:06:40.406901 | 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-07-25 03:06:40.430312 | debian-bookworm | Downloading click-8.4.2-py3-none-any.whl (119 kB) 2026-07-25 03:06:40.455404 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-25 03:06:40.477844 | debian-bookworm | Downloading cryptography-49.0.0-cp311-abi3-manylinux_2_34_x86_64.whl (4.7 MB) 2026-07-25 03:06:40.635501 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.7/4.7 MB 30.4 MB/s 0:00:00 2026-07-25 03:06:40.646790 | debian-bookworm | Downloading cffi-2.1.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (217 kB) 2026-07-25 03:06:40.675795 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2026-07-25 03:06:40.701382 | debian-bookworm | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-07-25 03:06:40.724917 | debian-bookworm | Downloading sh-2.3.0-py3-none-any.whl (48 kB) 2026-07-25 03:06:40.983569 | debian-bookworm | Building wheels for collected packages: pwgen 2026-07-25 03:06:40.984417 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2026-07-25 03:06:41.286713 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2026-07-25 03:06:41.287301 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3796 sha256=f534601e64b378427349fc9e160b289f33f2bdbd843cbd75838d82fcf64d1afb 2026-07-25 03:06:41.287883 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2026-07-25 03:06:41.289644 | debian-bookworm | Successfully built pwgen 2026-07-25 03:06:41.489810 | debian-bookworm | Installing collected packages: pwgen, urllib3, tabulate, sh, resolvelib, PyYAML, pycparser, packaging, MarkupSafe, idna, fasteners, colorama, click, charset_normalizer, certifi, requests, python-gilt, Jinja2, cffi, cryptography, ansible-core, ansible 2026-07-25 03:07:04.522475 | debian-bookworm | 2026-07-25 03:07:04.525120 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-12.3.0 ansible-core-2.19.11 certifi-2026.7.22 cffi-2.1.0 charset_normalizer-3.4.9 click-8.4.2 colorama-0.4.6 cryptography-49.0.0 fasteners-0.20 idna-3.18 packaging-26.2 pwgen-0.8.2.post0 pycparser-3.0 python-gilt-1.2.3 requests-2.34.2 resolvelib-1.2.1 sh-2.3.0 tabulate-0.10.0 urllib3-2.7.0 2026-07-25 03:07:04.621206 | debian-bookworm | check-kolla: 31993 I exit 0 (30.89 seconds) /home/zuul/src/github.com/osism/generics> python -I -m pip install -r requirements.txt pid=1605 [tox/execute/api.py:308] 2026-07-25 03:07:04.623516 | debian-bookworm | check-kolla: OK (31.74 seconds) 2026-07-25 03:07:04.623560 | debian-bookworm | congratulations :) (31.78 seconds) 2026-07-25 03:07:04.739886 | debian-bookworm | ok: Runtime: 0:00:32.081153 2026-07-25 03:07:04.746093 | 2026-07-25 03:07:04.746176 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-25 03:07:05.259262 | debian-bookworm | changed 2026-07-25 03:07:05.263966 | 2026-07-25 03:07:05.264045 | TASK [tox : Detect tox version] 2026-07-25 03:07:05.830525 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-25 03:07:06.311815 | debian-bookworm | ok: Runtime: 0:00:00.313274 2026-07-25 03:07:06.316372 | 2026-07-25 03:07:06.316451 | TASK [tox : Get tox envlist config] 2026-07-25 03:07:07.363552 | debian-bookworm | ok: Runtime: 0:00:00.324174 2026-07-25 03:07:07.381496 | 2026-07-25 03:07:07.381612 | TASK [tox : Install any sibling python packages] 2026-07-25 03:07:07.855720 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-25 03:07:07.861214 | 2026-07-25 03:07:07.861310 | TASK [tox : Remove tempfile] 2026-07-25 03:07:08.371078 | debian-bookworm | changed 2026-07-25 03:07:08.379053 | 2026-07-25 03:07:08.379143 | TASK [tox : Emit tox command] 2026-07-25 03:07:08.412441 | /home/zuul/.local/tox/bin/tox -echeck-kolla -vv --skip-missing-interpreters=false 2026-07-25 03:07:08.416652 | 2026-07-25 03:07:08.416734 | TASK [tox : Run tox] 2026-07-25 03:07:08.980161 | debian-bookworm | ROOT: 213 D setup logging to DEBUG on pid 1768 [tox/report.py:229] 2026-07-25 03:07:09.010391 | debian-bookworm | check-kolla: 243 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-07-25 03:07:09.012946 | debian-bookworm | check-kolla: 246 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-07-25 03:07:09.016602 | debian-bookworm | check-kolla: 249 D got python info of /usr/bin/python3.11 from /home/zuul/.cache/virtualenv/py_info/5/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:139] 2026-07-25 03:07:09.017388 | debian-bookworm | check-kolla: 250 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-07-25 03:07:09.017530 | debian-bookworm | check-kolla: 250 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, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:140] 2026-07-25 03:07:09.017587 | debian-bookworm | check-kolla: 251 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, May 12 2026, 05:17:27) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [python_discovery/_discovery.py:144] 2026-07-25 03:07:09.019325 | debian-bookworm | check-kolla: 252 D symlink on filesystem does work [virtualenv/info.py:51] 2026-07-25 03:07:09.019484 | debian-bookworm | check-kolla: 252 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-07-25 03:07:09.051703 | debian-bookworm | check-kolla: 285 W commands[0]> python3 src/check-kolla-inventory.py [tox/tox_env/api.py:485] 2026-07-25 03:07:09.532553 | debian-bookworm | check-kolla: 765 I exit 0 (0.48 seconds) /home/zuul/src/github.com/osism/generics> python3 src/check-kolla-inventory.py pid=1775 [tox/execute/api.py:308] 2026-07-25 03:07:09.534837 | debian-bookworm | check-kolla: OK (0.53=setup[0.05]+cmd[0.48] seconds) 2026-07-25 03:07:09.534869 | debian-bookworm | congratulations :) (0.56 seconds) 2026-07-25 03:07:09.969472 | debian-bookworm | ok: Runtime: 0:00:00.876171 2026-07-25 03:07:09.975301 | 2026-07-25 03:07:09.975401 | TASK [tox : Look for output] 2026-07-25 03:07:10.405285 | debian-bookworm | ok 2026-07-25 03:07:10.416630 | 2026-07-25 03:07:10.416774 | TASK [tox : Return file comments to Zuul] 2026-07-25 03:07:10.439970 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:10.445574 | 2026-07-25 03:07:10.445636 | PLAY RECAP 2026-07-25 03:07:10.445679 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-25 03:07:10.445699 | 2026-07-25 03:07:10.549991 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-25 03:07:10.551086 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-25 03:07:11.193482 | 2026-07-25 03:07:11.193644 | PLAY [all] 2026-07-25 03:07:11.209331 | 2026-07-25 03:07:11.209435 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-25 03:07:11.242645 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:11.247183 | 2026-07-25 03:07:11.247280 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-25 03:07:11.273828 | debian-bookworm | ok 2026-07-25 03:07:11.277881 | 2026-07-25 03:07:11.277956 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-25 03:07:11.750568 | debian-bookworm -> localhost | changed 2026-07-25 03:07:11.770082 | 2026-07-25 03:07:11.770215 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-25 03:07:11.816761 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:11.826467 | 2026-07-25 03:07:11.826671 | TASK [fetch-tox-output : Set envlist fact] 2026-07-25 03:07:11.876262 | debian-bookworm | ok 2026-07-25 03:07:11.882490 | 2026-07-25 03:07:11.882602 | TASK [fetch-tox-output : Get tox version] 2026-07-25 03:07:12.579313 | 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-07-25 03:07:12.596629 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-25 03:07:12.912093 | debian-bookworm | ok: Runtime: 0:00:00.328884 2026-07-25 03:07:12.917934 | 2026-07-25 03:07:12.918043 | TASK [fetch-tox-output : Find all default environments] 2026-07-25 03:07:13.471264 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:13.480619 | 2026-07-25 03:07:13.480757 | TASK [fetch-tox-output : Set envlist fact] 2026-07-25 03:07:13.516910 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:13.537031 | 2026-07-25 03:07:13.537260 | TASK [fetch-tox-output : Find all default environments] 2026-07-25 03:07:14.073647 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:14.078657 | 2026-07-25 03:07:14.078741 | TASK [fetch-tox-output : Set envlist fact] 2026-07-25 03:07:14.101417 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:14.107148 | 2026-07-25 03:07:14.107230 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-25 03:07:14.157826 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:14.165453 | 2026-07-25 03:07:14.165582 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-25 03:07:14.951525 | debian-bookworm | changed: 2026-07-25 03:07:14.951706 | debian-bookworm | created directory /var/lib/zuul/builds/5d10917d794b4225b19578858bb87d2e/work/logs/tox/check-kolla 2026-07-25 03:07:14.951741 | debian-bookworm | cd+++++++++ ./ 2026-07-25 03:07:14.951766 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-25 03:07:14.951843 | 2026-07-25 03:07:14.959667 | 2026-07-25 03:07:14.959756 | PLAY RECAP 2026-07-25 03:07:14.959813 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-25 03:07:14.959839 | 2026-07-25 03:07:15.061419 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-25 03:07:15.064185 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-25 03:07:15.869294 | 2026-07-25 03:07:15.869443 | PLAY [all] 2026-07-25 03:07:15.887406 | 2026-07-25 03:07:15.887554 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-25 03:07:16.169709 | debian-bookworm | changed: non-zero return code 2026-07-25 03:07:16.175273 | 2026-07-25 03:07:16.175389 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-25 03:07:16.198735 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:16.204464 | 2026-07-25 03:07:16.204592 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-25 03:07:16.224301 | 2026-07-25 03:07:16.224541 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-25 03:07:16.255938 | 2026-07-25 03:07:16.256111 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-25 03:07:16.279184 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:16.285259 | 2026-07-25 03:07:16.285372 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-25 03:07:16.314915 | 2026-07-25 03:07:16.315199 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-25 03:07:16.352073 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:16.357812 | 2026-07-25 03:07:16.357956 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-25 03:07:16.371814 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:16.377779 | 2026-07-25 03:07:16.377883 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-25 03:07:16.391274 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:16.399246 | 2026-07-25 03:07:16.399324 | PLAY RECAP 2026-07-25 03:07:16.399380 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-25 03:07:16.399404 | 2026-07-25 03:07:16.562546 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-25 03:07:16.563545 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-25 03:07:18.348954 | 2026-07-25 03:07:18.349254 | PLAY [Base post-fetch] 2026-07-25 03:07:18.402363 | 2026-07-25 03:07:18.404887 | TASK [diagnose-network : Ensure log directory exists] 2026-07-25 03:07:18.962351 | debian-bookworm | ok 2026-07-25 03:07:19.006770 | 2026-07-25 03:07:19.007050 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-25 03:07:31.470804 | debian-bookworm | ok: Runtime: 0:00:05.845121 2026-07-25 03:07:31.482198 | 2026-07-25 03:07:31.482346 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-25 03:07:37.687850 | debian-bookworm | ok: Runtime: 0:00:00.009505 2026-07-25 03:07:37.710450 | 2026-07-25 03:07:37.710719 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-25 03:07:44.128093 | debian-bookworm | ok: Runtime: 0:00:00.009051 2026-07-25 03:07:44.137771 | 2026-07-25 03:07:44.137867 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-25 03:07:44.204805 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:44.209888 | 2026-07-25 03:07:44.209986 | TASK [fetch-output : Set log path for single node] 2026-07-25 03:07:44.248891 | debian-bookworm | ok 2026-07-25 03:07:44.253884 | 2026-07-25 03:07:44.253976 | LOOP [fetch-output : Ensure local output dirs] 2026-07-25 03:07:44.571179 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/5d10917d794b4225b19578858bb87d2e/work/logs" 2026-07-25 03:07:44.888136 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5d10917d794b4225b19578858bb87d2e/work/artifacts" 2026-07-25 03:07:45.556304 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5d10917d794b4225b19578858bb87d2e/work/docs" 2026-07-25 03:07:45.569148 | 2026-07-25 03:07:45.569245 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-25 03:07:46.852115 | debian-bookworm | changed: 2026-07-25 03:07:46.853557 | debian-bookworm | .d..t...... ./ 2026-07-25 03:07:46.853622 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-25 03:07:46.853648 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-25 03:07:46.853670 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-25 03:07:46.853694 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-25 03:07:46.853715 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-25 03:07:46.853758 | debian-bookworm | changed: All items complete 2026-07-25 03:07:46.853786 | 2026-07-25 03:07:47.342671 | debian-bookworm | changed: .d..t...... ./ 2026-07-25 03:07:47.878783 | debian-bookworm | changed: .d..t...... ./ 2026-07-25 03:07:47.901109 | 2026-07-25 03:07:47.901235 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-25 03:07:47.950402 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:47.959597 | debian-bookworm | skipping: Conditional result was False 2026-07-25 03:07:47.979026 | 2026-07-25 03:07:47.979133 | PLAY RECAP 2026-07-25 03:07:47.979189 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-25 03:07:47.979214 | 2026-07-25 03:07:48.158007 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-25 03:07:48.159061 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-25 03:07:49.335602 | 2026-07-25 03:07:49.335748 | PLAY [Base post] 2026-07-25 03:07:49.365328 | 2026-07-25 03:07:49.365493 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-25 03:07:50.196154 | debian-bookworm | changed 2026-07-25 03:07:50.205513 | 2026-07-25 03:07:50.205650 | PLAY RECAP 2026-07-25 03:07:50.205727 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-25 03:07:50.205798 | 2026-07-25 03:07:50.409763 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-25 03:07:50.410765 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-25 03:07:51.542161 | 2026-07-25 03:07:51.542301 | PLAY [Base post-logs] 2026-07-25 03:07:51.552392 | 2026-07-25 03:07:51.552545 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-25 03:07:52.140851 | localhost | changed 2026-07-25 03:07:52.179148 | 2026-07-25 03:07:52.179894 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-25 03:07:52.251534 | localhost | ok 2026-07-25 03:07:52.257690 | 2026-07-25 03:07:52.257779 | TASK [Set zuul-log-path fact] 2026-07-25 03:07:52.276779 | localhost | ok 2026-07-25 03:07:52.286181 | 2026-07-25 03:07:52.286291 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-25 03:07:52.312599 | localhost | ok 2026-07-25 03:07:52.316941 | 2026-07-25 03:07:52.317383 | TASK [upload-logs : Create log directories] 2026-07-25 03:07:52.987401 | localhost | changed 2026-07-25 03:07:52.989927 | 2026-07-25 03:07:52.990013 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-25 03:07:53.492514 | localhost -> localhost | ok: Runtime: 0:00:00.003722 2026-07-25 03:07:53.496139 | 2026-07-25 03:07:53.496236 | TASK [upload-logs : Upload logs to log server] 2026-07-25 03:07:53.991663 | localhost | Output suppressed because no_log was given 2026-07-25 03:07:53.993258 | 2026-07-25 03:07:53.993342 | LOOP [upload-logs : Compress console log and json output] 2026-07-25 03:07:54.041673 | localhost | skipping: Conditional result was False 2026-07-25 03:07:54.047985 | localhost | skipping: Conditional result was False 2026-07-25 03:07:54.058856 | 2026-07-25 03:07:54.058949 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-25 03:07:54.101818 | localhost | skipping: Conditional result was False 2026-07-25 03:07:54.102079 | 2026-07-25 03:07:54.107246 | localhost | skipping: Conditional result was False 2026-07-25 03:07:54.114812 | 2026-07-25 03:07:54.115075 | LOOP [upload-logs : Upload console log and json output]