2025-10-28 03:09:17.725534 | Job console starting 2025-10-28 03:09:17.741052 | Updating git repos 2025-10-28 03:09:17.781778 | Cloning repos into workspace 2025-10-28 03:09:17.895611 | Restoring repo states 2025-10-28 03:09:17.904580 | Merging changes 2025-10-28 03:09:17.904598 | Checking out repos 2025-10-28 03:09:17.963499 | Preparing playbooks 2025-10-28 03:09:18.690447 | Running Ansible setup 2025-10-28 03:09:23.161092 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-28 03:09:23.959253 | 2025-10-28 03:09:23.959399 | PLAY [Base pre] 2025-10-28 03:09:23.975282 | 2025-10-28 03:09:23.975408 | TASK [Setup log path fact] 2025-10-28 03:09:24.005097 | debian-bookworm | ok 2025-10-28 03:09:24.022265 | 2025-10-28 03:09:24.022407 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-28 03:09:24.060773 | debian-bookworm | ok 2025-10-28 03:09:24.071026 | 2025-10-28 03:09:24.071163 | TASK [emit-job-header : Print job information] 2025-10-28 03:09:24.111968 | # Job Information 2025-10-28 03:09:24.112195 | Ansible Version: 2.16.14 2025-10-28 03:09:24.112231 | Job: tox 2025-10-28 03:09:24.112264 | Pipeline: periodic-daily 2025-10-28 03:09:24.112287 | Executor: 521e9411259a 2025-10-28 03:09:24.112308 | Triggered by: https://github.com/osism/openstack-image-manager 2025-10-28 03:09:24.112330 | Event ID: affea5d869e24613a9a8e54b932821d6 2025-10-28 03:09:24.117399 | 2025-10-28 03:09:24.117507 | LOOP [emit-job-header : Print node information] 2025-10-28 03:09:24.242268 | debian-bookworm | ok: 2025-10-28 03:09:24.242482 | debian-bookworm | # Node Information 2025-10-28 03:09:24.242521 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-28 03:09:24.242549 | debian-bookworm | Hostname: debian 2025-10-28 03:09:24.242574 | debian-bookworm | Username: zuul 2025-10-28 03:09:24.242597 | debian-bookworm | Distro: Debian 12.12 2025-10-28 03:09:24.242623 | debian-bookworm | Provider: regiocloud-a 2025-10-28 03:09:24.242646 | debian-bookworm | Region: 2025-10-28 03:09:24.242670 | debian-bookworm | Label: debian-bookworm 2025-10-28 03:09:24.242691 | debian-bookworm | Product Name: OpenStack Nova 2025-10-28 03:09:24.242713 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec2:5ce7 2025-10-28 03:09:24.254885 | 2025-10-28 03:09:24.255031 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-28 03:09:24.714528 | debian-bookworm -> localhost | changed 2025-10-28 03:09:24.726231 | 2025-10-28 03:09:24.726360 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-28 03:09:25.841811 | debian-bookworm -> localhost | changed 2025-10-28 03:09:25.853264 | 2025-10-28 03:09:25.853390 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-28 03:09:26.212693 | debian-bookworm -> localhost | ok 2025-10-28 03:09:26.219389 | 2025-10-28 03:09:26.219513 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-28 03:09:26.253549 | debian-bookworm | ok 2025-10-28 03:09:26.326029 | debian-bookworm | included: /var/lib/zuul/builds/37edb88f8b0b428abf8a3e3d9fde8eb1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-28 03:09:26.338678 | 2025-10-28 03:09:26.338800 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-28 03:09:27.485472 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-28 03:09:27.485658 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/37edb88f8b0b428abf8a3e3d9fde8eb1/work/37edb88f8b0b428abf8a3e3d9fde8eb1_id_rsa 2025-10-28 03:09:27.485696 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/37edb88f8b0b428abf8a3e3d9fde8eb1/work/37edb88f8b0b428abf8a3e3d9fde8eb1_id_rsa.pub 2025-10-28 03:09:27.485721 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-28 03:09:27.485743 | debian-bookworm -> localhost | SHA256:bNx+y8cfAwEAN4GPMe9EftenRyDfMLKlOjlBgugWP8E zuul-build-sshkey 2025-10-28 03:09:27.485765 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-28 03:09:27.485796 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-28 03:09:27.485818 | debian-bookworm -> localhost | | o oo=o. | 2025-10-28 03:09:27.485839 | debian-bookworm -> localhost | | o E+o.o + = | 2025-10-28 03:09:27.485859 | debian-bookworm -> localhost | | . o .Oo O.= | 2025-10-28 03:09:27.485879 | debian-bookworm -> localhost | | o o+ *..o.o.+| 2025-10-28 03:09:27.485899 | debian-bookworm -> localhost | | . .S o+.. o.| 2025-10-28 03:09:27.485922 | debian-bookworm -> localhost | | . o= o .| 2025-10-28 03:09:27.485941 | debian-bookworm -> localhost | | .o.. + | 2025-10-28 03:09:27.485960 | debian-bookworm -> localhost | | o .o o| 2025-10-28 03:09:27.486006 | debian-bookworm -> localhost | | o. ..| 2025-10-28 03:09:27.486028 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-28 03:09:27.486073 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.478710 2025-10-28 03:09:27.492109 | 2025-10-28 03:09:27.492193 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-28 03:09:27.529497 | debian-bookworm | ok 2025-10-28 03:09:27.544610 | debian-bookworm | included: /var/lib/zuul/builds/37edb88f8b0b428abf8a3e3d9fde8eb1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-28 03:09:27.561375 | 2025-10-28 03:09:27.561475 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-28 03:09:27.602300 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:09:27.608704 | 2025-10-28 03:09:27.608795 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-28 03:09:28.412713 | debian-bookworm | changed 2025-10-28 03:09:28.417863 | 2025-10-28 03:09:28.417946 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-28 03:09:28.668899 | debian-bookworm | ok 2025-10-28 03:09:28.674089 | 2025-10-28 03:09:28.674170 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-28 03:09:29.264826 | debian-bookworm | changed 2025-10-28 03:09:29.272465 | 2025-10-28 03:09:29.272556 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-28 03:09:29.882998 | debian-bookworm | changed 2025-10-28 03:09:29.892149 | 2025-10-28 03:09:29.892279 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-28 03:09:29.907427 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:09:29.914115 | 2025-10-28 03:09:29.914201 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-28 03:09:30.355721 | debian-bookworm -> localhost | changed 2025-10-28 03:09:30.367326 | 2025-10-28 03:09:30.367436 | TASK [add-build-sshkey : Add back temp key] 2025-10-28 03:09:30.676721 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/37edb88f8b0b428abf8a3e3d9fde8eb1/work/37edb88f8b0b428abf8a3e3d9fde8eb1_id_rsa (zuul-build-sshkey) 2025-10-28 03:09:30.676987 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008645 2025-10-28 03:09:30.685407 | 2025-10-28 03:09:30.685593 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-28 03:09:31.061486 | debian-bookworm | ok 2025-10-28 03:09:31.069557 | 2025-10-28 03:09:31.069682 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-28 03:09:31.094574 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:09:31.105746 | 2025-10-28 03:09:31.105840 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-28 03:09:31.536563 | debian-bookworm | ok 2025-10-28 03:09:31.550762 | 2025-10-28 03:09:31.550918 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-28 03:09:31.588037 | debian-bookworm | ok 2025-10-28 03:09:31.594624 | 2025-10-28 03:09:31.594739 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-28 03:09:31.883606 | debian-bookworm -> localhost | ok 2025-10-28 03:09:31.890752 | 2025-10-28 03:09:31.891061 | TASK [validate-host : Collect information about the host] 2025-10-28 03:09:33.181073 | debian-bookworm | ok 2025-10-28 03:09:33.202871 | 2025-10-28 03:09:33.203095 | TASK [validate-host : Sanitize hostname] 2025-10-28 03:09:33.385980 | debian-bookworm | ok 2025-10-28 03:09:33.451887 | 2025-10-28 03:09:33.452063 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-28 03:09:34.043641 | debian-bookworm -> localhost | changed 2025-10-28 03:09:34.049638 | 2025-10-28 03:09:34.049759 | TASK [validate-host : Collect information about zuul worker] 2025-10-28 03:09:34.464141 | debian-bookworm | ok 2025-10-28 03:09:34.469250 | 2025-10-28 03:09:34.469370 | TASK [validate-host : Write out all zuul information for each host] 2025-10-28 03:09:35.265805 | debian-bookworm -> localhost | changed 2025-10-28 03:09:35.277570 | 2025-10-28 03:09:35.277682 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-28 03:09:35.560177 | debian-bookworm | ok 2025-10-28 03:09:35.566080 | 2025-10-28 03:09:35.566188 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-28 03:09:36.429425 | debian-bookworm | changed: 2025-10-28 03:09:36.429633 | debian-bookworm | cd+++++++++ src/ 2025-10-28 03:09:36.429668 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-28 03:09:36.429693 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-28 03:09:36.429715 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-28 03:09:36.429735 | debian-bookworm | =6.2 2025-10-28 03:10:00.272571 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-10-28 03:10:00.322962 | debian-bookworm | Collecting chardet>=5.2 2025-10-28 03:10:00.337839 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-10-28 03:10:00.364122 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 10.0 MB/s eta 0:00:00 2025-10-28 03:10:00.421484 | debian-bookworm | Collecting colorama>=0.4.6 2025-10-28 03:10:00.435725 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-28 03:10:00.494150 | debian-bookworm | Collecting filelock>=3.20 2025-10-28 03:10:00.509515 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-10-28 03:10:00.581085 | debian-bookworm | Collecting packaging>=25 2025-10-28 03:10:00.594900 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-28 03:10:00.607609 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.2 MB/s eta 0:00:00 2025-10-28 03:10:00.666043 | debian-bookworm | Collecting platformdirs>=4.5 2025-10-28 03:10:00.680073 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-10-28 03:10:00.723239 | debian-bookworm | Collecting pluggy>=1.6 2025-10-28 03:10:00.737317 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-10-28 03:10:00.792385 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-10-28 03:10:00.807048 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-10-28 03:10:00.947615 | debian-bookworm | Collecting virtualenv>=20.34 2025-10-28 03:10:00.961473 | debian-bookworm | Downloading virtualenv-20.35.3-py3-none-any.whl (6.0 MB) 2025-10-28 03:10:01.278244 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 19.2 MB/s eta 0:00:00 2025-10-28 03:10:01.385941 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-10-28 03:10:01.399647 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-10-28 03:10:01.422463 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 23.9 MB/s eta 0:00:00 2025-10-28 03:10:01.574819 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-10-28 03:10:02.490679 | 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.32.0 virtualenv-20.35.3 2025-10-28 03:10:02.811135 | debian-bookworm | ok: Runtime: 0:00:03.261919 2025-10-28 03:10:02.821221 | 2025-10-28 03:10:02.821347 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-28 03:10:02.852175 | debian-bookworm | ok 2025-10-28 03:10:02.857802 | 2025-10-28 03:10:02.857881 | TASK [ensure-tox : Output tox version] 2025-10-28 03:10:03.608864 | 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-28 03:10:03.627839 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-28 03:10:03.886876 | debian-bookworm | ok: Runtime: 0:00:00.294953 2025-10-28 03:10:03.892408 | 2025-10-28 03:10:03.892511 | TASK [ensure-tox : Make global symlink] 2025-10-28 03:10:03.927427 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:03.934211 | 2025-10-28 03:10:03.934292 | PLAY RECAP 2025-10-28 03:10:03.934343 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-28 03:10:03.934369 | 2025-10-28 03:10:04.174102 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-10-28 03:10:04.175152 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-28 03:10:05.124484 | 2025-10-28 03:10:05.124660 | PLAY [all] 2025-10-28 03:10:05.141154 | 2025-10-28 03:10:05.141292 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-10-28 03:10:05.916375 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-28 03:10:06.170194 | debian-bookworm | ok: Runtime: 0:00:00.022090 2025-10-28 03:10:06.176217 | 2025-10-28 03:10:06.176350 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-10-28 03:10:06.739061 | debian-bookworm | ok: Runtime: 0:00:00.006608 2025-10-28 03:10:06.745526 | 2025-10-28 03:10:06.745651 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-10-28 03:10:07.268885 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-28 03:10:07.273138 | debian-bookworm | sudo: a password is required 2025-10-28 03:10:07.279077 | debian-bookworm | ok: Runtime: 0:00:00.023786 2025-10-28 03:10:07.289751 | 2025-10-28 03:10:07.289884 | TASK [tox : Check to see if the constraints file exists] 2025-10-28 03:10:07.344664 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:07.351580 | 2025-10-28 03:10:07.351729 | TASK [tox : Fail if constraints file is missing] 2025-10-28 03:10:07.376066 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:07.382879 | 2025-10-28 03:10:07.383063 | TASK [tox : Record file location] 2025-10-28 03:10:07.417389 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:07.424412 | 2025-10-28 03:10:07.424545 | TASK [tox : Install tox siblings] 2025-10-28 03:10:07.475628 | debian-bookworm | ok 2025-10-28 03:10:07.490243 | debian-bookworm | included: /var/lib/zuul/builds/37edb88f8b0b428abf8a3e3d9fde8eb1/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-10-28 03:10:07.505942 | 2025-10-28 03:10:07.506044 | TASK [tox : Run tox without tests] 2025-10-28 03:10:08.894126 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-10-28 03:10:23.188778 | debian-bookworm | test: OK (15.08 seconds) 2025-10-28 03:10:23.188850 | debian-bookworm | congratulations :) (15.11 seconds) 2025-10-28 03:10:23.562203 | debian-bookworm | ok: Runtime: 0:00:15.158170 2025-10-28 03:10:23.566957 | 2025-10-28 03:10:23.567032 | TASK [tox : Create a tempfile to save tox showconfig] 2025-10-28 03:10:24.011178 | debian-bookworm | changed 2025-10-28 03:10:24.015382 | 2025-10-28 03:10:24.015460 | TASK [tox : Get tox envlist config] 2025-10-28 03:10:25.042747 | debian-bookworm | ok: Runtime: 0:00:00.340249 2025-10-28 03:10:25.049307 | 2025-10-28 03:10:25.049401 | TASK [tox : Install any sibling python packages] 2025-10-28 03:10:25.576354 | debian-bookworm | ok: No setup.cfg, no action needed 2025-10-28 03:10:25.581543 | 2025-10-28 03:10:25.581620 | TASK [tox : Remove tempfile] 2025-10-28 03:10:25.984018 | debian-bookworm | changed 2025-10-28 03:10:25.992556 | 2025-10-28 03:10:25.992669 | TASK [tox : Emit tox command] 2025-10-28 03:10:26.036226 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-10-28 03:10:26.044405 | 2025-10-28 03:10:26.044517 | TASK [tox : Run tox] 2025-10-28 03:10:26.644991 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-10-28 03:10:27.290886 | debian-bookworm | ............... 2025-10-28 03:10:27.290942 | debian-bookworm | ---------------------------------------------------------------------- 2025-10-28 03:10:27.290958 | debian-bookworm | Ran 15 tests in 0.175s 2025-10-28 03:10:27.290963 | debian-bookworm | 2025-10-28 03:10:27.290970 | debian-bookworm | OK 2025-10-28 03:10:27.379939 | debian-bookworm | test: OK (0.78=setup[0.04]+cmd[0.73] seconds) 2025-10-28 03:10:27.379999 | debian-bookworm | congratulations :) (0.80 seconds) 2025-10-28 03:10:27.592620 | debian-bookworm | ok: Runtime: 0:00:01.083270 2025-10-28 03:10:27.608036 | 2025-10-28 03:10:27.608208 | TASK [tox : Look for output] 2025-10-28 03:10:28.008634 | debian-bookworm | ok 2025-10-28 03:10:28.022920 | 2025-10-28 03:10:28.023022 | TASK [tox : Return file comments to Zuul] 2025-10-28 03:10:28.056199 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:28.065543 | 2025-10-28 03:10:28.065628 | PLAY RECAP 2025-10-28 03:10:28.065700 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-28 03:10:28.065734 | 2025-10-28 03:10:28.155050 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-28 03:10:28.156590 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-28 03:10:28.904504 | 2025-10-28 03:10:28.904642 | PLAY [all] 2025-10-28 03:10:28.918510 | 2025-10-28 03:10:28.918615 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-10-28 03:10:28.973427 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:28.986033 | 2025-10-28 03:10:28.986216 | TASK [fetch-tox-output : Set tox log path for single node] 2025-10-28 03:10:29.040590 | debian-bookworm | ok 2025-10-28 03:10:29.052817 | 2025-10-28 03:10:29.053101 | TASK [fetch-tox-output : Ensure local tox dir] 2025-10-28 03:10:29.455253 | debian-bookworm -> localhost | changed 2025-10-28 03:10:29.462347 | 2025-10-28 03:10:29.462443 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-10-28 03:10:29.505801 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:29.511176 | 2025-10-28 03:10:29.511279 | TASK [fetch-tox-output : Set envlist fact] 2025-10-28 03:10:29.538598 | debian-bookworm | ok 2025-10-28 03:10:29.545004 | 2025-10-28 03:10:29.545096 | TASK [fetch-tox-output : Get tox version] 2025-10-28 03:10:30.165091 | 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-28 03:10:30.183584 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-28 03:10:30.574613 | debian-bookworm | ok: Runtime: 0:00:00.288250 2025-10-28 03:10:30.587720 | 2025-10-28 03:10:30.587918 | TASK [fetch-tox-output : Find all default environments] 2025-10-28 03:10:31.121405 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:31.135254 | 2025-10-28 03:10:31.135413 | TASK [fetch-tox-output : Set envlist fact] 2025-10-28 03:10:31.172222 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:31.183630 | 2025-10-28 03:10:31.183786 | TASK [fetch-tox-output : Find all default environments] 2025-10-28 03:10:31.737204 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:31.748184 | 2025-10-28 03:10:31.748343 | TASK [fetch-tox-output : Set envlist fact] 2025-10-28 03:10:31.774607 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:31.786163 | 2025-10-28 03:10:31.786303 | LOOP [fetch-tox-output : Copy tox logs] 2025-10-28 03:10:31.834172 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:31.853353 | 2025-10-28 03:10:31.853499 | LOOP [fetch-tox-output : Collect tox logs] 2025-10-28 03:10:32.688764 | debian-bookworm | changed: 2025-10-28 03:10:32.689059 | debian-bookworm | created directory /var/lib/zuul/builds/37edb88f8b0b428abf8a3e3d9fde8eb1/work/logs/tox/test 2025-10-28 03:10:32.689116 | debian-bookworm | cd+++++++++ ./ 2025-10-28 03:10:32.689156 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-10-28 03:10:32.689201 | 2025-10-28 03:10:32.697446 | 2025-10-28 03:10:32.697536 | PLAY RECAP 2025-10-28 03:10:32.697589 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-28 03:10:32.697612 | 2025-10-28 03:10:32.859159 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-28 03:10:32.860389 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-28 03:10:33.899833 | 2025-10-28 03:10:33.900048 | PLAY [all] 2025-10-28 03:10:33.919310 | 2025-10-28 03:10:33.919465 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-10-28 03:10:34.151675 | debian-bookworm | changed: non-zero return code 2025-10-28 03:10:34.166587 | 2025-10-28 03:10:34.166742 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-10-28 03:10:34.196153 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:34.206975 | 2025-10-28 03:10:34.207288 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-10-28 03:10:34.255356 | 2025-10-28 03:10:34.255601 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-10-28 03:10:34.293730 | 2025-10-28 03:10:34.293973 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-10-28 03:10:34.318340 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:34.324558 | 2025-10-28 03:10:34.324680 | LOOP [fetch-subunit-output : Generate subunit file] 2025-10-28 03:10:34.361525 | 2025-10-28 03:10:34.361993 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-10-28 03:10:34.389551 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:34.398778 | 2025-10-28 03:10:34.398949 | TASK [fetch-subunit-output : Remove the temporary file] 2025-10-28 03:10:34.436541 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:34.452101 | 2025-10-28 03:10:34.452223 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-10-28 03:10:34.484157 | debian-bookworm | skipping: Conditional result was False 2025-10-28 03:10:34.496155 | 2025-10-28 03:10:34.496261 | PLAY RECAP 2025-10-28 03:10:34.496314 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-28 03:10:34.496340 | 2025-10-28 03:10:34.735864 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-28 03:10:34.737014 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-28 03:10:35.700652 | 2025-10-28 03:10:35.700827 | PLAY [Base post] 2025-10-28 03:10:35.716956 | 2025-10-28 03:10:35.717104 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-28 03:10:36.509375 | debian-bookworm | changed 2025-10-28 03:10:36.525431 | 2025-10-28 03:10:36.527623 | PLAY RECAP 2025-10-28 03:10:36.527735 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-28 03:10:36.527800 | 2025-10-28 03:10:36.758324 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-28 03:10:36.759482 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-28 03:10:37.842681 | 2025-10-28 03:10:37.842915 | PLAY [Base post-logs] 2025-10-28 03:10:37.855035 | 2025-10-28 03:10:37.855187 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-28 03:10:38.293577 | localhost | changed 2025-10-28 03:10:38.311012 | 2025-10-28 03:10:38.311183 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-28 03:10:38.339724 | localhost | ok 2025-10-28 03:10:38.349237 | 2025-10-28 03:10:38.349414 | TASK [Set zuul-log-path fact] 2025-10-28 03:10:38.366096 | localhost | ok 2025-10-28 03:10:38.379249 | 2025-10-28 03:10:38.379379 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-28 03:10:38.405183 | localhost | ok 2025-10-28 03:10:38.409788 | 2025-10-28 03:10:38.409947 | TASK [upload-logs : Create log directories] 2025-10-28 03:10:38.890706 | localhost | changed 2025-10-28 03:10:38.896723 | 2025-10-28 03:10:38.896940 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-28 03:10:39.383723 | localhost -> localhost | ok: Runtime: 0:00:00.007700 2025-10-28 03:10:39.391712 | 2025-10-28 03:10:39.391911 | TASK [upload-logs : Upload logs to log server] 2025-10-28 03:10:39.927212 | localhost | Output suppressed because no_log was given 2025-10-28 03:10:39.952406 | 2025-10-28 03:10:39.952695 | LOOP [upload-logs : Compress console log and json output] 2025-10-28 03:10:40.009527 | localhost | skipping: Conditional result was False 2025-10-28 03:10:40.014480 | localhost | skipping: Conditional result was False 2025-10-28 03:10:40.029689 | 2025-10-28 03:10:40.029852 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-28 03:10:40.098094 | localhost | skipping: Conditional result was False 2025-10-28 03:10:40.098388 | 2025-10-28 03:10:40.103824 | localhost | skipping: Conditional result was False 2025-10-28 03:10:40.107576 | 2025-10-28 03:10:40.107684 | LOOP [upload-logs : Upload console log and json output]