2025-12-14 03:04:08.917410 | Job console starting 2025-12-14 03:04:08.933666 | Updating git repos 2025-12-14 03:04:08.981079 | Cloning repos into workspace 2025-12-14 03:04:09.048941 | Restoring repo states 2025-12-14 03:04:09.059218 | Merging changes 2025-12-14 03:04:09.059244 | Checking out repos 2025-12-14 03:04:09.149731 | Preparing playbooks 2025-12-14 03:04:10.108481 | Running Ansible setup 2025-12-14 03:04:17.226565 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-14 03:04:19.180566 | 2025-12-14 03:04:19.180769 | PLAY [Base pre] 2025-12-14 03:04:19.297620 | 2025-12-14 03:04:19.297805 | TASK [Setup log path fact] 2025-12-14 03:04:19.378602 | debian-bookworm | ok 2025-12-14 03:04:19.439479 | 2025-12-14 03:04:19.439665 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-14 03:04:19.581637 | debian-bookworm | ok 2025-12-14 03:04:19.613461 | 2025-12-14 03:04:19.613638 | TASK [emit-job-header : Print job information] 2025-12-14 03:04:19.927755 | # Job Information 2025-12-14 03:04:19.928082 | Ansible Version: 2.16.14 2025-12-14 03:04:19.928126 | Job: tox 2025-12-14 03:04:19.928370 | Pipeline: periodic-daily 2025-12-14 03:04:19.928424 | Executor: 521e9411259a 2025-12-14 03:04:19.928447 | Triggered by: https://github.com/osism/openstack-image-manager 2025-12-14 03:04:19.928484 | Event ID: 90b377415db542e3bfe098ae38f179db 2025-12-14 03:04:19.938701 | 2025-12-14 03:04:19.938902 | LOOP [emit-job-header : Print node information] 2025-12-14 03:04:20.760653 | debian-bookworm | ok: 2025-12-14 03:04:20.760857 | debian-bookworm | # Node Information 2025-12-14 03:04:20.760893 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-14 03:04:20.760938 | debian-bookworm | Hostname: debian 2025-12-14 03:04:20.760964 | debian-bookworm | Username: zuul 2025-12-14 03:04:20.760985 | debian-bookworm | Distro: Debian 12.12 2025-12-14 03:04:20.761009 | debian-bookworm | Provider: regiocloud-a 2025-12-14 03:04:20.761030 | debian-bookworm | Region: 2025-12-14 03:04:20.761052 | debian-bookworm | Label: debian-bookworm 2025-12-14 03:04:20.761072 | debian-bookworm | Product Name: OpenStack Nova 2025-12-14 03:04:20.761092 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2f:16f5 2025-12-14 03:04:20.804498 | 2025-12-14 03:04:20.804653 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-14 03:04:24.137104 | debian-bookworm -> localhost | changed 2025-12-14 03:04:24.145124 | 2025-12-14 03:04:24.145271 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-14 03:04:30.656562 | debian-bookworm -> localhost | changed 2025-12-14 03:04:30.699264 | 2025-12-14 03:04:30.699477 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-14 03:04:32.667509 | debian-bookworm -> localhost | ok 2025-12-14 03:04:32.688447 | 2025-12-14 03:04:32.688600 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-14 03:04:32.768540 | debian-bookworm | ok 2025-12-14 03:04:32.934969 | debian-bookworm | included: /var/lib/zuul/builds/6764244a14eb43ed8d1bdc6e1e24aef4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-14 03:04:32.969503 | 2025-12-14 03:04:32.969650 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-14 03:04:37.803875 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-14 03:04:37.804128 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6764244a14eb43ed8d1bdc6e1e24aef4/work/6764244a14eb43ed8d1bdc6e1e24aef4_id_rsa 2025-12-14 03:04:37.804168 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6764244a14eb43ed8d1bdc6e1e24aef4/work/6764244a14eb43ed8d1bdc6e1e24aef4_id_rsa.pub 2025-12-14 03:04:37.804196 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-14 03:04:37.804404 | debian-bookworm -> localhost | SHA256:Lz/EnsMz905L3afc/RqVEMaR0G4ngawhdkvjAOoRKeo zuul-build-sshkey 2025-12-14 03:04:37.804487 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-14 03:04:37.804534 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-14 03:04:37.804563 | debian-bookworm -> localhost | | .... ..=+o | 2025-12-14 03:04:37.804586 | debian-bookworm -> localhost | | . .o + = o.=. | 2025-12-14 03:04:37.804607 | debian-bookworm -> localhost | |. .o . * = ... | 2025-12-14 03:04:37.804627 | debian-bookworm -> localhost | |. . . + +...| 2025-12-14 03:04:37.804647 | debian-bookworm -> localhost | |. . S. . o..| 2025-12-14 03:04:37.804680 | debian-bookworm -> localhost | | E .o o.| 2025-12-14 03:04:37.804702 | debian-bookworm -> localhost | | .+.. + +| 2025-12-14 03:04:37.804722 | debian-bookworm -> localhost | | oO .+ =o| 2025-12-14 03:04:37.804742 | debian-bookworm -> localhost | | .* oB.=| 2025-12-14 03:04:37.804763 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-14 03:04:37.804829 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.927921 2025-12-14 03:04:37.816412 | 2025-12-14 03:04:37.816556 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-14 03:04:37.958540 | debian-bookworm | ok 2025-12-14 03:04:37.983600 | debian-bookworm | included: /var/lib/zuul/builds/6764244a14eb43ed8d1bdc6e1e24aef4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-14 03:04:38.042182 | 2025-12-14 03:04:38.042699 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-14 03:04:38.100432 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:04:38.110684 | 2025-12-14 03:04:38.113604 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-14 03:04:39.123264 | debian-bookworm | changed 2025-12-14 03:04:39.129126 | 2025-12-14 03:04:39.129260 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-14 03:04:39.436100 | debian-bookworm | ok 2025-12-14 03:04:39.452730 | 2025-12-14 03:04:39.452883 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-14 03:04:40.390470 | debian-bookworm | changed 2025-12-14 03:04:40.410279 | 2025-12-14 03:04:40.410432 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-14 03:04:41.314749 | debian-bookworm | changed 2025-12-14 03:04:41.339581 | 2025-12-14 03:04:41.339730 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-14 03:04:41.382118 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:04:41.400482 | 2025-12-14 03:04:41.400627 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-14 03:04:43.074092 | debian-bookworm -> localhost | changed 2025-12-14 03:04:43.092984 | 2025-12-14 03:04:43.093130 | TASK [add-build-sshkey : Add back temp key] 2025-12-14 03:04:44.820359 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6764244a14eb43ed8d1bdc6e1e24aef4/work/6764244a14eb43ed8d1bdc6e1e24aef4_id_rsa (zuul-build-sshkey) 2025-12-14 03:04:44.821133 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.061358 2025-12-14 03:04:44.839057 | 2025-12-14 03:04:44.839196 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-14 03:04:45.718074 | debian-bookworm | ok 2025-12-14 03:04:45.728967 | 2025-12-14 03:04:45.729193 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-14 03:04:45.785008 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:04:45.804988 | 2025-12-14 03:04:45.805135 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-14 03:04:46.938003 | debian-bookworm | ok 2025-12-14 03:04:46.973833 | 2025-12-14 03:04:46.973999 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-14 03:04:47.048410 | debian-bookworm | ok 2025-12-14 03:04:47.072194 | 2025-12-14 03:04:47.072342 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-14 03:04:48.001660 | debian-bookworm -> localhost | ok 2025-12-14 03:04:48.027453 | 2025-12-14 03:04:48.027689 | TASK [validate-host : Collect information about the host] 2025-12-14 03:04:50.961043 | debian-bookworm | ok 2025-12-14 03:04:50.988109 | 2025-12-14 03:04:50.991754 | TASK [validate-host : Sanitize hostname] 2025-12-14 03:04:51.470773 | debian-bookworm | ok 2025-12-14 03:04:51.594182 | 2025-12-14 03:04:51.594339 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-14 03:04:53.521699 | debian-bookworm -> localhost | changed 2025-12-14 03:04:53.528458 | 2025-12-14 03:04:53.528577 | TASK [validate-host : Collect information about zuul worker] 2025-12-14 03:04:54.344563 | debian-bookworm | ok 2025-12-14 03:04:54.352763 | 2025-12-14 03:04:54.352956 | TASK [validate-host : Write out all zuul information for each host] 2025-12-14 03:04:55.782393 | debian-bookworm -> localhost | changed 2025-12-14 03:04:55.801966 | 2025-12-14 03:04:55.802115 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-14 03:04:56.144599 | debian-bookworm | ok 2025-12-14 03:04:56.150421 | 2025-12-14 03:04:56.150539 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-14 03:04:57.919028 | debian-bookworm | changed: 2025-12-14 03:04:57.919243 | debian-bookworm | cd+++++++++ src/ 2025-12-14 03:04:57.931474 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-14 03:04:57.931653 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-14 03:04:57.931700 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-14 03:04:57.931726 | debian-bookworm | =6.2 2025-12-14 03:05:22.633079 | debian-bookworm | Downloading cachetools-6.2.3-py3-none-any.whl (11 kB) 2025-12-14 03:05:22.677402 | debian-bookworm | Collecting chardet>=5.2 2025-12-14 03:05:22.688677 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-12-14 03:05:22.708334 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.9 MB/s eta 0:00:00 2025-12-14 03:05:22.746443 | debian-bookworm | Collecting colorama>=0.4.6 2025-12-14 03:05:22.757841 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-12-14 03:05:22.813749 | debian-bookworm | Collecting filelock>=3.20 2025-12-14 03:05:22.826649 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-12-14 03:05:22.889068 | debian-bookworm | Collecting packaging>=25 2025-12-14 03:05:22.900846 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-12-14 03:05:22.910046 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.2 MB/s eta 0:00:00 2025-12-14 03:05:22.957272 | debian-bookworm | Collecting platformdirs>=4.5 2025-12-14 03:05:22.969279 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2025-12-14 03:05:23.012358 | debian-bookworm | Collecting pluggy>=1.6 2025-12-14 03:05:23.024181 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-12-14 03:05:23.111397 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-12-14 03:05:23.125092 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-12-14 03:05:23.270361 | debian-bookworm | Collecting virtualenv>=20.34 2025-12-14 03:05:23.282938 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2025-12-14 03:05:23.589004 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 19.9 MB/s eta 0:00:00 2025-12-14 03:05:23.692172 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-12-14 03:05:23.703209 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-12-14 03:05:23.726917 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 22.3 MB/s eta 0:00:00 2025-12-14 03:05:23.873123 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-12-14 03:05:24.691215 | debian-bookworm | Successfully installed cachetools-6.2.3 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-14 03:05:25.063768 | debian-bookworm | ok: Runtime: 0:00:02.996326 2025-12-14 03:05:25.070136 | 2025-12-14 03:05:25.070255 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-14 03:05:25.152171 | debian-bookworm | ok 2025-12-14 03:05:25.174374 | 2025-12-14 03:05:25.174534 | TASK [ensure-tox : Output tox version] 2025-12-14 03:05:25.756054 | 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-14 03:05:25.774399 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-14 03:05:26.236144 | debian-bookworm | ok: Runtime: 0:00:00.294448 2025-12-14 03:05:26.242391 | 2025-12-14 03:05:26.242516 | TASK [ensure-tox : Make global symlink] 2025-12-14 03:05:26.276882 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:26.295517 | 2025-12-14 03:05:26.295629 | PLAY RECAP 2025-12-14 03:05:26.295687 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-12-14 03:05:26.295713 | 2025-12-14 03:05:26.511494 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-12-14 03:05:26.512717 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-14 03:05:27.363605 | 2025-12-14 03:05:27.363776 | PLAY [all] 2025-12-14 03:05:27.381973 | 2025-12-14 03:05:27.382130 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-12-14 03:05:27.921501 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-14 03:05:28.428716 | debian-bookworm | ok: Runtime: 0:00:00.026428 2025-12-14 03:05:28.434875 | 2025-12-14 03:05:28.435081 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-12-14 03:05:28.965433 | debian-bookworm | ok: Runtime: 0:00:00.006274 2025-12-14 03:05:28.974359 | 2025-12-14 03:05:28.974582 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-12-14 03:05:29.375645 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-12-14 03:05:29.378897 | debian-bookworm | sudo: a password is required 2025-12-14 03:05:29.561658 | debian-bookworm | ok: Runtime: 0:00:00.023020 2025-12-14 03:05:29.596415 | 2025-12-14 03:05:29.597606 | TASK [tox : Check to see if the constraints file exists] 2025-12-14 03:05:29.674491 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:29.685332 | 2025-12-14 03:05:29.685493 | TASK [tox : Fail if constraints file is missing] 2025-12-14 03:05:29.790797 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:29.807664 | 2025-12-14 03:05:29.807860 | TASK [tox : Record file location] 2025-12-14 03:05:29.889376 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:29.908039 | 2025-12-14 03:05:29.908184 | TASK [tox : Install tox siblings] 2025-12-14 03:05:30.016248 | debian-bookworm | ok 2025-12-14 03:05:30.075689 | debian-bookworm | included: /var/lib/zuul/builds/6764244a14eb43ed8d1bdc6e1e24aef4/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-12-14 03:05:30.137279 | 2025-12-14 03:05:30.137440 | TASK [tox : Run tox without tests] 2025-12-14 03:05:31.623297 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-12-14 03:05:44.721443 | debian-bookworm | test: OK (13.67 seconds) 2025-12-14 03:05:44.721511 | debian-bookworm | congratulations :) (13.71 seconds) 2025-12-14 03:05:44.813993 | debian-bookworm | ok: Runtime: 0:00:13.959803 2025-12-14 03:05:44.839517 | 2025-12-14 03:05:44.839658 | TASK [tox : Create a tempfile to save tox showconfig] 2025-12-14 03:05:45.558390 | debian-bookworm | changed 2025-12-14 03:05:45.564428 | 2025-12-14 03:05:45.564561 | TASK [tox : Get tox envlist config] 2025-12-14 03:05:46.691063 | debian-bookworm | ok: Runtime: 0:00:00.299352 2025-12-14 03:05:46.702637 | 2025-12-14 03:05:46.702769 | TASK [tox : Install any sibling python packages] 2025-12-14 03:05:47.783329 | debian-bookworm | ok: No setup.cfg, no action needed 2025-12-14 03:05:47.811629 | 2025-12-14 03:05:47.811779 | TASK [tox : Remove tempfile] 2025-12-14 03:05:48.593655 | debian-bookworm | changed 2025-12-14 03:05:48.606065 | 2025-12-14 03:05:48.606206 | TASK [tox : Emit tox command] 2025-12-14 03:05:48.764239 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-12-14 03:05:48.777472 | 2025-12-14 03:05:48.777636 | TASK [tox : Run tox] 2025-12-14 03:05:50.026369 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-12-14 03:05:50.601599 | debian-bookworm | ............... 2025-12-14 03:05:50.601636 | debian-bookworm | ---------------------------------------------------------------------- 2025-12-14 03:05:50.601649 | debian-bookworm | Ran 15 tests in 0.167s 2025-12-14 03:05:50.601654 | debian-bookworm | 2025-12-14 03:05:50.601661 | debian-bookworm | OK 2025-12-14 03:05:50.660506 | debian-bookworm | test: OK (0.67=setup[0.04]+cmd[0.63] seconds) 2025-12-14 03:05:50.660554 | debian-bookworm | congratulations :) (0.70 seconds) 2025-12-14 03:05:51.147107 | debian-bookworm | ok: Runtime: 0:00:00.936252 2025-12-14 03:05:51.154069 | 2025-12-14 03:05:51.154244 | TASK [tox : Look for output] 2025-12-14 03:05:51.870811 | debian-bookworm | ok 2025-12-14 03:05:51.912188 | 2025-12-14 03:05:51.912360 | TASK [tox : Return file comments to Zuul] 2025-12-14 03:05:52.014348 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:52.027347 | 2025-12-14 03:05:52.027468 | PLAY RECAP 2025-12-14 03:05:52.027538 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-14 03:05:52.027567 | 2025-12-14 03:05:52.806422 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-12-14 03:05:52.807636 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-14 03:05:54.249576 | 2025-12-14 03:05:54.249705 | PLAY [all] 2025-12-14 03:05:54.296145 | 2025-12-14 03:05:54.296282 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-12-14 03:05:54.360361 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:54.365876 | 2025-12-14 03:05:54.366015 | TASK [fetch-tox-output : Set tox log path for single node] 2025-12-14 03:05:54.427376 | debian-bookworm | ok 2025-12-14 03:05:54.432269 | 2025-12-14 03:05:54.432368 | TASK [fetch-tox-output : Ensure local tox dir] 2025-12-14 03:05:55.004995 | debian-bookworm -> localhost | changed 2025-12-14 03:05:55.012490 | 2025-12-14 03:05:55.012599 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-12-14 03:05:55.087655 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:55.094060 | 2025-12-14 03:05:55.094170 | TASK [fetch-tox-output : Set envlist fact] 2025-12-14 03:05:55.152820 | debian-bookworm | ok 2025-12-14 03:05:55.159748 | 2025-12-14 03:05:55.159848 | TASK [fetch-tox-output : Get tox version] 2025-12-14 03:05:56.206830 | 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-14 03:05:56.223978 | debian-bookworm | 4.32.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-12-14 03:05:56.724973 | debian-bookworm | ok: Runtime: 0:00:00.253135 2025-12-14 03:05:56.729320 | 2025-12-14 03:05:56.729480 | TASK [fetch-tox-output : Find all default environments] 2025-12-14 03:05:57.279597 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:57.284533 | 2025-12-14 03:05:57.284628 | TASK [fetch-tox-output : Set envlist fact] 2025-12-14 03:05:57.307685 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:57.312228 | 2025-12-14 03:05:57.312312 | TASK [fetch-tox-output : Find all default environments] 2025-12-14 03:05:57.836688 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:57.856270 | 2025-12-14 03:05:57.856442 | TASK [fetch-tox-output : Set envlist fact] 2025-12-14 03:05:57.890985 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:57.898163 | 2025-12-14 03:05:57.898277 | LOOP [fetch-tox-output : Copy tox logs] 2025-12-14 03:05:57.962370 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:05:57.971553 | 2025-12-14 03:05:57.971665 | LOOP [fetch-tox-output : Collect tox logs] 2025-12-14 03:05:59.347857 | debian-bookworm | changed: 2025-12-14 03:05:59.348125 | debian-bookworm | created directory /var/lib/zuul/builds/6764244a14eb43ed8d1bdc6e1e24aef4/work/logs/tox/test 2025-12-14 03:05:59.348158 | debian-bookworm | cd+++++++++ ./ 2025-12-14 03:05:59.348179 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-12-14 03:05:59.348202 | 2025-12-14 03:05:59.359085 | 2025-12-14 03:05:59.359167 | PLAY RECAP 2025-12-14 03:05:59.359214 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-12-14 03:05:59.359236 | 2025-12-14 03:05:59.718470 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-12-14 03:05:59.719426 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-14 03:06:01.148460 | 2025-12-14 03:06:01.148577 | PLAY [all] 2025-12-14 03:06:01.181737 | 2025-12-14 03:06:01.181852 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-12-14 03:06:01.451736 | debian-bookworm | changed: non-zero return code 2025-12-14 03:06:01.456447 | 2025-12-14 03:06:01.456556 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-12-14 03:06:01.512190 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:06:01.518026 | 2025-12-14 03:06:01.518136 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-12-14 03:06:01.578514 | 2025-12-14 03:06:01.578670 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-12-14 03:06:01.627854 | 2025-12-14 03:06:01.628040 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-12-14 03:06:01.660897 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:06:01.665927 | 2025-12-14 03:06:01.666028 | LOOP [fetch-subunit-output : Generate subunit file] 2025-12-14 03:06:01.714817 | 2025-12-14 03:06:01.715907 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-12-14 03:06:01.758989 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:06:01.763795 | 2025-12-14 03:06:01.763905 | TASK [fetch-subunit-output : Remove the temporary file] 2025-12-14 03:06:01.807683 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:06:01.813263 | 2025-12-14 03:06:01.813364 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-12-14 03:06:01.870378 | debian-bookworm | skipping: Conditional result was False 2025-12-14 03:06:01.876267 | 2025-12-14 03:06:01.876330 | PLAY RECAP 2025-12-14 03:06:01.876369 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-12-14 03:06:01.876389 | 2025-12-14 03:06:02.281705 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-12-14 03:06:02.282684 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-14 03:06:04.371835 | 2025-12-14 03:06:04.371990 | PLAY [Base post] 2025-12-14 03:06:04.430419 | 2025-12-14 03:06:04.430556 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-14 03:06:05.202799 | debian-bookworm | changed 2025-12-14 03:06:05.212827 | 2025-12-14 03:06:05.212955 | PLAY RECAP 2025-12-14 03:06:05.213025 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-14 03:06:05.213094 | 2025-12-14 03:06:05.539530 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-14 03:06:05.540658 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-14 03:06:07.876437 | 2025-12-14 03:06:07.876555 | PLAY [Base post-logs] 2025-12-14 03:06:07.904447 | 2025-12-14 03:06:07.904572 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-14 03:06:09.502390 | localhost | changed 2025-12-14 03:06:09.514674 | 2025-12-14 03:06:09.514804 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-14 03:06:09.645654 | localhost | ok 2025-12-14 03:06:09.649684 | 2025-12-14 03:06:09.649792 | TASK [Set zuul-log-path fact] 2025-12-14 03:06:09.693938 | localhost | ok 2025-12-14 03:06:09.737109 | 2025-12-14 03:06:09.737227 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-14 03:06:09.806241 | localhost | ok 2025-12-14 03:06:09.839945 | 2025-12-14 03:06:09.840074 | TASK [upload-logs : Create log directories] 2025-12-14 03:06:11.143994 | localhost | changed 2025-12-14 03:06:11.146630 | 2025-12-14 03:06:11.146722 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-14 03:06:13.079281 | localhost -> localhost | ok: Runtime: 0:00:00.063828 2025-12-14 03:06:13.083323 | 2025-12-14 03:06:13.083426 | TASK [upload-logs : Upload logs to log server] 2025-12-14 03:06:14.233295 | localhost | Output suppressed because no_log was given 2025-12-14 03:06:14.235469 | 2025-12-14 03:06:14.235581 | LOOP [upload-logs : Compress console log and json output] 2025-12-14 03:06:14.299791 | localhost | skipping: Conditional result was False 2025-12-14 03:06:14.308765 | localhost | skipping: Conditional result was False 2025-12-14 03:06:14.315015 | 2025-12-14 03:06:14.315152 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-14 03:06:14.486352 | localhost | skipping: Conditional result was False 2025-12-14 03:06:14.486668 | 2025-12-14 03:06:14.518069 | localhost | skipping: Conditional result was False 2025-12-14 03:06:14.545796 | 2025-12-14 03:06:14.545965 | LOOP [upload-logs : Upload console log and json output]