2026-07-05 00:39:36.720912 | Job console starting 2026-07-05 00:39:36.730453 | Updating git repos 2026-07-05 00:39:36.770794 | Cloning repos into workspace 2026-07-05 00:39:36.865771 | Restoring repo states 2026-07-05 00:39:36.879937 | Merging changes 2026-07-05 00:39:37.448585 | Checking out repos 2026-07-05 00:39:37.511284 | Preparing playbooks 2026-07-05 00:39:38.615761 | Running Ansible setup 2026-07-05 00:39:44.099544 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-05 00:39:45.400569 | 2026-07-05 00:39:45.400787 | PLAY [Base pre] 2026-07-05 00:39:45.421983 | 2026-07-05 00:39:45.422170 | TASK [Setup log path fact] 2026-07-05 00:39:45.474818 | debian-bookworm | ok 2026-07-05 00:39:45.505391 | 2026-07-05 00:39:45.505645 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-05 00:39:45.536819 | debian-bookworm | ok 2026-07-05 00:39:45.551434 | 2026-07-05 00:39:45.551593 | TASK [emit-job-header : Print job information] 2026-07-05 00:39:45.604345 | # Job Information 2026-07-05 00:39:45.604633 | Ansible Version: 2.16.14 2026-07-05 00:39:45.604673 | Job: tox 2026-07-05 00:39:45.604712 | Pipeline: check 2026-07-05 00:39:45.604736 | Executor: 521e9411259a 2026-07-05 00:39:45.604756 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1246 2026-07-05 00:39:45.604777 | Event ID: d6594750-7809-11f1-841e-28daa25c7374 2026-07-05 00:39:45.619518 | 2026-07-05 00:39:45.619807 | LOOP [emit-job-header : Print node information] 2026-07-05 00:39:45.860369 | debian-bookworm | ok: 2026-07-05 00:39:45.860606 | debian-bookworm | # Node Information 2026-07-05 00:39:45.860641 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-05 00:39:45.860668 | debian-bookworm | Hostname: debian 2026-07-05 00:39:45.860691 | debian-bookworm | Username: zuul 2026-07-05 00:39:45.860713 | debian-bookworm | Distro: Debian 12.14 2026-07-05 00:39:45.860736 | debian-bookworm | Provider: regiocloud-a 2026-07-05 00:39:45.860757 | debian-bookworm | Region: 2026-07-05 00:39:45.860777 | debian-bookworm | Label: debian-bookworm 2026-07-05 00:39:45.860796 | debian-bookworm | Product Name: OpenStack Nova 2026-07-05 00:39:45.860815 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec0:d9b2 2026-07-05 00:39:45.882470 | 2026-07-05 00:39:45.882654 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-05 00:39:46.653827 | debian-bookworm -> localhost | changed 2026-07-05 00:39:46.662475 | 2026-07-05 00:39:46.662648 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-05 00:39:49.658519 | debian-bookworm -> localhost | changed 2026-07-05 00:39:49.677644 | 2026-07-05 00:39:49.677817 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-05 00:39:50.219003 | debian-bookworm -> localhost | ok 2026-07-05 00:39:50.226010 | 2026-07-05 00:39:50.226150 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-05 00:39:50.263834 | debian-bookworm | ok 2026-07-05 00:39:50.286366 | debian-bookworm | included: /var/lib/zuul/builds/92b685f902674d7790cea9affa2dbd8a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-05 00:39:50.312475 | 2026-07-05 00:39:50.312650 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-05 00:39:53.243284 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-05 00:39:53.243515 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/92b685f902674d7790cea9affa2dbd8a/work/92b685f902674d7790cea9affa2dbd8a_id_rsa 2026-07-05 00:39:53.243554 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/92b685f902674d7790cea9affa2dbd8a/work/92b685f902674d7790cea9affa2dbd8a_id_rsa.pub 2026-07-05 00:39:53.243580 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-05 00:39:53.243605 | debian-bookworm -> localhost | SHA256:gYCAb+4qMo8YYvRAY1ohr/9ZYJKH8CcD+xkLMAZIoQY zuul-build-sshkey 2026-07-05 00:39:53.243627 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-05 00:39:53.243658 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-05 00:39:53.243680 | debian-bookworm -> localhost | |E+o.. | 2026-07-05 00:39:53.243701 | debian-bookworm -> localhost | |*o.. . . | 2026-07-05 00:39:53.243721 | debian-bookworm -> localhost | |*Bo . . | 2026-07-05 00:39:53.243741 | debian-bookworm -> localhost | |BO+o . | 2026-07-05 00:39:53.243760 | debian-bookworm -> localhost | |==O = S | 2026-07-05 00:39:53.243783 | debian-bookworm -> localhost | |.++@ . | 2026-07-05 00:39:53.243803 | debian-bookworm -> localhost | |oo=. . | 2026-07-05 00:39:53.243823 | debian-bookworm -> localhost | |Bo.. o | 2026-07-05 00:39:53.243843 | debian-bookworm -> localhost | |*+. o | 2026-07-05 00:39:53.243863 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-05 00:39:53.243915 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.195954 2026-07-05 00:39:53.250366 | 2026-07-05 00:39:53.250469 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-05 00:39:53.269774 | debian-bookworm | ok 2026-07-05 00:39:53.283044 | debian-bookworm | included: /var/lib/zuul/builds/92b685f902674d7790cea9affa2dbd8a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-05 00:39:53.294528 | 2026-07-05 00:39:53.294640 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-05 00:39:53.323538 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:39:53.329480 | 2026-07-05 00:39:53.329576 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-05 00:39:53.911644 | debian-bookworm | changed 2026-07-05 00:39:53.922037 | 2026-07-05 00:39:53.922160 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-05 00:39:54.194421 | debian-bookworm | ok 2026-07-05 00:39:54.200541 | 2026-07-05 00:39:54.200638 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-05 00:39:54.827921 | debian-bookworm | changed 2026-07-05 00:39:54.832613 | 2026-07-05 00:39:54.832696 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-05 00:39:55.468593 | debian-bookworm | changed 2026-07-05 00:39:55.474155 | 2026-07-05 00:39:55.474263 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-05 00:39:55.498200 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:39:55.510383 | 2026-07-05 00:39:55.510515 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-05 00:39:56.124471 | debian-bookworm -> localhost | changed 2026-07-05 00:39:56.142552 | 2026-07-05 00:39:56.142675 | TASK [add-build-sshkey : Add back temp key] 2026-07-05 00:39:56.637277 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/92b685f902674d7790cea9affa2dbd8a/work/92b685f902674d7790cea9affa2dbd8a_id_rsa (zuul-build-sshkey) 2026-07-05 00:39:56.637506 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.041769 2026-07-05 00:39:56.646101 | 2026-07-05 00:39:56.646207 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-05 00:39:57.189643 | debian-bookworm | ok 2026-07-05 00:39:57.202757 | 2026-07-05 00:39:57.202915 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-05 00:39:57.255056 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:39:57.266782 | 2026-07-05 00:39:57.266940 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-05 00:39:57.828421 | debian-bookworm | ok 2026-07-05 00:39:57.851155 | 2026-07-05 00:39:57.851344 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-05 00:39:57.891952 | debian-bookworm | ok 2026-07-05 00:39:57.897719 | 2026-07-05 00:39:57.897850 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-05 00:39:58.677959 | debian-bookworm -> localhost | ok 2026-07-05 00:39:58.687393 | 2026-07-05 00:39:58.687530 | TASK [validate-host : Collect information about the host] 2026-07-05 00:40:00.480545 | debian-bookworm | ok 2026-07-05 00:40:00.504907 | 2026-07-05 00:40:00.505072 | TASK [validate-host : Sanitize hostname] 2026-07-05 00:40:00.957818 | debian-bookworm | ok 2026-07-05 00:40:00.969008 | 2026-07-05 00:40:00.969162 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-05 00:40:02.490550 | debian-bookworm -> localhost | changed 2026-07-05 00:40:02.501407 | 2026-07-05 00:40:02.501552 | TASK [validate-host : Collect information about zuul worker] 2026-07-05 00:40:03.065228 | debian-bookworm | ok 2026-07-05 00:40:03.076463 | 2026-07-05 00:40:03.076763 | TASK [validate-host : Write out all zuul information for each host] 2026-07-05 00:40:04.774871 | debian-bookworm -> localhost | changed 2026-07-05 00:40:04.789385 | 2026-07-05 00:40:04.789546 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-05 00:40:05.063969 | debian-bookworm | ok 2026-07-05 00:40:05.070679 | 2026-07-05 00:40:05.070819 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-05 00:40:06.158761 | debian-bookworm | changed: 2026-07-05 00:40:06.159007 | debian-bookworm | cd+++++++++ src/ 2026-07-05 00:40:06.159040 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-05 00:40:06.159061 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-05 00:40:06.159079 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-05 00:40:06.159098 | debian-bookworm | =7.0.3 2026-07-05 00:40:43.888448 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-05 00:40:43.929677 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-05 00:40:43.941496 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-05 00:40:44.002017 | debian-bookworm | Collecting filelock>=3.25 2026-07-05 00:40:44.013626 | debian-bookworm | Downloading filelock-3.29.5-py3-none-any.whl (45 kB) 2026-07-05 00:40:44.021574 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.1/45.1 kB 7.1 MB/s eta 0:00:00 2026-07-05 00:40:44.085589 | debian-bookworm | Collecting packaging>=26 2026-07-05 00:40:44.098623 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-05 00:40:44.114814 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 9.0 MB/s eta 0:00:00 2026-07-05 00:40:44.178459 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-05 00:40:44.191936 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-07-05 00:40:44.253729 | debian-bookworm | Collecting pluggy>=1.6 2026-07-05 00:40:44.266679 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-05 00:40:44.325147 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-05 00:40:44.338123 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-05 00:40:44.377533 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-07-05 00:40:44.390988 | debian-bookworm | Downloading python_discovery-1.4.3-py3-none-any.whl (33 kB) 2026-07-05 00:40:44.422840 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-05 00:40:44.434575 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-05 00:40:44.594571 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-05 00:40:44.606299 | debian-bookworm | Downloading virtualenv-21.5.1-py3-none-any.whl (4.6 MB) 2026-07-05 00:40:44.855150 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.6/4.6 MB 18.7 MB/s eta 0:00:00 2026-07-05 00:40:44.954295 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-05 00:40:44.965878 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-05 00:40:44.985947 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 26.6 MB/s eta 0:00:00 2026-07-05 00:40:45.096907 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-05 00:40:45.890928 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.29.5 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.3 tomli-w-1.2.0 tox-4.56.1 virtualenv-21.5.1 2026-07-05 00:40:46.270463 | debian-bookworm | ok: Runtime: 0:00:03.009416 2026-07-05 00:40:46.298385 | 2026-07-05 00:40:46.298551 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-05 00:40:46.332997 | debian-bookworm | ok 2026-07-05 00:40:46.361905 | 2026-07-05 00:40:46.362162 | TASK [ensure-tox : Output tox version] 2026-07-05 00:40:46.916477 | 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-05 00:40:46.934552 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-05 00:40:47.399502 | debian-bookworm | ok: Runtime: 0:00:00.333867 2026-07-05 00:40:47.410800 | 2026-07-05 00:40:47.411043 | TASK [ensure-tox : Make global symlink] 2026-07-05 00:40:47.436775 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:40:47.451722 | 2026-07-05 00:40:47.451864 | PLAY RECAP 2026-07-05 00:40:47.451956 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-05 00:40:47.452000 | 2026-07-05 00:40:47.619733 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-05 00:40:47.622611 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-05 00:40:48.464827 | 2026-07-05 00:40:48.465025 | PLAY [all] 2026-07-05 00:40:48.484366 | 2026-07-05 00:40:48.484534 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-05 00:40:48.987122 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-05 00:40:49.042441 | debian-bookworm | ok: Runtime: 0:00:00.027377 2026-07-05 00:40:49.056275 | 2026-07-05 00:40:49.056518 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-05 00:40:49.589809 | debian-bookworm | ok: Runtime: 0:00:00.007282 2026-07-05 00:40:49.601771 | 2026-07-05 00:40:49.602026 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-05 00:40:49.931903 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-05 00:40:49.932146 | debian-bookworm | sudo: a password is required 2026-07-05 00:40:50.147970 | debian-bookworm | ok: Runtime: 0:00:00.018899 2026-07-05 00:40:50.162131 | 2026-07-05 00:40:50.162486 | TASK [tox : Check to see if the constraints file exists] 2026-07-05 00:40:50.199479 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:40:50.207678 | 2026-07-05 00:40:50.207850 | TASK [tox : Fail if constraints file is missing] 2026-07-05 00:40:50.278103 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:40:50.291708 | 2026-07-05 00:40:50.291898 | TASK [tox : Record file location] 2026-07-05 00:40:50.344014 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:40:50.360189 | 2026-07-05 00:40:50.361259 | TASK [tox : Install tox siblings] 2026-07-05 00:40:50.417798 | debian-bookworm | ok 2026-07-05 00:40:50.440628 | debian-bookworm | included: /var/lib/zuul/builds/92b685f902674d7790cea9affa2dbd8a/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-05 00:40:50.457477 | 2026-07-05 00:40:50.458037 | TASK [tox : Run tox without tests] 2026-07-05 00:40:51.798106 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-05 00:41:04.776798 | debian-bookworm | test: OK (13.73 seconds) 2026-07-05 00:41:04.776851 | debian-bookworm | congratulations :) (13.76 seconds) 2026-07-05 00:41:05.018382 | debian-bookworm | ok: Runtime: 0:00:14.058616 2026-07-05 00:41:05.025878 | 2026-07-05 00:41:05.026017 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-05 00:41:05.515523 | debian-bookworm | changed 2026-07-05 00:41:05.525611 | 2026-07-05 00:41:05.525900 | TASK [tox : Detect tox version] 2026-07-05 00:41:06.111712 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-05 00:41:06.571999 | debian-bookworm | ok: Runtime: 0:00:00.314339 2026-07-05 00:41:06.586221 | 2026-07-05 00:41:06.586539 | TASK [tox : Get tox envlist config] 2026-07-05 00:41:07.624696 | debian-bookworm | ok: Runtime: 0:00:00.349749 2026-07-05 00:41:07.638871 | 2026-07-05 00:41:07.639089 | TASK [tox : Install any sibling python packages] 2026-07-05 00:41:08.141563 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-05 00:41:08.148296 | 2026-07-05 00:41:08.148435 | TASK [tox : Remove tempfile] 2026-07-05 00:41:08.683758 | debian-bookworm | changed 2026-07-05 00:41:08.698676 | 2026-07-05 00:41:08.698816 | TASK [tox : Emit tox command] 2026-07-05 00:41:08.739550 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-05 00:41:08.744752 | 2026-07-05 00:41:08.744870 | TASK [tox : Run tox] 2026-07-05 00:41:09.359924 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-05 00:41:10.202968 | debian-bookworm | .......................... 2026-07-05 00:41:10.203020 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-05 00:41:10.203032 | debian-bookworm | Ran 26 tests in 0.239s 2026-07-05 00:41:10.203037 | debian-bookworm | 2026-07-05 00:41:10.203043 | debian-bookworm | OK 2026-07-05 00:41:10.304607 | debian-bookworm | test: OK (0.99=setup[0.05]+cmd[0.94] seconds) 2026-07-05 00:41:10.304671 | debian-bookworm | congratulations :) (1.02 seconds) 2026-07-05 00:41:10.778732 | debian-bookworm | ok: Runtime: 0:00:01.312261 2026-07-05 00:41:10.791829 | 2026-07-05 00:41:10.791983 | TASK [tox : Look for output] 2026-07-05 00:41:11.198312 | debian-bookworm | ok 2026-07-05 00:41:11.221362 | 2026-07-05 00:41:11.221556 | TASK [tox : Return file comments to Zuul] 2026-07-05 00:41:11.258988 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:11.270819 | 2026-07-05 00:41:11.270990 | PLAY RECAP 2026-07-05 00:41:11.271069 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-05 00:41:11.271103 | 2026-07-05 00:41:11.457281 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-05 00:41:11.458640 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-05 00:41:12.289398 | 2026-07-05 00:41:12.289589 | PLAY [all] 2026-07-05 00:41:12.306879 | 2026-07-05 00:41:12.307062 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-05 00:41:12.363145 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:12.369425 | 2026-07-05 00:41:12.369594 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-05 00:41:12.424205 | debian-bookworm | ok 2026-07-05 00:41:12.431315 | 2026-07-05 00:41:12.431486 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-05 00:41:12.935223 | debian-bookworm -> localhost | changed 2026-07-05 00:41:12.946455 | 2026-07-05 00:41:12.946600 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-05 00:41:12.993273 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:13.003636 | 2026-07-05 00:41:13.003813 | TASK [fetch-tox-output : Set envlist fact] 2026-07-05 00:41:13.051274 | debian-bookworm | ok 2026-07-05 00:41:13.060948 | 2026-07-05 00:41:13.061089 | TASK [fetch-tox-output : Get tox version] 2026-07-05 00:41:13.804643 | 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-05 00:41:13.822254 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-05 00:41:14.094653 | debian-bookworm | ok: Runtime: 0:00:00.321329 2026-07-05 00:41:14.101388 | 2026-07-05 00:41:14.101532 | TASK [fetch-tox-output : Find all default environments] 2026-07-05 00:41:14.633200 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:14.644283 | 2026-07-05 00:41:14.644501 | TASK [fetch-tox-output : Set envlist fact] 2026-07-05 00:41:14.691655 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:14.702623 | 2026-07-05 00:41:14.702956 | TASK [fetch-tox-output : Find all default environments] 2026-07-05 00:41:15.237447 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:15.248976 | 2026-07-05 00:41:15.249217 | TASK [fetch-tox-output : Set envlist fact] 2026-07-05 00:41:15.274607 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:15.284571 | 2026-07-05 00:41:15.284741 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-05 00:41:15.333070 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:15.358360 | 2026-07-05 00:41:15.358671 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-05 00:41:16.264096 | debian-bookworm | changed: 2026-07-05 00:41:16.264388 | debian-bookworm | created directory /var/lib/zuul/builds/92b685f902674d7790cea9affa2dbd8a/work/logs/tox/test 2026-07-05 00:41:16.264447 | debian-bookworm | cd+++++++++ ./ 2026-07-05 00:41:16.264491 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-05 00:41:16.264542 | 2026-07-05 00:41:16.281694 | 2026-07-05 00:41:16.281862 | PLAY RECAP 2026-07-05 00:41:16.281953 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-05 00:41:16.281994 | 2026-07-05 00:41:16.451742 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-05 00:41:16.452947 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-05 00:41:17.304723 | 2026-07-05 00:41:17.304920 | PLAY [all] 2026-07-05 00:41:17.322144 | 2026-07-05 00:41:17.322333 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-05 00:41:17.547575 | debian-bookworm | changed: non-zero return code 2026-07-05 00:41:17.554796 | 2026-07-05 00:41:17.555001 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-05 00:41:17.581198 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:17.588579 | 2026-07-05 00:41:17.588730 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-05 00:41:17.625198 | 2026-07-05 00:41:17.625527 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-05 00:41:17.670535 | 2026-07-05 00:41:17.670764 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-05 00:41:17.695532 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:17.702666 | 2026-07-05 00:41:17.702823 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-05 00:41:17.743445 | 2026-07-05 00:41:17.743681 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-05 00:41:17.767826 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:17.774743 | 2026-07-05 00:41:17.774916 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-05 00:41:17.808969 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:17.829494 | 2026-07-05 00:41:17.829655 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-05 00:41:17.854003 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:17.861428 | 2026-07-05 00:41:17.861537 | PLAY RECAP 2026-07-05 00:41:17.861598 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-05 00:41:17.861625 | 2026-07-05 00:41:18.021519 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-05 00:41:18.024570 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-05 00:41:18.851208 | 2026-07-05 00:41:18.851416 | PLAY [Base post-fetch] 2026-07-05 00:41:18.866398 | 2026-07-05 00:41:18.866553 | TASK [diagnose-network : Ensure log directory exists] 2026-07-05 00:41:19.304934 | debian-bookworm | ok 2026-07-05 00:41:19.319200 | 2026-07-05 00:41:19.319478 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-05 00:41:31.211571 | debian-bookworm | ok: Runtime: 0:00:05.903172 2026-07-05 00:41:31.223950 | 2026-07-05 00:41:31.224165 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-05 00:41:37.271710 | debian-bookworm | ok: Runtime: 0:00:00.005927 2026-07-05 00:41:37.279442 | 2026-07-05 00:41:37.279592 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-05 00:41:43.340972 | debian-bookworm | ok: Runtime: 0:00:00.004737 2026-07-05 00:41:43.358985 | 2026-07-05 00:41:43.359161 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-05 00:41:43.425656 | debian-bookworm | skipping: Conditional result was False 2026-07-05 00:41:43.438916 | 2026-07-05 00:41:43.439130 | TASK [fetch-output : Set log path for single node] 2026-07-05 00:41:43.490802 | debian-bookworm | ok 2026-07-05 00:41:43.498018 | 2026-07-05 00:41:43.498161 | LOOP [fetch-output : Ensure local output dirs] 2026-07-05 00:41:43.802356 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/92b685f902674d7790cea9affa2dbd8a/work/logs" 2026-07-05 00:41:44.098527 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/92b685f902674d7790cea9affa2dbd8a/work/artifacts" 2026-07-05 00:41:44.451301 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/92b685f902674d7790cea9affa2dbd8a/work/docs" 2026-07-05 00:41:44.481552 | 2026-07-05 00:41:44.481796 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-05 00:41:45.307882 | debian-bookworm | changed: 2026-07-05 00:41:45.308186 | debian-bookworm | .d..t...... ./ 2026-07-05 00:41:45.308242 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-05 00:41:45.308331 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-05 00:41:45.308368 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-05 00:41:45.308403 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-05 00:41:45.308436 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-05 00:41:45.308495 | debian-bookworm | changed: All items complete 2026-07-05 00:41:45.308531 | 2026-07-05 00:41:45.921178 | debian-bookworm | changed: .d..t...... ./ 2026-07-05 00:41:46.506656 | debian-bookworm | changed: .d..t...... ./ 2026-07-05 00:41:46.536417 | 2026-07-05 00:41:46.536608 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-05 00:41:46.890266 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011507 2026-07-05 00:41:47.188570 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009914 2026-07-05 00:41:47.210363 | 2026-07-05 00:41:47.210493 | PLAY RECAP 2026-07-05 00:41:47.210565 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-05 00:41:47.210602 | 2026-07-05 00:41:47.381099 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-05 00:41:47.382810 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-05 00:41:48.197442 | 2026-07-05 00:41:48.197647 | PLAY [Base post] 2026-07-05 00:41:48.212311 | 2026-07-05 00:41:48.212460 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-05 00:41:48.829223 | debian-bookworm | changed 2026-07-05 00:41:48.839471 | 2026-07-05 00:41:48.839633 | PLAY RECAP 2026-07-05 00:41:48.839722 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-05 00:41:48.839798 | 2026-07-05 00:41:48.999912 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-05 00:41:49.001130 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-05 00:41:49.848893 | 2026-07-05 00:41:49.849094 | PLAY [Base post-logs] 2026-07-05 00:41:49.861122 | 2026-07-05 00:41:49.861319 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-05 00:41:50.377479 | localhost | changed 2026-07-05 00:41:50.388331 | 2026-07-05 00:41:50.388509 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-05 00:41:50.437301 | localhost | ok 2026-07-05 00:41:50.443278 | 2026-07-05 00:41:50.443455 | TASK [Set zuul-log-path fact] 2026-07-05 00:41:50.472413 | localhost | ok 2026-07-05 00:41:50.482457 | 2026-07-05 00:41:50.482575 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-05 00:41:50.519351 | localhost | ok 2026-07-05 00:41:50.523989 | 2026-07-05 00:41:50.524120 | TASK [upload-logs : Create log directories] 2026-07-05 00:41:51.168828 | localhost | changed 2026-07-05 00:41:51.173644 | 2026-07-05 00:41:51.173814 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-05 00:41:51.794151 | localhost -> localhost | ok: Runtime: 0:00:00.006471 2026-07-05 00:41:51.802496 | 2026-07-05 00:41:51.802783 | TASK [upload-logs : Upload logs to log server] 2026-07-05 00:41:52.445922 | localhost | Output suppressed because no_log was given 2026-07-05 00:41:52.450233 | 2026-07-05 00:41:52.450502 | LOOP [upload-logs : Compress console log and json output] 2026-07-05 00:41:52.518082 | localhost | skipping: Conditional result was False 2026-07-05 00:41:52.523726 | localhost | skipping: Conditional result was False 2026-07-05 00:41:52.535756 | 2026-07-05 00:41:52.536037 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-05 00:41:52.590027 | localhost | skipping: Conditional result was False 2026-07-05 00:41:52.590969 | 2026-07-05 00:41:52.594097 | localhost | skipping: Conditional result was False 2026-07-05 00:41:52.603044 | 2026-07-05 00:41:52.603527 | LOOP [upload-logs : Upload console log and json output]