2025-12-23 03:03:05.819974 | Job console starting 2025-12-23 03:03:05.832955 | Updating git repos 2025-12-23 03:03:05.862734 | Cloning repos into workspace 2025-12-23 03:03:05.966075 | Restoring repo states 2025-12-23 03:03:05.998141 | Merging changes 2025-12-23 03:03:05.998158 | Checking out repos 2025-12-23 03:03:06.060865 | Preparing playbooks 2025-12-23 03:03:07.198974 | Running Ansible setup 2025-12-23 03:03:13.353070 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-23 03:03:14.710573 | 2025-12-23 03:03:14.719044 | PLAY [Base pre] 2025-12-23 03:03:14.774565 | 2025-12-23 03:03:14.774746 | TASK [Setup log path fact] 2025-12-23 03:03:14.812501 | debian-bookworm | ok 2025-12-23 03:03:14.846058 | 2025-12-23 03:03:14.846239 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-23 03:03:14.976304 | debian-bookworm | ok 2025-12-23 03:03:15.028936 | 2025-12-23 03:03:15.029092 | TASK [emit-job-header : Print job information] 2025-12-23 03:03:15.181153 | # Job Information 2025-12-23 03:03:15.181361 | Ansible Version: 2.16.14 2025-12-23 03:03:15.181422 | Job: tox 2025-12-23 03:03:15.181457 | Pipeline: periodic-daily 2025-12-23 03:03:15.181481 | Executor: 521e9411259a 2025-12-23 03:03:15.181503 | Triggered by: https://github.com/osism/openstack-image-manager 2025-12-23 03:03:15.181526 | Event ID: 305c8ebfd629449cbcc8d49c778ea856 2025-12-23 03:03:15.217426 | 2025-12-23 03:03:15.217583 | LOOP [emit-job-header : Print node information] 2025-12-23 03:03:15.464991 | debian-bookworm | ok: 2025-12-23 03:03:15.465208 | debian-bookworm | # Node Information 2025-12-23 03:03:15.465246 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-23 03:03:15.465272 | debian-bookworm | Hostname: debian 2025-12-23 03:03:15.465294 | debian-bookworm | Username: zuul 2025-12-23 03:03:15.465315 | debian-bookworm | Distro: Debian 12.12 2025-12-23 03:03:15.465338 | debian-bookworm | Provider: regiocloud-a 2025-12-23 03:03:15.465359 | debian-bookworm | Region: 2025-12-23 03:03:15.465438 | debian-bookworm | Label: debian-bookworm 2025-12-23 03:03:15.465464 | debian-bookworm | Product Name: OpenStack Nova 2025-12-23 03:03:15.465484 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec1:c349 2025-12-23 03:03:15.539608 | 2025-12-23 03:03:15.539783 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-23 03:03:17.989924 | debian-bookworm -> localhost | changed 2025-12-23 03:03:18.010030 | 2025-12-23 03:03:18.010698 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-23 03:03:21.674041 | debian-bookworm -> localhost | changed 2025-12-23 03:03:21.685905 | 2025-12-23 03:03:21.686010 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-23 03:03:22.325056 | debian-bookworm -> localhost | ok 2025-12-23 03:03:22.330991 | 2025-12-23 03:03:22.331107 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-23 03:03:22.416458 | debian-bookworm | ok 2025-12-23 03:03:22.447689 | debian-bookworm | included: /var/lib/zuul/builds/5ebb312623224b609b0d4644b4ae61bd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-23 03:03:22.456688 | 2025-12-23 03:03:22.456785 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-23 03:03:26.233345 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-23 03:03:26.233586 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5ebb312623224b609b0d4644b4ae61bd/work/5ebb312623224b609b0d4644b4ae61bd_id_rsa 2025-12-23 03:03:26.233622 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5ebb312623224b609b0d4644b4ae61bd/work/5ebb312623224b609b0d4644b4ae61bd_id_rsa.pub 2025-12-23 03:03:26.233643 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-23 03:03:26.233662 | debian-bookworm -> localhost | SHA256:ZHswL3osefnzZdfotfIqcXaWjdyA0ApasZctKjmJ8I4 zuul-build-sshkey 2025-12-23 03:03:26.233679 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-23 03:03:26.233704 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-23 03:03:26.233723 | debian-bookworm -> localhost | | .. . | 2025-12-23 03:03:26.233741 | debian-bookworm -> localhost | | o..o. | 2025-12-23 03:03:26.233758 | debian-bookworm -> localhost | | . o*.+o.. | 2025-12-23 03:03:26.233774 | debian-bookworm -> localhost | | o ..= B... . | 2025-12-23 03:03:26.233790 | debian-bookworm -> localhost | | o = S o . +o| 2025-12-23 03:03:26.233811 | debian-bookworm -> localhost | | o * + . oo=+| 2025-12-23 03:03:26.233828 | debian-bookworm -> localhost | | E . + = + * +| 2025-12-23 03:03:26.233844 | debian-bookworm -> localhost | | + ... = o.| 2025-12-23 03:03:26.233861 | debian-bookworm -> localhost | | .oo.=o | 2025-12-23 03:03:26.233877 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-23 03:03:26.233918 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.604779 2025-12-23 03:03:26.239880 | 2025-12-23 03:03:26.239966 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-23 03:03:26.308721 | debian-bookworm | ok 2025-12-23 03:03:26.318656 | debian-bookworm | included: /var/lib/zuul/builds/5ebb312623224b609b0d4644b4ae61bd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-23 03:03:26.386009 | 2025-12-23 03:03:26.386114 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-23 03:03:26.472802 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:03:26.479250 | 2025-12-23 03:03:26.479340 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-23 03:03:27.988338 | debian-bookworm | changed 2025-12-23 03:03:27.992726 | 2025-12-23 03:03:27.992809 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-23 03:03:28.279953 | debian-bookworm | ok 2025-12-23 03:03:28.292182 | 2025-12-23 03:03:28.292287 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-23 03:03:29.043253 | debian-bookworm | changed 2025-12-23 03:03:29.055893 | 2025-12-23 03:03:29.055997 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-23 03:03:29.888715 | debian-bookworm | changed 2025-12-23 03:03:29.895654 | 2025-12-23 03:03:29.895761 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-23 03:03:29.935659 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:03:29.941844 | 2025-12-23 03:03:29.941950 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-23 03:03:31.324696 | debian-bookworm -> localhost | changed 2025-12-23 03:03:31.349630 | 2025-12-23 03:03:31.349777 | TASK [add-build-sshkey : Add back temp key] 2025-12-23 03:03:32.690519 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5ebb312623224b609b0d4644b4ae61bd/work/5ebb312623224b609b0d4644b4ae61bd_id_rsa (zuul-build-sshkey) 2025-12-23 03:03:32.690734 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.045680 2025-12-23 03:03:32.698344 | 2025-12-23 03:03:32.698478 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-23 03:03:33.245897 | debian-bookworm | ok 2025-12-23 03:03:33.250768 | 2025-12-23 03:03:33.255798 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-23 03:03:33.299161 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:03:33.309991 | 2025-12-23 03:03:33.310106 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-23 03:03:34.230634 | debian-bookworm | ok 2025-12-23 03:03:34.246571 | 2025-12-23 03:03:34.246669 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-23 03:03:34.345148 | debian-bookworm | ok 2025-12-23 03:03:34.350383 | 2025-12-23 03:03:34.350477 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-23 03:03:35.626649 | debian-bookworm -> localhost | ok 2025-12-23 03:03:35.633963 | 2025-12-23 03:03:35.634063 | TASK [validate-host : Collect information about the host] 2025-12-23 03:03:37.322815 | debian-bookworm | ok 2025-12-23 03:03:37.348560 | 2025-12-23 03:03:37.348667 | TASK [validate-host : Sanitize hostname] 2025-12-23 03:03:37.666706 | debian-bookworm | ok 2025-12-23 03:03:37.728347 | 2025-12-23 03:03:37.728469 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-23 03:03:39.788006 | debian-bookworm -> localhost | changed 2025-12-23 03:03:39.793355 | 2025-12-23 03:03:39.793458 | TASK [validate-host : Collect information about zuul worker] 2025-12-23 03:03:40.487320 | debian-bookworm | ok 2025-12-23 03:03:40.492224 | 2025-12-23 03:03:40.492316 | TASK [validate-host : Write out all zuul information for each host] 2025-12-23 03:03:42.138006 | debian-bookworm -> localhost | changed 2025-12-23 03:03:42.147014 | 2025-12-23 03:03:42.147113 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-23 03:03:42.481805 | debian-bookworm | ok 2025-12-23 03:03:42.498269 | 2025-12-23 03:03:42.498386 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-23 03:03:44.645932 | debian-bookworm | changed: 2025-12-23 03:03:44.646082 | debian-bookworm | cd+++++++++ src/ 2025-12-23 03:03:44.646112 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-23 03:03:44.646169 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-23 03:03:44.646189 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-23 03:03:44.646206 | debian-bookworm | =6.2 2025-12-23 03:04:11.441451 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2025-12-23 03:04:11.496639 | debian-bookworm | Collecting chardet>=5.2 2025-12-23 03:04:11.509970 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-23 03:04:11.520706 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 26.7 MB/s eta 0:00:00 2025-12-23 03:04:11.562239 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-23 03:04:11.575144 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-23 03:04:11.631941 | debian-bookworm | Collecting filelock>=3.20 2025-12-23 03:04:11.644890 | debian-bookworm | Downloading filelock-3.20.1-py3-none-any.whl (16 kB) 2025-12-23 03:04:11.698521 | debian-bookworm | Collecting packaging>=25 2025-12-23 03:04:11.711281 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-23 03:04:11.804215 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 1.0 MB/s eta 0:00:00 2025-12-23 03:04:11.872315 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-23 03:04:11.885465 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-23 03:04:11.930585 | debian-bookworm | Collecting pluggy>=1.6 2025-12-23 03:04:11.943394 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-23 03:04:11.987339 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-23 03:04:12.002775 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-23 03:04:12.150135 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-23 03:04:12.163204 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-23 03:04:12.458506 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 20.7 MB/s eta 0:00:00 2025-12-23 03:04:12.572116 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-23 03:04:12.585046 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-23 03:04:12.611798 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.5 MB/s eta 0:00:00 2025-12-23 03:04:12.795614 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-23 03:04:13.720239 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.1 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-12-23 03:04:14.117797 | debian-bookworm | ok: Runtime: 0:00:03.368199 2025-12-23 03:04:14.124651 | 2025-12-23 03:04:14.124789 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-23 03:04:14.197253 | debian-bookworm | ok 2025-12-23 03:04:14.202424 | 2025-12-23 03:04:14.202555 | TASK [ensure-tox : Output tox version] 2025-12-23 03:04:14.971380 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-23 03:04:14.991853 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-23 03:04:15.284994 | debian-bookworm | ok: Runtime: 0:00:00.348712 2025-12-23 03:04:15.291095 | 2025-12-23 03:04:15.291217 | TASK [ensure-tox : Make global symlink] 2025-12-23 03:04:15.353050 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:15.371512 | 2025-12-23 03:04:15.371641 | PLAY RECAP 2025-12-23 03:04:15.371730 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-23 03:04:15.371760 | 2025-12-23 03:04:15.875362 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-23 03:04:15.876507 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-23 03:04:18.713961 | 2025-12-23 03:04:18.714143 | PLAY [all] 2025-12-23 03:04:18.780744 | 2025-12-23 03:04:18.780928 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-23 03:04:19.866872 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-23 03:04:19.923729 | debian-bookworm | ok: Runtime: 0:00:00.032129 2025-12-23 03:04:19.930458 | 2025-12-23 03:04:19.930618 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-23 03:04:20.509176 | debian-bookworm | ok: Runtime: 0:00:00.006659 2025-12-23 03:04:20.528053 | 2025-12-23 03:04:20.528206 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-23 03:04:21.105868 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-23 03:04:21.107532 | debian-bookworm | sudo: a password is required 2025-12-23 03:04:21.149098 | debian-bookworm | ok: Runtime: 0:00:00.022774 2025-12-23 03:04:21.174703 | 2025-12-23 03:04:21.174926 | TASK [tox : Check to see if the constraints file exists] 2025-12-23 03:04:21.275675 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:21.282919 | 2025-12-23 03:04:21.283068 | TASK [tox : Fail if constraints file is missing] 2025-12-23 03:04:21.380265 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:21.389416 | 2025-12-23 03:04:21.389579 | TASK [tox : Record file location] 2025-12-23 03:04:21.505749 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:21.512670 | 2025-12-23 03:04:21.512808 | TASK [tox : Install tox siblings] 2025-12-23 03:04:21.568484 | debian-bookworm | ok 2025-12-23 03:04:21.594438 | debian-bookworm | included: /var/lib/zuul/builds/5ebb312623224b609b0d4644b4ae61bd/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-23 03:04:21.617698 | 2025-12-23 03:04:21.617849 | TASK [tox : Run tox without tests] 2025-12-23 03:04:22.872967 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-23 03:04:37.178260 | debian-bookworm | test: OK (14.80 seconds) 2025-12-23 03:04:37.179542 | debian-bookworm | congratulations :) (14.84 seconds) 2025-12-23 03:04:37.693836 | debian-bookworm | ok: Runtime: 0:00:15.132156 2025-12-23 03:04:37.708433 | 2025-12-23 03:04:37.708582 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-23 03:04:38.417807 | debian-bookworm | changed 2025-12-23 03:04:38.438680 | 2025-12-23 03:04:38.439658 | TASK [tox : Get tox envlist config] 2025-12-23 03:04:39.627536 | debian-bookworm | ok: Runtime: 0:00:00.345120 2025-12-23 03:04:39.635687 | 2025-12-23 03:04:39.635835 | TASK [tox : Install any sibling python packages] 2025-12-23 03:04:40.569546 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-23 03:04:40.575794 | 2025-12-23 03:04:40.575924 | TASK [tox : Remove tempfile] 2025-12-23 03:04:41.333841 | debian-bookworm | changed 2025-12-23 03:04:41.343234 | 2025-12-23 03:04:41.343404 | TASK [tox : Emit tox command] 2025-12-23 03:04:41.424991 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-23 03:04:41.433594 | 2025-12-23 03:04:41.433736 | TASK [tox : Run tox] 2025-12-23 03:04:42.525824 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-23 03:04:43.228312 | debian-bookworm | ............... 2025-12-23 03:04:43.228370 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-23 03:04:43.229137 | debian-bookworm | Ran 15 tests in 0.192s 2025-12-23 03:04:43.229154 | debian-bookworm | 2025-12-23 03:04:43.229164 | debian-bookworm | OK 2025-12-23 03:04:43.336760 | debian-bookworm | test: OK (0.85=setup[0.05]+cmd[0.81] seconds) 2025-12-23 03:04:43.336868 | debian-bookworm | congratulations :) (0.88 seconds) 2025-12-23 03:04:43.685731 | debian-bookworm | ok: Runtime: 0:00:01.233199 2025-12-23 03:04:43.690224 | 2025-12-23 03:04:43.690306 | TASK [tox : Look for output] 2025-12-23 03:04:44.463710 | debian-bookworm | ok 2025-12-23 03:04:44.512704 | 2025-12-23 03:04:44.512828 | TASK [tox : Return file comments to Zuul] 2025-12-23 03:04:44.584796 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:44.601508 | 2025-12-23 03:04:44.601608 | PLAY RECAP 2025-12-23 03:04:44.601686 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-23 03:04:44.601717 | 2025-12-23 03:04:45.041758 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-23 03:04:45.042596 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-23 03:04:46.457577 | 2025-12-23 03:04:46.457735 | PLAY [all] 2025-12-23 03:04:46.482284 | 2025-12-23 03:04:46.482445 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-23 03:04:46.569113 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:46.574740 | 2025-12-23 03:04:46.574900 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-23 03:04:46.632913 | debian-bookworm | ok 2025-12-23 03:04:46.637979 | 2025-12-23 03:04:46.638087 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-23 03:04:47.621908 | debian-bookworm -> localhost | changed 2025-12-23 03:04:47.630132 | 2025-12-23 03:04:47.630237 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-23 03:04:47.732344 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:47.738342 | 2025-12-23 03:04:47.738469 | TASK [fetch-tox-output : Set envlist fact] 2025-12-23 03:04:47.798032 | debian-bookworm | ok 2025-12-23 03:04:47.805392 | 2025-12-23 03:04:47.805493 | TASK [fetch-tox-output : Get tox version] 2025-12-23 03:04:48.502651 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-23 03:04:48.520347 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-23 03:04:48.874341 | debian-bookworm | ok: Runtime: 0:00:00.265376 2025-12-23 03:04:48.893289 | 2025-12-23 03:04:48.893433 | TASK [fetch-tox-output : Find all default environments] 2025-12-23 03:04:49.445968 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:49.452346 | 2025-12-23 03:04:49.452480 | TASK [fetch-tox-output : Set envlist fact] 2025-12-23 03:04:49.495784 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:49.501298 | 2025-12-23 03:04:49.501426 | TASK [fetch-tox-output : Find all default environments] 2025-12-23 03:04:50.057167 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:50.065450 | 2025-12-23 03:04:50.065578 | TASK [fetch-tox-output : Set envlist fact] 2025-12-23 03:04:50.127241 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:50.138241 | 2025-12-23 03:04:50.138416 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-23 03:04:50.261826 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:50.279968 | 2025-12-23 03:04:50.280082 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-23 03:04:51.966364 | debian-bookworm | changed: 2025-12-23 03:04:51.966986 | debian-bookworm | created directory /var/lib/zuul/builds/5ebb312623224b609b0d4644b4ae61bd/work/logs/tox/test 2025-12-23 03:04:51.967029 | debian-bookworm | cd+++++++++ ./ 2025-12-23 03:04:51.967462 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-23 03:04:51.967504 | 2025-12-23 03:04:51.979407 | 2025-12-23 03:04:51.979522 | PLAY RECAP 2025-12-23 03:04:51.979577 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-23 03:04:51.979601 | 2025-12-23 03:04:52.609393 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-23 03:04:52.610731 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-23 03:04:55.295179 | 2025-12-23 03:04:55.295345 | PLAY [all] 2025-12-23 03:04:55.324023 | 2025-12-23 03:04:55.324198 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-23 03:04:55.711669 | debian-bookworm | changed: non-zero return code 2025-12-23 03:04:55.725798 | 2025-12-23 03:04:55.726790 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-23 03:04:55.807808 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:55.817345 | 2025-12-23 03:04:55.817712 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-23 03:04:55.914886 | 2025-12-23 03:04:55.915157 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-23 03:04:55.988689 | 2025-12-23 03:04:55.988956 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-23 03:04:56.051145 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:56.061270 | 2025-12-23 03:04:56.061454 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-23 03:04:56.125620 | 2025-12-23 03:04:56.125830 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-23 03:04:56.172908 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:56.179148 | 2025-12-23 03:04:56.179279 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-23 03:04:56.232735 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:56.255851 | 2025-12-23 03:04:56.255999 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-23 03:04:56.345637 | debian-bookworm | skipping: Conditional result was False 2025-12-23 03:04:56.358401 | 2025-12-23 03:04:56.358517 | PLAY RECAP 2025-12-23 03:04:56.358570 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-23 03:04:56.358596 | 2025-12-23 03:04:56.616122 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-23 03:04:56.617227 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-23 03:04:58.339346 | 2025-12-23 03:04:58.339594 | PLAY [Base post] 2025-12-23 03:04:58.355639 | 2025-12-23 03:04:58.355799 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-23 03:04:59.036233 | debian-bookworm | changed 2025-12-23 03:04:59.046550 | 2025-12-23 03:04:59.046693 | PLAY RECAP 2025-12-23 03:04:59.046810 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-23 03:04:59.046932 | 2025-12-23 03:04:59.258670 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-23 03:04:59.259808 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-23 03:05:00.654280 | 2025-12-23 03:05:00.654509 | PLAY [Base post-logs] 2025-12-23 03:05:00.705429 | 2025-12-23 03:05:00.705617 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-23 03:05:02.154303 | localhost | changed 2025-12-23 03:05:02.165474 | 2025-12-23 03:05:02.165652 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-23 03:05:02.217634 | localhost | ok 2025-12-23 03:05:02.229617 | 2025-12-23 03:05:02.229752 | TASK [Set zuul-log-path fact] 2025-12-23 03:05:02.269407 | localhost | ok 2025-12-23 03:05:02.299631 | 2025-12-23 03:05:02.299789 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-23 03:05:02.334714 | localhost | ok 2025-12-23 03:05:02.338184 | 2025-12-23 03:05:02.338293 | TASK [upload-logs : Create log directories] 2025-12-23 03:05:03.180882 | localhost | changed 2025-12-23 03:05:03.185047 | 2025-12-23 03:05:03.185352 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-23 03:05:03.883152 | localhost -> localhost | ok: Runtime: 0:00:00.006264 2025-12-23 03:05:03.889820 | 2025-12-23 03:05:03.890241 | TASK [upload-logs : Upload logs to log server] 2025-12-23 03:05:04.865908 | localhost | Output suppressed because no_log was given 2025-12-23 03:05:04.868054 | 2025-12-23 03:05:04.868167 | LOOP [upload-logs : Compress console log and json output] 2025-12-23 03:05:04.926616 | localhost | skipping: Conditional result was False 2025-12-23 03:05:04.941880 | localhost | skipping: Conditional result was False 2025-12-23 03:05:04.948502 | 2025-12-23 03:05:04.948646 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-23 03:05:05.098169 | localhost | skipping: Conditional result was False 2025-12-23 03:05:05.099129 | 2025-12-23 03:05:05.107706 | localhost | skipping: Conditional result was False 2025-12-23 03:05:05.116139 | 2025-12-23 03:05:05.116286 | LOOP [upload-logs : Upload console log and json output]