2025-11-09 17:18:49.232936 | Job console starting 2025-11-09 17:18:49.242079 | Updating git repos 2025-11-09 17:18:49.278277 | Cloning repos into workspace 2025-11-09 17:18:49.357192 | Restoring repo states 2025-11-09 17:18:49.380485 | Merging changes 2025-11-09 17:18:49.880073 | Checking out repos 2025-11-09 17:18:49.943147 | Preparing playbooks 2025-11-09 17:18:50.806101 | Running Ansible setup 2025-11-09 17:18:57.134141 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-09 17:18:58.486826 | 2025-11-09 17:18:58.494528 | PLAY [Base pre] 2025-11-09 17:18:58.517690 | 2025-11-09 17:18:58.517807 | TASK [Setup log path fact] 2025-11-09 17:18:58.552700 | debian-bookworm | ok 2025-11-09 17:18:58.572399 | 2025-11-09 17:18:58.572504 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-09 17:18:58.604941 | debian-bookworm | ok 2025-11-09 17:18:58.616655 | 2025-11-09 17:18:58.616742 | TASK [emit-job-header : Print job information] 2025-11-09 17:18:58.647018 | # Job Information 2025-11-09 17:18:58.647205 | Ansible Version: 2.16.14 2025-11-09 17:18:58.647236 | Job: tox 2025-11-09 17:18:58.647265 | Pipeline: check 2025-11-09 17:18:58.647288 | Executor: 521e9411259a 2025-11-09 17:18:58.647305 | Triggered by: https://github.com/osism/openstack-image-manager/pull/987 2025-11-09 17:18:58.647323 | Event ID: 20fd5920-bd90-11f0-8d57-77d63dac04ab 2025-11-09 17:18:58.651394 | 2025-11-09 17:18:58.651485 | LOOP [emit-job-header : Print node information] 2025-11-09 17:18:58.752102 | debian-bookworm | ok: 2025-11-09 17:18:58.752291 | debian-bookworm | # Node Information 2025-11-09 17:18:58.752322 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-09 17:18:58.752343 | debian-bookworm | Hostname: debian 2025-11-09 17:18:58.752362 | debian-bookworm | Username: zuul 2025-11-09 17:18:58.752379 | debian-bookworm | Distro: Debian 12.12 2025-11-09 17:18:58.752398 | debian-bookworm | Provider: regiocloud-a 2025-11-09 17:18:58.752416 | debian-bookworm | Region: 2025-11-09 17:18:58.752433 | debian-bookworm | Label: debian-bookworm 2025-11-09 17:18:58.752449 | debian-bookworm | Product Name: OpenStack Nova 2025-11-09 17:18:58.752465 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee5:b828 2025-11-09 17:18:58.765895 | 2025-11-09 17:18:58.765986 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-09 17:18:59.291985 | debian-bookworm -> localhost | changed 2025-11-09 17:18:59.297714 | 2025-11-09 17:18:59.297810 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-09 17:19:01.650761 | debian-bookworm -> localhost | changed 2025-11-09 17:19:01.659881 | 2025-11-09 17:19:01.659969 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-09 17:19:02.145890 | debian-bookworm -> localhost | ok 2025-11-09 17:19:02.151264 | 2025-11-09 17:19:02.151359 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-09 17:19:02.185069 | debian-bookworm | ok 2025-11-09 17:19:02.212161 | debian-bookworm | included: /var/lib/zuul/builds/1b8c6fdd58564cbd8eb42166bacd0814/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-09 17:19:02.217625 | 2025-11-09 17:19:02.217698 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-09 17:19:04.288565 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-09 17:19:04.288801 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1b8c6fdd58564cbd8eb42166bacd0814/work/1b8c6fdd58564cbd8eb42166bacd0814_id_rsa 2025-11-09 17:19:04.288837 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1b8c6fdd58564cbd8eb42166bacd0814/work/1b8c6fdd58564cbd8eb42166bacd0814_id_rsa.pub 2025-11-09 17:19:04.288859 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-09 17:19:04.288880 | debian-bookworm -> localhost | SHA256:N4z1WEBYrY3lj3UYhbPmCm7rnDDm1IAl1jpkhYEVHII zuul-build-sshkey 2025-11-09 17:19:04.288899 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-09 17:19:04.288924 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-09 17:19:04.288943 | debian-bookworm -> localhost | | ..+==.++. o.| 2025-11-09 17:19:04.288961 | debian-bookworm -> localhost | | E ..oo. .o + | 2025-11-09 17:19:04.288978 | debian-bookworm -> localhost | | = o .*. = | 2025-11-09 17:19:04.288998 | debian-bookworm -> localhost | | + = +o+o = .| 2025-11-09 17:19:04.289015 | debian-bookworm -> localhost | | + S = .* . | 2025-11-09 17:19:04.289035 | debian-bookworm -> localhost | | . +... o | 2025-11-09 17:19:04.289052 | debian-bookworm -> localhost | | =... . | 2025-11-09 17:19:04.289069 | debian-bookworm -> localhost | | + +o.. | 2025-11-09 17:19:04.289086 | debian-bookworm -> localhost | | .o=. | 2025-11-09 17:19:04.289103 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-09 17:19:04.289144 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.237465 2025-11-09 17:19:04.309130 | 2025-11-09 17:19:04.309213 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-09 17:19:04.340069 | debian-bookworm | ok 2025-11-09 17:19:04.347262 | debian-bookworm | included: /var/lib/zuul/builds/1b8c6fdd58564cbd8eb42166bacd0814/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-09 17:19:04.371840 | 2025-11-09 17:19:04.371915 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-09 17:19:04.417251 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:19:04.421838 | 2025-11-09 17:19:04.421909 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-09 17:19:05.150244 | debian-bookworm | changed 2025-11-09 17:19:05.154478 | 2025-11-09 17:19:05.154553 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-09 17:19:05.400598 | debian-bookworm | ok 2025-11-09 17:19:05.405004 | 2025-11-09 17:19:05.405072 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-09 17:19:06.047302 | debian-bookworm | changed 2025-11-09 17:19:06.052613 | 2025-11-09 17:19:06.052686 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-09 17:19:06.707042 | debian-bookworm | changed 2025-11-09 17:19:06.711358 | 2025-11-09 17:19:06.711430 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-09 17:19:06.754055 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:19:06.759227 | 2025-11-09 17:19:06.759301 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-09 17:19:07.159550 | debian-bookworm -> localhost | changed 2025-11-09 17:19:07.168158 | 2025-11-09 17:19:07.168232 | TASK [add-build-sshkey : Add back temp key] 2025-11-09 17:19:07.475878 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1b8c6fdd58564cbd8eb42166bacd0814/work/1b8c6fdd58564cbd8eb42166bacd0814_id_rsa (zuul-build-sshkey) 2025-11-09 17:19:07.476399 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012456 2025-11-09 17:19:07.492930 | 2025-11-09 17:19:07.493052 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-09 17:19:07.948150 | debian-bookworm | ok 2025-11-09 17:19:07.952181 | 2025-11-09 17:19:07.952249 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-09 17:19:07.980296 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:19:07.988967 | 2025-11-09 17:19:07.989038 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-09 17:19:08.395604 | debian-bookworm | ok 2025-11-09 17:19:08.406935 | 2025-11-09 17:19:08.407026 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-09 17:19:08.436716 | debian-bookworm | ok 2025-11-09 17:19:08.442498 | 2025-11-09 17:19:08.442586 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-09 17:19:08.712139 | debian-bookworm -> localhost | ok 2025-11-09 17:19:08.718114 | 2025-11-09 17:19:08.718208 | TASK [validate-host : Collect information about the host] 2025-11-09 17:19:10.048021 | debian-bookworm | ok 2025-11-09 17:19:10.068241 | 2025-11-09 17:19:10.068347 | TASK [validate-host : Sanitize hostname] 2025-11-09 17:19:10.280122 | debian-bookworm | ok 2025-11-09 17:19:10.335900 | 2025-11-09 17:19:10.335998 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-09 17:19:11.033876 | debian-bookworm -> localhost | changed 2025-11-09 17:19:11.039228 | 2025-11-09 17:19:11.039311 | TASK [validate-host : Collect information about zuul worker] 2025-11-09 17:19:11.494609 | debian-bookworm | ok 2025-11-09 17:19:11.499029 | 2025-11-09 17:19:11.499112 | TASK [validate-host : Write out all zuul information for each host] 2025-11-09 17:19:12.504256 | debian-bookworm -> localhost | changed 2025-11-09 17:19:12.513912 | 2025-11-09 17:19:12.513995 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-09 17:19:12.748517 | debian-bookworm | ok 2025-11-09 17:19:12.752858 | 2025-11-09 17:19:12.752931 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-09 17:19:13.682806 | debian-bookworm | changed: 2025-11-09 17:19:13.682977 | debian-bookworm | cd+++++++++ src/ 2025-11-09 17:19:13.683006 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-09 17:19:13.683026 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-09 17:19:13.683045 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-09 17:19:13.683062 | debian-bookworm | =6.2 2025-11-09 17:19:35.805047 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-11-09 17:19:35.837252 | debian-bookworm | Collecting chardet>=5.2 2025-11-09 17:19:35.848673 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-09 17:19:35.865211 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 14.1 MB/s eta 0:00:00 2025-11-09 17:19:35.908996 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-09 17:19:35.920206 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-09 17:19:35.971314 | debian-bookworm | Collecting filelock>=3.20 2025-11-09 17:19:35.982248 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-09 17:19:36.024282 | debian-bookworm | Collecting packaging>=25 2025-11-09 17:19:36.035077 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-09 17:19:36.042198 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 12.6 MB/s eta 0:00:00 2025-11-09 17:19:36.084843 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-09 17:19:36.098970 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-09 17:19:36.139449 | debian-bookworm | Collecting pluggy>=1.6 2025-11-09 17:19:36.150349 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-09 17:19:36.184331 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-09 17:19:36.195896 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-09 17:19:36.311604 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-09 17:19:36.323395 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-09 17:19:36.593482 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 22.6 MB/s eta 0:00:00 2025-11-09 17:19:36.684800 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-09 17:19:36.697631 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-09 17:19:36.720425 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 22.3 MB/s eta 0:00:00 2025-11-09 17:19:36.829899 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-09 17:19:37.440007 | debian-bookworm | Successfully installed cachetools-6.2.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.0 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-11-09 17:19:37.913206 | debian-bookworm | ok: Runtime: 0:00:02.369135 2025-11-09 17:19:37.918787 | 2025-11-09 17:19:37.918919 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-09 17:19:37.948055 | debian-bookworm | ok 2025-11-09 17:19:37.952574 | 2025-11-09 17:19:37.952656 | TASK [ensure-tox : Output tox version] 2025-11-09 17:19:38.393615 | 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-11-09 17:19:38.407955 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-09 17:19:38.478126 | debian-bookworm | ok: Runtime: 0:00:00.241010 2025-11-09 17:19:38.483400 | 2025-11-09 17:19:38.483482 | TASK [ensure-tox : Make global symlink] 2025-11-09 17:19:38.539563 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:19:38.545732 | 2025-11-09 17:19:38.545825 | PLAY RECAP 2025-11-09 17:19:38.545883 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-09 17:19:38.545908 | 2025-11-09 17:19:38.702723 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-09 17:19:38.703879 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-09 17:19:39.541010 | 2025-11-09 17:19:39.541133 | PLAY [all] 2025-11-09 17:19:39.555420 | 2025-11-09 17:19:39.555520 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-09 17:19:40.119583 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-09 17:19:40.604079 | debian-bookworm | ok: Runtime: 0:00:00.021022 2025-11-09 17:19:40.609433 | 2025-11-09 17:19:40.609543 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-09 17:19:41.145681 | debian-bookworm | ok: Runtime: 0:00:00.003194 2025-11-09 17:19:41.151358 | 2025-11-09 17:19:41.151459 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-09 17:19:41.405795 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-09 17:19:41.407178 | debian-bookworm | sudo: a password is required 2025-11-09 17:19:41.687779 | debian-bookworm | ok: Runtime: 0:00:00.016077 2025-11-09 17:19:41.695773 | 2025-11-09 17:19:41.695872 | TASK [tox : Check to see if the constraints file exists] 2025-11-09 17:19:41.769235 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:19:41.775621 | 2025-11-09 17:19:41.775713 | TASK [tox : Fail if constraints file is missing] 2025-11-09 17:19:41.828729 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:19:41.834265 | 2025-11-09 17:19:41.834364 | TASK [tox : Record file location] 2025-11-09 17:19:41.878874 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:19:41.886065 | 2025-11-09 17:19:41.886330 | TASK [tox : Install tox siblings] 2025-11-09 17:19:41.930602 | debian-bookworm | ok 2025-11-09 17:19:41.939695 | debian-bookworm | included: /var/lib/zuul/builds/1b8c6fdd58564cbd8eb42166bacd0814/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-09 17:19:41.954779 | 2025-11-09 17:19:41.955076 | TASK [tox : Run tox without tests] 2025-11-09 17:19:43.005437 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-09 17:19:56.257719 | debian-bookworm | test: OK (13.70 seconds) 2025-11-09 17:19:56.257815 | debian-bookworm | congratulations :) (13.72 seconds) 2025-11-09 17:19:56.501536 | debian-bookworm | ok: Runtime: 0:00:13.975575 2025-11-09 17:19:56.514730 | 2025-11-09 17:19:56.514939 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-09 17:19:56.921186 | debian-bookworm | changed 2025-11-09 17:19:56.930073 | 2025-11-09 17:19:56.930218 | TASK [tox : Get tox envlist config] 2025-11-09 17:19:57.975524 | debian-bookworm | ok: Runtime: 0:00:00.336149 2025-11-09 17:19:57.989791 | 2025-11-09 17:19:57.989987 | TASK [tox : Install any sibling python packages] 2025-11-09 17:19:58.433587 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-09 17:19:58.443300 | 2025-11-09 17:19:58.443436 | TASK [tox : Remove tempfile] 2025-11-09 17:19:58.865747 | debian-bookworm | changed 2025-11-09 17:19:58.874233 | 2025-11-09 17:19:58.874362 | TASK [tox : Emit tox command] 2025-11-09 17:19:58.920620 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-09 17:19:58.928234 | 2025-11-09 17:19:58.928371 | TASK [tox : Run tox] 2025-11-09 17:19:59.535405 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-09 17:20:00.140715 | debian-bookworm | ............... 2025-11-09 17:20:00.140760 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-09 17:20:00.140776 | debian-bookworm | Ran 15 tests in 0.164s 2025-11-09 17:20:00.140781 | debian-bookworm | 2025-11-09 17:20:00.140789 | debian-bookworm | OK 2025-11-09 17:20:00.228396 | debian-bookworm | test: OK (0.73=setup[0.04]+cmd[0.69] seconds) 2025-11-09 17:20:00.228519 | debian-bookworm | congratulations :) (0.76 seconds) 2025-11-09 17:20:00.491990 | debian-bookworm | ok: Runtime: 0:00:01.033605 2025-11-09 17:20:00.499419 | 2025-11-09 17:20:00.499550 | TASK [tox : Look for output] 2025-11-09 17:20:00.893571 | debian-bookworm | ok 2025-11-09 17:20:00.909992 | 2025-11-09 17:20:00.910110 | TASK [tox : Return file comments to Zuul] 2025-11-09 17:20:00.954740 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:00.962779 | 2025-11-09 17:20:00.962903 | PLAY RECAP 2025-11-09 17:20:00.962972 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-09 17:20:00.963002 | 2025-11-09 17:20:01.090337 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-09 17:20:01.091537 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-09 17:20:01.851664 | 2025-11-09 17:20:01.851852 | PLAY [all] 2025-11-09 17:20:01.867444 | 2025-11-09 17:20:01.867574 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-09 17:20:01.923308 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:01.936277 | 2025-11-09 17:20:01.936518 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-09 17:20:01.994931 | debian-bookworm | ok 2025-11-09 17:20:02.002676 | 2025-11-09 17:20:02.002823 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-09 17:20:02.533023 | debian-bookworm -> localhost | changed 2025-11-09 17:20:02.543012 | 2025-11-09 17:20:02.543135 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-09 17:20:02.597898 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:02.612720 | 2025-11-09 17:20:02.612908 | TASK [fetch-tox-output : Set envlist fact] 2025-11-09 17:20:02.654039 | debian-bookworm | ok 2025-11-09 17:20:02.662225 | 2025-11-09 17:20:02.662346 | TASK [fetch-tox-output : Get tox version] 2025-11-09 17:20:03.306010 | 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-11-09 17:20:03.323930 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-09 17:20:03.695495 | debian-bookworm | ok: Runtime: 0:00:00.275028 2025-11-09 17:20:03.708247 | 2025-11-09 17:20:03.708414 | TASK [fetch-tox-output : Find all default environments] 2025-11-09 17:20:04.242106 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:04.264167 | 2025-11-09 17:20:04.264610 | TASK [fetch-tox-output : Set envlist fact] 2025-11-09 17:20:04.322538 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:04.331524 | 2025-11-09 17:20:04.331646 | TASK [fetch-tox-output : Find all default environments] 2025-11-09 17:20:04.867578 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:04.881250 | 2025-11-09 17:20:04.881427 | TASK [fetch-tox-output : Set envlist fact] 2025-11-09 17:20:04.916903 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:04.931002 | 2025-11-09 17:20:04.931188 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-09 17:20:04.984838 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:04.999429 | 2025-11-09 17:20:04.999585 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-09 17:20:05.789883 | debian-bookworm | changed: 2025-11-09 17:20:05.790109 | debian-bookworm | created directory /var/lib/zuul/builds/1b8c6fdd58564cbd8eb42166bacd0814/work/logs/tox/test 2025-11-09 17:20:05.790152 | debian-bookworm | cd+++++++++ ./ 2025-11-09 17:20:05.790185 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-09 17:20:05.790225 | 2025-11-09 17:20:05.810505 | 2025-11-09 17:20:05.810617 | PLAY RECAP 2025-11-09 17:20:05.810687 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-09 17:20:05.810720 | 2025-11-09 17:20:05.937771 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-09 17:20:05.940252 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-09 17:20:06.691401 | 2025-11-09 17:20:06.691571 | PLAY [all] 2025-11-09 17:20:06.707617 | 2025-11-09 17:20:06.707761 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-09 17:20:06.927570 | debian-bookworm | changed: non-zero return code 2025-11-09 17:20:06.936349 | 2025-11-09 17:20:06.936517 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-09 17:20:06.961854 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:06.972243 | 2025-11-09 17:20:06.972407 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-09 17:20:07.004176 | 2025-11-09 17:20:07.004393 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-09 17:20:07.057326 | 2025-11-09 17:20:07.057535 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-09 17:20:07.081908 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:07.091281 | 2025-11-09 17:20:07.091413 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-09 17:20:07.122544 | 2025-11-09 17:20:07.122788 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-09 17:20:07.138887 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:07.147939 | 2025-11-09 17:20:07.148117 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-09 17:20:07.163573 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:07.170585 | 2025-11-09 17:20:07.170709 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-09 17:20:07.186377 | debian-bookworm | skipping: Conditional result was False 2025-11-09 17:20:07.194066 | 2025-11-09 17:20:07.194153 | PLAY RECAP 2025-11-09 17:20:07.194211 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-09 17:20:07.194237 | 2025-11-09 17:20:07.319784 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-09 17:20:07.322576 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-09 17:20:08.062396 | 2025-11-09 17:20:08.062591 | PLAY [Base post] 2025-11-09 17:20:08.076512 | 2025-11-09 17:20:08.076657 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-09 17:20:08.654027 | debian-bookworm | changed 2025-11-09 17:20:08.677631 | 2025-11-09 17:20:08.677787 | PLAY RECAP 2025-11-09 17:20:08.677915 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-09 17:20:08.678007 | 2025-11-09 17:20:08.860021 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-09 17:20:08.862224 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-09 17:20:09.694705 | 2025-11-09 17:20:09.694931 | PLAY [Base post-logs] 2025-11-09 17:20:09.705159 | 2025-11-09 17:20:09.705290 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-09 17:20:10.146338 | localhost | changed 2025-11-09 17:20:10.157725 | 2025-11-09 17:20:10.157920 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-09 17:20:10.184009 | localhost | ok 2025-11-09 17:20:10.187065 | 2025-11-09 17:20:10.187172 | TASK [Set zuul-log-path fact] 2025-11-09 17:20:10.212445 | localhost | ok 2025-11-09 17:20:10.223541 | 2025-11-09 17:20:10.223661 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-09 17:20:10.259095 | localhost | ok 2025-11-09 17:20:10.262192 | 2025-11-09 17:20:10.262298 | TASK [upload-logs : Create log directories] 2025-11-09 17:20:10.816750 | localhost | changed 2025-11-09 17:20:10.821023 | 2025-11-09 17:20:10.821140 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-09 17:20:11.317233 | localhost -> localhost | ok: Runtime: 0:00:00.011837 2025-11-09 17:20:11.323366 | 2025-11-09 17:20:11.323526 | TASK [upload-logs : Upload logs to log server] 2025-11-09 17:20:12.100650 | localhost | Output suppressed because no_log was given 2025-11-09 17:20:12.103446 | 2025-11-09 17:20:12.103568 | LOOP [upload-logs : Compress console log and json output] 2025-11-09 17:20:12.156902 | localhost | skipping: Conditional result was False 2025-11-09 17:20:12.164957 | localhost | skipping: Conditional result was False 2025-11-09 17:20:12.171892 | 2025-11-09 17:20:12.172004 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-09 17:20:12.223150 | localhost | skipping: Conditional result was False 2025-11-09 17:20:12.223449 | 2025-11-09 17:20:12.230124 | localhost | skipping: Conditional result was False 2025-11-09 17:20:12.239861 | 2025-11-09 17:20:12.240661 | LOOP [upload-logs : Upload console log and json output]