2026-07-23 20:31:21.393387 | Job console starting 2026-07-23 20:31:21.417069 | Updating git repos 2026-07-23 20:31:21.502172 | Cloning repos into workspace 2026-07-23 20:31:21.596973 | Restoring repo states 2026-07-23 20:31:21.610421 | Merging changes 2026-07-23 20:31:22.504983 | Checking out repos 2026-07-23 20:31:22.567981 | Preparing playbooks 2026-07-23 20:31:24.116502 | Running Ansible setup 2026-07-23 20:31:31.203856 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-23 20:31:32.605298 | 2026-07-23 20:31:32.605425 | PLAY [Base pre] 2026-07-23 20:31:32.646052 | 2026-07-23 20:31:32.646189 | TASK [Setup log path fact] 2026-07-23 20:31:32.683685 | debian-bookworm | ok 2026-07-23 20:31:32.722380 | 2026-07-23 20:31:32.722529 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-23 20:31:32.759806 | debian-bookworm | ok 2026-07-23 20:31:32.768343 | 2026-07-23 20:31:32.768458 | TASK [emit-job-header : Print job information] 2026-07-23 20:31:32.848111 | # Job Information 2026-07-23 20:31:32.848268 | Ansible Version: 2.16.14 2026-07-23 20:31:32.848298 | Job: tox 2026-07-23 20:31:32.848326 | Pipeline: check 2026-07-23 20:31:32.848345 | Executor: 521e9411259a 2026-07-23 20:31:32.848363 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1257 2026-07-23 20:31:32.848381 | Event ID: 6ff46640-86d5-11f1-869a-57bb805b01b5 2026-07-23 20:31:32.853497 | 2026-07-23 20:31:32.853602 | LOOP [emit-job-header : Print node information] 2026-07-23 20:31:32.991746 | debian-bookworm | ok: 2026-07-23 20:31:32.991917 | debian-bookworm | # Node Information 2026-07-23 20:31:32.991947 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-23 20:31:32.991968 | debian-bookworm | Hostname: debian 2026-07-23 20:31:32.991987 | debian-bookworm | Username: zuul 2026-07-23 20:31:32.992004 | debian-bookworm | Distro: Debian 12.15 2026-07-23 20:31:32.992048 | debian-bookworm | Provider: regiocloud-a 2026-07-23 20:31:32.992069 | debian-bookworm | Region: 2026-07-23 20:31:32.992087 | debian-bookworm | Label: debian-bookworm 2026-07-23 20:31:32.992104 | debian-bookworm | Product Name: OpenStack Nova 2026-07-23 20:31:32.992121 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe48:d910 2026-07-23 20:31:33.005961 | 2026-07-23 20:31:33.006087 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-23 20:31:34.229482 | debian-bookworm -> localhost | changed 2026-07-23 20:31:34.235787 | 2026-07-23 20:31:34.235885 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-23 20:31:35.722556 | debian-bookworm -> localhost | changed 2026-07-23 20:31:35.737703 | 2026-07-23 20:31:35.737822 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-23 20:31:36.746769 | debian-bookworm -> localhost | ok 2026-07-23 20:31:36.775307 | 2026-07-23 20:31:36.775427 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-23 20:31:36.857825 | debian-bookworm | ok 2026-07-23 20:31:36.912474 | debian-bookworm | included: /var/lib/zuul/builds/07641d49db604e83a52a8578363d1b05/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-23 20:31:36.924443 | 2026-07-23 20:31:36.924540 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-23 20:31:41.350694 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-23 20:31:41.350920 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/07641d49db604e83a52a8578363d1b05/work/07641d49db604e83a52a8578363d1b05_id_rsa 2026-07-23 20:31:41.350960 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/07641d49db604e83a52a8578363d1b05/work/07641d49db604e83a52a8578363d1b05_id_rsa.pub 2026-07-23 20:31:41.351016 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-23 20:31:41.351044 | debian-bookworm -> localhost | SHA256:9ayapkqWIEsrT+RVAS64Nr31CVFPw2xx4KlULoOgaHw zuul-build-sshkey 2026-07-23 20:31:41.351066 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-23 20:31:41.351095 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-23 20:31:41.351117 | debian-bookworm -> localhost | | .....o*o. | 2026-07-23 20:31:41.351139 | debian-bookworm -> localhost | |o.... o.*++ | 2026-07-23 20:31:41.351159 | debian-bookworm -> localhost | |o+.E.o.+.=. | 2026-07-23 20:31:41.351179 | debian-bookworm -> localhost | |..o. .o +. o | 2026-07-23 20:31:41.351198 | debian-bookworm -> localhost | |o+o..o .S o | 2026-07-23 20:31:41.351228 | debian-bookworm -> localhost | |o=ooo.o . . | 2026-07-23 20:31:41.351248 | debian-bookworm -> localhost | |o.o.+ o . | 2026-07-23 20:31:41.351268 | debian-bookworm -> localhost | |.o o .o | 2026-07-23 20:31:41.351288 | debian-bookworm -> localhost | | . ...oo | 2026-07-23 20:31:41.351307 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-23 20:31:41.351357 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.474108 2026-07-23 20:31:41.357623 | 2026-07-23 20:31:41.357726 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-23 20:31:41.378043 | debian-bookworm | ok 2026-07-23 20:31:41.389490 | debian-bookworm | included: /var/lib/zuul/builds/07641d49db604e83a52a8578363d1b05/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-23 20:31:41.397862 | 2026-07-23 20:31:41.397963 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-23 20:31:41.411491 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:31:41.417751 | 2026-07-23 20:31:41.417854 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-23 20:31:42.101999 | debian-bookworm | changed 2026-07-23 20:31:42.109551 | 2026-07-23 20:31:42.109655 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-23 20:31:42.371333 | debian-bookworm | ok 2026-07-23 20:31:42.380209 | 2026-07-23 20:31:42.381956 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-23 20:31:43.202928 | debian-bookworm | changed 2026-07-23 20:31:43.210266 | 2026-07-23 20:31:43.210369 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-23 20:31:43.892419 | debian-bookworm | changed 2026-07-23 20:31:43.896906 | 2026-07-23 20:31:43.897001 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-23 20:31:43.909471 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:31:43.914055 | 2026-07-23 20:31:43.914129 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-23 20:31:44.404046 | debian-bookworm -> localhost | changed 2026-07-23 20:31:44.422649 | 2026-07-23 20:31:44.422755 | TASK [add-build-sshkey : Add back temp key] 2026-07-23 20:31:45.121198 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/07641d49db604e83a52a8578363d1b05/work/07641d49db604e83a52a8578363d1b05_id_rsa (zuul-build-sshkey) 2026-07-23 20:31:45.121422 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025935 2026-07-23 20:31:45.129155 | 2026-07-23 20:31:45.129275 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-23 20:31:45.535898 | debian-bookworm | ok 2026-07-23 20:31:45.551765 | 2026-07-23 20:31:45.551887 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-23 20:31:45.581540 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:31:45.591945 | 2026-07-23 20:31:45.592080 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-23 20:31:46.029551 | debian-bookworm | ok 2026-07-23 20:31:46.050325 | 2026-07-23 20:31:46.050493 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-23 20:31:46.100893 | debian-bookworm | ok 2026-07-23 20:31:46.106032 | 2026-07-23 20:31:46.106126 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-23 20:31:46.719700 | debian-bookworm -> localhost | ok 2026-07-23 20:31:46.737966 | 2026-07-23 20:31:46.738079 | TASK [validate-host : Collect information about the host] 2026-07-23 20:31:48.178619 | debian-bookworm | ok 2026-07-23 20:31:48.195676 | 2026-07-23 20:31:48.195794 | TASK [validate-host : Sanitize hostname] 2026-07-23 20:31:48.447279 | debian-bookworm | ok 2026-07-23 20:31:48.451792 | 2026-07-23 20:31:48.451890 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-23 20:31:49.107990 | debian-bookworm -> localhost | changed 2026-07-23 20:31:49.114657 | 2026-07-23 20:31:49.114753 | TASK [validate-host : Collect information about zuul worker] 2026-07-23 20:31:49.528917 | debian-bookworm | ok 2026-07-23 20:31:49.533014 | 2026-07-23 20:31:49.533096 | TASK [validate-host : Write out all zuul information for each host] 2026-07-23 20:31:50.149542 | debian-bookworm -> localhost | changed 2026-07-23 20:31:50.161576 | 2026-07-23 20:31:50.161690 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-23 20:31:50.439265 | debian-bookworm | ok 2026-07-23 20:31:50.444770 | 2026-07-23 20:31:50.444859 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-23 20:31:51.427239 | debian-bookworm | changed: 2026-07-23 20:31:51.427470 | debian-bookworm | cd+++++++++ src/ 2026-07-23 20:31:51.427505 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-23 20:31:51.427530 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-23 20:31:51.427552 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-23 20:31:51.427571 | debian-bookworm | =7.0.3 2026-07-23 20:32:29.615909 | debian-bookworm | Downloading cachetools-7.1.5-py3-none-any.whl (16 kB) 2026-07-23 20:32:29.657245 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-23 20:32:29.668976 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-23 20:32:29.739853 | debian-bookworm | Collecting filelock>=3.25 2026-07-23 20:32:29.751829 | debian-bookworm | Downloading filelock-3.32.0-py3-none-any.whl (97 kB) 2026-07-23 20:32:29.767170 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 97.7/97.7 kB 8.7 MB/s eta 0:00:00 2026-07-23 20:32:29.817341 | debian-bookworm | Collecting packaging>=26 2026-07-23 20:32:29.828439 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-23 20:32:29.838369 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 12.2 MB/s eta 0:00:00 2026-07-23 20:32:29.886822 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-23 20:32:29.898022 | debian-bookworm | Downloading platformdirs-4.11.0-py3-none-any.whl (23 kB) 2026-07-23 20:32:29.933924 | debian-bookworm | Collecting pluggy>=1.6 2026-07-23 20:32:29.944256 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-23 20:32:29.981280 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-23 20:32:29.995055 | debian-bookworm | Downloading pyproject_api-1.11.0-py3-none-any.whl (13 kB) 2026-07-23 20:32:30.031078 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-23 20:32:30.041654 | debian-bookworm | Downloading python_discovery-1.5.0-py3-none-any.whl (34 kB) 2026-07-23 20:32:30.074596 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-23 20:32:30.085584 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-23 20:32:30.246040 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-23 20:32:30.256964 | debian-bookworm | Downloading virtualenv-21.7.0-py3-none-any.whl (5.5 MB) 2026-07-23 20:32:30.516472 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 21.5 MB/s eta 0:00:00 2026-07-23 20:32:30.604027 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-23 20:32:30.616480 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-23 20:32:30.640005 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 23.6 MB/s eta 0:00:00 2026-07-23 20:32:30.742726 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-23 20:32:31.511710 | debian-bookworm | Successfully installed cachetools-7.1.5 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-23 20:32:31.973154 | debian-bookworm | ok: Runtime: 0:00:02.864773 2026-07-23 20:32:31.978195 | 2026-07-23 20:32:31.978275 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-23 20:32:32.067280 | debian-bookworm | ok 2026-07-23 20:32:32.071632 | 2026-07-23 20:32:32.071738 | TASK [ensure-tox : Output tox version] 2026-07-23 20:32:32.768542 | 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-23 20:32:32.785084 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-23 20:32:33.148023 | debian-bookworm | ok: Runtime: 0:00:00.297793 2026-07-23 20:32:33.153211 | 2026-07-23 20:32:33.153306 | TASK [ensure-tox : Make global symlink] 2026-07-23 20:32:33.186574 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:32:33.192453 | 2026-07-23 20:32:33.192528 | PLAY RECAP 2026-07-23 20:32:33.192572 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-23 20:32:33.192592 | 2026-07-23 20:32:33.619318 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-23 20:32:33.620181 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-23 20:32:34.974198 | 2026-07-23 20:32:34.974348 | PLAY [all] 2026-07-23 20:32:35.035206 | 2026-07-23 20:32:35.035364 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-23 20:32:35.708789 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-23 20:32:36.143337 | debian-bookworm | ok: Runtime: 0:00:00.030096 2026-07-23 20:32:36.149097 | 2026-07-23 20:32:36.149233 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-23 20:32:36.728137 | debian-bookworm | ok: Runtime: 0:00:00.006357 2026-07-23 20:32:36.733937 | 2026-07-23 20:32:36.734038 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-23 20:32:37.042416 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-23 20:32:37.046028 | debian-bookworm | sudo: a password is required 2026-07-23 20:32:37.296006 | debian-bookworm | ok: Runtime: 0:00:00.022324 2026-07-23 20:32:37.304123 | 2026-07-23 20:32:37.304214 | TASK [tox : Check to see if the constraints file exists] 2026-07-23 20:32:37.363418 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:32:37.368514 | 2026-07-23 20:32:37.368609 | TASK [tox : Fail if constraints file is missing] 2026-07-23 20:32:37.401604 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:32:37.406586 | 2026-07-23 20:32:37.406699 | TASK [tox : Record file location] 2026-07-23 20:32:37.469888 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:32:37.477177 | 2026-07-23 20:32:37.477285 | TASK [tox : Install tox siblings] 2026-07-23 20:32:37.523851 | debian-bookworm | ok 2026-07-23 20:32:37.540087 | debian-bookworm | included: /var/lib/zuul/builds/07641d49db604e83a52a8578363d1b05/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-23 20:32:37.549636 | 2026-07-23 20:32:37.549749 | TASK [tox : Run tox without tests] 2026-07-23 20:32:38.709857 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-23 20:32:51.014302 | debian-bookworm | test: OK (12.92 seconds) 2026-07-23 20:32:51.014418 | debian-bookworm | congratulations :) (12.95 seconds) 2026-07-23 20:32:51.100201 | debian-bookworm | ok: Runtime: 0:00:13.212399 2026-07-23 20:32:51.107315 | 2026-07-23 20:32:51.107416 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-23 20:32:51.838368 | debian-bookworm | changed 2026-07-23 20:32:51.846184 | 2026-07-23 20:32:51.846284 | TASK [tox : Detect tox version] 2026-07-23 20:32:52.497607 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-23 20:32:52.892180 | debian-bookworm | ok: Runtime: 0:00:00.316508 2026-07-23 20:32:52.899764 | 2026-07-23 20:32:52.899900 | TASK [tox : Get tox envlist config] 2026-07-23 20:32:53.980790 | debian-bookworm | ok: Runtime: 0:00:00.319155 2026-07-23 20:32:53.986377 | 2026-07-23 20:32:53.986517 | TASK [tox : Install any sibling python packages] 2026-07-23 20:32:54.411305 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-23 20:32:54.420231 | 2026-07-23 20:32:54.420338 | TASK [tox : Remove tempfile] 2026-07-23 20:32:55.009146 | debian-bookworm | changed 2026-07-23 20:32:55.021366 | 2026-07-23 20:32:55.021518 | TASK [tox : Emit tox command] 2026-07-23 20:32:55.083991 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-23 20:32:55.090601 | 2026-07-23 20:32:55.090709 | TASK [tox : Run tox] 2026-07-23 20:32:55.655340 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-23 20:32:56.131935 | debian-bookworm | ...........2026-07-23 20:32:56.131 | ERROR | contrib.check_updates:main:219 - operational failure: boom 2026-07-23 20:32:56.138682 | 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-23 20:32:56.138713 | debian-bookworm | warnings.warn( 2026-07-23 20:32:56.141954 | debian-bookworm | 2026-07-23 20:32:56.141 | INFO | openstack_image_manager.main:check_image_age:1283 - Checking for openstack images of age 90 2026-07-23 20:32:56.142267 | debian-bookworm | 2026-07-23 20:32:56.141 | INFO | openstack_image_manager.main:check_image_age:1328 - Image 'Ubuntu 20.04 (1)' was created on 2021-01-01 2026-07-23 20:32:56.142281 | debian-bookworm | 2026-07-23 20:32:56.142 | INFO | openstack_image_manager.main:check_image_age:1283 - Checking for openstack images of age 10 2026-07-23 20:32:56.142296 | debian-bookworm | 2026-07-23 20:32:56.142 | INFO | openstack_image_manager.main:check_image_age:1328 - Image 'Ubuntu 20.04 (1)' was created on 2021-01-01 2026-07-23 20:32:56.142639 | debian-bookworm | 2026-07-23 20:32:56.142 | 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-23 20:32:56.148034 | debian-bookworm | ..2026-07-23 20:32:56.147 | ERROR | openstack_image_manager.main:_download:714 - aria2c is not installed; cannot prefetch image 2026-07-23 20:32:56.151663 | debian-bookworm | .2026-07-23 20:32:56.151 | ERROR | openstack_image_manager.main:_download:745 - aria2c exited with rc=1 for http://x/y 2026-07-23 20:32:56.158108 | debian-bookworm | ..2026-07-23 20:32:56.157 | ERROR | openstack_image_manager.main:_download:739 - aria2c timed out downloading http://x/y 2026-07-23 20:32:56.164778 | debian-bookworm | ..2026-07-23 20:32:56.164 | 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-23 20:32:56.170782 | debian-bookworm | ..2026-07-23 20:32:56.170 | 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-23 20:32:56.177193 | debian-bookworm | ..2026-07-23 20:32:56.176 | ERROR | openstack_image_manager.main:get_checksum_from_checksums_url:250 - Failed to fetch checksums file from https://url.com/SHA512SUMS: 404 2026-07-23 20:32:56.180074 | debian-bookworm | .2026-07-23 20:32:56.179 | ERROR | openstack_image_manager.main:get_checksum_from_checksums_url:250 - Failed to fetch checksums file from https://url.com/SHA512SUMS: unreachable 2026-07-23 20:32:56.190160 | debian-bookworm | ...2026-07-23 20:32:56.189 | 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-23 20:32:56.193285 | debian-bookworm | .2026-07-23 20:32:56.193 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://x/y; skipping disk check 2026-07-23 20:32:56.197134 | debian-bookworm | .2026-07-23 20:32:56.196 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-23 20:32:56.197152 | debian-bookworm | 2026-07-23 20:32:56.197 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-23 20:32:56.498860 | debian-bookworm | 2026-07-23 20:32:56.498 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-23 20:32:56.501942 | debian-bookworm | 2026-07-23 20:32:56.501 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-23 20:32:56.502498 | debian-bookworm | 2026-07-23 20:32:56.502 | INFO | openstack_image_manager.main:_prefetch_import:666 - PREFETCH: glance-direct import succeeded for 'Ubuntu 20.04 (1)' 2026-07-23 20:32:56.511423 | debian-bookworm | .2026-07-23 20:32:56.511 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-23 20:32:56.511725 | debian-bookworm | 2026-07-23 20:32:56.511 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-23 20:32:56.512671 | debian-bookworm | 2026-07-23 20:32:56.512 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-23 20:32:56.512977 | debian-bookworm | 2026-07-23 20:32:56.512 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL file:///path/to/file.img 2026-07-23 20:32:56.512995 | debian-bookworm | 2026-07-23 20:32:56.512 | INFO | openstack_image_manager.main:import_image:539 - Importing local file '/path/to/file.img' as image Ubuntu 20.04 (1) 2026-07-23 20:32:56.519512 | debian-bookworm | .2026-07-23 20:32:56.519 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-23 20:32:56.519831 | debian-bookworm | 2026-07-23 20:32:56.519 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-23 20:32:56.520130 | debian-bookworm | 2026-07-23 20:32:56.519 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-23 20:32:56.521228 | debian-bookworm | 2026-07-23 20:32:56.520 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-23 20:32:56.521562 | debian-bookworm | 2026-07-23 20:32:56.521 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-23 20:32:56.521577 | debian-bookworm | 2026-07-23 20:32:56.521 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-23 20:32:56.521583 | debian-bookworm | 2026-07-23 20:32:56.521 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-23 20:32:56.522195 | debian-bookworm | 2026-07-23 20:32:56.522 | ERROR | openstack_image_manager.main:wait_for_image:830 - Image seems stuck in queued state 2026-07-23 20:32:56.527252 | debian-bookworm | .2026-07-23 20:32:56.527 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-23 20:32:56.527578 | debian-bookworm | 2026-07-23 20:32:56.527 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-23 20:32:56.527868 | debian-bookworm | 2026-07-23 20:32:56.527 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-23 20:32:56.528157 | debian-bookworm | 2026-07-23 20:32:56.527 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-23 20:32:56.528167 | debian-bookworm | 2026-07-23 20:32:56.527 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-23 20:32:56.528172 | debian-bookworm | 2026-07-23 20:32:56.527 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-23 20:32:56.528176 | debian-bookworm | 2026-07-23 20:32:56.528 | INFO | openstack_image_manager.main:wait_for_image:834 - Waiting for image to leave queued state... 2026-07-23 20:32:56.528643 | debian-bookworm | 2026-07-23 20:32:56.528 | ERROR | openstack_image_manager.main:wait_for_image:830 - Image seems stuck in queued state 2026-07-23 20:32:56.528957 | debian-bookworm | 2026-07-23 20:32:56.528 | ERROR | openstack_image_manager.main:import_image:602 - PREFETCH: fallback triggered for 'Ubuntu 20.04 (1)' (web-download failed) 2026-07-23 20:32:56.783499 | debian-bookworm | 2026-07-23 20:32:56.782 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-23 20:32:56.785841 | debian-bookworm | 2026-07-23 20:32:56.785 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-23 20:32:56.786523 | debian-bookworm | 2026-07-23 20:32:56.785 | INFO | openstack_image_manager.main:_prefetch_import:666 - PREFETCH: glance-direct import succeeded for 'Ubuntu 20.04 (1)' 2026-07-23 20:32:56.806756 | debian-bookworm | ...2026-07-23 20:32:56.806 | ERROR | openstack_image_manager.main:main:366 - Skipping cleanup of outdated images because of previous errors 2026-07-23 20:32:56.891454 | debian-bookworm | .2026-07-23 20:32:56.891 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04' (removal candidate) 2026-07-23 20:32:56.896249 | debian-bookworm | .2026-07-23 20:32:56.895 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04_2' (removal candidate) 2026-07-23 20:32:56.896720 | debian-bookworm | 2026-07-23 20:32:56.896 | INFO | openstack_image_manager.main:manage_outdated_images:1418 - Deactivating image 'Ubuntu 20.04_2' 2026-07-23 20:32:56.896736 | debian-bookworm | 2026-07-23 20:32:56.896 | INFO | openstack_image_manager.main:manage_outdated_images:1421 - Setting visibility of 'Ubuntu 20.04_2' to 'community' 2026-07-23 20:32:56.897064 | debian-bookworm | 2026-07-23 20:32:56.896 | INFO | openstack_image_manager.main:manage_outdated_images:1430 - Deleting Ubuntu 20.04_2 2026-07-23 20:32:56.897763 | debian-bookworm | 2026-07-23 20:32:56.897 | INFO | openstack_image_manager.main:manage_outdated_images:1378 - Processing image 'Ubuntu 20.04_2' (removal candidate) 2026-07-23 20:32:56.898077 | debian-bookworm | 2026-07-23 20:32:56.897 | INFO | openstack_image_manager.main:manage_outdated_images:1418 - Deactivating image 'Ubuntu 20.04_2' 2026-07-23 20:32:56.898092 | debian-bookworm | 2026-07-23 20:32:56.897 | INFO | openstack_image_manager.main:manage_outdated_images:1421 - Setting visibility of 'Ubuntu 20.04_2' to 'community' 2026-07-23 20:32:56.898097 | debian-bookworm | 2026-07-23 20:32:56.897 | 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-23 20:32:56.901707 | debian-bookworm | .2026-07-23 20:32:56.901 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-23 20:32:56.901726 | debian-bookworm | 2026-07-23 20:32:56.901 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-23 20:32:56.905887 | debian-bookworm | .2026-07-23 20:32:56.905 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-23 20:32:56.905905 | debian-bookworm | 2026-07-23 20:32:56.905 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-23 20:32:57.154261 | debian-bookworm | 2026-07-23 20:32:57.153 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-23 20:32:57.156363 | debian-bookworm | 2026-07-23 20:32:57.156 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download ok for 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.156764 | debian-bookworm | 2026-07-23 20:32:57.156 | ERROR | openstack_image_manager.main:_prefetch_import:655 - glance-direct import failed for Ubuntu 20.04 (1) 2026-07-23 20:32:57.156791 | debian-bookworm | 409 conflict on fixed id 2026-07-23 20:32:57.157047 | debian-bookworm | 2026-07-23 20:32:57.156 | ERROR | openstack_image_manager.main:_prefetch_import:658 - PREFETCH: glance-direct import failed for 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.165908 | debian-bookworm | .2026-07-23 20:32:57.165 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-23 20:32:57.166205 | debian-bookworm | 2026-07-23 20:32:57.165 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-23 20:32:57.420084 | debian-bookworm | 2026-07-23 20:32:57.419 | WARNING | openstack_image_manager.main:_has_space_for_download:684 - No Content-Length for http://url.com; skipping disk check 2026-07-23 20:32:57.422286 | debian-bookworm | 2026-07-23 20:32:57.421 | INFO | openstack_image_manager.main:_prefetch_import:636 - PREFETCH: aria2 download failed for 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.435140 | debian-bookworm | .2026-07-23 20:32:57.434 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.435728 | debian-bookworm | 2026-07-23 20:32:57.435 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-07-23 20:32:57.436580 | debian-bookworm | 2026-07-23 20:32:57.436 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04 (1)' successfully completed, reloading images 2026-07-23 20:32:57.438273 | debian-bookworm | 2026-07-23 20:32:57.438 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.438646 | debian-bookworm | 2026-07-23 20:32:57.438 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04 (1)' successfully completed, reloading images 2026-07-23 20:32:57.439109 | debian-bookworm | 2026-07-23 20:32:57.438 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.439449 | debian-bookworm | 2026-07-23 20:32:57.439 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-07-23 20:32:57.439466 | debian-bookworm | 2026-07-23 20:32:57.439 | INFO | openstack_image_manager.main:process_image:1020 - Skipping required import of image 'Ubuntu 20.04 (1)', running in dry-run mode 2026-07-23 20:32:57.444557 | debian-bookworm | .2026-07-23 20:32:57.444 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04 (latest)' 2026-07-23 20:32:57.444934 | debian-bookworm | 2026-07-23 20:32:57.444 | 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-23 20:32:57.449861 | debian-bookworm | .2026-07-23 20:32:57.449 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-1' 2026-07-23 20:32:57.450227 | debian-bookworm | 2026-07-23 20:32:57.450 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com: 200 2026-07-23 20:32:57.450748 | debian-bookworm | 2026-07-23 20:32:57.450 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04-1' successfully completed, reloading images 2026-07-23 20:32:57.456234 | debian-bookworm | .2026-07-23 20:32:57.456 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-(1)' 2026-07-23 20:32:57.456582 | debian-bookworm | 2026-07-23 20:32:57.456 | INFO | openstack_image_manager.main:process_image:1025 - Skipping image 'Ubuntu 20.04-(1)' (only importing the latest version from type multi) 2026-07-23 20:32:57.456597 | debian-bookworm | 2026-07-23 20:32:57.456 | INFO | openstack_image_manager.main:process_image:886 - Processing image 'Ubuntu 20.04-(2)' 2026-07-23 20:32:57.457544 | debian-bookworm | 2026-07-23 20:32:57.457 | INFO | openstack_image_manager.main:process_image:992 - Tested URL http://url.com2: 200 2026-07-23 20:32:57.457986 | debian-bookworm | 2026-07-23 20:32:57.457 | INFO | openstack_image_manager.main:process_image:1014 - Import of 'Ubuntu 20.04-(2)' successfully completed, reloading images 2026-07-23 20:32:57.473200 | debian-bookworm | ...2026-07-23 20:32:57.472 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.473576 | debian-bookworm | 2026-07-23 20:32:57.473 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-23 20:32:57.473870 | debian-bookworm | 2026-07-23 20:32:57.473 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.473883 | debian-bookworm | 2026-07-23 20:32:57.473 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-23 20:32:57.473888 | debian-bookworm | 2026-07-23 20:32:57.473 | INFO | openstack_image_manager.main:rename_images:1272 - Renaming Ubuntu 20.04 (1) to Ubuntu 20.04 2026-07-23 20:32:57.477635 | debian-bookworm | .2026-07-23 20:32:57.477 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04-(1)' 2026-07-23 20:32:57.477979 | debian-bookworm | 2026-07-23 20:32:57.477 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-23 20:32:57.478271 | debian-bookworm | 2026-07-23 20:32:57.477 | INFO | openstack_image_manager.main:rename_images:1262 - Renaming old latest 'Ubuntu 20.04' to 'Ubuntu 20.04-(1)' 2026-07-23 20:32:57.478288 | debian-bookworm | 2026-07-23 20:32:57.478 | INFO | openstack_image_manager.main:rename_images:1265 - Renaming imported image 'Ubuntu 20.04' to 'Ubuntu 20.04' 2026-07-23 20:32:57.478292 | debian-bookworm | 2026-07-23 20:32:57.478 | INFO | openstack_image_manager.main:rename_images:1272 - Renaming Ubuntu 20.04-(1) to Ubuntu 20.04 2026-07-23 20:32:57.509973 | debian-bookworm | ..2026-07-23 20:32:57.509 | INFO | openstack_image_manager.main:set_properties:1063 - Checking parameters of 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.510304 | debian-bookworm | 2026-07-23 20:32:57.509 | INFO | openstack_image_manager.main:set_properties:1129 - Setting internal_version = 1 2026-07-23 20:32:57.510317 | debian-bookworm | 2026-07-23 20:32:57.509 | INFO | openstack_image_manager.main:set_properties:1132 - Setting image_original_user = ubuntu 2026-07-23 20:32:57.510322 | debian-bookworm | 2026-07-23 20:32:57.510 | INFO | openstack_image_manager.main:set_properties:1145 - Adding tag my_tag 2026-07-23 20:32:57.510679 | debian-bookworm | 2026-07-23 20:32:57.510 | INFO | openstack_image_manager.main:set_properties:1150 - Deleting tag fake_tag 2026-07-23 20:32:57.511010 | debian-bookworm | 2026-07-23 20:32:57.510 | INFO | openstack_image_manager.main:set_properties:1161 - Setting property image_build_date: 2021-01-01 != 2021-01-21 2026-07-23 20:32:57.511670 | debian-bookworm | 2026-07-23 20:32:57.511 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property os_distro: ubuntu 2026-07-23 20:32:57.511683 | debian-bookworm | 2026-07-23 20:32:57.511 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property os_version: 20.04 2026-07-23 20:32:57.511688 | debian-bookworm | 2026-07-23 20:32:57.511 | INFO | openstack_image_manager.main:set_properties:1178 - Setting property image_source: http://url.com 2026-07-23 20:32:57.511692 | debian-bookworm | 2026-07-23 20:32:57.511 | INFO | openstack_image_manager.main:set_properties:1185 - Checking status of 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.511696 | debian-bookworm | 2026-07-23 20:32:57.511 | INFO | openstack_image_manager.main:set_properties:1190 - Deactivating image 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.511700 | debian-bookworm | 2026-07-23 20:32:57.511 | INFO | openstack_image_manager.main:set_properties:1197 - Checking visibility of 'Ubuntu 20.04 (1)' 2026-07-23 20:32:57.538841 | debian-bookworm | ...2026-07-23 20:32:57.538 | ERROR | openstack_image_manager.main:wait_for_image:814 - Image import timed out 2026-07-23 20:32:57.542887 | debian-bookworm | .2026-07-23 20:32:57.542 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-23 20:32:57.542906 | debian-bookworm | boom 2026-07-23 20:32:57.543188 | debian-bookworm | 2026-07-23 20:32:57.543 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-23 20:32:57.543198 | debian-bookworm | boom 2026-07-23 20:32:57.543527 | debian-bookworm | 2026-07-23 20:32:57.543 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-23 20:32:57.543537 | debian-bookworm | boom 2026-07-23 20:32:57.543541 | debian-bookworm | 2026-07-23 20:32:57.543 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-23 20:32:57.543545 | debian-bookworm | boom 2026-07-23 20:32:57.543549 | debian-bookworm | 2026-07-23 20:32:57.543 | ERROR | openstack_image_manager.main:wait_for_image:846 - Exception while importing image 2026-07-23 20:32:57.543553 | debian-bookworm | boom 2026-07-23 20:32:57.543557 | debian-bookworm | 2026-07-23 20:32:57.543 | ERROR | openstack_image_manager.main:wait_for_image:848 - Giving up on image after repeated errors 2026-07-23 20:32:57.547583 | debian-bookworm | .2026-07-23 20:32:57.547 | ERROR | openstack_image_manager.main:wait_for_image:837 - Image entered terminal state 'killed' 2026-07-23 20:32:57.551006 | debian-bookworm | .2026-07-23 20:32:57.550 | INFO | openstack_image_manager.main:import_image:518 - Importing image Ubuntu 20.04 (1) 2026-07-23 20:32:57.551312 | debian-bookworm | 2026-07-23 20:32:57.550 | INFO | openstack_image_manager.main:import_image:519 - Importing from URL http://url.com 2026-07-23 20:32:57.551325 | debian-bookworm | 2026-07-23 20:32:57.551 | ERROR | openstack_image_manager.main:import_image:584 - Web-download import for image Ubuntu 20.04 (1) failed 2026-07-23 20:32:57.551340 | debian-bookworm | glance api error 2026-07-23 20:32:57.551345 | debian-bookworm | 2026-07-23 20:32:57.551 | ERROR | openstack_image_manager.main:import_image:602 - PREFETCH: fallback triggered for 'Ubuntu 20.04 (1)' (web-download failed) 2026-07-23 20:32:57.551350 | debian-bookworm | . 2026-07-23 20:32:57.551354 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-23 20:32:57.551358 | debian-bookworm | Ran 64 tests in 1.442s 2026-07-23 20:32:57.551363 | debian-bookworm | 2026-07-23 20:32:57.551409 | debian-bookworm | OK 2026-07-23 20:32:57.625536 | debian-bookworm | test: OK (2.01=setup[0.04]+cmd[1.97] seconds) 2026-07-23 20:32:57.625566 | debian-bookworm | congratulations :) (2.04 seconds) 2026-07-23 20:32:58.125282 | debian-bookworm | ok: Runtime: 0:00:02.318699 2026-07-23 20:32:58.132993 | 2026-07-23 20:32:58.133253 | TASK [tox : Look for output] 2026-07-23 20:32:58.509972 | debian-bookworm | ok 2026-07-23 20:32:58.544674 | 2026-07-23 20:32:58.544855 | TASK [tox : Return file comments to Zuul] 2026-07-23 20:32:58.610008 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:32:58.618966 | 2026-07-23 20:32:58.619079 | PLAY RECAP 2026-07-23 20:32:58.619136 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-23 20:32:58.619163 | 2026-07-23 20:32:59.169809 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-23 20:32:59.171085 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-23 20:33:00.380449 | 2026-07-23 20:33:00.380686 | PLAY [all] 2026-07-23 20:33:00.407706 | 2026-07-23 20:33:00.407901 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-23 20:33:00.493816 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:00.500141 | 2026-07-23 20:33:00.500304 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-23 20:33:00.569979 | debian-bookworm | ok 2026-07-23 20:33:00.580816 | 2026-07-23 20:33:00.580961 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-23 20:33:01.642802 | debian-bookworm -> localhost | changed 2026-07-23 20:33:01.654671 | 2026-07-23 20:33:01.654819 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-23 20:33:01.752586 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:01.760507 | 2026-07-23 20:33:01.760696 | TASK [fetch-tox-output : Set envlist fact] 2026-07-23 20:33:01.800418 | debian-bookworm | ok 2026-07-23 20:33:01.807481 | 2026-07-23 20:33:01.807656 | TASK [fetch-tox-output : Get tox version] 2026-07-23 20:33:02.475028 | 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-23 20:33:02.491844 | debian-bookworm | 4.58.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-23 20:33:02.839104 | debian-bookworm | ok: Runtime: 0:00:00.283165 2026-07-23 20:33:02.843902 | 2026-07-23 20:33:02.843979 | TASK [fetch-tox-output : Find all default environments] 2026-07-23 20:33:03.368481 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:03.373834 | 2026-07-23 20:33:03.373935 | TASK [fetch-tox-output : Set envlist fact] 2026-07-23 20:33:03.417643 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:03.422910 | 2026-07-23 20:33:03.423004 | TASK [fetch-tox-output : Find all default environments] 2026-07-23 20:33:03.977982 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:03.982955 | 2026-07-23 20:33:03.983049 | TASK [fetch-tox-output : Set envlist fact] 2026-07-23 20:33:04.036524 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:04.041870 | 2026-07-23 20:33:04.041955 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-23 20:33:04.104961 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:04.121919 | 2026-07-23 20:33:04.122021 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-23 20:33:05.275231 | debian-bookworm | changed: 2026-07-23 20:33:05.275415 | debian-bookworm | created directory /var/lib/zuul/builds/07641d49db604e83a52a8578363d1b05/work/logs/tox/test 2026-07-23 20:33:05.275449 | debian-bookworm | cd+++++++++ ./ 2026-07-23 20:33:05.275474 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-23 20:33:05.275502 | 2026-07-23 20:33:05.289149 | 2026-07-23 20:33:05.289232 | PLAY RECAP 2026-07-23 20:33:05.289273 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-23 20:33:05.289293 | 2026-07-23 20:33:05.463809 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-23 20:33:05.464633 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-23 20:33:06.367269 | 2026-07-23 20:33:06.367402 | PLAY [all] 2026-07-23 20:33:06.389183 | 2026-07-23 20:33:06.389314 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-23 20:33:06.615766 | debian-bookworm | changed: non-zero return code 2026-07-23 20:33:06.641934 | 2026-07-23 20:33:06.642083 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-23 20:33:06.679287 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:06.686183 | 2026-07-23 20:33:06.686302 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-23 20:33:06.726264 | 2026-07-23 20:33:06.726456 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-23 20:33:06.766780 | 2026-07-23 20:33:06.766980 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-23 20:33:06.800203 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:06.806884 | 2026-07-23 20:33:06.807010 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-23 20:33:06.856497 | 2026-07-23 20:33:06.856763 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-23 20:33:06.880318 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:06.886332 | 2026-07-23 20:33:06.886442 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-23 20:33:06.912941 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:06.918789 | 2026-07-23 20:33:06.918961 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-23 20:33:06.942232 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:06.951002 | 2026-07-23 20:33:06.951075 | PLAY RECAP 2026-07-23 20:33:06.951130 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-23 20:33:06.951158 | 2026-07-23 20:33:07.055663 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-23 20:33:07.057636 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-23 20:33:07.944332 | 2026-07-23 20:33:07.944477 | PLAY [Base post-fetch] 2026-07-23 20:33:07.969469 | 2026-07-23 20:33:07.969612 | TASK [diagnose-network : Ensure log directory exists] 2026-07-23 20:33:08.363181 | debian-bookworm | ok 2026-07-23 20:33:08.378119 | 2026-07-23 20:33:08.378721 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-23 20:33:20.153565 | debian-bookworm | ok: Runtime: 0:00:05.853909 2026-07-23 20:33:20.175628 | 2026-07-23 20:33:20.175800 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-23 20:33:26.070634 | debian-bookworm | ok: Runtime: 0:00:00.007439 2026-07-23 20:33:26.077810 | 2026-07-23 20:33:26.077951 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-23 20:33:32.024573 | debian-bookworm | ok: Runtime: 0:00:00.007529 2026-07-23 20:33:32.041079 | 2026-07-23 20:33:32.041251 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-23 20:33:32.099986 | debian-bookworm | skipping: Conditional result was False 2026-07-23 20:33:32.106269 | 2026-07-23 20:33:32.106458 | TASK [fetch-output : Set log path for single node] 2026-07-23 20:33:32.149595 | debian-bookworm | ok 2026-07-23 20:33:32.158292 | 2026-07-23 20:33:32.158453 | LOOP [fetch-output : Ensure local output dirs] 2026-07-23 20:33:32.482341 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/07641d49db604e83a52a8578363d1b05/work/logs" 2026-07-23 20:33:32.767246 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/07641d49db604e83a52a8578363d1b05/work/artifacts" 2026-07-23 20:33:33.059671 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/07641d49db604e83a52a8578363d1b05/work/docs" 2026-07-23 20:33:33.075377 | 2026-07-23 20:33:33.075659 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-23 20:33:33.938065 | debian-bookworm | changed: 2026-07-23 20:33:33.938347 | debian-bookworm | .d..t...... ./ 2026-07-23 20:33:33.938383 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-23 20:33:33.938427 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-23 20:33:33.938456 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-23 20:33:33.938478 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-23 20:33:33.938499 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-23 20:33:33.938543 | debian-bookworm | changed: All items complete 2026-07-23 20:33:33.938566 | 2026-07-23 20:33:34.509391 | debian-bookworm | changed: .d..t...... ./ 2026-07-23 20:33:35.054001 | debian-bookworm | changed: .d..t...... ./ 2026-07-23 20:33:35.074478 | 2026-07-23 20:33:35.074623 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-23 20:33:35.428903 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007796 2026-07-23 20:33:35.867567 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.006716 2026-07-23 20:33:35.879854 | 2026-07-23 20:33:35.879994 | PLAY RECAP 2026-07-23 20:33:35.880103 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-23 20:33:35.880150 | 2026-07-23 20:33:36.064243 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-23 20:33:36.065465 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-23 20:33:36.944161 | 2026-07-23 20:33:36.944362 | PLAY [Base post] 2026-07-23 20:33:36.961731 | 2026-07-23 20:33:36.961901 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-23 20:33:37.575497 | debian-bookworm | changed 2026-07-23 20:33:37.583180 | 2026-07-23 20:33:37.583319 | PLAY RECAP 2026-07-23 20:33:37.583405 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-23 20:33:37.583470 | 2026-07-23 20:33:37.754670 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-23 20:33:37.757794 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-23 20:33:38.684646 | 2026-07-23 20:33:38.684860 | PLAY [Base post-logs] 2026-07-23 20:33:38.696371 | 2026-07-23 20:33:38.696576 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-23 20:33:39.352772 | localhost | changed 2026-07-23 20:33:39.367445 | 2026-07-23 20:33:39.367628 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-23 20:33:39.448501 | localhost | ok 2026-07-23 20:33:39.483605 | 2026-07-23 20:33:39.483883 | TASK [Set zuul-log-path fact] 2026-07-23 20:33:39.520724 | localhost | ok 2026-07-23 20:33:39.530474 | 2026-07-23 20:33:39.530606 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-23 20:33:39.568644 | localhost | ok 2026-07-23 20:33:39.572809 | 2026-07-23 20:33:39.572926 | TASK [upload-logs : Create log directories] 2026-07-23 20:33:40.248513 | localhost | changed 2026-07-23 20:33:40.253451 | 2026-07-23 20:33:40.253585 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-23 20:33:41.064691 | localhost -> localhost | ok: Runtime: 0:00:00.006424 2026-07-23 20:33:41.071641 | 2026-07-23 20:33:41.071823 | TASK [upload-logs : Upload logs to log server] 2026-07-23 20:33:41.736352 | localhost | Output suppressed because no_log was given 2026-07-23 20:33:41.738471 | 2026-07-23 20:33:41.738585 | LOOP [upload-logs : Compress console log and json output] 2026-07-23 20:33:41.792769 | localhost | skipping: Conditional result was False 2026-07-23 20:33:41.799365 | localhost | skipping: Conditional result was False 2026-07-23 20:33:41.811017 | 2026-07-23 20:33:41.811170 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-23 20:33:41.860915 | localhost | skipping: Conditional result was False 2026-07-23 20:33:41.861287 | 2026-07-23 20:33:41.866693 | localhost | skipping: Conditional result was False 2026-07-23 20:33:41.876078 | 2026-07-23 20:33:41.876236 | LOOP [upload-logs : Upload console log and json output]