2026-05-07 03:02:48.911200 | Job console starting 2026-05-07 03:02:48.946951 | Updating git repos 2026-05-07 03:02:48.985468 | Cloning repos into workspace 2026-05-07 03:02:49.059479 | Restoring repo states 2026-05-07 03:02:49.091482 | Merging changes 2026-05-07 03:02:49.091499 | Checking out repos 2026-05-07 03:02:49.181838 | Preparing playbooks 2026-05-07 03:02:49.695018 | Running Ansible setup 2026-05-07 03:02:54.311691 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-07 03:02:55.307727 | 2026-05-07 03:02:55.307858 | PLAY [Base pre] 2026-05-07 03:02:55.347564 | 2026-05-07 03:02:55.347705 | TASK [Setup log path fact] 2026-05-07 03:02:55.386598 | debian-bookworm | ok 2026-05-07 03:02:55.413149 | 2026-05-07 03:02:55.413289 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-07 03:02:55.461935 | debian-bookworm | ok 2026-05-07 03:02:55.480713 | 2026-05-07 03:02:55.480827 | TASK [emit-job-header : Print job information] 2026-05-07 03:02:55.548353 | # Job Information 2026-05-07 03:02:55.548528 | Ansible Version: 2.16.14 2026-05-07 03:02:55.548563 | Job: tox 2026-05-07 03:02:55.548598 | Pipeline: periodic-daily 2026-05-07 03:02:55.548620 | Executor: 521e9411259a 2026-05-07 03:02:55.548640 | Triggered by: https://github.com/osism/openstack-image-manager 2026-05-07 03:02:55.548662 | Event ID: 99223e4c45d74393ba509e3d70427222 2026-05-07 03:02:55.560298 | 2026-05-07 03:02:55.560415 | LOOP [emit-job-header : Print node information] 2026-05-07 03:02:55.796119 | debian-bookworm | ok: 2026-05-07 03:02:55.796318 | debian-bookworm | # Node Information 2026-05-07 03:02:55.796357 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-07 03:02:55.796388 | debian-bookworm | Hostname: debian 2026-05-07 03:02:55.796415 | debian-bookworm | Username: zuul 2026-05-07 03:02:55.796440 | debian-bookworm | Distro: Debian 12.13 2026-05-07 03:02:55.796469 | debian-bookworm | Provider: regiocloud-a 2026-05-07 03:02:55.796495 | debian-bookworm | Region: 2026-05-07 03:02:55.796520 | debian-bookworm | Label: debian-bookworm 2026-05-07 03:02:55.796544 | debian-bookworm | Product Name: OpenStack Nova 2026-05-07 03:02:55.796568 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe99:f3f3 2026-05-07 03:02:55.818198 | 2026-05-07 03:02:55.818315 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-07 03:02:56.330431 | debian-bookworm -> localhost | changed 2026-05-07 03:02:56.337302 | 2026-05-07 03:02:56.337404 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-07 03:02:57.708178 | debian-bookworm -> localhost | changed 2026-05-07 03:02:57.719094 | 2026-05-07 03:02:57.719222 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-07 03:02:58.091928 | debian-bookworm -> localhost | ok 2026-05-07 03:02:58.098575 | 2026-05-07 03:02:58.098712 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-07 03:02:58.129787 | debian-bookworm | ok 2026-05-07 03:02:58.146893 | debian-bookworm | included: /var/lib/zuul/builds/a4adb22d3cec4cf1b2b790fa85556c85/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-07 03:02:58.153388 | 2026-05-07 03:02:58.153519 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-07 03:03:00.869509 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-07 03:03:00.869749 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a4adb22d3cec4cf1b2b790fa85556c85/work/a4adb22d3cec4cf1b2b790fa85556c85_id_rsa 2026-05-07 03:03:00.869788 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a4adb22d3cec4cf1b2b790fa85556c85/work/a4adb22d3cec4cf1b2b790fa85556c85_id_rsa.pub 2026-05-07 03:03:00.869816 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-07 03:03:00.869841 | debian-bookworm -> localhost | SHA256:m6rxfFfPWotU1NxYxbNO/tVVVt6UUr6a6qwBwUC6A5o zuul-build-sshkey 2026-05-07 03:03:00.869864 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-07 03:03:00.869901 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-07 03:03:00.869924 | debian-bookworm -> localhost | | .o .oO| 2026-05-07 03:03:00.869946 | debian-bookworm -> localhost | | . o ..X*| 2026-05-07 03:03:00.869966 | debian-bookworm -> localhost | | . . o +oX| 2026-05-07 03:03:00.869985 | debian-bookworm -> localhost | |... . . . oo| 2026-05-07 03:03:00.870004 | debian-bookworm -> localhost | |E o .S =.o| 2026-05-07 03:03:00.870030 | debian-bookworm -> localhost | | . .o ..ooo| 2026-05-07 03:03:00.870051 | debian-bookworm -> localhost | | . o. ..=. o| 2026-05-07 03:03:00.870071 | debian-bookworm -> localhost | | + .. +..oo..| 2026-05-07 03:03:00.870199 | debian-bookworm -> localhost | | ..+. oo+o.. | 2026-05-07 03:03:00.870229 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-07 03:03:00.870294 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.937064 2026-05-07 03:03:00.885075 | 2026-05-07 03:03:00.885903 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-07 03:03:00.950429 | debian-bookworm | ok 2026-05-07 03:03:00.980700 | debian-bookworm | included: /var/lib/zuul/builds/a4adb22d3cec4cf1b2b790fa85556c85/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-07 03:03:01.020329 | 2026-05-07 03:03:01.020485 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-07 03:03:01.117941 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:03:01.125841 | 2026-05-07 03:03:01.125981 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-07 03:03:01.953161 | debian-bookworm | changed 2026-05-07 03:03:01.960556 | 2026-05-07 03:03:01.960647 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-07 03:03:02.212666 | debian-bookworm | ok 2026-05-07 03:03:02.217133 | 2026-05-07 03:03:02.217215 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-07 03:03:02.953958 | debian-bookworm | changed 2026-05-07 03:03:02.963227 | 2026-05-07 03:03:02.965931 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-07 03:03:03.643031 | debian-bookworm | changed 2026-05-07 03:03:03.649488 | 2026-05-07 03:03:03.649582 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-07 03:03:03.688497 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:03:03.694952 | 2026-05-07 03:03:03.695062 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-07 03:03:04.364409 | debian-bookworm -> localhost | changed 2026-05-07 03:03:04.375556 | 2026-05-07 03:03:04.375668 | TASK [add-build-sshkey : Add back temp key] 2026-05-07 03:03:04.672465 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a4adb22d3cec4cf1b2b790fa85556c85/work/a4adb22d3cec4cf1b2b790fa85556c85_id_rsa (zuul-build-sshkey) 2026-05-07 03:03:04.672679 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008813 2026-05-07 03:03:04.680158 | 2026-05-07 03:03:04.680251 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-07 03:03:05.094872 | debian-bookworm | ok 2026-05-07 03:03:05.103398 | 2026-05-07 03:03:05.106687 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-07 03:03:05.142534 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:03:05.153589 | 2026-05-07 03:03:05.153697 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-07 03:03:05.707285 | debian-bookworm | ok 2026-05-07 03:03:05.725646 | 2026-05-07 03:03:05.725756 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-07 03:03:05.773600 | debian-bookworm | ok 2026-05-07 03:03:05.778691 | 2026-05-07 03:03:05.778789 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-07 03:03:06.134794 | debian-bookworm -> localhost | ok 2026-05-07 03:03:06.142360 | 2026-05-07 03:03:06.142467 | TASK [validate-host : Collect information about the host] 2026-05-07 03:03:07.387234 | debian-bookworm | ok 2026-05-07 03:03:07.448889 | 2026-05-07 03:03:07.449051 | TASK [validate-host : Sanitize hostname] 2026-05-07 03:03:07.805719 | debian-bookworm | ok 2026-05-07 03:03:07.878199 | 2026-05-07 03:03:07.878342 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-07 03:03:09.432339 | debian-bookworm -> localhost | changed 2026-05-07 03:03:09.441645 | 2026-05-07 03:03:09.442041 | TASK [validate-host : Collect information about zuul worker] 2026-05-07 03:03:10.308405 | debian-bookworm | ok 2026-05-07 03:03:10.313821 | 2026-05-07 03:03:10.313914 | TASK [validate-host : Write out all zuul information for each host] 2026-05-07 03:03:11.920208 | debian-bookworm -> localhost | changed 2026-05-07 03:03:11.938708 | 2026-05-07 03:03:11.938810 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-07 03:03:12.283322 | debian-bookworm | ok 2026-05-07 03:03:12.295102 | 2026-05-07 03:03:12.295240 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-07 03:03:13.621873 | debian-bookworm | changed: 2026-05-07 03:03:13.622016 | debian-bookworm | cd+++++++++ src/ 2026-05-07 03:03:13.622044 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-07 03:03:13.622065 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-07 03:03:13.622082 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-07 03:03:13.622099 | debian-bookworm | =7.0.3 2026-05-07 03:03:41.093720 | debian-bookworm | Downloading cachetools-7.1.1-py3-none-any.whl (16 kB) 2026-05-07 03:03:41.158025 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-07 03:03:41.170029 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-07 03:03:41.234382 | debian-bookworm | Collecting filelock>=3.25 2026-05-07 03:03:41.246162 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-07 03:03:41.316114 | debian-bookworm | Collecting packaging>=26 2026-05-07 03:03:41.327809 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-07 03:03:41.344116 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 7.0 MB/s eta 0:00:00 2026-05-07 03:03:41.398259 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-07 03:03:41.411535 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-05-07 03:03:41.476306 | debian-bookworm | Collecting pluggy>=1.6 2026-05-07 03:03:41.488908 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-07 03:03:41.555627 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-07 03:03:41.568234 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-07 03:03:41.614676 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-07 03:03:41.627150 | debian-bookworm | Downloading python_discovery-1.3.0-py3-none-any.whl (33 kB) 2026-05-07 03:03:41.668670 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-07 03:03:41.681151 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-07 03:03:41.838548 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-07 03:03:41.850355 | debian-bookworm | Downloading virtualenv-21.3.1-py3-none-any.whl (7.6 MB) 2026-05-07 03:03:42.233629 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 20.0 MB/s eta 0:00:00 2026-05-07 03:03:42.338845 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-07 03:03:42.350296 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-07 03:03:42.383817 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 16.4 MB/s eta 0:00:00 2026-05-07 03:03:42.496978 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-07 03:03:43.492093 | 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-07 03:03:43.803073 | debian-bookworm | ok: Runtime: 0:00:03.501909 2026-05-07 03:03:43.811739 | 2026-05-07 03:03:43.811822 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-07 03:03:43.840295 | debian-bookworm | ok 2026-05-07 03:03:43.844268 | 2026-05-07 03:03:43.844346 | TASK [ensure-tox : Output tox version] 2026-05-07 03:03:44.397785 | 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-07 03:03:44.416208 | debian-bookworm | 4.53.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-07 03:03:44.879333 | debian-bookworm | ok: Runtime: 0:00:00.356790 2026-05-07 03:03:44.884779 | 2026-05-07 03:03:44.884859 | TASK [ensure-tox : Make global symlink] 2026-05-07 03:03:44.898171 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:03:44.903448 | 2026-05-07 03:03:44.903508 | PLAY RECAP 2026-05-07 03:03:44.903549 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-07 03:03:44.903570 | 2026-05-07 03:03:45.102902 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-07 03:03:45.103870 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-07 03:03:46.392045 | 2026-05-07 03:03:46.392329 | PLAY [all] 2026-05-07 03:03:46.425052 | 2026-05-07 03:03:46.425196 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-07 03:03:46.999149 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-07 03:03:47.479590 | debian-bookworm | ok: Runtime: 0:00:00.034607 2026-05-07 03:03:47.485243 | 2026-05-07 03:03:47.485365 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-07 03:03:48.045696 | debian-bookworm | ok: Runtime: 0:00:00.007271 2026-05-07 03:03:48.051761 | 2026-05-07 03:03:48.051861 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-07 03:03:48.425593 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-07 03:03:48.427233 | debian-bookworm | sudo: a password is required 2026-05-07 03:03:48.617039 | debian-bookworm | ok: Runtime: 0:00:00.021508 2026-05-07 03:03:48.629696 | 2026-05-07 03:03:48.629885 | TASK [tox : Check to see if the constraints file exists] 2026-05-07 03:03:48.658341 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:03:48.666813 | 2026-05-07 03:03:48.667044 | TASK [tox : Fail if constraints file is missing] 2026-05-07 03:03:48.696614 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:03:48.704734 | 2026-05-07 03:03:48.704860 | TASK [tox : Record file location] 2026-05-07 03:03:48.730382 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:03:48.736478 | 2026-05-07 03:03:48.736584 | TASK [tox : Install tox siblings] 2026-05-07 03:03:48.781701 | debian-bookworm | ok 2026-05-07 03:03:48.832210 | debian-bookworm | included: /var/lib/zuul/builds/a4adb22d3cec4cf1b2b790fa85556c85/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-07 03:03:48.845123 | 2026-05-07 03:03:48.845235 | TASK [tox : Run tox without tests] 2026-05-07 03:03:50.334721 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-05-07 03:04:03.199089 | debian-bookworm | test: OK (13.68 seconds) 2026-05-07 03:04:03.199147 | debian-bookworm | congratulations :) (13.70 seconds) 2026-05-07 03:04:03.390647 | debian-bookworm | ok: Runtime: 0:00:14.017004 2026-05-07 03:04:03.395309 | 2026-05-07 03:04:03.395388 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-07 03:04:03.940958 | debian-bookworm | changed 2026-05-07 03:04:03.948099 | 2026-05-07 03:04:03.948215 | TASK [tox : Detect tox version] 2026-05-07 03:04:04.631031 | debian-bookworm | 4.53.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-07 03:04:05.063727 | debian-bookworm | ok: Runtime: 0:00:00.325697 2026-05-07 03:04:05.069064 | 2026-05-07 03:04:05.069165 | TASK [tox : Get tox envlist config] 2026-05-07 03:04:06.178368 | debian-bookworm | ok: Runtime: 0:00:00.376563 2026-05-07 03:04:06.184314 | 2026-05-07 03:04:06.184422 | TASK [tox : Install any sibling python packages] 2026-05-07 03:04:07.097256 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-07 03:04:07.104977 | 2026-05-07 03:04:07.105076 | TASK [tox : Remove tempfile] 2026-05-07 03:04:08.032838 | debian-bookworm | changed 2026-05-07 03:04:08.048859 | 2026-05-07 03:04:08.048964 | TASK [tox : Emit tox command] 2026-05-07 03:04:08.111841 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-05-07 03:04:08.121286 | 2026-05-07 03:04:08.121391 | TASK [tox : Run tox] 2026-05-07 03:04:08.867328 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-05-07 03:04:09.632312 | debian-bookworm | ............... 2026-05-07 03:04:09.632400 | debian-bookworm | ---------------------------------------------------------------------- 2026-05-07 03:04:09.632433 | debian-bookworm | Ran 15 tests in 0.173s 2026-05-07 03:04:09.632448 | debian-bookworm | 2026-05-07 03:04:09.632467 | debian-bookworm | OK 2026-05-07 03:04:09.731063 | debian-bookworm | test: OK (0.91=setup[0.05]+cmd[0.86] seconds) 2026-05-07 03:04:09.731125 | debian-bookworm | congratulations :) (0.94 seconds) 2026-05-07 03:04:10.182121 | debian-bookworm | ok: Runtime: 0:00:01.231790 2026-05-07 03:04:10.187439 | 2026-05-07 03:04:10.187532 | TASK [tox : Look for output] 2026-05-07 03:04:10.773204 | debian-bookworm | ok 2026-05-07 03:04:10.808817 | 2026-05-07 03:04:10.808933 | TASK [tox : Return file comments to Zuul] 2026-05-07 03:04:10.869539 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:10.878545 | 2026-05-07 03:04:10.878623 | PLAY RECAP 2026-05-07 03:04:10.878667 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-07 03:04:10.878687 | 2026-05-07 03:04:11.215865 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-07 03:04:11.219645 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-07 03:04:12.742675 | 2026-05-07 03:04:12.742795 | PLAY [all] 2026-05-07 03:04:12.787896 | 2026-05-07 03:04:12.788024 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-07 03:04:12.962690 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:12.967403 | 2026-05-07 03:04:12.967512 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-07 03:04:13.024337 | debian-bookworm | ok 2026-05-07 03:04:13.028507 | 2026-05-07 03:04:13.028592 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-07 03:04:13.772362 | debian-bookworm -> localhost | changed 2026-05-07 03:04:13.779963 | 2026-05-07 03:04:13.780058 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-07 03:04:13.853499 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:13.858407 | 2026-05-07 03:04:13.858506 | TASK [fetch-tox-output : Set envlist fact] 2026-05-07 03:04:13.935799 | debian-bookworm | ok 2026-05-07 03:04:13.940493 | 2026-05-07 03:04:13.940574 | TASK [fetch-tox-output : Get tox version] 2026-05-07 03:04:14.844662 | 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-07 03:04:14.863019 | debian-bookworm | 4.53.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-07 03:04:15.006285 | debian-bookworm | ok: Runtime: 0:00:00.337626 2026-05-07 03:04:15.010626 | 2026-05-07 03:04:15.010703 | TASK [fetch-tox-output : Find all default environments] 2026-05-07 03:04:15.556672 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:15.561716 | 2026-05-07 03:04:15.561808 | TASK [fetch-tox-output : Set envlist fact] 2026-05-07 03:04:15.604982 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:15.610313 | 2026-05-07 03:04:15.610422 | TASK [fetch-tox-output : Find all default environments] 2026-05-07 03:04:16.159984 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:16.164770 | 2026-05-07 03:04:16.164857 | TASK [fetch-tox-output : Set envlist fact] 2026-05-07 03:04:16.207737 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:16.215659 | 2026-05-07 03:04:16.215757 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-07 03:04:16.285007 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:16.294030 | 2026-05-07 03:04:16.294145 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-07 03:04:17.372509 | debian-bookworm | changed: 2026-05-07 03:04:17.372687 | debian-bookworm | created directory /var/lib/zuul/builds/a4adb22d3cec4cf1b2b790fa85556c85/work/logs/tox/test 2026-05-07 03:04:17.372730 | debian-bookworm | cd+++++++++ ./ 2026-05-07 03:04:17.372791 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-07 03:04:17.372869 | 2026-05-07 03:04:17.388135 | 2026-05-07 03:04:17.388211 | PLAY RECAP 2026-05-07 03:04:17.388251 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-07 03:04:17.388273 | 2026-05-07 03:04:17.587233 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-07 03:04:17.588186 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-07 03:04:18.826897 | 2026-05-07 03:04:18.827033 | PLAY [all] 2026-05-07 03:04:18.847092 | 2026-05-07 03:04:18.847295 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-07 03:04:19.142508 | debian-bookworm | changed: non-zero return code 2026-05-07 03:04:19.158205 | 2026-05-07 03:04:19.158345 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-07 03:04:19.190539 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:19.196232 | 2026-05-07 03:04:19.196335 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-07 03:04:19.245707 | 2026-05-07 03:04:19.245877 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-07 03:04:19.278354 | 2026-05-07 03:04:19.278494 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-07 03:04:19.312553 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:19.317509 | 2026-05-07 03:04:19.317592 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-07 03:04:19.346124 | 2026-05-07 03:04:19.346280 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-07 03:04:19.359816 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:19.365290 | 2026-05-07 03:04:19.365383 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-07 03:04:19.378003 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:19.383478 | 2026-05-07 03:04:19.383572 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-07 03:04:19.398565 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:19.404237 | 2026-05-07 03:04:19.404301 | PLAY RECAP 2026-05-07 03:04:19.404341 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-07 03:04:19.404363 | 2026-05-07 03:04:19.521238 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-07 03:04:19.522138 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-07 03:04:20.262825 | 2026-05-07 03:04:20.262968 | PLAY [Base post-fetch] 2026-05-07 03:04:20.274290 | 2026-05-07 03:04:20.274392 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-07 03:04:20.329159 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:20.333789 | 2026-05-07 03:04:20.333898 | TASK [fetch-output : Set log path for single node] 2026-05-07 03:04:20.382367 | debian-bookworm | ok 2026-05-07 03:04:20.388025 | 2026-05-07 03:04:20.388147 | LOOP [fetch-output : Ensure local output dirs] 2026-05-07 03:04:20.932242 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/a4adb22d3cec4cf1b2b790fa85556c85/work/logs" 2026-05-07 03:04:21.340692 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a4adb22d3cec4cf1b2b790fa85556c85/work/artifacts" 2026-05-07 03:04:21.722202 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a4adb22d3cec4cf1b2b790fa85556c85/work/docs" 2026-05-07 03:04:21.738675 | 2026-05-07 03:04:21.738864 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-07 03:04:22.525584 | debian-bookworm | changed: 2026-05-07 03:04:22.525744 | debian-bookworm | .d..t...... ./ 2026-05-07 03:04:22.525771 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-07 03:04:22.525806 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-07 03:04:22.525831 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-07 03:04:22.525863 | debian-bookworm | changed: All items complete 2026-05-07 03:04:22.525885 | 2026-05-07 03:04:23.360301 | debian-bookworm | changed: .d..t...... ./ 2026-05-07 03:04:23.924709 | debian-bookworm | changed: .d..t...... ./ 2026-05-07 03:04:23.946920 | 2026-05-07 03:04:23.947034 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-07 03:04:23.976820 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:23.980609 | debian-bookworm | skipping: Conditional result was False 2026-05-07 03:04:23.996983 | 2026-05-07 03:04:23.997063 | PLAY RECAP 2026-05-07 03:04:23.997124 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-07 03:04:23.997150 | 2026-05-07 03:04:24.090663 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-07 03:04:24.091534 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-07 03:04:24.783327 | 2026-05-07 03:04:24.783444 | PLAY [Base post] 2026-05-07 03:04:24.795506 | 2026-05-07 03:04:24.795608 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-07 03:04:25.269522 | debian-bookworm | changed 2026-05-07 03:04:25.276152 | 2026-05-07 03:04:25.276247 | PLAY RECAP 2026-05-07 03:04:25.276304 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-07 03:04:25.276364 | 2026-05-07 03:04:25.385822 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-07 03:04:25.386791 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-07 03:04:26.244300 | 2026-05-07 03:04:26.244530 | PLAY [Base post-logs] 2026-05-07 03:04:26.284228 | 2026-05-07 03:04:26.284370 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-07 03:04:27.240506 | localhost | changed 2026-05-07 03:04:27.259719 | 2026-05-07 03:04:27.259860 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-07 03:04:27.318715 | localhost | ok 2026-05-07 03:04:27.321693 | 2026-05-07 03:04:27.321781 | TASK [Set zuul-log-path fact] 2026-05-07 03:04:27.336285 | localhost | ok 2026-05-07 03:04:27.344555 | 2026-05-07 03:04:27.344653 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-07 03:04:27.374485 | localhost | ok 2026-05-07 03:04:27.378254 | 2026-05-07 03:04:27.378349 | TASK [upload-logs : Create log directories] 2026-05-07 03:04:28.589798 | localhost | changed 2026-05-07 03:04:28.593996 | 2026-05-07 03:04:28.594170 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-07 03:04:29.559556 | localhost -> localhost | ok: Runtime: 0:00:00.011952 2026-05-07 03:04:29.571383 | 2026-05-07 03:04:29.571621 | TASK [upload-logs : Upload logs to log server] 2026-05-07 03:04:30.161049 | localhost | Output suppressed because no_log was given 2026-05-07 03:04:30.162672 | 2026-05-07 03:04:30.162757 | LOOP [upload-logs : Compress console log and json output] 2026-05-07 03:04:30.238736 | localhost | skipping: Conditional result was False 2026-05-07 03:04:30.246062 | localhost | skipping: Conditional result was False 2026-05-07 03:04:30.253828 | 2026-05-07 03:04:30.253931 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-07 03:04:30.304124 | localhost | skipping: Conditional result was False 2026-05-07 03:04:30.304397 | 2026-05-07 03:04:30.308720 | localhost | skipping: Conditional result was False 2026-05-07 03:04:30.319337 | 2026-05-07 03:04:30.319447 | LOOP [upload-logs : Upload console log and json output]