2026-10-02 03:04:49.161205 | Job console starting 2026-10-02 03:04:49.170801 | Updating git repos 2026-10-02 03:04:49.214606 | Cloning repos into workspace 2026-10-02 03:04:49.269698 | Restoring repo states 2026-10-02 03:04:49.284817 | Merging changes 2026-10-02 03:04:49.284849 | Checking out repos 2026-10-02 03:04:49.318811 | Preparing playbooks 2026-10-02 03:04:50.129138 | Running Ansible setup 2026-10-02 03:04:54.457354 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-02 03:04:55.175766 | 2026-10-02 03:04:55.175891 | PLAY [Base pre] 2026-10-02 03:04:55.208935 | 2026-10-02 03:04:55.209059 | TASK [Setup log path fact] 2026-10-02 03:04:55.228208 | debian-bookworm | ok 2026-10-02 03:04:55.263164 | 2026-10-02 03:04:55.263292 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-02 03:04:55.296797 | debian-bookworm | ok 2026-10-02 03:04:55.320882 | 2026-10-02 03:04:55.320993 | TASK [emit-job-header : Print job information] 2026-10-02 03:04:55.369191 | # Job Information 2026-10-02 03:04:55.369342 | Ansible Version: 2.16.14 2026-10-02 03:04:55.369376 | Job: generics-tox-seed 2026-10-02 03:04:55.369408 | Pipeline: periodic-daily 2026-10-02 03:04:55.369430 | Executor: 521e9411259a 2026-10-02 03:04:55.369450 | Triggered by: https://github.com/osism/generics 2026-10-02 03:04:55.369471 | Event ID: a85e3700e4ce40d48c737cc27a7ea07d 2026-10-02 03:04:55.374321 | 2026-10-02 03:04:55.374408 | LOOP [emit-job-header : Print node information] 2026-10-02 03:04:55.499194 | debian-bookworm | ok: 2026-10-02 03:04:55.499390 | debian-bookworm | # Node Information 2026-10-02 03:04:55.499427 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-10-02 03:04:55.499453 | debian-bookworm | Hostname: debian 2026-10-02 03:04:55.499474 | debian-bookworm | Username: zuul 2026-10-02 03:04:55.499494 | debian-bookworm | Distro: Debian 12.15 2026-10-02 03:04:55.499519 | debian-bookworm | Provider: regiocloud-a 2026-10-02 03:04:55.499552 | debian-bookworm | Region: 2026-10-02 03:04:55.499572 | debian-bookworm | Label: debian-bookworm 2026-10-02 03:04:55.499592 | debian-bookworm | Product Name: OpenStack Nova 2026-10-02 03:04:55.499610 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed8:1482 2026-10-02 03:04:55.518686 | 2026-10-02 03:04:55.518793 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-02 03:04:56.204649 | debian-bookworm -> localhost | changed 2026-10-02 03:04:56.210955 | 2026-10-02 03:04:56.211049 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-02 03:04:57.292168 | debian-bookworm -> localhost | changed 2026-10-02 03:04:57.303558 | 2026-10-02 03:04:57.304688 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-02 03:04:57.646923 | debian-bookworm -> localhost | ok 2026-10-02 03:04:57.652753 | 2026-10-02 03:04:57.652856 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-02 03:04:57.682383 | debian-bookworm | ok 2026-10-02 03:04:57.710540 | debian-bookworm | included: /var/lib/zuul/builds/f0926c1ef5cf4ace8480c221531bcc49/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-02 03:04:57.719131 | 2026-10-02 03:04:57.719208 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-02 03:04:58.995808 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-10-02 03:04:58.996006 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f0926c1ef5cf4ace8480c221531bcc49/work/f0926c1ef5cf4ace8480c221531bcc49_id_rsa 2026-10-02 03:04:58.996046 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f0926c1ef5cf4ace8480c221531bcc49/work/f0926c1ef5cf4ace8480c221531bcc49_id_rsa.pub 2026-10-02 03:04:58.996074 | debian-bookworm -> localhost | The key fingerprint is: 2026-10-02 03:04:58.996097 | debian-bookworm -> localhost | SHA256:Xj82F+tfLfUMTFS2gaALtRp5M3h+AW0U3vcLN0J534U zuul-build-sshkey 2026-10-02 03:04:58.996119 | debian-bookworm -> localhost | The key's randomart image is: 2026-10-02 03:04:58.996150 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-10-02 03:04:58.996173 | debian-bookworm -> localhost | | oo+o ooo| 2026-10-02 03:04:58.996194 | debian-bookworm -> localhost | | + =o.o.oo| 2026-10-02 03:04:58.996215 | debian-bookworm -> localhost | | = B.o +E+.| 2026-10-02 03:04:58.996235 | debian-bookworm -> localhost | | B + ooo =| 2026-10-02 03:04:58.996255 | debian-bookworm -> localhost | | .So.. o+o=| 2026-10-02 03:04:58.996280 | debian-bookworm -> localhost | | . ... +*=| 2026-10-02 03:04:58.996301 | debian-bookworm -> localhost | | . = +.=| 2026-10-02 03:04:58.996321 | debian-bookworm -> localhost | | . = ..| 2026-10-02 03:04:58.996341 | debian-bookworm -> localhost | | ...| 2026-10-02 03:04:58.996361 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-10-02 03:04:58.996408 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.865297 2026-10-02 03:04:59.002880 | 2026-10-02 03:04:59.002973 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-02 03:04:59.020674 | debian-bookworm | ok 2026-10-02 03:04:59.035399 | debian-bookworm | included: /var/lib/zuul/builds/f0926c1ef5cf4ace8480c221531bcc49/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-02 03:04:59.043315 | 2026-10-02 03:04:59.043394 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-02 03:04:59.056369 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:04:59.061767 | 2026-10-02 03:04:59.061851 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-02 03:04:59.831179 | debian-bookworm | changed 2026-10-02 03:04:59.840264 | 2026-10-02 03:04:59.840361 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-02 03:05:00.147934 | debian-bookworm | ok 2026-10-02 03:05:00.155445 | 2026-10-02 03:05:00.157915 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-02 03:05:00.962971 | debian-bookworm | changed 2026-10-02 03:05:00.972681 | 2026-10-02 03:05:00.972785 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-02 03:05:01.653395 | debian-bookworm | changed 2026-10-02 03:05:01.659653 | 2026-10-02 03:05:01.659752 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-02 03:05:01.691006 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:05:01.697056 | 2026-10-02 03:05:01.697151 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-02 03:05:02.434451 | debian-bookworm -> localhost | changed 2026-10-02 03:05:02.444795 | 2026-10-02 03:05:02.444893 | TASK [add-build-sshkey : Add back temp key] 2026-10-02 03:05:02.762988 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f0926c1ef5cf4ace8480c221531bcc49/work/f0926c1ef5cf4ace8480c221531bcc49_id_rsa (zuul-build-sshkey) 2026-10-02 03:05:02.763168 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011911 2026-10-02 03:05:02.769993 | 2026-10-02 03:05:02.770067 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-02 03:05:03.192665 | debian-bookworm | ok 2026-10-02 03:05:03.201457 | 2026-10-02 03:05:03.201614 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-02 03:05:03.229237 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:05:03.254721 | 2026-10-02 03:05:03.254836 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-02 03:05:03.657369 | debian-bookworm | ok 2026-10-02 03:05:03.667643 | 2026-10-02 03:05:03.667749 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-02 03:05:03.695406 | debian-bookworm | ok 2026-10-02 03:05:03.700214 | 2026-10-02 03:05:03.700308 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-02 03:05:04.246453 | debian-bookworm -> localhost | ok 2026-10-02 03:05:04.252679 | 2026-10-02 03:05:04.252772 | TASK [validate-host : Collect information about the host] 2026-10-02 03:05:05.512786 | debian-bookworm | ok 2026-10-02 03:05:05.529515 | 2026-10-02 03:05:05.529665 | TASK [validate-host : Sanitize hostname] 2026-10-02 03:05:05.656191 | debian-bookworm | ok 2026-10-02 03:05:05.670962 | 2026-10-02 03:05:05.671069 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-02 03:05:06.253374 | debian-bookworm -> localhost | changed 2026-10-02 03:05:06.259037 | 2026-10-02 03:05:06.259135 | TASK [validate-host : Collect information about zuul worker] 2026-10-02 03:05:06.734773 | debian-bookworm | ok 2026-10-02 03:05:06.740096 | 2026-10-02 03:05:06.740191 | TASK [validate-host : Write out all zuul information for each host] 2026-10-02 03:05:07.256227 | debian-bookworm -> localhost | changed 2026-10-02 03:05:07.263698 | 2026-10-02 03:05:07.263779 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-02 03:05:07.543866 | debian-bookworm | ok 2026-10-02 03:05:07.549342 | 2026-10-02 03:05:07.549601 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-02 03:05:08.331221 | debian-bookworm | changed: 2026-10-02 03:05:08.331392 | debian-bookworm | cd+++++++++ src/ 2026-10-02 03:05:08.331427 | debian-bookworm | cd+++++++++ src/github.com/ 2026-10-02 03:05:08.331452 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-10-02 03:05:08.331474 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-10-02 03:05:08.331505 | debian-bookworm | =7.0.3 2026-10-02 03:05:47.060125 | debian-bookworm | Downloading cachetools-7.2.0-py3-none-any.whl (16 kB) 2026-10-02 03:05:47.129625 | debian-bookworm | Collecting colorama>=0.4.6 2026-10-02 03:05:47.142340 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-10-02 03:05:47.242414 | debian-bookworm | Collecting filelock>=3.25 2026-10-02 03:05:47.256425 | debian-bookworm | Downloading filelock-4.0.9-py3-none-any.whl (110 kB) 2026-10-02 03:05:47.277298 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 110.4/110.4 kB 8.8 MB/s eta 0:00:00 2026-10-02 03:05:47.350992 | debian-bookworm | Collecting packaging>=26 2026-10-02 03:05:47.363691 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-10-02 03:05:47.383308 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 7.6 MB/s eta 0:00:00 2026-10-02 03:05:47.450726 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-10-02 03:05:47.463163 | debian-bookworm | Downloading platformdirs-4.12.2-py3-none-any.whl (32 kB) 2026-10-02 03:05:47.507925 | debian-bookworm | Collecting pluggy>=1.6 2026-10-02 03:05:47.520215 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-10-02 03:05:47.589238 | debian-bookworm | Collecting pyproject-api>=1.10 2026-10-02 03:05:47.601438 | debian-bookworm | Downloading pyproject_api-1.11.2-py3-none-any.whl (13 kB) 2026-10-02 03:05:47.654964 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-10-02 03:05:47.667063 | debian-bookworm | Downloading python_discovery-1.6.1-py3-none-any.whl (38 kB) 2026-10-02 03:05:47.715934 | debian-bookworm | Collecting tomli-w>=1.2 2026-10-02 03:05:47.730006 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-10-02 03:05:47.798196 | debian-bookworm | Collecting typing-extensions>=4.15 2026-10-02 03:05:47.810342 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-10-02 03:05:47.819722 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 5.7 MB/s eta 0:00:00 2026-10-02 03:05:48.022859 | debian-bookworm | Collecting virtualenv>=21.1 2026-10-02 03:05:48.035770 | debian-bookworm | Downloading virtualenv-21.14.3-py3-none-any.whl (5.5 MB) 2026-10-02 03:05:48.313016 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 20.1 MB/s eta 0:00:00 2026-10-02 03:05:48.419173 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-10-02 03:05:48.432051 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-10-02 03:05:48.522976 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 5.4 MB/s eta 0:00:00 2026-10-02 03:05:48.653049 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-10-02 03:05:49.669445 | debian-bookworm | Successfully installed cachetools-7.2.0 colorama-0.4.6 distlib-0.4.3 filelock-4.0.9 packaging-26.3 platformdirs-4.12.2 pluggy-1.6.0 pyproject-api-1.11.2 python-discovery-1.6.1 tomli-w-1.2.0 tox-4.64.7 typing-extensions-4.16.0 virtualenv-21.14.3 2026-10-02 03:05:50.299463 | debian-bookworm | ok: Runtime: 0:00:03.816504 2026-10-02 03:05:50.306315 | 2026-10-02 03:05:50.306485 | TASK [ensure-tox : Export installed tox_executable path] 2026-10-02 03:05:50.337024 | debian-bookworm | ok 2026-10-02 03:05:50.341963 | 2026-10-02 03:05:50.342063 | TASK [ensure-tox : Output tox version] 2026-10-02 03:05:50.959997 | 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-10-02 03:05:50.980718 | debian-bookworm | 4.64.7 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-10-02 03:05:51.373163 | debian-bookworm | ok: Runtime: 0:00:00.395530 2026-10-02 03:05:51.380846 | 2026-10-02 03:05:51.380955 | TASK [ensure-tox : Make global symlink] 2026-10-02 03:05:51.395090 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:05:51.402227 | 2026-10-02 03:05:51.402302 | PLAY RECAP 2026-10-02 03:05:51.402353 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-10-02 03:05:51.402400 | 2026-10-02 03:05:51.541108 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-10-02 03:05:51.543916 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-10-02 03:05:52.357994 | 2026-10-02 03:05:52.358156 | PLAY [all] 2026-10-02 03:05:52.375432 | 2026-10-02 03:05:52.375579 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-10-02 03:05:52.923754 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-10-02 03:05:53.413682 | debian-bookworm | ok: Runtime: 0:00:00.029650 2026-10-02 03:05:53.419585 | 2026-10-02 03:05:53.433934 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-10-02 03:05:54.021968 | debian-bookworm | ok: Runtime: 0:00:00.008640 2026-10-02 03:05:54.036796 | 2026-10-02 03:05:54.036963 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-10-02 03:05:54.328188 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-10-02 03:05:54.329809 | debian-bookworm | sudo: a password is required 2026-10-02 03:05:54.571899 | debian-bookworm | ok: Runtime: 0:00:00.017639 2026-10-02 03:05:54.583939 | 2026-10-02 03:05:54.584058 | TASK [tox : Check to see if the constraints file exists] 2026-10-02 03:05:54.608306 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:05:54.614838 | 2026-10-02 03:05:54.614955 | TASK [tox : Fail if constraints file is missing] 2026-10-02 03:05:54.638894 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:05:54.647854 | 2026-10-02 03:05:54.647974 | TASK [tox : Record file location] 2026-10-02 03:05:54.671853 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:05:54.685483 | 2026-10-02 03:05:54.685674 | TASK [tox : Install tox siblings] 2026-10-02 03:05:54.716381 | debian-bookworm | ok 2026-10-02 03:05:54.725508 | debian-bookworm | included: /var/lib/zuul/builds/f0926c1ef5cf4ace8480c221531bcc49/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-10-02 03:05:54.731219 | 2026-10-02 03:05:54.731330 | TASK [tox : Run tox without tests] 2026-10-02 03:05:55.352831 | debian-bookworm | ROOT: 252 D setup logging to DEBUG on pid 1599 [tox/report.py:249] 2026-10-02 03:05:55.392701 | debian-bookworm | seed: 291 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-10-02 03:05:55.395894 | debian-bookworm | seed: 295 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-10-02 03:05:55.400957 | debian-bookworm | seed: 300 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 c2655a2412c6721fdef449a12d19efac 58ba98fb47729e383f10ab433d21995c [python_discovery/_cached_py_info.py:223] 2026-10-02 03:05:55.493378 | debian-bookworm | seed: 392 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-10-02 03:05:55.494937 | debian-bookworm | seed: 394 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-10-02 03:05:55.495459 | debian-bookworm | seed: 394 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-10-02 03:05:55.495895 | debian-bookworm | seed: 395 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-10-02 03:05:55.499651 | debian-bookworm | seed: 398 D symlink on filesystem does work [virtualenv/info.py:51] 2026-10-02 03:05:55.500006 | debian-bookworm | seed: 399 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-10-02 03:05:55.538582 | debian-bookworm | seed: 437 I create virtual environment via CPython3Posix(dest=/home/zuul/src/github.com/osism/generics/.tox/seed, clear=False, no_vcs_ignore=False, venv_redirect=False, global=False) [virtualenv/run/session.py:77] 2026-10-02 03:05:55.538974 | debian-bookworm | seed: 438 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/bin [virtualenv/util/path/_sync.py:22] 2026-10-02 03:05:55.539191 | debian-bookworm | seed: 438 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/include [virtualenv/util/path/_sync.py:22] 2026-10-02 03:05:55.539324 | debian-bookworm | seed: 438 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages [virtualenv/util/path/_sync.py:22] 2026-10-02 03:05:55.539574 | debian-bookworm | seed: 438 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:54] 2026-10-02 03:05:55.539698 | debian-bookworm | seed: 439 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.539762 | debian-bookworm | seed: 439 D implementation = CPython [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.539819 | debian-bookworm | seed: 439 D python-version = 3.11 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.539880 | debian-bookworm | seed: 439 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.539936 | debian-bookworm | seed: 439 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.539999 | debian-bookworm | seed: 439 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.540055 | debian-bookworm | seed: 439 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/seed [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.540116 | debian-bookworm | seed: 439 D virtualenv = 21.14.3 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.540225 | debian-bookworm | seed: 439 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.540295 | debian-bookworm | seed: 439 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.540355 | debian-bookworm | seed: 439 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.540415 | debian-bookworm | seed: 439 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:55.540730 | debian-bookworm | seed: 440 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-10-02 03:05:55.541277 | debian-bookworm | seed: 440 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-10-02 03:05:55.541563 | debian-bookworm | seed: 440 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:316] 2026-10-02 03:05:55.584490 | debian-bookworm | seed: 440 D { 2026-10-02 03:05:55.584595 | debian-bookworm | "sys": { 2026-10-02 03:05:55.584620 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/seed/bin/python", 2026-10-02 03:05:55.584649 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-10-02 03:05:55.584670 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-10-02 03:05:55.584691 | debian-bookworm | "base_prefix": "/usr", 2026-10-02 03:05:55.584713 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-10-02 03:05:55.584734 | debian-bookworm | "base_exec_prefix": "/usr", 2026-10-02 03:05:55.584756 | debian-bookworm | "path": [ 2026-10-02 03:05:55.584777 | debian-bookworm | "/usr/lib/python311.zip", 2026-10-02 03:05:55.584797 | debian-bookworm | "/usr/lib/python3.11", 2026-10-02 03:05:55.584815 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-10-02 03:05:55.584827 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages" 2026-10-02 03:05:55.584839 | debian-bookworm | ], 2026-10-02 03:05:55.584850 | debian-bookworm | "meta_path": [ 2026-10-02 03:05:55.584861 | debian-bookworm | "", 2026-10-02 03:05:55.584873 | debian-bookworm | "", 2026-10-02 03:05:55.584884 | debian-bookworm | "" 2026-10-02 03:05:55.584895 | debian-bookworm | ], 2026-10-02 03:05:55.584907 | debian-bookworm | "fs_encoding": "utf-8", 2026-10-02 03:05:55.584918 | debian-bookworm | "io_encoding": "utf-8" 2026-10-02 03:05:55.584929 | debian-bookworm | }, 2026-10-02 03:05:55.584940 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-10-02 03:05:55.584951 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-10-02 03:05:55.584962 | debian-bookworm | "os": "", 2026-10-02 03:05:55.584973 | debian-bookworm | "site": "", 2026-10-02 03:05:55.584984 | debian-bookworm | "datetime": "", 2026-10-02 03:05:55.584995 | debian-bookworm | "math": "", 2026-10-02 03:05:55.585017 | debian-bookworm | "json": "" 2026-10-02 03:05:55.585029 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-10-02 03:05:55.585701 | debian-bookworm | seed: 484 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-10-02 03:05:55.595598 | debian-bookworm | seed: 494 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-10-02 03:05:55.597022 | debian-bookworm | seed: 496 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-10-02 03:05:55.601838 | debian-bookworm | seed: 500 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-10-02 03:05:55.606396 | debian-bookworm | seed: 505 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-10-02 03:05:55.953671 | debian-bookworm | seed: 852 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-10-02 03:05:55.954500 | debian-bookworm | seed: 853 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-10-02 03:05:55.955400 | debian-bookworm | seed: 854 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-10-02 03:05:56.089456 | debian-bookworm | seed: 988 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-10-02 03:05:56.094029 | debian-bookworm | seed: 993 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-10-02 03:05:56.097592 | debian-bookworm | seed: 996 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-10-02 03:05:56.098100 | debian-bookworm | seed: 997 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-10-02 03:05:56.099997 | debian-bookworm | seed: 999 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-10-02 03:05:56.156080 | debian-bookworm | seed: 1055 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-10-02 03:05:56.157237 | debian-bookworm | seed: 1056 D generated console scripts pip-3.11 pip3 pip pip3.11 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-10-02 03:05:56.158091 | debian-bookworm | seed: 1056 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-10-02 03:05:56.171786 | debian-bookworm | seed: 1071 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:54] 2026-10-02 03:05:56.171972 | debian-bookworm | seed: 1071 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.172086 | debian-bookworm | seed: 1071 D implementation = CPython [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.172215 | debian-bookworm | seed: 1071 D python-version = 3.11 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.172314 | debian-bookworm | seed: 1071 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.172411 | debian-bookworm | seed: 1071 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.172541 | debian-bookworm | seed: 1071 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.172648 | debian-bookworm | seed: 1071 D command = /home/zuul/.local/tox/bin/python3 -m virtualenv /home/zuul/src/github.com/osism/generics/.tox/seed [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.172750 | debian-bookworm | seed: 1072 D virtualenv = 21.14.3 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.172849 | debian-bookworm | seed: 1072 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.172964 | debian-bookworm | seed: 1072 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.173070 | debian-bookworm | seed: 1072 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.173223 | debian-bookworm | seed: 1072 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:65] 2026-10-02 03:05:56.178093 | debian-bookworm | seed: OK (0.79 seconds) 2026-10-02 03:05:56.178199 | debian-bookworm | congratulations :) (0.83 seconds) 2026-10-02 03:05:56.282334 | debian-bookworm | ok: Runtime: 0:00:01.192047 2026-10-02 03:05:56.288696 | 2026-10-02 03:05:56.288821 | TASK [tox : Create a tempfile to save tox showconfig] 2026-10-02 03:05:56.806051 | debian-bookworm | changed 2026-10-02 03:05:56.811433 | 2026-10-02 03:05:56.811555 | TASK [tox : Detect tox version] 2026-10-02 03:05:57.403134 | debian-bookworm | 4.64.7 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-10-02 03:05:57.867459 | debian-bookworm | ok: Runtime: 0:00:00.352737 2026-10-02 03:05:57.873193 | 2026-10-02 03:05:57.873306 | TASK [tox : Get tox envlist config] 2026-10-02 03:05:58.931761 | debian-bookworm | ok: Runtime: 0:00:00.400795 2026-10-02 03:05:58.938063 | 2026-10-02 03:05:58.938181 | TASK [tox : Install any sibling python packages] 2026-10-02 03:05:59.394157 | debian-bookworm | ok: No setup.cfg, no action needed 2026-10-02 03:05:59.399976 | 2026-10-02 03:05:59.400092 | TASK [tox : Remove tempfile] 2026-10-02 03:06:00.001586 | debian-bookworm | changed 2026-10-02 03:06:00.011473 | 2026-10-02 03:06:00.011609 | TASK [tox : Emit tox command] 2026-10-02 03:06:00.092402 | /home/zuul/.local/tox/bin/tox -eseed -vv --skip-missing-interpreters=false 2026-10-02 03:06:00.104120 | 2026-10-02 03:06:00.104261 | TASK [tox : Run tox] 2026-10-02 03:06:00.785105 | debian-bookworm | ROOT: 229 D setup logging to DEBUG on pid 1639 [tox/report.py:249] 2026-10-02 03:06:00.818952 | debian-bookworm | seed: 263 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-10-02 03:06:00.821764 | debian-bookworm | seed: 266 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-10-02 03:06:00.825911 | debian-bookworm | seed: 270 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-10-02 03:06:00.826394 | debian-bookworm | seed: 271 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-10-02 03:06:00.826544 | debian-bookworm | seed: 271 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-10-02 03:06:00.826623 | debian-bookworm | seed: 271 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-10-02 03:06:00.828244 | debian-bookworm | seed: 273 D symlink on filesystem does work [virtualenv/info.py:51] 2026-10-02 03:06:00.828366 | debian-bookworm | seed: 273 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-10-02 03:06:00.860844 | debian-bookworm | seed: 305 W commands[0]> bash src/test-seed.sh [tox/tox_env/api.py:500] 2026-10-02 03:06:01.477108 | debian-bookworm | PASS=44 FAIL=0 2026-10-02 03:06:01.478908 | debian-bookworm | seed: 923 I exit 0 (0.62 seconds) /home/zuul/src/github.com/osism/generics> bash src/test-seed.sh pid=1646 [tox/execute/api.py:337] 2026-10-02 03:06:01.480289 | debian-bookworm | seed: OK (0.67=setup[0.05]+cmd[0.62] seconds) 2026-10-02 03:06:01.480322 | debian-bookworm | congratulations :) (0.70 seconds) 2026-10-02 03:06:01.671792 | debian-bookworm | ok: Runtime: 0:00:01.047208 2026-10-02 03:06:01.680122 | 2026-10-02 03:06:01.680248 | TASK [tox : Look for output] 2026-10-02 03:06:02.126621 | debian-bookworm | ok 2026-10-02 03:06:02.183463 | 2026-10-02 03:06:02.183593 | TASK [tox : Return file comments to Zuul] 2026-10-02 03:06:02.253138 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:02.282064 | 2026-10-02 03:06:02.282264 | PLAY RECAP 2026-10-02 03:06:02.283070 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-10-02 03:06:02.283349 | 2026-10-02 03:06:02.578848 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-10-02 03:06:02.579777 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-10-02 03:06:03.655221 | 2026-10-02 03:06:03.655353 | PLAY [all] 2026-10-02 03:06:03.674517 | 2026-10-02 03:06:03.674633 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-10-02 03:06:03.761207 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:03.771133 | 2026-10-02 03:06:03.771256 | TASK [fetch-tox-output : Set tox log path for single node] 2026-10-02 03:06:03.838209 | debian-bookworm | ok 2026-10-02 03:06:03.851726 | 2026-10-02 03:06:03.851843 | TASK [fetch-tox-output : Ensure local tox dir] 2026-10-02 03:06:04.503757 | debian-bookworm -> localhost | changed 2026-10-02 03:06:04.520507 | 2026-10-02 03:06:04.520614 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-10-02 03:06:04.604034 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:04.610262 | 2026-10-02 03:06:04.610379 | TASK [fetch-tox-output : Set envlist fact] 2026-10-02 03:06:04.641753 | debian-bookworm | ok 2026-10-02 03:06:04.655087 | 2026-10-02 03:06:04.655848 | TASK [fetch-tox-output : Get tox version] 2026-10-02 03:06:05.444225 | 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-10-02 03:06:05.464362 | debian-bookworm | 4.64.7 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-10-02 03:06:05.690777 | debian-bookworm | ok: Runtime: 0:00:00.380933 2026-10-02 03:06:05.699739 | 2026-10-02 03:06:05.699858 | TASK [fetch-tox-output : Find all default environments] 2026-10-02 03:06:06.230061 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:06.234750 | 2026-10-02 03:06:06.234840 | TASK [fetch-tox-output : Set envlist fact] 2026-10-02 03:06:06.267479 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:06.272628 | 2026-10-02 03:06:06.272713 | TASK [fetch-tox-output : Find all default environments] 2026-10-02 03:06:06.798830 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:06.804301 | 2026-10-02 03:06:06.804419 | TASK [fetch-tox-output : Set envlist fact] 2026-10-02 03:06:06.837244 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:06.843099 | 2026-10-02 03:06:06.843192 | LOOP [fetch-tox-output : Copy tox logs] 2026-10-02 03:06:06.879612 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:06.892097 | 2026-10-02 03:06:06.892199 | LOOP [fetch-tox-output : Collect tox logs] 2026-10-02 03:06:07.701323 | debian-bookworm | changed: 2026-10-02 03:06:07.701641 | debian-bookworm | created directory /var/lib/zuul/builds/f0926c1ef5cf4ace8480c221531bcc49/work/logs/tox/seed 2026-10-02 03:06:07.701707 | debian-bookworm | cd+++++++++ ./ 2026-10-02 03:06:07.701751 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-10-02 03:06:07.701799 | 2026-10-02 03:06:07.719030 | 2026-10-02 03:06:07.719146 | PLAY RECAP 2026-10-02 03:06:07.719223 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-10-02 03:06:07.719261 | 2026-10-02 03:06:07.816144 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-10-02 03:06:07.817742 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-10-02 03:06:08.485110 | 2026-10-02 03:06:08.485232 | PLAY [all] 2026-10-02 03:06:08.507546 | 2026-10-02 03:06:08.507665 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-10-02 03:06:08.710620 | debian-bookworm | changed: non-zero return code 2026-10-02 03:06:08.715237 | 2026-10-02 03:06:08.715354 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-10-02 03:06:08.728164 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:08.732838 | 2026-10-02 03:06:08.732914 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-10-02 03:06:08.760411 | 2026-10-02 03:06:08.760538 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-10-02 03:06:08.787999 | 2026-10-02 03:06:08.788134 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-10-02 03:06:08.800330 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:08.804931 | 2026-10-02 03:06:08.805006 | LOOP [fetch-subunit-output : Generate subunit file] 2026-10-02 03:06:08.821389 | 2026-10-02 03:06:08.821519 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-10-02 03:06:08.833578 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:08.838857 | 2026-10-02 03:06:08.838931 | TASK [fetch-subunit-output : Remove the temporary file] 2026-10-02 03:06:08.860974 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:08.865370 | 2026-10-02 03:06:08.865441 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-10-02 03:06:08.877473 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:08.882338 | 2026-10-02 03:06:08.882390 | PLAY RECAP 2026-10-02 03:06:08.882432 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-10-02 03:06:08.882453 | 2026-10-02 03:06:08.957950 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-10-02 03:06:08.959159 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-02 03:06:09.710259 | 2026-10-02 03:06:09.710418 | PLAY [Base post-fetch] 2026-10-02 03:06:09.724479 | 2026-10-02 03:06:09.724602 | TASK [diagnose-network : Ensure log directory exists] 2026-10-02 03:06:10.119092 | debian-bookworm | ok 2026-10-02 03:06:10.126957 | 2026-10-02 03:06:10.127103 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-10-02 03:06:21.841510 | debian-bookworm | ok: Runtime: 0:00:05.927574 2026-10-02 03:06:21.851348 | 2026-10-02 03:06:21.851480 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-10-02 03:06:27.841007 | debian-bookworm | ok: Runtime: 0:00:00.008733 2026-10-02 03:06:27.846475 | 2026-10-02 03:06:27.846597 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-10-02 03:06:33.920212 | debian-bookworm | ok: Runtime: 0:00:00.005940 2026-10-02 03:06:33.925142 | 2026-10-02 03:06:33.925254 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)] 2026-10-02 03:06:34.466242 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:34.471274 | 2026-10-02 03:06:34.471361 | TASK [diagnose-network : Abort the pre-run on a fully isolated node] 2026-10-02 03:06:34.504208 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:34.512976 | 2026-10-02 03:06:34.513069 | TASK [fetch-output : Set log path for multiple nodes] 2026-10-02 03:06:34.560416 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:34.564926 | 2026-10-02 03:06:34.565016 | TASK [fetch-output : Set log path for single node] 2026-10-02 03:06:34.602502 | debian-bookworm | ok 2026-10-02 03:06:34.606723 | 2026-10-02 03:06:34.606808 | LOOP [fetch-output : Ensure local output dirs] 2026-10-02 03:06:35.172485 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/f0926c1ef5cf4ace8480c221531bcc49/work/logs" 2026-10-02 03:06:35.639268 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f0926c1ef5cf4ace8480c221531bcc49/work/artifacts" 2026-10-02 03:06:36.294324 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f0926c1ef5cf4ace8480c221531bcc49/work/docs" 2026-10-02 03:06:36.310372 | 2026-10-02 03:06:36.310470 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-02 03:06:37.564340 | debian-bookworm | changed: 2026-10-02 03:06:37.564505 | debian-bookworm | .d..t...... ./ 2026-10-02 03:06:37.564535 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-10-02 03:06:37.564555 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-10-02 03:06:37.564573 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-10-02 03:06:37.564591 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-10-02 03:06:37.564608 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-10-02 03:06:37.564637 | debian-bookworm | changed: All items complete 2026-10-02 03:06:37.564658 | 2026-10-02 03:06:38.763515 | debian-bookworm | changed: .d..t...... ./ 2026-10-02 03:06:39.647635 | debian-bookworm | changed: .d..t...... ./ 2026-10-02 03:06:39.675464 | 2026-10-02 03:06:39.675561 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-02 03:06:39.753181 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:39.763034 | debian-bookworm | skipping: Conditional result was False 2026-10-02 03:06:39.769081 | 2026-10-02 03:06:39.769145 | PLAY RECAP 2026-10-02 03:06:39.769188 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-10-02 03:06:39.769209 | 2026-10-02 03:06:39.992828 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-02 03:06:39.993773 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-02 03:06:41.683863 | 2026-10-02 03:06:41.683972 | PLAY [Base post] 2026-10-02 03:06:41.708051 | 2026-10-02 03:06:41.708173 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-02 03:06:43.070934 | debian-bookworm | changed 2026-10-02 03:06:43.077192 | 2026-10-02 03:06:43.077289 | PLAY RECAP 2026-10-02 03:06:43.077340 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-02 03:06:43.077390 | 2026-10-02 03:06:43.266607 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-02 03:06:43.267413 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-02 03:06:44.604953 | 2026-10-02 03:06:44.605070 | PLAY [Base post-logs] 2026-10-02 03:06:44.617128 | 2026-10-02 03:06:44.617242 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-02 03:06:45.350167 | localhost | changed 2026-10-02 03:06:45.357754 | 2026-10-02 03:06:45.357875 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-02 03:06:45.399446 | localhost | ok 2026-10-02 03:06:45.401776 | 2026-10-02 03:06:45.401847 | TASK [Set zuul-log-path fact] 2026-10-02 03:06:45.435648 | localhost | ok 2026-10-02 03:06:45.441767 | 2026-10-02 03:06:45.441851 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-02 03:06:45.506226 | localhost | ok 2026-10-02 03:06:45.508947 | 2026-10-02 03:06:45.509022 | TASK [upload-logs : Create log directories] 2026-10-02 03:06:46.308250 | localhost | changed 2026-10-02 03:06:46.316652 | 2026-10-02 03:06:46.316746 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-02 03:06:46.749902 | localhost -> localhost | ok: Runtime: 0:00:00.006602 2026-10-02 03:06:46.752959 | 2026-10-02 03:06:46.753034 | TASK [upload-logs : Upload logs to log server] 2026-10-02 03:06:47.235348 | localhost | Output suppressed because no_log was given 2026-10-02 03:06:47.237105 | 2026-10-02 03:06:47.237201 | LOOP [upload-logs : Compress console log and json output] 2026-10-02 03:06:47.278354 | localhost | skipping: Conditional result was False 2026-10-02 03:06:47.283794 | localhost | skipping: Conditional result was False 2026-10-02 03:06:47.296877 | 2026-10-02 03:06:47.297057 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-02 03:06:47.343140 | localhost | skipping: Conditional result was False 2026-10-02 03:06:47.343386 | 2026-10-02 03:06:47.346946 | localhost | skipping: Conditional result was False 2026-10-02 03:06:47.353778 | 2026-10-02 03:06:47.353865 | LOOP [upload-logs : Upload console log and json output]