2026-02-25 00:24:51.140715 | Job console starting 2026-02-25 00:24:51.171166 | Updating git repos 2026-02-25 00:24:51.245340 | Cloning repos into workspace 2026-02-25 00:24:51.353215 | Restoring repo states 2026-02-25 00:24:51.364594 | Merging changes 2026-02-25 00:24:51.917728 | Checking out repos 2026-02-25 00:24:51.976486 | Preparing playbooks 2026-02-25 00:24:52.831649 | Running Ansible setup 2026-02-25 00:24:57.895402 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-25 00:24:59.499896 | 2026-02-25 00:24:59.500074 | PLAY [Base pre] 2026-02-25 00:24:59.541897 | 2026-02-25 00:24:59.542064 | TASK [Setup log path fact] 2026-02-25 00:24:59.579679 | debian-bookworm | ok 2026-02-25 00:24:59.633702 | 2026-02-25 00:24:59.633898 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 00:24:59.715613 | debian-bookworm | ok 2026-02-25 00:24:59.754333 | 2026-02-25 00:24:59.754493 | TASK [emit-job-header : Print job information] 2026-02-25 00:24:59.861799 | # Job Information 2026-02-25 00:24:59.861980 | Ansible Version: 2.16.14 2026-02-25 00:24:59.862016 | Job: tox 2026-02-25 00:24:59.862049 | Pipeline: check 2026-02-25 00:24:59.862071 | Executor: 521e9411259a 2026-02-25 00:24:59.862093 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1151 2026-02-25 00:24:59.862114 | Event ID: 6085bd40-11e0-11f1-8c0a-74bd5e8cc8c5 2026-02-25 00:24:59.867570 | 2026-02-25 00:24:59.868254 | LOOP [emit-job-header : Print node information] 2026-02-25 00:25:00.032828 | debian-bookworm | ok: 2026-02-25 00:25:00.033283 | debian-bookworm | # Node Information 2026-02-25 00:25:00.033461 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-02-25 00:25:00.033492 | debian-bookworm | Hostname: debian 2026-02-25 00:25:00.033516 | debian-bookworm | Username: zuul 2026-02-25 00:25:00.033537 | debian-bookworm | Distro: Debian 12.13 2026-02-25 00:25:00.033562 | debian-bookworm | Provider: regiocloud-a 2026-02-25 00:25:00.033582 | debian-bookworm | Region: 2026-02-25 00:25:00.033604 | debian-bookworm | Label: debian-bookworm 2026-02-25 00:25:00.033624 | debian-bookworm | Product Name: OpenStack Nova 2026-02-25 00:25:00.033644 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe38:6593 2026-02-25 00:25:00.053981 | 2026-02-25 00:25:00.054136 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-25 00:25:01.383531 | debian-bookworm -> localhost | changed 2026-02-25 00:25:01.393146 | 2026-02-25 00:25:01.393400 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-25 00:25:03.990925 | debian-bookworm -> localhost | changed 2026-02-25 00:25:04.014522 | 2026-02-25 00:25:04.014643 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 00:25:04.474255 | debian-bookworm -> localhost | ok 2026-02-25 00:25:04.483430 | 2026-02-25 00:25:04.483543 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 00:25:04.524825 | debian-bookworm | ok 2026-02-25 00:25:04.578783 | debian-bookworm | included: /var/lib/zuul/builds/eb227324ed3648978141ded1fb3ab7c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 00:25:04.602489 | 2026-02-25 00:25:04.602619 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 00:25:07.288208 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-02-25 00:25:07.288368 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/eb227324ed3648978141ded1fb3ab7c3/work/eb227324ed3648978141ded1fb3ab7c3_id_rsa 2026-02-25 00:25:07.288398 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/eb227324ed3648978141ded1fb3ab7c3/work/eb227324ed3648978141ded1fb3ab7c3_id_rsa.pub 2026-02-25 00:25:07.288419 | debian-bookworm -> localhost | The key fingerprint is: 2026-02-25 00:25:07.288440 | debian-bookworm -> localhost | SHA256:BmDlRFP+rz4Rr824yRanS+5QD4lkkZRG4SkOYy58Q+U zuul-build-sshkey 2026-02-25 00:25:07.288459 | debian-bookworm -> localhost | The key's randomart image is: 2026-02-25 00:25:07.288486 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-02-25 00:25:07.288504 | debian-bookworm -> localhost | | oo*+*+ | 2026-02-25 00:25:07.288522 | debian-bookworm -> localhost | | . * ++o | 2026-02-25 00:25:07.288538 | debian-bookworm -> localhost | | = E.* | 2026-02-25 00:25:07.288555 | debian-bookworm -> localhost | | . + + = o.. | 2026-02-25 00:25:07.288571 | debian-bookworm -> localhost | | o + . S =o | 2026-02-25 00:25:07.288594 | debian-bookworm -> localhost | | o . . .o+o | 2026-02-25 00:25:07.288612 | debian-bookworm -> localhost | | . .Xo | 2026-02-25 00:25:07.288629 | debian-bookworm -> localhost | | =*oo | 2026-02-25 00:25:07.288646 | debian-bookworm -> localhost | | +X+ | 2026-02-25 00:25:07.288663 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-02-25 00:25:07.288704 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.911598 2026-02-25 00:25:07.293683 | 2026-02-25 00:25:07.293759 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 00:25:07.330246 | debian-bookworm | ok 2026-02-25 00:25:07.342819 | debian-bookworm | included: /var/lib/zuul/builds/eb227324ed3648978141ded1fb3ab7c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 00:25:07.366060 | 2026-02-25 00:25:07.366178 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 00:25:07.399539 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:25:07.405574 | 2026-02-25 00:25:07.405685 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 00:25:08.132134 | debian-bookworm | changed 2026-02-25 00:25:08.137968 | 2026-02-25 00:25:08.138064 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 00:25:08.383879 | debian-bookworm | ok 2026-02-25 00:25:08.392193 | 2026-02-25 00:25:08.392516 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 00:25:09.152209 | debian-bookworm | changed 2026-02-25 00:25:09.158356 | 2026-02-25 00:25:09.158444 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 00:25:09.923293 | debian-bookworm | changed 2026-02-25 00:25:09.927647 | 2026-02-25 00:25:09.927725 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 00:25:09.964473 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:25:09.969254 | 2026-02-25 00:25:09.969336 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 00:25:10.870671 | debian-bookworm -> localhost | changed 2026-02-25 00:25:10.882987 | 2026-02-25 00:25:10.883080 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 00:25:11.725923 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/eb227324ed3648978141ded1fb3ab7c3/work/eb227324ed3648978141ded1fb3ab7c3_id_rsa (zuul-build-sshkey) 2026-02-25 00:25:11.726092 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.050957 2026-02-25 00:25:11.732553 | 2026-02-25 00:25:11.732640 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 00:25:12.273061 | debian-bookworm | ok 2026-02-25 00:25:12.288151 | 2026-02-25 00:25:12.288256 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 00:25:12.321282 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:25:12.331525 | 2026-02-25 00:25:12.331625 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-25 00:25:12.798131 | debian-bookworm | ok 2026-02-25 00:25:12.825844 | 2026-02-25 00:25:12.829405 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-25 00:25:12.874690 | debian-bookworm | ok 2026-02-25 00:25:12.879663 | 2026-02-25 00:25:12.881748 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-25 00:25:13.372183 | debian-bookworm -> localhost | ok 2026-02-25 00:25:13.378172 | 2026-02-25 00:25:13.378265 | TASK [validate-host : Collect information about the host] 2026-02-25 00:25:14.648665 | debian-bookworm | ok 2026-02-25 00:25:14.676208 | 2026-02-25 00:25:14.678630 | TASK [validate-host : Sanitize hostname] 2026-02-25 00:25:14.828454 | debian-bookworm | ok 2026-02-25 00:25:14.893342 | 2026-02-25 00:25:14.893455 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-25 00:25:15.836468 | debian-bookworm -> localhost | changed 2026-02-25 00:25:15.842008 | 2026-02-25 00:25:15.842120 | TASK [validate-host : Collect information about zuul worker] 2026-02-25 00:25:16.314705 | debian-bookworm | ok 2026-02-25 00:25:16.324723 | 2026-02-25 00:25:16.324825 | TASK [validate-host : Write out all zuul information for each host] 2026-02-25 00:25:16.781933 | debian-bookworm -> localhost | changed 2026-02-25 00:25:16.791343 | 2026-02-25 00:25:16.791719 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-25 00:25:17.085052 | debian-bookworm | ok 2026-02-25 00:25:17.090860 | 2026-02-25 00:25:17.090952 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-25 00:25:18.330787 | debian-bookworm | changed: 2026-02-25 00:25:18.330977 | debian-bookworm | cd+++++++++ src/ 2026-02-25 00:25:18.331014 | debian-bookworm | cd+++++++++ src/github.com/ 2026-02-25 00:25:18.331039 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-02-25 00:25:18.331074 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-02-25 00:25:18.331095 | debian-bookworm | =7.0.1 2026-02-25 00:25:42.376304 | debian-bookworm | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-25 00:25:42.417960 | debian-bookworm | Collecting colorama>=0.4.6 2026-02-25 00:25:42.429692 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-25 00:25:42.488902 | debian-bookworm | Collecting filelock>=3.24.3 2026-02-25 00:25:42.500682 | debian-bookworm | Downloading filelock-3.24.3-py3-none-any.whl (24 kB) 2026-02-25 00:25:42.565637 | debian-bookworm | Collecting packaging>=26 2026-02-25 00:25:42.577503 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-25 00:25:42.586979 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 10.8 MB/s eta 0:00:00 2026-02-25 00:25:42.638250 | debian-bookworm | Collecting platformdirs>=4.9.2 2026-02-25 00:25:42.650393 | debian-bookworm | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-25 00:25:42.693211 | debian-bookworm | Collecting pluggy>=1.6 2026-02-25 00:25:42.705144 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-25 00:25:42.756849 | debian-bookworm | Collecting pyproject-api>=1.10 2026-02-25 00:25:42.769555 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-25 00:25:42.906257 | debian-bookworm | Collecting virtualenv>=20.38 2026-02-25 00:25:42.918214 | debian-bookworm | Downloading virtualenv-20.39.0-py3-none-any.whl (5.8 MB) 2026-02-25 00:25:43.119869 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 29.5 MB/s eta 0:00:00 2026-02-25 00:25:43.197285 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-02-25 00:25:43.208618 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-25 00:25:43.228823 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 26.7 MB/s eta 0:00:00 2026-02-25 00:25:43.323589 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, cachetools, virtualenv, pyproject-api, tox 2026-02-25 00:25:44.085634 | debian-bookworm | Successfully installed cachetools-7.0.1 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.46.0 virtualenv-20.39.0 2026-02-25 00:25:44.699354 | debian-bookworm | ok: Runtime: 0:00:02.760447 2026-02-25 00:25:44.725081 | 2026-02-25 00:25:44.725246 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-25 00:25:44.780859 | debian-bookworm | ok 2026-02-25 00:25:44.787972 | 2026-02-25 00:25:44.788088 | TASK [ensure-tox : Output tox version] 2026-02-25 00:25:45.447710 | 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-25 00:25:45.468636 | debian-bookworm | 4.46.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-02-25 00:25:45.831597 | debian-bookworm | ok: Runtime: 0:00:00.344873 2026-02-25 00:25:45.844534 | 2026-02-25 00:25:45.844696 | TASK [ensure-tox : Make global symlink] 2026-02-25 00:25:45.869954 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:25:45.879622 | 2026-02-25 00:25:45.879721 | PLAY RECAP 2026-02-25 00:25:45.879774 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-25 00:25:45.879799 | 2026-02-25 00:25:46.033677 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-25 00:25:46.034805 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-02-25 00:25:46.839791 | 2026-02-25 00:25:46.839979 | PLAY [all] 2026-02-25 00:25:46.856430 | 2026-02-25 00:25:46.856686 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-02-25 00:25:47.331835 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-02-25 00:25:47.399923 | debian-bookworm | ok: Runtime: 0:00:00.031364 2026-02-25 00:25:47.409657 | 2026-02-25 00:25:47.409873 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-02-25 00:25:47.940427 | debian-bookworm | ok: Runtime: 0:00:00.008902 2026-02-25 00:25:47.946542 | 2026-02-25 00:25:47.946661 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-02-25 00:25:48.264655 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-02-25 00:25:48.268349 | debian-bookworm | sudo: a password is required 2026-02-25 00:25:48.480600 | debian-bookworm | ok: Runtime: 0:00:00.024875 2026-02-25 00:25:48.491697 | 2026-02-25 00:25:48.491843 | TASK [tox : Check to see if the constraints file exists] 2026-02-25 00:25:48.527177 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:25:48.539294 | 2026-02-25 00:25:48.539485 | TASK [tox : Fail if constraints file is missing] 2026-02-25 00:25:48.595726 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:25:48.604208 | 2026-02-25 00:25:48.604363 | TASK [tox : Record file location] 2026-02-25 00:25:48.628923 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:25:48.636204 | 2026-02-25 00:25:48.636346 | TASK [tox : Install tox siblings] 2026-02-25 00:25:48.670160 | debian-bookworm | ok 2026-02-25 00:25:48.680049 | debian-bookworm | included: /var/lib/zuul/builds/eb227324ed3648978141ded1fb3ab7c3/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-02-25 00:25:48.686648 | 2026-02-25 00:25:48.686783 | TASK [tox : Run tox without tests] 2026-02-25 00:25:49.826138 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-02-25 00:26:04.188116 | debian-bookworm | test: OK (14.91 seconds) 2026-02-25 00:26:04.188184 | debian-bookworm | congratulations :) (14.95 seconds) 2026-02-25 00:26:04.730036 | debian-bookworm | ok: Runtime: 0:00:15.267579 2026-02-25 00:26:04.745087 | 2026-02-25 00:26:04.745272 | TASK [tox : Create a tempfile to save tox showconfig] 2026-02-25 00:26:05.172059 | debian-bookworm | changed 2026-02-25 00:26:05.177717 | 2026-02-25 00:26:05.177833 | TASK [tox : Get tox envlist config] 2026-02-25 00:26:06.212562 | debian-bookworm | ok: Runtime: 0:00:00.368497 2026-02-25 00:26:06.227127 | 2026-02-25 00:26:06.227288 | TASK [tox : Install any sibling python packages] 2026-02-25 00:26:06.681803 | debian-bookworm | ok: No setup.cfg, no action needed 2026-02-25 00:26:06.690960 | 2026-02-25 00:26:06.691111 | TASK [tox : Remove tempfile] 2026-02-25 00:26:07.140907 | debian-bookworm | changed 2026-02-25 00:26:07.150173 | 2026-02-25 00:26:07.150323 | TASK [tox : Emit tox command] 2026-02-25 00:26:07.206108 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-02-25 00:26:07.214575 | 2026-02-25 00:26:07.214772 | TASK [tox : Run tox] 2026-02-25 00:26:07.859584 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-02-25 00:26:08.509857 | debian-bookworm | ............... 2026-02-25 00:26:08.510306 | debian-bookworm | ---------------------------------------------------------------------- 2026-02-25 00:26:08.510333 | debian-bookworm | Ran 15 tests in 0.171s 2026-02-25 00:26:08.510340 | debian-bookworm | 2026-02-25 00:26:08.510348 | debian-bookworm | OK 2026-02-25 00:26:08.603109 | debian-bookworm | test: OK (0.79=setup[0.05]+cmd[0.74] seconds) 2026-02-25 00:26:08.603179 | debian-bookworm | congratulations :) (0.82 seconds) 2026-02-25 00:26:08.783547 | debian-bookworm | ok: Runtime: 0:00:01.138160 2026-02-25 00:26:08.798463 | 2026-02-25 00:26:08.798624 | TASK [tox : Look for output] 2026-02-25 00:26:09.212191 | debian-bookworm | ok 2026-02-25 00:26:09.230126 | 2026-02-25 00:26:09.230259 | TASK [tox : Return file comments to Zuul] 2026-02-25 00:26:09.275086 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:09.282605 | 2026-02-25 00:26:09.282743 | PLAY RECAP 2026-02-25 00:26:09.282810 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-02-25 00:26:09.282861 | 2026-02-25 00:26:09.408043 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-02-25 00:26:09.409197 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-25 00:26:10.189644 | 2026-02-25 00:26:10.189902 | PLAY [all] 2026-02-25 00:26:10.205485 | 2026-02-25 00:26:10.205627 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-25 00:26:10.261202 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:10.271436 | 2026-02-25 00:26:10.271613 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-25 00:26:10.317620 | debian-bookworm | ok 2026-02-25 00:26:10.325799 | 2026-02-25 00:26:10.325951 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-25 00:26:10.817879 | debian-bookworm -> localhost | changed 2026-02-25 00:26:10.834612 | 2026-02-25 00:26:10.834794 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-25 00:26:10.890270 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:10.902386 | 2026-02-25 00:26:10.902567 | TASK [fetch-tox-output : Set envlist fact] 2026-02-25 00:26:10.951253 | debian-bookworm | ok 2026-02-25 00:26:10.959526 | 2026-02-25 00:26:10.959675 | TASK [fetch-tox-output : Get tox version] 2026-02-25 00:26:11.682622 | 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-25 00:26:11.704675 | debian-bookworm | 4.46.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-02-25 00:26:11.992394 | debian-bookworm | ok: Runtime: 0:00:00.324966 2026-02-25 00:26:12.007560 | 2026-02-25 00:26:12.007741 | TASK [fetch-tox-output : Find all default environments] 2026-02-25 00:26:12.541770 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:12.554876 | 2026-02-25 00:26:12.555071 | TASK [fetch-tox-output : Set envlist fact] 2026-02-25 00:26:12.590483 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:12.603301 | 2026-02-25 00:26:12.603461 | TASK [fetch-tox-output : Find all default environments] 2026-02-25 00:26:13.135773 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:13.149218 | 2026-02-25 00:26:13.149422 | TASK [fetch-tox-output : Set envlist fact] 2026-02-25 00:26:13.185145 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:13.197529 | 2026-02-25 00:26:13.197713 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-25 00:26:13.253872 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:13.270610 | 2026-02-25 00:26:13.271772 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-25 00:26:14.044995 | debian-bookworm | changed: 2026-02-25 00:26:14.045327 | debian-bookworm | created directory /var/lib/zuul/builds/eb227324ed3648978141ded1fb3ab7c3/work/logs/tox/test 2026-02-25 00:26:14.045389 | debian-bookworm | cd+++++++++ ./ 2026-02-25 00:26:14.045430 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-02-25 00:26:14.045477 | 2026-02-25 00:26:14.066009 | 2026-02-25 00:26:14.066136 | PLAY RECAP 2026-02-25 00:26:14.066215 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-25 00:26:14.066253 | 2026-02-25 00:26:14.194040 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-25 00:26:14.195215 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-25 00:26:14.933955 | 2026-02-25 00:26:14.934119 | PLAY [all] 2026-02-25 00:26:14.950662 | 2026-02-25 00:26:14.950871 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-25 00:26:15.205939 | debian-bookworm | changed: non-zero return code 2026-02-25 00:26:15.214590 | 2026-02-25 00:26:15.214868 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-25 00:26:15.240199 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:15.249794 | 2026-02-25 00:26:15.250098 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-25 00:26:15.285722 | 2026-02-25 00:26:15.285955 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-25 00:26:15.322422 | 2026-02-25 00:26:15.322704 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-25 00:26:15.337949 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:15.347025 | 2026-02-25 00:26:15.347170 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-25 00:26:15.379827 | 2026-02-25 00:26:15.380063 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-25 00:26:15.405315 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:15.412372 | 2026-02-25 00:26:15.412502 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-25 00:26:15.436153 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:15.445835 | 2026-02-25 00:26:15.446055 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-25 00:26:15.469953 | debian-bookworm | skipping: Conditional result was False 2026-02-25 00:26:15.480927 | 2026-02-25 00:26:15.481050 | PLAY RECAP 2026-02-25 00:26:15.481130 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-25 00:26:15.481174 | 2026-02-25 00:26:15.610465 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-25 00:26:15.612942 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-25 00:26:16.360823 | 2026-02-25 00:26:16.361009 | PLAY [Base post] 2026-02-25 00:26:16.375200 | 2026-02-25 00:26:16.375359 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-25 00:26:16.981558 | debian-bookworm | changed 2026-02-25 00:26:16.993568 | 2026-02-25 00:26:16.993745 | PLAY RECAP 2026-02-25 00:26:16.993810 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-25 00:26:16.993871 | 2026-02-25 00:26:17.138560 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-25 00:26:17.139708 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-25 00:26:17.916187 | 2026-02-25 00:26:17.916352 | PLAY [Base post-logs] 2026-02-25 00:26:17.927378 | 2026-02-25 00:26:17.927524 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-25 00:26:18.378406 | localhost | changed 2026-02-25 00:26:18.388697 | 2026-02-25 00:26:18.388882 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-25 00:26:18.424630 | localhost | ok 2026-02-25 00:26:18.428181 | 2026-02-25 00:26:18.428285 | TASK [Set zuul-log-path fact] 2026-02-25 00:26:18.454275 | localhost | ok 2026-02-25 00:26:18.466727 | 2026-02-25 00:26:18.466894 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 00:26:18.506200 | localhost | ok 2026-02-25 00:26:18.518014 | 2026-02-25 00:26:18.518713 | TASK [upload-logs : Create log directories] 2026-02-25 00:26:19.013083 | localhost | changed 2026-02-25 00:26:19.016856 | 2026-02-25 00:26:19.016980 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-25 00:26:19.507762 | localhost -> localhost | ok: Runtime: 0:00:00.007560 2026-02-25 00:26:19.511848 | 2026-02-25 00:26:19.511969 | TASK [upload-logs : Upload logs to log server] 2026-02-25 00:26:20.076607 | localhost | Output suppressed because no_log was given 2026-02-25 00:26:20.078521 | 2026-02-25 00:26:20.078646 | LOOP [upload-logs : Compress console log and json output] 2026-02-25 00:26:20.137026 | localhost | skipping: Conditional result was False 2026-02-25 00:26:20.143667 | localhost | skipping: Conditional result was False 2026-02-25 00:26:20.148418 | 2026-02-25 00:26:20.148571 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-25 00:26:20.194712 | localhost | skipping: Conditional result was False 2026-02-25 00:26:20.195326 | 2026-02-25 00:26:20.200004 | localhost | skipping: Conditional result was False 2026-02-25 00:26:20.214622 | 2026-02-25 00:26:20.214816 | LOOP [upload-logs : Upload console log and json output]