2026-09-18 03:06:34.230913 | Job console starting 2026-09-18 03:06:34.242133 | Updating git repos 2026-09-18 03:06:34.280450 | Cloning repos into workspace 2026-09-18 03:06:34.355086 | Restoring repo states 2026-09-18 03:06:34.366400 | Merging changes 2026-09-18 03:06:34.366418 | Checking out repos 2026-09-18 03:06:34.394176 | Preparing playbooks 2026-09-18 03:06:35.241800 | Running Ansible setup 2026-09-18 03:06:39.414085 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-18 03:06:40.499894 | 2026-09-18 03:06:40.500022 | PLAY [Base pre] 2026-09-18 03:06:40.528710 | 2026-09-18 03:06:40.528829 | TASK [Setup log path fact] 2026-09-18 03:06:40.579654 | debian-bookworm | ok 2026-09-18 03:06:40.605222 | 2026-09-18 03:06:40.605378 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-18 03:06:40.660380 | debian-bookworm | ok 2026-09-18 03:06:40.674637 | 2026-09-18 03:06:40.674745 | TASK [emit-job-header : Print job information] 2026-09-18 03:06:40.726354 | # Job Information 2026-09-18 03:06:40.726505 | Ansible Version: 2.16.14 2026-09-18 03:06:40.726542 | Job: generics-tox-seed 2026-09-18 03:06:40.726576 | Pipeline: periodic-daily 2026-09-18 03:06:40.726599 | Executor: 521e9411259a 2026-09-18 03:06:40.726619 | Triggered by: https://github.com/osism/generics 2026-09-18 03:06:40.726641 | Event ID: fc7b45e0d32b4255ad6b84333bb838b4 2026-09-18 03:06:40.731366 | 2026-09-18 03:06:40.731454 | LOOP [emit-job-header : Print node information] 2026-09-18 03:06:40.921968 | debian-bookworm | ok: 2026-09-18 03:06:40.922126 | debian-bookworm | # Node Information 2026-09-18 03:06:40.922159 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-18 03:06:40.922184 | debian-bookworm | Hostname: debian 2026-09-18 03:06:40.922205 | debian-bookworm | Username: zuul 2026-09-18 03:06:40.922226 | debian-bookworm | Distro: Debian 12.15 2026-09-18 03:06:40.922251 | debian-bookworm | Provider: regiocloud-a 2026-09-18 03:06:40.922299 | debian-bookworm | Region: 2026-09-18 03:06:40.922324 | debian-bookworm | Label: debian-bookworm 2026-09-18 03:06:40.922344 | debian-bookworm | Product Name: OpenStack Nova 2026-09-18 03:06:40.922363 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb4:d783 2026-09-18 03:06:40.932778 | 2026-09-18 03:06:40.932885 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-18 03:06:41.360128 | debian-bookworm -> localhost | changed 2026-09-18 03:06:41.367109 | 2026-09-18 03:06:41.367215 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-18 03:06:42.674188 | debian-bookworm -> localhost | changed 2026-09-18 03:06:42.689795 | 2026-09-18 03:06:42.689916 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-18 03:06:43.175623 | debian-bookworm -> localhost | ok 2026-09-18 03:06:43.181881 | 2026-09-18 03:06:43.181986 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-18 03:06:43.223254 | debian-bookworm | ok 2026-09-18 03:06:43.249809 | debian-bookworm | included: /var/lib/zuul/builds/b743097465304ff891a931f24655be23/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-18 03:06:43.265456 | 2026-09-18 03:06:43.266069 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-18 03:06:44.489217 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-18 03:06:44.489415 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b743097465304ff891a931f24655be23/work/b743097465304ff891a931f24655be23_id_rsa 2026-09-18 03:06:44.489457 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b743097465304ff891a931f24655be23/work/b743097465304ff891a931f24655be23_id_rsa.pub 2026-09-18 03:06:44.489485 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-18 03:06:44.489511 | debian-bookworm -> localhost | SHA256:VSjPGCaNkzyh8o7b2/IAf7rcwR++rwPoihWLl8o8dUo zuul-build-sshkey 2026-09-18 03:06:44.489534 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-18 03:06:44.489589 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-18 03:06:44.489614 | debian-bookworm -> localhost | | ..= .. | 2026-09-18 03:06:44.489637 | debian-bookworm -> localhost | | .B = .. | 2026-09-18 03:06:44.489658 | debian-bookworm -> localhost | | . . = *. | 2026-09-18 03:06:44.489679 | debian-bookworm -> localhost | | o ..o | 2026-09-18 03:06:44.489700 | debian-bookworm -> localhost | | o .. S | 2026-09-18 03:06:44.489724 | debian-bookworm -> localhost | | . E.o. | 2026-09-18 03:06:44.489747 | debian-bookworm -> localhost | |. O.* +.. | 2026-09-18 03:06:44.489769 | debian-bookworm -> localhost | |o* =o* +.. | 2026-09-18 03:06:44.489790 | debian-bookworm -> localhost | |oo+.*=+ ==. | 2026-09-18 03:06:44.489811 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-18 03:06:44.489863 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.758739 2026-09-18 03:06:44.496190 | 2026-09-18 03:06:44.496288 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-18 03:06:44.524252 | debian-bookworm | ok 2026-09-18 03:06:44.538806 | debian-bookworm | included: /var/lib/zuul/builds/b743097465304ff891a931f24655be23/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-18 03:06:44.556972 | 2026-09-18 03:06:44.557061 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-18 03:06:44.574969 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:06:44.580592 | 2026-09-18 03:06:44.580682 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-18 03:06:45.355469 | debian-bookworm | changed 2026-09-18 03:06:45.365141 | 2026-09-18 03:06:45.365258 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-18 03:06:45.669791 | debian-bookworm | ok 2026-09-18 03:06:45.674244 | 2026-09-18 03:06:45.674347 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-18 03:06:46.374742 | debian-bookworm | changed 2026-09-18 03:06:46.387813 | 2026-09-18 03:06:46.387920 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-18 03:06:47.139366 | debian-bookworm | changed 2026-09-18 03:06:47.145365 | 2026-09-18 03:06:47.145460 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-18 03:06:47.158142 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:06:47.163947 | 2026-09-18 03:06:47.164037 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-18 03:06:47.893956 | debian-bookworm -> localhost | changed 2026-09-18 03:06:47.909481 | 2026-09-18 03:06:47.909649 | TASK [add-build-sshkey : Add back temp key] 2026-09-18 03:06:48.557156 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b743097465304ff891a931f24655be23/work/b743097465304ff891a931f24655be23_id_rsa (zuul-build-sshkey) 2026-09-18 03:06:48.557406 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.028617 2026-09-18 03:06:48.566504 | 2026-09-18 03:06:48.566596 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-18 03:06:49.090250 | debian-bookworm | ok 2026-09-18 03:06:49.099900 | 2026-09-18 03:06:49.100023 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-18 03:06:49.125350 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:06:49.142735 | 2026-09-18 03:06:49.142823 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-18 03:06:49.577110 | debian-bookworm | ok 2026-09-18 03:06:49.590306 | 2026-09-18 03:06:49.590403 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-18 03:06:49.616653 | debian-bookworm | ok 2026-09-18 03:06:49.620906 | 2026-09-18 03:06:49.620979 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-18 03:06:49.896191 | debian-bookworm -> localhost | ok 2026-09-18 03:06:49.905899 | 2026-09-18 03:06:49.906011 | TASK [validate-host : Collect information about the host] 2026-09-18 03:06:51.261293 | debian-bookworm | ok 2026-09-18 03:06:51.273016 | 2026-09-18 03:06:51.273107 | TASK [validate-host : Sanitize hostname] 2026-09-18 03:06:51.390589 | debian-bookworm | ok 2026-09-18 03:06:51.395276 | 2026-09-18 03:06:51.395380 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-18 03:06:51.922949 | debian-bookworm -> localhost | changed 2026-09-18 03:06:51.928572 | 2026-09-18 03:06:51.928670 | TASK [validate-host : Collect information about zuul worker] 2026-09-18 03:06:52.471329 | debian-bookworm | ok 2026-09-18 03:06:52.475972 | 2026-09-18 03:06:52.476065 | TASK [validate-host : Write out all zuul information for each host] 2026-09-18 03:06:53.234257 | debian-bookworm -> localhost | changed 2026-09-18 03:06:53.241684 | 2026-09-18 03:06:53.241767 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-18 03:06:53.546022 | debian-bookworm | ok 2026-09-18 03:06:53.551272 | 2026-09-18 03:06:53.551356 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-18 03:06:54.485453 | debian-bookworm | changed: 2026-09-18 03:06:54.485651 | debian-bookworm | cd+++++++++ src/ 2026-09-18 03:06:54.485715 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-18 03:06:54.485740 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-18 03:06:54.485761 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-09-18 03:06:54.485781 | debian-bookworm | =7.0.3 2026-09-18 03:07:34.806974 | debian-bookworm | Downloading cachetools-7.2.0-py3-none-any.whl (16 kB) 2026-09-18 03:07:34.853404 | debian-bookworm | Collecting colorama>=0.4.6 2026-09-18 03:07:34.868757 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-09-18 03:07:34.942389 | debian-bookworm | Collecting filelock>=3.25 2026-09-18 03:07:34.957728 | debian-bookworm | Downloading filelock-4.0.0-py3-none-any.whl (106 kB) 2026-09-18 03:07:34.975903 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 106.0/106.0 kB 8.3 MB/s eta 0:00:00 2026-09-18 03:07:35.044486 | debian-bookworm | Collecting packaging>=26 2026-09-18 03:07:35.059389 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-09-18 03:07:35.077505 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 8.6 MB/s eta 0:00:00 2026-09-18 03:07:35.136240 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-09-18 03:07:35.151324 | debian-bookworm | Downloading platformdirs-4.11.10-py3-none-any.whl (24 kB) 2026-09-18 03:07:35.211433 | debian-bookworm | Collecting pluggy>=1.6 2026-09-18 03:07:35.227102 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-09-18 03:07:35.295949 | debian-bookworm | Collecting pyproject-api>=1.10 2026-09-18 03:07:35.311196 | debian-bookworm | Downloading pyproject_api-1.11.2-py3-none-any.whl (13 kB) 2026-09-18 03:07:35.370846 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-09-18 03:07:35.387760 | debian-bookworm | Downloading python_discovery-1.6.1-py3-none-any.whl (38 kB) 2026-09-18 03:07:35.442938 | debian-bookworm | Collecting tomli-w>=1.2 2026-09-18 03:07:35.459444 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-09-18 03:07:35.532948 | debian-bookworm | Collecting typing-extensions>=4.15 2026-09-18 03:07:35.548330 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-09-18 03:07:35.567182 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 2.9 MB/s eta 0:00:00 2026-09-18 03:07:35.718560 | debian-bookworm | Collecting virtualenv>=21.1 2026-09-18 03:07:35.734924 | debian-bookworm | Downloading virtualenv-21.7.12-py3-none-any.whl (5.3 MB) 2026-09-18 03:07:36.046100 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.3/5.3 MB 17.4 MB/s eta 0:00:00 2026-09-18 03:07:36.153740 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-09-18 03:07:36.169772 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-09-18 03:07:36.201674 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 19.3 MB/s eta 0:00:00 2026-09-18 03:07:36.231811 | debian-bookworm | Collecting filelock>=3.25 2026-09-18 03:07:36.247003 | debian-bookworm | Downloading filelock-3.32.7-py3-none-any.whl (100 kB) 2026-09-18 03:07:36.274154 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 4.5 MB/s eta 0:00:00 2026-09-18 03:07:36.392457 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-09-18 03:07:37.415829 | 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.10 pluggy-1.6.0 pyproject-api-1.11.2 python-discovery-1.6.1 tomli-w-1.2.0 tox-4.61.5 typing-extensions-4.16.0 virtualenv-21.7.12 2026-09-18 03:07:37.949171 | debian-bookworm | ok: Runtime: 0:00:03.907552 2026-09-18 03:07:37.955955 | 2026-09-18 03:07:37.956079 | TASK [ensure-tox : Export installed tox_executable path] 2026-09-18 03:07:38.034868 | debian-bookworm | ok 2026-09-18 03:07:38.046190 | 2026-09-18 03:07:38.046351 | TASK [ensure-tox : Output tox version] 2026-09-18 03:07:38.904181 | 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-18 03:07:38.926079 | debian-bookworm | 4.61.5 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-18 03:07:39.154598 | debian-bookworm | ok: Runtime: 0:00:00.419345 2026-09-18 03:07:39.159034 | 2026-09-18 03:07:39.159105 | TASK [ensure-tox : Make global symlink] 2026-09-18 03:07:39.192022 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:39.197298 | 2026-09-18 03:07:39.197372 | PLAY RECAP 2026-09-18 03:07:39.197418 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-09-18 03:07:39.197438 | 2026-09-18 03:07:39.340288 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-09-18 03:07:39.341075 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-18 03:07:39.988870 | 2026-09-18 03:07:39.988981 | PLAY [all] 2026-09-18 03:07:40.002840 | 2026-09-18 03:07:40.002995 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-09-18 03:07:40.465683 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-18 03:07:40.525814 | debian-bookworm | ok: Runtime: 0:00:00.031469 2026-09-18 03:07:40.530309 | 2026-09-18 03:07:40.530397 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-09-18 03:07:41.065646 | debian-bookworm | ok: Runtime: 0:00:00.008458 2026-09-18 03:07:41.075129 | 2026-09-18 03:07:41.075256 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-09-18 03:07:41.463847 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-09-18 03:07:41.465808 | debian-bookworm | sudo: a password is required 2026-09-18 03:07:41.636071 | debian-bookworm | ok: Runtime: 0:00:00.019928 2026-09-18 03:07:41.646200 | 2026-09-18 03:07:41.646309 | TASK [tox : Check to see if the constraints file exists] 2026-09-18 03:07:41.670637 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:41.676183 | 2026-09-18 03:07:41.676287 | TASK [tox : Fail if constraints file is missing] 2026-09-18 03:07:41.699443 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:41.704965 | 2026-09-18 03:07:41.705058 | TASK [tox : Record file location] 2026-09-18 03:07:41.758367 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:41.766939 | 2026-09-18 03:07:41.767044 | TASK [tox : Install tox siblings] 2026-09-18 03:07:41.818548 | debian-bookworm | ok 2026-09-18 03:07:41.833670 | debian-bookworm | included: /var/lib/zuul/builds/b743097465304ff891a931f24655be23/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-09-18 03:07:41.850395 | 2026-09-18 03:07:41.850493 | TASK [tox : Run tox without tests] 2026-09-18 03:07:42.467603 | debian-bookworm | ROOT: 247 D setup logging to DEBUG on pid 1603 [tox/report.py:242] 2026-09-18 03:07:42.503700 | debian-bookworm | seed: 284 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-18 03:07:42.506747 | debian-bookworm | seed: 287 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-18 03:07:42.511540 | debian-bookworm | seed: 291 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 67658617b5dd14a5a55c91dfbcd04d66 2f37e3eac5d3e2c65b9c3342a3d81e1c [python_discovery/_cached_py_info.py:223] 2026-09-18 03:07:42.594673 | debian-bookworm | seed: 375 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-18 03:07:42.595138 | debian-bookworm | seed: 375 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-18 03:07:42.595356 | debian-bookworm | seed: 375 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-18 03:07:42.595505 | debian-bookworm | seed: 376 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-18 03:07:42.597802 | debian-bookworm | seed: 378 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-18 03:07:42.597950 | debian-bookworm | seed: 378 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-18 03:07:42.631042 | debian-bookworm | seed: 411 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-18 03:07:42.631284 | debian-bookworm | seed: 411 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/bin [virtualenv/util/path/_sync.py:22] 2026-09-18 03:07:42.631499 | debian-bookworm | seed: 412 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/include [virtualenv/util/path/_sync.py:22] 2026-09-18 03:07:42.631641 | debian-bookworm | seed: 412 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-18 03:07:42.632005 | debian-bookworm | seed: 412 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-18 03:07:42.632128 | debian-bookworm | seed: 412 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:42.632153 | debian-bookworm | seed: 412 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:42.632172 | debian-bookworm | seed: 412 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:42.632202 | debian-bookworm | seed: 412 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:42.632221 | debian-bookworm | seed: 412 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:42.632248 | debian-bookworm | seed: 412 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-18 03:07:42.632329 | debian-bookworm | seed: 412 D virtualenv = 21.7.12 [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:42.632373 | debian-bookworm | seed: 413 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:42.632489 | debian-bookworm | seed: 413 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:42.632511 | debian-bookworm | seed: 413 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:42.632549 | debian-bookworm | seed: 413 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:42.632922 | debian-bookworm | seed: 413 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-18 03:07:42.633407 | debian-bookworm | seed: 413 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-09-18 03:07:42.633678 | debian-bookworm | seed: 414 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-18 03:07:42.676558 | debian-bookworm | seed: 414 D { 2026-09-18 03:07:42.676629 | debian-bookworm | "sys": { 2026-09-18 03:07:42.676636 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/seed/bin/python", 2026-09-18 03:07:42.676642 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-09-18 03:07:42.676651 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-18 03:07:42.676657 | debian-bookworm | "base_prefix": "/usr", 2026-09-18 03:07:42.676664 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-09-18 03:07:42.676668 | debian-bookworm | "base_exec_prefix": "/usr", 2026-09-18 03:07:42.676672 | debian-bookworm | "path": [ 2026-09-18 03:07:42.676676 | debian-bookworm | "/usr/lib/python311.zip", 2026-09-18 03:07:42.676680 | debian-bookworm | "/usr/lib/python3.11", 2026-09-18 03:07:42.676684 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-09-18 03:07:42.676688 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages" 2026-09-18 03:07:42.676692 | debian-bookworm | ], 2026-09-18 03:07:42.676697 | debian-bookworm | "meta_path": [ 2026-09-18 03:07:42.676700 | debian-bookworm | "", 2026-09-18 03:07:42.676705 | debian-bookworm | "", 2026-09-18 03:07:42.676709 | debian-bookworm | "" 2026-09-18 03:07:42.676712 | debian-bookworm | ], 2026-09-18 03:07:42.676716 | debian-bookworm | "fs_encoding": "utf-8", 2026-09-18 03:07:42.676720 | debian-bookworm | "io_encoding": "utf-8" 2026-09-18 03:07:42.676724 | debian-bookworm | }, 2026-09-18 03:07:42.676728 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-09-18 03:07:42.676732 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-09-18 03:07:42.676736 | debian-bookworm | "os": "", 2026-09-18 03:07:42.676740 | debian-bookworm | "site": "", 2026-09-18 03:07:42.676750 | debian-bookworm | "datetime": "", 2026-09-18 03:07:42.676754 | debian-bookworm | "math": "", 2026-09-18 03:07:42.676758 | debian-bookworm | "json": "" 2026-09-18 03:07:42.676762 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-09-18 03:07:42.676984 | debian-bookworm | seed: 457 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-18 03:07:42.687437 | debian-bookworm | seed: 467 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-18 03:07:42.689120 | debian-bookworm | seed: 468 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-18 03:07:42.691385 | debian-bookworm | seed: 471 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-18 03:07:42.692001 | debian-bookworm | seed: 472 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-18 03:07:43.085162 | debian-bookworm | seed: 865 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-18 03:07:43.086417 | debian-bookworm | seed: 866 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-18 03:07:43.089593 | debian-bookworm | seed: 869 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-18 03:07:43.091300 | debian-bookworm | seed: 871 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-18 03:07:43.093159 | debian-bookworm | seed: 873 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-18 03:07:43.227906 | debian-bookworm | seed: 1008 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-18 03:07:43.228987 | debian-bookworm | seed: 1009 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-18 03:07:43.246571 | debian-bookworm | seed: 1026 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-18 03:07:43.271885 | debian-bookworm | seed: 1052 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-18 03:07:43.321303 | debian-bookworm | seed: 1101 D generated console scripts pip pip-3.11 pip3.11 pip3 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-09-18 03:07:43.321546 | debian-bookworm | seed: 1102 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-09-18 03:07:43.329181 | debian-bookworm | seed: 1109 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-09-18 03:07:43.329287 | debian-bookworm | seed: 1109 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:43.329299 | debian-bookworm | seed: 1109 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:43.329309 | debian-bookworm | seed: 1109 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:43.329322 | debian-bookworm | seed: 1109 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:43.329404 | debian-bookworm | seed: 1110 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:43.329463 | debian-bookworm | seed: 1110 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-18 03:07:43.329567 | debian-bookworm | seed: 1110 D virtualenv = 21.7.12 [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:43.329584 | debian-bookworm | seed: 1110 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:43.329665 | debian-bookworm | seed: 1110 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:43.329710 | debian-bookworm | seed: 1110 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:43.329770 | debian-bookworm | seed: 1110 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-09-18 03:07:43.332984 | debian-bookworm | seed: OK (0.83 seconds) 2026-09-18 03:07:43.333049 | debian-bookworm | congratulations :) (0.87 seconds) 2026-09-18 03:07:43.902950 | debian-bookworm | ok: Runtime: 0:00:01.242100 2026-09-18 03:07:43.912403 | 2026-09-18 03:07:43.912507 | TASK [tox : Create a tempfile to save tox showconfig] 2026-09-18 03:07:44.395490 | debian-bookworm | changed 2026-09-18 03:07:44.399852 | 2026-09-18 03:07:44.399934 | TASK [tox : Detect tox version] 2026-09-18 03:07:45.047482 | debian-bookworm | 4.61.5 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-18 03:07:45.427361 | debian-bookworm | ok: Runtime: 0:00:00.396288 2026-09-18 03:07:45.431677 | 2026-09-18 03:07:45.431751 | TASK [tox : Get tox envlist config] 2026-09-18 03:07:46.481582 | debian-bookworm | ok: Runtime: 0:00:00.445122 2026-09-18 03:07:46.492811 | 2026-09-18 03:07:46.492912 | TASK [tox : Install any sibling python packages] 2026-09-18 03:07:46.953772 | debian-bookworm | ok: No setup.cfg, no action needed 2026-09-18 03:07:46.961898 | 2026-09-18 03:07:46.961992 | TASK [tox : Remove tempfile] 2026-09-18 03:07:47.641139 | debian-bookworm | changed 2026-09-18 03:07:47.673486 | 2026-09-18 03:07:47.673602 | TASK [tox : Emit tox command] 2026-09-18 03:07:47.761279 | /home/zuul/.local/tox/bin/tox -eseed -vv --skip-missing-interpreters=false 2026-09-18 03:07:47.766023 | 2026-09-18 03:07:47.766115 | TASK [tox : Run tox] 2026-09-18 03:07:48.414063 | debian-bookworm | ROOT: 259 D setup logging to DEBUG on pid 1643 [tox/report.py:242] 2026-09-18 03:07:48.452513 | debian-bookworm | seed: 297 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-09-18 03:07:48.456229 | debian-bookworm | seed: 301 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-09-18 03:07:48.460953 | debian-bookworm | seed: 306 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-18 03:07:48.461428 | debian-bookworm | seed: 306 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-09-18 03:07:48.461669 | debian-bookworm | seed: 306 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-18 03:07:48.461771 | debian-bookworm | seed: 307 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-18 03:07:48.464277 | debian-bookworm | seed: 309 D symlink on filesystem does work [virtualenv/info.py:51] 2026-09-18 03:07:48.464570 | debian-bookworm | seed: 309 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-09-18 03:07:48.510352 | debian-bookworm | seed: 355 W commands[0]> bash src/test-seed.sh [tox/tox_env/api.py:485] 2026-09-18 03:07:49.254390 | debian-bookworm | PASS=44 FAIL=0 2026-09-18 03:07:49.256658 | debian-bookworm | seed: 1101 I exit 0 (0.75 seconds) /home/zuul/src/github.com/osism/generics> bash src/test-seed.sh pid=1650 [tox/execute/api.py:309] 2026-09-18 03:07:49.257893 | debian-bookworm | seed: OK (0.81=setup[0.06]+cmd[0.75] seconds) 2026-09-18 03:07:49.257917 | debian-bookworm | congratulations :) (0.85 seconds) 2026-09-18 03:07:49.819002 | debian-bookworm | ok: Runtime: 0:00:01.228908 2026-09-18 03:07:49.824533 | 2026-09-18 03:07:49.824628 | TASK [tox : Look for output] 2026-09-18 03:07:50.258102 | debian-bookworm | ok 2026-09-18 03:07:50.270481 | 2026-09-18 03:07:50.270573 | TASK [tox : Return file comments to Zuul] 2026-09-18 03:07:50.303691 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:50.310195 | 2026-09-18 03:07:50.310287 | PLAY RECAP 2026-09-18 03:07:50.310340 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-18 03:07:50.310365 | 2026-09-18 03:07:50.401319 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-09-18 03:07:50.402427 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-18 03:07:51.176728 | 2026-09-18 03:07:51.176852 | PLAY [all] 2026-09-18 03:07:51.204476 | 2026-09-18 03:07:51.204605 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-09-18 03:07:51.278694 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:51.284821 | 2026-09-18 03:07:51.284941 | TASK [fetch-tox-output : Set tox log path for single node] 2026-09-18 03:07:51.332839 | debian-bookworm | ok 2026-09-18 03:07:51.337916 | 2026-09-18 03:07:51.338015 | TASK [fetch-tox-output : Ensure local tox dir] 2026-09-18 03:07:51.974743 | debian-bookworm -> localhost | changed 2026-09-18 03:07:51.982488 | 2026-09-18 03:07:51.982585 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-09-18 03:07:52.056427 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:52.062034 | 2026-09-18 03:07:52.062137 | TASK [fetch-tox-output : Set envlist fact] 2026-09-18 03:07:52.140900 | debian-bookworm | ok 2026-09-18 03:07:52.146574 | 2026-09-18 03:07:52.146663 | TASK [fetch-tox-output : Get tox version] 2026-09-18 03:07:53.032191 | 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-18 03:07:53.058772 | debian-bookworm | 4.61.5 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-09-18 03:07:53.196593 | debian-bookworm | ok: Runtime: 0:00:00.433502 2026-09-18 03:07:53.200862 | 2026-09-18 03:07:53.200938 | TASK [fetch-tox-output : Find all default environments] 2026-09-18 03:07:53.723985 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:53.728717 | 2026-09-18 03:07:53.728800 | TASK [fetch-tox-output : Set envlist fact] 2026-09-18 03:07:53.764712 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:53.769345 | 2026-09-18 03:07:53.769426 | TASK [fetch-tox-output : Find all default environments] 2026-09-18 03:07:54.301328 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:54.311235 | 2026-09-18 03:07:54.311324 | TASK [fetch-tox-output : Set envlist fact] 2026-09-18 03:07:54.347050 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:54.360593 | 2026-09-18 03:07:54.360882 | LOOP [fetch-tox-output : Copy tox logs] 2026-09-18 03:07:54.451248 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:54.461008 | 2026-09-18 03:07:54.461096 | LOOP [fetch-tox-output : Collect tox logs] 2026-09-18 03:07:55.477650 | debian-bookworm | changed: 2026-09-18 03:07:55.477789 | debian-bookworm | created directory /var/lib/zuul/builds/b743097465304ff891a931f24655be23/work/logs/tox/seed 2026-09-18 03:07:55.477817 | debian-bookworm | cd+++++++++ ./ 2026-09-18 03:07:55.477838 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-09-18 03:07:55.477860 | 2026-09-18 03:07:55.485392 | 2026-09-18 03:07:55.485459 | PLAY RECAP 2026-09-18 03:07:55.485507 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-09-18 03:07:55.485533 | 2026-09-18 03:07:55.570351 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-09-18 03:07:55.571546 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-18 03:07:56.436431 | 2026-09-18 03:07:56.436544 | PLAY [all] 2026-09-18 03:07:56.448272 | 2026-09-18 03:07:56.448372 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-09-18 03:07:56.760717 | debian-bookworm | changed: non-zero return code 2026-09-18 03:07:56.769114 | 2026-09-18 03:07:56.769267 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-09-18 03:07:56.792130 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:56.797000 | 2026-09-18 03:07:56.797082 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-09-18 03:07:56.835048 | 2026-09-18 03:07:56.835222 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-09-18 03:07:56.883877 | 2026-09-18 03:07:56.884017 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-09-18 03:07:56.906714 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:56.911656 | 2026-09-18 03:07:56.911738 | LOOP [fetch-subunit-output : Generate subunit file] 2026-09-18 03:07:56.948925 | 2026-09-18 03:07:56.949069 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-09-18 03:07:56.982245 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:56.987978 | 2026-09-18 03:07:56.988069 | TASK [fetch-subunit-output : Remove the temporary file] 2026-09-18 03:07:57.020834 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:57.025669 | 2026-09-18 03:07:57.025767 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-09-18 03:07:57.059851 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:07:57.065084 | 2026-09-18 03:07:57.065140 | PLAY RECAP 2026-09-18 03:07:57.065183 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-09-18 03:07:57.065216 | 2026-09-18 03:07:57.197224 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-09-18 03:07:57.198154 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-18 03:07:58.454135 | 2026-09-18 03:07:58.454279 | PLAY [Base post-fetch] 2026-09-18 03:07:58.489617 | 2026-09-18 03:07:58.489748 | TASK [diagnose-network : Ensure log directory exists] 2026-09-18 03:07:59.058583 | debian-bookworm | ok 2026-09-18 03:07:59.066119 | 2026-09-18 03:07:59.066272 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-09-18 03:08:11.236738 | debian-bookworm | ok: Runtime: 0:00:06.169578 2026-09-18 03:08:11.243312 | 2026-09-18 03:08:11.243409 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-09-18 03:08:17.312456 | debian-bookworm | ok: Runtime: 0:00:00.009106 2026-09-18 03:08:17.319937 | 2026-09-18 03:08:17.320078 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-09-18 03:08:23.484299 | debian-bookworm | ok: Runtime: 0:00:00.010275 2026-09-18 03:08:23.491840 | 2026-09-18 03:08:23.491965 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)] 2026-09-18 03:08:24.024303 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:08:24.036455 | 2026-09-18 03:08:24.036597 | TASK [diagnose-network : Abort the pre-run on a fully isolated node] 2026-09-18 03:08:24.102427 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:08:24.114529 | 2026-09-18 03:08:24.114708 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-18 03:08:24.169704 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:08:24.182352 | 2026-09-18 03:08:24.182559 | TASK [fetch-output : Set log path for single node] 2026-09-18 03:08:24.230706 | debian-bookworm | ok 2026-09-18 03:08:24.238967 | 2026-09-18 03:08:24.239097 | LOOP [fetch-output : Ensure local output dirs] 2026-09-18 03:08:24.567053 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/b743097465304ff891a931f24655be23/work/logs" 2026-09-18 03:08:24.823913 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b743097465304ff891a931f24655be23/work/artifacts" 2026-09-18 03:08:25.089531 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b743097465304ff891a931f24655be23/work/docs" 2026-09-18 03:08:25.105821 | 2026-09-18 03:08:25.105947 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-18 03:08:26.124247 | debian-bookworm | changed: 2026-09-18 03:08:26.124523 | debian-bookworm | .d..t...... ./ 2026-09-18 03:08:26.124635 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-18 03:08:26.124664 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-18 03:08:26.124688 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-18 03:08:26.124711 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-18 03:08:26.124731 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-18 03:08:26.124774 | debian-bookworm | changed: All items complete 2026-09-18 03:08:26.124800 | 2026-09-18 03:08:26.709968 | debian-bookworm | changed: .d..t...... ./ 2026-09-18 03:08:27.267957 | debian-bookworm | changed: .d..t...... ./ 2026-09-18 03:08:27.290234 | 2026-09-18 03:08:27.290367 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-18 03:08:27.330423 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:08:27.334744 | debian-bookworm | skipping: Conditional result was False 2026-09-18 03:08:27.342059 | 2026-09-18 03:08:27.342142 | PLAY RECAP 2026-09-18 03:08:27.342272 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-18 03:08:27.342304 | 2026-09-18 03:08:27.488586 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-18 03:08:27.489679 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-18 03:08:28.357692 | 2026-09-18 03:08:28.357849 | PLAY [Base post] 2026-09-18 03:08:28.372155 | 2026-09-18 03:08:28.372326 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-18 03:08:29.011707 | debian-bookworm | changed 2026-09-18 03:08:29.025761 | 2026-09-18 03:08:29.026038 | PLAY RECAP 2026-09-18 03:08:29.026150 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-18 03:08:29.026272 | 2026-09-18 03:08:29.153894 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-18 03:08:29.155002 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-18 03:08:30.014597 | 2026-09-18 03:08:30.014766 | PLAY [Base post-logs] 2026-09-18 03:08:30.025801 | 2026-09-18 03:08:30.025943 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-18 03:08:30.487993 | localhost | changed 2026-09-18 03:08:30.499465 | 2026-09-18 03:08:30.499615 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-18 03:08:30.524846 | localhost | ok 2026-09-18 03:08:30.528322 | 2026-09-18 03:08:30.528424 | TASK [Set zuul-log-path fact] 2026-09-18 03:08:30.543679 | localhost | ok 2026-09-18 03:08:30.552713 | 2026-09-18 03:08:30.552821 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-18 03:08:30.577791 | localhost | ok 2026-09-18 03:08:30.590005 | 2026-09-18 03:08:30.590117 | TASK [upload-logs : Create log directories] 2026-09-18 03:08:31.174526 | localhost | changed 2026-09-18 03:08:31.180551 | 2026-09-18 03:08:31.180687 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-18 03:08:31.883771 | localhost -> localhost | ok: Runtime: 0:00:00.009223 2026-09-18 03:08:31.890750 | 2026-09-18 03:08:31.890986 | TASK [upload-logs : Upload logs to log server] 2026-09-18 03:08:33.120612 | localhost | Output suppressed because no_log was given 2026-09-18 03:08:33.123615 | 2026-09-18 03:08:33.123758 | LOOP [upload-logs : Compress console log and json output] 2026-09-18 03:08:33.245192 | localhost | skipping: Conditional result was False 2026-09-18 03:08:33.254809 | localhost | skipping: Conditional result was False 2026-09-18 03:08:33.258103 | 2026-09-18 03:08:33.258228 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-18 03:08:33.336720 | localhost | skipping: Conditional result was False 2026-09-18 03:08:33.337324 | 2026-09-18 03:08:33.344461 | localhost | skipping: Conditional result was False 2026-09-18 03:08:33.354773 | 2026-09-18 03:08:33.354878 | LOOP [upload-logs : Upload console log and json output]