2025-12-24 03:04:46.191657 | Job console starting 2025-12-24 03:04:46.205004 | Updating git repos 2025-12-24 03:04:46.243483 | Cloning repos into workspace 2025-12-24 03:04:46.335398 | Restoring repo states 2025-12-24 03:04:46.361240 | Merging changes 2025-12-24 03:04:46.361259 | Checking out repos 2025-12-24 03:04:46.499339 | Preparing playbooks 2025-12-24 03:04:47.803511 | Running Ansible setup 2025-12-24 03:04:55.815002 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-24 03:04:57.323709 | 2025-12-24 03:04:57.323948 | PLAY [Base pre] 2025-12-24 03:04:57.363716 | 2025-12-24 03:04:57.363886 | TASK [Setup log path fact] 2025-12-24 03:04:57.410134 | debian-bookworm | ok 2025-12-24 03:04:57.532391 | 2025-12-24 03:04:57.532596 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-24 03:04:57.621922 | debian-bookworm | ok 2025-12-24 03:04:57.637775 | 2025-12-24 03:04:57.637932 | TASK [emit-job-header : Print job information] 2025-12-24 03:04:57.764774 | # Job Information 2025-12-24 03:04:57.765250 | Ansible Version: 2.16.14 2025-12-24 03:04:57.765354 | Job: tox 2025-12-24 03:04:57.765447 | Pipeline: periodic-daily 2025-12-24 03:04:57.765512 | Executor: 521e9411259a 2025-12-24 03:04:57.765573 | Triggered by: https://github.com/osism/openstack-image-manager 2025-12-24 03:04:57.765635 | Event ID: df444414c4c24e43a1c0e0e9f3eb0815 2025-12-24 03:04:57.790994 | 2025-12-24 03:04:57.791216 | LOOP [emit-job-header : Print node information] 2025-12-24 03:04:58.016773 | debian-bookworm | ok: 2025-12-24 03:04:58.017750 | debian-bookworm | # Node Information 2025-12-24 03:04:58.018110 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-24 03:04:58.018343 | debian-bookworm | Hostname: debian 2025-12-24 03:04:58.018381 | debian-bookworm | Username: zuul 2025-12-24 03:04:58.018407 | debian-bookworm | Distro: Debian 12.12 2025-12-24 03:04:58.018434 | debian-bookworm | Provider: regiocloud-a 2025-12-24 03:04:58.018485 | debian-bookworm | Region: 2025-12-24 03:04:58.018565 | debian-bookworm | Label: debian-bookworm 2025-12-24 03:04:58.018779 | debian-bookworm | Product Name: OpenStack Nova 2025-12-24 03:04:58.019003 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe05:5eb9 2025-12-24 03:04:58.042397 | 2025-12-24 03:04:58.044978 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-24 03:04:58.915285 | debian-bookworm -> localhost | changed 2025-12-24 03:04:58.923468 | 2025-12-24 03:04:58.923622 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-24 03:05:01.099274 | debian-bookworm -> localhost | changed 2025-12-24 03:05:01.126682 | 2025-12-24 03:05:01.128897 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-24 03:05:01.935922 | debian-bookworm -> localhost | ok 2025-12-24 03:05:01.951664 | 2025-12-24 03:05:01.951819 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-24 03:05:02.007351 | debian-bookworm | ok 2025-12-24 03:05:02.047406 | debian-bookworm | included: /var/lib/zuul/builds/fde5f108aa1f457fba0890f0fd18f59d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-24 03:05:02.061633 | 2025-12-24 03:05:02.061782 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-24 03:05:04.020047 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-24 03:05:04.020342 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fde5f108aa1f457fba0890f0fd18f59d/work/fde5f108aa1f457fba0890f0fd18f59d_id_rsa 2025-12-24 03:05:04.020384 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fde5f108aa1f457fba0890f0fd18f59d/work/fde5f108aa1f457fba0890f0fd18f59d_id_rsa.pub 2025-12-24 03:05:04.020410 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-24 03:05:04.020436 | debian-bookworm -> localhost | SHA256:OfHGXBaZ/o0c3l4lWAUQ6vn8bluWKyX+b8fi6tBjiEE zuul-build-sshkey 2025-12-24 03:05:04.020458 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-24 03:05:04.020494 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-24 03:05:04.020516 | debian-bookworm -> localhost | | +=.o.| 2025-12-24 03:05:04.020538 | debian-bookworm -> localhost | | .o.. | 2025-12-24 03:05:04.020558 | debian-bookworm -> localhost | | E ..oo | 2025-12-24 03:05:04.020620 | debian-bookworm -> localhost | | . B +o o .| 2025-12-24 03:05:04.020646 | debian-bookworm -> localhost | | S B + *.| 2025-12-24 03:05:04.020673 | debian-bookworm -> localhost | | = = .=.=| 2025-12-24 03:05:04.020693 | debian-bookworm -> localhost | | . o B o++| 2025-12-24 03:05:04.020714 | debian-bookworm -> localhost | | o =oo*| 2025-12-24 03:05:04.020736 | debian-bookworm -> localhost | | .o=B*+| 2025-12-24 03:05:04.020755 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-24 03:05:04.020818 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.840865 2025-12-24 03:05:04.027875 | 2025-12-24 03:05:04.028009 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-24 03:05:04.087006 | debian-bookworm | ok 2025-12-24 03:05:04.103265 | debian-bookworm | included: /var/lib/zuul/builds/fde5f108aa1f457fba0890f0fd18f59d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-24 03:05:04.141090 | 2025-12-24 03:05:04.141258 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-24 03:05:04.168930 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:05:04.175821 | 2025-12-24 03:05:04.175963 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-24 03:05:05.458694 | debian-bookworm | changed 2025-12-24 03:05:05.467027 | 2025-12-24 03:05:05.469809 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-24 03:05:05.764461 | debian-bookworm | ok 2025-12-24 03:05:05.771228 | 2025-12-24 03:05:05.771375 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-24 03:05:06.594005 | debian-bookworm | changed 2025-12-24 03:05:06.617832 | 2025-12-24 03:05:06.617981 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-24 03:05:07.443775 | debian-bookworm | changed 2025-12-24 03:05:07.449837 | 2025-12-24 03:05:07.449979 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-24 03:05:07.493128 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:05:07.499694 | 2025-12-24 03:05:07.499839 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-24 03:05:08.491237 | debian-bookworm -> localhost | changed 2025-12-24 03:05:08.511779 | 2025-12-24 03:05:08.511930 | TASK [add-build-sshkey : Add back temp key] 2025-12-24 03:05:09.671691 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fde5f108aa1f457fba0890f0fd18f59d/work/fde5f108aa1f457fba0890f0fd18f59d_id_rsa (zuul-build-sshkey) 2025-12-24 03:05:09.671962 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.039759 2025-12-24 03:05:09.691258 | 2025-12-24 03:05:09.694017 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-24 03:05:10.580710 | debian-bookworm | ok 2025-12-24 03:05:10.604507 | 2025-12-24 03:05:10.604661 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-24 03:05:10.643956 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:05:10.657725 | 2025-12-24 03:05:10.657875 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-24 03:05:11.379295 | debian-bookworm | ok 2025-12-24 03:05:11.428150 | 2025-12-24 03:05:11.428338 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-24 03:05:11.517843 | debian-bookworm | ok 2025-12-24 03:05:11.528954 | 2025-12-24 03:05:11.529107 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-24 03:05:12.704947 | debian-bookworm -> localhost | ok 2025-12-24 03:05:12.713437 | 2025-12-24 03:05:12.713569 | TASK [validate-host : Collect information about the host] 2025-12-24 03:05:14.083119 | debian-bookworm | ok 2025-12-24 03:05:14.128575 | 2025-12-24 03:05:14.128724 | TASK [validate-host : Sanitize hostname] 2025-12-24 03:05:14.366470 | debian-bookworm | ok 2025-12-24 03:05:14.476895 | 2025-12-24 03:05:14.477043 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-24 03:05:15.780531 | debian-bookworm -> localhost | changed 2025-12-24 03:05:15.798050 | 2025-12-24 03:05:15.798215 | TASK [validate-host : Collect information about zuul worker] 2025-12-24 03:05:16.594991 | debian-bookworm | ok 2025-12-24 03:05:16.610315 | 2025-12-24 03:05:16.610484 | TASK [validate-host : Write out all zuul information for each host] 2025-12-24 03:05:17.819310 | debian-bookworm -> localhost | changed 2025-12-24 03:05:17.858487 | 2025-12-24 03:05:17.858636 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-24 03:05:18.145665 | debian-bookworm | ok 2025-12-24 03:05:18.161647 | 2025-12-24 03:05:18.161801 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-24 03:05:19.247174 | debian-bookworm | changed: 2025-12-24 03:05:19.247442 | debian-bookworm | cd+++++++++ src/ 2025-12-24 03:05:19.247480 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-24 03:05:19.247505 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-24 03:05:19.247526 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-24 03:05:19.247547 | debian-bookworm | =6.2 2025-12-24 03:05:42.952642 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2025-12-24 03:05:42.992883 | debian-bookworm | Collecting chardet>=5.2 2025-12-24 03:05:43.012578 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-24 03:05:43.026702 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 21.6 MB/s eta 0:00:00 2025-12-24 03:05:43.086394 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-24 03:05:43.103163 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-24 03:05:43.188265 | debian-bookworm | Collecting filelock>=3.20 2025-12-24 03:05:43.204881 | debian-bookworm | Downloading filelock-3.20.1-py3-none-any.whl (16 kB) 2025-12-24 03:05:43.277316 | debian-bookworm | Collecting packaging>=25 2025-12-24 03:05:43.293290 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-24 03:05:43.301533 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 11.0 MB/s eta 0:00:00 2025-12-24 03:05:43.349110 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-24 03:05:43.364740 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-24 03:05:43.408778 | debian-bookworm | Collecting pluggy>=1.6 2025-12-24 03:05:43.424522 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-24 03:05:43.464392 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-24 03:05:43.480185 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-24 03:05:43.614234 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-24 03:05:43.630131 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-24 03:05:43.979379 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 18.2 MB/s eta 0:00:00 2025-12-24 03:05:44.086237 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-24 03:05:44.103221 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-24 03:05:44.134640 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.1 MB/s eta 0:00:00 2025-12-24 03:05:44.297749 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-24 03:05:45.132745 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.1 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-12-24 03:05:45.731129 | debian-bookworm | ok: Runtime: 0:00:03.211505 2025-12-24 03:05:45.740684 | 2025-12-24 03:05:45.740825 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-24 03:05:45.857523 | debian-bookworm | ok 2025-12-24 03:05:45.872415 | 2025-12-24 03:05:45.872567 | TASK [ensure-tox : Output tox version] 2025-12-24 03:05:46.530981 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-24 03:05:46.549789 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-24 03:05:46.950735 | debian-bookworm | ok: Runtime: 0:00:00.318684 2025-12-24 03:05:46.977374 | 2025-12-24 03:05:46.977574 | TASK [ensure-tox : Make global symlink] 2025-12-24 03:05:47.034569 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:05:47.072780 | 2025-12-24 03:05:47.073325 | PLAY RECAP 2025-12-24 03:05:47.073398 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-24 03:05:47.073424 | 2025-12-24 03:05:47.731599 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-24 03:05:47.732994 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-24 03:05:49.986002 | 2025-12-24 03:05:49.986173 | PLAY [all] 2025-12-24 03:05:50.075289 | 2025-12-24 03:05:50.075470 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-24 03:05:51.338452 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-24 03:05:51.714365 | debian-bookworm | ok: Runtime: 0:00:00.030873 2025-12-24 03:05:51.720472 | 2025-12-24 03:05:51.720626 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-24 03:05:52.302819 | debian-bookworm | ok: Runtime: 0:00:00.006881 2025-12-24 03:05:52.320880 | 2025-12-24 03:05:52.321030 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-24 03:05:52.776365 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-24 03:05:52.776956 | debian-bookworm | sudo: a password is required 2025-12-24 03:05:52.879906 | debian-bookworm | ok: Runtime: 0:00:00.023079 2025-12-24 03:05:52.898343 | 2025-12-24 03:05:52.898491 | TASK [tox : Check to see if the constraints file exists] 2025-12-24 03:05:52.995610 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:05:53.002441 | 2025-12-24 03:05:53.002582 | TASK [tox : Fail if constraints file is missing] 2025-12-24 03:05:53.088025 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:05:53.095366 | 2025-12-24 03:05:53.095526 | TASK [tox : Record file location] 2025-12-24 03:05:53.156644 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:05:53.163983 | 2025-12-24 03:05:53.164128 | TASK [tox : Install tox siblings] 2025-12-24 03:05:53.232967 | debian-bookworm | ok 2025-12-24 03:05:53.255429 | debian-bookworm | included: /var/lib/zuul/builds/fde5f108aa1f457fba0890f0fd18f59d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-24 03:05:53.278474 | 2025-12-24 03:05:53.278631 | TASK [tox : Run tox without tests] 2025-12-24 03:05:54.548963 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-24 03:06:09.044828 | debian-bookworm | test: OK (15.11 seconds) 2025-12-24 03:06:09.044938 | debian-bookworm | congratulations :) (15.14 seconds) 2025-12-24 03:06:09.382324 | debian-bookworm | ok: Runtime: 0:00:15.475603 2025-12-24 03:06:09.389166 | 2025-12-24 03:06:09.389330 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-24 03:06:10.127468 | debian-bookworm | changed 2025-12-24 03:06:10.136063 | 2025-12-24 03:06:10.136191 | TASK [tox : Get tox envlist config] 2025-12-24 03:06:11.201874 | debian-bookworm | ok: Runtime: 0:00:00.412469 2025-12-24 03:06:11.209007 | 2025-12-24 03:06:11.209134 | TASK [tox : Install any sibling python packages] 2025-12-24 03:06:12.061696 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-24 03:06:12.068899 | 2025-12-24 03:06:12.069920 | TASK [tox : Remove tempfile] 2025-12-24 03:06:12.916326 | debian-bookworm | changed 2025-12-24 03:06:12.931038 | 2025-12-24 03:06:12.931188 | TASK [tox : Emit tox command] 2025-12-24 03:06:13.073162 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-24 03:06:13.086416 | 2025-12-24 03:06:13.086567 | TASK [tox : Run tox] 2025-12-24 03:06:13.987825 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-24 03:06:14.636641 | debian-bookworm | ............... 2025-12-24 03:06:14.636705 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-24 03:06:14.636721 | debian-bookworm | Ran 15 tests in 0.169s 2025-12-24 03:06:14.636727 | debian-bookworm | 2025-12-24 03:06:14.636735 | debian-bookworm | OK 2025-12-24 03:06:14.728810 | debian-bookworm | test: OK (0.78=setup[0.05]+cmd[0.74] seconds) 2025-12-24 03:06:14.728919 | debian-bookworm | congratulations :) (0.81 seconds) 2025-12-24 03:06:15.262481 | debian-bookworm | ok: Runtime: 0:00:01.103033 2025-12-24 03:06:15.268878 | 2025-12-24 03:06:15.269022 | TASK [tox : Look for output] 2025-12-24 03:06:16.104527 | debian-bookworm | ok 2025-12-24 03:06:16.145395 | 2025-12-24 03:06:16.145568 | TASK [tox : Return file comments to Zuul] 2025-12-24 03:06:16.269103 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:16.278166 | 2025-12-24 03:06:16.278316 | PLAY RECAP 2025-12-24 03:06:16.278376 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-24 03:06:16.278402 | 2025-12-24 03:06:17.341181 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-24 03:06:17.342547 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-24 03:06:21.208749 | 2025-12-24 03:06:21.208904 | PLAY [all] 2025-12-24 03:06:21.244152 | 2025-12-24 03:06:21.244311 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-24 03:06:21.431596 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:21.438282 | 2025-12-24 03:06:21.438442 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-24 03:06:21.577867 | debian-bookworm | ok 2025-12-24 03:06:21.593688 | 2025-12-24 03:06:21.593807 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-24 03:06:23.311294 | debian-bookworm -> localhost | changed 2025-12-24 03:06:23.318789 | 2025-12-24 03:06:23.318988 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-24 03:06:23.386982 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:23.396545 | 2025-12-24 03:06:23.396662 | TASK [fetch-tox-output : Set envlist fact] 2025-12-24 03:06:23.442262 | debian-bookworm | ok 2025-12-24 03:06:23.451050 | 2025-12-24 03:06:23.451160 | TASK [fetch-tox-output : Get tox version] 2025-12-24 03:06:24.360178 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-12-24 03:06:24.379081 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-24 03:06:24.525415 | debian-bookworm | ok: Runtime: 0:00:00.296259 2025-12-24 03:06:24.532602 | 2025-12-24 03:06:24.532700 | TASK [fetch-tox-output : Find all default environments] 2025-12-24 03:06:25.100943 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:25.106717 | 2025-12-24 03:06:25.106823 | TASK [fetch-tox-output : Set envlist fact] 2025-12-24 03:06:25.150474 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:25.156193 | 2025-12-24 03:06:25.156314 | TASK [fetch-tox-output : Find all default environments] 2025-12-24 03:06:25.705418 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:25.711667 | 2025-12-24 03:06:25.711804 | TASK [fetch-tox-output : Set envlist fact] 2025-12-24 03:06:25.771133 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:25.778529 | 2025-12-24 03:06:25.778679 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-24 03:06:25.880070 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:25.889748 | 2025-12-24 03:06:25.889905 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-24 03:06:27.139083 | debian-bookworm | changed: 2025-12-24 03:06:27.139861 | debian-bookworm | created directory /var/lib/zuul/builds/fde5f108aa1f457fba0890f0fd18f59d/work/logs/tox/test 2025-12-24 03:06:27.139918 | debian-bookworm | cd+++++++++ ./ 2025-12-24 03:06:27.139946 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-24 03:06:27.139984 | 2025-12-24 03:06:27.161935 | 2025-12-24 03:06:27.162047 | PLAY RECAP 2025-12-24 03:06:27.162103 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-24 03:06:27.162130 | 2025-12-24 03:06:27.385974 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-24 03:06:27.387800 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-24 03:06:28.701036 | 2025-12-24 03:06:28.701255 | PLAY [all] 2025-12-24 03:06:28.723298 | 2025-12-24 03:06:28.723625 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-24 03:06:28.973547 | debian-bookworm | changed: non-zero return code 2025-12-24 03:06:28.980832 | 2025-12-24 03:06:28.980999 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-24 03:06:29.016367 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:29.033350 | 2025-12-24 03:06:29.033521 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-24 03:06:29.095681 | 2025-12-24 03:06:29.096343 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-24 03:06:29.178305 | 2025-12-24 03:06:29.178549 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-24 03:06:29.227669 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:29.246009 | 2025-12-24 03:06:29.246186 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-24 03:06:29.306715 | 2025-12-24 03:06:29.307053 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-24 03:06:29.354280 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:29.363100 | 2025-12-24 03:06:29.363278 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-24 03:06:29.398886 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:29.406257 | 2025-12-24 03:06:29.406399 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-24 03:06:29.441312 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:06:29.457551 | 2025-12-24 03:06:29.457673 | PLAY RECAP 2025-12-24 03:06:29.457760 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-24 03:06:29.457800 | 2025-12-24 03:06:29.713665 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-24 03:06:29.714745 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-24 03:06:30.770023 | 2025-12-24 03:06:30.770229 | PLAY [Base post] 2025-12-24 03:06:30.802115 | 2025-12-24 03:06:30.802314 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-24 03:06:31.645660 | debian-bookworm | changed 2025-12-24 03:06:31.658328 | 2025-12-24 03:06:31.658470 | PLAY RECAP 2025-12-24 03:06:31.658537 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-24 03:06:31.658608 | 2025-12-24 03:06:32.148187 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-24 03:06:32.149347 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-24 03:06:33.946246 | 2025-12-24 03:06:33.946438 | PLAY [Base post-logs] 2025-12-24 03:06:33.971960 | 2025-12-24 03:06:33.972141 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-24 03:06:34.824477 | localhost | changed 2025-12-24 03:06:34.846868 | 2025-12-24 03:06:34.847055 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-24 03:06:34.874464 | localhost | ok 2025-12-24 03:06:34.878707 | 2025-12-24 03:06:34.878870 | TASK [Set zuul-log-path fact] 2025-12-24 03:06:34.899786 | localhost | ok 2025-12-24 03:06:34.913887 | 2025-12-24 03:06:34.914021 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-24 03:06:34.952664 | localhost | ok 2025-12-24 03:06:34.956744 | 2025-12-24 03:06:34.956887 | TASK [upload-logs : Create log directories] 2025-12-24 03:06:35.807894 | localhost | changed 2025-12-24 03:06:35.812708 | 2025-12-24 03:06:35.812860 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-24 03:06:36.496944 | localhost -> localhost | ok: Runtime: 0:00:00.008176 2025-12-24 03:06:36.504032 | 2025-12-24 03:06:36.504250 | TASK [upload-logs : Upload logs to log server] 2025-12-24 03:06:37.258569 | localhost | Output suppressed because no_log was given 2025-12-24 03:06:37.261433 | 2025-12-24 03:06:37.261549 | LOOP [upload-logs : Compress console log and json output] 2025-12-24 03:06:37.365702 | localhost | skipping: Conditional result was False 2025-12-24 03:06:37.372698 | localhost | skipping: Conditional result was False 2025-12-24 03:06:37.384773 | 2025-12-24 03:06:37.384905 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-24 03:06:37.461814 | localhost | skipping: Conditional result was False 2025-12-24 03:06:37.462111 | 2025-12-24 03:06:37.468495 | localhost | skipping: Conditional result was False 2025-12-24 03:06:37.475739 | 2025-12-24 03:06:37.475921 | LOOP [upload-logs : Upload console log and json output]