2025-11-09 00:19:46.748362 | Job console starting 2025-11-09 00:19:46.755806 | Updating git repos 2025-11-09 00:19:46.774577 | Cloning repos into workspace 2025-11-09 00:19:46.832585 | Restoring repo states 2025-11-09 00:19:46.839628 | Merging changes 2025-11-09 00:19:47.376529 | Checking out repos 2025-11-09 00:19:47.420323 | Preparing playbooks 2025-11-09 00:19:48.162474 | Running Ansible setup 2025-11-09 00:19:53.866646 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-09 00:19:54.658228 | 2025-11-09 00:19:54.658336 | PLAY [Base pre] 2025-11-09 00:19:54.679194 | 2025-11-09 00:19:54.679299 | TASK [Setup log path fact] 2025-11-09 00:19:54.716205 | debian-bookworm | ok 2025-11-09 00:19:54.728068 | 2025-11-09 00:19:54.728171 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-09 00:19:54.786066 | debian-bookworm | ok 2025-11-09 00:19:54.794143 | 2025-11-09 00:19:54.794231 | TASK [emit-job-header : Print job information] 2025-11-09 00:19:54.851415 | # Job Information 2025-11-09 00:19:54.851552 | Ansible Version: 2.16.14 2025-11-09 00:19:54.851581 | Job: tox 2025-11-09 00:19:54.851607 | Pipeline: check 2025-11-09 00:19:54.851626 | Executor: 521e9411259a 2025-11-09 00:19:54.851643 | Triggered by: https://github.com/osism/openstack-image-manager/pull/982 2025-11-09 00:19:54.851661 | Event ID: a2338df0-bd01-11f0-8993-d544a8d3313c 2025-11-09 00:19:54.855532 | 2025-11-09 00:19:54.855610 | LOOP [emit-job-header : Print node information] 2025-11-09 00:19:54.974984 | debian-bookworm | ok: 2025-11-09 00:19:54.975163 | debian-bookworm | # Node Information 2025-11-09 00:19:54.975194 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-09 00:19:54.975214 | debian-bookworm | Hostname: debian 2025-11-09 00:19:54.975233 | debian-bookworm | Username: zuul 2025-11-09 00:19:54.975251 | debian-bookworm | Distro: Debian 12.12 2025-11-09 00:19:54.975270 | debian-bookworm | Provider: regiocloud-a 2025-11-09 00:19:54.975287 | debian-bookworm | Region: 2025-11-09 00:19:54.975304 | debian-bookworm | Label: debian-bookworm 2025-11-09 00:19:54.975321 | debian-bookworm | Product Name: OpenStack Nova 2025-11-09 00:19:54.975337 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec6:6612 2025-11-09 00:19:54.989553 | 2025-11-09 00:19:54.989644 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-09 00:19:55.625956 | debian-bookworm -> localhost | changed 2025-11-09 00:19:55.631708 | 2025-11-09 00:19:55.631792 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-09 00:19:57.092283 | debian-bookworm -> localhost | changed 2025-11-09 00:19:57.100982 | 2025-11-09 00:19:57.101069 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-09 00:19:57.557917 | debian-bookworm -> localhost | ok 2025-11-09 00:19:57.562756 | 2025-11-09 00:19:57.562900 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-09 00:19:57.599184 | debian-bookworm | ok 2025-11-09 00:19:57.635399 | debian-bookworm | included: /var/lib/zuul/builds/ad6eb3438a064c958ce8e74de28b8f9a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-09 00:19:57.651352 | 2025-11-09 00:19:57.651452 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-09 00:19:59.054419 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-09 00:19:59.054588 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ad6eb3438a064c958ce8e74de28b8f9a/work/ad6eb3438a064c958ce8e74de28b8f9a_id_rsa 2025-11-09 00:19:59.054619 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ad6eb3438a064c958ce8e74de28b8f9a/work/ad6eb3438a064c958ce8e74de28b8f9a_id_rsa.pub 2025-11-09 00:19:59.054641 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-09 00:19:59.054663 | debian-bookworm -> localhost | SHA256:5OO+Al1+4t63FLfzzlpAvJP9+5dmVvbUSy/1oLlJkEY zuul-build-sshkey 2025-11-09 00:19:59.054682 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-09 00:19:59.054708 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-09 00:19:59.054726 | debian-bookworm -> localhost | | | 2025-11-09 00:19:59.054744 | debian-bookworm -> localhost | | . | 2025-11-09 00:19:59.054761 | debian-bookworm -> localhost | | . E o | 2025-11-09 00:19:59.054777 | debian-bookworm -> localhost | | o.. . . + | 2025-11-09 00:19:59.054793 | debian-bookworm -> localhost | | . oS + . * o| 2025-11-09 00:19:59.054812 | debian-bookworm -> localhost | | . ..oo.. o.=B| 2025-11-09 00:19:59.054840 | debian-bookworm -> localhost | | . ..o oo+=X| 2025-11-09 00:19:59.054858 | debian-bookworm -> localhost | | .... o+..@*| 2025-11-09 00:19:59.054875 | debian-bookworm -> localhost | | o+...+o==B| 2025-11-09 00:19:59.054892 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-09 00:19:59.054934 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.416745 2025-11-09 00:19:59.060512 | 2025-11-09 00:19:59.060596 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-09 00:19:59.097230 | debian-bookworm | ok 2025-11-09 00:19:59.105005 | debian-bookworm | included: /var/lib/zuul/builds/ad6eb3438a064c958ce8e74de28b8f9a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-09 00:19:59.122745 | 2025-11-09 00:19:59.122861 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-09 00:19:59.150500 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:19:59.155484 | 2025-11-09 00:19:59.155574 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-09 00:19:59.730982 | debian-bookworm | changed 2025-11-09 00:19:59.735280 | 2025-11-09 00:19:59.735351 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-09 00:19:59.983287 | debian-bookworm | ok 2025-11-09 00:19:59.995262 | 2025-11-09 00:19:59.995404 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-09 00:20:00.593445 | debian-bookworm | changed 2025-11-09 00:20:00.602624 | 2025-11-09 00:20:00.602732 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-09 00:20:01.238000 | debian-bookworm | changed 2025-11-09 00:20:01.244197 | 2025-11-09 00:20:01.244290 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-09 00:20:01.272944 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:20:01.279899 | 2025-11-09 00:20:01.279989 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-09 00:20:02.026532 | debian-bookworm -> localhost | changed 2025-11-09 00:20:02.040508 | 2025-11-09 00:20:02.040956 | TASK [add-build-sshkey : Add back temp key] 2025-11-09 00:20:02.770791 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ad6eb3438a064c958ce8e74de28b8f9a/work/ad6eb3438a064c958ce8e74de28b8f9a_id_rsa (zuul-build-sshkey) 2025-11-09 00:20:02.771020 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.029166 2025-11-09 00:20:02.778549 | 2025-11-09 00:20:02.778647 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-09 00:20:03.414077 | debian-bookworm | ok 2025-11-09 00:20:03.419033 | 2025-11-09 00:20:03.421195 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-09 00:20:03.471803 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:20:03.493391 | 2025-11-09 00:20:03.493525 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-09 00:20:03.954990 | debian-bookworm | ok 2025-11-09 00:20:03.968624 | 2025-11-09 00:20:03.968728 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-09 00:20:04.019430 | debian-bookworm | ok 2025-11-09 00:20:04.024449 | 2025-11-09 00:20:04.024543 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-09 00:20:04.362946 | debian-bookworm -> localhost | ok 2025-11-09 00:20:04.373348 | 2025-11-09 00:20:04.373461 | TASK [validate-host : Collect information about the host] 2025-11-09 00:20:05.529022 | debian-bookworm | ok 2025-11-09 00:20:05.542732 | 2025-11-09 00:20:05.542823 | TASK [validate-host : Sanitize hostname] 2025-11-09 00:20:05.654112 | debian-bookworm | ok 2025-11-09 00:20:05.714330 | 2025-11-09 00:20:05.714436 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-09 00:20:06.346019 | debian-bookworm -> localhost | changed 2025-11-09 00:20:06.350611 | 2025-11-09 00:20:06.350688 | TASK [validate-host : Collect information about zuul worker] 2025-11-09 00:20:06.887366 | debian-bookworm | ok 2025-11-09 00:20:06.892290 | 2025-11-09 00:20:06.892405 | TASK [validate-host : Write out all zuul information for each host] 2025-11-09 00:20:07.458034 | debian-bookworm -> localhost | changed 2025-11-09 00:20:07.488594 | 2025-11-09 00:20:07.489113 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-09 00:20:07.813085 | debian-bookworm | ok 2025-11-09 00:20:07.825106 | 2025-11-09 00:20:07.827631 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-09 00:20:08.858328 | debian-bookworm | changed: 2025-11-09 00:20:08.858525 | debian-bookworm | cd+++++++++ src/ 2025-11-09 00:20:08.858556 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-09 00:20:08.858577 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-09 00:20:08.858594 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-09 00:20:08.858611 | debian-bookworm | =6.2 2025-11-09 00:20:31.082803 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-11-09 00:20:31.119890 | debian-bookworm | Collecting chardet>=5.2 2025-11-09 00:20:31.135542 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-09 00:20:31.150217 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 21.5 MB/s eta 0:00:00 2025-11-09 00:20:31.197326 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-09 00:20:31.211396 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-09 00:20:31.267761 | debian-bookworm | Collecting filelock>=3.20 2025-11-09 00:20:31.280978 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-09 00:20:31.331190 | debian-bookworm | Collecting packaging>=25 2025-11-09 00:20:31.344537 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-09 00:20:31.352473 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 11.2 MB/s eta 0:00:00 2025-11-09 00:20:31.403021 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-09 00:20:31.416639 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-09 00:20:31.459420 | debian-bookworm | Collecting pluggy>=1.6 2025-11-09 00:20:31.472905 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-09 00:20:31.514648 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-09 00:20:31.529396 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-09 00:20:31.657840 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-09 00:20:31.672194 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-09 00:20:31.951759 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 22.8 MB/s eta 0:00:00 2025-11-09 00:20:32.055770 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-09 00:20:32.069413 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-09 00:20:32.094561 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.6 MB/s eta 0:00:00 2025-11-09 00:20:32.242016 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-09 00:20:33.102010 | debian-bookworm | Successfully installed cachetools-6.2.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.0 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-11-09 00:20:33.478033 | debian-bookworm | ok: Runtime: 0:00:03.005418 2025-11-09 00:20:33.493215 | 2025-11-09 00:20:33.493384 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-09 00:20:33.545431 | debian-bookworm | ok 2025-11-09 00:20:33.552907 | 2025-11-09 00:20:33.553670 | TASK [ensure-tox : Output tox version] 2025-11-09 00:20:34.064018 | 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-09 00:20:34.082608 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-09 00:20:34.594157 | debian-bookworm | ok: Runtime: 0:00:00.311086 2025-11-09 00:20:34.600112 | 2025-11-09 00:20:34.600227 | TASK [ensure-tox : Make global symlink] 2025-11-09 00:20:34.624418 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:20:34.630932 | 2025-11-09 00:20:34.631018 | PLAY RECAP 2025-11-09 00:20:34.631071 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-09 00:20:34.631095 | 2025-11-09 00:20:34.772299 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-09 00:20:34.773557 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-09 00:20:35.521184 | 2025-11-09 00:20:35.521339 | PLAY [all] 2025-11-09 00:20:35.537073 | 2025-11-09 00:20:35.537210 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-09 00:20:36.074837 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-09 00:20:36.573149 | debian-bookworm | ok: Runtime: 0:00:00.034864 2025-11-09 00:20:36.584904 | 2025-11-09 00:20:36.585102 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-09 00:20:37.119886 | debian-bookworm | ok: Runtime: 0:00:00.006735 2025-11-09 00:20:37.133449 | 2025-11-09 00:20:37.133579 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-09 00:20:37.426715 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-09 00:20:37.427657 | debian-bookworm | sudo: a password is required 2025-11-09 00:20:37.663559 | debian-bookworm | ok: Runtime: 0:00:00.022684 2025-11-09 00:20:37.674624 | 2025-11-09 00:20:37.674731 | TASK [tox : Check to see if the constraints file exists] 2025-11-09 00:20:37.708959 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:20:37.716366 | 2025-11-09 00:20:37.716527 | TASK [tox : Fail if constraints file is missing] 2025-11-09 00:20:37.741868 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:20:37.749471 | 2025-11-09 00:20:37.749586 | TASK [tox : Record file location] 2025-11-09 00:20:37.773596 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:20:37.780994 | 2025-11-09 00:20:37.781109 | TASK [tox : Install tox siblings] 2025-11-09 00:20:37.800943 | debian-bookworm | ok 2025-11-09 00:20:37.810015 | debian-bookworm | included: /var/lib/zuul/builds/ad6eb3438a064c958ce8e74de28b8f9a/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-09 00:20:37.816430 | 2025-11-09 00:20:37.816536 | TASK [tox : Run tox without tests] 2025-11-09 00:20:38.949033 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-09 00:20:52.809147 | debian-bookworm | test: OK (14.43 seconds) 2025-11-09 00:20:52.809220 | debian-bookworm | congratulations :) (14.46 seconds) 2025-11-09 00:20:52.900478 | debian-bookworm | ok: Runtime: 0:00:14.732324 2025-11-09 00:20:52.909054 | 2025-11-09 00:20:52.909189 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-09 00:20:53.318092 | debian-bookworm | changed 2025-11-09 00:20:53.330166 | 2025-11-09 00:20:53.330334 | TASK [tox : Get tox envlist config] 2025-11-09 00:20:54.368610 | debian-bookworm | ok: Runtime: 0:00:00.282045 2025-11-09 00:20:54.375264 | 2025-11-09 00:20:54.375432 | TASK [tox : Install any sibling python packages] 2025-11-09 00:20:54.799356 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-09 00:20:54.807923 | 2025-11-09 00:20:54.808053 | TASK [tox : Remove tempfile] 2025-11-09 00:20:55.203884 | debian-bookworm | changed 2025-11-09 00:20:55.209654 | 2025-11-09 00:20:55.209761 | TASK [tox : Emit tox command] 2025-11-09 00:20:55.260158 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-09 00:20:55.281309 | 2025-11-09 00:20:55.281454 | TASK [tox : Run tox] 2025-11-09 00:20:55.840438 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-09 00:20:56.403361 | debian-bookworm | ............... 2025-11-09 00:20:56.403397 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-09 00:20:56.403410 | debian-bookworm | Ran 15 tests in 0.165s 2025-11-09 00:20:56.403415 | debian-bookworm | 2025-11-09 00:20:56.403679 | debian-bookworm | OK 2025-11-09 00:20:56.466869 | debian-bookworm | test: OK (0.66=setup[0.04]+cmd[0.62] seconds) 2025-11-09 00:20:56.466923 | debian-bookworm | congratulations :) (0.69 seconds) 2025-11-09 00:20:56.843701 | debian-bookworm | ok: Runtime: 0:00:00.944400 2025-11-09 00:20:56.855859 | 2025-11-09 00:20:56.856010 | TASK [tox : Look for output] 2025-11-09 00:20:57.225766 | debian-bookworm | ok 2025-11-09 00:20:57.242116 | 2025-11-09 00:20:57.242228 | TASK [tox : Return file comments to Zuul] 2025-11-09 00:20:57.276116 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:20:57.286163 | 2025-11-09 00:20:57.286269 | PLAY RECAP 2025-11-09 00:20:57.286349 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-09 00:20:57.286448 | 2025-11-09 00:20:57.408792 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-09 00:20:57.411823 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-09 00:20:58.157128 | 2025-11-09 00:20:58.157285 | PLAY [all] 2025-11-09 00:20:58.173089 | 2025-11-09 00:20:58.173230 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-09 00:20:58.228937 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:20:58.241653 | 2025-11-09 00:20:58.241855 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-09 00:20:58.275891 | debian-bookworm | ok 2025-11-09 00:20:58.283807 | 2025-11-09 00:20:58.283952 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-09 00:20:58.755324 | debian-bookworm -> localhost | changed 2025-11-09 00:20:58.772123 | 2025-11-09 00:20:58.772269 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-09 00:20:58.817557 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:20:58.829742 | 2025-11-09 00:20:58.829910 | TASK [fetch-tox-output : Set envlist fact] 2025-11-09 00:20:58.867737 | debian-bookworm | ok 2025-11-09 00:20:58.877408 | 2025-11-09 00:20:58.877568 | TASK [fetch-tox-output : Get tox version] 2025-11-09 00:20:59.504107 | 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-09 00:20:59.521345 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-09 00:20:59.910586 | debian-bookworm | ok: Runtime: 0:00:00.254091 2025-11-09 00:20:59.916554 | 2025-11-09 00:20:59.916671 | TASK [fetch-tox-output : Find all default environments] 2025-11-09 00:21:00.444883 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:21:00.459988 | 2025-11-09 00:21:00.460224 | TASK [fetch-tox-output : Set envlist fact] 2025-11-09 00:21:00.497908 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:21:00.509953 | 2025-11-09 00:21:00.510116 | TASK [fetch-tox-output : Find all default environments] 2025-11-09 00:21:01.042449 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:21:01.055039 | 2025-11-09 00:21:01.055226 | TASK [fetch-tox-output : Set envlist fact] 2025-11-09 00:21:01.080598 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:21:01.093064 | 2025-11-09 00:21:01.093225 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-09 00:21:01.136492 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:21:01.151865 | 2025-11-09 00:21:01.152027 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-09 00:21:01.944624 | debian-bookworm | changed: 2025-11-09 00:21:01.944820 | debian-bookworm | created directory /var/lib/zuul/builds/ad6eb3438a064c958ce8e74de28b8f9a/work/logs/tox/test 2025-11-09 00:21:01.944855 | debian-bookworm | cd+++++++++ ./ 2025-11-09 00:21:01.944880 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-09 00:21:01.944909 | 2025-11-09 00:21:01.963261 | 2025-11-09 00:21:01.963427 | PLAY RECAP 2025-11-09 00:21:01.963586 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-09 00:21:01.963641 | 2025-11-09 00:21:02.091695 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-09 00:21:02.093241 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-09 00:21:02.820992 | 2025-11-09 00:21:02.821142 | PLAY [all] 2025-11-09 00:21:02.836458 | 2025-11-09 00:21:02.836586 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-09 00:21:03.050194 | debian-bookworm | changed: non-zero return code 2025-11-09 00:21:03.055930 | 2025-11-09 00:21:03.056071 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-09 00:21:03.079931 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:21:03.086631 | 2025-11-09 00:21:03.086753 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-09 00:21:03.123895 | 2025-11-09 00:21:03.124199 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-09 00:21:03.164826 | 2025-11-09 00:21:03.165099 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-09 00:21:03.189731 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:21:03.201439 | 2025-11-09 00:21:03.201604 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-09 00:21:03.234756 | 2025-11-09 00:21:03.235046 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-09 00:21:03.259768 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:21:03.270722 | 2025-11-09 00:21:03.270913 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-09 00:21:03.295089 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:21:03.305318 | 2025-11-09 00:21:03.305523 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-09 00:21:03.329789 | debian-bookworm | skipping: Conditional result was False 2025-11-09 00:21:03.342579 | 2025-11-09 00:21:03.342688 | PLAY RECAP 2025-11-09 00:21:03.342764 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-09 00:21:03.342804 | 2025-11-09 00:21:03.460293 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-09 00:21:03.461412 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-09 00:21:04.210022 | 2025-11-09 00:21:04.210179 | PLAY [Base post] 2025-11-09 00:21:04.224237 | 2025-11-09 00:21:04.224387 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-09 00:21:04.879840 | debian-bookworm | changed 2025-11-09 00:21:04.890131 | 2025-11-09 00:21:04.890264 | PLAY RECAP 2025-11-09 00:21:04.890345 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-09 00:21:04.890448 | 2025-11-09 00:21:05.016268 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-09 00:21:05.017678 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-09 00:21:05.810001 | 2025-11-09 00:21:05.810155 | PLAY [Base post-logs] 2025-11-09 00:21:05.821171 | 2025-11-09 00:21:05.821296 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-09 00:21:06.257519 | localhost | changed 2025-11-09 00:21:06.290925 | 2025-11-09 00:21:06.291691 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-09 00:21:06.337000 | localhost | ok 2025-11-09 00:21:06.342558 | 2025-11-09 00:21:06.342747 | TASK [Set zuul-log-path fact] 2025-11-09 00:21:06.358828 | localhost | ok 2025-11-09 00:21:06.370697 | 2025-11-09 00:21:06.370814 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-09 00:21:06.408774 | localhost | ok 2025-11-09 00:21:06.417222 | 2025-11-09 00:21:06.417463 | TASK [upload-logs : Create log directories] 2025-11-09 00:21:06.951394 | localhost | changed 2025-11-09 00:21:06.956112 | 2025-11-09 00:21:06.956261 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-09 00:21:07.439891 | localhost -> localhost | ok: Runtime: 0:00:00.007243 2025-11-09 00:21:07.449847 | 2025-11-09 00:21:07.450026 | TASK [upload-logs : Upload logs to log server] 2025-11-09 00:21:08.001519 | localhost | Output suppressed because no_log was given 2025-11-09 00:21:08.007197 | 2025-11-09 00:21:08.007603 | LOOP [upload-logs : Compress console log and json output] 2025-11-09 00:21:08.058094 | localhost | skipping: Conditional result was False 2025-11-09 00:21:08.063076 | localhost | skipping: Conditional result was False 2025-11-09 00:21:08.070470 | 2025-11-09 00:21:08.070685 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-09 00:21:08.114447 | localhost | skipping: Conditional result was False 2025-11-09 00:21:08.115023 | 2025-11-09 00:21:08.118700 | localhost | skipping: Conditional result was False 2025-11-09 00:21:08.131744 | 2025-11-09 00:21:08.131931 | LOOP [upload-logs : Upload console log and json output]