2025-11-20 21:52:51.331445 | Job console starting 2025-11-20 21:52:51.347800 | Updating git repos 2025-11-20 21:52:51.399973 | Cloning repos into workspace 2025-11-20 21:52:51.459247 | Restoring repo states 2025-11-20 21:52:51.492160 | Merging changes 2025-11-20 21:52:52.086634 | Checking out repos 2025-11-20 21:52:52.153175 | Preparing playbooks 2025-11-20 21:52:52.757995 | Running Ansible setup 2025-11-20 21:52:58.036063 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-20 21:52:59.470277 | 2025-11-20 21:52:59.470487 | PLAY [Base pre] 2025-11-20 21:52:59.518326 | 2025-11-20 21:52:59.518543 | TASK [Setup log path fact] 2025-11-20 21:52:59.554200 | debian-bookworm | ok 2025-11-20 21:52:59.575468 | 2025-11-20 21:52:59.575677 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-20 21:52:59.606738 | debian-bookworm | ok 2025-11-20 21:52:59.621436 | 2025-11-20 21:52:59.621572 | TASK [emit-job-header : Print job information] 2025-11-20 21:52:59.672662 | # Job Information 2025-11-20 21:52:59.672862 | Ansible Version: 2.16.14 2025-11-20 21:52:59.672896 | Job: tox 2025-11-20 21:52:59.672929 | Pipeline: check 2025-11-20 21:52:59.672951 | Executor: 521e9411259a 2025-11-20 21:52:59.672971 | Triggered by: https://github.com/osism/openstack-image-manager/pull/992 2025-11-20 21:52:59.672993 | Event ID: 3d85fc40-c65b-11f0-9659-b06e4e9be359 2025-11-20 21:52:59.680013 | 2025-11-20 21:52:59.680154 | LOOP [emit-job-header : Print node information] 2025-11-20 21:52:59.792956 | debian-bookworm | ok: 2025-11-20 21:52:59.793159 | debian-bookworm | # Node Information 2025-11-20 21:52:59.793193 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-20 21:52:59.793218 | debian-bookworm | Hostname: debian 2025-11-20 21:52:59.793240 | debian-bookworm | Username: zuul 2025-11-20 21:52:59.793261 | debian-bookworm | Distro: Debian 12.12 2025-11-20 21:52:59.793284 | debian-bookworm | Provider: regiocloud-a 2025-11-20 21:52:59.793304 | debian-bookworm | Region: 2025-11-20 21:52:59.793325 | debian-bookworm | Label: debian-bookworm 2025-11-20 21:52:59.793345 | debian-bookworm | Product Name: OpenStack Nova 2025-11-20 21:52:59.793364 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe37:15d8 2025-11-20 21:52:59.812188 | 2025-11-20 21:52:59.812334 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-20 21:53:00.916294 | debian-bookworm -> localhost | changed 2025-11-20 21:53:00.928661 | 2025-11-20 21:53:00.928805 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-20 21:53:03.138219 | debian-bookworm -> localhost | changed 2025-11-20 21:53:03.152429 | 2025-11-20 21:53:03.152572 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-20 21:53:03.800057 | debian-bookworm -> localhost | ok 2025-11-20 21:53:03.819219 | 2025-11-20 21:53:03.819372 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-20 21:53:03.859321 | debian-bookworm | ok 2025-11-20 21:53:03.906516 | debian-bookworm | included: /var/lib/zuul/builds/883c062b70674712ba36fa78cce2e45f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-20 21:53:03.927838 | 2025-11-20 21:53:03.927971 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-20 21:53:07.291101 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-20 21:53:07.291332 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/883c062b70674712ba36fa78cce2e45f/work/883c062b70674712ba36fa78cce2e45f_id_rsa 2025-11-20 21:53:07.291373 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/883c062b70674712ba36fa78cce2e45f/work/883c062b70674712ba36fa78cce2e45f_id_rsa.pub 2025-11-20 21:53:07.291401 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-20 21:53:07.291429 | debian-bookworm -> localhost | SHA256:3XWI5ux0T10SrWG/8yWgun728hZlrSw2QfLojjlKqXg zuul-build-sshkey 2025-11-20 21:53:07.291453 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-20 21:53:07.291489 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-20 21:53:07.291512 | debian-bookworm -> localhost | | .. | 2025-11-20 21:53:07.291534 | debian-bookworm -> localhost | | . ..oo.| 2025-11-20 21:53:07.291555 | debian-bookworm -> localhost | | =o.+=o| 2025-11-20 21:53:07.291575 | debian-bookworm -> localhost | | ..=+.+o=| 2025-11-20 21:53:07.291613 | debian-bookworm -> localhost | | S...=*..+| 2025-11-20 21:53:07.291641 | debian-bookworm -> localhost | | . oo=.+=.| 2025-11-20 21:53:07.291661 | debian-bookworm -> localhost | | o = ..+ .=| 2025-11-20 21:53:07.291681 | debian-bookworm -> localhost | | .Eo = = . .| 2025-11-20 21:53:07.291701 | debian-bookworm -> localhost | | ... .oo= =o | 2025-11-20 21:53:07.291721 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-20 21:53:07.291779 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.287132 2025-11-20 21:53:07.298550 | 2025-11-20 21:53:07.298712 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-20 21:53:07.349891 | debian-bookworm | ok 2025-11-20 21:53:07.371169 | debian-bookworm | included: /var/lib/zuul/builds/883c062b70674712ba36fa78cce2e45f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-20 21:53:07.391317 | 2025-11-20 21:53:07.391457 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-20 21:53:07.428179 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:53:07.435300 | 2025-11-20 21:53:07.435418 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-20 21:53:08.170089 | debian-bookworm | changed 2025-11-20 21:53:08.175963 | 2025-11-20 21:53:08.176091 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-20 21:53:08.428296 | debian-bookworm | ok 2025-11-20 21:53:08.434173 | 2025-11-20 21:53:08.434295 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-20 21:53:09.086889 | debian-bookworm | changed 2025-11-20 21:53:09.109040 | 2025-11-20 21:53:09.109152 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-20 21:53:09.824509 | debian-bookworm | changed 2025-11-20 21:53:09.832257 | 2025-11-20 21:53:09.833425 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-20 21:53:09.879361 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:53:09.886003 | 2025-11-20 21:53:09.886124 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-20 21:53:10.509161 | debian-bookworm -> localhost | changed 2025-11-20 21:53:10.523314 | 2025-11-20 21:53:10.523442 | TASK [add-build-sshkey : Add back temp key] 2025-11-20 21:53:11.117518 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/883c062b70674712ba36fa78cce2e45f/work/883c062b70674712ba36fa78cce2e45f_id_rsa (zuul-build-sshkey) 2025-11-20 21:53:11.117774 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024826 2025-11-20 21:53:11.126064 | 2025-11-20 21:53:11.126148 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-20 21:53:11.527713 | debian-bookworm | ok 2025-11-20 21:53:11.534375 | 2025-11-20 21:53:11.534493 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-20 21:53:11.558021 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:53:11.568287 | 2025-11-20 21:53:11.568388 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-20 21:53:11.965493 | debian-bookworm | ok 2025-11-20 21:53:11.979704 | 2025-11-20 21:53:11.979809 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-20 21:53:12.038085 | debian-bookworm | ok 2025-11-20 21:53:12.043054 | 2025-11-20 21:53:12.043150 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-20 21:53:12.342773 | debian-bookworm -> localhost | ok 2025-11-20 21:53:12.349495 | 2025-11-20 21:53:12.350429 | TASK [validate-host : Collect information about the host] 2025-11-20 21:53:13.424119 | debian-bookworm | ok 2025-11-20 21:53:13.437325 | 2025-11-20 21:53:13.437467 | TASK [validate-host : Sanitize hostname] 2025-11-20 21:53:13.527656 | debian-bookworm | ok 2025-11-20 21:53:13.585183 | 2025-11-20 21:53:13.585312 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-20 21:53:14.278629 | debian-bookworm -> localhost | changed 2025-11-20 21:53:14.284746 | 2025-11-20 21:53:14.284878 | TASK [validate-host : Collect information about zuul worker] 2025-11-20 21:53:14.721172 | debian-bookworm | ok 2025-11-20 21:53:14.726127 | 2025-11-20 21:53:14.726244 | TASK [validate-host : Write out all zuul information for each host] 2025-11-20 21:53:15.544732 | debian-bookworm -> localhost | changed 2025-11-20 21:53:15.555726 | 2025-11-20 21:53:15.555853 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-20 21:53:15.817263 | debian-bookworm | ok 2025-11-20 21:53:15.823014 | 2025-11-20 21:53:15.823129 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-20 21:53:16.893325 | debian-bookworm | changed: 2025-11-20 21:53:16.893533 | debian-bookworm | cd+++++++++ src/ 2025-11-20 21:53:16.893568 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-20 21:53:16.893634 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-20 21:53:16.893659 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-20 21:53:16.893680 | debian-bookworm | =6.2 2025-11-20 21:53:38.227229 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-11-20 21:53:38.280582 | debian-bookworm | Collecting chardet>=5.2 2025-11-20 21:53:38.296179 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-20 21:53:38.309082 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 24.1 MB/s eta 0:00:00 2025-11-20 21:53:38.363434 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-20 21:53:38.378136 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-20 21:53:38.434277 | debian-bookworm | Collecting filelock>=3.20 2025-11-20 21:53:38.447973 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-20 21:53:38.515898 | debian-bookworm | Collecting packaging>=25 2025-11-20 21:53:38.529887 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-20 21:53:38.538369 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.0 MB/s eta 0:00:00 2025-11-20 21:53:38.587406 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-20 21:53:38.601733 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-20 21:53:38.643924 | debian-bookworm | Collecting pluggy>=1.6 2025-11-20 21:53:38.659136 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-20 21:53:38.715888 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-20 21:53:38.730123 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-20 21:53:38.882912 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-20 21:53:38.898481 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-20 21:53:39.210430 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 20.2 MB/s eta 0:00:00 2025-11-20 21:53:39.314920 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-20 21:53:39.328364 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-20 21:53:39.353486 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.8 MB/s eta 0:00:00 2025-11-20 21:53:39.520893 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-20 21:53:40.407650 | debian-bookworm | Successfully installed cachetools-6.2.2 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.4 2025-11-20 21:53:40.636879 | debian-bookworm | ok: Runtime: 0:00:03.142133 2025-11-20 21:53:40.647727 | 2025-11-20 21:53:40.647890 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-20 21:53:40.697422 | debian-bookworm | ok 2025-11-20 21:53:40.705470 | 2025-11-20 21:53:40.705630 | TASK [ensure-tox : Output tox version] 2025-11-20 21:53:41.214941 | 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-11-20 21:53:41.233324 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-20 21:53:41.746352 | debian-bookworm | ok: Runtime: 0:00:00.296672 2025-11-20 21:53:41.756296 | 2025-11-20 21:53:41.756441 | TASK [ensure-tox : Make global symlink] 2025-11-20 21:53:41.784084 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:53:41.793491 | 2025-11-20 21:53:41.793588 | PLAY RECAP 2025-11-20 21:53:41.793713 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-20 21:53:41.793797 | 2025-11-20 21:53:41.954815 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-20 21:53:41.955958 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-20 21:53:42.876461 | 2025-11-20 21:53:42.876726 | PLAY [all] 2025-11-20 21:53:42.897348 | 2025-11-20 21:53:42.898137 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-20 21:53:43.425755 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-20 21:53:43.930216 | debian-bookworm | ok: Runtime: 0:00:00.033285 2025-11-20 21:53:43.936869 | 2025-11-20 21:53:43.937028 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-20 21:53:44.466469 | debian-bookworm | ok: Runtime: 0:00:00.007073 2025-11-20 21:53:44.481065 | 2025-11-20 21:53:44.481372 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-20 21:53:44.779352 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-20 21:53:44.781366 | debian-bookworm | sudo: a password is required 2025-11-20 21:53:45.022765 | debian-bookworm | ok: Runtime: 0:00:00.022680 2025-11-20 21:53:45.042684 | 2025-11-20 21:53:45.042878 | TASK [tox : Check to see if the constraints file exists] 2025-11-20 21:53:45.069129 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:53:45.078994 | 2025-11-20 21:53:45.079178 | TASK [tox : Fail if constraints file is missing] 2025-11-20 21:53:45.114221 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:53:45.125621 | 2025-11-20 21:53:45.125799 | TASK [tox : Record file location] 2025-11-20 21:53:45.163634 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:53:45.175541 | 2025-11-20 21:53:45.175732 | TASK [tox : Install tox siblings] 2025-11-20 21:53:45.210130 | debian-bookworm | ok 2025-11-20 21:53:45.220541 | debian-bookworm | included: /var/lib/zuul/builds/883c062b70674712ba36fa78cce2e45f/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-20 21:53:45.227108 | 2025-11-20 21:53:45.227241 | TASK [tox : Run tox without tests] 2025-11-20 21:53:46.316331 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-20 21:54:00.250722 | debian-bookworm | test: OK (14.49 seconds) 2025-11-20 21:54:00.250814 | debian-bookworm | congratulations :) (14.51 seconds) 2025-11-20 21:54:00.768478 | debian-bookworm | ok: Runtime: 0:00:14.804342 2025-11-20 21:54:00.778538 | 2025-11-20 21:54:00.778730 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-20 21:54:01.202191 | debian-bookworm | changed 2025-11-20 21:54:01.210893 | 2025-11-20 21:54:01.211044 | TASK [tox : Get tox envlist config] 2025-11-20 21:54:02.244119 | debian-bookworm | ok: Runtime: 0:00:00.330749 2025-11-20 21:54:02.255566 | 2025-11-20 21:54:02.255760 | TASK [tox : Install any sibling python packages] 2025-11-20 21:54:02.744592 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-20 21:54:02.754679 | 2025-11-20 21:54:02.754896 | TASK [tox : Remove tempfile] 2025-11-20 21:54:03.210228 | debian-bookworm | changed 2025-11-20 21:54:03.223908 | 2025-11-20 21:54:03.224083 | TASK [tox : Emit tox command] 2025-11-20 21:54:03.271800 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-20 21:54:03.280489 | 2025-11-20 21:54:03.280681 | TASK [tox : Run tox] 2025-11-20 21:54:03.904525 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-20 21:54:04.528802 | debian-bookworm | ............... 2025-11-20 21:54:04.528875 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-20 21:54:04.528907 | debian-bookworm | Ran 15 tests in 0.172s 2025-11-20 21:54:04.528920 | debian-bookworm | 2025-11-20 21:54:04.528936 | debian-bookworm | OK 2025-11-20 21:54:04.619901 | debian-bookworm | test: OK (0.76=setup[0.04]+cmd[0.71] seconds) 2025-11-20 21:54:04.619978 | debian-bookworm | congratulations :) (0.78 seconds) 2025-11-20 21:54:04.853216 | debian-bookworm | ok: Runtime: 0:00:01.068472 2025-11-20 21:54:04.867177 | 2025-11-20 21:54:04.867366 | TASK [tox : Look for output] 2025-11-20 21:54:05.304727 | debian-bookworm | ok 2025-11-20 21:54:05.323111 | 2025-11-20 21:54:05.323268 | TASK [tox : Return file comments to Zuul] 2025-11-20 21:54:05.368654 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:05.384087 | 2025-11-20 21:54:05.384239 | PLAY RECAP 2025-11-20 21:54:05.384327 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-20 21:54:05.384369 | 2025-11-20 21:54:05.520199 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-20 21:54:05.521368 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-20 21:54:06.287088 | 2025-11-20 21:54:06.287269 | PLAY [all] 2025-11-20 21:54:06.304342 | 2025-11-20 21:54:06.304494 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-20 21:54:06.371215 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:06.385106 | 2025-11-20 21:54:06.385346 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-20 21:54:06.444228 | debian-bookworm | ok 2025-11-20 21:54:06.453255 | 2025-11-20 21:54:06.453419 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-20 21:54:06.994741 | debian-bookworm -> localhost | changed 2025-11-20 21:54:07.002965 | 2025-11-20 21:54:07.003078 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-20 21:54:07.099169 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:07.114504 | 2025-11-20 21:54:07.117515 | TASK [fetch-tox-output : Set envlist fact] 2025-11-20 21:54:07.177903 | debian-bookworm | ok 2025-11-20 21:54:07.195138 | 2025-11-20 21:54:07.195396 | TASK [fetch-tox-output : Get tox version] 2025-11-20 21:54:08.013422 | 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-11-20 21:54:08.032165 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-20 21:54:08.236580 | debian-bookworm | ok: Runtime: 0:00:00.328091 2025-11-20 21:54:08.250552 | 2025-11-20 21:54:08.250785 | TASK [fetch-tox-output : Find all default environments] 2025-11-20 21:54:08.789370 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:08.803340 | 2025-11-20 21:54:08.803580 | TASK [fetch-tox-output : Set envlist fact] 2025-11-20 21:54:08.840768 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:08.862030 | 2025-11-20 21:54:08.862242 | TASK [fetch-tox-output : Find all default environments] 2025-11-20 21:54:09.407357 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:09.421790 | 2025-11-20 21:54:09.421977 | TASK [fetch-tox-output : Set envlist fact] 2025-11-20 21:54:09.457721 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:09.474422 | 2025-11-20 21:54:09.474597 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-20 21:54:09.531844 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:09.549088 | 2025-11-20 21:54:09.549279 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-20 21:54:10.408127 | debian-bookworm | changed: 2025-11-20 21:54:10.408406 | debian-bookworm | created directory /var/lib/zuul/builds/883c062b70674712ba36fa78cce2e45f/work/logs/tox/test 2025-11-20 21:54:10.408464 | debian-bookworm | cd+++++++++ ./ 2025-11-20 21:54:10.408506 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-20 21:54:10.408553 | 2025-11-20 21:54:10.428844 | 2025-11-20 21:54:10.429019 | PLAY RECAP 2025-11-20 21:54:10.429106 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-20 21:54:10.429146 | 2025-11-20 21:54:10.562962 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-20 21:54:10.564275 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-20 21:54:11.318815 | 2025-11-20 21:54:11.319007 | PLAY [all] 2025-11-20 21:54:11.335092 | 2025-11-20 21:54:11.335246 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-20 21:54:11.599273 | debian-bookworm | changed: non-zero return code 2025-11-20 21:54:11.605455 | 2025-11-20 21:54:11.605586 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-20 21:54:11.630695 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:11.639678 | 2025-11-20 21:54:11.639847 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-20 21:54:11.674787 | 2025-11-20 21:54:11.675077 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-20 21:54:11.714398 | 2025-11-20 21:54:11.714726 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-20 21:54:11.740343 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:11.754882 | 2025-11-20 21:54:11.755075 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-20 21:54:11.791983 | 2025-11-20 21:54:11.792328 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-20 21:54:11.817876 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:11.832107 | 2025-11-20 21:54:11.832277 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-20 21:54:11.857025 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:11.866212 | 2025-11-20 21:54:11.866356 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-20 21:54:11.890561 | debian-bookworm | skipping: Conditional result was False 2025-11-20 21:54:11.902631 | 2025-11-20 21:54:11.902737 | PLAY RECAP 2025-11-20 21:54:11.902809 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-20 21:54:11.902887 | 2025-11-20 21:54:12.030663 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-20 21:54:12.035051 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-20 21:54:12.802365 | 2025-11-20 21:54:12.802540 | PLAY [Base post] 2025-11-20 21:54:12.816301 | 2025-11-20 21:54:12.816447 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-20 21:54:13.399830 | debian-bookworm | changed 2025-11-20 21:54:13.409453 | 2025-11-20 21:54:13.409591 | PLAY RECAP 2025-11-20 21:54:13.409698 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-20 21:54:13.409778 | 2025-11-20 21:54:13.560532 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-20 21:54:13.563266 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-20 21:54:14.442136 | 2025-11-20 21:54:14.442307 | PLAY [Base post-logs] 2025-11-20 21:54:14.453492 | 2025-11-20 21:54:14.453671 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-20 21:54:14.939302 | localhost | changed 2025-11-20 21:54:14.954349 | 2025-11-20 21:54:14.954545 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-20 21:54:14.982103 | localhost | ok 2025-11-20 21:54:14.988412 | 2025-11-20 21:54:14.988565 | TASK [Set zuul-log-path fact] 2025-11-20 21:54:15.007092 | localhost | ok 2025-11-20 21:54:15.022859 | 2025-11-20 21:54:15.023015 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-20 21:54:15.051703 | localhost | ok 2025-11-20 21:54:15.057004 | 2025-11-20 21:54:15.057154 | TASK [upload-logs : Create log directories] 2025-11-20 21:54:15.605650 | localhost | changed 2025-11-20 21:54:15.610057 | 2025-11-20 21:54:15.610227 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-20 21:54:16.174463 | localhost -> localhost | ok: Runtime: 0:00:00.007142 2025-11-20 21:54:16.184038 | 2025-11-20 21:54:16.184241 | TASK [upload-logs : Upload logs to log server] 2025-11-20 21:54:16.784515 | localhost | Output suppressed because no_log was given 2025-11-20 21:54:16.788020 | 2025-11-20 21:54:16.788178 | LOOP [upload-logs : Compress console log and json output] 2025-11-20 21:54:16.846906 | localhost | skipping: Conditional result was False 2025-11-20 21:54:16.852873 | localhost | skipping: Conditional result was False 2025-11-20 21:54:16.857510 | 2025-11-20 21:54:16.857661 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-20 21:54:16.919885 | localhost | skipping: Conditional result was False 2025-11-20 21:54:16.920423 | 2025-11-20 21:54:16.924541 | localhost | skipping: Conditional result was False 2025-11-20 21:54:16.937804 | 2025-11-20 21:54:16.938039 | LOOP [upload-logs : Upload console log and json output]