2026-07-26 02:27:31.399408 | Job console starting 2026-07-26 02:27:31.413901 | Updating git repos 2026-07-26 02:27:31.485237 | Cloning repos into workspace 2026-07-26 02:27:31.644500 | Restoring repo states 2026-07-26 02:27:31.700572 | Merging changes 2026-07-26 02:27:32.636084 | Checking out repos 2026-07-26 02:27:32.702777 | Preparing playbooks 2026-07-26 02:27:34.254289 | Running Ansible setup 2026-07-26 02:27:41.656186 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-26 02:27:42.792906 | 2026-07-26 02:27:42.793032 | PLAY [Base pre] 2026-07-26 02:27:42.808114 | 2026-07-26 02:27:42.808224 | TASK [Setup log path fact] 2026-07-26 02:27:42.825238 | debian-bookworm | ok 2026-07-26 02:27:42.840450 | 2026-07-26 02:27:42.840626 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-26 02:27:42.899084 | debian-bookworm | ok 2026-07-26 02:27:42.913699 | 2026-07-26 02:27:42.913813 | TASK [emit-job-header : Print job information] 2026-07-26 02:27:42.992112 | # Job Information 2026-07-26 02:27:42.992277 | Ansible Version: 2.16.14 2026-07-26 02:27:42.992307 | Job: tox 2026-07-26 02:27:42.992335 | Pipeline: check 2026-07-26 02:27:42.992354 | Executor: 521e9411259a 2026-07-26 02:27:42.992371 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1248 2026-07-26 02:27:42.992390 | Event ID: 84fad180-8899-11f1-8735-f8ff8b0327e7 2026-07-26 02:27:42.996926 | 2026-07-26 02:27:42.997015 | LOOP [emit-job-header : Print node information] 2026-07-26 02:27:43.238661 | debian-bookworm | ok: 2026-07-26 02:27:43.238822 | debian-bookworm | # Node Information 2026-07-26 02:27:43.239086 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-26 02:27:43.239115 | debian-bookworm | Hostname: debian 2026-07-26 02:27:43.239135 | debian-bookworm | Username: zuul 2026-07-26 02:27:43.239153 | debian-bookworm | Distro: Debian 12.15 2026-07-26 02:27:43.239173 | debian-bookworm | Provider: regiocloud-a 2026-07-26 02:27:43.239191 | debian-bookworm | Region: 2026-07-26 02:27:43.239208 | debian-bookworm | Label: debian-bookworm 2026-07-26 02:27:43.239225 | debian-bookworm | Product Name: OpenStack Nova 2026-07-26 02:27:43.239241 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea0:3259 2026-07-26 02:27:43.256678 | 2026-07-26 02:27:43.256771 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-26 02:27:44.025633 | debian-bookworm -> localhost | changed 2026-07-26 02:27:44.031801 | 2026-07-26 02:27:44.031897 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-26 02:27:45.846980 | debian-bookworm -> localhost | changed 2026-07-26 02:27:45.855975 | 2026-07-26 02:27:45.856087 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-26 02:27:46.706562 | debian-bookworm -> localhost | ok 2026-07-26 02:27:46.712591 | 2026-07-26 02:27:46.712690 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-26 02:27:46.751210 | debian-bookworm | ok 2026-07-26 02:27:46.769554 | debian-bookworm | included: /var/lib/zuul/builds/693e7353c49749ab8d8935adff0a87f6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-26 02:27:46.803294 | 2026-07-26 02:27:46.803401 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-26 02:27:49.712338 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-26 02:27:49.712572 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/693e7353c49749ab8d8935adff0a87f6/work/693e7353c49749ab8d8935adff0a87f6_id_rsa 2026-07-26 02:27:49.712610 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/693e7353c49749ab8d8935adff0a87f6/work/693e7353c49749ab8d8935adff0a87f6_id_rsa.pub 2026-07-26 02:27:49.712635 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-26 02:27:49.712663 | debian-bookworm -> localhost | SHA256:Zqt18fdvS5aonF8JdHoNHVvznqvJy+YHOezDfJlMqTY zuul-build-sshkey 2026-07-26 02:27:49.712685 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-26 02:27:49.712716 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-26 02:27:49.712737 | debian-bookworm -> localhost | | o.| 2026-07-26 02:27:49.712759 | debian-bookworm -> localhost | | .*| 2026-07-26 02:27:49.712780 | debian-bookworm -> localhost | | ..oo| 2026-07-26 02:27:49.712812 | debian-bookworm -> localhost | | . ooo| 2026-07-26 02:27:49.712832 | debian-bookworm -> localhost | | S . .o.o+| 2026-07-26 02:27:49.712869 | debian-bookworm -> localhost | | o . o =+o+| 2026-07-26 02:27:49.712891 | debian-bookworm -> localhost | | o . =.BBo| 2026-07-26 02:27:49.712911 | debian-bookworm -> localhost | | o .. =E*B.| 2026-07-26 02:27:49.712932 | debian-bookworm -> localhost | | . +=O*o=| 2026-07-26 02:27:49.712953 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-26 02:27:49.713007 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.636535 2026-07-26 02:27:49.720091 | 2026-07-26 02:27:49.720197 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-26 02:27:49.766908 | debian-bookworm | ok 2026-07-26 02:27:49.785596 | debian-bookworm | included: /var/lib/zuul/builds/693e7353c49749ab8d8935adff0a87f6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-26 02:27:49.810340 | 2026-07-26 02:27:49.810466 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-26 02:27:49.844096 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:27:49.850193 | 2026-07-26 02:27:49.850302 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-26 02:27:50.556696 | debian-bookworm | changed 2026-07-26 02:27:50.570987 | 2026-07-26 02:27:50.571083 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-26 02:27:50.853031 | debian-bookworm | ok 2026-07-26 02:27:50.862156 | 2026-07-26 02:27:50.865959 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-26 02:27:51.594168 | debian-bookworm | changed 2026-07-26 02:27:51.599237 | 2026-07-26 02:27:51.599323 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-26 02:27:52.245640 | debian-bookworm | changed 2026-07-26 02:27:52.250192 | 2026-07-26 02:27:52.250329 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-26 02:27:52.287352 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:27:52.292487 | 2026-07-26 02:27:52.292572 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-26 02:27:52.887432 | debian-bookworm -> localhost | changed 2026-07-26 02:27:52.902556 | 2026-07-26 02:27:52.911283 | TASK [add-build-sshkey : Add back temp key] 2026-07-26 02:27:53.437385 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/693e7353c49749ab8d8935adff0a87f6/work/693e7353c49749ab8d8935adff0a87f6_id_rsa (zuul-build-sshkey) 2026-07-26 02:27:53.437643 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024737 2026-07-26 02:27:53.446680 | 2026-07-26 02:27:53.446803 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-26 02:27:53.853433 | debian-bookworm | ok 2026-07-26 02:27:53.857615 | 2026-07-26 02:27:53.857693 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-26 02:27:53.881943 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:27:53.890100 | 2026-07-26 02:27:53.890178 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-26 02:27:54.353935 | debian-bookworm | ok 2026-07-26 02:27:54.370680 | 2026-07-26 02:27:54.370792 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-26 02:27:54.422994 | debian-bookworm | ok 2026-07-26 02:27:54.429634 | 2026-07-26 02:27:54.429738 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-26 02:27:54.807973 | debian-bookworm -> localhost | ok 2026-07-26 02:27:54.814467 | 2026-07-26 02:27:54.814553 | TASK [validate-host : Collect information about the host] 2026-07-26 02:27:56.007861 | debian-bookworm | ok 2026-07-26 02:27:56.019471 | 2026-07-26 02:27:56.019570 | TASK [validate-host : Sanitize hostname] 2026-07-26 02:27:56.185152 | debian-bookworm | ok 2026-07-26 02:27:56.190533 | 2026-07-26 02:27:56.190621 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-26 02:27:56.781224 | debian-bookworm -> localhost | changed 2026-07-26 02:27:56.794177 | 2026-07-26 02:27:56.794326 | TASK [validate-host : Collect information about zuul worker] 2026-07-26 02:27:57.224378 | debian-bookworm | ok 2026-07-26 02:27:57.229164 | 2026-07-26 02:27:57.229270 | TASK [validate-host : Write out all zuul information for each host] 2026-07-26 02:27:58.022482 | debian-bookworm -> localhost | changed 2026-07-26 02:27:58.035134 | 2026-07-26 02:27:58.035258 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-26 02:27:58.310184 | debian-bookworm | ok 2026-07-26 02:27:58.317618 | 2026-07-26 02:27:58.319527 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-26 02:27:59.352108 | debian-bookworm | changed: 2026-07-26 02:27:59.352362 | debian-bookworm | cd+++++++++ src/ 2026-07-26 02:27:59.352399 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-26 02:27:59.352425 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-26 02:27:59.352448 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-26 02:27:59.352469 | debian-bookworm | =7.0.3 2026-07-26 02:28:39.990903 | debian-bookworm | Downloading cachetools-7.1.6-py3-none-any.whl (16 kB) 2026-07-26 02:28:40.050922 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-26 02:28:40.063721 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-26 02:28:40.148056 | debian-bookworm | Collecting filelock>=3.25 2026-07-26 02:28:40.159815 | debian-bookworm | Downloading filelock-3.32.0-py3-none-any.whl (97 kB) 2026-07-26 02:28:40.171002 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 97.7/97.7 kB 10.7 MB/s eta 0:00:00 2026-07-26 02:28:40.220549 | debian-bookworm | Collecting packaging>=26 2026-07-26 02:28:40.232222 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-26 02:28:40.243659 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 11.1 MB/s eta 0:00:00 2026-07-26 02:28:40.297614 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-26 02:28:40.308775 | debian-bookworm | Downloading platformdirs-4.11.0-py3-none-any.whl (23 kB) 2026-07-26 02:28:40.352216 | debian-bookworm | Collecting pluggy>=1.6 2026-07-26 02:28:40.364629 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-26 02:28:40.436109 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-26 02:28:40.447940 | debian-bookworm | Downloading pyproject_api-1.11.0-py3-none-any.whl (13 kB) 2026-07-26 02:28:40.503981 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-26 02:28:40.515727 | debian-bookworm | Downloading python_discovery-1.5.0-py3-none-any.whl (34 kB) 2026-07-26 02:28:40.574038 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-26 02:28:40.585872 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-26 02:28:40.744204 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-26 02:28:40.755677 | debian-bookworm | Downloading virtualenv-21.7.0-py3-none-any.whl (5.5 MB) 2026-07-26 02:28:41.094417 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 16.5 MB/s eta 0:00:00 2026-07-26 02:28:41.193056 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-26 02:28:41.204190 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-26 02:28:41.229441 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 22.7 MB/s eta 0:00:00 2026-07-26 02:28:41.339160 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-26 02:28:42.147198 | debian-bookworm | Successfully installed cachetools-7.1.6 colorama-0.4.6 distlib-0.4.3 filelock-3.32.0 packaging-26.2 platformdirs-4.11.0 pluggy-1.6.0 pyproject-api-1.11.0 python-discovery-1.5.0 tomli-w-1.2.0 tox-4.58.0 virtualenv-21.7.0 2026-07-26 02:28:42.571901 | debian-bookworm | ok: Runtime: 0:00:03.234756 2026-07-26 02:28:42.584567 | 2026-07-26 02:28:42.584685 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-26 02:28:42.680695 | debian-bookworm | ok 2026-07-26 02:28:42.691803 | 2026-07-26 02:28:42.691936 | TASK [ensure-tox : Output tox version] 2026-07-26 02:28:43.439901 | 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-07-26 02:28:43.457729 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-26 02:28:43.779425 | debian-bookworm | ok: Runtime: 0:00:00.347493 2026-07-26 02:28:43.785386 | 2026-07-26 02:28:43.785484 | TASK [ensure-tox : Make global symlink] 2026-07-26 02:28:43.808953 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:28:43.815952 | 2026-07-26 02:28:43.816042 | PLAY RECAP 2026-07-26 02:28:43.816094 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-26 02:28:43.816119 | 2026-07-26 02:28:44.075967 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-26 02:28:44.076826 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-26 02:28:45.086778 | 2026-07-26 02:28:45.086960 | PLAY [all] 2026-07-26 02:28:45.105253 | 2026-07-26 02:28:45.105387 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-26 02:28:45.695190 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-26 02:28:46.148105 | debian-bookworm | ok: Runtime: 0:00:00.031657 2026-07-26 02:28:46.158125 | 2026-07-26 02:28:46.158300 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-26 02:28:46.711441 | debian-bookworm | ok: Runtime: 0:00:00.007324 2026-07-26 02:28:46.717200 | 2026-07-26 02:28:46.717303 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-26 02:28:47.017616 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-26 02:28:47.019122 | debian-bookworm | sudo: a password is required 2026-07-26 02:28:47.263875 | debian-bookworm | ok: Runtime: 0:00:00.021519 2026-07-26 02:28:47.274723 | 2026-07-26 02:28:47.274871 | TASK [tox : Check to see if the constraints file exists] 2026-07-26 02:28:47.308517 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:28:47.318050 | 2026-07-26 02:28:47.318157 | TASK [tox : Fail if constraints file is missing] 2026-07-26 02:28:47.353444 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:28:47.359527 | 2026-07-26 02:28:47.359631 | TASK [tox : Record file location] 2026-07-26 02:28:47.383307 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:28:47.395406 | 2026-07-26 02:28:47.395538 | TASK [tox : Install tox siblings] 2026-07-26 02:28:47.444615 | debian-bookworm | ok 2026-07-26 02:28:47.488675 | debian-bookworm | included: /var/lib/zuul/builds/693e7353c49749ab8d8935adff0a87f6/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-26 02:28:47.506310 | 2026-07-26 02:28:47.506429 | TASK [tox : Run tox without tests] 2026-07-26 02:28:48.950075 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-26 02:29:02.504383 | debian-bookworm | test: OK (14.38 seconds) 2026-07-26 02:29:02.504472 | debian-bookworm | congratulations :) (14.41 seconds) 2026-07-26 02:29:03.058429 | debian-bookworm | ok: Runtime: 0:00:14.750865 2026-07-26 02:29:03.064878 | 2026-07-26 02:29:03.064977 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-26 02:29:03.551208 | debian-bookworm | changed 2026-07-26 02:29:03.557866 | 2026-07-26 02:29:03.557963 | TASK [tox : Detect tox version] 2026-07-26 02:29:04.290912 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-26 02:29:04.623204 | debian-bookworm | ok: Runtime: 0:00:00.410557 2026-07-26 02:29:04.632758 | 2026-07-26 02:29:04.632891 | TASK [tox : Get tox envlist config] 2026-07-26 02:29:05.723664 | debian-bookworm | ok: Runtime: 0:00:00.379019 2026-07-26 02:29:05.732694 | 2026-07-26 02:29:05.732903 | TASK [tox : Install any sibling python packages] 2026-07-26 02:29:06.356179 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-26 02:29:06.364008 | 2026-07-26 02:29:06.364116 | TASK [tox : Remove tempfile] 2026-07-26 02:29:06.827356 | debian-bookworm | changed 2026-07-26 02:29:06.832661 | 2026-07-26 02:29:06.832751 | TASK [tox : Emit tox command] 2026-07-26 02:29:06.911801 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-26 02:29:06.916803 | 2026-07-26 02:29:06.916911 | TASK [tox : Run tox] 2026-07-26 02:29:07.666844 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-26 02:29:08.273731 | debian-bookworm | ...........2026-07-26 02:29:08.273 | ERROR | contrib.check_updates:main:219 - operational failure: boom 2026-07-26 02:29:08.281142 | 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-07-26 02:29:08.281181 | debian-bookworm | warnings.warn( 2026-07-26 02:29:08.285052 | debian-bookworm | 2026-07-26 02:29:08.284 | INFO | openstack_image_manager.main:check_image_age:1283 - Checking for openstack images of age 90 2026-07-26 02:29:08.285572 | debian-bookworm | 2026-07-26 02:29:08.284 | INFO | openstack_image_manager.main:check_image_age:1328 - Image 'Ubuntu 20.04 (1)' was created on 2021-01-01 2026-07-26 02:29:08.285594 | debian-bookworm | 2026-07-26 02:29:08.285 | INFO | openstack_image_manager.main:check_image_age:1283 - Checking for openstack images of age 10 2026-07-26 02:29:08.285612 | debian-bookworm | 2026-07-26 02:29:08.285 | INFO | openstack_image_manager.main:check_image_age:1328 - Image 'Ubuntu 20.04 (1)' was created on 2021-01-01 2026-07-26 02:29:08.285628 | debian-bookworm | 2026-07-26 02:29:08.285 | 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-07-26 02:29:08.291961 | debian-bookworm | ..2026-07-26 02:29:08.291 | ERROR | openstack_image_manager.main:_download:714 - aria2c is not installed; cannot prefetch image 2026-07-26 02:29:08.295802 | debian-bookworm | .2026-07-26 02:29:08.295 | ERROR | openstack_image_manager.main:_download:745 - aria2c exited with rc=1 for http://x/y 2026-07-26 02:29:08.304558 | debian-bookworm | ..2026-07-26 02:29:08.304 | ERROR | openstack_image_manager.main:_download:739 - aria2c timed out downloading http://x/y 2026-07-26 02:29:08.311835 | debian-bookworm | ..2026-07-26 02:29:08.311 | 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-07-26 02:29:08.318696 | debian-bookworm | ..2026-07-26 02:29:08.318 | 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-07-26 02:29:08.325710 | debian-bookworm | ..2026-07-26 02:29:08.325 | ERROR | openstack_image_manager.main:get_checksum_from_checksums_url:250 - Failed to fetch checksums file from https://url.com/SHA512SUMS: 404 2026-07-26 02:29:08.328880 | debian-bookworm | .2026-07-26 02:29:08.328 | ERROR | openstack_image_manager.main:get_checksum_from_checksums_url:250 - Failed to fetch checksums file from https://url.com/SHA512SUMS: unreachable 2026-07-26 02:29:08.339718 | debian-bookworm | ...2026-07-26 02:29:08.339 | 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-07-26 02:29:08.343178 | debian-bookworm | .2026-07-26 02:29:08.342 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://x/y; skipping disk check 2026-07-26 02:29:08.347548 | debian-bookworm | .2026-07-26 02:29:08.347 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-26 02:29:08.347573 | debian-bookworm | 2026-07-26 02:29:08.347 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-26 02:29:08.604232 | debian-bookworm | 2026-07-26 02:29:08.603 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-26 02:29:08.606877 | debian-bookworm | 2026-07-26 02:29:08.606 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-26 02:29:08.607348 | debian-bookworm | 2026-07-26 02:29:08.607 | INFO | openstack_image_manager.main:_prefetch_import:666 - PREFETCH: glance-direct import succeeded for 'Ubuntu 20.04 (1)' 2026-07-26 02:29:08.617829 | debian-bookworm | .2026-07-26 02:29:08.617 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-26 02:29:08.617875 | debian-bookworm | 2026-07-26 02:29:08.617 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-26 02:29:08.619185 | debian-bookworm | 2026-07-26 02:29:08.618 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-26 02:29:08.619215 | debian-bookworm | 2026-07-26 02:29:08.619 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL file:///path/to/file.img 2026-07-26 02:29:08.620064 | debian-bookworm | 2026-07-26 02:29:08.619 | INFO | openstack_image_manager.main:import_image:539 - Importing local file '/path/to/file.img' as image Ubuntu 20.04 (1) 2026-07-26 02:29:08.626514 | debian-bookworm | .2026-07-26 02:29:08.626 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-26 02:29:08.626891 | debian-bookworm | 2026-07-26 02:29:08.626 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-26 02:29:08.627203 | debian-bookworm | 2026-07-26 02:29:08.626 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-26 02:29:08.627550 | debian-bookworm | 2026-07-26 02:29:08.627 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-26 02:29:08.627988 | debian-bookworm | 2026-07-26 02:29:08.627 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-26 02:29:08.628006 | debian-bookworm | 2026-07-26 02:29:08.627 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-26 02:29:08.628013 | debian-bookworm | 2026-07-26 02:29:08.627 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-26 02:29:08.629005 | debian-bookworm | 2026-07-26 02:29:08.628 | ERROR | openstack_image_manager.main:wait_for_image:830 - Image seems stuck in queued state 2026-07-26 02:29:08.634630 | debian-bookworm | .2026-07-26 02:29:08.634 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-26 02:29:08.634657 | debian-bookworm | 2026-07-26 02:29:08.634 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-26 02:29:08.635072 | debian-bookworm | 2026-07-26 02:29:08.634 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-26 02:29:08.635495 | debian-bookworm | 2026-07-26 02:29:08.635 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-26 02:29:08.635512 | debian-bookworm | 2026-07-26 02:29:08.635 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-26 02:29:08.635517 | debian-bookworm | 2026-07-26 02:29:08.635 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-26 02:29:08.635795 | debian-bookworm | 2026-07-26 02:29:08.635 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-26 02:29:08.636094 | debian-bookworm | 2026-07-26 02:29:08.635 | ERROR | openstack_image_manager.main:wait_for_image:830 - Image seems stuck in queued state 2026-07-26 02:29:08.636452 | debian-bookworm | 2026-07-26 02:29:08.636 | ERROR | openstack_image_manager.main:import_image:602 - PREFETCH: fallback triggered for 'Ubuntu 20.04 (1)' (web-download failed) 2026-07-26 02:29:08.875882 | debian-bookworm | 2026-07-26 02:29:08.875 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-26 02:29:08.878603 | debian-bookworm | 2026-07-26 02:29:08.878 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-26 02:29:08.879100 | debian-bookworm | 2026-07-26 02:29:08.878 | INFO | openstack_image_manager.main:_prefetch_import:666 - PREFETCH: glance-direct import succeeded for 'Ubuntu 20.04 (1)' 2026-07-26 02:29:08.920100 | debian-bookworm | ...2026-07-26 02:29:08.919 | ERROR | openstack_image_manager.main:main:366 - Skipping cleanup of outdated images because of previous errors 2026-07-26 02:29:09.015913 | debian-bookworm | .2026-07-26 02:29:09.015 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04' (removal candidate) 2026-07-26 02:29:09.020996 | debian-bookworm | .2026-07-26 02:29:09.020 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04_2' (removal candidate) 2026-07-26 02:29:09.021341 | debian-bookworm | 2026-07-26 02:29:09.020 | INFO | openstack_image_manager.main:manage_outdated_images:1418 - Deactivating image 'Ubuntu 20.04_2' 2026-07-26 02:29:09.021585 | debian-bookworm | 2026-07-26 02:29:09.021 | INFO | openstack_image_manager.main:manage_outdated_images:1421 - Setting visibility of 'Ubuntu 20.04_2' to 'community' 2026-07-26 02:29:09.021841 | debian-bookworm | 2026-07-26 02:29:09.021 | INFO | openstack_image_manager.main:manage_outdated_images:1430 - Deleting Ubuntu 20.04_2 2026-07-26 02:29:09.022524 | debian-bookworm | 2026-07-26 02:29:09.022 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04_2' (removal candidate) 2026-07-26 02:29:09.022783 | debian-bookworm | 2026-07-26 02:29:09.022 | INFO | openstack_image_manager.main:manage_outdated_images:1418 - Deactivating image 'Ubuntu 20.04_2' 2026-07-26 02:29:09.022796 | debian-bookworm | 2026-07-26 02:29:09.022 | INFO | openstack_image_manager.main:manage_outdated_images:1421 - Setting visibility of 'Ubuntu 20.04_2' to 'community' 2026-07-26 02:29:09.022801 | debian-bookworm | 2026-07-26 02:29:09.022 | INFO | openstack_image_manager.main:manage_outdated_images:1433 - Image 'Ubuntu 20.04_2' will not be deleted, because 'keep' flag is True 2026-07-26 02:29:09.026232 | debian-bookworm | .2026-07-26 02:29:09.026 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-26 02:29:09.026506 | debian-bookworm | 2026-07-26 02:29:09.026 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-26 02:29:09.030425 | debian-bookworm | .2026-07-26 02:29:09.030 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-26 02:29:09.030453 | debian-bookworm | 2026-07-26 02:29:09.030 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-26 02:29:09.306642 | debian-bookworm | 2026-07-26 02:29:09.305 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-26 02:29:09.309894 | debian-bookworm | 2026-07-26 02:29:09.309 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.310674 | debian-bookworm | 2026-07-26 02:29:09.310 | ERROR | openstack_image_manager.main:_prefetch_import:655 - glance-direct import failed for Ubuntu 20.04 (1) 2026-07-26 02:29:09.310711 | debian-bookworm | 409 conflict on fixed id 2026-07-26 02:29:09.311587 | debian-bookworm | 2026-07-26 02:29:09.310 | ERROR | openstack_image_manager.main:_prefetch_import:658 - PREFETCH: glance-direct import failed for 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.320313 | debian-bookworm | .2026-07-26 02:29:09.320 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-26 02:29:09.322862 | debian-bookworm | 2026-07-26 02:29:09.320 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-26 02:29:09.566688 | debian-bookworm | 2026-07-26 02:29:09.566 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-26 02:29:09.569618 | debian-bookworm | 2026-07-26 02:29:09.569 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download failed for 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.582779 | debian-bookworm | .2026-07-26 02:29:09.582 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.584842 | debian-bookworm | 2026-07-26 02:29:09.583 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-07-26 02:29:09.584895 | debian-bookworm | 2026-07-26 02:29:09.584 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04 (1)' successfully completed, reloading images 2026-07-26 02:29:09.588856 | debian-bookworm | 2026-07-26 02:29:09.586 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.588921 | debian-bookworm | 2026-07-26 02:29:09.586 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04 (1)' successfully completed, reloading images 2026-07-26 02:29:09.588938 | debian-bookworm | 2026-07-26 02:29:09.586 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.588950 | debian-bookworm | 2026-07-26 02:29:09.586 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-07-26 02:29:09.588961 | debian-bookworm | 2026-07-26 02:29:09.586 | INFO | openstack_image_manager.main:process_image:1020 - Skipping required import of image 'Ubuntu 20.04 (1)', running in dry-run mode 2026-07-26 02:29:09.592823 | debian-bookworm | .2026-07-26 02:29:09.592 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (latest)' 2026-07-26 02:29:09.592877 | debian-bookworm | 2026-07-26 02:29:09.592 | 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-07-26 02:29:09.598021 | debian-bookworm | .2026-07-26 02:29:09.597 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-1' 2026-07-26 02:29:09.598697 | debian-bookworm | 2026-07-26 02:29:09.598 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-07-26 02:29:09.600767 | debian-bookworm | 2026-07-26 02:29:09.599 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04-1' successfully completed, reloading images 2026-07-26 02:29:09.604857 | debian-bookworm | .2026-07-26 02:29:09.604 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-(1)' 2026-07-26 02:29:09.604904 | debian-bookworm | 2026-07-26 02:29:09.604 | INFO | openstack_image_manager.main:process_image:1025 - Skipping image 'Ubuntu 20.04-(1)' (only importing the latest version from type multi) 2026-07-26 02:29:09.604920 | debian-bookworm | 2026-07-26 02:29:09.604 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-(2)' 2026-07-26 02:29:09.608794 | debian-bookworm | 2026-07-26 02:29:09.605 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com2: 200 2026-07-26 02:29:09.608825 | debian-bookworm | 2026-07-26 02:29:09.606 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04-(2)' successfully completed, reloading images 2026-07-26 02:29:09.621985 | debian-bookworm | ...2026-07-26 02:29:09.621 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.624827 | debian-bookworm | 2026-07-26 02:29:09.622 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-26 02:29:09.624876 | debian-bookworm | 2026-07-26 02:29:09.622 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.624890 | debian-bookworm | 2026-07-26 02:29:09.622 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-26 02:29:09.624903 | debian-bookworm | 2026-07-26 02:29:09.622 | INFO | openstack_image_manager.main:rename_images:1272 - Renaming Ubuntu 20.04 (1) to Ubuntu 20.04 2026-07-26 02:29:09.629020 | debian-bookworm | .2026-07-26 02:29:09.626 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04-(1)' 2026-07-26 02:29:09.629088 | debian-bookworm | 2026-07-26 02:29:09.626 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-26 02:29:09.629111 | debian-bookworm | 2026-07-26 02:29:09.626 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04-(1)' 2026-07-26 02:29:09.629150 | debian-bookworm | 2026-07-26 02:29:09.626 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-26 02:29:09.629172 | debian-bookworm | 2026-07-26 02:29:09.626 | INFO | openstack_image_manager.main:rename_images:1272 - Renaming Ubuntu 20.04-(1) to Ubuntu 20.04 2026-07-26 02:29:09.660525 | debian-bookworm | ..2026-07-26 02:29:09.660 | INFO | openstack_image_manager.main:set_properties:1063 - Checking parameters of 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.661060 | debian-bookworm | 2026-07-26 02:29:09.660 | INFO | openstack_image_manager.main:set_properties:1129 - Setting internal_version = 1 2026-07-26 02:29:09.661095 | debian-bookworm | 2026-07-26 02:29:09.660 | INFO | openstack_image_manager.main:set_properties:1132 - Setting image_original_user = ubuntu 2026-07-26 02:29:09.661110 | debian-bookworm | 2026-07-26 02:29:09.660 | INFO | openstack_image_manager.main:set_properties:1145 - Adding tag my_tag 2026-07-26 02:29:09.661487 | debian-bookworm | 2026-07-26 02:29:09.661 | INFO | openstack_image_manager.main:set_properties:1150 - Deleting tag fake_tag 2026-07-26 02:29:09.661994 | debian-bookworm | 2026-07-26 02:29:09.661 | INFO | openstack_image_manager.main:set_properties:1161 - Setting property image_build_date: 2021-01-01 != 2021-01-21 2026-07-26 02:29:09.662550 | debian-bookworm | 2026-07-26 02:29:09.662 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property os_distro: ubuntu 2026-07-26 02:29:09.662952 | debian-bookworm | 2026-07-26 02:29:09.662 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property os_version: 20.04 2026-07-26 02:29:09.662978 | debian-bookworm | 2026-07-26 02:29:09.662 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property image_source: http://url.com 2026-07-26 02:29:09.662989 | debian-bookworm | 2026-07-26 02:29:09.662 | INFO | openstack_image_manager.main:set_properties:1185 - Checking status of 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.663350 | debian-bookworm | 2026-07-26 02:29:09.663 | INFO | openstack_image_manager.main:set_properties:1190 - Deactivating image 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.663696 | debian-bookworm | 2026-07-26 02:29:09.663 | INFO | openstack_image_manager.main:set_properties:1197 - Checking visibility of 'Ubuntu 20.04 (1)' 2026-07-26 02:29:09.692680 | debian-bookworm | ...2026-07-26 02:29:09.692 | ERROR | openstack_image_manager.main:wait_for_image:814 - Image import timed out 2026-07-26 02:29:09.697607 | debian-bookworm | .2026-07-26 02:29:09.697 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-26 02:29:09.697654 | debian-bookworm | boom 2026-07-26 02:29:09.698180 | debian-bookworm | 2026-07-26 02:29:09.698 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-26 02:29:09.698204 | debian-bookworm | boom 2026-07-26 02:29:09.698728 | debian-bookworm | 2026-07-26 02:29:09.698 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-26 02:29:09.698834 | debian-bookworm | boom 2026-07-26 02:29:09.699394 | debian-bookworm | 2026-07-26 02:29:09.698 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-26 02:29:09.699424 | debian-bookworm | boom 2026-07-26 02:29:09.699435 | debian-bookworm | 2026-07-26 02:29:09.698 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-26 02:29:09.699445 | debian-bookworm | boom 2026-07-26 02:29:09.699456 | debian-bookworm | 2026-07-26 02:29:09.698 | ERROR | openstack_image_manager.main:wait_for_image:848 - Giving up on image after repeated errors 2026-07-26 02:29:09.703572 | debian-bookworm | .2026-07-26 02:29:09.703 | ERROR | openstack_image_manager.main:wait_for_image:837 - Image entered terminal state 'killed' 2026-07-26 02:29:09.708584 | debian-bookworm | .2026-07-26 02:29:09.708 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-26 02:29:09.709027 | debian-bookworm | 2026-07-26 02:29:09.708 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-26 02:29:09.709072 | debian-bookworm | 2026-07-26 02:29:09.708 | ERROR | openstack_image_manager.main:import_image:584 - Web-download import for image Ubuntu 20.04 (1) failed 2026-07-26 02:29:09.709137 | debian-bookworm | glance api error 2026-07-26 02:29:09.709161 | debian-bookworm | 2026-07-26 02:29:09.708 | ERROR | openstack_image_manager.main:import_image:602 - PREFETCH: fallback triggered for 'Ubuntu 20.04 (1)' (web-download failed) 2026-07-26 02:29:09.724352 | debian-bookworm | .......2026-07-26 02:29:09 | INFO  | main:223 - Processing file /tmp/tmp5umaa2sg/example.yml 2026-07-26 02:29:09.730564 | debian-bookworm | 2026-07-26 02:29:09 | INFO  | update_image:144 - Checking image Example 1.0 2026-07-26 02:29:09.731038 | debian-bookworm | 2026-07-26 02:29:09 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:1111111111111111111111111111111111111111111111111111111111111111 2026-07-26 02:29:09.731085 | debian-bookworm | 2026-07-26 02:29:09 | INFO  | update_image:178 - New URL is https://nbg1.your-objectstorage.com/osism/openstack-images/example-1.0/20260101-example-1.0.qcow2 2026-07-26 02:29:09.734046 | debian-bookworm | 2026-07-26 02:29:09 | INFO  | main:239 - Dry-run enabled, not writing /tmp/tmp5umaa2sg/example.yml 2026-07-26 02:29:09.741578 | debian-bookworm | .2026-07-26 02:29:09 | INFO  | main:223 - Processing file /tmp/tmpoeh9t9w9/example.yml 2026-07-26 02:29:09.744975 | debian-bookworm | 2026-07-26 02:29:09 | INFO  | update_image:144 - Checking image Example 1.0 2026-07-26 02:29:09.745551 | debian-bookworm | 2026-07-26 02:29:09 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:0000000000000000000000000000000000000000000000000000000000000000 2026-07-26 02:29:09.745596 | debian-bookworm | 2026-07-26 02:29:09 | INFO  | update_image:158 - Image Example 1.0 is up-to-date, nothing to do 2026-07-26 02:29:09.753018 | debian-bookworm | .2026-07-26 02:29:09 | INFO  | main:223 - Processing file /tmp/tmpbu9g3quq/example.yml 2026-07-26 02:29:09.756859 | debian-bookworm | 2026-07-26 02:29:09 | INFO  | update_image:144 - Checking image Example 1.0 2026-07-26 02:29:09.757359 | debian-bookworm | 2026-07-26 02:29:09 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:1111111111111111111111111111111111111111111111111111111111111111 2026-07-26 02:29:09.757395 | debian-bookworm | 2026-07-26 02:29:09 | INFO  | update_image:178 - New URL is https://nbg1.your-objectstorage.com/osism/openstack-images/example-1.0/20260101-example-1.0.qcow2 2026-07-26 02:29:09.761406 | debian-bookworm | . 2026-07-26 02:29:09.761543 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-26 02:29:09.761562 | debian-bookworm | Ran 73 tests in 1.511s 2026-07-26 02:29:09.761574 | debian-bookworm | 2026-07-26 02:29:09.761586 | debian-bookworm | OK 2026-07-26 02:29:09.880339 | debian-bookworm | test: OK (2.26=setup[0.05]+cmd[2.21] seconds) 2026-07-26 02:29:09.880414 | debian-bookworm | congratulations :) (2.29 seconds) 2026-07-26 02:29:09.984928 | debian-bookworm | ok: Runtime: 0:00:02.622839 2026-07-26 02:29:09.996968 | 2026-07-26 02:29:09.997080 | TASK [tox : Look for output] 2026-07-26 02:29:10.681742 | debian-bookworm | ok 2026-07-26 02:29:10.717340 | 2026-07-26 02:29:10.717474 | TASK [tox : Return file comments to Zuul] 2026-07-26 02:29:10.775524 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:10.787115 | 2026-07-26 02:29:10.787212 | PLAY RECAP 2026-07-26 02:29:10.787279 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-26 02:29:10.787349 | 2026-07-26 02:29:11.127455 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-26 02:29:11.128478 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-26 02:29:12.608767 | 2026-07-26 02:29:12.608915 | PLAY [all] 2026-07-26 02:29:12.673759 | 2026-07-26 02:29:12.673945 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-26 02:29:12.717895 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:12.722736 | 2026-07-26 02:29:12.722896 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-26 02:29:12.749313 | debian-bookworm | ok 2026-07-26 02:29:12.753704 | 2026-07-26 02:29:12.753785 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-26 02:29:13.903439 | debian-bookworm -> localhost | changed 2026-07-26 02:29:13.909962 | 2026-07-26 02:29:13.910064 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-26 02:29:13.994539 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:13.999393 | 2026-07-26 02:29:13.999498 | TASK [fetch-tox-output : Set envlist fact] 2026-07-26 02:29:14.057078 | debian-bookworm | ok 2026-07-26 02:29:14.063156 | 2026-07-26 02:29:14.063263 | TASK [fetch-tox-output : Get tox version] 2026-07-26 02:29:15.068913 | 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-07-26 02:29:15.086451 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-26 02:29:15.591692 | debian-bookworm | ok: Runtime: 0:00:00.328454 2026-07-26 02:29:15.596505 | 2026-07-26 02:29:15.596599 | TASK [fetch-tox-output : Find all default environments] 2026-07-26 02:29:16.142164 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:16.147076 | 2026-07-26 02:29:16.147177 | TASK [fetch-tox-output : Set envlist fact] 2026-07-26 02:29:16.207047 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:16.211756 | 2026-07-26 02:29:16.211866 | TASK [fetch-tox-output : Find all default environments] 2026-07-26 02:29:16.761625 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:16.766528 | 2026-07-26 02:29:16.766625 | TASK [fetch-tox-output : Set envlist fact] 2026-07-26 02:29:16.810193 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:16.818736 | 2026-07-26 02:29:16.818869 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-26 02:29:16.967461 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:16.979143 | 2026-07-26 02:29:16.979267 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-26 02:29:18.527827 | debian-bookworm | changed: 2026-07-26 02:29:18.528061 | debian-bookworm | created directory /var/lib/zuul/builds/693e7353c49749ab8d8935adff0a87f6/work/logs/tox/test 2026-07-26 02:29:18.528102 | debian-bookworm | cd+++++++++ ./ 2026-07-26 02:29:18.528128 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-26 02:29:18.528160 | 2026-07-26 02:29:18.544486 | 2026-07-26 02:29:18.544578 | PLAY RECAP 2026-07-26 02:29:18.544626 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-26 02:29:18.544647 | 2026-07-26 02:29:19.331383 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-26 02:29:19.332219 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-26 02:29:21.658511 | 2026-07-26 02:29:21.658654 | PLAY [all] 2026-07-26 02:29:21.673684 | 2026-07-26 02:29:21.673841 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-26 02:29:22.085042 | debian-bookworm | changed: non-zero return code 2026-07-26 02:29:22.097762 | 2026-07-26 02:29:22.097917 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-26 02:29:22.160949 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:22.167114 | 2026-07-26 02:29:22.167248 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-26 02:29:22.204913 | 2026-07-26 02:29:22.205222 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-26 02:29:22.269744 | 2026-07-26 02:29:22.269938 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-26 02:29:22.309889 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:22.316016 | 2026-07-26 02:29:22.316116 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-26 02:29:22.365994 | 2026-07-26 02:29:22.366188 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-26 02:29:22.409835 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:22.416034 | 2026-07-26 02:29:22.416139 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-26 02:29:22.459671 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:22.466776 | 2026-07-26 02:29:22.466948 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-26 02:29:22.512743 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:22.522450 | 2026-07-26 02:29:22.522536 | PLAY RECAP 2026-07-26 02:29:22.522588 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-26 02:29:22.522613 | 2026-07-26 02:29:23.161469 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-26 02:29:23.162346 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-26 02:29:25.835225 | 2026-07-26 02:29:25.835391 | PLAY [Base post-fetch] 2026-07-26 02:29:25.896101 | 2026-07-26 02:29:25.897185 | TASK [diagnose-network : Ensure log directory exists] 2026-07-26 02:29:26.451019 | debian-bookworm | ok 2026-07-26 02:29:26.469565 | 2026-07-26 02:29:26.469731 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-26 02:29:38.658948 | debian-bookworm | ok: Runtime: 0:00:05.904957 2026-07-26 02:29:38.676905 | 2026-07-26 02:29:38.677083 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-26 02:29:44.971378 | debian-bookworm | ok: Runtime: 0:00:00.008221 2026-07-26 02:29:44.978974 | 2026-07-26 02:29:44.979127 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-26 02:29:51.056122 | debian-bookworm | ok: Runtime: 0:00:00.008677 2026-07-26 02:29:51.073568 | 2026-07-26 02:29:51.073781 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-26 02:29:51.130666 | debian-bookworm | skipping: Conditional result was False 2026-07-26 02:29:51.138247 | 2026-07-26 02:29:51.138417 | TASK [fetch-output : Set log path for single node] 2026-07-26 02:29:51.182116 | debian-bookworm | ok 2026-07-26 02:29:51.189681 | 2026-07-26 02:29:51.189872 | LOOP [fetch-output : Ensure local output dirs] 2026-07-26 02:29:51.564195 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/693e7353c49749ab8d8935adff0a87f6/work/logs" 2026-07-26 02:29:52.108059 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/693e7353c49749ab8d8935adff0a87f6/work/artifacts" 2026-07-26 02:29:52.448393 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/693e7353c49749ab8d8935adff0a87f6/work/docs" 2026-07-26 02:29:52.462656 | 2026-07-26 02:29:52.462885 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-26 02:29:53.577196 | debian-bookworm | changed: 2026-07-26 02:29:53.579035 | debian-bookworm | .d..t...... ./ 2026-07-26 02:29:53.579133 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-26 02:29:53.579166 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-26 02:29:53.579190 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-26 02:29:53.579213 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-26 02:29:53.579235 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-26 02:29:53.579295 | debian-bookworm | changed: All items complete 2026-07-26 02:29:53.579323 | 2026-07-26 02:29:54.133856 | debian-bookworm | changed: .d..t...... ./ 2026-07-26 02:29:54.742545 | debian-bookworm | changed: .d..t...... ./ 2026-07-26 02:29:54.759033 | 2026-07-26 02:29:54.759324 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-26 02:29:55.171682 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009986 2026-07-26 02:29:55.580317 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009442 2026-07-26 02:29:55.593332 | 2026-07-26 02:29:55.593462 | PLAY RECAP 2026-07-26 02:29:55.593521 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-26 02:29:55.593547 | 2026-07-26 02:29:55.770627 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-26 02:29:55.771834 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-26 02:29:56.915113 | 2026-07-26 02:29:56.917592 | PLAY [Base post] 2026-07-26 02:29:56.946292 | 2026-07-26 02:29:56.946472 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-26 02:29:57.716629 | debian-bookworm | changed 2026-07-26 02:29:57.731101 | 2026-07-26 02:29:57.731268 | PLAY RECAP 2026-07-26 02:29:57.731341 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-26 02:29:57.731406 | 2026-07-26 02:29:57.946097 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-26 02:29:57.947409 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-26 02:29:59.288906 | 2026-07-26 02:29:59.289103 | PLAY [Base post-logs] 2026-07-26 02:29:59.300337 | 2026-07-26 02:29:59.300479 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-26 02:29:59.829738 | localhost | changed 2026-07-26 02:29:59.841191 | 2026-07-26 02:29:59.841394 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-26 02:29:59.883326 | localhost | ok 2026-07-26 02:29:59.887422 | 2026-07-26 02:29:59.887567 | TASK [Set zuul-log-path fact] 2026-07-26 02:29:59.919852 | localhost | ok 2026-07-26 02:29:59.930278 | 2026-07-26 02:29:59.930448 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-26 02:29:59.956111 | localhost | ok 2026-07-26 02:29:59.959532 | 2026-07-26 02:29:59.959638 | TASK [upload-logs : Create log directories] 2026-07-26 02:30:01.053939 | localhost | changed 2026-07-26 02:30:01.057061 | 2026-07-26 02:30:01.057185 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-26 02:30:01.753449 | localhost -> localhost | ok: Runtime: 0:00:00.005199 2026-07-26 02:30:01.757981 | 2026-07-26 02:30:01.758106 | TASK [upload-logs : Upload logs to log server] 2026-07-26 02:30:02.637041 | localhost | Output suppressed because no_log was given 2026-07-26 02:30:02.639064 | 2026-07-26 02:30:02.639179 | LOOP [upload-logs : Compress console log and json output] 2026-07-26 02:30:02.713699 | localhost | skipping: Conditional result was False 2026-07-26 02:30:02.746365 | localhost | skipping: Conditional result was False 2026-07-26 02:30:02.753845 | 2026-07-26 02:30:02.754022 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-26 02:30:02.812106 | localhost | skipping: Conditional result was False 2026-07-26 02:30:02.812452 | 2026-07-26 02:30:02.818239 | localhost | skipping: Conditional result was False 2026-07-26 02:30:02.823209 | 2026-07-26 02:30:02.823390 | LOOP [upload-logs : Upload console log and json output]