2026-05-19 03:02:45.575629 | Job console starting 2026-05-19 03:02:45.600972 | Updating git repos 2026-05-19 03:02:45.643721 | Cloning repos into workspace 2026-05-19 03:02:45.737706 | Restoring repo states 2026-05-19 03:02:45.750101 | Merging changes 2026-05-19 03:02:45.750120 | Checking out repos 2026-05-19 03:02:45.822382 | Preparing playbooks 2026-05-19 03:02:46.920043 | Running Ansible setup 2026-05-19 03:02:52.900070 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-19 03:02:53.791989 | 2026-05-19 03:02:53.792113 | PLAY [Base pre] 2026-05-19 03:02:53.836059 | 2026-05-19 03:02:53.836178 | TASK [Setup log path fact] 2026-05-19 03:02:53.863570 | debian-bookworm | ok 2026-05-19 03:02:53.888530 | 2026-05-19 03:02:53.888652 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 03:02:53.936007 | debian-bookworm | ok 2026-05-19 03:02:53.945158 | 2026-05-19 03:02:53.945254 | TASK [emit-job-header : Print job information] 2026-05-19 03:02:54.002673 | # Job Information 2026-05-19 03:02:54.002800 | Ansible Version: 2.16.14 2026-05-19 03:02:54.002841 | Job: tox 2026-05-19 03:02:54.002871 | Pipeline: periodic-daily 2026-05-19 03:02:54.002913 | Executor: 521e9411259a 2026-05-19 03:02:54.002932 | Triggered by: https://github.com/osism/openstack-image-manager 2026-05-19 03:02:54.002951 | Event ID: 36b8331656c54e4d9ec23445703fffbf 2026-05-19 03:02:54.007370 | 2026-05-19 03:02:54.007453 | LOOP [emit-job-header : Print node information] 2026-05-19 03:02:54.242479 | debian-bookworm | ok: 2026-05-19 03:02:54.245127 | debian-bookworm | # Node Information 2026-05-19 03:02:54.245203 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-19 03:02:54.245234 | debian-bookworm | Hostname: debian 2026-05-19 03:02:54.245259 | debian-bookworm | Username: zuul 2026-05-19 03:02:54.245280 | debian-bookworm | Distro: Debian 12.14 2026-05-19 03:02:54.245306 | debian-bookworm | Provider: regiocloud-a 2026-05-19 03:02:54.245328 | debian-bookworm | Region: 2026-05-19 03:02:54.245349 | debian-bookworm | Label: debian-bookworm 2026-05-19 03:02:54.245370 | debian-bookworm | Product Name: OpenStack Nova 2026-05-19 03:02:54.245390 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7d:d75a 2026-05-19 03:02:54.261309 | 2026-05-19 03:02:54.261409 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-19 03:02:54.941355 | debian-bookworm -> localhost | changed 2026-05-19 03:02:54.947201 | 2026-05-19 03:02:54.947300 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-19 03:02:57.429672 | debian-bookworm -> localhost | changed 2026-05-19 03:02:57.445075 | 2026-05-19 03:02:57.445205 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-19 03:02:58.189594 | debian-bookworm -> localhost | ok 2026-05-19 03:02:58.208390 | 2026-05-19 03:02:58.208507 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-19 03:02:58.260133 | debian-bookworm | ok 2026-05-19 03:02:58.291463 | debian-bookworm | included: /var/lib/zuul/builds/760ff41512a44eeda0559f87e4032eec/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-19 03:02:58.317405 | 2026-05-19 03:02:58.317516 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-19 03:03:00.474470 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-19 03:03:00.474646 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/760ff41512a44eeda0559f87e4032eec/work/760ff41512a44eeda0559f87e4032eec_id_rsa 2026-05-19 03:03:00.474682 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/760ff41512a44eeda0559f87e4032eec/work/760ff41512a44eeda0559f87e4032eec_id_rsa.pub 2026-05-19 03:03:00.474710 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-19 03:03:00.474730 | debian-bookworm -> localhost | SHA256:i6yeaOGLr4mUO15klrCI/RNX8zP2twetJB8ku0byGo4 zuul-build-sshkey 2026-05-19 03:03:00.474748 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-19 03:03:00.474774 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-19 03:03:00.474792 | debian-bookworm -> localhost | | | 2026-05-19 03:03:00.474810 | debian-bookworm -> localhost | | | 2026-05-19 03:03:00.474826 | debian-bookworm -> localhost | | . o | 2026-05-19 03:03:00.474861 | debian-bookworm -> localhost | |o.o . . o . . | 2026-05-19 03:03:00.474879 | debian-bookworm -> localhost | |o..=. . S = + . | 2026-05-19 03:03:00.474916 | debian-bookworm -> localhost | | *. + . o.++ + .| 2026-05-19 03:03:00.474933 | debian-bookworm -> localhost | | + oo o . .+.=.+ | 2026-05-19 03:03:00.474949 | debian-bookworm -> localhost | |o+=. + o .+.o..| 2026-05-19 03:03:00.474966 | debian-bookworm -> localhost | |**=o+ E oo .. | 2026-05-19 03:03:00.474983 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-19 03:03:00.475029 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.989207 2026-05-19 03:03:00.480388 | 2026-05-19 03:03:00.480468 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-19 03:03:00.508463 | debian-bookworm | ok 2026-05-19 03:03:00.521626 | debian-bookworm | included: /var/lib/zuul/builds/760ff41512a44eeda0559f87e4032eec/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-19 03:03:00.547462 | 2026-05-19 03:03:00.547571 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-19 03:03:00.573974 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:03:00.580069 | 2026-05-19 03:03:00.580175 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-19 03:03:01.495089 | debian-bookworm | changed 2026-05-19 03:03:01.499598 | 2026-05-19 03:03:01.499687 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-19 03:03:01.771347 | debian-bookworm | ok 2026-05-19 03:03:01.776026 | 2026-05-19 03:03:01.776116 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-19 03:03:02.451597 | debian-bookworm | changed 2026-05-19 03:03:02.463382 | 2026-05-19 03:03:02.463507 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-19 03:03:03.097615 | debian-bookworm | changed 2026-05-19 03:03:03.103486 | 2026-05-19 03:03:03.103601 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-19 03:03:03.126581 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:03:03.132809 | 2026-05-19 03:03:03.133005 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-19 03:03:03.874525 | debian-bookworm -> localhost | changed 2026-05-19 03:03:03.887776 | 2026-05-19 03:03:03.887880 | TASK [add-build-sshkey : Add back temp key] 2026-05-19 03:03:04.215074 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/760ff41512a44eeda0559f87e4032eec/work/760ff41512a44eeda0559f87e4032eec_id_rsa (zuul-build-sshkey) 2026-05-19 03:03:04.215383 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009713 2026-05-19 03:03:04.238547 | 2026-05-19 03:03:04.238644 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-19 03:03:04.986567 | debian-bookworm | ok 2026-05-19 03:03:05.008278 | 2026-05-19 03:03:05.009347 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-19 03:03:05.085370 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:03:05.118178 | 2026-05-19 03:03:05.119555 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-19 03:03:05.869699 | debian-bookworm | ok 2026-05-19 03:03:05.929722 | 2026-05-19 03:03:05.931794 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-19 03:03:06.001448 | debian-bookworm | ok 2026-05-19 03:03:06.040121 | 2026-05-19 03:03:06.041490 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-19 03:03:06.766843 | debian-bookworm -> localhost | ok 2026-05-19 03:03:06.772998 | 2026-05-19 03:03:06.773101 | TASK [validate-host : Collect information about the host] 2026-05-19 03:03:08.113769 | debian-bookworm | ok 2026-05-19 03:03:08.133320 | 2026-05-19 03:03:08.133437 | TASK [validate-host : Sanitize hostname] 2026-05-19 03:03:08.433572 | debian-bookworm | ok 2026-05-19 03:03:08.485044 | 2026-05-19 03:03:08.485160 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-19 03:03:09.589440 | debian-bookworm -> localhost | changed 2026-05-19 03:03:09.595075 | 2026-05-19 03:03:09.595183 | TASK [validate-host : Collect information about zuul worker] 2026-05-19 03:03:09.988810 | debian-bookworm | ok 2026-05-19 03:03:09.993334 | 2026-05-19 03:03:09.993429 | TASK [validate-host : Write out all zuul information for each host] 2026-05-19 03:03:11.692754 | debian-bookworm -> localhost | changed 2026-05-19 03:03:11.702443 | 2026-05-19 03:03:11.702543 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-19 03:03:11.997858 | debian-bookworm | ok 2026-05-19 03:03:12.003282 | 2026-05-19 03:03:12.003387 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-19 03:03:13.818793 | debian-bookworm | changed: 2026-05-19 03:03:13.819149 | debian-bookworm | cd+++++++++ src/ 2026-05-19 03:03:13.819278 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-19 03:03:13.819300 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-19 03:03:13.819320 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-19 03:03:13.819337 | debian-bookworm | =7.0.3 2026-05-19 03:03:41.569564 | debian-bookworm | Downloading cachetools-7.1.3-py3-none-any.whl (16 kB) 2026-05-19 03:03:41.614317 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-19 03:03:41.627506 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-19 03:03:41.695073 | debian-bookworm | Collecting filelock>=3.25 2026-05-19 03:03:41.707794 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-19 03:03:41.782048 | debian-bookworm | Collecting packaging>=26 2026-05-19 03:03:41.794448 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-19 03:03:41.810944 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 7.6 MB/s eta 0:00:00 2026-05-19 03:03:41.889444 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-19 03:03:41.901542 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-05-19 03:03:41.945348 | debian-bookworm | Collecting pluggy>=1.6 2026-05-19 03:03:41.957867 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-19 03:03:42.005395 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-19 03:03:42.018291 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-19 03:03:42.054349 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-19 03:03:42.066070 | debian-bookworm | Downloading python_discovery-1.3.1-py3-none-any.whl (33 kB) 2026-05-19 03:03:42.105382 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-19 03:03:42.116843 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-19 03:03:42.285169 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-19 03:03:42.298501 | debian-bookworm | Downloading virtualenv-21.3.3-py3-none-any.whl (7.6 MB) 2026-05-19 03:03:42.640593 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 22.5 MB/s eta 0:00:00 2026-05-19 03:03:42.748980 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-19 03:03:42.760554 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-19 03:03:42.789244 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.3 MB/s eta 0:00:00 2026-05-19 03:03:42.908338 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-19 03:03:43.698715 | debian-bookworm | Successfully installed cachetools-7.1.3 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.1 tomli-w-1.2.0 tox-4.54.0 virtualenv-21.3.3 2026-05-19 03:03:43.902308 | debian-bookworm | ok: Runtime: 0:00:03.202000 2026-05-19 03:03:43.918183 | 2026-05-19 03:03:43.918357 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-19 03:03:44.008949 | debian-bookworm | ok 2026-05-19 03:03:44.015873 | 2026-05-19 03:03:44.016020 | TASK [ensure-tox : Output tox version] 2026-05-19 03:03:44.638738 | 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-19 03:03:44.657159 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-19 03:03:45.058008 | debian-bookworm | ok: Runtime: 0:00:00.354897 2026-05-19 03:03:45.065006 | 2026-05-19 03:03:45.065140 | TASK [ensure-tox : Make global symlink] 2026-05-19 03:03:45.121272 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:03:45.134452 | 2026-05-19 03:03:45.134577 | PLAY RECAP 2026-05-19 03:03:45.134636 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-19 03:03:45.134662 | 2026-05-19 03:03:45.939496 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-19 03:03:45.941275 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-19 03:03:48.197508 | 2026-05-19 03:03:48.197697 | PLAY [all] 2026-05-19 03:03:48.239957 | 2026-05-19 03:03:48.240148 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-19 03:03:49.129501 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-19 03:03:49.303350 | debian-bookworm | ok: Runtime: 0:00:00.027831 2026-05-19 03:03:49.307991 | 2026-05-19 03:03:49.308083 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-19 03:03:49.857501 | debian-bookworm | ok: Runtime: 0:00:00.005868 2026-05-19 03:03:49.862423 | 2026-05-19 03:03:49.862512 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-19 03:03:50.192840 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-19 03:03:50.194143 | debian-bookworm | sudo: a password is required 2026-05-19 03:03:50.434422 | debian-bookworm | ok: Runtime: 0:00:00.017696 2026-05-19 03:03:50.447410 | 2026-05-19 03:03:50.447510 | TASK [tox : Check to see if the constraints file exists] 2026-05-19 03:03:50.491305 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:03:50.502789 | 2026-05-19 03:03:50.502978 | TASK [tox : Fail if constraints file is missing] 2026-05-19 03:03:50.549049 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:03:50.561460 | 2026-05-19 03:03:50.561569 | TASK [tox : Record file location] 2026-05-19 03:03:50.579278 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:03:50.584783 | 2026-05-19 03:03:50.584881 | TASK [tox : Install tox siblings] 2026-05-19 03:03:50.634234 | debian-bookworm | ok 2026-05-19 03:03:50.662319 | debian-bookworm | included: /var/lib/zuul/builds/760ff41512a44eeda0559f87e4032eec/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-19 03:03:50.676035 | 2026-05-19 03:03:50.676157 | TASK [tox : Run tox without tests] 2026-05-19 03:03:52.013487 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-05-19 03:04:04.844296 | debian-bookworm | test: OK (13.51 seconds) 2026-05-19 03:04:04.844335 | debian-bookworm | congratulations :) (13.54 seconds) 2026-05-19 03:04:05.270931 | debian-bookworm | ok: Runtime: 0:00:13.794764 2026-05-19 03:04:05.276645 | 2026-05-19 03:04:05.276753 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-19 03:04:05.929395 | debian-bookworm | changed 2026-05-19 03:04:05.940227 | 2026-05-19 03:04:05.940345 | TASK [tox : Detect tox version] 2026-05-19 03:04:06.573491 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-19 03:04:07.020330 | debian-bookworm | ok: Runtime: 0:00:00.261880 2026-05-19 03:04:07.024853 | 2026-05-19 03:04:07.024964 | TASK [tox : Get tox envlist config] 2026-05-19 03:04:08.108743 | debian-bookworm | ok: Runtime: 0:00:00.341438 2026-05-19 03:04:08.116712 | 2026-05-19 03:04:08.116985 | TASK [tox : Install any sibling python packages] 2026-05-19 03:04:08.828172 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-19 03:04:08.838514 | 2026-05-19 03:04:08.838630 | TASK [tox : Remove tempfile] 2026-05-19 03:04:09.655179 | debian-bookworm | changed 2026-05-19 03:04:09.672801 | 2026-05-19 03:04:09.672948 | TASK [tox : Emit tox command] 2026-05-19 03:04:09.734924 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-05-19 03:04:09.741144 | 2026-05-19 03:04:09.741255 | TASK [tox : Run tox] 2026-05-19 03:04:10.325653 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-05-19 03:04:11.007777 | debian-bookworm | ............... 2026-05-19 03:04:11.007828 | debian-bookworm | ---------------------------------------------------------------------- 2026-05-19 03:04:11.007838 | debian-bookworm | Ran 15 tests in 0.170s 2026-05-19 03:04:11.007843 | debian-bookworm | 2026-05-19 03:04:11.007850 | debian-bookworm | OK 2026-05-19 03:04:11.083624 | debian-bookworm | test: OK (0.81=setup[0.05]+cmd[0.75] seconds) 2026-05-19 03:04:11.083676 | debian-bookworm | congratulations :) (0.83 seconds) 2026-05-19 03:04:11.303293 | debian-bookworm | ok: Runtime: 0:00:01.116462 2026-05-19 03:04:11.308122 | 2026-05-19 03:04:11.308214 | TASK [tox : Look for output] 2026-05-19 03:04:11.900531 | debian-bookworm | ok 2026-05-19 03:04:11.917659 | 2026-05-19 03:04:11.917758 | TASK [tox : Return file comments to Zuul] 2026-05-19 03:04:12.001136 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:12.006558 | 2026-05-19 03:04:12.006629 | PLAY RECAP 2026-05-19 03:04:12.006670 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-19 03:04:12.006690 | 2026-05-19 03:04:12.305624 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-19 03:04:12.306611 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-19 03:04:13.767710 | 2026-05-19 03:04:13.767832 | PLAY [all] 2026-05-19 03:04:13.796283 | 2026-05-19 03:04:13.796451 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-19 03:04:13.883309 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:13.896710 | 2026-05-19 03:04:13.897092 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-19 03:04:13.941860 | debian-bookworm | ok 2026-05-19 03:04:13.946146 | 2026-05-19 03:04:13.946233 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-19 03:04:14.592766 | debian-bookworm -> localhost | changed 2026-05-19 03:04:14.600255 | 2026-05-19 03:04:14.600359 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-19 03:04:14.644553 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:14.654519 | 2026-05-19 03:04:14.654645 | TASK [fetch-tox-output : Set envlist fact] 2026-05-19 03:04:14.701163 | debian-bookworm | ok 2026-05-19 03:04:14.711637 | 2026-05-19 03:04:14.711771 | TASK [fetch-tox-output : Get tox version] 2026-05-19 03:04:15.747073 | 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-19 03:04:15.763615 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-19 03:04:16.277328 | debian-bookworm | ok: Runtime: 0:00:00.274310 2026-05-19 03:04:16.283376 | 2026-05-19 03:04:16.283485 | TASK [fetch-tox-output : Find all default environments] 2026-05-19 03:04:16.840229 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:16.845264 | 2026-05-19 03:04:16.845361 | TASK [fetch-tox-output : Set envlist fact] 2026-05-19 03:04:16.891032 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:16.896072 | 2026-05-19 03:04:16.896169 | TASK [fetch-tox-output : Find all default environments] 2026-05-19 03:04:17.489909 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:17.494776 | 2026-05-19 03:04:17.494876 | TASK [fetch-tox-output : Set envlist fact] 2026-05-19 03:04:17.568289 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:17.573391 | 2026-05-19 03:04:17.573482 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-19 03:04:17.645185 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:17.652073 | 2026-05-19 03:04:17.652181 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-19 03:04:18.844067 | debian-bookworm | changed: 2026-05-19 03:04:18.844213 | debian-bookworm | created directory /var/lib/zuul/builds/760ff41512a44eeda0559f87e4032eec/work/logs/tox/test 2026-05-19 03:04:18.844242 | debian-bookworm | cd+++++++++ ./ 2026-05-19 03:04:18.844262 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-19 03:04:18.844285 | 2026-05-19 03:04:18.863071 | 2026-05-19 03:04:18.863165 | PLAY RECAP 2026-05-19 03:04:18.863218 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-19 03:04:18.863242 | 2026-05-19 03:04:18.994084 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-19 03:04:18.995082 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-19 03:04:20.435124 | 2026-05-19 03:04:20.435265 | PLAY [all] 2026-05-19 03:04:20.474127 | 2026-05-19 03:04:20.474255 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-19 03:04:20.764351 | debian-bookworm | changed: non-zero return code 2026-05-19 03:04:20.768779 | 2026-05-19 03:04:20.768887 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-19 03:04:20.805130 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:20.809830 | 2026-05-19 03:04:20.809937 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-19 03:04:20.847902 | 2026-05-19 03:04:20.848082 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-19 03:04:20.896428 | 2026-05-19 03:04:20.896585 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-19 03:04:20.919308 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:20.924250 | 2026-05-19 03:04:20.924345 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-19 03:04:20.961832 | 2026-05-19 03:04:20.962015 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-19 03:04:21.005109 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:21.010552 | 2026-05-19 03:04:21.010672 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-19 03:04:21.057150 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:21.061977 | 2026-05-19 03:04:21.062085 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-19 03:04:21.125408 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:21.130662 | 2026-05-19 03:04:21.130738 | PLAY RECAP 2026-05-19 03:04:21.130779 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-19 03:04:21.130799 | 2026-05-19 03:04:21.430731 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-19 03:04:21.431726 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-19 03:04:22.055131 | 2026-05-19 03:04:22.055250 | PLAY [Base post-fetch] 2026-05-19 03:04:22.084363 | 2026-05-19 03:04:22.084473 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-19 03:04:22.158693 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:22.181029 | 2026-05-19 03:04:22.181200 | TASK [fetch-output : Set log path for single node] 2026-05-19 03:04:22.212119 | debian-bookworm | ok 2026-05-19 03:04:22.217535 | 2026-05-19 03:04:22.217635 | LOOP [fetch-output : Ensure local output dirs] 2026-05-19 03:04:22.888041 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/760ff41512a44eeda0559f87e4032eec/work/logs" 2026-05-19 03:04:23.320939 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/760ff41512a44eeda0559f87e4032eec/work/artifacts" 2026-05-19 03:04:23.652047 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/760ff41512a44eeda0559f87e4032eec/work/docs" 2026-05-19 03:04:23.673994 | 2026-05-19 03:04:23.674162 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-19 03:04:24.348587 | debian-bookworm | changed: 2026-05-19 03:04:24.348753 | debian-bookworm | .d..t...... ./ 2026-05-19 03:04:24.348783 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-19 03:04:24.348813 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-19 03:04:24.348838 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-19 03:04:24.348868 | debian-bookworm | changed: All items complete 2026-05-19 03:04:24.348890 | 2026-05-19 03:04:24.997684 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 03:04:25.575913 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 03:04:25.596611 | 2026-05-19 03:04:25.596723 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-19 03:04:25.641131 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:25.651527 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:04:25.661101 | 2026-05-19 03:04:25.661177 | PLAY RECAP 2026-05-19 03:04:25.661228 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-19 03:04:25.661254 | 2026-05-19 03:04:25.776151 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-19 03:04:25.777671 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 03:04:26.503095 | 2026-05-19 03:04:26.503219 | PLAY [Base post] 2026-05-19 03:04:26.536018 | 2026-05-19 03:04:26.536128 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-19 03:04:27.048455 | debian-bookworm | changed 2026-05-19 03:04:27.059095 | 2026-05-19 03:04:27.059229 | PLAY RECAP 2026-05-19 03:04:27.059313 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-19 03:04:27.059398 | 2026-05-19 03:04:27.142616 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 03:04:27.143642 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-19 03:04:27.968473 | 2026-05-19 03:04:27.968599 | PLAY [Base post-logs] 2026-05-19 03:04:27.978493 | 2026-05-19 03:04:27.978616 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-19 03:04:28.443179 | localhost | changed 2026-05-19 03:04:28.454736 | 2026-05-19 03:04:28.454954 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-19 03:04:28.479465 | localhost | ok 2026-05-19 03:04:28.481997 | 2026-05-19 03:04:28.482074 | TASK [Set zuul-log-path fact] 2026-05-19 03:04:28.495926 | localhost | ok 2026-05-19 03:04:28.502974 | 2026-05-19 03:04:28.503071 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 03:04:28.526990 | localhost | ok 2026-05-19 03:04:28.529772 | 2026-05-19 03:04:28.529850 | TASK [upload-logs : Create log directories] 2026-05-19 03:04:29.059734 | localhost | changed 2026-05-19 03:04:29.062553 | 2026-05-19 03:04:29.062653 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-19 03:04:29.481043 | localhost -> localhost | ok: Runtime: 0:00:00.008735 2026-05-19 03:04:29.484734 | 2026-05-19 03:04:29.484836 | TASK [upload-logs : Upload logs to log server] 2026-05-19 03:04:30.030590 | localhost | Output suppressed because no_log was given 2026-05-19 03:04:30.033123 | 2026-05-19 03:04:30.033249 | LOOP [upload-logs : Compress console log and json output] 2026-05-19 03:04:30.077969 | localhost | skipping: Conditional result was False 2026-05-19 03:04:30.086078 | localhost | skipping: Conditional result was False 2026-05-19 03:04:30.090810 | 2026-05-19 03:04:30.090964 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-19 03:04:30.133001 | localhost | skipping: Conditional result was False 2026-05-19 03:04:30.133250 | 2026-05-19 03:04:30.137993 | localhost | skipping: Conditional result was False 2026-05-19 03:04:30.146493 | 2026-05-19 03:04:30.146601 | LOOP [upload-logs : Upload console log and json output]