2025-12-20 03:02:54.369445 | Job console starting 2025-12-20 03:02:54.380750 | Updating git repos 2025-12-20 03:02:54.429638 | Cloning repos into workspace 2025-12-20 03:02:54.519597 | Restoring repo states 2025-12-20 03:02:54.557072 | Merging changes 2025-12-20 03:02:54.557095 | Checking out repos 2025-12-20 03:02:54.757926 | Preparing playbooks 2025-12-20 03:02:56.476515 | Running Ansible setup 2025-12-20 03:03:03.266565 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-20 03:03:04.702964 | 2025-12-20 03:03:04.703138 | PLAY [Base pre] 2025-12-20 03:03:04.723627 | 2025-12-20 03:03:04.723792 | TASK [Setup log path fact] 2025-12-20 03:03:04.778761 | debian-bookworm | ok 2025-12-20 03:03:04.797116 | 2025-12-20 03:03:04.797286 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-20 03:03:04.835836 | debian-bookworm | ok 2025-12-20 03:03:04.850387 | 2025-12-20 03:03:04.850560 | TASK [emit-job-header : Print job information] 2025-12-20 03:03:04.935382 | # Job Information 2025-12-20 03:03:04.935753 | Ansible Version: 2.16.14 2025-12-20 03:03:04.935803 | Job: tox 2025-12-20 03:03:04.935843 | Pipeline: periodic-daily 2025-12-20 03:03:04.935886 | Executor: 521e9411259a 2025-12-20 03:03:04.935911 | Triggered by: https://github.com/osism/openstack-image-manager 2025-12-20 03:03:04.935947 | Event ID: a86f8346546c4fa48cb1a47d89e26d1d 2025-12-20 03:03:04.941947 | 2025-12-20 03:03:04.942107 | LOOP [emit-job-header : Print node information] 2025-12-20 03:03:05.220188 | debian-bookworm | ok: 2025-12-20 03:03:05.220551 | debian-bookworm | # Node Information 2025-12-20 03:03:05.220600 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-20 03:03:05.220627 | debian-bookworm | Hostname: debian 2025-12-20 03:03:05.220649 | debian-bookworm | Username: zuul 2025-12-20 03:03:05.220670 | debian-bookworm | Distro: Debian 12.12 2025-12-20 03:03:05.220694 | debian-bookworm | Provider: regiocloud-a 2025-12-20 03:03:05.220715 | debian-bookworm | Region: 2025-12-20 03:03:05.220737 | debian-bookworm | Label: debian-bookworm 2025-12-20 03:03:05.220756 | debian-bookworm | Product Name: OpenStack Nova 2025-12-20 03:03:05.220776 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9d:b833 2025-12-20 03:03:05.250046 | 2025-12-20 03:03:05.250205 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-20 03:03:07.134427 | debian-bookworm -> localhost | changed 2025-12-20 03:03:07.143757 | 2025-12-20 03:03:07.143897 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-20 03:03:10.008965 | debian-bookworm -> localhost | changed 2025-12-20 03:03:10.024889 | 2025-12-20 03:03:10.025036 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-20 03:03:10.666919 | debian-bookworm -> localhost | ok 2025-12-20 03:03:10.674242 | 2025-12-20 03:03:10.674385 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-20 03:03:10.759619 | debian-bookworm | ok 2025-12-20 03:03:10.844233 | debian-bookworm | included: /var/lib/zuul/builds/7d66c005b75f49e0b39e592c19d49c80/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-20 03:03:10.879172 | 2025-12-20 03:03:10.879338 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-20 03:03:14.491649 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-20 03:03:14.493137 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7d66c005b75f49e0b39e592c19d49c80/work/7d66c005b75f49e0b39e592c19d49c80_id_rsa 2025-12-20 03:03:14.493242 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7d66c005b75f49e0b39e592c19d49c80/work/7d66c005b75f49e0b39e592c19d49c80_id_rsa.pub 2025-12-20 03:03:14.493274 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-20 03:03:14.493856 | debian-bookworm -> localhost | SHA256:CgKy964VC5l7A2bE95HPlrCjglNFYZSFWTARvHjurrI zuul-build-sshkey 2025-12-20 03:03:14.493905 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-20 03:03:14.493944 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-20 03:03:14.493969 | debian-bookworm -> localhost | | oX@o | 2025-12-20 03:03:14.494673 | debian-bookworm -> localhost | | . o=. . | 2025-12-20 03:03:14.494722 | debian-bookworm -> localhost | |o o.o.+ | 2025-12-20 03:03:14.494748 | debian-bookworm -> localhost | |.+.=o. * . | 2025-12-20 03:03:14.497442 | debian-bookworm -> localhost | |. @oo + S | 2025-12-20 03:03:14.497575 | debian-bookworm -> localhost | | * *.= + | 2025-12-20 03:03:14.497610 | debian-bookworm -> localhost | |o o.B . | 2025-12-20 03:03:14.498314 | debian-bookworm -> localhost | |.. =.. | 2025-12-20 03:03:14.498345 | debian-bookworm -> localhost | |Eoo+o | 2025-12-20 03:03:14.498368 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-20 03:03:14.498454 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.817755 2025-12-20 03:03:14.537884 | 2025-12-20 03:03:14.541348 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-20 03:03:14.640243 | debian-bookworm | ok 2025-12-20 03:03:14.723032 | debian-bookworm | included: /var/lib/zuul/builds/7d66c005b75f49e0b39e592c19d49c80/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-20 03:03:14.884040 | 2025-12-20 03:03:14.884214 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-20 03:03:14.979192 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:03:15.049720 | 2025-12-20 03:03:15.051986 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-20 03:03:16.325227 | debian-bookworm | changed 2025-12-20 03:03:16.337642 | 2025-12-20 03:03:16.337780 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-20 03:03:16.758933 | debian-bookworm | ok 2025-12-20 03:03:16.772109 | 2025-12-20 03:03:16.772451 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-20 03:03:17.824020 | debian-bookworm | changed 2025-12-20 03:03:17.864801 | 2025-12-20 03:03:17.864973 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-20 03:03:19.028090 | debian-bookworm | changed 2025-12-20 03:03:19.050726 | 2025-12-20 03:03:19.054818 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-20 03:03:19.126569 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:03:19.158148 | 2025-12-20 03:03:19.158359 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-20 03:03:22.821348 | debian-bookworm -> localhost | changed 2025-12-20 03:03:22.833415 | 2025-12-20 03:03:22.833581 | TASK [add-build-sshkey : Add back temp key] 2025-12-20 03:03:23.969703 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7d66c005b75f49e0b39e592c19d49c80/work/7d66c005b75f49e0b39e592c19d49c80_id_rsa (zuul-build-sshkey) 2025-12-20 03:03:23.969958 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.051986 2025-12-20 03:03:23.978488 | 2025-12-20 03:03:23.978647 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-20 03:03:25.044576 | debian-bookworm | ok 2025-12-20 03:03:25.055571 | 2025-12-20 03:03:25.059823 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-20 03:03:25.153231 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:03:25.174248 | 2025-12-20 03:03:25.175957 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-20 03:03:26.168797 | debian-bookworm | ok 2025-12-20 03:03:26.233268 | 2025-12-20 03:03:26.233428 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-20 03:03:26.349607 | debian-bookworm | ok 2025-12-20 03:03:26.359725 | 2025-12-20 03:03:26.359871 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-20 03:03:27.869154 | debian-bookworm -> localhost | ok 2025-12-20 03:03:27.877748 | 2025-12-20 03:03:27.877888 | TASK [validate-host : Collect information about the host] 2025-12-20 03:03:30.216947 | debian-bookworm | ok 2025-12-20 03:03:30.303286 | 2025-12-20 03:03:30.303445 | TASK [validate-host : Sanitize hostname] 2025-12-20 03:03:30.553142 | debian-bookworm | ok 2025-12-20 03:03:30.752363 | 2025-12-20 03:03:30.752540 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-20 03:03:33.725386 | debian-bookworm -> localhost | changed 2025-12-20 03:03:33.731776 | 2025-12-20 03:03:33.731909 | TASK [validate-host : Collect information about zuul worker] 2025-12-20 03:03:35.109902 | debian-bookworm | ok 2025-12-20 03:03:35.116393 | 2025-12-20 03:03:35.116575 | TASK [validate-host : Write out all zuul information for each host] 2025-12-20 03:03:37.111697 | debian-bookworm -> localhost | changed 2025-12-20 03:03:37.124188 | 2025-12-20 03:03:37.124329 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-20 03:03:37.457860 | debian-bookworm | ok 2025-12-20 03:03:37.477449 | 2025-12-20 03:03:37.477627 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-20 03:03:40.286700 | debian-bookworm | changed: 2025-12-20 03:03:40.289323 | debian-bookworm | cd+++++++++ src/ 2025-12-20 03:03:40.289386 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-20 03:03:40.289413 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-20 03:03:40.289435 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-20 03:03:40.289456 | debian-bookworm | =6.2 2025-12-20 03:04:13.206806 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2025-12-20 03:04:13.260940 | debian-bookworm | Collecting chardet>=5.2 2025-12-20 03:04:13.279757 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-20 03:04:13.294955 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 21.3 MB/s eta 0:00:00 2025-12-20 03:04:13.342731 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-20 03:04:13.359275 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-20 03:04:13.415861 | debian-bookworm | Collecting filelock>=3.20 2025-12-20 03:04:13.430983 | debian-bookworm | Downloading filelock-3.20.1-py3-none-any.whl (16 kB) 2025-12-20 03:04:13.503858 | debian-bookworm | Collecting packaging>=25 2025-12-20 03:04:13.519249 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-20 03:04:13.630727 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 918.6 kB/s eta 0:00:00 2025-12-20 03:04:13.696962 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-20 03:04:13.712332 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-20 03:04:13.769763 | debian-bookworm | Collecting pluggy>=1.6 2025-12-20 03:04:13.785396 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-20 03:04:13.843013 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-20 03:04:13.858963 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-20 03:04:14.005130 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-20 03:04:14.020531 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-20 03:04:14.383055 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 16.8 MB/s eta 0:00:00 2025-12-20 03:04:14.491095 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-20 03:04:14.506268 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-20 03:04:14.540897 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 16.5 MB/s eta 0:00:00 2025-12-20 03:04:14.698844 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-20 03:04:15.519765 | 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-20 03:04:16.055136 | debian-bookworm | ok: Runtime: 0:00:03.339418 2025-12-20 03:04:16.064841 | 2025-12-20 03:04:16.065160 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-20 03:04:16.108828 | debian-bookworm | ok 2025-12-20 03:04:16.114362 | 2025-12-20 03:04:16.114542 | TASK [ensure-tox : Output tox version] 2025-12-20 03:04:16.703500 | 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-20 03:04:16.722441 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-20 03:04:17.158627 | debian-bookworm | ok: Runtime: 0:00:00.309302 2025-12-20 03:04:17.164611 | 2025-12-20 03:04:17.164726 | TASK [ensure-tox : Make global symlink] 2025-12-20 03:04:17.189419 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:17.205073 | 2025-12-20 03:04:17.205225 | PLAY RECAP 2025-12-20 03:04:17.205314 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-20 03:04:17.205358 | 2025-12-20 03:04:17.494215 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-20 03:04:17.495382 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-20 03:04:18.645346 | 2025-12-20 03:04:18.645550 | PLAY [all] 2025-12-20 03:04:18.676293 | 2025-12-20 03:04:18.676467 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-20 03:04:19.191777 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-20 03:04:19.261510 | debian-bookworm | ok: Runtime: 0:00:00.034033 2025-12-20 03:04:19.278428 | 2025-12-20 03:04:19.278639 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-20 03:04:19.817102 | debian-bookworm | ok: Runtime: 0:00:00.006802 2025-12-20 03:04:19.823875 | 2025-12-20 03:04:19.824015 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-20 03:04:20.144419 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-20 03:04:20.146201 | debian-bookworm | sudo: a password is required 2025-12-20 03:04:20.384627 | debian-bookworm | ok: Runtime: 0:00:00.019480 2025-12-20 03:04:20.397587 | 2025-12-20 03:04:20.397717 | TASK [tox : Check to see if the constraints file exists] 2025-12-20 03:04:20.435384 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:20.459080 | 2025-12-20 03:04:20.459268 | TASK [tox : Fail if constraints file is missing] 2025-12-20 03:04:20.495052 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:20.511088 | 2025-12-20 03:04:20.511348 | TASK [tox : Record file location] 2025-12-20 03:04:20.536986 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:20.543315 | 2025-12-20 03:04:20.543452 | TASK [tox : Install tox siblings] 2025-12-20 03:04:20.566283 | debian-bookworm | ok 2025-12-20 03:04:20.575121 | debian-bookworm | included: /var/lib/zuul/builds/7d66c005b75f49e0b39e592c19d49c80/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-20 03:04:20.581612 | 2025-12-20 03:04:20.581753 | TASK [tox : Run tox without tests] 2025-12-20 03:04:21.711845 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-20 03:04:36.066880 | debian-bookworm | test: OK (14.92 seconds) 2025-12-20 03:04:36.066937 | debian-bookworm | congratulations :) (14.95 seconds) 2025-12-20 03:04:36.183326 | debian-bookworm | ok: Runtime: 0:00:15.233185 2025-12-20 03:04:36.199888 | 2025-12-20 03:04:36.200042 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-20 03:04:36.803096 | debian-bookworm | changed 2025-12-20 03:04:36.809561 | 2025-12-20 03:04:36.809702 | TASK [tox : Get tox envlist config] 2025-12-20 03:04:37.919627 | debian-bookworm | ok: Runtime: 0:00:00.333416 2025-12-20 03:04:37.926044 | 2025-12-20 03:04:37.926232 | TASK [tox : Install any sibling python packages] 2025-12-20 03:04:38.594426 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-20 03:04:38.631744 | 2025-12-20 03:04:38.646244 | TASK [tox : Remove tempfile] 2025-12-20 03:04:39.471174 | debian-bookworm | changed 2025-12-20 03:04:39.479888 | 2025-12-20 03:04:39.480030 | TASK [tox : Emit tox command] 2025-12-20 03:04:39.595771 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-20 03:04:39.602335 | 2025-12-20 03:04:39.602478 | TASK [tox : Run tox] 2025-12-20 03:04:40.876264 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-20 03:04:41.625622 | debian-bookworm | ............... 2025-12-20 03:04:41.625704 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-20 03:04:41.625724 | debian-bookworm | Ran 15 tests in 0.191s 2025-12-20 03:04:41.625730 | debian-bookworm | 2025-12-20 03:04:41.626842 | debian-bookworm | OK 2025-12-20 03:04:41.731490 | debian-bookworm | test: OK (0.90=setup[0.05]+cmd[0.85] seconds) 2025-12-20 03:04:41.731578 | debian-bookworm | congratulations :) (0.93 seconds) 2025-12-20 03:04:41.976247 | debian-bookworm | ok: Runtime: 0:00:01.220385 2025-12-20 03:04:41.982481 | 2025-12-20 03:04:41.982621 | TASK [tox : Look for output] 2025-12-20 03:04:42.706926 | debian-bookworm | ok 2025-12-20 03:04:42.753253 | 2025-12-20 03:04:42.753411 | TASK [tox : Return file comments to Zuul] 2025-12-20 03:04:42.844106 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:42.857437 | 2025-12-20 03:04:42.857579 | PLAY RECAP 2025-12-20 03:04:42.857656 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-20 03:04:42.857683 | 2025-12-20 03:04:43.338143 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-20 03:04:43.339507 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-20 03:04:45.235851 | 2025-12-20 03:04:45.235962 | PLAY [all] 2025-12-20 03:04:45.256144 | 2025-12-20 03:04:45.256256 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-20 03:04:45.357579 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:45.362526 | 2025-12-20 03:04:45.362644 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-20 03:04:45.477807 | debian-bookworm | ok 2025-12-20 03:04:45.482048 | 2025-12-20 03:04:45.482140 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-20 03:04:46.332023 | debian-bookworm -> localhost | changed 2025-12-20 03:04:46.339324 | 2025-12-20 03:04:46.339430 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-20 03:04:46.403666 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:46.409060 | 2025-12-20 03:04:46.409171 | TASK [fetch-tox-output : Set envlist fact] 2025-12-20 03:04:46.473713 | debian-bookworm | ok 2025-12-20 03:04:46.491237 | 2025-12-20 03:04:46.491347 | TASK [fetch-tox-output : Get tox version] 2025-12-20 03:04:47.382676 | 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-20 03:04:47.401463 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-20 03:04:47.579467 | debian-bookworm | ok: Runtime: 0:00:00.305889 2025-12-20 03:04:47.584858 | 2025-12-20 03:04:47.584957 | TASK [fetch-tox-output : Find all default environments] 2025-12-20 03:04:48.151191 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:48.157009 | 2025-12-20 03:04:48.157123 | TASK [fetch-tox-output : Set envlist fact] 2025-12-20 03:04:48.210687 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:48.217146 | 2025-12-20 03:04:48.217254 | TASK [fetch-tox-output : Find all default environments] 2025-12-20 03:04:48.756520 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:48.762222 | 2025-12-20 03:04:48.762328 | TASK [fetch-tox-output : Set envlist fact] 2025-12-20 03:04:48.795588 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:48.801630 | 2025-12-20 03:04:48.801733 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-20 03:04:48.910315 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:48.923389 | 2025-12-20 03:04:48.923640 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-20 03:04:50.079685 | debian-bookworm | changed: 2025-12-20 03:04:50.079849 | debian-bookworm | created directory /var/lib/zuul/builds/7d66c005b75f49e0b39e592c19d49c80/work/logs/tox/test 2025-12-20 03:04:50.079883 | debian-bookworm | cd+++++++++ ./ 2025-12-20 03:04:50.079908 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-20 03:04:50.079936 | 2025-12-20 03:04:50.089358 | 2025-12-20 03:04:50.089433 | PLAY RECAP 2025-12-20 03:04:50.089483 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-20 03:04:50.089506 | 2025-12-20 03:04:50.294795 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-20 03:04:50.295650 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-20 03:04:52.384084 | 2025-12-20 03:04:52.384221 | PLAY [all] 2025-12-20 03:04:52.459770 | 2025-12-20 03:04:52.459913 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-20 03:04:52.838392 | debian-bookworm | changed: non-zero return code 2025-12-20 03:04:52.850800 | 2025-12-20 03:04:52.850978 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-20 03:04:52.895365 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:52.901562 | 2025-12-20 03:04:52.901673 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-20 03:04:52.944707 | 2025-12-20 03:04:52.944872 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-20 03:04:52.994570 | 2025-12-20 03:04:52.994743 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-20 03:04:53.026258 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:53.037252 | 2025-12-20 03:04:53.037355 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-20 03:04:53.100300 | 2025-12-20 03:04:53.100461 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-20 03:04:53.124654 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:53.133005 | 2025-12-20 03:04:53.134370 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-20 03:04:53.180851 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:53.192558 | 2025-12-20 03:04:53.192658 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-20 03:04:53.235701 | debian-bookworm | skipping: Conditional result was False 2025-12-20 03:04:53.243574 | 2025-12-20 03:04:53.243667 | PLAY RECAP 2025-12-20 03:04:53.243710 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-20 03:04:53.243732 | 2025-12-20 03:04:53.624672 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-20 03:04:53.626181 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-20 03:04:55.345502 | 2025-12-20 03:04:55.345652 | PLAY [Base post] 2025-12-20 03:04:55.363262 | 2025-12-20 03:04:55.363396 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-20 03:04:56.713133 | debian-bookworm | changed 2025-12-20 03:04:56.720689 | 2025-12-20 03:04:56.720785 | PLAY RECAP 2025-12-20 03:04:56.720844 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-20 03:04:56.720906 | 2025-12-20 03:04:56.944277 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-20 03:04:56.945087 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-20 03:04:58.827818 | 2025-12-20 03:04:58.827964 | PLAY [Base post-logs] 2025-12-20 03:04:58.861359 | 2025-12-20 03:04:58.861521 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-20 03:05:00.335337 | localhost | changed 2025-12-20 03:05:00.352586 | 2025-12-20 03:05:00.352738 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-20 03:05:00.418432 | localhost | ok 2025-12-20 03:05:00.421367 | 2025-12-20 03:05:00.421456 | TASK [Set zuul-log-path fact] 2025-12-20 03:05:00.476835 | localhost | ok 2025-12-20 03:05:00.484704 | 2025-12-20 03:05:00.484815 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-20 03:05:00.547272 | localhost | ok 2025-12-20 03:05:00.550232 | 2025-12-20 03:05:00.550320 | TASK [upload-logs : Create log directories] 2025-12-20 03:05:01.774793 | localhost | changed 2025-12-20 03:05:01.777342 | 2025-12-20 03:05:01.777433 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-20 03:05:03.254403 | localhost -> localhost | ok: Runtime: 0:00:00.025399 2025-12-20 03:05:03.259595 | 2025-12-20 03:05:03.259738 | TASK [upload-logs : Upload logs to log server] 2025-12-20 03:05:05.137394 | localhost | Output suppressed because no_log was given 2025-12-20 03:05:05.139658 | 2025-12-20 03:05:05.139776 | LOOP [upload-logs : Compress console log and json output] 2025-12-20 03:05:05.314164 | localhost | skipping: Conditional result was False 2025-12-20 03:05:05.347687 | localhost | skipping: Conditional result was False 2025-12-20 03:05:05.354600 | 2025-12-20 03:05:05.354731 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-20 03:05:05.449257 | localhost | skipping: Conditional result was False 2025-12-20 03:05:05.449524 | 2025-12-20 03:05:05.454230 | localhost | skipping: Conditional result was False 2025-12-20 03:05:05.465867 | 2025-12-20 03:05:05.465991 | LOOP [upload-logs : Upload console log and json output]