2026-03-02 03:03:10.509329 | Job console starting 2026-03-02 03:03:10.525846 | Updating git repos 2026-03-02 03:03:10.590264 | Cloning repos into workspace 2026-03-02 03:03:10.821387 | Restoring repo states 2026-03-02 03:03:10.852022 | Merging changes 2026-03-02 03:03:10.852047 | Checking out repos 2026-03-02 03:03:10.965207 | Preparing playbooks 2026-03-02 03:03:12.291034 | Running Ansible setup 2026-03-02 03:03:18.687569 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-02 03:03:20.332975 | 2026-03-02 03:03:20.333097 | PLAY [Base pre] 2026-03-02 03:03:20.362686 | 2026-03-02 03:03:20.362794 | TASK [Setup log path fact] 2026-03-02 03:03:20.407170 | debian-bookworm | ok 2026-03-02 03:03:20.422587 | 2026-03-02 03:03:20.422698 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-02 03:03:20.506580 | debian-bookworm | ok 2026-03-02 03:03:20.545007 | 2026-03-02 03:03:20.545115 | TASK [emit-job-header : Print job information] 2026-03-02 03:03:20.630579 | # Job Information 2026-03-02 03:03:20.630714 | Ansible Version: 2.16.14 2026-03-02 03:03:20.630741 | Job: tox 2026-03-02 03:03:20.630767 | Pipeline: periodic-daily 2026-03-02 03:03:20.630785 | Executor: 521e9411259a 2026-03-02 03:03:20.630802 | Triggered by: https://github.com/osism/openstack-image-manager 2026-03-02 03:03:20.630820 | Event ID: 8d844fd2fcf64bffa4094dc8f35ac971 2026-03-02 03:03:20.635302 | 2026-03-02 03:03:20.635392 | LOOP [emit-job-header : Print node information] 2026-03-02 03:03:20.790638 | debian-bookworm | ok: 2026-03-02 03:03:20.790774 | debian-bookworm | # Node Information 2026-03-02 03:03:20.790802 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-02 03:03:20.790822 | debian-bookworm | Hostname: debian 2026-03-02 03:03:20.790853 | debian-bookworm | Username: zuul 2026-03-02 03:03:20.790871 | debian-bookworm | Distro: Debian 12.13 2026-03-02 03:03:20.790890 | debian-bookworm | Provider: regiocloud-a 2026-03-02 03:03:20.790908 | debian-bookworm | Region: 2026-03-02 03:03:20.790925 | debian-bookworm | Label: debian-bookworm 2026-03-02 03:03:20.790941 | debian-bookworm | Product Name: OpenStack Nova 2026-03-02 03:03:20.790957 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe66:1f0e 2026-03-02 03:03:20.809711 | 2026-03-02 03:03:20.809806 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-02 03:03:21.812495 | debian-bookworm -> localhost | changed 2026-03-02 03:03:21.818714 | 2026-03-02 03:03:21.818805 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-02 03:03:23.549101 | debian-bookworm -> localhost | changed 2026-03-02 03:03:23.558117 | 2026-03-02 03:03:23.558202 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-02 03:03:24.221044 | debian-bookworm -> localhost | ok 2026-03-02 03:03:24.229287 | 2026-03-02 03:03:24.229378 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-02 03:03:24.259503 | debian-bookworm | ok 2026-03-02 03:03:24.290345 | debian-bookworm | included: /var/lib/zuul/builds/d2fa6ec2f1d64c82b101eedb6a3187d3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-02 03:03:24.303239 | 2026-03-02 03:03:24.303320 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-02 03:03:28.117692 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-02 03:03:28.117874 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d2fa6ec2f1d64c82b101eedb6a3187d3/work/d2fa6ec2f1d64c82b101eedb6a3187d3_id_rsa 2026-03-02 03:03:28.117904 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d2fa6ec2f1d64c82b101eedb6a3187d3/work/d2fa6ec2f1d64c82b101eedb6a3187d3_id_rsa.pub 2026-03-02 03:03:28.117925 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-02 03:03:28.117947 | debian-bookworm -> localhost | SHA256:WMQHzTV8LUVQrScz4WMaqxWk3gR2NBvxRTgcgBdEZS8 zuul-build-sshkey 2026-03-02 03:03:28.117965 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-02 03:03:28.117990 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-02 03:03:28.118009 | debian-bookworm -> localhost | | .o+ B%*=XB| 2026-03-02 03:03:28.118027 | debian-bookworm -> localhost | | .. B =BBoo| 2026-03-02 03:03:28.118044 | debian-bookworm -> localhost | | .o *.oE=.| 2026-03-02 03:03:28.118059 | debian-bookworm -> localhost | | o . + O..| 2026-03-02 03:03:28.118075 | debian-bookworm -> localhost | | . S. o * * | 2026-03-02 03:03:28.118095 | debian-bookworm -> localhost | | . = | 2026-03-02 03:03:28.118112 | debian-bookworm -> localhost | | o | 2026-03-02 03:03:28.118129 | debian-bookworm -> localhost | | . | 2026-03-02 03:03:28.118146 | debian-bookworm -> localhost | | | 2026-03-02 03:03:28.118165 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-02 03:03:28.118226 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.141783 2026-03-02 03:03:28.126555 | 2026-03-02 03:03:28.126667 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-02 03:03:28.177489 | debian-bookworm | ok 2026-03-02 03:03:28.192433 | debian-bookworm | included: /var/lib/zuul/builds/d2fa6ec2f1d64c82b101eedb6a3187d3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-02 03:03:28.211932 | 2026-03-02 03:03:28.212042 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-02 03:03:28.256864 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:03:28.262137 | 2026-03-02 03:03:28.262227 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-02 03:03:29.133728 | debian-bookworm | changed 2026-03-02 03:03:29.138114 | 2026-03-02 03:03:29.138188 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-02 03:03:29.401539 | debian-bookworm | ok 2026-03-02 03:03:29.405922 | 2026-03-02 03:03:29.405998 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-02 03:03:30.126545 | debian-bookworm | changed 2026-03-02 03:03:30.133830 | 2026-03-02 03:03:30.133924 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-02 03:03:30.833326 | debian-bookworm | changed 2026-03-02 03:03:30.837823 | 2026-03-02 03:03:30.837908 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-02 03:03:30.881481 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:03:30.886367 | 2026-03-02 03:03:30.886447 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-02 03:03:32.104647 | debian-bookworm -> localhost | changed 2026-03-02 03:03:32.113529 | 2026-03-02 03:03:32.113736 | TASK [add-build-sshkey : Add back temp key] 2026-03-02 03:03:32.691834 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d2fa6ec2f1d64c82b101eedb6a3187d3/work/d2fa6ec2f1d64c82b101eedb6a3187d3_id_rsa (zuul-build-sshkey) 2026-03-02 03:03:32.692013 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008282 2026-03-02 03:03:32.698144 | 2026-03-02 03:03:32.698221 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-02 03:03:33.071536 | debian-bookworm | ok 2026-03-02 03:03:33.076477 | 2026-03-02 03:03:33.076580 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-02 03:03:33.099604 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:03:33.111923 | 2026-03-02 03:03:33.112025 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-02 03:03:33.620278 | debian-bookworm | ok 2026-03-02 03:03:33.636512 | 2026-03-02 03:03:33.636618 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-02 03:03:33.677034 | debian-bookworm | ok 2026-03-02 03:03:33.682978 | 2026-03-02 03:03:33.683075 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-02 03:03:34.331030 | debian-bookworm -> localhost | ok 2026-03-02 03:03:34.337210 | 2026-03-02 03:03:34.337300 | TASK [validate-host : Collect information about the host] 2026-03-02 03:03:35.851810 | debian-bookworm | ok 2026-03-02 03:03:35.870280 | 2026-03-02 03:03:35.870385 | TASK [validate-host : Sanitize hostname] 2026-03-02 03:03:36.140671 | debian-bookworm | ok 2026-03-02 03:03:36.258055 | 2026-03-02 03:03:36.258161 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-02 03:03:37.803482 | debian-bookworm -> localhost | changed 2026-03-02 03:03:37.808016 | 2026-03-02 03:03:37.808095 | TASK [validate-host : Collect information about zuul worker] 2026-03-02 03:03:38.339378 | debian-bookworm | ok 2026-03-02 03:03:38.343478 | 2026-03-02 03:03:38.343562 | TASK [validate-host : Write out all zuul information for each host] 2026-03-02 03:03:39.687755 | debian-bookworm -> localhost | changed 2026-03-02 03:03:39.695532 | 2026-03-02 03:03:39.695646 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-02 03:03:39.995918 | debian-bookworm | ok 2026-03-02 03:03:40.000585 | 2026-03-02 03:03:40.000674 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-02 03:03:41.757747 | debian-bookworm | changed: 2026-03-02 03:03:41.757894 | debian-bookworm | cd+++++++++ src/ 2026-03-02 03:03:41.757922 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-02 03:03:41.757942 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-02 03:03:41.757959 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-03-02 03:03:41.757976 | debian-bookworm | =7.0.1 2026-03-02 03:04:06.546959 | debian-bookworm | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-03-02 03:04:06.593590 | debian-bookworm | Collecting colorama>=0.4.6 2026-03-02 03:04:06.609927 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-03-02 03:04:06.686920 | debian-bookworm | Collecting filelock>=3.24.3 2026-03-02 03:04:06.702978 | debian-bookworm | Downloading filelock-3.25.0-py3-none-any.whl (26 kB) 2026-03-02 03:04:06.756845 | debian-bookworm | Collecting packaging>=26 2026-03-02 03:04:06.773851 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-02 03:04:06.787817 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 8.4 MB/s eta 0:00:00 2026-03-02 03:04:06.849925 | debian-bookworm | Collecting platformdirs>=4.9.2 2026-03-02 03:04:06.865688 | debian-bookworm | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-03-02 03:04:06.909389 | debian-bookworm | Collecting pluggy>=1.6 2026-03-02 03:04:06.924763 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-02 03:04:06.966596 | debian-bookworm | Collecting pyproject-api>=1.10 2026-03-02 03:04:06.982250 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-03-02 03:04:07.117802 | debian-bookworm | Collecting virtualenv>=20.39 2026-03-02 03:04:07.133341 | debian-bookworm | Downloading virtualenv-21.1.0-py3-none-any.whl (5.8 MB) 2026-03-02 03:04:07.415672 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 20.8 MB/s eta 0:00:00 2026-03-02 03:04:07.531929 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-03-02 03:04:07.547918 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-03-02 03:04:07.575498 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 19.7 MB/s eta 0:00:00 2026-03-02 03:04:07.618175 | debian-bookworm | Collecting python-discovery>=1 2026-03-02 03:04:07.633693 | debian-bookworm | Downloading python_discovery-1.1.0-py3-none-any.whl (30 kB) 2026-03-02 03:04:07.756596 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-03-02 03:04:08.520867 | debian-bookworm | Successfully installed cachetools-7.0.1 colorama-0.4.6 distlib-0.4.0 filelock-3.25.0 packaging-26.0 platformdirs-4.9.2 pluggy-1.6.0 pyproject-api-1.10.0 python-discovery-1.1.0 tox-4.47.0 virtualenv-21.1.0 2026-03-02 03:04:08.916450 | debian-bookworm | ok: Runtime: 0:00:02.986243 2026-03-02 03:04:08.921267 | 2026-03-02 03:04:08.921348 | TASK [ensure-tox : Export installed tox_executable path] 2026-03-02 03:04:08.968833 | debian-bookworm | ok 2026-03-02 03:04:08.972755 | 2026-03-02 03:04:08.972826 | TASK [ensure-tox : Output tox version] 2026-03-02 03:04:09.503899 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-03-02 03:04:09.522711 | debian-bookworm | 4.47.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-02 03:04:09.997343 | debian-bookworm | ok: Runtime: 0:00:00.333076 2026-03-02 03:04:10.002900 | 2026-03-02 03:04:10.002991 | TASK [ensure-tox : Make global symlink] 2026-03-02 03:04:10.036128 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:10.042250 | 2026-03-02 03:04:10.042330 | PLAY RECAP 2026-03-02 03:04:10.042377 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-03-02 03:04:10.042401 | 2026-03-02 03:04:10.151265 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-03-02 03:04:10.154221 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-02 03:04:10.904902 | 2026-03-02 03:04:10.905027 | PLAY [all] 2026-03-02 03:04:10.924133 | 2026-03-02 03:04:10.924260 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-03-02 03:04:11.359762 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-02 03:04:11.457921 | debian-bookworm | ok: Runtime: 0:00:00.034073 2026-03-02 03:04:11.463299 | 2026-03-02 03:04:11.463408 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-03-02 03:04:11.988884 | debian-bookworm | ok: Runtime: 0:00:00.006965 2026-03-02 03:04:11.994872 | 2026-03-02 03:04:11.994970 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-03-02 03:04:12.287430 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-02 03:04:12.291258 | debian-bookworm | sudo: a password is required 2026-03-02 03:04:12.531522 | debian-bookworm | ok: Runtime: 0:00:00.024694 2026-03-02 03:04:12.543039 | 2026-03-02 03:04:12.543154 | TASK [tox : Check to see if the constraints file exists] 2026-03-02 03:04:12.604209 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:12.611346 | 2026-03-02 03:04:12.611457 | TASK [tox : Fail if constraints file is missing] 2026-03-02 03:04:12.639793 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:12.653267 | 2026-03-02 03:04:12.653446 | TASK [tox : Record file location] 2026-03-02 03:04:12.720659 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:12.731499 | 2026-03-02 03:04:12.731625 | TASK [tox : Install tox siblings] 2026-03-02 03:04:12.805424 | debian-bookworm | ok 2026-03-02 03:04:12.860647 | debian-bookworm | included: /var/lib/zuul/builds/d2fa6ec2f1d64c82b101eedb6a3187d3/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-03-02 03:04:12.873435 | 2026-03-02 03:04:12.873611 | TASK [tox : Run tox without tests] 2026-03-02 03:04:14.034157 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-03-02 03:04:27.541292 | debian-bookworm | test: OK (14.04 seconds) 2026-03-02 03:04:27.541374 | debian-bookworm | congratulations :) (14.07 seconds) 2026-03-02 03:04:27.930688 | debian-bookworm | ok: Runtime: 0:00:14.333333 2026-03-02 03:04:27.936755 | 2026-03-02 03:04:27.937001 | TASK [tox : Create a tempfile to save tox showconfig] 2026-03-02 03:04:28.378350 | debian-bookworm | changed 2026-03-02 03:04:28.389860 | 2026-03-02 03:04:28.389995 | TASK [tox : Get tox envlist config] 2026-03-02 03:04:29.430956 | debian-bookworm | ok: Runtime: 0:00:00.299295 2026-03-02 03:04:29.444320 | 2026-03-02 03:04:29.444509 | TASK [tox : Install any sibling python packages] 2026-03-02 03:04:30.141287 | debian-bookworm | ok: No setup.cfg, no action needed 2026-03-02 03:04:30.154040 | 2026-03-02 03:04:30.154174 | TASK [tox : Remove tempfile] 2026-03-02 03:04:30.856505 | debian-bookworm | changed 2026-03-02 03:04:30.868009 | 2026-03-02 03:04:30.868139 | TASK [tox : Emit tox command] 2026-03-02 03:04:30.928983 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-03-02 03:04:30.934606 | 2026-03-02 03:04:30.934727 | TASK [tox : Run tox] 2026-03-02 03:04:31.627580 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-03-02 03:04:32.199672 | debian-bookworm | ............... 2026-03-02 03:04:32.199707 | debian-bookworm | ---------------------------------------------------------------------- 2026-03-02 03:04:32.200003 | debian-bookworm | Ran 15 tests in 0.166s 2026-03-02 03:04:32.200011 | debian-bookworm | 2026-03-02 03:04:32.200019 | debian-bookworm | OK 2026-03-02 03:04:32.258461 | debian-bookworm | test: OK (0.67=setup[0.04]+cmd[0.63] seconds) 2026-03-02 03:04:32.258505 | debian-bookworm | congratulations :) (0.70 seconds) 2026-03-02 03:04:32.563860 | debian-bookworm | ok: Runtime: 0:00:00.964869 2026-03-02 03:04:32.585028 | 2026-03-02 03:04:32.586050 | TASK [tox : Look for output] 2026-03-02 03:04:33.413463 | debian-bookworm | ok 2026-03-02 03:04:33.467833 | 2026-03-02 03:04:33.467994 | TASK [tox : Return file comments to Zuul] 2026-03-02 03:04:33.550372 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:33.558587 | 2026-03-02 03:04:33.558697 | PLAY RECAP 2026-03-02 03:04:33.558752 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-03-02 03:04:33.558778 | 2026-03-02 03:04:33.801196 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-02 03:04:33.802353 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-02 03:04:35.335825 | 2026-03-02 03:04:35.336075 | PLAY [all] 2026-03-02 03:04:35.368212 | 2026-03-02 03:04:35.368515 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-03-02 03:04:35.425024 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:35.434973 | 2026-03-02 03:04:35.435165 | TASK [fetch-tox-output : Set tox log path for single node] 2026-03-02 03:04:35.482315 | debian-bookworm | ok 2026-03-02 03:04:35.492037 | 2026-03-02 03:04:35.492160 | TASK [fetch-tox-output : Ensure local tox dir] 2026-03-02 03:04:36.246757 | debian-bookworm -> localhost | changed 2026-03-02 03:04:36.254572 | 2026-03-02 03:04:36.254691 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-03-02 03:04:36.319021 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:36.331093 | 2026-03-02 03:04:36.331191 | TASK [fetch-tox-output : Set envlist fact] 2026-03-02 03:04:36.371257 | debian-bookworm | ok 2026-03-02 03:04:36.376276 | 2026-03-02 03:04:36.376369 | TASK [fetch-tox-output : Get tox version] 2026-03-02 03:04:37.010797 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-03-02 03:04:37.028684 | debian-bookworm | 4.47.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-02 03:04:37.403534 | debian-bookworm | ok: Runtime: 0:00:00.265509 2026-03-02 03:04:37.408239 | 2026-03-02 03:04:37.408313 | TASK [fetch-tox-output : Find all default environments] 2026-03-02 03:04:37.950935 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:37.956707 | 2026-03-02 03:04:37.957637 | TASK [fetch-tox-output : Set envlist fact] 2026-03-02 03:04:37.990720 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:37.996225 | 2026-03-02 03:04:37.996315 | TASK [fetch-tox-output : Find all default environments] 2026-03-02 03:04:38.524688 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:38.529333 | 2026-03-02 03:04:38.529417 | TASK [fetch-tox-output : Set envlist fact] 2026-03-02 03:04:38.552101 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:38.561815 | 2026-03-02 03:04:38.562494 | LOOP [fetch-tox-output : Copy tox logs] 2026-03-02 03:04:38.634133 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:38.647346 | 2026-03-02 03:04:38.647455 | LOOP [fetch-tox-output : Collect tox logs] 2026-03-02 03:04:39.421871 | debian-bookworm | changed: 2026-03-02 03:04:39.422038 | debian-bookworm | created directory /var/lib/zuul/builds/d2fa6ec2f1d64c82b101eedb6a3187d3/work/logs/tox/test 2026-03-02 03:04:39.422073 | debian-bookworm | cd+++++++++ ./ 2026-03-02 03:04:39.422097 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-03-02 03:04:39.422126 | 2026-03-02 03:04:39.436864 | 2026-03-02 03:04:39.436942 | PLAY RECAP 2026-03-02 03:04:39.443680 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-03-02 03:04:39.443717 | 2026-03-02 03:04:39.538319 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-02 03:04:39.539267 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-02 03:04:40.228659 | 2026-03-02 03:04:40.228789 | PLAY [all] 2026-03-02 03:04:40.248355 | 2026-03-02 03:04:40.248516 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-02 03:04:40.418445 | debian-bookworm | changed: non-zero return code 2026-03-02 03:04:40.423951 | 2026-03-02 03:04:40.424065 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-02 03:04:40.437278 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:40.443895 | 2026-03-02 03:04:40.444095 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-02 03:04:40.474821 | 2026-03-02 03:04:40.475060 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-02 03:04:40.504757 | 2026-03-02 03:04:40.504929 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-02 03:04:40.517923 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:40.524262 | 2026-03-02 03:04:40.524363 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-02 03:04:40.557289 | 2026-03-02 03:04:40.557463 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-02 03:04:40.571300 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:40.579672 | 2026-03-02 03:04:40.579800 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-02 03:04:40.614665 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:40.620865 | 2026-03-02 03:04:40.620963 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-02 03:04:40.646259 | debian-bookworm | skipping: Conditional result was False 2026-03-02 03:04:40.652968 | 2026-03-02 03:04:40.653045 | PLAY RECAP 2026-03-02 03:04:40.653095 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-02 03:04:40.653120 | 2026-03-02 03:04:40.748266 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-02 03:04:40.749243 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-02 03:04:41.540767 | 2026-03-02 03:04:41.540955 | PLAY [Base post] 2026-03-02 03:04:41.555607 | 2026-03-02 03:04:41.555764 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-02 03:04:42.172946 | debian-bookworm | changed 2026-03-02 03:04:42.183140 | 2026-03-02 03:04:42.183264 | PLAY RECAP 2026-03-02 03:04:42.183329 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-02 03:04:42.183391 | 2026-03-02 03:04:42.354379 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-02 03:04:42.356284 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-02 03:04:43.285432 | 2026-03-02 03:04:43.285644 | PLAY [Base post-logs] 2026-03-02 03:04:43.299197 | 2026-03-02 03:04:43.299343 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-02 03:04:43.833508 | localhost | changed 2026-03-02 03:04:43.851443 | 2026-03-02 03:04:43.851643 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-02 03:04:43.890859 | localhost | ok 2026-03-02 03:04:43.894169 | 2026-03-02 03:04:43.894268 | TASK [Set zuul-log-path fact] 2026-03-02 03:04:43.909256 | localhost | ok 2026-03-02 03:04:43.917515 | 2026-03-02 03:04:43.917629 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-02 03:04:43.942525 | localhost | ok 2026-03-02 03:04:43.946001 | 2026-03-02 03:04:43.946110 | TASK [upload-logs : Create log directories] 2026-03-02 03:04:44.483356 | localhost | changed 2026-03-02 03:04:44.489128 | 2026-03-02 03:04:44.489291 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-02 03:04:45.069023 | localhost -> localhost | ok: Runtime: 0:00:00.006409 2026-03-02 03:04:45.080282 | 2026-03-02 03:04:45.080523 | TASK [upload-logs : Upload logs to log server] 2026-03-02 03:04:45.760641 | localhost | Output suppressed because no_log was given 2026-03-02 03:04:45.763294 | 2026-03-02 03:04:45.763430 | LOOP [upload-logs : Compress console log and json output] 2026-03-02 03:04:45.827698 | localhost | skipping: Conditional result was False 2026-03-02 03:04:45.832090 | localhost | skipping: Conditional result was False 2026-03-02 03:04:45.845374 | 2026-03-02 03:04:45.845521 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-02 03:04:45.896687 | localhost | skipping: Conditional result was False 2026-03-02 03:04:45.896962 | 2026-03-02 03:04:45.915398 | localhost | skipping: Conditional result was False 2026-03-02 03:04:45.925595 | 2026-03-02 03:04:45.925866 | LOOP [upload-logs : Upload console log and json output]