2026-04-18 00:53:22.616256 | Job console starting 2026-04-18 00:53:22.629122 | Updating git repos 2026-04-18 00:53:22.664408 | Cloning repos into workspace 2026-04-18 00:53:22.739001 | Restoring repo states 2026-04-18 00:53:22.746697 | Merging changes 2026-04-18 00:53:23.177383 | Checking out repos 2026-04-18 00:53:23.239632 | Preparing playbooks 2026-04-18 00:53:24.615606 | Running Ansible setup 2026-04-18 00:53:30.933162 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 00:53:31.600224 | 2026-04-18 00:53:31.600397 | PLAY [localhost] 2026-04-18 00:53:31.648189 | 2026-04-18 00:53:31.648354 | TASK [Gathering Facts] 2026-04-18 00:53:32.723952 | localhost | ok 2026-04-18 00:53:32.731521 | 2026-04-18 00:53:32.731616 | TASK [Setup log path fact] 2026-04-18 00:53:32.758413 | localhost | ok 2026-04-18 00:53:32.779190 | 2026-04-18 00:53:32.779430 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 00:53:32.831858 | localhost | ok 2026-04-18 00:53:32.841556 | 2026-04-18 00:53:32.841650 | TASK [emit-job-header : Print job information] 2026-04-18 00:53:32.873620 | # Job Information 2026-04-18 00:53:32.873874 | Ansible Version: 2.16.16 2026-04-18 00:53:32.873951 | Job: pre-commit 2026-04-18 00:53:32.874004 | Pipeline: check 2026-04-18 00:53:32.874035 | Executor: 0a8996d2b663 2026-04-18 00:53:32.874061 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/109 2026-04-18 00:53:32.874092 | Event ID: e69d5b00-3ac0-11f1-8e84-863288ff99e4 2026-04-18 00:53:32.877800 | 2026-04-18 00:53:32.878131 | LOOP [emit-job-header : Print node information] 2026-04-18 00:53:32.975128 | localhost | ok: 2026-04-18 00:53:32.975355 | localhost | # Node Information 2026-04-18 00:53:32.975402 | localhost | Inventory Hostname: ubuntu-noble 2026-04-18 00:53:32.975438 | localhost | Hostname: np0000167201 2026-04-18 00:53:32.975472 | localhost | Username: zuul 2026-04-18 00:53:32.975513 | localhost | Distro: Ubuntu 24.04 2026-04-18 00:53:32.975549 | localhost | Provider: yul1 2026-04-18 00:53:32.975582 | localhost | Region: ca-ymq-1 2026-04-18 00:53:32.975614 | localhost | Label: ubuntu-noble 2026-04-18 00:53:32.975645 | localhost | Product Name: OpenStack Nova 2026-04-18 00:53:32.975676 | localhost | Interface IP: 199.204.45.23 2026-04-18 00:53:32.988548 | 2026-04-18 00:53:32.988741 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-18 00:53:33.501444 | localhost -> localhost | changed 2026-04-18 00:53:33.513996 | 2026-04-18 00:53:33.514576 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-18 00:53:34.755674 | localhost -> localhost | changed 2026-04-18 00:53:34.761935 | 2026-04-18 00:53:34.761992 | PLAY [all] 2026-04-18 00:53:34.770116 | 2026-04-18 00:53:34.770184 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-18 00:53:34.986048 | ubuntu-noble -> localhost | ok 2026-04-18 00:53:34.992834 | 2026-04-18 00:53:34.992900 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-18 00:53:35.026903 | ubuntu-noble | ok 2026-04-18 00:53:35.041878 | ubuntu-noble | included: /var/lib/zuul/builds/016ac737ab2b48afb2fe5dcbd9a84b40/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 00:53:35.050444 | 2026-04-18 00:53:35.050534 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-18 00:53:35.984113 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-04-18 00:53:35.984308 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/016ac737ab2b48afb2fe5dcbd9a84b40/work/016ac737ab2b48afb2fe5dcbd9a84b40_id_rsa 2026-04-18 00:53:35.984342 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/016ac737ab2b48afb2fe5dcbd9a84b40/work/016ac737ab2b48afb2fe5dcbd9a84b40_id_rsa.pub 2026-04-18 00:53:35.984366 | ubuntu-noble -> localhost | The key fingerprint is: 2026-04-18 00:53:35.984388 | ubuntu-noble -> localhost | SHA256:pglIUAyCYwPgLdtU8UecMC+MItT+nR9xd4Jzay5CYWo zuul-build-sshkey 2026-04-18 00:53:35.984422 | ubuntu-noble -> localhost | The key's randomart image is: 2026-04-18 00:53:35.984445 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-04-18 00:53:35.984476 | ubuntu-noble -> localhost | |X=o o.oo.. | 2026-04-18 00:53:35.984498 | ubuntu-noble -> localhost | |*+o.. + +o | 2026-04-18 00:53:35.984519 | ubuntu-noble -> localhost | |.=++ . + o . | 2026-04-18 00:53:35.984539 | ubuntu-noble -> localhost | | .*o. o+ + + . | 2026-04-18 00:53:35.984560 | ubuntu-noble -> localhost | | ...o . S + + + | 2026-04-18 00:53:35.984579 | ubuntu-noble -> localhost | | o E o o | 2026-04-18 00:53:35.984599 | ubuntu-noble -> localhost | | + o . o | 2026-04-18 00:53:35.984619 | ubuntu-noble -> localhost | | o . . | 2026-04-18 00:53:35.984643 | ubuntu-noble -> localhost | | . . | 2026-04-18 00:53:35.984665 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-04-18 00:53:35.984714 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.417453 2026-04-18 00:53:35.991132 | 2026-04-18 00:53:35.991226 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-18 00:53:36.021694 | ubuntu-noble | ok 2026-04-18 00:53:36.030739 | ubuntu-noble | included: /var/lib/zuul/builds/016ac737ab2b48afb2fe5dcbd9a84b40/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 00:53:36.039547 | 2026-04-18 00:53:36.039677 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-18 00:53:36.064761 | ubuntu-noble | skipping: Conditional result was False 2026-04-18 00:53:36.086255 | 2026-04-18 00:53:36.086613 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-18 00:53:36.690495 | ubuntu-noble | changed 2026-04-18 00:53:36.728979 | 2026-04-18 00:53:36.739104 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-18 00:53:37.002836 | ubuntu-noble | ok 2026-04-18 00:53:37.011446 | 2026-04-18 00:53:37.011542 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-18 00:53:37.599463 | ubuntu-noble | changed 2026-04-18 00:53:37.609103 | 2026-04-18 00:53:37.609174 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-18 00:53:38.181332 | ubuntu-noble | changed 2026-04-18 00:53:38.188914 | 2026-04-18 00:53:38.189061 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-18 00:53:38.216767 | ubuntu-noble | skipping: Conditional result was False 2026-04-18 00:53:38.225536 | 2026-04-18 00:53:38.225897 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-18 00:53:38.649339 | ubuntu-noble -> localhost | changed 2026-04-18 00:53:38.661516 | 2026-04-18 00:53:38.661675 | TASK [add-build-sshkey : Add back temp key] 2026-04-18 00:53:39.089660 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/016ac737ab2b48afb2fe5dcbd9a84b40/work/016ac737ab2b48afb2fe5dcbd9a84b40_id_rsa (zuul-build-sshkey) 2026-04-18 00:53:39.606244 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.034823 2026-04-18 00:53:39.615890 | 2026-04-18 00:53:39.615991 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-18 00:53:39.985575 | ubuntu-noble | ok 2026-04-18 00:53:39.990829 | 2026-04-18 00:53:39.990904 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-18 00:53:40.015580 | ubuntu-noble | skipping: Conditional result was False 2026-04-18 00:53:40.026928 | 2026-04-18 00:53:40.027008 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-18 00:53:40.413196 | ubuntu-noble | ok 2026-04-18 00:53:40.564710 | 2026-04-18 00:53:40.564830 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-18 00:53:41.469217 | ubuntu-noble | Output suppressed because no_log was given 2026-04-18 00:53:41.480390 | 2026-04-18 00:53:41.480485 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-18 00:53:41.761762 | ubuntu-noble | ok: "logs" 2026-04-18 00:53:41.761961 | ubuntu-noble | ok: All items complete 2026-04-18 00:53:41.762041 | 2026-04-18 00:53:41.910520 | ubuntu-noble | ok: "artifacts" 2026-04-18 00:53:42.165955 | ubuntu-noble | ok: "docs" 2026-04-18 00:53:42.173638 | 2026-04-18 00:53:42.173794 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-18 00:53:42.428269 | ubuntu-noble | changed: "logs" 2026-04-18 00:53:42.632860 | ubuntu-noble | changed: "artifacts" 2026-04-18 00:53:42.895339 | ubuntu-noble | changed: "docs" 2026-04-18 00:53:42.919685 | 2026-04-18 00:53:42.919800 | PLAY RECAP 2026-04-18 00:53:42.919845 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 00:53:42.919875 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-18 00:53:42.919895 | 2026-04-18 00:53:43.072335 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 00:53:43.073374 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-04-18 00:53:43.635197 | 2026-04-18 00:53:43.635333 | PLAY [all] 2026-04-18 00:53:43.647359 | 2026-04-18 00:53:43.647450 | TASK [setup-uv : Extract archive] 2026-04-18 00:53:46.267213 | ubuntu-noble | changed 2026-04-18 00:53:46.275169 | 2026-04-18 00:53:46.275260 | TASK [setup-uv : Print version] 2026-04-18 00:53:45.130024 | ubuntu-noble | uv 0.8.13 2026-04-18 00:53:46.811222 | ubuntu-noble | ok: Runtime: 0:00:00.017375 2026-04-18 00:53:46.820677 | 2026-04-18 00:53:46.820733 | PLAY RECAP 2026-04-18 00:53:46.820779 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 00:53:46.820803 | 2026-04-18 00:53:46.944250 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-04-18 00:53:46.946630 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-04-18 00:53:47.587882 | 2026-04-18 00:53:47.588002 | PLAY [all] 2026-04-18 00:53:47.599227 | 2026-04-18 00:53:47.599316 | TASK [Run "pre-commit"] 2026-04-18 00:53:46.707354 | ubuntu-noble | Downloading virtualenv (5.6MiB) 2026-04-18 00:53:46.931219 | ubuntu-noble | Downloading virtualenv 2026-04-18 00:53:46.944786 | ubuntu-noble | Installed 10 packages in 12ms 2026-04-18 00:53:47.343932 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-04-18 00:53:48.140834 | 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-04-18 00:53:48.143899 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black. 2026-04-18 00:53:50.218185 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8. 2026-04-18 00:53:50.603089 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort. 2026-04-18 00:53:51.275774 | 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-04-18 00:53:51.277540 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git. 2026-04-18 00:53:51.869760 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0. 2026-04-18 00:53:52.423045 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-04-18 00:53:52.423138 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-04-18 00:53:52.423146 | ubuntu-noble | [INFO] This may take a few minutes... 2026-04-18 00:53:56.525296 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black. 2026-04-18 00:53:56.525420 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-04-18 00:53:56.525440 | ubuntu-noble | [INFO] This may take a few minutes... 2026-04-18 00:54:01.064517 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8. 2026-04-18 00:54:01.064604 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-04-18 00:54:01.064624 | ubuntu-noble | [INFO] This may take a few minutes... 2026-04-18 00:54:04.618450 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort. 2026-04-18 00:54:04.618545 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-04-18 00:54:04.618557 | ubuntu-noble | [INFO] This may take a few minutes... 2026-04-18 00:54:07.651602 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git. 2026-04-18 00:54:07.651677 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-04-18 00:54:07.651690 | ubuntu-noble | [INFO] This may take a few minutes... 2026-04-18 00:54:19.829930 | ubuntu-noble | fix end of files.........................................................Passed 2026-04-18 00:54:19.897716 | ubuntu-noble | trim trailing whitespace.................................................Passed 2026-04-18 00:54:20.189359 | ubuntu-noble | black....................................................................Passed 2026-04-18 00:54:20.396624 | ubuntu-noble | flake8...................................................................Passed 2026-04-18 00:54:20.539960 | ubuntu-noble | isort....................................................................Passed 2026-04-18 00:54:36.590164 | ubuntu-noble | Ansible-lint.............................................................Passed 2026-04-18 00:54:36.691996 | ubuntu-noble | ok: Runtime: 0:00:50.184223 2026-04-18 00:54:36.694216 | 2026-04-18 00:54:36.694270 | PLAY RECAP 2026-04-18 00:54:36.694314 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 00:54:36.694335 | 2026-04-18 00:54:36.797868 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-04-18 00:54:36.800010 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 00:54:37.349828 | 2026-04-18 00:54:37.349960 | PLAY [all] 2026-04-18 00:54:37.362012 | 2026-04-18 00:54:37.362098 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-18 00:54:37.406723 | ubuntu-noble | skipping: Conditional result was False 2026-04-18 00:54:37.419345 | 2026-04-18 00:54:37.419519 | TASK [fetch-output : Set log path for single node] 2026-04-18 00:54:37.465260 | ubuntu-noble | ok 2026-04-18 00:54:37.470168 | 2026-04-18 00:54:37.470230 | LOOP [fetch-output : Ensure local output dirs] 2026-04-18 00:54:37.829950 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/016ac737ab2b48afb2fe5dcbd9a84b40/work/logs" 2026-04-18 00:54:38.053769 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/016ac737ab2b48afb2fe5dcbd9a84b40/work/artifacts" 2026-04-18 00:54:38.262815 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/016ac737ab2b48afb2fe5dcbd9a84b40/work/docs" 2026-04-18 00:54:38.281502 | 2026-04-18 00:54:38.281694 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-18 00:54:38.899748 | ubuntu-noble | changed: .d..t...... ./ 2026-04-18 00:54:38.900039 | ubuntu-noble | changed: All items complete 2026-04-18 00:54:38.900077 | 2026-04-18 00:54:39.372103 | ubuntu-noble | changed: .d..t...... ./ 2026-04-18 00:54:39.838032 | ubuntu-noble | changed: .d..t...... ./ 2026-04-18 00:54:39.866650 | 2026-04-18 00:54:39.866825 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-18 00:54:40.273998 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007437 2026-04-18 00:54:40.521927 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007033 2026-04-18 00:54:40.544527 | 2026-04-18 00:54:40.544630 | PLAY [all] 2026-04-18 00:54:40.550790 | 2026-04-18 00:54:40.550848 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-18 00:54:41.049616 | ubuntu-noble | changed 2026-04-18 00:54:41.055678 | 2026-04-18 00:54:41.055731 | PLAY RECAP 2026-04-18 00:54:41.055778 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 00:54:41.055800 | 2026-04-18 00:54:41.184081 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 00:54:41.186297 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-18 00:54:41.764477 | 2026-04-18 00:54:41.764613 | PLAY [localhost] 2026-04-18 00:54:41.774388 | 2026-04-18 00:54:41.774460 | TASK [Generate Zuul manifest] 2026-04-18 00:54:41.791615 | localhost | ok 2026-04-18 00:54:41.805157 | 2026-04-18 00:54:41.805234 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-18 00:54:42.141155 | localhost | changed 2026-04-18 00:54:42.155424 | 2026-04-18 00:54:42.155546 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-18 00:54:42.186959 | localhost | ok 2026-04-18 00:54:42.195933 | 2026-04-18 00:54:42.195999 | TASK [Upload logs] 2026-04-18 00:54:42.230272 | localhost | ok 2026-04-18 00:54:42.291619 | 2026-04-18 00:54:42.291759 | TASK [Set zuul-log-path fact] 2026-04-18 00:54:42.312513 | localhost | ok 2026-04-18 00:54:42.325543 | 2026-04-18 00:54:42.325687 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 00:54:42.356353 | localhost | ok 2026-04-18 00:54:42.366011 | 2026-04-18 00:54:42.366154 | TASK [upload-logs : Create log directories] 2026-04-18 00:54:42.773489 | localhost | changed 2026-04-18 00:54:42.778734 | 2026-04-18 00:54:42.778810 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-18 00:54:43.207197 | localhost -> localhost | ok: Runtime: 0:00:00.005467 2026-04-18 00:54:43.214733 | 2026-04-18 00:54:43.214881 | TASK [upload-logs : Upload logs to log server] 2026-04-18 00:54:43.686963 | localhost | Output suppressed because no_log was given 2026-04-18 00:54:43.692148 | 2026-04-18 00:54:43.692230 | LOOP [upload-logs : Compress console log and json output] 2026-04-18 00:54:43.741582 | localhost | skipping: Conditional result was False 2026-04-18 00:54:43.748770 | localhost | skipping: Conditional result was False 2026-04-18 00:54:43.763753 | 2026-04-18 00:54:43.763860 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-18 00:54:43.808898 | localhost | skipping: Conditional result was False 2026-04-18 00:54:43.809350 | 2026-04-18 00:54:43.813303 | localhost | skipping: Conditional result was False 2026-04-18 00:54:43.829848 | 2026-04-18 00:54:43.830007 | LOOP [upload-logs : Upload console log and json output]