2026-04-14 00:58:18.178415 | Job console starting
2026-04-14 00:58:18.191749 | Updating git repos
2026-04-14 00:58:18.217421 | Cloning repos into workspace
2026-04-14 00:58:18.530193 | Restoring repo states
2026-04-14 00:58:18.539001 | Merging changes
2026-04-14 00:58:18.991524 | Checking out repos
2026-04-14 00:58:19.027772 | Preparing playbooks
2026-04-14 00:58:20.164497 | Running Ansible setup
2026-04-14 00:58:24.889546 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-14 00:58:25.485955 | 
2026-04-14 00:58:25.486089 | PLAY [localhost]
2026-04-14 00:58:25.493483 | 
2026-04-14 00:58:25.493552 | TASK [Gathering Facts]
2026-04-14 00:58:26.400928 | localhost | ok
2026-04-14 00:58:26.409894 | 
2026-04-14 00:58:26.409981 | TASK [Setup log path fact]
2026-04-14 00:58:26.443017 | localhost | ok
2026-04-14 00:58:26.460692 | 
2026-04-14 00:58:26.460837 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-14 00:58:26.493763 | localhost | ok
2026-04-14 00:58:26.504864 | 
2026-04-14 00:58:26.505013 | TASK [emit-job-header : Print job information]
2026-04-14 00:58:26.547192 | # Job Information
2026-04-14 00:58:26.547509 | Ansible Version: 2.16.16
2026-04-14 00:58:26.547634 | Job: pre-commit
2026-04-14 00:58:26.547676 | Pipeline: check
2026-04-14 00:58:26.547705 | Executor: 0a8996d2b663
2026-04-14 00:58:26.547731 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/109
2026-04-14 00:58:26.547761 | Event ID: eeec5e90-379c-11f1-893a-d9171dbe9bef
2026-04-14 00:58:26.552615 | 
2026-04-14 00:58:26.552703 | LOOP [emit-job-header : Print node information]
2026-04-14 00:58:26.656587 | localhost | ok:
2026-04-14 00:58:26.657120 | localhost | # Node Information
2026-04-14 00:58:26.657166 | localhost | Inventory Hostname: ubuntu-noble
2026-04-14 00:58:26.657278 | localhost | Hostname: np0000165882
2026-04-14 00:58:26.657318 | localhost | Username: zuul
2026-04-14 00:58:26.657346 | localhost | Distro: Ubuntu 24.04
2026-04-14 00:58:26.657368 | localhost | Provider: yul1
2026-04-14 00:58:26.657387 | localhost | Region: ca-ymq-1
2026-04-14 00:58:26.657406 | localhost | Label: ubuntu-noble
2026-04-14 00:58:26.657426 | localhost | Product Name: OpenStack Nova
2026-04-14 00:58:26.657445 | localhost | Interface IP: 199.204.45.132
2026-04-14 00:58:26.671197 | 
2026-04-14 00:58:26.671350 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-14 00:58:27.297403 | localhost -> localhost | changed
2026-04-14 00:58:27.303026 | 
2026-04-14 00:58:27.303098 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-14 00:58:28.257382 | localhost -> localhost | changed
2026-04-14 00:58:28.263979 | 
2026-04-14 00:58:28.264036 | PLAY [all]
2026-04-14 00:58:28.273038 | 
2026-04-14 00:58:28.273109 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-14 00:58:28.905777 | ubuntu-noble -> localhost | ok
2026-04-14 00:58:28.914772 | 
2026-04-14 00:58:28.914846 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-14 00:58:28.946047 | ubuntu-noble | ok
2026-04-14 00:58:28.965886 | ubuntu-noble | included: /var/lib/zuul/builds/f411c6bffb8044a59e5129c4e37a3997/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-14 00:58:28.974911 | 
2026-04-14 00:58:28.975104 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-14 00:58:29.827746 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-04-14 00:58:29.827984 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/f411c6bffb8044a59e5129c4e37a3997/work/f411c6bffb8044a59e5129c4e37a3997_id_rsa
2026-04-14 00:58:29.828030 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/f411c6bffb8044a59e5129c4e37a3997/work/f411c6bffb8044a59e5129c4e37a3997_id_rsa.pub
2026-04-14 00:58:29.828064 | ubuntu-noble -> localhost | The key fingerprint is:
2026-04-14 00:58:29.828096 | ubuntu-noble -> localhost | SHA256:BQKsPas40L1cqXwtLh/9bTQyiDOTa59znYOg96qjWD8 zuul-build-sshkey
2026-04-14 00:58:29.828138 | ubuntu-noble -> localhost | The key's randomart image is:
2026-04-14 00:58:29.828169 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-04-14 00:58:29.828209 | ubuntu-noble -> localhost | |   .... .        |
2026-04-14 00:58:29.828241 | ubuntu-noble -> localhost | |    .  . .       |
2026-04-14 00:58:29.828271 | ubuntu-noble -> localhost | |   o      .      |
2026-04-14 00:58:29.828300 | ubuntu-noble -> localhost | |  . o    .       |
2026-04-14 00:58:29.828329 | ubuntu-noble -> localhost | | . . o +S.       |
2026-04-14 00:58:29.828358 | ubuntu-noble -> localhost | |. . o O.o o o    |
2026-04-14 00:58:29.828387 | ubuntu-noble -> localhost | |.. +.+.B.. * o   |
2026-04-14 00:58:29.828415 | ubuntu-noble -> localhost | |o .o*.E.+oo.=    |
2026-04-14 00:58:29.828448 | ubuntu-noble -> localhost | | .. .B=B+=o...   |
2026-04-14 00:58:29.828477 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-04-14 00:58:29.828541 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.364178
2026-04-14 00:58:29.836437 | 
2026-04-14 00:58:29.836499 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-14 00:58:29.870001 | ubuntu-noble | ok
2026-04-14 00:58:29.883312 | ubuntu-noble | included: /var/lib/zuul/builds/f411c6bffb8044a59e5129c4e37a3997/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-14 00:58:29.898367 | 
2026-04-14 00:58:29.898618 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-14 00:58:29.926378 | ubuntu-noble | skipping: Conditional result was False
2026-04-14 00:58:29.936779 | 
2026-04-14 00:58:30.007226 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-14 00:58:30.540946 | ubuntu-noble | changed
2026-04-14 00:58:30.547345 | 
2026-04-14 00:58:30.547412 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-14 00:58:30.775419 | ubuntu-noble | ok
2026-04-14 00:58:30.798505 | 
2026-04-14 00:58:30.798596 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-14 00:58:31.389575 | ubuntu-noble | changed
2026-04-14 00:58:31.398714 | 
2026-04-14 00:58:31.398844 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-14 00:58:31.967337 | ubuntu-noble | changed
2026-04-14 00:58:31.975228 | 
2026-04-14 00:58:31.975297 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-14 00:58:31.994536 | ubuntu-noble | skipping: Conditional result was False
2026-04-14 00:58:32.004413 | 
2026-04-14 00:58:32.004550 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-14 00:58:32.406831 | ubuntu-noble -> localhost | changed
2026-04-14 00:58:32.432240 | 
2026-04-14 00:58:32.509925 | TASK [add-build-sshkey : Add back temp key]
2026-04-14 00:58:32.847512 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/f411c6bffb8044a59e5129c4e37a3997/work/f411c6bffb8044a59e5129c4e37a3997_id_rsa (zuul-build-sshkey)
2026-04-14 00:58:32.847728 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016041
2026-04-14 00:58:32.853994 | 
2026-04-14 00:58:32.854064 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-14 00:58:33.238878 | ubuntu-noble | ok
2026-04-14 00:58:33.443179 | 
2026-04-14 00:58:33.443274 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-14 00:58:33.468068 | ubuntu-noble | skipping: Conditional result was False
2026-04-14 00:58:33.481071 | 
2026-04-14 00:58:33.481138 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-14 00:58:33.898686 | ubuntu-noble | ok
2026-04-14 00:58:33.909830 | 
2026-04-14 00:58:33.909897 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-14 00:58:34.876851 | ubuntu-noble | Output suppressed because no_log was given
2026-04-14 00:58:34.981397 | 
2026-04-14 00:58:34.981559 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-14 00:58:35.248346 | ubuntu-noble | ok: "logs"
2026-04-14 00:58:35.367112 | ubuntu-noble | ok: All items complete
2026-04-14 00:58:35.367225 | 
2026-04-14 00:58:35.397083 | ubuntu-noble | ok: "artifacts"
2026-04-14 00:58:35.659867 | ubuntu-noble | ok: "docs"
2026-04-14 00:58:35.672337 | 
2026-04-14 00:58:35.672456 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-14 00:58:35.923989 | ubuntu-noble | changed: "logs"
2026-04-14 00:58:36.112795 | ubuntu-noble | changed: "artifacts"
2026-04-14 00:58:36.466913 | ubuntu-noble | changed: "docs"
2026-04-14 00:58:36.486186 | 
2026-04-14 00:58:36.486547 | PLAY RECAP
2026-04-14 00:58:36.486599 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-14 00:58:36.486631 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-14 00:58:36.486651 | 
2026-04-14 00:58:36.707251 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-14 00:58:36.709358 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-14 00:58:37.376904 | 
2026-04-14 00:58:37.377088 | PLAY [all]
2026-04-14 00:58:37.396393 | 
2026-04-14 00:58:37.396481 | TASK [setup-uv : Extract archive]
2026-04-14 00:58:39.784866 | ubuntu-noble | changed
2026-04-14 00:58:39.873006 | 
2026-04-14 00:58:39.954076 | TASK [setup-uv : Print version]
2026-04-14 00:58:39.994250 | ubuntu-noble | uv 0.8.13
2026-04-14 00:58:40.497691 | ubuntu-noble | ok: Runtime: 0:00:00.015687
2026-04-14 00:58:40.504314 | 
2026-04-14 00:58:40.504377 | PLAY RECAP
2026-04-14 00:58:40.504423 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-14 00:58:40.504447 | 
2026-04-14 00:58:40.709224 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-14 00:58:40.710586 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-14 00:58:41.372802 | 
2026-04-14 00:58:41.372965 | PLAY [all]
2026-04-14 00:58:41.396629 | 
2026-04-14 00:58:41.396733 | TASK [Run "pre-commit"]
2026-04-14 00:58:41.790887 | ubuntu-noble | Downloading virtualenv (5.6MiB)
2026-04-14 00:58:41.889275 | ubuntu-noble |  Downloading virtualenv
2026-04-14 00:58:41.902188 | ubuntu-noble | Installed 10 packages in 12ms
2026-04-14 00:58:42.267738 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-14 00:58:42.745169 | 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-04-14 00:58:42.750675 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-04-14 00:58:43.271263 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-04-14 00:58:43.657363 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-04-14 00:58:44.062292 | 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-04-14 00:58:44.063453 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-04-14 00:58:44.638302 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-04-14 00:58:45.155008 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-14 00:58:45.155094 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-14 00:58:45.155104 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-14 00:58:49.052635 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-04-14 00:58:49.052740 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-14 00:58:49.052751 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-14 00:58:53.941881 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-04-14 00:58:53.942590 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-14 00:58:53.942604 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-14 00:58:57.204657 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-04-14 00:58:57.204734 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-14 00:58:57.204744 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-14 00:58:59.860134 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-04-14 00:58:59.860209 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-14 00:58:59.860220 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-14 00:59:10.770458 | ubuntu-noble | fix end of files.........................................................Passed
2026-04-14 00:59:10.837400 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-04-14 00:59:11.111487 | ubuntu-noble | black....................................................................Passed
2026-04-14 00:59:11.300768 | ubuntu-noble | flake8...................................................................Passed
2026-04-14 00:59:11.423247 | ubuntu-noble | isort....................................................................Passed
2026-04-14 00:59:26.579268 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-04-14 00:59:26.682986 | ubuntu-noble | ok: Runtime: 0:00:45.179501
2026-04-14 00:59:26.685220 | 
2026-04-14 00:59:26.685285 | PLAY RECAP
2026-04-14 00:59:26.685345 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-14 00:59:26.685375 | 
2026-04-14 00:59:26.798246 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-14 00:59:26.799594 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-14 00:59:27.439568 | 
2026-04-14 00:59:27.439737 | PLAY [all]
2026-04-14 00:59:27.452101 | 
2026-04-14 00:59:27.452192 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-14 00:59:27.503188 | ubuntu-noble | skipping: Conditional result was False
2026-04-14 00:59:27.509760 | 
2026-04-14 00:59:27.509849 | TASK [fetch-output : Set log path for single node]
2026-04-14 00:59:27.552160 | ubuntu-noble | ok
2026-04-14 00:59:27.557625 | 
2026-04-14 00:59:27.557702 | LOOP [fetch-output : Ensure local output dirs]
2026-04-14 00:59:27.955084 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/f411c6bffb8044a59e5129c4e37a3997/work/logs"
2026-04-14 00:59:28.167740 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/f411c6bffb8044a59e5129c4e37a3997/work/artifacts"
2026-04-14 00:59:28.375877 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/f411c6bffb8044a59e5129c4e37a3997/work/docs"
2026-04-14 00:59:28.392323 | 
2026-04-14 00:59:28.392914 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-14 00:59:29.065139 | ubuntu-noble | changed: .d..t...... ./
2026-04-14 00:59:29.065358 | ubuntu-noble | changed: All items complete
2026-04-14 00:59:29.065386 | 
2026-04-14 00:59:29.546432 | ubuntu-noble | changed: .d..t...... ./
2026-04-14 00:59:30.036749 | ubuntu-noble | changed: .d..t...... ./
2026-04-14 00:59:30.053748 | 
2026-04-14 00:59:30.053882 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-14 00:59:30.483688 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.006379
2026-04-14 00:59:30.708795 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007183
2026-04-14 00:59:30.727620 | 
2026-04-14 00:59:30.727739 | PLAY [all]
2026-04-14 00:59:30.734781 | 
2026-04-14 00:59:30.734851 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-14 00:59:31.241808 | ubuntu-noble | changed
2026-04-14 00:59:31.250073 | 
2026-04-14 00:59:31.250142 | PLAY RECAP
2026-04-14 00:59:31.250204 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-14 00:59:31.250234 | 
2026-04-14 00:59:31.367443 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-14 00:59:31.370236 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-14 00:59:31.958959 | 
2026-04-14 00:59:31.959098 | PLAY [localhost]
2026-04-14 00:59:31.969275 | 
2026-04-14 00:59:31.969350 | TASK [Generate Zuul manifest]
2026-04-14 00:59:31.992563 | localhost | ok
2026-04-14 00:59:32.007931 | 
2026-04-14 00:59:32.008013 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-14 00:59:32.340581 | localhost | changed
2026-04-14 00:59:32.352912 | 
2026-04-14 00:59:32.353060 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-14 00:59:32.386062 | localhost | ok
2026-04-14 00:59:32.397135 | 
2026-04-14 00:59:32.397281 | TASK [Upload logs]
2026-04-14 00:59:32.419704 | localhost | ok
2026-04-14 00:59:32.490182 | 
2026-04-14 00:59:32.490331 | TASK [Set zuul-log-path fact]
2026-04-14 00:59:32.512601 | localhost | ok
2026-04-14 00:59:32.524013 | 
2026-04-14 00:59:32.524083 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-14 00:59:32.560357 | localhost | ok
2026-04-14 00:59:32.571234 | 
2026-04-14 00:59:32.571307 | TASK [upload-logs : Create log directories]
2026-04-14 00:59:32.986492 | localhost | changed
2026-04-14 00:59:32.992874 | 
2026-04-14 00:59:32.992988 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-14 00:59:33.436279 | localhost -> localhost | ok: Runtime: 0:00:00.006075
2026-04-14 00:59:33.441342 | 
2026-04-14 00:59:33.441406 | TASK [upload-logs : Upload logs to log server]
2026-04-14 00:59:33.944907 | localhost | Output suppressed because no_log was given
2026-04-14 00:59:33.948932 | 
2026-04-14 00:59:33.949048 | LOOP [upload-logs : Compress console log and json output]
2026-04-14 00:59:34.012603 | localhost | skipping: Conditional result was False
2026-04-14 00:59:34.019822 | localhost | skipping: Conditional result was False
2026-04-14 00:59:34.032236 | 
2026-04-14 00:59:34.032451 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-14 00:59:34.079636 | localhost | skipping: Conditional result was False
2026-04-14 00:59:34.079886 | 
2026-04-14 00:59:34.084150 | localhost | skipping: Conditional result was False
2026-04-14 00:59:34.100468 | 
2026-04-14 00:59:34.100750 | LOOP [upload-logs : Upload console log and json output]