2026-05-14 09:58:32.906980 | Job console starting
2026-05-14 09:58:33.099170 | Updating git repos
2026-05-14 09:58:33.420837 | Cloning repos into workspace
2026-05-14 09:58:34.011461 | Restoring repo states
2026-05-14 09:58:34.031393 | Merging changes
2026-05-14 09:58:35.444290 | Checking out repos
2026-05-14 09:58:35.990580 | Preparing playbooks
2026-05-14 09:58:43.486901 | Running Ansible setup
2026-05-14 09:58:51.555404 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-14 09:58:52.286723 | 
2026-05-14 09:58:52.369284 | PLAY [localhost]
2026-05-14 09:58:52.387797 | 
2026-05-14 09:58:52.387952 | TASK [Gathering Facts]
2026-05-14 09:58:54.696634 | localhost | ok
2026-05-14 09:58:54.704519 | 
2026-05-14 09:58:54.704605 | TASK [Setup log path fact]
2026-05-14 09:58:54.726520 | localhost | ok
2026-05-14 09:58:54.738507 | 
2026-05-14 09:58:54.746113 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-14 09:58:54.798093 | localhost | ok
2026-05-14 09:58:54.905596 | 
2026-05-14 09:58:54.909381 | TASK [emit-job-header : Print job information]
2026-05-14 09:58:54.959525 | # Job Information
2026-05-14 09:58:54.959683 | Ansible Version: 2.16.18
2026-05-14 09:58:54.959718 | Job: pre-commit
2026-05-14 09:58:54.959741 | Pipeline: check
2026-05-14 09:58:54.959763 | Executor: 2d72f0692154
2026-05-14 09:58:54.959784 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/129
2026-05-14 09:58:54.959807 | Event ID: e1cdee90-4f7a-11f1-8e86-6e434c085c6c
2026-05-14 09:58:54.962693 | 
2026-05-14 09:58:54.962779 | LOOP [emit-job-header : Print node information]
2026-05-14 09:58:55.180802 | localhost | ok:
2026-05-14 09:58:55.181010 | localhost | # Node Information
2026-05-14 09:58:55.181044 | localhost | Inventory Hostname: ubuntu-noble
2026-05-14 09:58:55.181068 | localhost | Hostname: np0000174162
2026-05-14 09:58:55.181103 | localhost | Username: zuul
2026-05-14 09:58:55.181130 | localhost | Distro: Ubuntu 24.04
2026-05-14 09:58:55.181156 | localhost | Provider: yul1
2026-05-14 09:58:55.181180 | localhost | Region: ca-ymq-1
2026-05-14 09:58:55.181204 | localhost | Label: ubuntu-noble
2026-05-14 09:58:55.181231 | localhost | Product Name: OpenStack Nova
2026-05-14 09:58:55.181259 | localhost | Interface IP: 199.19.213.52
2026-05-14 09:58:55.188557 | 
2026-05-14 09:58:55.188709 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-14 09:58:55.936684 | localhost -> localhost | changed
2026-05-14 09:58:55.946578 | 
2026-05-14 09:58:55.946704 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-14 09:58:57.519792 | localhost -> localhost | changed
2026-05-14 09:58:57.526582 | 
2026-05-14 09:58:57.526646 | PLAY [all]
2026-05-14 09:58:57.537448 | 
2026-05-14 09:58:57.537568 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-14 09:58:57.914761 | ubuntu-noble -> localhost | ok
2026-05-14 09:58:57.928590 | 
2026-05-14 09:58:57.928942 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-14 09:58:57.983637 | ubuntu-noble | ok
2026-05-14 09:58:58.163852 | ubuntu-noble | included: /var/lib/zuul/builds/1c51bf3bc0ed41a0bafae16e780f7245/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-14 09:58:58.178612 | 
2026-05-14 09:58:58.178788 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-14 09:58:59.614288 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-05-14 09:58:59.614476 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/1c51bf3bc0ed41a0bafae16e780f7245/work/1c51bf3bc0ed41a0bafae16e780f7245_id_rsa
2026-05-14 09:58:59.614509 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/1c51bf3bc0ed41a0bafae16e780f7245/work/1c51bf3bc0ed41a0bafae16e780f7245_id_rsa.pub
2026-05-14 09:58:59.614533 | ubuntu-noble -> localhost | The key fingerprint is:
2026-05-14 09:58:59.614555 | ubuntu-noble -> localhost | SHA256:SPbvFPyFialmRDCTCthBaVGhe3hsBrA8PjxvHMJdoIg zuul-build-sshkey
2026-05-14 09:58:59.614594 | ubuntu-noble -> localhost | The key's randomart image is:
2026-05-14 09:58:59.614621 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-05-14 09:58:59.614648 | ubuntu-noble -> localhost | |.++*o.+.         |
2026-05-14 09:58:59.614672 | ubuntu-noble -> localhost | |=o*.. .+         |
2026-05-14 09:58:59.614693 | ubuntu-noble -> localhost | |E=o. oo .        |
2026-05-14 09:58:59.614715 | ubuntu-noble -> localhost | |+ o=oo + . o o   |
2026-05-14 09:58:59.614736 | ubuntu-noble -> localhost | | Boo* . S = o .  |
2026-05-14 09:58:59.614778 | ubuntu-noble -> localhost | |  *=.  . o o .   |
2026-05-14 09:58:59.614809 | ubuntu-noble -> localhost | |   +    + o .    |
2026-05-14 09:58:59.614834 | ubuntu-noble -> localhost | |  .    o o       |
2026-05-14 09:58:59.614858 | ubuntu-noble -> localhost | |          .      |
2026-05-14 09:58:59.614880 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-05-14 09:58:59.614926 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.678666
2026-05-14 09:58:59.620878 | 
2026-05-14 09:58:59.620946 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-14 09:58:59.652312 | ubuntu-noble | ok
2026-05-14 09:58:59.717980 | ubuntu-noble | included: /var/lib/zuul/builds/1c51bf3bc0ed41a0bafae16e780f7245/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-14 09:58:59.726904 | 
2026-05-14 09:58:59.727004 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-14 09:58:59.753878 | ubuntu-noble | skipping: Conditional result was False
2026-05-14 09:58:59.773203 | 
2026-05-14 09:58:59.773450 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-14 09:59:00.361581 | ubuntu-noble | changed
2026-05-14 09:59:01.535645 | 
2026-05-14 09:59:01.535777 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-14 09:59:01.756488 | ubuntu-noble | ok
2026-05-14 09:59:01.762043 | 
2026-05-14 09:59:01.762109 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-14 09:59:02.330109 | ubuntu-noble | changed
2026-05-14 09:59:02.335627 | 
2026-05-14 09:59:02.335692 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-14 09:59:02.917883 | ubuntu-noble | changed
2026-05-14 09:59:02.925305 | 
2026-05-14 09:59:02.925399 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-14 09:59:02.951313 | ubuntu-noble | skipping: Conditional result was False
2026-05-14 09:59:02.961732 | 
2026-05-14 09:59:02.961845 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-14 09:59:03.370520 | ubuntu-noble -> localhost | changed
2026-05-14 09:59:03.395142 | 
2026-05-14 09:59:03.395460 | TASK [add-build-sshkey : Add back temp key]
2026-05-14 09:59:03.714014 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/1c51bf3bc0ed41a0bafae16e780f7245/work/1c51bf3bc0ed41a0bafae16e780f7245_id_rsa (zuul-build-sshkey)
2026-05-14 09:59:03.714241 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.015488
2026-05-14 09:59:03.721514 | 
2026-05-14 09:59:03.721686 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-14 09:59:04.124862 | ubuntu-noble | ok
2026-05-14 09:59:06.840674 | 
2026-05-14 09:59:06.840819 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-14 09:59:06.878609 | ubuntu-noble | skipping: Conditional result was False
2026-05-14 09:59:06.896238 | 
2026-05-14 09:59:06.896953 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-05-14 09:59:07.292161 | ubuntu-noble | ok
2026-05-14 09:59:08.142455 | 
2026-05-14 09:59:08.142595 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-05-14 09:59:26.466206 | ubuntu-noble | Output suppressed because no_log was given
2026-05-14 09:59:26.650294 | 
2026-05-14 09:59:26.650428 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-05-14 09:59:26.890530 | ubuntu-noble | ok: "logs"
2026-05-14 09:59:26.890778 | ubuntu-noble | ok: All items complete
2026-05-14 09:59:26.890817 | 
2026-05-14 09:59:27.105210 | ubuntu-noble | ok: "artifacts"
2026-05-14 09:59:27.307859 | ubuntu-noble | ok: "docs"
2026-05-14 09:59:27.339671 | 
2026-05-14 09:59:27.342142 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-05-14 09:59:27.601426 | ubuntu-noble | changed: "logs"
2026-05-14 09:59:27.792542 | ubuntu-noble | changed: "artifacts"
2026-05-14 09:59:27.976248 | ubuntu-noble | changed: "docs"
2026-05-14 09:59:27.996849 | 
2026-05-14 09:59:27.997034 | PLAY RECAP
2026-05-14 09:59:27.997102 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-14 09:59:27.997148 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-14 09:59:27.997182 | 
2026-05-14 09:59:28.223488 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-14 09:59:28.415661 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-05-14 09:59:29.123525 | 
2026-05-14 09:59:29.123749 | PLAY [all]
2026-05-14 09:59:29.139175 | 
2026-05-14 09:59:29.139305 | TASK [setup-uv : Extract archive]
2026-05-14 09:59:31.578906 | ubuntu-noble | changed
2026-05-14 09:59:31.766741 | 
2026-05-14 09:59:31.766906 | TASK [setup-uv : Print version]
2026-05-14 09:59:32.223773 | ubuntu-noble | uv 0.8.13
2026-05-14 09:59:32.318526 | ubuntu-noble | ok: Runtime: 0:00:00.014326
2026-05-14 09:59:32.328602 | 
2026-05-14 09:59:32.328690 | PLAY RECAP
2026-05-14 09:59:32.328738 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-14 09:59:32.328762 | 
2026-05-14 09:59:32.463390 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-05-14 09:59:32.465732 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-05-14 09:59:33.200156 | 
2026-05-14 09:59:33.450522 | PLAY [all]
2026-05-14 09:59:33.468421 | 
2026-05-14 09:59:33.468586 | TASK [Run "pre-commit"]
2026-05-14 09:59:34.098388 | ubuntu-noble | Downloading virtualenv (7.2MiB)
2026-05-14 09:59:34.197029 | ubuntu-noble |  Downloading virtualenv
2026-05-14 09:59:34.216536 | ubuntu-noble | Installed 10 packages in 18ms
2026-05-14 09:59:34.948268 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-05-14 09:59:36.472977 | 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-05-14 09:59:36.478177 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-05-14 09:59:37.147527 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-05-14 09:59:37.766582 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-05-14 09:59:38.450379 | 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-05-14 09:59:38.451249 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-05-14 09:59:39.340423 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-05-14 09:59:40.278861 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-05-14 09:59:40.278933 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-05-14 09:59:40.278948 | ubuntu-noble | [INFO] This may take a few minutes...
2026-05-14 09:59:45.275011 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-05-14 09:59:45.275061 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-05-14 09:59:45.275066 | ubuntu-noble | [INFO] This may take a few minutes...
2026-05-14 09:59:50.275264 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-05-14 09:59:50.275359 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-05-14 09:59:50.275376 | ubuntu-noble | [INFO] This may take a few minutes...
2026-05-14 09:59:53.510841 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-05-14 09:59:53.510877 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-05-14 09:59:53.510884 | ubuntu-noble | [INFO] This may take a few minutes...
2026-05-14 09:59:56.247215 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-05-14 09:59:56.247270 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-05-14 09:59:56.247275 | ubuntu-noble | [INFO] This may take a few minutes...
2026-05-14 10:00:06.344620 | ubuntu-noble | fix end of files.........................................................Passed
2026-05-14 10:00:06.398768 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-05-14 10:00:06.726913 | ubuntu-noble | black....................................................................Passed
2026-05-14 10:00:06.928150 | ubuntu-noble | flake8...................................................................Passed
2026-05-14 10:00:07.054944 | ubuntu-noble | isort....................................................................Passed
2026-05-14 10:00:30.315231 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-05-14 10:00:31.511682 | ubuntu-noble | ok: Runtime: 0:00:56.453329
2026-05-14 10:00:31.513280 | 
2026-05-14 10:00:31.513336 | PLAY RECAP
2026-05-14 10:00:31.513379 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-14 10:00:31.513401 | 
2026-05-14 10:00:31.703749 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-05-14 10:00:31.721180 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-14 10:00:32.672149 | 
2026-05-14 10:00:32.672317 | PLAY [all]
2026-05-14 10:00:32.687499 | 
2026-05-14 10:00:32.687741 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-14 10:00:32.732925 | ubuntu-noble | skipping: Conditional result was False
2026-05-14 10:00:32.743831 | 
2026-05-14 10:00:32.744005 | TASK [fetch-output : Set log path for single node]
2026-05-14 10:00:32.786661 | ubuntu-noble | ok
2026-05-14 10:00:32.793666 | 
2026-05-14 10:00:32.793745 | LOOP [fetch-output : Ensure local output dirs]
2026-05-14 10:00:33.904337 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/1c51bf3bc0ed41a0bafae16e780f7245/work/logs"
2026-05-14 10:00:34.122842 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/1c51bf3bc0ed41a0bafae16e780f7245/work/artifacts"
2026-05-14 10:00:34.321609 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/1c51bf3bc0ed41a0bafae16e780f7245/work/docs"
2026-05-14 10:00:34.342825 | 
2026-05-14 10:00:34.342961 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-14 10:00:35.031271 | ubuntu-noble | ok
2026-05-14 10:00:35.031507 | ubuntu-noble | changed: All items complete
2026-05-14 10:00:35.031551 | 
2026-05-14 10:00:35.515354 | ubuntu-noble | changed: .d..t...... ./
2026-05-14 10:00:37.151656 | ubuntu-noble | changed: .d..t...... ./
2026-05-14 10:00:37.173029 | 
2026-05-14 10:00:37.173138 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-14 10:00:37.618756 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008817
2026-05-14 10:00:37.890595 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.009055
2026-05-14 10:00:37.910647 | 
2026-05-14 10:00:37.910790 | PLAY [all]
2026-05-14 10:00:37.919079 | 
2026-05-14 10:00:37.919220 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-14 10:00:38.467230 | ubuntu-noble | changed
2026-05-14 10:00:38.477830 | 
2026-05-14 10:00:38.477902 | PLAY RECAP
2026-05-14 10:00:38.477965 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-14 10:00:38.477995 | 
2026-05-14 10:00:38.617133 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-14 10:00:43.158124 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-14 10:00:45.089554 | 
2026-05-14 10:00:45.089717 | PLAY [localhost]
2026-05-14 10:00:45.102561 | 
2026-05-14 10:00:45.102705 | TASK [Generate Zuul manifest]
2026-05-14 10:00:45.122112 | localhost | ok
2026-05-14 10:00:45.468241 | 
2026-05-14 10:00:45.468408 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-14 10:00:46.166562 | localhost | changed
2026-05-14 10:00:46.178814 | 
2026-05-14 10:00:46.178925 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-14 10:00:47.265398 | localhost | ok
2026-05-14 10:00:47.275363 | 
2026-05-14 10:00:47.275458 | TASK [Upload logs]
2026-05-14 10:00:47.293888 | localhost | ok
2026-05-14 10:00:47.908814 | 
2026-05-14 10:00:47.908984 | TASK [Set zuul-log-path fact]
2026-05-14 10:00:47.932694 | localhost | ok
2026-05-14 10:00:52.572423 | 
2026-05-14 10:00:52.572577 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-14 10:00:52.603533 | localhost | ok
2026-05-14 10:00:52.613740 | 
2026-05-14 10:00:52.613973 | TASK [upload-logs : Create log directories]
2026-05-14 10:01:02.475840 | localhost | changed
2026-05-14 10:01:02.484808 | 
2026-05-14 10:01:02.485283 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-14 10:01:02.979702 | localhost -> localhost | ok: Runtime: 0:00:00.005178
2026-05-14 10:01:02.986113 | 
2026-05-14 10:01:02.986215 | TASK [upload-logs : Upload logs to log server]
2026-05-14 10:01:03.537286 | localhost | Output suppressed because no_log was given
2026-05-14 10:01:03.541164 | 
2026-05-14 10:01:03.541235 | LOOP [upload-logs : Compress console log and json output]
2026-05-14 10:01:03.584848 | localhost | skipping: Conditional result was False
2026-05-14 10:01:03.597488 | localhost | skipping: Conditional result was False
2026-05-14 10:01:03.617174 | 
2026-05-14 10:01:03.617461 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-14 10:01:03.663418 | localhost | skipping: Conditional result was False
2026-05-14 10:01:03.663909 | 
2026-05-14 10:01:03.668254 | localhost | skipping: Conditional result was False
2026-05-14 10:01:03.683237 | 
2026-05-14 10:01:03.683436 | LOOP [upload-logs : Upload console log and json output]