2026-05-27 15:37:02.627579 | Job console starting 2026-05-27 15:37:02.656850 | Updating git repos 2026-05-27 15:37:02.720080 | Cloning repos into workspace 2026-05-27 15:37:02.791080 | Restoring repo states 2026-05-27 15:37:02.802183 | Merging changes 2026-05-27 15:37:03.337876 | Checking out repos 2026-05-27 15:37:03.397789 | Preparing playbooks 2026-05-27 15:37:04.569316 | Running Ansible setup 2026-05-27 15:37:11.228039 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-27 15:37:12.808883 | 2026-05-27 15:37:12.809084 | PLAY [Base pre] 2026-05-27 15:37:12.842322 | 2026-05-27 15:37:12.842491 | TASK [Setup log path fact] 2026-05-27 15:37:12.880091 | debian-bookworm | ok 2026-05-27 15:37:12.908449 | 2026-05-27 15:37:12.908613 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-27 15:37:12.937496 | debian-bookworm | ok 2026-05-27 15:37:12.948041 | 2026-05-27 15:37:12.948170 | TASK [emit-job-header : Print job information] 2026-05-27 15:37:12.988237 | # Job Information 2026-05-27 15:37:12.988430 | Ansible Version: 2.16.14 2026-05-27 15:37:12.988467 | Job: tox 2026-05-27 15:37:12.988499 | Pipeline: check 2026-05-27 15:37:12.988523 | Executor: 521e9411259a 2026-05-27 15:37:12.988544 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1221 2026-05-27 15:37:12.988566 | Event ID: e19d92b0-59e1-11f1-91a8-d58e0cd67ae1 2026-05-27 15:37:12.993869 | 2026-05-27 15:37:12.994007 | LOOP [emit-job-header : Print node information] 2026-05-27 15:37:13.209684 | debian-bookworm | ok: 2026-05-27 15:37:13.209976 | debian-bookworm | # Node Information 2026-05-27 15:37:13.210021 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-27 15:37:13.210047 | debian-bookworm | Hostname: debian 2026-05-27 15:37:13.210069 | debian-bookworm | Username: zuul 2026-05-27 15:37:13.210089 | debian-bookworm | Distro: Debian 12.14 2026-05-27 15:37:13.210112 | debian-bookworm | Provider: regiocloud-a 2026-05-27 15:37:13.210132 | debian-bookworm | Region: 2026-05-27 15:37:13.210153 | debian-bookworm | Label: debian-bookworm 2026-05-27 15:37:13.210172 | debian-bookworm | Product Name: OpenStack Nova 2026-05-27 15:37:13.210191 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0d:2c1a 2026-05-27 15:37:13.233247 | 2026-05-27 15:37:13.233398 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-27 15:37:13.925124 | debian-bookworm -> localhost | changed 2026-05-27 15:37:13.932021 | 2026-05-27 15:37:13.932126 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-27 15:37:15.159847 | debian-bookworm -> localhost | changed 2026-05-27 15:37:15.168701 | 2026-05-27 15:37:15.168801 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-27 15:37:15.752444 | debian-bookworm -> localhost | ok 2026-05-27 15:37:15.757735 | 2026-05-27 15:37:15.757820 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-27 15:37:15.869334 | debian-bookworm | ok 2026-05-27 15:37:15.909023 | debian-bookworm | included: /var/lib/zuul/builds/0cee2a129afe4e1c872d5c6bf49b6be9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-27 15:37:15.914064 | 2026-05-27 15:37:15.914140 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-27 15:37:19.546973 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-27 15:37:19.547170 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0cee2a129afe4e1c872d5c6bf49b6be9/work/0cee2a129afe4e1c872d5c6bf49b6be9_id_rsa 2026-05-27 15:37:19.547205 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0cee2a129afe4e1c872d5c6bf49b6be9/work/0cee2a129afe4e1c872d5c6bf49b6be9_id_rsa.pub 2026-05-27 15:37:19.547231 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-27 15:37:19.547253 | debian-bookworm -> localhost | SHA256:PkpQHCSWl/7Eb05g1mBmpkc2sY8H8WWGnnjDWXtCbLQ zuul-build-sshkey 2026-05-27 15:37:19.547275 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-27 15:37:19.547305 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-27 15:37:19.547326 | debian-bookworm -> localhost | | ooo.o. += | 2026-05-27 15:37:19.547348 | debian-bookworm -> localhost | | ..oo.X+.+=. | 2026-05-27 15:37:19.547368 | debian-bookworm -> localhost | | ooXoB.*E. | 2026-05-27 15:37:19.547387 | debian-bookworm -> localhost | | .o O+O o . | 2026-05-27 15:37:19.547406 | debian-bookworm -> localhost | | . *S+o. o | 2026-05-27 15:37:19.547431 | debian-bookworm -> localhost | | . ...+ | 2026-05-27 15:37:19.547451 | debian-bookworm -> localhost | | . o+ | 2026-05-27 15:37:19.547470 | debian-bookworm -> localhost | | . . .. | 2026-05-27 15:37:19.547490 | debian-bookworm -> localhost | | . | 2026-05-27 15:37:19.547510 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-27 15:37:19.547557 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.463470 2026-05-27 15:37:19.553677 | 2026-05-27 15:37:19.553768 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-27 15:37:19.581114 | debian-bookworm | ok 2026-05-27 15:37:19.592038 | debian-bookworm | included: /var/lib/zuul/builds/0cee2a129afe4e1c872d5c6bf49b6be9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-27 15:37:19.606541 | 2026-05-27 15:37:19.606647 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-27 15:37:19.630078 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:37:19.647482 | 2026-05-27 15:37:19.647649 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-27 15:37:20.312744 | debian-bookworm | changed 2026-05-27 15:37:20.317342 | 2026-05-27 15:37:20.317487 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-27 15:37:20.570997 | debian-bookworm | ok 2026-05-27 15:37:20.575621 | 2026-05-27 15:37:20.575710 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-27 15:37:21.341892 | debian-bookworm | changed 2026-05-27 15:37:21.349455 | 2026-05-27 15:37:21.349556 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-27 15:37:22.113498 | debian-bookworm | changed 2026-05-27 15:37:22.118157 | 2026-05-27 15:37:22.118239 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-27 15:37:22.141665 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:37:22.146621 | 2026-05-27 15:37:22.146702 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-27 15:37:23.286149 | debian-bookworm -> localhost | changed 2026-05-27 15:37:23.295167 | 2026-05-27 15:37:23.295266 | TASK [add-build-sshkey : Add back temp key] 2026-05-27 15:37:23.807174 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0cee2a129afe4e1c872d5c6bf49b6be9/work/0cee2a129afe4e1c872d5c6bf49b6be9_id_rsa (zuul-build-sshkey) 2026-05-27 15:37:23.807351 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022910 2026-05-27 15:37:23.814592 | 2026-05-27 15:37:23.814778 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-27 15:37:24.237596 | debian-bookworm | ok 2026-05-27 15:37:24.242165 | 2026-05-27 15:37:24.242259 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-27 15:37:24.277261 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:37:24.286811 | 2026-05-27 15:37:24.288606 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-27 15:37:25.103149 | debian-bookworm | ok 2026-05-27 15:37:25.122308 | 2026-05-27 15:37:25.122418 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-27 15:37:25.189735 | debian-bookworm | ok 2026-05-27 15:37:25.193829 | 2026-05-27 15:37:25.193928 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-27 15:37:25.878054 | debian-bookworm -> localhost | ok 2026-05-27 15:37:25.883207 | 2026-05-27 15:37:25.883293 | TASK [validate-host : Collect information about the host] 2026-05-27 15:37:27.301928 | debian-bookworm | ok 2026-05-27 15:37:27.322465 | 2026-05-27 15:37:27.322562 | TASK [validate-host : Sanitize hostname] 2026-05-27 15:37:27.604617 | debian-bookworm | ok 2026-05-27 15:37:27.694314 | 2026-05-27 15:37:27.694420 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-27 15:37:28.907452 | debian-bookworm -> localhost | changed 2026-05-27 15:37:28.918471 | 2026-05-27 15:37:28.918577 | TASK [validate-host : Collect information about zuul worker] 2026-05-27 15:37:29.533371 | debian-bookworm | ok 2026-05-27 15:37:29.538139 | 2026-05-27 15:37:29.538218 | TASK [validate-host : Write out all zuul information for each host] 2026-05-27 15:37:30.620643 | debian-bookworm -> localhost | changed 2026-05-27 15:37:30.628880 | 2026-05-27 15:37:30.628973 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-27 15:37:30.942591 | debian-bookworm | ok 2026-05-27 15:37:30.947059 | 2026-05-27 15:37:30.947140 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-27 15:37:32.023492 | debian-bookworm | changed: 2026-05-27 15:37:32.023651 | debian-bookworm | cd+++++++++ src/ 2026-05-27 15:37:32.023679 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-27 15:37:32.023700 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-27 15:37:32.023718 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-27 15:37:32.023735 | debian-bookworm | =7.0.3 2026-05-27 15:37:58.366438 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-05-27 15:37:58.421191 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-27 15:37:58.433082 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-27 15:37:58.502630 | debian-bookworm | Collecting filelock>=3.25 2026-05-27 15:37:58.514933 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-27 15:37:58.565942 | debian-bookworm | Collecting packaging>=26 2026-05-27 15:37:58.577251 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-27 15:37:58.587984 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 11.6 MB/s eta 0:00:00 2026-05-27 15:37:58.637268 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-27 15:37:58.649372 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-05-27 15:37:58.689504 | debian-bookworm | Collecting pluggy>=1.6 2026-05-27 15:37:58.701492 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-27 15:37:58.741948 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-27 15:37:58.754353 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-27 15:37:58.790577 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-27 15:37:58.802205 | debian-bookworm | Downloading python_discovery-1.3.1-py3-none-any.whl (33 kB) 2026-05-27 15:37:58.834679 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-27 15:37:58.845818 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-27 15:37:58.986230 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-27 15:37:59.000150 | debian-bookworm | Downloading virtualenv-21.3.3-py3-none-any.whl (7.6 MB) 2026-05-27 15:37:59.331959 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 23.1 MB/s eta 0:00:00 2026-05-27 15:37:59.436320 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-27 15:37:59.449034 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-27 15:37:59.470165 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 25.8 MB/s eta 0:00:00 2026-05-27 15:37:59.582951 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-27 15:38:00.350884 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.0 filelock-3.29.0 packaging-26.2 platformdirs-4.9.6 pluggy-1.6.0 pyproject-api-1.10.0 python-discovery-1.3.1 tomli-w-1.2.0 tox-4.54.0 virtualenv-21.3.3 2026-05-27 15:38:00.745826 | debian-bookworm | ok: Runtime: 0:00:02.983148 2026-05-27 15:38:00.752020 | 2026-05-27 15:38:00.752118 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-27 15:38:00.821827 | debian-bookworm | ok 2026-05-27 15:38:00.826816 | 2026-05-27 15:38:00.830643 | TASK [ensure-tox : Output tox version] 2026-05-27 15:38:01.435679 | 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-05-27 15:38:01.453213 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-27 15:38:01.894093 | debian-bookworm | ok: Runtime: 0:00:00.317229 2026-05-27 15:38:01.901183 | 2026-05-27 15:38:01.901272 | TASK [ensure-tox : Make global symlink] 2026-05-27 15:38:01.934679 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:01.943485 | 2026-05-27 15:38:01.943625 | PLAY RECAP 2026-05-27 15:38:01.943692 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-27 15:38:01.943722 | 2026-05-27 15:38:02.109785 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-27 15:38:02.110589 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-27 15:38:03.544422 | 2026-05-27 15:38:03.544541 | PLAY [all] 2026-05-27 15:38:03.579972 | 2026-05-27 15:38:03.580157 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-27 15:38:04.039322 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-27 15:38:04.135737 | debian-bookworm | ok: Runtime: 0:00:00.030796 2026-05-27 15:38:04.140211 | 2026-05-27 15:38:04.140304 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-27 15:38:04.687283 | debian-bookworm | ok: Runtime: 0:00:00.007895 2026-05-27 15:38:04.692936 | 2026-05-27 15:38:04.693036 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-27 15:38:04.980207 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-27 15:38:04.983221 | debian-bookworm | sudo: a password is required 2026-05-27 15:38:05.223337 | debian-bookworm | ok: Runtime: 0:00:00.025189 2026-05-27 15:38:05.236125 | 2026-05-27 15:38:05.236227 | TASK [tox : Check to see if the constraints file exists] 2026-05-27 15:38:05.309948 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:05.317048 | 2026-05-27 15:38:05.317159 | TASK [tox : Fail if constraints file is missing] 2026-05-27 15:38:05.381585 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:05.395545 | 2026-05-27 15:38:05.395877 | TASK [tox : Record file location] 2026-05-27 15:38:05.440853 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:05.449788 | 2026-05-27 15:38:05.449981 | TASK [tox : Install tox siblings] 2026-05-27 15:38:05.512510 | debian-bookworm | ok 2026-05-27 15:38:05.552808 | debian-bookworm | included: /var/lib/zuul/builds/0cee2a129afe4e1c872d5c6bf49b6be9/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-27 15:38:05.591232 | 2026-05-27 15:38:05.591359 | TASK [tox : Run tox without tests] 2026-05-27 15:38:07.171424 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-05-27 15:38:19.921270 | debian-bookworm | test: OK (13.49 seconds) 2026-05-27 15:38:19.921316 | debian-bookworm | congratulations :) (13.52 seconds) 2026-05-27 15:38:20.200000 | debian-bookworm | ok: Runtime: 0:00:13.831594 2026-05-27 15:38:20.205486 | 2026-05-27 15:38:20.205583 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-27 15:38:20.617151 | debian-bookworm | changed 2026-05-27 15:38:20.622559 | 2026-05-27 15:38:20.622655 | TASK [tox : Detect tox version] 2026-05-27 15:38:21.140539 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-27 15:38:21.660262 | debian-bookworm | ok: Runtime: 0:00:00.267248 2026-05-27 15:38:21.666860 | 2026-05-27 15:38:21.667003 | TASK [tox : Get tox envlist config] 2026-05-27 15:38:22.710247 | debian-bookworm | ok: Runtime: 0:00:00.313918 2026-05-27 15:38:22.716449 | 2026-05-27 15:38:22.716548 | TASK [tox : Install any sibling python packages] 2026-05-27 15:38:23.130341 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-27 15:38:23.136545 | 2026-05-27 15:38:23.136651 | TASK [tox : Remove tempfile] 2026-05-27 15:38:23.646117 | debian-bookworm | changed 2026-05-27 15:38:23.652106 | 2026-05-27 15:38:23.652217 | TASK [tox : Emit tox command] 2026-05-27 15:38:23.691745 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-05-27 15:38:23.696899 | 2026-05-27 15:38:23.697171 | TASK [tox : Run tox] 2026-05-27 15:38:24.350651 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-05-27 15:38:25.073678 | debian-bookworm | ............... 2026-05-27 15:38:25.073781 | debian-bookworm | ---------------------------------------------------------------------- 2026-05-27 15:38:25.073796 | debian-bookworm | Ran 15 tests in 0.172s 2026-05-27 15:38:25.073801 | debian-bookworm | 2026-05-27 15:38:25.073808 | debian-bookworm | OK 2026-05-27 15:38:25.179362 | debian-bookworm | test: OK (0.88=setup[0.05]+cmd[0.83] seconds) 2026-05-27 15:38:25.179448 | debian-bookworm | congratulations :) (0.91 seconds) 2026-05-27 15:38:25.741159 | debian-bookworm | ok: Runtime: 0:00:01.231382 2026-05-27 15:38:25.754323 | 2026-05-27 15:38:25.754490 | TASK [tox : Look for output] 2026-05-27 15:38:26.160413 | debian-bookworm | ok 2026-05-27 15:38:26.180491 | 2026-05-27 15:38:26.180683 | TASK [tox : Return file comments to Zuul] 2026-05-27 15:38:26.216361 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:26.223467 | 2026-05-27 15:38:26.223581 | PLAY RECAP 2026-05-27 15:38:26.223638 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-27 15:38:26.223684 | 2026-05-27 15:38:26.390919 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-27 15:38:26.392276 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-27 15:38:27.324927 | 2026-05-27 15:38:27.325105 | PLAY [all] 2026-05-27 15:38:27.344385 | 2026-05-27 15:38:27.344547 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-27 15:38:27.411196 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:27.423469 | 2026-05-27 15:38:27.423742 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-27 15:38:27.465139 | debian-bookworm | ok 2026-05-27 15:38:27.470824 | 2026-05-27 15:38:27.470988 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-27 15:38:28.020183 | debian-bookworm -> localhost | changed 2026-05-27 15:38:28.028344 | 2026-05-27 15:38:28.028457 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-27 15:38:28.085990 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:28.096906 | 2026-05-27 15:38:28.097080 | TASK [fetch-tox-output : Set envlist fact] 2026-05-27 15:38:28.140588 | debian-bookworm | ok 2026-05-27 15:38:28.148096 | 2026-05-27 15:38:28.148223 | TASK [fetch-tox-output : Get tox version] 2026-05-27 15:38:28.912082 | 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-05-27 15:38:28.930086 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-27 15:38:29.180853 | debian-bookworm | ok: Runtime: 0:00:00.342218 2026-05-27 15:38:29.197557 | 2026-05-27 15:38:29.197832 | TASK [fetch-tox-output : Find all default environments] 2026-05-27 15:38:29.739650 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:29.747450 | 2026-05-27 15:38:29.747600 | TASK [fetch-tox-output : Set envlist fact] 2026-05-27 15:38:29.782568 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:29.798772 | 2026-05-27 15:38:29.799172 | TASK [fetch-tox-output : Find all default environments] 2026-05-27 15:38:30.339386 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:30.346827 | 2026-05-27 15:38:30.347167 | TASK [fetch-tox-output : Set envlist fact] 2026-05-27 15:38:30.396159 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:30.403488 | 2026-05-27 15:38:30.403662 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-27 15:38:30.497973 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:30.516266 | 2026-05-27 15:38:30.516416 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-27 15:38:31.404068 | debian-bookworm | changed: 2026-05-27 15:38:31.404293 | debian-bookworm | created directory /var/lib/zuul/builds/0cee2a129afe4e1c872d5c6bf49b6be9/work/logs/tox/test 2026-05-27 15:38:31.404327 | debian-bookworm | cd+++++++++ ./ 2026-05-27 15:38:31.404352 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-27 15:38:31.404383 | 2026-05-27 15:38:31.427280 | 2026-05-27 15:38:31.427443 | PLAY RECAP 2026-05-27 15:38:31.427531 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-27 15:38:31.427574 | 2026-05-27 15:38:31.581316 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-27 15:38:31.582391 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-27 15:38:32.502206 | 2026-05-27 15:38:32.502386 | PLAY [all] 2026-05-27 15:38:32.527177 | 2026-05-27 15:38:32.527342 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-27 15:38:32.759930 | debian-bookworm | changed: non-zero return code 2026-05-27 15:38:32.765783 | 2026-05-27 15:38:32.765916 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-27 15:38:32.790206 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:32.797486 | 2026-05-27 15:38:32.797676 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-27 15:38:32.855175 | 2026-05-27 15:38:32.855403 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-27 15:38:32.917425 | 2026-05-27 15:38:32.917672 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-27 15:38:32.941787 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:32.948228 | 2026-05-27 15:38:32.948362 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-27 15:38:32.998429 | 2026-05-27 15:38:32.998665 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-27 15:38:33.033092 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:33.039373 | 2026-05-27 15:38:33.039508 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-27 15:38:33.054070 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:33.060602 | 2026-05-27 15:38:33.060747 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-27 15:38:33.088780 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:33.098589 | 2026-05-27 15:38:33.098727 | PLAY RECAP 2026-05-27 15:38:33.098786 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-27 15:38:33.098811 | 2026-05-27 15:38:33.251488 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-27 15:38:33.252661 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-27 15:38:34.112002 | 2026-05-27 15:38:34.112175 | PLAY [Base post-fetch] 2026-05-27 15:38:34.129255 | 2026-05-27 15:38:34.129420 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-27 15:38:34.215793 | debian-bookworm | skipping: Conditional result was False 2026-05-27 15:38:34.223661 | 2026-05-27 15:38:34.223819 | TASK [fetch-output : Set log path for single node] 2026-05-27 15:38:34.266315 | debian-bookworm | ok 2026-05-27 15:38:34.275967 | 2026-05-27 15:38:34.276112 | LOOP [fetch-output : Ensure local output dirs] 2026-05-27 15:38:34.913777 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/0cee2a129afe4e1c872d5c6bf49b6be9/work/logs" 2026-05-27 15:38:35.251379 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0cee2a129afe4e1c872d5c6bf49b6be9/work/artifacts" 2026-05-27 15:38:35.552234 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0cee2a129afe4e1c872d5c6bf49b6be9/work/docs" 2026-05-27 15:38:35.566070 | 2026-05-27 15:38:35.566202 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-27 15:38:36.481690 | debian-bookworm | changed: 2026-05-27 15:38:36.481920 | debian-bookworm | .d..t...... ./ 2026-05-27 15:38:36.481954 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-27 15:38:36.481984 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-27 15:38:36.482010 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-27 15:38:36.482121 | debian-bookworm | changed: All items complete 2026-05-27 15:38:36.482152 | 2026-05-27 15:38:37.265536 | debian-bookworm | changed: .d..t...... ./ 2026-05-27 15:38:37.941693 | debian-bookworm | changed: .d..t...... ./ 2026-05-27 15:38:37.955055 | 2026-05-27 15:38:37.955190 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-27 15:38:38.616545 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.012074 2026-05-27 15:38:38.975988 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.006155 2026-05-27 15:38:38.988648 | 2026-05-27 15:38:38.988811 | PLAY RECAP 2026-05-27 15:38:38.988866 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-27 15:38:38.988891 | 2026-05-27 15:38:39.288251 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-27 15:38:39.289548 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-27 15:38:40.234231 | 2026-05-27 15:38:40.234414 | PLAY [Base post] 2026-05-27 15:38:40.258261 | 2026-05-27 15:38:40.258440 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-27 15:38:40.920369 | debian-bookworm | changed 2026-05-27 15:38:40.926971 | 2026-05-27 15:38:40.927084 | PLAY RECAP 2026-05-27 15:38:40.927150 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-27 15:38:40.927212 | 2026-05-27 15:38:41.083711 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-27 15:38:41.084783 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-27 15:38:42.046470 | 2026-05-27 15:38:42.046688 | PLAY [Base post-logs] 2026-05-27 15:38:42.062484 | 2026-05-27 15:38:42.062701 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-27 15:38:42.589164 | localhost | changed 2026-05-27 15:38:42.622774 | 2026-05-27 15:38:42.623664 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-27 15:38:42.684527 | localhost | ok 2026-05-27 15:38:42.693896 | 2026-05-27 15:38:42.694034 | TASK [Set zuul-log-path fact] 2026-05-27 15:38:42.736154 | localhost | ok 2026-05-27 15:38:42.747735 | 2026-05-27 15:38:42.747872 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-27 15:38:42.800049 | localhost | ok 2026-05-27 15:38:42.804007 | 2026-05-27 15:38:42.804122 | TASK [upload-logs : Create log directories] 2026-05-27 15:38:43.528734 | localhost | changed 2026-05-27 15:38:43.531792 | 2026-05-27 15:38:43.531901 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-27 15:38:44.125446 | localhost -> localhost | ok: Runtime: 0:00:00.006396 2026-05-27 15:38:44.129669 | 2026-05-27 15:38:44.129795 | TASK [upload-logs : Upload logs to log server] 2026-05-27 15:38:44.688952 | localhost | Output suppressed because no_log was given 2026-05-27 15:38:44.693782 | 2026-05-27 15:38:44.693943 | LOOP [upload-logs : Compress console log and json output] 2026-05-27 15:38:44.783096 | localhost | skipping: Conditional result was False 2026-05-27 15:38:44.786877 | localhost | skipping: Conditional result was False 2026-05-27 15:38:44.799940 | 2026-05-27 15:38:44.800120 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-27 15:38:44.846414 | localhost | skipping: Conditional result was False 2026-05-27 15:38:44.846781 | 2026-05-27 15:38:44.851315 | localhost | skipping: Conditional result was False 2026-05-27 15:38:44.860385 | 2026-05-27 15:38:44.860543 | LOOP [upload-logs : Upload console log and json output]