2025-10-10 03:09:01.914168 | Job console starting 2025-10-10 03:09:01.928105 | Updating git repos 2025-10-10 03:09:01.952060 | Cloning repos into workspace 2025-10-10 03:09:02.005810 | Restoring repo states 2025-10-10 03:09:02.021654 | Merging changes 2025-10-10 03:09:02.021666 | Checking out repos 2025-10-10 03:09:02.041675 | Preparing playbooks 2025-10-10 03:09:02.904467 | Running Ansible setup 2025-10-10 03:09:08.816934 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-10 03:09:10.586476 | 2025-10-10 03:09:10.586589 | PLAY [Base pre] 2025-10-10 03:09:10.614984 | 2025-10-10 03:09:10.615091 | TASK [Setup log path fact] 2025-10-10 03:09:10.636752 | debian-bookworm | ok 2025-10-10 03:09:10.659681 | 2025-10-10 03:09:10.659809 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-10 03:09:10.730982 | debian-bookworm | ok 2025-10-10 03:09:10.759070 | 2025-10-10 03:09:10.759169 | TASK [emit-job-header : Print job information] 2025-10-10 03:09:10.876453 | # Job Information 2025-10-10 03:09:10.876673 | Ansible Version: 2.16.14 2025-10-10 03:09:10.876707 | Job: tox 2025-10-10 03:09:10.876735 | Pipeline: periodic-daily 2025-10-10 03:09:10.876810 | Executor: 521e9411259a 2025-10-10 03:09:10.876886 | Triggered by: https://github.com/osism/openstack-image-manager 2025-10-10 03:09:10.876908 | Event ID: 28077d91121e408cab9c3af60ca05638 2025-10-10 03:09:10.882004 | 2025-10-10 03:09:10.882092 | LOOP [emit-job-header : Print node information] 2025-10-10 03:09:11.234006 | debian-bookworm | ok: 2025-10-10 03:09:11.234206 | debian-bookworm | # Node Information 2025-10-10 03:09:11.234235 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-10 03:09:11.234255 | debian-bookworm | Hostname: debian 2025-10-10 03:09:11.234273 | debian-bookworm | Username: zuul 2025-10-10 03:09:11.234289 | debian-bookworm | Distro: Debian 12.12 2025-10-10 03:09:11.234309 | debian-bookworm | Provider: regiocloud-a 2025-10-10 03:09:11.234326 | debian-bookworm | Region: 2025-10-10 03:09:11.234343 | debian-bookworm | Label: debian-bookworm 2025-10-10 03:09:11.234359 | debian-bookworm | Product Name: OpenStack Nova 2025-10-10 03:09:11.234374 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0f:b95d 2025-10-10 03:09:11.244597 | 2025-10-10 03:09:11.244690 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-10 03:09:12.620675 | debian-bookworm -> localhost | changed 2025-10-10 03:09:12.626496 | 2025-10-10 03:09:12.626584 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-10 03:09:16.089225 | debian-bookworm -> localhost | changed 2025-10-10 03:09:16.097713 | 2025-10-10 03:09:16.097847 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-10 03:09:17.003061 | debian-bookworm -> localhost | ok 2025-10-10 03:09:17.007977 | 2025-10-10 03:09:17.008065 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-10 03:09:17.054548 | debian-bookworm | ok 2025-10-10 03:09:17.101302 | debian-bookworm | included: /var/lib/zuul/builds/cd02f080b5bc4f359723d811abb9f487/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-10 03:09:17.131704 | 2025-10-10 03:09:17.131811 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-10 03:09:20.523367 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-10 03:09:20.523541 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cd02f080b5bc4f359723d811abb9f487/work/cd02f080b5bc4f359723d811abb9f487_id_rsa 2025-10-10 03:09:20.523573 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cd02f080b5bc4f359723d811abb9f487/work/cd02f080b5bc4f359723d811abb9f487_id_rsa.pub 2025-10-10 03:09:20.523594 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-10 03:09:20.523615 | debian-bookworm -> localhost | SHA256:XMc2ls20vuQyLxb2JOW6ZJh8STl9KYAj1pB0n5mvlPc zuul-build-sshkey 2025-10-10 03:09:20.523633 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-10 03:09:20.523659 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-10 03:09:20.523678 | debian-bookworm -> localhost | | .o.. . | 2025-10-10 03:09:20.523696 | debian-bookworm -> localhost | | .+ o.+= . | 2025-10-10 03:09:20.523714 | debian-bookworm -> localhost | | o +.*B + | 2025-10-10 03:09:20.523742 | debian-bookworm -> localhost | | .....++=. .| 2025-10-10 03:09:20.523759 | debian-bookworm -> localhost | | S o+*+..| 2025-10-10 03:09:20.523781 | debian-bookworm -> localhost | | ..+*==o | 2025-10-10 03:09:20.523799 | debian-bookworm -> localhost | | +oB*oE | 2025-10-10 03:09:20.523816 | debian-bookworm -> localhost | | +++. | 2025-10-10 03:09:20.523833 | debian-bookworm -> localhost | | ..o. | 2025-10-10 03:09:20.523849 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-10 03:09:20.523889 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.259556 2025-10-10 03:09:20.529173 | 2025-10-10 03:09:20.529254 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-10 03:09:20.565902 | debian-bookworm | ok 2025-10-10 03:09:20.581899 | debian-bookworm | included: /var/lib/zuul/builds/cd02f080b5bc4f359723d811abb9f487/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-10 03:09:20.598246 | 2025-10-10 03:09:20.598330 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-10 03:09:20.611116 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:09:20.615999 | 2025-10-10 03:09:20.616080 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-10 03:09:21.295109 | debian-bookworm | changed 2025-10-10 03:09:21.301269 | 2025-10-10 03:09:21.301348 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-10 03:09:21.611040 | debian-bookworm | ok 2025-10-10 03:09:21.615473 | 2025-10-10 03:09:21.615549 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-10 03:09:22.326013 | debian-bookworm | changed 2025-10-10 03:09:22.336451 | 2025-10-10 03:09:22.336554 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-10 03:09:23.093235 | debian-bookworm | changed 2025-10-10 03:09:23.100276 | 2025-10-10 03:09:23.100384 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-10 03:09:23.123477 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:09:23.129342 | 2025-10-10 03:09:23.129438 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-10 03:09:23.902681 | debian-bookworm -> localhost | changed 2025-10-10 03:09:23.913260 | 2025-10-10 03:09:23.913368 | TASK [add-build-sshkey : Add back temp key] 2025-10-10 03:09:24.246293 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cd02f080b5bc4f359723d811abb9f487/work/cd02f080b5bc4f359723d811abb9f487_id_rsa (zuul-build-sshkey) 2025-10-10 03:09:24.246531 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017962 2025-10-10 03:09:24.253805 | 2025-10-10 03:09:24.253896 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-10 03:09:24.727002 | debian-bookworm | ok 2025-10-10 03:09:24.733121 | 2025-10-10 03:09:24.733213 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-10 03:09:24.776457 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:09:24.788298 | 2025-10-10 03:09:24.788397 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-10 03:09:25.234262 | debian-bookworm | ok 2025-10-10 03:09:25.244700 | 2025-10-10 03:09:25.244806 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-10 03:09:25.262927 | debian-bookworm | ok 2025-10-10 03:09:25.266879 | 2025-10-10 03:09:25.266947 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-10 03:09:25.531667 | debian-bookworm -> localhost | ok 2025-10-10 03:09:25.546292 | 2025-10-10 03:09:25.546407 | TASK [validate-host : Collect information about the host] 2025-10-10 03:09:26.625671 | debian-bookworm | ok 2025-10-10 03:09:26.635454 | 2025-10-10 03:09:26.635545 | TASK [validate-host : Sanitize hostname] 2025-10-10 03:09:26.724965 | debian-bookworm | ok 2025-10-10 03:09:26.755579 | 2025-10-10 03:09:26.755680 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-10 03:09:27.233735 | debian-bookworm -> localhost | changed 2025-10-10 03:09:27.240326 | 2025-10-10 03:09:27.240451 | TASK [validate-host : Collect information about zuul worker] 2025-10-10 03:09:27.625947 | debian-bookworm | ok 2025-10-10 03:09:27.630577 | 2025-10-10 03:09:27.630674 | TASK [validate-host : Write out all zuul information for each host] 2025-10-10 03:09:28.303715 | debian-bookworm -> localhost | changed 2025-10-10 03:09:28.312780 | 2025-10-10 03:09:28.312878 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-10 03:09:28.619236 | debian-bookworm | ok 2025-10-10 03:09:28.626913 | 2025-10-10 03:09:28.627027 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-10 03:09:29.679816 | debian-bookworm | changed: 2025-10-10 03:09:29.679986 | debian-bookworm | cd+++++++++ src/ 2025-10-10 03:09:29.680022 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-10 03:09:29.680047 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-10 03:09:29.680069 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-10 03:09:29.680089 | debian-bookworm | =6.2 2025-10-10 03:09:52.674255 | debian-bookworm | Downloading cachetools-6.2.0-py3-none-any.whl (11 kB) 2025-10-10 03:09:52.705700 | debian-bookworm | Collecting chardet>=5.2 2025-10-10 03:09:52.713902 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-10-10 03:09:52.740093 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 8.5 MB/s eta 0:00:00 2025-10-10 03:09:52.778995 | debian-bookworm | Collecting colorama>=0.4.6 2025-10-10 03:09:52.788025 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-10 03:09:52.838586 | debian-bookworm | Collecting filelock>=3.20 2025-10-10 03:09:52.846749 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-10-10 03:09:52.893644 | debian-bookworm | Collecting packaging>=25 2025-10-10 03:09:52.902082 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-10 03:09:52.916006 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 5.6 MB/s eta 0:00:00 2025-10-10 03:09:52.965581 | debian-bookworm | Collecting platformdirs>=4.5 2025-10-10 03:09:52.974574 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-10-10 03:09:53.031350 | debian-bookworm | Collecting pluggy>=1.6 2025-10-10 03:09:53.039768 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-10-10 03:09:53.077564 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-10-10 03:09:53.086252 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-10-10 03:09:53.210725 | debian-bookworm | Collecting virtualenv>=20.34 2025-10-10 03:09:53.219114 | debian-bookworm | Downloading virtualenv-20.35.1-py3-none-any.whl (6.0 MB) 2025-10-10 03:09:53.456434 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 25.7 MB/s eta 0:00:00 2025-10-10 03:09:53.551505 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-10-10 03:09:53.561514 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-10-10 03:09:53.589329 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.1 MB/s eta 0:00:00 2025-10-10 03:09:53.757676 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-10-10 03:09:54.698472 | debian-bookworm | Successfully installed cachetools-6.2.0 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.1 2025-10-10 03:09:55.007144 | debian-bookworm | ok: Runtime: 0:00:03.032197 2025-10-10 03:09:55.011900 | 2025-10-10 03:09:55.011977 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-10 03:09:55.039258 | debian-bookworm | ok 2025-10-10 03:09:55.043173 | 2025-10-10 03:09:55.043246 | TASK [ensure-tox : Output tox version] 2025-10-10 03:09:55.577964 | 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-10 03:09:55.596800 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-10 03:09:56.064655 | debian-bookworm | ok: Runtime: 0:00:00.321698 2025-10-10 03:09:56.069914 | 2025-10-10 03:09:56.069994 | TASK [ensure-tox : Make global symlink] 2025-10-10 03:09:56.093233 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:09:56.104269 | 2025-10-10 03:09:56.104342 | PLAY RECAP 2025-10-10 03:09:56.104393 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-10 03:09:56.104418 | 2025-10-10 03:09:56.295483 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-10-10 03:09:56.296434 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-10 03:09:57.350104 | 2025-10-10 03:09:57.350227 | PLAY [all] 2025-10-10 03:09:57.364036 | 2025-10-10 03:09:57.364146 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-10-10 03:09:57.819707 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-10 03:09:57.909906 | debian-bookworm | ok: Runtime: 0:00:00.034613 2025-10-10 03:09:57.914422 | 2025-10-10 03:09:57.914514 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-10-10 03:09:58.438890 | debian-bookworm | ok: Runtime: 0:00:00.007726 2025-10-10 03:09:58.443535 | 2025-10-10 03:09:58.443615 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-10-10 03:09:58.717870 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-10 03:09:58.721965 | debian-bookworm | sudo: a password is required 2025-10-10 03:09:58.979171 | debian-bookworm | ok: Runtime: 0:00:00.028683 2025-10-10 03:09:58.987117 | 2025-10-10 03:09:58.987198 | TASK [tox : Check to see if the constraints file exists] 2025-10-10 03:09:59.020031 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:09:59.025052 | 2025-10-10 03:09:59.025141 | TASK [tox : Fail if constraints file is missing] 2025-10-10 03:09:59.057709 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:09:59.062539 | 2025-10-10 03:09:59.062624 | TASK [tox : Record file location] 2025-10-10 03:09:59.085898 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:09:59.090468 | 2025-10-10 03:09:59.090550 | TASK [tox : Install tox siblings] 2025-10-10 03:09:59.118450 | debian-bookworm | ok 2025-10-10 03:09:59.128795 | debian-bookworm | included: /var/lib/zuul/builds/cd02f080b5bc4f359723d811abb9f487/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-10-10 03:09:59.142024 | 2025-10-10 03:09:59.142122 | TASK [tox : Run tox without tests] 2025-10-10 03:10:00.292794 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-10-10 03:10:13.516196 | debian-bookworm | test: OK (13.82 seconds) 2025-10-10 03:10:13.516327 | debian-bookworm | congratulations :) (13.85 seconds) 2025-10-10 03:10:13.677467 | debian-bookworm | ok: Runtime: 0:00:14.147356 2025-10-10 03:10:13.682998 | 2025-10-10 03:10:13.683081 | TASK [tox : Create a tempfile to save tox showconfig] 2025-10-10 03:10:14.074577 | debian-bookworm | changed 2025-10-10 03:10:14.079436 | 2025-10-10 03:10:14.079518 | TASK [tox : Get tox envlist config] 2025-10-10 03:10:15.107870 | debian-bookworm | ok: Runtime: 0:00:00.364300 2025-10-10 03:10:15.113241 | 2025-10-10 03:10:15.113333 | TASK [tox : Install any sibling python packages] 2025-10-10 03:10:15.585610 | debian-bookworm | ok: No setup.cfg, no action needed 2025-10-10 03:10:15.594929 | 2025-10-10 03:10:15.595034 | TASK [tox : Remove tempfile] 2025-10-10 03:10:16.071476 | debian-bookworm | changed 2025-10-10 03:10:16.078571 | 2025-10-10 03:10:16.078679 | TASK [tox : Emit tox command] 2025-10-10 03:10:16.119639 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-10-10 03:10:16.125034 | 2025-10-10 03:10:16.125128 | TASK [tox : Run tox] 2025-10-10 03:10:16.857077 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-10-10 03:10:17.556960 | debian-bookworm | ............... 2025-10-10 03:10:17.557024 | debian-bookworm | ---------------------------------------------------------------------- 2025-10-10 03:10:17.557042 | debian-bookworm | Ran 15 tests in 0.179s 2025-10-10 03:10:17.557047 | debian-bookworm | 2025-10-10 03:10:17.557055 | debian-bookworm | OK 2025-10-10 03:10:17.670098 | debian-bookworm | test: OK (0.85=setup[0.04]+cmd[0.81] seconds) 2025-10-10 03:10:17.670199 | debian-bookworm | congratulations :) (0.88 seconds) 2025-10-10 03:10:17.763811 | debian-bookworm | ok: Runtime: 0:00:01.180451 2025-10-10 03:10:17.768943 | 2025-10-10 03:10:17.769070 | TASK [tox : Look for output] 2025-10-10 03:10:18.160382 | debian-bookworm | ok 2025-10-10 03:10:18.178961 | 2025-10-10 03:10:18.179116 | TASK [tox : Return file comments to Zuul] 2025-10-10 03:10:18.213544 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:18.220513 | 2025-10-10 03:10:18.220618 | PLAY RECAP 2025-10-10 03:10:18.220671 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-10 03:10:18.220696 | 2025-10-10 03:10:18.356808 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-10 03:10:18.359553 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-10 03:10:19.275415 | 2025-10-10 03:10:19.275574 | PLAY [all] 2025-10-10 03:10:19.298393 | 2025-10-10 03:10:19.298524 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-10-10 03:10:19.355050 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:19.364976 | 2025-10-10 03:10:19.365144 | TASK [fetch-tox-output : Set tox log path for single node] 2025-10-10 03:10:19.426418 | debian-bookworm | ok 2025-10-10 03:10:19.432535 | 2025-10-10 03:10:19.432701 | TASK [fetch-tox-output : Ensure local tox dir] 2025-10-10 03:10:19.922988 | debian-bookworm -> localhost | changed 2025-10-10 03:10:19.936710 | 2025-10-10 03:10:19.936857 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-10-10 03:10:19.981950 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:19.994978 | 2025-10-10 03:10:19.995149 | TASK [fetch-tox-output : Set envlist fact] 2025-10-10 03:10:20.049009 | debian-bookworm | ok 2025-10-10 03:10:20.057108 | 2025-10-10 03:10:20.057233 | TASK [fetch-tox-output : Get tox version] 2025-10-10 03:10:20.772317 | 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-10 03:10:20.792064 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-10 03:10:21.087714 | debian-bookworm | ok: Runtime: 0:00:00.325095 2025-10-10 03:10:21.093943 | 2025-10-10 03:10:21.094064 | TASK [fetch-tox-output : Find all default environments] 2025-10-10 03:10:21.640017 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:21.650980 | 2025-10-10 03:10:21.651150 | TASK [fetch-tox-output : Set envlist fact] 2025-10-10 03:10:21.707095 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:21.724314 | 2025-10-10 03:10:21.724476 | TASK [fetch-tox-output : Find all default environments] 2025-10-10 03:10:22.272511 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:22.278676 | 2025-10-10 03:10:22.278800 | TASK [fetch-tox-output : Set envlist fact] 2025-10-10 03:10:22.302491 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:22.308923 | 2025-10-10 03:10:22.309036 | LOOP [fetch-tox-output : Copy tox logs] 2025-10-10 03:10:22.351823 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:22.360104 | 2025-10-10 03:10:22.360217 | LOOP [fetch-tox-output : Collect tox logs] 2025-10-10 03:10:23.268085 | debian-bookworm | changed: 2025-10-10 03:10:23.268285 | debian-bookworm | created directory /var/lib/zuul/builds/cd02f080b5bc4f359723d811abb9f487/work/logs/tox/test 2025-10-10 03:10:23.268320 | debian-bookworm | cd+++++++++ ./ 2025-10-10 03:10:23.268344 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-10-10 03:10:23.268377 | 2025-10-10 03:10:23.282673 | 2025-10-10 03:10:23.282783 | PLAY RECAP 2025-10-10 03:10:23.282874 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-10 03:10:23.282902 | 2025-10-10 03:10:23.482809 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-10 03:10:23.484358 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-10 03:10:24.913695 | 2025-10-10 03:10:24.913858 | PLAY [all] 2025-10-10 03:10:24.956457 | 2025-10-10 03:10:24.956690 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-10-10 03:10:25.457132 | debian-bookworm | changed: non-zero return code 2025-10-10 03:10:25.477015 | 2025-10-10 03:10:25.477909 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-10-10 03:10:25.539496 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:25.547802 | 2025-10-10 03:10:25.547948 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-10-10 03:10:25.653115 | 2025-10-10 03:10:25.653322 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-10-10 03:10:25.798127 | 2025-10-10 03:10:25.798332 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-10-10 03:10:25.864045 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:25.873350 | 2025-10-10 03:10:25.873494 | LOOP [fetch-subunit-output : Generate subunit file] 2025-10-10 03:10:25.945814 | 2025-10-10 03:10:25.946077 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-10-10 03:10:26.009089 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:26.025961 | 2025-10-10 03:10:26.026096 | TASK [fetch-subunit-output : Remove the temporary file] 2025-10-10 03:10:26.135970 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:26.150708 | 2025-10-10 03:10:26.153721 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-10-10 03:10:26.178869 | debian-bookworm | skipping: Conditional result was False 2025-10-10 03:10:26.213767 | 2025-10-10 03:10:26.213873 | PLAY RECAP 2025-10-10 03:10:26.213927 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-10 03:10:26.213952 | 2025-10-10 03:10:26.530815 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-10 03:10:26.536242 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-10 03:10:28.541126 | 2025-10-10 03:10:28.541258 | PLAY [Base post] 2025-10-10 03:10:28.566102 | 2025-10-10 03:10:28.566209 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-10 03:10:29.442417 | debian-bookworm | changed 2025-10-10 03:10:29.450990 | 2025-10-10 03:10:29.451080 | PLAY RECAP 2025-10-10 03:10:29.451132 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-10 03:10:29.451181 | 2025-10-10 03:10:29.621126 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-10 03:10:29.622002 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-10 03:10:31.528742 | 2025-10-10 03:10:31.528864 | PLAY [Base post-logs] 2025-10-10 03:10:31.596937 | 2025-10-10 03:10:31.597054 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-10 03:10:33.190554 | localhost | changed 2025-10-10 03:10:33.198417 | 2025-10-10 03:10:33.198519 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-10 03:10:33.256290 | localhost | ok 2025-10-10 03:10:33.258616 | 2025-10-10 03:10:33.258687 | TASK [Set zuul-log-path fact] 2025-10-10 03:10:33.283133 | localhost | ok 2025-10-10 03:10:33.290284 | 2025-10-10 03:10:33.290376 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-10 03:10:33.348878 | localhost | ok 2025-10-10 03:10:33.351378 | 2025-10-10 03:10:33.351454 | TASK [upload-logs : Create log directories] 2025-10-10 03:10:34.504605 | localhost | changed 2025-10-10 03:10:34.506672 | 2025-10-10 03:10:34.506743 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-10 03:10:36.088124 | localhost -> localhost | ok: Runtime: 0:00:00.022057 2025-10-10 03:10:36.091167 | 2025-10-10 03:10:36.091253 | TASK [upload-logs : Upload logs to log server] 2025-10-10 03:10:37.454679 | localhost | Output suppressed because no_log was given 2025-10-10 03:10:37.456081 | 2025-10-10 03:10:37.456150 | LOOP [upload-logs : Compress console log and json output] 2025-10-10 03:10:37.583630 | localhost | skipping: Conditional result was False 2025-10-10 03:10:37.619096 | localhost | skipping: Conditional result was False 2025-10-10 03:10:37.625203 | 2025-10-10 03:10:37.625404 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-10 03:10:37.780558 | localhost | skipping: Conditional result was False 2025-10-10 03:10:37.780805 | 2025-10-10 03:10:37.805076 | localhost | skipping: Conditional result was False 2025-10-10 03:10:37.816572 | 2025-10-10 03:10:37.816685 | LOOP [upload-logs : Upload console log and json output]