2025-12-14 00:21:18.631076 | Job console starting 2025-12-14 00:21:18.657813 | Updating git repos 2025-12-14 00:21:18.707144 | Cloning repos into workspace 2025-12-14 00:21:18.840326 | Restoring repo states 2025-12-14 00:21:18.871267 | Merging changes 2025-12-14 00:21:19.665011 | Checking out repos 2025-12-14 00:21:19.760577 | Preparing playbooks 2025-12-14 00:21:21.619950 | Running Ansible setup 2025-12-14 00:21:31.170793 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-14 00:21:33.746351 | 2025-12-14 00:21:33.746533 | PLAY [Base pre] 2025-12-14 00:21:33.832720 | 2025-12-14 00:21:33.832946 | TASK [Setup log path fact] 2025-12-14 00:21:33.881219 | debian-bookworm | ok 2025-12-14 00:21:33.936419 | 2025-12-14 00:21:33.936642 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-14 00:21:34.045431 | debian-bookworm | ok 2025-12-14 00:21:34.098520 | 2025-12-14 00:21:34.098682 | TASK [emit-job-header : Print job information] 2025-12-14 00:21:34.280878 | # Job Information 2025-12-14 00:21:34.281345 | Ansible Version: 2.16.14 2025-12-14 00:21:34.281400 | Job: tox 2025-12-14 00:21:34.281440 | Pipeline: check 2025-12-14 00:21:34.281468 | Executor: 521e9411259a 2025-12-14 00:21:34.281490 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1036 2025-12-14 00:21:34.281526 | Event ID: 93300030-d882-11f0-9018-ff504e8fbcc3 2025-12-14 00:21:34.287308 | 2025-12-14 00:21:34.287471 | LOOP [emit-job-header : Print node information] 2025-12-14 00:21:34.739146 | debian-bookworm | ok: 2025-12-14 00:21:34.739414 | debian-bookworm | # Node Information 2025-12-14 00:21:34.739453 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-14 00:21:34.739479 | debian-bookworm | Hostname: debian 2025-12-14 00:21:34.739501 | debian-bookworm | Username: zuul 2025-12-14 00:21:34.739522 | debian-bookworm | Distro: Debian 12.12 2025-12-14 00:21:34.739546 | debian-bookworm | Provider: regiocloud-a 2025-12-14 00:21:34.739567 | debian-bookworm | Region: 2025-12-14 00:21:34.739588 | debian-bookworm | Label: debian-bookworm 2025-12-14 00:21:34.739607 | debian-bookworm | Product Name: OpenStack Nova 2025-12-14 00:21:34.739627 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1f:160e 2025-12-14 00:21:34.838729 | 2025-12-14 00:21:34.838953 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-14 00:21:37.515697 | debian-bookworm -> localhost | changed 2025-12-14 00:21:37.523699 | 2025-12-14 00:21:37.523840 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-14 00:21:42.210662 | debian-bookworm -> localhost | changed 2025-12-14 00:21:42.242857 | 2025-12-14 00:21:42.243005 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-14 00:21:43.780310 | debian-bookworm -> localhost | ok 2025-12-14 00:21:43.788074 | 2025-12-14 00:21:43.788250 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-14 00:21:43.895647 | debian-bookworm | ok 2025-12-14 00:21:43.982689 | debian-bookworm | included: /var/lib/zuul/builds/0ec73748cb8c4a7092d53f6ce1f797ad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-14 00:21:44.013039 | 2025-12-14 00:21:44.015000 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-14 00:21:46.410910 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-14 00:21:46.411150 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0ec73748cb8c4a7092d53f6ce1f797ad/work/0ec73748cb8c4a7092d53f6ce1f797ad_id_rsa 2025-12-14 00:21:46.411226 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0ec73748cb8c4a7092d53f6ce1f797ad/work/0ec73748cb8c4a7092d53f6ce1f797ad_id_rsa.pub 2025-12-14 00:21:46.411256 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-14 00:21:46.411281 | debian-bookworm -> localhost | SHA256:q1++8tNCp20g/TD4GaeDJ/+uAeqD255y1CBCI0hVrHE zuul-build-sshkey 2025-12-14 00:21:46.411303 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-14 00:21:46.411337 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-14 00:21:46.411358 | debian-bookworm -> localhost | |o...o. | 2025-12-14 00:21:46.411379 | debian-bookworm -> localhost | |o o. E | 2025-12-14 00:21:46.411399 | debian-bookworm -> localhost | | o .+ | 2025-12-14 00:21:46.411419 | debian-bookworm -> localhost | | ... . | 2025-12-14 00:21:46.411438 | debian-bookworm -> localhost | | . . oSo | 2025-12-14 00:21:46.411461 | debian-bookworm -> localhost | | ..+oB o | 2025-12-14 00:21:46.411480 | debian-bookworm -> localhost | | o. .=o# | 2025-12-14 00:21:46.411500 | debian-bookworm -> localhost | | oooo+oX.= | 2025-12-14 00:21:46.411520 | debian-bookworm -> localhost | | .=*o.**Xo | 2025-12-14 00:21:46.411540 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-14 00:21:46.411592 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.025538 2025-12-14 00:21:46.420464 | 2025-12-14 00:21:46.420666 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-14 00:21:46.462790 | debian-bookworm | ok 2025-12-14 00:21:46.483747 | debian-bookworm | included: /var/lib/zuul/builds/0ec73748cb8c4a7092d53f6ce1f797ad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-14 00:21:46.498601 | 2025-12-14 00:21:46.498748 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-14 00:21:46.549153 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:46.556691 | 2025-12-14 00:21:46.556889 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-14 00:21:47.564345 | debian-bookworm | changed 2025-12-14 00:21:47.570183 | 2025-12-14 00:21:47.570340 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-14 00:21:47.863140 | debian-bookworm | ok 2025-12-14 00:21:47.893463 | 2025-12-14 00:21:47.893615 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-14 00:21:48.743787 | debian-bookworm | changed 2025-12-14 00:21:48.752733 | 2025-12-14 00:21:48.752879 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-14 00:21:49.570506 | debian-bookworm | changed 2025-12-14 00:21:49.588897 | 2025-12-14 00:21:49.589366 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-14 00:21:49.614030 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:49.620708 | 2025-12-14 00:21:49.620837 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-14 00:21:50.630809 | debian-bookworm -> localhost | changed 2025-12-14 00:21:50.643602 | 2025-12-14 00:21:50.643746 | TASK [add-build-sshkey : Add back temp key] 2025-12-14 00:21:51.623271 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0ec73748cb8c4a7092d53f6ce1f797ad/work/0ec73748cb8c4a7092d53f6ce1f797ad_id_rsa (zuul-build-sshkey) 2025-12-14 00:21:51.623553 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.046627 2025-12-14 00:21:51.634404 | 2025-12-14 00:21:51.634539 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-14 00:21:52.292167 | debian-bookworm | ok 2025-12-14 00:21:52.320403 | 2025-12-14 00:21:52.320555 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-14 00:21:52.359003 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:21:52.371848 | 2025-12-14 00:21:52.371999 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-14 00:21:52.866912 | debian-bookworm | ok 2025-12-14 00:21:52.880779 | 2025-12-14 00:21:52.880921 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-14 00:21:52.922891 | debian-bookworm | ok 2025-12-14 00:21:52.929566 | 2025-12-14 00:21:52.929711 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-14 00:21:53.361980 | debian-bookworm -> localhost | ok 2025-12-14 00:21:53.372247 | 2025-12-14 00:21:53.372392 | TASK [validate-host : Collect information about the host] 2025-12-14 00:21:54.658005 | debian-bookworm | ok 2025-12-14 00:21:54.670636 | 2025-12-14 00:21:54.670770 | TASK [validate-host : Sanitize hostname] 2025-12-14 00:21:54.827108 | debian-bookworm | ok 2025-12-14 00:21:54.885975 | 2025-12-14 00:21:54.886114 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-14 00:21:55.683958 | debian-bookworm -> localhost | changed 2025-12-14 00:21:55.694332 | 2025-12-14 00:21:55.694470 | TASK [validate-host : Collect information about zuul worker] 2025-12-14 00:21:56.153329 | debian-bookworm | ok 2025-12-14 00:21:56.158811 | 2025-12-14 00:21:56.159046 | TASK [validate-host : Write out all zuul information for each host] 2025-12-14 00:21:56.764654 | debian-bookworm -> localhost | changed 2025-12-14 00:21:56.774728 | 2025-12-14 00:21:56.774904 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-14 00:21:57.055416 | debian-bookworm | ok 2025-12-14 00:21:57.063758 | 2025-12-14 00:21:57.063897 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-14 00:21:58.066520 | debian-bookworm | changed: 2025-12-14 00:21:58.066760 | debian-bookworm | cd+++++++++ src/ 2025-12-14 00:21:58.066821 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-14 00:21:58.066877 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-14 00:21:58.066901 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-14 00:21:58.066921 | debian-bookworm | =6.2 2025-12-14 00:22:26.149020 | debian-bookworm | Downloading cachetools-6.2.3-py3-none-any.whl (11 kB) 2025-12-14 00:22:26.202357 | debian-bookworm | Collecting chardet>=5.2 2025-12-14 00:22:26.219148 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-14 00:22:26.236933 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 17.3 MB/s eta 0:00:00 2025-12-14 00:22:26.286751 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-14 00:22:26.304962 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-14 00:22:26.385175 | debian-bookworm | Collecting filelock>=3.20 2025-12-14 00:22:26.401974 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-12-14 00:22:26.463574 | debian-bookworm | Collecting packaging>=25 2025-12-14 00:22:26.479835 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-14 00:22:26.493547 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 6.9 MB/s eta 0:00:00 2025-12-14 00:22:26.551063 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-14 00:22:26.569809 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-14 00:22:26.631185 | debian-bookworm | Collecting pluggy>=1.6 2025-12-14 00:22:26.646816 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-14 00:22:26.690204 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-14 00:22:26.708319 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-14 00:22:26.861656 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-14 00:22:26.877504 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-14 00:22:27.194321 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 19.3 MB/s eta 0:00:00 2025-12-14 00:22:27.304112 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-14 00:22:27.320196 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-14 00:22:27.346156 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.4 MB/s eta 0:00:00 2025-12-14 00:22:27.504270 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-14 00:22:28.469693 | debian-bookworm | Successfully installed cachetools-6.2.3 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-12-14 00:22:28.763010 | debian-bookworm | ok: Runtime: 0:00:03.399472 2025-12-14 00:22:28.771856 | 2025-12-14 00:22:28.771987 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-14 00:22:28.837899 | debian-bookworm | ok 2025-12-14 00:22:28.847595 | 2025-12-14 00:22:28.847735 | TASK [ensure-tox : Output tox version] 2025-12-14 00:22:29.499319 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-14 00:22:29.520689 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-14 00:22:29.916547 | debian-bookworm | ok: Runtime: 0:00:00.338651 2025-12-14 00:22:29.923525 | 2025-12-14 00:22:29.923644 | TASK [ensure-tox : Make global symlink] 2025-12-14 00:22:29.948929 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:22:29.975549 | 2025-12-14 00:22:29.975665 | PLAY RECAP 2025-12-14 00:22:29.976695 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-14 00:22:29.976783 | 2025-12-14 00:22:30.393437 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-14 00:22:30.394639 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-14 00:22:32.467566 | 2025-12-14 00:22:32.467813 | PLAY [all] 2025-12-14 00:22:32.485564 | 2025-12-14 00:22:32.485729 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-14 00:22:33.115994 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-14 00:22:33.529146 | debian-bookworm | ok: Runtime: 0:00:00.034785 2025-12-14 00:22:33.535541 | 2025-12-14 00:22:33.535697 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-14 00:22:34.117139 | debian-bookworm | ok: Runtime: 0:00:00.006331 2025-12-14 00:22:34.125538 | 2025-12-14 00:22:34.125681 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-14 00:22:34.437338 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-14 00:22:34.439105 | debian-bookworm | sudo: a password is required 2025-12-14 00:22:34.667392 | debian-bookworm | ok: Runtime: 0:00:00.020595 2025-12-14 00:22:34.680840 | 2025-12-14 00:22:34.680971 | TASK [tox : Check to see if the constraints file exists] 2025-12-14 00:22:34.749311 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:22:34.757670 | 2025-12-14 00:22:34.757805 | TASK [tox : Fail if constraints file is missing] 2025-12-14 00:22:34.820393 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:22:34.829270 | 2025-12-14 00:22:34.829452 | TASK [tox : Record file location] 2025-12-14 00:22:34.910383 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:22:34.918227 | 2025-12-14 00:22:34.918628 | TASK [tox : Install tox siblings] 2025-12-14 00:22:34.979563 | debian-bookworm | ok 2025-12-14 00:22:35.007536 | debian-bookworm | included: /var/lib/zuul/builds/0ec73748cb8c4a7092d53f6ce1f797ad/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-14 00:22:35.030537 | 2025-12-14 00:22:35.030954 | TASK [tox : Run tox without tests] 2025-12-14 00:22:36.297833 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-14 00:22:51.500912 | debian-bookworm | test: OK (15.79 seconds) 2025-12-14 00:22:51.500991 | debian-bookworm | congratulations :) (15.82 seconds) 2025-12-14 00:22:51.642416 | debian-bookworm | ok: Runtime: 0:00:16.119046 2025-12-14 00:22:51.649358 | 2025-12-14 00:22:51.649479 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-14 00:22:52.175318 | debian-bookworm | changed 2025-12-14 00:22:52.181404 | 2025-12-14 00:22:52.181552 | TASK [tox : Get tox envlist config] 2025-12-14 00:22:53.232050 | debian-bookworm | ok: Runtime: 0:00:00.352523 2025-12-14 00:22:53.238269 | 2025-12-14 00:22:53.238404 | TASK [tox : Install any sibling python packages] 2025-12-14 00:22:53.801907 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-14 00:22:53.810739 | 2025-12-14 00:22:53.810931 | TASK [tox : Remove tempfile] 2025-12-14 00:22:54.288935 | debian-bookworm | changed 2025-12-14 00:22:54.299894 | 2025-12-14 00:22:54.300042 | TASK [tox : Emit tox command] 2025-12-14 00:22:54.343457 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-14 00:22:54.350084 | 2025-12-14 00:22:54.350270 | TASK [tox : Run tox] 2025-12-14 00:22:55.007271 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-14 00:22:55.667192 | debian-bookworm | ............... 2025-12-14 00:22:55.667250 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-14 00:22:55.667267 | debian-bookworm | Ran 15 tests in 0.172s 2025-12-14 00:22:55.667272 | debian-bookworm | 2025-12-14 00:22:55.667280 | debian-bookworm | OK 2025-12-14 00:22:55.762670 | debian-bookworm | test: OK (0.80=setup[0.05]+cmd[0.75] seconds) 2025-12-14 00:22:55.762805 | debian-bookworm | congratulations :) (0.83 seconds) 2025-12-14 00:22:55.922418 | debian-bookworm | ok: Runtime: 0:00:01.143847 2025-12-14 00:22:55.936537 | 2025-12-14 00:22:55.936717 | TASK [tox : Look for output] 2025-12-14 00:22:56.410774 | debian-bookworm | ok 2025-12-14 00:22:56.429355 | 2025-12-14 00:22:56.429490 | TASK [tox : Return file comments to Zuul] 2025-12-14 00:22:56.474993 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:22:56.491253 | 2025-12-14 00:22:56.491431 | PLAY RECAP 2025-12-14 00:22:56.491572 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-14 00:22:56.491635 | 2025-12-14 00:22:56.639805 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-14 00:22:56.640933 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-14 00:22:57.472330 | 2025-12-14 00:22:57.472509 | PLAY [all] 2025-12-14 00:22:57.499239 | 2025-12-14 00:22:57.499405 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-14 00:22:57.544578 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:22:57.552470 | 2025-12-14 00:22:57.552653 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-14 00:22:57.594318 | debian-bookworm | ok 2025-12-14 00:22:57.599753 | 2025-12-14 00:22:57.599888 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-14 00:22:58.121496 | debian-bookworm -> localhost | changed 2025-12-14 00:22:58.138571 | 2025-12-14 00:22:58.138807 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-14 00:22:58.205161 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:22:58.219183 | 2025-12-14 00:22:58.219398 | TASK [fetch-tox-output : Set envlist fact] 2025-12-14 00:22:58.270024 | debian-bookworm | ok 2025-12-14 00:22:58.277381 | 2025-12-14 00:22:58.277511 | TASK [fetch-tox-output : Get tox version] 2025-12-14 00:22:59.019606 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-14 00:22:59.038773 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-14 00:22:59.323062 | debian-bookworm | ok: Runtime: 0:00:00.318095 2025-12-14 00:22:59.336514 | 2025-12-14 00:22:59.336709 | TASK [fetch-tox-output : Find all default environments] 2025-12-14 00:22:59.873403 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:22:59.886518 | 2025-12-14 00:22:59.886717 | TASK [fetch-tox-output : Set envlist fact] 2025-12-14 00:22:59.932481 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:22:59.946039 | 2025-12-14 00:22:59.946277 | TASK [fetch-tox-output : Find all default environments] 2025-12-14 00:23:00.479220 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:23:00.493609 | 2025-12-14 00:23:00.493790 | TASK [fetch-tox-output : Set envlist fact] 2025-12-14 00:23:00.529081 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:23:00.543838 | 2025-12-14 00:23:00.544017 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-14 00:23:00.597997 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:23:00.610346 | 2025-12-14 00:23:00.610501 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-14 00:23:01.511972 | debian-bookworm | changed: 2025-12-14 00:23:01.512387 | debian-bookworm | created directory /var/lib/zuul/builds/0ec73748cb8c4a7092d53f6ce1f797ad/work/logs/tox/test 2025-12-14 00:23:01.512491 | debian-bookworm | cd+++++++++ ./ 2025-12-14 00:23:01.512542 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-14 00:23:01.512589 | 2025-12-14 00:23:01.529443 | 2025-12-14 00:23:01.529587 | PLAY RECAP 2025-12-14 00:23:01.529710 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-14 00:23:01.529754 | 2025-12-14 00:23:01.685511 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-14 00:23:01.686586 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-14 00:23:02.530488 | 2025-12-14 00:23:02.530767 | PLAY [all] 2025-12-14 00:23:02.549777 | 2025-12-14 00:23:02.549942 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-14 00:23:02.856440 | debian-bookworm | changed: non-zero return code 2025-12-14 00:23:02.866140 | 2025-12-14 00:23:02.866518 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-14 00:23:02.898509 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:23:02.907562 | 2025-12-14 00:23:02.907717 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-14 00:23:02.941732 | 2025-12-14 00:23:02.941961 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-14 00:23:02.974825 | 2025-12-14 00:23:02.975062 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-14 00:23:02.999278 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:23:03.005908 | 2025-12-14 00:23:03.006043 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-14 00:23:03.051384 | 2025-12-14 00:23:03.051653 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-14 00:23:03.077549 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:23:03.092728 | 2025-12-14 00:23:03.092914 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-14 00:23:03.128541 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:23:03.140514 | 2025-12-14 00:23:03.140671 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-14 00:23:03.177043 | debian-bookworm | skipping: Conditional result was False 2025-12-14 00:23:03.190476 | 2025-12-14 00:23:03.190655 | PLAY RECAP 2025-12-14 00:23:03.190757 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-14 00:23:03.190804 | 2025-12-14 00:23:03.377843 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-14 00:23:03.378987 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-14 00:23:04.166066 | 2025-12-14 00:23:04.166294 | PLAY [Base post] 2025-12-14 00:23:04.190031 | 2025-12-14 00:23:04.190255 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-14 00:23:04.865017 | debian-bookworm | changed 2025-12-14 00:23:04.871326 | 2025-12-14 00:23:04.871446 | PLAY RECAP 2025-12-14 00:23:04.871510 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-14 00:23:04.871573 | 2025-12-14 00:23:05.014410 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-14 00:23:05.015586 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-14 00:23:05.829017 | 2025-12-14 00:23:05.829218 | PLAY [Base post-logs] 2025-12-14 00:23:05.840454 | 2025-12-14 00:23:05.840616 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-14 00:23:06.343226 | localhost | changed 2025-12-14 00:23:06.353772 | 2025-12-14 00:23:06.353956 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-14 00:23:06.380147 | localhost | ok 2025-12-14 00:23:06.383840 | 2025-12-14 00:23:06.383968 | TASK [Set zuul-log-path fact] 2025-12-14 00:23:06.400928 | localhost | ok 2025-12-14 00:23:06.409774 | 2025-12-14 00:23:06.409915 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-14 00:23:06.435949 | localhost | ok 2025-12-14 00:23:06.439339 | 2025-12-14 00:23:06.439456 | TASK [upload-logs : Create log directories] 2025-12-14 00:23:07.010820 | localhost | changed 2025-12-14 00:23:07.021268 | 2025-12-14 00:23:07.021422 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-14 00:23:07.631916 | localhost -> localhost | ok: Runtime: 0:00:00.005551 2025-12-14 00:23:07.636139 | 2025-12-14 00:23:07.636315 | TASK [upload-logs : Upload logs to log server] 2025-12-14 00:23:08.351213 | localhost | Output suppressed because no_log was given 2025-12-14 00:23:08.353925 | 2025-12-14 00:23:08.354057 | LOOP [upload-logs : Compress console log and json output] 2025-12-14 00:23:08.444609 | localhost | skipping: Conditional result was False 2025-12-14 00:23:08.449873 | localhost | skipping: Conditional result was False 2025-12-14 00:23:08.464726 | 2025-12-14 00:23:08.465008 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-14 00:23:08.541945 | localhost | skipping: Conditional result was False 2025-12-14 00:23:08.542308 | 2025-12-14 00:23:08.550163 | localhost | skipping: Conditional result was False 2025-12-14 00:23:08.564381 | 2025-12-14 00:23:08.564639 | LOOP [upload-logs : Upload console log and json output]