2025-12-21 00:20:42.677425 | Job console starting 2025-12-21 00:20:42.689908 | Updating git repos 2025-12-21 00:20:42.719377 | Cloning repos into workspace 2025-12-21 00:20:42.776338 | Restoring repo states 2025-12-21 00:20:42.787043 | Merging changes 2025-12-21 00:20:43.499342 | Checking out repos 2025-12-21 00:20:43.558190 | Preparing playbooks 2025-12-21 00:20:44.624044 | Running Ansible setup 2025-12-21 00:20:53.141338 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-21 00:20:55.696193 | 2025-12-21 00:20:55.701414 | PLAY [Base pre] 2025-12-21 00:20:55.761576 | 2025-12-21 00:20:55.761810 | TASK [Setup log path fact] 2025-12-21 00:20:55.812826 | debian-bookworm | ok 2025-12-21 00:20:55.893309 | 2025-12-21 00:20:55.893516 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-21 00:20:56.019119 | debian-bookworm | ok 2025-12-21 00:20:56.085728 | 2025-12-21 00:20:56.085884 | TASK [emit-job-header : Print job information] 2025-12-21 00:20:56.339549 | # Job Information 2025-12-21 00:20:56.339855 | Ansible Version: 2.16.14 2025-12-21 00:20:56.339896 | Job: tox 2025-12-21 00:20:56.339933 | Pipeline: check 2025-12-21 00:20:56.339977 | Executor: 521e9411259a 2025-12-21 00:20:56.340012 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1049 2025-12-21 00:20:56.340039 | Event ID: b7095b70-de02-11f0-8256-69cae2ae8395 2025-12-21 00:20:56.381905 | 2025-12-21 00:20:56.382103 | LOOP [emit-job-header : Print node information] 2025-12-21 00:20:56.742902 | debian-bookworm | ok: 2025-12-21 00:20:56.743129 | debian-bookworm | # Node Information 2025-12-21 00:20:56.743167 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-21 00:20:56.743193 | debian-bookworm | Hostname: debian 2025-12-21 00:20:56.743215 | debian-bookworm | Username: zuul 2025-12-21 00:20:56.743236 | debian-bookworm | Distro: Debian 12.12 2025-12-21 00:20:56.744836 | debian-bookworm | Provider: regiocloud-a 2025-12-21 00:20:56.744908 | debian-bookworm | Region: 2025-12-21 00:20:56.744935 | debian-bookworm | Label: debian-bookworm 2025-12-21 00:20:56.745138 | debian-bookworm | Product Name: OpenStack Nova 2025-12-21 00:20:56.745173 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8a:783d 2025-12-21 00:20:56.779352 | 2025-12-21 00:20:56.780367 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-21 00:20:58.089020 | debian-bookworm -> localhost | changed 2025-12-21 00:20:58.097333 | 2025-12-21 00:20:58.097491 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-21 00:21:02.349672 | debian-bookworm -> localhost | changed 2025-12-21 00:21:02.366133 | 2025-12-21 00:21:02.367533 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-21 00:21:03.590229 | debian-bookworm -> localhost | ok 2025-12-21 00:21:03.598360 | 2025-12-21 00:21:03.598513 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-21 00:21:03.660468 | debian-bookworm | ok 2025-12-21 00:21:03.685180 | debian-bookworm | included: /var/lib/zuul/builds/95df724a889e47f298752782ebfdea9a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-21 00:21:03.692338 | 2025-12-21 00:21:03.692466 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-21 00:21:08.008617 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-21 00:21:08.008838 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/95df724a889e47f298752782ebfdea9a/work/95df724a889e47f298752782ebfdea9a_id_rsa 2025-12-21 00:21:08.008875 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/95df724a889e47f298752782ebfdea9a/work/95df724a889e47f298752782ebfdea9a_id_rsa.pub 2025-12-21 00:21:08.008902 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-21 00:21:08.008929 | debian-bookworm -> localhost | SHA256:IoZMG7oYWVORn1tqLJd9XeluB8YZvOZvvss8fEEW7T0 zuul-build-sshkey 2025-12-21 00:21:08.008952 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-21 00:21:08.009008 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-21 00:21:08.009032 | debian-bookworm -> localhost | | oo .| 2025-12-21 00:21:08.009054 | debian-bookworm -> localhost | | .. ..| 2025-12-21 00:21:08.009075 | debian-bookworm -> localhost | | = . . . oo| 2025-12-21 00:21:08.009095 | debian-bookworm -> localhost | | * = o . =Eo| 2025-12-21 00:21:08.009115 | debian-bookworm -> localhost | |+ + o..*S . +o+.| 2025-12-21 00:21:08.009142 | debian-bookworm -> localhost | |.o ...B.. . . O. | 2025-12-21 00:21:08.009163 | debian-bookworm -> localhost | |o + . =...| 2025-12-21 00:21:08.009184 | debian-bookworm -> localhost | | *o+| 2025-12-21 00:21:08.009205 | debian-bookworm -> localhost | | . XB| 2025-12-21 00:21:08.009225 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-21 00:21:08.009276 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.574278 2025-12-21 00:21:08.018016 | 2025-12-21 00:21:08.018297 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-21 00:21:08.066025 | debian-bookworm | ok 2025-12-21 00:21:08.118294 | debian-bookworm | included: /var/lib/zuul/builds/95df724a889e47f298752782ebfdea9a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-21 00:21:08.135931 | 2025-12-21 00:21:08.136099 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-21 00:21:08.161643 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:21:08.169524 | 2025-12-21 00:21:08.169673 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-21 00:21:09.484744 | debian-bookworm | changed 2025-12-21 00:21:09.501660 | 2025-12-21 00:21:09.501809 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-21 00:21:09.793465 | debian-bookworm | ok 2025-12-21 00:21:09.813663 | 2025-12-21 00:21:09.814132 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-21 00:21:10.626885 | debian-bookworm | changed 2025-12-21 00:21:10.650948 | 2025-12-21 00:21:10.651147 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-21 00:21:11.494672 | debian-bookworm | changed 2025-12-21 00:21:11.504922 | 2025-12-21 00:21:11.505216 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-21 00:21:11.587274 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:21:11.606740 | 2025-12-21 00:21:11.606924 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-21 00:21:13.427403 | debian-bookworm -> localhost | changed 2025-12-21 00:21:13.457220 | 2025-12-21 00:21:13.457365 | TASK [add-build-sshkey : Add back temp key] 2025-12-21 00:21:15.051702 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/95df724a889e47f298752782ebfdea9a/work/95df724a889e47f298752782ebfdea9a_id_rsa (zuul-build-sshkey) 2025-12-21 00:21:15.052061 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.051966 2025-12-21 00:21:15.068046 | 2025-12-21 00:21:15.069546 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-21 00:21:16.424379 | debian-bookworm | ok 2025-12-21 00:21:16.436709 | 2025-12-21 00:21:16.436908 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-21 00:21:16.534499 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:21:16.552558 | 2025-12-21 00:21:16.552739 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-21 00:21:17.623997 | debian-bookworm | ok 2025-12-21 00:21:17.664508 | 2025-12-21 00:21:17.664669 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-21 00:21:17.778242 | debian-bookworm | ok 2025-12-21 00:21:17.797133 | 2025-12-21 00:21:17.797308 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-21 00:21:18.435464 | debian-bookworm -> localhost | ok 2025-12-21 00:21:18.443074 | 2025-12-21 00:21:18.443206 | TASK [validate-host : Collect information about the host] 2025-12-21 00:21:20.503928 | debian-bookworm | ok 2025-12-21 00:21:20.532884 | 2025-12-21 00:21:20.533066 | TASK [validate-host : Sanitize hostname] 2025-12-21 00:21:20.753328 | debian-bookworm | ok 2025-12-21 00:21:20.930815 | 2025-12-21 00:21:20.932323 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-21 00:21:22.602916 | debian-bookworm -> localhost | changed 2025-12-21 00:21:22.622127 | 2025-12-21 00:21:22.622275 | TASK [validate-host : Collect information about zuul worker] 2025-12-21 00:21:23.449812 | debian-bookworm | ok 2025-12-21 00:21:23.468442 | 2025-12-21 00:21:23.468588 | TASK [validate-host : Write out all zuul information for each host] 2025-12-21 00:21:25.595335 | debian-bookworm -> localhost | changed 2025-12-21 00:21:25.606056 | 2025-12-21 00:21:25.606189 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-21 00:21:25.959097 | debian-bookworm | ok 2025-12-21 00:21:26.017081 | 2025-12-21 00:21:26.020120 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-21 00:21:27.849904 | debian-bookworm | changed: 2025-12-21 00:21:27.850687 | debian-bookworm | cd+++++++++ src/ 2025-12-21 00:21:27.850744 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-21 00:21:27.850775 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-21 00:21:27.850807 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-21 00:21:27.850852 | debian-bookworm | =6.2 2025-12-21 00:22:01.358709 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2025-12-21 00:22:01.395684 | debian-bookworm | Collecting chardet>=5.2 2025-12-21 00:22:01.407369 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-21 00:22:01.417546 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 28.7 MB/s eta 0:00:00 2025-12-21 00:22:01.456450 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-21 00:22:01.468773 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-21 00:22:01.534624 | debian-bookworm | Collecting filelock>=3.20 2025-12-21 00:22:01.546314 | debian-bookworm | Downloading filelock-3.20.1-py3-none-any.whl (16 kB) 2025-12-21 00:22:01.597663 | debian-bookworm | Collecting packaging>=25 2025-12-21 00:22:01.609724 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-21 00:22:01.618457 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.8 MB/s eta 0:00:00 2025-12-21 00:22:01.666638 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-21 00:22:01.678737 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-21 00:22:01.719845 | debian-bookworm | Collecting pluggy>=1.6 2025-12-21 00:22:01.731315 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-21 00:22:01.774663 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-21 00:22:01.787070 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-21 00:22:01.919810 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-21 00:22:01.933554 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-21 00:22:02.188692 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 24.2 MB/s eta 0:00:00 2025-12-21 00:22:02.301383 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-21 00:22:02.313494 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-21 00:22:02.340159 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.0 MB/s eta 0:00:00 2025-12-21 00:22:02.508382 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-21 00:22:03.400846 | 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-21 00:22:03.756734 | debian-bookworm | ok: Runtime: 0:00:03.062740 2025-12-21 00:22:03.769741 | 2025-12-21 00:22:03.769947 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-21 00:22:03.864193 | debian-bookworm | ok 2025-12-21 00:22:03.875684 | 2025-12-21 00:22:03.875830 | TASK [ensure-tox : Output tox version] 2025-12-21 00:22:04.536025 | 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-21 00:22:04.555097 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-21 00:22:04.975497 | debian-bookworm | ok: Runtime: 0:00:00.317156 2025-12-21 00:22:04.983778 | 2025-12-21 00:22:04.983915 | TASK [ensure-tox : Make global symlink] 2025-12-21 00:22:05.011483 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:05.024943 | 2025-12-21 00:22:05.025107 | PLAY RECAP 2025-12-21 00:22:05.025167 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-21 00:22:05.025194 | 2025-12-21 00:22:05.183144 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-21 00:22:05.184265 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-21 00:22:06.253113 | 2025-12-21 00:22:06.253361 | PLAY [all] 2025-12-21 00:22:06.309662 | 2025-12-21 00:22:06.311700 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-21 00:22:06.839976 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-21 00:22:07.350997 | debian-bookworm | ok: Runtime: 0:00:00.027392 2025-12-21 00:22:07.360179 | 2025-12-21 00:22:07.360684 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-21 00:22:07.917428 | debian-bookworm | ok: Runtime: 0:00:00.007503 2025-12-21 00:22:07.930250 | 2025-12-21 00:22:07.930444 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-21 00:22:08.269164 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-21 00:22:08.269270 | debian-bookworm | sudo: a password is required 2025-12-21 00:22:08.489375 | debian-bookworm | ok: Runtime: 0:00:00.019528 2025-12-21 00:22:08.499879 | 2025-12-21 00:22:08.500020 | TASK [tox : Check to see if the constraints file exists] 2025-12-21 00:22:08.539186 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:08.546574 | 2025-12-21 00:22:08.546720 | TASK [tox : Fail if constraints file is missing] 2025-12-21 00:22:08.606207 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:08.620434 | 2025-12-21 00:22:08.620910 | TASK [tox : Record file location] 2025-12-21 00:22:08.659876 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:08.674645 | 2025-12-21 00:22:08.674888 | TASK [tox : Install tox siblings] 2025-12-21 00:22:08.712543 | debian-bookworm | ok 2025-12-21 00:22:08.725764 | debian-bookworm | included: /var/lib/zuul/builds/95df724a889e47f298752782ebfdea9a/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-21 00:22:08.735123 | 2025-12-21 00:22:08.735297 | TASK [tox : Run tox without tests] 2025-12-21 00:22:09.851434 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-21 00:22:24.205239 | debian-bookworm | test: OK (14.94 seconds) 2025-12-21 00:22:24.205293 | debian-bookworm | congratulations :) (14.97 seconds) 2025-12-21 00:22:24.770233 | debian-bookworm | ok: Runtime: 0:00:15.271769 2025-12-21 00:22:24.777083 | 2025-12-21 00:22:24.777240 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-21 00:22:25.531460 | debian-bookworm | changed 2025-12-21 00:22:25.542372 | 2025-12-21 00:22:25.544248 | TASK [tox : Get tox envlist config] 2025-12-21 00:22:26.628171 | debian-bookworm | ok: Runtime: 0:00:00.314820 2025-12-21 00:22:26.634395 | 2025-12-21 00:22:26.634524 | TASK [tox : Install any sibling python packages] 2025-12-21 00:22:27.513529 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-21 00:22:27.520020 | 2025-12-21 00:22:27.520212 | TASK [tox : Remove tempfile] 2025-12-21 00:22:28.012337 | debian-bookworm | changed 2025-12-21 00:22:28.018495 | 2025-12-21 00:22:28.018611 | TASK [tox : Emit tox command] 2025-12-21 00:22:28.070145 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-21 00:22:28.079802 | 2025-12-21 00:22:28.079940 | TASK [tox : Run tox] 2025-12-21 00:22:28.770723 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-21 00:22:29.372316 | debian-bookworm | ............... 2025-12-21 00:22:29.372355 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-21 00:22:29.372368 | debian-bookworm | Ran 15 tests in 0.184s 2025-12-21 00:22:29.372374 | debian-bookworm | 2025-12-21 00:22:29.372382 | debian-bookworm | OK 2025-12-21 00:22:29.430938 | debian-bookworm | test: OK (0.70=setup[0.04]+cmd[0.66] seconds) 2025-12-21 00:22:29.430980 | debian-bookworm | congratulations :) (0.72 seconds) 2025-12-21 00:22:29.701501 | debian-bookworm | ok: Runtime: 0:00:00.980610 2025-12-21 00:22:29.708685 | 2025-12-21 00:22:29.708827 | TASK [tox : Look for output] 2025-12-21 00:22:30.738370 | debian-bookworm | ok 2025-12-21 00:22:30.768284 | 2025-12-21 00:22:30.768438 | TASK [tox : Return file comments to Zuul] 2025-12-21 00:22:30.887985 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:30.895702 | 2025-12-21 00:22:30.895797 | PLAY RECAP 2025-12-21 00:22:30.895852 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-21 00:22:30.895877 | 2025-12-21 00:22:31.432846 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-21 00:22:31.434076 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-21 00:22:34.156381 | 2025-12-21 00:22:34.157447 | PLAY [all] 2025-12-21 00:22:34.221884 | 2025-12-21 00:22:34.222194 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-21 00:22:34.405279 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:34.414647 | 2025-12-21 00:22:34.414850 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-21 00:22:34.531669 | debian-bookworm | ok 2025-12-21 00:22:34.559250 | 2025-12-21 00:22:34.559587 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-21 00:22:35.486284 | debian-bookworm -> localhost | changed 2025-12-21 00:22:35.497194 | 2025-12-21 00:22:35.497341 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-21 00:22:35.592494 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:35.600597 | 2025-12-21 00:22:35.600756 | TASK [fetch-tox-output : Set envlist fact] 2025-12-21 00:22:35.661621 | debian-bookworm | ok 2025-12-21 00:22:35.670064 | 2025-12-21 00:22:35.670209 | TASK [fetch-tox-output : Get tox version] 2025-12-21 00:22:36.462398 | 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-21 00:22:36.480683 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-21 00:22:36.727029 | debian-bookworm | ok: Runtime: 0:00:00.282007 2025-12-21 00:22:36.741507 | 2025-12-21 00:22:36.741665 | TASK [fetch-tox-output : Find all default environments] 2025-12-21 00:22:37.296721 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:37.307761 | 2025-12-21 00:22:37.307925 | TASK [fetch-tox-output : Set envlist fact] 2025-12-21 00:22:37.365629 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:37.377905 | 2025-12-21 00:22:37.378093 | TASK [fetch-tox-output : Find all default environments] 2025-12-21 00:22:37.955216 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:37.963149 | 2025-12-21 00:22:37.963443 | TASK [fetch-tox-output : Set envlist fact] 2025-12-21 00:22:38.060925 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:38.087835 | 2025-12-21 00:22:38.088244 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-21 00:22:38.199523 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:38.209051 | 2025-12-21 00:22:38.209199 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-21 00:22:39.789542 | debian-bookworm | changed: 2025-12-21 00:22:39.789792 | debian-bookworm | created directory /var/lib/zuul/builds/95df724a889e47f298752782ebfdea9a/work/logs/tox/test 2025-12-21 00:22:39.789832 | debian-bookworm | cd+++++++++ ./ 2025-12-21 00:22:39.789857 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-21 00:22:39.789888 | 2025-12-21 00:22:39.803194 | 2025-12-21 00:22:39.803321 | PLAY RECAP 2025-12-21 00:22:39.803428 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-21 00:22:39.803457 | 2025-12-21 00:22:40.252107 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-21 00:22:40.253156 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-21 00:22:43.075787 | 2025-12-21 00:22:43.075962 | PLAY [all] 2025-12-21 00:22:43.185934 | 2025-12-21 00:22:43.186152 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-21 00:22:43.748804 | debian-bookworm | changed: non-zero return code 2025-12-21 00:22:43.767196 | 2025-12-21 00:22:43.767394 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-21 00:22:43.822702 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:43.832007 | 2025-12-21 00:22:43.832184 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-21 00:22:43.942954 | 2025-12-21 00:22:43.943360 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-21 00:22:44.024690 | 2025-12-21 00:22:44.024919 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-21 00:22:44.072358 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:44.112745 | 2025-12-21 00:22:44.112934 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-21 00:22:44.153491 | 2025-12-21 00:22:44.153740 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-21 00:22:44.223689 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:44.230674 | 2025-12-21 00:22:44.230874 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-21 00:22:44.275529 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:44.282275 | 2025-12-21 00:22:44.282416 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-21 00:22:44.319873 | debian-bookworm | skipping: Conditional result was False 2025-12-21 00:22:44.339326 | 2025-12-21 00:22:44.339461 | PLAY RECAP 2025-12-21 00:22:44.339827 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-21 00:22:44.339879 | 2025-12-21 00:22:44.983775 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-21 00:22:44.984922 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-21 00:22:47.316300 | 2025-12-21 00:22:47.316491 | PLAY [Base post] 2025-12-21 00:22:47.340786 | 2025-12-21 00:22:47.340964 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-21 00:22:48.207123 | debian-bookworm | changed 2025-12-21 00:22:48.234660 | 2025-12-21 00:22:48.234819 | PLAY RECAP 2025-12-21 00:22:48.234952 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-21 00:22:48.235045 | 2025-12-21 00:22:48.515387 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-21 00:22:48.516529 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-21 00:22:50.702907 | 2025-12-21 00:22:50.703116 | PLAY [Base post-logs] 2025-12-21 00:22:50.716674 | 2025-12-21 00:22:50.717362 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-21 00:22:52.240479 | localhost | changed 2025-12-21 00:22:52.271081 | 2025-12-21 00:22:52.271286 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-21 00:22:52.318195 | localhost | ok 2025-12-21 00:22:52.331719 | 2025-12-21 00:22:52.331857 | TASK [Set zuul-log-path fact] 2025-12-21 00:22:52.394081 | localhost | ok 2025-12-21 00:22:52.417172 | 2025-12-21 00:22:52.417326 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-21 00:22:52.523455 | localhost | ok 2025-12-21 00:22:52.527159 | 2025-12-21 00:22:52.527278 | TASK [upload-logs : Create log directories] 2025-12-21 00:22:53.961165 | localhost | changed 2025-12-21 00:22:53.964778 | 2025-12-21 00:22:53.964893 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-21 00:22:54.992666 | localhost -> localhost | ok: Runtime: 0:00:00.008409 2025-12-21 00:22:54.996869 | 2025-12-21 00:22:54.997030 | TASK [upload-logs : Upload logs to log server] 2025-12-21 00:22:55.812030 | localhost | Output suppressed because no_log was given 2025-12-21 00:22:55.814125 | 2025-12-21 00:22:55.814246 | LOOP [upload-logs : Compress console log and json output] 2025-12-21 00:22:55.881003 | localhost | skipping: Conditional result was False 2025-12-21 00:22:55.887391 | localhost | skipping: Conditional result was False 2025-12-21 00:22:55.890798 | 2025-12-21 00:22:55.890939 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-21 00:22:55.963949 | localhost | skipping: Conditional result was False 2025-12-21 00:22:55.964330 | 2025-12-21 00:22:56.000168 | localhost | skipping: Conditional result was False 2025-12-21 00:22:56.009824 | 2025-12-21 00:22:56.009961 | LOOP [upload-logs : Upload console log and json output]