2025-07-20 03:10:36.378951 | Job console starting 2025-07-20 03:10:36.399500 | Updating git repos 2025-07-20 03:10:36.479536 | Cloning repos into workspace 2025-07-20 03:10:36.558018 | Restoring repo states 2025-07-20 03:10:36.584862 | Merging changes 2025-07-20 03:10:36.584881 | Checking out repos 2025-07-20 03:10:36.718959 | Preparing playbooks 2025-07-20 03:10:38.037576 | Running Ansible setup 2025-07-20 03:10:44.212670 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-20 03:10:45.175490 | 2025-07-20 03:10:45.175655 | PLAY [Base pre] 2025-07-20 03:10:45.196454 | 2025-07-20 03:10:45.196610 | TASK [Setup log path fact] 2025-07-20 03:10:45.215817 | debian-bookworm | ok 2025-07-20 03:10:45.251278 | 2025-07-20 03:10:45.251480 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-20 03:10:45.305433 | debian-bookworm | ok 2025-07-20 03:10:45.320979 | 2025-07-20 03:10:45.321113 | TASK [emit-job-header : Print job information] 2025-07-20 03:10:45.399007 | # Job Information 2025-07-20 03:10:45.399203 | Ansible Version: 2.16.14 2025-07-20 03:10:45.399241 | Job: tox 2025-07-20 03:10:45.399274 | Pipeline: periodic-daily 2025-07-20 03:10:45.399298 | Executor: 521e9411259a 2025-07-20 03:10:45.399319 | Triggered by: https://github.com/osism/openstack-image-manager 2025-07-20 03:10:45.399342 | Event ID: 95077d80f1a9455f9714e65e4498c5cf 2025-07-20 03:10:45.404563 | 2025-07-20 03:10:45.404682 | LOOP [emit-job-header : Print node information] 2025-07-20 03:10:45.534508 | debian-bookworm | ok: 2025-07-20 03:10:45.535060 | debian-bookworm | # Node Information 2025-07-20 03:10:45.535131 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-20 03:10:45.535159 | debian-bookworm | Hostname: debian 2025-07-20 03:10:45.535182 | debian-bookworm | Username: zuul 2025-07-20 03:10:45.535202 | debian-bookworm | Distro: Debian 12.11 2025-07-20 03:10:45.535226 | debian-bookworm | Provider: regiocloud-a 2025-07-20 03:10:45.535247 | debian-bookworm | Region: 2025-07-20 03:10:45.535268 | debian-bookworm | Label: debian-bookworm 2025-07-20 03:10:45.535288 | debian-bookworm | Product Name: OpenStack Nova 2025-07-20 03:10:45.535307 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2e:b313 2025-07-20 03:10:45.573956 | 2025-07-20 03:10:45.574120 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-20 03:10:46.277514 | debian-bookworm -> localhost | changed 2025-07-20 03:10:46.284821 | 2025-07-20 03:10:46.284928 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-20 03:10:47.601990 | debian-bookworm -> localhost | changed 2025-07-20 03:10:47.612312 | 2025-07-20 03:10:47.612439 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-20 03:10:48.057572 | debian-bookworm -> localhost | ok 2025-07-20 03:10:48.063589 | 2025-07-20 03:10:48.063694 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-20 03:10:48.112021 | debian-bookworm | ok 2025-07-20 03:10:48.141856 | debian-bookworm | included: /var/lib/zuul/builds/c4e22111c62148b0b02f0ade2f589dcb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-20 03:10:48.158305 | 2025-07-20 03:10:48.158419 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-20 03:10:52.065761 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-20 03:10:52.066238 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c4e22111c62148b0b02f0ade2f589dcb/work/c4e22111c62148b0b02f0ade2f589dcb_id_rsa 2025-07-20 03:10:52.066371 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c4e22111c62148b0b02f0ade2f589dcb/work/c4e22111c62148b0b02f0ade2f589dcb_id_rsa.pub 2025-07-20 03:10:52.066452 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-20 03:10:52.066526 | debian-bookworm -> localhost | SHA256:pYcisvg/5uNz9nNCdDv7+hu5RnvE37J9ewIfV2eKrYA zuul-build-sshkey 2025-07-20 03:10:52.066591 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-20 03:10:52.066676 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-20 03:10:52.066740 | debian-bookworm -> localhost | | | 2025-07-20 03:10:52.066802 | debian-bookworm -> localhost | | | 2025-07-20 03:10:52.066895 | debian-bookworm -> localhost | | . | 2025-07-20 03:10:52.066955 | debian-bookworm -> localhost | | .+. +| 2025-07-20 03:10:52.067012 | debian-bookworm -> localhost | | . . ..So.. + oo| 2025-07-20 03:10:52.067078 | debian-bookworm -> localhost | | . o . .E.+ +.* .| 2025-07-20 03:10:52.067135 | debian-bookworm -> localhost | |. . . =o* +.| 2025-07-20 03:10:52.067192 | debian-bookworm -> localhost | | . = o o o +o=.=| 2025-07-20 03:10:52.067253 | debian-bookworm -> localhost | | .=+* ..+.==o.==| 2025-07-20 03:10:52.067311 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-20 03:10:52.067488 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.384155 2025-07-20 03:10:52.081792 | 2025-07-20 03:10:52.081943 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-20 03:10:52.118885 | debian-bookworm | ok 2025-07-20 03:10:52.131849 | debian-bookworm | included: /var/lib/zuul/builds/c4e22111c62148b0b02f0ade2f589dcb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-20 03:10:52.140990 | 2025-07-20 03:10:52.141083 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-20 03:10:52.164684 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:10:52.170720 | 2025-07-20 03:10:52.170826 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-20 03:10:52.870557 | debian-bookworm | changed 2025-07-20 03:10:52.876257 | 2025-07-20 03:10:52.876359 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-20 03:10:53.116830 | debian-bookworm | ok 2025-07-20 03:10:53.123017 | 2025-07-20 03:10:53.123116 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-20 03:10:53.776733 | debian-bookworm | changed 2025-07-20 03:10:53.796577 | 2025-07-20 03:10:53.796690 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-20 03:10:54.530283 | debian-bookworm | changed 2025-07-20 03:10:54.547418 | 2025-07-20 03:10:54.547543 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-20 03:10:54.594276 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:10:54.606727 | 2025-07-20 03:10:54.606963 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-20 03:10:55.770165 | debian-bookworm -> localhost | changed 2025-07-20 03:10:55.787669 | 2025-07-20 03:10:55.787807 | TASK [add-build-sshkey : Add back temp key] 2025-07-20 03:10:56.456261 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c4e22111c62148b0b02f0ade2f589dcb/work/c4e22111c62148b0b02f0ade2f589dcb_id_rsa (zuul-build-sshkey) 2025-07-20 03:10:56.456566 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021553 2025-07-20 03:10:56.465688 | 2025-07-20 03:10:56.465818 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-20 03:10:56.949992 | debian-bookworm | ok 2025-07-20 03:10:56.955844 | 2025-07-20 03:10:56.955975 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-20 03:10:57.008767 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:10:57.020980 | 2025-07-20 03:10:57.021115 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-20 03:10:57.764538 | debian-bookworm | ok 2025-07-20 03:10:57.786998 | 2025-07-20 03:10:57.787160 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-20 03:10:57.843091 | debian-bookworm | ok 2025-07-20 03:10:57.848490 | 2025-07-20 03:10:57.848618 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-20 03:10:58.294427 | debian-bookworm -> localhost | ok 2025-07-20 03:10:58.301664 | 2025-07-20 03:10:58.301785 | TASK [validate-host : Collect information about the host] 2025-07-20 03:10:59.503989 | debian-bookworm | ok 2025-07-20 03:10:59.523697 | 2025-07-20 03:10:59.523807 | TASK [validate-host : Sanitize hostname] 2025-07-20 03:10:59.622636 | debian-bookworm | ok 2025-07-20 03:10:59.685602 | 2025-07-20 03:10:59.685705 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-20 03:11:00.574556 | debian-bookworm -> localhost | changed 2025-07-20 03:11:00.580300 | 2025-07-20 03:11:00.580441 | TASK [validate-host : Collect information about zuul worker] 2025-07-20 03:11:01.084826 | debian-bookworm | ok 2025-07-20 03:11:01.089869 | 2025-07-20 03:11:01.089967 | TASK [validate-host : Write out all zuul information for each host] 2025-07-20 03:11:02.397603 | debian-bookworm -> localhost | changed 2025-07-20 03:11:02.408351 | 2025-07-20 03:11:02.408456 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-20 03:11:02.714099 | debian-bookworm | ok 2025-07-20 03:11:02.719353 | 2025-07-20 03:11:02.719440 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-20 03:11:03.999122 | debian-bookworm | changed: 2025-07-20 03:11:03.999283 | debian-bookworm | cd+++++++++ src/ 2025-07-20 03:11:03.999316 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-20 03:11:03.999367 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-20 03:11:03.999390 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-07-20 03:11:03.999410 | debian-bookworm | =5.5.1 2025-07-20 03:11:27.104566 | debian-bookworm | Downloading cachetools-6.1.0-py3-none-any.whl (11 kB) 2025-07-20 03:11:27.174455 | debian-bookworm | Collecting chardet>=5.2 2025-07-20 03:11:27.183179 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-07-20 03:11:27.270787 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 2.3 MB/s eta 0:00:00 2025-07-20 03:11:27.315857 | debian-bookworm | Collecting colorama>=0.4.6 2025-07-20 03:11:27.324194 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-07-20 03:11:27.401364 | debian-bookworm | Collecting filelock>=3.16.1 2025-07-20 03:11:27.409347 | debian-bookworm | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-07-20 03:11:27.455046 | debian-bookworm | Collecting packaging>=24.2 2025-07-20 03:11:27.462658 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-07-20 03:11:27.470398 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 11.4 MB/s eta 0:00:00 2025-07-20 03:11:27.514906 | debian-bookworm | Collecting platformdirs>=4.3.6 2025-07-20 03:11:27.522860 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-07-20 03:11:27.584394 | debian-bookworm | Collecting pluggy>=1.5 2025-07-20 03:11:27.591850 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-07-20 03:11:27.672548 | debian-bookworm | Collecting pyproject-api>=1.8 2025-07-20 03:11:27.680951 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-07-20 03:11:27.834175 | debian-bookworm | Collecting virtualenv>=20.31 2025-07-20 03:11:27.842317 | debian-bookworm | Downloading virtualenv-20.31.2-py3-none-any.whl (6.1 MB) 2025-07-20 03:11:28.113724 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.1/6.1 MB 22.8 MB/s eta 0:00:00 2025-07-20 03:11:28.241783 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-07-20 03:11:28.251058 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-07-20 03:11:28.289999 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 13.2 MB/s eta 0:00:00 2025-07-20 03:11:28.464771 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-07-20 03:11:29.340890 | debian-bookworm | Successfully installed cachetools-6.1.0 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.18.0 packaging-25.0 platformdirs-4.3.8 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.27.0 virtualenv-20.31.2 2025-07-20 03:11:29.950931 | debian-bookworm | ok: Runtime: 0:00:03.178419 2025-07-20 03:11:29.955601 | 2025-07-20 03:11:29.955688 | TASK [ensure-tox : Export installed tox_executable path] 2025-07-20 03:11:29.993627 | debian-bookworm | ok 2025-07-20 03:11:29.997434 | 2025-07-20 03:11:29.997506 | TASK [ensure-tox : Output tox version] 2025-07-20 03:11:30.527510 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-07-20 03:11:30.546199 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-07-20 03:11:31.053334 | debian-bookworm | ok: Runtime: 0:00:00.298442 2025-07-20 03:11:31.059082 | 2025-07-20 03:11:31.059166 | TASK [ensure-tox : Make global symlink] 2025-07-20 03:11:31.071914 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:31.079022 | 2025-07-20 03:11:31.079097 | PLAY RECAP 2025-07-20 03:11:31.079158 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-07-20 03:11:31.079188 | 2025-07-20 03:11:31.314511 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-07-20 03:11:31.315549 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-07-20 03:11:32.297332 | 2025-07-20 03:11:32.297445 | PLAY [all] 2025-07-20 03:11:32.310099 | 2025-07-20 03:11:32.310203 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-07-20 03:11:32.818407 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-07-20 03:11:32.869213 | debian-bookworm | ok: Runtime: 0:00:00.025372 2025-07-20 03:11:32.873563 | 2025-07-20 03:11:32.873665 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-07-20 03:11:33.437973 | debian-bookworm | ok: Runtime: 0:00:00.007302 2025-07-20 03:11:33.443719 | 2025-07-20 03:11:33.443845 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-07-20 03:11:33.824459 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-07-20 03:11:33.829981 | debian-bookworm | sudo: a password is required 2025-07-20 03:11:33.987028 | debian-bookworm | ok: Runtime: 0:00:00.026681 2025-07-20 03:11:34.005714 | 2025-07-20 03:11:34.005802 | TASK [tox : Check to see if the constraints file exists] 2025-07-20 03:11:34.059415 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:34.066799 | 2025-07-20 03:11:34.066902 | TASK [tox : Fail if constraints file is missing] 2025-07-20 03:11:34.085767 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:34.091540 | 2025-07-20 03:11:34.091626 | TASK [tox : Record file location] 2025-07-20 03:11:34.114040 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:34.118553 | 2025-07-20 03:11:34.118632 | TASK [tox : Install tox siblings] 2025-07-20 03:11:34.136513 | debian-bookworm | ok 2025-07-20 03:11:34.158902 | debian-bookworm | included: /var/lib/zuul/builds/c4e22111c62148b0b02f0ade2f589dcb/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-07-20 03:11:34.163960 | 2025-07-20 03:11:34.164046 | TASK [tox : Run tox without tests] 2025-07-20 03:11:35.345242 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-07-20 03:11:49.482046 | debian-bookworm | test: OK (14.71 seconds) 2025-07-20 03:11:49.482129 | debian-bookworm | congratulations :) (14.78 seconds) 2025-07-20 03:11:49.708772 | debian-bookworm | ok: Runtime: 0:00:15.023635 2025-07-20 03:11:49.715905 | 2025-07-20 03:11:49.716046 | TASK [tox : Create a tempfile to save tox showconfig] 2025-07-20 03:11:50.240357 | debian-bookworm | changed 2025-07-20 03:11:50.245927 | 2025-07-20 03:11:50.246051 | TASK [tox : Get tox envlist config] 2025-07-20 03:11:51.288685 | debian-bookworm | ok: Runtime: 0:00:00.342548 2025-07-20 03:11:51.294595 | 2025-07-20 03:11:51.294687 | TASK [tox : Install any sibling python packages] 2025-07-20 03:11:51.729006 | debian-bookworm | ok: No setup.cfg, no action needed 2025-07-20 03:11:51.734938 | 2025-07-20 03:11:51.735024 | TASK [tox : Remove tempfile] 2025-07-20 03:11:52.161130 | debian-bookworm | changed 2025-07-20 03:11:52.166505 | 2025-07-20 03:11:52.166592 | TASK [tox : Emit tox command] 2025-07-20 03:11:52.203973 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-07-20 03:11:52.208798 | 2025-07-20 03:11:52.208888 | TASK [tox : Run tox] 2025-07-20 03:11:52.829587 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-07-20 03:11:53.320299 | debian-bookworm | /home/zuul/src/github.com/osism/openstack-image-manager/openstack_image_manager/__init__.py:5: UserWarning: pkg_resources is deprecated as an API. See https://setuptools.pypa.io/en/latest/pkg_resources.html. The pkg_resources package is slated for removal as early as 2025-11-30. Refrain from using this package or pin to Setuptools<81. 2025-07-20 03:11:53.320379 | debian-bookworm | from pkg_resources import get_distribution, DistributionNotFound 2025-07-20 03:11:53.643803 | debian-bookworm | ............... 2025-07-20 03:11:53.643867 | debian-bookworm | ---------------------------------------------------------------------- 2025-07-20 03:11:53.643875 | debian-bookworm | Ran 15 tests in 0.175s 2025-07-20 03:11:53.643881 | debian-bookworm | 2025-07-20 03:11:53.643922 | debian-bookworm | OK 2025-07-20 03:11:53.771239 | debian-bookworm | test: OK (0.98=setup[0.04]+cmd[0.94] seconds) 2025-07-20 03:11:53.771295 | debian-bookworm | congratulations :) (1.05 seconds) 2025-07-20 03:11:54.277289 | debian-bookworm | ok: Runtime: 0:00:01.294480 2025-07-20 03:11:54.283758 | 2025-07-20 03:11:54.283848 | TASK [tox : Look for output] 2025-07-20 03:11:54.673779 | debian-bookworm | ok 2025-07-20 03:11:54.689167 | 2025-07-20 03:11:54.689313 | TASK [tox : Return file comments to Zuul] 2025-07-20 03:11:54.713366 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:54.719380 | 2025-07-20 03:11:54.719447 | PLAY RECAP 2025-07-20 03:11:54.719496 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-07-20 03:11:54.719521 | 2025-07-20 03:11:54.808690 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-07-20 03:11:54.809660 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-07-20 03:11:55.549816 | 2025-07-20 03:11:55.549978 | PLAY [all] 2025-07-20 03:11:55.565595 | 2025-07-20 03:11:55.565739 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-07-20 03:11:55.610719 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:55.617592 | 2025-07-20 03:11:55.617789 | TASK [fetch-tox-output : Set tox log path for single node] 2025-07-20 03:11:55.659872 | debian-bookworm | ok 2025-07-20 03:11:55.665337 | 2025-07-20 03:11:55.665460 | TASK [fetch-tox-output : Ensure local tox dir] 2025-07-20 03:11:56.133284 | debian-bookworm -> localhost | changed 2025-07-20 03:11:56.141218 | 2025-07-20 03:11:56.141390 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-07-20 03:11:56.195967 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:56.207653 | 2025-07-20 03:11:56.207824 | TASK [fetch-tox-output : Set envlist fact] 2025-07-20 03:11:56.256246 | debian-bookworm | ok 2025-07-20 03:11:56.266095 | 2025-07-20 03:11:56.266249 | TASK [fetch-tox-output : Get tox version] 2025-07-20 03:11:56.938530 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-07-20 03:11:56.956913 | debian-bookworm | 4.27.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-07-20 03:11:57.300476 | debian-bookworm | ok: Runtime: 0:00:00.300303 2025-07-20 03:11:57.306361 | 2025-07-20 03:11:57.306479 | TASK [fetch-tox-output : Find all default environments] 2025-07-20 03:11:57.861494 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:57.870763 | 2025-07-20 03:11:57.871095 | TASK [fetch-tox-output : Set envlist fact] 2025-07-20 03:11:57.897052 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:57.904903 | 2025-07-20 03:11:57.905036 | TASK [fetch-tox-output : Find all default environments] 2025-07-20 03:11:58.435100 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:58.445304 | 2025-07-20 03:11:58.445471 | TASK [fetch-tox-output : Set envlist fact] 2025-07-20 03:11:58.481921 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:58.496327 | 2025-07-20 03:11:58.496508 | LOOP [fetch-tox-output : Copy tox logs] 2025-07-20 03:11:58.555137 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:11:58.585206 | 2025-07-20 03:11:58.585422 | LOOP [fetch-tox-output : Collect tox logs] 2025-07-20 03:11:59.494078 | debian-bookworm | changed: 2025-07-20 03:11:59.494307 | debian-bookworm | created directory /var/lib/zuul/builds/c4e22111c62148b0b02f0ade2f589dcb/work/logs/tox/test 2025-07-20 03:11:59.494348 | debian-bookworm | cd+++++++++ ./ 2025-07-20 03:11:59.494374 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-07-20 03:11:59.494405 | 2025-07-20 03:11:59.509231 | 2025-07-20 03:11:59.509383 | PLAY RECAP 2025-07-20 03:11:59.509437 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-07-20 03:11:59.509462 | 2025-07-20 03:11:59.700728 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-07-20 03:11:59.701814 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-07-20 03:12:00.519821 | 2025-07-20 03:12:00.519983 | PLAY [all] 2025-07-20 03:12:00.535826 | 2025-07-20 03:12:00.535960 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-07-20 03:12:00.764680 | debian-bookworm | changed: non-zero return code 2025-07-20 03:12:00.772834 | 2025-07-20 03:12:00.773008 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-07-20 03:12:00.817754 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:12:00.823919 | 2025-07-20 03:12:00.824051 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-07-20 03:12:00.852036 | 2025-07-20 03:12:00.852239 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-07-20 03:12:00.894037 | 2025-07-20 03:12:00.894243 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-07-20 03:12:00.918613 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:12:00.925776 | 2025-07-20 03:12:00.925909 | LOOP [fetch-subunit-output : Generate subunit file] 2025-07-20 03:12:00.955556 | 2025-07-20 03:12:00.955770 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-07-20 03:12:00.979796 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:12:00.985809 | 2025-07-20 03:12:00.985937 | TASK [fetch-subunit-output : Remove the temporary file] 2025-07-20 03:12:01.009813 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:12:01.016120 | 2025-07-20 03:12:01.016237 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-07-20 03:12:01.040083 | debian-bookworm | skipping: Conditional result was False 2025-07-20 03:12:01.047302 | 2025-07-20 03:12:01.047386 | PLAY RECAP 2025-07-20 03:12:01.047436 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-07-20 03:12:01.047460 | 2025-07-20 03:12:01.174445 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-07-20 03:12:01.175588 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-07-20 03:12:01.943114 | 2025-07-20 03:12:01.943325 | PLAY [Base post] 2025-07-20 03:12:01.958388 | 2025-07-20 03:12:01.958524 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-07-20 03:12:02.542523 | debian-bookworm | changed 2025-07-20 03:12:02.558676 | 2025-07-20 03:12:02.558919 | PLAY RECAP 2025-07-20 03:12:02.559840 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-07-20 03:12:02.559919 | 2025-07-20 03:12:02.731197 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-07-20 03:12:02.732653 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-07-20 03:12:03.986319 | 2025-07-20 03:12:03.986538 | PLAY [Base post-logs] 2025-07-20 03:12:04.017670 | 2025-07-20 03:12:04.017842 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-07-20 03:12:05.036235 | localhost | changed 2025-07-20 03:12:05.050744 | 2025-07-20 03:12:05.050972 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-07-20 03:12:05.078286 | localhost | ok 2025-07-20 03:12:05.082828 | 2025-07-20 03:12:05.083052 | TASK [Set zuul-log-path fact] 2025-07-20 03:12:05.100560 | localhost | ok 2025-07-20 03:12:05.108916 | 2025-07-20 03:12:05.109031 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-20 03:12:05.134090 | localhost | ok 2025-07-20 03:12:05.137884 | 2025-07-20 03:12:05.138029 | TASK [upload-logs : Create log directories] 2025-07-20 03:12:05.799854 | localhost | changed 2025-07-20 03:12:05.802914 | 2025-07-20 03:12:05.803026 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-07-20 03:12:06.684891 | localhost -> localhost | ok: Runtime: 0:00:00.019070 2025-07-20 03:12:06.689072 | 2025-07-20 03:12:06.689187 | TASK [upload-logs : Upload logs to log server] 2025-07-20 03:12:07.415565 | localhost | Output suppressed because no_log was given 2025-07-20 03:12:07.417418 | 2025-07-20 03:12:07.417549 | LOOP [upload-logs : Compress console log and json output] 2025-07-20 03:12:07.533208 | localhost | skipping: Conditional result was False 2025-07-20 03:12:07.539528 | localhost | skipping: Conditional result was False 2025-07-20 03:12:07.546745 | 2025-07-20 03:12:07.546925 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-20 03:12:07.653736 | localhost | skipping: Conditional result was False 2025-07-20 03:12:07.654023 | 2025-07-20 03:12:07.664657 | localhost | skipping: Conditional result was False 2025-07-20 03:12:07.670125 | 2025-07-20 03:12:07.670294 | LOOP [upload-logs : Upload console log and json output]