2026-06-02 08:08:44.629718 | Job console starting 2026-06-02 08:08:44.641020 | Updating git repos 2026-06-02 08:08:44.703579 | Cloning repos into workspace 2026-06-02 08:08:44.743589 | Restoring repo states 2026-06-02 08:08:44.749714 | Merging changes 2026-06-02 08:08:45.326179 | Checking out repos 2026-06-02 08:08:45.363479 | Preparing playbooks 2026-06-02 08:08:46.491800 | Running Ansible setup 2026-06-02 08:08:52.744526 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-02 08:08:53.721685 | 2026-06-02 08:08:53.721816 | PLAY [Base pre] 2026-06-02 08:08:53.736540 | 2026-06-02 08:08:53.736660 | TASK [Setup log path fact] 2026-06-02 08:08:53.764092 | debian-bookworm | ok 2026-06-02 08:08:53.794821 | 2026-06-02 08:08:53.794992 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-02 08:08:53.822424 | debian-bookworm | ok 2026-06-02 08:08:53.831827 | 2026-06-02 08:08:53.831918 | TASK [emit-job-header : Print job information] 2026-06-02 08:08:53.879958 | # Job Information 2026-06-02 08:08:53.880194 | Ansible Version: 2.16.14 2026-06-02 08:08:53.880227 | Job: tox 2026-06-02 08:08:53.880261 | Pipeline: check 2026-06-02 08:08:53.882190 | Executor: 521e9411259a 2026-06-02 08:08:53.882216 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1218 2026-06-02 08:08:53.882237 | Event ID: b3a0b4b0-5e59-11f1-87f9-fd1a1c73c4bd 2026-06-02 08:08:53.886974 | 2026-06-02 08:08:53.887065 | LOOP [emit-job-header : Print node information] 2026-06-02 08:08:54.054094 | debian-bookworm | ok: 2026-06-02 08:08:54.054265 | debian-bookworm | # Node Information 2026-06-02 08:08:54.054294 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-02 08:08:54.054315 | debian-bookworm | Hostname: debian 2026-06-02 08:08:54.054334 | debian-bookworm | Username: zuul 2026-06-02 08:08:54.054352 | debian-bookworm | Distro: Debian 12.14 2026-06-02 08:08:54.054371 | debian-bookworm | Provider: regiocloud-a 2026-06-02 08:08:54.054388 | debian-bookworm | Region: 2026-06-02 08:08:54.054405 | debian-bookworm | Label: debian-bookworm 2026-06-02 08:08:54.054421 | debian-bookworm | Product Name: OpenStack Nova 2026-06-02 08:08:54.054437 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe64:629a 2026-06-02 08:08:54.063868 | 2026-06-02 08:08:54.063966 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-02 08:08:54.745860 | debian-bookworm -> localhost | changed 2026-06-02 08:08:54.752706 | 2026-06-02 08:08:54.752807 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-02 08:08:56.645894 | debian-bookworm -> localhost | changed 2026-06-02 08:08:56.657529 | 2026-06-02 08:08:56.657668 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-02 08:08:56.978858 | debian-bookworm -> localhost | ok 2026-06-02 08:08:56.984268 | 2026-06-02 08:08:56.984357 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-02 08:08:57.023338 | debian-bookworm | ok 2026-06-02 08:08:57.048315 | debian-bookworm | included: /var/lib/zuul/builds/e84a3b1e573347d1a0d65750fcb8a0ae/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-02 08:08:57.067327 | 2026-06-02 08:08:57.067431 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-02 08:08:59.037219 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-02 08:08:59.037393 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e84a3b1e573347d1a0d65750fcb8a0ae/work/e84a3b1e573347d1a0d65750fcb8a0ae_id_rsa 2026-06-02 08:08:59.037425 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e84a3b1e573347d1a0d65750fcb8a0ae/work/e84a3b1e573347d1a0d65750fcb8a0ae_id_rsa.pub 2026-06-02 08:08:59.037446 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-02 08:08:59.037466 | debian-bookworm -> localhost | SHA256:DaOhtQCMop789O2vRjYU+sy5snbb4kfme9HfsXQsEu8 zuul-build-sshkey 2026-06-02 08:08:59.037485 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-02 08:08:59.037511 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-02 08:08:59.037529 | debian-bookworm -> localhost | | o. | 2026-06-02 08:08:59.037547 | debian-bookworm -> localhost | |o .. . | 2026-06-02 08:08:59.037564 | debian-bookworm -> localhost | |o . + + | 2026-06-02 08:08:59.037580 | debian-bookworm -> localhost | |. = = + . | 2026-06-02 08:08:59.037608 | debian-bookworm -> localhost | |o . . B S . .o . | 2026-06-02 08:08:59.037628 | debian-bookworm -> localhost | | + . O o ...ooo| 2026-06-02 08:08:59.037645 | debian-bookworm -> localhost | | o . + * .oo.=| 2026-06-02 08:08:59.037662 | debian-bookworm -> localhost | | . + *.o . Eo.| 2026-06-02 08:08:59.037679 | debian-bookworm -> localhost | | ..B=*+o | 2026-06-02 08:08:59.037695 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-02 08:08:59.037740 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.287341 2026-06-02 08:08:59.043141 | 2026-06-02 08:08:59.043227 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-02 08:08:59.085458 | debian-bookworm | ok 2026-06-02 08:08:59.107027 | debian-bookworm | included: /var/lib/zuul/builds/e84a3b1e573347d1a0d65750fcb8a0ae/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-02 08:08:59.123729 | 2026-06-02 08:08:59.123831 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-02 08:08:59.157398 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:08:59.162254 | 2026-06-02 08:08:59.162338 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-02 08:08:59.977132 | debian-bookworm | changed 2026-06-02 08:08:59.982464 | 2026-06-02 08:08:59.982550 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-02 08:09:00.263254 | debian-bookworm | ok 2026-06-02 08:09:00.267873 | 2026-06-02 08:09:00.267953 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-02 08:09:01.020057 | debian-bookworm | changed 2026-06-02 08:09:01.033963 | 2026-06-02 08:09:01.034061 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-02 08:09:01.798364 | debian-bookworm | changed 2026-06-02 08:09:01.802784 | 2026-06-02 08:09:01.802876 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-02 08:09:01.879849 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:09:01.885493 | 2026-06-02 08:09:01.885602 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-02 08:09:02.925671 | debian-bookworm -> localhost | changed 2026-06-02 08:09:02.946732 | 2026-06-02 08:09:02.946827 | TASK [add-build-sshkey : Add back temp key] 2026-06-02 08:09:03.390089 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e84a3b1e573347d1a0d65750fcb8a0ae/work/e84a3b1e573347d1a0d65750fcb8a0ae_id_rsa (zuul-build-sshkey) 2026-06-02 08:09:03.390277 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030623 2026-06-02 08:09:03.396899 | 2026-06-02 08:09:03.396990 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-02 08:09:04.137341 | debian-bookworm | ok 2026-06-02 08:09:04.142784 | 2026-06-02 08:09:04.142987 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-02 08:09:04.189814 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:09:04.202371 | 2026-06-02 08:09:04.202469 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-02 08:09:04.993150 | debian-bookworm | ok 2026-06-02 08:09:05.013180 | 2026-06-02 08:09:05.013284 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-02 08:09:05.067031 | debian-bookworm | ok 2026-06-02 08:09:05.071350 | 2026-06-02 08:09:05.071431 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-02 08:09:05.781973 | debian-bookworm -> localhost | ok 2026-06-02 08:09:05.789643 | 2026-06-02 08:09:05.789760 | TASK [validate-host : Collect information about the host] 2026-06-02 08:09:07.040523 | debian-bookworm | ok 2026-06-02 08:09:07.065770 | 2026-06-02 08:09:07.065885 | TASK [validate-host : Sanitize hostname] 2026-06-02 08:09:07.158643 | debian-bookworm | ok 2026-06-02 08:09:07.329127 | 2026-06-02 08:09:07.329246 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-02 08:09:08.210419 | debian-bookworm -> localhost | changed 2026-06-02 08:09:08.216328 | 2026-06-02 08:09:08.216420 | TASK [validate-host : Collect information about zuul worker] 2026-06-02 08:09:08.741546 | debian-bookworm | ok 2026-06-02 08:09:08.746456 | 2026-06-02 08:09:08.746544 | TASK [validate-host : Write out all zuul information for each host] 2026-06-02 08:09:10.058038 | debian-bookworm -> localhost | changed 2026-06-02 08:09:10.077146 | 2026-06-02 08:09:10.077250 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-02 08:09:10.391234 | debian-bookworm | ok 2026-06-02 08:09:10.396395 | 2026-06-02 08:09:10.396481 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-02 08:09:11.287889 | debian-bookworm | changed: 2026-06-02 08:09:11.288043 | debian-bookworm | cd+++++++++ src/ 2026-06-02 08:09:11.288071 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-02 08:09:11.288091 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-02 08:09:11.288110 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-02 08:09:11.288127 | debian-bookworm | =7.0.3 2026-06-02 08:09:36.386170 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-06-02 08:09:36.429700 | debian-bookworm | Collecting colorama>=0.4.6 2026-06-02 08:09:36.442022 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-02 08:09:36.520529 | debian-bookworm | Collecting filelock>=3.25 2026-06-02 08:09:36.533191 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-06-02 08:09:36.586154 | debian-bookworm | Collecting packaging>=26 2026-06-02 08:09:36.597727 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-02 08:09:36.622479 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 5.0 MB/s eta 0:00:00 2026-06-02 08:09:36.687578 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-06-02 08:09:36.699616 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-06-02 08:09:36.743436 | debian-bookworm | Collecting pluggy>=1.6 2026-06-02 08:09:36.755035 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-02 08:09:36.794110 | debian-bookworm | Collecting pyproject-api>=1.10 2026-06-02 08:09:36.806946 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-06-02 08:09:36.854002 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-06-02 08:09:36.866495 | debian-bookworm | Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB) 2026-06-02 08:09:36.908113 | debian-bookworm | Collecting tomli-w>=1.2 2026-06-02 08:09:36.921207 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-06-02 08:09:37.065816 | debian-bookworm | Collecting virtualenv>=21.1 2026-06-02 08:09:37.077831 | debian-bookworm | Downloading virtualenv-21.4.2-py3-none-any.whl (7.6 MB) 2026-06-02 08:09:37.457886 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 20.2 MB/s eta 0:00:00 2026-06-02 08:09:37.586771 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-06-02 08:09:37.599660 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-06-02 08:09:37.627052 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.5 MB/s eta 0:00:00 2026-06-02 08:09:37.745162 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-06-02 08:09:38.506487 | 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.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-02 08:09:38.801005 | debian-bookworm | ok: Runtime: 0:00:03.130178 2026-06-02 08:09:38.806585 | 2026-06-02 08:09:38.806682 | TASK [ensure-tox : Export installed tox_executable path] 2026-06-02 08:09:38.855761 | debian-bookworm | ok 2026-06-02 08:09:38.860470 | 2026-06-02 08:09:38.860559 | TASK [ensure-tox : Output tox version] 2026-06-02 08:09:39.455304 | 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-02 08:09:39.473443 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-02 08:09:39.925152 | debian-bookworm | ok: Runtime: 0:00:00.354776 2026-06-02 08:09:39.936164 | 2026-06-02 08:09:39.936461 | TASK [ensure-tox : Make global symlink] 2026-06-02 08:09:39.962978 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:09:39.977258 | 2026-06-02 08:09:39.978202 | PLAY RECAP 2026-06-02 08:09:39.978325 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-06-02 08:09:39.978360 | 2026-06-02 08:09:40.362951 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-06-02 08:09:40.365683 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-02 08:09:41.348725 | 2026-06-02 08:09:41.348919 | PLAY [all] 2026-06-02 08:09:41.377131 | 2026-06-02 08:09:41.377314 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-06-02 08:09:42.041986 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-02 08:09:42.417596 | debian-bookworm | ok: Runtime: 0:00:00.023666 2026-06-02 08:09:42.423954 | 2026-06-02 08:09:42.424115 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-06-02 08:09:42.990433 | debian-bookworm | ok: Runtime: 0:00:00.005396 2026-06-02 08:09:42.997134 | 2026-06-02 08:09:42.997264 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-06-02 08:09:43.319126 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-02 08:09:43.320881 | debian-bookworm | sudo: a password is required 2026-06-02 08:09:43.546603 | debian-bookworm | ok: Runtime: 0:00:00.020682 2026-06-02 08:09:43.559481 | 2026-06-02 08:09:43.559636 | TASK [tox : Check to see if the constraints file exists] 2026-06-02 08:09:43.612620 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:09:43.619509 | 2026-06-02 08:09:43.619661 | TASK [tox : Fail if constraints file is missing] 2026-06-02 08:09:43.684501 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:09:43.692155 | 2026-06-02 08:09:43.692303 | TASK [tox : Record file location] 2026-06-02 08:09:43.740047 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:09:43.756844 | 2026-06-02 08:09:43.757001 | TASK [tox : Install tox siblings] 2026-06-02 08:09:43.828752 | debian-bookworm | ok 2026-06-02 08:09:43.868612 | debian-bookworm | included: /var/lib/zuul/builds/e84a3b1e573347d1a0d65750fcb8a0ae/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-06-02 08:09:43.895461 | 2026-06-02 08:09:43.895628 | TASK [tox : Run tox without tests] 2026-06-02 08:09:45.426117 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-06-02 08:09:58.578657 | debian-bookworm | test: OK (13.99 seconds) 2026-06-02 08:09:58.578764 | debian-bookworm | congratulations :) (14.02 seconds) 2026-06-02 08:09:58.980724 | debian-bookworm | ok: Runtime: 0:00:14.335668 2026-06-02 08:09:58.987016 | 2026-06-02 08:09:58.987100 | TASK [tox : Create a tempfile to save tox showconfig] 2026-06-02 08:09:59.537635 | debian-bookworm | changed 2026-06-02 08:09:59.541865 | 2026-06-02 08:09:59.541942 | TASK [tox : Detect tox version] 2026-06-02 08:10:00.131056 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-02 08:10:00.596415 | debian-bookworm | ok: Runtime: 0:00:00.312726 2026-06-02 08:10:00.607916 | 2026-06-02 08:10:00.608009 | TASK [tox : Get tox envlist config] 2026-06-02 08:10:01.667385 | debian-bookworm | ok: Runtime: 0:00:00.315149 2026-06-02 08:10:01.672330 | 2026-06-02 08:10:01.672430 | TASK [tox : Install any sibling python packages] 2026-06-02 08:10:02.055855 | debian-bookworm | ok: No setup.cfg, no action needed 2026-06-02 08:10:02.060457 | 2026-06-02 08:10:02.060535 | TASK [tox : Remove tempfile] 2026-06-02 08:10:02.563662 | debian-bookworm | changed 2026-06-02 08:10:02.574989 | 2026-06-02 08:10:02.575100 | TASK [tox : Emit tox command] 2026-06-02 08:10:02.613254 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-06-02 08:10:02.618528 | 2026-06-02 08:10:02.618632 | TASK [tox : Run tox] 2026-06-02 08:10:03.310764 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-06-02 08:10:03.958501 | debian-bookworm | ............... 2026-06-02 08:10:03.958538 | debian-bookworm | ---------------------------------------------------------------------- 2026-06-02 08:10:03.958548 | debian-bookworm | Ran 15 tests in 0.166s 2026-06-02 08:10:03.958553 | debian-bookworm | 2026-06-02 08:10:03.958559 | debian-bookworm | OK 2026-06-02 08:10:04.025609 | debian-bookworm | test: OK (0.76=setup[0.04]+cmd[0.71] seconds) 2026-06-02 08:10:04.025673 | debian-bookworm | congratulations :) (0.79 seconds) 2026-06-02 08:10:04.183480 | debian-bookworm | ok: Runtime: 0:00:01.087300 2026-06-02 08:10:04.194683 | 2026-06-02 08:10:04.195301 | TASK [tox : Look for output] 2026-06-02 08:10:04.612396 | debian-bookworm | ok 2026-06-02 08:10:04.653499 | 2026-06-02 08:10:04.654661 | TASK [tox : Return file comments to Zuul] 2026-06-02 08:10:04.736428 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:04.763759 | 2026-06-02 08:10:04.763899 | PLAY RECAP 2026-06-02 08:10:04.764358 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-06-02 08:10:04.764503 | 2026-06-02 08:10:04.867828 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-02 08:10:04.868672 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-02 08:10:06.208116 | 2026-06-02 08:10:06.208233 | PLAY [all] 2026-06-02 08:10:06.250865 | 2026-06-02 08:10:06.250987 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-06-02 08:10:06.319101 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:06.330076 | 2026-06-02 08:10:06.330208 | TASK [fetch-tox-output : Set tox log path for single node] 2026-06-02 08:10:06.412417 | debian-bookworm | ok 2026-06-02 08:10:06.427096 | 2026-06-02 08:10:06.427217 | TASK [fetch-tox-output : Ensure local tox dir] 2026-06-02 08:10:06.973300 | debian-bookworm -> localhost | changed 2026-06-02 08:10:06.981926 | 2026-06-02 08:10:06.982021 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-06-02 08:10:07.045299 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:07.049993 | 2026-06-02 08:10:07.050077 | TASK [fetch-tox-output : Set envlist fact] 2026-06-02 08:10:07.090140 | debian-bookworm | ok 2026-06-02 08:10:07.097871 | 2026-06-02 08:10:07.097986 | TASK [fetch-tox-output : Get tox version] 2026-06-02 08:10:07.820793 | 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-02 08:10:07.852966 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-02 08:10:08.150848 | debian-bookworm | ok: Runtime: 0:00:00.356033 2026-06-02 08:10:08.163034 | 2026-06-02 08:10:08.163145 | TASK [fetch-tox-output : Find all default environments] 2026-06-02 08:10:08.692455 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:08.700052 | 2026-06-02 08:10:08.700168 | TASK [fetch-tox-output : Set envlist fact] 2026-06-02 08:10:08.723203 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:08.729520 | 2026-06-02 08:10:08.729625 | TASK [fetch-tox-output : Find all default environments] 2026-06-02 08:10:09.272704 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:09.277391 | 2026-06-02 08:10:09.277479 | TASK [fetch-tox-output : Set envlist fact] 2026-06-02 08:10:09.301907 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:09.307095 | 2026-06-02 08:10:09.307184 | LOOP [fetch-tox-output : Copy tox logs] 2026-06-02 08:10:09.386876 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:09.396103 | 2026-06-02 08:10:09.396195 | LOOP [fetch-tox-output : Collect tox logs] 2026-06-02 08:10:10.232842 | debian-bookworm | changed: 2026-06-02 08:10:10.233009 | debian-bookworm | created directory /var/lib/zuul/builds/e84a3b1e573347d1a0d65750fcb8a0ae/work/logs/tox/test 2026-06-02 08:10:10.233042 | debian-bookworm | cd+++++++++ ./ 2026-06-02 08:10:10.233067 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-06-02 08:10:10.233095 | 2026-06-02 08:10:10.243402 | 2026-06-02 08:10:10.243509 | PLAY RECAP 2026-06-02 08:10:10.243561 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-06-02 08:10:10.243585 | 2026-06-02 08:10:10.365786 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-02 08:10:10.366575 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-02 08:10:11.183151 | 2026-06-02 08:10:11.183305 | PLAY [all] 2026-06-02 08:10:11.214900 | 2026-06-02 08:10:11.215154 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-02 08:10:11.555463 | debian-bookworm | changed: non-zero return code 2026-06-02 08:10:11.561511 | 2026-06-02 08:10:11.561635 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-02 08:10:11.584794 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:11.590261 | 2026-06-02 08:10:11.590372 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-02 08:10:11.630721 | 2026-06-02 08:10:11.630928 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-02 08:10:11.660565 | 2026-06-02 08:10:11.660733 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-02 08:10:11.697447 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:11.711577 | 2026-06-02 08:10:11.711701 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-02 08:10:11.745809 | 2026-06-02 08:10:11.745979 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-02 08:10:11.771250 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:11.778057 | 2026-06-02 08:10:11.778172 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-02 08:10:11.801251 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:11.807851 | 2026-06-02 08:10:11.807967 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-02 08:10:11.833784 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:11.841418 | 2026-06-02 08:10:11.841495 | PLAY RECAP 2026-06-02 08:10:11.841544 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-02 08:10:11.841570 | 2026-06-02 08:10:11.966010 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-02 08:10:11.966868 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-02 08:10:12.735795 | 2026-06-02 08:10:12.735931 | PLAY [Base post-fetch] 2026-06-02 08:10:12.749154 | 2026-06-02 08:10:12.749280 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-02 08:10:12.804204 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:10:12.809785 | 2026-06-02 08:10:12.809906 | TASK [fetch-output : Set log path for single node] 2026-06-02 08:10:12.837558 | debian-bookworm | ok 2026-06-02 08:10:12.842648 | 2026-06-02 08:10:12.842767 | LOOP [fetch-output : Ensure local output dirs] 2026-06-02 08:10:13.656148 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/e84a3b1e573347d1a0d65750fcb8a0ae/work/logs" 2026-06-02 08:10:14.111771 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e84a3b1e573347d1a0d65750fcb8a0ae/work/artifacts" 2026-06-02 08:10:14.507884 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e84a3b1e573347d1a0d65750fcb8a0ae/work/docs" 2026-06-02 08:10:14.535984 | 2026-06-02 08:10:14.536105 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-02 08:10:15.476328 | debian-bookworm | changed: 2026-06-02 08:10:15.476528 | debian-bookworm | .d..t...... ./ 2026-06-02 08:10:15.476561 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-02 08:10:15.476591 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-02 08:10:15.476617 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-02 08:10:15.476656 | debian-bookworm | changed: All items complete 2026-06-02 08:10:15.476681 | 2026-06-02 08:10:16.110251 | debian-bookworm | changed: .d..t...... ./ 2026-06-02 08:10:16.720633 | debian-bookworm | changed: .d..t...... ./ 2026-06-02 08:10:16.736805 | 2026-06-02 08:10:16.737194 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-02 08:10:17.272421 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.004304 2026-06-02 08:10:17.538784 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.004563 2026-06-02 08:10:17.550783 | 2026-06-02 08:10:17.550997 | PLAY RECAP 2026-06-02 08:10:17.551050 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-02 08:10:17.551076 | 2026-06-02 08:10:17.645739 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-02 08:10:17.647088 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-02 08:10:18.436626 | 2026-06-02 08:10:18.436753 | PLAY [Base post] 2026-06-02 08:10:18.457057 | 2026-06-02 08:10:18.457183 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-02 08:10:19.053348 | debian-bookworm | changed 2026-06-02 08:10:19.061490 | 2026-06-02 08:10:19.061596 | PLAY RECAP 2026-06-02 08:10:19.061657 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-02 08:10:19.061718 | 2026-06-02 08:10:19.158767 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-02 08:10:19.160708 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-02 08:10:20.104392 | 2026-06-02 08:10:20.104532 | PLAY [Base post-logs] 2026-06-02 08:10:20.129335 | 2026-06-02 08:10:20.129555 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-02 08:10:20.632966 | localhost | changed 2026-06-02 08:10:20.643535 | 2026-06-02 08:10:20.643728 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-02 08:10:20.668167 | localhost | ok 2026-06-02 08:10:20.671609 | 2026-06-02 08:10:20.671702 | TASK [Set zuul-log-path fact] 2026-06-02 08:10:20.706179 | localhost | ok 2026-06-02 08:10:20.714481 | 2026-06-02 08:10:20.714591 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-02 08:10:20.759520 | localhost | ok 2026-06-02 08:10:20.763556 | 2026-06-02 08:10:20.763654 | TASK [upload-logs : Create log directories] 2026-06-02 08:10:21.432810 | localhost | changed 2026-06-02 08:10:21.435347 | 2026-06-02 08:10:21.435441 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-02 08:10:22.014199 | localhost -> localhost | ok: Runtime: 0:00:00.010543 2026-06-02 08:10:22.017747 | 2026-06-02 08:10:22.017837 | TASK [upload-logs : Upload logs to log server] 2026-06-02 08:10:22.659588 | localhost | Output suppressed because no_log was given 2026-06-02 08:10:22.661212 | 2026-06-02 08:10:22.661308 | LOOP [upload-logs : Compress console log and json output] 2026-06-02 08:10:22.754209 | localhost | skipping: Conditional result was False 2026-06-02 08:10:22.772198 | localhost | skipping: Conditional result was False 2026-06-02 08:10:22.777542 | 2026-06-02 08:10:22.777651 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-02 08:10:22.880151 | localhost | skipping: Conditional result was False 2026-06-02 08:10:22.880405 | 2026-06-02 08:10:22.885032 | localhost | skipping: Conditional result was False 2026-06-02 08:10:22.892901 | 2026-06-02 08:10:22.892984 | LOOP [upload-logs : Upload console log and json output]