2026-06-07 00:48:30.468752 | Job console starting 2026-06-07 00:48:30.480249 | Updating git repos 2026-06-07 00:48:30.528251 | Cloning repos into workspace 2026-06-07 00:48:30.647566 | Restoring repo states 2026-06-07 00:48:30.701286 | Merging changes 2026-06-07 00:48:31.386140 | Checking out repos 2026-06-07 00:48:31.457991 | Preparing playbooks 2026-06-07 00:48:32.494317 | Running Ansible setup 2026-06-07 00:48:37.961184 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-07 00:48:38.846337 | 2026-06-07 00:48:38.846514 | PLAY [Base pre] 2026-06-07 00:48:38.865670 | 2026-06-07 00:48:38.865825 | TASK [Setup log path fact] 2026-06-07 00:48:38.895811 | debian-bookworm | ok 2026-06-07 00:48:38.913751 | 2026-06-07 00:48:38.913912 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-07 00:48:38.953360 | debian-bookworm | ok 2026-06-07 00:48:38.963990 | 2026-06-07 00:48:38.964129 | TASK [emit-job-header : Print job information] 2026-06-07 00:48:39.013118 | # Job Information 2026-06-07 00:48:39.013453 | Ansible Version: 2.16.14 2026-06-07 00:48:39.013495 | Job: tox 2026-06-07 00:48:39.013535 | Pipeline: check 2026-06-07 00:48:39.013563 | Executor: 521e9411259a 2026-06-07 00:48:39.013585 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1211 2026-06-07 00:48:39.013615 | Event ID: 7a21b360-620a-11f1-9308-81bcee8522f2 2026-06-07 00:48:39.021725 | 2026-06-07 00:48:39.021868 | LOOP [emit-job-header : Print node information] 2026-06-07 00:48:39.147780 | debian-bookworm | ok: 2026-06-07 00:48:39.148030 | debian-bookworm | # Node Information 2026-06-07 00:48:39.148140 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-07 00:48:39.148174 | debian-bookworm | Hostname: debian 2026-06-07 00:48:39.148210 | debian-bookworm | Username: zuul 2026-06-07 00:48:39.148232 | debian-bookworm | Distro: Debian 12.14 2026-06-07 00:48:39.148257 | debian-bookworm | Provider: regiocloud-a 2026-06-07 00:48:39.148278 | debian-bookworm | Region: 2026-06-07 00:48:39.148299 | debian-bookworm | Label: debian-bookworm 2026-06-07 00:48:39.148320 | debian-bookworm | Product Name: OpenStack Nova 2026-06-07 00:48:39.148340 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec2:11d6 2026-06-07 00:48:39.170047 | 2026-06-07 00:48:39.170224 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-07 00:48:39.766183 | debian-bookworm -> localhost | changed 2026-06-07 00:48:39.774126 | 2026-06-07 00:48:39.774303 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-07 00:48:41.252102 | debian-bookworm -> localhost | changed 2026-06-07 00:48:41.263377 | 2026-06-07 00:48:41.263524 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-07 00:48:41.998613 | debian-bookworm -> localhost | ok 2026-06-07 00:48:42.008322 | 2026-06-07 00:48:42.008470 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-07 00:48:42.066543 | debian-bookworm | ok 2026-06-07 00:48:42.109400 | debian-bookworm | included: /var/lib/zuul/builds/0943d172f124491aa110214a649356dc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-07 00:48:42.132055 | 2026-06-07 00:48:42.132333 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-07 00:48:44.745213 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-07 00:48:44.745447 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0943d172f124491aa110214a649356dc/work/0943d172f124491aa110214a649356dc_id_rsa 2026-06-07 00:48:44.745485 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0943d172f124491aa110214a649356dc/work/0943d172f124491aa110214a649356dc_id_rsa.pub 2026-06-07 00:48:44.745512 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-07 00:48:44.745535 | debian-bookworm -> localhost | SHA256:W/21+mwtqkNHm1EER181f5dybnnmJUqKPjYOZmaqj1o zuul-build-sshkey 2026-06-07 00:48:44.745557 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-07 00:48:44.745590 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-07 00:48:44.745612 | debian-bookworm -> localhost | | .++.+| 2026-06-07 00:48:44.745634 | debian-bookworm -> localhost | | ...=| 2026-06-07 00:48:44.745654 | debian-bookworm -> localhost | | o o=| 2026-06-07 00:48:44.745674 | debian-bookworm -> localhost | | .o + +| 2026-06-07 00:48:44.745694 | debian-bookworm -> localhost | | S ..o+.+=| 2026-06-07 00:48:44.745717 | debian-bookworm -> localhost | | +.o+o.=+| 2026-06-07 00:48:44.745738 | debian-bookworm -> localhost | | E * o.... ..o| 2026-06-07 00:48:44.745758 | debian-bookworm -> localhost | | . . * o+ . +..| 2026-06-07 00:48:44.745780 | debian-bookworm -> localhost | |..ooo ooo.o.oo+ | 2026-06-07 00:48:44.745801 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-07 00:48:44.745848 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.652241 2026-06-07 00:48:44.753433 | 2026-06-07 00:48:44.753539 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-07 00:48:44.802054 | debian-bookworm | ok 2026-06-07 00:48:44.814916 | debian-bookworm | included: /var/lib/zuul/builds/0943d172f124491aa110214a649356dc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-07 00:48:44.840194 | 2026-06-07 00:48:44.840300 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-07 00:48:44.853019 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:48:44.857943 | 2026-06-07 00:48:44.858036 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-07 00:48:45.481196 | debian-bookworm | changed 2026-06-07 00:48:45.487163 | 2026-06-07 00:48:45.487281 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-07 00:48:45.744349 | debian-bookworm | ok 2026-06-07 00:48:45.749802 | 2026-06-07 00:48:45.750002 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-07 00:48:46.541163 | debian-bookworm | changed 2026-06-07 00:48:46.564915 | 2026-06-07 00:48:46.565037 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-07 00:48:47.396110 | debian-bookworm | changed 2026-06-07 00:48:47.400819 | 2026-06-07 00:48:47.400899 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-07 00:48:47.427024 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:48:47.432110 | 2026-06-07 00:48:47.432193 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-07 00:48:48.565318 | debian-bookworm -> localhost | changed 2026-06-07 00:48:48.582882 | 2026-06-07 00:48:48.584979 | TASK [add-build-sshkey : Add back temp key] 2026-06-07 00:48:49.230190 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0943d172f124491aa110214a649356dc/work/0943d172f124491aa110214a649356dc_id_rsa (zuul-build-sshkey) 2026-06-07 00:48:49.230412 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019875 2026-06-07 00:48:49.238581 | 2026-06-07 00:48:49.238681 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-07 00:48:49.691535 | debian-bookworm | ok 2026-06-07 00:48:49.697247 | 2026-06-07 00:48:49.697344 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-07 00:48:49.734929 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:48:49.745420 | 2026-06-07 00:48:49.745524 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-07 00:48:50.456855 | debian-bookworm | ok 2026-06-07 00:48:50.490301 | 2026-06-07 00:48:50.490424 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-07 00:48:50.561111 | debian-bookworm | ok 2026-06-07 00:48:50.584697 | 2026-06-07 00:48:50.584852 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-07 00:48:51.825969 | debian-bookworm -> localhost | ok 2026-06-07 00:48:51.832278 | 2026-06-07 00:48:51.832380 | TASK [validate-host : Collect information about the host] 2026-06-07 00:48:53.292498 | debian-bookworm | ok 2026-06-07 00:48:53.318696 | 2026-06-07 00:48:53.318802 | TASK [validate-host : Sanitize hostname] 2026-06-07 00:48:53.560584 | debian-bookworm | ok 2026-06-07 00:48:53.653746 | 2026-06-07 00:48:53.653863 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-07 00:48:54.552802 | debian-bookworm -> localhost | changed 2026-06-07 00:48:54.557663 | 2026-06-07 00:48:54.557757 | TASK [validate-host : Collect information about zuul worker] 2026-06-07 00:48:55.050350 | debian-bookworm | ok 2026-06-07 00:48:55.055791 | 2026-06-07 00:48:55.055883 | TASK [validate-host : Write out all zuul information for each host] 2026-06-07 00:48:56.628765 | debian-bookworm -> localhost | changed 2026-06-07 00:48:56.636498 | 2026-06-07 00:48:56.636585 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-07 00:48:56.975948 | debian-bookworm | ok 2026-06-07 00:48:56.989078 | 2026-06-07 00:48:56.989396 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-07 00:48:58.783577 | debian-bookworm | changed: 2026-06-07 00:48:58.790166 | debian-bookworm | cd+++++++++ src/ 2026-06-07 00:48:58.790233 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-07 00:48:58.790620 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-07 00:48:58.790917 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-07 00:48:58.790975 | debian-bookworm | =7.0.3 2026-06-07 00:49:29.205100 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-06-07 00:49:29.265906 | debian-bookworm | Collecting colorama>=0.4.6 2026-06-07 00:49:29.278576 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-07 00:49:29.346148 | debian-bookworm | Collecting filelock>=3.25 2026-06-07 00:49:29.358529 | debian-bookworm | Downloading filelock-3.29.1-py3-none-any.whl (40 kB) 2026-06-07 00:49:29.367092 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 40.8/40.8 kB 6.0 MB/s eta 0:00:00 2026-06-07 00:49:29.415912 | debian-bookworm | Collecting packaging>=26 2026-06-07 00:49:29.428117 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-07 00:49:29.443822 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 9.1 MB/s eta 0:00:00 2026-06-07 00:49:29.533361 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-06-07 00:49:29.545829 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-06-07 00:49:29.587601 | debian-bookworm | Collecting pluggy>=1.6 2026-06-07 00:49:29.599286 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-07 00:49:29.646224 | debian-bookworm | Collecting pyproject-api>=1.10 2026-06-07 00:49:29.659570 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-06-07 00:49:29.695169 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-06-07 00:49:29.706844 | debian-bookworm | Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB) 2026-06-07 00:49:29.758447 | debian-bookworm | Collecting tomli-w>=1.2 2026-06-07 00:49:29.773837 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-06-07 00:49:29.946932 | debian-bookworm | Collecting virtualenv>=21.1 2026-06-07 00:49:29.959373 | debian-bookworm | Downloading virtualenv-21.4.2-py3-none-any.whl (7.6 MB) 2026-06-07 00:49:30.313829 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 21.8 MB/s eta 0:00:00 2026-06-07 00:49:30.430689 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-06-07 00:49:30.445648 | debian-bookworm | Downloading distlib-0.4.1-py2.py3-none-any.whl (469 kB) 2026-06-07 00:49:30.468569 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.2/469.2 kB 24.7 MB/s eta 0:00:00 2026-06-07 00:49:30.582915 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-06-07 00:49:31.414559 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.1 filelock-3.29.1 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.0 tomli-w-1.2.0 tox-4.55.1 virtualenv-21.4.2 2026-06-07 00:49:32.013028 | debian-bookworm | ok: Runtime: 0:00:03.275540 2026-06-07 00:49:32.018808 | 2026-06-07 00:49:32.018905 | TASK [ensure-tox : Export installed tox_executable path] 2026-06-07 00:49:32.078817 | debian-bookworm | ok 2026-06-07 00:49:32.083511 | 2026-06-07 00:49:32.083593 | TASK [ensure-tox : Output tox version] 2026-06-07 00:49:32.774629 | 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-06-07 00:49:32.792380 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-07 00:49:33.158890 | debian-bookworm | ok: Runtime: 0:00:00.333991 2026-06-07 00:49:33.164279 | 2026-06-07 00:49:33.164361 | TASK [ensure-tox : Make global symlink] 2026-06-07 00:49:33.197491 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:49:33.202712 | 2026-06-07 00:49:33.202785 | PLAY RECAP 2026-06-07 00:49:33.202827 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-06-07 00:49:33.202867 | 2026-06-07 00:49:33.540606 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-06-07 00:49:33.541420 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-07 00:49:35.198180 | 2026-06-07 00:49:35.198303 | PLAY [all] 2026-06-07 00:49:35.228377 | 2026-06-07 00:49:35.228506 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-06-07 00:49:35.796497 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-07 00:49:36.275152 | debian-bookworm | ok: Runtime: 0:00:00.034855 2026-06-07 00:49:36.280791 | 2026-06-07 00:49:36.280884 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-06-07 00:49:36.836633 | debian-bookworm | ok: Runtime: 0:00:00.007067 2026-06-07 00:49:36.841280 | 2026-06-07 00:49:36.841579 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-06-07 00:49:37.226458 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-07 00:49:37.228395 | debian-bookworm | sudo: a password is required 2026-06-07 00:49:37.382107 | debian-bookworm | ok: Runtime: 0:00:00.024117 2026-06-07 00:49:37.390200 | 2026-06-07 00:49:37.390277 | TASK [tox : Check to see if the constraints file exists] 2026-06-07 00:49:37.462351 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:49:37.467431 | 2026-06-07 00:49:37.467553 | TASK [tox : Fail if constraints file is missing] 2026-06-07 00:49:37.540943 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:49:37.547170 | 2026-06-07 00:49:37.547274 | TASK [tox : Record file location] 2026-06-07 00:49:37.608868 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:49:37.615040 | 2026-06-07 00:49:37.615138 | TASK [tox : Install tox siblings] 2026-06-07 00:49:37.671296 | debian-bookworm | ok 2026-06-07 00:49:37.686475 | debian-bookworm | included: /var/lib/zuul/builds/0943d172f124491aa110214a649356dc/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-06-07 00:49:37.692201 | 2026-06-07 00:49:37.692294 | TASK [tox : Run tox without tests] 2026-06-07 00:49:39.008937 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-06-07 00:49:52.888711 | debian-bookworm | test: OK (14.62 seconds) 2026-06-07 00:49:52.888820 | debian-bookworm | congratulations :) (14.65 seconds) 2026-06-07 00:49:53.249960 | debian-bookworm | ok: Runtime: 0:00:14.969954 2026-06-07 00:49:53.255863 | 2026-06-07 00:49:53.255953 | TASK [tox : Create a tempfile to save tox showconfig] 2026-06-07 00:49:53.676070 | debian-bookworm | changed 2026-06-07 00:49:53.688581 | 2026-06-07 00:49:53.689383 | TASK [tox : Detect tox version] 2026-06-07 00:49:54.265168 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-07 00:49:54.771934 | debian-bookworm | ok: Runtime: 0:00:00.296116 2026-06-07 00:49:54.777426 | 2026-06-07 00:49:54.777550 | TASK [tox : Get tox envlist config] 2026-06-07 00:49:55.838910 | debian-bookworm | ok: Runtime: 0:00:00.361345 2026-06-07 00:49:55.846800 | 2026-06-07 00:49:55.846958 | TASK [tox : Install any sibling python packages] 2026-06-07 00:49:56.630459 | debian-bookworm | ok: No setup.cfg, no action needed 2026-06-07 00:49:56.643744 | 2026-06-07 00:49:56.643890 | TASK [tox : Remove tempfile] 2026-06-07 00:49:57.314961 | debian-bookworm | changed 2026-06-07 00:49:57.327830 | 2026-06-07 00:49:57.327978 | TASK [tox : Emit tox command] 2026-06-07 00:49:57.402180 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-06-07 00:49:57.408194 | 2026-06-07 00:49:57.408324 | TASK [tox : Run tox] 2026-06-07 00:49:58.036935 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-06-07 00:49:58.834419 | debian-bookworm | ............... 2026-06-07 00:49:58.834474 | debian-bookworm | ---------------------------------------------------------------------- 2026-06-07 00:49:58.834487 | debian-bookworm | Ran 15 tests in 0.173s 2026-06-07 00:49:58.834492 | debian-bookworm | 2026-06-07 00:49:58.834499 | debian-bookworm | OK 2026-06-07 00:49:58.937773 | debian-bookworm | test: OK (0.95=setup[0.05]+cmd[0.90] seconds) 2026-06-07 00:49:58.937836 | debian-bookworm | congratulations :) (0.98 seconds) 2026-06-07 00:49:59.451837 | debian-bookworm | ok: Runtime: 0:00:01.286805 2026-06-07 00:49:59.457155 | 2026-06-07 00:49:59.457256 | TASK [tox : Look for output] 2026-06-07 00:49:59.915166 | debian-bookworm | ok 2026-06-07 00:49:59.933021 | 2026-06-07 00:49:59.933118 | TASK [tox : Return file comments to Zuul] 2026-06-07 00:49:59.986285 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:49:59.991514 | 2026-06-07 00:49:59.991587 | PLAY RECAP 2026-06-07 00:49:59.991630 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-06-07 00:49:59.991650 | 2026-06-07 00:50:00.130604 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-07 00:50:00.131439 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-07 00:50:01.176458 | 2026-06-07 00:50:01.176622 | PLAY [all] 2026-06-07 00:50:01.194433 | 2026-06-07 00:50:01.194598 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-06-07 00:50:01.258772 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:01.264768 | 2026-06-07 00:50:01.264906 | TASK [fetch-tox-output : Set tox log path for single node] 2026-06-07 00:50:01.302145 | debian-bookworm | ok 2026-06-07 00:50:01.307002 | 2026-06-07 00:50:01.307107 | TASK [fetch-tox-output : Ensure local tox dir] 2026-06-07 00:50:01.921799 | debian-bookworm -> localhost | changed 2026-06-07 00:50:01.929131 | 2026-06-07 00:50:01.929237 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-06-07 00:50:02.025508 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:02.031854 | 2026-06-07 00:50:02.031958 | TASK [fetch-tox-output : Set envlist fact] 2026-06-07 00:50:02.059567 | debian-bookworm | ok 2026-06-07 00:50:02.087859 | 2026-06-07 00:50:02.093966 | TASK [fetch-tox-output : Get tox version] 2026-06-07 00:50:02.790404 | 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-06-07 00:50:02.809044 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-07 00:50:03.135677 | debian-bookworm | ok: Runtime: 0:00:00.301296 2026-06-07 00:50:03.140048 | 2026-06-07 00:50:03.140126 | TASK [fetch-tox-output : Find all default environments] 2026-06-07 00:50:03.662695 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:03.668347 | 2026-06-07 00:50:03.668457 | TASK [fetch-tox-output : Set envlist fact] 2026-06-07 00:50:03.701855 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:03.706693 | 2026-06-07 00:50:03.706789 | TASK [fetch-tox-output : Find all default environments] 2026-06-07 00:50:04.252183 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:04.257071 | 2026-06-07 00:50:04.257164 | TASK [fetch-tox-output : Set envlist fact] 2026-06-07 00:50:04.302957 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:04.308466 | 2026-06-07 00:50:04.308568 | LOOP [fetch-tox-output : Copy tox logs] 2026-06-07 00:50:04.383490 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:04.397279 | 2026-06-07 00:50:04.397377 | LOOP [fetch-tox-output : Collect tox logs] 2026-06-07 00:50:05.521370 | debian-bookworm | changed: 2026-06-07 00:50:05.521527 | debian-bookworm | created directory /var/lib/zuul/builds/0943d172f124491aa110214a649356dc/work/logs/tox/test 2026-06-07 00:50:05.521567 | debian-bookworm | cd+++++++++ ./ 2026-06-07 00:50:05.521589 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-06-07 00:50:05.521615 | 2026-06-07 00:50:05.531825 | 2026-06-07 00:50:05.531892 | PLAY RECAP 2026-06-07 00:50:05.531933 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-06-07 00:50:05.531953 | 2026-06-07 00:50:05.661480 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-07 00:50:05.662275 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-07 00:50:06.700914 | 2026-06-07 00:50:06.701037 | PLAY [all] 2026-06-07 00:50:06.723995 | 2026-06-07 00:50:06.724117 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-07 00:50:06.993166 | debian-bookworm | changed: non-zero return code 2026-06-07 00:50:06.997718 | 2026-06-07 00:50:06.997859 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-07 00:50:07.010609 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:07.015099 | 2026-06-07 00:50:07.015189 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-07 00:50:07.043344 | 2026-06-07 00:50:07.043525 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-07 00:50:07.072019 | 2026-06-07 00:50:07.072172 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-07 00:50:07.095197 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:07.101293 | 2026-06-07 00:50:07.101399 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-07 00:50:07.129761 | 2026-06-07 00:50:07.129911 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-07 00:50:07.162847 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:07.170021 | 2026-06-07 00:50:07.170109 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-07 00:50:07.221716 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:07.226381 | 2026-06-07 00:50:07.226470 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-07 00:50:07.239175 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:07.244554 | 2026-06-07 00:50:07.244625 | PLAY RECAP 2026-06-07 00:50:07.244668 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-07 00:50:07.244689 | 2026-06-07 00:50:07.363456 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-07 00:50:07.364523 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-07 00:50:08.099052 | 2026-06-07 00:50:08.100950 | PLAY [Base post-fetch] 2026-06-07 00:50:08.126598 | 2026-06-07 00:50:08.126712 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-07 00:50:08.170270 | debian-bookworm | skipping: Conditional result was False 2026-06-07 00:50:08.175199 | 2026-06-07 00:50:08.175312 | TASK [fetch-output : Set log path for single node] 2026-06-07 00:50:08.202045 | debian-bookworm | ok 2026-06-07 00:50:08.206263 | 2026-06-07 00:50:08.206347 | LOOP [fetch-output : Ensure local output dirs] 2026-06-07 00:50:08.882070 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/0943d172f124491aa110214a649356dc/work/logs" 2026-06-07 00:50:09.125921 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0943d172f124491aa110214a649356dc/work/artifacts" 2026-06-07 00:50:09.356627 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0943d172f124491aa110214a649356dc/work/docs" 2026-06-07 00:50:09.367281 | 2026-06-07 00:50:09.367418 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-07 00:50:10.124932 | debian-bookworm | changed: 2026-06-07 00:50:10.125412 | debian-bookworm | .d..t...... ./ 2026-06-07 00:50:10.125481 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-07 00:50:10.125518 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-07 00:50:10.125549 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-07 00:50:10.125615 | debian-bookworm | changed: All items complete 2026-06-07 00:50:10.125646 | 2026-06-07 00:50:10.722296 | debian-bookworm | changed: .d..t...... ./ 2026-06-07 00:50:11.346863 | debian-bookworm | changed: .d..t...... ./ 2026-06-07 00:50:11.359459 | 2026-06-07 00:50:11.359547 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-07 00:50:11.771570 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.005337 2026-06-07 00:50:12.067598 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008470 2026-06-07 00:50:12.090691 | 2026-06-07 00:50:12.090802 | PLAY RECAP 2026-06-07 00:50:12.090904 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-07 00:50:12.090943 | 2026-06-07 00:50:12.207646 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-07 00:50:12.208594 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-07 00:50:12.931265 | 2026-06-07 00:50:12.931391 | PLAY [Base post] 2026-06-07 00:50:12.943492 | 2026-06-07 00:50:12.943617 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-07 00:50:13.476828 | debian-bookworm | changed 2026-06-07 00:50:13.487217 | 2026-06-07 00:50:13.487314 | PLAY RECAP 2026-06-07 00:50:13.487372 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-07 00:50:13.487433 | 2026-06-07 00:50:13.683906 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-07 00:50:13.684876 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-07 00:50:14.764715 | 2026-06-07 00:50:14.764851 | PLAY [Base post-logs] 2026-06-07 00:50:14.776160 | 2026-06-07 00:50:14.776286 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-07 00:50:15.396000 | localhost | changed 2026-06-07 00:50:15.411612 | 2026-06-07 00:50:15.411829 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-07 00:50:15.437048 | localhost | ok 2026-06-07 00:50:15.439920 | 2026-06-07 00:50:15.440011 | TASK [Set zuul-log-path fact] 2026-06-07 00:50:15.456142 | localhost | ok 2026-06-07 00:50:15.465119 | 2026-06-07 00:50:15.465222 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-07 00:50:15.490269 | localhost | ok 2026-06-07 00:50:15.493123 | 2026-06-07 00:50:15.493208 | TASK [upload-logs : Create log directories] 2026-06-07 00:50:15.986226 | localhost | changed 2026-06-07 00:50:15.989610 | 2026-06-07 00:50:15.989712 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-07 00:50:16.480059 | localhost -> localhost | ok: Runtime: 0:00:00.007850 2026-06-07 00:50:16.488360 | 2026-06-07 00:50:16.488485 | TASK [upload-logs : Upload logs to log server] 2026-06-07 00:50:17.084254 | localhost | Output suppressed because no_log was given 2026-06-07 00:50:17.085884 | 2026-06-07 00:50:17.085969 | LOOP [upload-logs : Compress console log and json output] 2026-06-07 00:50:17.130536 | localhost | skipping: Conditional result was False 2026-06-07 00:50:17.138188 | localhost | skipping: Conditional result was False 2026-06-07 00:50:17.141419 | 2026-06-07 00:50:17.141516 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-07 00:50:17.288982 | localhost | skipping: Conditional result was False 2026-06-07 00:50:17.289210 | 2026-06-07 00:50:17.295370 | localhost | skipping: Conditional result was False 2026-06-07 00:50:17.307946 | 2026-06-07 00:50:17.308050 | LOOP [upload-logs : Upload console log and json output]