2026-01-18 00:20:19.686737 | Job console starting 2026-01-18 00:20:19.702558 | Updating git repos 2026-01-18 00:20:19.721271 | Cloning repos into workspace 2026-01-18 00:20:19.780044 | Restoring repo states 2026-01-18 00:20:19.793480 | Merging changes 2026-01-18 00:20:20.335042 | Checking out repos 2026-01-18 00:20:20.382698 | Preparing playbooks 2026-01-18 00:20:20.989192 | Running Ansible setup 2026-01-18 00:20:25.859262 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-18 00:20:26.915068 | 2026-01-18 00:20:26.915232 | PLAY [Base pre] 2026-01-18 00:20:26.949724 | 2026-01-18 00:20:26.949898 | TASK [Setup log path fact] 2026-01-18 00:20:26.991313 | debian-bookworm | ok 2026-01-18 00:20:27.023301 | 2026-01-18 00:20:27.023475 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-18 00:20:27.094735 | debian-bookworm | ok 2026-01-18 00:20:27.116664 | 2026-01-18 00:20:27.116812 | TASK [emit-job-header : Print job information] 2026-01-18 00:20:27.171312 | # Job Information 2026-01-18 00:20:27.171567 | Ansible Version: 2.16.14 2026-01-18 00:20:27.171607 | Job: tox 2026-01-18 00:20:27.171646 | Pipeline: check 2026-01-18 00:20:27.171673 | Executor: 521e9411259a 2026-01-18 00:20:27.171694 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1091 2026-01-18 00:20:27.171716 | Event ID: 73486950-f403-11f0-8ee2-fda55c0c4814 2026-01-18 00:20:27.179193 | 2026-01-18 00:20:27.179327 | LOOP [emit-job-header : Print node information] 2026-01-18 00:20:27.346977 | debian-bookworm | ok: 2026-01-18 00:20:27.347244 | debian-bookworm | # Node Information 2026-01-18 00:20:27.347281 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-18 00:20:27.347306 | debian-bookworm | Hostname: debian 2026-01-18 00:20:27.347328 | debian-bookworm | Username: zuul 2026-01-18 00:20:27.347349 | debian-bookworm | Distro: Debian 12.13 2026-01-18 00:20:27.347372 | debian-bookworm | Provider: regiocloud-a 2026-01-18 00:20:27.347393 | debian-bookworm | Region: 2026-01-18 00:20:27.347414 | debian-bookworm | Label: debian-bookworm 2026-01-18 00:20:27.347435 | debian-bookworm | Product Name: OpenStack Nova 2026-01-18 00:20:27.347455 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea0:8472 2026-01-18 00:20:27.369332 | 2026-01-18 00:20:27.369480 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-18 00:20:27.998726 | debian-bookworm -> localhost | changed 2026-01-18 00:20:28.006604 | 2026-01-18 00:20:28.006750 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-18 00:20:29.547265 | debian-bookworm -> localhost | changed 2026-01-18 00:20:29.558696 | 2026-01-18 00:20:29.558828 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-18 00:20:29.915942 | debian-bookworm -> localhost | ok 2026-01-18 00:20:29.922770 | 2026-01-18 00:20:29.922941 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-18 00:20:29.948496 | debian-bookworm | ok 2026-01-18 00:20:29.968933 | debian-bookworm | included: /var/lib/zuul/builds/bbd7dd60b8634c0599ed2c7853a96e83/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-18 00:20:29.985615 | 2026-01-18 00:20:29.985754 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-18 00:20:31.581352 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-18 00:20:31.581518 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bbd7dd60b8634c0599ed2c7853a96e83/work/bbd7dd60b8634c0599ed2c7853a96e83_id_rsa 2026-01-18 00:20:31.581548 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bbd7dd60b8634c0599ed2c7853a96e83/work/bbd7dd60b8634c0599ed2c7853a96e83_id_rsa.pub 2026-01-18 00:20:31.581569 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-18 00:20:31.581588 | debian-bookworm -> localhost | SHA256:HHa6uW1SsSTRM4xArq2IHLDKbQ1S36iQdKLfAW0b2z4 zuul-build-sshkey 2026-01-18 00:20:31.581606 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-18 00:20:31.581633 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-18 00:20:31.581650 | debian-bookworm -> localhost | | .o. + | 2026-01-18 00:20:31.581667 | debian-bookworm -> localhost | | . . o = | 2026-01-18 00:20:31.581684 | debian-bookworm -> localhost | |.o.o+ . o..o | 2026-01-18 00:20:31.581700 | debian-bookworm -> localhost | |+.=o.Boo.+o | 2026-01-18 00:20:31.581715 | debian-bookworm -> localhost | |o= .=oo.So o | 2026-01-18 00:20:31.581733 | debian-bookworm -> localhost | |+o=o++ oo | 2026-01-18 00:20:31.581750 | debian-bookworm -> localhost | |ooo+o.E o. | 2026-01-18 00:20:31.581765 | debian-bookworm -> localhost | | . ..o. | 2026-01-18 00:20:31.581782 | debian-bookworm -> localhost | | .o. | 2026-01-18 00:20:31.581798 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-18 00:20:31.581841 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.784275 2026-01-18 00:20:31.586827 | 2026-01-18 00:20:31.586995 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-18 00:20:31.612259 | debian-bookworm | ok 2026-01-18 00:20:31.621198 | debian-bookworm | included: /var/lib/zuul/builds/bbd7dd60b8634c0599ed2c7853a96e83/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-18 00:20:31.630243 | 2026-01-18 00:20:31.630334 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-18 00:20:31.643489 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:20:31.649048 | 2026-01-18 00:20:31.649131 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-18 00:20:32.249082 | debian-bookworm | changed 2026-01-18 00:20:32.254244 | 2026-01-18 00:20:32.254335 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-18 00:20:32.499358 | debian-bookworm | ok 2026-01-18 00:20:32.506073 | 2026-01-18 00:20:32.506194 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-18 00:20:33.192468 | debian-bookworm | changed 2026-01-18 00:20:33.204335 | 2026-01-18 00:20:33.204446 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-18 00:20:33.797780 | debian-bookworm | changed 2026-01-18 00:20:33.804430 | 2026-01-18 00:20:33.804529 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-18 00:20:33.827587 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:20:33.833468 | 2026-01-18 00:20:33.833559 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-18 00:20:34.242696 | debian-bookworm -> localhost | changed 2026-01-18 00:20:34.253650 | 2026-01-18 00:20:34.253755 | TASK [add-build-sshkey : Add back temp key] 2026-01-18 00:20:34.676869 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bbd7dd60b8634c0599ed2c7853a96e83/work/bbd7dd60b8634c0599ed2c7853a96e83_id_rsa (zuul-build-sshkey) 2026-01-18 00:20:34.677077 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011951 2026-01-18 00:20:34.685189 | 2026-01-18 00:20:34.685287 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-18 00:20:35.104254 | debian-bookworm | ok 2026-01-18 00:20:35.119357 | 2026-01-18 00:20:35.119472 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-18 00:20:35.158776 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:20:35.169990 | 2026-01-18 00:20:35.170084 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-18 00:20:35.560881 | debian-bookworm | ok 2026-01-18 00:20:35.571956 | 2026-01-18 00:20:35.572103 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-18 00:20:35.599445 | debian-bookworm | ok 2026-01-18 00:20:35.604206 | 2026-01-18 00:20:35.604289 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-18 00:20:35.862143 | debian-bookworm -> localhost | ok 2026-01-18 00:20:35.870818 | 2026-01-18 00:20:35.870958 | TASK [validate-host : Collect information about the host] 2026-01-18 00:20:36.922823 | debian-bookworm | ok 2026-01-18 00:20:36.946385 | 2026-01-18 00:20:36.946528 | TASK [validate-host : Sanitize hostname] 2026-01-18 00:20:37.083979 | debian-bookworm | ok 2026-01-18 00:20:37.130615 | 2026-01-18 00:20:37.130748 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-18 00:20:37.778473 | debian-bookworm -> localhost | changed 2026-01-18 00:20:37.792151 | 2026-01-18 00:20:37.792285 | TASK [validate-host : Collect information about zuul worker] 2026-01-18 00:20:38.445490 | debian-bookworm | ok 2026-01-18 00:20:38.457495 | 2026-01-18 00:20:38.457631 | TASK [validate-host : Write out all zuul information for each host] 2026-01-18 00:20:39.155612 | debian-bookworm -> localhost | changed 2026-01-18 00:20:39.174500 | 2026-01-18 00:20:39.174646 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-18 00:20:39.466400 | debian-bookworm | ok 2026-01-18 00:20:39.472243 | 2026-01-18 00:20:39.472354 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-18 00:20:40.744036 | debian-bookworm | changed: 2026-01-18 00:20:40.744251 | debian-bookworm | cd+++++++++ src/ 2026-01-18 00:20:40.744287 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-18 00:20:40.744311 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-18 00:20:40.744334 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-18 00:20:40.744354 | debian-bookworm | =6.2.4 2026-01-18 00:21:05.533682 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-18 00:21:05.584261 | debian-bookworm | Collecting chardet>=5.2 2026-01-18 00:21:05.596280 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-18 00:21:05.627505 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 7.5 MB/s eta 0:00:00 2026-01-18 00:21:05.675749 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-18 00:21:05.687391 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-18 00:21:05.741257 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-18 00:21:05.751882 | debian-bookworm | Downloading filelock-3.20.3-py3-none-any.whl (16 kB) 2026-01-18 00:21:05.799946 | debian-bookworm | Collecting packaging>=25 2026-01-18 00:21:05.810930 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2026-01-18 00:21:05.821064 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.3 MB/s eta 0:00:00 2026-01-18 00:21:05.865171 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-18 00:21:05.876065 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-18 00:21:05.913954 | debian-bookworm | Collecting pluggy>=1.6 2026-01-18 00:21:05.924651 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-18 00:21:05.973757 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-18 00:21:05.987005 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-18 00:21:06.131392 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-18 00:21:06.143778 | debian-bookworm | Downloading virtualenv-20.36.1-py3-none-any.whl (6.0 MB) 2026-01-18 00:21:06.479913 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 18.1 MB/s eta 0:00:00 2026-01-18 00:21:06.580024 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-18 00:21:06.590816 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-18 00:21:06.610425 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 27.1 MB/s eta 0:00:00 2026-01-18 00:21:06.742898 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-18 00:21:07.537379 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.3 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.34.1 virtualenv-20.36.1 2026-01-18 00:21:07.838586 | debian-bookworm | ok: Runtime: 0:00:02.850439 2026-01-18 00:21:07.844483 | 2026-01-18 00:21:07.844575 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-18 00:21:07.894518 | debian-bookworm | ok 2026-01-18 00:21:07.898441 | 2026-01-18 00:21:07.898526 | TASK [ensure-tox : Output tox version] 2026-01-18 00:21:08.470499 | 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-01-18 00:21:08.489911 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-18 00:21:08.958710 | debian-bookworm | ok: Runtime: 0:00:00.269202 2026-01-18 00:21:08.964513 | 2026-01-18 00:21:08.964597 | TASK [ensure-tox : Make global symlink] 2026-01-18 00:21:08.987490 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:08.993685 | 2026-01-18 00:21:08.993763 | PLAY RECAP 2026-01-18 00:21:08.993815 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-18 00:21:08.993839 | 2026-01-18 00:21:09.175286 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-18 00:21:09.176975 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-18 00:21:10.656731 | 2026-01-18 00:21:10.656864 | PLAY [all] 2026-01-18 00:21:10.689614 | 2026-01-18 00:21:10.689732 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-18 00:21:11.354558 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-18 00:21:11.759463 | debian-bookworm | ok: Runtime: 0:00:00.036035 2026-01-18 00:21:11.763981 | 2026-01-18 00:21:11.764072 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-18 00:21:12.312337 | debian-bookworm | ok: Runtime: 0:00:00.006309 2026-01-18 00:21:12.317017 | 2026-01-18 00:21:12.317113 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-18 00:21:12.690799 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-18 00:21:12.694311 | debian-bookworm | sudo: a password is required 2026-01-18 00:21:12.889189 | debian-bookworm | ok: Runtime: 0:00:00.023363 2026-01-18 00:21:12.897173 | 2026-01-18 00:21:12.897260 | TASK [tox : Check to see if the constraints file exists] 2026-01-18 00:21:12.979076 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:12.985095 | 2026-01-18 00:21:12.985192 | TASK [tox : Fail if constraints file is missing] 2026-01-18 00:21:13.028801 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:13.033872 | 2026-01-18 00:21:13.034770 | TASK [tox : Record file location] 2026-01-18 00:21:13.109152 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:13.114035 | 2026-01-18 00:21:13.114127 | TASK [tox : Install tox siblings] 2026-01-18 00:21:13.162448 | debian-bookworm | ok 2026-01-18 00:21:13.177383 | debian-bookworm | included: /var/lib/zuul/builds/bbd7dd60b8634c0599ed2c7853a96e83/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-18 00:21:13.194627 | 2026-01-18 00:21:13.194731 | TASK [tox : Run tox without tests] 2026-01-18 00:21:14.379031 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-18 00:21:27.913331 | debian-bookworm | test: OK (14.08 seconds) 2026-01-18 00:21:27.913411 | debian-bookworm | congratulations :) (14.11 seconds) 2026-01-18 00:21:28.250508 | debian-bookworm | ok: Runtime: 0:00:14.389889 2026-01-18 00:21:28.256596 | 2026-01-18 00:21:28.256713 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-18 00:21:28.701613 | debian-bookworm | changed 2026-01-18 00:21:28.712720 | 2026-01-18 00:21:28.712870 | TASK [tox : Get tox envlist config] 2026-01-18 00:21:29.774455 | debian-bookworm | ok: Runtime: 0:00:00.291593 2026-01-18 00:21:29.780179 | 2026-01-18 00:21:29.780583 | TASK [tox : Install any sibling python packages] 2026-01-18 00:21:30.281878 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-18 00:21:30.292266 | 2026-01-18 00:21:30.292388 | TASK [tox : Remove tempfile] 2026-01-18 00:21:31.046963 | debian-bookworm | changed 2026-01-18 00:21:31.059406 | 2026-01-18 00:21:31.059546 | TASK [tox : Emit tox command] 2026-01-18 00:21:31.129776 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-18 00:21:31.140586 | 2026-01-18 00:21:31.140737 | TASK [tox : Run tox] 2026-01-18 00:21:31.848699 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-18 00:21:32.467856 | debian-bookworm | ............... 2026-01-18 00:21:32.467904 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-18 00:21:32.467919 | debian-bookworm | Ran 15 tests in 0.170s 2026-01-18 00:21:32.467924 | debian-bookworm | 2026-01-18 00:21:32.467931 | debian-bookworm | OK 2026-01-18 00:21:32.555394 | debian-bookworm | test: OK (0.74=setup[0.04]+cmd[0.70] seconds) 2026-01-18 00:21:32.555456 | debian-bookworm | congratulations :) (0.77 seconds) 2026-01-18 00:21:32.810400 | debian-bookworm | ok: Runtime: 0:00:01.037779 2026-01-18 00:21:32.816328 | 2026-01-18 00:21:32.816437 | TASK [tox : Look for output] 2026-01-18 00:21:33.280729 | debian-bookworm | ok 2026-01-18 00:21:33.305429 | 2026-01-18 00:21:33.305578 | TASK [tox : Return file comments to Zuul] 2026-01-18 00:21:33.373013 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:33.386069 | 2026-01-18 00:21:33.386183 | PLAY RECAP 2026-01-18 00:21:33.386442 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-18 00:21:33.386486 | 2026-01-18 00:21:33.686308 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-18 00:21:33.688047 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-18 00:21:34.842711 | 2026-01-18 00:21:34.842886 | PLAY [all] 2026-01-18 00:21:34.864822 | 2026-01-18 00:21:34.864973 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-18 00:21:34.929027 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:34.934916 | 2026-01-18 00:21:34.935050 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-18 00:21:34.981365 | debian-bookworm | ok 2026-01-18 00:21:34.991035 | 2026-01-18 00:21:34.991173 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-18 00:21:36.163268 | debian-bookworm -> localhost | changed 2026-01-18 00:21:36.173199 | 2026-01-18 00:21:36.173305 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-18 00:21:36.282169 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:36.287692 | 2026-01-18 00:21:36.287793 | TASK [fetch-tox-output : Set envlist fact] 2026-01-18 00:21:36.400221 | debian-bookworm | ok 2026-01-18 00:21:36.415064 | 2026-01-18 00:21:36.415169 | TASK [fetch-tox-output : Get tox version] 2026-01-18 00:21:37.355948 | 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-01-18 00:21:37.373180 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-18 00:21:37.554699 | debian-bookworm | ok: Runtime: 0:00:00.250968 2026-01-18 00:21:37.562585 | 2026-01-18 00:21:37.562683 | TASK [fetch-tox-output : Find all default environments] 2026-01-18 00:21:38.136407 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:38.142426 | 2026-01-18 00:21:38.142529 | TASK [fetch-tox-output : Set envlist fact] 2026-01-18 00:21:38.185922 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:38.192208 | 2026-01-18 00:21:38.192311 | TASK [fetch-tox-output : Find all default environments] 2026-01-18 00:21:38.749204 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:38.754759 | 2026-01-18 00:21:38.754877 | TASK [fetch-tox-output : Set envlist fact] 2026-01-18 00:21:38.798428 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:38.804481 | 2026-01-18 00:21:38.804574 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-18 00:21:38.886258 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:38.904468 | 2026-01-18 00:21:38.904574 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-18 00:21:40.354824 | debian-bookworm | changed: 2026-01-18 00:21:40.355014 | debian-bookworm | created directory /var/lib/zuul/builds/bbd7dd60b8634c0599ed2c7853a96e83/work/logs/tox/test 2026-01-18 00:21:40.355049 | debian-bookworm | cd+++++++++ ./ 2026-01-18 00:21:40.355075 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-18 00:21:40.355105 | 2026-01-18 00:21:40.369820 | 2026-01-18 00:21:40.370058 | PLAY RECAP 2026-01-18 00:21:40.370124 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-18 00:21:40.370152 | 2026-01-18 00:21:40.649407 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-18 00:21:40.650873 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-18 00:21:42.051543 | 2026-01-18 00:21:42.051663 | PLAY [all] 2026-01-18 00:21:42.086574 | 2026-01-18 00:21:42.086693 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-18 00:21:42.372361 | debian-bookworm | changed: non-zero return code 2026-01-18 00:21:42.376874 | 2026-01-18 00:21:42.376975 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-18 00:21:42.404837 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:42.409965 | 2026-01-18 00:21:42.410059 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-18 00:21:42.449688 | 2026-01-18 00:21:42.449839 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-18 00:21:42.488881 | 2026-01-18 00:21:42.489040 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-18 00:21:42.527247 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:42.532451 | 2026-01-18 00:21:42.532547 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-18 00:21:42.571833 | 2026-01-18 00:21:42.571995 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-18 00:21:42.594758 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:42.599375 | 2026-01-18 00:21:42.599460 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-18 00:21:42.622543 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:42.627211 | 2026-01-18 00:21:42.627288 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-18 00:21:42.651121 | debian-bookworm | skipping: Conditional result was False 2026-01-18 00:21:42.658045 | 2026-01-18 00:21:42.658117 | PLAY RECAP 2026-01-18 00:21:42.658162 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-18 00:21:42.658183 | 2026-01-18 00:21:42.890676 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-18 00:21:42.891514 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-18 00:21:43.815160 | 2026-01-18 00:21:43.815274 | PLAY [Base post] 2026-01-18 00:21:43.828621 | 2026-01-18 00:21:43.828737 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-18 00:21:44.632871 | debian-bookworm | changed 2026-01-18 00:21:44.638265 | 2026-01-18 00:21:44.638370 | PLAY RECAP 2026-01-18 00:21:44.638423 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-18 00:21:44.638474 | 2026-01-18 00:21:44.840696 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-18 00:21:44.842322 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-18 00:21:45.742702 | 2026-01-18 00:21:45.742828 | PLAY [Base post-logs] 2026-01-18 00:21:45.760775 | 2026-01-18 00:21:45.760896 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-18 00:21:46.260682 | localhost | changed 2026-01-18 00:21:46.274228 | 2026-01-18 00:21:46.274361 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-18 00:21:46.311829 | localhost | ok 2026-01-18 00:21:46.317510 | 2026-01-18 00:21:46.317972 | TASK [Set zuul-log-path fact] 2026-01-18 00:21:46.337958 | localhost | ok 2026-01-18 00:21:46.351455 | 2026-01-18 00:21:46.351560 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-18 00:21:46.375902 | localhost | ok 2026-01-18 00:21:46.378640 | 2026-01-18 00:21:46.378719 | TASK [upload-logs : Create log directories] 2026-01-18 00:21:46.914753 | localhost | changed 2026-01-18 00:21:46.924210 | 2026-01-18 00:21:46.924357 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-18 00:21:47.520560 | localhost -> localhost | ok: Runtime: 0:00:00.024017 2026-01-18 00:21:47.524321 | 2026-01-18 00:21:47.524415 | TASK [upload-logs : Upload logs to log server] 2026-01-18 00:21:48.244203 | localhost | Output suppressed because no_log was given 2026-01-18 00:21:48.245585 | 2026-01-18 00:21:48.245657 | LOOP [upload-logs : Compress console log and json output] 2026-01-18 00:21:48.284578 | localhost | skipping: Conditional result was False 2026-01-18 00:21:48.290580 | localhost | skipping: Conditional result was False 2026-01-18 00:21:48.300257 | 2026-01-18 00:21:48.300334 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-18 00:21:48.334249 | localhost | skipping: Conditional result was False 2026-01-18 00:21:48.334459 | 2026-01-18 00:21:48.338264 | localhost | skipping: Conditional result was False 2026-01-18 00:21:48.344572 | 2026-01-18 00:21:48.344649 | LOOP [upload-logs : Upload console log and json output]