2025-10-20 05:49:34.679310 | Job console starting 2025-10-20 05:49:34.693917 | Updating git repos 2025-10-20 05:49:34.726982 | Cloning repos into workspace 2025-10-20 05:49:34.795223 | Restoring repo states 2025-10-20 05:49:34.805652 | Merging changes 2025-10-20 05:49:35.260754 | Checking out repos 2025-10-20 05:49:35.328657 | Preparing playbooks 2025-10-20 05:49:36.008389 | Running Ansible setup 2025-10-20 05:49:40.911357 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-20 05:49:41.973859 | 2025-10-20 05:49:41.974019 | PLAY [Base pre] 2025-10-20 05:49:41.991014 | 2025-10-20 05:49:41.991177 | TASK [Setup log path fact] 2025-10-20 05:49:42.020484 | debian-bookworm | ok 2025-10-20 05:49:42.054659 | 2025-10-20 05:49:42.054821 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-20 05:49:42.105735 | debian-bookworm | ok 2025-10-20 05:49:42.129408 | 2025-10-20 05:49:42.129542 | TASK [emit-job-header : Print job information] 2025-10-20 05:49:42.175215 | # Job Information 2025-10-20 05:49:42.175411 | Ansible Version: 2.16.14 2025-10-20 05:49:42.175449 | Job: tox 2025-10-20 05:49:42.175481 | Pipeline: check 2025-10-20 05:49:42.175504 | Executor: 521e9411259a 2025-10-20 05:49:42.175525 | Triggered by: https://github.com/osism/openstack-image-manager/pull/973 2025-10-20 05:49:42.175548 | Event ID: 89551260-ad78-11f0-8ca1-b47d98c721ff 2025-10-20 05:49:42.180593 | 2025-10-20 05:49:42.180705 | LOOP [emit-job-header : Print node information] 2025-10-20 05:49:42.296427 | debian-bookworm | ok: 2025-10-20 05:49:42.296698 | debian-bookworm | # Node Information 2025-10-20 05:49:42.296792 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-20 05:49:42.296821 | debian-bookworm | Hostname: debian 2025-10-20 05:49:42.296847 | debian-bookworm | Username: zuul 2025-10-20 05:49:42.296871 | debian-bookworm | Distro: Debian 12.12 2025-10-20 05:49:42.296894 | debian-bookworm | Provider: regiocloud-a 2025-10-20 05:49:42.296916 | debian-bookworm | Region: 2025-10-20 05:49:42.296936 | debian-bookworm | Label: debian-bookworm 2025-10-20 05:49:42.296956 | debian-bookworm | Product Name: OpenStack Nova 2025-10-20 05:49:42.296975 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb9:4185 2025-10-20 05:49:42.325568 | 2025-10-20 05:49:42.325720 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-20 05:49:42.985846 | debian-bookworm -> localhost | changed 2025-10-20 05:49:42.993549 | 2025-10-20 05:49:42.993672 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-20 05:49:44.115621 | debian-bookworm -> localhost | changed 2025-10-20 05:49:44.125867 | 2025-10-20 05:49:44.125966 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-20 05:49:44.402348 | debian-bookworm -> localhost | ok 2025-10-20 05:49:44.408564 | 2025-10-20 05:49:44.408663 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-20 05:49:44.426687 | debian-bookworm | ok 2025-10-20 05:49:44.463508 | debian-bookworm | included: /var/lib/zuul/builds/f70bcf9398074e3abab363d72c4338a8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-20 05:49:44.473496 | 2025-10-20 05:49:44.473594 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-20 05:49:45.841998 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-20 05:49:45.842199 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f70bcf9398074e3abab363d72c4338a8/work/f70bcf9398074e3abab363d72c4338a8_id_rsa 2025-10-20 05:49:45.842239 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f70bcf9398074e3abab363d72c4338a8/work/f70bcf9398074e3abab363d72c4338a8_id_rsa.pub 2025-10-20 05:49:45.842266 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-20 05:49:45.842292 | debian-bookworm -> localhost | SHA256:M5n0tpXG/+onT1thzz8tro6fTkJeSUZNiIear/F+BUU zuul-build-sshkey 2025-10-20 05:49:45.842315 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-20 05:49:45.842345 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-20 05:49:45.842367 | debian-bookworm -> localhost | | o.=E | 2025-10-20 05:49:45.842388 | debian-bookworm -> localhost | | o.o o | 2025-10-20 05:49:45.842408 | debian-bookworm -> localhost | | .o .o. | 2025-10-20 05:49:45.842427 | debian-bookworm -> localhost | | .o+ +.o | 2025-10-20 05:49:45.842447 | debian-bookworm -> localhost | | S.+ B. o | 2025-10-20 05:49:45.842471 | debian-bookworm -> localhost | | .*.= .o.o| 2025-10-20 05:49:45.842491 | debian-bookworm -> localhost | | ++ ... *| 2025-10-20 05:49:45.842510 | debian-bookworm -> localhost | | . .+..o+*| 2025-10-20 05:49:45.842531 | debian-bookworm -> localhost | | .o=*++B=| 2025-10-20 05:49:45.842550 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-20 05:49:45.842599 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.875312 2025-10-20 05:49:45.848671 | 2025-10-20 05:49:45.848758 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-20 05:49:45.876140 | debian-bookworm | ok 2025-10-20 05:49:45.890242 | debian-bookworm | included: /var/lib/zuul/builds/f70bcf9398074e3abab363d72c4338a8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-20 05:49:45.923111 | 2025-10-20 05:49:45.923221 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-20 05:49:45.946232 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:49:45.951706 | 2025-10-20 05:49:45.951791 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-20 05:49:46.588363 | debian-bookworm | changed 2025-10-20 05:49:46.594422 | 2025-10-20 05:49:46.594511 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-20 05:49:46.851509 | debian-bookworm | ok 2025-10-20 05:49:46.856974 | 2025-10-20 05:49:46.857057 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-20 05:49:47.526998 | debian-bookworm | changed 2025-10-20 05:49:47.536571 | 2025-10-20 05:49:47.536696 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-20 05:49:48.206951 | debian-bookworm | changed 2025-10-20 05:49:48.212966 | 2025-10-20 05:49:48.213067 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-20 05:49:48.241820 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:49:48.247900 | 2025-10-20 05:49:48.247997 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-20 05:49:48.792895 | debian-bookworm -> localhost | changed 2025-10-20 05:49:48.803253 | 2025-10-20 05:49:48.803346 | TASK [add-build-sshkey : Add back temp key] 2025-10-20 05:49:49.153096 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f70bcf9398074e3abab363d72c4338a8/work/f70bcf9398074e3abab363d72c4338a8_id_rsa (zuul-build-sshkey) 2025-10-20 05:49:49.153327 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012410 2025-10-20 05:49:49.160850 | 2025-10-20 05:49:49.160942 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-20 05:49:49.595812 | debian-bookworm | ok 2025-10-20 05:49:49.600685 | 2025-10-20 05:49:49.600776 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-20 05:49:49.639077 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:49:49.660937 | 2025-10-20 05:49:49.661045 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-20 05:49:50.071581 | debian-bookworm | ok 2025-10-20 05:49:50.089467 | 2025-10-20 05:49:50.089570 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-20 05:49:50.117699 | debian-bookworm | ok 2025-10-20 05:49:50.134523 | 2025-10-20 05:49:50.134619 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-20 05:49:50.403552 | debian-bookworm -> localhost | ok 2025-10-20 05:49:50.409744 | 2025-10-20 05:49:50.409836 | TASK [validate-host : Collect information about the host] 2025-10-20 05:49:51.493032 | debian-bookworm | ok 2025-10-20 05:49:51.502795 | 2025-10-20 05:49:51.502936 | TASK [validate-host : Sanitize hostname] 2025-10-20 05:49:51.618542 | debian-bookworm | ok 2025-10-20 05:49:51.646102 | 2025-10-20 05:49:51.646216 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-20 05:49:52.369576 | debian-bookworm -> localhost | changed 2025-10-20 05:49:52.374846 | 2025-10-20 05:49:52.374933 | TASK [validate-host : Collect information about zuul worker] 2025-10-20 05:49:52.786616 | debian-bookworm | ok 2025-10-20 05:49:52.791220 | 2025-10-20 05:49:52.791312 | TASK [validate-host : Write out all zuul information for each host] 2025-10-20 05:49:53.249252 | debian-bookworm -> localhost | changed 2025-10-20 05:49:53.258019 | 2025-10-20 05:49:53.258122 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-20 05:49:53.522568 | debian-bookworm | ok 2025-10-20 05:49:53.527726 | 2025-10-20 05:49:53.527811 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-20 05:49:54.366505 | debian-bookworm | changed: 2025-10-20 05:49:54.366665 | debian-bookworm | cd+++++++++ src/ 2025-10-20 05:49:54.366699 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-20 05:49:54.366724 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-20 05:49:54.366745 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-20 05:49:54.366764 | debian-bookworm | =6.2 2025-10-20 05:50:15.948366 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-10-20 05:50:15.985450 | debian-bookworm | Collecting chardet>=5.2 2025-10-20 05:50:15.997627 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-10-20 05:50:16.033552 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 6.6 MB/s eta 0:00:00 2025-10-20 05:50:16.094773 | debian-bookworm | Collecting colorama>=0.4.6 2025-10-20 05:50:16.106812 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-20 05:50:16.162931 | debian-bookworm | Collecting filelock>=3.20 2025-10-20 05:50:16.174022 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-10-20 05:50:16.223871 | debian-bookworm | Collecting packaging>=25 2025-10-20 05:50:16.235133 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-20 05:50:16.247988 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.1 MB/s eta 0:00:00 2025-10-20 05:50:16.311029 | debian-bookworm | Collecting platformdirs>=4.5 2025-10-20 05:50:16.322170 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-10-20 05:50:16.363950 | debian-bookworm | Collecting pluggy>=1.6 2025-10-20 05:50:16.374909 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-10-20 05:50:16.413774 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-10-20 05:50:16.426426 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-10-20 05:50:16.595046 | debian-bookworm | Collecting virtualenv>=20.34 2025-10-20 05:50:16.608574 | debian-bookworm | Downloading virtualenv-20.35.3-py3-none-any.whl (6.0 MB) 2025-10-20 05:50:16.939540 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 18.3 MB/s eta 0:00:00 2025-10-20 05:50:17.045974 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-10-20 05:50:17.057037 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-10-20 05:50:17.080143 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 26.6 MB/s eta 0:00:00 2025-10-20 05:50:17.242119 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-10-20 05:50:17.988143 | debian-bookworm | Successfully installed cachetools-6.2.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.0 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.31.0 virtualenv-20.35.3 2025-10-20 05:50:18.524238 | debian-bookworm | ok: Runtime: 0:00:02.789546 2025-10-20 05:50:18.530559 | 2025-10-20 05:50:18.530678 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-20 05:50:18.572204 | debian-bookworm | ok 2025-10-20 05:50:18.577183 | 2025-10-20 05:50:18.577288 | TASK [ensure-tox : Output tox version] 2025-10-20 05:50:19.076887 | 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-10-20 05:50:19.095160 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-20 05:50:19.606806 | debian-bookworm | ok: Runtime: 0:00:00.292948 2025-10-20 05:50:19.614742 | 2025-10-20 05:50:19.614981 | TASK [ensure-tox : Make global symlink] 2025-10-20 05:50:19.642658 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:19.651968 | 2025-10-20 05:50:19.652061 | PLAY RECAP 2025-10-20 05:50:19.652191 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-20 05:50:19.652310 | 2025-10-20 05:50:19.880764 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-10-20 05:50:19.881921 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-20 05:50:20.690898 | 2025-10-20 05:50:20.691058 | PLAY [all] 2025-10-20 05:50:20.707113 | 2025-10-20 05:50:20.707270 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-10-20 05:50:21.203907 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-20 05:50:21.261529 | debian-bookworm | ok: Runtime: 0:00:00.030632 2025-10-20 05:50:21.268882 | 2025-10-20 05:50:21.269018 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-10-20 05:50:21.814668 | debian-bookworm | ok: Runtime: 0:00:00.006704 2025-10-20 05:50:21.820802 | 2025-10-20 05:50:21.820919 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-10-20 05:50:22.144120 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-20 05:50:22.148271 | debian-bookworm | sudo: a password is required 2025-10-20 05:50:22.352634 | debian-bookworm | ok: Runtime: 0:00:00.024287 2025-10-20 05:50:22.363525 | 2025-10-20 05:50:22.363634 | TASK [tox : Check to see if the constraints file exists] 2025-10-20 05:50:22.418435 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:22.428034 | 2025-10-20 05:50:22.428359 | TASK [tox : Fail if constraints file is missing] 2025-10-20 05:50:22.463032 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:22.470467 | 2025-10-20 05:50:22.470577 | TASK [tox : Record file location] 2025-10-20 05:50:22.515398 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:22.525056 | 2025-10-20 05:50:22.525194 | TASK [tox : Install tox siblings] 2025-10-20 05:50:22.558754 | debian-bookworm | ok 2025-10-20 05:50:22.571313 | debian-bookworm | included: /var/lib/zuul/builds/f70bcf9398074e3abab363d72c4338a8/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-10-20 05:50:22.578938 | 2025-10-20 05:50:22.579043 | TASK [tox : Run tox without tests] 2025-10-20 05:50:23.675561 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-10-20 05:50:37.417623 | debian-bookworm | test: OK (14.29 seconds) 2025-10-20 05:50:37.417707 | debian-bookworm | congratulations :) (14.32 seconds) 2025-10-20 05:50:37.621078 | debian-bookworm | ok: Runtime: 0:00:14.622955 2025-10-20 05:50:37.633188 | 2025-10-20 05:50:37.633353 | TASK [tox : Create a tempfile to save tox showconfig] 2025-10-20 05:50:38.049746 | debian-bookworm | changed 2025-10-20 05:50:38.059169 | 2025-10-20 05:50:38.059322 | TASK [tox : Get tox envlist config] 2025-10-20 05:50:39.090075 | debian-bookworm | ok: Runtime: 0:00:00.355416 2025-10-20 05:50:39.101416 | 2025-10-20 05:50:39.101576 | TASK [tox : Install any sibling python packages] 2025-10-20 05:50:39.545706 | debian-bookworm | ok: No setup.cfg, no action needed 2025-10-20 05:50:39.554381 | 2025-10-20 05:50:39.554514 | TASK [tox : Remove tempfile] 2025-10-20 05:50:39.980973 | debian-bookworm | changed 2025-10-20 05:50:39.988471 | 2025-10-20 05:50:39.988587 | TASK [tox : Emit tox command] 2025-10-20 05:50:40.045568 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-10-20 05:50:40.054854 | 2025-10-20 05:50:40.054994 | TASK [tox : Run tox] 2025-10-20 05:50:40.668547 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-10-20 05:50:41.299933 | debian-bookworm | ............... 2025-10-20 05:50:41.299986 | debian-bookworm | ---------------------------------------------------------------------- 2025-10-20 05:50:41.300002 | debian-bookworm | Ran 15 tests in 0.176s 2025-10-20 05:50:41.300008 | debian-bookworm | 2025-10-20 05:50:41.300015 | debian-bookworm | OK 2025-10-20 05:50:41.398926 | debian-bookworm | test: OK (0.77=setup[0.04]+cmd[0.73] seconds) 2025-10-20 05:50:41.398990 | debian-bookworm | congratulations :) (0.80 seconds) 2025-10-20 05:50:41.619761 | debian-bookworm | ok: Runtime: 0:00:01.070760 2025-10-20 05:50:41.633582 | 2025-10-20 05:50:41.633732 | TASK [tox : Look for output] 2025-10-20 05:50:42.034543 | debian-bookworm | ok 2025-10-20 05:50:42.052272 | 2025-10-20 05:50:42.052395 | TASK [tox : Return file comments to Zuul] 2025-10-20 05:50:42.096898 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:42.110968 | 2025-10-20 05:50:42.111087 | PLAY RECAP 2025-10-20 05:50:42.111221 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-20 05:50:42.111265 | 2025-10-20 05:50:42.226933 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-20 05:50:42.228334 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-20 05:50:42.956995 | 2025-10-20 05:50:42.957153 | PLAY [all] 2025-10-20 05:50:42.972213 | 2025-10-20 05:50:42.972339 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-10-20 05:50:43.027393 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:43.039320 | 2025-10-20 05:50:43.039500 | TASK [fetch-tox-output : Set tox log path for single node] 2025-10-20 05:50:43.076316 | debian-bookworm | ok 2025-10-20 05:50:43.081779 | 2025-10-20 05:50:43.081885 | TASK [fetch-tox-output : Ensure local tox dir] 2025-10-20 05:50:43.551510 | debian-bookworm -> localhost | changed 2025-10-20 05:50:43.559329 | 2025-10-20 05:50:43.559444 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-10-20 05:50:43.613638 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:43.625218 | 2025-10-20 05:50:43.625380 | TASK [fetch-tox-output : Set envlist fact] 2025-10-20 05:50:43.672894 | debian-bookworm | ok 2025-10-20 05:50:43.682690 | 2025-10-20 05:50:43.682817 | TASK [fetch-tox-output : Get tox version] 2025-10-20 05:50:44.361490 | 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-10-20 05:50:44.380107 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-20 05:50:44.716220 | debian-bookworm | ok: Runtime: 0:00:00.300881 2025-10-20 05:50:44.729302 | 2025-10-20 05:50:44.729464 | TASK [fetch-tox-output : Find all default environments] 2025-10-20 05:50:45.264602 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:45.278943 | 2025-10-20 05:50:45.279121 | TASK [fetch-tox-output : Set envlist fact] 2025-10-20 05:50:45.315185 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:45.326730 | 2025-10-20 05:50:45.326916 | TASK [fetch-tox-output : Find all default environments] 2025-10-20 05:50:45.860553 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:45.875680 | 2025-10-20 05:50:45.875851 | TASK [fetch-tox-output : Set envlist fact] 2025-10-20 05:50:45.910705 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:45.924570 | 2025-10-20 05:50:45.924727 | LOOP [fetch-tox-output : Copy tox logs] 2025-10-20 05:50:45.970796 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:45.993260 | 2025-10-20 05:50:45.993418 | LOOP [fetch-tox-output : Collect tox logs] 2025-10-20 05:50:46.789517 | debian-bookworm | changed: 2025-10-20 05:50:46.789736 | debian-bookworm | created directory /var/lib/zuul/builds/f70bcf9398074e3abab363d72c4338a8/work/logs/tox/test 2025-10-20 05:50:46.789778 | debian-bookworm | cd+++++++++ ./ 2025-10-20 05:50:46.789809 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-10-20 05:50:46.789843 | 2025-10-20 05:50:46.814995 | 2025-10-20 05:50:46.815192 | PLAY RECAP 2025-10-20 05:50:46.815318 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-20 05:50:46.815381 | 2025-10-20 05:50:46.936110 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-20 05:50:46.938737 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-20 05:50:47.680979 | 2025-10-20 05:50:47.681121 | PLAY [all] 2025-10-20 05:50:47.696973 | 2025-10-20 05:50:47.697095 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-10-20 05:50:47.936282 | debian-bookworm | changed: non-zero return code 2025-10-20 05:50:47.945316 | 2025-10-20 05:50:47.945475 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-10-20 05:50:47.970086 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:47.983783 | 2025-10-20 05:50:47.984057 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-10-20 05:50:48.023284 | 2025-10-20 05:50:48.023545 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-10-20 05:50:48.061908 | 2025-10-20 05:50:48.062217 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-10-20 05:50:48.087675 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:48.094972 | 2025-10-20 05:50:48.095094 | LOOP [fetch-subunit-output : Generate subunit file] 2025-10-20 05:50:48.129455 | 2025-10-20 05:50:48.129725 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-10-20 05:50:48.154051 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:48.166037 | 2025-10-20 05:50:48.166246 | TASK [fetch-subunit-output : Remove the temporary file] 2025-10-20 05:50:48.190410 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:48.204042 | 2025-10-20 05:50:48.204279 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-10-20 05:50:48.232611 | debian-bookworm | skipping: Conditional result was False 2025-10-20 05:50:48.247258 | 2025-10-20 05:50:48.247397 | PLAY RECAP 2025-10-20 05:50:48.247486 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-20 05:50:48.247595 | 2025-10-20 05:50:48.366777 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-20 05:50:48.371505 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-20 05:50:49.089114 | 2025-10-20 05:50:49.089286 | PLAY [Base post] 2025-10-20 05:50:49.102920 | 2025-10-20 05:50:49.103063 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-20 05:50:49.678581 | debian-bookworm | changed 2025-10-20 05:50:49.684753 | 2025-10-20 05:50:49.684860 | PLAY RECAP 2025-10-20 05:50:49.684924 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-20 05:50:49.684988 | 2025-10-20 05:50:49.800935 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-20 05:50:49.802041 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-20 05:50:50.558579 | 2025-10-20 05:50:50.558735 | PLAY [Base post-logs] 2025-10-20 05:50:50.569111 | 2025-10-20 05:50:50.569261 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-20 05:50:51.030829 | localhost | changed 2025-10-20 05:50:51.040966 | 2025-10-20 05:50:51.041113 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-20 05:50:51.066779 | localhost | ok 2025-10-20 05:50:51.070253 | 2025-10-20 05:50:51.070361 | TASK [Set zuul-log-path fact] 2025-10-20 05:50:51.098607 | localhost | ok 2025-10-20 05:50:51.113482 | 2025-10-20 05:50:51.113640 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-20 05:50:51.151086 | localhost | ok 2025-10-20 05:50:51.156354 | 2025-10-20 05:50:51.156505 | TASK [upload-logs : Create log directories] 2025-10-20 05:50:51.651378 | localhost | changed 2025-10-20 05:50:51.654173 | 2025-10-20 05:50:51.654275 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-20 05:50:52.184231 | localhost -> localhost | ok: Runtime: 0:00:00.011454 2025-10-20 05:50:52.188271 | 2025-10-20 05:50:52.188383 | TASK [upload-logs : Upload logs to log server] 2025-10-20 05:50:52.747759 | localhost | Output suppressed because no_log was given 2025-10-20 05:50:52.751437 | 2025-10-20 05:50:52.751615 | LOOP [upload-logs : Compress console log and json output] 2025-10-20 05:50:52.798383 | localhost | skipping: Conditional result was False 2025-10-20 05:50:52.803398 | localhost | skipping: Conditional result was False 2025-10-20 05:50:52.817666 | 2025-10-20 05:50:52.817905 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-20 05:50:52.863115 | localhost | skipping: Conditional result was False 2025-10-20 05:50:52.863657 | 2025-10-20 05:50:52.867399 | localhost | skipping: Conditional result was False 2025-10-20 05:50:52.880644 | 2025-10-20 05:50:52.880881 | LOOP [upload-logs : Upload console log and json output]