2026-07-20 08:21:46.255465 | Job console starting 2026-07-20 08:21:46.271674 | Updating git repos 2026-07-20 08:21:46.331888 | Cloning repos into workspace 2026-07-20 08:21:46.387920 | Restoring repo states 2026-07-20 08:21:46.398102 | Merging changes 2026-07-20 08:21:46.965184 | Checking out repos 2026-07-20 08:21:47.043625 | Preparing playbooks 2026-07-20 08:21:48.146518 | Running Ansible setup 2026-07-20 08:21:53.316456 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-20 08:21:54.580080 | 2026-07-20 08:21:54.580279 | PLAY [Base pre] 2026-07-20 08:21:54.626806 | 2026-07-20 08:21:54.627052 | TASK [Setup log path fact] 2026-07-20 08:21:54.655513 | debian-bookworm | ok 2026-07-20 08:21:54.683770 | 2026-07-20 08:21:54.683911 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-20 08:21:54.737734 | debian-bookworm | ok 2026-07-20 08:21:54.759392 | 2026-07-20 08:21:54.759509 | TASK [emit-job-header : Print job information] 2026-07-20 08:21:54.797730 | # Job Information 2026-07-20 08:21:54.797900 | Ansible Version: 2.16.14 2026-07-20 08:21:54.797936 | Job: tox 2026-07-20 08:21:54.797966 | Pipeline: check 2026-07-20 08:21:54.797989 | Executor: 521e9411259a 2026-07-20 08:21:54.798009 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1255 2026-07-20 08:21:54.798031 | Event ID: 068b4980-8414-11f1-9cd1-295fb6811784 2026-07-20 08:21:54.806666 | 2026-07-20 08:21:54.806807 | LOOP [emit-job-header : Print node information] 2026-07-20 08:21:54.948176 | debian-bookworm | ok: 2026-07-20 08:21:54.948370 | debian-bookworm | # Node Information 2026-07-20 08:21:54.948399 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-20 08:21:54.948420 | debian-bookworm | Hostname: debian 2026-07-20 08:21:54.948438 | debian-bookworm | Username: zuul 2026-07-20 08:21:54.948455 | debian-bookworm | Distro: Debian 12.15 2026-07-20 08:21:54.948475 | debian-bookworm | Provider: regiocloud-a 2026-07-20 08:21:54.948491 | debian-bookworm | Region: 2026-07-20 08:21:54.948508 | debian-bookworm | Label: debian-bookworm 2026-07-20 08:21:54.948525 | debian-bookworm | Product Name: OpenStack Nova 2026-07-20 08:21:54.948541 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe52:d9da 2026-07-20 08:21:54.961111 | 2026-07-20 08:21:54.961236 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-20 08:21:55.619128 | debian-bookworm -> localhost | changed 2026-07-20 08:21:55.625165 | 2026-07-20 08:21:55.625250 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-20 08:21:57.028335 | debian-bookworm -> localhost | changed 2026-07-20 08:21:57.037830 | 2026-07-20 08:21:57.037942 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-20 08:21:57.441536 | debian-bookworm -> localhost | ok 2026-07-20 08:21:57.446562 | 2026-07-20 08:21:57.446655 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-20 08:21:57.484945 | debian-bookworm | ok 2026-07-20 08:21:57.503756 | debian-bookworm | included: /var/lib/zuul/builds/547eeb6687114e2bba1350931e5b73ae/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-20 08:21:57.508757 | 2026-07-20 08:21:57.508834 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-20 08:21:58.773728 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-20 08:21:58.773924 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/547eeb6687114e2bba1350931e5b73ae/work/547eeb6687114e2bba1350931e5b73ae_id_rsa 2026-07-20 08:21:58.773956 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/547eeb6687114e2bba1350931e5b73ae/work/547eeb6687114e2bba1350931e5b73ae_id_rsa.pub 2026-07-20 08:21:58.773978 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-20 08:21:58.774000 | debian-bookworm -> localhost | SHA256:T3qSzZu9n/Ck4ITAsIy6iHhe3VhMIztBs7cYgvjLWRA zuul-build-sshkey 2026-07-20 08:21:58.774019 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-20 08:21:58.774052 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-20 08:21:58.774070 | debian-bookworm -> localhost | | E o | 2026-07-20 08:21:58.774088 | debian-bookworm -> localhost | | . o . o | 2026-07-20 08:21:58.774105 | debian-bookworm -> localhost | |. o o = + | 2026-07-20 08:21:58.774122 | debian-bookworm -> localhost | | . + = X o | 2026-07-20 08:21:58.774139 | debian-bookworm -> localhost | | o + * S . | 2026-07-20 08:21:58.774159 | debian-bookworm -> localhost | | o + . * O | 2026-07-20 08:21:58.774176 | debian-bookworm -> localhost | |. + . o * B . . | 2026-07-20 08:21:58.774193 | debian-bookworm -> localhost | |+... = = = . | 2026-07-20 08:21:58.774211 | debian-bookworm -> localhost | |=o. + +o+ | 2026-07-20 08:21:58.774228 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-20 08:21:58.774267 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.640510 2026-07-20 08:21:58.779605 | 2026-07-20 08:21:58.779704 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-20 08:21:58.796640 | debian-bookworm | ok 2026-07-20 08:21:58.805831 | debian-bookworm | included: /var/lib/zuul/builds/547eeb6687114e2bba1350931e5b73ae/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-20 08:21:58.812434 | 2026-07-20 08:21:58.812526 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-20 08:21:58.825524 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:21:58.830084 | 2026-07-20 08:21:58.830160 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-20 08:21:59.464671 | debian-bookworm | changed 2026-07-20 08:21:59.472082 | 2026-07-20 08:21:59.472168 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-20 08:21:59.757133 | debian-bookworm | ok 2026-07-20 08:21:59.763369 | 2026-07-20 08:21:59.778927 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-20 08:22:00.441723 | debian-bookworm | changed 2026-07-20 08:22:00.447019 | 2026-07-20 08:22:00.447113 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-20 08:22:01.079866 | debian-bookworm | changed 2026-07-20 08:22:01.092882 | 2026-07-20 08:22:01.093007 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-20 08:22:01.127414 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:22:01.137758 | 2026-07-20 08:22:01.137912 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-20 08:22:01.613625 | debian-bookworm -> localhost | changed 2026-07-20 08:22:01.624762 | 2026-07-20 08:22:01.624870 | TASK [add-build-sshkey : Add back temp key] 2026-07-20 08:22:01.923182 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/547eeb6687114e2bba1350931e5b73ae/work/547eeb6687114e2bba1350931e5b73ae_id_rsa (zuul-build-sshkey) 2026-07-20 08:22:01.923399 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018411 2026-07-20 08:22:01.930607 | 2026-07-20 08:22:01.930703 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-20 08:22:02.346378 | debian-bookworm | ok 2026-07-20 08:22:02.352302 | 2026-07-20 08:22:02.352407 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-20 08:22:02.381910 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:22:02.396091 | 2026-07-20 08:22:02.396211 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-20 08:22:02.921928 | debian-bookworm | ok 2026-07-20 08:22:02.936240 | 2026-07-20 08:22:02.936360 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-20 08:22:02.964002 | debian-bookworm | ok 2026-07-20 08:22:02.968859 | 2026-07-20 08:22:02.968945 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-20 08:22:03.219068 | debian-bookworm -> localhost | ok 2026-07-20 08:22:03.225543 | 2026-07-20 08:22:03.225645 | TASK [validate-host : Collect information about the host] 2026-07-20 08:22:04.361982 | debian-bookworm | ok 2026-07-20 08:22:04.374240 | 2026-07-20 08:22:04.374352 | TASK [validate-host : Sanitize hostname] 2026-07-20 08:22:04.516729 | debian-bookworm | ok 2026-07-20 08:22:04.527692 | 2026-07-20 08:22:04.527820 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-20 08:22:05.099594 | debian-bookworm -> localhost | changed 2026-07-20 08:22:05.105802 | 2026-07-20 08:22:05.105921 | TASK [validate-host : Collect information about zuul worker] 2026-07-20 08:22:05.542030 | debian-bookworm | ok 2026-07-20 08:22:05.556573 | 2026-07-20 08:22:05.556898 | TASK [validate-host : Write out all zuul information for each host] 2026-07-20 08:22:06.680729 | debian-bookworm -> localhost | changed 2026-07-20 08:22:06.696620 | 2026-07-20 08:22:06.696912 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-20 08:22:07.062544 | debian-bookworm | ok 2026-07-20 08:22:07.082952 | 2026-07-20 08:22:07.089711 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-20 08:22:08.020234 | debian-bookworm | changed: 2026-07-20 08:22:08.020526 | debian-bookworm | cd+++++++++ src/ 2026-07-20 08:22:08.020561 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-20 08:22:08.020586 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-20 08:22:08.020607 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-20 08:22:08.020627 | debian-bookworm | =7.0.3 2026-07-20 08:22:45.752917 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-20 08:22:45.806909 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-20 08:22:45.819614 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-20 08:22:45.941135 | debian-bookworm | Collecting filelock>=3.25 2026-07-20 08:22:45.953623 | debian-bookworm | Downloading filelock-3.31.1-py3-none-any.whl (97 kB) 2026-07-20 08:22:45.971741 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 97.2/97.2 kB 6.0 MB/s eta 0:00:00 2026-07-20 08:22:46.044699 | debian-bookworm | Collecting packaging>=26 2026-07-20 08:22:46.057561 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-20 08:22:46.077021 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 6.3 MB/s eta 0:00:00 2026-07-20 08:22:46.155744 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-20 08:22:46.168171 | debian-bookworm | Downloading platformdirs-4.10.1-py3-none-any.whl (22 kB) 2026-07-20 08:22:46.213457 | debian-bookworm | Collecting pluggy>=1.6 2026-07-20 08:22:46.225722 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-20 08:22:46.286966 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-20 08:22:46.299632 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-20 08:22:46.351983 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-20 08:22:46.364011 | debian-bookworm | Downloading python_discovery-1.4.4-py3-none-any.whl (34 kB) 2026-07-20 08:22:46.403262 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-20 08:22:46.417097 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-20 08:22:46.587090 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-20 08:22:46.599139 | debian-bookworm | Downloading virtualenv-21.6.1-py3-none-any.whl (5.5 MB) 2026-07-20 08:22:46.869556 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 20.8 MB/s eta 0:00:00 2026-07-20 08:22:46.984187 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-20 08:22:46.996558 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-20 08:22:47.018607 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 25.0 MB/s eta 0:00:00 2026-07-20 08:22:47.131908 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-20 08:22:47.969308 | 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 08:22:48.501604 | debian-bookworm | ok: Runtime: 0:00:03.359365 2026-07-20 08:22:48.517670 | 2026-07-20 08:22:48.517866 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-20 08:22:48.560851 | debian-bookworm | ok 2026-07-20 08:22:48.569856 | 2026-07-20 08:22:48.570026 | TASK [ensure-tox : Output tox version] 2026-07-20 08:22:49.121316 | 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 08:22:49.139290 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-20 08:22:49.604951 | debian-bookworm | ok: Runtime: 0:00:00.348243 2026-07-20 08:22:49.619280 | 2026-07-20 08:22:49.619462 | TASK [ensure-tox : Make global symlink] 2026-07-20 08:22:49.645291 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:22:49.660852 | 2026-07-20 08:22:49.661014 | PLAY RECAP 2026-07-20 08:22:49.661104 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-20 08:22:49.661147 | 2026-07-20 08:22:49.818027 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-20 08:22:49.819797 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-20 08:22:50.601687 | 2026-07-20 08:22:50.601857 | PLAY [all] 2026-07-20 08:22:50.617775 | 2026-07-20 08:22:50.617944 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-20 08:22:51.074939 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-20 08:22:51.149228 | debian-bookworm | ok: Runtime: 0:00:00.029411 2026-07-20 08:22:51.156019 | 2026-07-20 08:22:51.156171 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-20 08:22:51.688016 | debian-bookworm | ok: Runtime: 0:00:00.007160 2026-07-20 08:22:51.700780 | 2026-07-20 08:22:51.701068 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-20 08:22:52.006612 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-20 08:22:52.010303 | debian-bookworm | sudo: a password is required 2026-07-20 08:22:52.234447 | debian-bookworm | ok: Runtime: 0:00:00.023928 2026-07-20 08:22:52.257769 | 2026-07-20 08:22:52.257983 | TASK [tox : Check to see if the constraints file exists] 2026-07-20 08:22:52.294671 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:22:52.308974 | 2026-07-20 08:22:52.309162 | TASK [tox : Fail if constraints file is missing] 2026-07-20 08:22:52.334711 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:22:52.350270 | 2026-07-20 08:22:52.350596 | TASK [tox : Record file location] 2026-07-20 08:22:52.377603 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:22:52.392174 | 2026-07-20 08:22:52.392382 | TASK [tox : Install tox siblings] 2026-07-20 08:22:52.427517 | debian-bookworm | ok 2026-07-20 08:22:52.440050 | debian-bookworm | included: /var/lib/zuul/builds/547eeb6687114e2bba1350931e5b73ae/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-20 08:22:52.446392 | 2026-07-20 08:22:52.446505 | TASK [tox : Run tox without tests] 2026-07-20 08:22:53.716731 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-20 08:23:07.544161 | debian-bookworm | test: OK (14.52 seconds) 2026-07-20 08:23:07.544219 | debian-bookworm | congratulations :) (14.55 seconds) 2026-07-20 08:23:07.978552 | debian-bookworm | ok: Runtime: 0:00:14.870325 2026-07-20 08:23:07.992741 | 2026-07-20 08:23:07.992921 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-20 08:23:08.435166 | debian-bookworm | changed 2026-07-20 08:23:08.442719 | 2026-07-20 08:23:08.442916 | TASK [tox : Detect tox version] 2026-07-20 08:23:09.002082 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-20 08:23:09.474931 | debian-bookworm | ok: Runtime: 0:00:00.317370 2026-07-20 08:23:09.489963 | 2026-07-20 08:23:09.490238 | TASK [tox : Get tox envlist config] 2026-07-20 08:23:10.529346 | debian-bookworm | ok: Runtime: 0:00:00.383878 2026-07-20 08:23:10.535779 | 2026-07-20 08:23:10.535914 | TASK [tox : Install any sibling python packages] 2026-07-20 08:23:11.026888 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-20 08:23:11.034722 | 2026-07-20 08:23:11.034891 | TASK [tox : Remove tempfile] 2026-07-20 08:23:11.523585 | debian-bookworm | changed 2026-07-20 08:23:11.529266 | 2026-07-20 08:23:11.529393 | TASK [tox : Emit tox command] 2026-07-20 08:23:11.570016 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-20 08:23:11.576623 | 2026-07-20 08:23:11.578328 | TASK [tox : Run tox] 2026-07-20 08:23:12.183809 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-20 08:23:14.190516 | debian-bookworm | ...................................................2026-07-20 08:23:14 | INFO  | main:223 - Processing file /tmp/tmpso6frpqe/example.yml 2026-07-20 08:23:14.196643 | debian-bookworm | 2026-07-20 08:23:14 | INFO  | update_image:144 - Checking image Example 1.0 2026-07-20 08:23:14.196680 | debian-bookworm | 2026-07-20 08:23:14 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:1111111111111111111111111111111111111111111111111111111111111111 2026-07-20 08:23:14.197114 | debian-bookworm | 2026-07-20 08:23:14 | INFO  | update_image:178 - New URL is https://nbg1.your-objectstorage.com/osism/openstack-images/example-1.0/20260101-example-1.0.qcow2 2026-07-20 08:23:14.199645 | debian-bookworm | 2026-07-20 08:23:14 | INFO  | main:239 - Dry-run enabled, not writing /tmp/tmpso6frpqe/example.yml 2026-07-20 08:23:14.207330 | debian-bookworm | .2026-07-20 08:23:14 | INFO  | main:223 - Processing file /tmp/tmpnbenfyeq/example.yml 2026-07-20 08:23:14.210501 | debian-bookworm | 2026-07-20 08:23:14 | INFO  | update_image:144 - Checking image Example 1.0 2026-07-20 08:23:14.210920 | debian-bookworm | 2026-07-20 08:23:14 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:0000000000000000000000000000000000000000000000000000000000000000 2026-07-20 08:23:14.210940 | debian-bookworm | 2026-07-20 08:23:14 | INFO  | update_image:158 - Image Example 1.0 is up-to-date, nothing to do 2026-07-20 08:23:14.217946 | debian-bookworm | .2026-07-20 08:23:14 | INFO  | main:223 - Processing file /tmp/tmpb0ukp3r8/example.yml 2026-07-20 08:23:14.221004 | debian-bookworm | 2026-07-20 08:23:14 | INFO  | update_image:144 - Checking image Example 1.0 2026-07-20 08:23:14.221348 | debian-bookworm | 2026-07-20 08:23:14 | INFO  | update_image:147 - Checksum of current example.qcow2 is sha256:1111111111111111111111111111111111111111111111111111111111111111 2026-07-20 08:23:14.221365 | debian-bookworm | 2026-07-20 08:23:14 | INFO  | update_image:178 - New URL is https://nbg1.your-objectstorage.com/osism/openstack-images/example-1.0/20260101-example-1.0.qcow2 2026-07-20 08:23:14.224666 | debian-bookworm | . 2026-07-20 08:23:14.224719 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-20 08:23:14.224730 | debian-bookworm | Ran 54 tests in 1.505s 2026-07-20 08:23:14.224735 | debian-bookworm | 2026-07-20 08:23:14.224741 | debian-bookworm | OK 2026-07-20 08:23:14.329606 | debian-bookworm | test: OK (2.19=setup[0.05]+cmd[2.14] seconds) 2026-07-20 08:23:14.329668 | debian-bookworm | congratulations :) (2.22 seconds) 2026-07-20 08:23:14.611916 | debian-bookworm | ok: Runtime: 0:00:02.546711 2026-07-20 08:23:14.618751 | 2026-07-20 08:23:14.618891 | TASK [tox : Look for output] 2026-07-20 08:23:15.046553 | debian-bookworm | ok 2026-07-20 08:23:15.075615 | 2026-07-20 08:23:15.075801 | TASK [tox : Return file comments to Zuul] 2026-07-20 08:23:15.153272 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:15.162329 | 2026-07-20 08:23:15.162576 | PLAY RECAP 2026-07-20 08:23:15.162651 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-20 08:23:15.162677 | 2026-07-20 08:23:15.380438 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-20 08:23:15.382170 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-20 08:23:16.272817 | 2026-07-20 08:23:16.273028 | PLAY [all] 2026-07-20 08:23:16.290513 | 2026-07-20 08:23:16.290683 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-20 08:23:16.336472 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:16.343591 | 2026-07-20 08:23:16.343802 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-20 08:23:16.401386 | debian-bookworm | ok 2026-07-20 08:23:16.407072 | 2026-07-20 08:23:16.407206 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-20 08:23:16.970877 | debian-bookworm -> localhost | changed 2026-07-20 08:23:16.979690 | 2026-07-20 08:23:16.979830 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-20 08:23:17.024518 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:17.031251 | 2026-07-20 08:23:17.031400 | TASK [fetch-tox-output : Set envlist fact] 2026-07-20 08:23:17.072990 | debian-bookworm | ok 2026-07-20 08:23:17.079204 | 2026-07-20 08:23:17.079331 | TASK [fetch-tox-output : Get tox version] 2026-07-20 08:23:17.787822 | 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 08:23:17.805310 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-20 08:23:18.110713 | debian-bookworm | ok: Runtime: 0:00:00.325997 2026-07-20 08:23:18.116778 | 2026-07-20 08:23:18.116890 | TASK [fetch-tox-output : Find all default environments] 2026-07-20 08:23:18.675878 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:18.690882 | 2026-07-20 08:23:18.691120 | TASK [fetch-tox-output : Set envlist fact] 2026-07-20 08:23:18.736921 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:18.744061 | 2026-07-20 08:23:18.744207 | TASK [fetch-tox-output : Find all default environments] 2026-07-20 08:23:19.281237 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:19.287669 | 2026-07-20 08:23:19.287806 | TASK [fetch-tox-output : Set envlist fact] 2026-07-20 08:23:19.322201 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:19.330243 | 2026-07-20 08:23:19.330400 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-20 08:23:19.376116 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:19.407020 | 2026-07-20 08:23:19.407203 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-20 08:23:20.535180 | debian-bookworm | changed: 2026-07-20 08:23:20.535472 | debian-bookworm | created directory /var/lib/zuul/builds/547eeb6687114e2bba1350931e5b73ae/work/logs/tox/test 2026-07-20 08:23:20.535529 | debian-bookworm | cd+++++++++ ./ 2026-07-20 08:23:20.535570 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-20 08:23:20.535617 | 2026-07-20 08:23:20.552947 | 2026-07-20 08:23:20.553106 | PLAY RECAP 2026-07-20 08:23:20.553187 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-20 08:23:20.553224 | 2026-07-20 08:23:20.714938 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-20 08:23:20.716160 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-20 08:23:21.493881 | 2026-07-20 08:23:21.494113 | PLAY [all] 2026-07-20 08:23:21.516241 | 2026-07-20 08:23:21.516411 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-20 08:23:21.728814 | debian-bookworm | changed: non-zero return code 2026-07-20 08:23:21.738804 | 2026-07-20 08:23:21.739001 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-20 08:23:21.765783 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:21.772911 | 2026-07-20 08:23:21.773101 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-20 08:23:21.807601 | 2026-07-20 08:23:21.807869 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-20 08:23:21.849525 | 2026-07-20 08:23:21.849822 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-20 08:23:21.875257 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:21.883513 | 2026-07-20 08:23:21.883659 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-20 08:23:21.918431 | 2026-07-20 08:23:21.918653 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-20 08:23:21.943078 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:21.956417 | 2026-07-20 08:23:21.956616 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-20 08:23:21.986736 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:21.998198 | 2026-07-20 08:23:21.998350 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-20 08:23:22.023483 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:22.031789 | 2026-07-20 08:23:22.031896 | PLAY RECAP 2026-07-20 08:23:22.031954 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-20 08:23:22.032000 | 2026-07-20 08:23:22.247613 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-20 08:23:22.248825 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-20 08:23:23.054503 | 2026-07-20 08:23:23.054687 | PLAY [Base post-fetch] 2026-07-20 08:23:23.069800 | 2026-07-20 08:23:23.069959 | TASK [diagnose-network : Ensure log directory exists] 2026-07-20 08:23:23.479697 | debian-bookworm | ok 2026-07-20 08:23:23.490666 | 2026-07-20 08:23:23.490896 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-20 08:23:35.315158 | debian-bookworm | ok: Runtime: 0:00:06.001103 2026-07-20 08:23:35.326303 | 2026-07-20 08:23:35.326503 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-20 08:23:41.380866 | debian-bookworm | ok: Runtime: 0:00:00.008349 2026-07-20 08:23:41.388077 | 2026-07-20 08:23:41.388219 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-20 08:23:47.457574 | debian-bookworm | ok: Runtime: 0:00:00.008374 2026-07-20 08:23:47.472975 | 2026-07-20 08:23:47.473220 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-20 08:23:47.528252 | debian-bookworm | skipping: Conditional result was False 2026-07-20 08:23:47.541110 | 2026-07-20 08:23:47.541289 | TASK [fetch-output : Set log path for single node] 2026-07-20 08:23:47.590151 | debian-bookworm | ok 2026-07-20 08:23:47.597342 | 2026-07-20 08:23:47.597488 | LOOP [fetch-output : Ensure local output dirs] 2026-07-20 08:23:47.916884 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/547eeb6687114e2bba1350931e5b73ae/work/logs" 2026-07-20 08:23:48.208216 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/547eeb6687114e2bba1350931e5b73ae/work/artifacts" 2026-07-20 08:23:48.489371 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/547eeb6687114e2bba1350931e5b73ae/work/docs" 2026-07-20 08:23:48.507933 | 2026-07-20 08:23:48.508184 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-20 08:23:49.337504 | debian-bookworm | changed: 2026-07-20 08:23:49.337855 | debian-bookworm | .d..t...... ./ 2026-07-20 08:23:49.337910 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-20 08:23:49.337949 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-20 08:23:49.337983 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-20 08:23:49.338017 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-20 08:23:49.338071 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-20 08:23:49.338138 | debian-bookworm | changed: All items complete 2026-07-20 08:23:49.338176 | 2026-07-20 08:23:49.916734 | debian-bookworm | changed: .d..t...... ./ 2026-07-20 08:23:50.531412 | debian-bookworm | changed: .d..t...... ./ 2026-07-20 08:23:50.562104 | 2026-07-20 08:23:50.562278 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-20 08:23:50.893590 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008775 2026-07-20 08:23:51.198958 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008880 2026-07-20 08:23:51.220337 | 2026-07-20 08:23:51.220514 | PLAY RECAP 2026-07-20 08:23:51.220604 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-20 08:23:51.220648 | 2026-07-20 08:23:51.369063 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-20 08:23:51.370286 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-20 08:23:52.118445 | 2026-07-20 08:23:52.118632 | PLAY [Base post] 2026-07-20 08:23:52.132983 | 2026-07-20 08:23:52.133144 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-20 08:23:52.840675 | debian-bookworm | changed 2026-07-20 08:23:52.851655 | 2026-07-20 08:23:52.851853 | PLAY RECAP 2026-07-20 08:23:52.851975 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-20 08:23:52.852118 | 2026-07-20 08:23:52.984109 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-20 08:23:52.985294 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-20 08:23:53.799898 | 2026-07-20 08:23:53.800122 | PLAY [Base post-logs] 2026-07-20 08:23:53.811748 | 2026-07-20 08:23:53.811900 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-20 08:23:54.307368 | localhost | changed 2026-07-20 08:23:54.321910 | 2026-07-20 08:23:54.322170 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-20 08:23:54.361410 | localhost | ok 2026-07-20 08:23:54.368258 | 2026-07-20 08:23:54.368438 | TASK [Set zuul-log-path fact] 2026-07-20 08:23:54.397596 | localhost | ok 2026-07-20 08:23:54.412499 | 2026-07-20 08:23:54.412689 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-20 08:23:54.451217 | localhost | ok 2026-07-20 08:23:54.457589 | 2026-07-20 08:23:54.457763 | TASK [upload-logs : Create log directories] 2026-07-20 08:23:54.997657 | localhost | changed 2026-07-20 08:23:55.003033 | 2026-07-20 08:23:55.003273 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-20 08:23:55.538490 | localhost -> localhost | ok: Runtime: 0:00:00.007671 2026-07-20 08:23:55.546549 | 2026-07-20 08:23:55.546733 | TASK [upload-logs : Upload logs to log server] 2026-07-20 08:23:56.122946 | localhost | Output suppressed because no_log was given 2026-07-20 08:23:56.124953 | 2026-07-20 08:23:56.125087 | LOOP [upload-logs : Compress console log and json output] 2026-07-20 08:23:56.184583 | localhost | skipping: Conditional result was False 2026-07-20 08:23:56.190013 | localhost | skipping: Conditional result was False 2026-07-20 08:23:56.196486 | 2026-07-20 08:23:56.196706 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-20 08:23:56.245040 | localhost | skipping: Conditional result was False 2026-07-20 08:23:56.245682 | 2026-07-20 08:23:56.249756 | localhost | skipping: Conditional result was False 2026-07-20 08:23:56.263386 | 2026-07-20 08:23:56.263602 | LOOP [upload-logs : Upload console log and json output]