2026-07-07 03:04:11.228938 | Job console starting 2026-07-07 03:04:11.239072 | Updating git repos 2026-07-07 03:04:11.278744 | Cloning repos into workspace 2026-07-07 03:04:11.370677 | Restoring repo states 2026-07-07 03:04:11.400583 | Merging changes 2026-07-07 03:04:11.400602 | Checking out repos 2026-07-07 03:04:11.501434 | Preparing playbooks 2026-07-07 03:04:13.323426 | Running Ansible setup 2026-07-07 03:04:20.642674 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-07 03:04:24.449089 | 2026-07-07 03:04:24.457667 | PLAY [Base pre] 2026-07-07 03:04:24.537416 | 2026-07-07 03:04:24.537562 | TASK [Setup log path fact] 2026-07-07 03:04:24.594572 | debian-bookworm | ok 2026-07-07 03:04:24.646606 | 2026-07-07 03:04:24.646769 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-07 03:04:24.730406 | debian-bookworm | ok 2026-07-07 03:04:24.753761 | 2026-07-07 03:04:24.753875 | TASK [emit-job-header : Print job information] 2026-07-07 03:04:24.833306 | # Job Information 2026-07-07 03:04:24.833498 | Ansible Version: 2.16.14 2026-07-07 03:04:24.833529 | Job: tox 2026-07-07 03:04:24.833557 | Pipeline: periodic-daily 2026-07-07 03:04:24.833576 | Executor: 521e9411259a 2026-07-07 03:04:24.833593 | Triggered by: https://github.com/osism/openstack-image-manager 2026-07-07 03:04:24.833611 | Event ID: 288941d38c7d4127a14b83de6a1b3006 2026-07-07 03:04:24.837798 | 2026-07-07 03:04:24.837879 | LOOP [emit-job-header : Print node information] 2026-07-07 03:04:25.053819 | debian-bookworm | ok: 2026-07-07 03:04:25.054048 | debian-bookworm | # Node Information 2026-07-07 03:04:25.054080 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-07 03:04:25.054103 | debian-bookworm | Hostname: debian 2026-07-07 03:04:25.054121 | debian-bookworm | Username: zuul 2026-07-07 03:04:25.054139 | debian-bookworm | Distro: Debian 12.14 2026-07-07 03:04:25.054159 | debian-bookworm | Provider: regiocloud-a 2026-07-07 03:04:25.054176 | debian-bookworm | Region: 2026-07-07 03:04:25.054194 | debian-bookworm | Label: debian-bookworm 2026-07-07 03:04:25.054210 | debian-bookworm | Product Name: OpenStack Nova 2026-07-07 03:04:25.054226 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed4:380 2026-07-07 03:04:25.072215 | 2026-07-07 03:04:25.072322 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-07 03:04:25.763697 | debian-bookworm -> localhost | changed 2026-07-07 03:04:25.769740 | 2026-07-07 03:04:25.769840 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-07 03:04:27.176819 | debian-bookworm -> localhost | changed 2026-07-07 03:04:27.207834 | 2026-07-07 03:04:27.207951 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-07 03:04:28.146146 | debian-bookworm -> localhost | ok 2026-07-07 03:04:28.152593 | 2026-07-07 03:04:28.152705 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-07 03:04:28.192737 | debian-bookworm | ok 2026-07-07 03:04:28.251487 | debian-bookworm | included: /var/lib/zuul/builds/d760e15299a74f4b9cc4e97154b85ece/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-07 03:04:28.268242 | 2026-07-07 03:04:28.268354 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-07 03:04:31.378129 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-07 03:04:31.378339 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d760e15299a74f4b9cc4e97154b85ece/work/d760e15299a74f4b9cc4e97154b85ece_id_rsa 2026-07-07 03:04:31.378372 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d760e15299a74f4b9cc4e97154b85ece/work/d760e15299a74f4b9cc4e97154b85ece_id_rsa.pub 2026-07-07 03:04:31.378395 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-07 03:04:31.378414 | debian-bookworm -> localhost | SHA256:sWTERTABK25XMz/6Pgeh3tF2GEX9oolato99p49u6RI zuul-build-sshkey 2026-07-07 03:04:31.378433 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-07 03:04:31.378457 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-07 03:04:31.378475 | debian-bookworm -> localhost | | .o==o ... | 2026-07-07 03:04:31.378492 | debian-bookworm -> localhost | | o.. . .| 2026-07-07 03:04:31.378509 | debian-bookworm -> localhost | | . . B . .| 2026-07-07 03:04:31.378524 | debian-bookworm -> localhost | | . . + *. . . .| 2026-07-07 03:04:31.378540 | debian-bookworm -> localhost | | o . S.o+ = . | 2026-07-07 03:04:31.378559 | debian-bookworm -> localhost | | . . ..*.E . | 2026-07-07 03:04:31.378575 | debian-bookworm -> localhost | | ..= = o . | 2026-07-07 03:04:31.378592 | debian-bookworm -> localhost | | o.+oo +..| 2026-07-07 03:04:31.378609 | debian-bookworm -> localhost | | .++o*=+.| 2026-07-07 03:04:31.378626 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-07 03:04:31.378669 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.255351 2026-07-07 03:04:31.384768 | 2026-07-07 03:04:31.384852 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-07 03:04:31.454239 | debian-bookworm | ok 2026-07-07 03:04:31.475965 | debian-bookworm | included: /var/lib/zuul/builds/d760e15299a74f4b9cc4e97154b85ece/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-07 03:04:31.488600 | 2026-07-07 03:04:31.488695 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-07 03:04:31.537458 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:04:31.545178 | 2026-07-07 03:04:31.545881 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-07 03:04:32.693509 | debian-bookworm | changed 2026-07-07 03:04:32.751258 | 2026-07-07 03:04:32.751376 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-07 03:04:33.076641 | debian-bookworm | ok 2026-07-07 03:04:33.104102 | 2026-07-07 03:04:33.104914 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-07 03:04:34.024871 | debian-bookworm | changed 2026-07-07 03:04:34.033803 | 2026-07-07 03:04:34.033953 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-07 03:04:34.933536 | debian-bookworm | changed 2026-07-07 03:04:34.946464 | 2026-07-07 03:04:34.947160 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-07 03:04:35.009005 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:04:35.026016 | 2026-07-07 03:04:35.026140 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-07 03:04:36.710758 | debian-bookworm -> localhost | changed 2026-07-07 03:04:36.724289 | 2026-07-07 03:04:36.726206 | TASK [add-build-sshkey : Add back temp key] 2026-07-07 03:04:37.611157 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d760e15299a74f4b9cc4e97154b85ece/work/d760e15299a74f4b9cc4e97154b85ece_id_rsa (zuul-build-sshkey) 2026-07-07 03:04:37.611456 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.035815 2026-07-07 03:04:37.620583 | 2026-07-07 03:04:37.620677 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-07 03:04:38.559144 | debian-bookworm | ok 2026-07-07 03:04:38.592105 | 2026-07-07 03:04:38.592218 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-07 03:04:38.664275 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:04:38.686324 | 2026-07-07 03:04:38.692140 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-07 03:04:39.391335 | debian-bookworm | ok 2026-07-07 03:04:39.410298 | 2026-07-07 03:04:39.410406 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-07 03:04:39.498442 | debian-bookworm | ok 2026-07-07 03:04:39.505564 | 2026-07-07 03:04:39.506055 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-07 03:04:40.268640 | debian-bookworm -> localhost | ok 2026-07-07 03:04:40.273955 | 2026-07-07 03:04:40.274035 | TASK [validate-host : Collect information about the host] 2026-07-07 03:04:41.499845 | debian-bookworm | ok 2026-07-07 03:04:41.521083 | 2026-07-07 03:04:41.521193 | TASK [validate-host : Sanitize hostname] 2026-07-07 03:04:41.729094 | debian-bookworm | ok 2026-07-07 03:04:41.734010 | 2026-07-07 03:04:41.734110 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-07 03:04:43.018330 | debian-bookworm -> localhost | changed 2026-07-07 03:04:43.024558 | 2026-07-07 03:04:43.024812 | TASK [validate-host : Collect information about zuul worker] 2026-07-07 03:04:43.527096 | debian-bookworm | ok 2026-07-07 03:04:43.532170 | 2026-07-07 03:04:43.532258 | TASK [validate-host : Write out all zuul information for each host] 2026-07-07 03:04:44.721117 | debian-bookworm -> localhost | changed 2026-07-07 03:04:44.729664 | 2026-07-07 03:04:44.729780 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-07 03:04:45.040657 | debian-bookworm | ok 2026-07-07 03:04:45.056790 | 2026-07-07 03:04:45.056890 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-07 03:04:46.097280 | debian-bookworm | changed: 2026-07-07 03:04:46.097480 | debian-bookworm | cd+++++++++ src/ 2026-07-07 03:04:46.097515 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-07 03:04:46.097540 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-07 03:04:46.097562 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-07 03:04:46.097583 | debian-bookworm | =7.0.3 2026-07-07 03:05:31.071195 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-07 03:05:31.128563 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-07 03:05:31.140042 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-07 03:05:31.208623 | debian-bookworm | Collecting filelock>=3.25 2026-07-07 03:05:31.219917 | debian-bookworm | Downloading filelock-3.29.6-py3-none-any.whl (45 kB) 2026-07-07 03:05:31.228993 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.5/45.5 kB 5.8 MB/s eta 0:00:00 2026-07-07 03:05:31.277019 | debian-bookworm | Collecting packaging>=26 2026-07-07 03:05:31.288028 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-07 03:05:31.301576 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 9.1 MB/s eta 0:00:00 2026-07-07 03:05:31.368993 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-07 03:05:31.380008 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-07-07 03:05:31.442757 | debian-bookworm | Collecting pluggy>=1.6 2026-07-07 03:05:31.453981 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-07 03:05:31.520946 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-07 03:05:31.533003 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-07 03:05:31.569659 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-07-07 03:05:31.581208 | debian-bookworm | Downloading python_discovery-1.4.3-py3-none-any.whl (33 kB) 2026-07-07 03:05:31.718396 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-07 03:05:31.729346 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-07 03:05:31.867714 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-07 03:05:31.878930 | debian-bookworm | Downloading virtualenv-21.6.0-py3-none-any.whl (5.5 MB) 2026-07-07 03:05:32.187425 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 18.1 MB/s eta 0:00:00 2026-07-07 03:05:32.299094 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-07 03:05:32.310464 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-07 03:05:32.339252 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 18.0 MB/s eta 0:00:00 2026-07-07 03:05:32.443072 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-07 03:05:33.171905 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.29.6 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.3 tomli-w-1.2.0 tox-4.56.2 virtualenv-21.6.0 2026-07-07 03:05:33.425561 | debian-bookworm | ok: Runtime: 0:00:03.160366 2026-07-07 03:05:33.431606 | 2026-07-07 03:05:33.431708 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-07 03:05:33.483239 | debian-bookworm | ok 2026-07-07 03:05:33.495018 | 2026-07-07 03:05:33.495123 | TASK [ensure-tox : Output tox version] 2026-07-07 03:05:34.163407 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-07-07 03:05:34.181538 | debian-bookworm | 4.56.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-07 03:05:34.638884 | debian-bookworm | ok: Runtime: 0:00:00.357486 2026-07-07 03:05:34.645553 | 2026-07-07 03:05:34.645759 | TASK [ensure-tox : Make global symlink] 2026-07-07 03:05:34.720453 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:05:34.739128 | 2026-07-07 03:05:34.739250 | PLAY RECAP 2026-07-07 03:05:34.739313 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-07 03:05:34.739339 | 2026-07-07 03:05:35.253229 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-07 03:05:35.259489 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-07 03:05:37.061091 | 2026-07-07 03:05:37.062101 | PLAY [all] 2026-07-07 03:05:37.106739 | 2026-07-07 03:05:37.107556 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-07 03:05:38.232495 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-07 03:05:38.690091 | debian-bookworm | ok: Runtime: 0:00:00.030977 2026-07-07 03:05:38.724592 | 2026-07-07 03:05:38.724734 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-07 03:05:39.345496 | debian-bookworm | ok: Runtime: 0:00:00.008618 2026-07-07 03:05:39.361079 | 2026-07-07 03:05:39.361237 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-07 03:05:40.025570 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-07 03:05:40.029949 | debian-bookworm | sudo: a password is required 2026-07-07 03:05:40.453942 | debian-bookworm | ok: Runtime: 0:00:00.027639 2026-07-07 03:05:40.462261 | 2026-07-07 03:05:40.462353 | TASK [tox : Check to see if the constraints file exists] 2026-07-07 03:05:40.519265 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:05:40.525457 | 2026-07-07 03:05:40.525633 | TASK [tox : Fail if constraints file is missing] 2026-07-07 03:05:40.589321 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:05:40.595516 | 2026-07-07 03:05:40.595616 | TASK [tox : Record file location] 2026-07-07 03:05:40.650095 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:05:40.655795 | 2026-07-07 03:05:40.655888 | TASK [tox : Install tox siblings] 2026-07-07 03:05:40.706933 | debian-bookworm | ok 2026-07-07 03:05:40.734429 | debian-bookworm | included: /var/lib/zuul/builds/d760e15299a74f4b9cc4e97154b85ece/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-07 03:05:40.752506 | 2026-07-07 03:05:40.752603 | TASK [tox : Run tox without tests] 2026-07-07 03:05:42.351442 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-07 03:05:56.524527 | debian-bookworm | test: OK (15.04 seconds) 2026-07-07 03:05:56.524614 | debian-bookworm | congratulations :) (15.07 seconds) 2026-07-07 03:05:56.846958 | debian-bookworm | ok: Runtime: 0:00:15.408587 2026-07-07 03:05:56.853582 | 2026-07-07 03:05:56.853788 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-07 03:05:57.573950 | debian-bookworm | changed 2026-07-07 03:05:57.582175 | 2026-07-07 03:05:57.582666 | TASK [tox : Detect tox version] 2026-07-07 03:05:58.386253 | debian-bookworm | 4.56.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-07 03:05:58.675283 | debian-bookworm | ok: Runtime: 0:00:00.275425 2026-07-07 03:05:58.681317 | 2026-07-07 03:05:58.681482 | TASK [tox : Get tox envlist config] 2026-07-07 03:05:59.748990 | debian-bookworm | ok: Runtime: 0:00:00.324136 2026-07-07 03:05:59.756966 | 2026-07-07 03:05:59.757175 | TASK [tox : Install any sibling python packages] 2026-07-07 03:06:00.403198 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-07 03:06:00.423666 | 2026-07-07 03:06:00.424588 | TASK [tox : Remove tempfile] 2026-07-07 03:06:01.047517 | debian-bookworm | changed 2026-07-07 03:06:01.054562 | 2026-07-07 03:06:01.054762 | TASK [tox : Emit tox command] 2026-07-07 03:06:01.105822 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-07 03:06:01.111708 | 2026-07-07 03:06:01.111855 | TASK [tox : Run tox] 2026-07-07 03:06:01.799446 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-07 03:06:02.544611 | debian-bookworm | .......................... 2026-07-07 03:06:02.544667 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-07 03:06:02.544679 | debian-bookworm | Ran 26 tests in 0.231s 2026-07-07 03:06:02.544684 | debian-bookworm | 2026-07-07 03:06:02.544690 | debian-bookworm | OK 2026-07-07 03:06:02.652722 | debian-bookworm | test: OK (0.90=setup[0.05]+cmd[0.85] seconds) 2026-07-07 03:06:02.652851 | debian-bookworm | congratulations :) (0.93 seconds) 2026-07-07 03:06:03.166490 | debian-bookworm | ok: Runtime: 0:00:01.270493 2026-07-07 03:06:03.180638 | 2026-07-07 03:06:03.180884 | TASK [tox : Look for output] 2026-07-07 03:06:03.759719 | debian-bookworm | ok 2026-07-07 03:06:03.792580 | 2026-07-07 03:06:03.792912 | TASK [tox : Return file comments to Zuul] 2026-07-07 03:06:03.863982 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:03.876342 | 2026-07-07 03:06:03.876536 | PLAY RECAP 2026-07-07 03:06:03.876655 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-07 03:06:03.877146 | 2026-07-07 03:06:04.157571 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-07 03:06:04.159922 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-07 03:06:05.503178 | 2026-07-07 03:06:05.503367 | PLAY [all] 2026-07-07 03:06:05.521323 | 2026-07-07 03:06:05.521487 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-07 03:06:05.578043 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:05.584296 | 2026-07-07 03:06:05.584467 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-07 03:06:05.636070 | debian-bookworm | ok 2026-07-07 03:06:05.641682 | 2026-07-07 03:06:05.641811 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-07 03:06:06.204366 | debian-bookworm -> localhost | changed 2026-07-07 03:06:06.212968 | 2026-07-07 03:06:06.213099 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-07 03:06:06.273822 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:06.285444 | 2026-07-07 03:06:06.285628 | TASK [fetch-tox-output : Set envlist fact] 2026-07-07 03:06:06.342302 | debian-bookworm | ok 2026-07-07 03:06:06.351411 | 2026-07-07 03:06:06.351545 | TASK [fetch-tox-output : Get tox version] 2026-07-07 03:06:07.191402 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-07-07 03:06:07.208008 | debian-bookworm | 4.56.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-07 03:06:07.416929 | debian-bookworm | ok: Runtime: 0:00:00.298005 2026-07-07 03:06:07.434569 | 2026-07-07 03:06:07.434905 | TASK [fetch-tox-output : Find all default environments] 2026-07-07 03:06:07.973610 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:07.980687 | 2026-07-07 03:06:07.980833 | TASK [fetch-tox-output : Set envlist fact] 2026-07-07 03:06:08.016429 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:08.028608 | 2026-07-07 03:06:08.028845 | TASK [fetch-tox-output : Find all default environments] 2026-07-07 03:06:08.568748 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:08.579916 | 2026-07-07 03:06:08.580126 | TASK [fetch-tox-output : Set envlist fact] 2026-07-07 03:06:08.616718 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:08.636498 | 2026-07-07 03:06:08.636732 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-07 03:06:08.702342 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:08.720657 | 2026-07-07 03:06:08.720832 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-07 03:06:09.609117 | debian-bookworm | changed: 2026-07-07 03:06:09.609323 | debian-bookworm | created directory /var/lib/zuul/builds/d760e15299a74f4b9cc4e97154b85ece/work/logs/tox/test 2026-07-07 03:06:09.609359 | debian-bookworm | cd+++++++++ ./ 2026-07-07 03:06:09.609385 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-07 03:06:09.609416 | 2026-07-07 03:06:09.628651 | 2026-07-07 03:06:09.629576 | PLAY RECAP 2026-07-07 03:06:09.630050 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-07 03:06:09.630164 | 2026-07-07 03:06:09.873572 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-07 03:06:09.875226 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-07 03:06:10.742428 | 2026-07-07 03:06:10.742605 | PLAY [all] 2026-07-07 03:06:10.760404 | 2026-07-07 03:06:10.760567 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-07 03:06:11.030883 | debian-bookworm | changed: non-zero return code 2026-07-07 03:06:11.045862 | 2026-07-07 03:06:11.046074 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-07 03:06:11.073947 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:11.082529 | 2026-07-07 03:06:11.082762 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-07 03:06:11.114522 | 2026-07-07 03:06:11.114784 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-07 03:06:11.171630 | 2026-07-07 03:06:11.171911 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-07 03:06:11.209695 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:11.216298 | 2026-07-07 03:06:11.216426 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-07 03:06:11.246345 | 2026-07-07 03:06:11.246606 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-07 03:06:11.291156 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:11.298762 | 2026-07-07 03:06:11.298966 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-07 03:06:11.324018 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:11.332031 | 2026-07-07 03:06:11.332180 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-07 03:06:11.357787 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:11.373430 | 2026-07-07 03:06:11.373577 | PLAY RECAP 2026-07-07 03:06:11.373644 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-07 03:06:11.373687 | 2026-07-07 03:06:11.617582 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-07 03:06:11.618788 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-07 03:06:12.514078 | 2026-07-07 03:06:12.514265 | PLAY [Base post-fetch] 2026-07-07 03:06:12.530113 | 2026-07-07 03:06:12.530258 | TASK [diagnose-network : Ensure log directory exists] 2026-07-07 03:06:12.994360 | debian-bookworm | ok 2026-07-07 03:06:13.003178 | 2026-07-07 03:06:13.003358 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-07 03:06:24.795960 | debian-bookworm | ok: Runtime: 0:00:06.022876 2026-07-07 03:06:24.812427 | 2026-07-07 03:06:24.813048 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-07 03:06:30.905277 | debian-bookworm | ok: Runtime: 0:00:00.008488 2026-07-07 03:06:30.918308 | 2026-07-07 03:06:30.918461 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-07 03:06:37.056280 | debian-bookworm | ok: Runtime: 0:00:00.006681 2026-07-07 03:06:37.070206 | 2026-07-07 03:06:37.070350 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-07 03:06:37.156796 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:37.163696 | 2026-07-07 03:06:37.163824 | TASK [fetch-output : Set log path for single node] 2026-07-07 03:06:37.207275 | debian-bookworm | ok 2026-07-07 03:06:37.213244 | 2026-07-07 03:06:37.213374 | LOOP [fetch-output : Ensure local output dirs] 2026-07-07 03:06:37.537191 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/d760e15299a74f4b9cc4e97154b85ece/work/logs" 2026-07-07 03:06:38.009156 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d760e15299a74f4b9cc4e97154b85ece/work/artifacts" 2026-07-07 03:06:38.375804 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d760e15299a74f4b9cc4e97154b85ece/work/docs" 2026-07-07 03:06:38.396929 | 2026-07-07 03:06:38.397111 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-07 03:06:39.446010 | debian-bookworm | changed: 2026-07-07 03:06:39.446282 | debian-bookworm | .d..t...... ./ 2026-07-07 03:06:39.449096 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-07 03:06:39.449187 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-07 03:06:39.449218 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-07 03:06:39.449244 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-07 03:06:39.449268 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-07 03:06:39.449324 | debian-bookworm | changed: All items complete 2026-07-07 03:06:39.449368 | 2026-07-07 03:06:40.117474 | debian-bookworm | changed: .d..t...... ./ 2026-07-07 03:06:40.738209 | debian-bookworm | changed: .d..t...... ./ 2026-07-07 03:06:40.757334 | 2026-07-07 03:06:40.757535 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-07 03:06:40.800050 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:40.803906 | debian-bookworm | skipping: Conditional result was False 2026-07-07 03:06:40.815755 | 2026-07-07 03:06:40.816004 | PLAY RECAP 2026-07-07 03:06:40.816158 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-07 03:06:40.816229 | 2026-07-07 03:06:41.009841 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-07 03:06:41.011642 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-07 03:06:41.802926 | 2026-07-07 03:06:41.803122 | PLAY [Base post] 2026-07-07 03:06:41.822688 | 2026-07-07 03:06:41.822909 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-07 03:06:42.444465 | debian-bookworm | changed 2026-07-07 03:06:42.453610 | 2026-07-07 03:06:42.453770 | PLAY RECAP 2026-07-07 03:06:42.453844 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-07 03:06:42.453915 | 2026-07-07 03:06:42.596487 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-07 03:06:42.597743 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-07 03:06:43.516899 | 2026-07-07 03:06:43.517122 | PLAY [Base post-logs] 2026-07-07 03:06:43.529835 | 2026-07-07 03:06:43.530011 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-07 03:06:44.045669 | localhost | changed 2026-07-07 03:06:44.060423 | 2026-07-07 03:06:44.060807 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-07 03:06:44.088030 | localhost | ok 2026-07-07 03:06:44.093000 | 2026-07-07 03:06:44.093120 | TASK [Set zuul-log-path fact] 2026-07-07 03:06:44.110155 | localhost | ok 2026-07-07 03:06:44.121334 | 2026-07-07 03:06:44.121606 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-07 03:06:44.148858 | localhost | ok 2026-07-07 03:06:44.152456 | 2026-07-07 03:06:44.152586 | TASK [upload-logs : Create log directories] 2026-07-07 03:06:44.709862 | localhost | changed 2026-07-07 03:06:44.713266 | 2026-07-07 03:06:44.713386 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-07 03:06:45.229291 | localhost -> localhost | ok: Runtime: 0:00:00.005743 2026-07-07 03:06:45.233534 | 2026-07-07 03:06:45.233890 | TASK [upload-logs : Upload logs to log server] 2026-07-07 03:06:45.883074 | localhost | Output suppressed because no_log was given 2026-07-07 03:06:45.885328 | 2026-07-07 03:06:45.885445 | LOOP [upload-logs : Compress console log and json output] 2026-07-07 03:06:45.955659 | localhost | skipping: Conditional result was False 2026-07-07 03:06:45.963380 | localhost | skipping: Conditional result was False 2026-07-07 03:06:45.973302 | 2026-07-07 03:06:45.973442 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-07 03:06:46.066814 | localhost | skipping: Conditional result was False 2026-07-07 03:06:46.067171 | 2026-07-07 03:06:46.074985 | localhost | skipping: Conditional result was False 2026-07-07 03:06:46.081491 | 2026-07-07 03:06:46.081639 | LOOP [upload-logs : Upload console log and json output]