2026-08-23 03:02:18.332288 | Job console starting 2026-08-23 03:02:18.358030 | Updating git repos 2026-08-23 03:02:18.393854 | Cloning repos into workspace 2026-08-23 03:02:18.449712 | Restoring repo states 2026-08-23 03:02:18.467108 | Merging changes 2026-08-23 03:02:18.467126 | Checking out repos 2026-08-23 03:02:18.547967 | Preparing playbooks 2026-08-23 03:02:19.734581 | Running Ansible setup 2026-08-23 03:02:25.022164 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-23 03:02:26.094438 | 2026-08-23 03:02:26.094630 | PLAY [Base pre] 2026-08-23 03:02:26.115083 | 2026-08-23 03:02:26.115240 | TASK [Setup log path fact] 2026-08-23 03:02:26.156416 | debian-bookworm | ok 2026-08-23 03:02:26.173873 | 2026-08-23 03:02:26.174087 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-23 03:02:26.214253 | debian-bookworm | ok 2026-08-23 03:02:26.234237 | 2026-08-23 03:02:26.234417 | TASK [emit-job-header : Print job information] 2026-08-23 03:02:26.275666 | # Job Information 2026-08-23 03:02:26.275960 | Ansible Version: 2.16.14 2026-08-23 03:02:26.276018 | Job: tox 2026-08-23 03:02:26.276059 | Pipeline: periodic-daily 2026-08-23 03:02:26.276083 | Executor: 521e9411259a 2026-08-23 03:02:26.276104 | Triggered by: https://github.com/osism/openstack-image-manager 2026-08-23 03:02:26.276126 | Event ID: d945a576bb3d414089afe64a0ea6aa87 2026-08-23 03:02:26.281805 | 2026-08-23 03:02:26.281966 | LOOP [emit-job-header : Print node information] 2026-08-23 03:02:26.409795 | debian-bookworm | ok: 2026-08-23 03:02:26.410377 | debian-bookworm | # Node Information 2026-08-23 03:02:26.410902 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-23 03:02:26.411046 | debian-bookworm | Hostname: debian 2026-08-23 03:02:26.411084 | debian-bookworm | Username: zuul 2026-08-23 03:02:26.411107 | debian-bookworm | Distro: Debian 12.15 2026-08-23 03:02:26.411133 | debian-bookworm | Provider: regiocloud-a 2026-08-23 03:02:26.411155 | debian-bookworm | Region: 2026-08-23 03:02:26.411176 | debian-bookworm | Label: debian-bookworm 2026-08-23 03:02:26.411197 | debian-bookworm | Product Name: OpenStack Nova 2026-08-23 03:02:26.411216 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fecf:8caf 2026-08-23 03:02:26.431170 | 2026-08-23 03:02:26.431342 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-23 03:02:27.178420 | debian-bookworm -> localhost | changed 2026-08-23 03:02:27.186580 | 2026-08-23 03:02:27.187119 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-23 03:02:29.734182 | debian-bookworm -> localhost | changed 2026-08-23 03:02:29.752170 | 2026-08-23 03:02:29.752330 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-23 03:02:30.733997 | debian-bookworm -> localhost | ok 2026-08-23 03:02:30.750683 | 2026-08-23 03:02:30.750893 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-23 03:02:30.813490 | debian-bookworm | ok 2026-08-23 03:02:30.905773 | debian-bookworm | included: /var/lib/zuul/builds/41a4a145f19f4dce99c6ea18fe86d637/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-23 03:02:30.941630 | 2026-08-23 03:02:30.941835 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-23 03:02:33.410665 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-23 03:02:33.410889 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/41a4a145f19f4dce99c6ea18fe86d637/work/41a4a145f19f4dce99c6ea18fe86d637_id_rsa 2026-08-23 03:02:33.410931 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/41a4a145f19f4dce99c6ea18fe86d637/work/41a4a145f19f4dce99c6ea18fe86d637_id_rsa.pub 2026-08-23 03:02:33.410960 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-23 03:02:33.410997 | debian-bookworm -> localhost | SHA256:pUqVRtAErSk9IqDF7fj3pFSJ5eywcnQRZBEOR6CAGZY zuul-build-sshkey 2026-08-23 03:02:33.411020 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-23 03:02:33.411050 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-23 03:02:33.411073 | debian-bookworm -> localhost | |.*o. =X@+ | 2026-08-23 03:02:33.411095 | debian-bookworm -> localhost | |=Eo... *=. | 2026-08-23 03:02:33.411115 | debian-bookworm -> localhost | |.o o.. B=o. | 2026-08-23 03:02:33.411135 | debian-bookworm -> localhost | |. o + Oo*o | 2026-08-23 03:02:33.411154 | debian-bookworm -> localhost | | o +.BS | 2026-08-23 03:02:33.411181 | debian-bookworm -> localhost | | o.=.o | 2026-08-23 03:02:33.411202 | debian-bookworm -> localhost | | =.+ | 2026-08-23 03:02:33.411742 | debian-bookworm -> localhost | | . . | 2026-08-23 03:02:33.411789 | debian-bookworm -> localhost | | | 2026-08-23 03:02:33.411814 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-23 03:02:33.411880 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.165284 2026-08-23 03:02:33.418658 | 2026-08-23 03:02:33.418750 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-23 03:02:33.436508 | debian-bookworm | ok 2026-08-23 03:02:33.447723 | debian-bookworm | included: /var/lib/zuul/builds/41a4a145f19f4dce99c6ea18fe86d637/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-23 03:02:33.455888 | 2026-08-23 03:02:33.456008 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-23 03:02:33.469078 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:02:33.482054 | 2026-08-23 03:02:33.482172 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-23 03:02:34.179325 | debian-bookworm | changed 2026-08-23 03:02:34.190246 | 2026-08-23 03:02:34.190363 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-23 03:02:34.493009 | debian-bookworm | ok 2026-08-23 03:02:34.498711 | 2026-08-23 03:02:34.498822 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-23 03:02:35.160219 | debian-bookworm | changed 2026-08-23 03:02:35.165676 | 2026-08-23 03:02:35.165772 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-23 03:02:35.850464 | debian-bookworm | changed 2026-08-23 03:02:35.859507 | 2026-08-23 03:02:35.859655 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-23 03:02:35.883694 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:02:35.889539 | 2026-08-23 03:02:35.889635 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-23 03:02:36.395356 | debian-bookworm -> localhost | changed 2026-08-23 03:02:36.424144 | 2026-08-23 03:02:36.424330 | TASK [add-build-sshkey : Add back temp key] 2026-08-23 03:02:36.840123 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/41a4a145f19f4dce99c6ea18fe86d637/work/41a4a145f19f4dce99c6ea18fe86d637_id_rsa (zuul-build-sshkey) 2026-08-23 03:02:36.841270 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021692 2026-08-23 03:02:36.868422 | 2026-08-23 03:02:36.869726 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-23 03:02:37.472952 | debian-bookworm | ok 2026-08-23 03:02:37.514737 | 2026-08-23 03:02:37.518627 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-23 03:02:37.565611 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:02:37.621106 | 2026-08-23 03:02:37.622858 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-23 03:02:38.482675 | debian-bookworm | ok 2026-08-23 03:02:38.553200 | 2026-08-23 03:02:38.556356 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-23 03:02:38.646351 | debian-bookworm | ok 2026-08-23 03:02:38.654951 | 2026-08-23 03:02:38.655080 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-23 03:02:39.647043 | debian-bookworm -> localhost | ok 2026-08-23 03:02:39.654633 | 2026-08-23 03:02:39.654758 | TASK [validate-host : Collect information about the host] 2026-08-23 03:02:41.048504 | debian-bookworm | ok 2026-08-23 03:02:41.128376 | 2026-08-23 03:02:41.128506 | TASK [validate-host : Sanitize hostname] 2026-08-23 03:02:41.448736 | debian-bookworm | ok 2026-08-23 03:02:41.463815 | 2026-08-23 03:02:41.463953 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-23 03:02:42.880256 | debian-bookworm -> localhost | changed 2026-08-23 03:02:42.888125 | 2026-08-23 03:02:42.888238 | TASK [validate-host : Collect information about zuul worker] 2026-08-23 03:02:43.244932 | debian-bookworm | ok 2026-08-23 03:02:43.248913 | 2026-08-23 03:02:43.249013 | TASK [validate-host : Write out all zuul information for each host] 2026-08-23 03:02:43.988574 | debian-bookworm -> localhost | changed 2026-08-23 03:02:43.998152 | 2026-08-23 03:02:44.006968 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-23 03:02:44.286602 | debian-bookworm | ok 2026-08-23 03:02:44.292469 | 2026-08-23 03:02:44.292562 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-23 03:02:45.596608 | debian-bookworm | changed: 2026-08-23 03:02:45.596786 | debian-bookworm | cd+++++++++ src/ 2026-08-23 03:02:45.596821 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-23 03:02:45.596846 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-23 03:02:45.596868 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-08-23 03:02:45.596889 | debian-bookworm | =7.0.3 2026-08-23 03:03:15.782400 | debian-bookworm | Downloading cachetools-7.1.7-py3-none-any.whl (16 kB) 2026-08-23 03:03:15.840438 | debian-bookworm | Collecting colorama>=0.4.6 2026-08-23 03:03:15.854903 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-08-23 03:03:15.936712 | debian-bookworm | Collecting filelock>=3.25 2026-08-23 03:03:15.950782 | debian-bookworm | Downloading filelock-3.32.3-py3-none-any.whl (98 kB) 2026-08-23 03:03:15.958762 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.9/98.9 kB 17.7 MB/s eta 0:00:00 2026-08-23 03:03:16.006810 | debian-bookworm | Collecting packaging>=26 2026-08-23 03:03:16.020505 | debian-bookworm | Downloading packaging-26.3-py3-none-any.whl (129 kB) 2026-08-23 03:03:16.029109 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 130.0/130.0 kB 21.2 MB/s eta 0:00:00 2026-08-23 03:03:16.082075 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-08-23 03:03:16.095897 | debian-bookworm | Downloading platformdirs-4.11.3-py3-none-any.whl (23 kB) 2026-08-23 03:03:16.138950 | debian-bookworm | Collecting pluggy>=1.6 2026-08-23 03:03:16.152589 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-08-23 03:03:16.193621 | debian-bookworm | Collecting pyproject-api>=1.10 2026-08-23 03:03:16.209738 | debian-bookworm | Downloading pyproject_api-1.11.0-py3-none-any.whl (13 kB) 2026-08-23 03:03:16.266095 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-08-23 03:03:16.280131 | debian-bookworm | Downloading python_discovery-1.5.2-py3-none-any.whl (38 kB) 2026-08-23 03:03:16.321082 | debian-bookworm | Collecting tomli-w>=1.2 2026-08-23 03:03:16.335012 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-08-23 03:03:16.390315 | debian-bookworm | Collecting typing-extensions>=4.15 2026-08-23 03:03:16.404201 | debian-bookworm | Downloading typing_extensions-4.16.0-py3-none-any.whl (45 kB) 2026-08-23 03:03:16.414138 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.6/45.6 kB 4.9 MB/s eta 0:00:00 2026-08-23 03:03:16.549738 | debian-bookworm | Collecting virtualenv>=21.1 2026-08-23 03:03:16.563320 | debian-bookworm | Downloading virtualenv-21.7.4-py3-none-any.whl (5.3 MB) 2026-08-23 03:03:16.695245 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.3/5.3 MB 41.4 MB/s eta 0:00:00 2026-08-23 03:03:16.801556 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-08-23 03:03:16.818453 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-08-23 03:03:16.836345 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 32.7 MB/s eta 0:00:00 2026-08-23 03:03:16.935301 | debian-bookworm | Installing collected packages: distlib, typing-extensions, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-08-23 03:03:17.786051 | debian-bookworm | Successfully installed cachetools-7.1.7 colorama-0.4.6 distlib-0.4.3 filelock-3.32.3 packaging-26.3 platformdirs-4.11.3 pluggy-1.6.0 pyproject-api-1.11.0 python-discovery-1.5.2 tomli-w-1.2.0 tox-4.60.0 typing-extensions-4.16.0 virtualenv-21.7.4 2026-08-23 03:03:18.137662 | debian-bookworm | ok: Runtime: 0:00:02.921989 2026-08-23 03:03:18.144382 | 2026-08-23 03:03:18.144507 | TASK [ensure-tox : Export installed tox_executable path] 2026-08-23 03:03:18.186111 | debian-bookworm | ok 2026-08-23 03:03:18.192436 | 2026-08-23 03:03:18.192556 | TASK [ensure-tox : Output tox version] 2026-08-23 03:03:18.802972 | 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-23 03:03:18.821171 | debian-bookworm | 4.60.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-08-23 03:03:19.233762 | debian-bookworm | ok: Runtime: 0:00:00.310277 2026-08-23 03:03:19.240359 | 2026-08-23 03:03:19.240489 | TASK [ensure-tox : Make global symlink] 2026-08-23 03:03:19.275216 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:19.283013 | 2026-08-23 03:03:19.283121 | PLAY RECAP 2026-08-23 03:03:19.283191 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-08-23 03:03:19.283217 | 2026-08-23 03:03:19.466793 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-08-23 03:03:19.468038 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-08-23 03:03:20.469927 | 2026-08-23 03:03:20.470144 | PLAY [all] 2026-08-23 03:03:20.498048 | 2026-08-23 03:03:20.498251 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-08-23 03:03:21.211221 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-08-23 03:03:21.545300 | debian-bookworm | ok: Runtime: 0:00:00.026606 2026-08-23 03:03:21.560659 | 2026-08-23 03:03:21.560835 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-08-23 03:03:22.134271 | debian-bookworm | ok: Runtime: 0:00:00.007482 2026-08-23 03:03:22.143565 | 2026-08-23 03:03:22.143702 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-08-23 03:03:22.504674 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-08-23 03:03:22.506167 | debian-bookworm | sudo: a password is required 2026-08-23 03:03:22.737926 | debian-bookworm | ok: Runtime: 0:00:00.019552 2026-08-23 03:03:22.754177 | 2026-08-23 03:03:22.754351 | TASK [tox : Check to see if the constraints file exists] 2026-08-23 03:03:22.875745 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:22.886822 | 2026-08-23 03:03:22.887207 | TASK [tox : Fail if constraints file is missing] 2026-08-23 03:03:22.960610 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:22.967800 | 2026-08-23 03:03:22.967936 | TASK [tox : Record file location] 2026-08-23 03:03:23.059130 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:23.072535 | 2026-08-23 03:03:23.072683 | TASK [tox : Install tox siblings] 2026-08-23 03:03:23.161524 | debian-bookworm | ok 2026-08-23 03:03:23.182735 | debian-bookworm | included: /var/lib/zuul/builds/41a4a145f19f4dce99c6ea18fe86d637/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-08-23 03:03:23.208070 | 2026-08-23 03:03:23.208252 | TASK [tox : Run tox without tests] 2026-08-23 03:03:24.783240 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-08-23 03:03:37.637530 | debian-bookworm | test: OK (13.55 seconds) 2026-08-23 03:03:37.637609 | debian-bookworm | congratulations :) (13.58 seconds) 2026-08-23 03:03:37.804584 | debian-bookworm | ok: Runtime: 0:00:13.919799 2026-08-23 03:03:37.829753 | 2026-08-23 03:03:37.829911 | TASK [tox : Create a tempfile to save tox showconfig] 2026-08-23 03:03:38.364298 | debian-bookworm | changed 2026-08-23 03:03:38.372574 | 2026-08-23 03:03:38.373644 | TASK [tox : Detect tox version] 2026-08-23 03:03:39.090392 | debian-bookworm | 4.60.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-08-23 03:03:39.442239 | debian-bookworm | ok: Runtime: 0:00:00.358448 2026-08-23 03:03:39.448937 | 2026-08-23 03:03:39.449058 | TASK [tox : Get tox envlist config] 2026-08-23 03:03:40.505028 | debian-bookworm | ok: Runtime: 0:00:00.518866 2026-08-23 03:03:40.511965 | 2026-08-23 03:03:40.512088 | TASK [tox : Install any sibling python packages] 2026-08-23 03:03:41.451457 | debian-bookworm | ok: No setup.cfg, no action needed 2026-08-23 03:03:41.456897 | 2026-08-23 03:03:41.457013 | TASK [tox : Remove tempfile] 2026-08-23 03:03:42.076723 | debian-bookworm | changed 2026-08-23 03:03:42.087620 | 2026-08-23 03:03:42.087722 | TASK [tox : Emit tox command] 2026-08-23 03:03:42.136495 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-08-23 03:03:42.143429 | 2026-08-23 03:03:42.143535 | TASK [tox : Run tox] 2026-08-23 03:03:42.867591 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-08-23 03:03:43.415194 | debian-bookworm | ...........2026-08-23 03:03:43.414 | ERROR | contrib.check_updates:main:219 - operational failure: boom 2026-08-23 03:03:43.421909 | debian-bookworm | ......../home/zuul/src/github.com/osism/openstack-image-manager/.tox/test/lib/python3.11/site-packages/openstack/resource.py:874: RemovedInSDK50Warning: The _compute_attributes method is deprecated for removal 2026-08-23 03:03:43.421937 | debian-bookworm | warnings.warn( 2026-08-23 03:03:43.426100 | debian-bookworm | 2026-08-23 03:03:43.425 | INFO | openstack_image_manager.main:check_image_age:1283 - Checking for openstack images of age 90 2026-08-23 03:03:43.426514 | debian-bookworm | 2026-08-23 03:03:43.425 | INFO | openstack_image_manager.main:check_image_age:1328 - Image 'Ubuntu 20.04 (1)' was created on 2021-01-01 2026-08-23 03:03:43.426530 | debian-bookworm | 2026-08-23 03:03:43.426 | INFO | openstack_image_manager.main:check_image_age:1283 - Checking for openstack images of age 10 2026-08-23 03:03:43.426541 | debian-bookworm | 2026-08-23 03:03:43.426 | INFO | openstack_image_manager.main:check_image_age:1328 - Image 'Ubuntu 20.04 (1)' was created on 2021-01-01 2026-08-23 03:03:43.426552 | debian-bookworm | 2026-08-23 03:03:43.426 | WARNING | openstack_image_manager.main:check_image_age:1334 - Image 'Ubuntu 20.04 (1)' is 20 days older than the newest image in the definition 2026-08-23 03:03:43.432235 | debian-bookworm | ..2026-08-23 03:03:43.432 | ERROR | openstack_image_manager.main:_download:714 - aria2c is not installed; cannot prefetch image 2026-08-23 03:03:43.435672 | debian-bookworm | .2026-08-23 03:03:43.435 | ERROR | openstack_image_manager.main:_download:745 - aria2c exited with rc=1 for http://x/y 2026-08-23 03:03:43.442376 | debian-bookworm | ..2026-08-23 03:03:43.442 | ERROR | openstack_image_manager.main:_download:739 - aria2c timed out downloading http://x/y 2026-08-23 03:03:43.448901 | debian-bookworm | ..2026-08-23 03:03:43.448 | ERROR | openstack_image_manager.main:get_checksum_from_checksum_url:278 - Failed to fetch checksum file from https://url.com/image.qcow2.sha512: 404 2026-08-23 03:03:43.455324 | debian-bookworm | ..2026-08-23 03:03:43.455 | ERROR | openstack_image_manager.main:get_checksum_from_checksum_url:278 - Failed to fetch checksum file from https://url.com/image.qcow2.sha512: unreachable 2026-08-23 03:03:43.461651 | debian-bookworm | ..2026-08-23 03:03:43.461 | ERROR | openstack_image_manager.main:get_checksum_from_checksums_url:250 - Failed to fetch checksums file from https://url.com/SHA512SUMS: 404 2026-08-23 03:03:43.464569 | debian-bookworm | .2026-08-23 03:03:43.464 | ERROR | openstack_image_manager.main:get_checksum_from_checksums_url:250 - Failed to fetch checksums file from https://url.com/SHA512SUMS: unreachable 2026-08-23 03:03:43.474682 | debian-bookworm | ...2026-08-23 03:03:43.474 | ERROR | openstack_image_manager.main:_has_space_for_download:693 - Not enough disk to prefetch http://x/y: need ~2362232012 bytes, 1073741824 available at /tmp 2026-08-23 03:03:43.477945 | debian-bookworm | .2026-08-23 03:03:43.477 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://x/y; skipping disk check 2026-08-23 03:03:43.481627 | debian-bookworm | .2026-08-23 03:03:43.481 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-08-23 03:03:43.481643 | debian-bookworm | 2026-08-23 03:03:43.481 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-08-23 03:03:44.081501 | debian-bookworm | 2026-08-23 03:03:44.080 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-08-23 03:03:44.083789 | debian-bookworm | 2026-08-23 03:03:44.083 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-08-23 03:03:44.084307 | debian-bookworm | 2026-08-23 03:03:44.083 | INFO | openstack_image_manager.main:_prefetch_import:666 - PREFETCH: glance-direct import succeeded for 'Ubuntu 20.04 (1)' 2026-08-23 03:03:44.093794 | debian-bookworm | .2026-08-23 03:03:44.093 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-08-23 03:03:44.093828 | debian-bookworm | 2026-08-23 03:03:44.093 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-08-23 03:03:44.095242 | debian-bookworm | 2026-08-23 03:03:44.094 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-08-23 03:03:44.095621 | debian-bookworm | 2026-08-23 03:03:44.095 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL file:///path/to/file.img 2026-08-23 03:03:44.095642 | debian-bookworm | 2026-08-23 03:03:44.095 | INFO | openstack_image_manager.main:import_image:539 - Importing local file '/path/to/file.img' as image Ubuntu 20.04 (1) 2026-08-23 03:03:44.101559 | debian-bookworm | .2026-08-23 03:03:44.101 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-08-23 03:03:44.101585 | debian-bookworm | 2026-08-23 03:03:44.101 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-08-23 03:03:44.102083 | debian-bookworm | 2026-08-23 03:03:44.101 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-08-23 03:03:44.102426 | debian-bookworm | 2026-08-23 03:03:44.102 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-08-23 03:03:44.102750 | debian-bookworm | 2026-08-23 03:03:44.102 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-08-23 03:03:44.102765 | debian-bookworm | 2026-08-23 03:03:44.102 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-08-23 03:03:44.102770 | debian-bookworm | 2026-08-23 03:03:44.102 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-08-23 03:03:44.103383 | debian-bookworm | 2026-08-23 03:03:44.103 | ERROR | openstack_image_manager.main:wait_for_image:830 - Image seems stuck in queued state 2026-08-23 03:03:44.108634 | debian-bookworm | .2026-08-23 03:03:44.108 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-08-23 03:03:44.108655 | debian-bookworm | 2026-08-23 03:03:44.108 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-08-23 03:03:44.109067 | debian-bookworm | 2026-08-23 03:03:44.108 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-08-23 03:03:44.109436 | debian-bookworm | 2026-08-23 03:03:44.109 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-08-23 03:03:44.109743 | debian-bookworm | 2026-08-23 03:03:44.109 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-08-23 03:03:44.109756 | debian-bookworm | 2026-08-23 03:03:44.109 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-08-23 03:03:44.109760 | debian-bookworm | 2026-08-23 03:03:44.109 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-08-23 03:03:44.110207 | debian-bookworm | 2026-08-23 03:03:44.110 | ERROR | openstack_image_manager.main:wait_for_image:830 - Image seems stuck in queued state 2026-08-23 03:03:44.110222 | debian-bookworm | 2026-08-23 03:03:44.110 | ERROR | openstack_image_manager.main:import_image:602 - PREFETCH: fallback triggered for 'Ubuntu 20.04 (1)' (web-download failed) 2026-08-23 03:03:44.353893 | debian-bookworm | 2026-08-23 03:03:44.353 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-08-23 03:03:44.355827 | debian-bookworm | 2026-08-23 03:03:44.355 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-08-23 03:03:44.356259 | debian-bookworm | 2026-08-23 03:03:44.355 | INFO | openstack_image_manager.main:_prefetch_import:666 - PREFETCH: glance-direct import succeeded for 'Ubuntu 20.04 (1)' 2026-08-23 03:03:44.378042 | debian-bookworm | ...2026-08-23 03:03:44.377 | ERROR | openstack_image_manager.main:main:366 - Skipping cleanup of outdated images because of previous errors 2026-08-23 03:03:44.473257 | debian-bookworm | .2026-08-23 03:03:44.472 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04' (removal candidate) 2026-08-23 03:03:44.477811 | debian-bookworm | .2026-08-23 03:03:44.477 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04_2' (removal candidate) 2026-08-23 03:03:44.478198 | debian-bookworm | 2026-08-23 03:03:44.477 | INFO | openstack_image_manager.main:manage_outdated_images:1418 - Deactivating image 'Ubuntu 20.04_2' 2026-08-23 03:03:44.478212 | debian-bookworm | 2026-08-23 03:03:44.478 | INFO | openstack_image_manager.main:manage_outdated_images:1421 - Setting visibility of 'Ubuntu 20.04_2' to 'community' 2026-08-23 03:03:44.478580 | debian-bookworm | 2026-08-23 03:03:44.478 | INFO | openstack_image_manager.main:manage_outdated_images:1430 - Deleting Ubuntu 20.04_2 2026-08-23 03:03:44.479198 | debian-bookworm | 2026-08-23 03:03:44.478 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04_2' (removal candidate) 2026-08-23 03:03:44.479567 | debian-bookworm | 2026-08-23 03:03:44.479 | INFO | openstack_image_manager.main:manage_outdated_images:1418 - Deactivating image 'Ubuntu 20.04_2' 2026-08-23 03:03:44.479579 | debian-bookworm | 2026-08-23 03:03:44.479 | INFO | openstack_image_manager.main:manage_outdated_images:1421 - Setting visibility of 'Ubuntu 20.04_2' to 'community' 2026-08-23 03:03:44.479584 | debian-bookworm | 2026-08-23 03:03:44.479 | INFO | openstack_image_manager.main:manage_outdated_images:1433 - Image 'Ubuntu 20.04_2' will not be deleted, because 'keep' flag is True 2026-08-23 03:03:44.482712 | debian-bookworm | .2026-08-23 03:03:44.482 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-08-23 03:03:44.482727 | debian-bookworm | 2026-08-23 03:03:44.482 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-08-23 03:03:44.486737 | debian-bookworm | .2026-08-23 03:03:44.486 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-08-23 03:03:44.486754 | debian-bookworm | 2026-08-23 03:03:44.486 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-08-23 03:03:44.716347 | debian-bookworm | 2026-08-23 03:03:44.715 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-08-23 03:03:44.719345 | debian-bookworm | 2026-08-23 03:03:44.718 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-08-23 03:03:44.719640 | debian-bookworm | 2026-08-23 03:03:44.719 | ERROR | openstack_image_manager.main:_prefetch_import:655 - glance-direct import failed for Ubuntu 20.04 (1) 2026-08-23 03:03:44.719666 | debian-bookworm | 409 conflict on fixed id 2026-08-23 03:03:44.719845 | debian-bookworm | 2026-08-23 03:03:44.719 | ERROR | openstack_image_manager.main:_prefetch_import:658 - PREFETCH: glance-direct import failed for 'Ubuntu 20.04 (1)' 2026-08-23 03:03:44.728502 | debian-bookworm | .2026-08-23 03:03:44.728 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-08-23 03:03:44.728719 | debian-bookworm | 2026-08-23 03:03:44.728 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-08-23 03:03:44.964170 | debian-bookworm | 2026-08-23 03:03:44.963 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-08-23 03:03:44.966330 | debian-bookworm | 2026-08-23 03:03:44.965 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download failed for 'Ubuntu 20.04 (1)' 2026-08-23 03:03:44.977682 | debian-bookworm | .2026-08-23 03:03:44.977 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-08-23 03:03:44.978213 | debian-bookworm | 2026-08-23 03:03:44.977 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-08-23 03:03:44.978976 | debian-bookworm | 2026-08-23 03:03:44.978 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04 (1)' successfully completed, reloading images 2026-08-23 03:03:44.980506 | debian-bookworm | 2026-08-23 03:03:44.980 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-08-23 03:03:44.980858 | debian-bookworm | 2026-08-23 03:03:44.980 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04 (1)' successfully completed, reloading images 2026-08-23 03:03:44.981200 | debian-bookworm | 2026-08-23 03:03:44.980 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-08-23 03:03:44.981543 | debian-bookworm | 2026-08-23 03:03:44.981 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-08-23 03:03:44.981559 | debian-bookworm | 2026-08-23 03:03:44.981 | INFO | openstack_image_manager.main:process_image:1020 - Skipping required import of image 'Ubuntu 20.04 (1)', running in dry-run mode 2026-08-23 03:03:44.986199 | debian-bookworm | .2026-08-23 03:03:44.985 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (latest)' 2026-08-23 03:03:44.986700 | debian-bookworm | 2026-08-23 03:03:44.986 | ERROR | openstack_image_manager.main:process_image:948 - Could not find checksum for image 'Ubuntu 20.04', check the checksums_url or checksum_url 2026-08-23 03:03:44.991394 | debian-bookworm | .2026-08-23 03:03:44.991 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-1' 2026-08-23 03:03:44.991772 | debian-bookworm | 2026-08-23 03:03:44.991 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-08-23 03:03:44.992275 | debian-bookworm | 2026-08-23 03:03:44.992 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04-1' successfully completed, reloading images 2026-08-23 03:03:44.996989 | debian-bookworm | .2026-08-23 03:03:44.996 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-(1)' 2026-08-23 03:03:44.997033 | debian-bookworm | 2026-08-23 03:03:44.996 | INFO | openstack_image_manager.main:process_image:1025 - Skipping image 'Ubuntu 20.04-(1)' (only importing the latest version from type multi) 2026-08-23 03:03:44.997353 | debian-bookworm | 2026-08-23 03:03:44.996 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-(2)' 2026-08-23 03:03:44.998823 | debian-bookworm | 2026-08-23 03:03:44.998 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com2: 200 2026-08-23 03:03:44.999307 | debian-bookworm | 2026-08-23 03:03:44.999 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04-(2)' successfully completed, reloading images 2026-08-23 03:03:45.010089 | debian-bookworm | ...2026-08-23 03:03:45.009 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04 (1)' 2026-08-23 03:03:45.010681 | debian-bookworm | 2026-08-23 03:03:45.009 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-08-23 03:03:45.010694 | debian-bookworm | 2026-08-23 03:03:45.010 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04 (1)' 2026-08-23 03:03:45.010698 | debian-bookworm | 2026-08-23 03:03:45.010 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-08-23 03:03:45.010702 | debian-bookworm | 2026-08-23 03:03:45.010 | INFO | openstack_image_manager.main:rename_images:1272 - Renaming Ubuntu 20.04 (1) to Ubuntu 20.04 2026-08-23 03:03:45.013251 | debian-bookworm | .2026-08-23 03:03:45.013 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04-(1)' 2026-08-23 03:03:45.013675 | debian-bookworm | 2026-08-23 03:03:45.013 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-08-23 03:03:45.013687 | debian-bookworm | 2026-08-23 03:03:45.013 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04-(1)' 2026-08-23 03:03:45.013702 | debian-bookworm | 2026-08-23 03:03:45.013 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-08-23 03:03:45.013706 | debian-bookworm | 2026-08-23 03:03:45.013 | INFO | openstack_image_manager.main:rename_images:1272 - Renaming Ubuntu 20.04-(1) to Ubuntu 20.04 2026-08-23 03:03:45.039956 | debian-bookworm | ..2026-08-23 03:03:45.039 | INFO | openstack_image_manager.main:set_properties:1063 - Checking parameters of 'Ubuntu 20.04 (1)' 2026-08-23 03:03:45.040426 | debian-bookworm | 2026-08-23 03:03:45.039 | INFO | openstack_image_manager.main:set_properties:1129 - Setting internal_version = 1 2026-08-23 03:03:45.040439 | debian-bookworm | 2026-08-23 03:03:45.039 | INFO | openstack_image_manager.main:set_properties:1132 - Setting image_original_user = ubuntu 2026-08-23 03:03:45.040443 | debian-bookworm | 2026-08-23 03:03:45.039 | INFO | openstack_image_manager.main:set_properties:1145 - Adding tag my_tag 2026-08-23 03:03:45.040451 | debian-bookworm | 2026-08-23 03:03:45.040 | INFO | openstack_image_manager.main:set_properties:1150 - Deleting tag fake_tag 2026-08-23 03:03:45.040797 | debian-bookworm | 2026-08-23 03:03:45.040 | INFO | openstack_image_manager.main:set_properties:1161 - Setting property image_build_date: 2021-01-01 != 2021-01-21 2026-08-23 03:03:45.040807 | debian-bookworm | 2026-08-23 03:03:45.040 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property os_distro: ubuntu 2026-08-23 03:03:45.041195 | debian-bookworm | 2026-08-23 03:03:45.040 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property os_version: 20.04 2026-08-23 03:03:45.041207 | debian-bookworm | 2026-08-23 03:03:45.040 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property image_source: http://url.com 2026-08-23 03:03:45.041211 | debian-bookworm | 2026-08-23 03:03:45.040 | INFO | openstack_image_manager.main:set_properties:1185 - Checking status of 'Ubuntu 20.04 (1)' 2026-08-23 03:03:45.041214 | debian-bookworm | 2026-08-23 03:03:45.040 | INFO | openstack_image_manager.main:set_properties:1190 - Deactivating image 'Ubuntu 20.04 (1)' 2026-08-23 03:03:45.041218 | debian-bookworm | 2026-08-23 03:03:45.041 | INFO | openstack_image_manager.main:set_properties:1197 - Checking visibility of 'Ubuntu 20.04 (1)' 2026-08-23 03:03:45.063668 | debian-bookworm | ...2026-08-23 03:03:45.063 | ERROR | openstack_image_manager.main:wait_for_image:814 - Image import timed out 2026-08-23 03:03:45.067255 | debian-bookworm | .2026-08-23 03:03:45.066 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-08-23 03:03:45.067272 | debian-bookworm | boom 2026-08-23 03:03:45.067695 | debian-bookworm | 2026-08-23 03:03:45.067 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-08-23 03:03:45.067707 | debian-bookworm | boom 2026-08-23 03:03:45.067711 | debian-bookworm | 2026-08-23 03:03:45.067 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-08-23 03:03:45.067714 | debian-bookworm | boom 2026-08-23 03:03:45.067718 | debian-bookworm | 2026-08-23 03:03:45.067 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-08-23 03:03:45.067721 | debian-bookworm | boom 2026-08-23 03:03:45.067724 | debian-bookworm | 2026-08-23 03:03:45.067 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-08-23 03:03:45.067727 | debian-bookworm | boom 2026-08-23 03:03:45.067730 | debian-bookworm | 2026-08-23 03:03:45.067 | ERROR | openstack_image_manager.main:wait_for_image:848 - Giving up on image after repeated errors 2026-08-23 03:03:45.071996 | debian-bookworm | .2026-08-23 03:03:45.071 | ERROR | openstack_image_manager.main:wait_for_image:837 - Image entered terminal state 'killed' 2026-08-23 03:03:45.074872 | debian-bookworm | .2026-08-23 03:03:45.074 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-08-23 03:03:45.074886 | debian-bookworm | 2026-08-23 03:03:45.074 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-08-23 03:03:45.075314 | debian-bookworm | 2026-08-23 03:03:45.074 | ERROR | openstack_image_manager.main:import_image:584 - Web-download import for image Ubuntu 20.04 (1) failed 2026-08-23 03:03:45.075338 | debian-bookworm | glance api error 2026-08-23 03:03:45.075343 | debian-bookworm | 2026-08-23 03:03:45.074 | ERROR | openstack_image_manager.main:import_image:602 - PREFETCH: fallback triggered for 'Ubuntu 20.04 (1)' (web-download failed) 2026-08-23 03:03:45.085865 | debian-bookworm | .......2026-08-23 03:03:45 | INFO  | main:223 - Processing file /tmp/tmpljlciamb/example.yml 2026-08-23 03:03:45.090512 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | main:232 - Skipping disabled image Example 1.0 2026-08-23 03:03:45.096349 | debian-bookworm | .2026-08-23 03:03:45 | INFO  | main:223 - Processing file /tmp/tmpedyp0d8t/example.yml 2026-08-23 03:03:45.098827 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | update_image:144 - Checking image Example 1.0 2026-08-23 03:03:45.098842 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:1111111111111111111111111111111111111111111111111111111111111111 2026-08-23 03:03:45.099233 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | update_image:178 - New URL is https://nbg1.your-objectstorage.com/osism/openstack-images/example-1.0/20260101-example-1.0.qcow2 2026-08-23 03:03:45.100987 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | main:242 - Dry-run enabled, not writing /tmp/tmpedyp0d8t/example.yml 2026-08-23 03:03:45.106685 | debian-bookworm | .2026-08-23 03:03:45 | INFO  | main:223 - Processing file /tmp/tmptt_7d3wj/example.yml 2026-08-23 03:03:45.109314 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | update_image:144 - Checking image Example 1.0 2026-08-23 03:03:45.109330 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:0000000000000000000000000000000000000000000000000000000000000000 2026-08-23 03:03:45.109334 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | update_image:158 - Image Example 1.0 is up-to-date, nothing to do 2026-08-23 03:03:45.115074 | debian-bookworm | .2026-08-23 03:03:45 | INFO  | main:223 - Processing file /tmp/tmpi7pqg895/example.yml 2026-08-23 03:03:45.117453 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | update_image:144 - Checking image Example 1.0 2026-08-23 03:03:45.117468 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:1111111111111111111111111111111111111111111111111111111111111111 2026-08-23 03:03:45.117713 | debian-bookworm | 2026-08-23 03:03:45 | INFO  | update_image:178 - New URL is https://nbg1.your-objectstorage.com/osism/openstack-images/example-1.0/20260101-example-1.0.qcow2 2026-08-23 03:03:45.120317 | debian-bookworm | . 2026-08-23 03:03:45.120335 | debian-bookworm | ---------------------------------------------------------------------- 2026-08-23 03:03:45.120339 | debian-bookworm | Ran 74 tests in 1.728s 2026-08-23 03:03:45.120343 | debian-bookworm | 2026-08-23 03:03:45.120346 | debian-bookworm | OK 2026-08-23 03:03:45.190198 | debian-bookworm | test: OK (2.37=setup[0.05]+cmd[2.32] seconds) 2026-08-23 03:03:45.190258 | debian-bookworm | congratulations :) (2.40 seconds) 2026-08-23 03:03:45.739522 | debian-bookworm | ok: Runtime: 0:00:02.740210 2026-08-23 03:03:45.746855 | 2026-08-23 03:03:45.746997 | TASK [tox : Look for output] 2026-08-23 03:03:46.177729 | debian-bookworm | ok 2026-08-23 03:03:46.207230 | 2026-08-23 03:03:46.207367 | TASK [tox : Return file comments to Zuul] 2026-08-23 03:03:46.274254 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:46.282640 | 2026-08-23 03:03:46.282733 | PLAY RECAP 2026-08-23 03:03:46.282786 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-08-23 03:03:46.282811 | 2026-08-23 03:03:46.416119 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-08-23 03:03:46.417135 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-08-23 03:03:47.658287 | 2026-08-23 03:03:47.658436 | PLAY [all] 2026-08-23 03:03:47.690251 | 2026-08-23 03:03:47.690403 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-08-23 03:03:47.820648 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:47.826451 | 2026-08-23 03:03:47.826584 | TASK [fetch-tox-output : Set tox log path for single node] 2026-08-23 03:03:47.961190 | debian-bookworm | ok 2026-08-23 03:03:47.974690 | 2026-08-23 03:03:47.974809 | TASK [fetch-tox-output : Ensure local tox dir] 2026-08-23 03:03:49.491761 | debian-bookworm -> localhost | changed 2026-08-23 03:03:49.500739 | 2026-08-23 03:03:49.500878 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-08-23 03:03:49.721673 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:49.736200 | 2026-08-23 03:03:49.736351 | TASK [fetch-tox-output : Set envlist fact] 2026-08-23 03:03:49.945225 | debian-bookworm | ok 2026-08-23 03:03:49.975216 | 2026-08-23 03:03:49.976103 | TASK [fetch-tox-output : Get tox version] 2026-08-23 03:03:51.352316 | 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-23 03:03:51.371334 | debian-bookworm | 4.60.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-08-23 03:03:51.632257 | debian-bookworm | ok: Runtime: 0:00:00.331704 2026-08-23 03:03:51.638198 | 2026-08-23 03:03:51.638289 | TASK [fetch-tox-output : Find all default environments] 2026-08-23 03:03:52.233942 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:52.239473 | 2026-08-23 03:03:52.239568 | TASK [fetch-tox-output : Set envlist fact] 2026-08-23 03:03:52.313841 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:52.326045 | 2026-08-23 03:03:52.326142 | TASK [fetch-tox-output : Find all default environments] 2026-08-23 03:03:52.914163 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:52.919005 | 2026-08-23 03:03:52.919111 | TASK [fetch-tox-output : Set envlist fact] 2026-08-23 03:03:52.942080 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:52.947376 | 2026-08-23 03:03:52.947478 | LOOP [fetch-tox-output : Copy tox logs] 2026-08-23 03:03:53.064804 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:53.077067 | 2026-08-23 03:03:53.077166 | LOOP [fetch-tox-output : Collect tox logs] 2026-08-23 03:03:54.679158 | debian-bookworm | changed: 2026-08-23 03:03:54.679330 | debian-bookworm | created directory /var/lib/zuul/builds/41a4a145f19f4dce99c6ea18fe86d637/work/logs/tox/test 2026-08-23 03:03:54.679364 | debian-bookworm | cd+++++++++ ./ 2026-08-23 03:03:54.679390 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-08-23 03:03:54.679426 | 2026-08-23 03:03:54.700975 | 2026-08-23 03:03:54.701060 | PLAY RECAP 2026-08-23 03:03:54.701106 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-08-23 03:03:54.701605 | 2026-08-23 03:03:55.038633 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-08-23 03:03:55.039517 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-08-23 03:03:57.203873 | 2026-08-23 03:03:57.204035 | PLAY [all] 2026-08-23 03:03:57.234653 | 2026-08-23 03:03:57.234791 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-08-23 03:03:57.607065 | debian-bookworm | changed: non-zero return code 2026-08-23 03:03:57.611662 | 2026-08-23 03:03:57.611777 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-08-23 03:03:57.640780 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:57.645715 | 2026-08-23 03:03:57.645821 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-08-23 03:03:57.684480 | 2026-08-23 03:03:57.684645 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-08-23 03:03:57.734042 | 2026-08-23 03:03:57.734207 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-08-23 03:03:57.767356 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:57.791122 | 2026-08-23 03:03:57.791266 | LOOP [fetch-subunit-output : Generate subunit file] 2026-08-23 03:03:57.839133 | 2026-08-23 03:03:57.839290 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-08-23 03:03:57.862845 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:57.867840 | 2026-08-23 03:03:57.867929 | TASK [fetch-subunit-output : Remove the temporary file] 2026-08-23 03:03:57.890852 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:57.895726 | 2026-08-23 03:03:57.895809 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-08-23 03:03:57.941929 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:03:57.947338 | 2026-08-23 03:03:57.947400 | PLAY RECAP 2026-08-23 03:03:57.947441 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-08-23 03:03:57.947462 | 2026-08-23 03:03:58.232483 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-08-23 03:03:58.233369 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-23 03:03:59.636078 | 2026-08-23 03:03:59.636200 | PLAY [Base post-fetch] 2026-08-23 03:03:59.647983 | 2026-08-23 03:03:59.648096 | TASK [diagnose-network : Ensure log directory exists] 2026-08-23 03:04:00.032358 | debian-bookworm | ok 2026-08-23 03:04:00.042348 | 2026-08-23 03:04:00.042489 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-08-23 03:04:12.576477 | debian-bookworm | ok: Runtime: 0:00:06.192975 2026-08-23 03:04:12.597022 | 2026-08-23 03:04:12.597139 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-08-23 03:04:18.697331 | debian-bookworm | ok: Runtime: 0:00:00.008370 2026-08-23 03:04:18.711790 | 2026-08-23 03:04:18.711951 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-08-23 03:04:24.831038 | debian-bookworm | ok: Runtime: 0:00:00.010808 2026-08-23 03:04:24.842314 | 2026-08-23 03:04:24.842448 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-23 03:04:24.898298 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:04:24.904881 | 2026-08-23 03:04:24.905035 | TASK [fetch-output : Set log path for single node] 2026-08-23 03:04:24.959675 | debian-bookworm | ok 2026-08-23 03:04:24.971256 | 2026-08-23 03:04:24.971395 | LOOP [fetch-output : Ensure local output dirs] 2026-08-23 03:04:25.569741 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/41a4a145f19f4dce99c6ea18fe86d637/work/logs" 2026-08-23 03:04:26.035399 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/41a4a145f19f4dce99c6ea18fe86d637/work/artifacts" 2026-08-23 03:04:26.875856 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/41a4a145f19f4dce99c6ea18fe86d637/work/docs" 2026-08-23 03:04:26.889772 | 2026-08-23 03:04:26.896531 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-23 03:04:28.311783 | debian-bookworm | changed: 2026-08-23 03:04:28.312066 | debian-bookworm | .d..t...... ./ 2026-08-23 03:04:28.312105 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-23 03:04:28.312129 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-23 03:04:28.312150 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-23 03:04:28.312171 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-23 03:04:28.312192 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-23 03:04:28.312237 | debian-bookworm | changed: All items complete 2026-08-23 03:04:28.312261 | 2026-08-23 03:04:29.337887 | debian-bookworm | changed: .d..t...... ./ 2026-08-23 03:04:30.102224 | debian-bookworm | changed: .d..t...... ./ 2026-08-23 03:04:30.128136 | 2026-08-23 03:04:30.128287 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-23 03:04:30.168022 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:04:30.174694 | debian-bookworm | skipping: Conditional result was False 2026-08-23 03:04:30.188659 | 2026-08-23 03:04:30.188774 | PLAY RECAP 2026-08-23 03:04:30.188830 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-23 03:04:30.188855 | 2026-08-23 03:04:30.396567 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-23 03:04:30.397731 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-23 03:04:31.578935 | 2026-08-23 03:04:31.579116 | PLAY [Base post] 2026-08-23 03:04:31.614575 | 2026-08-23 03:04:31.614715 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-23 03:04:32.589484 | debian-bookworm | changed 2026-08-23 03:04:32.596571 | 2026-08-23 03:04:32.596761 | PLAY RECAP 2026-08-23 03:04:32.596862 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-23 03:04:32.597019 | 2026-08-23 03:04:32.884683 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-23 03:04:32.885695 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-23 03:04:34.974362 | 2026-08-23 03:04:34.974523 | PLAY [Base post-logs] 2026-08-23 03:04:34.992228 | 2026-08-23 03:04:34.992367 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-23 03:04:36.529413 | localhost | changed 2026-08-23 03:04:36.567255 | 2026-08-23 03:04:36.567479 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-23 03:04:36.607757 | localhost | ok 2026-08-23 03:04:36.612555 | 2026-08-23 03:04:36.612683 | TASK [Set zuul-log-path fact] 2026-08-23 03:04:36.672253 | localhost | ok 2026-08-23 03:04:36.699748 | 2026-08-23 03:04:36.699933 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-23 03:04:36.767606 | localhost | ok 2026-08-23 03:04:36.771452 | 2026-08-23 03:04:36.771569 | TASK [upload-logs : Create log directories] 2026-08-23 03:04:37.627354 | localhost | changed 2026-08-23 03:04:37.631411 | 2026-08-23 03:04:37.631546 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-23 03:04:38.639304 | localhost -> localhost | ok: Runtime: 0:00:00.017873 2026-08-23 03:04:38.644814 | 2026-08-23 03:04:38.645048 | TASK [upload-logs : Upload logs to log server] 2026-08-23 03:04:39.578264 | localhost | Output suppressed because no_log was given 2026-08-23 03:04:39.580055 | 2026-08-23 03:04:39.580144 | LOOP [upload-logs : Compress console log and json output] 2026-08-23 03:04:39.620188 | localhost | skipping: Conditional result was False 2026-08-23 03:04:39.639510 | localhost | skipping: Conditional result was False 2026-08-23 03:04:39.646457 | 2026-08-23 03:04:39.646566 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-23 03:04:39.708458 | localhost | skipping: Conditional result was False 2026-08-23 03:04:39.708718 | 2026-08-23 03:04:39.725354 | localhost | skipping: Conditional result was False 2026-08-23 03:04:39.732910 | 2026-08-23 03:04:39.733020 | LOOP [upload-logs : Upload console log and json output]