2026-10-17 07:40:03.356480 | Job console starting 2026-10-17 07:40:03.367745 | Updating git repos 2026-10-17 07:40:03.441638 | Cloning repos into workspace 2026-10-17 07:40:03.611106 | Restoring repo states 2026-10-17 07:40:03.639036 | Merging changes 2026-10-17 07:40:05.529461 | Checking out repos 2026-10-17 07:40:05.706620 | Preparing playbooks 2026-10-17 07:40:06.754304 | Running Ansible setup 2026-10-17 07:40:10.444733 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-10-17 07:40:10.990880 | 2026-10-17 07:40:10.991005 | PLAY [localhost] 2026-10-17 07:40:10.997812 | 2026-10-17 07:40:10.997879 | TASK [Gathering Facts] 2026-10-17 07:40:11.865230 | localhost | ok 2026-10-17 07:40:11.878611 | 2026-10-17 07:40:11.878767 | TASK [Setup log path fact] 2026-10-17 07:40:11.901494 | localhost | ok 2026-10-17 07:40:11.921178 | 2026-10-17 07:40:11.921289 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-17 07:40:11.963871 | localhost | ok 2026-10-17 07:40:11.975134 | 2026-10-17 07:40:11.975293 | TASK [emit-job-header : Print job information] 2026-10-17 07:40:12.028107 | # Job Information 2026-10-17 07:40:12.028363 | Ansible Version: 2.16.18 2026-10-17 07:40:12.028430 | Job: pre-commit 2026-10-17 07:40:12.028478 | Pipeline: check 2026-10-17 07:40:12.028581 | Executor: 2d72f0692154 2026-10-17 07:40:12.028635 | Triggered by: https://github.com/vexxhost/atmosphere-zuul-jobs/pull/8 2026-10-17 07:40:12.028698 | Event ID: 6007d170-c9fd-11f1-94e6-1a8adb95b95c 2026-10-17 07:40:12.034182 | 2026-10-17 07:40:12.034340 | LOOP [emit-job-header : Print node information] 2026-10-17 07:40:12.149947 | localhost | ok: 2026-10-17 07:40:12.150242 | localhost | # Node Information 2026-10-17 07:40:12.150322 | localhost | Inventory Hostname: ubuntu-noble 2026-10-17 07:40:12.150364 | localhost | Hostname: np0000196004 2026-10-17 07:40:12.150402 | localhost | Username: zuul 2026-10-17 07:40:12.150443 | localhost | Distro: Ubuntu 24.04 2026-10-17 07:40:12.150480 | localhost | Provider: yul1 2026-10-17 07:40:12.150515 | localhost | Region: ca-ymq-1 2026-10-17 07:40:12.150550 | localhost | Label: ubuntu-noble 2026-10-17 07:40:12.150585 | localhost | Product Name: OpenStack Nova 2026-10-17 07:40:12.150619 | localhost | Interface IP: 162.253.55.193 2026-10-17 07:40:12.157818 | 2026-10-17 07:40:12.157976 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-17 07:40:12.576470 | localhost -> localhost | changed 2026-10-17 07:40:12.585980 | 2026-10-17 07:40:12.586117 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-17 07:40:13.465371 | localhost -> localhost | changed 2026-10-17 07:40:13.476812 | 2026-10-17 07:40:13.476938 | PLAY [all] 2026-10-17 07:40:13.498891 | 2026-10-17 07:40:13.499083 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-17 07:40:13.757958 | ubuntu-noble -> localhost | ok 2026-10-17 07:40:13.770003 | 2026-10-17 07:40:13.770140 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-17 07:40:13.807991 | ubuntu-noble | ok 2026-10-17 07:40:13.833502 | ubuntu-noble | included: /var/lib/zuul/builds/3a305000b576426d8944d60df0713c9c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-17 07:40:13.840650 | 2026-10-17 07:40:13.840736 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-17 07:40:15.791115 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-10-17 07:40:15.791432 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/3a305000b576426d8944d60df0713c9c/work/3a305000b576426d8944d60df0713c9c_id_rsa 2026-10-17 07:40:15.791496 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/3a305000b576426d8944d60df0713c9c/work/3a305000b576426d8944d60df0713c9c_id_rsa.pub 2026-10-17 07:40:15.791541 | ubuntu-noble -> localhost | The key fingerprint is: 2026-10-17 07:40:15.791585 | ubuntu-noble -> localhost | SHA256:bkKoRd/mzXka0GdEYxry5Dq+ZA/4FWlrWZifyC6R6M0 zuul-build-sshkey 2026-10-17 07:40:15.791651 | ubuntu-noble -> localhost | The key's randomart image is: 2026-10-17 07:40:15.791694 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-10-17 07:40:15.791746 | ubuntu-noble -> localhost | | . o + | 2026-10-17 07:40:15.791791 | ubuntu-noble -> localhost | | = = . | 2026-10-17 07:40:15.791832 | ubuntu-noble -> localhost | | . + . | 2026-10-17 07:40:15.791873 | ubuntu-noble -> localhost | | . o . o = | 2026-10-17 07:40:15.791913 | ubuntu-noble -> localhost | | o o.S.B + | 2026-10-17 07:40:15.791953 | ubuntu-noble -> localhost | | o ..*oB @ . | 2026-10-17 07:40:15.791992 | ubuntu-noble -> localhost | | . .ooO.% + | 2026-10-17 07:40:15.792032 | ubuntu-noble -> localhost | | .*EB + | 2026-10-17 07:40:15.792077 | ubuntu-noble -> localhost | | o.+ | 2026-10-17 07:40:15.792119 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-10-17 07:40:15.792219 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.490493 2026-10-17 07:40:15.803885 | 2026-10-17 07:40:15.804024 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-17 07:40:15.840855 | ubuntu-noble | ok 2026-10-17 07:40:15.857813 | ubuntu-noble | included: /var/lib/zuul/builds/3a305000b576426d8944d60df0713c9c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-17 07:40:15.869436 | 2026-10-17 07:40:15.869517 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-17 07:40:15.893854 | ubuntu-noble | skipping: Conditional result was False 2026-10-17 07:40:15.903987 | 2026-10-17 07:40:15.904122 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-17 07:40:16.477076 | ubuntu-noble | changed 2026-10-17 07:40:16.489500 | 2026-10-17 07:40:16.489625 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-17 07:40:16.736751 | ubuntu-noble | ok 2026-10-17 07:40:16.747443 | 2026-10-17 07:40:16.747575 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-17 07:40:17.342391 | ubuntu-noble | changed 2026-10-17 07:40:17.352555 | 2026-10-17 07:40:17.352702 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-17 07:40:17.937840 | ubuntu-noble | changed 2026-10-17 07:40:17.942671 | 2026-10-17 07:40:17.942755 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-17 07:40:17.967021 | ubuntu-noble | skipping: Conditional result was False 2026-10-17 07:40:17.972556 | 2026-10-17 07:40:17.972619 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-17 07:40:18.361194 | ubuntu-noble -> localhost | changed 2026-10-17 07:40:18.382095 | 2026-10-17 07:40:18.382227 | TASK [add-build-sshkey : Add back temp key] 2026-10-17 07:40:18.703919 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/3a305000b576426d8944d60df0713c9c/work/3a305000b576426d8944d60df0713c9c_id_rsa (zuul-build-sshkey) 2026-10-17 07:40:18.704217 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016955 2026-10-17 07:40:18.715722 | 2026-10-17 07:40:18.715851 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-17 07:40:19.105951 | ubuntu-noble | ok 2026-10-17 07:40:19.115544 | 2026-10-17 07:40:19.115673 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-17 07:40:19.151070 | ubuntu-noble | skipping: Conditional result was False 2026-10-17 07:40:19.171949 | 2026-10-17 07:40:19.172091 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-10-17 07:40:19.622538 | ubuntu-noble | ok 2026-10-17 07:40:19.628806 | 2026-10-17 07:40:19.628862 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-10-17 07:40:21.816595 | ubuntu-noble | Output suppressed because no_log was given 2026-10-17 07:40:21.870672 | 2026-10-17 07:40:21.870819 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-10-17 07:40:22.131649 | ubuntu-noble | ok: "logs" 2026-10-17 07:40:22.131998 | ubuntu-noble | ok: All items complete 2026-10-17 07:40:22.132071 | 2026-10-17 07:40:22.319489 | ubuntu-noble | ok: "artifacts" 2026-10-17 07:40:22.510394 | ubuntu-noble | ok: "docs" 2026-10-17 07:40:22.530569 | 2026-10-17 07:40:22.530783 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-10-17 07:40:22.757602 | ubuntu-noble | changed: "logs" 2026-10-17 07:40:22.943445 | ubuntu-noble | changed: "artifacts" 2026-10-17 07:40:23.162278 | ubuntu-noble | changed: "docs" 2026-10-17 07:40:23.183464 | 2026-10-17 07:40:23.183651 | PLAY RECAP 2026-10-17 07:40:23.183737 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-17 07:40:23.183793 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-17 07:40:23.183831 | 2026-10-17 07:40:23.343352 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-10-17 07:40:23.345499 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-10-17 07:40:23.933496 | 2026-10-17 07:40:23.933627 | PLAY [all] 2026-10-17 07:40:23.944323 | 2026-10-17 07:40:23.944397 | TASK [setup-uv : Extract archive] 2026-10-17 07:40:26.816601 | ubuntu-noble | changed 2026-10-17 07:40:26.822147 | 2026-10-17 07:40:26.822225 | TASK [setup-uv : Print version] 2026-10-17 07:40:27.218191 | ubuntu-noble | uv 0.8.13 2026-10-17 07:40:27.358644 | ubuntu-noble | ok: Runtime: 0:00:00.018193 2026-10-17 07:40:27.371430 | 2026-10-17 07:40:27.371553 | PLAY RECAP 2026-10-17 07:40:27.371641 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-17 07:40:27.371691 | 2026-10-17 07:40:27.518634 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-10-17 07:40:27.520594 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-10-17 07:40:28.083268 | 2026-10-17 07:40:28.083415 | PLAY [all] 2026-10-17 07:40:28.093832 | 2026-10-17 07:40:28.094120 | TASK [Run "pre-commit"] 2026-10-17 07:40:28.786661 | ubuntu-noble | Downloading uv (16.5MiB) 2026-10-17 07:40:28.786754 | ubuntu-noble | Downloading virtualenv (5.2MiB) 2026-10-17 07:40:28.976436 | ubuntu-noble | Downloading uv 2026-10-17 07:40:29.028035 | ubuntu-noble | Downloading virtualenv 2026-10-17 07:40:29.045413 | ubuntu-noble | Installed 13 packages in 16ms 2026-10-17 07:40:29.444067 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-10-17 07:40:29.993373 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git. 2026-10-17 07:40:30.640796 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.19.0. 2026-10-17 07:40:31.441247 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-10-17 07:40:31.441314 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-10-17 07:40:31.441325 | ubuntu-noble | [INFO] This may take a few minutes... 2026-10-17 07:40:31.451787 | ubuntu-noble | [INFO] Using pre-commit with uv 0.13.1 via pre-commit-uv 4.4.0 2026-10-17 07:40:33.095469 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git. 2026-10-17 07:40:33.095521 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-10-17 07:40:33.095531 | ubuntu-noble | [INFO] This may take a few minutes... 2026-10-17 07:40:33.102697 | ubuntu-noble | [INFO] Using pre-commit with uv 0.13.1 via pre-commit-uv 4.4.0 2026-10-17 07:40:37.852261 | ubuntu-noble | fix end of files.........................................................Passed 2026-10-17 07:40:37.915339 | ubuntu-noble | trim trailing whitespace.................................................Passed 2026-10-17 07:40:49.177466 | ubuntu-noble | ansible-lint.............................................................Passed 2026-10-17 07:40:49.643198 | ubuntu-noble | ok: Runtime: 0:00:20.723812 2026-10-17 07:40:49.646006 | 2026-10-17 07:40:49.646096 | PLAY RECAP 2026-10-17 07:40:49.646174 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-17 07:40:49.646218 | 2026-10-17 07:40:49.778410 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-10-17 07:40:49.781055 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-10-17 07:40:50.365429 | 2026-10-17 07:40:50.365573 | PLAY [all] 2026-10-17 07:40:50.376227 | 2026-10-17 07:40:50.376326 | TASK [fetch-output : Set log path for multiple nodes] 2026-10-17 07:40:50.431021 | ubuntu-noble | skipping: Conditional result was False 2026-10-17 07:40:50.438443 | 2026-10-17 07:40:50.438554 | TASK [fetch-output : Set log path for single node] 2026-10-17 07:40:50.494731 | ubuntu-noble | ok 2026-10-17 07:40:50.504422 | 2026-10-17 07:40:50.504576 | LOOP [fetch-output : Ensure local output dirs] 2026-10-17 07:40:50.918442 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/3a305000b576426d8944d60df0713c9c/work/logs" 2026-10-17 07:40:51.109432 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/3a305000b576426d8944d60df0713c9c/work/artifacts" 2026-10-17 07:40:51.325458 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/3a305000b576426d8944d60df0713c9c/work/docs" 2026-10-17 07:40:51.341276 | 2026-10-17 07:40:51.341500 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-17 07:40:52.057821 | ubuntu-noble | changed: .d..t...... ./ 2026-10-17 07:40:52.058165 | ubuntu-noble | changed: All items complete 2026-10-17 07:40:52.058229 | 2026-10-17 07:40:52.605434 | ubuntu-noble | changed: .d..t...... ./ 2026-10-17 07:40:53.110310 | ubuntu-noble | changed: .d..t...... ./ 2026-10-17 07:40:53.134861 | 2026-10-17 07:40:53.135150 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-17 07:40:53.563997 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008812 2026-10-17 07:40:53.869385 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007429 2026-10-17 07:40:53.887342 | 2026-10-17 07:40:53.887514 | PLAY [all] 2026-10-17 07:40:53.899403 | 2026-10-17 07:40:53.899532 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-17 07:40:54.405110 | ubuntu-noble | changed 2026-10-17 07:40:54.410691 | 2026-10-17 07:40:54.410742 | PLAY RECAP 2026-10-17 07:40:54.410787 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-10-17 07:40:54.410807 | 2026-10-17 07:40:54.548886 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-10-17 07:40:54.550265 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-17 07:40:55.072643 | 2026-10-17 07:40:55.072768 | PLAY [localhost] 2026-10-17 07:40:55.081827 | 2026-10-17 07:40:55.081896 | TASK [Generate Zuul manifest] 2026-10-17 07:40:55.098461 | localhost | ok 2026-10-17 07:40:55.111190 | 2026-10-17 07:40:55.111275 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-17 07:40:55.525369 | localhost | changed 2026-10-17 07:40:55.546279 | 2026-10-17 07:40:55.546428 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-17 07:40:55.579697 | localhost | ok 2026-10-17 07:40:55.592232 | 2026-10-17 07:40:55.592380 | TASK [Upload logs] 2026-10-17 07:40:55.614406 | localhost | ok 2026-10-17 07:40:55.679651 | 2026-10-17 07:40:55.679760 | TASK [Set zuul-log-path fact] 2026-10-17 07:40:55.696247 | localhost | ok 2026-10-17 07:40:55.705879 | 2026-10-17 07:40:55.705941 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-17 07:40:55.743355 | localhost | ok 2026-10-17 07:40:55.751655 | 2026-10-17 07:40:55.751739 | TASK [upload-logs : Create log directories] 2026-10-17 07:40:56.190278 | localhost | changed 2026-10-17 07:40:56.199023 | 2026-10-17 07:40:56.199173 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-17 07:40:56.623047 | localhost -> localhost | ok: Runtime: 0:00:00.005195 2026-10-17 07:40:56.629090 | 2026-10-17 07:40:56.629173 | TASK [upload-logs : Upload logs to log server] 2026-10-17 07:40:57.125106 | localhost | Output suppressed because no_log was given 2026-10-17 07:40:57.131977 | 2026-10-17 07:40:57.132105 | LOOP [upload-logs : Compress console log and json output] 2026-10-17 07:40:57.180355 | localhost | skipping: Conditional result was False 2026-10-17 07:40:57.233456 | localhost | skipping: Conditional result was False 2026-10-17 07:40:57.245909 | 2026-10-17 07:40:57.246083 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-17 07:40:57.309006 | localhost | skipping: Conditional result was False 2026-10-17 07:40:57.309487 | 2026-10-17 07:40:57.315643 | localhost | skipping: Conditional result was False 2026-10-17 07:40:57.329847 | 2026-10-17 07:40:57.330033 | LOOP [upload-logs : Upload console log and json output]