2026-10-01 03:06:29.077899 | Job console starting 2026-10-01 03:06:29.085787 | Updating git repos 2026-10-01 03:06:29.141417 | Cloning repos into workspace 2026-10-01 03:06:29.182738 | Restoring repo states 2026-10-01 03:06:29.233230 | Merging changes 2026-10-01 03:06:29.233245 | Checking out repos 2026-10-01 03:06:29.283685 | Preparing playbooks 2026-10-01 03:06:30.290657 | Running Ansible setup 2026-10-01 03:06:34.690500 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-01 03:06:35.485342 | 2026-10-01 03:06:35.485512 | PLAY [Base pre] 2026-10-01 03:06:35.503894 | 2026-10-01 03:06:35.504038 | TASK [Setup log path fact] 2026-10-01 03:06:35.524326 | debian-bookworm | ok 2026-10-01 03:06:35.542547 | 2026-10-01 03:06:35.542735 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 03:06:35.582620 | debian-bookworm | ok 2026-10-01 03:06:35.593355 | 2026-10-01 03:06:35.593477 | TASK [emit-job-header : Print job information] 2026-10-01 03:06:35.632862 | # Job Information 2026-10-01 03:06:35.633057 | Ansible Version: 2.16.14 2026-10-01 03:06:35.633093 | Job: generics-tox-seed 2026-10-01 03:06:35.633127 | Pipeline: periodic-daily 2026-10-01 03:06:35.633149 | Executor: 521e9411259a 2026-10-01 03:06:35.633170 | Triggered by: https://github.com/osism/generics 2026-10-01 03:06:35.633192 | Event ID: 00228bc2765244c4be6a8985d33d5ec2 2026-10-01 03:06:35.638442 | 2026-10-01 03:06:35.638566 | LOOP [emit-job-header : Print node information] 2026-10-01 03:06:35.759407 | debian-bookworm | ok: 2026-10-01 03:06:35.759678 | debian-bookworm | # Node Information 2026-10-01 03:06:35.759737 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-10-01 03:06:35.759763 | debian-bookworm | Hostname: debian 2026-10-01 03:06:35.759785 | debian-bookworm | Username: zuul 2026-10-01 03:06:35.759806 | debian-bookworm | Distro: Debian 12.15 2026-10-01 03:06:35.759835 | debian-bookworm | Provider: regiocloud-a 2026-10-01 03:06:35.759861 | debian-bookworm | Region: 2026-10-01 03:06:35.759883 | debian-bookworm | Label: debian-bookworm 2026-10-01 03:06:35.759903 | debian-bookworm | Product Name: OpenStack Nova 2026-10-01 03:06:35.759922 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5c:ee5c 2026-10-01 03:06:35.776384 | 2026-10-01 03:06:35.776518 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-01 03:06:36.610790 | debian-bookworm -> localhost | changed 2026-10-01 03:06:36.618326 | 2026-10-01 03:06:36.618451 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-01 03:06:37.995485 | debian-bookworm -> localhost | changed 2026-10-01 03:06:38.010115 | 2026-10-01 03:06:38.010220 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-01 03:06:38.558822 | debian-bookworm -> localhost | ok 2026-10-01 03:06:38.564919 | 2026-10-01 03:06:38.565024 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-01 03:06:38.609205 | debian-bookworm | ok 2026-10-01 03:06:38.648704 | debian-bookworm | included: /var/lib/zuul/builds/3718adc4ad6e41a0905754d85fbd3891/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-01 03:06:38.654634 | 2026-10-01 03:06:38.654735 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-01 03:06:41.110732 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-10-01 03:06:41.110898 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3718adc4ad6e41a0905754d85fbd3891/work/3718adc4ad6e41a0905754d85fbd3891_id_rsa 2026-10-01 03:06:41.110931 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3718adc4ad6e41a0905754d85fbd3891/work/3718adc4ad6e41a0905754d85fbd3891_id_rsa.pub 2026-10-01 03:06:41.110954 | debian-bookworm -> localhost | The key fingerprint is: 2026-10-01 03:06:41.110975 | debian-bookworm -> localhost | SHA256:sW5ROgGfo/wJnxoTce5/r+JsCK0skcRvYlG2PcE7OIg zuul-build-sshkey 2026-10-01 03:06:41.110993 | debian-bookworm -> localhost | The key's randomart image is: 2026-10-01 03:06:41.111019 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-10-01 03:06:41.111038 | debian-bookworm -> localhost | | .. | 2026-10-01 03:06:41.111055 | debian-bookworm -> localhost | | ooo. | 2026-10-01 03:06:41.111072 | debian-bookworm -> localhost | | o +.+Bo. | 2026-10-01 03:06:41.111088 | debian-bookworm -> localhost | | E =.+==B | 2026-10-01 03:06:41.111105 | debian-bookworm -> localhost | | . +=oSo | 2026-10-01 03:06:41.111124 | debian-bookworm -> localhost | | = +B.= | 2026-10-01 03:06:41.111141 | debian-bookworm -> localhost | | . =ooO. | 2026-10-01 03:06:41.111157 | debian-bookworm -> localhost | | . o=.oo . | 2026-10-01 03:06:41.111174 | debian-bookworm -> localhost | | .. o+o.o. | 2026-10-01 03:06:41.111190 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-10-01 03:06:41.111234 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.558081 2026-10-01 03:06:41.116353 | 2026-10-01 03:06:41.116426 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-01 03:06:41.132369 | debian-bookworm | ok 2026-10-01 03:06:41.140228 | debian-bookworm | included: /var/lib/zuul/builds/3718adc4ad6e41a0905754d85fbd3891/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-01 03:06:41.146823 | 2026-10-01 03:06:41.146889 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-01 03:06:41.159030 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:06:41.163581 | 2026-10-01 03:06:41.163648 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-01 03:06:41.790223 | debian-bookworm | changed 2026-10-01 03:06:41.795074 | 2026-10-01 03:06:41.795147 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-01 03:06:42.062533 | debian-bookworm | ok 2026-10-01 03:06:42.069125 | 2026-10-01 03:06:42.069255 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-01 03:06:42.755726 | debian-bookworm | changed 2026-10-01 03:06:42.759984 | 2026-10-01 03:06:42.760056 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-01 03:06:43.400772 | debian-bookworm | changed 2026-10-01 03:06:43.408704 | 2026-10-01 03:06:43.408809 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-01 03:06:43.422098 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:06:43.431105 | 2026-10-01 03:06:43.431205 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-01 03:06:43.770703 | debian-bookworm -> localhost | changed 2026-10-01 03:06:43.787549 | 2026-10-01 03:06:43.787637 | TASK [add-build-sshkey : Add back temp key] 2026-10-01 03:06:44.176910 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3718adc4ad6e41a0905754d85fbd3891/work/3718adc4ad6e41a0905754d85fbd3891_id_rsa (zuul-build-sshkey) 2026-10-01 03:06:44.177118 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.033918 2026-10-01 03:06:44.184323 | 2026-10-01 03:06:44.184412 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-01 03:06:44.617188 | debian-bookworm | ok 2026-10-01 03:06:44.634125 | 2026-10-01 03:06:44.634225 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-01 03:06:44.667483 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:06:44.677498 | 2026-10-01 03:06:44.677608 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-01 03:06:45.279096 | debian-bookworm | ok 2026-10-01 03:06:45.305076 | 2026-10-01 03:06:45.305188 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-01 03:06:45.332573 | debian-bookworm | ok 2026-10-01 03:06:45.337341 | 2026-10-01 03:06:45.337422 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-01 03:06:45.795124 | debian-bookworm -> localhost | ok 2026-10-01 03:06:45.804803 | 2026-10-01 03:06:45.804898 | TASK [validate-host : Collect information about the host] 2026-10-01 03:06:46.970838 | debian-bookworm | ok 2026-10-01 03:06:46.991494 | 2026-10-01 03:06:46.991722 | TASK [validate-host : Sanitize hostname] 2026-10-01 03:06:47.105957 | debian-bookworm | ok 2026-10-01 03:06:47.110821 | 2026-10-01 03:06:47.110895 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-01 03:06:47.750843 | debian-bookworm -> localhost | changed 2026-10-01 03:06:47.755517 | 2026-10-01 03:06:47.755595 | TASK [validate-host : Collect information about zuul worker] 2026-10-01 03:06:48.159206 | debian-bookworm | ok 2026-10-01 03:06:48.162999 | 2026-10-01 03:06:48.163081 | TASK [validate-host : Write out all zuul information for each host] 2026-10-01 03:06:49.208224 | debian-bookworm -> localhost | changed 2026-10-01 03:06:49.218718 | 2026-10-01 03:06:49.218793 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-01 03:06:49.534506 | debian-bookworm | ok 2026-10-01 03:06:49.540207 | 2026-10-01 03:06:49.540280 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-01 03:06:50.499998 | debian-bookworm | changed: 2026-10-01 03:06:50.500144 | debian-bookworm | cd+++++++++ src/ 2026-10-01 03:06:50.500172 | debian-bookworm | cd+++++++++ src/github.com/ 2026-10-01 03:06:50.500192 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-10-01 03:06:50.500210 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-10-01 03:06:50.500226 | debian-bookworm | =7.0.3 2026-10-01 03:07:30.107918 | debian-bookworm | Downloading cachetools-7.2.0-py3-none-any.whl (16 kB) 2026-10-01 03:07:30.150166 | debian-bookworm | Collecting colorama>=0.4.6 2026-10-01 03:07:30.161717 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-10-01 03:07:30.248917 | debian-bookworm | Collecting filelock>=3.25 2026-10-01 03:07:30.260727 | debian-bookworm | Downloading filelock-4.0.7-py3-none-any.whl (109 kB) 2026-10-01 03:07:30.273613 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 109.2/109.2 kB 11.1 MB/s eta 0:00:00 2026-10-01 03:07:30.353613 | debian-bookworm | Collecting packaging>=26 2026-10-01 03:07:30.365455 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-10-01 03:07:30.382128 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 9.8 MB/s eta 0:00:00 2026-10-01 03:07:30.446372 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-10-01 03:07:30.458496 | debian-bookworm | Downloading platformdirs-4.12.2-py3-none-any.whl (32 kB) 2026-10-01 03:07:30.514539 | debian-bookworm | Collecting pluggy>=1.6 2026-10-01 03:07:30.526325 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-10-01 03:07:30.582212 | debian-bookworm | Collecting pyproject-api>=1.10 2026-10-01 03:07:30.600365 | debian-bookworm | Downloading pyproject_api-1.11.2-py3-none-any.whl (13 kB) 2026-10-01 03:07:30.668197 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-10-01 03:07:30.680290 | debian-bookworm | Downloading python_discovery-1.6.1-py3-none-any.whl (38 kB) 2026-10-01 03:07:30.731784 | debian-bookworm | Collecting tomli-w>=1.2 2026-10-01 03:07:30.743791 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-10-01 03:07:30.804795 | debian-bookworm | Collecting typing-extensions>=4.15 2026-10-01 03:07:30.818320 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-10-01 03:07:30.832233 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 4.5 MB/s eta 0:00:00 2026-10-01 03:07:30.993411 | debian-bookworm | Collecting virtualenv>=21.1 2026-10-01 03:07:31.005308 | debian-bookworm | Downloading virtualenv-21.14.1-py3-none-any.whl (5.5 MB) 2026-10-01 03:07:31.255354 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 22.3 MB/s eta 0:00:00 2026-10-01 03:07:31.357571 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-10-01 03:07:31.369054 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-10-01 03:07:31.404727 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 15.4 MB/s eta 0:00:00 2026-10-01 03:07:31.530906 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-10-01 03:07:32.613543 | debian-bookworm | Successfully installed cachetools-7.2.0 colorama-0.4.6 distlib-0.4.3 filelock-4.0.7 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.5 typing-extensions-4.16.0 virtualenv-21.14.1 2026-10-01 03:07:32.851078 | debian-bookworm | ok: Runtime: 0:00:03.584962 2026-10-01 03:07:32.856673 | 2026-10-01 03:07:32.856763 | TASK [ensure-tox : Export installed tox_executable path] 2026-10-01 03:07:32.896179 | debian-bookworm | ok 2026-10-01 03:07:32.901029 | 2026-10-01 03:07:32.901117 | TASK [ensure-tox : Output tox version] 2026-10-01 03:07:33.495119 | 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-01 03:07:33.514642 | debian-bookworm | 4.64.5 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-10-01 03:07:33.928909 | debian-bookworm | ok: Runtime: 0:00:00.390176 2026-10-01 03:07:33.943964 | 2026-10-01 03:07:33.944149 | TASK [ensure-tox : Make global symlink] 2026-10-01 03:07:33.969702 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:33.979695 | 2026-10-01 03:07:33.979785 | PLAY RECAP 2026-10-01 03:07:33.979854 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-10-01 03:07:33.979886 | 2026-10-01 03:07:34.083059 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-10-01 03:07:34.083858 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-10-01 03:07:34.885524 | 2026-10-01 03:07:34.885753 | PLAY [all] 2026-10-01 03:07:34.902570 | 2026-10-01 03:07:34.902760 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-10-01 03:07:35.333676 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-10-01 03:07:35.432982 | debian-bookworm | ok: Runtime: 0:00:00.030923 2026-10-01 03:07:35.438250 | 2026-10-01 03:07:35.438336 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-10-01 03:07:35.976921 | debian-bookworm | ok: Runtime: 0:00:00.008108 2026-10-01 03:07:35.984742 | 2026-10-01 03:07:35.984847 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-10-01 03:07:36.349290 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-10-01 03:07:36.351058 | debian-bookworm | sudo: a password is required 2026-10-01 03:07:36.536514 | debian-bookworm | ok: Runtime: 0:00:00.022417 2026-10-01 03:07:36.548453 | 2026-10-01 03:07:36.548549 | TASK [tox : Check to see if the constraints file exists] 2026-10-01 03:07:36.573208 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:36.580851 | 2026-10-01 03:07:36.580972 | TASK [tox : Fail if constraints file is missing] 2026-10-01 03:07:36.607057 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:36.613435 | 2026-10-01 03:07:36.613568 | TASK [tox : Record file location] 2026-10-01 03:07:36.638716 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:36.655794 | 2026-10-01 03:07:36.655907 | TASK [tox : Install tox siblings] 2026-10-01 03:07:36.717736 | debian-bookworm | ok 2026-10-01 03:07:36.747037 | debian-bookworm | included: /var/lib/zuul/builds/3718adc4ad6e41a0905754d85fbd3891/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-10-01 03:07:36.767559 | 2026-10-01 03:07:36.767683 | TASK [tox : Run tox without tests] 2026-10-01 03:07:37.450194 | debian-bookworm | ROOT: 247 D setup logging to DEBUG on pid 1598 [tox/report.py:249] 2026-10-01 03:07:37.485034 | debian-bookworm | seed: 282 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-10-01 03:07:37.488029 | debian-bookworm | seed: 285 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-10-01 03:07:37.493052 | debian-bookworm | seed: 290 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 a618f218f71a3549224bf468cdf869b0 5fd0cf1c5827c1178ed04a884909e46c [python_discovery/_cached_py_info.py:223] 2026-10-01 03:07:37.564709 | debian-bookworm | seed: 362 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-01 03:07:37.565764 | debian-bookworm | seed: 363 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-10-01 03:07:37.566267 | debian-bookworm | seed: 363 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-01 03:07:37.566707 | debian-bookworm | seed: 364 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-01 03:07:37.570458 | debian-bookworm | seed: 368 D symlink on filesystem does work [virtualenv/info.py:51] 2026-10-01 03:07:37.570688 | debian-bookworm | seed: 368 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-10-01 03:07:37.612178 | debian-bookworm | seed: 409 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-01 03:07:37.612513 | debian-bookworm | seed: 410 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/bin [virtualenv/util/path/_sync.py:22] 2026-10-01 03:07:37.612700 | debian-bookworm | seed: 410 D create folder /home/zuul/src/github.com/osism/generics/.tox/seed/include [virtualenv/util/path/_sync.py:22] 2026-10-01 03:07:37.612799 | debian-bookworm | seed: 410 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-01 03:07:37.613028 | debian-bookworm | seed: 410 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-10-01 03:07:37.613133 | debian-bookworm | seed: 411 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.613195 | debian-bookworm | seed: 411 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.613246 | debian-bookworm | seed: 411 D python-version = 3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.613300 | debian-bookworm | seed: 411 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.613366 | debian-bookworm | seed: 411 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.613417 | debian-bookworm | seed: 411 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.613474 | debian-bookworm | seed: 411 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-10-01 03:07:37.613532 | debian-bookworm | seed: 411 D virtualenv = 21.14.1 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.613595 | debian-bookworm | seed: 411 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.613648 | debian-bookworm | seed: 411 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.613698 | debian-bookworm | seed: 411 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.613746 | debian-bookworm | seed: 411 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:37.614154 | debian-bookworm | seed: 412 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-01 03:07:37.614757 | debian-bookworm | seed: 412 D ============================== target debug ============================== [virtualenv/run/session.py:79] 2026-10-01 03:07:37.615061 | debian-bookworm | seed: 412 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-01 03:07:37.655852 | debian-bookworm | seed: 412 D { 2026-10-01 03:07:37.655918 | debian-bookworm | "sys": { 2026-10-01 03:07:37.655926 | debian-bookworm | "executable": "/home/zuul/src/github.com/osism/generics/.tox/seed/bin/python", 2026-10-01 03:07:37.655938 | debian-bookworm | "_base_executable": "/usr/bin/python3.11", 2026-10-01 03:07:37.655947 | debian-bookworm | "prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-10-01 03:07:37.655954 | debian-bookworm | "base_prefix": "/usr", 2026-10-01 03:07:37.655962 | debian-bookworm | "exec_prefix": "/home/zuul/src/github.com/osism/generics/.tox/seed", 2026-10-01 03:07:37.655969 | debian-bookworm | "base_exec_prefix": "/usr", 2026-10-01 03:07:37.655975 | debian-bookworm | "path": [ 2026-10-01 03:07:37.655981 | debian-bookworm | "/usr/lib/python311.zip", 2026-10-01 03:07:37.655988 | debian-bookworm | "/usr/lib/python3.11", 2026-10-01 03:07:37.655994 | debian-bookworm | "/usr/lib/python3.11/lib-dynload", 2026-10-01 03:07:37.656001 | debian-bookworm | "/home/zuul/src/github.com/osism/generics/.tox/seed/lib/python3.11/site-packages" 2026-10-01 03:07:37.656008 | debian-bookworm | ], 2026-10-01 03:07:37.656014 | debian-bookworm | "meta_path": [ 2026-10-01 03:07:37.656021 | debian-bookworm | "", 2026-10-01 03:07:37.656028 | debian-bookworm | "", 2026-10-01 03:07:37.656034 | debian-bookworm | "" 2026-10-01 03:07:37.656041 | debian-bookworm | ], 2026-10-01 03:07:37.656047 | debian-bookworm | "fs_encoding": "utf-8", 2026-10-01 03:07:37.656053 | debian-bookworm | "io_encoding": "utf-8" 2026-10-01 03:07:37.656059 | debian-bookworm | }, 2026-10-01 03:07:37.656066 | debian-bookworm | "version": "3.11.2 (main, May 12 2026, 05:17:27) [GCC 12.2.0]", 2026-10-01 03:07:37.656073 | debian-bookworm | "makefile_filename": "/usr/lib/python3.11/config-3.11-x86_64-linux-gnu/Makefile", 2026-10-01 03:07:37.656080 | debian-bookworm | "os": "", 2026-10-01 03:07:37.656086 | debian-bookworm | "site": "", 2026-10-01 03:07:37.656093 | debian-bookworm | "datetime": "", 2026-10-01 03:07:37.656099 | debian-bookworm | "math": "", 2026-10-01 03:07:37.656114 | debian-bookworm | "json": "" 2026-10-01 03:07:37.656120 | debian-bookworm | } [virtualenv/run/session.py:80] 2026-10-01 03:07:37.656137 | debian-bookworm | seed: 453 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-01 03:07:37.666370 | debian-bookworm | seed: 464 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-01 03:07:37.667704 | debian-bookworm | seed: 464 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-01 03:07:37.670571 | debian-bookworm | seed: 468 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-01 03:07:37.671156 | debian-bookworm | seed: 468 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-01 03:07:38.031284 | debian-bookworm | seed: 829 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-01 03:07:38.032641 | debian-bookworm | seed: 830 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-01 03:07:38.033022 | debian-bookworm | seed: 830 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-01 03:07:38.153090 | debian-bookworm | seed: 950 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-01 03:07:38.166161 | debian-bookworm | seed: 964 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-01 03:07:38.179731 | debian-bookworm | seed: 977 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-01 03:07:38.184602 | debian-bookworm | seed: 982 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-01 03:07:38.185002 | debian-bookworm | seed: 982 D generated console scripts [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-10-01 03:07:38.240846 | debian-bookworm | seed: 1038 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-01 03:07:38.241661 | debian-bookworm | seed: 1039 D generated console scripts pip3.11 pip pip-3.11 pip3 [virtualenv/seed/embed/via_app_data/pip_install/base.py:69] 2026-10-01 03:07:38.242615 | debian-bookworm | seed: 1040 I add activators for Bash, CShell, Fish, Nushell, PowerShell, Python, Xonsh [virtualenv/run/session.py:90] 2026-10-01 03:07:38.254728 | debian-bookworm | seed: 1052 D write /home/zuul/src/github.com/osism/generics/.tox/seed/pyvenv.cfg [virtualenv/create/pyenv_cfg.py:44] 2026-10-01 03:07:38.254854 | debian-bookworm | seed: 1052 D home = /usr/bin [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.254980 | debian-bookworm | seed: 1052 D implementation = CPython [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.255090 | debian-bookworm | seed: 1053 D python-version = 3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.255219 | debian-bookworm | seed: 1053 D version_info = 3.11.2.final.0 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.255317 | debian-bookworm | seed: 1053 D version = 3.11.2 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.255480 | debian-bookworm | seed: 1053 D executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.255565 | debian-bookworm | seed: 1053 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-10-01 03:07:38.255667 | debian-bookworm | seed: 1053 D virtualenv = 21.14.1 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.255776 | debian-bookworm | seed: 1053 D include-system-site-packages = false [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.255894 | debian-bookworm | seed: 1053 D base-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.255996 | debian-bookworm | seed: 1053 D base-exec-prefix = /usr [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.256104 | debian-bookworm | seed: 1054 D base-executable = /usr/bin/python3.11 [virtualenv/create/pyenv_cfg.py:54] 2026-10-01 03:07:38.260666 | debian-bookworm | seed: OK (0.78 seconds) 2026-10-01 03:07:38.260703 | debian-bookworm | congratulations :) (0.81 seconds) 2026-10-01 03:07:38.825330 | debian-bookworm | ok: Runtime: 0:00:01.179311 2026-10-01 03:07:38.830371 | 2026-10-01 03:07:38.830445 | TASK [tox : Create a tempfile to save tox showconfig] 2026-10-01 03:07:39.494672 | debian-bookworm | changed 2026-10-01 03:07:39.499426 | 2026-10-01 03:07:39.499502 | TASK [tox : Detect tox version] 2026-10-01 03:07:40.100281 | debian-bookworm | 4.64.5 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-10-01 03:07:40.527261 | debian-bookworm | ok: Runtime: 0:00:00.350176 2026-10-01 03:07:40.537710 | 2026-10-01 03:07:40.537846 | TASK [tox : Get tox envlist config] 2026-10-01 03:07:41.568005 | debian-bookworm | ok: Runtime: 0:00:00.434954 2026-10-01 03:07:41.573738 | 2026-10-01 03:07:41.573832 | TASK [tox : Install any sibling python packages] 2026-10-01 03:07:42.026861 | debian-bookworm | ok: No setup.cfg, no action needed 2026-10-01 03:07:42.033504 | 2026-10-01 03:07:42.033611 | TASK [tox : Remove tempfile] 2026-10-01 03:07:42.548772 | debian-bookworm | changed 2026-10-01 03:07:42.564445 | 2026-10-01 03:07:42.564553 | TASK [tox : Emit tox command] 2026-10-01 03:07:42.663104 | /home/zuul/.local/tox/bin/tox -eseed -vv --skip-missing-interpreters=false 2026-10-01 03:07:42.667914 | 2026-10-01 03:07:42.668002 | TASK [tox : Run tox] 2026-10-01 03:07:43.336486 | debian-bookworm | ROOT: 228 D setup logging to DEBUG on pid 1638 [tox/report.py:249] 2026-10-01 03:07:43.369196 | debian-bookworm | seed: 261 D created app data folder /home/zuul/.cache/virtualenv [virtualenv/app_data/__init__.py:65] 2026-10-01 03:07:43.372025 | debian-bookworm | seed: 264 I find interpreter for spec PythonSpec(major=3, free_threaded=False) [python_discovery/_discovery.py:131] 2026-10-01 03:07:43.376233 | debian-bookworm | seed: 268 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-01 03:07:43.376685 | debian-bookworm | seed: 269 D filesystem is case-sensitive [python_discovery/_compat.py:18] 2026-10-01 03:07:43.376828 | debian-bookworm | seed: 269 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-01 03:07:43.376924 | debian-bookworm | seed: 269 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-01 03:07:43.378596 | debian-bookworm | seed: 270 D symlink on filesystem does work [virtualenv/info.py:51] 2026-10-01 03:07:43.378863 | debian-bookworm | seed: 271 D filesystem is case-sensitive [virtualenv/info.py:28] 2026-10-01 03:07:43.411162 | debian-bookworm | seed: 303 W commands[0]> bash src/test-seed.sh [tox/tox_env/api.py:500] 2026-10-01 03:07:44.099437 | debian-bookworm | PASS=44 FAIL=0 2026-10-01 03:07:44.103047 | debian-bookworm | seed: 995 I exit 0 (0.69 seconds) /home/zuul/src/github.com/osism/generics> bash src/test-seed.sh pid=1645 [tox/execute/api.py:337] 2026-10-01 03:07:44.105157 | debian-bookworm | seed: OK (0.74=setup[0.05]+cmd[0.69] seconds) 2026-10-01 03:07:44.105220 | debian-bookworm | congratulations :) (0.77 seconds) 2026-10-01 03:07:44.229667 | debian-bookworm | ok: Runtime: 0:00:01.121052 2026-10-01 03:07:44.235293 | 2026-10-01 03:07:44.235381 | TASK [tox : Look for output] 2026-10-01 03:07:44.631733 | debian-bookworm | ok 2026-10-01 03:07:44.647473 | 2026-10-01 03:07:44.647573 | TASK [tox : Return file comments to Zuul] 2026-10-01 03:07:44.670568 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:44.683038 | 2026-10-01 03:07:44.683110 | PLAY RECAP 2026-10-01 03:07:44.683222 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-10-01 03:07:44.683250 | 2026-10-01 03:07:44.806179 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-10-01 03:07:44.807855 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-10-01 03:07:45.579174 | 2026-10-01 03:07:45.579287 | PLAY [all] 2026-10-01 03:07:45.594212 | 2026-10-01 03:07:45.594314 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-10-01 03:07:45.647853 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:45.653464 | 2026-10-01 03:07:45.653587 | TASK [fetch-tox-output : Set tox log path for single node] 2026-10-01 03:07:45.692104 | debian-bookworm | ok 2026-10-01 03:07:45.696954 | 2026-10-01 03:07:45.697046 | TASK [fetch-tox-output : Ensure local tox dir] 2026-10-01 03:07:46.047999 | debian-bookworm -> localhost | changed 2026-10-01 03:07:46.055415 | 2026-10-01 03:07:46.055512 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-10-01 03:07:46.098490 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:46.103771 | 2026-10-01 03:07:46.103869 | TASK [fetch-tox-output : Set envlist fact] 2026-10-01 03:07:46.131445 | debian-bookworm | ok 2026-10-01 03:07:46.136981 | 2026-10-01 03:07:46.137065 | TASK [fetch-tox-output : Get tox version] 2026-10-01 03:07:46.891213 | 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-01 03:07:46.911100 | debian-bookworm | 4.64.5 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-10-01 03:07:47.167447 | debian-bookworm | ok: Runtime: 0:00:00.368020 2026-10-01 03:07:47.181040 | 2026-10-01 03:07:47.181264 | TASK [fetch-tox-output : Find all default environments] 2026-10-01 03:07:47.713105 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:47.717800 | 2026-10-01 03:07:47.717946 | TASK [fetch-tox-output : Set envlist fact] 2026-10-01 03:07:47.751045 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:47.756853 | 2026-10-01 03:07:47.757708 | TASK [fetch-tox-output : Find all default environments] 2026-10-01 03:07:48.307927 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:48.327138 | 2026-10-01 03:07:48.330287 | TASK [fetch-tox-output : Set envlist fact] 2026-10-01 03:07:48.363326 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:48.369262 | 2026-10-01 03:07:48.369364 | LOOP [fetch-tox-output : Copy tox logs] 2026-10-01 03:07:48.453168 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:48.460222 | 2026-10-01 03:07:48.460315 | LOOP [fetch-tox-output : Collect tox logs] 2026-10-01 03:07:49.314060 | debian-bookworm | changed: 2026-10-01 03:07:49.314220 | debian-bookworm | created directory /var/lib/zuul/builds/3718adc4ad6e41a0905754d85fbd3891/work/logs/tox/seed 2026-10-01 03:07:49.314254 | debian-bookworm | cd+++++++++ ./ 2026-10-01 03:07:49.314279 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-10-01 03:07:49.314305 | 2026-10-01 03:07:49.321754 | 2026-10-01 03:07:49.321823 | PLAY RECAP 2026-10-01 03:07:49.321873 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-10-01 03:07:49.321898 | 2026-10-01 03:07:49.445704 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-10-01 03:07:49.446560 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-10-01 03:07:50.366180 | 2026-10-01 03:07:50.366296 | PLAY [all] 2026-10-01 03:07:50.398207 | 2026-10-01 03:07:50.398366 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-10-01 03:07:50.674080 | debian-bookworm | changed: non-zero return code 2026-10-01 03:07:50.679503 | 2026-10-01 03:07:50.679634 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-10-01 03:07:50.703186 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:50.708716 | 2026-10-01 03:07:50.708818 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-10-01 03:07:50.729766 | 2026-10-01 03:07:50.730014 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-10-01 03:07:50.760647 | 2026-10-01 03:07:50.760810 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-10-01 03:07:50.773465 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:50.778964 | 2026-10-01 03:07:50.779065 | LOOP [fetch-subunit-output : Generate subunit file] 2026-10-01 03:07:50.812119 | 2026-10-01 03:07:50.812438 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-10-01 03:07:50.836696 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:50.842832 | 2026-10-01 03:07:50.842933 | TASK [fetch-subunit-output : Remove the temporary file] 2026-10-01 03:07:50.866013 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:50.872166 | 2026-10-01 03:07:50.872262 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-10-01 03:07:50.895371 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:07:50.902095 | 2026-10-01 03:07:50.902173 | PLAY RECAP 2026-10-01 03:07:50.902224 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-10-01 03:07:50.902318 | 2026-10-01 03:07:51.004055 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-10-01 03:07:51.004990 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-01 03:07:51.734927 | 2026-10-01 03:07:51.735050 | PLAY [Base post-fetch] 2026-10-01 03:07:51.750506 | 2026-10-01 03:07:51.750647 | TASK [diagnose-network : Ensure log directory exists] 2026-10-01 03:07:52.193903 | debian-bookworm | ok 2026-10-01 03:07:52.206467 | 2026-10-01 03:07:52.206654 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-10-01 03:08:04.041231 | debian-bookworm | ok: Runtime: 0:00:06.061772 2026-10-01 03:08:04.049230 | 2026-10-01 03:08:04.049675 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-10-01 03:08:10.135481 | debian-bookworm | ok: Runtime: 0:00:00.009711 2026-10-01 03:08:10.141300 | 2026-10-01 03:08:10.141430 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-10-01 03:08:16.210736 | debian-bookworm | ok: Runtime: 0:00:00.010439 2026-10-01 03:08:16.217467 | 2026-10-01 03:08:16.217648 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)] 2026-10-01 03:08:16.784885 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:08:16.791859 | 2026-10-01 03:08:16.791992 | TASK [diagnose-network : Abort the pre-run on a fully isolated node] 2026-10-01 03:08:16.888020 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:08:16.899838 | 2026-10-01 03:08:16.899971 | TASK [fetch-output : Set log path for multiple nodes] 2026-10-01 03:08:17.007767 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:08:17.014254 | 2026-10-01 03:08:17.014388 | TASK [fetch-output : Set log path for single node] 2026-10-01 03:08:17.062355 | debian-bookworm | ok 2026-10-01 03:08:17.071665 | 2026-10-01 03:08:17.071789 | LOOP [fetch-output : Ensure local output dirs] 2026-10-01 03:08:17.668947 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/3718adc4ad6e41a0905754d85fbd3891/work/logs" 2026-10-01 03:08:17.953816 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3718adc4ad6e41a0905754d85fbd3891/work/artifacts" 2026-10-01 03:08:18.241663 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3718adc4ad6e41a0905754d85fbd3891/work/docs" 2026-10-01 03:08:18.263480 | 2026-10-01 03:08:18.263719 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-01 03:08:19.124902 | debian-bookworm | changed: 2026-10-01 03:08:19.125163 | debian-bookworm | .d..t...... ./ 2026-10-01 03:08:19.125203 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-10-01 03:08:19.125227 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-10-01 03:08:19.125249 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-10-01 03:08:19.125272 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-10-01 03:08:19.125294 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-10-01 03:08:19.125334 | debian-bookworm | changed: All items complete 2026-10-01 03:08:19.125360 | 2026-10-01 03:08:19.810827 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 03:08:20.483258 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 03:08:20.504067 | 2026-10-01 03:08:20.504199 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-01 03:08:20.534692 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:08:20.540928 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:08:20.557608 | 2026-10-01 03:08:20.557855 | PLAY RECAP 2026-10-01 03:08:20.557918 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-10-01 03:08:20.557945 | 2026-10-01 03:08:20.786653 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-01 03:08:20.787770 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 03:08:21.793690 | 2026-10-01 03:08:21.793860 | PLAY [Base post] 2026-10-01 03:08:21.822631 | 2026-10-01 03:08:21.822791 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-01 03:08:22.715431 | debian-bookworm | changed 2026-10-01 03:08:22.722683 | 2026-10-01 03:08:22.722789 | PLAY RECAP 2026-10-01 03:08:22.722842 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-01 03:08:22.722891 | 2026-10-01 03:08:22.923723 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 03:08:22.924626 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-01 03:08:24.028454 | 2026-10-01 03:08:24.028576 | PLAY [Base post-logs] 2026-10-01 03:08:24.037202 | 2026-10-01 03:08:24.037296 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-01 03:08:24.722489 | localhost | changed 2026-10-01 03:08:24.736348 | 2026-10-01 03:08:24.736471 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-01 03:08:24.771564 | localhost | ok 2026-10-01 03:08:24.774553 | 2026-10-01 03:08:24.774648 | TASK [Set zuul-log-path fact] 2026-10-01 03:08:24.789395 | localhost | ok 2026-10-01 03:08:24.811079 | 2026-10-01 03:08:24.811191 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 03:08:24.840693 | localhost | ok 2026-10-01 03:08:24.843626 | 2026-10-01 03:08:24.843708 | TASK [upload-logs : Create log directories] 2026-10-01 03:08:25.944581 | localhost | changed 2026-10-01 03:08:25.947134 | 2026-10-01 03:08:25.947221 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-01 03:08:26.497636 | localhost -> localhost | ok: Runtime: 0:00:00.010447 2026-10-01 03:08:26.501111 | 2026-10-01 03:08:26.501201 | TASK [upload-logs : Upload logs to log server] 2026-10-01 03:08:27.059350 | localhost | Output suppressed because no_log was given 2026-10-01 03:08:27.060990 | 2026-10-01 03:08:27.061075 | LOOP [upload-logs : Compress console log and json output] 2026-10-01 03:08:27.101513 | localhost | skipping: Conditional result was False 2026-10-01 03:08:27.106043 | localhost | skipping: Conditional result was False 2026-10-01 03:08:27.111140 | 2026-10-01 03:08:27.111225 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-01 03:08:27.172694 | localhost | skipping: Conditional result was False 2026-10-01 03:08:27.173344 | 2026-10-01 03:08:27.176249 | localhost | skipping: Conditional result was False 2026-10-01 03:08:27.189882 | 2026-10-01 03:08:27.190054 | LOOP [upload-logs : Upload console log and json output]