2026-06-02 15:47:45.658261 | Job console starting 2026-06-02 15:47:45.700497 | Updating git repos 2026-06-02 15:47:45.771685 | Cloning repos into workspace 2026-06-02 15:47:45.827002 | Restoring repo states 2026-06-02 15:47:45.841163 | Merging changes 2026-06-02 15:47:46.515000 | Checking out repos 2026-06-02 15:47:46.643029 | Preparing playbooks 2026-06-02 15:47:47.988375 | Running Ansible setup 2026-06-02 15:47:53.930912 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-02 15:47:55.128679 | 2026-06-02 15:47:55.128925 | PLAY [Base pre] 2026-06-02 15:47:55.205083 | 2026-06-02 15:47:55.205342 | TASK [Setup log path fact] 2026-06-02 15:47:55.237174 | debian-bookworm | ok 2026-06-02 15:47:55.256386 | 2026-06-02 15:47:55.256629 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-02 15:47:55.289650 | debian-bookworm | ok 2026-06-02 15:47:55.305306 | 2026-06-02 15:47:55.305549 | TASK [emit-job-header : Print job information] 2026-06-02 15:47:55.347646 | # Job Information 2026-06-02 15:47:55.347994 | Ansible Version: 2.16.14 2026-06-02 15:47:55.348035 | Job: tox 2026-06-02 15:47:55.348066 | Pipeline: check 2026-06-02 15:47:55.348089 | Executor: 521e9411259a 2026-06-02 15:47:55.348110 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1225 2026-06-02 15:47:55.348132 | Event ID: 5fcef810-5e9a-11f1-8289-b227367b4398 2026-06-02 15:47:55.358738 | 2026-06-02 15:47:55.358961 | LOOP [emit-job-header : Print node information] 2026-06-02 15:47:55.503724 | debian-bookworm | ok: 2026-06-02 15:47:55.503959 | debian-bookworm | # Node Information 2026-06-02 15:47:55.503995 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-02 15:47:55.504021 | debian-bookworm | Hostname: debian 2026-06-02 15:47:55.504044 | debian-bookworm | Username: zuul 2026-06-02 15:47:55.504066 | debian-bookworm | Distro: Debian 12.14 2026-06-02 15:47:55.504093 | debian-bookworm | Provider: regiocloud-a 2026-06-02 15:47:55.504115 | debian-bookworm | Region: 2026-06-02 15:47:55.504137 | debian-bookworm | Label: debian-bookworm 2026-06-02 15:47:55.504173 | debian-bookworm | Product Name: OpenStack Nova 2026-06-02 15:47:55.504194 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec1:3910 2026-06-02 15:47:55.518795 | 2026-06-02 15:47:55.519055 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-02 15:47:56.477660 | debian-bookworm -> localhost | changed 2026-06-02 15:47:56.485398 | 2026-06-02 15:47:56.485537 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-02 15:47:58.007401 | debian-bookworm -> localhost | changed 2026-06-02 15:47:58.022449 | 2026-06-02 15:47:58.022565 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-02 15:47:58.500294 | debian-bookworm -> localhost | ok 2026-06-02 15:47:58.506220 | 2026-06-02 15:47:58.506318 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-02 15:47:58.545835 | debian-bookworm | ok 2026-06-02 15:47:58.565922 | debian-bookworm | included: /var/lib/zuul/builds/580dcb8addf748b198d93f38919cca2b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-02 15:47:58.582862 | 2026-06-02 15:47:58.582971 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-02 15:48:00.150623 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-02 15:48:00.150816 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/580dcb8addf748b198d93f38919cca2b/work/580dcb8addf748b198d93f38919cca2b_id_rsa 2026-06-02 15:48:00.150870 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/580dcb8addf748b198d93f38919cca2b/work/580dcb8addf748b198d93f38919cca2b_id_rsa.pub 2026-06-02 15:48:00.150897 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-02 15:48:00.150921 | debian-bookworm -> localhost | SHA256:yn334DOgn+1Wptb4h/nOaYNPbWa8Cdr63ZZzB6u359A zuul-build-sshkey 2026-06-02 15:48:00.150944 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-02 15:48:00.150977 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-02 15:48:00.150999 | debian-bookworm -> localhost | | | 2026-06-02 15:48:00.151021 | debian-bookworm -> localhost | | | 2026-06-02 15:48:00.151042 | debian-bookworm -> localhost | | | 2026-06-02 15:48:00.151063 | debian-bookworm -> localhost | | | 2026-06-02 15:48:00.151084 | debian-bookworm -> localhost | | S | 2026-06-02 15:48:00.151107 | debian-bookworm -> localhost | | . o . +o.| 2026-06-02 15:48:00.151128 | debian-bookworm -> localhost | | o ....oBo*E| 2026-06-02 15:48:00.151185 | debian-bookworm -> localhost | | .. =X+X@@| 2026-06-02 15:48:00.151208 | debian-bookworm -> localhost | | .o*BO*#@| 2026-06-02 15:48:00.151228 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-02 15:48:00.151278 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.858196 2026-06-02 15:48:00.157280 | 2026-06-02 15:48:00.157374 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-02 15:48:00.208649 | debian-bookworm | ok 2026-06-02 15:48:00.217416 | debian-bookworm | included: /var/lib/zuul/builds/580dcb8addf748b198d93f38919cca2b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-02 15:48:00.236352 | 2026-06-02 15:48:00.236457 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-02 15:48:00.274322 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:48:00.280255 | 2026-06-02 15:48:00.280346 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-02 15:48:01.023043 | debian-bookworm | changed 2026-06-02 15:48:01.031025 | 2026-06-02 15:48:01.031142 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-02 15:48:01.325119 | debian-bookworm | ok 2026-06-02 15:48:01.335523 | 2026-06-02 15:48:01.335653 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-02 15:48:02.073323 | debian-bookworm | changed 2026-06-02 15:48:02.080346 | 2026-06-02 15:48:02.080444 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-02 15:48:02.762001 | debian-bookworm | changed 2026-06-02 15:48:02.768409 | 2026-06-02 15:48:02.768504 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-02 15:48:02.781833 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:48:02.787476 | 2026-06-02 15:48:02.787560 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-02 15:48:03.281758 | debian-bookworm -> localhost | changed 2026-06-02 15:48:03.296514 | 2026-06-02 15:48:03.296651 | TASK [add-build-sshkey : Add back temp key] 2026-06-02 15:48:03.764476 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/580dcb8addf748b198d93f38919cca2b/work/580dcb8addf748b198d93f38919cca2b_id_rsa (zuul-build-sshkey) 2026-06-02 15:48:03.764729 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009905 2026-06-02 15:48:03.772751 | 2026-06-02 15:48:03.772847 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-02 15:48:04.235289 | debian-bookworm | ok 2026-06-02 15:48:04.244423 | 2026-06-02 15:48:04.244562 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-02 15:48:04.268576 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:48:04.287839 | 2026-06-02 15:48:04.287981 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-02 15:48:04.728493 | debian-bookworm | ok 2026-06-02 15:48:04.750695 | 2026-06-02 15:48:04.750822 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-02 15:48:04.783995 | debian-bookworm | ok 2026-06-02 15:48:04.789065 | 2026-06-02 15:48:04.789187 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-02 15:48:05.247982 | debian-bookworm -> localhost | ok 2026-06-02 15:48:05.254888 | 2026-06-02 15:48:05.255005 | TASK [validate-host : Collect information about the host] 2026-06-02 15:48:06.507603 | debian-bookworm | ok 2026-06-02 15:48:06.529207 | 2026-06-02 15:48:06.529351 | TASK [validate-host : Sanitize hostname] 2026-06-02 15:48:06.692742 | debian-bookworm | ok 2026-06-02 15:48:06.740823 | 2026-06-02 15:48:06.740966 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-02 15:48:07.528978 | debian-bookworm -> localhost | changed 2026-06-02 15:48:07.535292 | 2026-06-02 15:48:07.535420 | TASK [validate-host : Collect information about zuul worker] 2026-06-02 15:48:08.021141 | debian-bookworm | ok 2026-06-02 15:48:08.026287 | 2026-06-02 15:48:08.026406 | TASK [validate-host : Write out all zuul information for each host] 2026-06-02 15:48:08.666591 | debian-bookworm -> localhost | changed 2026-06-02 15:48:08.676688 | 2026-06-02 15:48:08.676827 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-02 15:48:08.966283 | debian-bookworm | ok 2026-06-02 15:48:08.977294 | 2026-06-02 15:48:08.977409 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-02 15:48:10.154680 | debian-bookworm | changed: 2026-06-02 15:48:10.154917 | debian-bookworm | cd+++++++++ src/ 2026-06-02 15:48:10.154955 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-02 15:48:10.154980 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-02 15:48:10.155003 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-02 15:48:10.155024 | debian-bookworm | =7.0.3 2026-06-02 15:48:36.264222 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-06-02 15:48:36.308168 | debian-bookworm | Collecting colorama>=0.4.6 2026-06-02 15:48:36.321087 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-02 15:48:36.386029 | debian-bookworm | Collecting filelock>=3.25 2026-06-02 15:48:36.399102 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-06-02 15:48:36.474550 | debian-bookworm | Collecting packaging>=26 2026-06-02 15:48:36.487201 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-02 15:48:36.499209 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 11.2 MB/s eta 0:00:00 2026-06-02 15:48:36.552338 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-06-02 15:48:36.565079 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-06-02 15:48:36.608027 | debian-bookworm | Collecting pluggy>=1.6 2026-06-02 15:48:36.619916 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-02 15:48:36.684426 | debian-bookworm | Collecting pyproject-api>=1.10 2026-06-02 15:48:36.697135 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-06-02 15:48:36.737503 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-06-02 15:48:36.750134 | debian-bookworm | Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB) 2026-06-02 15:48:36.786446 | debian-bookworm | Collecting tomli-w>=1.2 2026-06-02 15:48:36.798622 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-06-02 15:48:36.947703 | debian-bookworm | Collecting virtualenv>=21.1 2026-06-02 15:48:36.960603 | debian-bookworm | Downloading virtualenv-21.4.2-py3-none-any.whl (7.6 MB) 2026-06-02 15:48:37.319823 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 21.5 MB/s eta 0:00:00 2026-06-02 15:48:37.429880 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-06-02 15:48:37.446478 | debian-bookworm | Downloading distlib-0.4.1-py2.py3-none-any.whl (469 kB) 2026-06-02 15:48:37.481033 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.2/469.2 kB 16.4 MB/s eta 0:00:00 2026-06-02 15:48:37.626937 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-06-02 15:48:38.425330 | 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-02 15:48:38.644181 | debian-bookworm | ok: Runtime: 0:00:03.227225 2026-06-02 15:48:38.659932 | 2026-06-02 15:48:38.660133 | TASK [ensure-tox : Export installed tox_executable path] 2026-06-02 15:48:38.693105 | debian-bookworm | ok 2026-06-02 15:48:38.702717 | 2026-06-02 15:48:38.702890 | TASK [ensure-tox : Output tox version] 2026-06-02 15:48:39.281256 | 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 15:48:39.306363 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-02 15:48:39.736194 | debian-bookworm | ok: Runtime: 0:00:00.378162 2026-06-02 15:48:39.753909 | 2026-06-02 15:48:39.754153 | TASK [ensure-tox : Make global symlink] 2026-06-02 15:48:39.783327 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:48:39.792849 | 2026-06-02 15:48:39.792985 | PLAY RECAP 2026-06-02 15:48:39.793058 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-06-02 15:48:39.793091 | 2026-06-02 15:48:39.997251 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-06-02 15:48:39.998350 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-02 15:48:40.763988 | 2026-06-02 15:48:40.764180 | PLAY [all] 2026-06-02 15:48:40.781635 | 2026-06-02 15:48:40.781786 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-06-02 15:48:41.422647 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-02 15:48:41.821572 | debian-bookworm | ok: Runtime: 0:00:00.031294 2026-06-02 15:48:41.829238 | 2026-06-02 15:48:41.829435 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-06-02 15:48:42.370597 | debian-bookworm | ok: Runtime: 0:00:00.007564 2026-06-02 15:48:42.379773 | 2026-06-02 15:48:42.379928 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-06-02 15:48:42.684307 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-02 15:48:42.686966 | debian-bookworm | sudo: a password is required 2026-06-02 15:48:42.909992 | debian-bookworm | ok: Runtime: 0:00:00.023772 2026-06-02 15:48:42.930205 | 2026-06-02 15:48:42.930357 | TASK [tox : Check to see if the constraints file exists] 2026-06-02 15:48:42.965641 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:48:42.972404 | 2026-06-02 15:48:42.972527 | TASK [tox : Fail if constraints file is missing] 2026-06-02 15:48:43.027034 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:48:43.041836 | 2026-06-02 15:48:43.042019 | TASK [tox : Record file location] 2026-06-02 15:48:43.084607 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:48:43.091383 | 2026-06-02 15:48:43.091522 | TASK [tox : Install tox siblings] 2026-06-02 15:48:43.123470 | debian-bookworm | ok 2026-06-02 15:48:43.132815 | debian-bookworm | included: /var/lib/zuul/builds/580dcb8addf748b198d93f38919cca2b/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-06-02 15:48:43.138664 | 2026-06-02 15:48:43.138779 | TASK [tox : Run tox without tests] 2026-06-02 15:48:44.570458 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-06-02 15:48:58.209735 | debian-bookworm | test: OK (14.46 seconds) 2026-06-02 15:48:58.209806 | debian-bookworm | congratulations :) (14.49 seconds) 2026-06-02 15:48:58.683571 | debian-bookworm | ok: Runtime: 0:00:14.828855 2026-06-02 15:48:58.692773 | 2026-06-02 15:48:58.692931 | TASK [tox : Create a tempfile to save tox showconfig] 2026-06-02 15:48:59.139052 | debian-bookworm | changed 2026-06-02 15:48:59.144973 | 2026-06-02 15:48:59.145105 | TASK [tox : Detect tox version] 2026-06-02 15:48:59.709576 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-02 15:49:00.176100 | debian-bookworm | ok: Runtime: 0:00:00.322777 2026-06-02 15:49:00.192666 | 2026-06-02 15:49:00.193001 | TASK [tox : Get tox envlist config] 2026-06-02 15:49:01.232143 | debian-bookworm | ok: Runtime: 0:00:00.372729 2026-06-02 15:49:01.247343 | 2026-06-02 15:49:01.247550 | TASK [tox : Install any sibling python packages] 2026-06-02 15:49:01.724995 | debian-bookworm | ok: No setup.cfg, no action needed 2026-06-02 15:49:01.732491 | 2026-06-02 15:49:01.732616 | TASK [tox : Remove tempfile] 2026-06-02 15:49:02.291333 | debian-bookworm | changed 2026-06-02 15:49:02.296919 | 2026-06-02 15:49:02.297026 | TASK [tox : Emit tox command] 2026-06-02 15:49:02.354985 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-06-02 15:49:02.363927 | 2026-06-02 15:49:02.364101 | TASK [tox : Run tox] 2026-06-02 15:49:03.002543 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-06-02 15:49:03.784899 | debian-bookworm | ............... 2026-06-02 15:49:03.784965 | debian-bookworm | ---------------------------------------------------------------------- 2026-06-02 15:49:03.784979 | debian-bookworm | Ran 15 tests in 0.172s 2026-06-02 15:49:03.784985 | debian-bookworm | 2026-06-02 15:49:03.784993 | debian-bookworm | OK 2026-06-02 15:49:03.931691 | debian-bookworm | test: OK (0.98=setup[0.05]+cmd[0.93] seconds) 2026-06-02 15:49:03.931781 | debian-bookworm | congratulations :) (1.01 seconds) 2026-06-02 15:49:04.400560 | debian-bookworm | ok: Runtime: 0:00:01.333522 2026-06-02 15:49:04.414992 | 2026-06-02 15:49:04.415225 | TASK [tox : Look for output] 2026-06-02 15:49:04.864160 | debian-bookworm | ok 2026-06-02 15:49:04.878097 | 2026-06-02 15:49:04.878274 | TASK [tox : Return file comments to Zuul] 2026-06-02 15:49:04.912616 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:04.920366 | 2026-06-02 15:49:04.920474 | PLAY RECAP 2026-06-02 15:49:04.920535 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-06-02 15:49:04.920563 | 2026-06-02 15:49:05.053051 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-02 15:49:05.055821 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-02 15:49:05.853356 | 2026-06-02 15:49:05.853514 | PLAY [all] 2026-06-02 15:49:05.869027 | 2026-06-02 15:49:05.869208 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-06-02 15:49:05.927484 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:05.933899 | 2026-06-02 15:49:05.934051 | TASK [fetch-tox-output : Set tox log path for single node] 2026-06-02 15:49:05.978059 | debian-bookworm | ok 2026-06-02 15:49:05.985056 | 2026-06-02 15:49:05.985226 | TASK [fetch-tox-output : Ensure local tox dir] 2026-06-02 15:49:06.569246 | debian-bookworm -> localhost | changed 2026-06-02 15:49:06.584191 | 2026-06-02 15:49:06.584378 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-06-02 15:49:06.650702 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:06.660312 | 2026-06-02 15:49:06.660614 | TASK [fetch-tox-output : Set envlist fact] 2026-06-02 15:49:06.708773 | debian-bookworm | ok 2026-06-02 15:49:06.718496 | 2026-06-02 15:49:06.718664 | TASK [fetch-tox-output : Get tox version] 2026-06-02 15:49:07.472149 | 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 15:49:07.490188 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-02 15:49:07.753591 | debian-bookworm | ok: Runtime: 0:00:00.329079 2026-06-02 15:49:07.766058 | 2026-06-02 15:49:07.766299 | TASK [fetch-tox-output : Find all default environments] 2026-06-02 15:49:08.299882 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:08.310294 | 2026-06-02 15:49:08.310505 | TASK [fetch-tox-output : Set envlist fact] 2026-06-02 15:49:08.346683 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:08.362440 | 2026-06-02 15:49:08.362645 | TASK [fetch-tox-output : Find all default environments] 2026-06-02 15:49:08.897796 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:08.912021 | 2026-06-02 15:49:08.912215 | TASK [fetch-tox-output : Set envlist fact] 2026-06-02 15:49:08.947581 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:08.956151 | 2026-06-02 15:49:08.956508 | LOOP [fetch-tox-output : Copy tox logs] 2026-06-02 15:49:09.010151 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:09.025386 | 2026-06-02 15:49:09.025660 | LOOP [fetch-tox-output : Collect tox logs] 2026-06-02 15:49:09.898145 | debian-bookworm | changed: 2026-06-02 15:49:09.898442 | debian-bookworm | created directory /var/lib/zuul/builds/580dcb8addf748b198d93f38919cca2b/work/logs/tox/test 2026-06-02 15:49:09.898478 | debian-bookworm | cd+++++++++ ./ 2026-06-02 15:49:09.898503 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-06-02 15:49:09.898535 | 2026-06-02 15:49:09.920685 | 2026-06-02 15:49:09.920854 | PLAY RECAP 2026-06-02 15:49:09.920945 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-06-02 15:49:09.920987 | 2026-06-02 15:49:10.068107 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-02 15:49:10.069400 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-02 15:49:10.876345 | 2026-06-02 15:49:10.876538 | PLAY [all] 2026-06-02 15:49:10.892954 | 2026-06-02 15:49:10.893118 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-02 15:49:11.137650 | debian-bookworm | changed: non-zero return code 2026-06-02 15:49:11.144601 | 2026-06-02 15:49:11.144755 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-02 15:49:11.169626 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:11.177369 | 2026-06-02 15:49:11.177523 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-02 15:49:11.219210 | 2026-06-02 15:49:11.219502 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-02 15:49:11.268662 | 2026-06-02 15:49:11.268893 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-02 15:49:11.293324 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:11.299872 | 2026-06-02 15:49:11.300003 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-02 15:49:11.330927 | 2026-06-02 15:49:11.331212 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-02 15:49:11.355977 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:11.370347 | 2026-06-02 15:49:11.370553 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-02 15:49:11.395158 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:11.402488 | 2026-06-02 15:49:11.402613 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-02 15:49:11.426129 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:11.433944 | 2026-06-02 15:49:11.434032 | PLAY RECAP 2026-06-02 15:49:11.434088 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-02 15:49:11.434114 | 2026-06-02 15:49:11.575685 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-02 15:49:11.576805 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-02 15:49:12.348596 | 2026-06-02 15:49:12.348890 | PLAY [Base post-fetch] 2026-06-02 15:49:12.366561 | 2026-06-02 15:49:12.366770 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-02 15:49:12.423686 | debian-bookworm | skipping: Conditional result was False 2026-06-02 15:49:12.436794 | 2026-06-02 15:49:12.437074 | TASK [fetch-output : Set log path for single node] 2026-06-02 15:49:12.495378 | debian-bookworm | ok 2026-06-02 15:49:12.504152 | 2026-06-02 15:49:12.504369 | LOOP [fetch-output : Ensure local output dirs] 2026-06-02 15:49:12.994129 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/580dcb8addf748b198d93f38919cca2b/work/logs" 2026-06-02 15:49:13.257319 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/580dcb8addf748b198d93f38919cca2b/work/artifacts" 2026-06-02 15:49:13.517198 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/580dcb8addf748b198d93f38919cca2b/work/docs" 2026-06-02 15:49:13.540891 | 2026-06-02 15:49:13.541110 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-02 15:49:14.327260 | debian-bookworm | changed: 2026-06-02 15:49:14.327550 | debian-bookworm | .d..t...... ./ 2026-06-02 15:49:14.327589 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-02 15:49:14.327619 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-02 15:49:14.327646 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-02 15:49:14.327690 | debian-bookworm | changed: All items complete 2026-06-02 15:49:14.327718 | 2026-06-02 15:49:14.964948 | debian-bookworm | changed: .d..t...... ./ 2026-06-02 15:49:15.540321 | debian-bookworm | changed: .d..t...... ./ 2026-06-02 15:49:15.557567 | 2026-06-02 15:49:15.557694 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-02 15:49:16.127791 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006386 2026-06-02 15:49:16.513690 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011035 2026-06-02 15:49:16.527768 | 2026-06-02 15:49:16.527887 | PLAY RECAP 2026-06-02 15:49:16.527951 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-02 15:49:16.527982 | 2026-06-02 15:49:16.675554 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-02 15:49:16.678206 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-02 15:49:17.418984 | 2026-06-02 15:49:17.419153 | PLAY [Base post] 2026-06-02 15:49:17.432816 | 2026-06-02 15:49:17.432952 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-02 15:49:18.014276 | debian-bookworm | changed 2026-06-02 15:49:18.024307 | 2026-06-02 15:49:18.024460 | PLAY RECAP 2026-06-02 15:49:18.024567 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-02 15:49:18.024665 | 2026-06-02 15:49:18.141884 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-02 15:49:18.143044 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-02 15:49:18.929928 | 2026-06-02 15:49:18.930099 | PLAY [Base post-logs] 2026-06-02 15:49:18.940899 | 2026-06-02 15:49:18.941037 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-02 15:49:19.373721 | localhost | changed 2026-06-02 15:49:19.385377 | 2026-06-02 15:49:19.385534 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-02 15:49:19.421795 | localhost | ok 2026-06-02 15:49:19.426509 | 2026-06-02 15:49:19.426639 | TASK [Set zuul-log-path fact] 2026-06-02 15:49:19.442795 | localhost | ok 2026-06-02 15:49:19.454060 | 2026-06-02 15:49:19.454197 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-02 15:49:19.491134 | localhost | ok 2026-06-02 15:49:19.496654 | 2026-06-02 15:49:19.496808 | TASK [upload-logs : Create log directories] 2026-06-02 15:49:20.060790 | localhost | changed 2026-06-02 15:49:20.066412 | 2026-06-02 15:49:20.066569 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-02 15:49:20.579365 | localhost -> localhost | ok: Runtime: 0:00:00.007162 2026-06-02 15:49:20.583552 | 2026-06-02 15:49:20.583677 | TASK [upload-logs : Upload logs to log server] 2026-06-02 15:49:21.214358 | localhost | Output suppressed because no_log was given 2026-06-02 15:49:21.218490 | 2026-06-02 15:49:21.218678 | LOOP [upload-logs : Compress console log and json output] 2026-06-02 15:49:21.275335 | localhost | skipping: Conditional result was False 2026-06-02 15:49:21.280654 | localhost | skipping: Conditional result was False 2026-06-02 15:49:21.293001 | 2026-06-02 15:49:21.293224 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-02 15:49:21.357404 | localhost | skipping: Conditional result was False 2026-06-02 15:49:21.357889 | 2026-06-02 15:49:21.365228 | localhost | skipping: Conditional result was False 2026-06-02 15:49:21.376425 | 2026-06-02 15:49:21.376661 | LOOP [upload-logs : Upload console log and json output]