2025-05-19 03:31:05.401528 | Job console starting 2025-05-19 03:31:05.416718 | Updating git repos 2025-05-19 03:31:05.459359 | Cloning repos into workspace 2025-05-19 03:31:05.499092 | Restoring repo states 2025-05-19 03:31:05.508049 | Merging changes 2025-05-19 03:31:05.508073 | Checking out repos 2025-05-19 03:31:05.553739 | Preparing playbooks 2025-05-19 03:31:06.134250 | Running Ansible setup 2025-05-19 03:31:10.454251 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-19 03:31:11.398295 | 2025-05-19 03:31:11.398467 | PLAY [Base pre] 2025-05-19 03:31:11.418481 | 2025-05-19 03:31:11.418626 | TASK [Setup log path fact] 2025-05-19 03:31:11.459840 | debian-bookworm | ok 2025-05-19 03:31:11.478297 | 2025-05-19 03:31:11.478466 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-19 03:31:11.540458 | debian-bookworm | ok 2025-05-19 03:31:11.620632 | 2025-05-19 03:31:11.622239 | TASK [emit-job-header : Print job information] 2025-05-19 03:31:11.721555 | # Job Information 2025-05-19 03:31:11.721849 | Ansible Version: 2.16.14 2025-05-19 03:31:11.721904 | Job: tox 2025-05-19 03:31:11.721938 | Pipeline: periodic-daily 2025-05-19 03:31:11.721962 | Executor: 521e9411259a 2025-05-19 03:31:11.721983 | Triggered by: https://github.com/osism/openstack-image-manager 2025-05-19 03:31:11.722006 | Event ID: 5fba16ad0035492ca1f683ed3b192477 2025-05-19 03:31:11.729558 | 2025-05-19 03:31:11.729694 | LOOP [emit-job-header : Print node information] 2025-05-19 03:31:11.961472 | debian-bookworm | ok: 2025-05-19 03:31:11.962889 | debian-bookworm | # Node Information 2025-05-19 03:31:11.963428 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-19 03:31:11.963916 | debian-bookworm | Hostname: debian 2025-05-19 03:31:11.964122 | debian-bookworm | Username: zuul 2025-05-19 03:31:11.964546 | debian-bookworm | Distro: Debian 12.11 2025-05-19 03:31:11.964907 | debian-bookworm | Provider: regiocloud-a 2025-05-19 03:31:11.965276 | debian-bookworm | Region: 2025-05-19 03:31:11.965627 | debian-bookworm | Label: debian-bookworm 2025-05-19 03:31:11.965975 | debian-bookworm | Product Name: OpenStack Nova 2025-05-19 03:31:11.966336 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe41:82f8 2025-05-19 03:31:12.059614 | 2025-05-19 03:31:12.060574 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-19 03:31:13.463016 | debian-bookworm -> localhost | changed 2025-05-19 03:31:13.487093 | 2025-05-19 03:31:13.488101 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-19 03:31:16.540637 | debian-bookworm -> localhost | changed 2025-05-19 03:31:16.561576 | 2025-05-19 03:31:16.563084 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-19 03:31:17.238110 | debian-bookworm -> localhost | ok 2025-05-19 03:31:17.276737 | 2025-05-19 03:31:17.276893 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-19 03:31:17.320566 | debian-bookworm | ok 2025-05-19 03:31:17.354285 | debian-bookworm | included: /var/lib/zuul/builds/02692ea71a4d4f578f7b5f9d2cef510c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-19 03:31:17.377809 | 2025-05-19 03:31:17.377936 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-19 03:31:19.210097 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-19 03:31:19.210373 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/02692ea71a4d4f578f7b5f9d2cef510c/work/02692ea71a4d4f578f7b5f9d2cef510c_id_rsa 2025-05-19 03:31:19.210414 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/02692ea71a4d4f578f7b5f9d2cef510c/work/02692ea71a4d4f578f7b5f9d2cef510c_id_rsa.pub 2025-05-19 03:31:19.210442 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-19 03:31:19.210466 | debian-bookworm -> localhost | SHA256:2PMUdv6SDWe02vN76+8+nxebB+UpsgT+Rs1fD6idrcY zuul-build-sshkey 2025-05-19 03:31:19.210489 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-19 03:31:19.210523 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-19 03:31:19.210545 | debian-bookworm -> localhost | | | 2025-05-19 03:31:19.210568 | debian-bookworm -> localhost | | | 2025-05-19 03:31:19.210589 | debian-bookworm -> localhost | | o . . | 2025-05-19 03:31:19.210609 | debian-bookworm -> localhost | | o o + . ..| 2025-05-19 03:31:19.210630 | debian-bookworm -> localhost | | . S o =.+o.| 2025-05-19 03:31:19.210654 | debian-bookworm -> localhost | | = +.&ooo| 2025-05-19 03:31:19.210675 | debian-bookworm -> localhost | | =+*oBo*| 2025-05-19 03:31:19.210695 | debian-bookworm -> localhost | | .+E..B*| 2025-05-19 03:31:19.210715 | debian-bookworm -> localhost | | .....B/| 2025-05-19 03:31:19.210801 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-19 03:31:19.210883 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.852287 2025-05-19 03:31:19.221821 | 2025-05-19 03:31:19.221961 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-19 03:31:19.333858 | debian-bookworm | ok 2025-05-19 03:31:19.379267 | debian-bookworm | included: /var/lib/zuul/builds/02692ea71a4d4f578f7b5f9d2cef510c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-19 03:31:19.396645 | 2025-05-19 03:31:19.396779 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-19 03:31:19.422165 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:31:19.431347 | 2025-05-19 03:31:19.431570 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-19 03:31:20.534212 | debian-bookworm | changed 2025-05-19 03:31:20.558595 | 2025-05-19 03:31:20.561899 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-19 03:31:20.891668 | debian-bookworm | ok 2025-05-19 03:31:20.902280 | 2025-05-19 03:31:20.902411 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-19 03:31:21.847443 | debian-bookworm | changed 2025-05-19 03:31:21.866567 | 2025-05-19 03:31:21.867003 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-19 03:31:22.871911 | debian-bookworm | changed 2025-05-19 03:31:22.904355 | 2025-05-19 03:31:22.905449 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-19 03:31:22.981351 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:31:22.990426 | 2025-05-19 03:31:22.990659 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-19 03:31:24.177365 | debian-bookworm -> localhost | changed 2025-05-19 03:31:24.189257 | 2025-05-19 03:31:24.189362 | TASK [add-build-sshkey : Add back temp key] 2025-05-19 03:31:24.688639 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/02692ea71a4d4f578f7b5f9d2cef510c/work/02692ea71a4d4f578f7b5f9d2cef510c_id_rsa (zuul-build-sshkey) 2025-05-19 03:31:24.688858 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027440 2025-05-19 03:31:24.697304 | 2025-05-19 03:31:24.697411 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-19 03:31:25.206090 | debian-bookworm | ok 2025-05-19 03:31:25.211265 | 2025-05-19 03:31:25.211367 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-19 03:31:25.241330 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:31:25.251676 | 2025-05-19 03:31:25.251777 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-19 03:31:25.719705 | debian-bookworm | ok 2025-05-19 03:31:25.744414 | 2025-05-19 03:31:25.744526 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-19 03:31:25.795207 | debian-bookworm | ok 2025-05-19 03:31:25.800082 | 2025-05-19 03:31:25.800167 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-19 03:31:26.293241 | debian-bookworm -> localhost | ok 2025-05-19 03:31:26.315289 | 2025-05-19 03:31:26.315394 | TASK [validate-host : Collect information about the host] 2025-05-19 03:31:27.547083 | debian-bookworm | ok 2025-05-19 03:31:27.556870 | 2025-05-19 03:31:27.556972 | TASK [validate-host : Sanitize hostname] 2025-05-19 03:31:27.656154 | debian-bookworm | ok 2025-05-19 03:31:27.684893 | 2025-05-19 03:31:27.684999 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-19 03:31:28.220926 | debian-bookworm -> localhost | changed 2025-05-19 03:31:28.226632 | 2025-05-19 03:31:28.226739 | TASK [validate-host : Collect information about zuul worker] 2025-05-19 03:31:28.785451 | debian-bookworm | ok 2025-05-19 03:31:28.807867 | 2025-05-19 03:31:28.808078 | TASK [validate-host : Write out all zuul information for each host] 2025-05-19 03:31:29.926933 | debian-bookworm -> localhost | changed 2025-05-19 03:31:29.948548 | 2025-05-19 03:31:29.948702 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-19 03:31:30.270281 | debian-bookworm | ok 2025-05-19 03:31:30.279171 | 2025-05-19 03:31:30.280021 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-19 03:31:31.420343 | debian-bookworm | changed: 2025-05-19 03:31:31.420561 | debian-bookworm | cd+++++++++ src/ 2025-05-19 03:31:31.420597 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-19 03:31:31.420622 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-19 03:31:31.420645 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-05-19 03:31:31.420666 | debian-bookworm | =5.5.1 2025-05-19 03:31:54.154470 | debian-bookworm | Downloading cachetools-5.5.2-py3-none-any.whl (10 kB) 2025-05-19 03:31:54.196150 | debian-bookworm | Collecting chardet>=5.2 2025-05-19 03:31:54.204679 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-05-19 03:31:54.230724 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 10.4 MB/s eta 0:00:00 2025-05-19 03:31:54.268856 | debian-bookworm | Collecting colorama>=0.4.6 2025-05-19 03:31:54.277091 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-05-19 03:31:54.324804 | debian-bookworm | Collecting filelock>=3.16.1 2025-05-19 03:31:54.333313 | debian-bookworm | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-05-19 03:31:54.391330 | debian-bookworm | Collecting packaging>=24.2 2025-05-19 03:31:54.399486 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-05-19 03:31:54.408122 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.2 MB/s eta 0:00:00 2025-05-19 03:31:54.449531 | debian-bookworm | Collecting platformdirs>=4.3.6 2025-05-19 03:31:54.457433 | debian-bookworm | Downloading platformdirs-4.3.8-py3-none-any.whl (18 kB) 2025-05-19 03:31:54.494348 | debian-bookworm | Collecting pluggy>=1.5 2025-05-19 03:31:54.502047 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-05-19 03:31:54.536564 | debian-bookworm | Collecting pyproject-api>=1.8 2025-05-19 03:31:54.544794 | debian-bookworm | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2025-05-19 03:31:54.662887 | debian-bookworm | Collecting virtualenv>=20.31 2025-05-19 03:31:54.671051 | debian-bookworm | Downloading virtualenv-20.31.2-py3-none-any.whl (6.1 MB) 2025-05-19 03:31:54.962418 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.1/6.1 MB 21.0 MB/s eta 0:00:00 2025-05-19 03:31:55.071649 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-05-19 03:31:55.079418 | debian-bookworm | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-05-19 03:31:55.110502 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 16.5 MB/s eta 0:00:00 2025-05-19 03:31:55.267970 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-05-19 03:31:56.092602 | debian-bookworm | Successfully installed cachetools-5.5.2 chardet-5.2.0 colorama-0.4.6 distlib-0.3.9 filelock-3.18.0 packaging-25.0 platformdirs-4.3.8 pluggy-1.6.0 pyproject-api-1.9.1 tox-4.26.0 virtualenv-20.31.2 2025-05-19 03:31:56.611663 | debian-bookworm | ok: Runtime: 0:00:02.824000 2025-05-19 03:31:56.623586 | 2025-05-19 03:31:56.623797 | TASK [ensure-tox : Export installed tox_executable path] 2025-05-19 03:31:56.663520 | debian-bookworm | ok 2025-05-19 03:31:56.668495 | 2025-05-19 03:31:56.668615 | TASK [ensure-tox : Output tox version] 2025-05-19 03:31:57.192332 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-05-19 03:31:57.211000 | debian-bookworm | 4.26.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-05-19 03:31:57.700678 | debian-bookworm | ok: Runtime: 0:00:00.290236 2025-05-19 03:31:57.714788 | 2025-05-19 03:31:57.714981 | TASK [ensure-tox : Make global symlink] 2025-05-19 03:31:57.743104 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:31:57.756257 | 2025-05-19 03:31:57.756396 | PLAY RECAP 2025-05-19 03:31:57.756480 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-05-19 03:31:57.756519 | 2025-05-19 03:31:57.904318 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-05-19 03:31:57.906401 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-05-19 03:31:58.702436 | 2025-05-19 03:31:58.702600 | PLAY [all] 2025-05-19 03:31:58.719096 | 2025-05-19 03:31:58.719277 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-05-19 03:31:59.260096 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-05-19 03:31:59.760586 | debian-bookworm | ok: Runtime: 0:00:00.029224 2025-05-19 03:31:59.774343 | 2025-05-19 03:31:59.774539 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-05-19 03:32:00.306504 | debian-bookworm | ok: Runtime: 0:00:00.006212 2025-05-19 03:32:00.319966 | 2025-05-19 03:32:00.322655 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-05-19 03:32:00.631543 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-05-19 03:32:00.633249 | debian-bookworm | sudo: a password is required 2025-05-19 03:32:00.854499 | debian-bookworm | ok: Runtime: 0:00:00.019309 2025-05-19 03:32:00.874590 | 2025-05-19 03:32:00.874736 | TASK [tox : Check to see if the constraints file exists] 2025-05-19 03:32:00.910259 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:00.922646 | 2025-05-19 03:32:00.922808 | TASK [tox : Fail if constraints file is missing] 2025-05-19 03:32:00.947609 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:00.964807 | 2025-05-19 03:32:00.965071 | TASK [tox : Record file location] 2025-05-19 03:32:01.002411 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:01.016944 | 2025-05-19 03:32:01.017141 | TASK [tox : Install tox siblings] 2025-05-19 03:32:01.054939 | debian-bookworm | ok 2025-05-19 03:32:01.065113 | debian-bookworm | included: /var/lib/zuul/builds/02692ea71a4d4f578f7b5f9d2cef510c/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-05-19 03:32:01.071392 | 2025-05-19 03:32:01.071525 | TASK [tox : Run tox without tests] 2025-05-19 03:32:02.102975 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-05-19 03:32:15.849224 | debian-bookworm | test: OK (14.24 seconds) 2025-05-19 03:32:15.849328 | debian-bookworm | congratulations :) (14.31 seconds) 2025-05-19 03:32:16.109448 | debian-bookworm | ok: Runtime: 0:00:14.538002 2025-05-19 03:32:16.115524 | 2025-05-19 03:32:16.115639 | TASK [tox : Create a tempfile to save tox showconfig] 2025-05-19 03:32:16.551288 | debian-bookworm | changed 2025-05-19 03:32:16.556637 | 2025-05-19 03:32:16.556759 | TASK [tox : Get tox envlist config] 2025-05-19 03:32:17.621883 | debian-bookworm | ok: Runtime: 0:00:00.354578 2025-05-19 03:32:17.627345 | 2025-05-19 03:32:17.627444 | TASK [tox : Install any sibling python packages] 2025-05-19 03:32:18.165142 | debian-bookworm | ok: No setup.cfg, no action needed 2025-05-19 03:32:18.170694 | 2025-05-19 03:32:18.170792 | TASK [tox : Remove tempfile] 2025-05-19 03:32:18.921495 | debian-bookworm | changed 2025-05-19 03:32:18.927834 | 2025-05-19 03:32:18.927928 | TASK [tox : Emit tox command] 2025-05-19 03:32:18.997891 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-05-19 03:32:19.006023 | 2025-05-19 03:32:19.006191 | TASK [tox : Run tox] 2025-05-19 03:32:19.688135 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-05-19 03:32:20.467577 | debian-bookworm | ............... 2025-05-19 03:32:20.467662 | debian-bookworm | ---------------------------------------------------------------------- 2025-05-19 03:32:20.467693 | debian-bookworm | Ran 15 tests in 0.173s 2025-05-19 03:32:20.467707 | debian-bookworm | 2025-05-19 03:32:20.467725 | debian-bookworm | OK 2025-05-19 03:32:20.579335 | debian-bookworm | test: OK (0.93=setup[0.04]+cmd[0.89] seconds) 2025-05-19 03:32:20.580495 | debian-bookworm | congratulations :) (1.00 seconds) 2025-05-19 03:32:21.092998 | debian-bookworm | ok: Runtime: 0:00:01.231864 2025-05-19 03:32:21.099294 | 2025-05-19 03:32:21.099391 | TASK [tox : Look for output] 2025-05-19 03:32:21.474193 | debian-bookworm | ok 2025-05-19 03:32:21.492331 | 2025-05-19 03:32:21.492454 | TASK [tox : Return file comments to Zuul] 2025-05-19 03:32:21.526050 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:21.532209 | 2025-05-19 03:32:21.532308 | PLAY RECAP 2025-05-19 03:32:21.532362 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-05-19 03:32:21.532386 | 2025-05-19 03:32:21.634815 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-05-19 03:32:21.635794 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-05-19 03:32:22.365751 | 2025-05-19 03:32:22.365929 | PLAY [all] 2025-05-19 03:32:22.396313 | 2025-05-19 03:32:22.396476 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-05-19 03:32:22.463276 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:22.470453 | 2025-05-19 03:32:22.470612 | TASK [fetch-tox-output : Set tox log path for single node] 2025-05-19 03:32:22.509506 | debian-bookworm | ok 2025-05-19 03:32:22.514716 | 2025-05-19 03:32:22.514860 | TASK [fetch-tox-output : Ensure local tox dir] 2025-05-19 03:32:23.001850 | debian-bookworm -> localhost | changed 2025-05-19 03:32:23.016093 | 2025-05-19 03:32:23.016283 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-05-19 03:32:23.091951 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:23.101052 | 2025-05-19 03:32:23.101212 | TASK [fetch-tox-output : Set envlist fact] 2025-05-19 03:32:23.175585 | debian-bookworm | ok 2025-05-19 03:32:23.182290 | 2025-05-19 03:32:23.182409 | TASK [fetch-tox-output : Get tox version] 2025-05-19 03:32:23.875704 | debian-bookworm | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-05-19 03:32:23.893588 | debian-bookworm | 4.26.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-05-19 03:32:24.215711 | debian-bookworm | ok: Runtime: 0:00:00.278953 2025-05-19 03:32:24.223567 | 2025-05-19 03:32:24.223683 | TASK [fetch-tox-output : Find all default environments] 2025-05-19 03:32:24.757647 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:24.766538 | 2025-05-19 03:32:24.766685 | TASK [fetch-tox-output : Set envlist fact] 2025-05-19 03:32:24.801797 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:24.809129 | 2025-05-19 03:32:24.809360 | TASK [fetch-tox-output : Find all default environments] 2025-05-19 03:32:25.348660 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:25.354859 | 2025-05-19 03:32:25.354990 | TASK [fetch-tox-output : Set envlist fact] 2025-05-19 03:32:25.399328 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:25.406002 | 2025-05-19 03:32:25.406126 | LOOP [fetch-tox-output : Copy tox logs] 2025-05-19 03:32:25.454088 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:25.467284 | 2025-05-19 03:32:25.467435 | LOOP [fetch-tox-output : Collect tox logs] 2025-05-19 03:32:26.273767 | debian-bookworm | changed: 2025-05-19 03:32:26.274182 | debian-bookworm | created directory /var/lib/zuul/builds/02692ea71a4d4f578f7b5f9d2cef510c/work/logs/tox/test 2025-05-19 03:32:26.274306 | debian-bookworm | cd+++++++++ ./ 2025-05-19 03:32:26.274362 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-05-19 03:32:26.274401 | 2025-05-19 03:32:26.297803 | 2025-05-19 03:32:26.297942 | PLAY RECAP 2025-05-19 03:32:26.298039 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-05-19 03:32:26.298092 | 2025-05-19 03:32:26.436010 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-05-19 03:32:26.437111 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-05-19 03:32:27.244372 | 2025-05-19 03:32:27.244545 | PLAY [all] 2025-05-19 03:32:27.260797 | 2025-05-19 03:32:27.260953 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-05-19 03:32:27.544186 | debian-bookworm | changed: non-zero return code 2025-05-19 03:32:27.549823 | 2025-05-19 03:32:27.549953 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-05-19 03:32:27.578755 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:27.584698 | 2025-05-19 03:32:27.584813 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-05-19 03:32:27.615026 | 2025-05-19 03:32:27.615213 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-05-19 03:32:27.658271 | 2025-05-19 03:32:27.658471 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-05-19 03:32:27.682361 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:27.688388 | 2025-05-19 03:32:27.688507 | LOOP [fetch-subunit-output : Generate subunit file] 2025-05-19 03:32:27.717748 | 2025-05-19 03:32:27.717949 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-05-19 03:32:27.742699 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:27.748519 | 2025-05-19 03:32:27.748698 | TASK [fetch-subunit-output : Remove the temporary file] 2025-05-19 03:32:27.772500 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:27.778578 | 2025-05-19 03:32:27.778707 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-05-19 03:32:27.802914 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:32:27.809867 | 2025-05-19 03:32:27.809969 | PLAY RECAP 2025-05-19 03:32:27.810020 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-05-19 03:32:27.810056 | 2025-05-19 03:32:27.983777 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-05-19 03:32:27.984844 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-05-19 03:32:28.943801 | 2025-05-19 03:32:28.943988 | PLAY [Base post] 2025-05-19 03:32:28.958273 | 2025-05-19 03:32:28.958433 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-05-19 03:32:29.631909 | debian-bookworm | changed 2025-05-19 03:32:29.640138 | 2025-05-19 03:32:29.640287 | PLAY RECAP 2025-05-19 03:32:29.640355 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-05-19 03:32:29.640416 | 2025-05-19 03:32:29.784478 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-05-19 03:32:29.785574 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-05-19 03:32:30.892469 | 2025-05-19 03:32:30.892656 | PLAY [Base post-logs] 2025-05-19 03:32:30.905676 | 2025-05-19 03:32:30.906002 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-05-19 03:32:31.504106 | localhost | changed 2025-05-19 03:32:31.518848 | 2025-05-19 03:32:31.519129 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-05-19 03:32:31.556823 | localhost | ok 2025-05-19 03:32:31.560986 | 2025-05-19 03:32:31.561105 | TASK [Set zuul-log-path fact] 2025-05-19 03:32:31.577355 | localhost | ok 2025-05-19 03:32:31.594917 | 2025-05-19 03:32:31.595082 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-19 03:32:31.622245 | localhost | ok 2025-05-19 03:32:31.628128 | 2025-05-19 03:32:31.628405 | TASK [upload-logs : Create log directories] 2025-05-19 03:32:32.195206 | localhost | changed 2025-05-19 03:32:32.202917 | 2025-05-19 03:32:32.203066 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-05-19 03:32:32.862500 | localhost -> localhost | ok: Runtime: 0:00:00.007944 2025-05-19 03:32:32.869843 | 2025-05-19 03:32:32.870396 | TASK [upload-logs : Upload logs to log server] 2025-05-19 03:32:33.439507 | localhost | Output suppressed because no_log was given 2025-05-19 03:32:33.444098 | 2025-05-19 03:32:33.444398 | LOOP [upload-logs : Compress console log and json output] 2025-05-19 03:32:33.498980 | localhost | skipping: Conditional result was False 2025-05-19 03:32:33.504178 | localhost | skipping: Conditional result was False 2025-05-19 03:32:33.515993 | 2025-05-19 03:32:33.516214 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-19 03:32:33.563633 | localhost | skipping: Conditional result was False 2025-05-19 03:32:33.564240 | 2025-05-19 03:32:33.567602 | localhost | skipping: Conditional result was False 2025-05-19 03:32:33.581752 | 2025-05-19 03:32:33.581946 | LOOP [upload-logs : Upload console log and json output]