2025-08-20 03:16:55.777018 | Job console starting 2025-08-20 03:16:55.800492 | Updating git repos 2025-08-20 03:16:55.842167 | Cloning repos into workspace 2025-08-20 03:16:55.893222 | Restoring repo states 2025-08-20 03:16:55.909393 | Merging changes 2025-08-20 03:16:55.909414 | Checking out repos 2025-08-20 03:16:55.970127 | Preparing playbooks 2025-08-20 03:16:56.863110 | Running Ansible setup 2025-08-20 03:17:01.811377 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-20 03:17:02.669218 | 2025-08-20 03:17:02.669348 | PLAY [Base pre] 2025-08-20 03:17:02.692942 | 2025-08-20 03:17:02.693068 | TASK [Setup log path fact] 2025-08-20 03:17:02.722316 | debian-bookworm | ok 2025-08-20 03:17:02.736927 | 2025-08-20 03:17:02.737045 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-20 03:17:02.766047 | debian-bookworm | ok 2025-08-20 03:17:02.776459 | 2025-08-20 03:17:02.776572 | TASK [emit-job-header : Print job information] 2025-08-20 03:17:02.804465 | # Job Information 2025-08-20 03:17:02.804690 | Ansible Version: 2.16.14 2025-08-20 03:17:02.804728 | Job: cfg-generics-tox-check 2025-08-20 03:17:02.804762 | Pipeline: periodic-daily 2025-08-20 03:17:02.804786 | Executor: 521e9411259a 2025-08-20 03:17:02.804806 | Triggered by: https://github.com/osism/cfg-generics 2025-08-20 03:17:02.804831 | Event ID: 9d22db0034bd435580c9b7a43164fa17 2025-08-20 03:17:02.810968 | 2025-08-20 03:17:02.811079 | LOOP [emit-job-header : Print node information] 2025-08-20 03:17:02.927817 | debian-bookworm | ok: 2025-08-20 03:17:02.928041 | debian-bookworm | # Node Information 2025-08-20 03:17:02.928078 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-20 03:17:02.928103 | debian-bookworm | Hostname: debian 2025-08-20 03:17:02.928126 | debian-bookworm | Username: zuul 2025-08-20 03:17:02.928147 | debian-bookworm | Distro: Debian 12.11 2025-08-20 03:17:02.928171 | debian-bookworm | Provider: regiocloud-a 2025-08-20 03:17:02.928193 | debian-bookworm | Region: 2025-08-20 03:17:02.928215 | debian-bookworm | Label: debian-bookworm 2025-08-20 03:17:02.928235 | debian-bookworm | Product Name: OpenStack Nova 2025-08-20 03:17:02.928254 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec5:186e 2025-08-20 03:17:02.948286 | 2025-08-20 03:17:02.948393 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-20 03:17:03.829921 | debian-bookworm -> localhost | changed 2025-08-20 03:17:03.836509 | 2025-08-20 03:17:03.836613 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-20 03:17:05.854539 | debian-bookworm -> localhost | changed 2025-08-20 03:17:05.877872 | 2025-08-20 03:17:05.877965 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-20 03:17:06.207350 | debian-bookworm -> localhost | ok 2025-08-20 03:17:06.212193 | 2025-08-20 03:17:06.212282 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-20 03:17:06.238681 | debian-bookworm | ok 2025-08-20 03:17:06.258085 | debian-bookworm | included: /var/lib/zuul/builds/e6ddf13681e5466595418d9be655edc5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-20 03:17:06.270882 | 2025-08-20 03:17:06.270972 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-20 03:17:08.897210 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-20 03:17:08.897366 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e6ddf13681e5466595418d9be655edc5/work/e6ddf13681e5466595418d9be655edc5_id_rsa 2025-08-20 03:17:08.897397 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e6ddf13681e5466595418d9be655edc5/work/e6ddf13681e5466595418d9be655edc5_id_rsa.pub 2025-08-20 03:17:08.897418 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-20 03:17:08.897437 | debian-bookworm -> localhost | SHA256:bI059bH3U5Mx5ofLSq1XtxXT+lKiqk5m5NmLIN/KCXQ zuul-build-sshkey 2025-08-20 03:17:08.897455 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-20 03:17:08.897479 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-20 03:17:08.897498 | debian-bookworm -> localhost | | | 2025-08-20 03:17:08.897516 | debian-bookworm -> localhost | | | 2025-08-20 03:17:08.897533 | debian-bookworm -> localhost | | . . +.| 2025-08-20 03:17:08.897562 | debian-bookworm -> localhost | | . = . oo+=| 2025-08-20 03:17:08.897580 | debian-bookworm -> localhost | | . E S . o o==| 2025-08-20 03:17:08.897603 | debian-bookworm -> localhost | | . . + + +ooO| 2025-08-20 03:17:08.897643 | debian-bookworm -> localhost | | o . * . ..+*=| 2025-08-20 03:17:08.897663 | debian-bookworm -> localhost | | = B . o.oo.o| 2025-08-20 03:17:08.897681 | debian-bookworm -> localhost | | =o=.o.o. . | 2025-08-20 03:17:08.897699 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-20 03:17:08.897745 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.886757 2025-08-20 03:17:08.903012 | 2025-08-20 03:17:08.903090 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-20 03:17:08.949251 | debian-bookworm | ok 2025-08-20 03:17:08.956615 | debian-bookworm | included: /var/lib/zuul/builds/e6ddf13681e5466595418d9be655edc5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-20 03:17:08.980318 | 2025-08-20 03:17:08.980398 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-20 03:17:09.003313 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:17:09.007963 | 2025-08-20 03:17:09.008043 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-20 03:17:09.711543 | debian-bookworm | changed 2025-08-20 03:17:09.716346 | 2025-08-20 03:17:09.716419 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-20 03:17:09.997578 | debian-bookworm | ok 2025-08-20 03:17:10.002273 | 2025-08-20 03:17:10.002353 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-20 03:17:10.836941 | debian-bookworm | changed 2025-08-20 03:17:10.842533 | 2025-08-20 03:17:10.842629 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-20 03:17:11.639018 | debian-bookworm | changed 2025-08-20 03:17:11.643466 | 2025-08-20 03:17:11.643546 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-20 03:17:11.683432 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:17:11.688509 | 2025-08-20 03:17:11.688598 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-20 03:17:12.649428 | debian-bookworm -> localhost | changed 2025-08-20 03:17:12.666002 | 2025-08-20 03:17:12.666100 | TASK [add-build-sshkey : Add back temp key] 2025-08-20 03:17:13.139097 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e6ddf13681e5466595418d9be655edc5/work/e6ddf13681e5466595418d9be655edc5_id_rsa (zuul-build-sshkey) 2025-08-20 03:17:13.139297 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011157 2025-08-20 03:17:13.145947 | 2025-08-20 03:17:13.146032 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-20 03:17:13.547596 | debian-bookworm | ok 2025-08-20 03:17:13.552194 | 2025-08-20 03:17:13.552297 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-20 03:17:13.587498 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:17:13.600183 | 2025-08-20 03:17:13.603735 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-20 03:17:14.105778 | debian-bookworm | ok 2025-08-20 03:17:14.114277 | 2025-08-20 03:17:14.114365 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-20 03:17:14.185199 | debian-bookworm | ok 2025-08-20 03:17:14.189399 | 2025-08-20 03:17:14.189479 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-20 03:17:14.818316 | debian-bookworm -> localhost | ok 2025-08-20 03:17:14.823369 | 2025-08-20 03:17:14.823449 | TASK [validate-host : Collect information about the host] 2025-08-20 03:17:16.036470 | debian-bookworm | ok 2025-08-20 03:17:16.048994 | 2025-08-20 03:17:16.049090 | TASK [validate-host : Sanitize hostname] 2025-08-20 03:17:16.149793 | debian-bookworm | ok 2025-08-20 03:17:16.208144 | 2025-08-20 03:17:16.208243 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-20 03:17:16.966917 | debian-bookworm -> localhost | changed 2025-08-20 03:17:16.971898 | 2025-08-20 03:17:16.971982 | TASK [validate-host : Collect information about zuul worker] 2025-08-20 03:17:17.546554 | debian-bookworm | ok 2025-08-20 03:17:17.550288 | 2025-08-20 03:17:17.550365 | TASK [validate-host : Write out all zuul information for each host] 2025-08-20 03:17:18.860383 | debian-bookworm -> localhost | changed 2025-08-20 03:17:18.868020 | 2025-08-20 03:17:18.868109 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-20 03:17:19.161474 | debian-bookworm | ok 2025-08-20 03:17:19.193459 | 2025-08-20 03:17:19.193569 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-20 03:17:20.790519 | debian-bookworm | changed: 2025-08-20 03:17:20.790685 | debian-bookworm | cd+++++++++ src/ 2025-08-20 03:17:20.790714 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-20 03:17:20.790735 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-20 03:17:20.790753 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-generics/ 2025-08-20 03:17:20.790770 | debian-bookworm | =6.1 2025-08-20 03:17:46.090798 | debian-bookworm | Downloading cachetools-6.1.0-py3-none-any.whl (11 kB) 2025-08-20 03:17:46.121852 | debian-bookworm | Collecting chardet>=5.2 2025-08-20 03:17:46.130200 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-08-20 03:17:46.148021 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 13.6 MB/s eta 0:00:00 2025-08-20 03:17:46.198396 | debian-bookworm | Collecting colorama>=0.4.6 2025-08-20 03:17:46.207152 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-08-20 03:17:46.258307 | debian-bookworm | Collecting filelock>=3.18 2025-08-20 03:17:46.266263 | debian-bookworm | Downloading filelock-3.19.1-py3-none-any.whl (15 kB) 2025-08-20 03:17:46.325901 | debian-bookworm | Collecting packaging>=25 2025-08-20 03:17:46.333753 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-08-20 03:17:46.344281 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.7 MB/s eta 0:00:00 2025-08-20 03:17:46.386758 | debian-bookworm | Collecting platformdirs>=4.3.8 2025-08-20 03:17:46.395150 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-08-20 03:17:46.450325 | debian-bookworm | Collecting pluggy>=1.6 2025-08-20 03:17:46.458515 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-08-20 03:17:46.511268 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-08-20 03:17:46.519912 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-08-20 03:17:46.649509 | debian-bookworm | Collecting virtualenv>=20.31.2 2025-08-20 03:17:46.657682 | debian-bookworm | Downloading virtualenv-20.34.0-py3-none-any.whl (6.0 MB) 2025-08-20 03:17:46.931333 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 22.3 MB/s eta 0:00:00 2025-08-20 03:17:47.040075 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-08-20 03:17:47.048315 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-08-20 03:17:47.073204 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.8 MB/s eta 0:00:00 2025-08-20 03:17:47.240121 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-08-20 03:17:48.061768 | debian-bookworm | Successfully installed cachetools-6.1.0 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.19.1 packaging-25.0 platformdirs-4.3.8 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.28.4 virtualenv-20.34.0 2025-08-20 03:17:48.453310 | debian-bookworm | ok: Runtime: 0:00:02.901396 2025-08-20 03:17:48.465201 | 2025-08-20 03:17:48.465281 | TASK [ensure-tox : Export installed tox_executable path] 2025-08-20 03:17:48.547285 | debian-bookworm | ok 2025-08-20 03:17:48.553415 | 2025-08-20 03:17:48.553583 | TASK [ensure-tox : Output tox version] 2025-08-20 03:17:49.195476 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-08-20 03:17:49.214407 | debian-bookworm | 4.28.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-08-20 03:17:49.597537 | debian-bookworm | ok: Runtime: 0:00:00.312305 2025-08-20 03:17:49.605820 | 2025-08-20 03:17:49.605892 | TASK [ensure-tox : Make global symlink] 2025-08-20 03:17:49.660975 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:17:49.666635 | 2025-08-20 03:17:49.666698 | PLAY RECAP 2025-08-20 03:17:49.666739 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-08-20 03:17:49.666760 | 2025-08-20 03:17:49.981992 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-08-20 03:17:49.984245 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-08-20 03:17:51.521493 | 2025-08-20 03:17:51.521637 | PLAY [all] 2025-08-20 03:17:51.585568 | 2025-08-20 03:17:51.585715 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-08-20 03:17:52.129318 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-08-20 03:17:52.638810 | debian-bookworm | ok: Runtime: 0:00:00.027707 2025-08-20 03:17:52.644992 | 2025-08-20 03:17:52.645125 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-08-20 03:17:53.220670 | debian-bookworm | ok: Runtime: 0:00:00.006127 2025-08-20 03:17:53.225451 | 2025-08-20 03:17:53.225531 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-08-20 03:17:53.581707 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-08-20 03:17:53.583451 | debian-bookworm | sudo: a password is required 2025-08-20 03:17:53.796650 | debian-bookworm | ok: Runtime: 0:00:00.021076 2025-08-20 03:17:53.804456 | 2025-08-20 03:17:53.804543 | TASK [tox : Check to see if the constraints file exists] 2025-08-20 03:17:53.832413 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:17:53.837293 | 2025-08-20 03:17:53.837380 | TASK [tox : Fail if constraints file is missing] 2025-08-20 03:17:53.890991 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:17:53.895865 | 2025-08-20 03:17:53.895957 | TASK [tox : Record file location] 2025-08-20 03:17:53.928830 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:17:53.933928 | 2025-08-20 03:17:53.934021 | TASK [tox : Install tox siblings] 2025-08-20 03:17:53.961435 | debian-bookworm | ok 2025-08-20 03:17:53.977923 | debian-bookworm | included: /var/lib/zuul/builds/e6ddf13681e5466595418d9be655edc5/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-08-20 03:17:53.982415 | 2025-08-20 03:17:53.982495 | TASK [tox : Run tox without tests] 2025-08-20 03:17:54.579573 | debian-bookworm | ROOT: 156 D setup logging to DEBUG on pid 1429 [tox/report.py:222] 2025-08-20 03:17:54.659282 | debian-bookworm | check: 236 D created app data folder /home/zuul/.local/share/virtualenv [virtualenv/app_data/__init__.py:42] 2025-08-20 03:17:54.663971 | debian-bookworm | check: 241 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:77] 2025-08-20 03:17:54.665544 | debian-bookworm | check: 242 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/discovery/py_info.py j7sS2jF17OcO5a6P6rsqpLtYFuxnXiGQ 020t11p1OSQVH8QCKk5Q2eZqSVxmjfHR [virtualenv/discovery/cached_py_info.py:145] 2025-08-20 03:17:54.739191 | debian-bookworm | check: 316 D wrote python info of /usr/bin/python3.11 at /home/zuul/.local/share/virtualenv/py_info/2/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:152] 2025-08-20 03:17:54.740471 | debian-bookworm | check: 317 D filesystem is case-sensitive [virtualenv/discovery/info.py:20] 2025-08-20 03:17:54.741233 | debian-bookworm | check: 318 I proposed PythonInfo(spec=CPython3.11.2.final.0-64, system=/usr/bin/python3.11, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:84] 2025-08-20 03:17:54.741583 | debian-bookworm | check: 318 D accepted PythonInfo(spec=CPython3.11.2.final.0-64, system=/usr/bin/python3.11, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:86] 2025-08-20 03:17:54.744504 | debian-bookworm | check: 321 D symlink on filesystem does work [virtualenv/info.py:50] 2025-08-20 03:17:54.744813 | debian-bookworm | check: 322 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-08-20 03:17:54.788676 | debian-bookworm | check: 365 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/cfg-generics/.tox/check, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:52] 2025-08-20 03:17:54.789174 | debian-bookworm | check: 366 D create folder /home/zuul/src/github.com/osism/cfg-generics/.tox/check/bin [virtualenv/util/path/_sync.py:14] 2025-08-20 03:17:54.789428 | debian-bookworm | check: 366 D create folder /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:14] 2025-08-20 03:17:54.789810 | debian-bookworm | check: 367 D write /home/zuul/src/github.com/osism/cfg-generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-08-20 03:17:54.789944 | debian-bookworm | check: 367 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:54.790053 | debian-bookworm | check: 367 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:54.790160 | debian-bookworm | check: 367 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:54.790227 | debian-bookworm | check: 367 D virtualenv = 20.34.0 [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:54.790349 | debian-bookworm | check: 367 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:54.790436 | debian-bookworm | check: 367 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:54.790535 | debian-bookworm | check: 368 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:54.790682 | debian-bookworm | check: 368 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:54.791105 | debian-bookworm | check: 368 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/bin/python [virtualenv/util/path/_sync.py:34] 2025-08-20 03:17:54.791650 | debian-bookworm | check: 369 D create virtualenv import hook file /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/_virtualenv.pth [virtualenv/create/via_global_ref/api.py:98] 2025-08-20 03:17:54.792086 | debian-bookworm | check: 369 D create /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/_virtualenv.py [virtualenv/create/via_global_ref/api.py:101] 2025-08-20 03:17:54.792755 | debian-bookworm | check: 370 D ============================== target debug ============================== [virtualenv/run/session.py:54] 2025-08-20 03:17:54.793190 | debian-bookworm | check: 370 D debug via /home/zuul/src/github.com/osism/cfg-generics/.tox/check/bin/python /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:215] 2025-08-20 03:17:54.839139 | debian-bookworm | check: 370 D { 2025-08-20 03:17:54.839191 | debian-bookworm | "sys": { 2025-08-20 03:17:54.839197 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/cfg-generics/.tox/check/bin/python", 2025-08-20 03:17:54.839203 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2025-08-20 03:17:54.839209 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/cfg-generics/.tox/check", 2025-08-20 03:17:54.839215 | debian-bookworm | "base_prefix": "/usr", 2025-08-20 03:17:54.839223 | debian-bookworm | "real_prefix": null, 2025-08-20 03:17:54.839228 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/cfg-generics/.tox/check", 2025-08-20 03:17:54.839232 | debian-bookworm | "base_exec_prefix": "/usr", 2025-08-20 03:17:54.839236 | debian-bookworm | "path": [ 2025-08-20 03:17:54.839240 | debian-bookworm | "/usr/lib/python311.zip", 2025-08-20 03:17:54.839246 | debian-bookworm | "/usr/lib/python3.11", 2025-08-20 03:17:54.839250 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2025-08-20 03:17:54.839254 | debian-bookworm | "/home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages" 2025-08-20 03:17:54.839258 | debian-bookworm | ], 2025-08-20 03:17:54.839263 | debian-bookworm | "meta_path": [ 2025-08-20 03:17:54.839267 | debian-bookworm | "", 2025-08-20 03:17:54.839271 | debian-bookworm | "", 2025-08-20 03:17:54.839275 | debian-bookworm | "", 2025-08-20 03:17:54.839279 | debian-bookworm | "" 2025-08-20 03:17:54.839283 | debian-bookworm | ], 2025-08-20 03:17:54.839287 | debian-bookworm | "fs_encoding": "utf-8", 2025-08-20 03:17:54.839291 | debian-bookworm | "io_encoding": "utf-8" 2025-08-20 03:17:54.839295 | debian-bookworm | }, 2025-08-20 03:17:54.839299 | debian-bookworm | "version": "3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]", 2025-08-20 03:17:54.839307 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2025-08-20 03:17:54.839311 | debian-bookworm | "os": "", 2025-08-20 03:17:54.839315 | debian-bookworm | "site": "", 2025-08-20 03:17:54.839319 | debian-bookworm | "datetime": "", 2025-08-20 03:17:54.839323 | debian-bookworm | "math": "", 2025-08-20 03:17:54.839327 | debian-bookworm | "json": "" 2025-08-20 03:17:54.839331 | debian-bookworm | } [virtualenv/run/session.py:55] 2025-08-20 03:17:54.839399 | debian-bookworm | check: 416 I add seed packages via FromAppData(download=False, pip=bundle, setuptools=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv) [virtualenv/run/session.py:59] 2025-08-20 03:17:54.842768 | debian-bookworm | check: 420 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-25.2-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51] 2025-08-20 03:17:54.843775 | debian-bookworm | check: 421 D build install image for pip-25.2-py3-none-any.whl to /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.2-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2025-08-20 03:17:54.844287 | debian-bookworm | check: 421 D install setuptools from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/setuptools-80.9.0-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:51] 2025-08-20 03:17:54.849086 | debian-bookworm | check: 426 D build install image for setuptools-80.9.0-py3-none-any.whl to /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:49] 2025-08-20 03:17:55.079070 | debian-bookworm | check: 656 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools-80.9.0.virtualenv to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/setuptools-80.9.0.virtualenv [virtualenv/util/path/_sync.py:42] 2025-08-20 03:17:55.079561 | debian-bookworm | check: 656 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/pkg_resources to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/pkg_resources [virtualenv/util/path/_sync.py:42] 2025-08-20 03:17:55.087243 | debian-bookworm | check: 664 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/_distutils_hack to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:42] 2025-08-20 03:17:55.088499 | debian-bookworm | check: 665 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/distutils-precedence.pth to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:42] 2025-08-20 03:17:55.088920 | debian-bookworm | check: 666 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/setuptools [virtualenv/util/path/_sync.py:42] 2025-08-20 03:17:55.139320 | debian-bookworm | check: 716 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.2-py3-none-any/pip to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/pip [virtualenv/util/path/_sync.py:42] 2025-08-20 03:17:55.279495 | debian-bookworm | check: 856 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-80.9.0-py3-none-any/setuptools-80.9.0.dist-info to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/setuptools-80.9.0.dist-info [virtualenv/util/path/_sync.py:42] 2025-08-20 03:17:55.283790 | debian-bookworm | check: 861 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-08-20 03:17:55.291999 | debian-bookworm | check: 869 D copy /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.2-py3-none-any/pip-25.2.virtualenv to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/pip-25.2.virtualenv [virtualenv/util/path/_sync.py:42] 2025-08-20 03:17:55.292295 | debian-bookworm | check: 869 D copy directory /home/zuul/.local/share/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-25.2-py3-none-any/pip-25.2.dist-info to /home/zuul/src/github.com/osism/cfg-generics/.tox/check/lib/python3.11/site-packages/pip-25.2.dist-info [virtualenv/util/path/_sync.py:42] 2025-08-20 03:17:55.296936 | debian-bookworm | check: 874 D generated console scripts pip3.11 pip pip-3.11 pip3 [virtualenv/seed/embed/via_app_data/pip_install/base.py:45] 2025-08-20 03:17:55.297663 | debian-bookworm | check: 874 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python [virtualenv/run/session.py:65] 2025-08-20 03:17:55.303775 | debian-bookworm | check: 881 D write /home/zuul/src/github.com/osism/cfg-generics/.tox/check/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:35] 2025-08-20 03:17:55.303944 | debian-bookworm | check: 881 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:55.304022 | debian-bookworm | check: 881 D implementation = CPython [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:55.304085 | debian-bookworm | check: 881 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:55.304146 | debian-bookworm | check: 881 D virtualenv = 20.34.0 [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:55.304205 | debian-bookworm | check: 881 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:55.304276 | debian-bookworm | check: 881 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:55.304343 | debian-bookworm | check: 881 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:55.304421 | debian-bookworm | check: 881 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:40] 2025-08-20 03:17:55.309622 | debian-bookworm | check: 887 W install_deps> python -I -m pip install -r requirements.txt [tox/tox_env/api.py:461] 2025-08-20 03:17:56.466050 | debian-bookworm | Collecting Jinja2==3.1.6 (from -r requirements.txt (line 1)) 2025-08-20 03:17:56.532274 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2025-08-20 03:17:56.629604 | debian-bookworm | Collecting PyYAML==6.0.2 (from -r requirements.txt (line 2)) 2025-08-20 03:17:56.637454 | debian-bookworm | Downloading PyYAML-6.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (2.1 kB) 2025-08-20 03:17:56.702341 | debian-bookworm | Collecting ansible==11.8.0 (from -r requirements.txt (line 3)) 2025-08-20 03:17:56.711147 | debian-bookworm | Downloading ansible-11.8.0-py3-none-any.whl.metadata (8.1 kB) 2025-08-20 03:17:56.744220 | debian-bookworm | Collecting packaging==25.0 (from -r requirements.txt (line 4)) 2025-08-20 03:17:56.752393 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl.metadata (3.3 kB) 2025-08-20 03:17:56.779881 | debian-bookworm | Collecting pwgen==0.8.2.post0 (from -r requirements.txt (line 5)) 2025-08-20 03:17:56.788790 | debian-bookworm | Downloading pwgen-0.8.2.post0.tar.gz (2.9 kB) 2025-08-20 03:17:56.800663 | debian-bookworm | Installing build dependencies: started 2025-08-20 03:17:57.915772 | debian-bookworm | Installing build dependencies: finished with status 'done' 2025-08-20 03:17:57.916217 | debian-bookworm | Getting requirements to build wheel: started 2025-08-20 03:17:58.349230 | debian-bookworm | Getting requirements to build wheel: finished with status 'done' 2025-08-20 03:17:58.350304 | debian-bookworm | Preparing metadata (pyproject.toml): started 2025-08-20 03:17:58.619660 | debian-bookworm | Preparing metadata (pyproject.toml): finished with status 'done' 2025-08-20 03:17:58.659195 | debian-bookworm | Collecting python-gilt==1.2.3 (from -r requirements.txt (line 6)) 2025-08-20 03:17:58.669850 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl.metadata (1.4 kB) 2025-08-20 03:17:58.733451 | debian-bookworm | Collecting requests==2.32.4 (from -r requirements.txt (line 7)) 2025-08-20 03:17:58.741084 | debian-bookworm | Downloading requests-2.32.4-py3-none-any.whl.metadata (4.9 kB) 2025-08-20 03:17:58.770725 | debian-bookworm | Collecting tabulate==0.9.0 (from -r requirements.txt (line 8)) 2025-08-20 03:17:58.778247 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl.metadata (34 kB) 2025-08-20 03:17:58.875650 | debian-bookworm | Collecting MarkupSafe>=2.0 (from Jinja2==3.1.6->-r requirements.txt (line 1)) 2025-08-20 03:17:58.883955 | debian-bookworm | Downloading MarkupSafe-3.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (4.0 kB) 2025-08-20 03:17:58.962356 | debian-bookworm | Collecting ansible-core~=2.18.7 (from ansible==11.8.0->-r requirements.txt (line 3)) 2025-08-20 03:17:58.971020 | debian-bookworm | Downloading ansible_core-2.18.8-py3-none-any.whl.metadata (7.7 kB) 2025-08-20 03:17:59.031000 | debian-bookworm | Collecting click (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-08-20 03:17:59.038992 | debian-bookworm | Downloading click-8.2.1-py3-none-any.whl.metadata (2.5 kB) 2025-08-20 03:17:59.083263 | debian-bookworm | Collecting colorama (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-08-20 03:17:59.091096 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-08-20 03:17:59.128092 | debian-bookworm | Collecting fasteners (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-08-20 03:17:59.136540 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl.metadata (4.8 kB) 2025-08-20 03:17:59.173852 | debian-bookworm | Collecting sh (from python-gilt==1.2.3->-r requirements.txt (line 6)) 2025-08-20 03:17:59.181986 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl.metadata (3.7 kB) 2025-08-20 03:17:59.321256 | debian-bookworm | Collecting charset_normalizer<4,>=2 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-08-20 03:17:59.329137 | debian-bookworm | Downloading charset_normalizer-3.4.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (36 kB) 2025-08-20 03:17:59.376118 | debian-bookworm | Collecting idna<4,>=2.5 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-08-20 03:17:59.384436 | debian-bookworm | Downloading idna-3.10-py3-none-any.whl.metadata (10 kB) 2025-08-20 03:17:59.439922 | debian-bookworm | Collecting urllib3<3,>=1.21.1 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-08-20 03:17:59.447344 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl.metadata (6.5 kB) 2025-08-20 03:17:59.502797 | debian-bookworm | Collecting certifi>=2017.4.17 (from requests==2.32.4->-r requirements.txt (line 7)) 2025-08-20 03:17:59.511648 | debian-bookworm | Downloading certifi-2025.8.3-py3-none-any.whl.metadata (2.4 kB) 2025-08-20 03:17:59.805894 | debian-bookworm | Collecting cryptography (from ansible-core~=2.18.7->ansible==11.8.0->-r requirements.txt (line 3)) 2025-08-20 03:17:59.813407 | debian-bookworm | Downloading cryptography-45.0.6-cp311-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2025-08-20 03:17:59.912265 | debian-bookworm | Collecting resolvelib<1.1.0,>=0.5.3 (from ansible-core~=2.18.7->ansible==11.8.0->-r requirements.txt (line 3)) 2025-08-20 03:17:59.920418 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl.metadata (4.0 kB) 2025-08-20 03:18:00.217109 | debian-bookworm | Collecting cffi>=1.14 (from cryptography->ansible-core~=2.18.7->ansible==11.8.0->-r requirements.txt (line 3)) 2025-08-20 03:18:00.224969 | debian-bookworm | Downloading cffi-1.17.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (1.5 kB) 2025-08-20 03:18:00.253580 | debian-bookworm | Collecting pycparser (from cffi>=1.14->cryptography->ansible-core~=2.18.7->ansible==11.8.0->-r requirements.txt (line 3)) 2025-08-20 03:18:00.262903 | debian-bookworm | Downloading pycparser-2.22-py3-none-any.whl.metadata (943 bytes) 2025-08-20 03:18:00.297357 | debian-bookworm | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-08-20 03:18:00.323481 | debian-bookworm | Downloading PyYAML-6.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (762 kB) 2025-08-20 03:18:00.365095 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 763.0/763.0 kB 21.3 MB/s 0:00:00 2025-08-20 03:18:00.375341 | debian-bookworm | Downloading ansible-11.8.0-py3-none-any.whl (56.0 MB) 2025-08-20 03:18:02.311985 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 56.0/56.0 MB 28.9 MB/s 0:00:01 2025-08-20 03:18:02.320333 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-08-20 03:18:02.337258 | debian-bookworm | Downloading python_gilt-1.2.3-py2.py3-none-any.whl (22 kB) 2025-08-20 03:18:02.352037 | debian-bookworm | Downloading requests-2.32.4-py3-none-any.whl (64 kB) 2025-08-20 03:18:02.369437 | debian-bookworm | Downloading tabulate-0.9.0-py3-none-any.whl (35 kB) 2025-08-20 03:18:02.388521 | debian-bookworm | Downloading ansible_core-2.18.8-py3-none-any.whl (2.2 MB) 2025-08-20 03:18:02.479669 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.2/2.2 MB 25.3 MB/s 0:00:00 2025-08-20 03:18:02.490920 | debian-bookworm | Downloading charset_normalizer-3.4.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (150 kB) 2025-08-20 03:18:02.511733 | debian-bookworm | Downloading idna-3.10-py3-none-any.whl (70 kB) 2025-08-20 03:18:02.530696 | debian-bookworm | Downloading resolvelib-1.0.1-py2.py3-none-any.whl (17 kB) 2025-08-20 03:18:02.550256 | debian-bookworm | Downloading urllib3-2.5.0-py3-none-any.whl (129 kB) 2025-08-20 03:18:02.571539 | debian-bookworm | Downloading certifi-2025.8.3-py3-none-any.whl (161 kB) 2025-08-20 03:18:02.593737 | debian-bookworm | Downloading MarkupSafe-3.0.2-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (23 kB) 2025-08-20 03:18:02.612488 | debian-bookworm | Downloading click-8.2.1-py3-none-any.whl (102 kB) 2025-08-20 03:18:02.635041 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-08-20 03:18:02.653505 | debian-bookworm | Downloading cryptography-45.0.6-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2025-08-20 03:18:02.837596 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 24.7 MB/s 0:00:00 2025-08-20 03:18:02.847403 | debian-bookworm | Downloading cffi-1.17.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (467 kB) 2025-08-20 03:18:02.882142 | debian-bookworm | Downloading fasteners-0.20-py3-none-any.whl (18 kB) 2025-08-20 03:18:02.904969 | debian-bookworm | Downloading pycparser-2.22-py3-none-any.whl (117 kB) 2025-08-20 03:18:02.928783 | debian-bookworm | Downloading sh-2.2.2-py3-none-any.whl (38 kB) 2025-08-20 03:18:03.212817 | debian-bookworm | Building wheels for collected packages: pwgen 2025-08-20 03:18:03.213766 | debian-bookworm | Building wheel for pwgen (pyproject.toml): started 2025-08-20 03:18:03.519037 | debian-bookworm | Building wheel for pwgen (pyproject.toml): finished with status 'done' 2025-08-20 03:18:03.519543 | debian-bookworm | Created wheel for pwgen: filename=pwgen-0.8.2.post0-py3-none-any.whl size=3797 sha256=ac30537a8d79ffbdb372e7b941bb68df3b74e6190ea5a84508c3e13361c537df 2025-08-20 03:18:03.519600 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/c3/81/ed/8e13725daf8a767fbde13d7583ce457f3fdf974023341fac95 2025-08-20 03:18:03.521734 | debian-bookworm | Successfully built pwgen 2025-08-20 03:18:03.778198 | debian-bookworm | Installing collected packages: resolvelib, pwgen, urllib3, tabulate, sh, PyYAML, pycparser, packaging, MarkupSafe, idna, fasteners, colorama, click, charset_normalizer, certifi, requests, python-gilt, Jinja2, cffi, cryptography, ansible-core, ansible 2025-08-20 03:18:31.343986 | debian-bookworm | 2025-08-20 03:18:31.346916 | debian-bookworm | Successfully installed Jinja2-3.1.6 MarkupSafe-3.0.2 PyYAML-6.0.2 ansible-11.8.0 ansible-core-2.18.8 certifi-2025.8.3 cffi-1.17.1 charset_normalizer-3.4.3 click-8.2.1 colorama-0.4.6 cryptography-45.0.6 fasteners-0.20 idna-3.10 packaging-25.0 pwgen-0.8.2.post0 pycparser-2.22 python-gilt-1.2.3 requests-2.32.4 resolvelib-1.0.1 sh-2.2.2 tabulate-0.9.0 urllib3-2.5.0 2025-08-20 03:18:31.493948 | debian-bookworm | check: 37071 I exit 0 (36.18 seconds) /home/zuul/src/github.com/osism/cfg-generics> python -I -m pip install -r requirements.txt pid=1442 [tox/execute/api.py:294] 2025-08-20 03:18:31.495953 | debian-bookworm | check: OK (36.85 seconds) 2025-08-20 03:18:31.496024 | debian-bookworm | congratulations :) (36.92 seconds) 2025-08-20 03:18:31.589663 | debian-bookworm | ok: Runtime: 0:00:37.150623 2025-08-20 03:18:31.610895 | 2025-08-20 03:18:31.611032 | TASK [tox : Create a tempfile to save tox showconfig] 2025-08-20 03:18:32.031258 | debian-bookworm | changed 2025-08-20 03:18:32.038376 | 2025-08-20 03:18:32.038501 | TASK [tox : Get tox envlist config] 2025-08-20 03:18:33.067069 | debian-bookworm | ok: Runtime: 0:00:00.307355 2025-08-20 03:18:33.082892 | 2025-08-20 03:18:33.083049 | TASK [tox : Install any sibling python packages] 2025-08-20 03:18:33.519328 | debian-bookworm | ok: No setup.cfg, no action needed 2025-08-20 03:18:33.526065 | 2025-08-20 03:18:33.526188 | TASK [tox : Remove tempfile] 2025-08-20 03:18:33.998054 | debian-bookworm | changed 2025-08-20 03:18:34.006193 | 2025-08-20 03:18:34.006322 | TASK [tox : Emit tox command] 2025-08-20 03:18:34.046920 | /home/zuul/.local/tox/bin/tox -echeck -vv --skip-missing-interpreters=false 2025-08-20 03:18:34.052853 | 2025-08-20 03:18:34.052989 | TASK [tox : Run tox] 2025-08-20 03:18:34.570314 | debian-bookworm | ROOT: 157 D setup logging to DEBUG on pid 1596 [tox/report.py:222] 2025-08-20 03:18:34.641056 | debian-bookworm | check: 228 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [virtualenv/discovery/builtin.py:77] 2025-08-20 03:18:34.641816 | debian-bookworm | check: 228 D got python info of /usr/bin/python3.11 from /home/zuul/.local/share/virtualenv/py_info/2/ca3ed784184f1b3bb7c3539bfb45e71710cd27667424f92c2d5bb4df9c107c23.json [virtualenv/app_data/via_disk_folder.py:132] 2025-08-20 03:18:34.642633 | debian-bookworm | check: 229 D filesystem is case-sensitive [virtualenv/discovery/info.py:20] 2025-08-20 03:18:34.642783 | debian-bookworm | check: 229 I proposed PythonInfo(spec=CPython3.11.2.final.0-64, system=/usr/bin/python3.11, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:84] 2025-08-20 03:18:34.642864 | debian-bookworm | check: 230 D accepted PythonInfo(spec=CPython3.11.2.final.0-64, system=/usr/bin/python3.11, exe=/home/zuul/.local/tox/bin/python3, platform=linux, version='3.11.2 (main, Apr 28 2025, 14:11:48) [GCC 12.2.0]', encoding_fs_io=utf-8-utf-8) [virtualenv/discovery/builtin.py:86] 2025-08-20 03:18:34.644005 | debian-bookworm | check: 231 D symlink on filesystem does work [virtualenv/info.py:50] 2025-08-20 03:18:34.644183 | debian-bookworm | check: 231 D filesystem is case-sensitive [virtualenv/info.py:27] 2025-08-20 03:18:34.673447 | debian-bookworm | check: 260 W commands[0]> python3 src/check-inventory-sorting.py [tox/tox_env/api.py:461] 2025-08-20 03:18:34.736438 | debian-bookworm | check: 323 I exit 0 (0.06 seconds) /home/zuul/src/github.com/osism/cfg-generics> python3 src/check-inventory-sorting.py pid=1603 [tox/execute/api.py:294] 2025-08-20 03:18:34.737594 | debian-bookworm | check: OK (0.10=setup[0.04]+cmd[0.06] seconds) 2025-08-20 03:18:34.737613 | debian-bookworm | congratulations :) (0.17 seconds) 2025-08-20 03:18:35.131688 | debian-bookworm | ok: Runtime: 0:00:00.413894 2025-08-20 03:18:35.157662 | 2025-08-20 03:18:35.157788 | TASK [tox : Look for output] 2025-08-20 03:18:35.623783 | debian-bookworm | ok 2025-08-20 03:18:35.643207 | 2025-08-20 03:18:35.643353 | TASK [tox : Return file comments to Zuul] 2025-08-20 03:18:35.689335 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:35.699847 | 2025-08-20 03:18:35.699963 | PLAY RECAP 2025-08-20 03:18:35.700019 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-08-20 03:18:35.700044 | 2025-08-20 03:18:35.882401 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-08-20 03:18:35.885108 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-08-20 03:18:37.077486 | 2025-08-20 03:18:37.077701 | PLAY [all] 2025-08-20 03:18:37.098793 | 2025-08-20 03:18:37.098983 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-08-20 03:18:37.173589 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:37.179987 | 2025-08-20 03:18:37.180166 | TASK [fetch-tox-output : Set tox log path for single node] 2025-08-20 03:18:37.224114 | debian-bookworm | ok 2025-08-20 03:18:37.229870 | 2025-08-20 03:18:37.229998 | TASK [fetch-tox-output : Ensure local tox dir] 2025-08-20 03:18:37.774872 | debian-bookworm -> localhost | changed 2025-08-20 03:18:37.785270 | 2025-08-20 03:18:37.785391 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-08-20 03:18:37.830237 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:37.837250 | 2025-08-20 03:18:37.837369 | TASK [fetch-tox-output : Set envlist fact] 2025-08-20 03:18:37.901963 | debian-bookworm | ok 2025-08-20 03:18:37.917825 | 2025-08-20 03:18:37.917975 | TASK [fetch-tox-output : Get tox version] 2025-08-20 03:18:38.563461 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-08-20 03:18:38.580411 | debian-bookworm | 4.28.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-08-20 03:18:38.951215 | debian-bookworm | ok: Runtime: 0:00:00.254452 2025-08-20 03:18:38.960274 | 2025-08-20 03:18:38.960761 | TASK [fetch-tox-output : Find all default environments] 2025-08-20 03:18:39.503359 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:39.516094 | 2025-08-20 03:18:39.516300 | TASK [fetch-tox-output : Set envlist fact] 2025-08-20 03:18:39.541637 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:39.548466 | 2025-08-20 03:18:39.548627 | TASK [fetch-tox-output : Find all default environments] 2025-08-20 03:18:40.085704 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:40.096087 | 2025-08-20 03:18:40.096241 | TASK [fetch-tox-output : Set envlist fact] 2025-08-20 03:18:40.123205 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:40.141096 | 2025-08-20 03:18:40.141257 | LOOP [fetch-tox-output : Copy tox logs] 2025-08-20 03:18:40.200437 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:40.215486 | 2025-08-20 03:18:40.215671 | LOOP [fetch-tox-output : Collect tox logs] 2025-08-20 03:18:41.071859 | debian-bookworm | changed: 2025-08-20 03:18:41.072060 | debian-bookworm | created directory /var/lib/zuul/builds/e6ddf13681e5466595418d9be655edc5/work/logs/tox/check 2025-08-20 03:18:41.072104 | debian-bookworm | cd+++++++++ ./ 2025-08-20 03:18:41.072130 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-08-20 03:18:41.072238 | 2025-08-20 03:18:41.083981 | 2025-08-20 03:18:41.084074 | PLAY RECAP 2025-08-20 03:18:41.084124 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-08-20 03:18:41.084149 | 2025-08-20 03:18:41.225355 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-08-20 03:18:41.226407 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-08-20 03:18:41.999735 | 2025-08-20 03:18:41.999889 | PLAY [all] 2025-08-20 03:18:42.016312 | 2025-08-20 03:18:42.016453 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-08-20 03:18:42.260431 | debian-bookworm | changed: non-zero return code 2025-08-20 03:18:42.271308 | 2025-08-20 03:18:42.272305 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-08-20 03:18:42.319290 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:42.333547 | 2025-08-20 03:18:42.333715 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-08-20 03:18:42.385879 | 2025-08-20 03:18:42.386092 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-08-20 03:18:42.424741 | 2025-08-20 03:18:42.424955 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-08-20 03:18:42.457043 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:42.464211 | 2025-08-20 03:18:42.464325 | LOOP [fetch-subunit-output : Generate subunit file] 2025-08-20 03:18:42.505234 | 2025-08-20 03:18:42.505434 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-08-20 03:18:42.539477 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:42.545472 | 2025-08-20 03:18:42.545623 | TASK [fetch-subunit-output : Remove the temporary file] 2025-08-20 03:18:42.568815 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:42.574760 | 2025-08-20 03:18:42.574889 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-08-20 03:18:42.662263 | debian-bookworm | skipping: Conditional result was False 2025-08-20 03:18:42.679064 | 2025-08-20 03:18:42.679159 | PLAY RECAP 2025-08-20 03:18:42.679211 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-08-20 03:18:42.679236 | 2025-08-20 03:18:42.936596 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-08-20 03:18:42.937993 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-20 03:18:44.434091 | 2025-08-20 03:18:44.434254 | PLAY [Base post] 2025-08-20 03:18:44.458175 | 2025-08-20 03:18:44.458459 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-20 03:18:45.105236 | debian-bookworm | changed 2025-08-20 03:18:45.119035 | 2025-08-20 03:18:45.119259 | PLAY RECAP 2025-08-20 03:18:45.119326 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-20 03:18:45.119391 | 2025-08-20 03:18:45.257043 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-20 03:18:45.257970 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-20 03:18:46.282288 | 2025-08-20 03:18:46.282421 | PLAY [Base post-logs] 2025-08-20 03:18:46.356153 | 2025-08-20 03:18:46.356289 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-20 03:18:47.090665 | localhost | changed 2025-08-20 03:18:47.100132 | 2025-08-20 03:18:47.100261 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-20 03:18:47.146292 | localhost | ok 2025-08-20 03:18:47.152554 | 2025-08-20 03:18:47.152670 | TASK [Set zuul-log-path fact] 2025-08-20 03:18:47.189205 | localhost | ok 2025-08-20 03:18:47.197934 | 2025-08-20 03:18:47.198037 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-20 03:18:47.239613 | localhost | ok 2025-08-20 03:18:47.242331 | 2025-08-20 03:18:47.242415 | TASK [upload-logs : Create log directories] 2025-08-20 03:18:47.912354 | localhost | changed 2025-08-20 03:18:47.914799 | 2025-08-20 03:18:47.914935 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-20 03:18:48.467229 | localhost -> localhost | ok: Runtime: 0:00:00.020210 2025-08-20 03:18:48.470751 | 2025-08-20 03:18:48.471158 | TASK [upload-logs : Upload logs to log server] 2025-08-20 03:18:49.399850 | localhost | Output suppressed because no_log was given 2025-08-20 03:18:49.401184 | 2025-08-20 03:18:49.401253 | LOOP [upload-logs : Compress console log and json output] 2025-08-20 03:18:49.468087 | localhost | skipping: Conditional result was False 2025-08-20 03:18:49.483088 | localhost | skipping: Conditional result was False 2025-08-20 03:18:49.486280 | 2025-08-20 03:18:49.486375 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-20 03:18:49.539253 | localhost | skipping: Conditional result was False 2025-08-20 03:18:49.539458 | 2025-08-20 03:18:49.543236 | localhost | skipping: Conditional result was False 2025-08-20 03:18:49.551542 | 2025-08-20 03:18:49.551642 | LOOP [upload-logs : Upload console log and json output]