2026-02-25 03:02:48.364829 | Job console starting 2026-02-25 03:02:48.376426 | Updating git repos 2026-02-25 03:02:48.452254 | Cloning repos into workspace 2026-02-25 03:02:48.711581 | Restoring repo states 2026-02-25 03:02:48.739972 | Merging changes 2026-02-25 03:02:48.739992 | Checking out repos 2026-02-25 03:02:48.842735 | Preparing playbooks 2026-02-25 03:02:49.790626 | Running Ansible setup 2026-02-25 03:02:56.873770 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-25 03:02:57.565503 | 2026-02-25 03:02:57.565675 | PLAY [Base pre] 2026-02-25 03:02:57.579065 | 2026-02-25 03:02:57.579167 | TASK [Setup log path fact] 2026-02-25 03:02:57.595791 | debian-bookworm | ok 2026-02-25 03:02:57.607871 | 2026-02-25 03:02:57.607982 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 03:02:57.652614 | debian-bookworm | ok 2026-02-25 03:02:57.663430 | 2026-02-25 03:02:57.663542 | TASK [emit-job-header : Print job information] 2026-02-25 03:02:57.701681 | # Job Information 2026-02-25 03:02:57.701851 | Ansible Version: 2.16.14 2026-02-25 03:02:57.701888 | Job: tox 2026-02-25 03:02:57.701919 | Pipeline: periodic-daily 2026-02-25 03:02:57.701941 | Executor: 521e9411259a 2026-02-25 03:02:57.701962 | Triggered by: https://github.com/osism/openstack-image-manager 2026-02-25 03:02:57.701985 | Event ID: abaefea706304d5787b3c7905b046e67 2026-02-25 03:02:57.707505 | 2026-02-25 03:02:57.707602 | LOOP [emit-job-header : Print node information] 2026-02-25 03:02:57.849627 | debian-bookworm | ok: 2026-02-25 03:02:57.849817 | debian-bookworm | # Node Information 2026-02-25 03:02:57.849902 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-02-25 03:02:57.849933 | debian-bookworm | Hostname: debian 2026-02-25 03:02:57.849955 | debian-bookworm | Username: zuul 2026-02-25 03:02:57.849976 | debian-bookworm | Distro: Debian 12.13 2026-02-25 03:02:57.850000 | debian-bookworm | Provider: regiocloud-a 2026-02-25 03:02:57.850022 | debian-bookworm | Region: 2026-02-25 03:02:57.850042 | debian-bookworm | Label: debian-bookworm 2026-02-25 03:02:57.850072 | debian-bookworm | Product Name: OpenStack Nova 2026-02-25 03:02:57.850104 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe36:ddde 2026-02-25 03:02:57.873275 | 2026-02-25 03:02:57.873393 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-25 03:02:58.573533 | debian-bookworm -> localhost | changed 2026-02-25 03:02:58.580650 | 2026-02-25 03:02:58.580759 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-25 03:03:00.357836 | debian-bookworm -> localhost | changed 2026-02-25 03:03:00.378904 | 2026-02-25 03:03:00.379023 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 03:03:01.053817 | debian-bookworm -> localhost | ok 2026-02-25 03:03:01.060052 | 2026-02-25 03:03:01.060159 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 03:03:01.091775 | debian-bookworm | ok 2026-02-25 03:03:01.128492 | debian-bookworm | included: /var/lib/zuul/builds/2c5b2222715f40ec9c5801438c5c98af/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 03:03:01.154086 | 2026-02-25 03:03:01.154198 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 03:03:03.156247 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-02-25 03:03:03.156443 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2c5b2222715f40ec9c5801438c5c98af/work/2c5b2222715f40ec9c5801438c5c98af_id_rsa 2026-02-25 03:03:03.156479 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2c5b2222715f40ec9c5801438c5c98af/work/2c5b2222715f40ec9c5801438c5c98af_id_rsa.pub 2026-02-25 03:03:03.156505 | debian-bookworm -> localhost | The key fingerprint is: 2026-02-25 03:03:03.156529 | debian-bookworm -> localhost | SHA256:NhUcD0trEYK7w2mq80yI8v3JfauP4G/WTuDGUm8aHZ4 zuul-build-sshkey 2026-02-25 03:03:03.156551 | debian-bookworm -> localhost | The key's randomart image is: 2026-02-25 03:03:03.156583 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-02-25 03:03:03.156606 | debian-bookworm -> localhost | | ...Bo | 2026-02-25 03:03:03.156627 | debian-bookworm -> localhost | | . o.B | 2026-02-25 03:03:03.156648 | debian-bookworm -> localhost | | . = . | 2026-02-25 03:03:03.156667 | debian-bookworm -> localhost | | . o | 2026-02-25 03:03:03.156686 | debian-bookworm -> localhost | | . oS . | 2026-02-25 03:03:03.156713 | debian-bookworm -> localhost | | . . *= * o | 2026-02-25 03:03:03.156735 | debian-bookworm -> localhost | |o . .oo.=.E | 2026-02-25 03:03:03.156756 | debian-bookworm -> localhost | |...+.o *o*o | 2026-02-25 03:03:03.156776 | debian-bookworm -> localhost | | o++.=+*=+. | 2026-02-25 03:03:03.156797 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-02-25 03:03:03.156856 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.133269 2026-02-25 03:03:03.163248 | 2026-02-25 03:03:03.163351 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 03:03:03.213777 | debian-bookworm | ok 2026-02-25 03:03:03.238064 | debian-bookworm | included: /var/lib/zuul/builds/2c5b2222715f40ec9c5801438c5c98af/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 03:03:03.278659 | 2026-02-25 03:03:03.278776 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 03:03:03.330132 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:03:03.336589 | 2026-02-25 03:03:03.336693 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 03:03:04.284762 | debian-bookworm | changed 2026-02-25 03:03:04.290113 | 2026-02-25 03:03:04.290209 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 03:03:04.584378 | debian-bookworm | ok 2026-02-25 03:03:04.593139 | 2026-02-25 03:03:04.593249 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 03:03:05.313383 | debian-bookworm | changed 2026-02-25 03:03:05.322739 | 2026-02-25 03:03:05.323761 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 03:03:06.055454 | debian-bookworm | changed 2026-02-25 03:03:06.065653 | 2026-02-25 03:03:06.065756 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 03:03:06.103284 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:03:06.109417 | 2026-02-25 03:03:06.109534 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 03:03:06.936336 | debian-bookworm -> localhost | changed 2026-02-25 03:03:06.951762 | 2026-02-25 03:03:06.951896 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 03:03:07.768384 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2c5b2222715f40ec9c5801438c5c98af/work/2c5b2222715f40ec9c5801438c5c98af_id_rsa (zuul-build-sshkey) 2026-02-25 03:03:07.768651 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.037466 2026-02-25 03:03:07.779523 | 2026-02-25 03:03:07.779770 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 03:03:08.434347 | debian-bookworm | ok 2026-02-25 03:03:08.441215 | 2026-02-25 03:03:08.441348 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 03:03:08.489972 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:03:08.508334 | 2026-02-25 03:03:08.508475 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-25 03:03:09.173114 | debian-bookworm | ok 2026-02-25 03:03:09.196752 | 2026-02-25 03:03:09.196886 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-25 03:03:09.250394 | debian-bookworm | ok 2026-02-25 03:03:09.256290 | 2026-02-25 03:03:09.256391 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-25 03:03:09.793586 | debian-bookworm -> localhost | ok 2026-02-25 03:03:09.800701 | 2026-02-25 03:03:09.800803 | TASK [validate-host : Collect information about the host] 2026-02-25 03:03:10.969114 | debian-bookworm | ok 2026-02-25 03:03:10.979789 | 2026-02-25 03:03:10.979913 | TASK [validate-host : Sanitize hostname] 2026-02-25 03:03:11.114869 | debian-bookworm | ok 2026-02-25 03:03:11.168383 | 2026-02-25 03:03:11.168483 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-25 03:03:11.844352 | debian-bookworm -> localhost | changed 2026-02-25 03:03:11.853394 | 2026-02-25 03:03:11.853520 | TASK [validate-host : Collect information about zuul worker] 2026-02-25 03:03:12.449130 | debian-bookworm | ok 2026-02-25 03:03:12.463955 | 2026-02-25 03:03:12.464059 | TASK [validate-host : Write out all zuul information for each host] 2026-02-25 03:03:13.124610 | debian-bookworm -> localhost | changed 2026-02-25 03:03:13.134364 | 2026-02-25 03:03:13.134463 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-25 03:03:13.447344 | debian-bookworm | ok 2026-02-25 03:03:13.456106 | 2026-02-25 03:03:13.456236 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-25 03:03:14.417135 | debian-bookworm | changed: 2026-02-25 03:03:14.417363 | debian-bookworm | cd+++++++++ src/ 2026-02-25 03:03:14.417419 | debian-bookworm | cd+++++++++ src/github.com/ 2026-02-25 03:03:14.417458 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-02-25 03:03:14.417493 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-02-25 03:03:14.417525 | debian-bookworm | =7.0.1 2026-02-25 03:03:40.551460 | debian-bookworm | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-25 03:03:40.611400 | debian-bookworm | Collecting colorama>=0.4.6 2026-02-25 03:03:40.624336 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-25 03:03:40.717419 | debian-bookworm | Collecting filelock>=3.24.3 2026-02-25 03:03:40.731285 | debian-bookworm | Downloading filelock-3.24.3-py3-none-any.whl (24 kB) 2026-02-25 03:03:40.801722 | debian-bookworm | Collecting packaging>=26 2026-02-25 03:03:40.813760 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-25 03:03:40.827577 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 9.1 MB/s eta 0:00:00 2026-02-25 03:03:40.895969 | debian-bookworm | Collecting platformdirs>=4.9.2 2026-02-25 03:03:40.909073 | debian-bookworm | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-25 03:03:40.965859 | debian-bookworm | Collecting pluggy>=1.6 2026-02-25 03:03:40.978778 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-25 03:03:41.034716 | debian-bookworm | Collecting pyproject-api>=1.10 2026-02-25 03:03:41.048685 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-25 03:03:41.200828 | debian-bookworm | Collecting virtualenv>=20.38 2026-02-25 03:03:41.215097 | debian-bookworm | Downloading virtualenv-20.39.0-py3-none-any.whl (5.8 MB) 2026-02-25 03:03:41.486753 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 21.9 MB/s eta 0:00:00 2026-02-25 03:03:41.590217 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-02-25 03:03:41.604055 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-25 03:03:41.626680 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 24.9 MB/s eta 0:00:00 2026-02-25 03:03:41.729970 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, cachetools, virtualenv, pyproject-api, tox 2026-02-25 03:03:42.473378 | 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 03:03:42.886446 | debian-bookworm | ok: Runtime: 0:00:03.001446 2026-02-25 03:03:42.893545 | 2026-02-25 03:03:42.893637 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-25 03:03:42.956233 | debian-bookworm | ok 2026-02-25 03:03:42.963597 | 2026-02-25 03:03:42.963698 | TASK [ensure-tox : Output tox version] 2026-02-25 03:03:43.579514 | 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 03:03:43.600502 | debian-bookworm | 4.46.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-02-25 03:03:44.016340 | debian-bookworm | ok: Runtime: 0:00:00.343595 2026-02-25 03:03:44.022244 | 2026-02-25 03:03:44.022333 | TASK [ensure-tox : Make global symlink] 2026-02-25 03:03:44.048071 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:03:44.055010 | 2026-02-25 03:03:44.055084 | PLAY RECAP 2026-02-25 03:03:44.055131 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-25 03:03:44.055156 | 2026-02-25 03:03:44.218044 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-25 03:03:44.219142 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-02-25 03:03:45.004969 | 2026-02-25 03:03:45.005224 | PLAY [all] 2026-02-25 03:03:45.045068 | 2026-02-25 03:03:45.045526 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-02-25 03:03:45.582434 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-02-25 03:03:46.100169 | debian-bookworm | ok: Runtime: 0:00:00.031327 2026-02-25 03:03:46.106157 | 2026-02-25 03:03:46.106294 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-02-25 03:03:46.633082 | debian-bookworm | ok: Runtime: 0:00:00.006135 2026-02-25 03:03:46.639713 | 2026-02-25 03:03:46.639841 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-02-25 03:03:47.099927 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-02-25 03:03:47.101077 | debian-bookworm | sudo: a password is required 2026-02-25 03:03:47.172978 | debian-bookworm | ok: Runtime: 0:00:00.190739 2026-02-25 03:03:47.184562 | 2026-02-25 03:03:47.184683 | TASK [tox : Check to see if the constraints file exists] 2026-02-25 03:03:47.209129 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:03:47.216297 | 2026-02-25 03:03:47.216450 | TASK [tox : Fail if constraints file is missing] 2026-02-25 03:03:47.242211 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:03:47.249507 | 2026-02-25 03:03:47.249637 | TASK [tox : Record file location] 2026-02-25 03:03:47.274696 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:03:47.281103 | 2026-02-25 03:03:47.281235 | TASK [tox : Install tox siblings] 2026-02-25 03:03:47.312140 | debian-bookworm | ok 2026-02-25 03:03:47.321850 | debian-bookworm | included: /var/lib/zuul/builds/2c5b2222715f40ec9c5801438c5c98af/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-02-25 03:03:47.330598 | 2026-02-25 03:03:47.330736 | TASK [tox : Run tox without tests] 2026-02-25 03:03:48.569455 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-02-25 03:04:03.060579 | debian-bookworm | test: OK (15.05 seconds) 2026-02-25 03:04:03.060680 | debian-bookworm | congratulations :) (15.09 seconds) 2026-02-25 03:04:03.364535 | debian-bookworm | ok: Runtime: 0:00:15.476496 2026-02-25 03:04:03.373062 | 2026-02-25 03:04:03.373181 | TASK [tox : Create a tempfile to save tox showconfig] 2026-02-25 03:04:03.872076 | debian-bookworm | changed 2026-02-25 03:04:03.877243 | 2026-02-25 03:04:03.877344 | TASK [tox : Get tox envlist config] 2026-02-25 03:04:04.919351 | debian-bookworm | ok: Runtime: 0:00:00.359701 2026-02-25 03:04:04.924640 | 2026-02-25 03:04:04.924743 | TASK [tox : Install any sibling python packages] 2026-02-25 03:04:05.417823 | debian-bookworm | ok: No setup.cfg, no action needed 2026-02-25 03:04:05.423181 | 2026-02-25 03:04:05.423269 | TASK [tox : Remove tempfile] 2026-02-25 03:04:05.849035 | debian-bookworm | changed 2026-02-25 03:04:05.854894 | 2026-02-25 03:04:05.854986 | TASK [tox : Emit tox command] 2026-02-25 03:04:05.893547 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-02-25 03:04:05.898786 | 2026-02-25 03:04:05.898909 | TASK [tox : Run tox] 2026-02-25 03:04:06.518862 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-02-25 03:04:07.160651 | debian-bookworm | ............... 2026-02-25 03:04:07.160708 | debian-bookworm | ---------------------------------------------------------------------- 2026-02-25 03:04:07.160725 | debian-bookworm | Ran 15 tests in 0.170s 2026-02-25 03:04:07.161227 | debian-bookworm | 2026-02-25 03:04:07.161245 | debian-bookworm | OK 2026-02-25 03:04:07.249915 | debian-bookworm | test: OK (0.77=setup[0.05]+cmd[0.73] seconds) 2026-02-25 03:04:07.249986 | debian-bookworm | congratulations :) (0.81 seconds) 2026-02-25 03:04:07.451563 | debian-bookworm | ok: Runtime: 0:00:01.103906 2026-02-25 03:04:07.461510 | 2026-02-25 03:04:07.461609 | TASK [tox : Look for output] 2026-02-25 03:04:07.894009 | debian-bookworm | ok 2026-02-25 03:04:07.910068 | 2026-02-25 03:04:07.912318 | TASK [tox : Return file comments to Zuul] 2026-02-25 03:04:07.937770 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:07.945325 | 2026-02-25 03:04:07.945420 | PLAY RECAP 2026-02-25 03:04:07.945482 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-02-25 03:04:07.945512 | 2026-02-25 03:04:08.041434 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-02-25 03:04:08.042407 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-25 03:04:09.144647 | 2026-02-25 03:04:09.144781 | PLAY [all] 2026-02-25 03:04:09.181343 | 2026-02-25 03:04:09.181479 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-25 03:04:09.309960 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:09.320771 | 2026-02-25 03:04:09.320961 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-25 03:04:09.371042 | debian-bookworm | ok 2026-02-25 03:04:09.376432 | 2026-02-25 03:04:09.379013 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-25 03:04:10.304775 | debian-bookworm -> localhost | changed 2026-02-25 03:04:10.313557 | 2026-02-25 03:04:10.313677 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-25 03:04:10.373997 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:10.392631 | 2026-02-25 03:04:10.393678 | TASK [fetch-tox-output : Set envlist fact] 2026-02-25 03:04:10.512530 | debian-bookworm | ok 2026-02-25 03:04:10.532146 | 2026-02-25 03:04:10.532628 | TASK [fetch-tox-output : Get tox version] 2026-02-25 03:04:11.380780 | 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 03:04:11.401507 | debian-bookworm | 4.46.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-02-25 03:04:11.602572 | debian-bookworm | ok: Runtime: 0:00:00.320830 2026-02-25 03:04:11.608354 | 2026-02-25 03:04:11.608477 | TASK [fetch-tox-output : Find all default environments] 2026-02-25 03:04:12.155184 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:12.161678 | 2026-02-25 03:04:12.161829 | TASK [fetch-tox-output : Set envlist fact] 2026-02-25 03:04:12.197024 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:12.203491 | 2026-02-25 03:04:12.203635 | TASK [fetch-tox-output : Find all default environments] 2026-02-25 03:04:12.779136 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:12.792219 | 2026-02-25 03:04:12.792438 | TASK [fetch-tox-output : Set envlist fact] 2026-02-25 03:04:12.820633 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:12.828565 | 2026-02-25 03:04:12.828698 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-25 03:04:12.909572 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:12.937833 | 2026-02-25 03:04:12.938015 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-25 03:04:13.843985 | debian-bookworm | changed: 2026-02-25 03:04:13.844196 | debian-bookworm | created directory /var/lib/zuul/builds/2c5b2222715f40ec9c5801438c5c98af/work/logs/tox/test 2026-02-25 03:04:13.844231 | debian-bookworm | cd+++++++++ ./ 2026-02-25 03:04:13.844256 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-02-25 03:04:13.844286 | 2026-02-25 03:04:13.852277 | 2026-02-25 03:04:13.852386 | PLAY RECAP 2026-02-25 03:04:13.852440 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-25 03:04:13.852482 | 2026-02-25 03:04:14.000246 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-25 03:04:14.002875 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-25 03:04:15.112209 | 2026-02-25 03:04:15.112408 | PLAY [all] 2026-02-25 03:04:15.130194 | 2026-02-25 03:04:15.130370 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-25 03:04:15.359272 | debian-bookworm | changed: non-zero return code 2026-02-25 03:04:15.369794 | 2026-02-25 03:04:15.370101 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-25 03:04:15.396167 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:15.403728 | 2026-02-25 03:04:15.403931 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-25 03:04:15.439451 | 2026-02-25 03:04:15.439656 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-25 03:04:15.472564 | 2026-02-25 03:04:15.472760 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-25 03:04:15.487687 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:15.494986 | 2026-02-25 03:04:15.495124 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-25 03:04:15.526369 | 2026-02-25 03:04:15.526563 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-25 03:04:15.550508 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:15.558453 | 2026-02-25 03:04:15.558590 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-25 03:04:15.583202 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:15.589652 | 2026-02-25 03:04:15.589772 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-25 03:04:15.623578 | debian-bookworm | skipping: Conditional result was False 2026-02-25 03:04:15.633731 | 2026-02-25 03:04:15.633850 | PLAY RECAP 2026-02-25 03:04:15.633951 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-25 03:04:15.633990 | 2026-02-25 03:04:15.775383 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-25 03:04:15.777937 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-25 03:04:16.592178 | 2026-02-25 03:04:16.592372 | PLAY [Base post] 2026-02-25 03:04:16.606852 | 2026-02-25 03:04:16.607014 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-25 03:04:17.238667 | debian-bookworm | changed 2026-02-25 03:04:17.249053 | 2026-02-25 03:04:17.249236 | PLAY RECAP 2026-02-25 03:04:17.249326 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-25 03:04:17.249411 | 2026-02-25 03:04:17.382320 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-02-25 03:04:17.384382 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-25 03:04:18.240652 | 2026-02-25 03:04:18.240840 | PLAY [Base post-logs] 2026-02-25 03:04:18.252108 | 2026-02-25 03:04:18.252262 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-25 03:04:18.776384 | localhost | changed 2026-02-25 03:04:18.788851 | 2026-02-25 03:04:18.789047 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-25 03:04:18.817044 | localhost | ok 2026-02-25 03:04:18.820808 | 2026-02-25 03:04:18.820937 | TASK [Set zuul-log-path fact] 2026-02-25 03:04:18.852851 | localhost | ok 2026-02-25 03:04:18.870145 | 2026-02-25 03:04:18.870316 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 03:04:18.906823 | localhost | ok 2026-02-25 03:04:18.910240 | 2026-02-25 03:04:18.910349 | TASK [upload-logs : Create log directories] 2026-02-25 03:04:19.492739 | localhost | changed 2026-02-25 03:04:19.495722 | 2026-02-25 03:04:19.495838 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-25 03:04:20.091137 | localhost -> localhost | ok: Runtime: 0:00:00.007274 2026-02-25 03:04:20.099343 | 2026-02-25 03:04:20.099530 | TASK [upload-logs : Upload logs to log server] 2026-02-25 03:04:20.747128 | localhost | Output suppressed because no_log was given 2026-02-25 03:04:20.752969 | 2026-02-25 03:04:20.753168 | LOOP [upload-logs : Compress console log and json output] 2026-02-25 03:04:20.809178 | localhost | skipping: Conditional result was False 2026-02-25 03:04:20.815480 | localhost | skipping: Conditional result was False 2026-02-25 03:04:20.823880 | 2026-02-25 03:04:20.824054 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-25 03:04:20.881270 | localhost | skipping: Conditional result was False 2026-02-25 03:04:20.881762 | 2026-02-25 03:04:20.885649 | localhost | skipping: Conditional result was False 2026-02-25 03:04:20.893970 | 2026-02-25 03:04:20.894163 | LOOP [upload-logs : Upload console log and json output]