2025-11-27 04:10:25.302180 | Job console starting 2025-11-27 04:10:25.320716 | Updating git repos 2025-11-27 04:10:25.368701 | Cloning repos into workspace 2025-11-27 04:10:25.470635 | Restoring repo states 2025-11-27 04:10:25.505961 | Merging changes 2025-11-27 04:10:26.054354 | Checking out repos 2025-11-27 04:10:26.123716 | Preparing playbooks 2025-11-27 04:10:27.187968 | Running Ansible setup 2025-11-27 04:10:32.284162 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-27 04:10:33.473097 | 2025-11-27 04:10:33.473279 | PLAY [Base pre] 2025-11-27 04:10:33.507317 | 2025-11-27 04:10:33.507561 | TASK [Setup log path fact] 2025-11-27 04:10:33.548693 | debian-bookworm | ok 2025-11-27 04:10:33.585407 | 2025-11-27 04:10:33.586343 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-27 04:10:33.634583 | debian-bookworm | ok 2025-11-27 04:10:33.656127 | 2025-11-27 04:10:33.656270 | TASK [emit-job-header : Print job information] 2025-11-27 04:10:33.695859 | # Job Information 2025-11-27 04:10:33.696668 | Ansible Version: 2.16.14 2025-11-27 04:10:33.696727 | Job: tox 2025-11-27 04:10:33.696762 | Pipeline: check 2025-11-27 04:10:33.696785 | Executor: 521e9411259a 2025-11-27 04:10:33.696807 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1004 2025-11-27 04:10:33.696829 | Event ID: fac6fee0-cb46-11f0-9dbc-6ded21ae4b52 2025-11-27 04:10:33.702055 | 2025-11-27 04:10:33.702188 | LOOP [emit-job-header : Print node information] 2025-11-27 04:10:33.850524 | debian-bookworm | ok: 2025-11-27 04:10:33.850728 | debian-bookworm | # Node Information 2025-11-27 04:10:33.850764 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-27 04:10:33.850789 | debian-bookworm | Hostname: debian 2025-11-27 04:10:33.850811 | debian-bookworm | Username: zuul 2025-11-27 04:10:33.850855 | debian-bookworm | Distro: Debian 12.12 2025-11-27 04:10:33.850884 | debian-bookworm | Provider: regiocloud-a 2025-11-27 04:10:33.850907 | debian-bookworm | Region: 2025-11-27 04:10:33.850929 | debian-bookworm | Label: debian-bookworm 2025-11-27 04:10:33.850949 | debian-bookworm | Product Name: OpenStack Nova 2025-11-27 04:10:33.850968 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe30:2cfc 2025-11-27 04:10:33.885235 | 2025-11-27 04:10:33.885384 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-27 04:10:34.847249 | debian-bookworm -> localhost | changed 2025-11-27 04:10:34.854915 | 2025-11-27 04:10:34.855054 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-27 04:10:36.625940 | debian-bookworm -> localhost | changed 2025-11-27 04:10:36.641126 | 2025-11-27 04:10:36.641278 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-27 04:10:37.217957 | debian-bookworm -> localhost | ok 2025-11-27 04:10:37.224389 | 2025-11-27 04:10:37.224536 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-27 04:10:37.263701 | debian-bookworm | ok 2025-11-27 04:10:37.290157 | debian-bookworm | included: /var/lib/zuul/builds/319e82861fe648b5ab5909c42c798c96/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-27 04:10:37.313788 | 2025-11-27 04:10:37.314453 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-27 04:10:38.681937 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-27 04:10:38.682208 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/319e82861fe648b5ab5909c42c798c96/work/319e82861fe648b5ab5909c42c798c96_id_rsa 2025-11-27 04:10:38.682251 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/319e82861fe648b5ab5909c42c798c96/work/319e82861fe648b5ab5909c42c798c96_id_rsa.pub 2025-11-27 04:10:38.682278 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-27 04:10:38.682303 | debian-bookworm -> localhost | SHA256:sZxSs6To6mDjrWuVKCm6p0V68cpFlznRRLRX/jSYlfc zuul-build-sshkey 2025-11-27 04:10:38.682327 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-27 04:10:38.682361 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-27 04:10:38.682384 | debian-bookworm -> localhost | | o+ . .. | 2025-11-27 04:10:38.682406 | debian-bookworm -> localhost | | o . o +. .| 2025-11-27 04:10:38.682465 | debian-bookworm -> localhost | | . B . + o..| 2025-11-27 04:10:38.682488 | debian-bookworm -> localhost | | . O B o .E| 2025-11-27 04:10:38.682508 | debian-bookworm -> localhost | | .+ + B S . | 2025-11-27 04:10:38.682531 | debian-bookworm -> localhost | |++ B . o | 2025-11-27 04:10:38.682552 | debian-bookworm -> localhost | |*o+ + | 2025-11-27 04:10:38.682572 | debian-bookworm -> localhost | |+*++ | 2025-11-27 04:10:38.682594 | debian-bookworm -> localhost | |+OB. | 2025-11-27 04:10:38.682615 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-27 04:10:38.682681 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.643899 2025-11-27 04:10:38.690297 | 2025-11-27 04:10:38.690439 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-27 04:10:38.719801 | debian-bookworm | ok 2025-11-27 04:10:38.729351 | debian-bookworm | included: /var/lib/zuul/builds/319e82861fe648b5ab5909c42c798c96/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-27 04:10:38.739613 | 2025-11-27 04:10:38.739714 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-27 04:10:38.763349 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:10:38.769256 | 2025-11-27 04:10:38.769361 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-27 04:10:39.467919 | debian-bookworm | changed 2025-11-27 04:10:39.484722 | 2025-11-27 04:10:39.490465 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-27 04:10:39.748050 | debian-bookworm | ok 2025-11-27 04:10:39.754173 | 2025-11-27 04:10:39.754301 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-27 04:10:40.452205 | debian-bookworm | changed 2025-11-27 04:10:40.464796 | 2025-11-27 04:10:40.464941 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-27 04:10:41.137559 | debian-bookworm | changed 2025-11-27 04:10:41.161348 | 2025-11-27 04:10:41.161627 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-27 04:10:41.198403 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:10:41.205667 | 2025-11-27 04:10:41.206367 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-27 04:10:41.743747 | debian-bookworm -> localhost | changed 2025-11-27 04:10:41.755542 | 2025-11-27 04:10:41.755685 | TASK [add-build-sshkey : Add back temp key] 2025-11-27 04:10:42.109787 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/319e82861fe648b5ab5909c42c798c96/work/319e82861fe648b5ab5909c42c798c96_id_rsa (zuul-build-sshkey) 2025-11-27 04:10:42.110081 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013213 2025-11-27 04:10:42.119303 | 2025-11-27 04:10:42.119471 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-27 04:10:42.606901 | debian-bookworm | ok 2025-11-27 04:10:42.613279 | 2025-11-27 04:10:42.613474 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-27 04:10:42.638876 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:10:42.650047 | 2025-11-27 04:10:42.650195 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-27 04:10:43.157392 | debian-bookworm | ok 2025-11-27 04:10:43.169735 | 2025-11-27 04:10:43.169921 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-27 04:10:43.201875 | debian-bookworm | ok 2025-11-27 04:10:43.207953 | 2025-11-27 04:10:43.208108 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-27 04:10:43.599887 | debian-bookworm -> localhost | ok 2025-11-27 04:10:43.606675 | 2025-11-27 04:10:43.606794 | TASK [validate-host : Collect information about the host] 2025-11-27 04:10:44.769189 | debian-bookworm | ok 2025-11-27 04:10:44.789052 | 2025-11-27 04:10:44.789201 | TASK [validate-host : Sanitize hostname] 2025-11-27 04:10:44.900988 | debian-bookworm | ok 2025-11-27 04:10:44.961445 | 2025-11-27 04:10:44.961600 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-27 04:10:45.749760 | debian-bookworm -> localhost | changed 2025-11-27 04:10:45.755622 | 2025-11-27 04:10:45.755743 | TASK [validate-host : Collect information about zuul worker] 2025-11-27 04:10:46.230184 | debian-bookworm | ok 2025-11-27 04:10:46.238304 | 2025-11-27 04:10:46.238506 | TASK [validate-host : Write out all zuul information for each host] 2025-11-27 04:10:46.881037 | debian-bookworm -> localhost | changed 2025-11-27 04:10:46.902224 | 2025-11-27 04:10:46.902361 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-27 04:10:47.221475 | debian-bookworm | ok 2025-11-27 04:10:47.227588 | 2025-11-27 04:10:47.227737 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-27 04:10:48.364684 | debian-bookworm | changed: 2025-11-27 04:10:48.364909 | debian-bookworm | cd+++++++++ src/ 2025-11-27 04:10:48.364944 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-27 04:10:48.364968 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-27 04:10:48.364989 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-27 04:10:48.365010 | debian-bookworm | =6.2 2025-11-27 04:11:11.016655 | debian-bookworm | Downloading cachetools-6.2.2-py3-none-any.whl (11 kB) 2025-11-27 04:11:11.051448 | debian-bookworm | Collecting chardet>=5.2 2025-11-27 04:11:11.063535 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-11-27 04:11:11.072867 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 31.1 MB/s eta 0:00:00 2025-11-27 04:11:11.111191 | debian-bookworm | Collecting colorama>=0.4.6 2025-11-27 04:11:11.122868 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-11-27 04:11:11.194036 | debian-bookworm | Collecting filelock>=3.20 2025-11-27 04:11:11.207455 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-11-27 04:11:11.277766 | debian-bookworm | Collecting packaging>=25 2025-11-27 04:11:11.288912 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-11-27 04:11:11.298526 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 12.2 MB/s eta 0:00:00 2025-11-27 04:11:11.363389 | debian-bookworm | Collecting platformdirs>=4.5 2025-11-27 04:11:11.374837 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-11-27 04:11:11.417102 | debian-bookworm | Collecting pluggy>=1.6 2025-11-27 04:11:11.428616 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-11-27 04:11:11.467760 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-11-27 04:11:11.478812 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-11-27 04:11:11.607464 | debian-bookworm | Collecting virtualenv>=20.34 2025-11-27 04:11:11.620668 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-11-27 04:11:11.876429 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 24.0 MB/s eta 0:00:00 2025-11-27 04:11:11.995536 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-11-27 04:11:12.008894 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-11-27 04:11:12.033464 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 24.4 MB/s eta 0:00:00 2025-11-27 04:11:12.195597 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-11-27 04:11:13.078216 | 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.0 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.32.0 virtualenv-20.35.4 2025-11-27 04:11:13.503919 | debian-bookworm | ok: Runtime: 0:00:02.964435 2025-11-27 04:11:13.510492 | 2025-11-27 04:11:13.510625 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-27 04:11:13.541175 | debian-bookworm | ok 2025-11-27 04:11:13.546359 | 2025-11-27 04:11:13.546513 | TASK [ensure-tox : Output tox version] 2025-11-27 04:11:14.059333 | 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-11-27 04:11:14.077538 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-27 04:11:14.577161 | debian-bookworm | ok: Runtime: 0:00:00.304815 2025-11-27 04:11:14.584305 | 2025-11-27 04:11:14.584587 | TASK [ensure-tox : Make global symlink] 2025-11-27 04:11:14.609184 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:14.624803 | 2025-11-27 04:11:14.624919 | PLAY RECAP 2025-11-27 04:11:14.624976 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-27 04:11:14.625003 | 2025-11-27 04:11:14.855582 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-11-27 04:11:14.856677 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-27 04:11:15.834047 | 2025-11-27 04:11:15.834295 | PLAY [all] 2025-11-27 04:11:15.851388 | 2025-11-27 04:11:15.851579 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-11-27 04:11:16.343782 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-27 04:11:16.392181 | debian-bookworm | ok: Runtime: 0:00:00.025009 2025-11-27 04:11:16.399151 | 2025-11-27 04:11:16.399306 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-11-27 04:11:16.927997 | debian-bookworm | ok: Runtime: 0:00:00.006630 2025-11-27 04:11:16.942153 | 2025-11-27 04:11:16.942332 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-11-27 04:11:17.239040 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-11-27 04:11:17.240462 | debian-bookworm | sudo: a password is required 2025-11-27 04:11:17.475476 | debian-bookworm | ok: Runtime: 0:00:00.022038 2025-11-27 04:11:17.486511 | 2025-11-27 04:11:17.486683 | TASK [tox : Check to see if the constraints file exists] 2025-11-27 04:11:17.510982 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:17.517511 | 2025-11-27 04:11:17.517636 | TASK [tox : Fail if constraints file is missing] 2025-11-27 04:11:17.541458 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:17.549867 | 2025-11-27 04:11:17.550014 | TASK [tox : Record file location] 2025-11-27 04:11:17.575006 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:17.586662 | 2025-11-27 04:11:17.586932 | TASK [tox : Install tox siblings] 2025-11-27 04:11:17.627889 | debian-bookworm | ok 2025-11-27 04:11:17.641495 | debian-bookworm | included: /var/lib/zuul/builds/319e82861fe648b5ab5909c42c798c96/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-11-27 04:11:17.648525 | 2025-11-27 04:11:17.648667 | TASK [tox : Run tox without tests] 2025-11-27 04:11:18.706925 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-11-27 04:11:32.223934 | debian-bookworm | test: OK (14.04 seconds) 2025-11-27 04:11:32.224039 | debian-bookworm | congratulations :) (14.07 seconds) 2025-11-27 04:11:32.691320 | debian-bookworm | ok: Runtime: 0:00:14.345488 2025-11-27 04:11:32.706755 | 2025-11-27 04:11:32.706955 | TASK [tox : Create a tempfile to save tox showconfig] 2025-11-27 04:11:33.124976 | debian-bookworm | changed 2025-11-27 04:11:33.131296 | 2025-11-27 04:11:33.131455 | TASK [tox : Get tox envlist config] 2025-11-27 04:11:34.160767 | debian-bookworm | ok: Runtime: 0:00:00.337954 2025-11-27 04:11:34.174096 | 2025-11-27 04:11:34.174284 | TASK [tox : Install any sibling python packages] 2025-11-27 04:11:34.654707 | debian-bookworm | ok: No setup.cfg, no action needed 2025-11-27 04:11:34.664636 | 2025-11-27 04:11:34.664781 | TASK [tox : Remove tempfile] 2025-11-27 04:11:35.117873 | debian-bookworm | changed 2025-11-27 04:11:35.128741 | 2025-11-27 04:11:35.128893 | TASK [tox : Emit tox command] 2025-11-27 04:11:35.185870 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-11-27 04:11:35.194595 | 2025-11-27 04:11:35.194766 | TASK [tox : Run tox] 2025-11-27 04:11:35.842513 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-11-27 04:11:36.534574 | debian-bookworm | ............... 2025-11-27 04:11:36.534700 | debian-bookworm | ---------------------------------------------------------------------- 2025-11-27 04:11:36.534745 | debian-bookworm | Ran 15 tests in 0.172s 2025-11-27 04:11:36.534769 | debian-bookworm | 2025-11-27 04:11:36.534837 | debian-bookworm | OK 2025-11-27 04:11:36.633462 | debian-bookworm | test: OK (0.84=setup[0.05]+cmd[0.79] seconds) 2025-11-27 04:11:36.633566 | debian-bookworm | congratulations :) (0.87 seconds) 2025-11-27 04:11:36.776242 | debian-bookworm | ok: Runtime: 0:00:01.160902 2025-11-27 04:11:36.788975 | 2025-11-27 04:11:36.789169 | TASK [tox : Look for output] 2025-11-27 04:11:37.212738 | debian-bookworm | ok 2025-11-27 04:11:37.231416 | 2025-11-27 04:11:37.231606 | TASK [tox : Return file comments to Zuul] 2025-11-27 04:11:37.276233 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:37.292799 | 2025-11-27 04:11:37.292986 | PLAY RECAP 2025-11-27 04:11:37.293096 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-27 04:11:37.293153 | 2025-11-27 04:11:37.446736 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-11-27 04:11:37.449830 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-27 04:11:38.227238 | 2025-11-27 04:11:38.227396 | PLAY [all] 2025-11-27 04:11:38.244849 | 2025-11-27 04:11:38.244997 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-11-27 04:11:38.302258 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:38.308806 | 2025-11-27 04:11:38.308961 | TASK [fetch-tox-output : Set tox log path for single node] 2025-11-27 04:11:38.364987 | debian-bookworm | ok 2025-11-27 04:11:38.373015 | 2025-11-27 04:11:38.373170 | TASK [fetch-tox-output : Ensure local tox dir] 2025-11-27 04:11:38.864215 | debian-bookworm -> localhost | changed 2025-11-27 04:11:38.872633 | 2025-11-27 04:11:38.872787 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-11-27 04:11:38.918228 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:38.924883 | 2025-11-27 04:11:38.925042 | TASK [fetch-tox-output : Set envlist fact] 2025-11-27 04:11:38.965141 | debian-bookworm | ok 2025-11-27 04:11:38.972824 | 2025-11-27 04:11:38.972976 | TASK [fetch-tox-output : Get tox version] 2025-11-27 04:11:39.677173 | 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-11-27 04:11:39.695400 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-11-27 04:11:40.005233 | debian-bookworm | ok: Runtime: 0:00:00.301131 2025-11-27 04:11:40.031342 | 2025-11-27 04:11:40.031546 | TASK [fetch-tox-output : Find all default environments] 2025-11-27 04:11:40.565878 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:40.572551 | 2025-11-27 04:11:40.572698 | TASK [fetch-tox-output : Set envlist fact] 2025-11-27 04:11:40.607133 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:40.613125 | 2025-11-27 04:11:40.613332 | TASK [fetch-tox-output : Find all default environments] 2025-11-27 04:11:41.145250 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:41.159008 | 2025-11-27 04:11:41.159169 | TASK [fetch-tox-output : Set envlist fact] 2025-11-27 04:11:41.184085 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:41.198010 | 2025-11-27 04:11:41.198175 | LOOP [fetch-tox-output : Copy tox logs] 2025-11-27 04:11:41.256569 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:41.281249 | 2025-11-27 04:11:41.281522 | LOOP [fetch-tox-output : Collect tox logs] 2025-11-27 04:11:42.130516 | debian-bookworm | changed: 2025-11-27 04:11:42.130778 | debian-bookworm | created directory /var/lib/zuul/builds/319e82861fe648b5ab5909c42c798c96/work/logs/tox/test 2025-11-27 04:11:42.130830 | debian-bookworm | cd+++++++++ ./ 2025-11-27 04:11:42.130893 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-11-27 04:11:42.130935 | 2025-11-27 04:11:42.163270 | 2025-11-27 04:11:42.163396 | PLAY RECAP 2025-11-27 04:11:42.163530 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-27 04:11:42.163580 | 2025-11-27 04:11:42.318895 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-11-27 04:11:42.321483 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-27 04:11:43.117521 | 2025-11-27 04:11:43.117707 | PLAY [all] 2025-11-27 04:11:43.136120 | 2025-11-27 04:11:43.136296 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-27 04:11:43.376680 | debian-bookworm | changed: non-zero return code 2025-11-27 04:11:43.386279 | 2025-11-27 04:11:43.386559 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-11-27 04:11:43.412567 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:43.423055 | 2025-11-27 04:11:43.423209 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-11-27 04:11:43.459670 | 2025-11-27 04:11:43.459919 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-11-27 04:11:43.496457 | 2025-11-27 04:11:43.496720 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-11-27 04:11:43.521748 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:43.528648 | 2025-11-27 04:11:43.528776 | LOOP [fetch-subunit-output : Generate subunit file] 2025-11-27 04:11:43.559499 | 2025-11-27 04:11:43.559720 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-11-27 04:11:43.583968 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:43.594923 | 2025-11-27 04:11:43.595089 | TASK [fetch-subunit-output : Remove the temporary file] 2025-11-27 04:11:43.611785 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:43.618949 | 2025-11-27 04:11:43.619072 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-11-27 04:11:43.642972 | debian-bookworm | skipping: Conditional result was False 2025-11-27 04:11:43.653046 | 2025-11-27 04:11:43.653151 | PLAY RECAP 2025-11-27 04:11:43.653222 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-27 04:11:43.653257 | 2025-11-27 04:11:43.790601 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-27 04:11:43.791739 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-27 04:11:44.637285 | 2025-11-27 04:11:44.637475 | PLAY [Base post] 2025-11-27 04:11:44.653523 | 2025-11-27 04:11:44.653678 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-27 04:11:45.338448 | debian-bookworm | changed 2025-11-27 04:11:45.358891 | 2025-11-27 04:11:45.359145 | PLAY RECAP 2025-11-27 04:11:45.359306 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-27 04:11:45.359505 | 2025-11-27 04:11:45.509405 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-27 04:11:45.512093 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-27 04:11:46.379458 | 2025-11-27 04:11:46.379692 | PLAY [Base post-logs] 2025-11-27 04:11:46.391851 | 2025-11-27 04:11:46.392007 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-27 04:11:46.935500 | localhost | changed 2025-11-27 04:11:46.952224 | 2025-11-27 04:11:46.952449 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-27 04:11:46.991399 | localhost | ok 2025-11-27 04:11:46.998921 | 2025-11-27 04:11:46.999116 | TASK [Set zuul-log-path fact] 2025-11-27 04:11:47.017627 | localhost | ok 2025-11-27 04:11:47.031356 | 2025-11-27 04:11:47.031549 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-27 04:11:47.058671 | localhost | ok 2025-11-27 04:11:47.064116 | 2025-11-27 04:11:47.064289 | TASK [upload-logs : Create log directories] 2025-11-27 04:11:47.591592 | localhost | changed 2025-11-27 04:11:47.596740 | 2025-11-27 04:11:47.596916 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-27 04:11:48.120186 | localhost -> localhost | ok: Runtime: 0:00:00.007913 2025-11-27 04:11:48.124327 | 2025-11-27 04:11:48.124485 | TASK [upload-logs : Upload logs to log server] 2025-11-27 04:11:48.730021 | localhost | Output suppressed because no_log was given 2025-11-27 04:11:48.734386 | 2025-11-27 04:11:48.734663 | LOOP [upload-logs : Compress console log and json output] 2025-11-27 04:11:48.797186 | localhost | skipping: Conditional result was False 2025-11-27 04:11:48.802243 | localhost | skipping: Conditional result was False 2025-11-27 04:11:48.809956 | 2025-11-27 04:11:48.810143 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-27 04:11:48.860881 | localhost | skipping: Conditional result was False 2025-11-27 04:11:48.861535 | 2025-11-27 04:11:48.865046 | localhost | skipping: Conditional result was False 2025-11-27 04:11:48.872275 | 2025-11-27 04:11:48.872508 | LOOP [upload-logs : Upload console log and json output]