2026-01-19 14:13:12.935437 | Job console starting 2026-01-19 14:13:12.949042 | Updating git repos 2026-01-19 14:13:13.012391 | Cloning repos into workspace 2026-01-19 14:13:13.106914 | Restoring repo states 2026-01-19 14:13:13.119364 | Merging changes 2026-01-19 14:13:13.624201 | Checking out repos 2026-01-19 14:13:13.732241 | Preparing playbooks 2026-01-19 14:13:14.498487 | Running Ansible setup 2026-01-19 14:13:20.475656 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-19 14:13:21.675658 | 2026-01-19 14:13:21.675835 | PLAY [Base pre] 2026-01-19 14:13:21.726569 | 2026-01-19 14:13:21.726736 | TASK [Setup log path fact] 2026-01-19 14:13:21.769741 | debian-bookworm | ok 2026-01-19 14:13:21.808760 | 2026-01-19 14:13:21.808931 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-19 14:13:21.883931 | debian-bookworm | ok 2026-01-19 14:13:21.919303 | 2026-01-19 14:13:21.919455 | TASK [emit-job-header : Print job information] 2026-01-19 14:13:21.991936 | # Job Information 2026-01-19 14:13:21.992133 | Ansible Version: 2.16.14 2026-01-19 14:13:21.992285 | Job: tox 2026-01-19 14:13:21.992322 | Pipeline: check 2026-01-19 14:13:21.992346 | Executor: 521e9411259a 2026-01-19 14:13:21.992367 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1098 2026-01-19 14:13:21.992429 | Event ID: f69271f0-f540-11f0-9429-f428f17afa43 2026-01-19 14:13:21.998557 | 2026-01-19 14:13:21.998763 | LOOP [emit-job-header : Print node information] 2026-01-19 14:13:22.273101 | debian-bookworm | ok: 2026-01-19 14:13:22.273298 | debian-bookworm | # Node Information 2026-01-19 14:13:22.273335 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-19 14:13:22.273362 | debian-bookworm | Hostname: debian 2026-01-19 14:13:22.273385 | debian-bookworm | Username: zuul 2026-01-19 14:13:22.273408 | debian-bookworm | Distro: Debian 12.13 2026-01-19 14:13:22.273434 | debian-bookworm | Provider: regiocloud-a 2026-01-19 14:13:22.273458 | debian-bookworm | Region: 2026-01-19 14:13:22.273482 | debian-bookworm | Label: debian-bookworm 2026-01-19 14:13:22.273505 | debian-bookworm | Product Name: OpenStack Nova 2026-01-19 14:13:22.273527 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe86:d67f 2026-01-19 14:13:22.295194 | 2026-01-19 14:13:22.295352 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-19 14:13:23.106687 | debian-bookworm -> localhost | changed 2026-01-19 14:13:23.114265 | 2026-01-19 14:13:23.114493 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-19 14:13:24.887206 | debian-bookworm -> localhost | changed 2026-01-19 14:13:24.896181 | 2026-01-19 14:13:24.896273 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-19 14:13:25.392748 | debian-bookworm -> localhost | ok 2026-01-19 14:13:25.398325 | 2026-01-19 14:13:25.398498 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-19 14:13:25.416484 | debian-bookworm | ok 2026-01-19 14:13:25.430203 | debian-bookworm | included: /var/lib/zuul/builds/3c88d7fb797f428bafaadf9c8ef0c12f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-19 14:13:25.435097 | 2026-01-19 14:13:25.435168 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-19 14:13:27.676617 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-19 14:13:27.676806 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3c88d7fb797f428bafaadf9c8ef0c12f/work/3c88d7fb797f428bafaadf9c8ef0c12f_id_rsa 2026-01-19 14:13:27.676845 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3c88d7fb797f428bafaadf9c8ef0c12f/work/3c88d7fb797f428bafaadf9c8ef0c12f_id_rsa.pub 2026-01-19 14:13:27.676872 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-19 14:13:27.676899 | debian-bookworm -> localhost | SHA256:OFpr0SY5bsSxwIzSO63rfJz6b54pMI4R5d+qs3NxvYU zuul-build-sshkey 2026-01-19 14:13:27.676927 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-19 14:13:27.676956 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-19 14:13:27.676978 | debian-bookworm -> localhost | | | 2026-01-19 14:13:27.677014 | debian-bookworm -> localhost | | ..+ | 2026-01-19 14:13:27.677036 | debian-bookworm -> localhost | |.oo + . | 2026-01-19 14:13:27.677056 | debian-bookworm -> localhost | |...o o * | 2026-01-19 14:13:27.677077 | debian-bookworm -> localhost | | .o...%.S. | 2026-01-19 14:13:27.677103 | debian-bookworm -> localhost | |. ooo=oBE . | 2026-01-19 14:13:27.677152 | debian-bookworm -> localhost | | +.+.== o | 2026-01-19 14:13:27.677176 | debian-bookworm -> localhost | |..+.Bo.o. | 2026-01-19 14:13:27.677197 | debian-bookworm -> localhost | | .BX.== | 2026-01-19 14:13:27.677217 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-19 14:13:27.677270 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.675240 2026-01-19 14:13:27.685574 | 2026-01-19 14:13:27.685669 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-19 14:13:27.719225 | debian-bookworm | ok 2026-01-19 14:13:27.733782 | debian-bookworm | included: /var/lib/zuul/builds/3c88d7fb797f428bafaadf9c8ef0c12f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-19 14:13:27.743718 | 2026-01-19 14:13:27.743821 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-19 14:13:27.767490 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:13:27.776145 | 2026-01-19 14:13:27.776401 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-19 14:13:28.482730 | debian-bookworm | changed 2026-01-19 14:13:28.488520 | 2026-01-19 14:13:28.488607 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-19 14:13:28.726494 | debian-bookworm | ok 2026-01-19 14:13:28.740621 | 2026-01-19 14:13:28.740710 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-19 14:13:29.424980 | debian-bookworm | changed 2026-01-19 14:13:29.437258 | 2026-01-19 14:13:29.437348 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-19 14:13:30.204491 | debian-bookworm | changed 2026-01-19 14:13:30.210977 | 2026-01-19 14:13:30.211097 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-19 14:13:30.265449 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:13:30.271864 | 2026-01-19 14:13:30.271969 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-19 14:13:30.875688 | debian-bookworm -> localhost | changed 2026-01-19 14:13:30.884635 | 2026-01-19 14:13:30.884719 | TASK [add-build-sshkey : Add back temp key] 2026-01-19 14:13:31.356687 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3c88d7fb797f428bafaadf9c8ef0c12f/work/3c88d7fb797f428bafaadf9c8ef0c12f_id_rsa (zuul-build-sshkey) 2026-01-19 14:13:31.356859 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008205 2026-01-19 14:13:31.364206 | 2026-01-19 14:13:31.364294 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-19 14:13:31.940216 | debian-bookworm | ok 2026-01-19 14:13:31.951921 | 2026-01-19 14:13:31.952040 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-19 14:13:32.004819 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:13:32.013220 | 2026-01-19 14:13:32.013311 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-19 14:13:32.632292 | debian-bookworm | ok 2026-01-19 14:13:32.642806 | 2026-01-19 14:13:32.642904 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-19 14:13:32.669492 | debian-bookworm | ok 2026-01-19 14:13:32.673478 | 2026-01-19 14:13:32.673549 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-19 14:13:33.409753 | debian-bookworm -> localhost | ok 2026-01-19 14:13:33.414798 | 2026-01-19 14:13:33.415130 | TASK [validate-host : Collect information about the host] 2026-01-19 14:13:34.444079 | debian-bookworm | ok 2026-01-19 14:13:34.465193 | 2026-01-19 14:13:34.465298 | TASK [validate-host : Sanitize hostname] 2026-01-19 14:13:34.570147 | debian-bookworm | ok 2026-01-19 14:13:34.666876 | 2026-01-19 14:13:34.666986 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-19 14:13:36.068794 | debian-bookworm -> localhost | changed 2026-01-19 14:13:36.074220 | 2026-01-19 14:13:36.074305 | TASK [validate-host : Collect information about zuul worker] 2026-01-19 14:13:36.599549 | debian-bookworm | ok 2026-01-19 14:13:36.604367 | 2026-01-19 14:13:36.604461 | TASK [validate-host : Write out all zuul information for each host] 2026-01-19 14:13:37.553661 | debian-bookworm -> localhost | changed 2026-01-19 14:13:37.562610 | 2026-01-19 14:13:37.562702 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-19 14:13:37.852672 | debian-bookworm | ok 2026-01-19 14:13:37.858657 | 2026-01-19 14:13:37.858747 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-19 14:13:39.304262 | debian-bookworm | changed: 2026-01-19 14:13:39.304429 | debian-bookworm | cd+++++++++ src/ 2026-01-19 14:13:39.304464 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-19 14:13:39.304487 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-19 14:13:39.304508 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-19 14:13:39.304528 | debian-bookworm | =6.2.4 2026-01-19 14:14:02.377708 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-19 14:14:02.415865 | debian-bookworm | Collecting chardet>=5.2 2026-01-19 14:14:02.427371 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-19 14:14:02.448322 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.0 MB/s eta 0:00:00 2026-01-19 14:14:02.497113 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-19 14:14:02.510768 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-19 14:14:02.592841 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-19 14:14:02.604510 | debian-bookworm | Downloading filelock-3.20.3-py3-none-any.whl (16 kB) 2026-01-19 14:14:02.662898 | debian-bookworm | Collecting packaging>=25 2026-01-19 14:14:02.675072 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2026-01-19 14:14:02.684721 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 8.9 MB/s eta 0:00:00 2026-01-19 14:14:02.737003 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-19 14:14:02.748549 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-19 14:14:02.792405 | debian-bookworm | Collecting pluggy>=1.6 2026-01-19 14:14:02.803490 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-19 14:14:02.853768 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-19 14:14:02.867269 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-19 14:14:03.034500 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-19 14:14:03.046251 | debian-bookworm | Downloading virtualenv-20.36.1-py3-none-any.whl (6.0 MB) 2026-01-19 14:14:03.345540 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 20.3 MB/s eta 0:00:00 2026-01-19 14:14:03.461560 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-19 14:14:03.475162 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-19 14:14:03.504305 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.1 MB/s eta 0:00:00 2026-01-19 14:14:03.670136 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-19 14:14:04.540053 | 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-19 14:14:04.749499 | debian-bookworm | ok: Runtime: 0:00:03.165026 2026-01-19 14:14:04.755577 | 2026-01-19 14:14:04.755696 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-19 14:14:04.797744 | debian-bookworm | ok 2026-01-19 14:14:04.803068 | 2026-01-19 14:14:04.803192 | TASK [ensure-tox : Output tox version] 2026-01-19 14:14:05.322054 | 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-19 14:14:05.341050 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-19 14:14:05.839252 | debian-bookworm | ok: Runtime: 0:00:00.297335 2026-01-19 14:14:05.846908 | 2026-01-19 14:14:05.847059 | TASK [ensure-tox : Make global symlink] 2026-01-19 14:14:05.884931 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:05.898359 | 2026-01-19 14:14:05.898469 | PLAY RECAP 2026-01-19 14:14:05.898522 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-19 14:14:05.898546 | 2026-01-19 14:14:06.099895 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-19 14:14:06.101098 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-19 14:14:07.040161 | 2026-01-19 14:14:07.040330 | PLAY [all] 2026-01-19 14:14:07.062372 | 2026-01-19 14:14:07.062530 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-19 14:14:07.549570 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-19 14:14:07.620257 | debian-bookworm | ok: Runtime: 0:00:00.029850 2026-01-19 14:14:07.638326 | 2026-01-19 14:14:07.638492 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-19 14:14:08.193139 | debian-bookworm | ok: Runtime: 0:00:00.006838 2026-01-19 14:14:08.199442 | 2026-01-19 14:14:08.199568 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-19 14:14:08.503342 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-19 14:14:08.504992 | debian-bookworm | sudo: a password is required 2026-01-19 14:14:08.727596 | debian-bookworm | ok: Runtime: 0:00:00.018212 2026-01-19 14:14:08.746615 | 2026-01-19 14:14:08.746756 | TASK [tox : Check to see if the constraints file exists] 2026-01-19 14:14:08.783535 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:08.797602 | 2026-01-19 14:14:08.797787 | TASK [tox : Fail if constraints file is missing] 2026-01-19 14:14:08.833592 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:08.849722 | 2026-01-19 14:14:08.849924 | TASK [tox : Record file location] 2026-01-19 14:14:08.885853 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:08.902164 | 2026-01-19 14:14:08.902514 | TASK [tox : Install tox siblings] 2026-01-19 14:14:08.944739 | debian-bookworm | ok 2026-01-19 14:14:08.957396 | debian-bookworm | included: /var/lib/zuul/builds/3c88d7fb797f428bafaadf9c8ef0c12f/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-19 14:14:08.965168 | 2026-01-19 14:14:08.965395 | TASK [tox : Run tox without tests] 2026-01-19 14:14:10.065673 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-19 14:14:24.424625 | debian-bookworm | test: OK (14.89 seconds) 2026-01-19 14:14:24.424726 | debian-bookworm | congratulations :) (14.92 seconds) 2026-01-19 14:14:24.546291 | debian-bookworm | ok: Runtime: 0:00:15.197400 2026-01-19 14:14:24.553916 | 2026-01-19 14:14:24.554129 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-19 14:14:24.989189 | debian-bookworm | changed 2026-01-19 14:14:24.994919 | 2026-01-19 14:14:24.995060 | TASK [tox : Get tox envlist config] 2026-01-19 14:14:26.026610 | debian-bookworm | ok: Runtime: 0:00:00.351311 2026-01-19 14:14:26.032594 | 2026-01-19 14:14:26.032704 | TASK [tox : Install any sibling python packages] 2026-01-19 14:14:26.544801 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-19 14:14:26.555447 | 2026-01-19 14:14:26.555637 | TASK [tox : Remove tempfile] 2026-01-19 14:14:26.995624 | debian-bookworm | changed 2026-01-19 14:14:27.005573 | 2026-01-19 14:14:27.005707 | TASK [tox : Emit tox command] 2026-01-19 14:14:27.060197 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-19 14:14:27.068068 | 2026-01-19 14:14:27.068200 | TASK [tox : Run tox] 2026-01-19 14:14:27.707406 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-19 14:14:28.388989 | debian-bookworm | ............... 2026-01-19 14:14:28.389039 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-19 14:14:28.389054 | debian-bookworm | Ran 15 tests in 0.171s 2026-01-19 14:14:28.389059 | debian-bookworm | 2026-01-19 14:14:28.389067 | debian-bookworm | OK 2026-01-19 14:14:28.476697 | debian-bookworm | test: OK (0.81=setup[0.05]+cmd[0.77] seconds) 2026-01-19 14:14:28.476761 | debian-bookworm | congratulations :) (0.85 seconds) 2026-01-19 14:14:28.635738 | debian-bookworm | ok: Runtime: 0:00:01.154723 2026-01-19 14:14:28.641548 | 2026-01-19 14:14:28.641653 | TASK [tox : Look for output] 2026-01-19 14:14:29.060338 | debian-bookworm | ok 2026-01-19 14:14:29.079333 | 2026-01-19 14:14:29.079496 | TASK [tox : Return file comments to Zuul] 2026-01-19 14:14:29.117571 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:29.132801 | 2026-01-19 14:14:29.132942 | PLAY RECAP 2026-01-19 14:14:29.133063 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-19 14:14:29.133113 | 2026-01-19 14:14:29.285161 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-19 14:14:29.287868 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-19 14:14:30.101025 | 2026-01-19 14:14:30.101197 | PLAY [all] 2026-01-19 14:14:30.117353 | 2026-01-19 14:14:30.117505 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-19 14:14:30.173539 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:30.186102 | 2026-01-19 14:14:30.186318 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-19 14:14:30.237268 | debian-bookworm | ok 2026-01-19 14:14:30.244678 | 2026-01-19 14:14:30.244818 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-19 14:14:30.725282 | debian-bookworm -> localhost | changed 2026-01-19 14:14:30.733525 | 2026-01-19 14:14:30.733653 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-19 14:14:30.788821 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:30.803662 | 2026-01-19 14:14:30.803851 | TASK [fetch-tox-output : Set envlist fact] 2026-01-19 14:14:30.846284 | debian-bookworm | ok 2026-01-19 14:14:30.853039 | 2026-01-19 14:14:30.853156 | TASK [fetch-tox-output : Get tox version] 2026-01-19 14:14:31.546044 | 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-19 14:14:31.564317 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-19 14:14:31.885058 | debian-bookworm | ok: Runtime: 0:00:00.292829 2026-01-19 14:14:31.896824 | 2026-01-19 14:14:31.896987 | TASK [fetch-tox-output : Find all default environments] 2026-01-19 14:14:32.435149 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:32.441350 | 2026-01-19 14:14:32.441548 | TASK [fetch-tox-output : Set envlist fact] 2026-01-19 14:14:32.496460 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:32.502746 | 2026-01-19 14:14:32.502904 | TASK [fetch-tox-output : Find all default environments] 2026-01-19 14:14:33.062595 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:33.070596 | 2026-01-19 14:14:33.070740 | TASK [fetch-tox-output : Set envlist fact] 2026-01-19 14:14:33.097266 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:33.104157 | 2026-01-19 14:14:33.104276 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-19 14:14:33.151533 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:33.166621 | 2026-01-19 14:14:33.166759 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-19 14:14:33.984243 | debian-bookworm | changed: 2026-01-19 14:14:33.984447 | debian-bookworm | created directory /var/lib/zuul/builds/3c88d7fb797f428bafaadf9c8ef0c12f/work/logs/tox/test 2026-01-19 14:14:33.984481 | debian-bookworm | cd+++++++++ ./ 2026-01-19 14:14:33.984505 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-19 14:14:33.984534 | 2026-01-19 14:14:34.002275 | 2026-01-19 14:14:34.002391 | PLAY RECAP 2026-01-19 14:14:34.002448 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-19 14:14:34.002472 | 2026-01-19 14:14:34.151490 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-19 14:14:34.152565 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-19 14:14:34.941547 | 2026-01-19 14:14:34.941716 | PLAY [all] 2026-01-19 14:14:34.959216 | 2026-01-19 14:14:34.959384 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-19 14:14:35.183549 | debian-bookworm | changed: non-zero return code 2026-01-19 14:14:35.189840 | 2026-01-19 14:14:35.189973 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-19 14:14:35.215186 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:35.225469 | 2026-01-19 14:14:35.225624 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-19 14:14:35.258910 | 2026-01-19 14:14:35.259553 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-19 14:14:35.307042 | 2026-01-19 14:14:35.307312 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-19 14:14:35.343984 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:35.358268 | 2026-01-19 14:14:35.358454 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-19 14:14:35.407733 | 2026-01-19 14:14:35.408064 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-19 14:14:35.434044 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:35.448106 | 2026-01-19 14:14:35.448294 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-19 14:14:35.473600 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:35.479794 | 2026-01-19 14:14:35.479912 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-19 14:14:35.503827 | debian-bookworm | skipping: Conditional result was False 2026-01-19 14:14:35.512296 | 2026-01-19 14:14:35.512390 | PLAY RECAP 2026-01-19 14:14:35.512443 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-19 14:14:35.512470 | 2026-01-19 14:14:35.669339 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-19 14:14:35.670549 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-19 14:14:36.434173 | 2026-01-19 14:14:36.434360 | PLAY [Base post] 2026-01-19 14:14:36.448954 | 2026-01-19 14:14:36.449126 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-19 14:14:37.016093 | debian-bookworm | changed 2026-01-19 14:14:37.024534 | 2026-01-19 14:14:37.024664 | PLAY RECAP 2026-01-19 14:14:37.024737 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-19 14:14:37.024813 | 2026-01-19 14:14:37.156526 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-19 14:14:37.157656 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-19 14:14:38.085223 | 2026-01-19 14:14:38.085395 | PLAY [Base post-logs] 2026-01-19 14:14:38.096345 | 2026-01-19 14:14:38.096495 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-19 14:14:38.573581 | localhost | changed 2026-01-19 14:14:38.584429 | 2026-01-19 14:14:38.584598 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-19 14:14:38.610987 | localhost | ok 2026-01-19 14:14:38.614459 | 2026-01-19 14:14:38.614565 | TASK [Set zuul-log-path fact] 2026-01-19 14:14:38.631613 | localhost | ok 2026-01-19 14:14:38.639887 | 2026-01-19 14:14:38.640051 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-19 14:14:38.665706 | localhost | ok 2026-01-19 14:14:38.669362 | 2026-01-19 14:14:38.669482 | TASK [upload-logs : Create log directories] 2026-01-19 14:14:39.179061 | localhost | changed 2026-01-19 14:14:39.183260 | 2026-01-19 14:14:39.183397 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-19 14:14:39.688929 | localhost -> localhost | ok: Runtime: 0:00:00.007457 2026-01-19 14:14:39.693123 | 2026-01-19 14:14:39.693246 | TASK [upload-logs : Upload logs to log server] 2026-01-19 14:14:40.285448 | localhost | Output suppressed because no_log was given 2026-01-19 14:14:40.287393 | 2026-01-19 14:14:40.287506 | LOOP [upload-logs : Compress console log and json output] 2026-01-19 14:14:40.345384 | localhost | skipping: Conditional result was False 2026-01-19 14:14:40.351540 | localhost | skipping: Conditional result was False 2026-01-19 14:14:40.355998 | 2026-01-19 14:14:40.356138 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-19 14:14:40.402166 | localhost | skipping: Conditional result was False 2026-01-19 14:14:40.402452 | 2026-01-19 14:14:40.407983 | localhost | skipping: Conditional result was False 2026-01-19 14:14:40.416260 | 2026-01-19 14:14:40.416497 | LOOP [upload-logs : Upload console log and json output]