2025-08-26 20:38:35.104017 | Job console starting 2025-08-26 20:38:35.114823 | Updating git repos 2025-08-26 20:38:35.135000 | Cloning repos into workspace 2025-08-26 20:38:35.160941 | Restoring repo states 2025-08-26 20:38:35.174096 | Merging changes 2025-08-26 20:38:35.770995 | Checking out repos 2025-08-26 20:38:35.828234 | Preparing playbooks 2025-08-26 20:38:36.457511 | Running Ansible setup 2025-08-26 20:38:42.533657 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-26 20:38:43.312018 | 2025-08-26 20:38:43.312125 | PLAY [Base pre] 2025-08-26 20:38:43.326321 | 2025-08-26 20:38:43.326413 | TASK [Setup log path fact] 2025-08-26 20:38:43.347836 | debian-bookworm | ok 2025-08-26 20:38:43.365138 | 2025-08-26 20:38:43.365236 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-26 20:38:43.425137 | debian-bookworm | ok 2025-08-26 20:38:43.432918 | 2025-08-26 20:38:43.432999 | TASK [emit-job-header : Print job information] 2025-08-26 20:38:43.506535 | # Job Information 2025-08-26 20:38:43.506680 | Ansible Version: 2.16.14 2025-08-26 20:38:43.506903 | Job: tox 2025-08-26 20:38:43.507013 | Pipeline: check 2025-08-26 20:38:43.507034 | Executor: 521e9411259a 2025-08-26 20:38:43.507051 | Triggered by: https://github.com/osism/openstack-image-manager/pull/948 2025-08-26 20:38:43.507070 | Event ID: 823b43f0-82bc-11f0-82ce-6eabe790fe8f 2025-08-26 20:38:43.511068 | 2025-08-26 20:38:43.511145 | LOOP [emit-job-header : Print node information] 2025-08-26 20:38:43.655047 | debian-bookworm | ok: 2025-08-26 20:38:43.655251 | debian-bookworm | # Node Information 2025-08-26 20:38:43.655282 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-26 20:38:43.655303 | debian-bookworm | Hostname: debian 2025-08-26 20:38:43.655321 | debian-bookworm | Username: zuul 2025-08-26 20:38:43.655337 | debian-bookworm | Distro: Debian 12.11 2025-08-26 20:38:43.655357 | debian-bookworm | Provider: regiocloud-a 2025-08-26 20:38:43.655375 | debian-bookworm | Region: 2025-08-26 20:38:43.655392 | debian-bookworm | Label: debian-bookworm 2025-08-26 20:38:43.655408 | debian-bookworm | Product Name: OpenStack Nova 2025-08-26 20:38:43.655424 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe31:e92 2025-08-26 20:38:43.670376 | 2025-08-26 20:38:43.670509 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-26 20:38:44.167494 | debian-bookworm -> localhost | changed 2025-08-26 20:38:44.175625 | 2025-08-26 20:38:44.175733 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-26 20:38:45.370470 | debian-bookworm -> localhost | changed 2025-08-26 20:38:45.385127 | 2025-08-26 20:38:45.385231 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-26 20:38:46.418402 | debian-bookworm -> localhost | ok 2025-08-26 20:38:46.424306 | 2025-08-26 20:38:46.424407 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-26 20:38:46.462736 | debian-bookworm | ok 2025-08-26 20:38:46.496328 | debian-bookworm | included: /var/lib/zuul/builds/6b3b89805b084505847fc28741432432/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-26 20:38:46.506730 | 2025-08-26 20:38:46.506862 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-26 20:38:50.060877 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-26 20:38:50.061110 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6b3b89805b084505847fc28741432432/work/6b3b89805b084505847fc28741432432_id_rsa 2025-08-26 20:38:50.061147 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6b3b89805b084505847fc28741432432/work/6b3b89805b084505847fc28741432432_id_rsa.pub 2025-08-26 20:38:50.061172 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-26 20:38:50.061199 | debian-bookworm -> localhost | SHA256:bc7w/r5KYW95DoWdvPGZM7/La6rvThdeG6yNkvuDaQo zuul-build-sshkey 2025-08-26 20:38:50.061232 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-26 20:38:50.061262 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-26 20:38:50.061285 | debian-bookworm -> localhost | | | 2025-08-26 20:38:50.061307 | debian-bookworm -> localhost | | | 2025-08-26 20:38:50.061328 | debian-bookworm -> localhost | | | 2025-08-26 20:38:50.061349 | debian-bookworm -> localhost | | . +.. | 2025-08-26 20:38:50.061369 | debian-bookworm -> localhost | | S = . *+.| 2025-08-26 20:38:50.061396 | debian-bookworm -> localhost | | B o.o=+B| 2025-08-26 20:38:50.061418 | debian-bookworm -> localhost | | E =oB+oX.| 2025-08-26 20:38:50.061438 | debian-bookworm -> localhost | | .o =+=o.+| 2025-08-26 20:38:50.061459 | debian-bookworm -> localhost | | .=*XB===| 2025-08-26 20:38:50.061479 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-26 20:38:50.061531 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.749454 2025-08-26 20:38:50.068637 | 2025-08-26 20:38:50.068827 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-26 20:38:50.097297 | debian-bookworm | ok 2025-08-26 20:38:50.106521 | debian-bookworm | included: /var/lib/zuul/builds/6b3b89805b084505847fc28741432432/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-26 20:38:50.116228 | 2025-08-26 20:38:50.116308 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-26 20:38:50.139650 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:38:50.148362 | 2025-08-26 20:38:50.148455 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-26 20:38:50.934127 | debian-bookworm | changed 2025-08-26 20:38:50.939648 | 2025-08-26 20:38:50.939741 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-26 20:38:51.333285 | debian-bookworm | ok 2025-08-26 20:38:51.338719 | 2025-08-26 20:38:51.338846 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-26 20:38:52.046685 | debian-bookworm | changed 2025-08-26 20:38:52.053569 | 2025-08-26 20:38:52.053667 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-26 20:38:52.719918 | debian-bookworm | changed 2025-08-26 20:38:52.727579 | 2025-08-26 20:38:52.727665 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-26 20:38:52.760959 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:38:52.766635 | 2025-08-26 20:38:52.766721 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-26 20:38:53.558526 | debian-bookworm -> localhost | changed 2025-08-26 20:38:53.581923 | 2025-08-26 20:38:53.582033 | TASK [add-build-sshkey : Add back temp key] 2025-08-26 20:38:54.222141 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6b3b89805b084505847fc28741432432/work/6b3b89805b084505847fc28741432432_id_rsa (zuul-build-sshkey) 2025-08-26 20:38:54.222354 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014216 2025-08-26 20:38:54.230199 | 2025-08-26 20:38:54.230287 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-26 20:38:54.613047 | debian-bookworm | ok 2025-08-26 20:38:54.617969 | 2025-08-26 20:38:54.618058 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-26 20:38:54.641550 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:38:54.651448 | 2025-08-26 20:38:54.651542 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-26 20:38:55.042994 | debian-bookworm | ok 2025-08-26 20:38:55.053733 | 2025-08-26 20:38:55.053860 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-26 20:38:55.081581 | debian-bookworm | ok 2025-08-26 20:38:55.088128 | 2025-08-26 20:38:55.088216 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-26 20:38:55.450539 | debian-bookworm -> localhost | ok 2025-08-26 20:38:55.460974 | 2025-08-26 20:38:55.461193 | TASK [validate-host : Collect information about the host] 2025-08-26 20:38:56.650342 | debian-bookworm | ok 2025-08-26 20:38:56.661184 | 2025-08-26 20:38:56.661280 | TASK [validate-host : Sanitize hostname] 2025-08-26 20:38:56.750206 | debian-bookworm | ok 2025-08-26 20:38:56.789464 | 2025-08-26 20:38:56.789567 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-26 20:38:57.533170 | debian-bookworm -> localhost | changed 2025-08-26 20:38:57.537675 | 2025-08-26 20:38:57.537765 | TASK [validate-host : Collect information about zuul worker] 2025-08-26 20:38:57.907663 | debian-bookworm | ok 2025-08-26 20:38:57.911417 | 2025-08-26 20:38:57.911496 | TASK [validate-host : Write out all zuul information for each host] 2025-08-26 20:38:58.390665 | debian-bookworm -> localhost | changed 2025-08-26 20:38:58.399903 | 2025-08-26 20:38:58.399990 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-26 20:38:58.671577 | debian-bookworm | ok 2025-08-26 20:38:58.676730 | 2025-08-26 20:38:58.676825 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-26 20:38:59.804935 | debian-bookworm | changed: 2025-08-26 20:38:59.805128 | debian-bookworm | cd+++++++++ src/ 2025-08-26 20:38:59.805161 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-26 20:38:59.805184 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-26 20:38:59.805204 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-08-26 20:38:59.805224 | debian-bookworm | =6.1 2025-08-26 20:39:24.925338 | debian-bookworm | Downloading cachetools-6.2.0-py3-none-any.whl (11 kB) 2025-08-26 20:39:24.955935 | debian-bookworm | Collecting chardet>=5.2 2025-08-26 20:39:24.964078 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-08-26 20:39:24.984008 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.4 MB/s eta 0:00:00 2025-08-26 20:39:25.017734 | debian-bookworm | Collecting colorama>=0.4.6 2025-08-26 20:39:25.026337 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-08-26 20:39:25.086227 | debian-bookworm | Collecting filelock>=3.18 2025-08-26 20:39:25.094520 | debian-bookworm | Downloading filelock-3.19.1-py3-none-any.whl (15 kB) 2025-08-26 20:39:25.142062 | debian-bookworm | Collecting packaging>=25 2025-08-26 20:39:25.150327 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-08-26 20:39:25.158250 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 11.8 MB/s eta 0:00:00 2025-08-26 20:39:25.201405 | debian-bookworm | Collecting platformdirs>=4.3.8 2025-08-26 20:39:25.210441 | debian-bookworm | Downloading platformdirs-4.4.0-py3-none-any.whl (18 kB) 2025-08-26 20:39:25.252430 | debian-bookworm | Collecting pluggy>=1.6 2025-08-26 20:39:25.260971 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-08-26 20:39:25.320494 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-08-26 20:39:25.329360 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-08-26 20:39:25.455578 | debian-bookworm | Collecting virtualenv>=20.31.2 2025-08-26 20:39:25.463838 | debian-bookworm | Downloading virtualenv-20.34.0-py3-none-any.whl (6.0 MB) 2025-08-26 20:39:25.732507 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 22.6 MB/s eta 0:00:00 2025-08-26 20:39:25.829586 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-08-26 20:39:25.852787 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-08-26 20:39:25.884776 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.2 MB/s eta 0:00:00 2025-08-26 20:39:26.044804 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-08-26 20:39:26.887425 | 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.28.4 virtualenv-20.34.0 2025-08-26 20:39:27.319955 | debian-bookworm | ok: Runtime: 0:00:02.933751 2025-08-26 20:39:27.326282 | 2025-08-26 20:39:27.326406 | TASK [ensure-tox : Export installed tox_executable path] 2025-08-26 20:39:27.368778 | debian-bookworm | ok 2025-08-26 20:39:27.375802 | 2025-08-26 20:39:27.375918 | TASK [ensure-tox : Output tox version] 2025-08-26 20:39:27.975842 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-08-26 20:39:27.995253 | debian-bookworm | 4.28.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-08-26 20:39:28.410813 | debian-bookworm | ok: Runtime: 0:00:00.322829 2025-08-26 20:39:28.417841 | 2025-08-26 20:39:28.417946 | TASK [ensure-tox : Make global symlink] 2025-08-26 20:39:28.445642 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:28.457031 | 2025-08-26 20:39:28.457124 | PLAY RECAP 2025-08-26 20:39:28.457184 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-08-26 20:39:28.457209 | 2025-08-26 20:39:28.695932 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-08-26 20:39:28.697236 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-08-26 20:39:29.644955 | 2025-08-26 20:39:29.645083 | PLAY [all] 2025-08-26 20:39:29.671439 | 2025-08-26 20:39:29.671564 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-08-26 20:39:30.382234 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-08-26 20:39:30.725661 | debian-bookworm | ok: Runtime: 0:00:00.034384 2025-08-26 20:39:30.731021 | 2025-08-26 20:39:30.731125 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-08-26 20:39:31.262350 | debian-bookworm | ok: Runtime: 0:00:00.007081 2025-08-26 20:39:31.268123 | 2025-08-26 20:39:31.268278 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-08-26 20:39:31.717148 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-08-26 20:39:31.718952 | debian-bookworm | sudo: a password is required 2025-08-26 20:39:31.828713 | debian-bookworm | ok: Runtime: 0:00:00.023539 2025-08-26 20:39:31.838493 | 2025-08-26 20:39:31.838588 | TASK [tox : Check to see if the constraints file exists] 2025-08-26 20:39:31.887198 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:31.891968 | 2025-08-26 20:39:31.892053 | TASK [tox : Fail if constraints file is missing] 2025-08-26 20:39:31.914769 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:31.919492 | 2025-08-26 20:39:31.919570 | TASK [tox : Record file location] 2025-08-26 20:39:31.972434 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:31.981935 | 2025-08-26 20:39:31.982022 | TASK [tox : Install tox siblings] 2025-08-26 20:39:32.003472 | debian-bookworm | ok 2025-08-26 20:39:32.019198 | debian-bookworm | included: /var/lib/zuul/builds/6b3b89805b084505847fc28741432432/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-08-26 20:39:32.024166 | 2025-08-26 20:39:32.024251 | TASK [tox : Run tox without tests] 2025-08-26 20:39:33.170658 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-08-26 20:39:46.004781 | debian-bookworm | test: OK (13.40 seconds) 2025-08-26 20:39:46.004852 | debian-bookworm | congratulations :) (13.48 seconds) 2025-08-26 20:39:46.107246 | debian-bookworm | ok: Runtime: 0:00:13.723502 2025-08-26 20:39:46.112339 | 2025-08-26 20:39:46.112424 | TASK [tox : Create a tempfile to save tox showconfig] 2025-08-26 20:39:46.527574 | debian-bookworm | changed 2025-08-26 20:39:46.532631 | 2025-08-26 20:39:46.532727 | TASK [tox : Get tox envlist config] 2025-08-26 20:39:47.560603 | debian-bookworm | ok: Runtime: 0:00:00.336618 2025-08-26 20:39:47.566179 | 2025-08-26 20:39:47.566268 | TASK [tox : Install any sibling python packages] 2025-08-26 20:39:47.989946 | debian-bookworm | ok: No setup.cfg, no action needed 2025-08-26 20:39:47.999235 | 2025-08-26 20:39:47.999326 | TASK [tox : Remove tempfile] 2025-08-26 20:39:48.433532 | debian-bookworm | changed 2025-08-26 20:39:48.441529 | 2025-08-26 20:39:48.441637 | TASK [tox : Emit tox command] 2025-08-26 20:39:48.482740 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-08-26 20:39:48.490470 | 2025-08-26 20:39:48.490572 | TASK [tox : Run tox] 2025-08-26 20:39:49.068664 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-08-26 20:39:49.582909 | 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-08-26 20:39:49.582950 | debian-bookworm | from pkg_resources import get_distribution, DistributionNotFound 2025-08-26 20:39:49.881004 | debian-bookworm | ............... 2025-08-26 20:39:49.881041 | debian-bookworm | ---------------------------------------------------------------------- 2025-08-26 20:39:49.881047 | debian-bookworm | Ran 15 tests in 0.172s 2025-08-26 20:39:49.881052 | debian-bookworm | 2025-08-26 20:39:49.881069 | debian-bookworm | OK 2025-08-26 20:39:49.963889 | debian-bookworm | test: OK (0.93=setup[0.04]+cmd[0.89] seconds) 2025-08-26 20:39:49.963919 | debian-bookworm | congratulations :) (1.00 seconds) 2025-08-26 20:39:50.073997 | debian-bookworm | ok: Runtime: 0:00:01.204127 2025-08-26 20:39:50.093266 | 2025-08-26 20:39:50.093392 | TASK [tox : Look for output] 2025-08-26 20:39:50.494242 | debian-bookworm | ok 2025-08-26 20:39:50.510664 | 2025-08-26 20:39:50.510894 | TASK [tox : Return file comments to Zuul] 2025-08-26 20:39:50.555384 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:50.564003 | 2025-08-26 20:39:50.564095 | PLAY RECAP 2025-08-26 20:39:50.564155 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-08-26 20:39:50.564182 | 2025-08-26 20:39:50.713991 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-08-26 20:39:50.715631 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-08-26 20:39:51.460022 | 2025-08-26 20:39:51.460174 | PLAY [all] 2025-08-26 20:39:51.475878 | 2025-08-26 20:39:51.476010 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-08-26 20:39:51.544005 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:51.556251 | 2025-08-26 20:39:51.556452 | TASK [fetch-tox-output : Set tox log path for single node] 2025-08-26 20:39:51.611950 | debian-bookworm | ok 2025-08-26 20:39:51.618094 | 2025-08-26 20:39:51.618225 | TASK [fetch-tox-output : Ensure local tox dir] 2025-08-26 20:39:52.121472 | debian-bookworm -> localhost | changed 2025-08-26 20:39:52.130412 | 2025-08-26 20:39:52.130569 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-08-26 20:39:52.177145 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:52.184763 | 2025-08-26 20:39:52.184917 | TASK [fetch-tox-output : Set envlist fact] 2025-08-26 20:39:52.228462 | debian-bookworm | ok 2025-08-26 20:39:52.237965 | 2025-08-26 20:39:52.238138 | TASK [fetch-tox-output : Get tox version] 2025-08-26 20:39:52.888652 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-08-26 20:39:52.905743 | debian-bookworm | 4.28.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-08-26 20:39:53.278010 | debian-bookworm | ok: Runtime: 0:00:00.242782 2025-08-26 20:39:53.285836 | 2025-08-26 20:39:53.285987 | TASK [fetch-tox-output : Find all default environments] 2025-08-26 20:39:53.820148 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:53.834970 | 2025-08-26 20:39:53.835150 | TASK [fetch-tox-output : Set envlist fact] 2025-08-26 20:39:53.870983 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:53.886678 | 2025-08-26 20:39:53.886929 | TASK [fetch-tox-output : Find all default environments] 2025-08-26 20:39:54.421481 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:54.428193 | 2025-08-26 20:39:54.428307 | TASK [fetch-tox-output : Set envlist fact] 2025-08-26 20:39:54.452497 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:54.459296 | 2025-08-26 20:39:54.459406 | LOOP [fetch-tox-output : Copy tox logs] 2025-08-26 20:39:54.506768 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:54.520202 | 2025-08-26 20:39:54.520313 | LOOP [fetch-tox-output : Collect tox logs] 2025-08-26 20:39:55.309926 | debian-bookworm | changed: 2025-08-26 20:39:55.310542 | debian-bookworm | created directory /var/lib/zuul/builds/6b3b89805b084505847fc28741432432/work/logs/tox/test 2025-08-26 20:39:55.310826 | debian-bookworm | cd+++++++++ ./ 2025-08-26 20:39:55.311112 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-08-26 20:39:55.311213 | 2025-08-26 20:39:55.329130 | 2025-08-26 20:39:55.329241 | PLAY RECAP 2025-08-26 20:39:55.329300 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-08-26 20:39:55.329327 | 2025-08-26 20:39:55.465708 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-08-26 20:39:55.467022 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-08-26 20:39:56.225350 | 2025-08-26 20:39:56.225502 | PLAY [all] 2025-08-26 20:39:56.242096 | 2025-08-26 20:39:56.242230 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-08-26 20:39:56.478744 | debian-bookworm | changed: non-zero return code 2025-08-26 20:39:56.485819 | 2025-08-26 20:39:56.485974 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-08-26 20:39:56.511414 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:56.521705 | 2025-08-26 20:39:56.521872 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-08-26 20:39:56.572600 | 2025-08-26 20:39:56.572928 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-08-26 20:39:56.623982 | 2025-08-26 20:39:56.624476 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-08-26 20:39:56.659954 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:56.669324 | 2025-08-26 20:39:56.669468 | LOOP [fetch-subunit-output : Generate subunit file] 2025-08-26 20:39:56.706486 | 2025-08-26 20:39:56.706919 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-08-26 20:39:56.736260 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:56.750893 | 2025-08-26 20:39:56.751097 | TASK [fetch-subunit-output : Remove the temporary file] 2025-08-26 20:39:56.776518 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:56.783500 | 2025-08-26 20:39:56.783634 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-08-26 20:39:56.828357 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:56.836113 | 2025-08-26 20:39:56.836208 | PLAY RECAP 2025-08-26 20:39:56.836265 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-08-26 20:39:56.836290 | 2025-08-26 20:39:56.989679 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-08-26 20:39:56.991316 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-26 20:39:57.753869 | 2025-08-26 20:39:57.754054 | PLAY [Base post] 2025-08-26 20:39:57.768384 | 2025-08-26 20:39:57.768523 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-26 20:39:58.333053 | debian-bookworm | changed 2025-08-26 20:39:58.341963 | 2025-08-26 20:39:58.342089 | PLAY RECAP 2025-08-26 20:39:58.342310 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-26 20:39:58.342401 | 2025-08-26 20:39:58.471422 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-26 20:39:58.472618 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-26 20:39:59.307237 | 2025-08-26 20:39:59.307415 | PLAY [Base post-logs] 2025-08-26 20:39:59.317906 | 2025-08-26 20:39:59.318048 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-26 20:39:59.793343 | localhost | changed 2025-08-26 20:39:59.803840 | 2025-08-26 20:39:59.804014 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-26 20:39:59.831151 | localhost | ok 2025-08-26 20:39:59.834349 | 2025-08-26 20:39:59.834456 | TASK [Set zuul-log-path fact] 2025-08-26 20:39:59.852538 | localhost | ok 2025-08-26 20:39:59.860955 | 2025-08-26 20:39:59.861087 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-26 20:39:59.888539 | localhost | ok 2025-08-26 20:39:59.893015 | 2025-08-26 20:39:59.893135 | TASK [upload-logs : Create log directories] 2025-08-26 20:40:00.427021 | localhost | changed 2025-08-26 20:40:00.429908 | 2025-08-26 20:40:00.430019 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-26 20:40:00.982324 | localhost -> localhost | ok: Runtime: 0:00:00.009436 2025-08-26 20:40:00.987971 | 2025-08-26 20:40:00.988121 | TASK [upload-logs : Upload logs to log server] 2025-08-26 20:40:01.585411 | localhost | Output suppressed because no_log was given 2025-08-26 20:40:01.592562 | 2025-08-26 20:40:01.592689 | LOOP [upload-logs : Compress console log and json output] 2025-08-26 20:40:01.657888 | localhost | skipping: Conditional result was False 2025-08-26 20:40:01.663033 | localhost | skipping: Conditional result was False 2025-08-26 20:40:01.676238 | 2025-08-26 20:40:01.676480 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-26 20:40:01.729175 | localhost | skipping: Conditional result was False 2025-08-26 20:40:01.729885 | 2025-08-26 20:40:01.738437 | localhost | skipping: Conditional result was False 2025-08-26 20:40:01.749567 | 2025-08-26 20:40:01.749800 | LOOP [upload-logs : Upload console log and json output]