2026-01-22 17:49:05.893761 | Job console starting
2026-01-22 17:49:05.902516 | Updating git repos
2026-01-22 17:49:05.929149 | Cloning repos into workspace
2026-01-22 17:49:05.991975 | Restoring repo states
2026-01-22 17:49:05.999422 | Merging changes
2026-01-22 17:49:06.271337 | Checking out repos
2026-01-22 17:49:06.308288 | Preparing playbooks
2026-01-22 17:49:07.259937 | Running Ansible setup
2026-01-22 17:49:10.927211 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-01-22 17:49:11.577281 | 
2026-01-22 17:49:11.577431 | PLAY [localhost]
2026-01-22 17:49:11.585900 | 
2026-01-22 17:49:11.586008 | TASK [Gathering Facts]
2026-01-22 17:49:12.419643 | localhost | ok
2026-01-22 17:49:12.430077 | 
2026-01-22 17:49:12.430179 | TASK [Setup log path fact]
2026-01-22 17:49:12.451316 | localhost | ok
2026-01-22 17:49:12.462803 | 
2026-01-22 17:49:12.462879 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-01-22 17:49:12.491626 | localhost | ok
2026-01-22 17:49:12.499253 | 
2026-01-22 17:49:12.499327 | TASK [emit-job-header : Print job information]
2026-01-22 17:49:12.541924 | # Job Information
2026-01-22 17:49:12.542367 | Ansible Version: 2.16.15
2026-01-22 17:49:12.542499 | Job: pre-commit
2026-01-22 17:49:12.542606 | Pipeline: check
2026-01-22 17:49:12.542710 | Executor: 3a2793d2bd32
2026-01-22 17:49:12.542760 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/91
2026-01-22 17:49:12.542815 | Event ID: 88a5cb70-f7ba-11f0-9772-771f06e5a5e2
2026-01-22 17:49:12.547015 | 
2026-01-22 17:49:12.547083 | LOOP [emit-job-header : Print node information]
2026-01-22 17:49:12.651567 | localhost | ok:
2026-01-22 17:49:12.651799 | localhost | # Node Information
2026-01-22 17:49:12.651840 | localhost | Inventory Hostname: ubuntu-noble
2026-01-22 17:49:12.651871 | localhost | Hostname: np0000154404
2026-01-22 17:49:12.651899 | localhost | Username: zuul
2026-01-22 17:49:12.651931 | localhost | Distro: Ubuntu 24.04
2026-01-22 17:49:12.651959 | localhost | Provider: yul1
2026-01-22 17:49:12.651987 | localhost | Region: ca-ymq-1
2026-01-22 17:49:12.652014 | localhost | Label: ubuntu-noble
2026-01-22 17:49:12.652040 | localhost | Product Name: OpenStack Nova
2026-01-22 17:49:12.652066 | localhost | Interface IP: 199.204.45.23
2026-01-22 17:49:12.666264 | 
2026-01-22 17:49:12.666386 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-01-22 17:49:13.050013 | localhost -> localhost | changed
2026-01-22 17:49:13.057734 | 
2026-01-22 17:49:13.057842 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-01-22 17:49:13.912032 | localhost -> localhost | changed
2026-01-22 17:49:13.919066 | 
2026-01-22 17:49:13.919134 | PLAY [all]
2026-01-22 17:49:13.927885 | 
2026-01-22 17:49:13.927956 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-01-22 17:49:14.165750 | ubuntu-noble -> localhost | ok
2026-01-22 17:49:14.176281 | 
2026-01-22 17:49:14.176355 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-01-22 17:49:14.210426 | ubuntu-noble | ok
2026-01-22 17:49:14.224553 | ubuntu-noble | included: /var/lib/zuul/builds/5414266525754375bbefa3dd17b98dd3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-01-22 17:49:14.230646 | 
2026-01-22 17:49:14.230707 | TASK [add-build-sshkey : Create Temp SSH key]
2026-01-22 17:49:15.166007 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-01-22 17:49:15.166244 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/5414266525754375bbefa3dd17b98dd3/work/5414266525754375bbefa3dd17b98dd3_id_rsa
2026-01-22 17:49:15.166331 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/5414266525754375bbefa3dd17b98dd3/work/5414266525754375bbefa3dd17b98dd3_id_rsa.pub
2026-01-22 17:49:15.166368 | ubuntu-noble -> localhost | The key fingerprint is:
2026-01-22 17:49:15.166398 | ubuntu-noble -> localhost | SHA256:9BfJlWlWsT8n6hubCgQk5OTmS2XWkZCpgC+Q+5as+cs zuul-build-sshkey
2026-01-22 17:49:15.166445 | ubuntu-noble -> localhost | The key's randomart image is:
2026-01-22 17:49:15.166475 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-01-22 17:49:15.166514 | ubuntu-noble -> localhost | | o .+ o+..    .=o|
2026-01-22 17:49:15.166546 | ubuntu-noble -> localhost | |+ .+ oo... . o= .|
2026-01-22 17:49:15.166575 | ubuntu-noble -> localhost | |.o .+.= o   +o . |
2026-01-22 17:49:15.166603 | ubuntu-noble -> localhost | |o .o.+ o .   .  .|
2026-01-22 17:49:15.166632 | ubuntu-noble -> localhost | | + .o   S . . ..o|
2026-01-22 17:49:15.166659 | ubuntu-noble -> localhost | |  =. . .   . . .o|
2026-01-22 17:49:15.166687 | ubuntu-noble -> localhost | | +  .   .   o    |
2026-01-22 17:49:15.166714 | ubuntu-noble -> localhost | |o.       . . +   |
2026-01-22 17:49:15.166745 | ubuntu-noble -> localhost | | .E.      ..=.   |
2026-01-22 17:49:15.166774 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-01-22 17:49:15.166836 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.514137
2026-01-22 17:49:15.174426 | 
2026-01-22 17:49:15.174516 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-01-22 17:49:15.205830 | ubuntu-noble | ok
2026-01-22 17:49:15.221917 | ubuntu-noble | included: /var/lib/zuul/builds/5414266525754375bbefa3dd17b98dd3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-01-22 17:49:15.237434 | 
2026-01-22 17:49:15.366366 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-01-22 17:49:15.393528 | ubuntu-noble | skipping: Conditional result was False
2026-01-22 17:49:15.404641 | 
2026-01-22 17:49:15.404755 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-01-22 17:49:15.915822 | ubuntu-noble | changed
2026-01-22 17:49:15.923399 | 
2026-01-22 17:49:15.923464 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-01-22 17:49:16.138219 | ubuntu-noble | ok
2026-01-22 17:49:16.147420 | 
2026-01-22 17:49:16.147488 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-01-22 17:49:16.719233 | ubuntu-noble | changed
2026-01-22 17:49:16.727202 | 
2026-01-22 17:49:16.727295 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-01-22 17:49:17.270289 | ubuntu-noble | changed
2026-01-22 17:49:17.277266 | 
2026-01-22 17:49:17.277358 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-01-22 17:49:17.300531 | ubuntu-noble | skipping: Conditional result was False
2026-01-22 17:49:17.313966 | 
2026-01-22 17:49:17.314033 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-01-22 17:49:17.713764 | ubuntu-noble -> localhost | changed
2026-01-22 17:49:17.728962 | 
2026-01-22 17:49:17.729034 | TASK [add-build-sshkey : Add back temp key]
2026-01-22 17:49:18.047903 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/5414266525754375bbefa3dd17b98dd3/work/5414266525754375bbefa3dd17b98dd3_id_rsa (zuul-build-sshkey)
2026-01-22 17:49:18.048181 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009708
2026-01-22 17:49:18.056230 | 
2026-01-22 17:49:18.056324 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-01-22 17:49:18.447474 | ubuntu-noble | ok
2026-01-22 17:49:18.452749 | 
2026-01-22 17:49:18.452814 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-01-22 17:49:18.478389 | ubuntu-noble | skipping: Conditional result was False
2026-01-22 17:49:18.492130 | 
2026-01-22 17:49:18.492199 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-01-22 17:49:18.860822 | ubuntu-noble | ok
2026-01-22 17:49:18.869729 | 
2026-01-22 17:49:18.869809 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-01-22 17:49:19.801726 | ubuntu-noble | Output suppressed because no_log was given
2026-01-22 17:49:19.811405 | 
2026-01-22 17:49:19.811471 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-01-22 17:49:20.035594 | ubuntu-noble | ok: "logs"
2026-01-22 17:49:20.035932 | ubuntu-noble | ok: All items complete
2026-01-22 17:49:20.035985 | 
2026-01-22 17:49:20.229758 | ubuntu-noble | ok: "artifacts"
2026-01-22 17:49:20.483467 | ubuntu-noble | ok: "docs"
2026-01-22 17:49:20.504030 | 
2026-01-22 17:49:20.504173 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-01-22 17:49:20.729097 | ubuntu-noble | changed: "logs"
2026-01-22 17:49:20.925724 | ubuntu-noble | changed: "artifacts"
2026-01-22 17:49:21.110646 | ubuntu-noble | changed: "docs"
2026-01-22 17:49:21.129280 | 
2026-01-22 17:49:21.129338 | PLAY RECAP
2026-01-22 17:49:21.129396 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-22 17:49:21.129462 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-01-22 17:49:21.129489 | 
2026-01-22 17:49:21.281606 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-01-22 17:49:21.282795 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-01-22 17:49:21.876930 | 
2026-01-22 17:49:21.877140 | PLAY [all]
2026-01-22 17:49:21.891977 | 
2026-01-22 17:49:21.892170 | TASK [setup-uv : Extract archive]
2026-01-22 17:49:24.285191 | ubuntu-noble | changed
2026-01-22 17:49:24.293786 | 
2026-01-22 17:49:24.293887 | TASK [setup-uv : Print version]
2026-01-22 17:49:24.594362 | ubuntu-noble | uv 0.8.13
2026-01-22 17:49:24.831189 | ubuntu-noble | ok: Runtime: 0:00:00.011090
2026-01-22 17:49:24.840170 | 
2026-01-22 17:49:24.840219 | PLAY RECAP
2026-01-22 17:49:24.840265 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-22 17:49:24.840288 | 
2026-01-22 17:49:24.997240 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-01-22 17:49:24.998565 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-01-22 17:49:25.557239 | 
2026-01-22 17:49:25.557367 | PLAY [all]
2026-01-22 17:49:25.568907 | 
2026-01-22 17:49:25.568995 | TASK [Run "pre-commit"]
2026-01-22 17:49:27.200369 | ubuntu-noble | Downloading virtualenv (5.7MiB)
2026-01-22 17:49:27.287313 | ubuntu-noble |  Downloading virtualenv
2026-01-22 17:49:27.298108 | ubuntu-noble | Installed 9 packages in 10ms
2026-01-22 17:49:27.673390 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-01-22 17:49:28.200138 | 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-01-22 17:49:28.206284 | ubuntu-noble | [INFO] Initializing environment for https://github.com/compilerla/conventional-pre-commit.
2026-01-22 17:49:28.502514 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-01-22 17:49:29.029717 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-01-22 17:49:29.565000 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-01-22 17:49:29.565073 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-01-22 17:49:29.565084 | ubuntu-noble | [INFO] This may take a few minutes...
2026-01-22 17:49:33.613333 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-01-22 17:49:33.613381 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-01-22 17:49:33.613386 | ubuntu-noble | [INFO] This may take a few minutes...
2026-01-22 17:49:44.601194 | ubuntu-noble | fix end of files.........................................................Passed
2026-01-22 17:49:44.639409 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-01-22 17:50:06.354605 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-01-22 17:50:06.574215 | ubuntu-noble | ok: Runtime: 0:00:40.478125
2026-01-22 17:50:06.576562 | 
2026-01-22 17:50:06.576613 | PLAY RECAP
2026-01-22 17:50:06.576664 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-22 17:50:06.576686 | 
2026-01-22 17:50:06.700452 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-01-22 17:50:06.702941 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-01-22 17:50:07.283728 | 
2026-01-22 17:50:07.283874 | PLAY [all]
2026-01-22 17:50:07.295811 | 
2026-01-22 17:50:07.295893 | TASK [fetch-output : Set log path for multiple nodes]
2026-01-22 17:50:07.340831 | ubuntu-noble | skipping: Conditional result was False
2026-01-22 17:50:07.349702 | 
2026-01-22 17:50:07.349811 | TASK [fetch-output : Set log path for single node]
2026-01-22 17:50:07.394948 | ubuntu-noble | ok
2026-01-22 17:50:07.401831 | 
2026-01-22 17:50:07.401906 | LOOP [fetch-output : Ensure local output dirs]
2026-01-22 17:50:07.778610 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/5414266525754375bbefa3dd17b98dd3/work/logs"
2026-01-22 17:50:07.978634 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/5414266525754375bbefa3dd17b98dd3/work/artifacts"
2026-01-22 17:50:08.181440 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/5414266525754375bbefa3dd17b98dd3/work/docs"
2026-01-22 17:50:08.198368 | 
2026-01-22 17:50:08.198447 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-01-22 17:50:08.850038 | ubuntu-noble | changed: .d..t...... ./
2026-01-22 17:50:08.850306 | ubuntu-noble | changed: All items complete
2026-01-22 17:50:08.850344 | 
2026-01-22 17:50:09.330369 | ubuntu-noble | changed: .d..t...... ./
2026-01-22 17:50:09.791946 | ubuntu-noble | changed: .d..t...... ./
2026-01-22 17:50:09.812289 | 
2026-01-22 17:50:09.812361 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-01-22 17:50:10.240206 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008549
2026-01-22 17:50:10.454847 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007228
2026-01-22 17:50:10.477590 | 
2026-01-22 17:50:10.477754 | PLAY [all]
2026-01-22 17:50:10.485309 | 
2026-01-22 17:50:10.485393 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-01-22 17:50:10.954872 | ubuntu-noble | changed
2026-01-22 17:50:10.962295 | 
2026-01-22 17:50:10.962352 | PLAY RECAP
2026-01-22 17:50:10.962396 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-01-22 17:50:10.962417 | 
2026-01-22 17:50:11.077975 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-01-22 17:50:11.080440 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main]
2026-01-22 17:50:11.625027 | 
2026-01-22 17:50:11.625189 | PLAY [localhost]
2026-01-22 17:50:11.636274 | 
2026-01-22 17:50:11.636355 | TASK [Generate Zuul manifest]
2026-01-22 17:50:11.657628 | localhost | ok
2026-01-22 17:50:11.675114 | 
2026-01-22 17:50:11.675199 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-01-22 17:50:11.977151 | localhost | changed
2026-01-22 17:50:11.988526 | 
2026-01-22 17:50:11.988602 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-01-22 17:50:12.018670 | localhost | ok
2026-01-22 17:50:12.025562 | 
2026-01-22 17:50:12.025623 | TASK [Upload logs]
2026-01-22 17:50:12.043345 | localhost | ok
2026-01-22 17:50:12.100522 | 
2026-01-22 17:50:12.100609 | TASK [Set zuul-log-path fact]
2026-01-22 17:50:12.118727 | localhost | ok
2026-01-22 17:50:12.131818 | 
2026-01-22 17:50:12.131882 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-01-22 17:50:12.160388 | localhost | ok
2026-01-22 17:50:12.169287 | 
2026-01-22 17:50:12.169390 | TASK [upload-logs : Create log directories]
2026-01-22 17:50:12.572314 | localhost | changed
2026-01-22 17:50:12.578682 | 
2026-01-22 17:50:12.578775 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-01-22 17:50:12.978634 | localhost -> localhost | ok: Runtime: 0:00:00.005312
2026-01-22 17:50:12.985675 | 
2026-01-22 17:50:12.985766 | TASK [upload-logs : Upload logs to log server]
2026-01-22 17:50:13.434711 | localhost | Output suppressed because no_log was given
2026-01-22 17:50:13.438557 | 
2026-01-22 17:50:13.438623 | LOOP [upload-logs : Compress console log and json output]
2026-01-22 17:50:13.486479 | localhost | skipping: Conditional result was False
2026-01-22 17:50:13.493256 | localhost | skipping: Conditional result was False
2026-01-22 17:50:13.503540 | 
2026-01-22 17:50:13.503709 | LOOP [upload-logs : Upload compressed console log and json output]
2026-01-22 17:50:13.547517 | localhost | skipping: Conditional result was False
2026-01-22 17:50:13.547992 | 
2026-01-22 17:50:13.550555 | localhost | skipping: Conditional result was False
2026-01-22 17:50:13.568275 | 
2026-01-22 17:50:13.568433 | LOOP [upload-logs : Upload console log and json output]