2026-02-22 00:23:14.641865 | Job console starting 2026-02-22 00:23:14.655829 | Updating git repos 2026-02-22 00:23:14.679370 | Cloning repos into workspace 2026-02-22 00:23:14.794200 | Restoring repo states 2026-02-22 00:23:14.821780 | Merging changes 2026-02-22 00:23:15.540879 | Checking out repos 2026-02-22 00:23:15.561266 | Preparing playbooks 2026-02-22 00:23:16.115504 | Running Ansible setup 2026-02-22 00:23:20.798548 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-22 00:23:21.909566 | 2026-02-22 00:23:21.912952 | PLAY [Base pre] 2026-02-22 00:23:21.946234 | 2026-02-22 00:23:21.946443 | TASK [Setup log path fact] 2026-02-22 00:23:21.968034 | debian-bookworm | ok 2026-02-22 00:23:21.987350 | 2026-02-22 00:23:21.987515 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-22 00:23:22.038096 | debian-bookworm | ok 2026-02-22 00:23:22.048352 | 2026-02-22 00:23:22.048484 | TASK [emit-job-header : Print job information] 2026-02-22 00:23:22.096384 | # Job Information 2026-02-22 00:23:22.096594 | Ansible Version: 2.16.14 2026-02-22 00:23:22.096629 | Job: tox 2026-02-22 00:23:22.096661 | Pipeline: check 2026-02-22 00:23:22.096683 | Executor: 521e9411259a 2026-02-22 00:23:22.096704 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1146 2026-02-22 00:23:22.096726 | Event ID: 9f3c39a0-0f84-11f1-99d8-3c4acd37339b 2026-02-22 00:23:22.109432 | 2026-02-22 00:23:22.109586 | LOOP [emit-job-header : Print node information] 2026-02-22 00:23:22.263853 | debian-bookworm | ok: 2026-02-22 00:23:22.264047 | debian-bookworm | # Node Information 2026-02-22 00:23:22.264083 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-02-22 00:23:22.264108 | debian-bookworm | Hostname: debian 2026-02-22 00:23:22.264129 | debian-bookworm | Username: zuul 2026-02-22 00:23:22.264150 | debian-bookworm | Distro: Debian 12.13 2026-02-22 00:23:22.264173 | debian-bookworm | Provider: regiocloud-a 2026-02-22 00:23:22.264194 | debian-bookworm | Region: 2026-02-22 00:23:22.264215 | debian-bookworm | Label: debian-bookworm 2026-02-22 00:23:22.264234 | debian-bookworm | Product Name: OpenStack Nova 2026-02-22 00:23:22.264254 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fece:e60d 2026-02-22 00:23:22.277051 | 2026-02-22 00:23:22.277186 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-22 00:23:23.018634 | debian-bookworm -> localhost | changed 2026-02-22 00:23:23.026249 | 2026-02-22 00:23:23.026435 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-22 00:23:24.429090 | debian-bookworm -> localhost | changed 2026-02-22 00:23:24.450433 | 2026-02-22 00:23:24.450616 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-22 00:23:25.288906 | debian-bookworm -> localhost | ok 2026-02-22 00:23:25.305087 | 2026-02-22 00:23:25.305242 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-22 00:23:25.371814 | debian-bookworm | ok 2026-02-22 00:23:25.461901 | debian-bookworm | included: /var/lib/zuul/builds/7e599236cf914067a785155425cbcbc9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-22 00:23:25.481960 | 2026-02-22 00:23:25.482094 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-22 00:23:28.381800 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-02-22 00:23:28.381989 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7e599236cf914067a785155425cbcbc9/work/7e599236cf914067a785155425cbcbc9_id_rsa 2026-02-22 00:23:28.382039 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7e599236cf914067a785155425cbcbc9/work/7e599236cf914067a785155425cbcbc9_id_rsa.pub 2026-02-22 00:23:28.382066 | debian-bookworm -> localhost | The key fingerprint is: 2026-02-22 00:23:28.382101 | debian-bookworm -> localhost | SHA256:ewliASoNblIP8YkT5zTcAMXOjitNjdYqm25+lGxQI1Y zuul-build-sshkey 2026-02-22 00:23:28.382124 | debian-bookworm -> localhost | The key's randomart image is: 2026-02-22 00:23:28.382158 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-02-22 00:23:28.382179 | debian-bookworm -> localhost | |. BEBo | 2026-02-22 00:23:28.382201 | debian-bookworm -> localhost | |.* &o+. | 2026-02-22 00:23:28.382221 | debian-bookworm -> localhost | |+oBo* . | 2026-02-22 00:23:28.382240 | debian-bookworm -> localhost | |oo .o . | 2026-02-22 00:23:28.382259 | debian-bookworm -> localhost | | o*. o S | 2026-02-22 00:23:28.382301 | debian-bookworm -> localhost | | ==+. . o . | 2026-02-22 00:23:28.382323 | debian-bookworm -> localhost | | +oo . o | 2026-02-22 00:23:28.382342 | debian-bookworm -> localhost | |oo+. . | 2026-02-22 00:23:28.382362 | debian-bookworm -> localhost | |**. | 2026-02-22 00:23:28.382382 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-02-22 00:23:28.382432 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.710521 2026-02-22 00:23:28.388809 | 2026-02-22 00:23:28.388899 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-22 00:23:28.407404 | debian-bookworm | ok 2026-02-22 00:23:28.420666 | debian-bookworm | included: /var/lib/zuul/builds/7e599236cf914067a785155425cbcbc9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-22 00:23:28.429876 | 2026-02-22 00:23:28.429972 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-22 00:23:28.452920 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:23:28.459288 | 2026-02-22 00:23:28.459389 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-22 00:23:29.167336 | debian-bookworm | changed 2026-02-22 00:23:29.172912 | 2026-02-22 00:23:29.173008 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-22 00:23:29.446012 | debian-bookworm | ok 2026-02-22 00:23:29.453436 | 2026-02-22 00:23:29.453554 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-22 00:23:30.123617 | debian-bookworm | changed 2026-02-22 00:23:30.131382 | 2026-02-22 00:23:30.131484 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-22 00:23:30.899909 | debian-bookworm | changed 2026-02-22 00:23:30.907493 | 2026-02-22 00:23:30.907606 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-22 00:23:30.930856 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:23:30.938345 | 2026-02-22 00:23:30.938450 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-22 00:23:31.369295 | debian-bookworm -> localhost | changed 2026-02-22 00:23:31.379638 | 2026-02-22 00:23:31.379734 | TASK [add-build-sshkey : Add back temp key] 2026-02-22 00:23:31.686949 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7e599236cf914067a785155425cbcbc9/work/7e599236cf914067a785155425cbcbc9_id_rsa (zuul-build-sshkey) 2026-02-22 00:23:31.687181 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010640 2026-02-22 00:23:31.695360 | 2026-02-22 00:23:31.695475 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-22 00:23:32.140873 | debian-bookworm | ok 2026-02-22 00:23:32.146295 | 2026-02-22 00:23:32.146412 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-22 00:23:32.171886 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:23:32.182692 | 2026-02-22 00:23:32.182808 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-22 00:23:32.651463 | debian-bookworm | ok 2026-02-22 00:23:32.667438 | 2026-02-22 00:23:32.667572 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-22 00:23:32.696876 | debian-bookworm | ok 2026-02-22 00:23:32.702347 | 2026-02-22 00:23:32.702465 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-22 00:23:33.019905 | debian-bookworm -> localhost | ok 2026-02-22 00:23:33.027196 | 2026-02-22 00:23:33.027334 | TASK [validate-host : Collect information about the host] 2026-02-22 00:23:34.301815 | debian-bookworm | ok 2026-02-22 00:23:34.320345 | 2026-02-22 00:23:34.320476 | TASK [validate-host : Sanitize hostname] 2026-02-22 00:23:34.432031 | debian-bookworm | ok 2026-02-22 00:23:34.498568 | 2026-02-22 00:23:34.498711 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-22 00:23:35.697602 | debian-bookworm -> localhost | changed 2026-02-22 00:23:35.704309 | 2026-02-22 00:23:35.704437 | TASK [validate-host : Collect information about zuul worker] 2026-02-22 00:23:36.151852 | debian-bookworm | ok 2026-02-22 00:23:36.160878 | 2026-02-22 00:23:36.167327 | TASK [validate-host : Write out all zuul information for each host] 2026-02-22 00:23:37.589714 | debian-bookworm -> localhost | changed 2026-02-22 00:23:37.603438 | 2026-02-22 00:23:37.603585 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-22 00:23:37.929050 | debian-bookworm | ok 2026-02-22 00:23:37.936651 | 2026-02-22 00:23:37.936783 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-22 00:23:39.395117 | debian-bookworm | changed: 2026-02-22 00:23:39.395399 | debian-bookworm | cd+++++++++ src/ 2026-02-22 00:23:39.395435 | debian-bookworm | cd+++++++++ src/github.com/ 2026-02-22 00:23:39.395460 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-02-22 00:23:39.395482 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-02-22 00:23:39.395503 | debian-bookworm | =7.0.1 2026-02-22 00:24:05.079044 | debian-bookworm | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-22 00:24:05.128720 | debian-bookworm | Collecting chardet>=5.2 2026-02-22 00:24:05.145894 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-22 00:24:05.168502 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 12.8 MB/s eta 0:00:00 2026-02-22 00:24:05.220445 | debian-bookworm | Collecting colorama>=0.4.6 2026-02-22 00:24:05.232534 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-22 00:24:05.291553 | debian-bookworm | Collecting filelock>=3.24 2026-02-22 00:24:05.303122 | debian-bookworm | Downloading filelock-3.24.3-py3-none-any.whl (24 kB) 2026-02-22 00:24:05.358525 | debian-bookworm | Collecting packaging>=26 2026-02-22 00:24:05.371359 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-22 00:24:05.380351 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 11.9 MB/s eta 0:00:00 2026-02-22 00:24:05.433243 | debian-bookworm | Collecting platformdirs>=4.9.1 2026-02-22 00:24:05.445743 | debian-bookworm | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-22 00:24:05.502409 | debian-bookworm | Collecting pluggy>=1.6 2026-02-22 00:24:05.516397 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-22 00:24:05.573021 | debian-bookworm | Collecting pyproject-api>=1.10 2026-02-22 00:24:05.585404 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-22 00:24:05.765680 | debian-bookworm | Collecting virtualenv>=20.36.1 2026-02-22 00:24:05.777588 | debian-bookworm | Downloading virtualenv-20.38.0-py3-none-any.whl (5.8 MB) 2026-02-22 00:24:06.045811 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 22.1 MB/s eta 0:00:00 2026-02-22 00:24:06.170405 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-02-22 00:24:06.183459 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-22 00:24:06.230722 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 11.2 MB/s eta 0:00:00 2026-02-22 00:24:06.391046 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-22 00:24:07.310529 | debian-bookworm | Successfully installed cachetools-7.0.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.24.3 packaging-26.0 platformdirs-4.9.2 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.44.0 virtualenv-20.38.0 2026-02-22 00:24:07.898976 | debian-bookworm | ok: Runtime: 0:00:03.275778 2026-02-22 00:24:07.916999 | 2026-02-22 00:24:07.917173 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-22 00:24:07.964253 | debian-bookworm | ok 2026-02-22 00:24:07.972874 | 2026-02-22 00:24:07.973135 | TASK [ensure-tox : Output tox version] 2026-02-22 00:24:08.583264 | 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-02-22 00:24:08.603689 | debian-bookworm | 4.44.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-02-22 00:24:09.013154 | debian-bookworm | ok: Runtime: 0:00:00.367952 2026-02-22 00:24:09.019743 | 2026-02-22 00:24:09.019846 | TASK [ensure-tox : Make global symlink] 2026-02-22 00:24:09.044448 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:09.051229 | 2026-02-22 00:24:09.051352 | PLAY RECAP 2026-02-22 00:24:09.051409 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-22 00:24:09.051434 | 2026-02-22 00:24:09.228289 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-22 00:24:09.229445 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-02-22 00:24:09.964007 | 2026-02-22 00:24:09.964185 | PLAY [all] 2026-02-22 00:24:09.980519 | 2026-02-22 00:24:09.980682 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-02-22 00:24:10.515959 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-02-22 00:24:11.016932 | debian-bookworm | ok: Runtime: 0:00:00.033305 2026-02-22 00:24:11.033617 | 2026-02-22 00:24:11.033866 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-02-22 00:24:11.572427 | debian-bookworm | ok: Runtime: 0:00:00.008299 2026-02-22 00:24:11.579363 | 2026-02-22 00:24:11.579507 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-02-22 00:24:12.020082 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-02-22 00:24:12.021807 | debian-bookworm | sudo: a password is required 2026-02-22 00:24:12.142924 | debian-bookworm | ok: Runtime: 0:00:00.021882 2026-02-22 00:24:12.153785 | 2026-02-22 00:24:12.153914 | TASK [tox : Check to see if the constraints file exists] 2026-02-22 00:24:12.184411 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:12.192638 | 2026-02-22 00:24:12.192787 | TASK [tox : Fail if constraints file is missing] 2026-02-22 00:24:12.229633 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:12.236933 | 2026-02-22 00:24:12.237069 | TASK [tox : Record file location] 2026-02-22 00:24:12.301919 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:12.308959 | 2026-02-22 00:24:12.309090 | TASK [tox : Install tox siblings] 2026-02-22 00:24:12.370155 | debian-bookworm | ok 2026-02-22 00:24:12.391651 | debian-bookworm | included: /var/lib/zuul/builds/7e599236cf914067a785155425cbcbc9/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-02-22 00:24:12.412804 | 2026-02-22 00:24:12.412957 | TASK [tox : Run tox without tests] 2026-02-22 00:24:13.815953 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-02-22 00:24:27.936584 | debian-bookworm | test: OK (14.72 seconds) 2026-02-22 00:24:27.936670 | debian-bookworm | congratulations :) (14.76 seconds) 2026-02-22 00:24:28.060187 | debian-bookworm | ok: Runtime: 0:00:15.115238 2026-02-22 00:24:28.073439 | 2026-02-22 00:24:28.073572 | TASK [tox : Create a tempfile to save tox showconfig] 2026-02-22 00:24:28.803105 | debian-bookworm | changed 2026-02-22 00:24:28.813681 | 2026-02-22 00:24:28.813818 | TASK [tox : Get tox envlist config] 2026-02-22 00:24:29.910361 | debian-bookworm | ok: Runtime: 0:00:00.397556 2026-02-22 00:24:29.916434 | 2026-02-22 00:24:29.916559 | TASK [tox : Install any sibling python packages] 2026-02-22 00:24:30.515126 | debian-bookworm | ok: No setup.cfg, no action needed 2026-02-22 00:24:30.520381 | 2026-02-22 00:24:30.520473 | TASK [tox : Remove tempfile] 2026-02-22 00:24:31.044958 | debian-bookworm | changed 2026-02-22 00:24:31.054244 | 2026-02-22 00:24:31.054394 | TASK [tox : Emit tox command] 2026-02-22 00:24:31.102307 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-02-22 00:24:31.108376 | 2026-02-22 00:24:31.108486 | TASK [tox : Run tox] 2026-02-22 00:24:31.878665 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-02-22 00:24:32.659482 | debian-bookworm | ............... 2026-02-22 00:24:32.659590 | debian-bookworm | ---------------------------------------------------------------------- 2026-02-22 00:24:32.659616 | debian-bookworm | Ran 15 tests in 0.200s 2026-02-22 00:24:32.659647 | debian-bookworm | 2026-02-22 00:24:32.659660 | debian-bookworm | OK 2026-02-22 00:24:32.775597 | debian-bookworm | test: OK (0.94=setup[0.05]+cmd[0.90] seconds) 2026-02-22 00:24:32.775745 | debian-bookworm | congratulations :) (1.01 seconds) 2026-02-22 00:24:33.181778 | debian-bookworm | ok: Runtime: 0:00:01.355223 2026-02-22 00:24:33.186239 | 2026-02-22 00:24:33.186336 | TASK [tox : Look for output] 2026-02-22 00:24:33.616483 | debian-bookworm | ok 2026-02-22 00:24:33.629989 | 2026-02-22 00:24:33.630097 | TASK [tox : Return file comments to Zuul] 2026-02-22 00:24:33.675038 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:33.681982 | 2026-02-22 00:24:33.682058 | PLAY RECAP 2026-02-22 00:24:33.682105 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-02-22 00:24:33.682138 | 2026-02-22 00:24:33.779409 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-02-22 00:24:33.780377 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-22 00:24:35.333804 | 2026-02-22 00:24:35.333930 | PLAY [all] 2026-02-22 00:24:35.368075 | 2026-02-22 00:24:35.368292 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-22 00:24:35.495861 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:35.513401 | 2026-02-22 00:24:35.513983 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-22 00:24:35.579727 | debian-bookworm | ok 2026-02-22 00:24:35.585476 | 2026-02-22 00:24:35.585583 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-22 00:24:36.440982 | debian-bookworm -> localhost | changed 2026-02-22 00:24:36.453724 | 2026-02-22 00:24:36.453838 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-22 00:24:36.585522 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:36.592039 | 2026-02-22 00:24:36.592148 | TASK [fetch-tox-output : Set envlist fact] 2026-02-22 00:24:36.640302 | debian-bookworm | ok 2026-02-22 00:24:36.645830 | 2026-02-22 00:24:36.645925 | TASK [fetch-tox-output : Get tox version] 2026-02-22 00:24:37.657812 | 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-02-22 00:24:37.678634 | debian-bookworm | 4.44.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-02-22 00:24:38.234245 | debian-bookworm | ok: Runtime: 0:00:00.342255 2026-02-22 00:24:38.239932 | 2026-02-22 00:24:38.240025 | TASK [fetch-tox-output : Find all default environments] 2026-02-22 00:24:38.812597 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:38.817632 | 2026-02-22 00:24:38.817727 | TASK [fetch-tox-output : Set envlist fact] 2026-02-22 00:24:38.860572 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:38.865157 | 2026-02-22 00:24:38.865246 | TASK [fetch-tox-output : Find all default environments] 2026-02-22 00:24:39.409657 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:39.414299 | 2026-02-22 00:24:39.414386 | TASK [fetch-tox-output : Set envlist fact] 2026-02-22 00:24:39.437115 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:39.442243 | 2026-02-22 00:24:39.442349 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-22 00:24:39.493826 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:39.502074 | 2026-02-22 00:24:39.502179 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-22 00:24:40.659458 | debian-bookworm | changed: 2026-02-22 00:24:40.659598 | debian-bookworm | created directory /var/lib/zuul/builds/7e599236cf914067a785155425cbcbc9/work/logs/tox/test 2026-02-22 00:24:40.659627 | debian-bookworm | cd+++++++++ ./ 2026-02-22 00:24:40.659647 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-02-22 00:24:40.659672 | 2026-02-22 00:24:40.669311 | 2026-02-22 00:24:40.669388 | PLAY RECAP 2026-02-22 00:24:40.669429 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-22 00:24:40.669448 | 2026-02-22 00:24:40.759816 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-22 00:24:40.760613 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-22 00:24:41.771590 | 2026-02-22 00:24:41.771706 | PLAY [all] 2026-02-22 00:24:41.789649 | 2026-02-22 00:24:41.789759 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-22 00:24:42.109963 | debian-bookworm | changed: non-zero return code 2026-02-22 00:24:42.120265 | 2026-02-22 00:24:42.122912 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-22 00:24:42.158459 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:42.167900 | 2026-02-22 00:24:42.167997 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-22 00:24:42.214058 | 2026-02-22 00:24:42.214211 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-22 00:24:42.268359 | 2026-02-22 00:24:42.268504 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-22 00:24:42.292477 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:42.305501 | 2026-02-22 00:24:42.306914 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-22 00:24:42.356779 | 2026-02-22 00:24:42.356986 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-22 00:24:42.410167 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:42.426586 | 2026-02-22 00:24:42.426690 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-22 00:24:42.466511 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:42.478827 | 2026-02-22 00:24:42.480688 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-22 00:24:42.554667 | debian-bookworm | skipping: Conditional result was False 2026-02-22 00:24:42.561666 | 2026-02-22 00:24:42.561733 | PLAY RECAP 2026-02-22 00:24:42.561774 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-22 00:24:42.561793 | 2026-02-22 00:24:43.054330 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-22 00:24:43.055149 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-22 00:24:43.982597 | 2026-02-22 00:24:43.982719 | PLAY [Base post] 2026-02-22 00:24:44.011598 | 2026-02-22 00:24:44.011717 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-22 00:24:44.788194 | debian-bookworm | changed 2026-02-22 00:24:44.794411 | 2026-02-22 00:24:44.794490 | PLAY RECAP 2026-02-22 00:24:44.794538 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-22 00:24:44.794588 | 2026-02-22 00:24:44.888500 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-22 00:24:44.889321 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-22 00:24:45.805348 | 2026-02-22 00:24:45.805469 | PLAY [Base post-logs] 2026-02-22 00:24:45.813486 | 2026-02-22 00:24:45.813603 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-22 00:24:46.272178 | localhost | changed 2026-02-22 00:24:46.280331 | 2026-02-22 00:24:46.280451 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-22 00:24:46.304712 | localhost | ok 2026-02-22 00:24:46.307119 | 2026-02-22 00:24:46.307194 | TASK [Set zuul-log-path fact] 2026-02-22 00:24:46.330914 | localhost | ok 2026-02-22 00:24:46.336975 | 2026-02-22 00:24:46.337058 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-22 00:24:46.370817 | localhost | ok 2026-02-22 00:24:46.373140 | 2026-02-22 00:24:46.373219 | TASK [upload-logs : Create log directories] 2026-02-22 00:24:46.967899 | localhost | changed 2026-02-22 00:24:46.970713 | 2026-02-22 00:24:46.970810 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-22 00:24:47.680307 | localhost -> localhost | ok: Runtime: 0:00:00.030030 2026-02-22 00:24:47.689490 | 2026-02-22 00:24:47.689601 | TASK [upload-logs : Upload logs to log server] 2026-02-22 00:24:48.241232 | localhost | Output suppressed because no_log was given 2026-02-22 00:24:48.242928 | 2026-02-22 00:24:48.243015 | LOOP [upload-logs : Compress console log and json output] 2026-02-22 00:24:48.298435 | localhost | skipping: Conditional result was False 2026-02-22 00:24:48.304187 | localhost | skipping: Conditional result was False 2026-02-22 00:24:48.315972 | 2026-02-22 00:24:48.316078 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-22 00:24:48.361603 | localhost | skipping: Conditional result was False 2026-02-22 00:24:48.361893 | 2026-02-22 00:24:48.366398 | localhost | skipping: Conditional result was False 2026-02-22 00:24:48.371750 | 2026-02-22 00:24:48.371838 | LOOP [upload-logs : Upload console log and json output]