2026-07-20 09:29:34.186220 | Job console starting 2026-07-20 09:29:34.206135 | Updating git repos 2026-07-20 09:29:34.265948 | Cloning repos into workspace 2026-07-20 09:29:34.376676 | Restoring repo states 2026-07-20 09:29:34.411640 | Merging changes 2026-07-20 09:29:35.047621 | Checking out repos 2026-07-20 09:29:35.147328 | Preparing playbooks 2026-07-20 09:29:36.207002 | Running Ansible setup 2026-07-20 09:29:41.136327 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-20 09:29:42.050226 | 2026-07-20 09:29:42.050375 | PLAY [Base pre] 2026-07-20 09:29:42.085731 | 2026-07-20 09:29:42.085889 | TASK [Setup log path fact] 2026-07-20 09:29:42.116958 | debian-bookworm | ok 2026-07-20 09:29:42.134785 | 2026-07-20 09:29:42.134967 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-20 09:29:42.162983 | debian-bookworm | ok 2026-07-20 09:29:42.172938 | 2026-07-20 09:29:42.173045 | TASK [emit-job-header : Print job information] 2026-07-20 09:29:42.211608 | # Job Information 2026-07-20 09:29:42.211780 | Ansible Version: 2.16.14 2026-07-20 09:29:42.211814 | Job: tox 2026-07-20 09:29:42.211847 | Pipeline: check 2026-07-20 09:29:42.211893 | Executor: 521e9411259a 2026-07-20 09:29:42.211916 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1256 2026-07-20 09:29:42.211938 | Event ID: ff44dd90-841c-11f1-885c-0e8ae01d4a0c 2026-07-20 09:29:42.216895 | 2026-07-20 09:29:42.216991 | LOOP [emit-job-header : Print node information] 2026-07-20 09:29:42.327064 | debian-bookworm | ok: 2026-07-20 09:29:42.327331 | debian-bookworm | # Node Information 2026-07-20 09:29:42.327368 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-20 09:29:42.327394 | debian-bookworm | Hostname: debian 2026-07-20 09:29:42.327416 | debian-bookworm | Username: zuul 2026-07-20 09:29:42.327437 | debian-bookworm | Distro: Debian 12.15 2026-07-20 09:29:42.327460 | debian-bookworm | Provider: regiocloud-a 2026-07-20 09:29:42.327482 | debian-bookworm | Region: 2026-07-20 09:29:42.327503 | debian-bookworm | Label: debian-bookworm 2026-07-20 09:29:42.327524 | debian-bookworm | Product Name: OpenStack Nova 2026-07-20 09:29:42.327543 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:febc:48c1 2026-07-20 09:29:42.346911 | 2026-07-20 09:29:42.347028 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-20 09:29:42.784771 | debian-bookworm -> localhost | changed 2026-07-20 09:29:42.791790 | 2026-07-20 09:29:42.791930 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-20 09:29:43.744536 | debian-bookworm -> localhost | changed 2026-07-20 09:29:43.755083 | 2026-07-20 09:29:43.755195 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-20 09:29:44.102962 | debian-bookworm -> localhost | ok 2026-07-20 09:29:44.108963 | 2026-07-20 09:29:44.109068 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-20 09:29:44.149119 | debian-bookworm | ok 2026-07-20 09:29:44.170549 | debian-bookworm | included: /var/lib/zuul/builds/2ae8db5c1ffc4187ada132dda42a27c0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-20 09:29:44.176753 | 2026-07-20 09:29:44.176857 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-20 09:29:45.926794 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-20 09:29:45.927050 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2ae8db5c1ffc4187ada132dda42a27c0/work/2ae8db5c1ffc4187ada132dda42a27c0_id_rsa 2026-07-20 09:29:45.927090 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2ae8db5c1ffc4187ada132dda42a27c0/work/2ae8db5c1ffc4187ada132dda42a27c0_id_rsa.pub 2026-07-20 09:29:45.927117 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-20 09:29:45.927144 | debian-bookworm -> localhost | SHA256:CL0LKfCo4HC1qQsdkkAh1c+NNjLhtObdoLS90iDU8d4 zuul-build-sshkey 2026-07-20 09:29:45.927167 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-20 09:29:45.927200 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-20 09:29:45.927223 | debian-bookworm -> localhost | |.+o. | 2026-07-20 09:29:45.927245 | debian-bookworm -> localhost | |o =. | 2026-07-20 09:29:45.927265 | debian-bookworm -> localhost | |o +oB.o | 2026-07-20 09:29:45.927285 | debian-bookworm -> localhost | |.=..O=Oo. | 2026-07-20 09:29:45.927305 | debian-bookworm -> localhost | |*.=+=Xo=S | 2026-07-20 09:29:45.927335 | debian-bookworm -> localhost | |=+.+=.+.E | 2026-07-20 09:29:45.927355 | debian-bookworm -> localhost | |o.o. o.. | 2026-07-20 09:29:45.927375 | debian-bookworm -> localhost | | . .. o | 2026-07-20 09:29:45.927396 | debian-bookworm -> localhost | | . . | 2026-07-20 09:29:45.927416 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-20 09:29:45.927465 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.258984 2026-07-20 09:29:45.945280 | 2026-07-20 09:29:45.945411 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-20 09:29:45.993464 | debian-bookworm | ok 2026-07-20 09:29:46.011799 | debian-bookworm | included: /var/lib/zuul/builds/2ae8db5c1ffc4187ada132dda42a27c0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-20 09:29:46.032219 | 2026-07-20 09:29:46.032340 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-20 09:29:46.066607 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:29:46.077067 | 2026-07-20 09:29:46.077178 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-20 09:29:46.698110 | debian-bookworm | changed 2026-07-20 09:29:46.711230 | 2026-07-20 09:29:46.711462 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-20 09:29:46.985847 | debian-bookworm | ok 2026-07-20 09:29:46.997223 | 2026-07-20 09:29:46.997359 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-20 09:29:47.603872 | debian-bookworm | changed 2026-07-20 09:29:47.610164 | 2026-07-20 09:29:47.610291 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-20 09:29:48.268646 | debian-bookworm | changed 2026-07-20 09:29:48.279066 | 2026-07-20 09:29:48.279238 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-20 09:29:48.304263 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:29:48.316204 | 2026-07-20 09:29:48.316345 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-20 09:29:48.746791 | debian-bookworm -> localhost | changed 2026-07-20 09:29:48.764741 | 2026-07-20 09:29:48.764876 | TASK [add-build-sshkey : Add back temp key] 2026-07-20 09:29:49.065119 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2ae8db5c1ffc4187ada132dda42a27c0/work/2ae8db5c1ffc4187ada132dda42a27c0_id_rsa (zuul-build-sshkey) 2026-07-20 09:29:49.065501 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012390 2026-07-20 09:29:49.080047 | 2026-07-20 09:29:49.080309 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-20 09:29:49.465396 | debian-bookworm | ok 2026-07-20 09:29:49.470521 | 2026-07-20 09:29:49.470615 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-20 09:29:49.493916 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:29:49.504303 | 2026-07-20 09:29:49.504396 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-20 09:29:49.909202 | debian-bookworm | ok 2026-07-20 09:29:49.926627 | 2026-07-20 09:29:49.926772 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-20 09:29:49.957978 | debian-bookworm | ok 2026-07-20 09:29:49.963553 | 2026-07-20 09:29:49.963668 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-20 09:29:50.280158 | debian-bookworm -> localhost | ok 2026-07-20 09:29:50.291230 | 2026-07-20 09:29:50.291369 | TASK [validate-host : Collect information about the host] 2026-07-20 09:29:51.471720 | debian-bookworm | ok 2026-07-20 09:29:51.495255 | 2026-07-20 09:29:51.495445 | TASK [validate-host : Sanitize hostname] 2026-07-20 09:29:51.672162 | debian-bookworm | ok 2026-07-20 09:29:51.677666 | 2026-07-20 09:29:51.677779 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-20 09:29:52.265009 | debian-bookworm -> localhost | changed 2026-07-20 09:29:52.271467 | 2026-07-20 09:29:52.271592 | TASK [validate-host : Collect information about zuul worker] 2026-07-20 09:29:52.692363 | debian-bookworm | ok 2026-07-20 09:29:52.700796 | 2026-07-20 09:29:52.700962 | TASK [validate-host : Write out all zuul information for each host] 2026-07-20 09:29:53.309846 | debian-bookworm -> localhost | changed 2026-07-20 09:29:53.320372 | 2026-07-20 09:29:53.320505 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-20 09:29:53.576900 | debian-bookworm | ok 2026-07-20 09:29:53.590237 | 2026-07-20 09:29:53.590384 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-20 09:29:54.496570 | debian-bookworm | changed: 2026-07-20 09:29:54.496828 | debian-bookworm | cd+++++++++ src/ 2026-07-20 09:29:54.496864 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-20 09:29:54.496889 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-20 09:29:54.496910 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-20 09:29:54.496953 | debian-bookworm | =7.0.3 2026-07-20 09:30:30.025664 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-20 09:30:30.070290 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-20 09:30:30.081708 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-20 09:30:30.148873 | debian-bookworm | Collecting filelock>=3.25 2026-07-20 09:30:30.160737 | debian-bookworm | Downloading filelock-3.31.1-py3-none-any.whl (97 kB) 2026-07-20 09:30:30.170916 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 97.2/97.2 kB 13.2 MB/s eta 0:00:00 2026-07-20 09:30:30.220062 | debian-bookworm | Collecting packaging>=26 2026-07-20 09:30:30.231029 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-20 09:30:30.241456 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 12.8 MB/s eta 0:00:00 2026-07-20 09:30:30.293755 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-20 09:30:30.304836 | debian-bookworm | Downloading platformdirs-4.10.1-py3-none-any.whl (22 kB) 2026-07-20 09:30:30.346908 | debian-bookworm | Collecting pluggy>=1.6 2026-07-20 09:30:30.357801 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-20 09:30:30.399920 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-20 09:30:30.411176 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-20 09:30:30.449354 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-20 09:30:30.460390 | debian-bookworm | Downloading python_discovery-1.4.4-py3-none-any.whl (34 kB) 2026-07-20 09:30:30.493382 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-20 09:30:30.504079 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-20 09:30:30.698577 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-20 09:30:30.710512 | debian-bookworm | Downloading virtualenv-21.6.1-py3-none-any.whl (5.5 MB) 2026-07-20 09:30:30.998446 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 19.5 MB/s eta 0:00:00 2026-07-20 09:30:31.104045 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-20 09:30:31.116724 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-20 09:30:31.136521 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 28.3 MB/s eta 0:00:00 2026-07-20 09:30:31.242381 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-20 09:30:32.014002 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.31.1 packaging-26.2 platformdirs-4.10.1 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.4 tomli-w-1.2.0 tox-4.57.0 virtualenv-21.6.1 2026-07-20 09:30:32.209871 | debian-bookworm | ok: Runtime: 0:00:03.042883 2026-07-20 09:30:32.216757 | 2026-07-20 09:30:32.216887 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-20 09:30:32.278979 | debian-bookworm | ok 2026-07-20 09:30:32.298181 | 2026-07-20 09:30:32.298349 | TASK [ensure-tox : Output tox version] 2026-07-20 09:30:32.969757 | 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-20 09:30:32.987487 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-20 09:30:33.373689 | debian-bookworm | ok: Runtime: 0:00:00.341490 2026-07-20 09:30:33.393305 | 2026-07-20 09:30:33.393443 | TASK [ensure-tox : Make global symlink] 2026-07-20 09:30:33.434442 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:30:33.447100 | 2026-07-20 09:30:33.447218 | PLAY RECAP 2026-07-20 09:30:33.447275 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-20 09:30:33.447301 | 2026-07-20 09:30:33.633487 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-20 09:30:33.635193 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-20 09:30:34.513806 | 2026-07-20 09:30:34.514094 | PLAY [all] 2026-07-20 09:30:34.535123 | 2026-07-20 09:30:34.535298 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-20 09:30:35.052251 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-20 09:30:35.106696 | debian-bookworm | ok: Runtime: 0:00:00.032611 2026-07-20 09:30:35.116752 | 2026-07-20 09:30:35.116911 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-20 09:30:35.646485 | debian-bookworm | ok: Runtime: 0:00:00.006783 2026-07-20 09:30:35.654925 | 2026-07-20 09:30:35.655063 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-20 09:30:36.002898 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-20 09:30:36.006774 | debian-bookworm | sudo: a password is required 2026-07-20 09:30:36.191635 | debian-bookworm | ok: Runtime: 0:00:00.023509 2026-07-20 09:30:36.222913 | 2026-07-20 09:30:36.223147 | TASK [tox : Check to see if the constraints file exists] 2026-07-20 09:30:36.282114 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:30:36.290874 | 2026-07-20 09:30:36.291045 | TASK [tox : Fail if constraints file is missing] 2026-07-20 09:30:36.325663 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:30:36.333129 | 2026-07-20 09:30:36.333282 | TASK [tox : Record file location] 2026-07-20 09:30:36.369631 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:30:36.376980 | 2026-07-20 09:30:36.377188 | TASK [tox : Install tox siblings] 2026-07-20 09:30:36.408889 | debian-bookworm | ok 2026-07-20 09:30:36.423293 | debian-bookworm | included: /var/lib/zuul/builds/2ae8db5c1ffc4187ada132dda42a27c0/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-20 09:30:36.433148 | 2026-07-20 09:30:36.433306 | TASK [tox : Run tox without tests] 2026-07-20 09:30:37.751059 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-20 09:30:50.179957 | debian-bookworm | test: OK (13.16 seconds) 2026-07-20 09:30:50.180049 | debian-bookworm | congratulations :) (13.19 seconds) 2026-07-20 09:30:50.476830 | debian-bookworm | ok: Runtime: 0:00:13.500563 2026-07-20 09:30:50.487800 | 2026-07-20 09:30:50.487949 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-20 09:30:50.947309 | debian-bookworm | changed 2026-07-20 09:30:50.956213 | 2026-07-20 09:30:50.956355 | TASK [tox : Detect tox version] 2026-07-20 09:30:51.541443 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-20 09:30:51.988398 | debian-bookworm | ok: Runtime: 0:00:00.315269 2026-07-20 09:30:52.001869 | 2026-07-20 09:30:52.002040 | TASK [tox : Get tox envlist config] 2026-07-20 09:30:53.035490 | debian-bookworm | ok: Runtime: 0:00:00.366678 2026-07-20 09:30:53.049289 | 2026-07-20 09:30:53.049495 | TASK [tox : Install any sibling python packages] 2026-07-20 09:30:53.545933 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-20 09:30:53.554536 | 2026-07-20 09:30:53.554679 | TASK [tox : Remove tempfile] 2026-07-20 09:30:54.092518 | debian-bookworm | changed 2026-07-20 09:30:54.098025 | 2026-07-20 09:30:54.098135 | TASK [tox : Emit tox command] 2026-07-20 09:30:54.157892 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-20 09:30:54.172100 | 2026-07-20 09:30:54.172403 | TASK [tox : Run tox] 2026-07-20 09:30:54.816308 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-20 09:30:55.357131 | debian-bookworm | ...........2026-07-20 09:30:55.356 | ERROR | contrib.check_updates:main:219 - operational failure: boom 2026-07-20 09:30:55.368494 | debian-bookworm | ........2026-07-20 09:30:55.368 | INFO | openstack_image_manager.main:check_image_age:1271 - Checking for openstack images of age 90 2026-07-20 09:30:55.368991 | debian-bookworm | 2026-07-20 09:30:55.368 | INFO | openstack_image_manager.main:check_image_age:1316 - Image 'Ubuntu 20.04 (1)' was created on 2021-01-01 2026-07-20 09:30:55.369335 | debian-bookworm | 2026-07-20 09:30:55.368 | INFO | openstack_image_manager.main:check_image_age:1271 - Checking for openstack images of age 10 2026-07-20 09:30:55.369364 | debian-bookworm | 2026-07-20 09:30:55.369 | INFO | openstack_image_manager.main:check_image_age:1316 - Image 'Ubuntu 20.04 (1)' was created on 2021-01-01 2026-07-20 09:30:55.369377 | debian-bookworm | 2026-07-20 09:30:55.369 | WARNING | openstack_image_manager.main:check_image_age:1322 - Image 'Ubuntu 20.04 (1)' is 20 days older than the newest image in the definition 2026-07-20 09:30:55.375838 | debian-bookworm | ..2026-07-20 09:30:55.375 | ERROR | openstack_image_manager.main:_download:702 - aria2c is not installed; cannot prefetch image 2026-07-20 09:30:55.379751 | debian-bookworm | .2026-07-20 09:30:55.379 | ERROR | openstack_image_manager.main:_download:733 - aria2c exited with rc=1 for http://x/y 2026-07-20 09:30:55.388327 | debian-bookworm | ..2026-07-20 09:30:55.388 | ERROR | openstack_image_manager.main:_download:727 - aria2c timed out downloading http://x/y 2026-07-20 09:30:55.395767 | debian-bookworm | ..2026-07-20 09:30:55.395 | ERROR | openstack_image_manager.main:get_checksum_from_checksum_url:277 - Failed to fetch checksum file from https://url.com/image.qcow2.sha512: 404 2026-07-20 09:30:55.402598 | debian-bookworm | ..2026-07-20 09:30:55.402 | ERROR | openstack_image_manager.main:get_checksum_from_checksum_url:277 - Failed to fetch checksum file from https://url.com/image.qcow2.sha512: unreachable 2026-07-20 09:30:55.409721 | debian-bookworm | ..2026-07-20 09:30:55.409 | ERROR | openstack_image_manager.main:get_checksum_from_checksums_url:249 - Failed to fetch checksums file from https://url.com/SHA512SUMS: 404 2026-07-20 09:30:55.413381 | debian-bookworm | .2026-07-20 09:30:55.413 | ERROR | openstack_image_manager.main:get_checksum_from_checksums_url:249 - Failed to fetch checksums file from https://url.com/SHA512SUMS: unreachable 2026-07-20 09:30:55.424475 | debian-bookworm | ...2026-07-20 09:30:55.424 | ERROR | openstack_image_manager.main:_has_space_for_download:681 - Not enough disk to prefetch http://x/y: need ~2362232012 bytes, 1073741824 available at /tmp 2026-07-20 09:30:55.428120 | debian-bookworm | .2026-07-20 09:30:55.427 | WARNING | openstack_image_manager.main:_has_space_for_download:672 - No Content-Length for http://x/y; skipping disk check 2026-07-20 09:30:55.432589 | debian-bookworm | .2026-07-20 09:30:55.432 | INFO | openstack_image_manager.main:import_image:508 - Importing image Ubuntu 20.04 (1) 2026-07-20 09:30:55.432951 | debian-bookworm | 2026-07-20 09:30:55.432 | INFO | openstack_image_manager.main:import_image:509 - Importing from URL http://url.com 2026-07-20 09:30:55.734614 | debian-bookworm | 2026-07-20 09:30:55.734 | WARNING | openstack_image_manager.main:_has_space_for_download:672 - No Content-Length for http://url.com; skipping disk check 2026-07-20 09:30:55.740660 | debian-bookworm | 2026-07-20 09:30:55.737 | INFO | openstack_image_manager.main:_prefetch_import:624 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-20 09:30:55.740703 | debian-bookworm | 2026-07-20 09:30:55.737 | INFO | openstack_image_manager.main:_prefetch_import:654 - PREFETCH: glance-direct import succeeded for 'Ubuntu 20.04 (1)' 2026-07-20 09:30:55.747600 | debian-bookworm | .2026-07-20 09:30:55.747 | INFO | openstack_image_manager.main:import_image:508 - Importing image Ubuntu 20.04 (1) 2026-07-20 09:30:55.748128 | debian-bookworm | 2026-07-20 09:30:55.747 | INFO | openstack_image_manager.main:import_image:509 - Importing from URL http://url.com 2026-07-20 09:30:55.756492 | debian-bookworm | 2026-07-20 09:30:55.749 | INFO | openstack_image_manager.main:import_image:508 - Importing image Ubuntu 20.04 (1) 2026-07-20 09:30:55.756526 | debian-bookworm | 2026-07-20 09:30:55.749 | INFO | openstack_image_manager.main:import_image:509 - Importing from URL file:///path/to/file.img 2026-07-20 09:30:55.756567 | debian-bookworm | 2026-07-20 09:30:55.749 | INFO | openstack_image_manager.main:import_image:527 - Importing local file '/path/to/file.img' as image Ubuntu 20.04 (1) 2026-07-20 09:30:55.756581 | debian-bookworm | .2026-07-20 09:30:55.755 | INFO | openstack_image_manager.main:import_image:508 - Importing image Ubuntu 20.04 (1) 2026-07-20 09:30:55.756864 | debian-bookworm | 2026-07-20 09:30:55.756 | INFO | openstack_image_manager.main:import_image:509 - Importing from URL http://url.com 2026-07-20 09:30:55.757891 | debian-bookworm | 2026-07-20 09:30:55.757 | INFO | openstack_image_manager.main:wait_for_image:822 - Waiting for image to leave queued state... 2026-07-20 09:30:55.758754 | debian-bookworm | 2026-07-20 09:30:55.758 | INFO | openstack_image_manager.main:wait_for_image:822 - Waiting for image to leave queued state... 2026-07-20 09:30:55.759224 | debian-bookworm | 2026-07-20 09:30:55.758 | INFO | openstack_image_manager.main:wait_for_image:822 - Waiting for image to leave queued state... 2026-07-20 09:30:55.759641 | debian-bookworm | 2026-07-20 09:30:55.759 | INFO | openstack_image_manager.main:wait_for_image:822 - Waiting for image to leave queued state... 2026-07-20 09:30:55.760039 | debian-bookworm | 2026-07-20 09:30:55.759 | INFO | openstack_image_manager.main:wait_for_image:822 - Waiting for image to leave queued state... 2026-07-20 09:30:55.761247 | debian-bookworm | 2026-07-20 09:30:55.760 | ERROR | openstack_image_manager.main:wait_for_image:818 - Image seems stuck in queued state 2026-07-20 09:30:55.769033 | debian-bookworm | .2026-07-20 09:30:55.768 | INFO | openstack_image_manager.main:import_image:508 - Importing image Ubuntu 20.04 (1) 2026-07-20 09:30:55.769468 | debian-bookworm | 2026-07-20 09:30:55.769 | INFO | openstack_image_manager.main:import_image:509 - Importing from URL http://url.com 2026-07-20 09:30:55.770101 | debian-bookworm | 2026-07-20 09:30:55.769 | INFO | openstack_image_manager.main:wait_for_image:822 - Waiting for image to leave queued state... 2026-07-20 09:30:55.770818 | debian-bookworm | 2026-07-20 09:30:55.770 | INFO | openstack_image_manager.main:wait_for_image:822 - Waiting for image to leave queued state... 2026-07-20 09:30:55.771218 | debian-bookworm | 2026-07-20 09:30:55.770 | INFO | openstack_image_manager.main:wait_for_image:822 - Waiting for image to leave queued state... 2026-07-20 09:30:55.771565 | debian-bookworm | 2026-07-20 09:30:55.771 | INFO | openstack_image_manager.main:wait_for_image:822 - Waiting for image to leave queued state... 2026-07-20 09:30:55.771590 | debian-bookworm | 2026-07-20 09:30:55.771 | INFO | openstack_image_manager.main:wait_for_image:822 - Waiting for image to leave queued state... 2026-07-20 09:30:55.772528 | debian-bookworm | 2026-07-20 09:30:55.772 | ERROR | openstack_image_manager.main:wait_for_image:818 - Image seems stuck in queued state 2026-07-20 09:30:55.772567 | debian-bookworm | 2026-07-20 09:30:55.772 | ERROR | openstack_image_manager.main:import_image:590 - PREFETCH: fallback triggered for 'Ubuntu 20.04 (1)' (web-download failed) 2026-07-20 09:30:56.043474 | debian-bookworm | 2026-07-20 09:30:56.042 | WARNING | openstack_image_manager.main:_has_space_for_download:672 - No Content-Length for http://url.com; skipping disk check 2026-07-20 09:30:56.046398 | debian-bookworm | 2026-07-20 09:30:56.046 | INFO | openstack_image_manager.main:_prefetch_import:624 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.047097 | debian-bookworm | 2026-07-20 09:30:56.046 | INFO | openstack_image_manager.main:_prefetch_import:654 - PREFETCH: glance-direct import succeeded for 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.068051 | debian-bookworm | ...2026-07-20 09:30:56.067 | ERROR | openstack_image_manager.main:main:356 - Skipping cleanup of outdated images because of previous errors 2026-07-20 09:30:56.152422 | debian-bookworm | .2026-07-20 09:30:56.152 | INFO | openstack_image_manager.main:manage_outdated_images:1366 - Processing image 'Ubuntu 20.04' (removal candidate) 2026-07-20 09:30:56.157237 | debian-bookworm | .2026-07-20 09:30:56.157 | INFO | openstack_image_manager.main:manage_outdated_images:1366 - Processing image 'Ubuntu 20.04_2' (removal candidate) 2026-07-20 09:30:56.157579 | debian-bookworm | 2026-07-20 09:30:56.157 | INFO | openstack_image_manager.main:manage_outdated_images:1406 - Deactivating image 'Ubuntu 20.04_2' 2026-07-20 09:30:56.157977 | debian-bookworm | 2026-07-20 09:30:56.157 | INFO | openstack_image_manager.main:manage_outdated_images:1409 - Setting visibility of 'Ubuntu 20.04_2' to 'community' 2026-07-20 09:30:56.158519 | debian-bookworm | 2026-07-20 09:30:56.158 | INFO | openstack_image_manager.main:manage_outdated_images:1418 - Deleting Ubuntu 20.04_2 2026-07-20 09:30:56.159350 | debian-bookworm | 2026-07-20 09:30:56.159 | INFO | openstack_image_manager.main:manage_outdated_images:1366 - Processing image 'Ubuntu 20.04_2' (removal candidate) 2026-07-20 09:30:56.159671 | debian-bookworm | 2026-07-20 09:30:56.159 | INFO | openstack_image_manager.main:manage_outdated_images:1406 - Deactivating image 'Ubuntu 20.04_2' 2026-07-20 09:30:56.159699 | debian-bookworm | 2026-07-20 09:30:56.159 | INFO | openstack_image_manager.main:manage_outdated_images:1409 - Setting visibility of 'Ubuntu 20.04_2' to 'community' 2026-07-20 09:30:56.159943 | debian-bookworm | 2026-07-20 09:30:56.159 | INFO | openstack_image_manager.main:manage_outdated_images:1421 - Image 'Ubuntu 20.04_2' will not be deleted, because 'keep' flag is True 2026-07-20 09:30:56.163301 | debian-bookworm | .2026-07-20 09:30:56.163 | INFO | openstack_image_manager.main:import_image:508 - Importing image Ubuntu 20.04 (1) 2026-07-20 09:30:56.163685 | debian-bookworm | 2026-07-20 09:30:56.163 | INFO | openstack_image_manager.main:import_image:509 - Importing from URL http://url.com 2026-07-20 09:30:56.167576 | debian-bookworm | .2026-07-20 09:30:56.167 | INFO | openstack_image_manager.main:import_image:508 - Importing image Ubuntu 20.04 (1) 2026-07-20 09:30:56.167918 | debian-bookworm | 2026-07-20 09:30:56.167 | INFO | openstack_image_manager.main:import_image:509 - Importing from URL http://url.com 2026-07-20 09:30:56.417638 | debian-bookworm | 2026-07-20 09:30:56.417 | WARNING | openstack_image_manager.main:_has_space_for_download:672 - No Content-Length for http://url.com; skipping disk check 2026-07-20 09:30:56.424588 | debian-bookworm | 2026-07-20 09:30:56.420 | INFO | openstack_image_manager.main:_prefetch_import:624 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.424629 | debian-bookworm | 2026-07-20 09:30:56.420 | ERROR | openstack_image_manager.main:_prefetch_import:643 - glance-direct import failed for Ubuntu 20.04 (1) 2026-07-20 09:30:56.424643 | debian-bookworm | 409 conflict on fixed id 2026-07-20 09:30:56.424662 | debian-bookworm | 2026-07-20 09:30:56.421 | ERROR | openstack_image_manager.main:_prefetch_import:646 - PREFETCH: glance-direct import failed for 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.431092 | debian-bookworm | .2026-07-20 09:30:56.430 | INFO | openstack_image_manager.main:import_image:508 - Importing image Ubuntu 20.04 (1) 2026-07-20 09:30:56.431682 | debian-bookworm | 2026-07-20 09:30:56.431 | INFO | openstack_image_manager.main:import_image:509 - Importing from URL http://url.com 2026-07-20 09:30:56.693619 | debian-bookworm | 2026-07-20 09:30:56.693 | WARNING | openstack_image_manager.main:_has_space_for_download:672 - No Content-Length for http://url.com; skipping disk check 2026-07-20 09:30:56.700518 | debian-bookworm | 2026-07-20 09:30:56.695 | INFO | openstack_image_manager.main:_prefetch_import:624 - PREFETCH: aria2 download failed for 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.706792 | debian-bookworm | .2026-07-20 09:30:56.706 | INFO | openstack_image_manager.main:process_image:874 - Processing image 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.708491 | debian-bookworm | 2026-07-20 09:30:56.707 | INFO | openstack_image_manager.main:process_image:980 - Tested URL http://url.com: 200 2026-07-20 09:30:56.708528 | debian-bookworm | 2026-07-20 09:30:56.708 | INFO | openstack_image_manager.main:process_image:1002 - Import of 'Ubuntu 20.04 (1)' successfully completed, reloading images 2026-07-20 09:30:56.714508 | debian-bookworm | 2026-07-20 09:30:56.710 | INFO | openstack_image_manager.main:process_image:874 - Processing image 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.714536 | debian-bookworm | 2026-07-20 09:30:56.710 | INFO | openstack_image_manager.main:process_image:1002 - Import of 'Ubuntu 20.04 (1)' successfully completed, reloading images 2026-07-20 09:30:56.714551 | debian-bookworm | 2026-07-20 09:30:56.710 | INFO | openstack_image_manager.main:process_image:874 - Processing image 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.714584 | debian-bookworm | 2026-07-20 09:30:56.710 | INFO | openstack_image_manager.main:process_image:980 - Tested URL http://url.com: 200 2026-07-20 09:30:56.714597 | debian-bookworm | 2026-07-20 09:30:56.710 | INFO | openstack_image_manager.main:process_image:1008 - Skipping required import of image 'Ubuntu 20.04 (1)', running in dry-run mode 2026-07-20 09:30:56.716502 | debian-bookworm | .2026-07-20 09:30:56.715 | INFO | openstack_image_manager.main:process_image:874 - Processing image 'Ubuntu 20.04 (latest)' 2026-07-20 09:30:56.716527 | debian-bookworm | 2026-07-20 09:30:56.715 | ERROR | openstack_image_manager.main:process_image:936 - Could not find checksum for image 'Ubuntu 20.04', check the checksums_url or checksum_url 2026-07-20 09:30:56.724400 | debian-bookworm | .2026-07-20 09:30:56.720 | INFO | openstack_image_manager.main:process_image:874 - Processing image 'Ubuntu 20.04-1' 2026-07-20 09:30:56.724429 | debian-bookworm | 2026-07-20 09:30:56.721 | INFO | openstack_image_manager.main:process_image:980 - Tested URL http://url.com: 200 2026-07-20 09:30:56.724441 | debian-bookworm | 2026-07-20 09:30:56.721 | INFO | openstack_image_manager.main:process_image:1002 - Import of 'Ubuntu 20.04-1' successfully completed, reloading images 2026-07-20 09:30:56.727192 | debian-bookworm | .2026-07-20 09:30:56.726 | INFO | openstack_image_manager.main:process_image:874 - Processing image 'Ubuntu 20.04-(1)' 2026-07-20 09:30:56.732509 | debian-bookworm | 2026-07-20 09:30:56.727 | INFO | openstack_image_manager.main:process_image:1013 - Skipping image 'Ubuntu 20.04-(1)' (only importing the latest version from type multi) 2026-07-20 09:30:56.732540 | debian-bookworm | 2026-07-20 09:30:56.727 | INFO | openstack_image_manager.main:process_image:874 - Processing image 'Ubuntu 20.04-(2)' 2026-07-20 09:30:56.732552 | debian-bookworm | 2026-07-20 09:30:56.728 | INFO | openstack_image_manager.main:process_image:980 - Tested URL http://url.com2: 200 2026-07-20 09:30:56.732564 | debian-bookworm | 2026-07-20 09:30:56.729 | INFO | openstack_image_manager.main:process_image:1002 - Import of 'Ubuntu 20.04-(2)' successfully completed, reloading images 2026-07-20 09:30:56.744515 | debian-bookworm | ...2026-07-20 09:30:56.744 | INFO | openstack_image_manager.main:rename_images:1250 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.748508 | debian-bookworm | 2026-07-20 09:30:56.744 | INFO | openstack_image_manager.main:rename_images:1253 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-20 09:30:56.748549 | debian-bookworm | 2026-07-20 09:30:56.745 | INFO | openstack_image_manager.main:rename_images:1250 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.748561 | debian-bookworm | 2026-07-20 09:30:56.745 | INFO | openstack_image_manager.main:rename_images:1253 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-20 09:30:56.748573 | debian-bookworm | 2026-07-20 09:30:56.745 | INFO | openstack_image_manager.main:rename_images:1260 - Renaming Ubuntu 20.04 (1) to Ubuntu 20.04 2026-07-20 09:30:56.756508 | debian-bookworm | .2026-07-20 09:30:56.748 | INFO | openstack_image_manager.main:rename_images:1250 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04-(1)' 2026-07-20 09:30:56.756554 | debian-bookworm | 2026-07-20 09:30:56.748 | INFO | openstack_image_manager.main:rename_images:1253 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-20 09:30:56.756574 | debian-bookworm | 2026-07-20 09:30:56.749 | INFO | openstack_image_manager.main:rename_images:1250 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04-(1)' 2026-07-20 09:30:56.756599 | debian-bookworm | 2026-07-20 09:30:56.749 | INFO | openstack_image_manager.main:rename_images:1253 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-20 09:30:56.756611 | debian-bookworm | 2026-07-20 09:30:56.749 | INFO | openstack_image_manager.main:rename_images:1260 - Renaming Ubuntu 20.04-(1) to Ubuntu 20.04 2026-07-20 09:30:56.782661 | debian-bookworm | ..2026-07-20 09:30:56.782 | INFO | openstack_image_manager.main:set_properties:1051 - Checking parameters of 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.784460 | debian-bookworm | 2026-07-20 09:30:56.782 | INFO | openstack_image_manager.main:set_properties:1117 - Setting internal_version = 1 2026-07-20 09:30:56.784510 | debian-bookworm | 2026-07-20 09:30:56.782 | INFO | openstack_image_manager.main:set_properties:1120 - Setting image_original_user = ubuntu 2026-07-20 09:30:56.784523 | debian-bookworm | 2026-07-20 09:30:56.782 | INFO | openstack_image_manager.main:set_properties:1133 - Adding tag my_tag 2026-07-20 09:30:56.784543 | debian-bookworm | 2026-07-20 09:30:56.783 | INFO | openstack_image_manager.main:set_properties:1138 - Deleting tag fake_tag 2026-07-20 09:30:56.784555 | debian-bookworm | 2026-07-20 09:30:56.783 | INFO | openstack_image_manager.main:set_properties:1149 - Setting property image_build_date: 2021-01-01 != 2021-01-21 2026-07-20 09:30:56.784566 | debian-bookworm | 2026-07-20 09:30:56.783 | INFO | openstack_image_manager.main:set_properties:1166 - Setting property os_distro: ubuntu 2026-07-20 09:30:56.784578 | debian-bookworm | 2026-07-20 09:30:56.783 | INFO | openstack_image_manager.main:set_properties:1166 - Setting property os_version: 20.04 2026-07-20 09:30:56.784589 | debian-bookworm | 2026-07-20 09:30:56.783 | INFO | openstack_image_manager.main:set_properties:1166 - Setting property image_source: http://url.com 2026-07-20 09:30:56.784600 | debian-bookworm | 2026-07-20 09:30:56.783 | INFO | openstack_image_manager.main:set_properties:1173 - Checking status of 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.784610 | debian-bookworm | 2026-07-20 09:30:56.783 | INFO | openstack_image_manager.main:set_properties:1178 - Deactivating image 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.784621 | debian-bookworm | 2026-07-20 09:30:56.784 | INFO | openstack_image_manager.main:set_properties:1185 - Checking visibility of 'Ubuntu 20.04 (1)' 2026-07-20 09:30:56.812576 | debian-bookworm | ...2026-07-20 09:30:56.812 | ERROR | openstack_image_manager.main:wait_for_image:802 - Image import timed out 2026-07-20 09:30:56.817250 | debian-bookworm | .2026-07-20 09:30:56.817 | ERROR | openstack_image_manager.main:wait_for_image:834 - Exception while importing image 2026-07-20 09:30:56.817293 | debian-bookworm | boom 2026-07-20 09:30:56.817818 | debian-bookworm | 2026-07-20 09:30:56.817 | ERROR | openstack_image_manager.main:wait_for_image:834 - Exception while importing image 2026-07-20 09:30:56.817842 | debian-bookworm | boom 2026-07-20 09:30:56.818193 | debian-bookworm | 2026-07-20 09:30:56.817 | ERROR | openstack_image_manager.main:wait_for_image:834 - Exception while importing image 2026-07-20 09:30:56.818217 | debian-bookworm | boom 2026-07-20 09:30:56.818527 | debian-bookworm | 2026-07-20 09:30:56.818 | ERROR | openstack_image_manager.main:wait_for_image:834 - Exception while importing image 2026-07-20 09:30:56.818551 | debian-bookworm | boom 2026-07-20 09:30:56.818563 | debian-bookworm | 2026-07-20 09:30:56.818 | ERROR | openstack_image_manager.main:wait_for_image:834 - Exception while importing image 2026-07-20 09:30:56.818576 | debian-bookworm | boom 2026-07-20 09:30:56.818874 | debian-bookworm | 2026-07-20 09:30:56.818 | ERROR | openstack_image_manager.main:wait_for_image:836 - Giving up on image after repeated errors 2026-07-20 09:30:56.823110 | debian-bookworm | .2026-07-20 09:30:56.822 | ERROR | openstack_image_manager.main:wait_for_image:825 - Image entered terminal state 'killed' 2026-07-20 09:30:56.827782 | debian-bookworm | .2026-07-20 09:30:56.827 | INFO | openstack_image_manager.main:import_image:508 - Importing image Ubuntu 20.04 (1) 2026-07-20 09:30:56.828178 | debian-bookworm | 2026-07-20 09:30:56.827 | INFO | openstack_image_manager.main:import_image:509 - Importing from URL http://url.com 2026-07-20 09:30:56.828549 | debian-bookworm | 2026-07-20 09:30:56.828 | ERROR | openstack_image_manager.main:import_image:572 - Web-download import for image Ubuntu 20.04 (1) failed 2026-07-20 09:30:56.828576 | debian-bookworm | glance api error 2026-07-20 09:30:56.828589 | debian-bookworm | 2026-07-20 09:30:56.828 | ERROR | openstack_image_manager.main:import_image:590 - PREFETCH: fallback triggered for 'Ubuntu 20.04 (1)' (web-download failed) 2026-07-20 09:30:56.828882 | debian-bookworm | . 2026-07-20 09:30:56.828924 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-20 09:30:56.828936 | debian-bookworm | Ran 64 tests in 1.497s 2026-07-20 09:30:56.828957 | debian-bookworm | 2026-07-20 09:30:56.828969 | debian-bookworm | OK 2026-07-20 09:30:56.921662 | debian-bookworm | test: OK (2.15=setup[0.05]+cmd[2.10] seconds) 2026-07-20 09:30:56.921730 | debian-bookworm | congratulations :) (2.18 seconds) 2026-07-20 09:30:57.245279 | debian-bookworm | ok: Runtime: 0:00:02.487917 2026-07-20 09:30:57.252597 | 2026-07-20 09:30:57.252703 | TASK [tox : Look for output] 2026-07-20 09:30:57.654300 | debian-bookworm | ok 2026-07-20 09:30:57.668518 | 2026-07-20 09:30:57.668670 | TASK [tox : Return file comments to Zuul] 2026-07-20 09:30:57.703127 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:30:57.711295 | 2026-07-20 09:30:57.711397 | PLAY RECAP 2026-07-20 09:30:57.711456 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-20 09:30:57.711482 | 2026-07-20 09:30:57.868386 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-20 09:30:57.869605 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-20 09:30:58.676522 | 2026-07-20 09:30:58.676726 | PLAY [all] 2026-07-20 09:30:58.693739 | 2026-07-20 09:30:58.693920 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-20 09:30:58.749499 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:30:58.755833 | 2026-07-20 09:30:58.756002 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-20 09:30:58.801300 | debian-bookworm | ok 2026-07-20 09:30:58.806660 | 2026-07-20 09:30:58.806782 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-20 09:30:59.354726 | debian-bookworm -> localhost | changed 2026-07-20 09:30:59.363352 | 2026-07-20 09:30:59.363484 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-20 09:30:59.417851 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:30:59.424731 | 2026-07-20 09:30:59.424849 | TASK [fetch-tox-output : Set envlist fact] 2026-07-20 09:30:59.463452 | debian-bookworm | ok 2026-07-20 09:30:59.469323 | 2026-07-20 09:30:59.469435 | TASK [fetch-tox-output : Get tox version] 2026-07-20 09:31:00.191343 | 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-20 09:31:00.209265 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-20 09:31:00.507696 | debian-bookworm | ok: Runtime: 0:00:00.338675 2026-07-20 09:31:00.514026 | 2026-07-20 09:31:00.514159 | TASK [fetch-tox-output : Find all default environments] 2026-07-20 09:31:01.046079 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:01.059672 | 2026-07-20 09:31:01.059868 | TASK [fetch-tox-output : Set envlist fact] 2026-07-20 09:31:01.085237 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:01.091587 | 2026-07-20 09:31:01.091710 | TASK [fetch-tox-output : Find all default environments] 2026-07-20 09:31:01.625724 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:01.632326 | 2026-07-20 09:31:01.632459 | TASK [fetch-tox-output : Set envlist fact] 2026-07-20 09:31:01.697961 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:01.705672 | 2026-07-20 09:31:01.705811 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-20 09:31:01.806910 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:01.817671 | 2026-07-20 09:31:01.817881 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-20 09:31:02.645466 | debian-bookworm | changed: 2026-07-20 09:31:02.645759 | debian-bookworm | created directory /var/lib/zuul/builds/2ae8db5c1ffc4187ada132dda42a27c0/work/logs/tox/test 2026-07-20 09:31:02.645811 | debian-bookworm | cd+++++++++ ./ 2026-07-20 09:31:02.645847 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-20 09:31:02.645890 | 2026-07-20 09:31:02.660324 | 2026-07-20 09:31:02.660465 | PLAY RECAP 2026-07-20 09:31:02.660524 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-20 09:31:02.660549 | 2026-07-20 09:31:02.822360 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-20 09:31:02.823533 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-20 09:31:03.623609 | 2026-07-20 09:31:03.623891 | PLAY [all] 2026-07-20 09:31:03.641515 | 2026-07-20 09:31:03.641677 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-20 09:31:03.890332 | debian-bookworm | changed: non-zero return code 2026-07-20 09:31:03.897631 | 2026-07-20 09:31:03.897787 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-20 09:31:03.922622 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:03.930267 | 2026-07-20 09:31:03.930407 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-20 09:31:03.963670 | 2026-07-20 09:31:03.963897 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-20 09:31:04.008195 | 2026-07-20 09:31:04.008433 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-20 09:31:04.032956 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:04.039635 | 2026-07-20 09:31:04.039762 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-20 09:31:04.077083 | 2026-07-20 09:31:04.077405 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-20 09:31:04.102314 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:04.109502 | 2026-07-20 09:31:04.109639 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-20 09:31:04.133541 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:04.140515 | 2026-07-20 09:31:04.140639 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-20 09:31:04.164379 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:04.174112 | 2026-07-20 09:31:04.174232 | PLAY RECAP 2026-07-20 09:31:04.174300 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-20 09:31:04.174344 | 2026-07-20 09:31:04.323244 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-20 09:31:04.324430 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-20 09:31:05.092429 | 2026-07-20 09:31:05.092617 | PLAY [Base post-fetch] 2026-07-20 09:31:05.107716 | 2026-07-20 09:31:05.107868 | TASK [diagnose-network : Ensure log directory exists] 2026-07-20 09:31:05.500357 | debian-bookworm | ok 2026-07-20 09:31:05.512600 | 2026-07-20 09:31:05.512809 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-20 09:31:17.589174 | debian-bookworm | ok: Runtime: 0:00:05.852910 2026-07-20 09:31:17.597709 | 2026-07-20 09:31:17.597871 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-20 09:31:23.655295 | debian-bookworm | ok: Runtime: 0:00:00.010123 2026-07-20 09:31:23.663217 | 2026-07-20 09:31:23.663468 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-20 09:31:29.721671 | debian-bookworm | ok: Runtime: 0:00:00.009192 2026-07-20 09:31:29.736622 | 2026-07-20 09:31:29.736759 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-20 09:31:29.793888 | debian-bookworm | skipping: Conditional result was False 2026-07-20 09:31:29.806776 | 2026-07-20 09:31:29.807017 | TASK [fetch-output : Set log path for single node] 2026-07-20 09:31:29.869842 | debian-bookworm | ok 2026-07-20 09:31:29.878627 | 2026-07-20 09:31:29.878791 | LOOP [fetch-output : Ensure local output dirs] 2026-07-20 09:31:30.207016 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/2ae8db5c1ffc4187ada132dda42a27c0/work/logs" 2026-07-20 09:31:30.480916 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2ae8db5c1ffc4187ada132dda42a27c0/work/artifacts" 2026-07-20 09:31:30.767542 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2ae8db5c1ffc4187ada132dda42a27c0/work/docs" 2026-07-20 09:31:30.787770 | 2026-07-20 09:31:30.787980 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-20 09:31:31.621474 | debian-bookworm | changed: 2026-07-20 09:31:31.621864 | debian-bookworm | .d..t...... ./ 2026-07-20 09:31:31.621927 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-20 09:31:31.621970 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-20 09:31:31.622009 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-20 09:31:31.622052 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-20 09:31:31.622090 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-20 09:31:31.622161 | debian-bookworm | changed: All items complete 2026-07-20 09:31:31.622207 | 2026-07-20 09:31:32.206412 | debian-bookworm | changed: .d..t...... ./ 2026-07-20 09:31:32.809955 | debian-bookworm | changed: .d..t...... ./ 2026-07-20 09:31:32.823553 | 2026-07-20 09:31:32.823691 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-20 09:31:33.189530 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011897 2026-07-20 09:31:33.509506 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011348 2026-07-20 09:31:33.525979 | 2026-07-20 09:31:33.526109 | PLAY RECAP 2026-07-20 09:31:33.526182 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-20 09:31:33.526218 | 2026-07-20 09:31:33.672478 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-20 09:31:33.673703 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-20 09:31:34.474505 | 2026-07-20 09:31:34.474704 | PLAY [Base post] 2026-07-20 09:31:34.489099 | 2026-07-20 09:31:34.489261 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-20 09:31:35.108495 | debian-bookworm | changed 2026-07-20 09:31:35.117248 | 2026-07-20 09:31:35.117411 | PLAY RECAP 2026-07-20 09:31:35.117501 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-20 09:31:35.117603 | 2026-07-20 09:31:35.276217 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-20 09:31:35.279147 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-20 09:31:36.128905 | 2026-07-20 09:31:36.129163 | PLAY [Base post-logs] 2026-07-20 09:31:36.140607 | 2026-07-20 09:31:36.140765 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-20 09:31:36.630753 | localhost | changed 2026-07-20 09:31:36.644249 | 2026-07-20 09:31:36.644450 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-20 09:31:36.672318 | localhost | ok 2026-07-20 09:31:36.678712 | 2026-07-20 09:31:36.678896 | TASK [Set zuul-log-path fact] 2026-07-20 09:31:36.696596 | localhost | ok 2026-07-20 09:31:36.708471 | 2026-07-20 09:31:36.708623 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-20 09:31:36.734386 | localhost | ok 2026-07-20 09:31:36.738302 | 2026-07-20 09:31:36.738420 | TASK [upload-logs : Create log directories] 2026-07-20 09:31:37.262148 | localhost | changed 2026-07-20 09:31:37.265115 | 2026-07-20 09:31:37.265232 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-20 09:31:37.787141 | localhost -> localhost | ok: Runtime: 0:00:00.007561 2026-07-20 09:31:37.791638 | 2026-07-20 09:31:37.791761 | TASK [upload-logs : Upload logs to log server] 2026-07-20 09:31:38.404491 | localhost | Output suppressed because no_log was given 2026-07-20 09:31:38.409055 | 2026-07-20 09:31:38.409298 | LOOP [upload-logs : Compress console log and json output] 2026-07-20 09:31:38.467177 | localhost | skipping: Conditional result was False 2026-07-20 09:31:38.473974 | localhost | skipping: Conditional result was False 2026-07-20 09:31:38.485683 | 2026-07-20 09:31:38.485952 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-20 09:31:38.549130 | localhost | skipping: Conditional result was False 2026-07-20 09:31:38.549514 | 2026-07-20 09:31:38.552345 | localhost | skipping: Conditional result was False 2026-07-20 09:31:38.557919 | 2026-07-20 09:31:38.558140 | LOOP [upload-logs : Upload console log and json output]