2026-09-21 03:14:01.235911 | Job console starting 2026-09-21 03:14:01.242339 | Updating git repos 2026-09-21 03:14:01.280730 | Cloning repos into workspace 2026-09-21 03:14:01.324397 | Restoring repo states 2026-09-21 03:14:01.358389 | Merging changes 2026-09-21 03:14:01.358406 | Checking out repos 2026-09-21 03:14:01.434243 | Preparing playbooks 2026-09-21 03:14:02.364813 | Running Ansible setup 2026-09-21 03:14:06.741828 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-21 03:14:07.622190 | 2026-09-21 03:14:07.622325 | PLAY [Base pre] 2026-09-21 03:14:07.639508 | 2026-09-21 03:14:07.639612 | TASK [Setup log path fact] 2026-09-21 03:14:07.657180 | debian-bookworm | ok 2026-09-21 03:14:07.687991 | 2026-09-21 03:14:07.688116 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-21 03:14:07.726131 | debian-bookworm | ok 2026-09-21 03:14:07.739662 | 2026-09-21 03:14:07.739754 | TASK [emit-job-header : Print job information] 2026-09-21 03:14:07.816669 | # Job Information 2026-09-21 03:14:07.816836 | Ansible Version: 2.16.14 2026-09-21 03:14:07.816872 | Job: generics-tox-seed 2026-09-21 03:14:07.816906 | Pipeline: periodic-daily 2026-09-21 03:14:07.816929 | Executor: 521e9411259a 2026-09-21 03:14:07.816972 | Triggered by: https://github.com/osism/generics 2026-09-21 03:14:07.816995 | Event ID: 5e38cf275a7a4c4484bae4d4d5bd04a1 2026-09-21 03:14:07.826366 | 2026-09-21 03:14:07.826460 | LOOP [emit-job-header : Print node information] 2026-09-21 03:14:08.008074 | debian-bookworm | ok: 2026-09-21 03:14:08.008283 | debian-bookworm | # Node Information 2026-09-21 03:14:08.008322 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-21 03:14:08.008350 | debian-bookworm | Hostname: debian 2026-09-21 03:14:08.008372 | debian-bookworm | Username: zuul 2026-09-21 03:14:08.008394 | debian-bookworm | Distro: Debian 12.15 2026-09-21 03:14:08.008419 | debian-bookworm | Provider: regiocloud-a 2026-09-21 03:14:08.008441 | debian-bookworm | Region: 2026-09-21 03:14:08.008462 | debian-bookworm | Label: debian-bookworm 2026-09-21 03:14:08.008482 | debian-bookworm | Product Name: OpenStack Nova 2026-09-21 03:14:08.008501 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3e:727b 2026-09-21 03:14:08.027562 | 2026-09-21 03:14:08.027670 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-21 03:14:08.555370 | debian-bookworm -> localhost | changed 2026-09-21 03:14:08.561088 | 2026-09-21 03:14:08.561178 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-21 03:14:09.551787 | debian-bookworm -> localhost | changed 2026-09-21 03:14:09.561360 | 2026-09-21 03:14:09.561442 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-21 03:14:09.854705 | debian-bookworm -> localhost | ok 2026-09-21 03:14:09.867437 | 2026-09-21 03:14:09.867635 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-21 03:14:09.894335 | debian-bookworm | ok 2026-09-21 03:14:09.911758 | debian-bookworm | included: /var/lib/zuul/builds/0bc8e37b9b33424db3df5834d0058a07/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-21 03:14:09.919317 | 2026-09-21 03:14:09.919500 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-21 03:14:11.881385 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-21 03:14:11.881593 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0bc8e37b9b33424db3df5834d0058a07/work/0bc8e37b9b33424db3df5834d0058a07_id_rsa 2026-09-21 03:14:11.881636 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0bc8e37b9b33424db3df5834d0058a07/work/0bc8e37b9b33424db3df5834d0058a07_id_rsa.pub 2026-09-21 03:14:11.881664 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-21 03:14:11.881690 | debian-bookworm -> localhost | SHA256:5QTdcxffHScbcnjKJSUqKPY87kmm2sA7UCQtzGn3tUk zuul-build-sshkey 2026-09-21 03:14:11.881713 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-21 03:14:11.881742 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-21 03:14:11.881765 | debian-bookworm -> localhost | |o.. .. .oo=oo| 2026-09-21 03:14:11.881787 | debian-bookworm -> localhost | |o=o. E ...=+++B| 2026-09-21 03:14:11.881808 | debian-bookworm -> localhost | |.+. + + + +. B..+| 2026-09-21 03:14:11.881827 | debian-bookworm -> localhost | | .. = o = o | 2026-09-21 03:14:11.881847 | debian-bookworm -> localhost | | . + S . | 2026-09-21 03:14:11.881870 | debian-bookworm -> localhost | |.. . . | 2026-09-21 03:14:11.881890 | debian-bookworm -> localhost | | .o + | 2026-09-21 03:14:11.881909 | debian-bookworm -> localhost | | .+ = . | 2026-09-21 03:14:11.881930 | debian-bookworm -> localhost | | ooo o | 2026-09-21 03:14:11.881962 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-21 03:14:11.882013 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.378179 2026-09-21 03:14:11.888105 | 2026-09-21 03:14:11.888193 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-21 03:14:11.905131 | debian-bookworm | ok 2026-09-21 03:14:11.914668 | debian-bookworm | included: /var/lib/zuul/builds/0bc8e37b9b33424db3df5834d0058a07/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-21 03:14:11.922458 | 2026-09-21 03:14:11.922534 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-21 03:14:11.945152 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:14:11.950691 | 2026-09-21 03:14:11.950776 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-21 03:14:12.680703 | debian-bookworm | changed 2026-09-21 03:14:12.686667 | 2026-09-21 03:14:12.686753 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-21 03:14:12.979907 | debian-bookworm | ok 2026-09-21 03:14:12.986078 | 2026-09-21 03:14:12.986171 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-21 03:14:13.666175 | debian-bookworm | changed 2026-09-21 03:14:13.674122 | 2026-09-21 03:14:13.674226 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-21 03:14:14.404601 | debian-bookworm | changed 2026-09-21 03:14:14.411385 | 2026-09-21 03:14:14.411459 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-21 03:14:14.444534 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:14:14.451654 | 2026-09-21 03:14:14.451745 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-21 03:14:14.853619 | debian-bookworm -> localhost | changed 2026-09-21 03:14:14.863963 | 2026-09-21 03:14:14.864048 | TASK [add-build-sshkey : Add back temp key] 2026-09-21 03:14:15.178478 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0bc8e37b9b33424db3df5834d0058a07/work/0bc8e37b9b33424db3df5834d0058a07_id_rsa (zuul-build-sshkey) 2026-09-21 03:14:15.178780 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009658 2026-09-21 03:14:15.186448 | 2026-09-21 03:14:15.186534 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-21 03:14:15.595070 | debian-bookworm | ok 2026-09-21 03:14:15.606147 | 2026-09-21 03:14:15.606270 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-21 03:14:15.629869 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:14:15.640908 | 2026-09-21 03:14:15.641013 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-21 03:14:16.077807 | debian-bookworm | ok 2026-09-21 03:14:16.092583 | 2026-09-21 03:14:16.092690 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-21 03:14:16.136679 | debian-bookworm | ok 2026-09-21 03:14:16.145803 | 2026-09-21 03:14:16.145926 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-21 03:14:16.590553 | debian-bookworm -> localhost | ok 2026-09-21 03:14:16.596669 | 2026-09-21 03:14:16.596750 | TASK [validate-host : Collect information about the host] 2026-09-21 03:14:17.802028 | debian-bookworm | ok 2026-09-21 03:14:17.823852 | 2026-09-21 03:14:17.823968 | TASK [validate-host : Sanitize hostname] 2026-09-21 03:14:18.014520 | debian-bookworm | ok 2026-09-21 03:14:18.022690 | 2026-09-21 03:14:18.022815 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-21 03:14:18.752788 | debian-bookworm -> localhost | changed 2026-09-21 03:14:18.758842 | 2026-09-21 03:14:18.758977 | TASK [validate-host : Collect information about zuul worker] 2026-09-21 03:14:19.221087 | debian-bookworm | ok 2026-09-21 03:14:19.236177 | 2026-09-21 03:14:19.236312 | TASK [validate-host : Write out all zuul information for each host] 2026-09-21 03:14:19.861999 | debian-bookworm -> localhost | changed 2026-09-21 03:14:19.883548 | 2026-09-21 03:14:19.883677 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-21 03:14:20.220887 | debian-bookworm | ok 2026-09-21 03:14:20.227291 | 2026-09-21 03:14:20.227413 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-21 03:14:21.394999 | debian-bookworm | changed: 2026-09-21 03:14:21.395393 | debian-bookworm | cd+++++++++ src/ 2026-09-21 03:14:21.395434 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-21 03:14:21.395459 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-21 03:14:21.395481 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-09-21 03:14:21.395502 | debian-bookworm | =7.0.3 2026-09-21 03:15:02.000452 | debian-bookworm | Downloading cachetools-7.2.0-py3-none-any.whl (16 kB) 2026-09-21 03:15:02.058443 | debian-bookworm | Collecting colorama>=0.4.6 2026-09-21 03:15:02.075700 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-09-21 03:15:02.172146 | debian-bookworm | Collecting filelock>=3.25 2026-09-21 03:15:02.187756 | debian-bookworm | Downloading filelock-4.0.1-py3-none-any.whl (106 kB) 2026-09-21 03:15:02.197857 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 106.2/106.2 kB 15.1 MB/s eta 0:00:00 2026-09-21 03:15:02.246757 | debian-bookworm | Collecting packaging>=26 2026-09-21 03:15:02.262753 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-09-21 03:15:02.279498 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 14.4 MB/s eta 0:00:00 2026-09-21 03:15:02.355884 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-09-21 03:15:02.372485 | debian-bookworm | Downloading platformdirs-4.11.11-py3-none-any.whl (24 kB) 2026-09-21 03:15:02.436659 | debian-bookworm | Collecting pluggy>=1.6 2026-09-21 03:15:02.452472 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-09-21 03:15:02.511640 | debian-bookworm | Collecting pyproject-api>=1.10 2026-09-21 03:15:02.528052 | debian-bookworm | Downloading pyproject_api-1.11.2-py3-none-any.whl (13 kB) 2026-09-21 03:15:02.576826 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-09-21 03:15:02.594252 | debian-bookworm | Downloading python_discovery-1.6.1-py3-none-any.whl (38 kB) 2026-09-21 03:15:02.640536 | debian-bookworm | Collecting tomli-w>=1.2 2026-09-21 03:15:02.655773 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-09-21 03:15:02.729248 | debian-bookworm | Collecting typing-extensions>=4.15 2026-09-21 03:15:02.744323 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-09-21 03:15:02.752957 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 6.6 MB/s eta 0:00:00 2026-09-21 03:15:02.925211 | debian-bookworm | Collecting virtualenv>=21.1 2026-09-21 03:15:02.940140 | debian-bookworm | Downloading virtualenv-21.9.0-py3-none-any.whl (5.5 MB) 2026-09-21 03:15:03.075815 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 41.9 MB/s eta 0:00:00 2026-09-21 03:15:03.184554 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-09-21 03:15:03.200459 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-09-21 03:15:03.227850 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 23.9 MB/s eta 0:00:00 2026-09-21 03:15:03.256741 | debian-bookworm | Collecting filelock>=3.25 2026-09-21 03:15:03.272291 | debian-bookworm | Downloading filelock-3.32.7-py3-none-any.whl (100 kB) 2026-09-21 03:15:03.289084 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 9.5 MB/s eta 0:00:00 2026-09-21 03:15:03.411754 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-09-21 03:15:04.599819 | debian-bookworm | Successfully installed cachetools-7.2.0 colorama-0.4.6 distlib-0.4.3 filelock-3.32.7 packaging-26.3 platformdirs-4.11.11 pluggy-1.6.0 pyproject-api-1.11.2 python-discovery-1.6.1 tomli-w-1.2.0 tox-4.63.0 typing-extensions-4.16.0 virtualenv-21.9.0 2026-09-21 03:15:05.167008 | debian-bookworm | ok: Runtime: 0:00:03.805824 2026-09-21 03:15:05.172658 | 2026-09-21 03:15:05.172751 | TASK [ensure-tox : Export installed tox_executable path] 2026-09-21 03:15:05.201563 | debian-bookworm | ok 2026-09-21 03:15:05.206803 | 2026-09-21 03:15:05.206895 | TASK [ensure-tox : Output tox version] 2026-09-21 03:15:05.885647 | 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-09-21 03:15:05.906970 | debian-bookworm | 4.63.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-21 03:15:06.245714 | debian-bookworm | ok: Runtime: 0:00:00.412079 2026-09-21 03:15:06.251077 | 2026-09-21 03:15:06.251160 | TASK [ensure-tox : Make global symlink] 2026-09-21 03:15:06.264405 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:06.271251 | 2026-09-21 03:15:06.271317 | PLAY RECAP 2026-09-21 03:15:06.271370 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-09-21 03:15:06.271396 | 2026-09-21 03:15:06.410422 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-09-21 03:15:06.411341 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-21 03:15:07.814531 | 2026-09-21 03:15:07.814640 | PLAY [all] 2026-09-21 03:15:07.849971 | 2026-09-21 03:15:07.850085 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-09-21 03:15:08.335264 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-21 03:15:08.401661 | debian-bookworm | ok: Runtime: 0:00:00.031475 2026-09-21 03:15:08.409896 | 2026-09-21 03:15:08.410025 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-09-21 03:15:08.972066 | debian-bookworm | ok: Runtime: 0:00:00.006292 2026-09-21 03:15:08.977995 | 2026-09-21 03:15:08.978090 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-09-21 03:15:09.444532 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-21 03:15:09.448760 | debian-bookworm | sudo: a password is required 2026-09-21 03:15:09.538465 | debian-bookworm | ok: Runtime: 0:00:00.031744 2026-09-21 03:15:09.548512 | 2026-09-21 03:15:09.548605 | TASK [tox : Check to see if the constraints file exists] 2026-09-21 03:15:09.612323 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:09.618275 | 2026-09-21 03:15:09.618380 | TASK [tox : Fail if constraints file is missing] 2026-09-21 03:15:09.651663 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:09.657522 | 2026-09-21 03:15:09.657651 | TASK [tox : Record file location] 2026-09-21 03:15:09.702163 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:09.711587 | 2026-09-21 03:15:09.711699 | TASK [tox : Install tox siblings] 2026-09-21 03:15:09.730080 | debian-bookworm | ok 2026-09-21 03:15:09.738311 | debian-bookworm | included: /var/lib/zuul/builds/0bc8e37b9b33424db3df5834d0058a07/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-09-21 03:15:09.743208 | 2026-09-21 03:15:09.743287 | TASK [tox : Run tox without tests] 2026-09-21 03:15:10.416256 | debian-bookworm | ROOT: 256 D setup logging to DEBUG on pid 1587 [tox/report.py:249] 2026-09-21 03:15:10.453830 | debian-bookworm | seed: 293 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-21 03:15:10.458543 | debian-bookworm | seed: 298 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-21 03:15:10.464860 | debian-bookworm | seed: 305 D get interpreter info via cmd: /usr/bin/python3.11 /home/zuul/.local/tox/lib/python3.11/site-packages/python_discovery/_py_info_collect.py 578f86021d5f1e10354e4ee9bfea53c5 e7cbc34f01c62dad848fb13d3642a549 [python_discovery/_cached_py_info.py:223] 2026-09-21 03:15:10.538847 | debian-bookworm | seed: 378 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-09-21 03:15:10.540023 | debian-bookworm | seed: 380 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-21 03:15:10.540428 | debian-bookworm | seed: 380 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-09-21 03:15:10.540745 | debian-bookworm | seed: 381 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-09-21 03:15:10.545304 | debian-bookworm | seed: 385 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-21 03:15:10.545529 | debian-bookworm | seed: 385 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-21 03:15:10.591620 | debian-bookworm | seed: 431 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/generics/.tox/seed, clear=False, no_vcs_ignore=False, global=False) [virtualenv/run/session.py:77] 2026-09-21 03:15:10.592177 | debian-bookworm | seed: 432 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/bin [virtualenv/util/path/_sync.py:22] 2026-09-21 03:15:10.592405 | debian-bookworm | seed: 432 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/include [virtualenv/util/path/_sync.py:22] 2026-09-21 03:15:10.592513 | debian-bookworm | seed: 432 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:22] 2026-09-21 03:15:10.592759 | debian-bookworm | seed: 433 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-21 03:15:10.592898 | debian-bookworm | seed: 433 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.592968 | debian-bookworm | seed: 433 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.593026 | debian-bookworm | seed: 433 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.593086 | debian-bookworm | seed: 433 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.593155 | debian-bookworm | seed: 433 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.593214 | debian-bookworm | seed: 433 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/seed [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.593247 | debian-bookworm | seed: 433 D virtualenv = 21.9.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.593319 | debian-bookworm | seed: 433 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.593349 | debian-bookworm | seed: 433 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.593409 | debian-bookworm | seed: 433 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.593468 | debian-bookworm | seed: 433 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:10.593972 | debian-bookworm | seed: 434 D symlink /usr/bin/python3.11 to /home/zuul/src/github.com/osism/generics/.tox/seed/bin/python [virtualenv/util/path/_sync.py:42] 2026-09-21 03:15:10.594722 | debian-bookworm | seed: 435 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-09-21 03:15:10.595087 | debian-bookworm | seed: 435 D debug via /home/zuul/src/github.com/osism/generics/.tox/seed/bin/python /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/create/debug.py [virtualenv/create/creator.py:265] 2026-09-21 03:15:10.641101 | debian-bookworm | seed: 435 D { 2026-09-21 03:15:10.641174 | debian-bookworm | "sys": { 2026-09-21 03:15:10.641182 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/seed/bin/python", 2026-09-21 03:15:10.641188 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-09-21 03:15:10.641202 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-21 03:15:10.641209 | debian-bookworm | "base_prefix": "/usr", 2026-09-21 03:15:10.641215 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-21 03:15:10.641221 | debian-bookworm | "base_exec_prefix": "/usr", 2026-09-21 03:15:10.641225 | debian-bookworm | "path": [ 2026-09-21 03:15:10.641230 | debian-bookworm | "/usr/lib/python311.zip", 2026-09-21 03:15:10.641235 | debian-bookworm | "/usr/lib/python3.11", 2026-09-21 03:15:10.641239 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-09-21 03:15:10.641244 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages" 2026-09-21 03:15:10.641249 | debian-bookworm | ], 2026-09-21 03:15:10.641254 | debian-bookworm | "meta_path": [ 2026-09-21 03:15:10.641258 | debian-bookworm | "", 2026-09-21 03:15:10.641264 | debian-bookworm | "", 2026-09-21 03:15:10.641269 | debian-bookworm | "" 2026-09-21 03:15:10.641273 | debian-bookworm | ], 2026-09-21 03:15:10.641277 | debian-bookworm | "fs_encoding": "utf-8", 2026-09-21 03:15:10.641282 | debian-bookworm | "io_encoding": "utf-8" 2026-09-21 03:15:10.641287 | debian-bookworm | }, 2026-09-21 03:15:10.641291 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-09-21 03:15:10.641296 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-09-21 03:15:10.641301 | debian-bookworm | "os": "", 2026-09-21 03:15:10.641305 | debian-bookworm | "site": "", 2026-09-21 03:15:10.641315 | debian-bookworm | "datetime": "", 2026-09-21 03:15:10.641319 | debian-bookworm | "math": "", 2026-09-21 03:15:10.641324 | debian-bookworm | "json": "" 2026-09-21 03:15:10.641328 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-09-21 03:15:10.641476 | debian-bookworm | seed: 481 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-09-21 03:15:10.652775 | debian-bookworm | seed: 493 D install pip from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/pip-26.2.1-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-09-21 03:15:10.653487 | debian-bookworm | seed: 493 D install setuptools from wheel /home/zuul/.local/tox/lib/python3.11/site-packages/virtualenv/seed/wheels/embed/setuptools-84.0.0-py3-none-any.whl via CopyPipInstall [virtualenv/seed/embed/via_app_data/via_app_data.py:65] 2026-09-21 03:15:10.655332 | debian-bookworm | seed: 495 D build install image for pip-26.2.1-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.2.1-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-09-21 03:15:10.655756 | debian-bookworm | seed: 496 D build install image for setuptools-84.0.0-py3-none-any.whl to /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any [virtualenv/seed/embed/via_app_data/pip_install/base.py:81] 2026-09-21 03:15:11.020478 | debian-bookworm | seed: 860 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any/setuptools to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/setuptools [virtualenv/util/path/_sync.py:50] 2026-09-21 03:15:11.140777 | debian-bookworm | seed: 981 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.2.1-py3-none-any/pip to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/pip [virtualenv/util/path/_sync.py:50] 2026-09-21 03:15:11.181601 | debian-bookworm | seed: 1021 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any/setuptools-84.0.0.dist-info to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/setuptools-84.0.0.dist-info [virtualenv/util/path/_sync.py:50] 2026-09-21 03:15:11.187160 | debian-bookworm | seed: 1027 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any/distutils-precedence.pth to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/distutils-precedence.pth [virtualenv/util/path/_sync.py:50] 2026-09-21 03:15:11.187797 | debian-bookworm | seed: 1028 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any/setuptools-84.0.0.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/setuptools-84.0.0.virtualenv [virtualenv/util/path/_sync.py:50] 2026-09-21 03:15:11.188812 | debian-bookworm | seed: 1028 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/setuptools-84.0.0-py3-none-any/_distutils_hack to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/_distutils_hack [virtualenv/util/path/_sync.py:50] 2026-09-21 03:15:11.191159 | debian-bookworm | seed: 1031 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-21 03:15:11.224061 | debian-bookworm | seed: 1064 D copy /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.2.1-py3-none-any/pip-26.2.1.virtualenv to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/pip-26.2.1.virtualenv [virtualenv/util/path/_sync.py:50] 2026-09-21 03:15:11.224600 | debian-bookworm | seed: 1064 D copy directory /home/zuul/.cache/virtualenv/wheel/3.11/image/1/CopyPipInstall/pip-26.2.1-py3-none-any/pip-26.2.1.dist-info to /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages/pip-26.2.1.dist-info [virtualenv/util/path/_sync.py:50] 2026-09-21 03:15:11.229650 | debian-bookworm | seed: 1070 D generated console scripts pip3.11 pip3 pip pip-3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-21 03:15:11.230443 | debian-bookworm | seed: 1070 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-09-21 03:15:11.240711 | debian-bookworm | seed: 1080 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-21 03:15:11.240854 | debian-bookworm | seed: 1081 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.240992 | debian-bookworm | seed: 1081 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.241174 | debian-bookworm | seed: 1081 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.241296 | debian-bookworm | seed: 1081 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.241434 | debian-bookworm | seed: 1081 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.241535 | debian-bookworm | seed: 1081 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/seed [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.241651 | debian-bookworm | seed: 1082 D virtualenv = 21.9.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.241767 | debian-bookworm | seed: 1082 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.241888 | debian-bookworm | seed: 1082 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.242014 | debian-bookworm | seed: 1082 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.242148 | debian-bookworm | seed: 1082 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-21 03:15:11.247609 | debian-bookworm | seed: OK (0.80 seconds) 2026-09-21 03:15:11.247651 | debian-bookworm | congratulations :) (0.83 seconds) 2026-09-21 03:15:11.781477 | debian-bookworm | ok: Runtime: 0:00:01.227100 2026-09-21 03:15:11.787805 | 2026-09-21 03:15:11.787891 | TASK [tox : Create a tempfile to save tox showconfig] 2026-09-21 03:15:12.309451 | debian-bookworm | changed 2026-09-21 03:15:12.313668 | 2026-09-21 03:15:12.313755 | TASK [tox : Detect tox version] 2026-09-21 03:15:12.960944 | debian-bookworm | 4.63.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-21 03:15:13.362255 | debian-bookworm | ok: Runtime: 0:00:00.368169 2026-09-21 03:15:13.367639 | 2026-09-21 03:15:13.367720 | TASK [tox : Get tox envlist config] 2026-09-21 03:15:14.423052 | debian-bookworm | ok: Runtime: 0:00:00.360569 2026-09-21 03:15:14.427996 | 2026-09-21 03:15:14.428094 | TASK [tox : Install any sibling python packages] 2026-09-21 03:15:14.823102 | debian-bookworm | ok: No setup.cfg, no action needed 2026-09-21 03:15:14.827495 | 2026-09-21 03:15:14.827571 | TASK [tox : Remove tempfile] 2026-09-21 03:15:15.230294 | debian-bookworm | changed 2026-09-21 03:15:15.234645 | 2026-09-21 03:15:15.234759 | TASK [tox : Emit tox command] 2026-09-21 03:15:15.261294 | /home/zuul/.local/tox/bin/tox -eseed -vv --skip-missing-interpreters=false 2026-09-21 03:15:15.265269 | 2026-09-21 03:15:15.265347 | TASK [tox : Run tox] 2026-09-21 03:15:15.806112 | debian-bookworm | ROOT: 215 D setup logging to DEBUG on pid 1627 [tox/report.py:249] 2026-09-21 03:15:15.837511 | debian-bookworm | seed: 246 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-21 03:15:15.840203 | debian-bookworm | seed: 249 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-21 03:15:15.844023 | debian-bookworm | seed: 253 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-09-21 03:15:15.844390 | debian-bookworm | seed: 253 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-21 03:15:15.844549 | debian-bookworm | seed: 253 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-09-21 03:15:15.844602 | debian-bookworm | seed: 253 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-09-21 03:15:15.846191 | debian-bookworm | seed: 255 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-21 03:15:15.846244 | debian-bookworm | seed: 255 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-21 03:15:15.876443 | debian-bookworm | seed: 285 W commands[0]> bash src/test-seed.sh [tox/tox_env/api.py:487] 2026-09-21 03:15:16.377428 | debian-bookworm | PASS=44 FAIL=0 2026-09-21 03:15:16.378702 | debian-bookworm | seed: 787 I exit 0 (0.50 seconds) /home/zuul/src/github.com/osism/generics> bash src/test-seed.sh pid=1634 [tox/execute/api.py:337] 2026-09-21 03:15:16.379524 | debian-bookworm | seed: OK (0.55=setup[0.04]+cmd[0.50] seconds) 2026-09-21 03:15:16.379539 | debian-bookworm | congratulations :) (0.58 seconds) 2026-09-21 03:15:16.792395 | debian-bookworm | ok: Runtime: 0:00:00.904537 2026-09-21 03:15:16.798374 | 2026-09-21 03:15:16.798467 | TASK [tox : Look for output] 2026-09-21 03:15:17.149651 | debian-bookworm | ok 2026-09-21 03:15:17.175407 | 2026-09-21 03:15:17.175511 | TASK [tox : Return file comments to Zuul] 2026-09-21 03:15:17.230468 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:17.239444 | 2026-09-21 03:15:17.239613 | PLAY RECAP 2026-09-21 03:15:17.239667 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-21 03:15:17.239692 | 2026-09-21 03:15:17.369093 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-21 03:15:17.369879 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-21 03:15:18.537571 | 2026-09-21 03:15:18.537678 | PLAY [all] 2026-09-21 03:15:18.558951 | 2026-09-21 03:15:18.559055 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-09-21 03:15:18.622531 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:18.627238 | 2026-09-21 03:15:18.627339 | TASK [fetch-tox-output : Set tox log path for single node] 2026-09-21 03:15:18.653343 | debian-bookworm | ok 2026-09-21 03:15:18.657469 | 2026-09-21 03:15:18.657567 | TASK [fetch-tox-output : Ensure local tox dir] 2026-09-21 03:15:19.382773 | debian-bookworm -> localhost | changed 2026-09-21 03:15:19.389852 | 2026-09-21 03:15:19.389952 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-09-21 03:15:19.439639 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:19.445705 | 2026-09-21 03:15:19.445789 | TASK [fetch-tox-output : Set envlist fact] 2026-09-21 03:15:19.483356 | debian-bookworm | ok 2026-09-21 03:15:19.488068 | 2026-09-21 03:15:19.488144 | TASK [fetch-tox-output : Get tox version] 2026-09-21 03:15:20.258810 | 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-09-21 03:15:20.287618 | debian-bookworm | 4.63.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-21 03:15:20.522694 | debian-bookworm | ok: Runtime: 0:00:00.438155 2026-09-21 03:15:20.528471 | 2026-09-21 03:15:20.528563 | TASK [fetch-tox-output : Find all default environments] 2026-09-21 03:15:21.084303 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:21.089280 | 2026-09-21 03:15:21.089367 | TASK [fetch-tox-output : Set envlist fact] 2026-09-21 03:15:21.124303 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:21.132852 | 2026-09-21 03:15:21.132933 | TASK [fetch-tox-output : Find all default environments] 2026-09-21 03:15:21.657414 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:21.662228 | 2026-09-21 03:15:21.662318 | TASK [fetch-tox-output : Set envlist fact] 2026-09-21 03:15:21.684969 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:21.690193 | 2026-09-21 03:15:21.690285 | LOOP [fetch-tox-output : Copy tox logs] 2026-09-21 03:15:21.746500 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:21.759784 | 2026-09-21 03:15:21.759874 | LOOP [fetch-tox-output : Collect tox logs] 2026-09-21 03:15:22.606843 | debian-bookworm | changed: 2026-09-21 03:15:22.606999 | debian-bookworm | created directory /var/lib/zuul/builds/0bc8e37b9b33424db3df5834d0058a07/work/logs/tox/seed 2026-09-21 03:15:22.607027 | debian-bookworm | cd+++++++++ ./ 2026-09-21 03:15:22.607048 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-09-21 03:15:22.607071 | 2026-09-21 03:15:22.620800 | 2026-09-21 03:15:22.620873 | PLAY RECAP 2026-09-21 03:15:22.620914 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-09-21 03:15:22.620934 | 2026-09-21 03:15:22.785369 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-21 03:15:22.786156 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-21 03:15:23.694239 | 2026-09-21 03:15:23.694347 | PLAY [all] 2026-09-21 03:15:23.706186 | 2026-09-21 03:15:23.706287 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-09-21 03:15:23.896140 | debian-bookworm | changed: non-zero return code 2026-09-21 03:15:23.900598 | 2026-09-21 03:15:23.900698 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-09-21 03:15:23.940065 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:23.944776 | 2026-09-21 03:15:23.944870 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-09-21 03:15:23.993017 | 2026-09-21 03:15:23.993166 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-09-21 03:15:24.032007 | 2026-09-21 03:15:24.032161 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-09-21 03:15:24.080288 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:24.085237 | 2026-09-21 03:15:24.085325 | LOOP [fetch-subunit-output : Generate subunit file] 2026-09-21 03:15:24.132561 | 2026-09-21 03:15:24.132720 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-09-21 03:15:24.155519 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:24.160113 | 2026-09-21 03:15:24.160197 | TASK [fetch-subunit-output : Remove the temporary file] 2026-09-21 03:15:24.192964 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:24.197626 | 2026-09-21 03:15:24.197712 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-09-21 03:15:24.220347 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:24.225442 | 2026-09-21 03:15:24.225508 | PLAY RECAP 2026-09-21 03:15:24.225577 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-09-21 03:15:24.225599 | 2026-09-21 03:15:24.406812 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-21 03:15:24.407578 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-21 03:15:25.605431 | 2026-09-21 03:15:25.605558 | PLAY [Base post-fetch] 2026-09-21 03:15:25.660590 | 2026-09-21 03:15:25.660704 | TASK [diagnose-network : Ensure log directory exists] 2026-09-21 03:15:26.050250 | debian-bookworm | ok 2026-09-21 03:15:26.056487 | 2026-09-21 03:15:26.056594 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-09-21 03:15:37.880258 | debian-bookworm | ok: Runtime: 0:00:05.978447 2026-09-21 03:15:37.896311 | 2026-09-21 03:15:37.896469 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-09-21 03:15:44.146637 | debian-bookworm | ok: Runtime: 0:00:00.009515 2026-09-21 03:15:44.151956 | 2026-09-21 03:15:44.152057 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-09-21 03:15:50.246066 | debian-bookworm | ok: Runtime: 0:00:00.010222 2026-09-21 03:15:50.251644 | 2026-09-21 03:15:50.251901 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)] 2026-09-21 03:15:50.788556 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:50.802604 | 2026-09-21 03:15:50.802789 | TASK [diagnose-network : Abort the pre-run on a fully isolated node] 2026-09-21 03:15:50.859838 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:50.881823 | 2026-09-21 03:15:50.882029 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-21 03:15:50.927197 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:50.940772 | 2026-09-21 03:15:50.940973 | TASK [fetch-output : Set log path for single node] 2026-09-21 03:15:50.990560 | debian-bookworm | ok 2026-09-21 03:15:50.999164 | 2026-09-21 03:15:50.999306 | LOOP [fetch-output : Ensure local output dirs] 2026-09-21 03:15:51.349115 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/0bc8e37b9b33424db3df5834d0058a07/work/logs" 2026-09-21 03:15:51.642954 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0bc8e37b9b33424db3df5834d0058a07/work/artifacts" 2026-09-21 03:15:51.912120 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0bc8e37b9b33424db3df5834d0058a07/work/docs" 2026-09-21 03:15:51.921308 | 2026-09-21 03:15:51.921417 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-21 03:15:52.684179 | debian-bookworm | changed: 2026-09-21 03:15:52.684421 | debian-bookworm | .d..t...... ./ 2026-09-21 03:15:52.684502 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-21 03:15:52.684531 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-21 03:15:52.684554 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-21 03:15:52.684576 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-21 03:15:52.684597 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-21 03:15:52.684637 | debian-bookworm | changed: All items complete 2026-09-21 03:15:52.684658 | 2026-09-21 03:15:53.266889 | debian-bookworm | changed: .d..t...... ./ 2026-09-21 03:15:53.869259 | debian-bookworm | changed: .d..t...... ./ 2026-09-21 03:15:53.886274 | 2026-09-21 03:15:53.886411 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-21 03:15:53.919554 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:53.929786 | debian-bookworm | skipping: Conditional result was False 2026-09-21 03:15:53.946089 | 2026-09-21 03:15:53.946198 | PLAY RECAP 2026-09-21 03:15:53.946255 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-21 03:15:53.946280 | 2026-09-21 03:15:54.123830 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-21 03:15:54.126241 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-21 03:15:54.934362 | 2026-09-21 03:15:54.934513 | PLAY [Base post] 2026-09-21 03:15:54.948626 | 2026-09-21 03:15:54.948761 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-21 03:15:55.618647 | debian-bookworm | changed 2026-09-21 03:15:55.625337 | 2026-09-21 03:15:55.625446 | PLAY RECAP 2026-09-21 03:15:55.625507 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-21 03:15:55.625607 | 2026-09-21 03:15:55.748854 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-21 03:15:55.749991 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-21 03:15:56.589886 | 2026-09-21 03:15:56.590071 | PLAY [Base post-logs] 2026-09-21 03:15:56.600516 | 2026-09-21 03:15:56.600646 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-21 03:15:57.093362 | localhost | changed 2026-09-21 03:15:57.104331 | 2026-09-21 03:15:57.104471 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-21 03:15:57.130028 | localhost | ok 2026-09-21 03:15:57.133844 | 2026-09-21 03:15:57.134097 | TASK [Set zuul-log-path fact] 2026-09-21 03:15:57.148743 | localhost | ok 2026-09-21 03:15:57.157910 | 2026-09-21 03:15:57.158040 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-21 03:15:57.182670 | localhost | ok 2026-09-21 03:15:57.185636 | 2026-09-21 03:15:57.185743 | TASK [upload-logs : Create log directories] 2026-09-21 03:15:57.733689 | localhost | changed 2026-09-21 03:15:57.736865 | 2026-09-21 03:15:57.737149 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-21 03:15:58.250339 | localhost -> localhost | ok: Runtime: 0:00:00.013432 2026-09-21 03:15:58.255252 | 2026-09-21 03:15:58.255392 | TASK [upload-logs : Upload logs to log server] 2026-09-21 03:15:58.867897 | localhost | Output suppressed because no_log was given 2026-09-21 03:15:58.871130 | 2026-09-21 03:15:58.871249 | LOOP [upload-logs : Compress console log and json output] 2026-09-21 03:15:58.928572 | localhost | skipping: Conditional result was False 2026-09-21 03:15:58.934214 | localhost | skipping: Conditional result was False 2026-09-21 03:15:58.941537 | 2026-09-21 03:15:58.941804 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-21 03:15:58.996376 | localhost | skipping: Conditional result was False 2026-09-21 03:15:58.996641 | 2026-09-21 03:15:59.011555 | localhost | skipping: Conditional result was False 2026-09-21 03:15:59.024527 | 2026-09-21 03:15:59.024663 | LOOP [upload-logs : Upload console log and json output]