2026-07-27 03:02:13.401305 | Job console starting 2026-07-27 03:02:13.440372 | Updating git repos 2026-07-27 03:02:13.473047 | Cloning repos into workspace 2026-07-27 03:02:13.518699 | Restoring repo states 2026-07-27 03:02:13.526503 | Merging changes 2026-07-27 03:02:13.526520 | Checking out repos 2026-07-27 03:02:13.617701 | Preparing playbooks 2026-07-27 03:02:14.879700 | Running Ansible setup 2026-07-27 03:02:19.591216 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-27 03:02:20.488511 | 2026-07-27 03:02:20.488647 | PLAY [Base pre] 2026-07-27 03:02:20.520703 | 2026-07-27 03:02:20.520834 | TASK [Setup log path fact] 2026-07-27 03:02:20.549982 | debian-bookworm | ok 2026-07-27 03:02:20.566399 | 2026-07-27 03:02:20.566538 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-27 03:02:20.594688 | debian-bookworm | ok 2026-07-27 03:02:20.612976 | 2026-07-27 03:02:20.613099 | TASK [emit-job-header : Print job information] 2026-07-27 03:02:20.671716 | # Job Information 2026-07-27 03:02:20.671949 | Ansible Version: 2.16.14 2026-07-27 03:02:20.671989 | Job: tox 2026-07-27 03:02:20.672022 | Pipeline: periodic-daily 2026-07-27 03:02:20.672046 | Executor: 521e9411259a 2026-07-27 03:02:20.672066 | Triggered by: https://github.com/osism/openstack-image-manager 2026-07-27 03:02:20.672088 | Event ID: 91253b8dc5ab47748b065a84a5c9331c 2026-07-27 03:02:20.676869 | 2026-07-27 03:02:20.676969 | LOOP [emit-job-header : Print node information] 2026-07-27 03:02:20.800338 | debian-bookworm | ok: 2026-07-27 03:02:20.800550 | debian-bookworm | # Node Information 2026-07-27 03:02:20.800586 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-27 03:02:20.800611 | debian-bookworm | Hostname: debian 2026-07-27 03:02:20.800634 | debian-bookworm | Username: zuul 2026-07-27 03:02:20.800654 | debian-bookworm | Distro: Debian 12.15 2026-07-27 03:02:20.800677 | debian-bookworm | Provider: regiocloud-a 2026-07-27 03:02:20.800698 | debian-bookworm | Region: 2026-07-27 03:02:20.800719 | debian-bookworm | Label: debian-bookworm 2026-07-27 03:02:20.800739 | debian-bookworm | Product Name: OpenStack Nova 2026-07-27 03:02:20.800759 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee1:fd24 2026-07-27 03:02:20.820805 | 2026-07-27 03:02:20.820937 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-27 03:02:21.419460 | debian-bookworm -> localhost | changed 2026-07-27 03:02:21.426759 | 2026-07-27 03:02:21.426877 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-27 03:02:22.590354 | debian-bookworm -> localhost | changed 2026-07-27 03:02:22.607700 | 2026-07-27 03:02:22.607856 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-27 03:02:22.884085 | debian-bookworm -> localhost | ok 2026-07-27 03:02:22.891221 | 2026-07-27 03:02:22.891353 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-27 03:02:22.924863 | debian-bookworm | ok 2026-07-27 03:02:22.957325 | debian-bookworm | included: /var/lib/zuul/builds/b85bb86f97e649638f26c287f55120c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-27 03:02:22.968873 | 2026-07-27 03:02:22.969019 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-27 03:02:25.247058 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-27 03:02:25.247905 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b85bb86f97e649638f26c287f55120c3/work/b85bb86f97e649638f26c287f55120c3_id_rsa 2026-07-27 03:02:25.247965 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b85bb86f97e649638f26c287f55120c3/work/b85bb86f97e649638f26c287f55120c3_id_rsa.pub 2026-07-27 03:02:25.247991 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-27 03:02:25.248012 | debian-bookworm -> localhost | SHA256:tvILFkzxwZOJZhH0iwdFec1x6mE9GrLjPdnm7lF2xF4 zuul-build-sshkey 2026-07-27 03:02:25.248031 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-27 03:02:25.248059 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-27 03:02:25.248088 | debian-bookworm -> localhost | | .=*++ o... | 2026-07-27 03:02:25.248106 | debian-bookworm -> localhost | | +=*.. o+ . | 2026-07-27 03:02:25.248123 | debian-bookworm -> localhost | | oo oo. = o E| 2026-07-27 03:02:25.248140 | debian-bookworm -> localhost | | o o . = + +.| 2026-07-27 03:02:25.248157 | debian-bookworm -> localhost | | + S o o =| 2026-07-27 03:02:25.248176 | debian-bookworm -> localhost | | + o o o o.| 2026-07-27 03:02:25.248193 | debian-bookworm -> localhost | | + . . + + | 2026-07-27 03:02:25.248209 | debian-bookworm -> localhost | | . + + . | 2026-07-27 03:02:25.248226 | debian-bookworm -> localhost | | o. o+ | 2026-07-27 03:02:25.248243 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-27 03:02:25.248289 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.755129 2026-07-27 03:02:25.253744 | 2026-07-27 03:02:25.253840 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-27 03:02:25.291251 | debian-bookworm | ok 2026-07-27 03:02:25.302950 | debian-bookworm | included: /var/lib/zuul/builds/b85bb86f97e649638f26c287f55120c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-27 03:02:25.310212 | 2026-07-27 03:02:25.310283 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-27 03:02:25.323635 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:02:25.330244 | 2026-07-27 03:02:25.330345 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-27 03:02:26.248069 | debian-bookworm | changed 2026-07-27 03:02:26.252675 | 2026-07-27 03:02:26.252751 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-27 03:02:26.509303 | debian-bookworm | ok 2026-07-27 03:02:26.514286 | 2026-07-27 03:02:26.514373 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-27 03:02:27.224304 | debian-bookworm | changed 2026-07-27 03:02:27.229080 | 2026-07-27 03:02:27.229169 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-27 03:02:27.849572 | debian-bookworm | changed 2026-07-27 03:02:27.855439 | 2026-07-27 03:02:27.855546 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-27 03:02:27.869264 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:02:27.876964 | 2026-07-27 03:02:27.877083 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-27 03:02:28.560580 | debian-bookworm -> localhost | changed 2026-07-27 03:02:28.572475 | 2026-07-27 03:02:28.572586 | TASK [add-build-sshkey : Add back temp key] 2026-07-27 03:02:29.039130 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b85bb86f97e649638f26c287f55120c3/work/b85bb86f97e649638f26c287f55120c3_id_rsa (zuul-build-sshkey) 2026-07-27 03:02:29.039360 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016990 2026-07-27 03:02:29.046988 | 2026-07-27 03:02:29.047089 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-27 03:02:29.449439 | debian-bookworm | ok 2026-07-27 03:02:29.457534 | 2026-07-27 03:02:29.457660 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-27 03:02:29.481252 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:02:29.498344 | 2026-07-27 03:02:29.498440 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-27 03:02:29.936047 | debian-bookworm | ok 2026-07-27 03:02:29.949966 | 2026-07-27 03:02:29.950067 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-27 03:02:29.978962 | debian-bookworm | ok 2026-07-27 03:02:29.984356 | 2026-07-27 03:02:29.984445 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-27 03:02:30.280429 | debian-bookworm -> localhost | ok 2026-07-27 03:02:30.286975 | 2026-07-27 03:02:30.287078 | TASK [validate-host : Collect information about the host] 2026-07-27 03:02:31.427793 | debian-bookworm | ok 2026-07-27 03:02:31.447865 | 2026-07-27 03:02:31.448004 | TASK [validate-host : Sanitize hostname] 2026-07-27 03:02:31.617195 | debian-bookworm | ok 2026-07-27 03:02:31.632005 | 2026-07-27 03:02:31.632106 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-27 03:02:32.706502 | debian-bookworm -> localhost | changed 2026-07-27 03:02:32.714825 | 2026-07-27 03:02:32.715084 | TASK [validate-host : Collect information about zuul worker] 2026-07-27 03:02:33.261205 | debian-bookworm | ok 2026-07-27 03:02:33.266762 | 2026-07-27 03:02:33.266940 | TASK [validate-host : Write out all zuul information for each host] 2026-07-27 03:02:34.172340 | debian-bookworm -> localhost | changed 2026-07-27 03:02:34.181849 | 2026-07-27 03:02:34.181974 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-27 03:02:34.492835 | debian-bookworm | ok 2026-07-27 03:02:34.497949 | 2026-07-27 03:02:34.498036 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-27 03:02:35.646102 | debian-bookworm | changed: 2026-07-27 03:02:35.646278 | debian-bookworm | cd+++++++++ src/ 2026-07-27 03:02:35.646313 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-27 03:02:35.646338 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-27 03:02:35.646360 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-27 03:02:35.646381 | debian-bookworm | =7.0.3 2026-07-27 03:03:12.485652 | debian-bookworm | Downloading cachetools-7.1.6-py3-none-any.whl (16 kB) 2026-07-27 03:03:12.539170 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-27 03:03:12.551959 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-27 03:03:12.635138 | debian-bookworm | Collecting filelock>=3.25 2026-07-27 03:03:12.646045 | debian-bookworm | Downloading filelock-3.32.0-py3-none-any.whl (97 kB) 2026-07-27 03:03:12.656284 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 97.7/97.7 kB 11.2 MB/s eta 0:00:00 2026-07-27 03:03:12.699668 | debian-bookworm | Collecting packaging>=26 2026-07-27 03:03:12.710054 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-27 03:03:12.719905 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 12.2 MB/s eta 0:00:00 2026-07-27 03:03:12.767394 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-27 03:03:12.779532 | debian-bookworm | Downloading platformdirs-4.11.0-py3-none-any.whl (23 kB) 2026-07-27 03:03:12.842331 | debian-bookworm | Collecting pluggy>=1.6 2026-07-27 03:03:12.853801 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-27 03:03:12.911874 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-27 03:03:12.923579 | debian-bookworm | Downloading pyproject_api-1.11.0-py3-none-any.whl (13 kB) 2026-07-27 03:03:12.972481 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-27 03:03:12.983279 | debian-bookworm | Downloading python_discovery-1.5.0-py3-none-any.whl (34 kB) 2026-07-27 03:03:13.016983 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-27 03:03:13.028185 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-27 03:03:13.175451 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-27 03:03:13.185859 | debian-bookworm | Downloading virtualenv-21.7.0-py3-none-any.whl (5.5 MB) 2026-07-27 03:03:13.423194 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 23.5 MB/s eta 0:00:00 2026-07-27 03:03:13.525934 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-27 03:03:13.537415 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-27 03:03:13.562051 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 24.5 MB/s eta 0:00:00 2026-07-27 03:03:13.665855 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-27 03:03:14.470219 | 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-27 03:03:14.918018 | debian-bookworm | ok: Runtime: 0:00:02.901588 2026-07-27 03:03:14.925354 | 2026-07-27 03:03:14.925501 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-27 03:03:15.007114 | debian-bookworm | ok 2026-07-27 03:03:15.026219 | 2026-07-27 03:03:15.026389 | TASK [ensure-tox : Output tox version] 2026-07-27 03:03:15.639831 | 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-27 03:03:15.656584 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-27 03:03:16.123384 | debian-bookworm | ok: Runtime: 0:00:00.300826 2026-07-27 03:03:16.129981 | 2026-07-27 03:03:16.130180 | TASK [ensure-tox : Make global symlink] 2026-07-27 03:03:16.185472 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:16.193772 | 2026-07-27 03:03:16.193906 | PLAY RECAP 2026-07-27 03:03:16.193965 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-27 03:03:16.193989 | 2026-07-27 03:03:16.415798 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-27 03:03:16.417698 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-27 03:03:17.646529 | 2026-07-27 03:03:17.646709 | PLAY [all] 2026-07-27 03:03:17.669503 | 2026-07-27 03:03:17.669662 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-27 03:03:18.179648 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-27 03:03:18.228954 | debian-bookworm | ok: Runtime: 0:00:00.028217 2026-07-27 03:03:18.239562 | 2026-07-27 03:03:18.239766 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-27 03:03:18.771152 | debian-bookworm | ok: Runtime: 0:00:00.006343 2026-07-27 03:03:18.778278 | 2026-07-27 03:03:18.778421 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-27 03:03:19.044111 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-27 03:03:19.045463 | debian-bookworm | sudo: a password is required 2026-07-27 03:03:19.309611 | debian-bookworm | ok: Runtime: 0:00:00.015455 2026-07-27 03:03:19.344149 | 2026-07-27 03:03:19.344321 | TASK [tox : Check to see if the constraints file exists] 2026-07-27 03:03:19.414376 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:19.441631 | 2026-07-27 03:03:19.441838 | TASK [tox : Fail if constraints file is missing] 2026-07-27 03:03:19.508636 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:19.516213 | 2026-07-27 03:03:19.516377 | TASK [tox : Record file location] 2026-07-27 03:03:19.583922 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:19.590721 | 2026-07-27 03:03:19.590921 | TASK [tox : Install tox siblings] 2026-07-27 03:03:19.714516 | debian-bookworm | ok 2026-07-27 03:03:19.752800 | debian-bookworm | included: /var/lib/zuul/builds/b85bb86f97e649638f26c287f55120c3/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-27 03:03:19.769393 | 2026-07-27 03:03:19.769557 | TASK [tox : Run tox without tests] 2026-07-27 03:03:21.073113 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-27 03:03:34.408935 | debian-bookworm | test: OK (13.98 seconds) 2026-07-27 03:03:34.408987 | debian-bookworm | congratulations :) (14.01 seconds) 2026-07-27 03:03:34.868608 | debian-bookworm | ok: Runtime: 0:00:14.303114 2026-07-27 03:03:34.875142 | 2026-07-27 03:03:34.875267 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-27 03:03:35.294426 | debian-bookworm | changed 2026-07-27 03:03:35.308326 | 2026-07-27 03:03:35.308479 | TASK [tox : Detect tox version] 2026-07-27 03:03:36.074717 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-27 03:03:36.389840 | debian-bookworm | ok: Runtime: 0:00:00.331054 2026-07-27 03:03:36.396055 | 2026-07-27 03:03:36.396200 | TASK [tox : Get tox envlist config] 2026-07-27 03:03:37.445539 | debian-bookworm | ok: Runtime: 0:00:00.368636 2026-07-27 03:03:37.469050 | 2026-07-27 03:03:37.469218 | TASK [tox : Install any sibling python packages] 2026-07-27 03:03:38.106057 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-27 03:03:38.114083 | 2026-07-27 03:03:38.114214 | TASK [tox : Remove tempfile] 2026-07-27 03:03:38.715709 | debian-bookworm | changed 2026-07-27 03:03:38.721500 | 2026-07-27 03:03:38.721613 | TASK [tox : Emit tox command] 2026-07-27 03:03:38.770563 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-27 03:03:38.781123 | 2026-07-27 03:03:38.781329 | TASK [tox : Run tox] 2026-07-27 03:03:39.429121 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-27 03:03:39.983022 | debian-bookworm | ...........2026-07-27 03:03:39.982 | ERROR | contrib.check_updates:main:219 - operational failure: boom 2026-07-27 03:03:39.990358 | 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-27 03:03:39.990397 | debian-bookworm | warnings.warn( 2026-07-27 03:03:39.993920 | debian-bookworm | 2026-07-27 03:03:39.993 | INFO | openstack_image_manager.main:check_image_age:1283 - Checking for openstack images of age 90 2026-07-27 03:03:39.994252 | debian-bookworm | 2026-07-27 03:03:39.993 | INFO | openstack_image_manager.main:check_image_age:1328 - Image 'Ubuntu 20.04 (1)' was created on 2021-01-01 2026-07-27 03:03:39.994267 | debian-bookworm | 2026-07-27 03:03:39.994 | INFO | openstack_image_manager.main:check_image_age:1283 - Checking for openstack images of age 10 2026-07-27 03:03:39.994577 | debian-bookworm | 2026-07-27 03:03:39.994 | INFO | openstack_image_manager.main:check_image_age:1328 - Image 'Ubuntu 20.04 (1)' was created on 2021-01-01 2026-07-27 03:03:39.994595 | debian-bookworm | 2026-07-27 03:03:39.994 | 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-27 03:03:40.000228 | debian-bookworm | ..2026-07-27 03:03:39.999 | ERROR | openstack_image_manager.main:_download:714 - aria2c is not installed; cannot prefetch image 2026-07-27 03:03:40.003782 | debian-bookworm | .2026-07-27 03:03:40.003 | ERROR | openstack_image_manager.main:_download:745 - aria2c exited with rc=1 for http://x/y 2026-07-27 03:03:40.012097 | debian-bookworm | ..2026-07-27 03:03:40.011 | ERROR | openstack_image_manager.main:_download:739 - aria2c timed out downloading http://x/y 2026-07-27 03:03:40.018974 | debian-bookworm | ..2026-07-27 03:03:40.018 | 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-27 03:03:40.025312 | debian-bookworm | ..2026-07-27 03:03:40.024 | 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-27 03:03:40.033469 | debian-bookworm | ..2026-07-27 03:03:40.033 | ERROR | openstack_image_manager.main:get_checksum_from_checksums_url:250 - Failed to fetch checksums file from https://url.com/SHA512SUMS: 404 2026-07-27 03:03:40.036594 | debian-bookworm | .2026-07-27 03:03:40.036 | ERROR | openstack_image_manager.main:get_checksum_from_checksums_url:250 - Failed to fetch checksums file from https://url.com/SHA512SUMS: unreachable 2026-07-27 03:03:40.046909 | debian-bookworm | ...2026-07-27 03:03:40.046 | 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-27 03:03:40.050106 | debian-bookworm | .2026-07-27 03:03:40.049 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://x/y; skipping disk check 2026-07-27 03:03:40.054119 | debian-bookworm | .2026-07-27 03:03:40.053 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-27 03:03:40.054459 | debian-bookworm | 2026-07-27 03:03:40.054 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-27 03:03:40.377770 | debian-bookworm | 2026-07-27 03:03:40.377 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-27 03:03:40.379598 | debian-bookworm | 2026-07-27 03:03:40.379 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-27 03:03:40.380295 | debian-bookworm | 2026-07-27 03:03:40.379 | INFO | openstack_image_manager.main:_prefetch_import:666 - PREFETCH: glance-direct import succeeded for 'Ubuntu 20.04 (1)' 2026-07-27 03:03:40.386604 | debian-bookworm | .2026-07-27 03:03:40.386 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-27 03:03:40.386635 | debian-bookworm | 2026-07-27 03:03:40.386 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-27 03:03:40.389209 | debian-bookworm | 2026-07-27 03:03:40.388 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-27 03:03:40.389671 | debian-bookworm | 2026-07-27 03:03:40.389 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL file:///path/to/file.img 2026-07-27 03:03:40.390134 | debian-bookworm | 2026-07-27 03:03:40.389 | INFO | openstack_image_manager.main:import_image:539 - Importing local file '/path/to/file.img' as image Ubuntu 20.04 (1) 2026-07-27 03:03:40.401199 | debian-bookworm | .2026-07-27 03:03:40.400 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-27 03:03:40.401240 | debian-bookworm | 2026-07-27 03:03:40.401 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-27 03:03:40.401946 | debian-bookworm | 2026-07-27 03:03:40.401 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-27 03:03:40.402479 | debian-bookworm | 2026-07-27 03:03:40.402 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-27 03:03:40.402787 | debian-bookworm | 2026-07-27 03:03:40.402 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-27 03:03:40.402804 | debian-bookworm | 2026-07-27 03:03:40.402 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-27 03:03:40.402812 | debian-bookworm | 2026-07-27 03:03:40.402 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-27 03:03:40.403678 | debian-bookworm | 2026-07-27 03:03:40.403 | ERROR | openstack_image_manager.main:wait_for_image:830 - Image seems stuck in queued state 2026-07-27 03:03:40.410913 | debian-bookworm | .2026-07-27 03:03:40.410 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-27 03:03:40.410943 | debian-bookworm | 2026-07-27 03:03:40.410 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-27 03:03:40.411421 | debian-bookworm | 2026-07-27 03:03:40.411 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-27 03:03:40.411771 | debian-bookworm | 2026-07-27 03:03:40.411 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-27 03:03:40.412121 | debian-bookworm | 2026-07-27 03:03:40.411 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-27 03:03:40.412136 | debian-bookworm | 2026-07-27 03:03:40.411 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-27 03:03:40.412141 | debian-bookworm | 2026-07-27 03:03:40.411 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-27 03:03:40.412670 | debian-bookworm | 2026-07-27 03:03:40.412 | ERROR | openstack_image_manager.main:wait_for_image:830 - Image seems stuck in queued state 2026-07-27 03:03:40.413017 | debian-bookworm | 2026-07-27 03:03:40.412 | ERROR | openstack_image_manager.main:import_image:602 - PREFETCH: fallback triggered for 'Ubuntu 20.04 (1)' (web-download failed) 2026-07-27 03:03:40.719596 | debian-bookworm | 2026-07-27 03:03:40.719 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-27 03:03:40.722022 | debian-bookworm | 2026-07-27 03:03:40.721 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-27 03:03:40.722489 | debian-bookworm | 2026-07-27 03:03:40.722 | INFO | openstack_image_manager.main:_prefetch_import:666 - PREFETCH: glance-direct import succeeded for 'Ubuntu 20.04 (1)' 2026-07-27 03:03:40.745381 | debian-bookworm | ...2026-07-27 03:03:40.745 | ERROR | openstack_image_manager.main:main:366 - Skipping cleanup of outdated images because of previous errors 2026-07-27 03:03:40.831451 | debian-bookworm | .2026-07-27 03:03:40.831 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04' (removal candidate) 2026-07-27 03:03:40.835992 | debian-bookworm | .2026-07-27 03:03:40.835 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04_2' (removal candidate) 2026-07-27 03:03:40.836365 | debian-bookworm | 2026-07-27 03:03:40.835 | INFO | openstack_image_manager.main:manage_outdated_images:1418 - Deactivating image 'Ubuntu 20.04_2' 2026-07-27 03:03:40.836381 | debian-bookworm | 2026-07-27 03:03:40.836 | INFO | openstack_image_manager.main:manage_outdated_images:1421 - Setting visibility of 'Ubuntu 20.04_2' to 'community' 2026-07-27 03:03:40.836685 | debian-bookworm | 2026-07-27 03:03:40.836 | INFO | openstack_image_manager.main:manage_outdated_images:1430 - Deleting Ubuntu 20.04_2 2026-07-27 03:03:40.837405 | debian-bookworm | 2026-07-27 03:03:40.837 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04_2' (removal candidate) 2026-07-27 03:03:40.837425 | debian-bookworm | 2026-07-27 03:03:40.837 | INFO | openstack_image_manager.main:manage_outdated_images:1418 - Deactivating image 'Ubuntu 20.04_2' 2026-07-27 03:03:40.837718 | debian-bookworm | 2026-07-27 03:03:40.837 | INFO | openstack_image_manager.main:manage_outdated_images:1421 - Setting visibility of 'Ubuntu 20.04_2' to 'community' 2026-07-27 03:03:40.837729 | debian-bookworm | 2026-07-27 03:03:40.837 | 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-27 03:03:40.840958 | debian-bookworm | .2026-07-27 03:03:40.840 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-27 03:03:40.841319 | debian-bookworm | 2026-07-27 03:03:40.840 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-27 03:03:40.844940 | debian-bookworm | .2026-07-27 03:03:40.844 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-27 03:03:40.844961 | debian-bookworm | 2026-07-27 03:03:40.844 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-27 03:03:41.148893 | debian-bookworm | 2026-07-27 03:03:41.148 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-27 03:03:41.152161 | debian-bookworm | 2026-07-27 03:03:41.151 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.152609 | debian-bookworm | 2026-07-27 03:03:41.152 | ERROR | openstack_image_manager.main:_prefetch_import:655 - glance-direct import failed for Ubuntu 20.04 (1) 2026-07-27 03:03:41.152640 | debian-bookworm | 409 conflict on fixed id 2026-07-27 03:03:41.152653 | debian-bookworm | 2026-07-27 03:03:41.152 | ERROR | openstack_image_manager.main:_prefetch_import:658 - PREFETCH: glance-direct import failed for 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.161512 | debian-bookworm | .2026-07-27 03:03:41.161 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-27 03:03:41.161964 | debian-bookworm | 2026-07-27 03:03:41.161 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-27 03:03:41.538522 | debian-bookworm | 2026-07-27 03:03:41.537 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-27 03:03:41.541395 | debian-bookworm | 2026-07-27 03:03:41.540 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download failed for 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.554367 | debian-bookworm | .2026-07-27 03:03:41.553 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.554944 | debian-bookworm | 2026-07-27 03:03:41.554 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-07-27 03:03:41.555388 | debian-bookworm | 2026-07-27 03:03:41.555 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04 (1)' successfully completed, reloading images 2026-07-27 03:03:41.556781 | debian-bookworm | 2026-07-27 03:03:41.556 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.557144 | debian-bookworm | 2026-07-27 03:03:41.556 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04 (1)' successfully completed, reloading images 2026-07-27 03:03:41.557531 | debian-bookworm | 2026-07-27 03:03:41.557 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.557907 | debian-bookworm | 2026-07-27 03:03:41.557 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-07-27 03:03:41.557924 | debian-bookworm | 2026-07-27 03:03:41.557 | INFO | openstack_image_manager.main:process_image:1020 - Skipping required import of image 'Ubuntu 20.04 (1)', running in dry-run mode 2026-07-27 03:03:41.562091 | debian-bookworm | .2026-07-27 03:03:41.561 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (latest)' 2026-07-27 03:03:41.562428 | debian-bookworm | 2026-07-27 03:03:41.562 | 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-27 03:03:41.566516 | debian-bookworm | .2026-07-27 03:03:41.566 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-1' 2026-07-27 03:03:41.566878 | debian-bookworm | 2026-07-27 03:03:41.566 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-07-27 03:03:41.567431 | debian-bookworm | 2026-07-27 03:03:41.567 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04-1' successfully completed, reloading images 2026-07-27 03:03:41.572448 | debian-bookworm | .2026-07-27 03:03:41.572 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-(1)' 2026-07-27 03:03:41.572474 | debian-bookworm | 2026-07-27 03:03:41.572 | INFO | openstack_image_manager.main:process_image:1025 - Skipping image 'Ubuntu 20.04-(1)' (only importing the latest version from type multi) 2026-07-27 03:03:41.572890 | debian-bookworm | 2026-07-27 03:03:41.572 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-(2)' 2026-07-27 03:03:41.573796 | debian-bookworm | 2026-07-27 03:03:41.573 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com2: 200 2026-07-27 03:03:41.574294 | debian-bookworm | 2026-07-27 03:03:41.574 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04-(2)' successfully completed, reloading images 2026-07-27 03:03:41.588845 | debian-bookworm | ...2026-07-27 03:03:41.588 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.589218 | debian-bookworm | 2026-07-27 03:03:41.588 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-27 03:03:41.589578 | debian-bookworm | 2026-07-27 03:03:41.589 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.589595 | debian-bookworm | 2026-07-27 03:03:41.589 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-27 03:03:41.589600 | debian-bookworm | 2026-07-27 03:03:41.589 | INFO | openstack_image_manager.main:rename_images:1272 - Renaming Ubuntu 20.04 (1) to Ubuntu 20.04 2026-07-27 03:03:41.593148 | debian-bookworm | .2026-07-27 03:03:41.592 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04-(1)' 2026-07-27 03:03:41.593599 | debian-bookworm | 2026-07-27 03:03:41.593 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-27 03:03:41.593955 | debian-bookworm | 2026-07-27 03:03:41.593 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04-(1)' 2026-07-27 03:03:41.593990 | debian-bookworm | 2026-07-27 03:03:41.593 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-27 03:03:41.594244 | debian-bookworm | 2026-07-27 03:03:41.593 | INFO | openstack_image_manager.main:rename_images:1272 - Renaming Ubuntu 20.04-(1) to Ubuntu 20.04 2026-07-27 03:03:41.629611 | debian-bookworm | ..2026-07-27 03:03:41.629 | INFO | openstack_image_manager.main:set_properties:1063 - Checking parameters of 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.629970 | debian-bookworm | 2026-07-27 03:03:41.629 | INFO | openstack_image_manager.main:set_properties:1129 - Setting internal_version = 1 2026-07-27 03:03:41.629988 | debian-bookworm | 2026-07-27 03:03:41.629 | INFO | openstack_image_manager.main:set_properties:1132 - Setting image_original_user = ubuntu 2026-07-27 03:03:41.629993 | debian-bookworm | 2026-07-27 03:03:41.629 | INFO | openstack_image_manager.main:set_properties:1145 - Adding tag my_tag 2026-07-27 03:03:41.630212 | debian-bookworm | 2026-07-27 03:03:41.630 | INFO | openstack_image_manager.main:set_properties:1150 - Deleting tag fake_tag 2026-07-27 03:03:41.630513 | debian-bookworm | 2026-07-27 03:03:41.630 | INFO | openstack_image_manager.main:set_properties:1161 - Setting property image_build_date: 2021-01-01 != 2021-01-21 2026-07-27 03:03:41.630835 | debian-bookworm | 2026-07-27 03:03:41.630 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property os_distro: ubuntu 2026-07-27 03:03:41.631041 | debian-bookworm | 2026-07-27 03:03:41.630 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property os_version: 20.04 2026-07-27 03:03:41.631051 | debian-bookworm | 2026-07-27 03:03:41.630 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property image_source: http://url.com 2026-07-27 03:03:41.631056 | debian-bookworm | 2026-07-27 03:03:41.630 | INFO | openstack_image_manager.main:set_properties:1185 - Checking status of 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.631227 | debian-bookworm | 2026-07-27 03:03:41.630 | INFO | openstack_image_manager.main:set_properties:1190 - Deactivating image 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.631408 | debian-bookworm | 2026-07-27 03:03:41.631 | INFO | openstack_image_manager.main:set_properties:1197 - Checking visibility of 'Ubuntu 20.04 (1)' 2026-07-27 03:03:41.659579 | debian-bookworm | ...2026-07-27 03:03:41.659 | ERROR | openstack_image_manager.main:wait_for_image:814 - Image import timed out 2026-07-27 03:03:41.664033 | debian-bookworm | .2026-07-27 03:03:41.663 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-27 03:03:41.664062 | debian-bookworm | boom 2026-07-27 03:03:41.664525 | debian-bookworm | 2026-07-27 03:03:41.664 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-27 03:03:41.664537 | debian-bookworm | boom 2026-07-27 03:03:41.664542 | debian-bookworm | 2026-07-27 03:03:41.664 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-27 03:03:41.664546 | debian-bookworm | boom 2026-07-27 03:03:41.664550 | debian-bookworm | 2026-07-27 03:03:41.664 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-27 03:03:41.664554 | debian-bookworm | boom 2026-07-27 03:03:41.664558 | debian-bookworm | 2026-07-27 03:03:41.664 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-27 03:03:41.664562 | debian-bookworm | boom 2026-07-27 03:03:41.664915 | debian-bookworm | 2026-07-27 03:03:41.664 | ERROR | openstack_image_manager.main:wait_for_image:848 - Giving up on image after repeated errors 2026-07-27 03:03:41.668885 | debian-bookworm | .2026-07-27 03:03:41.668 | ERROR | openstack_image_manager.main:wait_for_image:837 - Image entered terminal state 'killed' 2026-07-27 03:03:41.673407 | debian-bookworm | .2026-07-27 03:03:41.673 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-27 03:03:41.673433 | debian-bookworm | 2026-07-27 03:03:41.673 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-27 03:03:41.673768 | debian-bookworm | 2026-07-27 03:03:41.673 | ERROR | openstack_image_manager.main:import_image:584 - Web-download import for image Ubuntu 20.04 (1) failed 2026-07-27 03:03:41.673797 | debian-bookworm | glance api error 2026-07-27 03:03:41.673803 | debian-bookworm | 2026-07-27 03:03:41.673 | ERROR | openstack_image_manager.main:import_image:602 - PREFETCH: fallback triggered for 'Ubuntu 20.04 (1)' (web-download failed) 2026-07-27 03:03:41.687566 | debian-bookworm | .......2026-07-27 03:03:41 | INFO  | main:223 - Processing file /tmp/tmpbb_d2qcg/example.yml 2026-07-27 03:03:41.695436 | debian-bookworm | 2026-07-27 03:03:41 | INFO  | update_image:144 - Checking image Example 1.0 2026-07-27 03:03:41.695465 | debian-bookworm | 2026-07-27 03:03:41 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:1111111111111111111111111111111111111111111111111111111111111111 2026-07-27 03:03:41.695802 | debian-bookworm | 2026-07-27 03:03:41 | 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-27 03:03:41.698376 | debian-bookworm | 2026-07-27 03:03:41 | INFO  | main:239 - Dry-run enabled, not writing /tmp/tmpbb_d2qcg/example.yml 2026-07-27 03:03:41.705838 | debian-bookworm | .2026-07-27 03:03:41 | INFO  | main:223 - Processing file /tmp/tmp_7erf5_0/example.yml 2026-07-27 03:03:41.708992 | debian-bookworm | 2026-07-27 03:03:41 | INFO  | update_image:144 - Checking image Example 1.0 2026-07-27 03:03:41.709387 | debian-bookworm | 2026-07-27 03:03:41 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:0000000000000000000000000000000000000000000000000000000000000000 2026-07-27 03:03:41.709406 | debian-bookworm | 2026-07-27 03:03:41 | INFO  | update_image:158 - Image Example 1.0 is up-to-date, nothing to do 2026-07-27 03:03:41.716337 | debian-bookworm | .2026-07-27 03:03:41 | INFO  | main:223 - Processing file /tmp/tmphusa4l6m/example.yml 2026-07-27 03:03:41.719452 | debian-bookworm | 2026-07-27 03:03:41 | INFO  | update_image:144 - Checking image Example 1.0 2026-07-27 03:03:41.719477 | debian-bookworm | 2026-07-27 03:03:41 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:1111111111111111111111111111111111111111111111111111111111111111 2026-07-27 03:03:41.719868 | debian-bookworm | 2026-07-27 03:03:41 | 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-27 03:03:41.722790 | debian-bookworm | . 2026-07-27 03:03:41.722857 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-27 03:03:41.722864 | debian-bookworm | Ran 73 tests in 1.763s 2026-07-27 03:03:41.722869 | debian-bookworm | 2026-07-27 03:03:41.722874 | debian-bookworm | OK 2026-07-27 03:03:41.843550 | debian-bookworm | test: OK (2.46=setup[0.05]+cmd[2.41] seconds) 2026-07-27 03:03:41.843622 | debian-bookworm | congratulations :) (2.50 seconds) 2026-07-27 03:03:42.320884 | debian-bookworm | ok: Runtime: 0:00:02.827990 2026-07-27 03:03:42.330193 | 2026-07-27 03:03:42.330323 | TASK [tox : Look for output] 2026-07-27 03:03:42.781412 | debian-bookworm | ok 2026-07-27 03:03:42.814418 | 2026-07-27 03:03:42.814586 | TASK [tox : Return file comments to Zuul] 2026-07-27 03:03:42.911283 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:42.927196 | 2026-07-27 03:03:42.927324 | PLAY RECAP 2026-07-27 03:03:42.927392 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-27 03:03:42.927422 | 2026-07-27 03:03:43.315189 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-27 03:03:43.318416 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-27 03:03:44.548336 | 2026-07-27 03:03:44.548553 | PLAY [all] 2026-07-27 03:03:44.595372 | 2026-07-27 03:03:44.595651 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-27 03:03:44.692712 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:44.705031 | 2026-07-27 03:03:44.705258 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-27 03:03:44.779930 | debian-bookworm | ok 2026-07-27 03:03:44.786618 | 2026-07-27 03:03:44.786765 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-27 03:03:45.741045 | debian-bookworm -> localhost | changed 2026-07-27 03:03:45.750567 | 2026-07-27 03:03:45.751445 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-27 03:03:45.821540 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:45.828542 | 2026-07-27 03:03:45.828692 | TASK [fetch-tox-output : Set envlist fact] 2026-07-27 03:03:45.904706 | debian-bookworm | ok 2026-07-27 03:03:45.911549 | 2026-07-27 03:03:45.911680 | TASK [fetch-tox-output : Get tox version] 2026-07-27 03:03:47.157945 | 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-27 03:03:47.175758 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-27 03:03:47.486324 | debian-bookworm | ok: Runtime: 0:00:00.326637 2026-07-27 03:03:47.492978 | 2026-07-27 03:03:47.493113 | TASK [fetch-tox-output : Find all default environments] 2026-07-27 03:03:48.047274 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:48.053596 | 2026-07-27 03:03:48.053730 | TASK [fetch-tox-output : Set envlist fact] 2026-07-27 03:03:48.103105 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:48.113209 | 2026-07-27 03:03:48.113325 | TASK [fetch-tox-output : Find all default environments] 2026-07-27 03:03:48.664514 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:48.669496 | 2026-07-27 03:03:48.669586 | TASK [fetch-tox-output : Set envlist fact] 2026-07-27 03:03:48.713243 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:48.720847 | 2026-07-27 03:03:48.720939 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-27 03:03:48.833436 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:48.842098 | 2026-07-27 03:03:48.842204 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-27 03:03:49.633058 | debian-bookworm | changed: 2026-07-27 03:03:49.633208 | debian-bookworm | created directory /var/lib/zuul/builds/b85bb86f97e649638f26c287f55120c3/work/logs/tox/test 2026-07-27 03:03:49.633235 | debian-bookworm | cd+++++++++ ./ 2026-07-27 03:03:49.633256 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-27 03:03:49.633280 | 2026-07-27 03:03:49.640907 | 2026-07-27 03:03:49.640984 | PLAY RECAP 2026-07-27 03:03:49.641034 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-27 03:03:49.641059 | 2026-07-27 03:03:49.964521 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-27 03:03:49.965366 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-27 03:03:50.939442 | 2026-07-27 03:03:50.939571 | PLAY [all] 2026-07-27 03:03:50.956919 | 2026-07-27 03:03:50.957111 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-27 03:03:51.312623 | debian-bookworm | changed: non-zero return code 2026-07-27 03:03:51.342133 | 2026-07-27 03:03:51.342990 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-27 03:03:51.385959 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:51.399355 | 2026-07-27 03:03:51.400132 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-27 03:03:51.420911 | 2026-07-27 03:03:51.421060 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-27 03:03:51.470087 | 2026-07-27 03:03:51.470236 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-27 03:03:51.504275 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:51.511838 | 2026-07-27 03:03:51.511932 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-27 03:03:51.549771 | 2026-07-27 03:03:51.549957 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-27 03:03:51.573122 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:51.579077 | 2026-07-27 03:03:51.579171 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-27 03:03:51.612230 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:51.617212 | 2026-07-27 03:03:51.617302 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-27 03:03:51.650508 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:03:51.661044 | 2026-07-27 03:03:51.661170 | PLAY RECAP 2026-07-27 03:03:51.661226 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-27 03:03:51.661250 | 2026-07-27 03:03:51.864312 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-27 03:03:51.865168 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-27 03:03:53.003871 | 2026-07-27 03:03:53.003997 | PLAY [Base post-fetch] 2026-07-27 03:03:53.044971 | 2026-07-27 03:03:53.045118 | TASK [diagnose-network : Ensure log directory exists] 2026-07-27 03:03:53.630634 | debian-bookworm | ok 2026-07-27 03:03:53.653158 | 2026-07-27 03:03:53.653309 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-27 03:04:06.428404 | debian-bookworm | ok: Runtime: 0:00:05.923508 2026-07-27 03:04:06.444448 | 2026-07-27 03:04:06.444569 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-27 03:04:12.462095 | debian-bookworm | ok: Runtime: 0:00:00.007321 2026-07-27 03:04:12.467636 | 2026-07-27 03:04:12.467763 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-27 03:04:18.455397 | debian-bookworm | ok: Runtime: 0:00:00.009269 2026-07-27 03:04:18.474280 | 2026-07-27 03:04:18.474400 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-27 03:04:18.551725 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:04:18.557690 | 2026-07-27 03:04:18.557814 | TASK [fetch-output : Set log path for single node] 2026-07-27 03:04:18.588253 | debian-bookworm | ok 2026-07-27 03:04:18.593085 | 2026-07-27 03:04:18.593180 | LOOP [fetch-output : Ensure local output dirs] 2026-07-27 03:04:18.898547 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/b85bb86f97e649638f26c287f55120c3/work/logs" 2026-07-27 03:04:19.183648 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b85bb86f97e649638f26c287f55120c3/work/artifacts" 2026-07-27 03:04:19.579873 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b85bb86f97e649638f26c287f55120c3/work/docs" 2026-07-27 03:04:19.595349 | 2026-07-27 03:04:19.595562 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-27 03:04:20.437023 | debian-bookworm | changed: 2026-07-27 03:04:20.437217 | debian-bookworm | .d..t...... ./ 2026-07-27 03:04:20.437253 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-27 03:04:20.437278 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-27 03:04:20.437299 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-27 03:04:20.437320 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-27 03:04:20.437340 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-27 03:04:20.437382 | debian-bookworm | changed: All items complete 2026-07-27 03:04:20.437405 | 2026-07-27 03:04:21.040859 | debian-bookworm | changed: .d..t...... ./ 2026-07-27 03:04:21.798303 | debian-bookworm | changed: .d..t...... ./ 2026-07-27 03:04:21.817101 | 2026-07-27 03:04:21.817208 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-27 03:04:21.865267 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:04:21.868991 | debian-bookworm | skipping: Conditional result was False 2026-07-27 03:04:21.878441 | 2026-07-27 03:04:21.878508 | PLAY RECAP 2026-07-27 03:04:21.878559 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-27 03:04:21.878583 | 2026-07-27 03:04:22.012383 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-27 03:04:22.013394 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-27 03:04:22.864941 | 2026-07-27 03:04:22.865142 | PLAY [Base post] 2026-07-27 03:04:22.890107 | 2026-07-27 03:04:22.890292 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-27 03:04:23.557240 | debian-bookworm | changed 2026-07-27 03:04:23.574060 | 2026-07-27 03:04:23.574219 | PLAY RECAP 2026-07-27 03:04:23.574290 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-27 03:04:23.574353 | 2026-07-27 03:04:24.022677 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-27 03:04:24.029398 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-27 03:04:25.800382 | 2026-07-27 03:04:25.800519 | PLAY [Base post-logs] 2026-07-27 03:04:25.825097 | 2026-07-27 03:04:25.825227 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-27 03:04:27.152491 | localhost | changed 2026-07-27 03:04:27.165364 | 2026-07-27 03:04:27.165553 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-27 03:04:27.203003 | localhost | ok 2026-07-27 03:04:27.205537 | 2026-07-27 03:04:27.205611 | TASK [Set zuul-log-path fact] 2026-07-27 03:04:27.235614 | localhost | ok 2026-07-27 03:04:27.242262 | 2026-07-27 03:04:27.242349 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-27 03:04:27.277410 | localhost | ok 2026-07-27 03:04:27.279976 | 2026-07-27 03:04:27.280051 | TASK [upload-logs : Create log directories] 2026-07-27 03:04:28.323719 | localhost | changed 2026-07-27 03:04:28.326081 | 2026-07-27 03:04:28.326167 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-27 03:04:28.982513 | localhost -> localhost | ok: Runtime: 0:00:00.028978 2026-07-27 03:04:28.986164 | 2026-07-27 03:04:28.986256 | TASK [upload-logs : Upload logs to log server] 2026-07-27 03:04:29.520852 | localhost | Output suppressed because no_log was given 2026-07-27 03:04:29.522478 | 2026-07-27 03:04:29.522566 | LOOP [upload-logs : Compress console log and json output] 2026-07-27 03:04:29.573205 | localhost | skipping: Conditional result was False 2026-07-27 03:04:29.579039 | localhost | skipping: Conditional result was False 2026-07-27 03:04:29.592518 | 2026-07-27 03:04:29.592839 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-27 03:04:29.648467 | localhost | skipping: Conditional result was False 2026-07-27 03:04:29.648750 | 2026-07-27 03:04:29.653070 | localhost | skipping: Conditional result was False 2026-07-27 03:04:29.663022 | 2026-07-27 03:04:29.663135 | LOOP [upload-logs : Upload console log and json output]