2026-05-10 00:40:51.722674 | Job console starting 2026-05-10 00:40:51.731216 | Updating git repos 2026-05-10 00:40:51.780897 | Cloning repos into workspace 2026-05-10 00:40:51.842696 | Restoring repo states 2026-05-10 00:40:51.863473 | Merging changes 2026-05-10 00:40:52.473882 | Checking out repos 2026-05-10 00:40:52.523150 | Preparing playbooks 2026-05-10 00:40:53.611294 | Running Ansible setup 2026-05-10 00:40:59.089443 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-10 00:40:59.876525 | 2026-05-10 00:40:59.876651 | PLAY [Base pre] 2026-05-10 00:40:59.890296 | 2026-05-10 00:40:59.890440 | TASK [Setup log path fact] 2026-05-10 00:40:59.931664 | debian-bookworm | ok 2026-05-10 00:40:59.968115 | 2026-05-10 00:40:59.968241 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-10 00:40:59.995529 | debian-bookworm | ok 2026-05-10 00:41:00.012126 | 2026-05-10 00:41:00.012232 | TASK [emit-job-header : Print job information] 2026-05-10 00:41:00.079825 | # Job Information 2026-05-10 00:41:00.079969 | Ansible Version: 2.16.14 2026-05-10 00:41:00.079999 | Job: tox 2026-05-10 00:41:00.080027 | Pipeline: check 2026-05-10 00:41:00.080047 | Executor: 521e9411259a 2026-05-10 00:41:00.080064 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1211 2026-05-10 00:41:00.080083 | Event ID: a594d580-4c08-11f1-9a70-5b22e73e725a 2026-05-10 00:41:00.084081 | 2026-05-10 00:41:00.084163 | LOOP [emit-job-header : Print node information] 2026-05-10 00:41:00.206921 | debian-bookworm | ok: 2026-05-10 00:41:00.207065 | debian-bookworm | # Node Information 2026-05-10 00:41:00.207093 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-10 00:41:00.207115 | debian-bookworm | Hostname: debian 2026-05-10 00:41:00.207134 | debian-bookworm | Username: zuul 2026-05-10 00:41:00.207152 | debian-bookworm | Distro: Debian 12.13 2026-05-10 00:41:00.207173 | debian-bookworm | Provider: regiocloud-a 2026-05-10 00:41:00.207766 | debian-bookworm | Region: 2026-05-10 00:41:00.207800 | debian-bookworm | Label: debian-bookworm 2026-05-10 00:41:00.207821 | debian-bookworm | Product Name: OpenStack Nova 2026-05-10 00:41:00.208341 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe20:8d4f 2026-05-10 00:41:00.232501 | 2026-05-10 00:41:00.232600 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-10 00:41:00.679959 | debian-bookworm -> localhost | changed 2026-05-10 00:41:00.687377 | 2026-05-10 00:41:00.687473 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-10 00:41:02.229579 | debian-bookworm -> localhost | changed 2026-05-10 00:41:02.241698 | 2026-05-10 00:41:02.241816 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-10 00:41:02.564650 | debian-bookworm -> localhost | ok 2026-05-10 00:41:02.570782 | 2026-05-10 00:41:02.570903 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-10 00:41:02.601379 | debian-bookworm | ok 2026-05-10 00:41:02.631815 | debian-bookworm | included: /var/lib/zuul/builds/34f3aab5296e4f3ea8788670f4918867/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-10 00:41:02.640519 | 2026-05-10 00:41:02.640627 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-10 00:41:06.261627 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-10 00:41:06.261798 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/34f3aab5296e4f3ea8788670f4918867/work/34f3aab5296e4f3ea8788670f4918867_id_rsa 2026-05-10 00:41:06.261830 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/34f3aab5296e4f3ea8788670f4918867/work/34f3aab5296e4f3ea8788670f4918867_id_rsa.pub 2026-05-10 00:41:06.261852 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-10 00:41:06.261873 | debian-bookworm -> localhost | SHA256:+WV/9i+YrH7Gun60VKesKteFRXshc6RWt2iIzlzpksc zuul-build-sshkey 2026-05-10 00:41:06.261892 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-10 00:41:06.261919 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-10 00:41:06.261938 | debian-bookworm -> localhost | | .o.| 2026-05-10 00:41:06.261957 | debian-bookworm -> localhost | | . oo=oo| 2026-05-10 00:41:06.261974 | debian-bookworm -> localhost | | . + *+o.| 2026-05-10 00:41:06.261991 | debian-bookworm -> localhost | | +.= o + o| 2026-05-10 00:41:06.262007 | debian-bookworm -> localhost | | S* Eo= + | 2026-05-10 00:41:06.262030 | debian-bookworm -> localhost | | .oo+.+ | 2026-05-10 00:41:06.262047 | debian-bookworm -> localhost | | .* *. o| 2026-05-10 00:41:06.262064 | debian-bookworm -> localhost | | . . % .o.| 2026-05-10 00:41:06.262082 | debian-bookworm -> localhost | | =BO .+| 2026-05-10 00:41:06.262098 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-10 00:41:06.262141 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.954307 2026-05-10 00:41:06.267324 | 2026-05-10 00:41:06.267428 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-10 00:41:06.283837 | debian-bookworm | ok 2026-05-10 00:41:06.297015 | debian-bookworm | included: /var/lib/zuul/builds/34f3aab5296e4f3ea8788670f4918867/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-10 00:41:06.315174 | 2026-05-10 00:41:06.315275 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-10 00:41:06.348119 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:41:06.352944 | 2026-05-10 00:41:06.353032 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-10 00:41:07.081557 | debian-bookworm | changed 2026-05-10 00:41:07.088294 | 2026-05-10 00:41:07.088396 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-10 00:41:07.331253 | debian-bookworm | ok 2026-05-10 00:41:07.340115 | 2026-05-10 00:41:07.340227 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-10 00:41:08.009832 | debian-bookworm | changed 2026-05-10 00:41:08.016370 | 2026-05-10 00:41:08.016467 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-10 00:41:08.559130 | debian-bookworm | changed 2026-05-10 00:41:08.563686 | 2026-05-10 00:41:08.563891 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-10 00:41:08.576427 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:41:08.581127 | 2026-05-10 00:41:08.581198 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-10 00:41:09.107302 | debian-bookworm -> localhost | changed 2026-05-10 00:41:09.123355 | 2026-05-10 00:41:09.123462 | TASK [add-build-sshkey : Add back temp key] 2026-05-10 00:41:09.766904 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/34f3aab5296e4f3ea8788670f4918867/work/34f3aab5296e4f3ea8788670f4918867_id_rsa (zuul-build-sshkey) 2026-05-10 00:41:09.767126 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.031756 2026-05-10 00:41:09.774602 | 2026-05-10 00:41:09.774712 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-10 00:41:10.385321 | debian-bookworm | ok 2026-05-10 00:41:10.390461 | 2026-05-10 00:41:10.390557 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-10 00:41:10.427298 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:41:10.438365 | 2026-05-10 00:41:10.438480 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-10 00:41:11.165538 | debian-bookworm | ok 2026-05-10 00:41:11.193404 | 2026-05-10 00:41:11.193522 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-10 00:41:11.242622 | debian-bookworm | ok 2026-05-10 00:41:11.249826 | 2026-05-10 00:41:11.249929 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-10 00:41:11.762765 | debian-bookworm -> localhost | ok 2026-05-10 00:41:11.769808 | 2026-05-10 00:41:11.770060 | TASK [validate-host : Collect information about the host] 2026-05-10 00:41:13.425121 | debian-bookworm | ok 2026-05-10 00:41:13.443169 | 2026-05-10 00:41:13.443308 | TASK [validate-host : Sanitize hostname] 2026-05-10 00:41:13.576723 | debian-bookworm | ok 2026-05-10 00:41:13.608371 | 2026-05-10 00:41:13.608474 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-10 00:41:14.472672 | debian-bookworm -> localhost | changed 2026-05-10 00:41:14.477198 | 2026-05-10 00:41:14.477284 | TASK [validate-host : Collect information about zuul worker] 2026-05-10 00:41:14.982632 | debian-bookworm | ok 2026-05-10 00:41:14.987198 | 2026-05-10 00:41:14.987294 | TASK [validate-host : Write out all zuul information for each host] 2026-05-10 00:41:15.528380 | debian-bookworm -> localhost | changed 2026-05-10 00:41:15.537914 | 2026-05-10 00:41:15.538026 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-10 00:41:15.820569 | debian-bookworm | ok 2026-05-10 00:41:15.826407 | 2026-05-10 00:41:15.826539 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-10 00:41:16.696722 | debian-bookworm | changed: 2026-05-10 00:41:16.696945 | debian-bookworm | cd+++++++++ src/ 2026-05-10 00:41:16.696991 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-10 00:41:16.697024 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-10 00:41:16.697052 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-10 00:41:16.697080 | debian-bookworm | =7.0.3 2026-05-10 00:41:41.576029 | debian-bookworm | Downloading cachetools-7.1.1-py3-none-any.whl (16 kB) 2026-05-10 00:41:41.630039 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-10 00:41:41.642478 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-10 00:41:41.707412 | debian-bookworm | Collecting filelock>=3.25 2026-05-10 00:41:41.719103 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-10 00:41:41.774378 | debian-bookworm | Collecting packaging>=26 2026-05-10 00:41:41.785937 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-10 00:41:41.799543 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 8.8 MB/s eta 0:00:00 2026-05-10 00:41:41.851455 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-10 00:41:41.863960 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-05-10 00:41:41.906737 | debian-bookworm | Collecting pluggy>=1.6 2026-05-10 00:41:41.920316 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-10 00:41:41.975956 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-10 00:41:41.988276 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-10 00:41:42.033694 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-10 00:41:42.046581 | debian-bookworm | Downloading python_discovery-1.3.0-py3-none-any.whl (33 kB) 2026-05-10 00:41:42.092718 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-10 00:41:42.104966 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-10 00:41:42.241875 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-10 00:41:42.253832 | debian-bookworm | Downloading virtualenv-21.3.1-py3-none-any.whl (7.6 MB) 2026-05-10 00:41:42.587056 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 23.1 MB/s eta 0:00:00 2026-05-10 00:41:42.697245 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-10 00:41:42.708980 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-10 00:41:42.735875 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 19.5 MB/s eta 0:00:00 2026-05-10 00:41:42.843175 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-10 00:41:43.618760 | debian-bookworm | Successfully installed cachetools-7.1.1 colorama-0.4.6 distlib-0.4.0 filelock-3.29.0 packaging-26.2 platformdirs-4.9.6 pluggy-1.6.0 pyproject-api-1.10.0 python-discovery-1.3.0 tomli-w-1.2.0 tox-4.53.1 virtualenv-21.3.1 2026-05-10 00:41:43.937548 | debian-bookworm | ok: Runtime: 0:00:03.118785 2026-05-10 00:41:43.951696 | 2026-05-10 00:41:43.951882 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-10 00:41:44.004796 | debian-bookworm | ok 2026-05-10 00:41:44.009866 | 2026-05-10 00:41:44.009987 | TASK [ensure-tox : Output tox version] 2026-05-10 00:41:44.566140 | 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-05-10 00:41:44.584248 | debian-bookworm | 4.53.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-10 00:41:45.043479 | debian-bookworm | ok: Runtime: 0:00:00.334205 2026-05-10 00:41:45.056566 | 2026-05-10 00:41:45.056727 | TASK [ensure-tox : Make global symlink] 2026-05-10 00:41:45.082966 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:41:45.094543 | 2026-05-10 00:41:45.094681 | PLAY RECAP 2026-05-10 00:41:45.094762 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-10 00:41:45.094803 | 2026-05-10 00:41:45.261074 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-10 00:41:45.262453 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-10 00:41:46.017217 | 2026-05-10 00:41:46.017432 | PLAY [all] 2026-05-10 00:41:46.034023 | 2026-05-10 00:41:46.034182 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-10 00:41:46.521120 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-10 00:41:46.580422 | debian-bookworm | ok: Runtime: 0:00:00.031045 2026-05-10 00:41:46.589306 | 2026-05-10 00:41:46.589504 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-10 00:41:47.127109 | debian-bookworm | ok: Runtime: 0:00:00.006621 2026-05-10 00:41:47.140887 | 2026-05-10 00:41:47.141078 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-10 00:41:47.456096 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-10 00:41:47.460011 | debian-bookworm | sudo: a password is required 2026-05-10 00:41:47.678032 | debian-bookworm | ok: Runtime: 0:00:00.026293 2026-05-10 00:41:47.700949 | 2026-05-10 00:41:47.701110 | TASK [tox : Check to see if the constraints file exists] 2026-05-10 00:41:47.736852 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:41:47.748066 | 2026-05-10 00:41:47.748246 | TASK [tox : Fail if constraints file is missing] 2026-05-10 00:41:47.774052 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:41:47.780419 | 2026-05-10 00:41:47.780536 | TASK [tox : Record file location] 2026-05-10 00:41:47.804530 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:41:47.810300 | 2026-05-10 00:41:47.810426 | TASK [tox : Install tox siblings] 2026-05-10 00:41:47.839155 | debian-bookworm | ok 2026-05-10 00:41:47.851938 | debian-bookworm | included: /var/lib/zuul/builds/34f3aab5296e4f3ea8788670f4918867/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-10 00:41:47.858586 | 2026-05-10 00:41:47.858705 | TASK [tox : Run tox without tests] 2026-05-10 00:41:49.171517 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-05-10 00:42:02.745216 | debian-bookworm | test: OK (14.28 seconds) 2026-05-10 00:42:02.745305 | debian-bookworm | congratulations :) (14.31 seconds) 2026-05-10 00:42:02.899841 | debian-bookworm | ok: Runtime: 0:00:14.637921 2026-05-10 00:42:02.905994 | 2026-05-10 00:42:02.906108 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-10 00:42:03.341784 | debian-bookworm | changed 2026-05-10 00:42:03.349365 | 2026-05-10 00:42:03.349530 | TASK [tox : Detect tox version] 2026-05-10 00:42:03.900128 | debian-bookworm | 4.53.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-10 00:42:04.380739 | debian-bookworm | ok: Runtime: 0:00:00.310456 2026-05-10 00:42:04.386772 | 2026-05-10 00:42:04.386916 | TASK [tox : Get tox envlist config] 2026-05-10 00:42:05.419243 | debian-bookworm | ok: Runtime: 0:00:00.351325 2026-05-10 00:42:05.433753 | 2026-05-10 00:42:05.433948 | TASK [tox : Install any sibling python packages] 2026-05-10 00:42:05.916469 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-10 00:42:05.928595 | 2026-05-10 00:42:05.928736 | TASK [tox : Remove tempfile] 2026-05-10 00:42:06.452755 | debian-bookworm | changed 2026-05-10 00:42:06.458629 | 2026-05-10 00:42:06.458751 | TASK [tox : Emit tox command] 2026-05-10 00:42:06.515431 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-05-10 00:42:06.523728 | 2026-05-10 00:42:06.523890 | TASK [tox : Run tox] 2026-05-10 00:42:07.150757 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-05-10 00:42:07.903068 | debian-bookworm | ............... 2026-05-10 00:42:07.903539 | debian-bookworm | ---------------------------------------------------------------------- 2026-05-10 00:42:07.903568 | debian-bookworm | Ran 15 tests in 0.169s 2026-05-10 00:42:07.903574 | debian-bookworm | 2026-05-10 00:42:07.903582 | debian-bookworm | OK 2026-05-10 00:42:08.005199 | debian-bookworm | test: OK (0.91=setup[0.06]+cmd[0.85] seconds) 2026-05-10 00:42:08.005266 | debian-bookworm | congratulations :) (0.94 seconds) 2026-05-10 00:42:08.556116 | debian-bookworm | ok: Runtime: 0:00:01.242411 2026-05-10 00:42:08.571795 | 2026-05-10 00:42:08.572017 | TASK [tox : Look for output] 2026-05-10 00:42:08.992675 | debian-bookworm | ok 2026-05-10 00:42:09.011706 | 2026-05-10 00:42:09.011850 | TASK [tox : Return file comments to Zuul] 2026-05-10 00:42:09.057659 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:09.072250 | 2026-05-10 00:42:09.072412 | PLAY RECAP 2026-05-10 00:42:09.072500 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-10 00:42:09.072541 | 2026-05-10 00:42:09.216813 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-10 00:42:09.217984 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-10 00:42:09.990494 | 2026-05-10 00:42:09.990683 | PLAY [all] 2026-05-10 00:42:10.009080 | 2026-05-10 00:42:10.009262 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-10 00:42:10.064336 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:10.070433 | 2026-05-10 00:42:10.070597 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-10 00:42:10.111519 | debian-bookworm | ok 2026-05-10 00:42:10.117594 | 2026-05-10 00:42:10.117717 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-10 00:42:10.619511 | debian-bookworm -> localhost | changed 2026-05-10 00:42:10.628166 | 2026-05-10 00:42:10.628291 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-10 00:42:10.689284 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:10.695755 | 2026-05-10 00:42:10.695886 | TASK [fetch-tox-output : Set envlist fact] 2026-05-10 00:42:10.738340 | debian-bookworm | ok 2026-05-10 00:42:10.748659 | 2026-05-10 00:42:10.748834 | TASK [fetch-tox-output : Get tox version] 2026-05-10 00:42:11.517495 | 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-05-10 00:42:11.534241 | debian-bookworm | 4.53.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-10 00:42:11.781879 | debian-bookworm | ok: Runtime: 0:00:00.338450 2026-05-10 00:42:11.793549 | 2026-05-10 00:42:11.793727 | TASK [fetch-tox-output : Find all default environments] 2026-05-10 00:42:12.329288 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:12.339776 | 2026-05-10 00:42:12.339985 | TASK [fetch-tox-output : Set envlist fact] 2026-05-10 00:42:12.365689 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:12.379269 | 2026-05-10 00:42:12.379474 | TASK [fetch-tox-output : Find all default environments] 2026-05-10 00:42:12.912678 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:12.926319 | 2026-05-10 00:42:12.926607 | TASK [fetch-tox-output : Set envlist fact] 2026-05-10 00:42:12.962739 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:12.979114 | 2026-05-10 00:42:12.979289 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-10 00:42:13.039799 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:13.052321 | 2026-05-10 00:42:13.052485 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-10 00:42:13.907247 | debian-bookworm | changed: 2026-05-10 00:42:13.907518 | debian-bookworm | created directory /var/lib/zuul/builds/34f3aab5296e4f3ea8788670f4918867/work/logs/tox/test 2026-05-10 00:42:13.907563 | debian-bookworm | cd+++++++++ ./ 2026-05-10 00:42:13.907594 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-10 00:42:13.907629 | 2026-05-10 00:42:13.926404 | 2026-05-10 00:42:13.926539 | PLAY RECAP 2026-05-10 00:42:13.926604 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-10 00:42:13.926634 | 2026-05-10 00:42:14.063110 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-10 00:42:14.064217 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-10 00:42:14.827445 | 2026-05-10 00:42:14.827614 | PLAY [all] 2026-05-10 00:42:14.843472 | 2026-05-10 00:42:14.843625 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-10 00:42:15.073132 | debian-bookworm | changed: non-zero return code 2026-05-10 00:42:15.082186 | 2026-05-10 00:42:15.082486 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-10 00:42:15.110108 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:15.124925 | 2026-05-10 00:42:15.125218 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-10 00:42:15.167660 | 2026-05-10 00:42:15.167973 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-10 00:42:15.216096 | 2026-05-10 00:42:15.216447 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-10 00:42:15.244574 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:15.260540 | 2026-05-10 00:42:15.260802 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-10 00:42:15.296855 | 2026-05-10 00:42:15.297165 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-10 00:42:15.324827 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:15.337818 | 2026-05-10 00:42:15.338031 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-10 00:42:15.363851 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:15.370899 | 2026-05-10 00:42:15.371051 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-10 00:42:15.396981 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:15.425040 | 2026-05-10 00:42:15.425243 | PLAY RECAP 2026-05-10 00:42:15.425363 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-10 00:42:15.425469 | 2026-05-10 00:42:15.571168 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-10 00:42:15.572314 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-10 00:42:16.393969 | 2026-05-10 00:42:16.394159 | PLAY [Base post-fetch] 2026-05-10 00:42:16.410924 | 2026-05-10 00:42:16.411093 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-10 00:42:16.477704 | debian-bookworm | skipping: Conditional result was False 2026-05-10 00:42:16.489557 | 2026-05-10 00:42:16.489761 | TASK [fetch-output : Set log path for single node] 2026-05-10 00:42:16.541564 | debian-bookworm | ok 2026-05-10 00:42:16.551231 | 2026-05-10 00:42:16.551451 | LOOP [fetch-output : Ensure local output dirs] 2026-05-10 00:42:17.079239 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/34f3aab5296e4f3ea8788670f4918867/work/logs" 2026-05-10 00:42:17.353897 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/34f3aab5296e4f3ea8788670f4918867/work/artifacts" 2026-05-10 00:42:17.621967 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/34f3aab5296e4f3ea8788670f4918867/work/docs" 2026-05-10 00:42:17.643645 | 2026-05-10 00:42:17.643823 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-10 00:42:18.453165 | debian-bookworm | changed: 2026-05-10 00:42:18.453439 | debian-bookworm | .d..t...... ./ 2026-05-10 00:42:18.453483 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-10 00:42:18.453519 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-10 00:42:18.453552 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-10 00:42:18.453600 | debian-bookworm | changed: All items complete 2026-05-10 00:42:18.453632 | 2026-05-10 00:42:19.078070 | debian-bookworm | changed: .d..t...... ./ 2026-05-10 00:42:19.657475 | debian-bookworm | changed: .d..t...... ./ 2026-05-10 00:42:19.681258 | 2026-05-10 00:42:19.681468 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-10 00:42:20.240046 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008582 2026-05-10 00:42:20.513258 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009268 2026-05-10 00:42:20.527112 | 2026-05-10 00:42:20.527217 | PLAY RECAP 2026-05-10 00:42:20.527270 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-10 00:42:20.527295 | 2026-05-10 00:42:20.688333 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-10 00:42:20.689521 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-10 00:42:21.486247 | 2026-05-10 00:42:21.486449 | PLAY [Base post] 2026-05-10 00:42:21.500751 | 2026-05-10 00:42:21.500906 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-10 00:42:22.114288 | debian-bookworm | changed 2026-05-10 00:42:22.120932 | 2026-05-10 00:42:22.121050 | PLAY RECAP 2026-05-10 00:42:22.121113 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-10 00:42:22.121176 | 2026-05-10 00:42:22.258723 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-10 00:42:22.261785 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-10 00:42:23.080643 | 2026-05-10 00:42:23.080829 | PLAY [Base post-logs] 2026-05-10 00:42:23.092309 | 2026-05-10 00:42:23.092519 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-10 00:42:23.576783 | localhost | changed 2026-05-10 00:42:23.594800 | 2026-05-10 00:42:23.595062 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-10 00:42:23.621850 | localhost | ok 2026-05-10 00:42:23.625164 | 2026-05-10 00:42:23.625269 | TASK [Set zuul-log-path fact] 2026-05-10 00:42:23.650860 | localhost | ok 2026-05-10 00:42:23.662175 | 2026-05-10 00:42:23.662306 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-10 00:42:23.687876 | localhost | ok 2026-05-10 00:42:23.691016 | 2026-05-10 00:42:23.691124 | TASK [upload-logs : Create log directories] 2026-05-10 00:42:24.190994 | localhost | changed 2026-05-10 00:42:24.195578 | 2026-05-10 00:42:24.195720 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-10 00:42:24.729967 | localhost -> localhost | ok: Runtime: 0:00:00.006789 2026-05-10 00:42:24.740055 | 2026-05-10 00:42:24.740270 | TASK [upload-logs : Upload logs to log server] 2026-05-10 00:42:25.327265 | localhost | Output suppressed because no_log was given 2026-05-10 00:42:25.329235 | 2026-05-10 00:42:25.329335 | LOOP [upload-logs : Compress console log and json output] 2026-05-10 00:42:25.392614 | localhost | skipping: Conditional result was False 2026-05-10 00:42:25.401473 | localhost | skipping: Conditional result was False 2026-05-10 00:42:25.407375 | 2026-05-10 00:42:25.407616 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-10 00:42:25.459778 | localhost | skipping: Conditional result was False 2026-05-10 00:42:25.460095 | 2026-05-10 00:42:25.464520 | localhost | skipping: Conditional result was False 2026-05-10 00:42:25.480138 | 2026-05-10 00:42:25.480491 | LOOP [upload-logs : Upload console log and json output]