2025-09-28 03:11:46.335289 | Job console starting 2025-09-28 03:11:46.368481 | Updating git repos 2025-09-28 03:11:46.411860 | Cloning repos into workspace 2025-09-28 03:11:46.511521 | Restoring repo states 2025-09-28 03:11:46.524172 | Merging changes 2025-09-28 03:11:46.524192 | Checking out repos 2025-09-28 03:11:46.621807 | Preparing playbooks 2025-09-28 03:11:47.528646 | Running Ansible setup 2025-09-28 03:11:53.006062 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-28 03:11:53.806955 | 2025-09-28 03:11:53.807069 | PLAY [Base pre] 2025-09-28 03:11:53.839887 | 2025-09-28 03:11:53.839985 | TASK [Setup log path fact] 2025-09-28 03:11:53.876700 | debian-bookworm | ok 2025-09-28 03:11:53.889547 | 2025-09-28 03:11:53.889662 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-28 03:11:53.946229 | debian-bookworm | ok 2025-09-28 03:11:53.956027 | 2025-09-28 03:11:53.956110 | TASK [emit-job-header : Print job information] 2025-09-28 03:11:54.013569 | # Job Information 2025-09-28 03:11:54.013704 | Ansible Version: 2.16.14 2025-09-28 03:11:54.013734 | Job: tox 2025-09-28 03:11:54.013761 | Pipeline: periodic-daily 2025-09-28 03:11:54.013779 | Executor: 521e9411259a 2025-09-28 03:11:54.013796 | Triggered by: https://github.com/osism/openstack-image-manager 2025-09-28 03:11:54.013814 | Event ID: 81c06cea6ab64d21ab913cb55cbca502 2025-09-28 03:11:54.017829 | 2025-09-28 03:11:54.017901 | LOOP [emit-job-header : Print node information] 2025-09-28 03:11:54.228764 | debian-bookworm | ok: 2025-09-28 03:11:54.228942 | debian-bookworm | # Node Information 2025-09-28 03:11:54.228970 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-28 03:11:54.228990 | debian-bookworm | Hostname: debian 2025-09-28 03:11:54.229008 | debian-bookworm | Username: zuul 2025-09-28 03:11:54.229025 | debian-bookworm | Distro: Debian 12.12 2025-09-28 03:11:54.229043 | debian-bookworm | Provider: regiocloud-a 2025-09-28 03:11:54.229060 | debian-bookworm | Region: 2025-09-28 03:11:54.229077 | debian-bookworm | Label: debian-bookworm 2025-09-28 03:11:54.229093 | debian-bookworm | Product Name: OpenStack Nova 2025-09-28 03:11:54.229109 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feaf:bcc8 2025-09-28 03:11:54.286988 | 2025-09-28 03:11:54.287181 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-28 03:11:54.888055 | debian-bookworm -> localhost | changed 2025-09-28 03:11:54.894866 | 2025-09-28 03:11:54.894972 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-28 03:11:56.346993 | debian-bookworm -> localhost | changed 2025-09-28 03:11:56.355939 | 2025-09-28 03:11:56.356022 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-28 03:11:56.829210 | debian-bookworm -> localhost | ok 2025-09-28 03:11:56.841687 | 2025-09-28 03:11:56.841786 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-28 03:11:56.878724 | debian-bookworm | ok 2025-09-28 03:11:56.905356 | debian-bookworm | included: /var/lib/zuul/builds/57c68cfe9ae040a881f6740161a3aba5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-28 03:11:56.918597 | 2025-09-28 03:11:56.918684 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-28 03:11:58.194045 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-28 03:11:58.194216 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/57c68cfe9ae040a881f6740161a3aba5/work/57c68cfe9ae040a881f6740161a3aba5_id_rsa 2025-09-28 03:11:58.194257 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/57c68cfe9ae040a881f6740161a3aba5/work/57c68cfe9ae040a881f6740161a3aba5_id_rsa.pub 2025-09-28 03:11:58.194280 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-28 03:11:58.194299 | debian-bookworm -> localhost | SHA256:wWK5D3vLHS3NnIR2dsXat9JPiIAljxJjp4jThSGX5Mg zuul-build-sshkey 2025-09-28 03:11:58.194317 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-28 03:11:58.194342 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-28 03:11:58.194359 | debian-bookworm -> localhost | | ..+. | 2025-09-28 03:11:58.194376 | debian-bookworm -> localhost | | . =.o o . | 2025-09-28 03:11:58.194392 | debian-bookworm -> localhost | | E o O = . o| 2025-09-28 03:11:58.194408 | debian-bookworm -> localhost | | o = B B . + | 2025-09-28 03:11:58.194424 | debian-bookworm -> localhost | | o o = S = + o o| 2025-09-28 03:11:58.194442 | debian-bookworm -> localhost | | . = . X +..o| 2025-09-28 03:11:58.194459 | debian-bookworm -> localhost | | . o o B..o.| 2025-09-28 03:11:58.194475 | debian-bookworm -> localhost | | o o o ...| 2025-09-28 03:11:58.194494 | debian-bookworm -> localhost | | o . .| 2025-09-28 03:11:58.194510 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-28 03:11:58.194551 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.418685 2025-09-28 03:11:58.199926 | 2025-09-28 03:11:58.200006 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-28 03:11:58.226721 | debian-bookworm | ok 2025-09-28 03:11:58.236370 | debian-bookworm | included: /var/lib/zuul/builds/57c68cfe9ae040a881f6740161a3aba5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-28 03:11:58.255898 | 2025-09-28 03:11:58.255966 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-28 03:11:58.268523 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:11:58.272896 | 2025-09-28 03:11:58.272968 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-28 03:11:58.846391 | debian-bookworm | changed 2025-09-28 03:11:58.850703 | 2025-09-28 03:11:58.850781 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-28 03:11:59.118871 | debian-bookworm | ok 2025-09-28 03:11:59.123344 | 2025-09-28 03:11:59.123420 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-28 03:11:59.746965 | debian-bookworm | changed 2025-09-28 03:11:59.753116 | 2025-09-28 03:11:59.753197 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-28 03:12:00.355488 | debian-bookworm | changed 2025-09-28 03:12:00.359899 | 2025-09-28 03:12:00.359971 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-28 03:12:00.373524 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:12:00.378486 | 2025-09-28 03:12:00.378560 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-28 03:12:00.743984 | debian-bookworm -> localhost | changed 2025-09-28 03:12:00.753253 | 2025-09-28 03:12:00.753331 | TASK [add-build-sshkey : Add back temp key] 2025-09-28 03:12:01.062191 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/57c68cfe9ae040a881f6740161a3aba5/work/57c68cfe9ae040a881f6740161a3aba5_id_rsa (zuul-build-sshkey) 2025-09-28 03:12:01.062443 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008556 2025-09-28 03:12:01.069710 | 2025-09-28 03:12:01.069803 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-28 03:12:01.441416 | debian-bookworm | ok 2025-09-28 03:12:01.446889 | 2025-09-28 03:12:01.446982 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-28 03:12:01.483678 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:12:01.493581 | 2025-09-28 03:12:01.493673 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-28 03:12:01.934409 | debian-bookworm | ok 2025-09-28 03:12:01.957290 | 2025-09-28 03:12:01.957436 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-28 03:12:01.997506 | debian-bookworm | ok 2025-09-28 03:12:02.006782 | 2025-09-28 03:12:02.006909 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-28 03:12:02.752299 | debian-bookworm -> localhost | ok 2025-09-28 03:12:02.763332 | 2025-09-28 03:12:02.763445 | TASK [validate-host : Collect information about the host] 2025-09-28 03:12:04.428994 | debian-bookworm | ok 2025-09-28 03:12:04.466732 | 2025-09-28 03:12:04.466888 | TASK [validate-host : Sanitize hostname] 2025-09-28 03:12:04.640384 | debian-bookworm | ok 2025-09-28 03:12:04.705143 | 2025-09-28 03:12:04.705277 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-28 03:12:05.421648 | debian-bookworm -> localhost | changed 2025-09-28 03:12:05.427094 | 2025-09-28 03:12:05.427185 | TASK [validate-host : Collect information about zuul worker] 2025-09-28 03:12:05.799974 | debian-bookworm | ok 2025-09-28 03:12:05.804482 | 2025-09-28 03:12:05.804576 | TASK [validate-host : Write out all zuul information for each host] 2025-09-28 03:12:06.582489 | debian-bookworm -> localhost | changed 2025-09-28 03:12:06.594307 | 2025-09-28 03:12:06.594402 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-28 03:12:06.888154 | debian-bookworm | ok 2025-09-28 03:12:06.893579 | 2025-09-28 03:12:06.893671 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-28 03:12:07.866570 | debian-bookworm | changed: 2025-09-28 03:12:07.866723 | debian-bookworm | cd+++++++++ src/ 2025-09-28 03:12:07.866752 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-28 03:12:07.866772 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-28 03:12:07.866790 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-09-28 03:12:07.866807 | debian-bookworm | =6.1 2025-09-28 03:12:30.705352 | debian-bookworm | Downloading cachetools-6.2.0-py3-none-any.whl (11 kB) 2025-09-28 03:12:30.755381 | debian-bookworm | Collecting chardet>=5.2 2025-09-28 03:12:30.764650 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-09-28 03:12:30.783041 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 13.2 MB/s eta 0:00:00 2025-09-28 03:12:30.821280 | debian-bookworm | Collecting colorama>=0.4.6 2025-09-28 03:12:30.829118 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-09-28 03:12:30.911161 | debian-bookworm | Collecting filelock>=3.18 2025-09-28 03:12:30.920431 | debian-bookworm | Downloading filelock-3.19.1-py3-none-any.whl (15 kB) 2025-09-28 03:12:30.985469 | debian-bookworm | Collecting packaging>=25 2025-09-28 03:12:30.993260 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-09-28 03:12:31.000139 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 13.1 MB/s eta 0:00:00 2025-09-28 03:12:31.040639 | debian-bookworm | Collecting platformdirs>=4.3.8 2025-09-28 03:12:31.048235 | debian-bookworm | Downloading platformdirs-4.4.0-py3-none-any.whl (18 kB) 2025-09-28 03:12:31.102987 | debian-bookworm | Collecting pluggy>=1.6 2025-09-28 03:12:31.110899 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-09-28 03:12:31.147935 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-09-28 03:12:31.155452 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-09-28 03:12:31.283592 | debian-bookworm | Collecting virtualenv>=20.31.2 2025-09-28 03:12:31.291416 | debian-bookworm | Downloading virtualenv-20.34.0-py3-none-any.whl (6.0 MB) 2025-09-28 03:12:31.554306 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 23.1 MB/s eta 0:00:00 2025-09-28 03:12:31.651573 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-09-28 03:12:31.659079 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-09-28 03:12:31.684756 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.3 MB/s eta 0:00:00 2025-09-28 03:12:31.829153 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-09-28 03:12:32.613283 | debian-bookworm | Successfully installed cachetools-6.2.0 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.19.1 packaging-25.0 platformdirs-4.4.0 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.30.2 virtualenv-20.34.0 2025-09-28 03:12:32.764716 | debian-bookworm | ok: Runtime: 0:00:02.716736 2025-09-28 03:12:32.772318 | 2025-09-28 03:12:32.772459 | TASK [ensure-tox : Export installed tox_executable path] 2025-09-28 03:12:32.891961 | debian-bookworm | ok 2025-09-28 03:12:32.919826 | 2025-09-28 03:12:32.920002 | TASK [ensure-tox : Output tox version] 2025-09-28 03:12:33.564958 | 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-09-28 03:12:33.582170 | debian-bookworm | 4.30.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-09-28 03:12:34.018489 | debian-bookworm | ok: Runtime: 0:00:00.256912 2025-09-28 03:12:34.024564 | 2025-09-28 03:12:34.024672 | TASK [ensure-tox : Make global symlink] 2025-09-28 03:12:34.059519 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:12:34.071525 | 2025-09-28 03:12:34.071704 | PLAY RECAP 2025-09-28 03:12:34.071778 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-09-28 03:12:34.071807 | 2025-09-28 03:12:34.887681 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-09-28 03:12:34.888811 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-09-28 03:12:36.457047 | 2025-09-28 03:12:36.457176 | PLAY [all] 2025-09-28 03:12:36.471549 | 2025-09-28 03:12:36.471813 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-09-28 03:12:36.907655 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-09-28 03:12:37.003692 | debian-bookworm | ok: Runtime: 0:00:00.026046 2025-09-28 03:12:37.009103 | 2025-09-28 03:12:37.009246 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-09-28 03:12:37.556351 | debian-bookworm | ok: Runtime: 0:00:00.006596 2025-09-28 03:12:37.560979 | 2025-09-28 03:12:37.561060 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-09-28 03:12:37.901145 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-09-28 03:12:37.903038 | debian-bookworm | sudo: a password is required 2025-09-28 03:12:38.100936 | debian-bookworm | ok: Runtime: 0:00:00.019523 2025-09-28 03:12:38.108803 | 2025-09-28 03:12:38.108877 | TASK [tox : Check to see if the constraints file exists] 2025-09-28 03:12:38.137448 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:12:38.142970 | 2025-09-28 03:12:38.143056 | TASK [tox : Fail if constraints file is missing] 2025-09-28 03:12:38.206382 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:12:38.211530 | 2025-09-28 03:12:38.211619 | TASK [tox : Record file location] 2025-09-28 03:12:38.255104 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:12:38.259936 | 2025-09-28 03:12:38.260015 | TASK [tox : Install tox siblings] 2025-09-28 03:12:38.328708 | debian-bookworm | ok 2025-09-28 03:12:38.335298 | debian-bookworm | included: /var/lib/zuul/builds/57c68cfe9ae040a881f6740161a3aba5/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-09-28 03:12:38.347873 | 2025-09-28 03:12:38.347964 | TASK [tox : Run tox without tests] 2025-09-28 03:12:39.507210 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-09-28 03:12:52.187456 | debian-bookworm | test: OK (13.27 seconds) 2025-09-28 03:12:52.187546 | debian-bookworm | congratulations :) (13.30 seconds) 2025-09-28 03:12:52.411995 | debian-bookworm | ok: Runtime: 0:00:13.587826 2025-09-28 03:12:52.417564 | 2025-09-28 03:12:52.417650 | TASK [tox : Create a tempfile to save tox showconfig] 2025-09-28 03:12:52.920779 | debian-bookworm | changed 2025-09-28 03:12:52.925854 | 2025-09-28 03:12:52.925942 | TASK [tox : Get tox envlist config] 2025-09-28 03:12:53.988473 | debian-bookworm | ok: Runtime: 0:00:00.334083 2025-09-28 03:12:53.993569 | 2025-09-28 03:12:53.993648 | TASK [tox : Install any sibling python packages] 2025-09-28 03:12:54.623270 | debian-bookworm | ok: No setup.cfg, no action needed 2025-09-28 03:12:54.628506 | 2025-09-28 03:12:54.628594 | TASK [tox : Remove tempfile] 2025-09-28 03:12:55.218458 | debian-bookworm | changed 2025-09-28 03:12:55.223055 | 2025-09-28 03:12:55.223133 | TASK [tox : Emit tox command] 2025-09-28 03:12:55.293220 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-09-28 03:12:55.302808 | 2025-09-28 03:12:55.302930 | TASK [tox : Run tox] 2025-09-28 03:12:56.041111 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-09-28 03:12:56.692095 | debian-bookworm | ............... 2025-09-28 03:12:56.692145 | debian-bookworm | ---------------------------------------------------------------------- 2025-09-28 03:12:56.692161 | debian-bookworm | Ran 15 tests in 0.175s 2025-09-28 03:12:56.692166 | debian-bookworm | 2025-09-28 03:12:56.692173 | debian-bookworm | OK 2025-09-28 03:12:56.775566 | debian-bookworm | test: OK (0.78=setup[0.04]+cmd[0.73] seconds) 2025-09-28 03:12:56.775621 | debian-bookworm | congratulations :) (0.80 seconds) 2025-09-28 03:12:56.986858 | debian-bookworm | ok: Runtime: 0:00:01.098964 2025-09-28 03:12:56.991277 | 2025-09-28 03:12:56.991350 | TASK [tox : Look for output] 2025-09-28 03:12:57.383879 | debian-bookworm | ok 2025-09-28 03:12:57.419112 | 2025-09-28 03:12:57.419245 | TASK [tox : Return file comments to Zuul] 2025-09-28 03:12:57.488309 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:12:57.494209 | 2025-09-28 03:12:57.494280 | PLAY RECAP 2025-09-28 03:12:57.494329 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-09-28 03:12:57.494352 | 2025-09-28 03:12:57.779229 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-09-28 03:12:57.780021 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-09-28 03:12:59.061836 | 2025-09-28 03:12:59.061950 | PLAY [all] 2025-09-28 03:12:59.093780 | 2025-09-28 03:12:59.093886 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-09-28 03:12:59.179190 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:12:59.184223 | 2025-09-28 03:12:59.184337 | TASK [fetch-tox-output : Set tox log path for single node] 2025-09-28 03:12:59.255077 | debian-bookworm | ok 2025-09-28 03:12:59.259266 | 2025-09-28 03:12:59.259356 | TASK [fetch-tox-output : Ensure local tox dir] 2025-09-28 03:13:00.444734 | debian-bookworm -> localhost | changed 2025-09-28 03:13:00.450704 | 2025-09-28 03:13:00.450784 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-09-28 03:13:00.503756 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:00.508133 | 2025-09-28 03:13:00.508220 | TASK [fetch-tox-output : Set envlist fact] 2025-09-28 03:13:00.534387 | debian-bookworm | ok 2025-09-28 03:13:00.538920 | 2025-09-28 03:13:00.538989 | TASK [fetch-tox-output : Get tox version] 2025-09-28 03:13:01.179262 | 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-09-28 03:13:01.197767 | debian-bookworm | 4.30.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-09-28 03:13:01.579791 | debian-bookworm | ok: Runtime: 0:00:00.289179 2025-09-28 03:13:01.585464 | 2025-09-28 03:13:01.585545 | TASK [fetch-tox-output : Find all default environments] 2025-09-28 03:13:02.115453 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:02.128569 | 2025-09-28 03:13:02.128733 | TASK [fetch-tox-output : Set envlist fact] 2025-09-28 03:13:02.154717 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:02.176662 | 2025-09-28 03:13:02.176777 | TASK [fetch-tox-output : Find all default environments] 2025-09-28 03:13:02.702970 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:02.713678 | 2025-09-28 03:13:02.713929 | TASK [fetch-tox-output : Set envlist fact] 2025-09-28 03:13:02.739909 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:02.747108 | 2025-09-28 03:13:02.747247 | LOOP [fetch-tox-output : Copy tox logs] 2025-09-28 03:13:02.795209 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:02.820851 | 2025-09-28 03:13:02.820972 | LOOP [fetch-tox-output : Collect tox logs] 2025-09-28 03:13:03.955327 | debian-bookworm | changed: 2025-09-28 03:13:03.955489 | debian-bookworm | created directory /var/lib/zuul/builds/57c68cfe9ae040a881f6740161a3aba5/work/logs/tox/test 2025-09-28 03:13:03.955520 | debian-bookworm | cd+++++++++ ./ 2025-09-28 03:13:03.955541 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-09-28 03:13:03.955568 | 2025-09-28 03:13:03.962691 | 2025-09-28 03:13:03.962789 | PLAY RECAP 2025-09-28 03:13:03.962864 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-09-28 03:13:03.962890 | 2025-09-28 03:13:04.054105 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-09-28 03:13:04.054921 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-09-28 03:13:04.734003 | 2025-09-28 03:13:04.734109 | PLAY [all] 2025-09-28 03:13:04.754814 | 2025-09-28 03:13:04.754975 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-09-28 03:13:04.987632 | debian-bookworm | changed: non-zero return code 2025-09-28 03:13:04.992085 | 2025-09-28 03:13:04.992200 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-09-28 03:13:05.033341 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:05.038035 | 2025-09-28 03:13:05.038122 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-09-28 03:13:05.076294 | 2025-09-28 03:13:05.076444 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-09-28 03:13:05.126100 | 2025-09-28 03:13:05.126481 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-09-28 03:13:05.139105 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:05.143763 | 2025-09-28 03:13:05.143845 | LOOP [fetch-subunit-output : Generate subunit file] 2025-09-28 03:13:05.170731 | 2025-09-28 03:13:05.171002 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-09-28 03:13:05.204524 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:05.209430 | 2025-09-28 03:13:05.209533 | TASK [fetch-subunit-output : Remove the temporary file] 2025-09-28 03:13:05.232752 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:05.237778 | 2025-09-28 03:13:05.237863 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-09-28 03:13:05.250995 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:13:05.256144 | 2025-09-28 03:13:05.256211 | PLAY RECAP 2025-09-28 03:13:05.256250 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-09-28 03:13:05.256270 | 2025-09-28 03:13:05.372645 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-09-28 03:13:05.373430 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-28 03:13:06.293741 | 2025-09-28 03:13:06.293887 | PLAY [Base post] 2025-09-28 03:13:06.313183 | 2025-09-28 03:13:06.313317 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-28 03:13:06.957148 | debian-bookworm | changed 2025-09-28 03:13:06.967008 | 2025-09-28 03:13:06.967098 | PLAY RECAP 2025-09-28 03:13:06.967150 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-28 03:13:06.967226 | 2025-09-28 03:13:07.059965 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-28 03:13:07.060902 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-28 03:13:08.009371 | 2025-09-28 03:13:08.009501 | PLAY [Base post-logs] 2025-09-28 03:13:08.025321 | 2025-09-28 03:13:08.025432 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-28 03:13:08.735035 | localhost | changed 2025-09-28 03:13:08.744795 | 2025-09-28 03:13:08.744917 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-28 03:13:08.769740 | localhost | ok 2025-09-28 03:13:08.772548 | 2025-09-28 03:13:08.772634 | TASK [Set zuul-log-path fact] 2025-09-28 03:13:08.800100 | localhost | ok 2025-09-28 03:13:08.807812 | 2025-09-28 03:13:08.807906 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-28 03:13:08.832565 | localhost | ok 2025-09-28 03:13:08.835654 | 2025-09-28 03:13:08.835746 | TASK [upload-logs : Create log directories] 2025-09-28 03:13:09.310991 | localhost | changed 2025-09-28 03:13:09.314038 | 2025-09-28 03:13:09.314129 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-28 03:13:10.305512 | localhost -> localhost | ok: Runtime: 0:00:00.014748 2025-09-28 03:13:10.308913 | 2025-09-28 03:13:10.308997 | TASK [upload-logs : Upload logs to log server] 2025-09-28 03:13:11.440895 | localhost | Output suppressed because no_log was given 2025-09-28 03:13:11.442493 | 2025-09-28 03:13:11.442573 | LOOP [upload-logs : Compress console log and json output] 2025-09-28 03:13:11.543460 | localhost | skipping: Conditional result was False 2025-09-28 03:13:11.559469 | localhost | skipping: Conditional result was False 2025-09-28 03:13:11.568646 | 2025-09-28 03:13:11.568749 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-28 03:13:11.716060 | localhost | skipping: Conditional result was False 2025-09-28 03:13:11.716282 | 2025-09-28 03:13:11.756213 | localhost | skipping: Conditional result was False 2025-09-28 03:13:11.766470 | 2025-09-28 03:13:11.766580 | LOOP [upload-logs : Upload console log and json output]