2026-07-13 20:20:14.179021 | Job console starting 2026-07-13 20:20:14.195621 | Updating git repos 2026-07-13 20:20:14.278269 | Cloning repos into workspace 2026-07-13 20:20:14.582430 | Restoring repo states 2026-07-13 20:20:14.609880 | Merging changes 2026-07-13 20:20:15.259682 | Checking out repos 2026-07-13 20:20:15.345843 | Preparing playbooks 2026-07-13 20:20:16.886326 | Running Ansible setup 2026-07-13 20:20:24.699364 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-13 20:20:25.696100 | 2026-07-13 20:20:25.696242 | PLAY [Base pre] 2026-07-13 20:20:25.712658 | 2026-07-13 20:20:25.712775 | TASK [Setup log path fact] 2026-07-13 20:20:25.739800 | debian-bookworm | ok 2026-07-13 20:20:25.762774 | 2026-07-13 20:20:25.762926 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-13 20:20:25.804425 | debian-bookworm | ok 2026-07-13 20:20:25.813045 | 2026-07-13 20:20:25.813140 | TASK [emit-job-header : Print job information] 2026-07-13 20:20:25.860866 | # Job Information 2026-07-13 20:20:25.861067 | Ansible Version: 2.16.14 2026-07-13 20:20:25.861099 | Job: tox 2026-07-13 20:20:25.861132 | Pipeline: check 2026-07-13 20:20:25.861154 | Executor: 521e9411259a 2026-07-13 20:20:25.861170 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1252 2026-07-13 20:20:25.861188 | Event ID: 3b033090-7ef8-11f1-96bf-796c93c709e7 2026-07-13 20:20:25.865388 | 2026-07-13 20:20:25.865484 | LOOP [emit-job-header : Print node information] 2026-07-13 20:20:26.026754 | debian-bookworm | ok: 2026-07-13 20:20:26.026976 | debian-bookworm | # Node Information 2026-07-13 20:20:26.027008 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-13 20:20:26.027029 | debian-bookworm | Hostname: debian 2026-07-13 20:20:26.027047 | debian-bookworm | Username: zuul 2026-07-13 20:20:26.027064 | debian-bookworm | Distro: Debian 12.15 2026-07-13 20:20:26.027083 | debian-bookworm | Provider: regiocloud-a 2026-07-13 20:20:26.027100 | debian-bookworm | Region: 2026-07-13 20:20:26.027118 | debian-bookworm | Label: debian-bookworm 2026-07-13 20:20:26.027134 | debian-bookworm | Product Name: OpenStack Nova 2026-07-13 20:20:26.027150 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedc:1664 2026-07-13 20:20:26.059374 | 2026-07-13 20:20:26.059525 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-13 20:20:26.843077 | debian-bookworm -> localhost | changed 2026-07-13 20:20:26.850415 | 2026-07-13 20:20:26.850546 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-13 20:20:28.812961 | debian-bookworm -> localhost | changed 2026-07-13 20:20:28.821761 | 2026-07-13 20:20:28.821860 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-13 20:20:29.353587 | debian-bookworm -> localhost | ok 2026-07-13 20:20:29.358567 | 2026-07-13 20:20:29.358657 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-13 20:20:29.396670 | debian-bookworm | ok 2026-07-13 20:20:29.429278 | debian-bookworm | included: /var/lib/zuul/builds/06620caa669a4c22a04801936398ea30/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-13 20:20:29.434297 | 2026-07-13 20:20:29.434380 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-13 20:20:30.963944 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-13 20:20:30.964157 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/06620caa669a4c22a04801936398ea30/work/06620caa669a4c22a04801936398ea30_id_rsa 2026-07-13 20:20:30.964194 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/06620caa669a4c22a04801936398ea30/work/06620caa669a4c22a04801936398ea30_id_rsa.pub 2026-07-13 20:20:30.964248 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-13 20:20:30.964273 | debian-bookworm -> localhost | SHA256:UrLT1A494x3BA+zmuEWTkilp9eRzl1PMF/DPp5WinTA zuul-build-sshkey 2026-07-13 20:20:30.964295 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-13 20:20:30.964324 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-13 20:20:30.964345 | debian-bookworm -> localhost | | ..o...+.| 2026-07-13 20:20:30.964367 | debian-bookworm -> localhost | | .oo o.. =| 2026-07-13 20:20:30.964387 | debian-bookworm -> localhost | | .o+B=... +.| 2026-07-13 20:20:30.964407 | debian-bookworm -> localhost | | +*++X+..+.o| 2026-07-13 20:20:30.964425 | debian-bookworm -> localhost | | .+.S*oE.o o=| 2026-07-13 20:20:30.964451 | debian-bookworm -> localhost | | o. o = oo.| 2026-07-13 20:20:30.964471 | debian-bookworm -> localhost | | o . o. | 2026-07-13 20:20:30.964490 | debian-bookworm -> localhost | | . | 2026-07-13 20:20:30.964510 | debian-bookworm -> localhost | | | 2026-07-13 20:20:30.964530 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-13 20:20:30.964576 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.509832 2026-07-13 20:20:30.970692 | 2026-07-13 20:20:30.970792 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-13 20:20:30.988058 | debian-bookworm | ok 2026-07-13 20:20:30.998049 | debian-bookworm | included: /var/lib/zuul/builds/06620caa669a4c22a04801936398ea30/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-13 20:20:31.006402 | 2026-07-13 20:20:31.006502 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-13 20:20:31.019764 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:20:31.026375 | 2026-07-13 20:20:31.026489 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-13 20:20:31.769247 | debian-bookworm | changed 2026-07-13 20:20:31.774948 | 2026-07-13 20:20:31.775047 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-13 20:20:32.065754 | debian-bookworm | ok 2026-07-13 20:20:32.072051 | 2026-07-13 20:20:32.072153 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-13 20:20:32.830124 | debian-bookworm | changed 2026-07-13 20:20:32.835531 | 2026-07-13 20:20:32.835632 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-13 20:20:33.491390 | debian-bookworm | changed 2026-07-13 20:20:33.497891 | 2026-07-13 20:20:33.498001 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-13 20:20:33.511916 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:20:33.519681 | 2026-07-13 20:20:33.519796 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-13 20:20:34.022234 | debian-bookworm -> localhost | changed 2026-07-13 20:20:34.032528 | 2026-07-13 20:20:34.032640 | TASK [add-build-sshkey : Add back temp key] 2026-07-13 20:20:34.451621 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/06620caa669a4c22a04801936398ea30/work/06620caa669a4c22a04801936398ea30_id_rsa (zuul-build-sshkey) 2026-07-13 20:20:34.451849 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014540 2026-07-13 20:20:34.459351 | 2026-07-13 20:20:34.459458 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-13 20:20:34.963521 | debian-bookworm | ok 2026-07-13 20:20:34.968681 | 2026-07-13 20:20:34.968775 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-13 20:20:35.000407 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:20:35.012922 | 2026-07-13 20:20:35.013040 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-13 20:20:35.533913 | debian-bookworm | ok 2026-07-13 20:20:35.553890 | 2026-07-13 20:20:35.554012 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-13 20:20:35.621732 | debian-bookworm | ok 2026-07-13 20:20:35.639546 | 2026-07-13 20:20:35.639669 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-13 20:20:36.158723 | debian-bookworm -> localhost | ok 2026-07-13 20:20:36.165065 | 2026-07-13 20:20:36.165170 | TASK [validate-host : Collect information about the host] 2026-07-13 20:20:37.288490 | debian-bookworm | ok 2026-07-13 20:20:37.322606 | 2026-07-13 20:20:37.322730 | TASK [validate-host : Sanitize hostname] 2026-07-13 20:20:37.560690 | debian-bookworm | ok 2026-07-13 20:20:37.565299 | 2026-07-13 20:20:37.565397 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-13 20:20:38.331552 | debian-bookworm -> localhost | changed 2026-07-13 20:20:38.338450 | 2026-07-13 20:20:38.338616 | TASK [validate-host : Collect information about zuul worker] 2026-07-13 20:20:38.850633 | debian-bookworm | ok 2026-07-13 20:20:38.856587 | 2026-07-13 20:20:38.856720 | TASK [validate-host : Write out all zuul information for each host] 2026-07-13 20:20:39.731630 | debian-bookworm -> localhost | changed 2026-07-13 20:20:39.746316 | 2026-07-13 20:20:39.746471 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-13 20:20:40.132879 | debian-bookworm | ok 2026-07-13 20:20:40.139354 | 2026-07-13 20:20:40.139482 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-13 20:20:41.220344 | debian-bookworm | changed: 2026-07-13 20:20:41.220565 | debian-bookworm | cd+++++++++ src/ 2026-07-13 20:20:41.220601 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-13 20:20:41.220625 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-13 20:20:41.220646 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-13 20:20:41.220666 | debian-bookworm | =7.0.3 2026-07-13 20:21:21.501060 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-13 20:21:21.555861 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-13 20:21:21.571072 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-13 20:21:21.651767 | debian-bookworm | Collecting filelock>=3.25 2026-07-13 20:21:21.666866 | debian-bookworm | Downloading filelock-3.29.7-py3-none-any.whl (46 kB) 2026-07-13 20:21:21.676076 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.0/46.0 kB 5.9 MB/s eta 0:00:00 2026-07-13 20:21:21.723404 | debian-bookworm | Collecting packaging>=26 2026-07-13 20:21:21.738132 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-13 20:21:21.753485 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 9.9 MB/s eta 0:00:00 2026-07-13 20:21:21.820076 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-13 20:21:21.835032 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-07-13 20:21:21.877674 | debian-bookworm | Collecting pluggy>=1.6 2026-07-13 20:21:21.891987 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-13 20:21:21.933892 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-13 20:21:21.948456 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-13 20:21:21.984774 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-13 20:21:21.999878 | debian-bookworm | Downloading python_discovery-1.4.4-py3-none-any.whl (34 kB) 2026-07-13 20:21:22.035400 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-13 20:21:22.050193 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-13 20:21:22.212589 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-13 20:21:22.228736 | debian-bookworm | Downloading virtualenv-21.6.1-py3-none-any.whl (5.5 MB) 2026-07-13 20:21:22.551148 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 17.5 MB/s eta 0:00:00 2026-07-13 20:21:22.683523 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-13 20:21:22.699579 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-13 20:21:22.728904 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 20.5 MB/s eta 0:00:00 2026-07-13 20:21:22.841442 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-13 20:21:23.668808 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.29.7 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.4 tomli-w-1.2.0 tox-4.56.4 virtualenv-21.6.1 2026-07-13 20:21:24.125384 | debian-bookworm | ok: Runtime: 0:00:03.420019 2026-07-13 20:21:24.131746 | 2026-07-13 20:21:24.131866 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-13 20:21:24.174952 | debian-bookworm | ok 2026-07-13 20:21:24.181375 | 2026-07-13 20:21:24.181502 | TASK [ensure-tox : Output tox version] 2026-07-13 20:21:24.778687 | 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-07-13 20:21:24.796109 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-13 20:21:25.213190 | debian-bookworm | ok: Runtime: 0:00:00.350426 2026-07-13 20:21:25.221787 | 2026-07-13 20:21:25.221919 | TASK [ensure-tox : Make global symlink] 2026-07-13 20:21:25.248459 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:21:25.258077 | 2026-07-13 20:21:25.258198 | PLAY RECAP 2026-07-13 20:21:25.258265 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-13 20:21:25.258291 | 2026-07-13 20:21:25.447645 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-13 20:21:25.448930 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-13 20:21:26.358191 | 2026-07-13 20:21:26.358400 | PLAY [all] 2026-07-13 20:21:26.377494 | 2026-07-13 20:21:26.377675 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-13 20:21:26.940674 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-13 20:21:27.410987 | debian-bookworm | ok: Runtime: 0:00:00.032167 2026-07-13 20:21:27.422521 | 2026-07-13 20:21:27.422716 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-13 20:21:27.972332 | debian-bookworm | ok: Runtime: 0:00:00.008054 2026-07-13 20:21:27.987181 | 2026-07-13 20:21:27.987372 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-13 20:21:28.312790 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-13 20:21:28.313865 | debian-bookworm | sudo: a password is required 2026-07-13 20:21:28.524045 | debian-bookworm | ok: Runtime: 0:00:00.023964 2026-07-13 20:21:28.542073 | 2026-07-13 20:21:28.542255 | TASK [tox : Check to see if the constraints file exists] 2026-07-13 20:21:28.581907 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:21:28.596998 | 2026-07-13 20:21:28.597343 | TASK [tox : Fail if constraints file is missing] 2026-07-13 20:21:28.665230 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:21:28.690633 | 2026-07-13 20:21:28.690813 | TASK [tox : Record file location] 2026-07-13 20:21:28.733818 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:21:28.744125 | 2026-07-13 20:21:28.744481 | TASK [tox : Install tox siblings] 2026-07-13 20:21:28.794729 | debian-bookworm | ok 2026-07-13 20:21:28.813805 | debian-bookworm | included: /var/lib/zuul/builds/06620caa669a4c22a04801936398ea30/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-13 20:21:28.823386 | 2026-07-13 20:21:28.823537 | TASK [tox : Run tox without tests] 2026-07-13 20:21:30.264490 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-13 20:21:44.682091 | debian-bookworm | test: OK (15.26 seconds) 2026-07-13 20:21:44.682159 | debian-bookworm | congratulations :) (15.29 seconds) 2026-07-13 20:21:44.880155 | debian-bookworm | ok: Runtime: 0:00:15.599134 2026-07-13 20:21:44.890297 | 2026-07-13 20:21:44.890415 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-13 20:21:45.407540 | debian-bookworm | changed 2026-07-13 20:21:45.416881 | 2026-07-13 20:21:45.417005 | TASK [tox : Detect tox version] 2026-07-13 20:21:46.023330 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-13 20:21:46.484144 | debian-bookworm | ok: Runtime: 0:00:00.312061 2026-07-13 20:21:46.493474 | 2026-07-13 20:21:46.493570 | TASK [tox : Get tox envlist config] 2026-07-13 20:21:47.557189 | debian-bookworm | ok: Runtime: 0:00:00.364903 2026-07-13 20:21:47.562368 | 2026-07-13 20:21:47.562453 | TASK [tox : Install any sibling python packages] 2026-07-13 20:21:48.565713 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-13 20:21:48.572032 | 2026-07-13 20:21:48.572158 | TASK [tox : Remove tempfile] 2026-07-13 20:21:49.670935 | debian-bookworm | changed 2026-07-13 20:21:49.692384 | 2026-07-13 20:21:49.692546 | TASK [tox : Emit tox command] 2026-07-13 20:21:49.818716 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-13 20:21:49.833517 | 2026-07-13 20:21:49.833639 | TASK [tox : Run tox] 2026-07-13 20:21:50.816357 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-13 20:21:52.820055 | debian-bookworm | ............................................. 2026-07-13 20:21:52.820130 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-13 20:21:52.820140 | debian-bookworm | Ran 45 tests in 1.504s 2026-07-13 20:21:52.820147 | debian-bookworm | 2026-07-13 20:21:52.820154 | debian-bookworm | OK 2026-07-13 20:21:52.939771 | debian-bookworm | test: OK (2.17=setup[0.05]+cmd[2.12] seconds) 2026-07-13 20:21:52.939837 | debian-bookworm | congratulations :) (2.20 seconds) 2026-07-13 20:21:53.431482 | debian-bookworm | ok: Runtime: 0:00:02.528217 2026-07-13 20:21:53.440211 | 2026-07-13 20:21:53.440317 | TASK [tox : Look for output] 2026-07-13 20:21:54.595357 | debian-bookworm | ok 2026-07-13 20:21:54.636143 | 2026-07-13 20:21:54.636263 | TASK [tox : Return file comments to Zuul] 2026-07-13 20:21:54.734348 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:21:54.740181 | 2026-07-13 20:21:54.740255 | PLAY RECAP 2026-07-13 20:21:54.740302 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-13 20:21:54.740323 | 2026-07-13 20:21:55.383582 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-13 20:21:55.384602 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-13 20:21:57.848326 | 2026-07-13 20:21:57.848476 | PLAY [all] 2026-07-13 20:21:57.901408 | 2026-07-13 20:21:57.901548 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-13 20:21:58.051917 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:21:58.057282 | 2026-07-13 20:21:58.057405 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-13 20:21:58.216991 | debian-bookworm | ok 2026-07-13 20:21:58.221891 | 2026-07-13 20:21:58.221992 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-13 20:22:00.081712 | debian-bookworm -> localhost | changed 2026-07-13 20:22:00.089917 | 2026-07-13 20:22:00.090036 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-13 20:22:00.191973 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:00.199556 | 2026-07-13 20:22:00.199676 | TASK [fetch-tox-output : Set envlist fact] 2026-07-13 20:22:00.274288 | debian-bookworm | ok 2026-07-13 20:22:00.285393 | 2026-07-13 20:22:00.285510 | TASK [fetch-tox-output : Get tox version] 2026-07-13 20:22:01.467700 | 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-07-13 20:22:01.485867 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-13 20:22:01.928239 | debian-bookworm | ok: Runtime: 0:00:00.342650 2026-07-13 20:22:01.935607 | 2026-07-13 20:22:01.935724 | TASK [fetch-tox-output : Find all default environments] 2026-07-13 20:22:02.498907 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:02.504142 | 2026-07-13 20:22:02.504242 | TASK [fetch-tox-output : Set envlist fact] 2026-07-13 20:22:02.570272 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:02.576646 | 2026-07-13 20:22:02.576736 | TASK [fetch-tox-output : Find all default environments] 2026-07-13 20:22:03.170057 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:03.179304 | 2026-07-13 20:22:03.179407 | TASK [fetch-tox-output : Set envlist fact] 2026-07-13 20:22:03.223462 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:03.229632 | 2026-07-13 20:22:03.229742 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-13 20:22:03.349297 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:03.360642 | 2026-07-13 20:22:03.360747 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-13 20:22:05.682346 | debian-bookworm | changed: 2026-07-13 20:22:05.682646 | debian-bookworm | created directory /var/lib/zuul/builds/06620caa669a4c22a04801936398ea30/work/logs/tox/test 2026-07-13 20:22:05.682688 | debian-bookworm | cd+++++++++ ./ 2026-07-13 20:22:05.682711 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-13 20:22:05.682828 | 2026-07-13 20:22:05.694721 | 2026-07-13 20:22:05.694801 | PLAY RECAP 2026-07-13 20:22:05.694866 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-13 20:22:05.694888 | 2026-07-13 20:22:06.116556 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-13 20:22:06.117559 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-13 20:22:08.480425 | 2026-07-13 20:22:08.497632 | PLAY [all] 2026-07-13 20:22:08.553567 | 2026-07-13 20:22:08.553701 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-13 20:22:08.927602 | debian-bookworm | changed: non-zero return code 2026-07-13 20:22:08.932174 | 2026-07-13 20:22:08.932271 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-13 20:22:08.977040 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:08.982304 | 2026-07-13 20:22:08.982398 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-13 20:22:09.034710 | 2026-07-13 20:22:09.034883 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-13 20:22:09.107619 | 2026-07-13 20:22:09.107838 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-13 20:22:09.166313 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:09.174315 | 2026-07-13 20:22:09.174423 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-13 20:22:09.219000 | 2026-07-13 20:22:09.219238 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-13 20:22:09.273534 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:09.282826 | 2026-07-13 20:22:09.282961 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-13 20:22:09.314738 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:09.320144 | 2026-07-13 20:22:09.320518 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-13 20:22:09.364223 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:09.372863 | 2026-07-13 20:22:09.373021 | PLAY RECAP 2026-07-13 20:22:09.373069 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-13 20:22:09.373090 | 2026-07-13 20:22:09.594746 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-13 20:22:09.596077 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-13 20:22:11.738972 | 2026-07-13 20:22:11.739121 | PLAY [Base post-fetch] 2026-07-13 20:22:11.794689 | 2026-07-13 20:22:11.794922 | TASK [diagnose-network : Ensure log directory exists] 2026-07-13 20:22:12.558182 | debian-bookworm | ok 2026-07-13 20:22:12.585777 | 2026-07-13 20:22:12.585929 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-13 20:22:25.274282 | debian-bookworm | ok: Runtime: 0:00:06.218126 2026-07-13 20:22:25.288999 | 2026-07-13 20:22:25.289135 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-13 20:22:31.746528 | debian-bookworm | ok: Runtime: 0:00:00.004873 2026-07-13 20:22:31.757051 | 2026-07-13 20:22:31.757214 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-13 20:22:37.998457 | debian-bookworm | ok: Runtime: 0:00:00.008891 2026-07-13 20:22:38.048344 | 2026-07-13 20:22:38.048510 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-13 20:22:38.286472 | debian-bookworm | skipping: Conditional result was False 2026-07-13 20:22:38.298179 | 2026-07-13 20:22:38.298387 | TASK [fetch-output : Set log path for single node] 2026-07-13 20:22:38.411328 | debian-bookworm | ok 2026-07-13 20:22:38.446779 | 2026-07-13 20:22:38.447689 | LOOP [fetch-output : Ensure local output dirs] 2026-07-13 20:22:39.532525 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/06620caa669a4c22a04801936398ea30/work/logs" 2026-07-13 20:22:40.154221 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/06620caa669a4c22a04801936398ea30/work/artifacts" 2026-07-13 20:22:40.798398 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/06620caa669a4c22a04801936398ea30/work/docs" 2026-07-13 20:22:40.828182 | 2026-07-13 20:22:40.828312 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-13 20:22:41.972867 | debian-bookworm | changed: 2026-07-13 20:22:41.973093 | debian-bookworm | .d..t...... ./ 2026-07-13 20:22:41.973132 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-13 20:22:41.973156 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-13 20:22:41.973177 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-13 20:22:41.973206 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-13 20:22:41.973227 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-13 20:22:41.973271 | debian-bookworm | changed: All items complete 2026-07-13 20:22:41.973325 | 2026-07-13 20:22:42.662548 | debian-bookworm | changed: .d..t...... ./ 2026-07-13 20:22:43.257235 | debian-bookworm | changed: .d..t...... ./ 2026-07-13 20:22:43.277860 | 2026-07-13 20:22:43.277973 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-13 20:22:43.634111 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.005646 2026-07-13 20:22:43.907197 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.017047 2026-07-13 20:22:43.923965 | 2026-07-13 20:22:43.925979 | PLAY RECAP 2026-07-13 20:22:43.926052 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-13 20:22:43.926093 | 2026-07-13 20:22:44.057731 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-13 20:22:44.058764 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-13 20:22:44.796639 | 2026-07-13 20:22:44.796782 | PLAY [Base post] 2026-07-13 20:22:44.810284 | 2026-07-13 20:22:44.810465 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-13 20:22:45.437298 | debian-bookworm | changed 2026-07-13 20:22:45.476762 | 2026-07-13 20:22:45.476919 | PLAY RECAP 2026-07-13 20:22:45.476989 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-13 20:22:45.477055 | 2026-07-13 20:22:45.705357 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-13 20:22:45.706779 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-13 20:22:46.917674 | 2026-07-13 20:22:46.917866 | PLAY [Base post-logs] 2026-07-13 20:22:46.940267 | 2026-07-13 20:22:46.940456 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-13 20:22:47.612745 | localhost | changed 2026-07-13 20:22:47.632379 | 2026-07-13 20:22:47.633708 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-13 20:22:47.679359 | localhost | ok 2026-07-13 20:22:47.684030 | 2026-07-13 20:22:47.684190 | TASK [Set zuul-log-path fact] 2026-07-13 20:22:47.701320 | localhost | ok 2026-07-13 20:22:47.716484 | 2026-07-13 20:22:47.716628 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-13 20:22:47.742410 | localhost | ok 2026-07-13 20:22:47.746004 | 2026-07-13 20:22:47.746157 | TASK [upload-logs : Create log directories] 2026-07-13 20:22:48.588339 | localhost | changed 2026-07-13 20:22:48.591792 | 2026-07-13 20:22:48.591931 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-13 20:22:49.321262 | localhost -> localhost | ok: Runtime: 0:00:00.009828 2026-07-13 20:22:49.328402 | 2026-07-13 20:22:49.328552 | TASK [upload-logs : Upload logs to log server] 2026-07-13 20:22:50.223469 | localhost | Output suppressed because no_log was given 2026-07-13 20:22:50.227882 | 2026-07-13 20:22:50.228150 | LOOP [upload-logs : Compress console log and json output] 2026-07-13 20:22:50.315714 | localhost | skipping: Conditional result was False 2026-07-13 20:22:50.323548 | localhost | skipping: Conditional result was False 2026-07-13 20:22:50.338784 | 2026-07-13 20:22:50.339042 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-13 20:22:50.401142 | localhost | skipping: Conditional result was False 2026-07-13 20:22:50.401479 | 2026-07-13 20:22:50.406495 | localhost | skipping: Conditional result was False 2026-07-13 20:22:50.420365 | 2026-07-13 20:22:50.421131 | LOOP [upload-logs : Upload console log and json output]