2026-05-26 03:02:31.733154 | Job console starting 2026-05-26 03:02:31.741768 | Updating git repos 2026-05-26 03:02:31.770681 | Cloning repos into workspace 2026-05-26 03:02:31.902928 | Restoring repo states 2026-05-26 03:02:31.921293 | Merging changes 2026-05-26 03:02:31.921309 | Checking out repos 2026-05-26 03:02:32.070361 | Preparing playbooks 2026-05-26 03:02:32.778346 | Running Ansible setup 2026-05-26 03:02:37.441834 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-26 03:02:38.348779 | 2026-05-26 03:02:38.348915 | PLAY [Base pre] 2026-05-26 03:02:38.365213 | 2026-05-26 03:02:38.365446 | TASK [Setup log path fact] 2026-05-26 03:02:38.393692 | debian-bookworm | ok 2026-05-26 03:02:38.422151 | 2026-05-26 03:02:38.422284 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-26 03:02:38.474970 | debian-bookworm | ok 2026-05-26 03:02:38.491658 | 2026-05-26 03:02:38.491773 | TASK [emit-job-header : Print job information] 2026-05-26 03:02:38.540716 | # Job Information 2026-05-26 03:02:38.540871 | Ansible Version: 2.16.14 2026-05-26 03:02:38.540905 | Job: tox 2026-05-26 03:02:38.540938 | Pipeline: periodic-daily 2026-05-26 03:02:38.540961 | Executor: 521e9411259a 2026-05-26 03:02:38.540981 | Triggered by: https://github.com/osism/openstack-image-manager 2026-05-26 03:02:38.541004 | Event ID: e6e6e7f8fdd345ada259ba2e981210e8 2026-05-26 03:02:38.545920 | 2026-05-26 03:02:38.546019 | LOOP [emit-job-header : Print node information] 2026-05-26 03:02:38.694327 | debian-bookworm | ok: 2026-05-26 03:02:38.694631 | debian-bookworm | # Node Information 2026-05-26 03:02:38.694672 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-26 03:02:38.694698 | debian-bookworm | Hostname: debian 2026-05-26 03:02:38.694721 | debian-bookworm | Username: zuul 2026-05-26 03:02:38.694742 | debian-bookworm | Distro: Debian 12.14 2026-05-26 03:02:38.694770 | debian-bookworm | Provider: regiocloud-a 2026-05-26 03:02:38.694791 | debian-bookworm | Region: 2026-05-26 03:02:38.694812 | debian-bookworm | Label: debian-bookworm 2026-05-26 03:02:38.694852 | debian-bookworm | Product Name: OpenStack Nova 2026-05-26 03:02:38.694875 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0d:466c 2026-05-26 03:02:38.716227 | 2026-05-26 03:02:38.716336 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-26 03:02:39.362913 | debian-bookworm -> localhost | changed 2026-05-26 03:02:39.370024 | 2026-05-26 03:02:39.370124 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-26 03:02:40.694717 | debian-bookworm -> localhost | changed 2026-05-26 03:02:40.704007 | 2026-05-26 03:02:40.704110 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-26 03:02:41.128948 | debian-bookworm -> localhost | ok 2026-05-26 03:02:41.133851 | 2026-05-26 03:02:41.133930 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-26 03:02:41.151775 | debian-bookworm | ok 2026-05-26 03:02:41.175796 | debian-bookworm | included: /var/lib/zuul/builds/146c853232ba476dbd794f18a701c07f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-26 03:02:41.185737 | 2026-05-26 03:02:41.185828 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-26 03:02:43.252021 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-26 03:02:43.252186 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/146c853232ba476dbd794f18a701c07f/work/146c853232ba476dbd794f18a701c07f_id_rsa 2026-05-26 03:02:43.252216 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/146c853232ba476dbd794f18a701c07f/work/146c853232ba476dbd794f18a701c07f_id_rsa.pub 2026-05-26 03:02:43.252238 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-26 03:02:43.252257 | debian-bookworm -> localhost | SHA256:i2gXJ1gHFHD1/6/OMElNPGOE1Gn2BJROIQfxvvAkzC0 zuul-build-sshkey 2026-05-26 03:02:43.252275 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-26 03:02:43.252299 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-26 03:02:43.252316 | debian-bookworm -> localhost | | .o=o. .=**= | 2026-05-26 03:02:43.252333 | debian-bookworm -> localhost | | . . . .*B .| 2026-05-26 03:02:43.252349 | debian-bookworm -> localhost | | . . . =Bo | 2026-05-26 03:02:43.252364 | debian-bookworm -> localhost | | o . + *.o.| 2026-05-26 03:02:43.252380 | debian-bookworm -> localhost | | . o S E = | 2026-05-26 03:02:43.252417 | debian-bookworm -> localhost | | . = . . O . | 2026-05-26 03:02:43.252434 | debian-bookworm -> localhost | | o o . + + | 2026-05-26 03:02:43.252450 | debian-bookworm -> localhost | | . . + . | 2026-05-26 03:02:43.252468 | debian-bookworm -> localhost | | .+..| 2026-05-26 03:02:43.252484 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-26 03:02:43.252527 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.121011 2026-05-26 03:02:43.257779 | 2026-05-26 03:02:43.257867 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-26 03:02:43.286339 | debian-bookworm | ok 2026-05-26 03:02:43.309529 | debian-bookworm | included: /var/lib/zuul/builds/146c853232ba476dbd794f18a701c07f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-26 03:02:43.327832 | 2026-05-26 03:02:43.327926 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-26 03:02:43.361045 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:02:43.365993 | 2026-05-26 03:02:43.366079 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-26 03:02:43.995921 | debian-bookworm | changed 2026-05-26 03:02:44.002993 | 2026-05-26 03:02:44.003088 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-26 03:02:44.244090 | debian-bookworm | ok 2026-05-26 03:02:44.251913 | 2026-05-26 03:02:44.252027 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-26 03:02:44.850770 | debian-bookworm | changed 2026-05-26 03:02:44.856910 | 2026-05-26 03:02:44.857001 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-26 03:02:45.537668 | debian-bookworm | changed 2026-05-26 03:02:45.542116 | 2026-05-26 03:02:45.542200 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-26 03:02:45.560173 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:02:45.565622 | 2026-05-26 03:02:45.565713 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-26 03:02:46.045027 | debian-bookworm -> localhost | changed 2026-05-26 03:02:46.053824 | 2026-05-26 03:02:46.053917 | TASK [add-build-sshkey : Add back temp key] 2026-05-26 03:02:46.436110 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/146c853232ba476dbd794f18a701c07f/work/146c853232ba476dbd794f18a701c07f_id_rsa (zuul-build-sshkey) 2026-05-26 03:02:46.436311 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016744 2026-05-26 03:02:46.443838 | 2026-05-26 03:02:46.443933 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-26 03:02:46.845490 | debian-bookworm | ok 2026-05-26 03:02:46.850329 | 2026-05-26 03:02:46.850439 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-26 03:02:46.893965 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:02:46.913578 | 2026-05-26 03:02:46.913687 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-26 03:02:47.362788 | debian-bookworm | ok 2026-05-26 03:02:47.391404 | 2026-05-26 03:02:47.391500 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-26 03:02:47.440658 | debian-bookworm | ok 2026-05-26 03:02:47.453909 | 2026-05-26 03:02:47.454003 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-26 03:02:48.036530 | debian-bookworm -> localhost | ok 2026-05-26 03:02:48.044138 | 2026-05-26 03:02:48.044234 | TASK [validate-host : Collect information about the host] 2026-05-26 03:02:49.784860 | debian-bookworm | ok 2026-05-26 03:02:49.835864 | 2026-05-26 03:02:49.835977 | TASK [validate-host : Sanitize hostname] 2026-05-26 03:02:50.289266 | debian-bookworm | ok 2026-05-26 03:02:50.450564 | 2026-05-26 03:02:50.450678 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-26 03:02:51.582764 | debian-bookworm -> localhost | changed 2026-05-26 03:02:51.588272 | 2026-05-26 03:02:51.588371 | TASK [validate-host : Collect information about zuul worker] 2026-05-26 03:02:52.243226 | debian-bookworm | ok 2026-05-26 03:02:52.248519 | 2026-05-26 03:02:52.248617 | TASK [validate-host : Write out all zuul information for each host] 2026-05-26 03:02:52.979538 | debian-bookworm -> localhost | changed 2026-05-26 03:02:52.988577 | 2026-05-26 03:02:52.988674 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-26 03:02:53.248226 | debian-bookworm | ok 2026-05-26 03:02:53.253489 | 2026-05-26 03:02:53.253579 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-26 03:02:54.561755 | debian-bookworm | changed: 2026-05-26 03:02:54.561904 | debian-bookworm | cd+++++++++ src/ 2026-05-26 03:02:54.561933 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-26 03:02:54.561952 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-26 03:02:54.561969 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-26 03:02:54.561986 | debian-bookworm | =7.0.3 2026-05-26 03:03:20.180050 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-05-26 03:03:20.220378 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-26 03:03:20.232050 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-26 03:03:20.302808 | debian-bookworm | Collecting filelock>=3.25 2026-05-26 03:03:20.314611 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-26 03:03:20.379510 | debian-bookworm | Collecting packaging>=26 2026-05-26 03:03:20.391439 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-26 03:03:20.409715 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 8.0 MB/s eta 0:00:00 2026-05-26 03:03:20.472815 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-26 03:03:20.485336 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-05-26 03:03:20.527800 | debian-bookworm | Collecting pluggy>=1.6 2026-05-26 03:03:20.539724 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-26 03:03:20.582059 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-26 03:03:20.595524 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-26 03:03:20.632783 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-26 03:03:20.645452 | debian-bookworm | Downloading python_discovery-1.3.1-py3-none-any.whl (33 kB) 2026-05-26 03:03:20.686750 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-26 03:03:20.698401 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-26 03:03:20.839348 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-26 03:03:20.851382 | debian-bookworm | Downloading virtualenv-21.3.3-py3-none-any.whl (7.6 MB) 2026-05-26 03:03:21.277219 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 18.0 MB/s eta 0:00:00 2026-05-26 03:03:21.385484 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-26 03:03:21.396938 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-26 03:03:21.425376 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.4 MB/s eta 0:00:00 2026-05-26 03:03:21.547461 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-26 03:03:22.395109 | debian-bookworm | Successfully installed cachetools-7.1.4 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-26 03:03:23.020816 | debian-bookworm | ok: Runtime: 0:00:03.254558 2026-05-26 03:03:23.027376 | 2026-05-26 03:03:23.027524 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-26 03:03:23.099767 | debian-bookworm | ok 2026-05-26 03:03:23.109893 | 2026-05-26 03:03:23.110045 | TASK [ensure-tox : Output tox version] 2026-05-26 03:03:23.764357 | 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-26 03:03:23.781995 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-26 03:03:24.180430 | debian-bookworm | ok: Runtime: 0:00:00.345905 2026-05-26 03:03:24.189307 | 2026-05-26 03:03:24.189458 | TASK [ensure-tox : Make global symlink] 2026-05-26 03:03:24.214603 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:24.224527 | 2026-05-26 03:03:24.224625 | PLAY RECAP 2026-05-26 03:03:24.224681 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-26 03:03:24.224705 | 2026-05-26 03:03:24.439396 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-26 03:03:24.440548 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-26 03:03:25.272511 | 2026-05-26 03:03:25.272696 | PLAY [all] 2026-05-26 03:03:25.307749 | 2026-05-26 03:03:25.307920 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-26 03:03:25.792426 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-26 03:03:25.843519 | debian-bookworm | ok: Runtime: 0:00:00.029769 2026-05-26 03:03:25.849282 | 2026-05-26 03:03:25.849414 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-26 03:03:26.378123 | debian-bookworm | ok: Runtime: 0:00:00.008206 2026-05-26 03:03:26.384599 | 2026-05-26 03:03:26.384726 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-26 03:03:26.715945 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-26 03:03:26.718713 | debian-bookworm | sudo: a password is required 2026-05-26 03:03:26.926530 | debian-bookworm | ok: Runtime: 0:00:00.022497 2026-05-26 03:03:26.937715 | 2026-05-26 03:03:26.937839 | TASK [tox : Check to see if the constraints file exists] 2026-05-26 03:03:26.994105 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:27.001797 | 2026-05-26 03:03:27.002091 | TASK [tox : Fail if constraints file is missing] 2026-05-26 03:03:27.057274 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:27.065487 | 2026-05-26 03:03:27.065639 | TASK [tox : Record file location] 2026-05-26 03:03:27.131496 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:27.146119 | 2026-05-26 03:03:27.149503 | TASK [tox : Install tox siblings] 2026-05-26 03:03:27.195761 | debian-bookworm | ok 2026-05-26 03:03:27.207429 | debian-bookworm | included: /var/lib/zuul/builds/146c853232ba476dbd794f18a701c07f/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-26 03:03:27.233440 | 2026-05-26 03:03:27.233616 | TASK [tox : Run tox without tests] 2026-05-26 03:03:28.598192 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-05-26 03:03:41.777514 | debian-bookworm | test: OK (13.90 seconds) 2026-05-26 03:03:41.777588 | debian-bookworm | congratulations :) (13.92 seconds) 2026-05-26 03:03:42.302813 | debian-bookworm | ok: Runtime: 0:00:14.227341 2026-05-26 03:03:42.307616 | 2026-05-26 03:03:42.307698 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-26 03:03:43.043687 | debian-bookworm | changed 2026-05-26 03:03:43.048262 | 2026-05-26 03:03:43.048345 | TASK [tox : Detect tox version] 2026-05-26 03:03:43.774344 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-26 03:03:44.132847 | debian-bookworm | ok: Runtime: 0:00:00.301099 2026-05-26 03:03:44.137436 | 2026-05-26 03:03:44.137531 | TASK [tox : Get tox envlist config] 2026-05-26 03:03:45.195336 | debian-bookworm | ok: Runtime: 0:00:00.360117 2026-05-26 03:03:45.201149 | 2026-05-26 03:03:45.201261 | TASK [tox : Install any sibling python packages] 2026-05-26 03:03:45.899543 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-26 03:03:45.904955 | 2026-05-26 03:03:45.905055 | TASK [tox : Remove tempfile] 2026-05-26 03:03:46.583455 | debian-bookworm | changed 2026-05-26 03:03:46.593120 | 2026-05-26 03:03:46.593228 | TASK [tox : Emit tox command] 2026-05-26 03:03:46.656163 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-05-26 03:03:46.661564 | 2026-05-26 03:03:46.661662 | TASK [tox : Run tox] 2026-05-26 03:03:47.342409 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-05-26 03:03:48.092573 | debian-bookworm | ............... 2026-05-26 03:03:48.092622 | debian-bookworm | ---------------------------------------------------------------------- 2026-05-26 03:03:48.092633 | debian-bookworm | Ran 15 tests in 0.175s 2026-05-26 03:03:48.092639 | debian-bookworm | 2026-05-26 03:03:48.092646 | debian-bookworm | OK 2026-05-26 03:03:48.186182 | debian-bookworm | test: OK (0.89=setup[0.05]+cmd[0.84] seconds) 2026-05-26 03:03:48.186261 | debian-bookworm | congratulations :) (0.92 seconds) 2026-05-26 03:03:48.720960 | debian-bookworm | ok: Runtime: 0:00:01.215557 2026-05-26 03:03:48.725843 | 2026-05-26 03:03:48.725935 | TASK [tox : Look for output] 2026-05-26 03:03:49.258978 | debian-bookworm | ok 2026-05-26 03:03:49.320577 | 2026-05-26 03:03:49.320875 | TASK [tox : Return file comments to Zuul] 2026-05-26 03:03:49.439868 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:49.446727 | 2026-05-26 03:03:49.446794 | PLAY RECAP 2026-05-26 03:03:49.446930 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-26 03:03:49.446953 | 2026-05-26 03:03:49.775239 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-26 03:03:49.776073 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-26 03:03:51.617255 | 2026-05-26 03:03:51.617382 | PLAY [all] 2026-05-26 03:03:51.642375 | 2026-05-26 03:03:51.642528 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-26 03:03:51.778045 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:51.784995 | 2026-05-26 03:03:51.785122 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-26 03:03:51.869097 | debian-bookworm | ok 2026-05-26 03:03:51.877889 | 2026-05-26 03:03:51.877997 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-26 03:03:53.759367 | debian-bookworm -> localhost | changed 2026-05-26 03:03:53.765754 | 2026-05-26 03:03:53.765844 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-26 03:03:53.955272 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:53.962924 | 2026-05-26 03:03:53.963019 | TASK [fetch-tox-output : Set envlist fact] 2026-05-26 03:03:54.053205 | debian-bookworm | ok 2026-05-26 03:03:54.057840 | 2026-05-26 03:03:54.057913 | TASK [fetch-tox-output : Get tox version] 2026-05-26 03:03:55.275862 | 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-26 03:03:55.293463 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-26 03:03:55.654864 | debian-bookworm | ok: Runtime: 0:00:00.308097 2026-05-26 03:03:55.659583 | 2026-05-26 03:03:55.659659 | TASK [fetch-tox-output : Find all default environments] 2026-05-26 03:03:56.207956 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:56.213473 | 2026-05-26 03:03:56.213589 | TASK [fetch-tox-output : Set envlist fact] 2026-05-26 03:03:56.257275 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:56.261969 | 2026-05-26 03:03:56.262052 | TASK [fetch-tox-output : Find all default environments] 2026-05-26 03:03:56.826181 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:56.844270 | 2026-05-26 03:03:56.844378 | TASK [fetch-tox-output : Set envlist fact] 2026-05-26 03:03:56.907821 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:56.931566 | 2026-05-26 03:03:56.931674 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-26 03:03:57.075226 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:03:57.098710 | 2026-05-26 03:03:57.098923 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-26 03:03:58.517138 | debian-bookworm | changed: 2026-05-26 03:03:58.517303 | debian-bookworm | created directory /var/lib/zuul/builds/146c853232ba476dbd794f18a701c07f/work/logs/tox/test 2026-05-26 03:03:58.517339 | debian-bookworm | cd+++++++++ ./ 2026-05-26 03:03:58.517365 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-26 03:03:58.517397 | 2026-05-26 03:03:58.531646 | 2026-05-26 03:03:58.531727 | PLAY RECAP 2026-05-26 03:03:58.531775 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-26 03:03:58.531798 | 2026-05-26 03:03:58.956263 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-26 03:03:58.959944 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-26 03:04:00.344456 | 2026-05-26 03:04:00.344589 | PLAY [all] 2026-05-26 03:04:00.375339 | 2026-05-26 03:04:00.375457 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-26 03:04:00.619714 | debian-bookworm | changed: non-zero return code 2026-05-26 03:04:00.624342 | 2026-05-26 03:04:00.624442 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-26 03:04:00.661972 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:04:00.667775 | 2026-05-26 03:04:00.667895 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-26 03:04:00.716623 | 2026-05-26 03:04:00.716775 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-26 03:04:00.779351 | 2026-05-26 03:04:00.779518 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-26 03:04:00.794361 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:04:00.799256 | 2026-05-26 03:04:00.799342 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-26 03:04:00.826510 | 2026-05-26 03:04:00.826658 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-26 03:04:00.879839 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:04:00.885344 | 2026-05-26 03:04:00.885451 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-26 03:04:00.931080 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:04:00.936002 | 2026-05-26 03:04:00.936092 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-26 03:04:00.970514 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:04:00.975975 | 2026-05-26 03:04:00.976038 | PLAY RECAP 2026-05-26 03:04:00.976080 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-26 03:04:00.976101 | 2026-05-26 03:04:01.314582 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-26 03:04:01.315400 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-26 03:04:02.769861 | 2026-05-26 03:04:02.769982 | PLAY [Base post-fetch] 2026-05-26 03:04:02.781580 | 2026-05-26 03:04:02.781688 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-26 03:04:02.845964 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:04:02.850851 | 2026-05-26 03:04:02.850963 | TASK [fetch-output : Set log path for single node] 2026-05-26 03:04:02.908025 | debian-bookworm | ok 2026-05-26 03:04:02.912763 | 2026-05-26 03:04:02.912846 | LOOP [fetch-output : Ensure local output dirs] 2026-05-26 03:04:03.717207 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/146c853232ba476dbd794f18a701c07f/work/logs" 2026-05-26 03:04:04.265640 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/146c853232ba476dbd794f18a701c07f/work/artifacts" 2026-05-26 03:04:04.853435 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/146c853232ba476dbd794f18a701c07f/work/docs" 2026-05-26 03:04:04.878078 | 2026-05-26 03:04:04.878217 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-26 03:04:05.866766 | debian-bookworm | changed: 2026-05-26 03:04:05.866962 | debian-bookworm | .d..t...... ./ 2026-05-26 03:04:05.866993 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-26 03:04:05.867022 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-26 03:04:05.867048 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-26 03:04:05.867081 | debian-bookworm | changed: All items complete 2026-05-26 03:04:05.867103 | 2026-05-26 03:04:06.631002 | debian-bookworm | changed: .d..t...... ./ 2026-05-26 03:04:07.515250 | debian-bookworm | changed: .d..t...... ./ 2026-05-26 03:04:07.528928 | 2026-05-26 03:04:07.529005 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-26 03:04:07.586666 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:04:07.596331 | debian-bookworm | skipping: Conditional result was False 2026-05-26 03:04:07.604897 | 2026-05-26 03:04:07.604963 | PLAY RECAP 2026-05-26 03:04:07.605006 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-26 03:04:07.605027 | 2026-05-26 03:04:07.755430 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-26 03:04:07.756269 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-26 03:04:08.652059 | 2026-05-26 03:04:08.652177 | PLAY [Base post] 2026-05-26 03:04:08.666577 | 2026-05-26 03:04:08.666679 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-26 03:04:09.166293 | debian-bookworm | changed 2026-05-26 03:04:09.172532 | 2026-05-26 03:04:09.172631 | PLAY RECAP 2026-05-26 03:04:09.172698 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-26 03:04:09.172759 | 2026-05-26 03:04:09.272153 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-26 03:04:09.273136 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-26 03:04:10.016554 | 2026-05-26 03:04:10.016692 | PLAY [Base post-logs] 2026-05-26 03:04:10.026176 | 2026-05-26 03:04:10.026308 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-26 03:04:10.616756 | localhost | changed 2026-05-26 03:04:10.625838 | 2026-05-26 03:04:10.625962 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-26 03:04:10.651170 | localhost | ok 2026-05-26 03:04:10.653990 | 2026-05-26 03:04:10.654071 | TASK [Set zuul-log-path fact] 2026-05-26 03:04:10.678392 | localhost | ok 2026-05-26 03:04:10.686851 | 2026-05-26 03:04:10.686998 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-26 03:04:10.724799 | localhost | ok 2026-05-26 03:04:10.727665 | 2026-05-26 03:04:10.727752 | TASK [upload-logs : Create log directories] 2026-05-26 03:04:11.477114 | localhost | changed 2026-05-26 03:04:11.479730 | 2026-05-26 03:04:11.479814 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-26 03:04:12.772062 | localhost -> localhost | ok: Runtime: 0:00:00.029704 2026-05-26 03:04:12.775668 | 2026-05-26 03:04:12.775765 | TASK [upload-logs : Upload logs to log server] 2026-05-26 03:04:13.508528 | localhost | Output suppressed because no_log was given 2026-05-26 03:04:13.509908 | 2026-05-26 03:04:13.509981 | LOOP [upload-logs : Compress console log and json output] 2026-05-26 03:04:13.551470 | localhost | skipping: Conditional result was False 2026-05-26 03:04:13.562440 | localhost | skipping: Conditional result was False 2026-05-26 03:04:13.580535 | 2026-05-26 03:04:13.580628 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-26 03:04:13.637349 | localhost | skipping: Conditional result was False 2026-05-26 03:04:13.637611 | 2026-05-26 03:04:13.642999 | localhost | skipping: Conditional result was False 2026-05-26 03:04:13.655363 | 2026-05-26 03:04:13.655445 | LOOP [upload-logs : Upload console log and json output]