2026-01-12 03:03:05.231512 | Job console starting 2026-01-12 03:03:05.240263 | Updating git repos 2026-01-12 03:03:05.280536 | Cloning repos into workspace 2026-01-12 03:03:05.507303 | Restoring repo states 2026-01-12 03:03:05.532176 | Merging changes 2026-01-12 03:03:05.532220 | Checking out repos 2026-01-12 03:03:05.652625 | Preparing playbooks 2026-01-12 03:03:07.483589 | Running Ansible setup 2026-01-12 03:03:15.981588 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-12 03:03:17.706052 | 2026-01-12 03:03:17.706248 | PLAY [Base pre] 2026-01-12 03:03:17.776154 | 2026-01-12 03:03:17.776334 | TASK [Setup log path fact] 2026-01-12 03:03:17.825906 | debian-bookworm | ok 2026-01-12 03:03:17.864965 | 2026-01-12 03:03:17.865146 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-12 03:03:17.937564 | debian-bookworm | ok 2026-01-12 03:03:17.969386 | 2026-01-12 03:03:17.970808 | TASK [emit-job-header : Print job information] 2026-01-12 03:03:18.043906 | # Job Information 2026-01-12 03:03:18.044104 | Ansible Version: 2.16.14 2026-01-12 03:03:18.044140 | Job: tox 2026-01-12 03:03:18.044171 | Pipeline: periodic-daily 2026-01-12 03:03:18.044194 | Executor: 521e9411259a 2026-01-12 03:03:18.044215 | Triggered by: https://github.com/osism/openstack-image-manager 2026-01-12 03:03:18.044238 | Event ID: 7f6791a896a14a2eb7126ad79442ff1d 2026-01-12 03:03:18.055742 | 2026-01-12 03:03:18.055898 | LOOP [emit-job-header : Print node information] 2026-01-12 03:03:18.358336 | debian-bookworm | ok: 2026-01-12 03:03:18.358568 | debian-bookworm | # Node Information 2026-01-12 03:03:18.358622 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-12 03:03:18.358652 | debian-bookworm | Hostname: debian 2026-01-12 03:03:18.358714 | debian-bookworm | Username: zuul 2026-01-12 03:03:18.358739 | debian-bookworm | Distro: Debian 12.13 2026-01-12 03:03:18.358774 | debian-bookworm | Provider: regiocloud-a 2026-01-12 03:03:18.358796 | debian-bookworm | Region: 2026-01-12 03:03:18.358817 | debian-bookworm | Label: debian-bookworm 2026-01-12 03:03:18.358857 | debian-bookworm | Product Name: OpenStack Nova 2026-01-12 03:03:18.358878 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb3:b095 2026-01-12 03:03:18.374329 | 2026-01-12 03:03:18.374489 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-12 03:03:19.549395 | debian-bookworm -> localhost | changed 2026-01-12 03:03:19.557316 | 2026-01-12 03:03:19.557464 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-12 03:03:22.466760 | debian-bookworm -> localhost | changed 2026-01-12 03:03:22.478513 | 2026-01-12 03:03:22.478653 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-12 03:03:23.188819 | debian-bookworm -> localhost | ok 2026-01-12 03:03:23.195754 | 2026-01-12 03:03:23.195905 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-12 03:03:23.245553 | debian-bookworm | ok 2026-01-12 03:03:23.285881 | debian-bookworm | included: /var/lib/zuul/builds/257f5416ec9f469a92de8ba69342cde0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-12 03:03:23.295756 | 2026-01-12 03:03:23.295905 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-12 03:03:30.377038 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-12 03:03:30.377248 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/257f5416ec9f469a92de8ba69342cde0/work/257f5416ec9f469a92de8ba69342cde0_id_rsa 2026-01-12 03:03:30.377280 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/257f5416ec9f469a92de8ba69342cde0/work/257f5416ec9f469a92de8ba69342cde0_id_rsa.pub 2026-01-12 03:03:30.377302 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-12 03:03:30.377322 | debian-bookworm -> localhost | SHA256:VIlSIIm7wdx34jL3azqiSM7u2B9jvF1gBwqvSlSBUFQ zuul-build-sshkey 2026-01-12 03:03:30.377340 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-12 03:03:30.377366 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-12 03:03:30.377389 | debian-bookworm -> localhost | |oo++E..o.... | 2026-01-12 03:03:30.377406 | debian-bookworm -> localhost | | .. o.. ... | 2026-01-12 03:03:30.377422 | debian-bookworm -> localhost | | o.+ ... | 2026-01-12 03:03:30.377438 | debian-bookworm -> localhost | | *o..oo. | 2026-01-12 03:03:30.377454 | debian-bookworm -> localhost | | . oooooS | 2026-01-12 03:03:30.377476 | debian-bookworm -> localhost | |. .oo.oo | 2026-01-12 03:03:30.377493 | debian-bookworm -> localhost | | o. =+ .. | 2026-01-12 03:03:30.377510 | debian-bookworm -> localhost | |*+ ..=..o | 2026-01-12 03:03:30.377527 | debian-bookworm -> localhost | |*=ooo.o+.. | 2026-01-12 03:03:30.377545 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-12 03:03:30.377588 | debian-bookworm -> localhost | ok: Runtime: 0:00:05.736594 2026-01-12 03:03:30.383301 | 2026-01-12 03:03:30.383396 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-12 03:03:30.440953 | debian-bookworm | ok 2026-01-12 03:03:30.468495 | debian-bookworm | included: /var/lib/zuul/builds/257f5416ec9f469a92de8ba69342cde0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-12 03:03:30.482701 | 2026-01-12 03:03:30.482796 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-12 03:03:30.505695 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:03:30.519143 | 2026-01-12 03:03:30.519258 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-12 03:03:31.350498 | debian-bookworm | changed 2026-01-12 03:03:31.364879 | 2026-01-12 03:03:31.365006 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-12 03:03:31.695358 | debian-bookworm | ok 2026-01-12 03:03:31.742444 | 2026-01-12 03:03:31.742611 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-12 03:03:32.662132 | debian-bookworm | changed 2026-01-12 03:03:32.670412 | 2026-01-12 03:03:32.670513 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-12 03:03:33.519045 | debian-bookworm | changed 2026-01-12 03:03:33.530978 | 2026-01-12 03:03:33.531083 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-12 03:03:33.589573 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:03:33.597276 | 2026-01-12 03:03:33.597400 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-12 03:03:34.787223 | debian-bookworm -> localhost | changed 2026-01-12 03:03:34.799114 | 2026-01-12 03:03:34.799218 | TASK [add-build-sshkey : Add back temp key] 2026-01-12 03:03:35.588999 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/257f5416ec9f469a92de8ba69342cde0/work/257f5416ec9f469a92de8ba69342cde0_id_rsa (zuul-build-sshkey) 2026-01-12 03:03:35.589982 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030577 2026-01-12 03:03:35.603975 | 2026-01-12 03:03:35.604076 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-12 03:03:36.129791 | debian-bookworm | ok 2026-01-12 03:03:36.143547 | 2026-01-12 03:03:36.143689 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-12 03:03:36.183571 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:03:36.203338 | 2026-01-12 03:03:36.203470 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-12 03:03:36.833508 | debian-bookworm | ok 2026-01-12 03:03:36.847514 | 2026-01-12 03:03:36.847619 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-12 03:03:36.882142 | debian-bookworm | ok 2026-01-12 03:03:36.889051 | 2026-01-12 03:03:36.889158 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-12 03:03:37.518073 | debian-bookworm -> localhost | ok 2026-01-12 03:03:37.544684 | 2026-01-12 03:03:37.544824 | TASK [validate-host : Collect information about the host] 2026-01-12 03:03:39.591200 | debian-bookworm | ok 2026-01-12 03:03:39.602122 | 2026-01-12 03:03:39.602275 | TASK [validate-host : Sanitize hostname] 2026-01-12 03:03:39.789224 | debian-bookworm | ok 2026-01-12 03:03:39.860450 | 2026-01-12 03:03:39.860602 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-12 03:03:41.156980 | debian-bookworm -> localhost | changed 2026-01-12 03:03:41.163097 | 2026-01-12 03:03:41.163230 | TASK [validate-host : Collect information about zuul worker] 2026-01-12 03:03:41.873314 | debian-bookworm | ok 2026-01-12 03:03:41.877970 | 2026-01-12 03:03:41.878072 | TASK [validate-host : Write out all zuul information for each host] 2026-01-12 03:03:42.821151 | debian-bookworm -> localhost | changed 2026-01-12 03:03:42.830508 | 2026-01-12 03:03:42.830641 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-12 03:03:43.165164 | debian-bookworm | ok 2026-01-12 03:03:43.171434 | 2026-01-12 03:03:43.171535 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-12 03:03:44.551802 | debian-bookworm | changed: 2026-01-12 03:03:44.551989 | debian-bookworm | cd+++++++++ src/ 2026-01-12 03:03:44.552026 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-12 03:03:44.552051 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-12 03:03:44.552073 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-12 03:03:44.552093 | debian-bookworm | =6.2.4 2026-01-12 03:04:09.718201 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-12 03:04:09.757185 | debian-bookworm | Collecting chardet>=5.2 2026-01-12 03:04:09.772300 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-12 03:04:09.795459 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.1 MB/s eta 0:00:00 2026-01-12 03:04:09.857240 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-12 03:04:09.873285 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-12 03:04:09.935481 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-12 03:04:09.950631 | debian-bookworm | Downloading filelock-3.20.3-py3-none-any.whl (16 kB) 2026-01-12 03:04:09.999799 | debian-bookworm | Collecting packaging>=25 2026-01-12 03:04:10.016582 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2026-01-12 03:04:10.064814 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 1.7 MB/s eta 0:00:00 2026-01-12 03:04:10.116799 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-12 03:04:10.132077 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-12 03:04:10.172995 | debian-bookworm | Collecting pluggy>=1.6 2026-01-12 03:04:10.188103 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-12 03:04:10.229782 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-12 03:04:10.246221 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-12 03:04:10.382214 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-12 03:04:10.397893 | debian-bookworm | Downloading virtualenv-20.36.1-py3-none-any.whl (6.0 MB) 2026-01-12 03:04:10.723231 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 18.8 MB/s eta 0:00:00 2026-01-12 03:04:10.828966 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-12 03:04:10.843948 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-12 03:04:10.878514 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 16.2 MB/s eta 0:00:00 2026-01-12 03:04:11.052627 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-12 03:04:11.978340 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.3 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.34.1 virtualenv-20.36.1 2026-01-12 03:04:12.526186 | debian-bookworm | ok: Runtime: 0:00:03.260902 2026-01-12 03:04:12.535864 | 2026-01-12 03:04:12.536116 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-12 03:04:12.669669 | debian-bookworm | ok 2026-01-12 03:04:12.687700 | 2026-01-12 03:04:12.687862 | TASK [ensure-tox : Output tox version] 2026-01-12 03:04:13.369236 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-01-12 03:04:13.387554 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-12 03:04:13.747131 | debian-bookworm | ok: Runtime: 0:00:00.323836 2026-01-12 03:04:13.753379 | 2026-01-12 03:04:13.753510 | TASK [ensure-tox : Make global symlink] 2026-01-12 03:04:13.800409 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:13.813989 | 2026-01-12 03:04:13.814140 | PLAY RECAP 2026-01-12 03:04:13.814233 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-12 03:04:13.814265 | 2026-01-12 03:04:14.329468 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-12 03:04:14.332116 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-12 03:04:16.336229 | 2026-01-12 03:04:16.336377 | PLAY [all] 2026-01-12 03:04:16.382559 | 2026-01-12 03:04:16.382709 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-12 03:04:17.425572 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-12 03:04:17.481854 | debian-bookworm | ok: Runtime: 0:00:00.029958 2026-01-12 03:04:17.489976 | 2026-01-12 03:04:17.490113 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-12 03:04:18.045091 | debian-bookworm | ok: Runtime: 0:00:00.007644 2026-01-12 03:04:18.050798 | 2026-01-12 03:04:18.056872 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-12 03:04:18.486793 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-12 03:04:18.489932 | debian-bookworm | sudo: a password is required 2026-01-12 03:04:18.649123 | debian-bookworm | ok: Runtime: 0:00:00.024358 2026-01-12 03:04:18.677832 | 2026-01-12 03:04:18.678020 | TASK [tox : Check to see if the constraints file exists] 2026-01-12 03:04:18.747671 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:18.757152 | 2026-01-12 03:04:18.757377 | TASK [tox : Fail if constraints file is missing] 2026-01-12 03:04:18.897737 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:18.909356 | 2026-01-12 03:04:18.909475 | TASK [tox : Record file location] 2026-01-12 03:04:19.015615 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:19.022239 | 2026-01-12 03:04:19.022406 | TASK [tox : Install tox siblings] 2026-01-12 03:04:19.083147 | debian-bookworm | ok 2026-01-12 03:04:19.103312 | debian-bookworm | included: /var/lib/zuul/builds/257f5416ec9f469a92de8ba69342cde0/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-12 03:04:19.120506 | 2026-01-12 03:04:19.120633 | TASK [tox : Run tox without tests] 2026-01-12 03:04:20.152796 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-12 03:04:33.727762 | debian-bookworm | test: OK (14.04 seconds) 2026-01-12 03:04:33.727846 | debian-bookworm | congratulations :) (14.06 seconds) 2026-01-12 03:04:34.186596 | debian-bookworm | ok: Runtime: 0:00:14.305669 2026-01-12 03:04:34.192977 | 2026-01-12 03:04:34.193103 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-12 03:04:35.028021 | debian-bookworm | changed 2026-01-12 03:04:35.038225 | 2026-01-12 03:04:35.038365 | TASK [tox : Get tox envlist config] 2026-01-12 03:04:36.119245 | debian-bookworm | ok: Runtime: 0:00:00.329849 2026-01-12 03:04:36.125556 | 2026-01-12 03:04:36.125691 | TASK [tox : Install any sibling python packages] 2026-01-12 03:04:36.983324 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-12 03:04:36.994121 | 2026-01-12 03:04:36.994260 | TASK [tox : Remove tempfile] 2026-01-12 03:04:37.922565 | debian-bookworm | changed 2026-01-12 03:04:37.928893 | 2026-01-12 03:04:37.929028 | TASK [tox : Emit tox command] 2026-01-12 03:04:37.969759 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-12 03:04:37.975115 | 2026-01-12 03:04:37.975247 | TASK [tox : Run tox] 2026-01-12 03:04:38.648749 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-12 03:04:39.322053 | debian-bookworm | ............... 2026-01-12 03:04:39.323451 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-12 03:04:39.323515 | debian-bookworm | Ran 15 tests in 0.181s 2026-01-12 03:04:39.323531 | debian-bookworm | 2026-01-12 03:04:39.323550 | debian-bookworm | OK 2026-01-12 03:04:39.407549 | debian-bookworm | test: OK (0.80=setup[0.04]+cmd[0.76] seconds) 2026-01-12 03:04:39.407649 | debian-bookworm | congratulations :) (0.83 seconds) 2026-01-12 03:04:39.564724 | debian-bookworm | ok: Runtime: 0:00:01.117124 2026-01-12 03:04:39.570728 | 2026-01-12 03:04:39.571109 | TASK [tox : Look for output] 2026-01-12 03:04:40.329705 | debian-bookworm | ok 2026-01-12 03:04:40.355984 | 2026-01-12 03:04:40.356144 | TASK [tox : Return file comments to Zuul] 2026-01-12 03:04:40.421376 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:40.448845 | 2026-01-12 03:04:40.449618 | PLAY RECAP 2026-01-12 03:04:40.449870 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-12 03:04:40.449949 | 2026-01-12 03:04:41.486424 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-12 03:04:41.487583 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-12 03:04:43.756894 | 2026-01-12 03:04:43.757095 | PLAY [all] 2026-01-12 03:04:43.801224 | 2026-01-12 03:04:43.801541 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-12 03:04:43.924611 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:43.933382 | 2026-01-12 03:04:43.933947 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-12 03:04:44.010989 | debian-bookworm | ok 2026-01-12 03:04:44.017234 | 2026-01-12 03:04:44.017382 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-12 03:04:45.387856 | debian-bookworm -> localhost | changed 2026-01-12 03:04:45.397409 | 2026-01-12 03:04:45.397562 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-12 03:04:45.499482 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:45.507161 | 2026-01-12 03:04:45.507330 | TASK [fetch-tox-output : Set envlist fact] 2026-01-12 03:04:45.593278 | debian-bookworm | ok 2026-01-12 03:04:45.605701 | 2026-01-12 03:04:45.605843 | TASK [fetch-tox-output : Get tox version] 2026-01-12 03:04:46.368775 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-01-12 03:04:46.387436 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-12 03:04:46.655440 | debian-bookworm | ok: Runtime: 0:00:00.297115 2026-01-12 03:04:46.670454 | 2026-01-12 03:04:46.670583 | TASK [fetch-tox-output : Find all default environments] 2026-01-12 03:04:47.230017 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:47.236685 | 2026-01-12 03:04:47.236898 | TASK [fetch-tox-output : Set envlist fact] 2026-01-12 03:04:47.294045 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:47.300600 | 2026-01-12 03:04:47.300761 | TASK [fetch-tox-output : Find all default environments] 2026-01-12 03:04:47.842237 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:47.849712 | 2026-01-12 03:04:47.849852 | TASK [fetch-tox-output : Set envlist fact] 2026-01-12 03:04:47.904846 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:47.913411 | 2026-01-12 03:04:47.913558 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-12 03:04:48.028519 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:48.037255 | 2026-01-12 03:04:48.037396 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-12 03:04:49.687691 | debian-bookworm | changed: 2026-01-12 03:04:49.691264 | debian-bookworm | created directory /var/lib/zuul/builds/257f5416ec9f469a92de8ba69342cde0/work/logs/tox/test 2026-01-12 03:04:49.691373 | debian-bookworm | cd+++++++++ ./ 2026-01-12 03:04:49.691404 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-12 03:04:49.691438 | 2026-01-12 03:04:49.705970 | 2026-01-12 03:04:49.706082 | PLAY RECAP 2026-01-12 03:04:49.706136 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-12 03:04:49.706162 | 2026-01-12 03:04:50.003323 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-12 03:04:50.004396 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-12 03:04:51.380328 | 2026-01-12 03:04:51.380510 | PLAY [all] 2026-01-12 03:04:51.411533 | 2026-01-12 03:04:51.411746 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-12 03:04:51.702373 | debian-bookworm | changed: non-zero return code 2026-01-12 03:04:51.713314 | 2026-01-12 03:04:51.713543 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-12 03:04:51.740207 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:51.751680 | 2026-01-12 03:04:51.751894 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-12 03:04:51.803054 | 2026-01-12 03:04:51.803390 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-12 03:04:51.848493 | 2026-01-12 03:04:51.848749 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-12 03:04:51.873158 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:51.880369 | 2026-01-12 03:04:51.880526 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-12 03:04:51.939638 | 2026-01-12 03:04:51.939877 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-12 03:04:51.985506 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:51.992100 | 2026-01-12 03:04:51.992403 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-12 03:04:52.047156 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:52.053481 | 2026-01-12 03:04:52.053667 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-12 03:04:52.088267 | debian-bookworm | skipping: Conditional result was False 2026-01-12 03:04:52.103090 | 2026-01-12 03:04:52.103225 | PLAY RECAP 2026-01-12 03:04:52.103282 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-12 03:04:52.103307 | 2026-01-12 03:04:52.344495 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-12 03:04:52.345702 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-12 03:04:53.580016 | 2026-01-12 03:04:53.580198 | PLAY [Base post] 2026-01-12 03:04:53.598868 | 2026-01-12 03:04:53.599029 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-12 03:04:54.181344 | debian-bookworm | changed 2026-01-12 03:04:54.194224 | 2026-01-12 03:04:54.194532 | PLAY RECAP 2026-01-12 03:04:54.196310 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-12 03:04:54.196421 | 2026-01-12 03:04:54.480595 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-12 03:04:54.481755 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-12 03:04:55.726875 | 2026-01-12 03:04:55.727061 | PLAY [Base post-logs] 2026-01-12 03:04:55.740744 | 2026-01-12 03:04:55.740929 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-12 03:04:56.407055 | localhost | changed 2026-01-12 03:04:56.422503 | 2026-01-12 03:04:56.422719 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-12 03:04:56.486486 | localhost | ok 2026-01-12 03:04:56.489836 | 2026-01-12 03:04:56.489953 | TASK [Set zuul-log-path fact] 2026-01-12 03:04:56.520334 | localhost | ok 2026-01-12 03:04:56.535842 | 2026-01-12 03:04:56.535989 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-12 03:04:56.602559 | localhost | ok 2026-01-12 03:04:56.606511 | 2026-01-12 03:04:56.606663 | TASK [upload-logs : Create log directories] 2026-01-12 03:04:57.510865 | localhost | changed 2026-01-12 03:04:57.516428 | 2026-01-12 03:04:57.516591 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-12 03:04:58.442768 | localhost -> localhost | ok: Runtime: 0:00:00.030755 2026-01-12 03:04:58.447778 | 2026-01-12 03:04:58.447908 | TASK [upload-logs : Upload logs to log server] 2026-01-12 03:04:59.844172 | localhost | Output suppressed because no_log was given 2026-01-12 03:04:59.848605 | 2026-01-12 03:04:59.849141 | LOOP [upload-logs : Compress console log and json output] 2026-01-12 03:04:59.944250 | localhost | skipping: Conditional result was False 2026-01-12 03:04:59.953136 | localhost | skipping: Conditional result was False 2026-01-12 03:04:59.962124 | 2026-01-12 03:04:59.962268 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-12 03:05:00.125968 | localhost | skipping: Conditional result was False 2026-01-12 03:05:00.126256 | 2026-01-12 03:05:00.142605 | localhost | skipping: Conditional result was False 2026-01-12 03:05:00.158703 | 2026-01-12 03:05:00.158883 | LOOP [upload-logs : Upload console log and json output]