2026-09-20 03:06:25.666684 | Job console starting 2026-09-20 03:06:25.680201 | Updating git repos 2026-09-20 03:06:25.701994 | Cloning repos into workspace 2026-09-20 03:06:25.746408 | Restoring repo states 2026-09-20 03:06:25.757665 | Merging changes 2026-09-20 03:06:25.757677 | Checking out repos 2026-09-20 03:06:25.793132 | Preparing playbooks 2026-09-20 03:06:26.431261 | Running Ansible setup 2026-09-20 03:06:31.421234 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-20 03:06:32.171365 | 2026-09-20 03:06:32.171488 | PLAY [Base pre] 2026-09-20 03:06:32.187540 | 2026-09-20 03:06:32.187649 | TASK [Setup log path fact] 2026-09-20 03:06:32.205401 | debian-bookworm | ok 2026-09-20 03:06:32.220171 | 2026-09-20 03:06:32.220288 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-20 03:06:32.247845 | debian-bookworm | ok 2026-09-20 03:06:32.257159 | 2026-09-20 03:06:32.257246 | TASK [emit-job-header : Print job information] 2026-09-20 03:06:32.295690 | # Job Information 2026-09-20 03:06:32.295862 | Ansible Version: 2.16.14 2026-09-20 03:06:32.295912 | Job: generics-tox-seed 2026-09-20 03:06:32.295951 | Pipeline: periodic-daily 2026-09-20 03:06:32.295978 | Executor: 521e9411259a 2026-09-20 03:06:32.296002 | Triggered by: https://github.com/osism/generics 2026-09-20 03:06:32.296026 | Event ID: 35e4e94e9ea046539d2b7cca65a8a9af 2026-09-20 03:06:32.300973 | 2026-09-20 03:06:32.301058 | LOOP [emit-job-header : Print node information] 2026-09-20 03:06:32.420851 | debian-bookworm | ok: 2026-09-20 03:06:32.421076 | debian-bookworm | # Node Information 2026-09-20 03:06:32.421112 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-20 03:06:32.421137 | debian-bookworm | Hostname: debian 2026-09-20 03:06:32.421158 | debian-bookworm | Username: zuul 2026-09-20 03:06:32.421179 | debian-bookworm | Distro: Debian 12.15 2026-09-20 03:06:32.421206 | debian-bookworm | Provider: regiocloud-a 2026-09-20 03:06:32.421228 | debian-bookworm | Region: 2026-09-20 03:06:32.421249 | debian-bookworm | Label: debian-bookworm 2026-09-20 03:06:32.421269 | debian-bookworm | Product Name: OpenStack Nova 2026-09-20 03:06:32.421289 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5a:7ee7 2026-09-20 03:06:32.434452 | 2026-09-20 03:06:32.434557 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-20 03:06:32.841114 | debian-bookworm -> localhost | changed 2026-09-20 03:06:32.855669 | 2026-09-20 03:06:32.855830 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-20 03:06:33.873923 | debian-bookworm -> localhost | changed 2026-09-20 03:06:33.884768 | 2026-09-20 03:06:33.884869 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-20 03:06:34.182777 | debian-bookworm -> localhost | ok 2026-09-20 03:06:34.192845 | 2026-09-20 03:06:34.193109 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-20 03:06:34.226145 | debian-bookworm | ok 2026-09-20 03:06:34.241058 | debian-bookworm | included: /var/lib/zuul/builds/805e33ed19794201b84e35d345a3629c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-20 03:06:34.246887 | 2026-09-20 03:06:34.247003 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-20 03:06:36.566684 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-20 03:06:36.566886 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/805e33ed19794201b84e35d345a3629c/work/805e33ed19794201b84e35d345a3629c_id_rsa 2026-09-20 03:06:36.566940 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/805e33ed19794201b84e35d345a3629c/work/805e33ed19794201b84e35d345a3629c_id_rsa.pub 2026-09-20 03:06:36.566968 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-20 03:06:36.566994 | debian-bookworm -> localhost | SHA256:l1eSPdfKwHJDVNbt+2L8/gRklpJMELKe5jm8bta372I zuul-build-sshkey 2026-09-20 03:06:36.567019 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-20 03:06:36.567052 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-20 03:06:36.567074 | debian-bookworm -> localhost | | . o++.o..| 2026-09-20 03:06:36.567096 | debian-bookworm -> localhost | | o = = .+| 2026-09-20 03:06:36.567117 | debian-bookworm -> localhost | | . . @ O.o| 2026-09-20 03:06:36.567136 | debian-bookworm -> localhost | | . . + @ +.| 2026-09-20 03:06:36.567156 | debian-bookworm -> localhost | | S o . + .| 2026-09-20 03:06:36.567179 | debian-bookworm -> localhost | | + o . o | 2026-09-20 03:06:36.567200 | debian-bookworm -> localhost | | =. . o| 2026-09-20 03:06:36.567220 | debian-bookworm -> localhost | | oo. E +..| 2026-09-20 03:06:36.567241 | debian-bookworm -> localhost | | +o o.*o+=| 2026-09-20 03:06:36.567261 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-20 03:06:36.567320 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.837944 2026-09-20 03:06:36.593051 | 2026-09-20 03:06:36.593161 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-20 03:06:36.626271 | debian-bookworm | ok 2026-09-20 03:06:36.645199 | debian-bookworm | included: /var/lib/zuul/builds/805e33ed19794201b84e35d345a3629c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-20 03:06:36.672692 | 2026-09-20 03:06:36.672791 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-20 03:06:36.710730 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:06:36.717388 | 2026-09-20 03:06:36.717483 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-20 03:06:37.935651 | debian-bookworm | changed 2026-09-20 03:06:37.943680 | 2026-09-20 03:06:37.943770 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-20 03:06:38.250590 | debian-bookworm | ok 2026-09-20 03:06:38.256740 | 2026-09-20 03:06:38.256835 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-20 03:06:38.953227 | debian-bookworm | changed 2026-09-20 03:06:38.957844 | 2026-09-20 03:06:38.957936 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-20 03:06:39.634492 | debian-bookworm | changed 2026-09-20 03:06:39.639830 | 2026-09-20 03:06:39.639939 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-20 03:06:39.653197 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:06:39.659876 | 2026-09-20 03:06:39.659985 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-20 03:06:40.233459 | debian-bookworm -> localhost | changed 2026-09-20 03:06:40.245235 | 2026-09-20 03:06:40.245330 | TASK [add-build-sshkey : Add back temp key] 2026-09-20 03:06:40.758435 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/805e33ed19794201b84e35d345a3629c/work/805e33ed19794201b84e35d345a3629c_id_rsa (zuul-build-sshkey) 2026-09-20 03:06:40.758639 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.033658 2026-09-20 03:06:40.766046 | 2026-09-20 03:06:40.766136 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-20 03:06:41.165736 | debian-bookworm | ok 2026-09-20 03:06:41.173783 | 2026-09-20 03:06:41.173915 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-20 03:06:41.197566 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:06:41.214086 | 2026-09-20 03:06:41.214186 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-20 03:06:41.629352 | debian-bookworm | ok 2026-09-20 03:06:41.645312 | 2026-09-20 03:06:41.645489 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-20 03:06:41.688760 | debian-bookworm | ok 2026-09-20 03:06:41.696296 | 2026-09-20 03:06:41.696400 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-20 03:06:41.995236 | debian-bookworm -> localhost | ok 2026-09-20 03:06:42.001786 | 2026-09-20 03:06:42.001879 | TASK [validate-host : Collect information about the host] 2026-09-20 03:06:43.151825 | debian-bookworm | ok 2026-09-20 03:06:43.164135 | 2026-09-20 03:06:43.164227 | TASK [validate-host : Sanitize hostname] 2026-09-20 03:06:43.269189 | debian-bookworm | ok 2026-09-20 03:06:43.273484 | 2026-09-20 03:06:43.273590 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-20 03:06:43.744313 | debian-bookworm -> localhost | changed 2026-09-20 03:06:43.749954 | 2026-09-20 03:06:43.750050 | TASK [validate-host : Collect information about zuul worker] 2026-09-20 03:06:44.144077 | debian-bookworm | ok 2026-09-20 03:06:44.148794 | 2026-09-20 03:06:44.148881 | TASK [validate-host : Write out all zuul information for each host] 2026-09-20 03:06:44.701500 | debian-bookworm -> localhost | changed 2026-09-20 03:06:44.710739 | 2026-09-20 03:06:44.710827 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-20 03:06:45.013917 | debian-bookworm | ok 2026-09-20 03:06:45.022101 | 2026-09-20 03:06:45.022217 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-20 03:06:45.827478 | debian-bookworm | changed: 2026-09-20 03:06:45.827717 | debian-bookworm | cd+++++++++ src/ 2026-09-20 03:06:45.827755 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-20 03:06:45.827779 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-20 03:06:45.827801 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-09-20 03:06:45.827822 | debian-bookworm | =7.0.3 2026-09-20 03:07:25.223887 | debian-bookworm | Downloading cachetools-7.2.0-py3-none-any.whl (16 kB) 2026-09-20 03:07:25.280730 | debian-bookworm | Collecting colorama>=0.4.6 2026-09-20 03:07:25.293759 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-09-20 03:07:25.394183 | debian-bookworm | Collecting filelock>=3.25 2026-09-20 03:07:25.407847 | debian-bookworm | Downloading filelock-4.0.1-py3-none-any.whl (106 kB) 2026-09-20 03:07:25.425396 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 106.2/106.2 kB 8.3 MB/s eta 0:00:00 2026-09-20 03:07:25.509745 | debian-bookworm | Collecting packaging>=26 2026-09-20 03:07:25.523334 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-09-20 03:07:25.541439 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 9.7 MB/s eta 0:00:00 2026-09-20 03:07:25.623144 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-09-20 03:07:25.636496 | debian-bookworm | Downloading platformdirs-4.11.11-py3-none-any.whl (24 kB) 2026-09-20 03:07:25.719965 | debian-bookworm | Collecting pluggy>=1.6 2026-09-20 03:07:25.731712 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-09-20 03:07:25.784514 | debian-bookworm | Collecting pyproject-api>=1.10 2026-09-20 03:07:25.796322 | debian-bookworm | Downloading pyproject_api-1.11.2-py3-none-any.whl (13 kB) 2026-09-20 03:07:25.863559 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-09-20 03:07:25.877777 | debian-bookworm | Downloading python_discovery-1.6.1-py3-none-any.whl (38 kB) 2026-09-20 03:07:25.930276 | debian-bookworm | Collecting tomli-w>=1.2 2026-09-20 03:07:25.943238 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-09-20 03:07:26.004798 | debian-bookworm | Collecting typing-extensions>=4.15 2026-09-20 03:07:26.017932 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-09-20 03:07:26.028799 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 5.9 MB/s eta 0:00:00 2026-09-20 03:07:26.225582 | debian-bookworm | Collecting virtualenv>=21.1 2026-09-20 03:07:26.237017 | debian-bookworm | Downloading virtualenv-21.9.0-py3-none-any.whl (5.5 MB) 2026-09-20 03:07:26.536976 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 18.6 MB/s eta 0:00:00 2026-09-20 03:07:26.660621 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-09-20 03:07:26.673624 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-09-20 03:07:26.693532 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 29.1 MB/s eta 0:00:00 2026-09-20 03:07:26.714632 | debian-bookworm | Collecting filelock>=3.25 2026-09-20 03:07:26.727393 | debian-bookworm | Downloading filelock-3.32.7-py3-none-any.whl (100 kB) 2026-09-20 03:07:26.740423 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 12.6 MB/s eta 0:00:00 2026-09-20 03:07:26.870679 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-09-20 03:07:27.898329 | 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-20 03:07:28.464186 | debian-bookworm | ok: Runtime: 0:00:03.855405 2026-09-20 03:07:28.469093 | 2026-09-20 03:07:28.469179 | TASK [ensure-tox : Export installed tox_executable path] 2026-09-20 03:07:28.553495 | debian-bookworm | ok 2026-09-20 03:07:28.574484 | 2026-09-20 03:07:28.574592 | TASK [ensure-tox : Output tox version] 2026-09-20 03:07:29.365531 | 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-20 03:07:29.393408 | debian-bookworm | 4.63.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-20 03:07:29.667651 | debian-bookworm | ok: Runtime: 0:00:00.419572 2026-09-20 03:07:29.672136 | 2026-09-20 03:07:29.672212 | TASK [ensure-tox : Make global symlink] 2026-09-20 03:07:29.715572 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:29.722058 | 2026-09-20 03:07:29.722129 | PLAY RECAP 2026-09-20 03:07:29.722179 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-09-20 03:07:29.722200 | 2026-09-20 03:07:30.230516 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-09-20 03:07:30.231309 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-20 03:07:31.668971 | 2026-09-20 03:07:31.669157 | PLAY [all] 2026-09-20 03:07:31.682436 | 2026-09-20 03:07:31.682535 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-09-20 03:07:32.213419 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-20 03:07:32.727568 | debian-bookworm | ok: Runtime: 0:00:00.036923 2026-09-20 03:07:32.732051 | 2026-09-20 03:07:32.732149 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-09-20 03:07:33.295078 | debian-bookworm | ok: Runtime: 0:00:00.006378 2026-09-20 03:07:33.302345 | 2026-09-20 03:07:33.309800 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-09-20 03:07:33.661453 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-20 03:07:33.662915 | debian-bookworm | sudo: a password is required 2026-09-20 03:07:33.863974 | debian-bookworm | ok: Runtime: 0:00:00.023453 2026-09-20 03:07:33.874595 | 2026-09-20 03:07:33.874683 | TASK [tox : Check to see if the constraints file exists] 2026-09-20 03:07:33.907744 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:33.915459 | 2026-09-20 03:07:33.915565 | TASK [tox : Fail if constraints file is missing] 2026-09-20 03:07:33.939790 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:33.947528 | 2026-09-20 03:07:33.947612 | TASK [tox : Record file location] 2026-09-20 03:07:33.970357 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:33.975615 | 2026-09-20 03:07:33.975699 | TASK [tox : Install tox siblings] 2026-09-20 03:07:34.004457 | debian-bookworm | ok 2026-09-20 03:07:34.011736 | debian-bookworm | included: /var/lib/zuul/builds/805e33ed19794201b84e35d345a3629c/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-09-20 03:07:34.016490 | 2026-09-20 03:07:34.016567 | TASK [tox : Run tox without tests] 2026-09-20 03:07:34.636025 | debian-bookworm | ROOT: 264 D setup logging to DEBUG on pid 1595 [tox/report.py:249] 2026-09-20 03:07:34.672876 | debian-bookworm | seed: 301 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-20 03:07:34.677840 | debian-bookworm | seed: 306 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-20 03:07:34.682527 | debian-bookworm | seed: 311 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 f8e8058f84078d81258baed16300e76c 474f4614e018affd2a14c114e4d8d7f5 [python_discovery/_cached_py_info.py:223] 2026-09-20 03:07:34.756038 | debian-bookworm | seed: 384 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-20 03:07:34.756614 | debian-bookworm | seed: 385 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-20 03:07:34.756967 | debian-bookworm | seed: 385 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-20 03:07:34.757090 | debian-bookworm | seed: 386 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-20 03:07:34.760778 | debian-bookworm | seed: 389 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-20 03:07:34.761103 | debian-bookworm | seed: 390 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-20 03:07:34.807394 | debian-bookworm | seed: 436 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-20 03:07:34.807630 | debian-bookworm | seed: 436 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/bin [virtualenv/util/path/_sync.py:22] 2026-09-20 03:07:34.807812 | debian-bookworm | seed: 436 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/include [virtualenv/util/path/_sync.py:22] 2026-09-20 03:07:34.807918 | debian-bookworm | seed: 437 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-20 03:07:34.808185 | debian-bookworm | seed: 437 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-20 03:07:34.808293 | debian-bookworm | seed: 437 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:34.808359 | debian-bookworm | seed: 437 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:34.808404 | debian-bookworm | seed: 437 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:34.808463 | debian-bookworm | seed: 437 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:34.808516 | debian-bookworm | seed: 437 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:34.808574 | debian-bookworm | seed: 437 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-20 03:07:34.808626 | debian-bookworm | seed: 437 D virtualenv = 21.9.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:34.808684 | debian-bookworm | seed: 437 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:34.808738 | debian-bookworm | seed: 437 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:34.808789 | debian-bookworm | seed: 437 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:34.808839 | debian-bookworm | seed: 438 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:34.809222 | debian-bookworm | seed: 438 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-20 03:07:34.809842 | debian-bookworm | seed: 438 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-09-20 03:07:34.810121 | debian-bookworm | seed: 439 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-20 03:07:34.857624 | debian-bookworm | seed: 438 D { 2026-09-20 03:07:34.857683 | debian-bookworm | "sys": { 2026-09-20 03:07:34.857691 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/seed/bin/python", 2026-09-20 03:07:34.857696 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-09-20 03:07:34.857704 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-20 03:07:34.857710 | debian-bookworm | "base_prefix": "/usr", 2026-09-20 03:07:34.857716 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-20 03:07:34.857721 | debian-bookworm | "base_exec_prefix": "/usr", 2026-09-20 03:07:34.857725 | debian-bookworm | "path": [ 2026-09-20 03:07:34.857729 | debian-bookworm | "/usr/lib/python311.zip", 2026-09-20 03:07:34.857733 | debian-bookworm | "/usr/lib/python3.11", 2026-09-20 03:07:34.857737 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-09-20 03:07:34.857741 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages" 2026-09-20 03:07:34.857745 | debian-bookworm | ], 2026-09-20 03:07:34.857750 | debian-bookworm | "meta_path": [ 2026-09-20 03:07:34.857753 | debian-bookworm | "", 2026-09-20 03:07:34.857757 | debian-bookworm | "", 2026-09-20 03:07:34.857761 | debian-bookworm | "" 2026-09-20 03:07:34.857765 | debian-bookworm | ], 2026-09-20 03:07:34.857769 | debian-bookworm | "fs_encoding": "utf-8", 2026-09-20 03:07:34.857773 | debian-bookworm | "io_encoding": "utf-8" 2026-09-20 03:07:34.857777 | debian-bookworm | }, 2026-09-20 03:07:34.857781 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-09-20 03:07:34.857785 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-09-20 03:07:34.857789 | debian-bookworm | "os": "", 2026-09-20 03:07:34.857793 | debian-bookworm | "site": "", 2026-09-20 03:07:34.857802 | debian-bookworm | "datetime": "", 2026-09-20 03:07:34.857806 | debian-bookworm | "math": "", 2026-09-20 03:07:34.857810 | debian-bookworm | "json": "" 2026-09-20 03:07:34.857814 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-09-20 03:07:34.858209 | debian-bookworm | seed: 486 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-20 03:07:34.867420 | debian-bookworm | seed: 496 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-20 03:07:34.874121 | debian-bookworm | seed: 497 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-20 03:07:34.874752 | debian-bookworm | seed: 503 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-20 03:07:34.877882 | debian-bookworm | seed: 506 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-20 03:07:35.336885 | debian-bookworm | seed: 965 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-20 03:07:35.337996 | debian-bookworm | seed: 966 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-20 03:07:35.338735 | debian-bookworm | seed: 967 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-20 03:07:35.344479 | debian-bookworm | seed: 973 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-20 03:07:35.413815 | debian-bookworm | seed: 1042 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-20 03:07:35.427938 | debian-bookworm | seed: 1056 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-20 03:07:35.428605 | debian-bookworm | seed: 1057 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-20 03:07:35.511823 | debian-bookworm | seed: 1140 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-20 03:07:35.512785 | debian-bookworm | seed: 1141 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-20 03:07:35.545741 | debian-bookworm | seed: 1174 D generated console scripts pip3 pip-3.11 pip pip3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-20 03:07:35.547018 | debian-bookworm | seed: 1175 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-09-20 03:07:35.556733 | debian-bookworm | seed: 1185 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-20 03:07:35.557053 | debian-bookworm | seed: 1186 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:35.557239 | debian-bookworm | seed: 1186 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:35.557393 | debian-bookworm | seed: 1186 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:35.557536 | debian-bookworm | seed: 1186 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:35.557670 | debian-bookworm | seed: 1186 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:35.557802 | debian-bookworm | seed: 1186 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-20 03:07:35.557946 | debian-bookworm | seed: 1187 D virtualenv = 21.9.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:35.558181 | debian-bookworm | seed: 1187 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:35.558321 | debian-bookworm | seed: 1187 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:35.558451 | debian-bookworm | seed: 1187 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:35.558579 | debian-bookworm | seed: 1187 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-20 03:07:35.563258 | debian-bookworm | seed: OK (0.90 seconds) 2026-09-20 03:07:35.563349 | debian-bookworm | congratulations :) (0.93 seconds) 2026-09-20 03:07:36.046897 | debian-bookworm | ok: Runtime: 0:00:01.330739 2026-09-20 03:07:36.052224 | 2026-09-20 03:07:36.052295 | TASK [tox : Create a tempfile to save tox showconfig] 2026-09-20 03:07:36.442297 | debian-bookworm | changed 2026-09-20 03:07:36.446521 | 2026-09-20 03:07:36.446605 | TASK [tox : Detect tox version] 2026-09-20 03:07:37.073379 | debian-bookworm | 4.63.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-20 03:07:37.474082 | debian-bookworm | ok: Runtime: 0:00:00.429943 2026-09-20 03:07:37.478929 | 2026-09-20 03:07:37.479006 | TASK [tox : Get tox envlist config] 2026-09-20 03:07:38.524265 | debian-bookworm | ok: Runtime: 0:00:00.484218 2026-09-20 03:07:38.528726 | 2026-09-20 03:07:38.528809 | TASK [tox : Install any sibling python packages] 2026-09-20 03:07:38.942069 | debian-bookworm | ok: No setup.cfg, no action needed 2026-09-20 03:07:38.946503 | 2026-09-20 03:07:38.946581 | TASK [tox : Remove tempfile] 2026-09-20 03:07:39.379759 | debian-bookworm | changed 2026-09-20 03:07:39.384025 | 2026-09-20 03:07:39.384096 | TASK [tox : Emit tox command] 2026-09-20 03:07:39.410668 | /home/zuul/.local/tox/bin/tox -eseed -vv --skip-missing-interpreters=false 2026-09-20 03:07:39.414605 | 2026-09-20 03:07:39.414680 | TASK [tox : Run tox] 2026-09-20 03:07:40.035853 | debian-bookworm | ROOT: 251 D setup logging to DEBUG on pid 1635 [tox/report.py:249] 2026-09-20 03:07:40.076351 | debian-bookworm | seed: 292 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-20 03:07:40.081029 | debian-bookworm | seed: 297 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-20 03:07:40.086577 | debian-bookworm | seed: 302 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-20 03:07:40.087115 | debian-bookworm | seed: 303 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-20 03:07:40.087307 | debian-bookworm | seed: 303 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-20 03:07:40.087425 | debian-bookworm | seed: 303 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-20 03:07:40.089517 | debian-bookworm | seed: 305 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-20 03:07:40.089596 | debian-bookworm | seed: 305 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-20 03:07:40.125587 | debian-bookworm | seed: 341 W commands[0]> bash src/test-seed.sh [tox/tox_env/api.py:487] 2026-09-20 03:07:40.814984 | debian-bookworm | PASS=44 FAIL=0 2026-09-20 03:07:40.817049 | debian-bookworm | seed: 1033 I exit 0 (0.69 seconds) /home/zuul/src/github.com/osism/generics> bash src/test-seed.sh pid=1642 [tox/execute/api.py:337] 2026-09-20 03:07:40.818740 | debian-bookworm | seed: OK (0.75=setup[0.06]+cmd[0.69] seconds) 2026-09-20 03:07:40.818771 | debian-bookworm | congratulations :) (0.78 seconds) 2026-09-20 03:07:40.959015 | debian-bookworm | ok: Runtime: 0:00:01.159483 2026-09-20 03:07:40.966230 | 2026-09-20 03:07:40.966328 | TASK [tox : Look for output] 2026-09-20 03:07:41.355973 | debian-bookworm | ok 2026-09-20 03:07:41.369830 | 2026-09-20 03:07:41.369940 | TASK [tox : Return file comments to Zuul] 2026-09-20 03:07:41.392813 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:41.400348 | 2026-09-20 03:07:41.400419 | PLAY RECAP 2026-09-20 03:07:41.400469 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-20 03:07:41.400493 | 2026-09-20 03:07:41.515746 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-20 03:07:41.516711 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-20 03:07:42.318042 | 2026-09-20 03:07:42.318164 | PLAY [all] 2026-09-20 03:07:42.331445 | 2026-09-20 03:07:42.331547 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-09-20 03:07:42.385077 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:42.390512 | 2026-09-20 03:07:42.390622 | TASK [fetch-tox-output : Set tox log path for single node] 2026-09-20 03:07:42.429512 | debian-bookworm | ok 2026-09-20 03:07:42.435354 | 2026-09-20 03:07:42.435515 | TASK [fetch-tox-output : Ensure local tox dir] 2026-09-20 03:07:42.822914 | debian-bookworm -> localhost | changed 2026-09-20 03:07:42.829041 | 2026-09-20 03:07:42.829123 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-09-20 03:07:42.882154 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:42.889189 | 2026-09-20 03:07:42.889304 | TASK [fetch-tox-output : Set envlist fact] 2026-09-20 03:07:42.923561 | debian-bookworm | ok 2026-09-20 03:07:42.932463 | 2026-09-20 03:07:42.932574 | TASK [fetch-tox-output : Get tox version] 2026-09-20 03:07:43.618898 | 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-20 03:07:43.639246 | debian-bookworm | 4.63.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-20 03:07:43.962827 | debian-bookworm | ok: Runtime: 0:00:00.361860 2026-09-20 03:07:43.974803 | 2026-09-20 03:07:43.974954 | TASK [fetch-tox-output : Find all default environments] 2026-09-20 03:07:44.509714 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:44.515238 | 2026-09-20 03:07:44.515341 | TASK [fetch-tox-output : Set envlist fact] 2026-09-20 03:07:44.548529 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:44.554022 | 2026-09-20 03:07:44.554117 | TASK [fetch-tox-output : Find all default environments] 2026-09-20 03:07:45.081718 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:45.089107 | 2026-09-20 03:07:45.089229 | TASK [fetch-tox-output : Set envlist fact] 2026-09-20 03:07:45.112537 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:45.118857 | 2026-09-20 03:07:45.118961 | LOOP [fetch-tox-output : Copy tox logs] 2026-09-20 03:07:45.209645 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:45.228451 | 2026-09-20 03:07:45.228561 | LOOP [fetch-tox-output : Collect tox logs] 2026-09-20 03:07:46.190623 | debian-bookworm | changed: 2026-09-20 03:07:46.190777 | debian-bookworm | created directory /var/lib/zuul/builds/805e33ed19794201b84e35d345a3629c/work/logs/tox/seed 2026-09-20 03:07:46.190811 | debian-bookworm | cd+++++++++ ./ 2026-09-20 03:07:46.190836 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-09-20 03:07:46.190865 | 2026-09-20 03:07:46.204948 | 2026-09-20 03:07:46.205028 | PLAY RECAP 2026-09-20 03:07:46.205077 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-09-20 03:07:46.205101 | 2026-09-20 03:07:46.345476 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-20 03:07:46.346433 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-20 03:07:47.021332 | 2026-09-20 03:07:47.021465 | PLAY [all] 2026-09-20 03:07:47.035871 | 2026-09-20 03:07:47.036003 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-09-20 03:07:47.222263 | debian-bookworm | changed: non-zero return code 2026-09-20 03:07:47.230667 | 2026-09-20 03:07:47.230790 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-09-20 03:07:47.254330 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:47.263740 | 2026-09-20 03:07:47.263902 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-09-20 03:07:47.298799 | 2026-09-20 03:07:47.299233 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-09-20 03:07:47.344719 | 2026-09-20 03:07:47.344984 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-09-20 03:07:47.379436 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:47.394999 | 2026-09-20 03:07:47.395187 | LOOP [fetch-subunit-output : Generate subunit file] 2026-09-20 03:07:47.432777 | 2026-09-20 03:07:47.433058 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-09-20 03:07:47.459002 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:47.468149 | 2026-09-20 03:07:47.468297 | TASK [fetch-subunit-output : Remove the temporary file] 2026-09-20 03:07:47.492823 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:47.501730 | 2026-09-20 03:07:47.501836 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-09-20 03:07:47.535160 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:07:47.541372 | 2026-09-20 03:07:47.541443 | PLAY RECAP 2026-09-20 03:07:47.541491 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-09-20 03:07:47.541516 | 2026-09-20 03:07:47.678189 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-20 03:07:47.679113 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-20 03:07:48.434041 | 2026-09-20 03:07:48.434160 | PLAY [Base post-fetch] 2026-09-20 03:07:48.447541 | 2026-09-20 03:07:48.447651 | TASK [diagnose-network : Ensure log directory exists] 2026-09-20 03:07:48.905718 | debian-bookworm | ok 2026-09-20 03:07:48.916725 | 2026-09-20 03:07:48.916883 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-09-20 03:08:00.751699 | debian-bookworm | ok: Runtime: 0:00:06.029514 2026-09-20 03:08:00.757880 | 2026-09-20 03:08:00.757996 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-09-20 03:08:06.770503 | debian-bookworm | ok: Runtime: 0:00:00.008822 2026-09-20 03:08:06.779422 | 2026-09-20 03:08:06.779568 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-09-20 03:08:12.830628 | debian-bookworm | ok: Runtime: 0:00:00.009572 2026-09-20 03:08:12.838107 | 2026-09-20 03:08:12.838227 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)] 2026-09-20 03:08:13.368942 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:08:13.375216 | 2026-09-20 03:08:13.375315 | TASK [diagnose-network : Abort the pre-run on a fully isolated node] 2026-09-20 03:08:13.418654 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:08:13.429482 | 2026-09-20 03:08:13.429593 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-20 03:08:13.472774 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:08:13.480537 | 2026-09-20 03:08:13.480636 | TASK [fetch-output : Set log path for single node] 2026-09-20 03:08:13.519265 | debian-bookworm | ok 2026-09-20 03:08:13.524086 | 2026-09-20 03:08:13.524168 | LOOP [fetch-output : Ensure local output dirs] 2026-09-20 03:08:13.768363 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/805e33ed19794201b84e35d345a3629c/work/logs" 2026-09-20 03:08:13.988687 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/805e33ed19794201b84e35d345a3629c/work/artifacts" 2026-09-20 03:08:14.240456 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/805e33ed19794201b84e35d345a3629c/work/docs" 2026-09-20 03:08:14.251549 | 2026-09-20 03:08:14.251651 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-20 03:08:15.275549 | debian-bookworm | changed: 2026-09-20 03:08:15.275739 | debian-bookworm | .d..t...... ./ 2026-09-20 03:08:15.275775 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-20 03:08:15.275799 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-20 03:08:15.275820 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-20 03:08:15.275841 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-20 03:08:15.275861 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-20 03:08:15.275907 | debian-bookworm | changed: All items complete 2026-09-20 03:08:15.275934 | 2026-09-20 03:08:16.050331 | debian-bookworm | changed: .d..t...... ./ 2026-09-20 03:08:16.742372 | debian-bookworm | changed: .d..t...... ./ 2026-09-20 03:08:16.755306 | 2026-09-20 03:08:16.755394 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-20 03:08:16.773281 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:08:16.776144 | debian-bookworm | skipping: Conditional result was False 2026-09-20 03:08:16.783355 | 2026-09-20 03:08:16.783410 | PLAY RECAP 2026-09-20 03:08:16.783453 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-20 03:08:16.783473 | 2026-09-20 03:08:17.036414 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-20 03:08:17.037264 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-20 03:08:18.049689 | 2026-09-20 03:08:18.049800 | PLAY [Base post] 2026-09-20 03:08:18.069543 | 2026-09-20 03:08:18.069667 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-20 03:08:18.717661 | debian-bookworm | changed 2026-09-20 03:08:18.732692 | 2026-09-20 03:08:18.732779 | PLAY RECAP 2026-09-20 03:08:18.732832 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-20 03:08:18.732905 | 2026-09-20 03:08:18.851599 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-20 03:08:18.852385 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-20 03:08:19.574480 | 2026-09-20 03:08:19.574592 | PLAY [Base post-logs] 2026-09-20 03:08:19.582620 | 2026-09-20 03:08:19.582713 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-20 03:08:20.006353 | localhost | changed 2026-09-20 03:08:20.014376 | 2026-09-20 03:08:20.014485 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-20 03:08:20.048489 | localhost | ok 2026-09-20 03:08:20.051427 | 2026-09-20 03:08:20.051502 | TASK [Set zuul-log-path fact] 2026-09-20 03:08:20.064951 | localhost | ok 2026-09-20 03:08:20.071294 | 2026-09-20 03:08:20.071368 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-20 03:08:20.094622 | localhost | ok 2026-09-20 03:08:20.096933 | 2026-09-20 03:08:20.097005 | TASK [upload-logs : Create log directories] 2026-09-20 03:08:20.475141 | localhost | changed 2026-09-20 03:08:20.477462 | 2026-09-20 03:08:20.477536 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-20 03:08:20.921985 | localhost -> localhost | ok: Runtime: 0:00:00.005723 2026-09-20 03:08:20.925054 | 2026-09-20 03:08:20.925145 | TASK [upload-logs : Upload logs to log server] 2026-09-20 03:08:21.720622 | localhost | Output suppressed because no_log was given 2026-09-20 03:08:21.722052 | 2026-09-20 03:08:21.722128 | LOOP [upload-logs : Compress console log and json output] 2026-09-20 03:08:21.765013 | localhost | skipping: Conditional result was False 2026-09-20 03:08:21.770435 | localhost | skipping: Conditional result was False 2026-09-20 03:08:21.777171 | 2026-09-20 03:08:21.777252 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-20 03:08:21.858052 | localhost | skipping: Conditional result was False 2026-09-20 03:08:21.858314 | 2026-09-20 03:08:21.868454 | localhost | skipping: Conditional result was False 2026-09-20 03:08:21.871972 | 2026-09-20 03:08:21.872057 | LOOP [upload-logs : Upload console log and json output]