2026-01-23 00:19:25.251563 | Job console starting 2026-01-23 00:19:25.265133 | Updating git repos 2026-01-23 00:19:25.291119 | Cloning repos into workspace 2026-01-23 00:19:25.375873 | Restoring repo states 2026-01-23 00:19:25.401000 | Merging changes 2026-01-23 00:19:25.881171 | Checking out repos 2026-01-23 00:19:25.920239 | Preparing playbooks 2026-01-23 00:19:26.600479 | Running Ansible setup 2026-01-23 00:19:31.409467 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-23 00:19:32.246599 | 2026-01-23 00:19:32.246802 | PLAY [Base pre] 2026-01-23 00:19:32.264203 | 2026-01-23 00:19:32.264405 | TASK [Setup log path fact] 2026-01-23 00:19:32.284377 | debian-bookworm | ok 2026-01-23 00:19:32.301474 | 2026-01-23 00:19:32.301624 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-23 00:19:32.362427 | debian-bookworm | ok 2026-01-23 00:19:32.388427 | 2026-01-23 00:19:32.388565 | TASK [emit-job-header : Print job information] 2026-01-23 00:19:32.460307 | # Job Information 2026-01-23 00:19:32.460488 | Ansible Version: 2.16.14 2026-01-23 00:19:32.460524 | Job: tox 2026-01-23 00:19:32.460556 | Pipeline: check 2026-01-23 00:19:32.460579 | Executor: 521e9411259a 2026-01-23 00:19:32.460601 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1104 2026-01-23 00:19:32.460626 | Event ID: 26ab1290-f7f1-11f0-82a8-41bd6bac191d 2026-01-23 00:19:32.465607 | 2026-01-23 00:19:32.465751 | LOOP [emit-job-header : Print node information] 2026-01-23 00:19:32.695408 | debian-bookworm | ok: 2026-01-23 00:19:32.695608 | debian-bookworm | # Node Information 2026-01-23 00:19:32.695643 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-23 00:19:32.695667 | debian-bookworm | Hostname: debian 2026-01-23 00:19:32.695690 | debian-bookworm | Username: zuul 2026-01-23 00:19:32.695711 | debian-bookworm | Distro: Debian 12.13 2026-01-23 00:19:32.695771 | debian-bookworm | Provider: regiocloud-a 2026-01-23 00:19:32.695794 | debian-bookworm | Region: 2026-01-23 00:19:32.695816 | debian-bookworm | Label: debian-bookworm 2026-01-23 00:19:32.695837 | debian-bookworm | Product Name: OpenStack Nova 2026-01-23 00:19:32.695857 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9c:520c 2026-01-23 00:19:32.708343 | 2026-01-23 00:19:32.708483 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-23 00:19:33.375324 | debian-bookworm -> localhost | changed 2026-01-23 00:19:33.383623 | 2026-01-23 00:19:33.383776 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-23 00:19:34.794424 | debian-bookworm -> localhost | changed 2026-01-23 00:19:34.807716 | 2026-01-23 00:19:34.807916 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-23 00:19:35.177281 | debian-bookworm -> localhost | ok 2026-01-23 00:19:35.183814 | 2026-01-23 00:19:35.183946 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-23 00:19:35.223680 | debian-bookworm | ok 2026-01-23 00:19:35.265372 | debian-bookworm | included: /var/lib/zuul/builds/7a127f85fe034a66871bce858cae384f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-23 00:19:35.272103 | 2026-01-23 00:19:35.272211 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-23 00:19:36.236083 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-23 00:19:36.236860 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7a127f85fe034a66871bce858cae384f/work/7a127f85fe034a66871bce858cae384f_id_rsa 2026-01-23 00:19:36.236919 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7a127f85fe034a66871bce858cae384f/work/7a127f85fe034a66871bce858cae384f_id_rsa.pub 2026-01-23 00:19:36.236949 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-23 00:19:36.236977 | debian-bookworm -> localhost | SHA256:ITry8BO8CmUUmovAJqYaSDxKqfS+4dNGJGoj6cuz3dc zuul-build-sshkey 2026-01-23 00:19:36.237001 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-23 00:19:36.237035 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-23 00:19:36.237058 | debian-bookworm -> localhost | | . | 2026-01-23 00:19:36.237079 | debian-bookworm -> localhost | |oo.. | 2026-01-23 00:19:36.237099 | debian-bookworm -> localhost | |=@. . . | 2026-01-23 00:19:36.237119 | debian-bookworm -> localhost | |#ooo o . . | 2026-01-23 00:19:36.237139 | debian-bookworm -> localhost | |O.*.B S | 2026-01-23 00:19:36.237161 | debian-bookworm -> localhost | |+B.= = | 2026-01-23 00:19:36.237182 | debian-bookworm -> localhost | |* .oB . | 2026-01-23 00:19:36.237202 | debian-bookworm -> localhost | |.+oo++ . E | 2026-01-23 00:19:36.237223 | debian-bookworm -> localhost | | +=+o.. | 2026-01-23 00:19:36.237243 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-23 00:19:36.237296 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.367978 2026-01-23 00:19:36.243955 | 2026-01-23 00:19:36.244067 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-23 00:19:36.276063 | debian-bookworm | ok 2026-01-23 00:19:36.288954 | debian-bookworm | included: /var/lib/zuul/builds/7a127f85fe034a66871bce858cae384f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-23 00:19:36.303580 | 2026-01-23 00:19:36.303683 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-23 00:19:36.361565 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:19:36.373461 | 2026-01-23 00:19:36.373582 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-23 00:19:37.175767 | debian-bookworm | changed 2026-01-23 00:19:37.181277 | 2026-01-23 00:19:37.181381 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-23 00:19:37.433667 | debian-bookworm | ok 2026-01-23 00:19:37.439305 | 2026-01-23 00:19:37.439420 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-23 00:19:38.090686 | debian-bookworm | changed 2026-01-23 00:19:38.097981 | 2026-01-23 00:19:38.098088 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-23 00:19:38.795764 | debian-bookworm | changed 2026-01-23 00:19:38.803689 | 2026-01-23 00:19:38.803829 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-23 00:19:38.827995 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:19:38.841344 | 2026-01-23 00:19:38.841507 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-23 00:19:39.390202 | debian-bookworm -> localhost | changed 2026-01-23 00:19:39.402305 | 2026-01-23 00:19:39.402435 | TASK [add-build-sshkey : Add back temp key] 2026-01-23 00:19:39.844805 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7a127f85fe034a66871bce858cae384f/work/7a127f85fe034a66871bce858cae384f_id_rsa (zuul-build-sshkey) 2026-01-23 00:19:39.845207 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011926 2026-01-23 00:19:39.854670 | 2026-01-23 00:19:39.854824 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-23 00:19:40.450450 | debian-bookworm | ok 2026-01-23 00:19:40.456689 | 2026-01-23 00:19:40.456824 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-23 00:19:40.480892 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:19:40.492730 | 2026-01-23 00:19:40.492854 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-23 00:19:40.948636 | debian-bookworm | ok 2026-01-23 00:19:40.971621 | 2026-01-23 00:19:40.971861 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-23 00:19:41.006647 | debian-bookworm | ok 2026-01-23 00:19:41.015021 | 2026-01-23 00:19:41.015157 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-23 00:19:41.439333 | debian-bookworm -> localhost | ok 2026-01-23 00:19:41.446163 | 2026-01-23 00:19:41.446288 | TASK [validate-host : Collect information about the host] 2026-01-23 00:19:42.637427 | debian-bookworm | ok 2026-01-23 00:19:42.647643 | 2026-01-23 00:19:42.647795 | TASK [validate-host : Sanitize hostname] 2026-01-23 00:19:42.780334 | debian-bookworm | ok 2026-01-23 00:19:42.827588 | 2026-01-23 00:19:42.827768 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-23 00:19:43.403696 | debian-bookworm -> localhost | changed 2026-01-23 00:19:43.410525 | 2026-01-23 00:19:43.410655 | TASK [validate-host : Collect information about zuul worker] 2026-01-23 00:19:43.835154 | debian-bookworm | ok 2026-01-23 00:19:43.847166 | 2026-01-23 00:19:43.847326 | TASK [validate-host : Write out all zuul information for each host] 2026-01-23 00:19:44.523274 | debian-bookworm -> localhost | changed 2026-01-23 00:19:44.538403 | 2026-01-23 00:19:44.538684 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-23 00:19:44.820685 | debian-bookworm | ok 2026-01-23 00:19:44.827601 | 2026-01-23 00:19:44.827759 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-23 00:19:46.321938 | debian-bookworm | changed: 2026-01-23 00:19:46.322163 | debian-bookworm | cd+++++++++ src/ 2026-01-23 00:19:46.322198 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-23 00:19:46.322223 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-23 00:19:46.322245 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-23 00:19:46.322266 | debian-bookworm | =6.2.4 2026-01-23 00:20:09.634528 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-23 00:20:09.667417 | debian-bookworm | Collecting chardet>=5.2 2026-01-23 00:20:09.678698 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-23 00:20:09.751216 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 2.8 MB/s eta 0:00:00 2026-01-23 00:20:09.806956 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-23 00:20:09.818883 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-23 00:20:09.873660 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-23 00:20:09.884985 | debian-bookworm | Downloading filelock-3.20.3-py3-none-any.whl (16 kB) 2026-01-23 00:20:09.933856 | debian-bookworm | Collecting packaging>=25 2026-01-23 00:20:09.944867 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-01-23 00:20:09.964724 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 3.9 MB/s eta 0:00:00 2026-01-23 00:20:10.009665 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-23 00:20:10.021183 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-23 00:20:10.061527 | debian-bookworm | Collecting pluggy>=1.6 2026-01-23 00:20:10.073000 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-23 00:20:10.226804 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-23 00:20:10.240263 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-23 00:20:10.373167 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-23 00:20:10.385236 | debian-bookworm | Downloading virtualenv-20.36.1-py3-none-any.whl (6.0 MB) 2026-01-23 00:20:10.710763 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 18.7 MB/s eta 0:00:00 2026-01-23 00:20:10.826956 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-23 00:20:10.838854 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-23 00:20:10.864040 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.6 MB/s eta 0:00:00 2026-01-23 00:20:11.017482 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-23 00:20:11.900854 | 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-26.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.34.1 virtualenv-20.36.1 2026-01-23 00:20:12.519299 | debian-bookworm | ok: Runtime: 0:00:03.244965 2026-01-23 00:20:12.526442 | 2026-01-23 00:20:12.526580 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-23 00:20:12.560940 | debian-bookworm | ok 2026-01-23 00:20:12.572147 | 2026-01-23 00:20:12.572271 | TASK [ensure-tox : Output tox version] 2026-01-23 00:20:13.114620 | 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-23 00:20:13.137657 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-23 00:20:13.605437 | debian-bookworm | ok: Runtime: 0:00:00.337370 2026-01-23 00:20:13.624805 | 2026-01-23 00:20:13.624970 | TASK [ensure-tox : Make global symlink] 2026-01-23 00:20:13.659826 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:13.676625 | 2026-01-23 00:20:13.676804 | PLAY RECAP 2026-01-23 00:20:13.676868 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-23 00:20:13.676894 | 2026-01-23 00:20:13.928500 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-23 00:20:13.929608 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-23 00:20:14.728445 | 2026-01-23 00:20:14.728621 | PLAY [all] 2026-01-23 00:20:14.746988 | 2026-01-23 00:20:14.747141 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-23 00:20:15.224618 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-23 00:20:15.289259 | debian-bookworm | ok: Runtime: 0:00:00.033410 2026-01-23 00:20:15.297580 | 2026-01-23 00:20:15.297997 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-23 00:20:15.828632 | debian-bookworm | ok: Runtime: 0:00:00.006882 2026-01-23 00:20:15.841919 | 2026-01-23 00:20:15.842093 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-23 00:20:16.204655 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-23 00:20:16.205881 | debian-bookworm | sudo: a password is required 2026-01-23 00:20:16.377362 | debian-bookworm | ok: Runtime: 0:00:00.023210 2026-01-23 00:20:16.399156 | 2026-01-23 00:20:16.399308 | TASK [tox : Check to see if the constraints file exists] 2026-01-23 00:20:16.434906 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:16.441152 | 2026-01-23 00:20:16.441274 | TASK [tox : Fail if constraints file is missing] 2026-01-23 00:20:16.485479 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:16.497535 | 2026-01-23 00:20:16.497768 | TASK [tox : Record file location] 2026-01-23 00:20:16.525270 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:16.535308 | 2026-01-23 00:20:16.535460 | TASK [tox : Install tox siblings] 2026-01-23 00:20:16.572206 | debian-bookworm | ok 2026-01-23 00:20:16.583461 | debian-bookworm | included: /var/lib/zuul/builds/7a127f85fe034a66871bce858cae384f/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-23 00:20:16.589783 | 2026-01-23 00:20:16.589915 | TASK [tox : Run tox without tests] 2026-01-23 00:20:17.749539 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-23 00:20:31.508118 | debian-bookworm | test: OK (14.37 seconds) 2026-01-23 00:20:31.508239 | debian-bookworm | congratulations :) (14.40 seconds) 2026-01-23 00:20:31.630679 | debian-bookworm | ok: Runtime: 0:00:14.683053 2026-01-23 00:20:31.643690 | 2026-01-23 00:20:31.643868 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-23 00:20:32.072264 | debian-bookworm | changed 2026-01-23 00:20:32.078884 | 2026-01-23 00:20:32.079013 | TASK [tox : Get tox envlist config] 2026-01-23 00:20:33.107985 | debian-bookworm | ok: Runtime: 0:00:00.296292 2026-01-23 00:20:33.121797 | 2026-01-23 00:20:33.122000 | TASK [tox : Install any sibling python packages] 2026-01-23 00:20:33.565274 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-23 00:20:33.574142 | 2026-01-23 00:20:33.574277 | TASK [tox : Remove tempfile] 2026-01-23 00:20:33.975471 | debian-bookworm | changed 2026-01-23 00:20:33.983818 | 2026-01-23 00:20:33.983950 | TASK [tox : Emit tox command] 2026-01-23 00:20:34.039947 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-23 00:20:34.048563 | 2026-01-23 00:20:34.048773 | TASK [tox : Run tox] 2026-01-23 00:20:34.640318 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-23 00:20:35.221341 | debian-bookworm | ............... 2026-01-23 00:20:35.221377 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-23 00:20:35.221390 | debian-bookworm | Ran 15 tests in 0.163s 2026-01-23 00:20:35.221395 | debian-bookworm | 2026-01-23 00:20:35.221402 | debian-bookworm | OK 2026-01-23 00:20:35.283793 | debian-bookworm | test: OK (0.68=setup[0.04]+cmd[0.64] seconds) 2026-01-23 00:20:35.283838 | debian-bookworm | congratulations :) (0.71 seconds) 2026-01-23 00:20:35.616986 | debian-bookworm | ok: Runtime: 0:00:00.964593 2026-01-23 00:20:35.628883 | 2026-01-23 00:20:35.629037 | TASK [tox : Look for output] 2026-01-23 00:20:36.011045 | debian-bookworm | ok 2026-01-23 00:20:36.028264 | 2026-01-23 00:20:36.028381 | TASK [tox : Return file comments to Zuul] 2026-01-23 00:20:36.072574 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:36.086669 | 2026-01-23 00:20:36.086855 | PLAY RECAP 2026-01-23 00:20:36.086943 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-23 00:20:36.086986 | 2026-01-23 00:20:36.213405 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-23 00:20:36.216587 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-23 00:20:36.961353 | 2026-01-23 00:20:36.961512 | PLAY [all] 2026-01-23 00:20:36.977202 | 2026-01-23 00:20:36.977331 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-23 00:20:37.043370 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:37.055480 | 2026-01-23 00:20:37.055679 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-23 00:20:37.099307 | debian-bookworm | ok 2026-01-23 00:20:37.106642 | 2026-01-23 00:20:37.106801 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-23 00:20:37.586988 | debian-bookworm -> localhost | changed 2026-01-23 00:20:37.599098 | 2026-01-23 00:20:37.599261 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-23 00:20:37.654821 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:37.669337 | 2026-01-23 00:20:37.669533 | TASK [fetch-tox-output : Set envlist fact] 2026-01-23 00:20:37.715921 | debian-bookworm | ok 2026-01-23 00:20:37.725080 | 2026-01-23 00:20:37.725224 | TASK [fetch-tox-output : Get tox version] 2026-01-23 00:20:38.407997 | 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-23 00:20:38.425997 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-23 00:20:38.761813 | debian-bookworm | ok: Runtime: 0:00:00.291715 2026-01-23 00:20:38.775443 | 2026-01-23 00:20:38.775606 | TASK [fetch-tox-output : Find all default environments] 2026-01-23 00:20:39.309068 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:39.322489 | 2026-01-23 00:20:39.322670 | TASK [fetch-tox-output : Set envlist fact] 2026-01-23 00:20:39.358499 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:39.373463 | 2026-01-23 00:20:39.373655 | TASK [fetch-tox-output : Find all default environments] 2026-01-23 00:20:39.906242 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:39.920977 | 2026-01-23 00:20:39.921175 | TASK [fetch-tox-output : Set envlist fact] 2026-01-23 00:20:39.957313 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:39.972089 | 2026-01-23 00:20:39.972275 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-23 00:20:40.030038 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:40.058605 | 2026-01-23 00:20:40.058816 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-23 00:20:40.853805 | debian-bookworm | changed: 2026-01-23 00:20:40.854114 | debian-bookworm | created directory /var/lib/zuul/builds/7a127f85fe034a66871bce858cae384f/work/logs/tox/test 2026-01-23 00:20:40.854176 | debian-bookworm | cd+++++++++ ./ 2026-01-23 00:20:40.854220 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-23 00:20:40.854269 | 2026-01-23 00:20:40.874913 | 2026-01-23 00:20:40.875054 | PLAY RECAP 2026-01-23 00:20:40.875135 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-23 00:20:40.875173 | 2026-01-23 00:20:41.020085 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-23 00:20:41.021416 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-23 00:20:41.785646 | 2026-01-23 00:20:41.785831 | PLAY [all] 2026-01-23 00:20:41.803297 | 2026-01-23 00:20:41.803447 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-23 00:20:42.035855 | debian-bookworm | changed: non-zero return code 2026-01-23 00:20:42.041452 | 2026-01-23 00:20:42.041584 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-23 00:20:42.066018 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:42.071799 | 2026-01-23 00:20:42.071916 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-23 00:20:42.110054 | 2026-01-23 00:20:42.110344 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-23 00:20:42.150643 | 2026-01-23 00:20:42.150978 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-23 00:20:42.167040 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:42.177737 | 2026-01-23 00:20:42.177900 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-23 00:20:42.211253 | 2026-01-23 00:20:42.211523 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-23 00:20:42.226901 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:42.240848 | 2026-01-23 00:20:42.241028 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-23 00:20:42.266069 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:42.276176 | 2026-01-23 00:20:42.276337 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-23 00:20:42.301123 | debian-bookworm | skipping: Conditional result was False 2026-01-23 00:20:42.316545 | 2026-01-23 00:20:42.316696 | PLAY RECAP 2026-01-23 00:20:42.316798 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-23 00:20:42.316842 | 2026-01-23 00:20:42.449825 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-23 00:20:42.450933 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-23 00:20:43.209245 | 2026-01-23 00:20:43.209422 | PLAY [Base post] 2026-01-23 00:20:43.223212 | 2026-01-23 00:20:43.223351 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-23 00:20:43.782474 | debian-bookworm | changed 2026-01-23 00:20:43.788903 | 2026-01-23 00:20:43.789008 | PLAY RECAP 2026-01-23 00:20:43.789068 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-23 00:20:43.789127 | 2026-01-23 00:20:43.908850 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-23 00:20:43.909950 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-23 00:20:44.715796 | 2026-01-23 00:20:44.715968 | PLAY [Base post-logs] 2026-01-23 00:20:44.727074 | 2026-01-23 00:20:44.727223 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-23 00:20:45.202798 | localhost | changed 2026-01-23 00:20:45.224300 | 2026-01-23 00:20:45.224535 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-23 00:20:45.285379 | localhost | ok 2026-01-23 00:20:45.296254 | 2026-01-23 00:20:45.296493 | TASK [Set zuul-log-path fact] 2026-01-23 00:20:45.325320 | localhost | ok 2026-01-23 00:20:45.335520 | 2026-01-23 00:20:45.335647 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-23 00:20:45.380101 | localhost | ok 2026-01-23 00:20:45.393532 | 2026-01-23 00:20:45.394097 | TASK [upload-logs : Create log directories] 2026-01-23 00:20:45.957547 | localhost | changed 2026-01-23 00:20:45.961409 | 2026-01-23 00:20:45.961534 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-23 00:20:46.453041 | localhost -> localhost | ok: Runtime: 0:00:00.007549 2026-01-23 00:20:46.461048 | 2026-01-23 00:20:46.461235 | TASK [upload-logs : Upload logs to log server] 2026-01-23 00:20:47.043572 | localhost | Output suppressed because no_log was given 2026-01-23 00:20:47.045441 | 2026-01-23 00:20:47.045549 | LOOP [upload-logs : Compress console log and json output] 2026-01-23 00:20:47.102965 | localhost | skipping: Conditional result was False 2026-01-23 00:20:47.108993 | localhost | skipping: Conditional result was False 2026-01-23 00:20:47.116536 | 2026-01-23 00:20:47.116825 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-23 00:20:47.171172 | localhost | skipping: Conditional result was False 2026-01-23 00:20:47.171812 | 2026-01-23 00:20:47.175486 | localhost | skipping: Conditional result was False 2026-01-23 00:20:47.189493 | 2026-01-23 00:20:47.189793 | LOOP [upload-logs : Upload console log and json output]