2025-12-11 20:15:32.496482 | Job console starting 2025-12-11 20:15:32.552878 | Updating git repos 2025-12-11 20:15:32.617090 | Cloning repos into workspace 2025-12-11 20:15:32.744531 | Restoring repo states 2025-12-11 20:15:32.777234 | Merging changes 2025-12-11 20:15:33.335468 | Checking out repos 2025-12-11 20:15:33.442181 | Preparing playbooks 2025-12-11 20:15:34.565974 | Running Ansible setup 2025-12-11 20:15:40.304881 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-11 20:15:41.469977 | 2025-12-11 20:15:41.470165 | PLAY [Base pre] 2025-12-11 20:15:41.497993 | 2025-12-11 20:15:41.498176 | TASK [Setup log path fact] 2025-12-11 20:15:41.529621 | debian-bookworm | ok 2025-12-11 20:15:41.560584 | 2025-12-11 20:15:41.560771 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-11 20:15:41.633565 | debian-bookworm | ok 2025-12-11 20:15:41.659640 | 2025-12-11 20:15:41.659807 | TASK [emit-job-header : Print job information] 2025-12-11 20:15:41.751113 | # Job Information 2025-12-11 20:15:41.751334 | Ansible Version: 2.16.14 2025-12-11 20:15:41.751372 | Job: tox 2025-12-11 20:15:41.751405 | Pipeline: check 2025-12-11 20:15:41.751428 | Executor: 521e9411259a 2025-12-11 20:15:41.751448 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1031 2025-12-11 20:15:41.751470 | Event ID: 1e3badc0-d6ce-11f0-9f80-6b075b51ea20 2025-12-11 20:15:41.764755 | 2025-12-11 20:15:41.764918 | LOOP [emit-job-header : Print node information] 2025-12-11 20:15:41.992983 | debian-bookworm | ok: 2025-12-11 20:15:41.993326 | debian-bookworm | # Node Information 2025-12-11 20:15:41.993381 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-11 20:15:41.993407 | debian-bookworm | Hostname: debian 2025-12-11 20:15:41.993429 | debian-bookworm | Username: zuul 2025-12-11 20:15:41.993451 | debian-bookworm | Distro: Debian 12.12 2025-12-11 20:15:41.993477 | debian-bookworm | Provider: regiocloud-a 2025-12-11 20:15:41.993497 | debian-bookworm | Region: 2025-12-11 20:15:41.993518 | debian-bookworm | Label: debian-bookworm 2025-12-11 20:15:41.993539 | debian-bookworm | Product Name: OpenStack Nova 2025-12-11 20:15:41.993559 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe00:e0e2 2025-12-11 20:15:42.014559 | 2025-12-11 20:15:42.014717 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-11 20:15:42.879301 | debian-bookworm -> localhost | changed 2025-12-11 20:15:42.888219 | 2025-12-11 20:15:42.888411 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-11 20:15:44.724239 | debian-bookworm -> localhost | changed 2025-12-11 20:15:44.735724 | 2025-12-11 20:15:44.735870 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-11 20:15:45.236770 | debian-bookworm -> localhost | ok 2025-12-11 20:15:45.243441 | 2025-12-11 20:15:45.243588 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-11 20:15:45.289324 | debian-bookworm | ok 2025-12-11 20:15:45.308557 | debian-bookworm | included: /var/lib/zuul/builds/5b71045016de491e878c5694abe7e8c1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-11 20:15:45.315984 | 2025-12-11 20:15:45.316122 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-11 20:15:47.949230 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-11 20:15:47.949485 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5b71045016de491e878c5694abe7e8c1/work/5b71045016de491e878c5694abe7e8c1_id_rsa 2025-12-11 20:15:47.949526 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5b71045016de491e878c5694abe7e8c1/work/5b71045016de491e878c5694abe7e8c1_id_rsa.pub 2025-12-11 20:15:47.949553 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-11 20:15:47.949579 | debian-bookworm -> localhost | SHA256:HCOBLoMeng9qC6mt/VU9JH6XpcgnLcjfSfe9rSgXObM zuul-build-sshkey 2025-12-11 20:15:47.949602 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-11 20:15:47.949636 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-11 20:15:47.949658 | debian-bookworm -> localhost | | .. | 2025-12-11 20:15:47.949680 | debian-bookworm -> localhost | | . . | 2025-12-11 20:15:47.949700 | debian-bookworm -> localhost | | . . . + . . | 2025-12-11 20:15:47.949720 | debian-bookworm -> localhost | |..o . = O o + | 2025-12-11 20:15:47.949740 | debian-bookworm -> localhost | |o oo S O B.. | 2025-12-11 20:15:47.949766 | debian-bookworm -> localhost | | * . o O=o ..| 2025-12-11 20:15:47.949786 | debian-bookworm -> localhost | |+ o . . o= o| 2025-12-11 20:15:47.949806 | debian-bookworm -> localhost | |++ . . . E. o| 2025-12-11 20:15:47.949827 | debian-bookworm -> localhost | |+o+.. o. .o.| 2025-12-11 20:15:47.949847 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-11 20:15:47.949903 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.841046 2025-12-11 20:15:47.957132 | 2025-12-11 20:15:47.957343 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-11 20:15:47.986975 | debian-bookworm | ok 2025-12-11 20:15:47.997634 | debian-bookworm | included: /var/lib/zuul/builds/5b71045016de491e878c5694abe7e8c1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-11 20:15:48.008403 | 2025-12-11 20:15:48.008532 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-11 20:15:48.032895 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:15:48.039205 | 2025-12-11 20:15:48.039332 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-11 20:15:48.750180 | debian-bookworm | changed 2025-12-11 20:15:48.758954 | 2025-12-11 20:15:48.759109 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-11 20:15:49.021217 | debian-bookworm | ok 2025-12-11 20:15:49.031738 | 2025-12-11 20:15:49.031901 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-11 20:15:49.751196 | debian-bookworm | changed 2025-12-11 20:15:49.769850 | 2025-12-11 20:15:49.770000 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-11 20:15:50.466691 | debian-bookworm | changed 2025-12-11 20:15:50.476997 | 2025-12-11 20:15:50.477132 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-11 20:15:50.501554 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:15:50.516861 | 2025-12-11 20:15:50.517062 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-11 20:15:51.289427 | debian-bookworm -> localhost | changed 2025-12-11 20:15:51.303589 | 2025-12-11 20:15:51.303829 | TASK [add-build-sshkey : Add back temp key] 2025-12-11 20:15:51.768788 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5b71045016de491e878c5694abe7e8c1/work/5b71045016de491e878c5694abe7e8c1_id_rsa (zuul-build-sshkey) 2025-12-11 20:15:51.769042 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019219 2025-12-11 20:15:51.778133 | 2025-12-11 20:15:51.778298 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-11 20:15:52.208583 | debian-bookworm | ok 2025-12-11 20:15:52.214041 | 2025-12-11 20:15:52.214166 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-11 20:15:52.281873 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:15:52.293776 | 2025-12-11 20:15:52.293919 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-11 20:15:52.891864 | debian-bookworm | ok 2025-12-11 20:15:52.915276 | 2025-12-11 20:15:52.915492 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-11 20:15:52.946331 | debian-bookworm | ok 2025-12-11 20:15:52.955056 | 2025-12-11 20:15:52.955205 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-11 20:15:53.294613 | debian-bookworm -> localhost | ok 2025-12-11 20:15:53.305221 | 2025-12-11 20:15:53.305463 | TASK [validate-host : Collect information about the host] 2025-12-11 20:15:54.455783 | debian-bookworm | ok 2025-12-11 20:15:54.475376 | 2025-12-11 20:15:54.475529 | TASK [validate-host : Sanitize hostname] 2025-12-11 20:15:54.678399 | debian-bookworm | ok 2025-12-11 20:15:54.760980 | 2025-12-11 20:15:54.761206 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-11 20:15:55.535136 | debian-bookworm -> localhost | changed 2025-12-11 20:15:55.541702 | 2025-12-11 20:15:55.541833 | TASK [validate-host : Collect information about zuul worker] 2025-12-11 20:15:55.978740 | debian-bookworm | ok 2025-12-11 20:15:55.990662 | 2025-12-11 20:15:55.990816 | TASK [validate-host : Write out all zuul information for each host] 2025-12-11 20:15:56.824609 | debian-bookworm -> localhost | changed 2025-12-11 20:15:56.835097 | 2025-12-11 20:15:56.835238 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-11 20:15:57.142604 | debian-bookworm | ok 2025-12-11 20:15:57.149644 | 2025-12-11 20:15:57.149761 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-11 20:15:58.348689 | debian-bookworm | changed: 2025-12-11 20:15:58.348921 | debian-bookworm | cd+++++++++ src/ 2025-12-11 20:15:58.348958 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-11 20:15:58.348982 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-11 20:15:58.349003 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-11 20:15:58.349024 | debian-bookworm | =6.2 2025-12-11 20:16:21.903502 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-12-11 20:16:21.946361 | debian-bookworm | Collecting chardet>=5.2 2025-12-11 20:16:21.961838 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-11 20:16:21.972519 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 25.8 MB/s eta 0:00:00 2025-12-11 20:16:22.012307 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-11 20:16:22.024462 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-11 20:16:22.099000 | debian-bookworm | Collecting filelock>=3.20 2025-12-11 20:16:22.113147 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-12-11 20:16:22.174284 | debian-bookworm | Collecting packaging>=25 2025-12-11 20:16:22.188499 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-11 20:16:22.198660 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 10.8 MB/s eta 0:00:00 2025-12-11 20:16:22.274931 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-11 20:16:22.287982 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-11 20:16:22.356012 | debian-bookworm | Collecting pluggy>=1.6 2025-12-11 20:16:22.367850 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-11 20:16:22.430109 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-11 20:16:22.448723 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-11 20:16:22.591372 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-11 20:16:22.629672 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-11 20:16:22.928926 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 20.7 MB/s eta 0:00:00 2025-12-11 20:16:23.036692 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-11 20:16:23.048385 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-11 20:16:23.072449 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.7 MB/s eta 0:00:00 2025-12-11 20:16:23.217636 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-11 20:16:24.105038 | debian-bookworm | Successfully installed cachetools-6.2.2 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 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-11 20:16:24.319491 | debian-bookworm | ok: Runtime: 0:00:03.155990 2025-12-11 20:16:24.326714 | 2025-12-11 20:16:24.326872 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-11 20:16:24.385067 | debian-bookworm | ok 2025-12-11 20:16:24.395084 | 2025-12-11 20:16:24.395231 | TASK [ensure-tox : Output tox version] 2025-12-11 20:16:24.957876 | 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-11 20:16:24.976271 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-11 20:16:25.444815 | debian-bookworm | ok: Runtime: 0:00:00.301304 2025-12-11 20:16:25.463120 | 2025-12-11 20:16:25.463332 | TASK [ensure-tox : Make global symlink] 2025-12-11 20:16:25.511579 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:25.528036 | 2025-12-11 20:16:25.529023 | PLAY RECAP 2025-12-11 20:16:25.529549 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-11 20:16:25.529604 | 2025-12-11 20:16:25.734125 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-11 20:16:25.735384 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-11 20:16:26.631603 | 2025-12-11 20:16:26.631784 | PLAY [all] 2025-12-11 20:16:26.649131 | 2025-12-11 20:16:26.649324 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-11 20:16:27.202185 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-11 20:16:27.684474 | debian-bookworm | ok: Runtime: 0:00:00.030060 2025-12-11 20:16:27.694899 | 2025-12-11 20:16:27.695055 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-11 20:16:28.233624 | debian-bookworm | ok: Runtime: 0:00:00.007182 2025-12-11 20:16:28.239801 | 2025-12-11 20:16:28.239931 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-11 20:16:28.542673 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-11 20:16:28.546140 | debian-bookworm | sudo: a password is required 2025-12-11 20:16:28.771310 | debian-bookworm | ok: Runtime: 0:00:00.025541 2025-12-11 20:16:28.790686 | 2025-12-11 20:16:28.790851 | TASK [tox : Check to see if the constraints file exists] 2025-12-11 20:16:28.817512 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:28.823888 | 2025-12-11 20:16:28.824018 | TASK [tox : Fail if constraints file is missing] 2025-12-11 20:16:28.860120 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:28.871615 | 2025-12-11 20:16:28.871809 | TASK [tox : Record file location] 2025-12-11 20:16:28.908300 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:28.917378 | 2025-12-11 20:16:28.917556 | TASK [tox : Install tox siblings] 2025-12-11 20:16:28.961160 | debian-bookworm | ok 2025-12-11 20:16:28.977093 | debian-bookworm | included: /var/lib/zuul/builds/5b71045016de491e878c5694abe7e8c1/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-11 20:16:28.986888 | 2025-12-11 20:16:28.987077 | TASK [tox : Run tox without tests] 2025-12-11 20:16:30.196678 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-11 20:16:44.365195 | debian-bookworm | test: OK (14.78 seconds) 2025-12-11 20:16:44.365254 | debian-bookworm | congratulations :) (14.81 seconds) 2025-12-11 20:16:44.537899 | debian-bookworm | ok: Runtime: 0:00:15.105016 2025-12-11 20:16:44.544105 | 2025-12-11 20:16:44.544238 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-11 20:16:44.978812 | debian-bookworm | changed 2025-12-11 20:16:44.985494 | 2025-12-11 20:16:44.985632 | TASK [tox : Get tox envlist config] 2025-12-11 20:16:46.017429 | debian-bookworm | ok: Runtime: 0:00:00.349193 2025-12-11 20:16:46.032423 | 2025-12-11 20:16:46.032654 | TASK [tox : Install any sibling python packages] 2025-12-11 20:16:46.486912 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-11 20:16:46.495613 | 2025-12-11 20:16:46.495775 | TASK [tox : Remove tempfile] 2025-12-11 20:16:46.963967 | debian-bookworm | changed 2025-12-11 20:16:46.972222 | 2025-12-11 20:16:46.972434 | TASK [tox : Emit tox command] 2025-12-11 20:16:47.024511 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-11 20:16:47.031116 | 2025-12-11 20:16:47.031318 | TASK [tox : Run tox] 2025-12-11 20:16:47.671416 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-11 20:16:48.291386 | debian-bookworm | ............... 2025-12-11 20:16:48.291437 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-11 20:16:48.291452 | debian-bookworm | Ran 15 tests in 0.168s 2025-12-11 20:16:48.291458 | debian-bookworm | 2025-12-11 20:16:48.291465 | debian-bookworm | OK 2025-12-11 20:16:48.386314 | debian-bookworm | test: OK (0.76=setup[0.05]+cmd[0.71] seconds) 2025-12-11 20:16:48.386394 | debian-bookworm | congratulations :) (0.79 seconds) 2025-12-11 20:16:48.601665 | debian-bookworm | ok: Runtime: 0:00:01.082237 2025-12-11 20:16:48.616136 | 2025-12-11 20:16:48.616384 | TASK [tox : Look for output] 2025-12-11 20:16:49.033270 | debian-bookworm | ok 2025-12-11 20:16:49.056134 | 2025-12-11 20:16:49.056385 | TASK [tox : Return file comments to Zuul] 2025-12-11 20:16:49.102440 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:49.117960 | 2025-12-11 20:16:49.118119 | PLAY RECAP 2025-12-11 20:16:49.118210 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-11 20:16:49.118282 | 2025-12-11 20:16:49.265097 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-11 20:16:49.266306 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-11 20:16:50.079405 | 2025-12-11 20:16:50.079609 | PLAY [all] 2025-12-11 20:16:50.095384 | 2025-12-11 20:16:50.095539 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-11 20:16:50.150474 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:50.156578 | 2025-12-11 20:16:50.156729 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-11 20:16:50.211530 | debian-bookworm | ok 2025-12-11 20:16:50.220425 | 2025-12-11 20:16:50.220588 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-11 20:16:50.732996 | debian-bookworm -> localhost | changed 2025-12-11 20:16:50.741462 | 2025-12-11 20:16:50.741596 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-11 20:16:50.796130 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:50.807214 | 2025-12-11 20:16:50.807409 | TASK [fetch-tox-output : Set envlist fact] 2025-12-11 20:16:50.855137 | debian-bookworm | ok 2025-12-11 20:16:50.863906 | 2025-12-11 20:16:50.864034 | TASK [fetch-tox-output : Get tox version] 2025-12-11 20:16:51.574713 | 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-11 20:16:51.593401 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-11 20:16:51.897566 | debian-bookworm | ok: Runtime: 0:00:00.310863 2025-12-11 20:16:51.912639 | 2025-12-11 20:16:51.912854 | TASK [fetch-tox-output : Find all default environments] 2025-12-11 20:16:52.455926 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:52.468531 | 2025-12-11 20:16:52.468828 | TASK [fetch-tox-output : Set envlist fact] 2025-12-11 20:16:52.515184 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:52.524603 | 2025-12-11 20:16:52.524821 | TASK [fetch-tox-output : Find all default environments] 2025-12-11 20:16:53.061607 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:53.068553 | 2025-12-11 20:16:53.068695 | TASK [fetch-tox-output : Set envlist fact] 2025-12-11 20:16:53.104697 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:53.112510 | 2025-12-11 20:16:53.112657 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-11 20:16:53.172119 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:53.186937 | 2025-12-11 20:16:53.187115 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-11 20:16:53.998042 | debian-bookworm | changed: 2025-12-11 20:16:53.998298 | debian-bookworm | created directory /var/lib/zuul/builds/5b71045016de491e878c5694abe7e8c1/work/logs/tox/test 2025-12-11 20:16:53.998783 | debian-bookworm | cd+++++++++ ./ 2025-12-11 20:16:53.998826 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-11 20:16:53.998963 | 2025-12-11 20:16:54.020636 | 2025-12-11 20:16:54.020789 | PLAY RECAP 2025-12-11 20:16:54.020875 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-11 20:16:54.020916 | 2025-12-11 20:16:54.208998 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-11 20:16:54.210071 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-11 20:16:55.075979 | 2025-12-11 20:16:55.076180 | PLAY [all] 2025-12-11 20:16:55.093189 | 2025-12-11 20:16:55.093408 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-11 20:16:55.326113 | debian-bookworm | changed: non-zero return code 2025-12-11 20:16:55.344393 | 2025-12-11 20:16:55.344592 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-11 20:16:55.370575 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:55.378777 | 2025-12-11 20:16:55.379017 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-11 20:16:55.416563 | 2025-12-11 20:16:55.416855 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-11 20:16:55.454795 | 2025-12-11 20:16:55.455522 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-11 20:16:55.483238 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:55.491650 | 2025-12-11 20:16:55.491844 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-11 20:16:55.525551 | 2025-12-11 20:16:55.525894 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-11 20:16:55.553265 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:55.560638 | 2025-12-11 20:16:55.560859 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-11 20:16:55.585735 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:55.593515 | 2025-12-11 20:16:55.593688 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-11 20:16:55.618597 | debian-bookworm | skipping: Conditional result was False 2025-12-11 20:16:55.628223 | 2025-12-11 20:16:55.628352 | PLAY RECAP 2025-12-11 20:16:55.628482 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-11 20:16:55.628510 | 2025-12-11 20:16:55.790647 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-11 20:16:55.791901 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-11 20:16:56.529452 | 2025-12-11 20:16:56.529634 | PLAY [Base post] 2025-12-11 20:16:56.544396 | 2025-12-11 20:16:56.544557 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-11 20:16:57.183938 | debian-bookworm | changed 2025-12-11 20:16:57.192703 | 2025-12-11 20:16:57.192846 | PLAY RECAP 2025-12-11 20:16:57.192914 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-11 20:16:57.192980 | 2025-12-11 20:16:57.323496 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-11 20:16:57.324614 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-11 20:16:58.168654 | 2025-12-11 20:16:58.168841 | PLAY [Base post-logs] 2025-12-11 20:16:58.179849 | 2025-12-11 20:16:58.180004 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-11 20:16:58.669667 | localhost | changed 2025-12-11 20:16:58.688705 | 2025-12-11 20:16:58.688903 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-11 20:16:58.726703 | localhost | ok 2025-12-11 20:16:58.731546 | 2025-12-11 20:16:58.731697 | TASK [Set zuul-log-path fact] 2025-12-11 20:16:58.759051 | localhost | ok 2025-12-11 20:16:58.771111 | 2025-12-11 20:16:58.771327 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-11 20:16:58.809670 | localhost | ok 2025-12-11 20:16:58.816676 | 2025-12-11 20:16:58.816881 | TASK [upload-logs : Create log directories] 2025-12-11 20:16:59.383919 | localhost | changed 2025-12-11 20:16:59.389375 | 2025-12-11 20:16:59.389589 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-11 20:16:59.933285 | localhost -> localhost | ok: Runtime: 0:00:00.007504 2025-12-11 20:16:59.937603 | 2025-12-11 20:16:59.937726 | TASK [upload-logs : Upload logs to log server] 2025-12-11 20:17:00.532719 | localhost | Output suppressed because no_log was given 2025-12-11 20:17:00.534787 | 2025-12-11 20:17:00.534943 | LOOP [upload-logs : Compress console log and json output] 2025-12-11 20:17:00.585621 | localhost | skipping: Conditional result was False 2025-12-11 20:17:00.594643 | localhost | skipping: Conditional result was False 2025-12-11 20:17:00.605513 | 2025-12-11 20:17:00.605783 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-11 20:17:00.666319 | localhost | skipping: Conditional result was False 2025-12-11 20:17:00.666791 | 2025-12-11 20:17:00.681696 | localhost | skipping: Conditional result was False 2025-12-11 20:17:00.686632 | 2025-12-11 20:17:00.686782 | LOOP [upload-logs : Upload console log and json output]