2026-10-17 02:50:55.395578 | Job console starting 2026-10-17 02:50:55.410018 | Updating git repos 2026-10-17 02:50:55.439975 | Cloning repos into workspace 2026-10-17 02:50:55.550141 | Restoring repo states 2026-10-17 02:50:55.558473 | Merging changes 2026-10-17 02:50:56.113568 | Checking out repos 2026-10-17 02:50:56.167205 | Preparing playbooks 2026-10-17 02:50:57.238681 | Running Ansible setup 2026-10-17 02:51:00.874212 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-10-17 02:51:01.431527 | 2026-10-17 02:51:01.432119 | PLAY [localhost] 2026-10-17 02:51:01.439092 | 2026-10-17 02:51:01.439157 | TASK [Gathering Facts] 2026-10-17 02:51:02.298230 | localhost | ok 2026-10-17 02:51:02.310675 | 2026-10-17 02:51:02.310828 | TASK [Setup log path fact] 2026-10-17 02:51:02.330695 | localhost | ok 2026-10-17 02:51:02.349238 | 2026-10-17 02:51:02.349371 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-17 02:51:02.389529 | localhost | ok 2026-10-17 02:51:02.400799 | 2026-10-17 02:51:02.400949 | TASK [emit-job-header : Print job information] 2026-10-17 02:51:02.450040 | # Job Information 2026-10-17 02:51:02.450191 | Ansible Version: 2.16.18 2026-10-17 02:51:02.450221 | Job: pre-commit 2026-10-17 02:51:02.450241 | Pipeline: check 2026-10-17 02:51:02.450259 | Executor: 2d72f0692154 2026-10-17 02:51:02.450276 | Triggered by: https://github.com/vexxhost/atmosphere-zuul-jobs/pull/7 2026-10-17 02:51:02.450297 | Event ID: 19da4cf0-c9d5-11f1-8100-2ade005239ed 2026-10-17 02:51:02.452856 | 2026-10-17 02:51:02.452924 | LOOP [emit-job-header : Print node information] 2026-10-17 02:51:02.537542 | localhost | ok: 2026-10-17 02:51:02.537798 | localhost | # Node Information 2026-10-17 02:51:02.537862 | localhost | Inventory Hostname: ubuntu-noble 2026-10-17 02:51:02.537913 | localhost | Hostname: np0000195994 2026-10-17 02:51:02.537957 | localhost | Username: zuul 2026-10-17 02:51:02.538010 | localhost | Distro: Ubuntu 24.04 2026-10-17 02:51:02.538053 | localhost | Provider: yul1 2026-10-17 02:51:02.538095 | localhost | Region: ca-ymq-1 2026-10-17 02:51:02.538135 | localhost | Label: ubuntu-noble 2026-10-17 02:51:02.538174 | localhost | Product Name: OpenStack Nova 2026-10-17 02:51:02.538214 | localhost | Interface IP: 162.253.55.5 2026-10-17 02:51:02.550997 | 2026-10-17 02:51:02.551132 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-17 02:51:02.940753 | localhost -> localhost | changed 2026-10-17 02:51:02.950295 | 2026-10-17 02:51:02.950436 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-17 02:51:03.806231 | localhost -> localhost | changed 2026-10-17 02:51:03.816864 | 2026-10-17 02:51:03.816980 | PLAY [all] 2026-10-17 02:51:03.831743 | 2026-10-17 02:51:03.831880 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-17 02:51:04.069522 | ubuntu-noble -> localhost | ok 2026-10-17 02:51:04.082621 | 2026-10-17 02:51:04.082798 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-17 02:51:04.117339 | ubuntu-noble | ok 2026-10-17 02:51:04.145419 | ubuntu-noble | included: /var/lib/zuul/builds/32825021df5148a0bbebf801e6250ef8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-17 02:51:04.153425 | 2026-10-17 02:51:04.153541 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-17 02:51:06.785681 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-10-17 02:51:06.785964 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/32825021df5148a0bbebf801e6250ef8/work/32825021df5148a0bbebf801e6250ef8_id_rsa 2026-10-17 02:51:06.786026 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/32825021df5148a0bbebf801e6250ef8/work/32825021df5148a0bbebf801e6250ef8_id_rsa.pub 2026-10-17 02:51:06.786074 | ubuntu-noble -> localhost | The key fingerprint is: 2026-10-17 02:51:06.786117 | ubuntu-noble -> localhost | SHA256:NExuIxrn1KN0+SZaY+eypTYlZJQuSAAfyouMyO49mxo zuul-build-sshkey 2026-10-17 02:51:06.786178 | ubuntu-noble -> localhost | The key's randomart image is: 2026-10-17 02:51:06.786221 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-10-17 02:51:06.786268 | ubuntu-noble -> localhost | |..o. .. | 2026-10-17 02:51:06.786311 | ubuntu-noble -> localhost | |.o .. =o. | 2026-10-17 02:51:06.786352 | ubuntu-noble -> localhost | |......=o% | 2026-10-17 02:51:06.786393 | ubuntu-noble -> localhost | |* . .B.*+= | 2026-10-17 02:51:06.786434 | ubuntu-noble -> localhost | |++ . o+S + | 2026-10-17 02:51:06.786473 | ubuntu-noble -> localhost | |. +.*. | 2026-10-17 02:51:06.786513 | ubuntu-noble -> localhost | | E . .oo | 2026-10-17 02:51:06.786552 | ubuntu-noble -> localhost | |. o.. o= | 2026-10-17 02:51:06.786617 | ubuntu-noble -> localhost | | o.+o .o. | 2026-10-17 02:51:06.786662 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-10-17 02:51:06.786750 | ubuntu-noble -> localhost | ok: Runtime: 0:00:02.186297 2026-10-17 02:51:06.797568 | 2026-10-17 02:51:06.797738 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-17 02:51:06.832034 | ubuntu-noble | ok 2026-10-17 02:51:06.851891 | ubuntu-noble | included: /var/lib/zuul/builds/32825021df5148a0bbebf801e6250ef8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-17 02:51:06.863114 | 2026-10-17 02:51:06.863197 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-17 02:51:06.887972 | ubuntu-noble | skipping: Conditional result was False 2026-10-17 02:51:06.900794 | 2026-10-17 02:51:06.900931 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-17 02:51:07.463500 | ubuntu-noble | changed 2026-10-17 02:51:07.474023 | 2026-10-17 02:51:07.474151 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-17 02:51:07.702793 | ubuntu-noble | ok 2026-10-17 02:51:07.712745 | 2026-10-17 02:51:07.712887 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-17 02:51:08.304819 | ubuntu-noble | changed 2026-10-17 02:51:08.315177 | 2026-10-17 02:51:08.315311 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-17 02:51:08.937580 | ubuntu-noble | changed 2026-10-17 02:51:08.949301 | 2026-10-17 02:51:08.949430 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-17 02:51:08.973315 | ubuntu-noble | skipping: Conditional result was False 2026-10-17 02:51:08.983739 | 2026-10-17 02:51:08.983864 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-17 02:51:09.363143 | ubuntu-noble -> localhost | changed 2026-10-17 02:51:09.383271 | 2026-10-17 02:51:09.383408 | TASK [add-build-sshkey : Add back temp key] 2026-10-17 02:51:09.692993 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/32825021df5148a0bbebf801e6250ef8/work/32825021df5148a0bbebf801e6250ef8_id_rsa (zuul-build-sshkey) 2026-10-17 02:51:09.693295 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.015727 2026-10-17 02:51:09.705659 | 2026-10-17 02:51:09.705781 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-17 02:51:10.074161 | ubuntu-noble | ok 2026-10-17 02:51:10.083401 | 2026-10-17 02:51:10.083518 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-17 02:51:10.098515 | ubuntu-noble | skipping: Conditional result was False 2026-10-17 02:51:10.117307 | 2026-10-17 02:51:10.117430 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-10-17 02:51:10.507332 | ubuntu-noble | ok 2026-10-17 02:51:10.558277 | 2026-10-17 02:51:10.558444 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-10-17 02:51:11.646191 | ubuntu-noble | Output suppressed because no_log was given 2026-10-17 02:51:11.665223 | 2026-10-17 02:51:11.665348 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-10-17 02:51:11.909489 | ubuntu-noble | ok: "logs" 2026-10-17 02:51:11.909901 | ubuntu-noble | ok: All items complete 2026-10-17 02:51:11.909973 | 2026-10-17 02:51:12.115717 | ubuntu-noble | ok: "artifacts" 2026-10-17 02:51:12.346854 | ubuntu-noble | ok: "docs" 2026-10-17 02:51:12.359445 | 2026-10-17 02:51:12.359610 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-10-17 02:51:12.620455 | ubuntu-noble | changed: "logs" 2026-10-17 02:51:12.816630 | ubuntu-noble | changed: "artifacts" 2026-10-17 02:51:13.011942 | ubuntu-noble | changed: "docs" 2026-10-17 02:51:13.039138 | 2026-10-17 02:51:13.039323 | PLAY RECAP 2026-10-17 02:51:13.039414 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-17 02:51:13.039534 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-17 02:51:13.039630 | 2026-10-17 02:51:13.192309 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-10-17 02:51:13.194325 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-10-17 02:51:13.758213 | 2026-10-17 02:51:13.758778 | PLAY [all] 2026-10-17 02:51:13.770901 | 2026-10-17 02:51:13.770993 | TASK [setup-uv : Extract archive] 2026-10-17 02:51:16.402905 | ubuntu-noble | changed 2026-10-17 02:51:16.414573 | 2026-10-17 02:51:16.414744 | TASK [setup-uv : Print version] 2026-10-17 02:51:16.832627 | ubuntu-noble | uv 0.8.13 2026-10-17 02:51:16.961725 | ubuntu-noble | ok: Runtime: 0:00:00.020279 2026-10-17 02:51:16.974132 | 2026-10-17 02:51:16.974241 | PLAY RECAP 2026-10-17 02:51:16.974326 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-17 02:51:16.974371 | 2026-10-17 02:51:17.092683 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-10-17 02:51:17.094671 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-10-17 02:51:17.632407 | 2026-10-17 02:51:17.632574 | PLAY [all] 2026-10-17 02:51:17.643847 | 2026-10-17 02:51:17.643939 | TASK [Run "pre-commit"] 2026-10-17 02:51:18.345071 | ubuntu-noble | Downloading uv (16.5MiB) 2026-10-17 02:51:18.347642 | ubuntu-noble | Downloading virtualenv (5.2MiB) 2026-10-17 02:51:18.555205 | ubuntu-noble | Downloading uv 2026-10-17 02:51:18.626405 | ubuntu-noble | Downloading virtualenv 2026-10-17 02:51:18.645454 | ubuntu-noble | Installed 13 packages in 18ms 2026-10-17 02:51:19.058573 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-10-17 02:51:20.318875 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git. 2026-10-17 02:51:21.787709 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.19.0. 2026-10-17 02:51:22.464132 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-10-17 02:51:22.464220 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-10-17 02:51:22.464237 | ubuntu-noble | [INFO] This may take a few minutes... 2026-10-17 02:51:22.474024 | ubuntu-noble | [INFO] Using pre-commit with uv 0.13.1 via pre-commit-uv 4.4.0 2026-10-17 02:51:24.510780 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git. 2026-10-17 02:51:24.510834 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-10-17 02:51:24.510844 | ubuntu-noble | [INFO] This may take a few minutes... 2026-10-17 02:51:24.517450 | ubuntu-noble | [INFO] Using pre-commit with uv 0.13.1 via pre-commit-uv 4.4.0 2026-10-17 02:51:29.660788 | ubuntu-noble | fix end of files.........................................................Passed 2026-10-17 02:51:29.713897 | ubuntu-noble | trim trailing whitespace.................................................Passed 2026-10-17 02:51:41.483103 | ubuntu-noble | ansible-lint.............................................................Passed 2026-10-17 02:51:41.694095 | ubuntu-noble | ok: Runtime: 0:00:23.532256 2026-10-17 02:51:41.697469 | 2026-10-17 02:51:41.697585 | PLAY RECAP 2026-10-17 02:51:41.697712 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-17 02:51:41.697770 | 2026-10-17 02:51:41.886903 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-10-17 02:51:41.888937 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-10-17 02:51:42.456695 | 2026-10-17 02:51:42.457230 | PLAY [all] 2026-10-17 02:51:42.468646 | 2026-10-17 02:51:42.468722 | TASK [fetch-output : Set log path for multiple nodes] 2026-10-17 02:51:42.522379 | ubuntu-noble | skipping: Conditional result was False 2026-10-17 02:51:42.530652 | 2026-10-17 02:51:42.530754 | TASK [fetch-output : Set log path for single node] 2026-10-17 02:51:42.575442 | ubuntu-noble | ok 2026-10-17 02:51:42.583568 | 2026-10-17 02:51:42.583678 | LOOP [fetch-output : Ensure local output dirs] 2026-10-17 02:51:42.983660 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/32825021df5148a0bbebf801e6250ef8/work/logs" 2026-10-17 02:51:43.213347 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/32825021df5148a0bbebf801e6250ef8/work/artifacts" 2026-10-17 02:51:43.425959 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/32825021df5148a0bbebf801e6250ef8/work/docs" 2026-10-17 02:51:43.449465 | 2026-10-17 02:51:43.449784 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-17 02:51:44.220767 | ubuntu-noble | changed: .d..t...... ./ 2026-10-17 02:51:44.221108 | ubuntu-noble | changed: All items complete 2026-10-17 02:51:44.221160 | 2026-10-17 02:51:44.748576 | ubuntu-noble | changed: .d..t...... ./ 2026-10-17 02:51:45.270140 | ubuntu-noble | changed: .d..t...... ./ 2026-10-17 02:51:45.303498 | 2026-10-17 02:51:45.303682 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-17 02:51:45.753764 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007490 2026-10-17 02:51:45.992191 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007112 2026-10-17 02:51:46.009270 | 2026-10-17 02:51:46.009394 | PLAY [all] 2026-10-17 02:51:46.018081 | 2026-10-17 02:51:46.018164 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-17 02:51:46.517908 | ubuntu-noble | changed 2026-10-17 02:51:46.530639 | 2026-10-17 02:51:46.530793 | PLAY RECAP 2026-10-17 02:51:46.530881 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-10-17 02:51:46.530922 | 2026-10-17 02:51:46.677363 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-10-17 02:51:46.679484 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-17 02:51:47.212156 | 2026-10-17 02:51:47.212647 | PLAY [localhost] 2026-10-17 02:51:47.222109 | 2026-10-17 02:51:47.222179 | TASK [Generate Zuul manifest] 2026-10-17 02:51:47.237983 | localhost | ok 2026-10-17 02:51:47.250076 | 2026-10-17 02:51:47.250144 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-17 02:51:47.644110 | localhost | changed 2026-10-17 02:51:47.662863 | 2026-10-17 02:51:47.663002 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-17 02:51:47.705531 | localhost | ok 2026-10-17 02:51:47.718959 | 2026-10-17 02:51:47.719140 | TASK [Upload logs] 2026-10-17 02:51:47.740286 | localhost | ok 2026-10-17 02:51:47.804153 | 2026-10-17 02:51:47.804265 | TASK [Set zuul-log-path fact] 2026-10-17 02:51:47.820216 | localhost | ok 2026-10-17 02:51:47.829468 | 2026-10-17 02:51:47.829530 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-17 02:51:47.856527 | localhost | ok 2026-10-17 02:51:47.864321 | 2026-10-17 02:51:47.864421 | TASK [upload-logs : Create log directories] 2026-10-17 02:51:48.266532 | localhost | changed 2026-10-17 02:51:48.273621 | 2026-10-17 02:51:48.273735 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-17 02:51:48.686303 | localhost -> localhost | ok: Runtime: 0:00:00.004582 2026-10-17 02:51:48.692400 | 2026-10-17 02:51:48.692486 | TASK [upload-logs : Upload logs to log server] 2026-10-17 02:51:49.168249 | localhost | Output suppressed because no_log was given 2026-10-17 02:51:49.175305 | 2026-10-17 02:51:49.175491 | LOOP [upload-logs : Compress console log and json output] 2026-10-17 02:51:49.236490 | localhost | skipping: Conditional result was False 2026-10-17 02:51:49.246351 | localhost | skipping: Conditional result was False 2026-10-17 02:51:49.259654 | 2026-10-17 02:51:49.259854 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-17 02:51:49.295053 | localhost | skipping: Conditional result was False 2026-10-17 02:51:49.295597 | 2026-10-17 02:51:49.298440 | localhost | skipping: Conditional result was False 2026-10-17 02:51:49.313809 | 2026-10-17 02:51:49.313980 | LOOP [upload-logs : Upload console log and json output]