2026-01-05 03:20:15.458478 | Job console starting 2026-01-05 03:20:15.474219 | Updating git repos 2026-01-05 03:20:15.526068 | Cloning repos into workspace 2026-01-05 03:20:15.629135 | Restoring repo states 2026-01-05 03:20:15.675570 | Merging changes 2026-01-05 03:20:15.675594 | Checking out repos 2026-01-05 03:20:15.795744 | Preparing playbooks 2026-01-05 03:20:17.136639 | Running Ansible setup 2026-01-05 03:20:25.277768 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-05 03:20:27.208583 | 2026-01-05 03:20:27.208763 | PLAY [Base pre] 2026-01-05 03:20:27.235358 | 2026-01-05 03:20:27.235549 | TASK [Setup log path fact] 2026-01-05 03:20:27.275441 | debian-bookworm | ok 2026-01-05 03:20:27.294055 | 2026-01-05 03:20:27.294308 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-05 03:20:27.470979 | debian-bookworm | ok 2026-01-05 03:20:27.510114 | 2026-01-05 03:20:27.510301 | TASK [emit-job-header : Print job information] 2026-01-05 03:20:27.656775 | # Job Information 2026-01-05 03:20:27.656984 | Ansible Version: 2.16.14 2026-01-05 03:20:27.657024 | Job: tox 2026-01-05 03:20:27.657057 | Pipeline: periodic-daily 2026-01-05 03:20:27.657080 | Executor: 521e9411259a 2026-01-05 03:20:27.657102 | Triggered by: https://github.com/osism/openstack-image-manager 2026-01-05 03:20:27.657126 | Event ID: fab18e68225b4777a255d0c228379edd 2026-01-05 03:20:27.666109 | 2026-01-05 03:20:27.666290 | LOOP [emit-job-header : Print node information] 2026-01-05 03:20:27.854090 | debian-bookworm | ok: 2026-01-05 03:20:27.854322 | debian-bookworm | # Node Information 2026-01-05 03:20:27.854358 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-05 03:20:27.854383 | debian-bookworm | Hostname: debian 2026-01-05 03:20:27.854404 | debian-bookworm | Username: zuul 2026-01-05 03:20:27.854425 | debian-bookworm | Distro: Debian 12.12 2026-01-05 03:20:27.854448 | debian-bookworm | Provider: regiocloud-a 2026-01-05 03:20:27.854469 | debian-bookworm | Region: 2026-01-05 03:20:27.854490 | debian-bookworm | Label: debian-bookworm 2026-01-05 03:20:27.854510 | debian-bookworm | Product Name: OpenStack Nova 2026-01-05 03:20:27.854530 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe74:c231 2026-01-05 03:20:27.903749 | 2026-01-05 03:20:27.903907 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-05 03:20:28.723464 | debian-bookworm -> localhost | changed 2026-01-05 03:20:28.731915 | 2026-01-05 03:20:28.732062 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-05 03:20:30.287610 | debian-bookworm -> localhost | changed 2026-01-05 03:20:30.305535 | 2026-01-05 03:20:30.305692 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-05 03:20:30.712609 | debian-bookworm -> localhost | ok 2026-01-05 03:20:30.721607 | 2026-01-05 03:20:30.722210 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-05 03:20:30.752992 | debian-bookworm | ok 2026-01-05 03:20:30.773073 | debian-bookworm | included: /var/lib/zuul/builds/9759a2a5c6f24443a3a7157879f26b64/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-05 03:20:30.780027 | 2026-01-05 03:20:30.780173 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-05 03:20:33.252381 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-05 03:20:33.254603 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9759a2a5c6f24443a3a7157879f26b64/work/9759a2a5c6f24443a3a7157879f26b64_id_rsa 2026-01-05 03:20:33.254763 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9759a2a5c6f24443a3a7157879f26b64/work/9759a2a5c6f24443a3a7157879f26b64_id_rsa.pub 2026-01-05 03:20:33.254798 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-05 03:20:33.254826 | debian-bookworm -> localhost | SHA256:kxdChxYNZet6JOXuAEERITAzPgdaLt126TEHJXaHbu4 zuul-build-sshkey 2026-01-05 03:20:33.254940 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-05 03:20:33.254976 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-05 03:20:33.254999 | debian-bookworm -> localhost | | B.. O=*B= | 2026-01-05 03:20:33.255023 | debian-bookworm -> localhost | | * * + *++.. | 2026-01-05 03:20:33.255044 | debian-bookworm -> localhost | |o = + *oo + | 2026-01-05 03:20:33.255064 | debian-bookworm -> localhost | | . + o =o* . | 2026-01-05 03:20:33.255083 | debian-bookworm -> localhost | | ooS = | 2026-01-05 03:20:33.255111 | debian-bookworm -> localhost | | ..B | 2026-01-05 03:20:33.255133 | debian-bookworm -> localhost | | .o o | 2026-01-05 03:20:33.255193 | debian-bookworm -> localhost | | E+ | 2026-01-05 03:20:33.255217 | debian-bookworm -> localhost | | . | 2026-01-05 03:20:33.255237 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-05 03:20:33.255320 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.604044 2026-01-05 03:20:33.275419 | 2026-01-05 03:20:33.275592 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-05 03:20:33.331527 | debian-bookworm | ok 2026-01-05 03:20:33.345222 | debian-bookworm | included: /var/lib/zuul/builds/9759a2a5c6f24443a3a7157879f26b64/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-05 03:20:33.357154 | 2026-01-05 03:20:33.357316 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-05 03:20:33.383036 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:20:33.390417 | 2026-01-05 03:20:33.390556 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-05 03:20:34.515680 | debian-bookworm | changed 2026-01-05 03:20:34.521906 | 2026-01-05 03:20:34.522043 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-05 03:20:34.809200 | debian-bookworm | ok 2026-01-05 03:20:34.815977 | 2026-01-05 03:20:34.816120 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-05 03:20:35.630268 | debian-bookworm | changed 2026-01-05 03:20:35.648623 | 2026-01-05 03:20:35.648804 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-05 03:20:36.580288 | debian-bookworm | changed 2026-01-05 03:20:36.593349 | 2026-01-05 03:20:36.593504 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-05 03:20:36.681264 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:20:36.690361 | 2026-01-05 03:20:36.690502 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-05 03:20:38.167702 | debian-bookworm -> localhost | changed 2026-01-05 03:20:38.194058 | 2026-01-05 03:20:38.194308 | TASK [add-build-sshkey : Add back temp key] 2026-01-05 03:20:39.561037 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9759a2a5c6f24443a3a7157879f26b64/work/9759a2a5c6f24443a3a7157879f26b64_id_rsa (zuul-build-sshkey) 2026-01-05 03:20:39.561319 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023998 2026-01-05 03:20:39.571997 | 2026-01-05 03:20:39.572157 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-05 03:20:40.629319 | debian-bookworm | ok 2026-01-05 03:20:40.635778 | 2026-01-05 03:20:40.641810 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-05 03:20:40.717348 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:20:40.735458 | 2026-01-05 03:20:40.735621 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-05 03:20:41.436404 | debian-bookworm | ok 2026-01-05 03:20:41.458208 | 2026-01-05 03:20:41.458359 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-05 03:20:41.537863 | debian-bookworm | ok 2026-01-05 03:20:41.543579 | 2026-01-05 03:20:41.543720 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-05 03:20:42.293103 | debian-bookworm -> localhost | ok 2026-01-05 03:20:42.300281 | 2026-01-05 03:20:42.300419 | TASK [validate-host : Collect information about the host] 2026-01-05 03:20:43.693258 | debian-bookworm | ok 2026-01-05 03:20:43.716230 | 2026-01-05 03:20:43.716380 | TASK [validate-host : Sanitize hostname] 2026-01-05 03:20:43.893179 | debian-bookworm | ok 2026-01-05 03:20:44.000597 | 2026-01-05 03:20:44.000756 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-05 03:20:44.943305 | debian-bookworm -> localhost | changed 2026-01-05 03:20:44.963085 | 2026-01-05 03:20:44.963249 | TASK [validate-host : Collect information about zuul worker] 2026-01-05 03:20:45.540297 | debian-bookworm | ok 2026-01-05 03:20:45.545490 | 2026-01-05 03:20:45.545623 | TASK [validate-host : Write out all zuul information for each host] 2026-01-05 03:20:46.524406 | debian-bookworm -> localhost | changed 2026-01-05 03:20:46.534474 | 2026-01-05 03:20:46.534609 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-05 03:20:46.857667 | debian-bookworm | ok 2026-01-05 03:20:46.863860 | 2026-01-05 03:20:46.863992 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-05 03:20:48.101718 | debian-bookworm | changed: 2026-01-05 03:20:48.101943 | debian-bookworm | cd+++++++++ src/ 2026-01-05 03:20:48.101980 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-05 03:20:48.102004 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-05 03:20:48.102026 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-05 03:20:48.102047 | debian-bookworm | =6.2.4 2026-01-05 03:21:15.490858 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-05 03:21:15.559545 | debian-bookworm | Collecting chardet>=5.2 2026-01-05 03:21:15.573503 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-05 03:21:15.585664 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 24.5 MB/s eta 0:00:00 2026-01-05 03:21:15.648504 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-05 03:21:15.662678 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-05 03:21:15.738556 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-05 03:21:15.751627 | debian-bookworm | Downloading filelock-3.20.2-py3-none-any.whl (16 kB) 2026-01-05 03:21:15.804125 | debian-bookworm | Collecting packaging>=25 2026-01-05 03:21:15.816975 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2026-01-05 03:21:15.824826 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 11.0 MB/s eta 0:00:00 2026-01-05 03:21:15.886585 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-05 03:21:15.899512 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-05 03:21:15.950731 | debian-bookworm | Collecting pluggy>=1.6 2026-01-05 03:21:15.964218 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-05 03:21:16.018768 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-05 03:21:16.032953 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-05 03:21:16.177844 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-05 03:21:16.191011 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2026-01-05 03:21:16.553657 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 16.8 MB/s eta 0:00:00 2026-01-05 03:21:16.674068 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-05 03:21:16.689489 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-05 03:21:16.723120 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 16.8 MB/s eta 0:00:00 2026-01-05 03:21:16.879840 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-05 03:21:17.866279 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.2 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.33.0 virtualenv-20.35.4 2026-01-05 03:21:18.331636 | debian-bookworm | ok: Runtime: 0:00:03.406258 2026-01-05 03:21:18.338655 | 2026-01-05 03:21:18.338822 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-05 03:21:18.411907 | debian-bookworm | ok 2026-01-05 03:21:18.418727 | 2026-01-05 03:21:18.418889 | TASK [ensure-tox : Output tox version] 2026-01-05 03:21:18.972826 | 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-05 03:21:18.991437 | debian-bookworm | 4.33.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-05 03:21:19.459378 | debian-bookworm | ok: Runtime: 0:00:00.298269 2026-01-05 03:21:19.466372 | 2026-01-05 03:21:19.466491 | TASK [ensure-tox : Make global symlink] 2026-01-05 03:21:19.511189 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:19.518893 | 2026-01-05 03:21:19.518997 | PLAY RECAP 2026-01-05 03:21:19.519053 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-05 03:21:19.519080 | 2026-01-05 03:21:20.010153 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-05 03:21:20.011351 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-05 03:21:22.013639 | 2026-01-05 03:21:22.013818 | PLAY [all] 2026-01-05 03:21:22.034153 | 2026-01-05 03:21:22.034323 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-05 03:21:22.798847 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-05 03:21:23.083396 | debian-bookworm | ok: Runtime: 0:00:00.025714 2026-01-05 03:21:23.090390 | 2026-01-05 03:21:23.090550 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-05 03:21:23.661424 | debian-bookworm | ok: Runtime: 0:00:00.006768 2026-01-05 03:21:23.668490 | 2026-01-05 03:21:23.668639 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-05 03:21:24.133531 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-05 03:21:24.135695 | debian-bookworm | sudo: a password is required 2026-01-05 03:21:24.262420 | debian-bookworm | ok: Runtime: 0:00:00.023899 2026-01-05 03:21:24.284999 | 2026-01-05 03:21:24.285182 | TASK [tox : Check to see if the constraints file exists] 2026-01-05 03:21:24.421371 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:24.431386 | 2026-01-05 03:21:24.431541 | TASK [tox : Fail if constraints file is missing] 2026-01-05 03:21:24.500935 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:24.509027 | 2026-01-05 03:21:24.509234 | TASK [tox : Record file location] 2026-01-05 03:21:24.571133 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:24.579282 | 2026-01-05 03:21:24.579444 | TASK [tox : Install tox siblings] 2026-01-05 03:21:24.647426 | debian-bookworm | ok 2026-01-05 03:21:24.678410 | debian-bookworm | included: /var/lib/zuul/builds/9759a2a5c6f24443a3a7157879f26b64/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-05 03:21:24.695282 | 2026-01-05 03:21:24.695431 | TASK [tox : Run tox without tests] 2026-01-05 03:21:26.046536 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-05 03:21:40.490075 | debian-bookworm | test: OK (15.04 seconds) 2026-01-05 03:21:40.490159 | debian-bookworm | congratulations :) (15.07 seconds) 2026-01-05 03:21:40.780783 | debian-bookworm | ok: Runtime: 0:00:15.369200 2026-01-05 03:21:40.786756 | 2026-01-05 03:21:40.786972 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-05 03:21:41.477393 | debian-bookworm | changed 2026-01-05 03:21:41.482389 | 2026-01-05 03:21:41.482489 | TASK [tox : Get tox envlist config] 2026-01-05 03:21:42.547056 | debian-bookworm | ok: Runtime: 0:00:00.402980 2026-01-05 03:21:42.552788 | 2026-01-05 03:21:42.552901 | TASK [tox : Install any sibling python packages] 2026-01-05 03:21:43.299880 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-05 03:21:43.307407 | 2026-01-05 03:21:43.307517 | TASK [tox : Remove tempfile] 2026-01-05 03:21:43.798735 | debian-bookworm | changed 2026-01-05 03:21:43.810628 | 2026-01-05 03:21:43.810750 | TASK [tox : Emit tox command] 2026-01-05 03:21:43.856052 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-05 03:21:43.861262 | 2026-01-05 03:21:43.861378 | TASK [tox : Run tox] 2026-01-05 03:21:44.777017 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-05 03:21:45.453594 | debian-bookworm | ............... 2026-01-05 03:21:45.453651 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-05 03:21:45.453667 | debian-bookworm | Ran 15 tests in 0.173s 2026-01-05 03:21:45.453672 | debian-bookworm | 2026-01-05 03:21:45.453679 | debian-bookworm | OK 2026-01-05 03:21:45.551466 | debian-bookworm | test: OK (0.82=setup[0.05]+cmd[0.77] seconds) 2026-01-05 03:21:45.551544 | debian-bookworm | congratulations :) (0.85 seconds) 2026-01-05 03:21:46.085173 | debian-bookworm | ok: Runtime: 0:00:01.155703 2026-01-05 03:21:46.093219 | 2026-01-05 03:21:46.093363 | TASK [tox : Look for output] 2026-01-05 03:21:46.870476 | debian-bookworm | ok 2026-01-05 03:21:46.923373 | 2026-01-05 03:21:46.923547 | TASK [tox : Return file comments to Zuul] 2026-01-05 03:21:47.057445 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:47.067702 | 2026-01-05 03:21:47.067821 | PLAY RECAP 2026-01-05 03:21:47.067880 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-05 03:21:47.067907 | 2026-01-05 03:21:47.454125 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-05 03:21:47.457358 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-05 03:21:49.281485 | 2026-01-05 03:21:49.281781 | PLAY [all] 2026-01-05 03:21:49.302886 | 2026-01-05 03:21:49.303068 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-05 03:21:49.379637 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:49.389777 | 2026-01-05 03:21:49.389984 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-05 03:21:49.433984 | debian-bookworm | ok 2026-01-05 03:21:49.448426 | 2026-01-05 03:21:49.448579 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-05 03:21:50.398932 | debian-bookworm -> localhost | changed 2026-01-05 03:21:50.413834 | 2026-01-05 03:21:50.414149 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-05 03:21:50.511225 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:50.518174 | 2026-01-05 03:21:50.518317 | TASK [fetch-tox-output : Set envlist fact] 2026-01-05 03:21:50.561005 | debian-bookworm | ok 2026-01-05 03:21:50.572252 | 2026-01-05 03:21:50.572400 | TASK [fetch-tox-output : Get tox version] 2026-01-05 03:21:51.288901 | 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-05 03:21:51.308796 | debian-bookworm | 4.33.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-05 03:21:51.606058 | debian-bookworm | ok: Runtime: 0:00:00.315563 2026-01-05 03:21:51.612718 | 2026-01-05 03:21:51.612839 | TASK [fetch-tox-output : Find all default environments] 2026-01-05 03:21:52.168816 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:52.175368 | 2026-01-05 03:21:52.175502 | TASK [fetch-tox-output : Set envlist fact] 2026-01-05 03:21:52.210278 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:52.216480 | 2026-01-05 03:21:52.216624 | TASK [fetch-tox-output : Find all default environments] 2026-01-05 03:21:52.783849 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:52.808248 | 2026-01-05 03:21:52.808421 | TASK [fetch-tox-output : Set envlist fact] 2026-01-05 03:21:52.867949 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:52.875299 | 2026-01-05 03:21:52.875442 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-05 03:21:52.949593 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:52.961740 | 2026-01-05 03:21:52.961885 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-05 03:21:54.159424 | debian-bookworm | changed: 2026-01-05 03:21:54.159641 | debian-bookworm | created directory /var/lib/zuul/builds/9759a2a5c6f24443a3a7157879f26b64/work/logs/tox/test 2026-01-05 03:21:54.159716 | debian-bookworm | cd+++++++++ ./ 2026-01-05 03:21:54.159747 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-05 03:21:54.159780 | 2026-01-05 03:21:54.181294 | 2026-01-05 03:21:54.181447 | PLAY RECAP 2026-01-05 03:21:54.181510 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-05 03:21:54.181536 | 2026-01-05 03:21:54.646994 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-05 03:21:54.648142 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-05 03:21:59.126170 | 2026-01-05 03:21:59.126365 | PLAY [all] 2026-01-05 03:21:59.197839 | 2026-01-05 03:21:59.198072 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-05 03:21:59.675843 | debian-bookworm | changed: non-zero return code 2026-01-05 03:21:59.691815 | 2026-01-05 03:21:59.692012 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-05 03:21:59.729480 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:21:59.736449 | 2026-01-05 03:21:59.736606 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-05 03:21:59.839322 | 2026-01-05 03:21:59.839649 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-05 03:21:59.975227 | 2026-01-05 03:21:59.975480 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-05 03:22:00.061642 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:22:00.070010 | 2026-01-05 03:22:00.070202 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-05 03:22:00.137900 | 2026-01-05 03:22:00.147206 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-05 03:22:00.281653 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:22:00.288743 | 2026-01-05 03:22:00.288883 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-05 03:22:00.329646 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:22:00.360470 | 2026-01-05 03:22:00.360635 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-05 03:22:00.415877 | debian-bookworm | skipping: Conditional result was False 2026-01-05 03:22:00.456945 | 2026-01-05 03:22:00.457102 | PLAY RECAP 2026-01-05 03:22:00.457179 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-05 03:22:00.457207 | 2026-01-05 03:22:00.679004 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-05 03:22:00.680178 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-05 03:22:02.424951 | 2026-01-05 03:22:02.425171 | PLAY [Base post] 2026-01-05 03:22:02.482725 | 2026-01-05 03:22:02.482961 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-05 03:22:03.493961 | debian-bookworm | changed 2026-01-05 03:22:03.516283 | 2026-01-05 03:22:03.516879 | PLAY RECAP 2026-01-05 03:22:03.516955 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-05 03:22:03.517020 | 2026-01-05 03:22:04.132528 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-05 03:22:04.133792 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-05 03:22:08.040166 | 2026-01-05 03:22:08.040357 | PLAY [Base post-logs] 2026-01-05 03:22:08.057936 | 2026-01-05 03:22:08.058158 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-05 03:22:09.867221 | localhost | changed 2026-01-05 03:22:09.879553 | 2026-01-05 03:22:09.879747 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-05 03:22:09.937620 | localhost | ok 2026-01-05 03:22:09.941740 | 2026-01-05 03:22:09.941863 | TASK [Set zuul-log-path fact] 2026-01-05 03:22:09.972580 | localhost | ok 2026-01-05 03:22:09.983693 | 2026-01-05 03:22:09.983843 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-05 03:22:10.087711 | localhost | ok 2026-01-05 03:22:10.091172 | 2026-01-05 03:22:10.091298 | TASK [upload-logs : Create log directories] 2026-01-05 03:22:11.428730 | localhost | changed 2026-01-05 03:22:11.434644 | 2026-01-05 03:22:11.434780 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-05 03:22:12.967880 | localhost -> localhost | ok: Runtime: 0:00:00.033179 2026-01-05 03:22:12.997233 | 2026-01-05 03:22:12.997379 | TASK [upload-logs : Upload logs to log server] 2026-01-05 03:22:14.561218 | localhost | Output suppressed because no_log was given 2026-01-05 03:22:14.563334 | 2026-01-05 03:22:14.563442 | LOOP [upload-logs : Compress console log and json output] 2026-01-05 03:22:14.759650 | localhost | skipping: Conditional result was False 2026-01-05 03:22:14.776305 | localhost | skipping: Conditional result was False 2026-01-05 03:22:14.784530 | 2026-01-05 03:22:14.784702 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-05 03:22:14.917157 | localhost | skipping: Conditional result was False 2026-01-05 03:22:14.917484 | 2026-01-05 03:22:14.929163 | localhost | skipping: Conditional result was False 2026-01-05 03:22:14.937601 | 2026-01-05 03:22:14.937817 | LOOP [upload-logs : Upload console log and json output]