2026-06-08 03:15:56.286978 | Job console starting 2026-06-08 03:15:56.297992 | Updating git repos 2026-06-08 03:15:56.334957 | Cloning repos into workspace 2026-06-08 03:15:56.420765 | Restoring repo states 2026-06-08 03:15:56.433415 | Merging changes 2026-06-08 03:15:56.433434 | Checking out repos 2026-06-08 03:15:56.542778 | Preparing playbooks 2026-06-08 03:15:58.099394 | Running Ansible setup 2026-06-08 03:16:03.183789 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-08 03:16:04.043318 | 2026-06-08 03:16:04.043451 | PLAY [Base pre] 2026-06-08 03:16:04.062535 | 2026-06-08 03:16:04.062645 | TASK [Setup log path fact] 2026-06-08 03:16:04.081183 | debian-bookworm | ok 2026-06-08 03:16:04.097457 | 2026-06-08 03:16:04.097573 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 03:16:04.125745 | debian-bookworm | ok 2026-06-08 03:16:04.135155 | 2026-06-08 03:16:04.135258 | TASK [emit-job-header : Print job information] 2026-06-08 03:16:04.176827 | # Job Information 2026-06-08 03:16:04.176986 | Ansible Version: 2.16.14 2026-06-08 03:16:04.177020 | Job: tox 2026-06-08 03:16:04.177053 | Pipeline: periodic-daily 2026-06-08 03:16:04.177076 | Executor: 521e9411259a 2026-06-08 03:16:04.177097 | Triggered by: https://github.com/osism/openstack-image-manager 2026-06-08 03:16:04.177119 | Event ID: aabc2ef5e8944e638e94e63d04439768 2026-06-08 03:16:04.186194 | 2026-06-08 03:16:04.186304 | LOOP [emit-job-header : Print node information] 2026-06-08 03:16:04.314498 | debian-bookworm | ok: 2026-06-08 03:16:04.314791 | debian-bookworm | # Node Information 2026-06-08 03:16:04.314849 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-08 03:16:04.314887 | debian-bookworm | Hostname: debian 2026-06-08 03:16:04.315045 | debian-bookworm | Username: zuul 2026-06-08 03:16:04.315078 | debian-bookworm | Distro: Debian 12.14 2026-06-08 03:16:04.315107 | debian-bookworm | Provider: regiocloud-a 2026-06-08 03:16:04.315131 | debian-bookworm | Region: 2026-06-08 03:16:04.315153 | debian-bookworm | Label: debian-bookworm 2026-06-08 03:16:04.315222 | debian-bookworm | Product Name: OpenStack Nova 2026-06-08 03:16:04.315248 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7e:2e67 2026-06-08 03:16:04.336484 | 2026-06-08 03:16:04.336627 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-08 03:16:04.849903 | debian-bookworm -> localhost | changed 2026-06-08 03:16:04.856666 | 2026-06-08 03:16:04.856826 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-08 03:16:05.841006 | debian-bookworm -> localhost | changed 2026-06-08 03:16:05.852403 | 2026-06-08 03:16:05.852506 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-08 03:16:06.114243 | debian-bookworm -> localhost | ok 2026-06-08 03:16:06.120295 | 2026-06-08 03:16:06.120412 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-08 03:16:06.142571 | debian-bookworm | ok 2026-06-08 03:16:06.158979 | debian-bookworm | included: /var/lib/zuul/builds/74624488199c447e82c366873ed40320/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-08 03:16:06.164887 | 2026-06-08 03:16:06.164970 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-08 03:16:07.838093 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-08 03:16:07.838656 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/74624488199c447e82c366873ed40320/work/74624488199c447e82c366873ed40320_id_rsa 2026-06-08 03:16:07.838735 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/74624488199c447e82c366873ed40320/work/74624488199c447e82c366873ed40320_id_rsa.pub 2026-06-08 03:16:07.838764 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-08 03:16:07.838788 | debian-bookworm -> localhost | SHA256:9XfD96VbRoZVAGQaVTuEU2Yfpj28YsDQYExZwerIScg zuul-build-sshkey 2026-06-08 03:16:07.838811 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-08 03:16:07.838854 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-08 03:16:07.838879 | debian-bookworm -> localhost | | o=B=*=B+.| 2026-06-08 03:16:07.838901 | debian-bookworm -> localhost | | .oo*o+=oo| 2026-06-08 03:16:07.838922 | debian-bookworm -> localhost | | . . +o oo+o| 2026-06-08 03:16:07.838942 | debian-bookworm -> localhost | | E . o .. .+o| 2026-06-08 03:16:07.838962 | debian-bookworm -> localhost | | o S .oo+*| 2026-06-08 03:16:07.838986 | debian-bookworm -> localhost | | + . ...==| 2026-06-08 03:16:07.839123 | debian-bookworm -> localhost | | . +| 2026-06-08 03:16:07.839154 | debian-bookworm -> localhost | | + | 2026-06-08 03:16:07.839188 | debian-bookworm -> localhost | | . | 2026-06-08 03:16:07.839211 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-08 03:16:07.839273 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.226403 2026-06-08 03:16:07.848319 | 2026-06-08 03:16:07.848416 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-08 03:16:07.866890 | debian-bookworm | ok 2026-06-08 03:16:07.877171 | debian-bookworm | included: /var/lib/zuul/builds/74624488199c447e82c366873ed40320/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-08 03:16:07.887052 | 2026-06-08 03:16:07.887147 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-08 03:16:07.900403 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:16:07.906232 | 2026-06-08 03:16:07.906322 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-08 03:16:08.607215 | debian-bookworm | changed 2026-06-08 03:16:08.614679 | 2026-06-08 03:16:08.614824 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-08 03:16:08.903970 | debian-bookworm | ok 2026-06-08 03:16:08.950353 | 2026-06-08 03:16:08.950502 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-08 03:16:09.762489 | debian-bookworm | changed 2026-06-08 03:16:09.783523 | 2026-06-08 03:16:09.783673 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-08 03:16:10.544436 | debian-bookworm | changed 2026-06-08 03:16:10.552383 | 2026-06-08 03:16:10.552506 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-08 03:16:10.577540 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:16:10.585713 | 2026-06-08 03:16:10.585850 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-08 03:16:11.098323 | debian-bookworm -> localhost | changed 2026-06-08 03:16:11.122001 | 2026-06-08 03:16:11.122153 | TASK [add-build-sshkey : Add back temp key] 2026-06-08 03:16:11.627842 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/74624488199c447e82c366873ed40320/work/74624488199c447e82c366873ed40320_id_rsa (zuul-build-sshkey) 2026-06-08 03:16:11.628246 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009622 2026-06-08 03:16:11.641412 | 2026-06-08 03:16:11.641536 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-08 03:16:12.019740 | debian-bookworm | ok 2026-06-08 03:16:12.026474 | 2026-06-08 03:16:12.026582 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-08 03:16:12.060984 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:16:12.076770 | 2026-06-08 03:16:12.076872 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-08 03:16:12.498057 | debian-bookworm | ok 2026-06-08 03:16:12.512941 | 2026-06-08 03:16:12.513043 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-08 03:16:12.552810 | debian-bookworm | ok 2026-06-08 03:16:12.558563 | 2026-06-08 03:16:12.558647 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-08 03:16:12.841810 | debian-bookworm -> localhost | ok 2026-06-08 03:16:12.855166 | 2026-06-08 03:16:12.855302 | TASK [validate-host : Collect information about the host] 2026-06-08 03:16:13.869409 | debian-bookworm | ok 2026-06-08 03:16:13.883317 | 2026-06-08 03:16:13.883416 | TASK [validate-host : Sanitize hostname] 2026-06-08 03:16:13.986318 | debian-bookworm | ok 2026-06-08 03:16:14.040610 | 2026-06-08 03:16:14.040732 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-08 03:16:14.607022 | debian-bookworm -> localhost | changed 2026-06-08 03:16:14.612423 | 2026-06-08 03:16:14.612520 | TASK [validate-host : Collect information about zuul worker] 2026-06-08 03:16:15.102651 | debian-bookworm | ok 2026-06-08 03:16:15.110370 | 2026-06-08 03:16:15.110495 | TASK [validate-host : Write out all zuul information for each host] 2026-06-08 03:16:15.771670 | debian-bookworm -> localhost | changed 2026-06-08 03:16:15.780771 | 2026-06-08 03:16:15.780868 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-08 03:16:16.050453 | debian-bookworm | ok 2026-06-08 03:16:16.057211 | 2026-06-08 03:16:16.060099 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-08 03:16:17.409861 | debian-bookworm | changed: 2026-06-08 03:16:17.410076 | debian-bookworm | cd+++++++++ src/ 2026-06-08 03:16:17.410111 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-08 03:16:17.410135 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-08 03:16:17.410157 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-08 03:16:17.410177 | debian-bookworm | =7.0.3 2026-06-08 03:16:44.095922 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-06-08 03:16:44.150020 | debian-bookworm | Collecting colorama>=0.4.6 2026-06-08 03:16:44.161163 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-08 03:16:44.222913 | debian-bookworm | Collecting filelock>=3.25 2026-06-08 03:16:44.233850 | debian-bookworm | Downloading filelock-3.29.1-py3-none-any.whl (40 kB) 2026-06-08 03:16:44.241198 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 40.8/40.8 kB 6.4 MB/s eta 0:00:00 2026-06-08 03:16:44.298901 | debian-bookworm | Collecting packaging>=26 2026-06-08 03:16:44.309650 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-08 03:16:44.320394 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 11.4 MB/s eta 0:00:00 2026-06-08 03:16:44.372011 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-06-08 03:16:44.383311 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-06-08 03:16:44.425521 | debian-bookworm | Collecting pluggy>=1.6 2026-06-08 03:16:44.436398 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-08 03:16:44.590112 | debian-bookworm | Collecting pyproject-api>=1.10 2026-06-08 03:16:44.602289 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-06-08 03:16:44.637935 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-06-08 03:16:44.650741 | debian-bookworm | Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB) 2026-06-08 03:16:44.703855 | debian-bookworm | Collecting tomli-w>=1.2 2026-06-08 03:16:44.715534 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-06-08 03:16:45.176447 | debian-bookworm | Collecting virtualenv>=21.1 2026-06-08 03:16:45.201499 | debian-bookworm | Downloading virtualenv-21.4.2-py3-none-any.whl (7.6 MB) 2026-06-08 03:16:45.536280 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 23.0 MB/s eta 0:00:00 2026-06-08 03:16:45.638109 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-06-08 03:16:45.649571 | debian-bookworm | Downloading distlib-0.4.1-py2.py3-none-any.whl (469 kB) 2026-06-08 03:16:45.684301 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.2/469.2 kB 17.2 MB/s eta 0:00:00 2026-06-08 03:16:45.807591 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-06-08 03:16:46.599155 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.1 filelock-3.29.1 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.0 tomli-w-1.2.0 tox-4.55.1 virtualenv-21.4.2 2026-06-08 03:16:46.983201 | debian-bookworm | ok: Runtime: 0:00:03.482834 2026-06-08 03:16:46.998064 | 2026-06-08 03:16:46.998203 | TASK [ensure-tox : Export installed tox_executable path] 2026-06-08 03:16:47.090820 | debian-bookworm | ok 2026-06-08 03:16:47.107258 | 2026-06-08 03:16:47.107466 | TASK [ensure-tox : Output tox version] 2026-06-08 03:16:47.784182 | 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-06-08 03:16:47.801561 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-08 03:16:48.194673 | debian-bookworm | ok: Runtime: 0:00:00.325046 2026-06-08 03:16:48.202243 | 2026-06-08 03:16:48.202366 | TASK [ensure-tox : Make global symlink] 2026-06-08 03:16:48.228091 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:16:48.236141 | 2026-06-08 03:16:48.236241 | PLAY RECAP 2026-06-08 03:16:48.236300 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-06-08 03:16:48.236326 | 2026-06-08 03:16:48.397798 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-06-08 03:16:48.399107 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-08 03:16:49.229274 | 2026-06-08 03:16:49.229462 | PLAY [all] 2026-06-08 03:16:49.249537 | 2026-06-08 03:16:49.249729 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-06-08 03:16:49.765025 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-08 03:16:49.817231 | debian-bookworm | ok: Runtime: 0:00:00.029229 2026-06-08 03:16:49.823937 | 2026-06-08 03:16:49.824122 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-06-08 03:16:50.357224 | debian-bookworm | ok: Runtime: 0:00:00.008277 2026-06-08 03:16:50.372067 | 2026-06-08 03:16:50.372264 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-06-08 03:16:50.680408 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-08 03:16:50.681225 | debian-bookworm | sudo: a password is required 2026-06-08 03:16:50.909418 | debian-bookworm | ok: Runtime: 0:00:00.019680 2026-06-08 03:16:50.933748 | 2026-06-08 03:16:50.933938 | TASK [tox : Check to see if the constraints file exists] 2026-06-08 03:16:50.971934 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:16:50.983760 | 2026-06-08 03:16:50.983911 | TASK [tox : Fail if constraints file is missing] 2026-06-08 03:16:51.009528 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:16:51.018086 | 2026-06-08 03:16:51.018259 | TASK [tox : Record file location] 2026-06-08 03:16:51.061251 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:16:51.070322 | 2026-06-08 03:16:51.070470 | TASK [tox : Install tox siblings] 2026-06-08 03:16:51.127334 | debian-bookworm | ok 2026-06-08 03:16:51.148033 | debian-bookworm | included: /var/lib/zuul/builds/74624488199c447e82c366873ed40320/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-06-08 03:16:51.162379 | 2026-06-08 03:16:51.163214 | TASK [tox : Run tox without tests] 2026-06-08 03:16:52.354520 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-06-08 03:17:04.458096 | debian-bookworm | test: OK (12.70 seconds) 2026-06-08 03:17:04.458182 | debian-bookworm | congratulations :) (12.73 seconds) 2026-06-08 03:17:04.720199 | debian-bookworm | ok: Runtime: 0:00:13.007340 2026-06-08 03:17:04.726210 | 2026-06-08 03:17:04.726318 | TASK [tox : Create a tempfile to save tox showconfig] 2026-06-08 03:17:05.069324 | debian-bookworm | changed 2026-06-08 03:17:05.073427 | 2026-06-08 03:17:05.073506 | TASK [tox : Detect tox version] 2026-06-08 03:17:05.612675 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-08 03:17:06.131788 | debian-bookworm | ok: Runtime: 0:00:00.270131 2026-06-08 03:17:06.143232 | 2026-06-08 03:17:06.143374 | TASK [tox : Get tox envlist config] 2026-06-08 03:17:07.172426 | debian-bookworm | ok: Runtime: 0:00:00.325598 2026-06-08 03:17:07.193497 | 2026-06-08 03:17:07.193634 | TASK [tox : Install any sibling python packages] 2026-06-08 03:17:07.776739 | debian-bookworm | ok: No setup.cfg, no action needed 2026-06-08 03:17:07.788050 | 2026-06-08 03:17:07.788241 | TASK [tox : Remove tempfile] 2026-06-08 03:17:08.423658 | debian-bookworm | changed 2026-06-08 03:17:08.459167 | 2026-06-08 03:17:08.459414 | TASK [tox : Emit tox command] 2026-06-08 03:17:08.496137 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-06-08 03:17:08.501571 | 2026-06-08 03:17:08.501672 | TASK [tox : Run tox] 2026-06-08 03:17:09.057128 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-06-08 03:17:09.681520 | debian-bookworm | ............... 2026-06-08 03:17:09.681557 | debian-bookworm | ---------------------------------------------------------------------- 2026-06-08 03:17:09.681567 | debian-bookworm | Ran 15 tests in 0.166s 2026-06-08 03:17:09.681572 | debian-bookworm | 2026-06-08 03:17:09.681579 | debian-bookworm | OK 2026-06-08 03:17:09.743686 | debian-bookworm | test: OK (0.73=setup[0.04]+cmd[0.68] seconds) 2026-06-08 03:17:09.743733 | debian-bookworm | congratulations :) (0.75 seconds) 2026-06-08 03:17:10.046446 | debian-bookworm | ok: Runtime: 0:00:01.015471 2026-06-08 03:17:10.052652 | 2026-06-08 03:17:10.052765 | TASK [tox : Look for output] 2026-06-08 03:17:10.495468 | debian-bookworm | ok 2026-06-08 03:17:10.518575 | 2026-06-08 03:17:10.518784 | TASK [tox : Return file comments to Zuul] 2026-06-08 03:17:10.561029 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:10.573515 | 2026-06-08 03:17:10.573639 | PLAY RECAP 2026-06-08 03:17:10.573719 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-06-08 03:17:10.573751 | 2026-06-08 03:17:10.739257 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-08 03:17:10.740431 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-08 03:17:11.769122 | 2026-06-08 03:17:11.769303 | PLAY [all] 2026-06-08 03:17:11.813030 | 2026-06-08 03:17:11.813195 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-06-08 03:17:11.963281 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:11.969480 | 2026-06-08 03:17:11.969651 | TASK [fetch-tox-output : Set tox log path for single node] 2026-06-08 03:17:12.063442 | debian-bookworm | ok 2026-06-08 03:17:12.080829 | 2026-06-08 03:17:12.081070 | TASK [fetch-tox-output : Ensure local tox dir] 2026-06-08 03:17:12.970854 | debian-bookworm -> localhost | changed 2026-06-08 03:17:12.979298 | 2026-06-08 03:17:12.979428 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-06-08 03:17:13.033909 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:13.040031 | 2026-06-08 03:17:13.040152 | TASK [fetch-tox-output : Set envlist fact] 2026-06-08 03:17:13.079652 | debian-bookworm | ok 2026-06-08 03:17:13.091501 | 2026-06-08 03:17:13.091679 | TASK [fetch-tox-output : Get tox version] 2026-06-08 03:17:13.858411 | 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-06-08 03:17:13.874957 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-08 03:17:14.121496 | debian-bookworm | ok: Runtime: 0:00:00.280350 2026-06-08 03:17:14.127585 | 2026-06-08 03:17:14.127754 | TASK [fetch-tox-output : Find all default environments] 2026-06-08 03:17:14.691292 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:14.697708 | 2026-06-08 03:17:14.697842 | TASK [fetch-tox-output : Set envlist fact] 2026-06-08 03:17:14.792685 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:14.799041 | 2026-06-08 03:17:14.799163 | TASK [fetch-tox-output : Find all default environments] 2026-06-08 03:17:15.364625 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:15.374893 | 2026-06-08 03:17:15.375039 | TASK [fetch-tox-output : Set envlist fact] 2026-06-08 03:17:15.411567 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:15.419764 | 2026-06-08 03:17:15.419881 | LOOP [fetch-tox-output : Copy tox logs] 2026-06-08 03:17:15.492348 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:15.503699 | 2026-06-08 03:17:15.503831 | LOOP [fetch-tox-output : Collect tox logs] 2026-06-08 03:17:16.352871 | debian-bookworm | changed: 2026-06-08 03:17:16.353080 | debian-bookworm | created directory /var/lib/zuul/builds/74624488199c447e82c366873ed40320/work/logs/tox/test 2026-06-08 03:17:16.353118 | debian-bookworm | cd+++++++++ ./ 2026-06-08 03:17:16.353143 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-06-08 03:17:16.353171 | 2026-06-08 03:17:16.363128 | 2026-06-08 03:17:16.363239 | PLAY RECAP 2026-06-08 03:17:16.363296 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-06-08 03:17:16.363321 | 2026-06-08 03:17:16.561431 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-08 03:17:16.562586 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-08 03:17:17.472690 | 2026-06-08 03:17:17.472856 | PLAY [all] 2026-06-08 03:17:17.489081 | 2026-06-08 03:17:17.489227 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-08 03:17:17.714313 | debian-bookworm | changed: non-zero return code 2026-06-08 03:17:17.722937 | 2026-06-08 03:17:17.723111 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-08 03:17:17.748013 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:17.757278 | 2026-06-08 03:17:17.757454 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-08 03:17:17.789629 | 2026-06-08 03:17:17.789837 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-08 03:17:17.823792 | 2026-06-08 03:17:17.824009 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-08 03:17:17.848735 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:17.855207 | 2026-06-08 03:17:17.855344 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-08 03:17:17.887246 | 2026-06-08 03:17:17.887562 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-08 03:17:17.905917 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:17.912120 | 2026-06-08 03:17:17.912262 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-08 03:17:17.936214 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:17.942411 | 2026-06-08 03:17:17.942578 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-08 03:17:17.966572 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:17.973476 | 2026-06-08 03:17:17.973588 | PLAY RECAP 2026-06-08 03:17:17.973642 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-08 03:17:17.973668 | 2026-06-08 03:17:18.137432 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-08 03:17:18.138677 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-08 03:17:19.670889 | 2026-06-08 03:17:19.671081 | PLAY [Base post-fetch] 2026-06-08 03:17:19.716943 | 2026-06-08 03:17:19.717134 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-08 03:17:19.800919 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:19.807280 | 2026-06-08 03:17:19.807465 | TASK [fetch-output : Set log path for single node] 2026-06-08 03:17:19.858928 | debian-bookworm | ok 2026-06-08 03:17:19.864330 | 2026-06-08 03:17:19.864484 | LOOP [fetch-output : Ensure local output dirs] 2026-06-08 03:17:20.780050 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/74624488199c447e82c366873ed40320/work/logs" 2026-06-08 03:17:21.227807 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/74624488199c447e82c366873ed40320/work/artifacts" 2026-06-08 03:17:21.676516 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/74624488199c447e82c366873ed40320/work/docs" 2026-06-08 03:17:21.694164 | 2026-06-08 03:17:21.694313 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-08 03:17:22.506383 | debian-bookworm | changed: 2026-06-08 03:17:22.506671 | debian-bookworm | .d..t...... ./ 2026-06-08 03:17:22.506708 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-08 03:17:22.506746 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-08 03:17:22.506778 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-08 03:17:22.506820 | debian-bookworm | changed: All items complete 2026-06-08 03:17:22.506868 | 2026-06-08 03:17:23.184290 | debian-bookworm | changed: .d..t...... ./ 2026-06-08 03:17:23.918501 | debian-bookworm | changed: .d..t...... ./ 2026-06-08 03:17:23.959889 | 2026-06-08 03:17:23.960035 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-08 03:17:24.036469 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:24.052335 | debian-bookworm | skipping: Conditional result was False 2026-06-08 03:17:24.087666 | 2026-06-08 03:17:24.088340 | PLAY RECAP 2026-06-08 03:17:24.088735 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-08 03:17:24.088768 | 2026-06-08 03:17:24.490114 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-08 03:17:24.492344 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 03:17:26.146168 | 2026-06-08 03:17:26.146348 | PLAY [Base post] 2026-06-08 03:17:26.188029 | 2026-06-08 03:17:26.188204 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-08 03:17:27.028120 | debian-bookworm | changed 2026-06-08 03:17:27.034332 | 2026-06-08 03:17:27.034419 | PLAY RECAP 2026-06-08 03:17:27.035711 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-08 03:17:27.035879 | 2026-06-08 03:17:27.238446 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 03:17:27.239476 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-08 03:17:28.043135 | 2026-06-08 03:17:28.043266 | PLAY [Base post-logs] 2026-06-08 03:17:28.056869 | 2026-06-08 03:17:28.056983 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-08 03:17:28.656315 | localhost | changed 2026-06-08 03:17:28.666046 | 2026-06-08 03:17:28.666192 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-08 03:17:28.711785 | localhost | ok 2026-06-08 03:17:28.714606 | 2026-06-08 03:17:28.714692 | TASK [Set zuul-log-path fact] 2026-06-08 03:17:28.739864 | localhost | ok 2026-06-08 03:17:28.747314 | 2026-06-08 03:17:28.747418 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 03:17:28.785181 | localhost | ok 2026-06-08 03:17:28.787975 | 2026-06-08 03:17:28.788064 | TASK [upload-logs : Create log directories] 2026-06-08 03:17:29.434178 | localhost | changed 2026-06-08 03:17:29.436840 | 2026-06-08 03:17:29.436934 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-08 03:17:30.520440 | localhost -> localhost | ok: Runtime: 0:00:00.012985 2026-06-08 03:17:30.524114 | 2026-06-08 03:17:30.524210 | TASK [upload-logs : Upload logs to log server] 2026-06-08 03:17:31.671266 | localhost | Output suppressed because no_log was given 2026-06-08 03:17:31.672821 | 2026-06-08 03:17:31.672906 | LOOP [upload-logs : Compress console log and json output] 2026-06-08 03:17:31.748880 | localhost | skipping: Conditional result was False 2026-06-08 03:17:31.764280 | localhost | skipping: Conditional result was False 2026-06-08 03:17:31.770048 | 2026-06-08 03:17:31.770150 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-08 03:17:31.834796 | localhost | skipping: Conditional result was False 2026-06-08 03:17:31.835023 | 2026-06-08 03:17:31.839805 | localhost | skipping: Conditional result was False 2026-06-08 03:17:31.847635 | 2026-06-08 03:17:31.847729 | LOOP [upload-logs : Upload console log and json output]