2026-05-15 03:15:19.385869 | Job console starting 2026-05-15 03:15:19.398520 | Updating git repos 2026-05-15 03:15:19.433661 | Cloning repos into workspace 2026-05-15 03:15:19.486676 | Restoring repo states 2026-05-15 03:15:19.495688 | Merging changes 2026-05-15 03:15:19.495716 | Checking out repos 2026-05-15 03:15:19.573680 | Preparing playbooks 2026-05-15 03:15:20.430665 | Running Ansible setup 2026-05-15 03:15:25.555411 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-15 03:15:26.376208 | 2026-05-15 03:15:26.376339 | PLAY [Base pre] 2026-05-15 03:15:26.410330 | 2026-05-15 03:15:26.410456 | TASK [Setup log path fact] 2026-05-15 03:15:26.439096 | debian-bookworm | ok 2026-05-15 03:15:26.459555 | 2026-05-15 03:15:26.459732 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-15 03:15:26.520002 | debian-bookworm | ok 2026-05-15 03:15:26.536739 | 2026-05-15 03:15:26.536881 | TASK [emit-job-header : Print job information] 2026-05-15 03:15:26.584169 | # Job Information 2026-05-15 03:15:26.584407 | Ansible Version: 2.16.14 2026-05-15 03:15:26.584448 | Job: tox 2026-05-15 03:15:26.584488 | Pipeline: periodic-daily 2026-05-15 03:15:26.584511 | Executor: 521e9411259a 2026-05-15 03:15:26.584532 | Triggered by: https://github.com/osism/openstack-image-manager 2026-05-15 03:15:26.584554 | Event ID: 0bc7489cdb61474cafd81d47831605ee 2026-05-15 03:15:26.591496 | 2026-05-15 03:15:26.591615 | LOOP [emit-job-header : Print node information] 2026-05-15 03:15:26.692040 | debian-bookworm | ok: 2026-05-15 03:15:26.692248 | debian-bookworm | # Node Information 2026-05-15 03:15:26.692281 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-15 03:15:26.692306 | debian-bookworm | Hostname: debian 2026-05-15 03:15:26.692328 | debian-bookworm | Username: zuul 2026-05-15 03:15:26.692348 | debian-bookworm | Distro: Debian 12.13 2026-05-15 03:15:26.692373 | debian-bookworm | Provider: regiocloud-a 2026-05-15 03:15:26.692393 | debian-bookworm | Region: 2026-05-15 03:15:26.692414 | debian-bookworm | Label: debian-bookworm 2026-05-15 03:15:26.692434 | debian-bookworm | Product Name: OpenStack Nova 2026-05-15 03:15:26.692454 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed1:3bf7 2026-05-15 03:15:26.706959 | 2026-05-15 03:15:26.707104 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-15 03:15:27.617579 | debian-bookworm -> localhost | changed 2026-05-15 03:15:27.624887 | 2026-05-15 03:15:27.624995 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-15 03:15:28.872794 | debian-bookworm -> localhost | changed 2026-05-15 03:15:28.887451 | 2026-05-15 03:15:28.887689 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-15 03:15:29.348684 | debian-bookworm -> localhost | ok 2026-05-15 03:15:29.355921 | 2026-05-15 03:15:29.356078 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-15 03:15:29.388315 | debian-bookworm | ok 2026-05-15 03:15:29.450899 | debian-bookworm | included: /var/lib/zuul/builds/5390678b60de4015bf89854eceb30647/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-15 03:15:29.468406 | 2026-05-15 03:15:29.468579 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-15 03:15:31.677738 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-15 03:15:31.678002 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5390678b60de4015bf89854eceb30647/work/5390678b60de4015bf89854eceb30647_id_rsa 2026-05-15 03:15:31.678041 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5390678b60de4015bf89854eceb30647/work/5390678b60de4015bf89854eceb30647_id_rsa.pub 2026-05-15 03:15:31.678108 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-15 03:15:31.678136 | debian-bookworm -> localhost | SHA256:tZfDHf+kIFtuws3g55F7q6g2FvFnDVV22YYGt2KTmlw zuul-build-sshkey 2026-05-15 03:15:31.678160 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-15 03:15:31.678196 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-15 03:15:31.678218 | debian-bookworm -> localhost | | ...o*| 2026-05-15 03:15:31.678241 | debian-bookworm -> localhost | | o+++| 2026-05-15 03:15:31.678262 | debian-bookworm -> localhost | | . Eoo. | 2026-05-15 03:15:31.678282 | debian-bookworm -> localhost | | .o B.= o | 2026-05-15 03:15:31.678302 | debian-bookworm -> localhost | | SoB Bo. o| 2026-05-15 03:15:31.678330 | debian-bookworm -> localhost | | .o.Xo+.o.| 2026-05-15 03:15:31.678350 | debian-bookworm -> localhost | | .=oO . .| 2026-05-15 03:15:31.678370 | debian-bookworm -> localhost | | + * o. | 2026-05-15 03:15:31.678391 | debian-bookworm -> localhost | | o.o. +o.. | 2026-05-15 03:15:31.678411 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-15 03:15:31.678482 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.478436 2026-05-15 03:15:31.686640 | 2026-05-15 03:15:31.686779 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-15 03:15:31.730023 | debian-bookworm | ok 2026-05-15 03:15:31.744900 | debian-bookworm | included: /var/lib/zuul/builds/5390678b60de4015bf89854eceb30647/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-15 03:15:31.782338 | 2026-05-15 03:15:31.782481 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-15 03:15:31.838280 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:15:31.845342 | 2026-05-15 03:15:31.845459 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-15 03:15:32.749925 | debian-bookworm | changed 2026-05-15 03:15:32.756521 | 2026-05-15 03:15:32.756612 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-15 03:15:33.018498 | debian-bookworm | ok 2026-05-15 03:15:33.023055 | 2026-05-15 03:15:33.023156 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-15 03:15:33.805565 | debian-bookworm | changed 2026-05-15 03:15:33.811822 | 2026-05-15 03:15:33.811906 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-15 03:15:34.510605 | debian-bookworm | changed 2026-05-15 03:15:34.520152 | 2026-05-15 03:15:34.520567 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-15 03:15:34.544331 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:15:34.553555 | 2026-05-15 03:15:34.553661 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-15 03:15:35.158230 | debian-bookworm -> localhost | changed 2026-05-15 03:15:35.170389 | 2026-05-15 03:15:35.170494 | TASK [add-build-sshkey : Add back temp key] 2026-05-15 03:15:35.616151 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5390678b60de4015bf89854eceb30647/work/5390678b60de4015bf89854eceb30647_id_rsa (zuul-build-sshkey) 2026-05-15 03:15:35.616366 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012638 2026-05-15 03:15:35.624735 | 2026-05-15 03:15:35.624839 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-15 03:15:36.039168 | debian-bookworm | ok 2026-05-15 03:15:36.044073 | 2026-05-15 03:15:36.044189 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-15 03:15:36.072202 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:15:36.082394 | 2026-05-15 03:15:36.082505 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-15 03:15:36.510121 | debian-bookworm | ok 2026-05-15 03:15:36.521543 | 2026-05-15 03:15:36.521647 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-15 03:15:36.563505 | debian-bookworm | ok 2026-05-15 03:15:36.568458 | 2026-05-15 03:15:36.568555 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-15 03:15:36.823843 | debian-bookworm -> localhost | ok 2026-05-15 03:15:36.830023 | 2026-05-15 03:15:36.830136 | TASK [validate-host : Collect information about the host] 2026-05-15 03:15:38.077146 | debian-bookworm | ok 2026-05-15 03:15:38.094091 | 2026-05-15 03:15:38.094201 | TASK [validate-host : Sanitize hostname] 2026-05-15 03:15:38.203893 | debian-bookworm | ok 2026-05-15 03:15:38.240452 | 2026-05-15 03:15:38.240560 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-15 03:15:38.917334 | debian-bookworm -> localhost | changed 2026-05-15 03:15:38.927666 | 2026-05-15 03:15:38.927821 | TASK [validate-host : Collect information about zuul worker] 2026-05-15 03:15:39.328833 | debian-bookworm | ok 2026-05-15 03:15:39.333428 | 2026-05-15 03:15:39.333528 | TASK [validate-host : Write out all zuul information for each host] 2026-05-15 03:15:40.356848 | debian-bookworm -> localhost | changed 2026-05-15 03:15:40.375402 | 2026-05-15 03:15:40.375554 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-15 03:15:40.662974 | debian-bookworm | ok 2026-05-15 03:15:40.674317 | 2026-05-15 03:15:40.674521 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-15 03:15:41.850960 | debian-bookworm | changed: 2026-05-15 03:15:41.852579 | debian-bookworm | cd+++++++++ src/ 2026-05-15 03:15:41.853411 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-15 03:15:41.854285 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-15 03:15:41.854331 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-15 03:15:41.854400 | debian-bookworm | =7.0.3 2026-05-15 03:16:07.821384 | debian-bookworm | Downloading cachetools-7.1.1-py3-none-any.whl (16 kB) 2026-05-15 03:16:07.863717 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-15 03:16:07.875792 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-15 03:16:07.962591 | debian-bookworm | Collecting filelock>=3.25 2026-05-15 03:16:07.974698 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-15 03:16:08.025859 | debian-bookworm | Collecting packaging>=26 2026-05-15 03:16:08.037284 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-15 03:16:08.054561 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 8.6 MB/s eta 0:00:00 2026-05-15 03:16:08.108994 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-15 03:16:08.120759 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-05-15 03:16:08.161178 | debian-bookworm | Collecting pluggy>=1.6 2026-05-15 03:16:08.172578 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-15 03:16:08.225903 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-15 03:16:08.237643 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-15 03:16:08.287017 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-15 03:16:08.300754 | debian-bookworm | Downloading python_discovery-1.3.1-py3-none-any.whl (33 kB) 2026-05-15 03:16:08.354973 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-15 03:16:08.367118 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-15 03:16:08.504724 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-15 03:16:08.516565 | debian-bookworm | Downloading virtualenv-21.3.3-py3-none-any.whl (7.6 MB) 2026-05-15 03:16:08.885592 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 20.9 MB/s eta 0:00:00 2026-05-15 03:16:08.995858 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-15 03:16:09.007415 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-15 03:16:09.038206 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.5 MB/s eta 0:00:00 2026-05-15 03:16:09.157717 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-15 03:16:10.015962 | debian-bookworm | Successfully installed cachetools-7.1.1 colorama-0.4.6 distlib-0.4.0 filelock-3.29.0 packaging-26.2 platformdirs-4.9.6 pluggy-1.6.0 pyproject-api-1.10.0 python-discovery-1.3.1 tomli-w-1.2.0 tox-4.54.0 virtualenv-21.3.3 2026-05-15 03:16:10.221895 | debian-bookworm | ok: Runtime: 0:00:03.174799 2026-05-15 03:16:10.235201 | 2026-05-15 03:16:10.235349 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-15 03:16:10.269261 | debian-bookworm | ok 2026-05-15 03:16:10.280310 | 2026-05-15 03:16:10.280467 | TASK [ensure-tox : Output tox version] 2026-05-15 03:16:10.913283 | 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-05-15 03:16:10.931666 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-15 03:16:11.323188 | debian-bookworm | ok: Runtime: 0:00:00.354942 2026-05-15 03:16:11.328715 | 2026-05-15 03:16:11.328816 | TASK [ensure-tox : Make global symlink] 2026-05-15 03:16:11.341956 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:11.348062 | 2026-05-15 03:16:11.348130 | PLAY RECAP 2026-05-15 03:16:11.348191 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-15 03:16:11.348218 | 2026-05-15 03:16:11.483365 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-15 03:16:11.485026 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-15 03:16:12.941124 | 2026-05-15 03:16:12.941271 | PLAY [all] 2026-05-15 03:16:12.956849 | 2026-05-15 03:16:12.956973 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-15 03:16:13.740005 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-15 03:16:13.986569 | debian-bookworm | ok: Runtime: 0:00:00.028283 2026-05-15 03:16:13.992507 | 2026-05-15 03:16:13.992603 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-15 03:16:14.541286 | debian-bookworm | ok: Runtime: 0:00:00.008247 2026-05-15 03:16:14.545973 | 2026-05-15 03:16:14.546059 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-15 03:16:14.904647 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-15 03:16:14.908045 | debian-bookworm | sudo: a password is required 2026-05-15 03:16:15.101708 | debian-bookworm | ok: Runtime: 0:00:00.025583 2026-05-15 03:16:15.110393 | 2026-05-15 03:16:15.110482 | TASK [tox : Check to see if the constraints file exists] 2026-05-15 03:16:15.151423 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:15.156555 | 2026-05-15 03:16:15.156645 | TASK [tox : Fail if constraints file is missing] 2026-05-15 03:16:15.190141 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:15.195779 | 2026-05-15 03:16:15.195884 | TASK [tox : Record file location] 2026-05-15 03:16:15.231100 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:15.235871 | 2026-05-15 03:16:15.235962 | TASK [tox : Install tox siblings] 2026-05-15 03:16:15.277450 | debian-bookworm | ok 2026-05-15 03:16:15.290286 | debian-bookworm | included: /var/lib/zuul/builds/5390678b60de4015bf89854eceb30647/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-15 03:16:15.297969 | 2026-05-15 03:16:15.298065 | TASK [tox : Run tox without tests] 2026-05-15 03:16:16.901331 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-05-15 03:16:30.718039 | debian-bookworm | test: OK (14.60 seconds) 2026-05-15 03:16:30.718093 | debian-bookworm | congratulations :) (14.63 seconds) 2026-05-15 03:16:30.875029 | debian-bookworm | ok: Runtime: 0:00:14.976123 2026-05-15 03:16:30.885022 | 2026-05-15 03:16:30.885165 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-15 03:16:31.306692 | debian-bookworm | changed 2026-05-15 03:16:31.314316 | 2026-05-15 03:16:31.314501 | TASK [tox : Detect tox version] 2026-05-15 03:16:31.936717 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-15 03:16:32.355982 | debian-bookworm | ok: Runtime: 0:00:00.327169 2026-05-15 03:16:32.371104 | 2026-05-15 03:16:32.372556 | TASK [tox : Get tox envlist config] 2026-05-15 03:16:33.432614 | debian-bookworm | ok: Runtime: 0:00:00.372075 2026-05-15 03:16:33.438770 | 2026-05-15 03:16:33.438928 | TASK [tox : Install any sibling python packages] 2026-05-15 03:16:33.945036 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-15 03:16:33.953706 | 2026-05-15 03:16:33.953849 | TASK [tox : Remove tempfile] 2026-05-15 03:16:34.485143 | debian-bookworm | changed 2026-05-15 03:16:34.490885 | 2026-05-15 03:16:34.491014 | TASK [tox : Emit tox command] 2026-05-15 03:16:34.562614 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-05-15 03:16:34.574118 | 2026-05-15 03:16:34.574319 | TASK [tox : Run tox] 2026-05-15 03:16:35.302888 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-05-15 03:16:36.067400 | debian-bookworm | ............... 2026-05-15 03:16:36.067510 | debian-bookworm | ---------------------------------------------------------------------- 2026-05-15 03:16:36.067541 | debian-bookworm | Ran 15 tests in 0.172s 2026-05-15 03:16:36.067553 | debian-bookworm | 2026-05-15 03:16:36.067570 | debian-bookworm | OK 2026-05-15 03:16:36.159021 | debian-bookworm | test: OK (0.90=setup[0.05]+cmd[0.85] seconds) 2026-05-15 03:16:36.159144 | debian-bookworm | congratulations :) (0.93 seconds) 2026-05-15 03:16:36.637335 | debian-bookworm | ok: Runtime: 0:00:01.223602 2026-05-15 03:16:36.643618 | 2026-05-15 03:16:36.643710 | TASK [tox : Look for output] 2026-05-15 03:16:37.027404 | debian-bookworm | ok 2026-05-15 03:16:37.045401 | 2026-05-15 03:16:37.045518 | TASK [tox : Return file comments to Zuul] 2026-05-15 03:16:37.072814 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:37.078923 | 2026-05-15 03:16:37.079215 | PLAY RECAP 2026-05-15 03:16:37.079301 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-15 03:16:37.079327 | 2026-05-15 03:16:37.194176 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-15 03:16:37.195313 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-15 03:16:38.013039 | 2026-05-15 03:16:38.013169 | PLAY [all] 2026-05-15 03:16:38.036830 | 2026-05-15 03:16:38.036971 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-15 03:16:38.080791 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:38.086322 | 2026-05-15 03:16:38.086436 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-15 03:16:38.113729 | debian-bookworm | ok 2026-05-15 03:16:38.118599 | 2026-05-15 03:16:38.118689 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-15 03:16:38.950373 | debian-bookworm -> localhost | changed 2026-05-15 03:16:38.957808 | 2026-05-15 03:16:38.957910 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-15 03:16:39.001345 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:39.006791 | 2026-05-15 03:16:39.006910 | TASK [fetch-tox-output : Set envlist fact] 2026-05-15 03:16:39.045062 | debian-bookworm | ok 2026-05-15 03:16:39.053261 | 2026-05-15 03:16:39.053363 | TASK [fetch-tox-output : Get tox version] 2026-05-15 03:16:39.723727 | 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-05-15 03:16:39.741199 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-15 03:16:40.082647 | debian-bookworm | ok: Runtime: 0:00:00.305190 2026-05-15 03:16:40.088710 | 2026-05-15 03:16:40.088799 | TASK [fetch-tox-output : Find all default environments] 2026-05-15 03:16:40.616923 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:40.624187 | 2026-05-15 03:16:40.624333 | TASK [fetch-tox-output : Set envlist fact] 2026-05-15 03:16:40.648964 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:40.654593 | 2026-05-15 03:16:40.654688 | TASK [fetch-tox-output : Find all default environments] 2026-05-15 03:16:41.213099 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:41.239492 | 2026-05-15 03:16:41.239812 | TASK [fetch-tox-output : Set envlist fact] 2026-05-15 03:16:41.276401 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:41.288047 | 2026-05-15 03:16:41.288154 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-15 03:16:41.357371 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:41.375984 | 2026-05-15 03:16:41.376838 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-15 03:16:42.646332 | debian-bookworm | changed: 2026-05-15 03:16:42.646501 | debian-bookworm | created directory /var/lib/zuul/builds/5390678b60de4015bf89854eceb30647/work/logs/tox/test 2026-05-15 03:16:42.646536 | debian-bookworm | cd+++++++++ ./ 2026-05-15 03:16:42.646561 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-15 03:16:42.646589 | 2026-05-15 03:16:42.661544 | 2026-05-15 03:16:42.661622 | PLAY RECAP 2026-05-15 03:16:42.661673 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-15 03:16:42.661698 | 2026-05-15 03:16:42.812545 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-15 03:16:42.814533 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-15 03:16:44.305185 | 2026-05-15 03:16:44.305334 | PLAY [all] 2026-05-15 03:16:44.328428 | 2026-05-15 03:16:44.328568 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-15 03:16:44.532293 | debian-bookworm | changed: non-zero return code 2026-05-15 03:16:44.541942 | 2026-05-15 03:16:44.542048 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-15 03:16:44.555092 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:44.559626 | 2026-05-15 03:16:44.559708 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-15 03:16:44.577065 | 2026-05-15 03:16:44.577201 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-15 03:16:44.605931 | 2026-05-15 03:16:44.606086 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-15 03:16:44.619274 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:44.624366 | 2026-05-15 03:16:44.624455 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-15 03:16:44.642053 | 2026-05-15 03:16:44.642196 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-15 03:16:44.654582 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:44.660063 | 2026-05-15 03:16:44.660161 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-15 03:16:44.682764 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:44.687844 | 2026-05-15 03:16:44.687939 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-15 03:16:44.712402 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:44.717722 | 2026-05-15 03:16:44.717790 | PLAY RECAP 2026-05-15 03:16:44.717833 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-15 03:16:44.717853 | 2026-05-15 03:16:44.850322 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-15 03:16:44.852117 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-15 03:16:45.584421 | 2026-05-15 03:16:45.584574 | PLAY [Base post-fetch] 2026-05-15 03:16:45.599465 | 2026-05-15 03:16:45.599600 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-15 03:16:45.654051 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:45.659952 | 2026-05-15 03:16:45.660092 | TASK [fetch-output : Set log path for single node] 2026-05-15 03:16:45.749147 | debian-bookworm | ok 2026-05-15 03:16:45.754141 | 2026-05-15 03:16:45.754244 | LOOP [fetch-output : Ensure local output dirs] 2026-05-15 03:16:46.415237 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/5390678b60de4015bf89854eceb30647/work/logs" 2026-05-15 03:16:46.809000 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5390678b60de4015bf89854eceb30647/work/artifacts" 2026-05-15 03:16:47.037928 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5390678b60de4015bf89854eceb30647/work/docs" 2026-05-15 03:16:47.049870 | 2026-05-15 03:16:47.049992 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-15 03:16:47.824143 | debian-bookworm | changed: 2026-05-15 03:16:47.824363 | debian-bookworm | .d..t...... ./ 2026-05-15 03:16:47.824397 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-15 03:16:47.824435 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-15 03:16:47.824467 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-15 03:16:47.824507 | debian-bookworm | changed: All items complete 2026-05-15 03:16:47.824533 | 2026-05-15 03:16:48.490187 | debian-bookworm | changed: .d..t...... ./ 2026-05-15 03:16:49.053917 | debian-bookworm | changed: .d..t...... ./ 2026-05-15 03:16:49.080541 | 2026-05-15 03:16:49.080664 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-15 03:16:49.137779 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:49.145839 | debian-bookworm | skipping: Conditional result was False 2026-05-15 03:16:49.158716 | 2026-05-15 03:16:49.158877 | PLAY RECAP 2026-05-15 03:16:49.158934 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-15 03:16:49.158960 | 2026-05-15 03:16:49.273055 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-15 03:16:49.274041 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-15 03:16:50.821023 | 2026-05-15 03:16:50.821163 | PLAY [Base post] 2026-05-15 03:16:50.851864 | 2026-05-15 03:16:50.855377 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-15 03:16:51.688786 | debian-bookworm | changed 2026-05-15 03:16:51.697286 | 2026-05-15 03:16:51.697378 | PLAY RECAP 2026-05-15 03:16:51.697439 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-15 03:16:51.697498 | 2026-05-15 03:16:52.123540 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-15 03:16:52.124537 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-15 03:16:53.326301 | 2026-05-15 03:16:53.326445 | PLAY [Base post-logs] 2026-05-15 03:16:53.353043 | 2026-05-15 03:16:53.353170 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-15 03:16:53.943223 | localhost | changed 2026-05-15 03:16:53.952344 | 2026-05-15 03:16:53.952469 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-15 03:16:53.981497 | localhost | ok 2026-05-15 03:16:53.994429 | 2026-05-15 03:16:53.994555 | TASK [Set zuul-log-path fact] 2026-05-15 03:16:54.020068 | localhost | ok 2026-05-15 03:16:54.031641 | 2026-05-15 03:16:54.031787 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-15 03:16:54.087019 | localhost | ok 2026-05-15 03:16:54.089983 | 2026-05-15 03:16:54.090090 | TASK [upload-logs : Create log directories] 2026-05-15 03:16:54.775496 | localhost | changed 2026-05-15 03:16:54.778305 | 2026-05-15 03:16:54.778408 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-15 03:16:55.396887 | localhost -> localhost | ok: Runtime: 0:00:00.005783 2026-05-15 03:16:55.400817 | 2026-05-15 03:16:55.400909 | TASK [upload-logs : Upload logs to log server] 2026-05-15 03:16:56.002096 | localhost | Output suppressed because no_log was given 2026-05-15 03:16:56.003744 | 2026-05-15 03:16:56.003829 | LOOP [upload-logs : Compress console log and json output] 2026-05-15 03:16:56.046102 | localhost | skipping: Conditional result was False 2026-05-15 03:16:56.056049 | localhost | skipping: Conditional result was False 2026-05-15 03:16:56.059870 | 2026-05-15 03:16:56.059975 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-15 03:16:56.107224 | localhost | skipping: Conditional result was False 2026-05-15 03:16:56.107529 | 2026-05-15 03:16:56.113346 | localhost | skipping: Conditional result was False 2026-05-15 03:16:56.126596 | 2026-05-15 03:16:56.126727 | LOOP [upload-logs : Upload console log and json output]