2026-06-03 03:14:53.652200 | Job console starting 2026-06-03 03:14:53.675477 | Updating git repos 2026-06-03 03:14:53.725364 | Cloning repos into workspace 2026-06-03 03:14:53.839172 | Restoring repo states 2026-06-03 03:14:53.859730 | Merging changes 2026-06-03 03:14:53.859753 | Checking out repos 2026-06-03 03:14:53.949752 | Preparing playbooks 2026-06-03 03:14:55.841779 | Running Ansible setup 2026-06-03 03:15:02.153800 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-03 03:15:03.829878 | 2026-06-03 03:15:03.830032 | PLAY [Base pre] 2026-06-03 03:15:03.896342 | 2026-06-03 03:15:03.896484 | TASK [Setup log path fact] 2026-06-03 03:15:03.941231 | debian-bookworm | ok 2026-06-03 03:15:04.009451 | 2026-06-03 03:15:04.009619 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-03 03:15:04.060417 | debian-bookworm | ok 2026-06-03 03:15:04.084605 | 2026-06-03 03:15:04.084753 | TASK [emit-job-header : Print job information] 2026-06-03 03:15:04.134022 | # Job Information 2026-06-03 03:15:04.134199 | Ansible Version: 2.16.14 2026-06-03 03:15:04.134234 | Job: tox 2026-06-03 03:15:04.134267 | Pipeline: periodic-daily 2026-06-03 03:15:04.134289 | Executor: 521e9411259a 2026-06-03 03:15:04.134309 | Triggered by: https://github.com/osism/openstack-image-manager 2026-06-03 03:15:04.134331 | Event ID: 4bbeb7469f33465a86ba2599a1784be8 2026-06-03 03:15:04.140293 | 2026-06-03 03:15:04.140398 | LOOP [emit-job-header : Print node information] 2026-06-03 03:15:04.385158 | debian-bookworm | ok: 2026-06-03 03:15:04.385373 | debian-bookworm | # Node Information 2026-06-03 03:15:04.385432 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-03 03:15:04.385474 | debian-bookworm | Hostname: debian 2026-06-03 03:15:04.385560 | debian-bookworm | Username: zuul 2026-06-03 03:15:04.385587 | debian-bookworm | Distro: Debian 12.14 2026-06-03 03:15:04.385612 | debian-bookworm | Provider: regiocloud-a 2026-06-03 03:15:04.385632 | debian-bookworm | Region: 2026-06-03 03:15:04.385653 | debian-bookworm | Label: debian-bookworm 2026-06-03 03:15:04.385673 | debian-bookworm | Product Name: OpenStack Nova 2026-06-03 03:15:04.385692 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9e:a88f 2026-06-03 03:15:04.409420 | 2026-06-03 03:15:04.409530 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-03 03:15:05.568721 | debian-bookworm -> localhost | changed 2026-06-03 03:15:05.580083 | 2026-06-03 03:15:05.580852 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-03 03:15:08.235841 | debian-bookworm -> localhost | changed 2026-06-03 03:15:08.244502 | 2026-06-03 03:15:08.244591 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-03 03:15:08.824835 | debian-bookworm -> localhost | ok 2026-06-03 03:15:08.831304 | 2026-06-03 03:15:08.831388 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-03 03:15:08.869931 | debian-bookworm | ok 2026-06-03 03:15:08.892712 | debian-bookworm | included: /var/lib/zuul/builds/a2f54182314a4d2abe40f73f394f8f58/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-03 03:15:08.904858 | 2026-06-03 03:15:08.904964 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-03 03:15:10.513397 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-03 03:15:10.515230 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a2f54182314a4d2abe40f73f394f8f58/work/a2f54182314a4d2abe40f73f394f8f58_id_rsa 2026-06-03 03:15:10.515336 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a2f54182314a4d2abe40f73f394f8f58/work/a2f54182314a4d2abe40f73f394f8f58_id_rsa.pub 2026-06-03 03:15:10.515363 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-03 03:15:10.515385 | debian-bookworm -> localhost | SHA256:H5/7XB9pvuqNoCw82siZqK/uHFwC8Ny8w0c36Uxh1I4 zuul-build-sshkey 2026-06-03 03:15:10.515404 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-03 03:15:10.515428 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-03 03:15:10.515446 | debian-bookworm -> localhost | |. .+. | 2026-06-03 03:15:10.515464 | debian-bookworm -> localhost | |.o o . o. | 2026-06-03 03:15:10.515502 | debian-bookworm -> localhost | |. o o . =o | 2026-06-03 03:15:10.515520 | debian-bookworm -> localhost | |. . o =E.. | 2026-06-03 03:15:10.515536 | debian-bookworm -> localhost | | . .+ . S . | 2026-06-03 03:15:10.515561 | debian-bookworm -> localhost | |. o o . o . .| 2026-06-03 03:15:10.515578 | debian-bookworm -> localhost | | o . ..o +.| 2026-06-03 03:15:10.515595 | debian-bookworm -> localhost | |. . o =+. . .o=.o| 2026-06-03 03:15:10.515612 | debian-bookworm -> localhost | |o*+o *..oo o=++o| 2026-06-03 03:15:10.515629 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-03 03:15:10.515692 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.452899 2026-06-03 03:15:10.521465 | 2026-06-03 03:15:10.521552 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-03 03:15:10.559414 | debian-bookworm | ok 2026-06-03 03:15:10.567197 | debian-bookworm | included: /var/lib/zuul/builds/a2f54182314a4d2abe40f73f394f8f58/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-03 03:15:10.590281 | 2026-06-03 03:15:10.590384 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-03 03:15:10.625851 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:15:10.631265 | 2026-06-03 03:15:10.631361 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-03 03:15:11.456946 | debian-bookworm | changed 2026-06-03 03:15:11.461486 | 2026-06-03 03:15:11.461570 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-03 03:15:11.721513 | debian-bookworm | ok 2026-06-03 03:15:11.726916 | 2026-06-03 03:15:11.727016 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-03 03:15:12.549057 | debian-bookworm | changed 2026-06-03 03:15:12.559035 | 2026-06-03 03:15:12.559136 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-03 03:15:13.291488 | debian-bookworm | changed 2026-06-03 03:15:13.302176 | 2026-06-03 03:15:13.302277 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-03 03:15:13.325693 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:15:13.332426 | 2026-06-03 03:15:13.332839 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-03 03:15:14.062502 | debian-bookworm -> localhost | changed 2026-06-03 03:15:14.074311 | 2026-06-03 03:15:14.074410 | TASK [add-build-sshkey : Add back temp key] 2026-06-03 03:15:14.857565 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a2f54182314a4d2abe40f73f394f8f58/work/a2f54182314a4d2abe40f73f394f8f58_id_rsa (zuul-build-sshkey) 2026-06-03 03:15:14.857773 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013762 2026-06-03 03:15:14.865609 | 2026-06-03 03:15:14.865705 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-03 03:15:15.338478 | debian-bookworm | ok 2026-06-03 03:15:15.343994 | 2026-06-03 03:15:15.344104 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-03 03:15:15.368073 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:15:15.379964 | 2026-06-03 03:15:15.380068 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-03 03:15:15.908974 | debian-bookworm | ok 2026-06-03 03:15:15.938684 | 2026-06-03 03:15:15.938828 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-03 03:15:16.002345 | debian-bookworm | ok 2026-06-03 03:15:16.013646 | 2026-06-03 03:15:16.013803 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-03 03:15:16.879312 | debian-bookworm -> localhost | ok 2026-06-03 03:15:16.886419 | 2026-06-03 03:15:16.886541 | TASK [validate-host : Collect information about the host] 2026-06-03 03:15:18.579855 | debian-bookworm | ok 2026-06-03 03:15:18.599721 | 2026-06-03 03:15:18.599874 | TASK [validate-host : Sanitize hostname] 2026-06-03 03:15:18.980540 | debian-bookworm | ok 2026-06-03 03:15:19.211599 | 2026-06-03 03:15:19.211782 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-03 03:15:20.705833 | debian-bookworm -> localhost | changed 2026-06-03 03:15:20.712483 | 2026-06-03 03:15:20.712574 | TASK [validate-host : Collect information about zuul worker] 2026-06-03 03:15:21.612623 | debian-bookworm | ok 2026-06-03 03:15:21.616876 | 2026-06-03 03:15:21.616972 | TASK [validate-host : Write out all zuul information for each host] 2026-06-03 03:15:22.361870 | debian-bookworm -> localhost | changed 2026-06-03 03:15:22.369817 | 2026-06-03 03:15:22.369928 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-03 03:15:22.606143 | debian-bookworm | ok 2026-06-03 03:15:22.613794 | 2026-06-03 03:15:22.613903 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-03 03:15:23.825743 | debian-bookworm | changed: 2026-06-03 03:15:23.825909 | debian-bookworm | cd+++++++++ src/ 2026-06-03 03:15:23.825942 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-03 03:15:23.825962 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-03 03:15:23.825980 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-03 03:15:23.825996 | debian-bookworm | =7.0.3 2026-06-03 03:15:49.930490 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-06-03 03:15:49.997777 | debian-bookworm | Collecting colorama>=0.4.6 2026-06-03 03:15:50.009812 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-03 03:15:50.078950 | debian-bookworm | Collecting filelock>=3.25 2026-06-03 03:15:50.092373 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-06-03 03:15:50.161645 | debian-bookworm | Collecting packaging>=26 2026-06-03 03:15:50.173265 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-03 03:15:50.189111 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 9.7 MB/s eta 0:00:00 2026-06-03 03:15:50.243979 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-06-03 03:15:50.256952 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-06-03 03:15:50.326644 | debian-bookworm | Collecting pluggy>=1.6 2026-06-03 03:15:50.337848 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-03 03:15:50.380111 | debian-bookworm | Collecting pyproject-api>=1.10 2026-06-03 03:15:50.391927 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-06-03 03:15:50.427694 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-06-03 03:15:50.439198 | debian-bookworm | Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB) 2026-06-03 03:15:50.473880 | debian-bookworm | Collecting tomli-w>=1.2 2026-06-03 03:15:50.487561 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-06-03 03:15:50.619559 | debian-bookworm | Collecting virtualenv>=21.1 2026-06-03 03:15:50.632150 | debian-bookworm | Downloading virtualenv-21.4.2-py3-none-any.whl (7.6 MB) 2026-06-03 03:15:50.956952 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 23.6 MB/s eta 0:00:00 2026-06-03 03:15:51.060258 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-06-03 03:15:51.072041 | debian-bookworm | Downloading distlib-0.4.1-py2.py3-none-any.whl (469 kB) 2026-06-03 03:15:51.111631 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.2/469.2 kB 13.1 MB/s eta 0:00:00 2026-06-03 03:15:51.225039 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-06-03 03:15:51.980949 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.1 filelock-3.29.0 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.0 virtualenv-21.4.2 2026-06-03 03:15:52.335658 | debian-bookworm | ok: Runtime: 0:00:02.981069 2026-06-03 03:15:52.350887 | 2026-06-03 03:15:52.351064 | TASK [ensure-tox : Export installed tox_executable path] 2026-06-03 03:15:52.396870 | debian-bookworm | ok 2026-06-03 03:15:52.401907 | 2026-06-03 03:15:52.402025 | TASK [ensure-tox : Output tox version] 2026-06-03 03:15:52.915342 | 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-03 03:15:52.931738 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-03 03:15:53.434548 | debian-bookworm | ok: Runtime: 0:00:00.281808 2026-06-03 03:15:53.440641 | 2026-06-03 03:15:53.440759 | TASK [ensure-tox : Make global symlink] 2026-06-03 03:15:53.485548 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:15:53.494101 | 2026-06-03 03:15:53.494218 | PLAY RECAP 2026-06-03 03:15:53.494278 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-06-03 03:15:53.494305 | 2026-06-03 03:15:53.667001 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-06-03 03:15:53.668153 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-03 03:15:54.661332 | 2026-06-03 03:15:54.661557 | PLAY [all] 2026-06-03 03:15:54.682349 | 2026-06-03 03:15:54.682542 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-06-03 03:15:55.256565 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-03 03:15:55.715150 | debian-bookworm | ok: Runtime: 0:00:00.021367 2026-06-03 03:15:55.721557 | 2026-06-03 03:15:55.721717 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-06-03 03:15:56.289157 | debian-bookworm | ok: Runtime: 0:00:00.005978 2026-06-03 03:15:56.298438 | 2026-06-03 03:15:56.298617 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-06-03 03:15:56.561306 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-03 03:15:56.562537 | debian-bookworm | sudo: a password is required 2026-06-03 03:15:56.829938 | debian-bookworm | ok: Runtime: 0:00:00.014620 2026-06-03 03:15:56.840860 | 2026-06-03 03:15:56.840988 | TASK [tox : Check to see if the constraints file exists] 2026-06-03 03:15:56.886718 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:15:56.895912 | 2026-06-03 03:15:56.896059 | TASK [tox : Fail if constraints file is missing] 2026-06-03 03:15:56.920723 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:15:56.927419 | 2026-06-03 03:15:56.927533 | TASK [tox : Record file location] 2026-06-03 03:15:56.952077 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:15:56.958293 | 2026-06-03 03:15:56.958411 | TASK [tox : Install tox siblings] 2026-06-03 03:15:56.981339 | debian-bookworm | ok 2026-06-03 03:15:56.991540 | debian-bookworm | included: /var/lib/zuul/builds/a2f54182314a4d2abe40f73f394f8f58/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-06-03 03:15:56.997297 | 2026-06-03 03:15:56.997407 | TASK [tox : Run tox without tests] 2026-06-03 03:15:58.142163 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-06-03 03:16:10.918549 | debian-bookworm | test: OK (13.41 seconds) 2026-06-03 03:16:10.918604 | debian-bookworm | congratulations :) (13.44 seconds) 2026-06-03 03:16:11.033992 | debian-bookworm | ok: Runtime: 0:00:13.716796 2026-06-03 03:16:11.039951 | 2026-06-03 03:16:11.040069 | TASK [tox : Create a tempfile to save tox showconfig] 2026-06-03 03:16:11.607131 | debian-bookworm | changed 2026-06-03 03:16:11.613967 | 2026-06-03 03:16:11.614106 | TASK [tox : Detect tox version] 2026-06-03 03:16:12.365409 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-03 03:16:12.682526 | debian-bookworm | ok: Runtime: 0:00:00.334458 2026-06-03 03:16:12.696343 | 2026-06-03 03:16:12.696550 | TASK [tox : Get tox envlist config] 2026-06-03 03:16:13.731877 | debian-bookworm | ok: Runtime: 0:00:00.377024 2026-06-03 03:16:13.738265 | 2026-06-03 03:16:13.738390 | TASK [tox : Install any sibling python packages] 2026-06-03 03:16:14.267217 | debian-bookworm | ok: No setup.cfg, no action needed 2026-06-03 03:16:14.278193 | 2026-06-03 03:16:14.278323 | TASK [tox : Remove tempfile] 2026-06-03 03:16:14.818085 | debian-bookworm | changed 2026-06-03 03:16:14.848786 | 2026-06-03 03:16:14.848945 | TASK [tox : Emit tox command] 2026-06-03 03:16:14.888915 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-06-03 03:16:14.894116 | 2026-06-03 03:16:14.894238 | TASK [tox : Run tox] 2026-06-03 03:16:15.484057 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-06-03 03:16:16.155927 | debian-bookworm | ............... 2026-06-03 03:16:16.155967 | debian-bookworm | ---------------------------------------------------------------------- 2026-06-03 03:16:16.155977 | debian-bookworm | Ran 15 tests in 0.165s 2026-06-03 03:16:16.155982 | debian-bookworm | 2026-06-03 03:16:16.155989 | debian-bookworm | OK 2026-06-03 03:16:16.224487 | debian-bookworm | test: OK (0.78=setup[0.04]+cmd[0.74] seconds) 2026-06-03 03:16:16.224534 | debian-bookworm | congratulations :) (0.81 seconds) 2026-06-03 03:16:16.426908 | debian-bookworm | ok: Runtime: 0:00:01.087563 2026-06-03 03:16:16.441452 | 2026-06-03 03:16:16.441623 | TASK [tox : Look for output] 2026-06-03 03:16:16.996477 | debian-bookworm | ok 2026-06-03 03:16:17.070968 | 2026-06-03 03:16:17.071145 | TASK [tox : Return file comments to Zuul] 2026-06-03 03:16:17.128406 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:17.136702 | 2026-06-03 03:16:17.136801 | PLAY RECAP 2026-06-03 03:16:17.136873 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-06-03 03:16:17.136905 | 2026-06-03 03:16:17.459311 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-03 03:16:17.460947 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-03 03:16:18.917036 | 2026-06-03 03:16:18.917224 | PLAY [all] 2026-06-03 03:16:18.955967 | 2026-06-03 03:16:18.956156 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-06-03 03:16:19.042038 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:19.048300 | 2026-06-03 03:16:19.048508 | TASK [fetch-tox-output : Set tox log path for single node] 2026-06-03 03:16:19.150783 | debian-bookworm | ok 2026-06-03 03:16:19.164313 | 2026-06-03 03:16:19.164456 | TASK [fetch-tox-output : Ensure local tox dir] 2026-06-03 03:16:19.884636 | debian-bookworm -> localhost | changed 2026-06-03 03:16:19.893679 | 2026-06-03 03:16:19.893843 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-06-03 03:16:19.979921 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:19.986038 | 2026-06-03 03:16:19.986173 | TASK [fetch-tox-output : Set envlist fact] 2026-06-03 03:16:20.056876 | debian-bookworm | ok 2026-06-03 03:16:20.068706 | 2026-06-03 03:16:20.068918 | TASK [fetch-tox-output : Get tox version] 2026-06-03 03:16:20.804246 | 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-03 03:16:20.823351 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-03 03:16:21.119854 | debian-bookworm | ok: Runtime: 0:00:00.308569 2026-06-03 03:16:21.125523 | 2026-06-03 03:16:21.125639 | TASK [fetch-tox-output : Find all default environments] 2026-06-03 03:16:21.670313 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:21.678983 | 2026-06-03 03:16:21.679103 | TASK [fetch-tox-output : Set envlist fact] 2026-06-03 03:16:21.716310 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:21.725644 | 2026-06-03 03:16:21.725863 | TASK [fetch-tox-output : Find all default environments] 2026-06-03 03:16:22.293702 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:22.303843 | 2026-06-03 03:16:22.304014 | TASK [fetch-tox-output : Set envlist fact] 2026-06-03 03:16:22.328907 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:22.335087 | 2026-06-03 03:16:22.335175 | LOOP [fetch-tox-output : Copy tox logs] 2026-06-03 03:16:22.374650 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:22.383514 | 2026-06-03 03:16:22.383612 | LOOP [fetch-tox-output : Collect tox logs] 2026-06-03 03:16:23.061474 | debian-bookworm | changed: 2026-06-03 03:16:23.061676 | debian-bookworm | created directory /var/lib/zuul/builds/a2f54182314a4d2abe40f73f394f8f58/work/logs/tox/test 2026-06-03 03:16:23.061710 | debian-bookworm | cd+++++++++ ./ 2026-06-03 03:16:23.061735 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-06-03 03:16:23.061765 | 2026-06-03 03:16:23.074534 | 2026-06-03 03:16:23.074640 | PLAY RECAP 2026-06-03 03:16:23.074691 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-06-03 03:16:23.074712 | 2026-06-03 03:16:23.224895 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-03 03:16:23.225919 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-03 03:16:24.074485 | 2026-06-03 03:16:24.074611 | PLAY [all] 2026-06-03 03:16:24.089731 | 2026-06-03 03:16:24.089858 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-03 03:16:24.305873 | debian-bookworm | changed: non-zero return code 2026-06-03 03:16:24.314093 | 2026-06-03 03:16:24.314259 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-03 03:16:24.339045 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:24.348294 | 2026-06-03 03:16:24.348447 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-03 03:16:24.380339 | 2026-06-03 03:16:24.380531 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-03 03:16:24.419042 | 2026-06-03 03:16:24.419305 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-03 03:16:24.454276 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:24.463393 | 2026-06-03 03:16:24.463531 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-03 03:16:24.495534 | 2026-06-03 03:16:24.495768 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-03 03:16:24.519905 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:24.535075 | 2026-06-03 03:16:24.535234 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-03 03:16:24.559838 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:24.576596 | 2026-06-03 03:16:24.576803 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-03 03:16:24.603457 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:24.611182 | 2026-06-03 03:16:24.611268 | PLAY RECAP 2026-06-03 03:16:24.611321 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-03 03:16:24.611346 | 2026-06-03 03:16:24.722899 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-03 03:16:24.726938 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-03 03:16:25.553863 | 2026-06-03 03:16:25.554109 | PLAY [Base post-fetch] 2026-06-03 03:16:25.567492 | 2026-06-03 03:16:25.567615 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-03 03:16:25.623326 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:25.646394 | 2026-06-03 03:16:25.646638 | TASK [fetch-output : Set log path for single node] 2026-06-03 03:16:25.677942 | debian-bookworm | ok 2026-06-03 03:16:25.690209 | 2026-06-03 03:16:25.690313 | LOOP [fetch-output : Ensure local output dirs] 2026-06-03 03:16:26.197369 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/a2f54182314a4d2abe40f73f394f8f58/work/logs" 2026-06-03 03:16:26.480793 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a2f54182314a4d2abe40f73f394f8f58/work/artifacts" 2026-06-03 03:16:26.825657 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a2f54182314a4d2abe40f73f394f8f58/work/docs" 2026-06-03 03:16:26.841390 | 2026-06-03 03:16:26.841533 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-03 03:16:27.689065 | debian-bookworm | changed: 2026-06-03 03:16:27.689313 | debian-bookworm | .d..t...... ./ 2026-06-03 03:16:27.689349 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-03 03:16:27.689399 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-03 03:16:27.689426 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-03 03:16:27.689468 | debian-bookworm | changed: All items complete 2026-06-03 03:16:27.689491 | 2026-06-03 03:16:28.294890 | debian-bookworm | changed: .d..t...... ./ 2026-06-03 03:16:28.965171 | debian-bookworm | changed: .d..t...... ./ 2026-06-03 03:16:28.988984 | 2026-06-03 03:16:28.989131 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-03 03:16:29.022703 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:29.035151 | debian-bookworm | skipping: Conditional result was False 2026-06-03 03:16:29.055411 | 2026-06-03 03:16:29.055519 | PLAY RECAP 2026-06-03 03:16:29.055576 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-03 03:16:29.055601 | 2026-06-03 03:16:29.215281 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-03 03:16:29.216466 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-03 03:16:30.639126 | 2026-06-03 03:16:30.639350 | PLAY [Base post] 2026-06-03 03:16:30.657103 | 2026-06-03 03:16:30.657291 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-03 03:16:31.192372 | debian-bookworm | changed 2026-06-03 03:16:31.199464 | 2026-06-03 03:16:31.199601 | PLAY RECAP 2026-06-03 03:16:31.199669 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-03 03:16:31.199734 | 2026-06-03 03:16:31.412670 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-03 03:16:31.413855 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-03 03:16:32.357423 | 2026-06-03 03:16:32.357603 | PLAY [Base post-logs] 2026-06-03 03:16:32.377696 | 2026-06-03 03:16:32.377880 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-03 03:16:32.956286 | localhost | changed 2026-06-03 03:16:32.968390 | 2026-06-03 03:16:32.968563 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-03 03:16:32.999828 | localhost | ok 2026-06-03 03:16:33.004860 | 2026-06-03 03:16:33.004974 | TASK [Set zuul-log-path fact] 2026-06-03 03:16:33.020277 | localhost | ok 2026-06-03 03:16:33.028479 | 2026-06-03 03:16:33.028598 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-03 03:16:33.053891 | localhost | ok 2026-06-03 03:16:33.057107 | 2026-06-03 03:16:33.057223 | TASK [upload-logs : Create log directories] 2026-06-03 03:16:33.739154 | localhost | changed 2026-06-03 03:16:33.743333 | 2026-06-03 03:16:33.743481 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-03 03:16:34.449513 | localhost -> localhost | ok: Runtime: 0:00:00.009484 2026-06-03 03:16:34.459302 | 2026-06-03 03:16:34.459488 | TASK [upload-logs : Upload logs to log server] 2026-06-03 03:16:36.112243 | localhost | Output suppressed because no_log was given 2026-06-03 03:16:36.114251 | 2026-06-03 03:16:36.114365 | LOOP [upload-logs : Compress console log and json output] 2026-06-03 03:16:36.274670 | localhost | skipping: Conditional result was False 2026-06-03 03:16:36.291720 | localhost | skipping: Conditional result was False 2026-06-03 03:16:36.304843 | 2026-06-03 03:16:36.304997 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-03 03:16:36.464346 | localhost | skipping: Conditional result was False 2026-06-03 03:16:36.464655 | 2026-06-03 03:16:36.474444 | localhost | skipping: Conditional result was False 2026-06-03 03:16:36.483467 | 2026-06-03 03:16:36.483610 | LOOP [upload-logs : Upload console log and json output]