2025-09-08 07:12:09.002116 | Job console starting 2025-09-08 07:12:09.028528 | Updating git repos 2025-09-08 07:12:09.086787 | Cloning repos into workspace 2025-09-08 07:12:09.183244 | Restoring repo states 2025-09-08 07:12:09.205399 | Merging changes 2025-09-08 07:12:09.719176 | Checking out repos 2025-09-08 07:12:09.782518 | Preparing playbooks 2025-09-08 07:12:10.820746 | Running Ansible setup 2025-09-08 07:12:16.403042 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-08 07:12:17.425479 | 2025-09-08 07:12:17.425648 | PLAY [Base pre] 2025-09-08 07:12:17.442917 | 2025-09-08 07:12:17.443074 | TASK [Setup log path fact] 2025-09-08 07:12:17.464525 | debian-bookworm | ok 2025-09-08 07:12:17.484773 | 2025-09-08 07:12:17.484940 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-08 07:12:17.535562 | debian-bookworm | ok 2025-09-08 07:12:17.545631 | 2025-09-08 07:12:17.545755 | TASK [emit-job-header : Print job information] 2025-09-08 07:12:17.596400 | # Job Information 2025-09-08 07:12:17.596583 | Ansible Version: 2.16.14 2025-09-08 07:12:17.596619 | Job: tox 2025-09-08 07:12:17.596653 | Pipeline: check 2025-09-08 07:12:17.596676 | Executor: 521e9411259a 2025-09-08 07:12:17.596697 | Triggered by: https://github.com/osism/openstack-image-manager/pull/943 2025-09-08 07:12:17.596720 | Event ID: 1cf618a0-8c83-11f0-82db-be1792f47637 2025-09-08 07:12:17.601819 | 2025-09-08 07:12:17.601938 | LOOP [emit-job-header : Print node information] 2025-09-08 07:12:17.819092 | debian-bookworm | ok: 2025-09-08 07:12:17.819358 | debian-bookworm | # Node Information 2025-09-08 07:12:17.819413 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-08 07:12:17.819440 | debian-bookworm | Hostname: debian 2025-09-08 07:12:17.819463 | debian-bookworm | Username: zuul 2025-09-08 07:12:17.819484 | debian-bookworm | Distro: Debian 12.12 2025-09-08 07:12:17.819509 | debian-bookworm | Provider: regiocloud-a 2025-09-08 07:12:17.819530 | debian-bookworm | Region: 2025-09-08 07:12:17.819551 | debian-bookworm | Label: debian-bookworm 2025-09-08 07:12:17.819571 | debian-bookworm | Product Name: OpenStack Nova 2025-09-08 07:12:17.819590 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec7:fbd9 2025-09-08 07:12:17.841126 | 2025-09-08 07:12:17.841263 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-08 07:12:18.541626 | debian-bookworm -> localhost | changed 2025-09-08 07:12:18.549775 | 2025-09-08 07:12:18.549914 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-08 07:12:19.737457 | debian-bookworm -> localhost | changed 2025-09-08 07:12:19.753739 | 2025-09-08 07:12:19.753851 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-08 07:12:20.221783 | debian-bookworm -> localhost | ok 2025-09-08 07:12:20.227732 | 2025-09-08 07:12:20.227834 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-08 07:12:20.265796 | debian-bookworm | ok 2025-09-08 07:12:20.283094 | debian-bookworm | included: /var/lib/zuul/builds/8c04bbc726a14503a4d9aa9233a50cc8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-08 07:12:20.289065 | 2025-09-08 07:12:20.289151 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-08 07:12:21.959590 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-08 07:12:21.959778 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8c04bbc726a14503a4d9aa9233a50cc8/work/8c04bbc726a14503a4d9aa9233a50cc8_id_rsa 2025-09-08 07:12:21.959816 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8c04bbc726a14503a4d9aa9233a50cc8/work/8c04bbc726a14503a4d9aa9233a50cc8_id_rsa.pub 2025-09-08 07:12:21.959842 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-08 07:12:21.959868 | debian-bookworm -> localhost | SHA256:tpJmKPZl563QcqZGQBjmrDVwj1UBOMQFcAd8Yuykub0 zuul-build-sshkey 2025-09-08 07:12:21.959890 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-08 07:12:21.959926 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-08 07:12:21.959948 | debian-bookworm -> localhost | |o*OB=oo. | 2025-09-08 07:12:21.959970 | debian-bookworm -> localhost | | B@=o | 2025-09-08 07:12:21.959991 | debian-bookworm -> localhost | | **=. | 2025-09-08 07:12:21.960011 | debian-bookworm -> localhost | |oo... | 2025-09-08 07:12:21.960031 | debian-bookworm -> localhost | |.o . S | 2025-09-08 07:12:21.960054 | debian-bookworm -> localhost | |. . ..+ . | 2025-09-08 07:12:21.960074 | debian-bookworm -> localhost | | o...X * | 2025-09-08 07:12:21.960094 | debian-bookworm -> localhost | | .Eo =.X . | 2025-09-08 07:12:21.960114 | debian-bookworm -> localhost | | ... o.. | 2025-09-08 07:12:21.960134 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-08 07:12:21.960181 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.987958 2025-09-08 07:12:21.966130 | 2025-09-08 07:12:21.966217 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-08 07:12:22.003869 | debian-bookworm | ok 2025-09-08 07:12:22.012533 | debian-bookworm | included: /var/lib/zuul/builds/8c04bbc726a14503a4d9aa9233a50cc8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-08 07:12:22.041296 | 2025-09-08 07:12:22.041426 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-08 07:12:22.064748 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:12:22.072106 | 2025-09-08 07:12:22.072212 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-08 07:12:22.710670 | debian-bookworm | changed 2025-09-08 07:12:22.715141 | 2025-09-08 07:12:22.715218 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-08 07:12:22.965465 | debian-bookworm | ok 2025-09-08 07:12:22.972713 | 2025-09-08 07:12:22.972837 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-08 07:12:23.604022 | debian-bookworm | changed 2025-09-08 07:12:23.613164 | 2025-09-08 07:12:23.613290 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-08 07:12:24.238282 | debian-bookworm | changed 2025-09-08 07:12:24.245184 | 2025-09-08 07:12:24.245280 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-08 07:12:24.279107 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:12:24.284714 | 2025-09-08 07:12:24.284873 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-08 07:12:24.693992 | debian-bookworm -> localhost | changed 2025-09-08 07:12:24.704394 | 2025-09-08 07:12:24.704489 | TASK [add-build-sshkey : Add back temp key] 2025-09-08 07:12:25.003327 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8c04bbc726a14503a4d9aa9233a50cc8/work/8c04bbc726a14503a4d9aa9233a50cc8_id_rsa (zuul-build-sshkey) 2025-09-08 07:12:25.003550 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011883 2025-09-08 07:12:25.011446 | 2025-09-08 07:12:25.011541 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-08 07:12:25.437203 | debian-bookworm | ok 2025-09-08 07:12:25.442076 | 2025-09-08 07:12:25.442176 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-08 07:12:25.475414 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:12:25.485257 | 2025-09-08 07:12:25.485345 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-08 07:12:25.927766 | debian-bookworm | ok 2025-09-08 07:12:25.939730 | 2025-09-08 07:12:25.939831 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-08 07:12:25.979464 | debian-bookworm | ok 2025-09-08 07:12:25.984326 | 2025-09-08 07:12:25.984422 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-08 07:12:26.270731 | debian-bookworm -> localhost | ok 2025-09-08 07:12:26.276783 | 2025-09-08 07:12:26.276867 | TASK [validate-host : Collect information about the host] 2025-09-08 07:12:27.367054 | debian-bookworm | ok 2025-09-08 07:12:27.377865 | 2025-09-08 07:12:27.377989 | TASK [validate-host : Sanitize hostname] 2025-09-08 07:12:27.541562 | debian-bookworm | ok 2025-09-08 07:12:27.612264 | 2025-09-08 07:12:27.612454 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-08 07:12:28.248752 | debian-bookworm -> localhost | changed 2025-09-08 07:12:28.254826 | 2025-09-08 07:12:28.254968 | TASK [validate-host : Collect information about zuul worker] 2025-09-08 07:12:28.669161 | debian-bookworm | ok 2025-09-08 07:12:28.674527 | 2025-09-08 07:12:28.674644 | TASK [validate-host : Write out all zuul information for each host] 2025-09-08 07:12:29.545546 | debian-bookworm -> localhost | changed 2025-09-08 07:12:29.556608 | 2025-09-08 07:12:29.556742 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-08 07:12:29.878185 | debian-bookworm | ok 2025-09-08 07:12:29.887615 | 2025-09-08 07:12:29.887756 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-08 07:12:30.826542 | debian-bookworm | changed: 2025-09-08 07:12:30.826814 | debian-bookworm | cd+++++++++ src/ 2025-09-08 07:12:30.826902 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-08 07:12:30.826938 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-08 07:12:30.826967 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-09-08 07:12:30.826994 | debian-bookworm | =6.1 2025-09-08 07:12:53.274571 | debian-bookworm | Downloading cachetools-6.2.0-py3-none-any.whl (11 kB) 2025-09-08 07:12:53.305095 | debian-bookworm | Collecting chardet>=5.2 2025-09-08 07:12:53.313331 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-09-08 07:12:53.331642 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 12.2 MB/s eta 0:00:00 2025-09-08 07:12:53.376933 | debian-bookworm | Collecting colorama>=0.4.6 2025-09-08 07:12:53.385009 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-09-08 07:12:53.445168 | debian-bookworm | Collecting filelock>=3.18 2025-09-08 07:12:53.452472 | debian-bookworm | Downloading filelock-3.19.1-py3-none-any.whl (15 kB) 2025-09-08 07:12:53.509471 | debian-bookworm | Collecting packaging>=25 2025-09-08 07:12:53.516869 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-09-08 07:12:53.524931 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.9 MB/s eta 0:00:00 2025-09-08 07:12:53.564240 | debian-bookworm | Collecting platformdirs>=4.3.8 2025-09-08 07:12:53.571898 | debian-bookworm | Downloading platformdirs-4.4.0-py3-none-any.whl (18 kB) 2025-09-08 07:12:53.611007 | debian-bookworm | Collecting pluggy>=1.6 2025-09-08 07:12:53.618393 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-09-08 07:12:53.668342 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-09-08 07:12:53.676596 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-09-08 07:12:53.795466 | debian-bookworm | Collecting virtualenv>=20.31.2 2025-09-08 07:12:53.801927 | debian-bookworm | Downloading virtualenv-20.34.0-py3-none-any.whl (6.0 MB) 2025-09-08 07:12:54.052398 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 24.3 MB/s eta 0:00:00 2025-09-08 07:12:54.162063 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-09-08 07:12:54.170657 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-09-08 07:12:54.194967 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 24.0 MB/s eta 0:00:00 2025-09-08 07:12:54.348879 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-09-08 07:12:55.257184 | 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-08 07:12:55.713621 | debian-bookworm | ok: Runtime: 0:00:02.894565 2025-09-08 07:12:55.725240 | 2025-09-08 07:12:55.725461 | TASK [ensure-tox : Export installed tox_executable path] 2025-09-08 07:12:55.767082 | debian-bookworm | ok 2025-09-08 07:12:55.772151 | 2025-09-08 07:12:55.772269 | TASK [ensure-tox : Output tox version] 2025-09-08 07:12:56.360252 | 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-08 07:12:56.378646 | debian-bookworm | 4.30.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-09-08 07:12:56.812480 | debian-bookworm | ok: Runtime: 0:00:00.302380 2025-09-08 07:12:56.818333 | 2025-09-08 07:12:56.818456 | TASK [ensure-tox : Make global symlink] 2025-09-08 07:12:56.858335 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:12:56.867336 | 2025-09-08 07:12:56.867448 | PLAY RECAP 2025-09-08 07:12:56.867508 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-09-08 07:12:56.867534 | 2025-09-08 07:12:57.055080 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-09-08 07:12:57.056337 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-09-08 07:12:57.811197 | 2025-09-08 07:12:57.811411 | PLAY [all] 2025-09-08 07:12:57.845810 | 2025-09-08 07:12:57.845959 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-09-08 07:12:58.304381 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-09-08 07:12:58.376256 | debian-bookworm | ok: Runtime: 0:00:00.029061 2025-09-08 07:12:58.381993 | 2025-09-08 07:12:58.382128 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-09-08 07:12:58.910557 | debian-bookworm | ok: Runtime: 0:00:00.008622 2025-09-08 07:12:58.917490 | 2025-09-08 07:12:58.917646 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-09-08 07:12:59.244098 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-09-08 07:12:59.246896 | debian-bookworm | sudo: a password is required 2025-09-08 07:12:59.448077 | debian-bookworm | ok: Runtime: 0:00:00.024010 2025-09-08 07:12:59.459984 | 2025-09-08 07:12:59.460138 | TASK [tox : Check to see if the constraints file exists] 2025-09-08 07:12:59.496703 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:12:59.511955 | 2025-09-08 07:12:59.512153 | TASK [tox : Fail if constraints file is missing] 2025-09-08 07:12:59.563031 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:12:59.578292 | 2025-09-08 07:12:59.578466 | TASK [tox : Record file location] 2025-09-08 07:12:59.604332 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:12:59.615630 | 2025-09-08 07:12:59.615776 | TASK [tox : Install tox siblings] 2025-09-08 07:12:59.650814 | debian-bookworm | ok 2025-09-08 07:12:59.659751 | debian-bookworm | included: /var/lib/zuul/builds/8c04bbc726a14503a4d9aa9233a50cc8/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-09-08 07:12:59.666773 | 2025-09-08 07:12:59.667458 | TASK [tox : Run tox without tests] 2025-09-08 07:13:00.864072 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-09-08 07:13:13.868306 | debian-bookworm | test: OK (13.59 seconds) 2025-09-08 07:13:13.868378 | debian-bookworm | congratulations :) (13.62 seconds) 2025-09-08 07:13:14.231685 | debian-bookworm | ok: Runtime: 0:00:13.926049 2025-09-08 07:13:14.244877 | 2025-09-08 07:13:14.245161 | TASK [tox : Create a tempfile to save tox showconfig] 2025-09-08 07:13:14.681227 | debian-bookworm | changed 2025-09-08 07:13:14.695002 | 2025-09-08 07:13:14.695227 | TASK [tox : Get tox envlist config] 2025-09-08 07:13:15.732389 | debian-bookworm | ok: Runtime: 0:00:00.350973 2025-09-08 07:13:15.745210 | 2025-09-08 07:13:15.745420 | TASK [tox : Install any sibling python packages] 2025-09-08 07:13:16.249296 | debian-bookworm | ok: No setup.cfg, no action needed 2025-09-08 07:13:16.257417 | 2025-09-08 07:13:16.257548 | TASK [tox : Remove tempfile] 2025-09-08 07:13:16.721150 | debian-bookworm | changed 2025-09-08 07:13:16.730131 | 2025-09-08 07:13:16.730274 | TASK [tox : Emit tox command] 2025-09-08 07:13:16.788714 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-09-08 07:13:16.796961 | 2025-09-08 07:13:16.797111 | TASK [tox : Run tox] 2025-09-08 07:13:17.444444 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-09-08 07:13:18.086877 | debian-bookworm | ............... 2025-09-08 07:13:18.086934 | debian-bookworm | ---------------------------------------------------------------------- 2025-09-08 07:13:18.086951 | debian-bookworm | Ran 15 tests in 0.175s 2025-09-08 07:13:18.086956 | debian-bookworm | 2025-09-08 07:13:18.086963 | debian-bookworm | OK 2025-09-08 07:13:18.187256 | debian-bookworm | test: OK (0.79=setup[0.05]+cmd[0.74] seconds) 2025-09-08 07:13:18.187378 | debian-bookworm | congratulations :) (0.82 seconds) 2025-09-08 07:13:18.365833 | debian-bookworm | ok: Runtime: 0:00:01.112108 2025-09-08 07:13:18.378291 | 2025-09-08 07:13:18.378473 | TASK [tox : Look for output] 2025-09-08 07:13:18.831353 | debian-bookworm | ok 2025-09-08 07:13:18.849195 | 2025-09-08 07:13:18.849306 | TASK [tox : Return file comments to Zuul] 2025-09-08 07:13:18.883896 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:18.896458 | 2025-09-08 07:13:18.896564 | PLAY RECAP 2025-09-08 07:13:18.896641 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-09-08 07:13:18.896682 | 2025-09-08 07:13:19.021329 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-09-08 07:13:19.022518 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-09-08 07:13:19.763774 | 2025-09-08 07:13:19.763949 | PLAY [all] 2025-09-08 07:13:19.778930 | 2025-09-08 07:13:19.779055 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-09-08 07:13:19.834343 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:19.840089 | 2025-09-08 07:13:19.840221 | TASK [fetch-tox-output : Set tox log path for single node] 2025-09-08 07:13:19.896156 | debian-bookworm | ok 2025-09-08 07:13:19.903806 | 2025-09-08 07:13:19.903942 | TASK [fetch-tox-output : Ensure local tox dir] 2025-09-08 07:13:20.414674 | debian-bookworm -> localhost | changed 2025-09-08 07:13:20.424849 | 2025-09-08 07:13:20.424983 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-09-08 07:13:20.480647 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:20.491553 | 2025-09-08 07:13:20.491725 | TASK [fetch-tox-output : Set envlist fact] 2025-09-08 07:13:20.539276 | debian-bookworm | ok 2025-09-08 07:13:20.548115 | 2025-09-08 07:13:20.548231 | TASK [fetch-tox-output : Get tox version] 2025-09-08 07:13:21.227560 | 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-08 07:13:21.246929 | debian-bookworm | 4.30.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-09-08 07:13:21.581181 | debian-bookworm | ok: Runtime: 0:00:00.298483 2025-09-08 07:13:21.594050 | 2025-09-08 07:13:21.594220 | TASK [fetch-tox-output : Find all default environments] 2025-09-08 07:13:22.126881 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:22.139510 | 2025-09-08 07:13:22.139707 | TASK [fetch-tox-output : Set envlist fact] 2025-09-08 07:13:22.176509 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:22.192730 | 2025-09-08 07:13:22.192905 | TASK [fetch-tox-output : Find all default environments] 2025-09-08 07:13:22.727403 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:22.740019 | 2025-09-08 07:13:22.740185 | TASK [fetch-tox-output : Set envlist fact] 2025-09-08 07:13:22.776149 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:22.789326 | 2025-09-08 07:13:22.789501 | LOOP [fetch-tox-output : Copy tox logs] 2025-09-08 07:13:22.842387 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:22.858117 | 2025-09-08 07:13:22.858258 | LOOP [fetch-tox-output : Collect tox logs] 2025-09-08 07:13:23.679821 | debian-bookworm | changed: 2025-09-08 07:13:23.680114 | debian-bookworm | created directory /var/lib/zuul/builds/8c04bbc726a14503a4d9aa9233a50cc8/work/logs/tox/test 2025-09-08 07:13:23.680175 | debian-bookworm | cd+++++++++ ./ 2025-09-08 07:13:23.680219 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-09-08 07:13:23.680265 | 2025-09-08 07:13:23.695846 | 2025-09-08 07:13:23.695951 | PLAY RECAP 2025-09-08 07:13:23.696020 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-09-08 07:13:23.696055 | 2025-09-08 07:13:23.831339 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-09-08 07:13:23.834006 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-09-08 07:13:24.583024 | 2025-09-08 07:13:24.583177 | PLAY [all] 2025-09-08 07:13:24.600312 | 2025-09-08 07:13:24.600454 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-09-08 07:13:24.838627 | debian-bookworm | changed: non-zero return code 2025-09-08 07:13:24.846706 | 2025-09-08 07:13:24.846885 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-09-08 07:13:24.882563 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:24.894270 | 2025-09-08 07:13:24.894452 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-09-08 07:13:24.943700 | 2025-09-08 07:13:24.944030 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-09-08 07:13:24.994970 | 2025-09-08 07:13:24.995245 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-09-08 07:13:25.019886 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:25.030965 | 2025-09-08 07:13:25.031117 | LOOP [fetch-subunit-output : Generate subunit file] 2025-09-08 07:13:25.069513 | 2025-09-08 07:13:25.069887 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-09-08 07:13:25.095490 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:25.107008 | 2025-09-08 07:13:25.107165 | TASK [fetch-subunit-output : Remove the temporary file] 2025-09-08 07:13:25.141846 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:25.148236 | 2025-09-08 07:13:25.148351 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-09-08 07:13:25.171861 | debian-bookworm | skipping: Conditional result was False 2025-09-08 07:13:25.180952 | 2025-09-08 07:13:25.181046 | PLAY RECAP 2025-09-08 07:13:25.181105 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-09-08 07:13:25.181135 | 2025-09-08 07:13:25.297391 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-09-08 07:13:25.300094 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-08 07:13:26.084496 | 2025-09-08 07:13:26.084676 | PLAY [Base post] 2025-09-08 07:13:26.098682 | 2025-09-08 07:13:26.098858 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-08 07:13:26.674405 | debian-bookworm | changed 2025-09-08 07:13:26.681055 | 2025-09-08 07:13:26.681167 | PLAY RECAP 2025-09-08 07:13:26.681236 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-08 07:13:26.681299 | 2025-09-08 07:13:26.793062 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-08 07:13:26.795791 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-08 07:13:27.611993 | 2025-09-08 07:13:27.612161 | PLAY [Base post-logs] 2025-09-08 07:13:27.623889 | 2025-09-08 07:13:27.624022 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-08 07:13:28.073768 | localhost | changed 2025-09-08 07:13:28.090471 | 2025-09-08 07:13:28.090647 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-08 07:13:28.117760 | localhost | ok 2025-09-08 07:13:28.122535 | 2025-09-08 07:13:28.122669 | TASK [Set zuul-log-path fact] 2025-09-08 07:13:28.138580 | localhost | ok 2025-09-08 07:13:28.146956 | 2025-09-08 07:13:28.147086 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-08 07:13:28.174459 | localhost | ok 2025-09-08 07:13:28.180437 | 2025-09-08 07:13:28.180611 | TASK [upload-logs : Create log directories] 2025-09-08 07:13:28.655465 | localhost | changed 2025-09-08 07:13:28.658304 | 2025-09-08 07:13:28.658465 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-08 07:13:29.159109 | localhost -> localhost | ok: Runtime: 0:00:00.005154 2025-09-08 07:13:29.163423 | 2025-09-08 07:13:29.163554 | TASK [upload-logs : Upload logs to log server] 2025-09-08 07:13:29.791516 | localhost | Output suppressed because no_log was given 2025-09-08 07:13:29.794970 | 2025-09-08 07:13:29.795148 | LOOP [upload-logs : Compress console log and json output] 2025-09-08 07:13:29.850315 | localhost | skipping: Conditional result was False 2025-09-08 07:13:29.859699 | localhost | skipping: Conditional result was False 2025-09-08 07:13:29.868167 | 2025-09-08 07:13:29.868515 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-08 07:13:29.916754 | localhost | skipping: Conditional result was False 2025-09-08 07:13:29.917073 | 2025-09-08 07:13:29.923881 | localhost | skipping: Conditional result was False 2025-09-08 07:13:29.932538 | 2025-09-08 07:13:29.932830 | LOOP [upload-logs : Upload console log and json output]