2025-11-23 00:21:02.645037 | Job console starting 2025-11-23 00:21:02.659148 | Updating git repos 2025-11-23 00:21:02.695985 | Cloning repos into workspace 2025-11-23 00:21:02.818952 | Restoring repo states 2025-11-23 00:21:02.842102 | Merging changes 2025-11-23 00:21:03.385700 | Checking out repos 2025-11-23 00:21:03.444808 | Preparing playbooks 2025-11-23 00:21:04.304933 | Running Ansible setup 2025-11-23 00:21:10.238001 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-23 00:21:11.164272 | 2025-11-23 00:21:11.164381 | PLAY [Base pre] 2025-11-23 00:21:11.177641 | 2025-11-23 00:21:11.177746 | TASK [Setup log path fact] 2025-11-23 00:21:11.215470 | debian-bookworm | ok 2025-11-23 00:21:11.241478 | 2025-11-23 00:21:11.241589 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-23 00:21:11.310454 | debian-bookworm | ok 2025-11-23 00:21:11.330906 | 2025-11-23 00:21:11.331007 | TASK [emit-job-header : Print job information] 2025-11-23 00:21:11.398646 | # Job Information 2025-11-23 00:21:11.398782 | Ansible Version: 2.16.14 2025-11-23 00:21:11.398811 | Job: tox 2025-11-23 00:21:11.398898 | Pipeline: check 2025-11-23 00:21:11.398921 | Executor: 521e9411259a 2025-11-23 00:21:11.398939 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1003 2025-11-23 00:21:11.398957 | Event ID: 19329300-c802-11f0-8d2e-7b9ae4273fa3 2025-11-23 00:21:11.402993 | 2025-11-23 00:21:11.403100 | LOOP [emit-job-header : Print node information] 2025-11-23 00:21:11.567212 | debian-bookworm | ok: 2025-11-23 00:21:11.567407 | debian-bookworm | # Node Information 2025-11-23 00:21:11.567436 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-23 00:21:11.567457 | debian-bookworm | Hostname: debian 2025-11-23 00:21:11.567475 | debian-bookworm | Username: zuul 2025-11-23 00:21:11.567492 | debian-bookworm | Distro: Debian 12.12 2025-11-23 00:21:11.567511 | debian-bookworm | Provider: regiocloud-a 2025-11-23 00:21:11.567528 | debian-bookworm | Region: 2025-11-23 00:21:11.567565 | debian-bookworm | Label: debian-bookworm 2025-11-23 00:21:11.567611 | debian-bookworm | Product Name: OpenStack Nova 2025-11-23 00:21:11.567656 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe83:74fd 2025-11-23 00:21:11.586882 | 2025-11-23 00:21:11.586989 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-23 00:21:13.125008 | debian-bookworm -> localhost | changed 2025-11-23 00:21:13.138620 | 2025-11-23 00:21:13.139092 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-23 00:21:16.178467 | debian-bookworm -> localhost | changed 2025-11-23 00:21:16.195158 | 2025-11-23 00:21:16.195276 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-23 00:21:16.926757 | debian-bookworm -> localhost | ok 2025-11-23 00:21:16.932776 | 2025-11-23 00:21:16.932881 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-23 00:21:16.971347 | debian-bookworm | ok 2025-11-23 00:21:17.040678 | debian-bookworm | included: /var/lib/zuul/builds/df915bb7a37747e68d4f52bc143322b4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-23 00:21:17.063783 | 2025-11-23 00:21:17.063889 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-23 00:21:21.179312 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-23 00:21:21.179489 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/df915bb7a37747e68d4f52bc143322b4/work/df915bb7a37747e68d4f52bc143322b4_id_rsa 2025-11-23 00:21:21.179523 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/df915bb7a37747e68d4f52bc143322b4/work/df915bb7a37747e68d4f52bc143322b4_id_rsa.pub 2025-11-23 00:21:21.179546 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-23 00:21:21.179567 | debian-bookworm -> localhost | SHA256:R60gWOP/+hVBclQSOa7RrpYNtCatw2S/Sy2XgZXP4Qo zuul-build-sshkey 2025-11-23 00:21:21.179586 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-23 00:21:21.179611 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-23 00:21:21.179629 | debian-bookworm -> localhost | | o ..*+. | 2025-11-23 00:21:21.179646 | debian-bookworm -> localhost | | + . =oo | 2025-11-23 00:21:21.179664 | debian-bookworm -> localhost | | . o . .o=.. | 2025-11-23 00:21:21.179680 | debian-bookworm -> localhost | | o oo+o= . | 2025-11-23 00:21:21.179697 | debian-bookworm -> localhost | | SoE=o + | 2025-11-23 00:21:21.179717 | debian-bookworm -> localhost | | +o*o.= | 2025-11-23 00:21:21.179734 | debian-bookworm -> localhost | | + =+=* | 2025-11-23 00:21:21.179749 | debian-bookworm -> localhost | | +o=+. | 2025-11-23 00:21:21.179777 | debian-bookworm -> localhost | | .++o | 2025-11-23 00:21:21.179796 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-23 00:21:21.179836 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.086799 2025-11-23 00:21:21.185953 | 2025-11-23 00:21:21.186041 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-23 00:21:21.223446 | debian-bookworm | ok 2025-11-23 00:21:21.244932 | debian-bookworm | included: /var/lib/zuul/builds/df915bb7a37747e68d4f52bc143322b4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-23 00:21:21.262258 | 2025-11-23 00:21:21.262354 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-23 00:21:21.325555 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:21:21.330711 | 2025-11-23 00:21:21.330798 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-23 00:21:22.037931 | debian-bookworm | changed 2025-11-23 00:21:22.047572 | 2025-11-23 00:21:22.047656 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-23 00:21:22.336407 | debian-bookworm | ok 2025-11-23 00:21:22.341284 | 2025-11-23 00:21:22.341374 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-23 00:21:23.004853 | debian-bookworm | changed 2025-11-23 00:21:23.011545 | 2025-11-23 00:21:23.011644 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-23 00:21:23.758162 | debian-bookworm | changed 2025-11-23 00:21:23.762574 | 2025-11-23 00:21:23.762659 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-23 00:21:23.796034 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:21:23.801613 | 2025-11-23 00:21:23.801709 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-23 00:21:24.313829 | debian-bookworm -> localhost | changed 2025-11-23 00:21:24.324582 | 2025-11-23 00:21:24.324684 | TASK [add-build-sshkey : Add back temp key] 2025-11-23 00:21:24.641579 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/df915bb7a37747e68d4f52bc143322b4/work/df915bb7a37747e68d4f52bc143322b4_id_rsa (zuul-build-sshkey) 2025-11-23 00:21:24.641901 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013498 2025-11-23 00:21:24.653180 | 2025-11-23 00:21:24.653290 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-23 00:21:25.163634 | debian-bookworm | ok 2025-11-23 00:21:25.170138 | 2025-11-23 00:21:25.170240 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-23 00:21:25.204811 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:21:25.220203 | 2025-11-23 00:21:25.220324 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-23 00:21:25.686336 | debian-bookworm | ok 2025-11-23 00:21:25.700409 | 2025-11-23 00:21:25.700514 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-23 00:21:25.748499 | debian-bookworm | ok 2025-11-23 00:21:25.755512 | 2025-11-23 00:21:25.755608 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-23 00:21:26.175541 | debian-bookworm -> localhost | ok 2025-11-23 00:21:26.181628 | 2025-11-23 00:21:26.181719 | TASK [validate-host : Collect information about the host] 2025-11-23 00:21:27.331250 | debian-bookworm | ok 2025-11-23 00:21:27.358738 | 2025-11-23 00:21:27.358899 | TASK [validate-host : Sanitize hostname] 2025-11-23 00:21:27.696596 | debian-bookworm | ok 2025-11-23 00:21:27.746226 | 2025-11-23 00:21:27.746361 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-23 00:21:28.444932 | debian-bookworm -> localhost | changed 2025-11-23 00:21:28.451429 | 2025-11-23 00:21:28.451547 | TASK [validate-host : Collect information about zuul worker] 2025-11-23 00:21:28.953036 | debian-bookworm | ok 2025-11-23 00:21:28.962550 | 2025-11-23 00:21:28.962689 | TASK [validate-host : Write out all zuul information for each host] 2025-11-23 00:21:29.666161 | debian-bookworm -> localhost | changed 2025-11-23 00:21:29.701167 | 2025-11-23 00:21:29.701567 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-23 00:21:30.006433 | debian-bookworm | ok 2025-11-23 00:21:30.012456 | 2025-11-23 00:21:30.012579 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-23 00:21:31.181063 | debian-bookworm | changed: 2025-11-23 00:21:31.181386 | debian-bookworm | cd+++++++++ src/ 2025-11-23 00:21:31.181461 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-23 00:21:31.181497 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-23 00:21:31.181520 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-23 00:21:31.181542 | debian-bookworm | =6.2 2025-11-23 00:21:54.852482 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-11-23 00:21:54.888625 | debian-bookworm | Collecting chardet>=5.2 2025-11-23 00:21:54.900801 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-23 00:21:54.911434 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 26.2 MB/s eta 0:00:00 2025-11-23 00:21:54.969437 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-23 00:21:54.983473 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-23 00:21:55.059330 | debian-bookworm | Collecting filelock>=3.20 2025-11-23 00:21:55.070905 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-23 00:21:55.127369 | debian-bookworm | Collecting packaging>=25 2025-11-23 00:21:55.138692 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-23 00:21:55.147201 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.2 MB/s eta 0:00:00 2025-11-23 00:21:55.210422 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-23 00:21:55.221950 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-23 00:21:55.266708 | debian-bookworm | Collecting pluggy>=1.6 2025-11-23 00:21:55.279329 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-23 00:21:55.336374 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-23 00:21:55.349910 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-23 00:21:55.493427 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-23 00:21:55.505869 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-23 00:21:55.741369 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 26.0 MB/s eta 0:00:00 2025-11-23 00:21:55.848347 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-23 00:21:55.859551 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-23 00:21:55.886617 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 22.0 MB/s eta 0:00:00 2025-11-23 00:21:56.041143 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-23 00:21:56.934763 | 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-23 00:21:57.225981 | debian-bookworm | ok: Runtime: 0:00:03.085612 2025-11-23 00:21:57.232392 | 2025-11-23 00:21:57.232509 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-23 00:21:57.263436 | debian-bookworm | ok 2025-11-23 00:21:57.268748 | 2025-11-23 00:21:57.268866 | TASK [ensure-tox : Output tox version] 2025-11-23 00:21:57.783400 | 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-23 00:21:57.802265 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-23 00:21:58.299579 | debian-bookworm | ok: Runtime: 0:00:00.308317 2025-11-23 00:21:58.305573 | 2025-11-23 00:21:58.305681 | TASK [ensure-tox : Make global symlink] 2025-11-23 00:21:58.340298 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:21:58.347215 | 2025-11-23 00:21:58.347308 | PLAY RECAP 2025-11-23 00:21:58.347365 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-23 00:21:58.347390 | 2025-11-23 00:21:58.506440 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-23 00:21:58.507616 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-23 00:21:59.280931 | 2025-11-23 00:21:59.281127 | PLAY [all] 2025-11-23 00:21:59.298334 | 2025-11-23 00:21:59.298487 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-23 00:21:59.811868 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-23 00:21:59.858182 | debian-bookworm | ok: Runtime: 0:00:00.028326 2025-11-23 00:21:59.865445 | 2025-11-23 00:21:59.865598 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-23 00:22:00.414567 | debian-bookworm | ok: Runtime: 0:00:00.006285 2025-11-23 00:22:00.420911 | 2025-11-23 00:22:00.421040 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-23 00:22:00.706970 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-23 00:22:00.708717 | debian-bookworm | sudo: a password is required 2025-11-23 00:22:00.950816 | debian-bookworm | ok: Runtime: 0:00:00.018104 2025-11-23 00:22:00.967698 | 2025-11-23 00:22:00.967995 | TASK [tox : Check to see if the constraints file exists] 2025-11-23 00:22:01.006423 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:01.021428 | 2025-11-23 00:22:01.021623 | TASK [tox : Fail if constraints file is missing] 2025-11-23 00:22:01.106888 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:01.116930 | 2025-11-23 00:22:01.117233 | TASK [tox : Record file location] 2025-11-23 00:22:01.184017 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:01.206593 | 2025-11-23 00:22:01.206783 | TASK [tox : Install tox siblings] 2025-11-23 00:22:01.275878 | debian-bookworm | ok 2025-11-23 00:22:01.290861 | debian-bookworm | included: /var/lib/zuul/builds/df915bb7a37747e68d4f52bc143322b4/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-23 00:22:01.298760 | 2025-11-23 00:22:01.298961 | TASK [tox : Run tox without tests] 2025-11-23 00:22:02.463254 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-23 00:22:17.186694 | debian-bookworm | test: OK (15.32 seconds) 2025-11-23 00:22:17.186792 | debian-bookworm | congratulations :) (15.35 seconds) 2025-11-23 00:22:17.360159 | debian-bookworm | ok: Runtime: 0:00:15.652678 2025-11-23 00:22:17.374664 | 2025-11-23 00:22:17.374815 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-23 00:22:17.808934 | debian-bookworm | changed 2025-11-23 00:22:17.816034 | 2025-11-23 00:22:17.816182 | TASK [tox : Get tox envlist config] 2025-11-23 00:22:18.846967 | debian-bookworm | ok: Runtime: 0:00:00.328421 2025-11-23 00:22:18.861571 | 2025-11-23 00:22:18.861782 | TASK [tox : Install any sibling python packages] 2025-11-23 00:22:19.327231 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-23 00:22:19.335167 | 2025-11-23 00:22:19.335314 | TASK [tox : Remove tempfile] 2025-11-23 00:22:19.781269 | debian-bookworm | changed 2025-11-23 00:22:19.789542 | 2025-11-23 00:22:19.789692 | TASK [tox : Emit tox command] 2025-11-23 00:22:19.837338 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-23 00:22:19.845257 | 2025-11-23 00:22:19.845441 | TASK [tox : Run tox] 2025-11-23 00:22:20.484324 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-23 00:22:21.114864 | debian-bookworm | ............... 2025-11-23 00:22:21.114914 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-23 00:22:21.114929 | debian-bookworm | Ran 15 tests in 0.174s 2025-11-23 00:22:21.114934 | debian-bookworm | 2025-11-23 00:22:21.114941 | debian-bookworm | OK 2025-11-23 00:22:21.204139 | debian-bookworm | test: OK (0.77=setup[0.05]+cmd[0.72] seconds) 2025-11-23 00:22:21.204202 | debian-bookworm | congratulations :) (0.80 seconds) 2025-11-23 00:22:21.419019 | debian-bookworm | ok: Runtime: 0:00:01.080960 2025-11-23 00:22:21.437308 | 2025-11-23 00:22:21.437489 | TASK [tox : Look for output] 2025-11-23 00:22:21.840786 | debian-bookworm | ok 2025-11-23 00:22:21.878050 | 2025-11-23 00:22:21.878459 | TASK [tox : Return file comments to Zuul] 2025-11-23 00:22:21.927472 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:21.941857 | 2025-11-23 00:22:21.942000 | PLAY RECAP 2025-11-23 00:22:21.942106 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-23 00:22:21.942150 | 2025-11-23 00:22:22.083850 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-23 00:22:22.087557 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-23 00:22:22.861365 | 2025-11-23 00:22:22.861526 | PLAY [all] 2025-11-23 00:22:22.876967 | 2025-11-23 00:22:22.877145 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-23 00:22:22.932854 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:22.947327 | 2025-11-23 00:22:22.947556 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-23 00:22:22.999371 | debian-bookworm | ok 2025-11-23 00:22:23.005182 | 2025-11-23 00:22:23.005303 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-23 00:22:23.506781 | debian-bookworm -> localhost | changed 2025-11-23 00:22:23.515188 | 2025-11-23 00:22:23.515312 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-23 00:22:23.570763 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:23.583871 | 2025-11-23 00:22:23.584215 | TASK [fetch-tox-output : Set envlist fact] 2025-11-23 00:22:23.632149 | debian-bookworm | ok 2025-11-23 00:22:23.643814 | 2025-11-23 00:22:23.644043 | TASK [fetch-tox-output : Get tox version] 2025-11-23 00:22:24.314205 | 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-23 00:22:24.332305 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-23 00:22:24.679794 | debian-bookworm | ok: Runtime: 0:00:00.280339 2025-11-23 00:22:24.693160 | 2025-11-23 00:22:24.693355 | TASK [fetch-tox-output : Find all default environments] 2025-11-23 00:22:25.231689 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:25.247373 | 2025-11-23 00:22:25.247572 | TASK [fetch-tox-output : Set envlist fact] 2025-11-23 00:22:25.283482 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:25.299880 | 2025-11-23 00:22:25.300174 | TASK [fetch-tox-output : Find all default environments] 2025-11-23 00:22:25.835749 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:25.851802 | 2025-11-23 00:22:25.851985 | TASK [fetch-tox-output : Set envlist fact] 2025-11-23 00:22:25.888257 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:25.904143 | 2025-11-23 00:22:25.904325 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-23 00:22:25.959701 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:25.974808 | 2025-11-23 00:22:25.975000 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-23 00:22:26.781009 | debian-bookworm | changed: 2025-11-23 00:22:26.781230 | debian-bookworm | created directory /var/lib/zuul/builds/df915bb7a37747e68d4f52bc143322b4/work/logs/tox/test 2025-11-23 00:22:26.781265 | debian-bookworm | cd+++++++++ ./ 2025-11-23 00:22:26.781291 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-23 00:22:26.781321 | 2025-11-23 00:22:26.798297 | 2025-11-23 00:22:26.798395 | PLAY RECAP 2025-11-23 00:22:26.798444 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-23 00:22:26.798467 | 2025-11-23 00:22:26.950569 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-23 00:22:26.951726 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-23 00:22:27.764762 | 2025-11-23 00:22:27.764921 | PLAY [all] 2025-11-23 00:22:27.781828 | 2025-11-23 00:22:27.781985 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-23 00:22:28.032466 | debian-bookworm | changed: non-zero return code 2025-11-23 00:22:28.039815 | 2025-11-23 00:22:28.039992 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-23 00:22:28.066594 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:28.074380 | 2025-11-23 00:22:28.074551 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-23 00:22:28.121654 | 2025-11-23 00:22:28.121917 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-23 00:22:28.155452 | 2025-11-23 00:22:28.155660 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-23 00:22:28.171102 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:28.177335 | 2025-11-23 00:22:28.177458 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-23 00:22:28.207769 | 2025-11-23 00:22:28.207979 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-23 00:22:28.232007 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:28.237959 | 2025-11-23 00:22:28.238102 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-23 00:22:28.262024 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:28.275805 | 2025-11-23 00:22:28.276010 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-23 00:22:28.301751 | debian-bookworm | skipping: Conditional result was False 2025-11-23 00:22:28.320552 | 2025-11-23 00:22:28.320689 | PLAY RECAP 2025-11-23 00:22:28.320763 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-23 00:22:28.320799 | 2025-11-23 00:22:28.453805 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-23 00:22:28.454956 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-23 00:22:29.223415 | 2025-11-23 00:22:29.223600 | PLAY [Base post] 2025-11-23 00:22:29.238152 | 2025-11-23 00:22:29.238308 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-23 00:22:29.836962 | debian-bookworm | changed 2025-11-23 00:22:29.847865 | 2025-11-23 00:22:29.848010 | PLAY RECAP 2025-11-23 00:22:29.848093 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-23 00:22:29.848159 | 2025-11-23 00:22:29.975379 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-23 00:22:29.976463 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-23 00:22:30.795857 | 2025-11-23 00:22:30.796031 | PLAY [Base post-logs] 2025-11-23 00:22:30.807164 | 2025-11-23 00:22:30.807302 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-23 00:22:31.312485 | localhost | changed 2025-11-23 00:22:31.325682 | 2025-11-23 00:22:31.325855 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-23 00:22:31.364960 | localhost | ok 2025-11-23 00:22:31.372396 | 2025-11-23 00:22:31.372553 | TASK [Set zuul-log-path fact] 2025-11-23 00:22:31.391706 | localhost | ok 2025-11-23 00:22:31.405452 | 2025-11-23 00:22:31.405602 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-23 00:22:31.443452 | localhost | ok 2025-11-23 00:22:31.449367 | 2025-11-23 00:22:31.449556 | TASK [upload-logs : Create log directories] 2025-11-23 00:22:32.002468 | localhost | changed 2025-11-23 00:22:32.007922 | 2025-11-23 00:22:32.008157 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-23 00:22:32.520396 | localhost -> localhost | ok: Runtime: 0:00:00.007072 2025-11-23 00:22:32.524657 | 2025-11-23 00:22:32.524782 | TASK [upload-logs : Upload logs to log server] 2025-11-23 00:22:33.086153 | localhost | Output suppressed because no_log was given 2025-11-23 00:22:33.088291 | 2025-11-23 00:22:33.088406 | LOOP [upload-logs : Compress console log and json output] 2025-11-23 00:22:33.139031 | localhost | skipping: Conditional result was False 2025-11-23 00:22:33.144913 | localhost | skipping: Conditional result was False 2025-11-23 00:22:33.159419 | 2025-11-23 00:22:33.159649 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-23 00:22:33.208301 | localhost | skipping: Conditional result was False 2025-11-23 00:22:33.209015 | 2025-11-23 00:22:33.211811 | localhost | skipping: Conditional result was False 2025-11-23 00:22:33.226915 | 2025-11-23 00:22:33.227137 | LOOP [upload-logs : Upload console log and json output]