2025-10-19 18:47:27.817584 | Job console starting 2025-10-19 18:47:27.845347 | Updating git repos 2025-10-19 18:47:27.874939 | Cloning repos into workspace 2025-10-19 18:47:27.925842 | Restoring repo states 2025-10-19 18:47:27.966763 | Merging changes 2025-10-19 18:47:28.579209 | Checking out repos 2025-10-19 18:47:28.667174 | Preparing playbooks 2025-10-19 18:47:29.573467 | Running Ansible setup 2025-10-19 18:47:34.588543 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-19 18:47:35.547657 | 2025-10-19 18:47:35.547814 | PLAY [Base pre] 2025-10-19 18:47:35.575958 | 2025-10-19 18:47:35.576138 | TASK [Setup log path fact] 2025-10-19 18:47:35.594918 | debian-bookworm | ok 2025-10-19 18:47:35.611139 | 2025-10-19 18:47:35.611286 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-19 18:47:35.641213 | debian-bookworm | ok 2025-10-19 18:47:35.651147 | 2025-10-19 18:47:35.651267 | TASK [emit-job-header : Print job information] 2025-10-19 18:47:35.701795 | # Job Information 2025-10-19 18:47:35.701970 | Ansible Version: 2.16.14 2025-10-19 18:47:35.702006 | Job: tox 2025-10-19 18:47:35.702038 | Pipeline: check 2025-10-19 18:47:35.702080 | Executor: 521e9411259a 2025-10-19 18:47:35.702100 | Triggered by: https://github.com/osism/openstack-image-manager/pull/972 2025-10-19 18:47:35.702122 | Event ID: 0ab02190-ad1c-11f0-8f4c-ff6def70dbcb 2025-10-19 18:47:35.707295 | 2025-10-19 18:47:35.707417 | LOOP [emit-job-header : Print node information] 2025-10-19 18:47:35.837982 | debian-bookworm | ok: 2025-10-19 18:47:35.838243 | debian-bookworm | # Node Information 2025-10-19 18:47:35.838284 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-19 18:47:35.838311 | debian-bookworm | Hostname: debian 2025-10-19 18:47:35.838333 | debian-bookworm | Username: zuul 2025-10-19 18:47:35.838354 | debian-bookworm | Distro: Debian 12.12 2025-10-19 18:47:35.838380 | debian-bookworm | Provider: regiocloud-a 2025-10-19 18:47:35.838400 | debian-bookworm | Region: 2025-10-19 18:47:35.838421 | debian-bookworm | Label: debian-bookworm 2025-10-19 18:47:35.838441 | debian-bookworm | Product Name: OpenStack Nova 2025-10-19 18:47:35.838460 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fece:7757 2025-10-19 18:47:35.869624 | 2025-10-19 18:47:35.869769 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-19 18:47:36.636806 | debian-bookworm -> localhost | changed 2025-10-19 18:47:36.643528 | 2025-10-19 18:47:36.643630 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-19 18:47:37.831686 | debian-bookworm -> localhost | changed 2025-10-19 18:47:37.840294 | 2025-10-19 18:47:37.840376 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-19 18:47:38.171459 | debian-bookworm -> localhost | ok 2025-10-19 18:47:38.176491 | 2025-10-19 18:47:38.176573 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-19 18:47:38.192690 | debian-bookworm | ok 2025-10-19 18:47:38.206860 | debian-bookworm | included: /var/lib/zuul/builds/a2801dad43db4a33aab7272b3e692fd2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-19 18:47:38.211579 | 2025-10-19 18:47:38.211648 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-19 18:47:39.534104 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-19 18:47:39.534258 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a2801dad43db4a33aab7272b3e692fd2/work/a2801dad43db4a33aab7272b3e692fd2_id_rsa 2025-10-19 18:47:39.534289 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a2801dad43db4a33aab7272b3e692fd2/work/a2801dad43db4a33aab7272b3e692fd2_id_rsa.pub 2025-10-19 18:47:39.534311 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-19 18:47:39.534331 | debian-bookworm -> localhost | SHA256:aaFEuhhgIqVziCIVthuHXG0clw2VMYmWqJRCCFDqU0k zuul-build-sshkey 2025-10-19 18:47:39.534349 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-19 18:47:39.534374 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-19 18:47:39.534391 | debian-bookworm -> localhost | |O*BE.+oooB++ | 2025-10-19 18:47:39.534408 | debian-bookworm -> localhost | |*Oo++o=.= +. | 2025-10-19 18:47:39.534425 | debian-bookworm -> localhost | |O B=oo... | 2025-10-19 18:47:39.534441 | debian-bookworm -> localhost | |+o.*.o . o | 2025-10-19 18:47:39.534456 | debian-bookworm -> localhost | | oo . . S | 2025-10-19 18:47:39.534478 | debian-bookworm -> localhost | | . . | 2025-10-19 18:47:39.534495 | debian-bookworm -> localhost | | | 2025-10-19 18:47:39.534512 | debian-bookworm -> localhost | | | 2025-10-19 18:47:39.534529 | debian-bookworm -> localhost | | | 2025-10-19 18:47:39.534546 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-19 18:47:39.534587 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.895035 2025-10-19 18:47:39.539592 | 2025-10-19 18:47:39.539668 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-19 18:47:39.565950 | debian-bookworm | ok 2025-10-19 18:47:39.581943 | debian-bookworm | included: /var/lib/zuul/builds/a2801dad43db4a33aab7272b3e692fd2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-19 18:47:39.588911 | 2025-10-19 18:47:39.588976 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-19 18:47:39.622440 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:47:39.626794 | 2025-10-19 18:47:39.626882 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-19 18:47:40.271105 | debian-bookworm | changed 2025-10-19 18:47:40.275839 | 2025-10-19 18:47:40.275910 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-19 18:47:40.547632 | debian-bookworm | ok 2025-10-19 18:47:40.556249 | 2025-10-19 18:47:40.556360 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-19 18:47:41.205077 | debian-bookworm | changed 2025-10-19 18:47:41.211808 | 2025-10-19 18:47:41.212967 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-19 18:47:41.838612 | debian-bookworm | changed 2025-10-19 18:47:41.845653 | 2025-10-19 18:47:41.845767 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-19 18:47:41.868969 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:47:41.874970 | 2025-10-19 18:47:41.875106 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-19 18:47:42.259815 | debian-bookworm -> localhost | changed 2025-10-19 18:47:42.270974 | 2025-10-19 18:47:42.271119 | TASK [add-build-sshkey : Add back temp key] 2025-10-19 18:47:42.629463 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a2801dad43db4a33aab7272b3e692fd2/work/a2801dad43db4a33aab7272b3e692fd2_id_rsa (zuul-build-sshkey) 2025-10-19 18:47:42.629718 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011515 2025-10-19 18:47:42.637700 | 2025-10-19 18:47:42.637804 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-19 18:47:43.120246 | debian-bookworm | ok 2025-10-19 18:47:43.125294 | 2025-10-19 18:47:43.125384 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-19 18:47:43.148610 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:47:43.158394 | 2025-10-19 18:47:43.158480 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-19 18:47:43.594656 | debian-bookworm | ok 2025-10-19 18:47:43.606394 | 2025-10-19 18:47:43.606485 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-19 18:47:43.623914 | debian-bookworm | ok 2025-10-19 18:47:43.630022 | 2025-10-19 18:47:43.630138 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-19 18:47:43.881398 | debian-bookworm -> localhost | ok 2025-10-19 18:47:43.887634 | 2025-10-19 18:47:43.887731 | TASK [validate-host : Collect information about the host] 2025-10-19 18:47:44.966672 | debian-bookworm | ok 2025-10-19 18:47:44.980374 | 2025-10-19 18:47:44.980484 | TASK [validate-host : Sanitize hostname] 2025-10-19 18:47:45.085711 | debian-bookworm | ok 2025-10-19 18:47:45.115746 | 2025-10-19 18:47:45.115840 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-19 18:47:45.643578 | debian-bookworm -> localhost | changed 2025-10-19 18:47:45.648915 | 2025-10-19 18:47:45.649014 | TASK [validate-host : Collect information about zuul worker] 2025-10-19 18:47:46.059327 | debian-bookworm | ok 2025-10-19 18:47:46.063908 | 2025-10-19 18:47:46.064002 | TASK [validate-host : Write out all zuul information for each host] 2025-10-19 18:47:46.818186 | debian-bookworm -> localhost | changed 2025-10-19 18:47:46.833905 | 2025-10-19 18:47:46.834025 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-19 18:47:47.088124 | debian-bookworm | ok 2025-10-19 18:47:47.093144 | 2025-10-19 18:47:47.093232 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-19 18:47:48.019125 | debian-bookworm | changed: 2025-10-19 18:47:48.019376 | debian-bookworm | cd+++++++++ src/ 2025-10-19 18:47:48.019407 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-19 18:47:48.019427 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-19 18:47:48.019445 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-19 18:47:48.019461 | debian-bookworm | =6.2 2025-10-19 18:48:09.979538 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-10-19 18:48:10.015804 | debian-bookworm | Collecting chardet>=5.2 2025-10-19 18:48:10.030574 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-10-19 18:48:10.051486 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 10.7 MB/s eta 0:00:00 2025-10-19 18:48:10.089286 | debian-bookworm | Collecting colorama>=0.4.6 2025-10-19 18:48:10.101649 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-19 18:48:10.175663 | debian-bookworm | Collecting filelock>=3.20 2025-10-19 18:48:10.188160 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-10-19 18:48:10.236729 | debian-bookworm | Collecting packaging>=25 2025-10-19 18:48:10.249149 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-19 18:48:10.258334 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.0 MB/s eta 0:00:00 2025-10-19 18:48:10.305241 | debian-bookworm | Collecting platformdirs>=4.5 2025-10-19 18:48:10.317986 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-10-19 18:48:10.375264 | debian-bookworm | Collecting pluggy>=1.6 2025-10-19 18:48:10.387879 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-10-19 18:48:10.433821 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-10-19 18:48:10.449449 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-10-19 18:48:10.586239 | debian-bookworm | Collecting virtualenv>=20.34 2025-10-19 18:48:10.601308 | debian-bookworm | Downloading virtualenv-20.35.3-py3-none-any.whl (6.0 MB) 2025-10-19 18:48:10.873613 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 22.2 MB/s eta 0:00:00 2025-10-19 18:48:10.972188 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-10-19 18:48:10.984586 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-10-19 18:48:11.015644 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.9 MB/s eta 0:00:00 2025-10-19 18:48:11.200087 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-10-19 18:48:12.114634 | debian-bookworm | Successfully installed cachetools-6.2.1 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.31.0 virtualenv-20.35.3 2025-10-19 18:48:12.351120 | debian-bookworm | ok: Runtime: 0:00:03.119614 2025-10-19 18:48:12.361950 | 2025-10-19 18:48:12.362089 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-19 18:48:12.402472 | debian-bookworm | ok 2025-10-19 18:48:12.418896 | 2025-10-19 18:48:12.419083 | TASK [ensure-tox : Output tox version] 2025-10-19 18:48:12.925984 | 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-10-19 18:48:12.944596 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-19 18:48:13.451566 | debian-bookworm | ok: Runtime: 0:00:00.304560 2025-10-19 18:48:13.457468 | 2025-10-19 18:48:13.457592 | TASK [ensure-tox : Make global symlink] 2025-10-19 18:48:13.472953 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:13.484542 | 2025-10-19 18:48:13.484650 | PLAY RECAP 2025-10-19 18:48:13.484707 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-19 18:48:13.484732 | 2025-10-19 18:48:13.633214 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-10-19 18:48:13.634293 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-19 18:48:14.515462 | 2025-10-19 18:48:14.515618 | PLAY [all] 2025-10-19 18:48:14.546019 | 2025-10-19 18:48:14.546785 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-10-19 18:48:15.014268 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-19 18:48:15.093180 | debian-bookworm | ok: Runtime: 0:00:00.023509 2025-10-19 18:48:15.115594 | 2025-10-19 18:48:15.115784 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-10-19 18:48:15.658952 | debian-bookworm | ok: Runtime: 0:00:00.008036 2025-10-19 18:48:15.666692 | 2025-10-19 18:48:15.666809 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-10-19 18:48:15.971524 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-19 18:48:15.974571 | debian-bookworm | sudo: a password is required 2025-10-19 18:48:16.197969 | debian-bookworm | ok: Runtime: 0:00:00.024380 2025-10-19 18:48:16.217630 | 2025-10-19 18:48:16.217763 | TASK [tox : Check to see if the constraints file exists] 2025-10-19 18:48:16.242542 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:16.254321 | 2025-10-19 18:48:16.254552 | TASK [tox : Fail if constraints file is missing] 2025-10-19 18:48:16.279392 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:16.289235 | 2025-10-19 18:48:16.289377 | TASK [tox : Record file location] 2025-10-19 18:48:16.323699 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:16.334273 | 2025-10-19 18:48:16.334425 | TASK [tox : Install tox siblings] 2025-10-19 18:48:16.372309 | debian-bookworm | ok 2025-10-19 18:48:16.383665 | debian-bookworm | included: /var/lib/zuul/builds/a2801dad43db4a33aab7272b3e692fd2/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-10-19 18:48:16.389698 | 2025-10-19 18:48:16.389805 | TASK [tox : Run tox without tests] 2025-10-19 18:48:17.574221 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-10-19 18:48:32.288785 | debian-bookworm | test: OK (15.31 seconds) 2025-10-19 18:48:32.288838 | debian-bookworm | congratulations :) (15.34 seconds) 2025-10-19 18:48:32.434936 | debian-bookworm | ok: Runtime: 0:00:15.626506 2025-10-19 18:48:32.444895 | 2025-10-19 18:48:32.445114 | TASK [tox : Create a tempfile to save tox showconfig] 2025-10-19 18:48:32.873601 | debian-bookworm | changed 2025-10-19 18:48:32.883708 | 2025-10-19 18:48:32.883852 | TASK [tox : Get tox envlist config] 2025-10-19 18:48:33.917275 | debian-bookworm | ok: Runtime: 0:00:00.355678 2025-10-19 18:48:33.930618 | 2025-10-19 18:48:33.930799 | TASK [tox : Install any sibling python packages] 2025-10-19 18:48:34.388785 | debian-bookworm | ok: No setup.cfg, no action needed 2025-10-19 18:48:34.397169 | 2025-10-19 18:48:34.397304 | TASK [tox : Remove tempfile] 2025-10-19 18:48:34.838467 | debian-bookworm | changed 2025-10-19 18:48:34.847072 | 2025-10-19 18:48:34.847204 | TASK [tox : Emit tox command] 2025-10-19 18:48:34.902543 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-10-19 18:48:34.910410 | 2025-10-19 18:48:34.910543 | TASK [tox : Run tox] 2025-10-19 18:48:35.527356 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-10-19 18:48:36.164131 | debian-bookworm | ............... 2025-10-19 18:48:36.164645 | debian-bookworm | ---------------------------------------------------------------------- 2025-10-19 18:48:36.164672 | debian-bookworm | Ran 15 tests in 0.174s 2025-10-19 18:48:36.164679 | debian-bookworm | 2025-10-19 18:48:36.164687 | debian-bookworm | OK 2025-10-19 18:48:36.257350 | debian-bookworm | test: OK (0.77=setup[0.04]+cmd[0.73] seconds) 2025-10-19 18:48:36.257409 | debian-bookworm | congratulations :) (0.80 seconds) 2025-10-19 18:48:36.471767 | debian-bookworm | ok: Runtime: 0:00:01.083029 2025-10-19 18:48:36.485401 | 2025-10-19 18:48:36.485557 | TASK [tox : Look for output] 2025-10-19 18:48:36.877486 | debian-bookworm | ok 2025-10-19 18:48:36.898093 | 2025-10-19 18:48:36.898225 | TASK [tox : Return file comments to Zuul] 2025-10-19 18:48:36.933824 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:36.947925 | 2025-10-19 18:48:36.948060 | PLAY RECAP 2025-10-19 18:48:36.948148 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-19 18:48:36.948191 | 2025-10-19 18:48:37.071989 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-19 18:48:37.074669 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-19 18:48:37.852702 | 2025-10-19 18:48:37.852859 | PLAY [all] 2025-10-19 18:48:37.868553 | 2025-10-19 18:48:37.868691 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-10-19 18:48:37.924507 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:37.935747 | 2025-10-19 18:48:37.935935 | TASK [fetch-tox-output : Set tox log path for single node] 2025-10-19 18:48:37.983314 | debian-bookworm | ok 2025-10-19 18:48:37.991899 | 2025-10-19 18:48:37.992050 | TASK [fetch-tox-output : Ensure local tox dir] 2025-10-19 18:48:38.461971 | debian-bookworm -> localhost | changed 2025-10-19 18:48:38.470131 | 2025-10-19 18:48:38.470254 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-10-19 18:48:38.524389 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:38.535838 | 2025-10-19 18:48:38.535996 | TASK [fetch-tox-output : Set envlist fact] 2025-10-19 18:48:38.572578 | debian-bookworm | ok 2025-10-19 18:48:38.582262 | 2025-10-19 18:48:38.582408 | TASK [fetch-tox-output : Get tox version] 2025-10-19 18:48:39.240238 | 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-10-19 18:48:39.258522 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-19 18:48:39.616631 | debian-bookworm | ok: Runtime: 0:00:00.277275 2025-10-19 18:48:39.629567 | 2025-10-19 18:48:39.629729 | TASK [fetch-tox-output : Find all default environments] 2025-10-19 18:48:40.163833 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:40.170151 | 2025-10-19 18:48:40.170290 | TASK [fetch-tox-output : Set envlist fact] 2025-10-19 18:48:40.204281 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:40.212347 | 2025-10-19 18:48:40.212470 | TASK [fetch-tox-output : Find all default environments] 2025-10-19 18:48:40.741727 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:40.754986 | 2025-10-19 18:48:40.755175 | TASK [fetch-tox-output : Set envlist fact] 2025-10-19 18:48:40.790203 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:40.801502 | 2025-10-19 18:48:40.801645 | LOOP [fetch-tox-output : Copy tox logs] 2025-10-19 18:48:40.850329 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:40.868850 | 2025-10-19 18:48:40.869001 | LOOP [fetch-tox-output : Collect tox logs] 2025-10-19 18:48:41.628369 | debian-bookworm | changed: 2025-10-19 18:48:41.628571 | debian-bookworm | created directory /var/lib/zuul/builds/a2801dad43db4a33aab7272b3e692fd2/work/logs/tox/test 2025-10-19 18:48:41.628606 | debian-bookworm | cd+++++++++ ./ 2025-10-19 18:48:41.628631 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-10-19 18:48:41.628659 | 2025-10-19 18:48:41.640477 | 2025-10-19 18:48:41.640579 | PLAY RECAP 2025-10-19 18:48:41.640629 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-19 18:48:41.640654 | 2025-10-19 18:48:41.759212 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-19 18:48:41.760260 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-19 18:48:42.481227 | 2025-10-19 18:48:42.481386 | PLAY [all] 2025-10-19 18:48:42.496756 | 2025-10-19 18:48:42.496900 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-10-19 18:48:42.722494 | debian-bookworm | changed: non-zero return code 2025-10-19 18:48:42.730941 | 2025-10-19 18:48:42.731125 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-10-19 18:48:42.756188 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:42.765479 | 2025-10-19 18:48:42.765624 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-10-19 18:48:42.803661 | 2025-10-19 18:48:42.803924 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-10-19 18:48:42.852169 | 2025-10-19 18:48:42.852436 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-10-19 18:48:42.876836 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:42.890149 | 2025-10-19 18:48:42.890312 | LOOP [fetch-subunit-output : Generate subunit file] 2025-10-19 18:48:42.926572 | 2025-10-19 18:48:42.926888 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-10-19 18:48:42.951154 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:42.963928 | 2025-10-19 18:48:42.964122 | TASK [fetch-subunit-output : Remove the temporary file] 2025-10-19 18:48:42.988505 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:42.999513 | 2025-10-19 18:48:42.999674 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-10-19 18:48:43.023786 | debian-bookworm | skipping: Conditional result was False 2025-10-19 18:48:43.038575 | 2025-10-19 18:48:43.038693 | PLAY RECAP 2025-10-19 18:48:43.038780 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-19 18:48:43.038825 | 2025-10-19 18:48:43.159727 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-19 18:48:43.162295 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-19 18:48:43.881671 | 2025-10-19 18:48:43.881834 | PLAY [Base post] 2025-10-19 18:48:43.895441 | 2025-10-19 18:48:43.895567 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-19 18:48:44.451596 | debian-bookworm | changed 2025-10-19 18:48:44.460582 | 2025-10-19 18:48:44.460709 | PLAY RECAP 2025-10-19 18:48:44.460781 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-19 18:48:44.460866 | 2025-10-19 18:48:44.587348 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-19 18:48:44.589971 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-19 18:48:45.382751 | 2025-10-19 18:48:45.382937 | PLAY [Base post-logs] 2025-10-19 18:48:45.395160 | 2025-10-19 18:48:45.395299 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-19 18:48:45.828963 | localhost | changed 2025-10-19 18:48:45.848174 | 2025-10-19 18:48:45.848353 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-19 18:48:45.873940 | localhost | ok 2025-10-19 18:48:45.877299 | 2025-10-19 18:48:45.877401 | TASK [Set zuul-log-path fact] 2025-10-19 18:48:45.891897 | localhost | ok 2025-10-19 18:48:45.899779 | 2025-10-19 18:48:45.899880 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-19 18:48:45.924335 | localhost | ok 2025-10-19 18:48:45.927726 | 2025-10-19 18:48:45.927836 | TASK [upload-logs : Create log directories] 2025-10-19 18:48:46.411192 | localhost | changed 2025-10-19 18:48:46.414008 | 2025-10-19 18:48:46.414132 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-19 18:48:46.925329 | localhost -> localhost | ok: Runtime: 0:00:00.006773 2025-10-19 18:48:46.933767 | 2025-10-19 18:48:46.933940 | TASK [upload-logs : Upload logs to log server] 2025-10-19 18:48:47.481940 | localhost | Output suppressed because no_log was given 2025-10-19 18:48:47.486392 | 2025-10-19 18:48:47.486593 | LOOP [upload-logs : Compress console log and json output] 2025-10-19 18:48:47.541965 | localhost | skipping: Conditional result was False 2025-10-19 18:48:47.545335 | localhost | skipping: Conditional result was False 2025-10-19 18:48:47.560144 | 2025-10-19 18:48:47.560347 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-19 18:48:47.619639 | localhost | skipping: Conditional result was False 2025-10-19 18:48:47.620298 | 2025-10-19 18:48:47.621716 | localhost | skipping: Conditional result was False 2025-10-19 18:48:47.626994 | 2025-10-19 18:48:47.627196 | LOOP [upload-logs : Upload console log and json output]