2026-05-18 09:43:58.934530 | Job console starting 2026-05-18 09:43:58.956147 | Updating git repos 2026-05-18 09:43:59.005507 | Cloning repos into workspace 2026-05-18 09:43:59.073100 | Restoring repo states 2026-05-18 09:43:59.101238 | Merging changes 2026-05-18 09:43:59.724656 | Checking out repos 2026-05-18 09:43:59.813689 | Preparing playbooks 2026-05-18 09:44:01.600074 | Running Ansible setup 2026-05-18 09:44:08.019203 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-18 09:44:09.327682 | 2026-05-18 09:44:09.327804 | PLAY [Base pre] 2026-05-18 09:44:09.357139 | 2026-05-18 09:44:09.357255 | TASK [Setup log path fact] 2026-05-18 09:44:09.384767 | debian-bookworm | ok 2026-05-18 09:44:09.410076 | 2026-05-18 09:44:09.410200 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 09:44:09.461742 | debian-bookworm | ok 2026-05-18 09:44:09.473517 | 2026-05-18 09:44:09.473617 | TASK [emit-job-header : Print job information] 2026-05-18 09:44:09.541528 | # Job Information 2026-05-18 09:44:09.541681 | Ansible Version: 2.16.14 2026-05-18 09:44:09.541710 | Job: openstack-image-manager-integration-test 2026-05-18 09:44:09.541737 | Pipeline: check 2026-05-18 09:44:09.541755 | Executor: 521e9411259a 2026-05-18 09:44:09.541772 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1207 2026-05-18 09:44:09.541791 | Event ID: 12731b80-529e-11f1-949f-a247c0e75d52 2026-05-18 09:44:09.545814 | 2026-05-18 09:44:09.545909 | LOOP [emit-job-header : Print node information] 2026-05-18 09:44:09.685105 | debian-bookworm | ok: 2026-05-18 09:44:09.685382 | debian-bookworm | # Node Information 2026-05-18 09:44:09.685420 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-18 09:44:09.685446 | debian-bookworm | Hostname: debian 2026-05-18 09:44:09.685470 | debian-bookworm | Username: zuul 2026-05-18 09:44:09.685491 | debian-bookworm | Distro: Debian 12.14 2026-05-18 09:44:09.685515 | debian-bookworm | Provider: regiocloud-a 2026-05-18 09:44:09.685537 | debian-bookworm | Region: 2026-05-18 09:44:09.685559 | debian-bookworm | Label: debian-bookworm 2026-05-18 09:44:09.685579 | debian-bookworm | Product Name: OpenStack Nova 2026-05-18 09:44:09.685598 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe04:300d 2026-05-18 09:44:09.699683 | 2026-05-18 09:44:09.699792 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-18 09:44:10.466533 | debian-bookworm -> localhost | changed 2026-05-18 09:44:10.472456 | 2026-05-18 09:44:10.472541 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-18 09:44:12.492831 | debian-bookworm -> localhost | changed 2026-05-18 09:44:12.501429 | 2026-05-18 09:44:12.501516 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-18 09:44:12.875439 | debian-bookworm -> localhost | ok 2026-05-18 09:44:12.880514 | 2026-05-18 09:44:12.880601 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-18 09:44:12.923578 | debian-bookworm | ok 2026-05-18 09:44:12.973390 | debian-bookworm | included: /var/lib/zuul/builds/2735657e0ad8411686391d879bace7b8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-18 09:44:12.988752 | 2026-05-18 09:44:12.988876 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-18 09:44:16.452226 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-18 09:44:16.452586 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2735657e0ad8411686391d879bace7b8/work/2735657e0ad8411686391d879bace7b8_id_rsa 2026-05-18 09:44:16.452667 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2735657e0ad8411686391d879bace7b8/work/2735657e0ad8411686391d879bace7b8_id_rsa.pub 2026-05-18 09:44:16.452724 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-18 09:44:16.452774 | debian-bookworm -> localhost | SHA256:0zFrfwirgKeM1NSKq4+FwPajvwhYxeR7IuF+HAQT92g zuul-build-sshkey 2026-05-18 09:44:16.452842 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-18 09:44:16.452889 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-18 09:44:16.452952 | debian-bookworm -> localhost | | +.o | 2026-05-18 09:44:16.453000 | debian-bookworm -> localhost | | B o | 2026-05-18 09:44:16.453044 | debian-bookworm -> localhost | | . E . o | 2026-05-18 09:44:16.453085 | debian-bookworm -> localhost | |.. = o . + | 2026-05-18 09:44:16.453126 | debian-bookworm -> localhost | |.o+ = o S = | 2026-05-18 09:44:16.453174 | debian-bookworm -> localhost | |++.* * o + . | 2026-05-18 09:44:16.453217 | debian-bookworm -> localhost | |+ =o* o . o . | 2026-05-18 09:44:16.453261 | debian-bookworm -> localhost | |.+o=.o . . . | 2026-05-18 09:44:16.453311 | debian-bookworm -> localhost | |o==o+ . | 2026-05-18 09:44:16.453395 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-18 09:44:16.453539 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.616006 2026-05-18 09:44:16.465256 | 2026-05-18 09:44:16.465402 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-18 09:44:16.495806 | debian-bookworm | ok 2026-05-18 09:44:16.504264 | debian-bookworm | included: /var/lib/zuul/builds/2735657e0ad8411686391d879bace7b8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-18 09:44:16.512392 | 2026-05-18 09:44:16.512469 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-18 09:44:16.527491 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:16.533066 | 2026-05-18 09:44:16.533153 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-18 09:44:17.216695 | debian-bookworm | changed 2026-05-18 09:44:17.221963 | 2026-05-18 09:44:17.222049 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-18 09:44:17.494285 | debian-bookworm | ok 2026-05-18 09:44:17.505357 | 2026-05-18 09:44:17.505454 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-18 09:44:18.156147 | debian-bookworm | changed 2026-05-18 09:44:18.162770 | 2026-05-18 09:44:18.169086 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-18 09:44:19.074176 | debian-bookworm | changed 2026-05-18 09:44:19.087558 | 2026-05-18 09:44:19.087659 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-18 09:44:19.138650 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:19.144678 | 2026-05-18 09:44:19.144776 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-18 09:44:20.406724 | debian-bookworm -> localhost | changed 2026-05-18 09:44:20.417239 | 2026-05-18 09:44:20.417340 | TASK [add-build-sshkey : Add back temp key] 2026-05-18 09:44:21.400011 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2735657e0ad8411686391d879bace7b8/work/2735657e0ad8411686391d879bace7b8_id_rsa (zuul-build-sshkey) 2026-05-18 09:44:21.400351 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011582 2026-05-18 09:44:21.420210 | 2026-05-18 09:44:21.429436 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-18 09:44:22.238635 | debian-bookworm | ok 2026-05-18 09:44:22.242794 | 2026-05-18 09:44:22.242890 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-18 09:44:22.282362 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:22.301753 | 2026-05-18 09:44:22.301849 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-18 09:44:22.787218 | debian-bookworm | ok 2026-05-18 09:44:22.795868 | 2026-05-18 09:44:22.795962 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-18 09:44:22.841890 | debian-bookworm | ok 2026-05-18 09:44:22.850408 | 2026-05-18 09:44:22.850547 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-18 09:44:23.192611 | debian-bookworm -> localhost | ok 2026-05-18 09:44:23.200467 | 2026-05-18 09:44:23.200585 | TASK [validate-host : Collect information about the host] 2026-05-18 09:44:24.475251 | debian-bookworm | ok 2026-05-18 09:44:24.492835 | 2026-05-18 09:44:24.493015 | TASK [validate-host : Sanitize hostname] 2026-05-18 09:44:24.644782 | debian-bookworm | ok 2026-05-18 09:44:24.712790 | 2026-05-18 09:44:24.712900 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-18 09:44:25.685279 | debian-bookworm -> localhost | changed 2026-05-18 09:44:25.692360 | 2026-05-18 09:44:25.692508 | TASK [validate-host : Collect information about zuul worker] 2026-05-18 09:44:26.109060 | debian-bookworm | ok 2026-05-18 09:44:26.113687 | 2026-05-18 09:44:26.113792 | TASK [validate-host : Write out all zuul information for each host] 2026-05-18 09:44:26.914622 | debian-bookworm -> localhost | changed 2026-05-18 09:44:26.946279 | 2026-05-18 09:44:26.946381 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-18 09:44:27.259708 | debian-bookworm | ok 2026-05-18 09:44:27.266904 | 2026-05-18 09:44:27.267021 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-18 09:44:28.214191 | debian-bookworm | changed: 2026-05-18 09:44:28.214449 | debian-bookworm | cd+++++++++ src/ 2026-05-18 09:44:28.214501 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-18 09:44:28.214534 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-18 09:44:28.214628 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-18 09:44:28.214659 | debian-bookworm | =7.0.3 2026-05-18 09:44:52.151449 | debian-bookworm | Downloading cachetools-7.1.2-py3-none-any.whl (16 kB) 2026-05-18 09:44:52.207988 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-18 09:44:52.220345 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-18 09:44:52.294933 | debian-bookworm | Collecting filelock>=3.25 2026-05-18 09:44:52.306892 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-18 09:44:52.357905 | debian-bookworm | Collecting packaging>=26 2026-05-18 09:44:52.370073 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-18 09:44:52.382102 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 10.9 MB/s eta 0:00:00 2026-05-18 09:44:52.453044 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-18 09:44:52.465521 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-05-18 09:44:52.507565 | debian-bookworm | Collecting pluggy>=1.6 2026-05-18 09:44:52.519040 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-18 09:44:52.559259 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-18 09:44:52.571501 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-18 09:44:52.614677 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-18 09:44:52.626580 | debian-bookworm | Downloading python_discovery-1.3.1-py3-none-any.whl (33 kB) 2026-05-18 09:44:52.670125 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-18 09:44:52.682813 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-18 09:44:52.848453 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-18 09:44:52.859588 | debian-bookworm | Downloading virtualenv-21.3.3-py3-none-any.whl (7.6 MB) 2026-05-18 09:44:53.205648 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 22.3 MB/s eta 0:00:00 2026-05-18 09:44:53.312043 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-18 09:44:53.323678 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-18 09:44:53.356303 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 17.7 MB/s eta 0:00:00 2026-05-18 09:44:53.480814 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-18 09:44:54.290874 | debian-bookworm | Successfully installed cachetools-7.1.2 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-18 09:44:54.883161 | debian-bookworm | ok: Runtime: 0:00:03.166027 2026-05-18 09:44:54.895118 | 2026-05-18 09:44:54.895231 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-18 09:44:54.937083 | debian-bookworm | ok 2026-05-18 09:44:54.943096 | 2026-05-18 09:44:54.943193 | TASK [ensure-tox : Output tox version] 2026-05-18 09:44:55.567208 | 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-18 09:44:55.585014 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-18 09:44:56.004363 | debian-bookworm | ok: Runtime: 0:00:00.339722 2026-05-18 09:44:56.010193 | 2026-05-18 09:44:56.010291 | TASK [ensure-tox : Make global symlink] 2026-05-18 09:44:56.045203 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:56.061120 | 2026-05-18 09:44:56.061349 | LOOP [Install dependencies] 2026-05-18 09:44:56.099755 | debian-bookworm | ok: "ensure-python" 2026-05-18 09:44:56.100008 | debian-bookworm | ok: All items complete 2026-05-18 09:44:56.100041 | 2026-05-18 09:44:56.119157 | debian-bookworm | ok: "ensure-pip" 2026-05-18 09:44:56.203349 | 2026-05-18 09:44:56.203467 | TASK [ensure-python : Validate python_version value] 2026-05-18 09:44:56.255692 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:56.264662 | 2026-05-18 09:44:56.264883 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-05-18 09:44:56.298774 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:56.306913 | 2026-05-18 09:44:56.307055 | TASK [ensure-python : Pull in venv package] 2026-05-18 09:44:56.353227 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:56.359860 | 2026-05-18 09:44:56.359966 | TASK [ensure-python : Set default RPM package name] 2026-05-18 09:44:56.424394 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:56.431676 | 2026-05-18 09:44:56.431786 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-05-18 09:44:56.478155 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:56.484230 | 2026-05-18 09:44:56.484335 | TASK [ensure-python : Install RPM package] 2026-05-18 09:44:56.508216 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:56.522541 | 2026-05-18 09:44:56.522658 | TASK [ensure-python : Install python using pyenv] 2026-05-18 09:44:56.559148 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:56.568225 | 2026-05-18 09:44:56.568338 | TASK [ensure-python : Activate python using stow] 2026-05-18 09:44:56.591657 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:56.601908 | 2026-05-18 09:44:56.602035 | TASK [ensure-pip : Check if pip is installed] 2026-05-18 09:44:57.017789 | debian-bookworm | /usr/bin/pip3 2026-05-18 09:44:57.060514 | debian-bookworm | usage: __main__.py [-h] {unpack,pack,convert,version,help} ... 2026-05-18 09:44:57.060572 | debian-bookworm | 2026-05-18 09:44:57.060590 | debian-bookworm | positional arguments: 2026-05-18 09:44:57.060601 | debian-bookworm | {unpack,pack,convert,version,help} 2026-05-18 09:44:57.060611 | debian-bookworm | commands 2026-05-18 09:44:57.060622 | debian-bookworm | unpack Unpack wheel 2026-05-18 09:44:57.060647 | debian-bookworm | pack Repack wheel 2026-05-18 09:44:57.060729 | debian-bookworm | convert Convert egg or wininst to wheel 2026-05-18 09:44:57.060743 | debian-bookworm | version Print version and exit 2026-05-18 09:44:57.060756 | debian-bookworm | help Show this help 2026-05-18 09:44:57.060764 | debian-bookworm | 2026-05-18 09:44:57.060771 | debian-bookworm | options: 2026-05-18 09:44:57.060781 | debian-bookworm | -h, --help show this help message and exit 2026-05-18 09:44:57.148303 | debian-bookworm | ok: Runtime: 0:00:00.062534 2026-05-18 09:44:57.159832 | 2026-05-18 09:44:57.159933 | LOOP [ensure-pip : Install pip from packages] 2026-05-18 09:44:57.237346 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:57.256066 | 2026-05-18 09:44:57.256186 | TASK [ensure-pip : Ensure setuptools] 2026-05-18 09:44:57.299851 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:57.305834 | 2026-05-18 09:44:57.305934 | TASK [ensure-pip : Check for ensurepip module] 2026-05-18 09:44:57.726896 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-05-18 09:44:57.727065 | debian-bookworm | [--altinstall] [--default-pip] 2026-05-18 09:44:57.727085 | debian-bookworm | 2026-05-18 09:44:57.727100 | debian-bookworm | options: 2026-05-18 09:44:57.727115 | debian-bookworm | -h, --help show this help message and exit 2026-05-18 09:44:57.727134 | debian-bookworm | --version Show the version of pip that is bundled with this Python. 2026-05-18 09:44:57.727147 | debian-bookworm | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-05-18 09:44:57.727185 | debian-bookworm | times. 2026-05-18 09:44:57.727208 | debian-bookworm | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-05-18 09:44:57.727221 | debian-bookworm | --user Install using the user scheme. 2026-05-18 09:44:57.727233 | debian-bookworm | --root ROOT Install everything relative to this alternate root directory. 2026-05-18 09:44:57.727244 | debian-bookworm | --altinstall Make an alternate install, installing only the X.Y versioned 2026-05-18 09:44:57.727254 | debian-bookworm | scripts (Default: pipX, pipX.Y, easy_install-X.Y). 2026-05-18 09:44:57.727264 | debian-bookworm | --default-pip Make a default pip install, installing the unqualified pip 2026-05-18 09:44:57.727274 | debian-bookworm | and easy_install in addition to the versioned scripts. 2026-05-18 09:44:57.880313 | debian-bookworm | ok: Runtime: 0:00:00.065250 2026-05-18 09:44:57.886059 | 2026-05-18 09:44:57.886159 | TASK [ensure-pip : Ensure python3-venv] 2026-05-18 09:44:57.929976 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:57.936278 | 2026-05-18 09:44:57.936385 | TASK [ensure-pip : Install pip from source] 2026-05-18 09:44:57.959883 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:44:57.966265 | 2026-05-18 09:44:57.966373 | TASK [ensure-pip : Probe for venv python full path] 2026-05-18 09:44:58.324225 | debian-bookworm | /usr/bin/python3 2026-05-18 09:44:58.516052 | debian-bookworm | ok: Runtime: 0:00:00.009087 2026-05-18 09:44:58.520638 | 2026-05-18 09:44:58.520724 | TASK [ensure-pip : Set host default] 2026-05-18 09:44:58.618808 | debian-bookworm | ok 2026-05-18 09:44:58.623115 | 2026-05-18 09:44:58.623194 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-05-18 09:44:58.712465 | debian-bookworm | ok 2026-05-18 09:44:58.720292 | 2026-05-18 09:44:58.720378 | LOOP [devstack : Create /opt/stack directories] 2026-05-18 09:44:59.227857 | debian-bookworm | changed: "/opt/stack" 2026-05-18 09:44:59.228103 | 2026-05-18 09:44:59.510664 | debian-bookworm | changed: "/opt/stack/data" 2026-05-18 09:44:59.810595 | debian-bookworm | changed: "/opt/stack/logs" 2026-05-18 09:45:00.109235 | debian-bookworm | changed: "/opt/stack/status" 2026-05-18 09:45:00.115862 | 2026-05-18 09:45:00.115961 | TASK [devstack : Run preparations] 2026-05-18 09:45:00.574812 | debian-bookworm | + set -e 2026-05-18 09:45:00.574943 | debian-bookworm | + git clone --branch stable/2025.1 https://opendev.org/openstack/devstack.git 2026-05-18 09:45:00.590897 | debian-bookworm | Cloning into 'devstack'... 2026-05-18 09:47:11.637184 | debian-bookworm | fatal: unable to access 'https://opendev.org/openstack/devstack.git/': Failed to connect to opendev.org port 443 after 130988 ms: Couldn't connect to server 2026-05-18 09:47:11.811357 | debian-bookworm | ERROR 2026-05-18 09:47:11.811692 | debian-bookworm | { 2026-05-18 09:47:11.811759 | debian-bookworm | "delta": "0:02:11.079262", 2026-05-18 09:47:11.811804 | debian-bookworm | "end": "2026-05-18 09:47:11.645538", 2026-05-18 09:47:11.811842 | debian-bookworm | "msg": "non-zero return code", 2026-05-18 09:47:11.811877 | debian-bookworm | "rc": 128, 2026-05-18 09:47:11.811911 | debian-bookworm | "start": "2026-05-18 09:45:00.566276" 2026-05-18 09:47:11.811944 | debian-bookworm | } failure 2026-05-18 09:47:11.814799 | 2026-05-18 09:47:11.815033 | PLAY RECAP 2026-05-18 09:47:11.815127 | debian-bookworm | ok: 19 changed: 13 unreachable: 0 failed: 1 skipped: 18 rescued: 0 ignored: 0 2026-05-18 09:47:11.815167 | 2026-05-18 09:47:11.976208 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openstack-image-manager/playbooks/pre-integration-test.yml@main] 2026-05-18 09:47:11.977161 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 09:47:12.749183 | 2026-05-18 09:47:12.749427 | PLAY [Base post-fetch] 2026-05-18 09:47:12.768344 | 2026-05-18 09:47:12.768575 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-18 09:47:12.824853 | debian-bookworm | skipping: Conditional result was False 2026-05-18 09:47:12.831020 | 2026-05-18 09:47:12.831194 | TASK [fetch-output : Set log path for single node] 2026-05-18 09:47:12.894659 | debian-bookworm | ok 2026-05-18 09:47:12.901628 | 2026-05-18 09:47:12.901784 | LOOP [fetch-output : Ensure local output dirs] 2026-05-18 09:47:13.431382 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/2735657e0ad8411686391d879bace7b8/work/logs" 2026-05-18 09:47:13.766486 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2735657e0ad8411686391d879bace7b8/work/artifacts" 2026-05-18 09:47:14.030782 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2735657e0ad8411686391d879bace7b8/work/docs" 2026-05-18 09:47:14.053246 | 2026-05-18 09:47:14.053411 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-18 09:47:14.918871 | debian-bookworm | changed: 2026-05-18 09:47:14.919192 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-18 09:47:14.919252 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-18 09:47:14.919301 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-18 09:47:14.919372 | debian-bookworm | changed: All items complete 2026-05-18 09:47:14.919416 | 2026-05-18 09:47:15.575612 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 09:47:16.165955 | debian-bookworm | changed: .d..t...... ./ 2026-05-18 09:47:16.181567 | 2026-05-18 09:47:16.181728 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-18 09:47:16.784487 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006536 2026-05-18 09:47:17.089673 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009787 2026-05-18 09:47:17.105246 | 2026-05-18 09:47:17.105368 | PLAY RECAP 2026-05-18 09:47:17.105427 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-18 09:47:17.105455 | 2026-05-18 09:47:17.252948 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-18 09:47:17.254220 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 09:47:18.161431 | 2026-05-18 09:47:18.161666 | PLAY [Base post] 2026-05-18 09:47:18.190169 | 2026-05-18 09:47:18.190393 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-18 09:47:18.725672 | debian-bookworm | changed 2026-05-18 09:47:18.732413 | 2026-05-18 09:47:18.732565 | PLAY RECAP 2026-05-18 09:47:18.732633 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-18 09:47:18.732697 | 2026-05-18 09:47:18.872692 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-18 09:47:18.873541 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-18 09:47:19.732987 | 2026-05-18 09:47:19.733195 | PLAY [Base post-logs] 2026-05-18 09:47:19.744306 | 2026-05-18 09:47:19.744440 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-18 09:47:20.240120 | localhost | changed 2026-05-18 09:47:20.253042 | 2026-05-18 09:47:20.253267 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-18 09:47:20.281686 | localhost | ok 2026-05-18 09:47:20.285362 | 2026-05-18 09:47:20.285477 | TASK [Set zuul-log-path fact] 2026-05-18 09:47:20.313855 | localhost | ok 2026-05-18 09:47:20.328788 | 2026-05-18 09:47:20.329042 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-18 09:47:20.369085 | localhost | ok 2026-05-18 09:47:20.375859 | 2026-05-18 09:47:20.376051 | TASK [upload-logs : Create log directories] 2026-05-18 09:47:20.952129 | localhost | changed 2026-05-18 09:47:20.955343 | 2026-05-18 09:47:20.955460 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-18 09:47:21.503217 | localhost -> localhost | ok: Runtime: 0:00:00.011662 2026-05-18 09:47:21.507836 | 2026-05-18 09:47:21.507967 | TASK [upload-logs : Upload logs to log server] 2026-05-18 09:47:22.122445 | localhost | Output suppressed because no_log was given 2026-05-18 09:47:22.124423 | 2026-05-18 09:47:22.124534 | LOOP [upload-logs : Compress console log and json output] 2026-05-18 09:47:22.173734 | localhost | skipping: Conditional result was False 2026-05-18 09:47:22.179375 | localhost | skipping: Conditional result was False 2026-05-18 09:47:22.189149 | 2026-05-18 09:47:22.189336 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-18 09:47:22.237625 | localhost | skipping: Conditional result was False 2026-05-18 09:47:22.238106 | 2026-05-18 09:47:22.241885 | localhost | skipping: Conditional result was False 2026-05-18 09:47:22.253147 | 2026-05-18 09:47:22.253315 | LOOP [upload-logs : Upload console log and json output]