2025-11-02 00:18:30.069132 | Job console starting 2025-11-02 00:18:30.093813 | Updating git repos 2025-11-02 00:18:30.143635 | Cloning repos into workspace 2025-11-02 00:18:30.252875 | Restoring repo states 2025-11-02 00:18:30.265906 | Merging changes 2025-11-02 00:18:30.762568 | Checking out repos 2025-11-02 00:18:30.826550 | Preparing playbooks 2025-11-02 00:18:31.695777 | Running Ansible setup 2025-11-02 00:18:37.477424 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-02 00:18:39.699130 | 2025-11-02 00:18:39.699256 | PLAY [Base pre] 2025-11-02 00:18:39.739438 | 2025-11-02 00:18:39.739549 | TASK [Setup log path fact] 2025-11-02 00:18:39.777443 | debian-bookworm | ok 2025-11-02 00:18:39.791392 | 2025-11-02 00:18:39.791504 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-02 00:18:39.819544 | debian-bookworm | ok 2025-11-02 00:18:39.832156 | 2025-11-02 00:18:39.832254 | TASK [emit-job-header : Print job information] 2025-11-02 00:18:39.868841 | # Job Information 2025-11-02 00:18:39.868972 | Ansible Version: 2.16.14 2025-11-02 00:18:39.869000 | Job: tox 2025-11-02 00:18:39.869027 | Pipeline: check 2025-11-02 00:18:39.869045 | Executor: 521e9411259a 2025-11-02 00:18:39.869062 | Triggered by: https://github.com/osism/openstack-image-manager/pull/981 2025-11-02 00:18:39.869080 | Event ID: 6fe99a90-b781-11f0-8a2a-028557c5efb2 2025-11-02 00:18:39.872893 | 2025-11-02 00:18:39.872969 | LOOP [emit-job-header : Print node information] 2025-11-02 00:18:40.098659 | debian-bookworm | ok: 2025-11-02 00:18:40.098828 | debian-bookworm | # Node Information 2025-11-02 00:18:40.098994 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-02 00:18:40.099023 | debian-bookworm | Hostname: debian 2025-11-02 00:18:40.099047 | debian-bookworm | Username: zuul 2025-11-02 00:18:40.099069 | debian-bookworm | Distro: Debian 12.12 2025-11-02 00:18:40.099093 | debian-bookworm | Provider: regiocloud-a 2025-11-02 00:18:40.099115 | debian-bookworm | Region: 2025-11-02 00:18:40.099137 | debian-bookworm | Label: debian-bookworm 2025-11-02 00:18:40.099157 | debian-bookworm | Product Name: OpenStack Nova 2025-11-02 00:18:40.099197 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe79:7a8a 2025-11-02 00:18:40.107935 | 2025-11-02 00:18:40.108017 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-02 00:18:41.028010 | debian-bookworm -> localhost | changed 2025-11-02 00:18:41.034042 | 2025-11-02 00:18:41.034131 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-02 00:18:42.432860 | debian-bookworm -> localhost | changed 2025-11-02 00:18:42.441233 | 2025-11-02 00:18:42.441314 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-02 00:18:42.750299 | debian-bookworm -> localhost | ok 2025-11-02 00:18:42.758903 | 2025-11-02 00:18:42.758993 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-02 00:18:42.787982 | debian-bookworm | ok 2025-11-02 00:18:42.812736 | debian-bookworm | included: /var/lib/zuul/builds/808726b2107e4f718040d0f7146b3b18/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-02 00:18:42.820880 | 2025-11-02 00:18:42.820965 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-02 00:18:44.349037 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-02 00:18:44.349254 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/808726b2107e4f718040d0f7146b3b18/work/808726b2107e4f718040d0f7146b3b18_id_rsa 2025-11-02 00:18:44.349291 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/808726b2107e4f718040d0f7146b3b18/work/808726b2107e4f718040d0f7146b3b18_id_rsa.pub 2025-11-02 00:18:44.349313 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-02 00:18:44.349335 | debian-bookworm -> localhost | SHA256:uKHXmd1WY1ntRWPigaLai5xgSBTyOSKqUi26d8sSfbQ zuul-build-sshkey 2025-11-02 00:18:44.349354 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-02 00:18:44.349379 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-02 00:18:44.349397 | debian-bookworm -> localhost | |... .o o.| 2025-11-02 00:18:44.349415 | debian-bookworm -> localhost | |.o . . .. +.o| 2025-11-02 00:18:44.349433 | debian-bookworm -> localhost | |+ + . . . +| 2025-11-02 00:18:44.349449 | debian-bookworm -> localhost | |oo o .o +.| 2025-11-02 00:18:44.349465 | debian-bookworm -> localhost | |o +...=.S = .| 2025-11-02 00:18:44.349484 | debian-bookworm -> localhost | |.+.+.oE= + . o . | 2025-11-02 00:18:44.349501 | debian-bookworm -> localhost | |+ ..+.= = . o | 2025-11-02 00:18:44.349518 | debian-bookworm -> localhost | |..o..= . . | 2025-11-02 00:18:44.349536 | debian-bookworm -> localhost | |.. oo. | 2025-11-02 00:18:44.349552 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-02 00:18:44.349595 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.884023 2025-11-02 00:18:44.354761 | 2025-11-02 00:18:44.354877 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-02 00:18:44.371356 | debian-bookworm | ok 2025-11-02 00:18:44.378480 | debian-bookworm | included: /var/lib/zuul/builds/808726b2107e4f718040d0f7146b3b18/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-02 00:18:44.385385 | 2025-11-02 00:18:44.385448 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-02 00:18:44.397802 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:18:44.402190 | 2025-11-02 00:18:44.402257 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-02 00:18:45.013243 | debian-bookworm | changed 2025-11-02 00:18:45.021437 | 2025-11-02 00:18:45.021549 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-02 00:18:45.281362 | debian-bookworm | ok 2025-11-02 00:18:45.288478 | 2025-11-02 00:18:45.288568 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-02 00:18:45.940306 | debian-bookworm | changed 2025-11-02 00:18:45.951330 | 2025-11-02 00:18:45.951437 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-02 00:18:46.574904 | debian-bookworm | changed 2025-11-02 00:18:46.580971 | 2025-11-02 00:18:46.581064 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-02 00:18:46.625184 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:18:46.632460 | 2025-11-02 00:18:46.632552 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-02 00:18:47.627075 | debian-bookworm -> localhost | changed 2025-11-02 00:18:47.638390 | 2025-11-02 00:18:47.638502 | TASK [add-build-sshkey : Add back temp key] 2025-11-02 00:18:48.342061 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/808726b2107e4f718040d0f7146b3b18/work/808726b2107e4f718040d0f7146b3b18_id_rsa (zuul-build-sshkey) 2025-11-02 00:18:48.342300 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032438 2025-11-02 00:18:48.351700 | 2025-11-02 00:18:48.351813 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-02 00:18:48.794434 | debian-bookworm | ok 2025-11-02 00:18:48.811478 | 2025-11-02 00:18:48.811577 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-02 00:18:48.848826 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:18:48.860197 | 2025-11-02 00:18:48.860286 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-02 00:18:49.363450 | debian-bookworm | ok 2025-11-02 00:18:49.376721 | 2025-11-02 00:18:49.376814 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-02 00:18:49.434408 | debian-bookworm | ok 2025-11-02 00:18:49.438468 | 2025-11-02 00:18:49.438537 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-02 00:18:49.895407 | debian-bookworm -> localhost | ok 2025-11-02 00:18:49.905952 | 2025-11-02 00:18:49.906041 | TASK [validate-host : Collect information about the host] 2025-11-02 00:18:50.996587 | debian-bookworm | ok 2025-11-02 00:18:51.008603 | 2025-11-02 00:18:51.008712 | TASK [validate-host : Sanitize hostname] 2025-11-02 00:18:51.135780 | debian-bookworm | ok 2025-11-02 00:18:51.216773 | 2025-11-02 00:18:51.216900 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-02 00:18:51.844016 | debian-bookworm -> localhost | changed 2025-11-02 00:18:51.859987 | 2025-11-02 00:18:51.860396 | TASK [validate-host : Collect information about zuul worker] 2025-11-02 00:18:52.342559 | debian-bookworm | ok 2025-11-02 00:18:52.353394 | 2025-11-02 00:18:52.353497 | TASK [validate-host : Write out all zuul information for each host] 2025-11-02 00:18:53.009587 | debian-bookworm -> localhost | changed 2025-11-02 00:18:53.019948 | 2025-11-02 00:18:53.020037 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-02 00:18:53.290966 | debian-bookworm | ok 2025-11-02 00:18:53.298488 | 2025-11-02 00:18:53.298601 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-02 00:18:54.188117 | debian-bookworm | changed: 2025-11-02 00:18:54.188275 | debian-bookworm | cd+++++++++ src/ 2025-11-02 00:18:54.188305 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-02 00:18:54.188325 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-02 00:18:54.188344 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-02 00:18:54.188361 | debian-bookworm | =6.2 2025-11-02 00:19:16.916842 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-11-02 00:19:16.972028 | debian-bookworm | Collecting chardet>=5.2 2025-11-02 00:19:16.985268 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-02 00:19:17.006049 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.1 MB/s eta 0:00:00 2025-11-02 00:19:17.061655 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-02 00:19:17.073964 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-02 00:19:17.135711 | debian-bookworm | Collecting filelock>=3.20 2025-11-02 00:19:17.147757 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-02 00:19:17.214437 | debian-bookworm | Collecting packaging>=25 2025-11-02 00:19:17.226249 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-02 00:19:17.239856 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 6.5 MB/s eta 0:00:00 2025-11-02 00:19:17.303337 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-02 00:19:17.315389 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-02 00:19:17.366493 | debian-bookworm | Collecting pluggy>=1.6 2025-11-02 00:19:17.378411 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-02 00:19:17.421383 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-02 00:19:17.434462 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-02 00:19:17.600991 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-02 00:19:17.614728 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-02 00:19:17.888258 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 22.4 MB/s eta 0:00:00 2025-11-02 00:19:18.009857 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-02 00:19:18.029815 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-02 00:19:18.052462 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 23.9 MB/s eta 0:00:00 2025-11-02 00:19:18.210325 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-02 00:19:19.060507 | 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-02 00:19:19.688809 | debian-bookworm | ok: Runtime: 0:00:03.230578 2025-11-02 00:19:19.695360 | 2025-11-02 00:19:19.695481 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-02 00:19:19.750667 | debian-bookworm | ok 2025-11-02 00:19:19.758085 | 2025-11-02 00:19:19.758426 | TASK [ensure-tox : Output tox version] 2025-11-02 00:19:20.322057 | 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-02 00:19:20.341330 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-02 00:19:20.799041 | debian-bookworm | ok: Runtime: 0:00:00.296521 2025-11-02 00:19:20.805036 | 2025-11-02 00:19:20.805138 | TASK [ensure-tox : Make global symlink] 2025-11-02 00:19:20.834532 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:20.846910 | 2025-11-02 00:19:20.847031 | PLAY RECAP 2025-11-02 00:19:20.847093 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-02 00:19:20.847120 | 2025-11-02 00:19:21.012902 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-02 00:19:21.014323 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-02 00:19:22.001622 | 2025-11-02 00:19:22.001797 | PLAY [all] 2025-11-02 00:19:22.020110 | 2025-11-02 00:19:22.020260 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-02 00:19:22.513496 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-02 00:19:22.568158 | debian-bookworm | ok: Runtime: 0:00:00.031016 2025-11-02 00:19:22.573781 | 2025-11-02 00:19:22.573929 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-02 00:19:23.106494 | debian-bookworm | ok: Runtime: 0:00:00.004908 2025-11-02 00:19:23.117821 | 2025-11-02 00:19:23.118040 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-02 00:19:23.438687 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-02 00:19:23.441547 | debian-bookworm | sudo: a password is required 2025-11-02 00:19:23.650346 | debian-bookworm | ok: Runtime: 0:00:00.023075 2025-11-02 00:19:23.683013 | 2025-11-02 00:19:23.683202 | TASK [tox : Check to see if the constraints file exists] 2025-11-02 00:19:23.710375 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:23.723359 | 2025-11-02 00:19:23.723518 | TASK [tox : Fail if constraints file is missing] 2025-11-02 00:19:23.758511 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:23.769817 | 2025-11-02 00:19:23.770031 | TASK [tox : Record file location] 2025-11-02 00:19:23.794916 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:23.809145 | 2025-11-02 00:19:23.809313 | TASK [tox : Install tox siblings] 2025-11-02 00:19:23.836502 | debian-bookworm | ok 2025-11-02 00:19:23.847343 | debian-bookworm | included: /var/lib/zuul/builds/808726b2107e4f718040d0f7146b3b18/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-02 00:19:23.853304 | 2025-11-02 00:19:23.853409 | TASK [tox : Run tox without tests] 2025-11-02 00:19:24.966002 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-02 00:19:40.326900 | debian-bookworm | test: OK (15.91 seconds) 2025-11-02 00:19:40.326952 | debian-bookworm | congratulations :) (15.94 seconds) 2025-11-02 00:19:40.893174 | debian-bookworm | ok: Runtime: 0:00:16.236199 2025-11-02 00:19:40.899206 | 2025-11-02 00:19:40.899326 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-02 00:19:41.377291 | debian-bookworm | changed 2025-11-02 00:19:41.384548 | 2025-11-02 00:19:41.384661 | TASK [tox : Get tox envlist config] 2025-11-02 00:19:42.426265 | debian-bookworm | ok: Runtime: 0:00:00.362598 2025-11-02 00:19:42.438079 | 2025-11-02 00:19:42.438243 | TASK [tox : Install any sibling python packages] 2025-11-02 00:19:42.932421 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-02 00:19:42.939776 | 2025-11-02 00:19:42.943074 | TASK [tox : Remove tempfile] 2025-11-02 00:19:43.388965 | debian-bookworm | changed 2025-11-02 00:19:43.395362 | 2025-11-02 00:19:43.395489 | TASK [tox : Emit tox command] 2025-11-02 00:19:43.435082 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-02 00:19:43.440095 | 2025-11-02 00:19:43.440207 | TASK [tox : Run tox] 2025-11-02 00:19:44.098917 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-02 00:19:44.786541 | debian-bookworm | ............... 2025-11-02 00:19:44.786625 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-02 00:19:44.786642 | debian-bookworm | Ran 15 tests in 0.177s 2025-11-02 00:19:44.786647 | debian-bookworm | 2025-11-02 00:19:44.786654 | debian-bookworm | OK 2025-11-02 00:19:44.894530 | debian-bookworm | test: OK (0.84=setup[0.05]+cmd[0.79] seconds) 2025-11-02 00:19:44.894608 | debian-bookworm | congratulations :) (0.87 seconds) 2025-11-02 00:19:45.011833 | debian-bookworm | ok: Runtime: 0:00:01.173139 2025-11-02 00:19:45.018725 | 2025-11-02 00:19:45.018889 | TASK [tox : Look for output] 2025-11-02 00:19:45.430806 | debian-bookworm | ok 2025-11-02 00:19:45.451761 | 2025-11-02 00:19:45.451930 | TASK [tox : Return file comments to Zuul] 2025-11-02 00:19:45.495363 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:45.504678 | 2025-11-02 00:19:45.504826 | PLAY RECAP 2025-11-02 00:19:45.504926 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-02 00:19:45.505013 | 2025-11-02 00:19:45.659004 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-02 00:19:45.660137 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-02 00:19:47.374276 | 2025-11-02 00:19:47.374469 | PLAY [all] 2025-11-02 00:19:47.411627 | 2025-11-02 00:19:47.411773 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-02 00:19:47.487553 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:47.494058 | 2025-11-02 00:19:47.494207 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-02 00:19:47.533303 | debian-bookworm | ok 2025-11-02 00:19:47.538616 | 2025-11-02 00:19:47.538724 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-02 00:19:48.036436 | debian-bookworm -> localhost | changed 2025-11-02 00:19:48.048757 | 2025-11-02 00:19:48.048882 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-02 00:19:48.092426 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:48.097684 | 2025-11-02 00:19:48.097774 | TASK [fetch-tox-output : Set envlist fact] 2025-11-02 00:19:48.125134 | debian-bookworm | ok 2025-11-02 00:19:48.130353 | 2025-11-02 00:19:48.130435 | TASK [fetch-tox-output : Get tox version] 2025-11-02 00:19:48.824078 | 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-02 00:19:48.842690 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-02 00:19:49.157258 | debian-bookworm | ok: Runtime: 0:00:00.314022 2025-11-02 00:19:49.162789 | 2025-11-02 00:19:49.163014 | TASK [fetch-tox-output : Find all default environments] 2025-11-02 00:19:49.711563 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:49.717459 | 2025-11-02 00:19:49.717560 | TASK [fetch-tox-output : Set envlist fact] 2025-11-02 00:19:49.771541 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:49.777365 | 2025-11-02 00:19:49.777461 | TASK [fetch-tox-output : Find all default environments] 2025-11-02 00:19:50.353627 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:50.360137 | 2025-11-02 00:19:50.360241 | TASK [fetch-tox-output : Set envlist fact] 2025-11-02 00:19:50.393673 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:50.400961 | 2025-11-02 00:19:50.401060 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-02 00:19:50.487452 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:50.502101 | 2025-11-02 00:19:50.502227 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-02 00:19:51.711105 | debian-bookworm | changed: 2025-11-02 00:19:51.711262 | debian-bookworm | created directory /var/lib/zuul/builds/808726b2107e4f718040d0f7146b3b18/work/logs/tox/test 2025-11-02 00:19:51.711296 | debian-bookworm | cd+++++++++ ./ 2025-11-02 00:19:51.711320 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-02 00:19:51.711349 | 2025-11-02 00:19:51.732346 | 2025-11-02 00:19:51.732452 | PLAY RECAP 2025-11-02 00:19:51.732508 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-02 00:19:51.732533 | 2025-11-02 00:19:51.967737 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-02 00:19:51.969091 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-02 00:19:53.058312 | 2025-11-02 00:19:53.058426 | PLAY [all] 2025-11-02 00:19:53.072377 | 2025-11-02 00:19:53.072478 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-02 00:19:53.387567 | debian-bookworm | changed: non-zero return code 2025-11-02 00:19:53.404173 | 2025-11-02 00:19:53.404290 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-02 00:19:53.459228 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:53.464165 | 2025-11-02 00:19:53.464256 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-02 00:19:53.492984 | 2025-11-02 00:19:53.493132 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-02 00:19:53.552710 | 2025-11-02 00:19:53.552954 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-02 00:19:53.592088 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:53.596785 | 2025-11-02 00:19:53.596880 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-02 00:19:53.634207 | 2025-11-02 00:19:53.634351 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-02 00:19:53.667217 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:53.671732 | 2025-11-02 00:19:53.671812 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-02 00:19:53.704614 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:53.709199 | 2025-11-02 00:19:53.709279 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-02 00:19:53.742202 | debian-bookworm | skipping: Conditional result was False 2025-11-02 00:19:53.748041 | 2025-11-02 00:19:53.748102 | PLAY RECAP 2025-11-02 00:19:53.748141 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-02 00:19:53.748163 | 2025-11-02 00:19:53.929753 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-02 00:19:53.930584 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-02 00:19:55.543680 | 2025-11-02 00:19:55.543818 | PLAY [Base post] 2025-11-02 00:19:55.582364 | 2025-11-02 00:19:55.582534 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-02 00:19:56.494934 | debian-bookworm | changed 2025-11-02 00:19:56.504441 | 2025-11-02 00:19:56.504523 | PLAY RECAP 2025-11-02 00:19:56.504573 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-02 00:19:56.504626 | 2025-11-02 00:19:56.751915 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-02 00:19:56.753549 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-02 00:19:58.215544 | 2025-11-02 00:19:58.215657 | PLAY [Base post-logs] 2025-11-02 00:19:58.252936 | 2025-11-02 00:19:58.253047 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-02 00:19:59.201821 | localhost | changed 2025-11-02 00:19:59.210563 | 2025-11-02 00:19:59.210680 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-02 00:19:59.278450 | localhost | ok 2025-11-02 00:19:59.281468 | 2025-11-02 00:19:59.281540 | TASK [Set zuul-log-path fact] 2025-11-02 00:19:59.306437 | localhost | ok 2025-11-02 00:19:59.313376 | 2025-11-02 00:19:59.313495 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-02 00:19:59.361196 | localhost | ok 2025-11-02 00:19:59.364377 | 2025-11-02 00:19:59.364455 | TASK [upload-logs : Create log directories] 2025-11-02 00:20:00.885038 | localhost | changed 2025-11-02 00:20:00.887231 | 2025-11-02 00:20:00.887307 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-02 00:20:02.081665 | localhost -> localhost | ok: Runtime: 0:00:00.010659 2025-11-02 00:20:02.084664 | 2025-11-02 00:20:02.084742 | TASK [upload-logs : Upload logs to log server] 2025-11-02 00:20:02.829462 | localhost | Output suppressed because no_log was given 2025-11-02 00:20:02.830789 | 2025-11-02 00:20:02.831163 | LOOP [upload-logs : Compress console log and json output] 2025-11-02 00:20:02.922314 | localhost | skipping: Conditional result was False 2025-11-02 00:20:02.940771 | localhost | skipping: Conditional result was False 2025-11-02 00:20:02.947000 | 2025-11-02 00:20:02.947102 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-02 00:20:03.025378 | localhost | skipping: Conditional result was False 2025-11-02 00:20:03.025603 | 2025-11-02 00:20:03.032785 | localhost | skipping: Conditional result was False 2025-11-02 00:20:03.040958 | 2025-11-02 00:20:03.041038 | LOOP [upload-logs : Upload console log and json output]