2026-08-09 00:36:57.848114 | Job console starting 2026-08-09 00:36:57.859717 | Updating git repos 2026-08-09 00:36:57.878654 | Cloning repos into workspace 2026-08-09 00:36:57.942319 | Restoring repo states 2026-08-09 00:36:57.952618 | Merging changes 2026-08-09 00:36:58.513716 | Checking out repos 2026-08-09 00:36:58.547735 | Preparing playbooks 2026-08-09 00:36:59.691124 | Running Ansible setup 2026-08-09 00:37:03.162856 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-09 00:37:03.714667 | 2026-08-09 00:37:03.714781 | PLAY [localhost] 2026-08-09 00:37:03.721794 | 2026-08-09 00:37:03.721863 | TASK [Gathering Facts] 2026-08-09 00:37:04.594590 | localhost | ok 2026-08-09 00:37:04.603844 | 2026-08-09 00:37:04.603928 | TASK [Setup log path fact] 2026-08-09 00:37:04.624703 | localhost | ok 2026-08-09 00:37:04.636777 | 2026-08-09 00:37:04.636846 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-09 00:37:04.668597 | localhost | ok 2026-08-09 00:37:04.676110 | 2026-08-09 00:37:04.676181 | TASK [emit-job-header : Print job information] 2026-08-09 00:37:04.717407 | # Job Information 2026-08-09 00:37:04.717631 | Ansible Version: 2.16.18 2026-08-09 00:37:04.717703 | Job: pre-commit 2026-08-09 00:37:04.717753 | Pipeline: check 2026-08-09 00:37:04.717797 | Executor: 2d72f0692154 2026-08-09 00:37:04.717840 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/142 2026-08-09 00:37:04.717890 | Event ID: 79706e10-9389-11f1-8d84-18be58ece7d6 2026-08-09 00:37:04.722264 | 2026-08-09 00:37:04.722353 | LOOP [emit-job-header : Print node information] 2026-08-09 00:37:04.822900 | localhost | ok: 2026-08-09 00:37:04.823480 | localhost | # Node Information 2026-08-09 00:37:04.823525 | localhost | Inventory Hostname: ubuntu-noble 2026-08-09 00:37:04.823555 | localhost | Hostname: np0000188273 2026-08-09 00:37:04.823583 | localhost | Username: zuul 2026-08-09 00:37:04.823615 | localhost | Distro: Ubuntu 24.04 2026-08-09 00:37:04.823643 | localhost | Provider: yul1 2026-08-09 00:37:04.823670 | localhost | Region: ca-ymq-1 2026-08-09 00:37:04.823695 | localhost | Label: ubuntu-noble 2026-08-09 00:37:04.823748 | localhost | Product Name: OpenStack Nova 2026-08-09 00:37:04.823774 | localhost | Interface IP: 199.204.45.38 2026-08-09 00:37:04.841334 | 2026-08-09 00:37:04.841553 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-09 00:37:05.224849 | localhost -> localhost | changed 2026-08-09 00:37:05.234006 | 2026-08-09 00:37:05.234118 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-09 00:37:06.053283 | localhost -> localhost | changed 2026-08-09 00:37:06.064663 | 2026-08-09 00:37:06.064752 | PLAY [all] 2026-08-09 00:37:06.074006 | 2026-08-09 00:37:06.074080 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-09 00:37:06.302446 | ubuntu-noble -> localhost | ok 2026-08-09 00:37:06.314133 | 2026-08-09 00:37:06.314204 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-09 00:37:06.345288 | ubuntu-noble | ok 2026-08-09 00:37:06.360074 | ubuntu-noble | included: /var/lib/zuul/builds/07ce2833da594f4293921186563012db/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-09 00:37:06.366166 | 2026-08-09 00:37:06.366225 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-09 00:37:06.972118 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-08-09 00:37:06.972336 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/07ce2833da594f4293921186563012db/work/07ce2833da594f4293921186563012db_id_rsa 2026-08-09 00:37:06.972380 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/07ce2833da594f4293921186563012db/work/07ce2833da594f4293921186563012db_id_rsa.pub 2026-08-09 00:37:06.972412 | ubuntu-noble -> localhost | The key fingerprint is: 2026-08-09 00:37:06.972443 | ubuntu-noble -> localhost | SHA256:XieqGXC5mhjmEK+E/Pxody0qtpR2fBdZu3Nc8LVCa5w zuul-build-sshkey 2026-08-09 00:37:06.972485 | ubuntu-noble -> localhost | The key's randomart image is: 2026-08-09 00:37:06.972515 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-08-09 00:37:06.972558 | ubuntu-noble -> localhost | | | 2026-08-09 00:37:06.972589 | ubuntu-noble -> localhost | | | 2026-08-09 00:37:06.972618 | ubuntu-noble -> localhost | | . o .| 2026-08-09 00:37:06.972646 | ubuntu-noble -> localhost | | . o + = o| 2026-08-09 00:37:06.972675 | ubuntu-noble -> localhost | |. . o Soo..E + | 2026-08-09 00:37:06.972702 | ubuntu-noble -> localhost | |oo oo o o.o+ o | 2026-08-09 00:37:06.972730 | ubuntu-noble -> localhost | |oo++ oo.+. o o | 2026-08-09 00:37:06.972757 | ubuntu-noble -> localhost | |.==*o+.*.. o | 2026-08-09 00:37:06.972788 | ubuntu-noble -> localhost | |. ==Bo= . | 2026-08-09 00:37:06.972817 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-08-09 00:37:06.972882 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.203911 2026-08-09 00:37:06.979530 | 2026-08-09 00:37:06.979591 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-09 00:37:07.003859 | ubuntu-noble | ok 2026-08-09 00:37:07.019268 | ubuntu-noble | included: /var/lib/zuul/builds/07ce2833da594f4293921186563012db/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-09 00:37:07.027915 | 2026-08-09 00:37:07.027979 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-09 00:37:07.053864 | ubuntu-noble | skipping: Conditional result was False 2026-08-09 00:37:07.059999 | 2026-08-09 00:37:07.060066 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-09 00:37:07.564504 | ubuntu-noble | changed 2026-08-09 00:37:07.571914 | 2026-08-09 00:37:07.571977 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-09 00:37:07.791552 | ubuntu-noble | ok 2026-08-09 00:37:07.798488 | 2026-08-09 00:37:07.798563 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-09 00:37:08.350680 | ubuntu-noble | changed 2026-08-09 00:37:08.356862 | 2026-08-09 00:37:08.356947 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-09 00:37:08.905018 | ubuntu-noble | changed 2026-08-09 00:37:08.912101 | 2026-08-09 00:37:08.912174 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-09 00:37:08.936699 | ubuntu-noble | skipping: Conditional result was False 2026-08-09 00:37:08.947809 | 2026-08-09 00:37:08.947936 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-09 00:37:09.296975 | ubuntu-noble -> localhost | changed 2026-08-09 00:37:09.310123 | 2026-08-09 00:37:09.310218 | TASK [add-build-sshkey : Add back temp key] 2026-08-09 00:37:09.601517 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/07ce2833da594f4293921186563012db/work/07ce2833da594f4293921186563012db_id_rsa (zuul-build-sshkey) 2026-08-09 00:37:09.601819 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013257 2026-08-09 00:37:09.611204 | 2026-08-09 00:37:09.611353 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-09 00:37:09.978616 | ubuntu-noble | ok 2026-08-09 00:37:09.984538 | 2026-08-09 00:37:09.984624 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-09 00:37:10.009580 | ubuntu-noble | skipping: Conditional result was False 2026-08-09 00:37:10.026794 | 2026-08-09 00:37:10.026874 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-09 00:37:10.421009 | ubuntu-noble | ok 2026-08-09 00:37:10.464823 | 2026-08-09 00:37:10.464990 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-09 00:37:11.325153 | ubuntu-noble | Output suppressed because no_log was given 2026-08-09 00:37:11.335690 | 2026-08-09 00:37:11.335753 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-09 00:37:11.559413 | ubuntu-noble | ok: "logs" 2026-08-09 00:37:11.559847 | ubuntu-noble | ok: All items complete 2026-08-09 00:37:11.559916 | 2026-08-09 00:37:11.749487 | ubuntu-noble | ok: "artifacts" 2026-08-09 00:37:11.937688 | ubuntu-noble | ok: "docs" 2026-08-09 00:37:11.955002 | 2026-08-09 00:37:11.955095 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-09 00:37:12.169753 | ubuntu-noble | changed: "logs" 2026-08-09 00:37:12.364575 | ubuntu-noble | changed: "artifacts" 2026-08-09 00:37:12.564342 | ubuntu-noble | changed: "docs" 2026-08-09 00:37:12.584537 | 2026-08-09 00:37:12.584645 | PLAY RECAP 2026-08-09 00:37:12.584707 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-09 00:37:12.584749 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-09 00:37:12.584779 | 2026-08-09 00:37:12.711222 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-09 00:37:12.712309 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-08-09 00:37:13.277505 | 2026-08-09 00:37:13.277633 | PLAY [all] 2026-08-09 00:37:13.289505 | 2026-08-09 00:37:13.289585 | TASK [setup-uv : Extract archive] 2026-08-09 00:37:15.755322 | ubuntu-noble | changed 2026-08-09 00:37:15.761839 | 2026-08-09 00:37:15.761932 | TASK [setup-uv : Print version] 2026-08-09 00:37:16.126908 | ubuntu-noble | uv 0.8.13 2026-08-09 00:37:16.302704 | ubuntu-noble | ok: Runtime: 0:00:00.014383 2026-08-09 00:37:16.310459 | 2026-08-09 00:37:16.310522 | PLAY RECAP 2026-08-09 00:37:16.310563 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-09 00:37:16.310586 | 2026-08-09 00:37:16.422438 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-08-09 00:37:16.424808 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-08-09 00:37:17.007687 | 2026-08-09 00:37:17.007855 | PLAY [all] 2026-08-09 00:37:17.020732 | 2026-08-09 00:37:17.020881 | TASK [Run "pre-commit"] 2026-08-09 00:37:17.631795 | ubuntu-noble | Downloading virtualenv (5.2MiB) 2026-08-09 00:37:17.724160 | ubuntu-noble | Downloading virtualenv 2026-08-09 00:37:17.738673 | ubuntu-noble | Installed 10 packages in 13ms 2026-08-09 00:37:18.094516 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-08-09 00:37:18.779546 | ubuntu-noble | [WARNING] repo `https://github.com/pre-commit/pre-commit-hooks` uses deprecated stage names (commit, push) which will be removed in a future version. Hint: often `pre-commit autoupdate --repo https://github.com/pre-commit/pre-commit-hooks` will fix this. if it does not -- consider reporting an issue to that repo. 2026-08-09 00:37:18.784832 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black. 2026-08-09 00:37:22.814315 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8. 2026-08-09 00:37:23.282210 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort. 2026-08-09 00:37:23.819807 | ubuntu-noble | [WARNING] repo `https://github.com/pycqa/isort` uses deprecated stage names (commit, merge-commit, push) which will be removed in a future version. Hint: often `pre-commit autoupdate --repo https://github.com/pycqa/isort` will fix this. if it does not -- consider reporting an issue to that repo. 2026-08-09 00:37:23.822172 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git. 2026-08-09 00:37:24.424345 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0. 2026-08-09 00:37:25.010988 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-08-09 00:37:25.011090 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-08-09 00:37:25.011105 | ubuntu-noble | [INFO] This may take a few minutes... 2026-08-09 00:37:28.890108 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black. 2026-08-09 00:37:28.890172 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-08-09 00:37:28.890184 | ubuntu-noble | [INFO] This may take a few minutes... 2026-08-09 00:37:32.894816 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8. 2026-08-09 00:37:32.894884 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-08-09 00:37:32.894896 | ubuntu-noble | [INFO] This may take a few minutes... 2026-08-09 00:37:36.011981 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort. 2026-08-09 00:37:36.012103 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-08-09 00:37:36.012121 | ubuntu-noble | [INFO] This may take a few minutes... 2026-08-09 00:37:38.674761 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git. 2026-08-09 00:37:38.674816 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-08-09 00:37:38.674825 | ubuntu-noble | [INFO] This may take a few minutes... 2026-08-09 00:37:48.556057 | ubuntu-noble | fix end of files.........................................................Passed 2026-08-09 00:37:48.624828 | ubuntu-noble | trim trailing whitespace.................................................Passed 2026-08-09 00:37:48.874847 | ubuntu-noble | black....................................................................Passed 2026-08-09 00:37:49.058794 | ubuntu-noble | flake8...................................................................Passed 2026-08-09 00:37:49.181020 | ubuntu-noble | isort....................................................................Passed 2026-08-09 00:38:09.519292 | ubuntu-noble | Ansible-lint.............................................................Passed 2026-08-09 00:38:09.603073 | ubuntu-noble | ok: Runtime: 0:00:52.175071 2026-08-09 00:38:09.605245 | 2026-08-09 00:38:09.605297 | PLAY RECAP 2026-08-09 00:38:09.605346 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-09 00:38:09.605369 | 2026-08-09 00:38:09.777620 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-08-09 00:38:09.789812 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-09 00:38:10.413632 | 2026-08-09 00:38:10.413778 | PLAY [all] 2026-08-09 00:38:10.426255 | 2026-08-09 00:38:10.426355 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-09 00:38:10.471798 | ubuntu-noble | skipping: Conditional result was False 2026-08-09 00:38:10.483942 | 2026-08-09 00:38:10.484112 | TASK [fetch-output : Set log path for single node] 2026-08-09 00:38:10.522219 | ubuntu-noble | ok 2026-08-09 00:38:10.529133 | 2026-08-09 00:38:10.529203 | LOOP [fetch-output : Ensure local output dirs] 2026-08-09 00:38:10.901854 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/07ce2833da594f4293921186563012db/work/logs" 2026-08-09 00:38:11.106326 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/07ce2833da594f4293921186563012db/work/artifacts" 2026-08-09 00:38:11.307583 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/07ce2833da594f4293921186563012db/work/docs" 2026-08-09 00:38:11.326425 | 2026-08-09 00:38:11.327095 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-09 00:38:11.989803 | ubuntu-noble | ok 2026-08-09 00:38:11.990058 | ubuntu-noble | changed: All items complete 2026-08-09 00:38:11.990087 | 2026-08-09 00:38:12.450624 | ubuntu-noble | changed: .d..t...... ./ 2026-08-09 00:38:12.914567 | ubuntu-noble | changed: .d..t...... ./ 2026-08-09 00:38:12.935086 | 2026-08-09 00:38:12.935200 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-09 00:38:13.343971 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007737 2026-08-09 00:38:13.603076 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008947 2026-08-09 00:38:13.623480 | 2026-08-09 00:38:13.623586 | PLAY [all] 2026-08-09 00:38:13.631001 | 2026-08-09 00:38:13.631067 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-09 00:38:14.110706 | ubuntu-noble | changed 2026-08-09 00:38:14.116803 | 2026-08-09 00:38:14.116853 | PLAY RECAP 2026-08-09 00:38:14.116898 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-09 00:38:14.116920 | 2026-08-09 00:38:14.290835 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-09 00:38:14.292171 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-09 00:38:14.843641 | 2026-08-09 00:38:14.843747 | PLAY [localhost] 2026-08-09 00:38:14.854273 | 2026-08-09 00:38:14.854355 | TASK [Generate Zuul manifest] 2026-08-09 00:38:14.875225 | localhost | ok 2026-08-09 00:38:14.892360 | 2026-08-09 00:38:14.892485 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-09 00:38:15.237133 | localhost | changed 2026-08-09 00:38:15.249846 | 2026-08-09 00:38:15.249936 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-09 00:38:15.281861 | localhost | ok 2026-08-09 00:38:15.292630 | 2026-08-09 00:38:15.292715 | TASK [Upload logs] 2026-08-09 00:38:15.314482 | localhost | ok 2026-08-09 00:38:15.372900 | 2026-08-09 00:38:15.373024 | TASK [Set zuul-log-path fact] 2026-08-09 00:38:15.392334 | localhost | ok 2026-08-09 00:38:15.405858 | 2026-08-09 00:38:15.405924 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-09 00:38:15.437665 | localhost | ok 2026-08-09 00:38:15.445381 | 2026-08-09 00:38:15.445445 | TASK [upload-logs : Create log directories] 2026-08-09 00:38:15.872749 | localhost | changed 2026-08-09 00:38:15.879101 | 2026-08-09 00:38:15.879191 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-09 00:38:16.305454 | localhost -> localhost | ok: Runtime: 0:00:00.003847 2026-08-09 00:38:16.311685 | 2026-08-09 00:38:16.311770 | TASK [upload-logs : Upload logs to log server] 2026-08-09 00:38:16.760019 | localhost | Output suppressed because no_log was given 2026-08-09 00:38:16.765195 | 2026-08-09 00:38:16.765264 | LOOP [upload-logs : Compress console log and json output] 2026-08-09 00:38:16.808494 | localhost | skipping: Conditional result was False 2026-08-09 00:38:16.815848 | localhost | skipping: Conditional result was False 2026-08-09 00:38:16.828290 | 2026-08-09 00:38:16.828474 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-09 00:38:16.869875 | localhost | skipping: Conditional result was False 2026-08-09 00:38:16.870261 | 2026-08-09 00:38:16.873920 | localhost | skipping: Conditional result was False 2026-08-09 00:38:16.883934 | 2026-08-09 00:38:16.884110 | LOOP [upload-logs : Upload console log and json output]