2026-07-10 00:17:03.360230 | Job console starting 2026-07-10 00:17:03.374816 | Updating git repos 2026-07-10 00:17:03.402837 | Cloning repos into workspace 2026-07-10 00:17:05.007075 | Restoring repo states 2026-07-10 00:17:05.016603 | Merging changes 2026-07-10 00:17:05.472552 | Checking out repos 2026-07-10 00:17:06.780783 | Preparing playbooks 2026-07-10 00:17:08.694713 | Running Ansible setup 2026-07-10 00:17:12.743018 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-07-10 00:17:13.396228 | 2026-07-10 00:17:13.396759 | PLAY [localhost] 2026-07-10 00:17:13.405242 | 2026-07-10 00:17:13.405376 | TASK [Gathering Facts] 2026-07-10 00:17:14.335529 | localhost | ok 2026-07-10 00:17:14.351735 | 2026-07-10 00:17:14.351873 | TASK [Setup log path fact] 2026-07-10 00:17:14.371079 | localhost | ok 2026-07-10 00:17:14.383525 | 2026-07-10 00:17:14.383607 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-10 00:17:14.422215 | localhost | ok 2026-07-10 00:17:14.432564 | 2026-07-10 00:17:14.432637 | TASK [emit-job-header : Print job information] 2026-07-10 00:17:14.475959 | # Job Information 2026-07-10 00:17:14.476220 | Ansible Version: 2.16.18 2026-07-10 00:17:14.476275 | Job: pre-commit 2026-07-10 00:17:14.476314 | Pipeline: check 2026-07-10 00:17:14.476350 | Executor: 2d72f0692154 2026-07-10 00:17:14.476409 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/138 2026-07-10 00:17:14.476452 | Event ID: 61a9ca30-7bf4-11f1-9ca8-ec96cd71e004 2026-07-10 00:17:14.479704 | 2026-07-10 00:17:14.479775 | LOOP [emit-job-header : Print node information] 2026-07-10 00:17:14.608594 | localhost | ok: 2026-07-10 00:17:14.608803 | localhost | # Node Information 2026-07-10 00:17:14.608831 | localhost | Inventory Hostname: ubuntu-noble 2026-07-10 00:17:14.608853 | localhost | Hostname: np0000184875 2026-07-10 00:17:14.608872 | localhost | Username: zuul 2026-07-10 00:17:14.608895 | localhost | Distro: Ubuntu 24.04 2026-07-10 00:17:14.608914 | localhost | Provider: yul1 2026-07-10 00:17:14.608933 | localhost | Region: ca-ymq-1 2026-07-10 00:17:14.608965 | localhost | Label: ubuntu-noble 2026-07-10 00:17:14.608987 | localhost | Product Name: OpenStack Nova 2026-07-10 00:17:14.609006 | localhost | Interface IP: 199.204.45.38 2026-07-10 00:17:14.625486 | 2026-07-10 00:17:14.625644 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-10 00:17:15.047175 | localhost -> localhost | changed 2026-07-10 00:17:15.056338 | 2026-07-10 00:17:15.056460 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-10 00:17:16.001841 | localhost -> localhost | changed 2026-07-10 00:17:16.008237 | 2026-07-10 00:17:16.008300 | PLAY [all] 2026-07-10 00:17:16.016696 | 2026-07-10 00:17:16.016761 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-10 00:17:16.265749 | ubuntu-noble -> localhost | ok 2026-07-10 00:17:16.275483 | 2026-07-10 00:17:16.275594 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-10 00:17:16.310650 | ubuntu-noble | ok 2026-07-10 00:17:16.326709 | ubuntu-noble | included: /var/lib/zuul/builds/aa700da9ac7547baa447033e7ee5282d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-10 00:17:16.333646 | 2026-07-10 00:17:16.333778 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-10 00:17:18.105093 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-07-10 00:17:18.105276 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/aa700da9ac7547baa447033e7ee5282d/work/aa700da9ac7547baa447033e7ee5282d_id_rsa 2026-07-10 00:17:18.105306 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/aa700da9ac7547baa447033e7ee5282d/work/aa700da9ac7547baa447033e7ee5282d_id_rsa.pub 2026-07-10 00:17:18.105329 | ubuntu-noble -> localhost | The key fingerprint is: 2026-07-10 00:17:18.105350 | ubuntu-noble -> localhost | SHA256:Zzf8Nn/CcBS89ZUiquT0uipp24/sEc5AOujfWdWnZ1w zuul-build-sshkey 2026-07-10 00:17:18.105387 | ubuntu-noble -> localhost | The key's randomart image is: 2026-07-10 00:17:18.105408 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-07-10 00:17:18.105432 | ubuntu-noble -> localhost | | . .| 2026-07-10 00:17:18.105453 | ubuntu-noble -> localhost | | . .o.o| 2026-07-10 00:17:18.105473 | ubuntu-noble -> localhost | | . . . .+o| 2026-07-10 00:17:18.105492 | ubuntu-noble -> localhost | |. o o ... o .| 2026-07-10 00:17:18.105511 | ubuntu-noble -> localhost | |.o . .+ S.o.+o E | 2026-07-10 00:17:18.105529 | ubuntu-noble -> localhost | |. . + .o.+ .=oo | 2026-07-10 00:17:18.105548 | ubuntu-noble -> localhost | | . .+ .. . B+ | 2026-07-10 00:17:18.105566 | ubuntu-noble -> localhost | | .++ =. o.oo.| 2026-07-10 00:17:18.105587 | ubuntu-noble -> localhost | | .o+Ooo. .o| 2026-07-10 00:17:18.105607 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-07-10 00:17:18.105663 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.247512 2026-07-10 00:17:18.111801 | 2026-07-10 00:17:18.111942 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-10 00:17:18.145030 | ubuntu-noble | ok 2026-07-10 00:17:18.155925 | ubuntu-noble | included: /var/lib/zuul/builds/aa700da9ac7547baa447033e7ee5282d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-10 00:17:18.164086 | 2026-07-10 00:17:18.164179 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-10 00:17:18.189037 | ubuntu-noble | skipping: Conditional result was False 2026-07-10 00:17:18.198508 | 2026-07-10 00:17:18.198668 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-10 00:17:18.733482 | ubuntu-noble | changed 2026-07-10 00:17:18.740218 | 2026-07-10 00:17:18.740284 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-10 00:17:18.966034 | ubuntu-noble | ok 2026-07-10 00:17:18.973089 | 2026-07-10 00:17:18.973151 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-10 00:17:19.565274 | ubuntu-noble | changed 2026-07-10 00:17:19.570963 | 2026-07-10 00:17:19.571029 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-10 00:17:20.150445 | ubuntu-noble | changed 2026-07-10 00:17:20.158459 | 2026-07-10 00:17:20.158529 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-10 00:17:20.182823 | ubuntu-noble | skipping: Conditional result was False 2026-07-10 00:17:20.189636 | 2026-07-10 00:17:20.189706 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-10 00:17:20.570926 | ubuntu-noble -> localhost | changed 2026-07-10 00:17:20.590333 | 2026-07-10 00:17:20.590875 | TASK [add-build-sshkey : Add back temp key] 2026-07-10 00:17:20.878795 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/aa700da9ac7547baa447033e7ee5282d/work/aa700da9ac7547baa447033e7ee5282d_id_rsa (zuul-build-sshkey) 2026-07-10 00:17:20.879024 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011829 2026-07-10 00:17:20.887093 | 2026-07-10 00:17:20.887176 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-10 00:17:21.258951 | ubuntu-noble | ok 2026-07-10 00:17:21.266101 | 2026-07-10 00:17:21.266219 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-10 00:17:21.292135 | ubuntu-noble | skipping: Conditional result was False 2026-07-10 00:17:21.310340 | 2026-07-10 00:17:21.310434 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-07-10 00:17:21.690694 | ubuntu-noble | ok 2026-07-10 00:17:21.751222 | 2026-07-10 00:17:21.751378 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-07-10 00:17:22.599535 | ubuntu-noble | Output suppressed because no_log was given 2026-07-10 00:17:22.612390 | 2026-07-10 00:17:22.612460 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-07-10 00:17:22.840297 | ubuntu-noble | ok: "logs" 2026-07-10 00:17:22.840715 | ubuntu-noble | ok: All items complete 2026-07-10 00:17:22.840782 | 2026-07-10 00:17:23.036199 | ubuntu-noble | ok: "artifacts" 2026-07-10 00:17:23.226644 | ubuntu-noble | ok: "docs" 2026-07-10 00:17:23.244319 | 2026-07-10 00:17:23.244512 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-07-10 00:17:23.466416 | ubuntu-noble | changed: "logs" 2026-07-10 00:17:23.652711 | ubuntu-noble | changed: "artifacts" 2026-07-10 00:17:23.848186 | ubuntu-noble | changed: "docs" 2026-07-10 00:17:23.870442 | 2026-07-10 00:17:23.870560 | PLAY RECAP 2026-07-10 00:17:23.870610 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-10 00:17:23.870641 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-07-10 00:17:23.870698 | 2026-07-10 00:17:24.004720 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-07-10 00:17:24.007121 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-07-10 00:17:24.735226 | 2026-07-10 00:17:24.735369 | PLAY [all] 2026-07-10 00:17:24.751457 | 2026-07-10 00:17:24.751587 | TASK [setup-uv : Extract archive] 2026-07-10 00:17:27.198823 | ubuntu-noble | changed 2026-07-10 00:17:27.206792 | 2026-07-10 00:17:27.206885 | TASK [setup-uv : Print version] 2026-07-10 00:17:27.572954 | ubuntu-noble | uv 0.8.13 2026-07-10 00:17:27.744886 | ubuntu-noble | ok: Runtime: 0:00:00.016844 2026-07-10 00:17:27.752183 | 2026-07-10 00:17:27.752260 | PLAY RECAP 2026-07-10 00:17:27.752308 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-10 00:17:27.752334 | 2026-07-10 00:17:27.887827 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-07-10 00:17:27.889128 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-07-10 00:17:28.534272 | 2026-07-10 00:17:28.534843 | PLAY [all] 2026-07-10 00:17:28.547361 | 2026-07-10 00:17:28.547466 | TASK [Run "pre-commit"] 2026-07-10 00:17:29.351585 | ubuntu-noble | Downloading virtualenv (5.3MiB) 2026-07-10 00:17:29.513733 | ubuntu-noble | Downloading virtualenv 2026-07-10 00:17:29.526665 | ubuntu-noble | Installed 10 packages in 11ms 2026-07-10 00:17:29.929500 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-07-10 00:17:30.456818 | 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-07-10 00:17:30.462613 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black. 2026-07-10 00:17:30.984263 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8. 2026-07-10 00:17:31.365940 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort. 2026-07-10 00:17:31.813111 | 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-07-10 00:17:31.814751 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git. 2026-07-10 00:17:32.516345 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0. 2026-07-10 00:17:33.035469 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-07-10 00:17:33.035537 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-07-10 00:17:33.035544 | ubuntu-noble | [INFO] This may take a few minutes... 2026-07-10 00:17:37.282975 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black. 2026-07-10 00:17:37.283104 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-07-10 00:17:37.283112 | ubuntu-noble | [INFO] This may take a few minutes... 2026-07-10 00:17:42.462599 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8. 2026-07-10 00:17:42.462692 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-07-10 00:17:42.462705 | ubuntu-noble | [INFO] This may take a few minutes... 2026-07-10 00:17:46.197306 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort. 2026-07-10 00:17:46.197378 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-07-10 00:17:46.197387 | ubuntu-noble | [INFO] This may take a few minutes... 2026-07-10 00:17:48.999392 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git. 2026-07-10 00:17:48.999480 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-07-10 00:17:48.999491 | ubuntu-noble | [INFO] This may take a few minutes... 2026-07-10 00:18:01.523138 | ubuntu-noble | fix end of files.........................................................Passed 2026-07-10 00:18:01.590710 | ubuntu-noble | trim trailing whitespace.................................................Passed 2026-07-10 00:18:01.860615 | ubuntu-noble | black....................................................................Passed 2026-07-10 00:18:02.050212 | ubuntu-noble | flake8...................................................................Passed 2026-07-10 00:18:02.174336 | ubuntu-noble | isort....................................................................Passed 2026-07-10 00:18:27.113624 | ubuntu-noble | Ansible-lint.............................................................Passed 2026-07-10 00:18:27.230060 | ubuntu-noble | ok: Runtime: 0:00:58.259706 2026-07-10 00:18:27.232117 | 2026-07-10 00:18:27.232166 | PLAY RECAP 2026-07-10 00:18:27.232208 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-10 00:18:27.232229 | 2026-07-10 00:18:27.356297 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-07-10 00:18:27.358781 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-07-10 00:18:27.934176 | 2026-07-10 00:18:27.934304 | PLAY [all] 2026-07-10 00:18:27.946182 | 2026-07-10 00:18:27.946258 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-10 00:18:27.991456 | ubuntu-noble | skipping: Conditional result was False 2026-07-10 00:18:28.003292 | 2026-07-10 00:18:28.003471 | TASK [fetch-output : Set log path for single node] 2026-07-10 00:18:28.049675 | ubuntu-noble | ok 2026-07-10 00:18:28.055509 | 2026-07-10 00:18:28.055581 | LOOP [fetch-output : Ensure local output dirs] 2026-07-10 00:18:28.421510 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/aa700da9ac7547baa447033e7ee5282d/work/logs" 2026-07-10 00:18:28.625783 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/aa700da9ac7547baa447033e7ee5282d/work/artifacts" 2026-07-10 00:18:28.850467 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/aa700da9ac7547baa447033e7ee5282d/work/docs" 2026-07-10 00:18:28.867263 | 2026-07-10 00:18:28.867361 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-10 00:18:29.493646 | ubuntu-noble | ok 2026-07-10 00:18:30.286069 | ubuntu-noble | changed: All items complete 2026-07-10 00:18:30.286194 | 2026-07-10 00:18:30.359931 | ubuntu-noble | changed: .d..t...... ./ 2026-07-10 00:18:30.858330 | ubuntu-noble | changed: .d..t...... ./ 2026-07-10 00:18:30.874890 | 2026-07-10 00:18:30.875014 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-10 00:18:31.298682 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007670 2026-07-10 00:18:31.548883 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007296 2026-07-10 00:18:31.568823 | 2026-07-10 00:18:31.568986 | PLAY [all] 2026-07-10 00:18:31.581413 | 2026-07-10 00:18:31.581594 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-10 00:18:32.053196 | ubuntu-noble | changed 2026-07-10 00:18:32.060942 | 2026-07-10 00:18:32.061033 | PLAY RECAP 2026-07-10 00:18:32.061090 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-10 00:18:32.061120 | 2026-07-10 00:18:32.182040 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-07-10 00:18:32.184000 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-10 00:18:32.730000 | 2026-07-10 00:18:32.730126 | PLAY [localhost] 2026-07-10 00:18:32.740231 | 2026-07-10 00:18:32.740299 | TASK [Generate Zuul manifest] 2026-07-10 00:18:32.762615 | localhost | ok 2026-07-10 00:18:32.781135 | 2026-07-10 00:18:32.781224 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-10 00:18:33.137839 | localhost | changed 2026-07-10 00:18:33.148582 | 2026-07-10 00:18:33.148667 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-10 00:18:33.671275 | localhost | ok 2026-07-10 00:18:33.682401 | 2026-07-10 00:18:33.682538 | TASK [Upload logs] 2026-07-10 00:18:33.702377 | localhost | ok 2026-07-10 00:18:33.762628 | 2026-07-10 00:18:33.762837 | TASK [Set zuul-log-path fact] 2026-07-10 00:18:33.781854 | localhost | ok 2026-07-10 00:18:33.792238 | 2026-07-10 00:18:33.792303 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-10 00:18:33.823749 | localhost | ok 2026-07-10 00:18:33.834548 | 2026-07-10 00:18:33.834674 | TASK [upload-logs : Create log directories] 2026-07-10 00:18:34.242001 | localhost | changed 2026-07-10 00:18:34.249193 | 2026-07-10 00:18:34.249316 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-10 00:18:34.656841 | localhost -> localhost | ok: Runtime: 0:00:00.005411 2026-07-10 00:18:34.663494 | 2026-07-10 00:18:34.663580 | TASK [upload-logs : Upload logs to log server] 2026-07-10 00:18:35.819653 | localhost | Output suppressed because no_log was given 2026-07-10 00:18:35.824701 | 2026-07-10 00:18:35.824788 | LOOP [upload-logs : Compress console log and json output] 2026-07-10 00:18:35.868618 | localhost | skipping: Conditional result was False 2026-07-10 00:18:35.875766 | localhost | skipping: Conditional result was False 2026-07-10 00:18:35.890072 | 2026-07-10 00:18:35.890206 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-10 00:18:35.937161 | localhost | skipping: Conditional result was False 2026-07-10 00:18:35.937552 | 2026-07-10 00:18:35.941278 | localhost | skipping: Conditional result was False 2026-07-10 00:18:35.954523 | 2026-07-10 00:18:35.978930 | LOOP [upload-logs : Upload console log and json output]