2026-05-23 03:16:24.237948 | Job console starting 2026-05-23 03:16:24.250877 | Updating git repos 2026-05-23 03:16:24.300119 | Cloning repos into workspace 2026-05-23 03:16:24.427490 | Restoring repo states 2026-05-23 03:16:24.459146 | Merging changes 2026-05-23 03:16:24.459169 | Checking out repos 2026-05-23 03:16:24.545567 | Preparing playbooks 2026-05-23 03:16:26.025625 | Running Ansible setup 2026-05-23 03:16:31.197251 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-23 03:16:32.321718 | 2026-05-23 03:16:32.321846 | PLAY [Base pre] 2026-05-23 03:16:32.339318 | 2026-05-23 03:16:32.339442 | TASK [Setup log path fact] 2026-05-23 03:16:32.357666 | debian-bookworm | ok 2026-05-23 03:16:32.373781 | 2026-05-23 03:16:32.373907 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-23 03:16:32.403731 | debian-bookworm | ok 2026-05-23 03:16:32.418563 | 2026-05-23 03:16:32.418864 | TASK [emit-job-header : Print job information] 2026-05-23 03:16:32.468515 | # Job Information 2026-05-23 03:16:32.468681 | Ansible Version: 2.16.14 2026-05-23 03:16:32.468718 | Job: tox 2026-05-23 03:16:32.468753 | Pipeline: periodic-daily 2026-05-23 03:16:32.468777 | Executor: 521e9411259a 2026-05-23 03:16:32.468799 | Triggered by: https://github.com/osism/openstack-image-manager 2026-05-23 03:16:32.468821 | Event ID: 244611051051496ebd9fb1431396ca7b 2026-05-23 03:16:32.474434 | 2026-05-23 03:16:32.474528 | LOOP [emit-job-header : Print node information] 2026-05-23 03:16:32.699085 | debian-bookworm | ok: 2026-05-23 03:16:32.699333 | debian-bookworm | # Node Information 2026-05-23 03:16:32.699375 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-23 03:16:32.699401 | debian-bookworm | Hostname: debian 2026-05-23 03:16:32.699424 | debian-bookworm | Username: zuul 2026-05-23 03:16:32.699444 | debian-bookworm | Distro: Debian 12.14 2026-05-23 03:16:32.699469 | debian-bookworm | Provider: regiocloud-a 2026-05-23 03:16:32.699490 | debian-bookworm | Region: 2026-05-23 03:16:32.699512 | debian-bookworm | Label: debian-bookworm 2026-05-23 03:16:32.699531 | debian-bookworm | Product Name: OpenStack Nova 2026-05-23 03:16:32.699550 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee5:2b04 2026-05-23 03:16:32.719292 | 2026-05-23 03:16:32.719397 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-23 03:16:33.393408 | debian-bookworm -> localhost | changed 2026-05-23 03:16:33.400196 | 2026-05-23 03:16:33.400300 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-23 03:16:34.476703 | debian-bookworm -> localhost | changed 2026-05-23 03:16:34.487485 | 2026-05-23 03:16:34.487585 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-23 03:16:34.753420 | debian-bookworm -> localhost | ok 2026-05-23 03:16:34.759679 | 2026-05-23 03:16:34.759776 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-23 03:16:34.789977 | debian-bookworm | ok 2026-05-23 03:16:34.808120 | debian-bookworm | included: /var/lib/zuul/builds/5a2d81b098fa441da20090bb50fd1fd1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-23 03:16:34.821827 | 2026-05-23 03:16:34.821926 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-23 03:16:35.769477 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-23 03:16:35.769737 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5a2d81b098fa441da20090bb50fd1fd1/work/5a2d81b098fa441da20090bb50fd1fd1_id_rsa 2026-05-23 03:16:35.769785 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5a2d81b098fa441da20090bb50fd1fd1/work/5a2d81b098fa441da20090bb50fd1fd1_id_rsa.pub 2026-05-23 03:16:35.769819 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-23 03:16:35.769849 | debian-bookworm -> localhost | SHA256:bq9jL26/S0v3IW8Rp3uCbOtN0ryi8tiM+N60MaWucOE zuul-build-sshkey 2026-05-23 03:16:35.769876 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-23 03:16:35.769916 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-23 03:16:35.769944 | debian-bookworm -> localhost | | | 2026-05-23 03:16:35.769970 | debian-bookworm -> localhost | | | 2026-05-23 03:16:35.769996 | debian-bookworm -> localhost | | | 2026-05-23 03:16:35.770020 | debian-bookworm -> localhost | | . .| 2026-05-23 03:16:35.770045 | debian-bookworm -> localhost | | S . + | 2026-05-23 03:16:35.770078 | debian-bookworm -> localhost | | o . o oo | 2026-05-23 03:16:35.770103 | debian-bookworm -> localhost | | . E B.+.=o | 2026-05-23 03:16:35.770129 | debian-bookworm -> localhost | | =*% *=B+o.| 2026-05-23 03:16:35.770448 | debian-bookworm -> localhost | | .*OX/*o+=o | 2026-05-23 03:16:35.770492 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-23 03:16:35.770565 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.420328 2026-05-23 03:16:35.778963 | 2026-05-23 03:16:35.779057 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-23 03:16:35.810505 | debian-bookworm | ok 2026-05-23 03:16:35.822475 | debian-bookworm | included: /var/lib/zuul/builds/5a2d81b098fa441da20090bb50fd1fd1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-23 03:16:35.832800 | 2026-05-23 03:16:35.832886 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-23 03:16:35.856369 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:16:35.862341 | 2026-05-23 03:16:35.862473 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-23 03:16:36.497518 | debian-bookworm | changed 2026-05-23 03:16:36.503045 | 2026-05-23 03:16:36.503141 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-23 03:16:36.753237 | debian-bookworm | ok 2026-05-23 03:16:36.774233 | 2026-05-23 03:16:36.774345 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-23 03:16:37.494157 | debian-bookworm | changed 2026-05-23 03:16:37.500706 | 2026-05-23 03:16:37.500800 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-23 03:16:38.134595 | debian-bookworm | changed 2026-05-23 03:16:38.141996 | 2026-05-23 03:16:38.142117 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-23 03:16:38.165869 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:16:38.172322 | 2026-05-23 03:16:38.172452 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-23 03:16:38.719507 | debian-bookworm -> localhost | changed 2026-05-23 03:16:38.731554 | 2026-05-23 03:16:38.731734 | TASK [add-build-sshkey : Add back temp key] 2026-05-23 03:16:39.079701 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5a2d81b098fa441da20090bb50fd1fd1/work/5a2d81b098fa441da20090bb50fd1fd1_id_rsa (zuul-build-sshkey) 2026-05-23 03:16:39.079965 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011341 2026-05-23 03:16:39.088403 | 2026-05-23 03:16:39.088533 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-23 03:16:39.526285 | debian-bookworm | ok 2026-05-23 03:16:39.533931 | 2026-05-23 03:16:39.534076 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-23 03:16:39.571947 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:16:39.585579 | 2026-05-23 03:16:39.585731 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-23 03:16:40.081620 | debian-bookworm | ok 2026-05-23 03:16:40.099064 | 2026-05-23 03:16:40.099217 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-23 03:16:40.139018 | debian-bookworm | ok 2026-05-23 03:16:40.144293 | 2026-05-23 03:16:40.144404 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-23 03:16:40.502540 | debian-bookworm -> localhost | ok 2026-05-23 03:16:40.509519 | 2026-05-23 03:16:40.509633 | TASK [validate-host : Collect information about the host] 2026-05-23 03:16:41.776319 | debian-bookworm | ok 2026-05-23 03:16:41.788871 | 2026-05-23 03:16:41.789012 | TASK [validate-host : Sanitize hostname] 2026-05-23 03:16:41.907766 | debian-bookworm | ok 2026-05-23 03:16:41.968717 | 2026-05-23 03:16:41.968875 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-23 03:16:42.571940 | debian-bookworm -> localhost | changed 2026-05-23 03:16:42.579477 | 2026-05-23 03:16:42.579625 | TASK [validate-host : Collect information about zuul worker] 2026-05-23 03:16:43.064920 | debian-bookworm | ok 2026-05-23 03:16:43.072785 | 2026-05-23 03:16:43.072923 | TASK [validate-host : Write out all zuul information for each host] 2026-05-23 03:16:44.059128 | debian-bookworm -> localhost | changed 2026-05-23 03:16:44.091383 | 2026-05-23 03:16:44.091520 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-23 03:16:44.402293 | debian-bookworm | ok 2026-05-23 03:16:44.412893 | 2026-05-23 03:16:44.413050 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-23 03:16:45.697641 | debian-bookworm | changed: 2026-05-23 03:16:45.697909 | debian-bookworm | cd+++++++++ src/ 2026-05-23 03:16:45.697947 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-23 03:16:45.697972 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-23 03:16:45.697994 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-23 03:16:45.698014 | debian-bookworm | =7.0.3 2026-05-23 03:17:11.625769 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-05-23 03:17:11.689499 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-23 03:17:11.702379 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-23 03:17:11.769774 | debian-bookworm | Collecting filelock>=3.25 2026-05-23 03:17:11.781528 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-23 03:17:11.842347 | debian-bookworm | Collecting packaging>=26 2026-05-23 03:17:11.853789 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-23 03:17:11.869550 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 9.2 MB/s eta 0:00:00 2026-05-23 03:17:11.935527 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-23 03:17:11.947006 | debian-bookworm | Downloading platformdirs-4.9.6-py3-none-any.whl (21 kB) 2026-05-23 03:17:11.987433 | debian-bookworm | Collecting pluggy>=1.6 2026-05-23 03:17:11.998510 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-23 03:17:12.037623 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-23 03:17:12.049845 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-23 03:17:12.083730 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-23 03:17:12.094857 | debian-bookworm | Downloading python_discovery-1.3.1-py3-none-any.whl (33 kB) 2026-05-23 03:17:12.130182 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-23 03:17:12.141924 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-23 03:17:12.280795 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-23 03:17:12.294404 | debian-bookworm | Downloading virtualenv-21.3.3-py3-none-any.whl (7.6 MB) 2026-05-23 03:17:12.645653 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 22.0 MB/s eta 0:00:00 2026-05-23 03:17:12.760327 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-23 03:17:12.772009 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-23 03:17:12.799489 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.2 MB/s eta 0:00:00 2026-05-23 03:17:12.926128 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-23 03:17:13.810505 | 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-23 03:17:14.380834 | debian-bookworm | ok: Runtime: 0:00:03.248621 2026-05-23 03:17:14.385644 | 2026-05-23 03:17:14.385745 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-23 03:17:14.423659 | debian-bookworm | ok 2026-05-23 03:17:14.427552 | 2026-05-23 03:17:14.427635 | TASK [ensure-tox : Output tox version] 2026-05-23 03:17:15.013617 | 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-23 03:17:15.031326 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-23 03:17:15.455371 | debian-bookworm | ok: Runtime: 0:00:00.341355 2026-05-23 03:17:15.462386 | 2026-05-23 03:17:15.462700 | TASK [ensure-tox : Make global symlink] 2026-05-23 03:17:15.517206 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:15.527106 | 2026-05-23 03:17:15.527212 | PLAY RECAP 2026-05-23 03:17:15.527367 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-23 03:17:15.527394 | 2026-05-23 03:17:15.793689 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-23 03:17:15.794520 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-23 03:17:17.000997 | 2026-05-23 03:17:17.001110 | PLAY [all] 2026-05-23 03:17:17.014118 | 2026-05-23 03:17:17.014222 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-23 03:17:17.437641 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-23 03:17:17.540093 | debian-bookworm | ok: Runtime: 0:00:00.028190 2026-05-23 03:17:17.544735 | 2026-05-23 03:17:17.544822 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-23 03:17:18.087103 | debian-bookworm | ok: Runtime: 0:00:00.007100 2026-05-23 03:17:18.099272 | 2026-05-23 03:17:18.099367 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-23 03:17:18.425284 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-23 03:17:18.427015 | debian-bookworm | sudo: a password is required 2026-05-23 03:17:18.652576 | debian-bookworm | ok: Runtime: 0:00:00.019076 2026-05-23 03:17:18.669813 | 2026-05-23 03:17:18.669894 | TASK [tox : Check to see if the constraints file exists] 2026-05-23 03:17:18.713412 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:18.725940 | 2026-05-23 03:17:18.726044 | TASK [tox : Fail if constraints file is missing] 2026-05-23 03:17:18.781549 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:18.786701 | 2026-05-23 03:17:18.786803 | TASK [tox : Record file location] 2026-05-23 03:17:18.833521 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:18.838235 | 2026-05-23 03:17:18.838330 | TASK [tox : Install tox siblings] 2026-05-23 03:17:18.866630 | debian-bookworm | ok 2026-05-23 03:17:18.876901 | debian-bookworm | included: /var/lib/zuul/builds/5a2d81b098fa441da20090bb50fd1fd1/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-23 03:17:18.888267 | 2026-05-23 03:17:18.888357 | TASK [tox : Run tox without tests] 2026-05-23 03:17:20.425619 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-05-23 03:17:34.301991 | debian-bookworm | test: OK (14.75 seconds) 2026-05-23 03:17:34.302125 | debian-bookworm | congratulations :) (14.77 seconds) 2026-05-23 03:17:34.463047 | debian-bookworm | ok: Runtime: 0:00:15.081461 2026-05-23 03:17:34.469150 | 2026-05-23 03:17:34.469259 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-23 03:17:34.961952 | debian-bookworm | changed 2026-05-23 03:17:34.967252 | 2026-05-23 03:17:34.967356 | TASK [tox : Detect tox version] 2026-05-23 03:17:35.525127 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-23 03:17:36.001199 | debian-bookworm | ok: Runtime: 0:00:00.318964 2026-05-23 03:17:36.010938 | 2026-05-23 03:17:36.011093 | TASK [tox : Get tox envlist config] 2026-05-23 03:17:37.055549 | debian-bookworm | ok: Runtime: 0:00:00.373508 2026-05-23 03:17:37.062615 | 2026-05-23 03:17:37.062935 | TASK [tox : Install any sibling python packages] 2026-05-23 03:17:37.593345 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-23 03:17:37.599650 | 2026-05-23 03:17:37.599782 | TASK [tox : Remove tempfile] 2026-05-23 03:17:38.152197 | debian-bookworm | changed 2026-05-23 03:17:38.158184 | 2026-05-23 03:17:38.158308 | TASK [tox : Emit tox command] 2026-05-23 03:17:38.198576 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-05-23 03:17:38.205937 | 2026-05-23 03:17:38.206066 | TASK [tox : Run tox] 2026-05-23 03:17:38.816868 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-05-23 03:17:39.624484 | debian-bookworm | ............... 2026-05-23 03:17:39.624587 | debian-bookworm | ---------------------------------------------------------------------- 2026-05-23 03:17:39.624616 | debian-bookworm | Ran 15 tests in 0.180s 2026-05-23 03:17:39.624630 | debian-bookworm | 2026-05-23 03:17:39.624649 | debian-bookworm | OK 2026-05-23 03:17:39.724637 | debian-bookworm | test: OK (0.95=setup[0.05]+cmd[0.91] seconds) 2026-05-23 03:17:39.724761 | debian-bookworm | congratulations :) (0.98 seconds) 2026-05-23 03:17:40.239361 | debian-bookworm | ok: Runtime: 0:00:01.285400 2026-05-23 03:17:40.246654 | 2026-05-23 03:17:40.246797 | TASK [tox : Look for output] 2026-05-23 03:17:40.786003 | debian-bookworm | ok 2026-05-23 03:17:40.865463 | 2026-05-23 03:17:40.865624 | TASK [tox : Return file comments to Zuul] 2026-05-23 03:17:40.981955 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:40.989863 | 2026-05-23 03:17:40.989976 | PLAY RECAP 2026-05-23 03:17:40.990034 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-23 03:17:40.990058 | 2026-05-23 03:17:41.516706 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-23 03:17:41.517960 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-23 03:17:43.062566 | 2026-05-23 03:17:43.062748 | PLAY [all] 2026-05-23 03:17:43.102974 | 2026-05-23 03:17:43.103130 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-23 03:17:43.202439 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:43.207681 | 2026-05-23 03:17:43.207803 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-23 03:17:43.264789 | debian-bookworm | ok 2026-05-23 03:17:43.269922 | 2026-05-23 03:17:43.270018 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-23 03:17:43.869139 | debian-bookworm -> localhost | changed 2026-05-23 03:17:43.875486 | 2026-05-23 03:17:43.875575 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-23 03:17:43.908458 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:43.913094 | 2026-05-23 03:17:43.913185 | TASK [fetch-tox-output : Set envlist fact] 2026-05-23 03:17:43.940104 | debian-bookworm | ok 2026-05-23 03:17:43.944780 | 2026-05-23 03:17:43.944855 | TASK [fetch-tox-output : Get tox version] 2026-05-23 03:17:44.630157 | 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-23 03:17:44.647804 | debian-bookworm | 4.54.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-23 03:17:44.970234 | debian-bookworm | ok: Runtime: 0:00:00.343562 2026-05-23 03:17:44.975810 | 2026-05-23 03:17:44.975941 | TASK [fetch-tox-output : Find all default environments] 2026-05-23 03:17:45.504404 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:45.511336 | 2026-05-23 03:17:45.511467 | TASK [fetch-tox-output : Set envlist fact] 2026-05-23 03:17:45.556504 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:45.566255 | 2026-05-23 03:17:45.566423 | TASK [fetch-tox-output : Find all default environments] 2026-05-23 03:17:46.099060 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:46.116479 | 2026-05-23 03:17:46.116682 | TASK [fetch-tox-output : Set envlist fact] 2026-05-23 03:17:46.145476 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:46.153592 | 2026-05-23 03:17:46.153838 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-23 03:17:46.213590 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:46.227051 | 2026-05-23 03:17:46.227263 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-23 03:17:47.155118 | debian-bookworm | changed: 2026-05-23 03:17:47.155287 | debian-bookworm | created directory /var/lib/zuul/builds/5a2d81b098fa441da20090bb50fd1fd1/work/logs/tox/test 2026-05-23 03:17:47.155322 | debian-bookworm | cd+++++++++ ./ 2026-05-23 03:17:47.155347 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-23 03:17:47.155374 | 2026-05-23 03:17:47.166512 | 2026-05-23 03:17:47.167053 | PLAY RECAP 2026-05-23 03:17:47.167491 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-23 03:17:47.167946 | 2026-05-23 03:17:47.353628 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-23 03:17:47.358092 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-23 03:17:48.690625 | 2026-05-23 03:17:48.690822 | PLAY [all] 2026-05-23 03:17:48.724987 | 2026-05-23 03:17:48.725127 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-23 03:17:49.100985 | debian-bookworm | changed: non-zero return code 2026-05-23 03:17:49.115481 | 2026-05-23 03:17:49.115640 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-23 03:17:49.192538 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:49.201258 | 2026-05-23 03:17:49.201505 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-23 03:17:49.298398 | 2026-05-23 03:17:49.298683 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-23 03:17:49.387635 | 2026-05-23 03:17:49.387910 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-23 03:17:49.469510 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:49.479102 | 2026-05-23 03:17:49.479248 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-23 03:17:49.556503 | 2026-05-23 03:17:49.557129 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-23 03:17:49.636406 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:49.645880 | 2026-05-23 03:17:49.646018 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-23 03:17:49.723014 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:49.731364 | 2026-05-23 03:17:49.732297 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-23 03:17:49.815897 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:49.825965 | 2026-05-23 03:17:49.826068 | PLAY RECAP 2026-05-23 03:17:49.826123 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-23 03:17:49.826150 | 2026-05-23 03:17:50.077058 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-23 03:17:50.078401 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-23 03:17:51.346341 | 2026-05-23 03:17:51.346506 | PLAY [Base post-fetch] 2026-05-23 03:17:51.380290 | 2026-05-23 03:17:51.380454 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-23 03:17:51.447073 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:51.453390 | 2026-05-23 03:17:51.453533 | TASK [fetch-output : Set log path for single node] 2026-05-23 03:17:51.486292 | debian-bookworm | ok 2026-05-23 03:17:51.503311 | 2026-05-23 03:17:51.503527 | LOOP [fetch-output : Ensure local output dirs] 2026-05-23 03:17:52.229826 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/5a2d81b098fa441da20090bb50fd1fd1/work/logs" 2026-05-23 03:17:52.723612 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5a2d81b098fa441da20090bb50fd1fd1/work/artifacts" 2026-05-23 03:17:53.259307 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5a2d81b098fa441da20090bb50fd1fd1/work/docs" 2026-05-23 03:17:53.272905 | 2026-05-23 03:17:53.273051 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-23 03:17:54.148347 | debian-bookworm | changed: 2026-05-23 03:17:54.148588 | debian-bookworm | .d..t...... ./ 2026-05-23 03:17:54.148628 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-23 03:17:54.148667 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-23 03:17:54.148710 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-23 03:17:54.148749 | debian-bookworm | changed: All items complete 2026-05-23 03:17:54.148774 | 2026-05-23 03:17:54.677118 | debian-bookworm | changed: .d..t...... ./ 2026-05-23 03:17:55.354345 | debian-bookworm | changed: .d..t...... ./ 2026-05-23 03:17:55.374545 | 2026-05-23 03:17:55.374679 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-23 03:17:55.401663 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:55.406595 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:17:55.420678 | 2026-05-23 03:17:55.420789 | PLAY RECAP 2026-05-23 03:17:55.420851 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-23 03:17:55.420877 | 2026-05-23 03:17:55.588434 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-23 03:17:55.589461 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-23 03:17:56.333526 | 2026-05-23 03:17:56.333645 | PLAY [Base post] 2026-05-23 03:17:56.350644 | 2026-05-23 03:17:56.350805 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-23 03:17:56.934085 | debian-bookworm | changed 2026-05-23 03:17:56.951229 | 2026-05-23 03:17:56.951354 | PLAY RECAP 2026-05-23 03:17:56.951431 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-23 03:17:56.951509 | 2026-05-23 03:17:57.107926 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-23 03:17:57.108994 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-23 03:17:58.190379 | 2026-05-23 03:17:58.190886 | PLAY [Base post-logs] 2026-05-23 03:17:58.228065 | 2026-05-23 03:17:58.228236 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-23 03:17:58.831874 | localhost | changed 2026-05-23 03:17:58.851446 | 2026-05-23 03:17:58.851617 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-23 03:17:58.907885 | localhost | ok 2026-05-23 03:17:58.911898 | 2026-05-23 03:17:58.911994 | TASK [Set zuul-log-path fact] 2026-05-23 03:17:58.927301 | localhost | ok 2026-05-23 03:17:58.935152 | 2026-05-23 03:17:58.935247 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-23 03:17:58.984125 | localhost | ok 2026-05-23 03:17:58.987270 | 2026-05-23 03:17:58.987369 | TASK [upload-logs : Create log directories] 2026-05-23 03:17:59.782260 | localhost | changed 2026-05-23 03:17:59.785433 | 2026-05-23 03:17:59.785533 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-23 03:18:00.356924 | localhost -> localhost | ok: Runtime: 0:00:00.008010 2026-05-23 03:18:00.361104 | 2026-05-23 03:18:00.361218 | TASK [upload-logs : Upload logs to log server] 2026-05-23 03:18:00.908777 | localhost | Output suppressed because no_log was given 2026-05-23 03:18:00.910364 | 2026-05-23 03:18:00.910450 | LOOP [upload-logs : Compress console log and json output] 2026-05-23 03:18:00.960296 | localhost | skipping: Conditional result was False 2026-05-23 03:18:00.962912 | localhost | skipping: Conditional result was False 2026-05-23 03:18:00.974530 | 2026-05-23 03:18:00.974661 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-23 03:18:01.023127 | localhost | skipping: Conditional result was False 2026-05-23 03:18:01.023851 | 2026-05-23 03:18:01.027116 | localhost | skipping: Conditional result was False 2026-05-23 03:18:01.032253 | 2026-05-23 03:18:01.032345 | LOOP [upload-logs : Upload console log and json output]