2026-08-25 03:16:48.670000 | Job console starting 2026-08-25 03:16:48.685865 | Updating git repos 2026-08-25 03:16:48.713641 | Cloning repos into workspace 2026-08-25 03:16:48.778553 | Restoring repo states 2026-08-25 03:16:48.833569 | Merging changes 2026-08-25 03:16:48.833595 | Checking out repos 2026-08-25 03:16:48.918096 | Preparing playbooks 2026-08-25 03:16:50.082167 | Running Ansible setup 2026-08-25 03:16:55.568232 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-25 03:16:56.542274 | 2026-08-25 03:16:56.542420 | PLAY [Base pre] 2026-08-25 03:16:56.559291 | 2026-08-25 03:16:56.559421 | TASK [Setup log path fact] 2026-08-25 03:16:56.578512 | debian-bookworm | ok 2026-08-25 03:16:56.594619 | 2026-08-25 03:16:56.594739 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-25 03:16:56.633532 | debian-bookworm | ok 2026-08-25 03:16:56.643053 | 2026-08-25 03:16:56.643145 | TASK [emit-job-header : Print job information] 2026-08-25 03:16:56.681713 | # Job Information 2026-08-25 03:16:56.681874 | Ansible Version: 2.16.14 2026-08-25 03:16:56.681909 | Job: openstack-image-manager-integration-test 2026-08-25 03:16:56.681943 | Pipeline: periodic-daily 2026-08-25 03:16:56.681966 | Executor: 521e9411259a 2026-08-25 03:16:56.681986 | Triggered by: https://github.com/osism/openstack-image-manager 2026-08-25 03:16:56.682008 | Event ID: 9e4fde8f0fd84b8dbe31fa8149dae6d5 2026-08-25 03:16:56.686771 | 2026-08-25 03:16:56.686876 | LOOP [emit-job-header : Print node information] 2026-08-25 03:16:56.812776 | debian-bookworm | ok: 2026-08-25 03:16:56.815148 | debian-bookworm | # Node Information 2026-08-25 03:16:56.815214 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-25 03:16:56.815238 | debian-bookworm | Hostname: debian 2026-08-25 03:16:56.815257 | debian-bookworm | Username: zuul 2026-08-25 03:16:56.815275 | debian-bookworm | Distro: Debian 12.15 2026-08-25 03:16:56.815294 | debian-bookworm | Provider: regiocloud-a 2026-08-25 03:16:56.815311 | debian-bookworm | Region: 2026-08-25 03:16:56.815329 | debian-bookworm | Label: debian-bookworm 2026-08-25 03:16:56.815346 | debian-bookworm | Product Name: OpenStack Nova 2026-08-25 03:16:56.815362 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe07:ec31 2026-08-25 03:16:56.833093 | 2026-08-25 03:16:56.833935 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-25 03:16:57.483137 | debian-bookworm -> localhost | changed 2026-08-25 03:16:57.492727 | 2026-08-25 03:16:57.492834 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-25 03:16:58.690057 | debian-bookworm -> localhost | changed 2026-08-25 03:16:58.723529 | 2026-08-25 03:16:58.723647 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-25 03:16:59.463282 | debian-bookworm -> localhost | ok 2026-08-25 03:16:59.471343 | 2026-08-25 03:16:59.471499 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-25 03:16:59.501678 | debian-bookworm | ok 2026-08-25 03:16:59.531191 | debian-bookworm | included: /var/lib/zuul/builds/5107b5a1675046efbacd7fc1eeec2aea/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-25 03:16:59.544150 | 2026-08-25 03:16:59.544339 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-25 03:17:01.420012 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-25 03:17:01.420232 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5107b5a1675046efbacd7fc1eeec2aea/work/5107b5a1675046efbacd7fc1eeec2aea_id_rsa 2026-08-25 03:17:01.420272 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5107b5a1675046efbacd7fc1eeec2aea/work/5107b5a1675046efbacd7fc1eeec2aea_id_rsa.pub 2026-08-25 03:17:01.420300 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-25 03:17:01.420323 | debian-bookworm -> localhost | SHA256:dGJqd7Bps1cFtnEuBGACTJAbnUR5WD8Ub2WYbdZkmaU zuul-build-sshkey 2026-08-25 03:17:01.420355 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-25 03:17:01.420393 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-25 03:17:01.420418 | debian-bookworm -> localhost | | .O=*o =o.=Bo++.| 2026-08-25 03:17:01.420440 | debian-bookworm -> localhost | | o * .= .o=+B+. | 2026-08-25 03:17:01.420461 | debian-bookworm -> localhost | | o . B +oo E | 2026-08-25 03:17:01.420481 | debian-bookworm -> localhost | | . + O o | 2026-08-25 03:17:01.420501 | debian-bookworm -> localhost | | o S . . | 2026-08-25 03:17:01.420525 | debian-bookworm -> localhost | | . o + . | 2026-08-25 03:17:01.420546 | debian-bookworm -> localhost | | . . | 2026-08-25 03:17:01.420566 | debian-bookworm -> localhost | | . | 2026-08-25 03:17:01.420586 | debian-bookworm -> localhost | | | 2026-08-25 03:17:01.420606 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-25 03:17:01.420652 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.003936 2026-08-25 03:17:01.427161 | 2026-08-25 03:17:01.427257 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-25 03:17:01.476263 | debian-bookworm | ok 2026-08-25 03:17:01.492420 | debian-bookworm | included: /var/lib/zuul/builds/5107b5a1675046efbacd7fc1eeec2aea/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-25 03:17:01.511527 | 2026-08-25 03:17:01.511630 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-25 03:17:01.548065 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:01.554569 | 2026-08-25 03:17:01.554667 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-25 03:17:02.241061 | debian-bookworm | changed 2026-08-25 03:17:02.247925 | 2026-08-25 03:17:02.248023 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-25 03:17:02.472883 | debian-bookworm | ok 2026-08-25 03:17:02.478970 | 2026-08-25 03:17:02.479065 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-25 03:17:03.053998 | debian-bookworm | changed 2026-08-25 03:17:03.060330 | 2026-08-25 03:17:03.060439 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-25 03:17:03.720824 | debian-bookworm | changed 2026-08-25 03:17:03.726420 | 2026-08-25 03:17:03.726509 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-25 03:17:03.750411 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:03.756467 | 2026-08-25 03:17:03.756554 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-25 03:17:04.192029 | debian-bookworm -> localhost | changed 2026-08-25 03:17:04.200778 | 2026-08-25 03:17:04.200865 | TASK [add-build-sshkey : Add back temp key] 2026-08-25 03:17:04.543988 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5107b5a1675046efbacd7fc1eeec2aea/work/5107b5a1675046efbacd7fc1eeec2aea_id_rsa (zuul-build-sshkey) 2026-08-25 03:17:04.544182 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.036222 2026-08-25 03:17:04.551131 | 2026-08-25 03:17:04.551213 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-25 03:17:05.003033 | debian-bookworm | ok 2026-08-25 03:17:05.016158 | 2026-08-25 03:17:05.016261 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-25 03:17:05.049702 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:05.061891 | 2026-08-25 03:17:05.061989 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-25 03:17:05.557348 | debian-bookworm | ok 2026-08-25 03:17:05.578323 | 2026-08-25 03:17:05.578455 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-25 03:17:05.627545 | debian-bookworm | ok 2026-08-25 03:17:05.633543 | 2026-08-25 03:17:05.633639 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-25 03:17:05.973734 | debian-bookworm -> localhost | ok 2026-08-25 03:17:05.989094 | 2026-08-25 03:17:05.989501 | TASK [validate-host : Collect information about the host] 2026-08-25 03:17:07.153855 | debian-bookworm | ok 2026-08-25 03:17:07.166310 | 2026-08-25 03:17:07.166450 | TASK [validate-host : Sanitize hostname] 2026-08-25 03:17:07.347171 | debian-bookworm | ok 2026-08-25 03:17:07.353161 | 2026-08-25 03:17:07.353298 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-25 03:17:07.978571 | debian-bookworm -> localhost | changed 2026-08-25 03:17:07.986812 | 2026-08-25 03:17:07.986981 | TASK [validate-host : Collect information about zuul worker] 2026-08-25 03:17:08.435903 | debian-bookworm | ok 2026-08-25 03:17:08.442219 | 2026-08-25 03:17:08.442347 | TASK [validate-host : Write out all zuul information for each host] 2026-08-25 03:17:09.120635 | debian-bookworm -> localhost | changed 2026-08-25 03:17:09.131997 | 2026-08-25 03:17:09.132135 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-25 03:17:09.438040 | debian-bookworm | ok 2026-08-25 03:17:09.447051 | 2026-08-25 03:17:09.447211 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-25 03:17:10.416785 | debian-bookworm | changed: 2026-08-25 03:17:10.417065 | debian-bookworm | cd+++++++++ src/ 2026-08-25 03:17:10.417201 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-25 03:17:10.417234 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-25 03:17:10.417266 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-08-25 03:17:10.417288 | debian-bookworm | =7.0.3 2026-08-25 03:17:44.777325 | debian-bookworm | Downloading cachetools-7.1.7-py3-none-any.whl (16 kB) 2026-08-25 03:17:44.839748 | debian-bookworm | Collecting colorama>=0.4.6 2026-08-25 03:17:44.853931 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-08-25 03:17:44.927333 | debian-bookworm | Collecting filelock>=3.25 2026-08-25 03:17:44.941319 | debian-bookworm | Downloading filelock-3.32.4-py3-none-any.whl (99 kB) 2026-08-25 03:17:44.949226 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 99.9/99.9 kB 17.2 MB/s eta 0:00:00 2026-08-25 03:17:45.012801 | debian-bookworm | Collecting packaging>=26 2026-08-25 03:17:45.026477 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-08-25 03:17:45.035323 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 20.2 MB/s eta 0:00:00 2026-08-25 03:17:45.109085 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-08-25 03:17:45.123838 | debian-bookworm | Downloading platformdirs-4.11.4-py3-none-any.whl (23 kB) 2026-08-25 03:17:45.189871 | debian-bookworm | Collecting pluggy>=1.6 2026-08-25 03:17:45.204280 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-08-25 03:17:45.268366 | debian-bookworm | Collecting pyproject-api>=1.10 2026-08-25 03:17:45.283620 | debian-bookworm | Downloading pyproject_api-1.11.0-py3-none-any.whl (13 kB) 2026-08-25 03:17:45.338079 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-08-25 03:17:45.352742 | debian-bookworm | Downloading python_discovery-1.5.3-py3-none-any.whl (38 kB) 2026-08-25 03:17:45.402027 | debian-bookworm | Collecting tomli-w>=1.2 2026-08-25 03:17:45.416682 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-08-25 03:17:45.482650 | debian-bookworm | Collecting typing-extensions>=4.15 2026-08-25 03:17:45.496603 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-08-25 03:17:45.503867 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 7.7 MB/s eta 0:00:00 2026-08-25 03:17:45.643157 | debian-bookworm | Collecting virtualenv>=21.1 2026-08-25 03:17:45.657176 | debian-bookworm | Downloading virtualenv-21.7.4-py3-none-any.whl (5.3 MB) 2026-08-25 03:17:45.772571 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.3/5.3 MB 48.2 MB/s eta 0:00:00 2026-08-25 03:17:45.860972 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-08-25 03:17:45.874614 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-08-25 03:17:45.900135 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 23.6 MB/s eta 0:00:00 2026-08-25 03:17:46.008061 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-08-25 03:17:46.847092 | debian-bookworm | Successfully installed cachetools-7.1.7 colorama-0.4.6 distlib-0.4.3 filelock-3.32.4 packaging-26.3 platformdirs-4.11.4 pluggy-1.6.0 pyproject-api-1.11.0 python-discovery-1.5.3 tomli-w-1.2.0 tox-4.60.0 typing-extensions-4.16.0 virtualenv-21.7.4 2026-08-25 03:17:47.209028 | debian-bookworm | ok: Runtime: 0:00:03.007330 2026-08-25 03:17:47.216620 | 2026-08-25 03:17:47.216764 | TASK [ensure-tox : Export installed tox_executable path] 2026-08-25 03:17:47.304913 | debian-bookworm | ok 2026-08-25 03:17:47.323751 | 2026-08-25 03:17:47.323960 | TASK [ensure-tox : Output tox version] 2026-08-25 03:17:47.886593 | 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-08-25 03:17:47.904985 | debian-bookworm | 4.60.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-08-25 03:17:48.380708 | debian-bookworm | ok: Runtime: 0:00:00.325788 2026-08-25 03:17:48.387639 | 2026-08-25 03:17:48.387751 | TASK [ensure-tox : Make global symlink] 2026-08-25 03:17:48.471303 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:48.483262 | 2026-08-25 03:17:48.483427 | LOOP [Install dependencies] 2026-08-25 03:17:48.587072 | debian-bookworm | ok: "ensure-python" 2026-08-25 03:17:48.587304 | debian-bookworm | ok: All items complete 2026-08-25 03:17:48.587361 | 2026-08-25 03:17:48.592039 | debian-bookworm | ok: "ensure-pip" 2026-08-25 03:17:48.667663 | 2026-08-25 03:17:48.667813 | TASK [ensure-python : Validate python_version value] 2026-08-25 03:17:48.747200 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:48.757550 | 2026-08-25 03:17:48.757742 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-08-25 03:17:48.814004 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:48.822346 | 2026-08-25 03:17:48.822519 | TASK [ensure-python : Pull in venv package] 2026-08-25 03:17:48.879637 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:48.887492 | 2026-08-25 03:17:48.887651 | TASK [ensure-python : Set default RPM package name] 2026-08-25 03:17:48.925676 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:48.937841 | 2026-08-25 03:17:48.938063 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-08-25 03:17:49.056090 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:49.063765 | 2026-08-25 03:17:49.063960 | TASK [ensure-python : Install RPM package] 2026-08-25 03:17:49.174194 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:49.181477 | 2026-08-25 03:17:49.183679 | TASK [ensure-python : Install python using pyenv] 2026-08-25 03:17:49.217518 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:49.227226 | 2026-08-25 03:17:49.227653 | TASK [ensure-python : Activate python using stow] 2026-08-25 03:17:49.297835 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:49.330018 | 2026-08-25 03:17:49.330596 | TASK [ensure-pip : Check if pip is installed] 2026-08-25 03:17:49.831519 | debian-bookworm | /usr/bin/pip3 2026-08-25 03:17:49.861683 | debian-bookworm | usage: __main__.py [-h] {unpack,pack,convert,version,help} ... 2026-08-25 03:17:49.861719 | debian-bookworm | 2026-08-25 03:17:49.861729 | debian-bookworm | positional arguments: 2026-08-25 03:17:49.861734 | debian-bookworm | {unpack,pack,convert,version,help} 2026-08-25 03:17:49.861740 | debian-bookworm | commands 2026-08-25 03:17:49.861745 | debian-bookworm | unpack Unpack wheel 2026-08-25 03:17:49.861817 | debian-bookworm | pack Repack wheel 2026-08-25 03:17:49.861829 | debian-bookworm | convert Convert egg or wininst to wheel 2026-08-25 03:17:49.861834 | debian-bookworm | version Print version and exit 2026-08-25 03:17:49.861841 | debian-bookworm | help Show this help 2026-08-25 03:17:49.861846 | debian-bookworm | 2026-08-25 03:17:49.861850 | debian-bookworm | options: 2026-08-25 03:17:49.861855 | debian-bookworm | -h, --help show this help message and exit 2026-08-25 03:17:49.960805 | debian-bookworm | ok: Runtime: 0:00:00.042593 2026-08-25 03:17:49.968087 | 2026-08-25 03:17:49.968224 | LOOP [ensure-pip : Install pip from packages] 2026-08-25 03:17:50.018017 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:50.026199 | 2026-08-25 03:17:50.026362 | TASK [ensure-pip : Ensure setuptools] 2026-08-25 03:17:50.085905 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:50.093220 | 2026-08-25 03:17:50.093399 | TASK [ensure-pip : Check for ensurepip module] 2026-08-25 03:17:50.436058 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-08-25 03:17:50.436228 | debian-bookworm | [--altinstall] [--default-pip] 2026-08-25 03:17:50.436252 | debian-bookworm | 2026-08-25 03:17:50.436268 | debian-bookworm | options: 2026-08-25 03:17:50.436286 | debian-bookworm | -h, --help show this help message and exit 2026-08-25 03:17:50.436306 | debian-bookworm | --version Show the version of pip that is bundled with this Python. 2026-08-25 03:17:50.436320 | debian-bookworm | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-08-25 03:17:50.436365 | debian-bookworm | times. 2026-08-25 03:17:50.436391 | debian-bookworm | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-08-25 03:17:50.436406 | debian-bookworm | --user Install using the user scheme. 2026-08-25 03:17:50.436423 | debian-bookworm | --root ROOT Install everything relative to this alternate root directory. 2026-08-25 03:17:50.436435 | debian-bookworm | --altinstall Make an alternate install, installing only the X.Y versioned 2026-08-25 03:17:50.436446 | debian-bookworm | scripts (Default: pipX, pipX.Y, easy_install-X.Y). 2026-08-25 03:17:50.436457 | debian-bookworm | --default-pip Make a default pip install, installing the unqualified pip 2026-08-25 03:17:50.436468 | debian-bookworm | and easy_install in addition to the versioned scripts. 2026-08-25 03:17:50.646313 | debian-bookworm | ok: Runtime: 0:00:00.071501 2026-08-25 03:17:50.652465 | 2026-08-25 03:17:50.652566 | TASK [ensure-pip : Ensure python3-venv] 2026-08-25 03:17:50.687666 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:50.713923 | 2026-08-25 03:17:50.715115 | TASK [ensure-pip : Install pip from source] 2026-08-25 03:17:50.736459 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:17:50.744354 | 2026-08-25 03:17:50.744485 | TASK [ensure-pip : Probe for venv python full path] 2026-08-25 03:17:51.047298 | debian-bookworm | /usr/bin/python3 2026-08-25 03:17:51.289407 | debian-bookworm | ok: Runtime: 0:00:00.005869 2026-08-25 03:17:51.300615 | 2026-08-25 03:17:51.300752 | TASK [ensure-pip : Set host default] 2026-08-25 03:17:51.355139 | debian-bookworm | ok 2026-08-25 03:17:51.360439 | 2026-08-25 03:17:51.360534 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-08-25 03:17:51.420179 | debian-bookworm | ok 2026-08-25 03:17:51.436020 | 2026-08-25 03:17:51.436142 | LOOP [devstack : Create /opt/stack directories] 2026-08-25 03:17:51.962051 | debian-bookworm | changed: "/opt/stack" 2026-08-25 03:17:51.962370 | 2026-08-25 03:17:52.204765 | debian-bookworm | changed: "/opt/stack/data" 2026-08-25 03:17:52.439837 | debian-bookworm | changed: "/opt/stack/logs" 2026-08-25 03:17:52.651905 | debian-bookworm | changed: "/opt/stack/status" 2026-08-25 03:17:52.669567 | 2026-08-25 03:17:52.669678 | TASK [devstack : Run preparations] 2026-08-25 03:17:52.923564 | debian-bookworm | + set -e 2026-08-25 03:17:52.923653 | debian-bookworm | + git clone --branch stable/2025.1 https://opendev.org/openstack/devstack.git 2026-08-25 03:17:52.938158 | debian-bookworm | Cloning into 'devstack'... 2026-08-25 03:17:53.697762 | debian-bookworm | fatal: unable to access 'https://opendev.org/openstack/devstack.git/': The requested URL returned error: 503 2026-08-25 03:17:54.226487 | debian-bookworm | ERROR 2026-08-25 03:17:54.226681 | debian-bookworm | { 2026-08-25 03:17:54.226717 | debian-bookworm | "delta": "0:00:00.784092", 2026-08-25 03:17:54.226741 | debian-bookworm | "end": "2026-08-25 03:17:53.704138", 2026-08-25 03:17:54.226761 | debian-bookworm | "msg": "non-zero return code", 2026-08-25 03:17:54.226780 | debian-bookworm | "rc": 128, 2026-08-25 03:17:54.226798 | debian-bookworm | "start": "2026-08-25 03:17:52.920046" 2026-08-25 03:17:54.226816 | debian-bookworm | } failure 2026-08-25 03:17:54.230551 | 2026-08-25 03:17:54.230627 | PLAY RECAP 2026-08-25 03:17:54.230682 | debian-bookworm | ok: 19 changed: 13 unreachable: 0 failed: 1 skipped: 18 rescued: 0 ignored: 0 2026-08-25 03:17:54.230708 | 2026-08-25 03:17:54.372395 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openstack-image-manager/playbooks/pre-integration-test.yml@main] 2026-08-25 03:17:54.373246 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-25 03:17:55.219809 | 2026-08-25 03:17:55.219949 | PLAY [Base post-fetch] 2026-08-25 03:17:55.235120 | 2026-08-25 03:17:55.235247 | TASK [diagnose-network : Ensure log directory exists] 2026-08-25 03:17:55.651921 | debian-bookworm | ok 2026-08-25 03:17:55.679681 | 2026-08-25 03:17:55.679865 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-08-25 03:18:07.781409 | debian-bookworm | ok: Runtime: 0:00:05.853187 2026-08-25 03:18:07.789155 | 2026-08-25 03:18:07.789297 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-08-25 03:18:13.718460 | debian-bookworm | ok: Runtime: 0:00:00.009325 2026-08-25 03:18:13.727052 | 2026-08-25 03:18:13.727489 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-08-25 03:18:19.688465 | debian-bookworm | ok: Runtime: 0:00:00.008546 2026-08-25 03:18:19.709124 | 2026-08-25 03:18:19.709280 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-25 03:18:19.765948 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:18:19.775534 | 2026-08-25 03:18:19.775710 | TASK [fetch-output : Set log path for single node] 2026-08-25 03:18:19.827889 | debian-bookworm | ok 2026-08-25 03:18:19.833041 | 2026-08-25 03:18:19.833165 | LOOP [fetch-output : Ensure local output dirs] 2026-08-25 03:18:20.246447 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/5107b5a1675046efbacd7fc1eeec2aea/work/logs" 2026-08-25 03:18:20.677435 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5107b5a1675046efbacd7fc1eeec2aea/work/artifacts" 2026-08-25 03:18:21.231837 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5107b5a1675046efbacd7fc1eeec2aea/work/docs" 2026-08-25 03:18:21.248157 | 2026-08-25 03:18:21.248334 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-25 03:18:22.426195 | debian-bookworm | changed: 2026-08-25 03:18:22.426504 | debian-bookworm | .d..t...... ./ 2026-08-25 03:18:22.426551 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-25 03:18:22.427482 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-25 03:18:22.427677 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-25 03:18:22.427712 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-25 03:18:22.427737 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-25 03:18:22.427801 | debian-bookworm | changed: All items complete 2026-08-25 03:18:22.427830 | 2026-08-25 03:18:23.288453 | debian-bookworm | changed: .d..t...... ./ 2026-08-25 03:18:24.116063 | debian-bookworm | changed: .d..t...... ./ 2026-08-25 03:18:24.142540 | 2026-08-25 03:18:24.142718 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-25 03:18:24.202627 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:18:24.216815 | debian-bookworm | skipping: Conditional result was False 2026-08-25 03:18:24.243076 | 2026-08-25 03:18:24.243200 | PLAY RECAP 2026-08-25 03:18:24.243258 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-25 03:18:24.243282 | 2026-08-25 03:18:24.693261 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-25 03:18:24.694177 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-25 03:18:25.776609 | 2026-08-25 03:18:25.776833 | PLAY [Base post] 2026-08-25 03:18:25.792408 | 2026-08-25 03:18:25.792580 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-25 03:18:26.377048 | debian-bookworm | changed 2026-08-25 03:18:26.384075 | 2026-08-25 03:18:26.384194 | PLAY RECAP 2026-08-25 03:18:26.384261 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-25 03:18:26.384368 | 2026-08-25 03:18:26.677747 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-25 03:18:26.678937 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-25 03:18:28.184600 | 2026-08-25 03:18:28.184821 | PLAY [Base post-logs] 2026-08-25 03:18:28.198035 | 2026-08-25 03:18:28.198215 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-25 03:18:29.033260 | localhost | changed 2026-08-25 03:18:29.047525 | 2026-08-25 03:18:29.047721 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-25 03:18:29.077183 | localhost | ok 2026-08-25 03:18:29.089231 | 2026-08-25 03:18:29.089404 | TASK [Set zuul-log-path fact] 2026-08-25 03:18:29.130683 | localhost | ok 2026-08-25 03:18:29.145660 | 2026-08-25 03:18:29.145803 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-25 03:18:29.233372 | localhost | ok 2026-08-25 03:18:29.238479 | 2026-08-25 03:18:29.238618 | TASK [upload-logs : Create log directories] 2026-08-25 03:18:30.332214 | localhost | changed 2026-08-25 03:18:30.335454 | 2026-08-25 03:18:30.335573 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-25 03:18:31.480169 | localhost -> localhost | ok: Runtime: 0:00:00.032494 2026-08-25 03:18:31.484918 | 2026-08-25 03:18:31.485039 | TASK [upload-logs : Upload logs to log server] 2026-08-25 03:18:32.375318 | localhost | Output suppressed because no_log was given 2026-08-25 03:18:32.376972 | 2026-08-25 03:18:32.377057 | LOOP [upload-logs : Compress console log and json output] 2026-08-25 03:18:32.430918 | localhost | skipping: Conditional result was False 2026-08-25 03:18:32.435797 | localhost | skipping: Conditional result was False 2026-08-25 03:18:32.443936 | 2026-08-25 03:18:32.444039 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-25 03:18:32.578037 | localhost | skipping: Conditional result was False 2026-08-25 03:18:32.578388 | 2026-08-25 03:18:32.601648 | localhost | skipping: Conditional result was False 2026-08-25 03:18:32.612624 | 2026-08-25 03:18:32.612748 | LOOP [upload-logs : Upload console log and json output]