2026-04-15 00:58:50.883599 | Job console starting
2026-04-15 00:58:50.906771 | Updating git repos
2026-04-15 00:58:50.930022 | Cloning repos into workspace
2026-04-15 00:58:52.926313 | Restoring repo states
2026-04-15 00:58:52.936258 | Merging changes
2026-04-15 00:58:53.527495 | Checking out repos
2026-04-15 00:58:53.863028 | Preparing playbooks
2026-04-15 00:59:08.883598 | Running Ansible setup
2026-04-15 00:59:13.334820 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-15 00:59:13.985302 | 
2026-04-15 00:59:14.190910 | PLAY [localhost]
2026-04-15 00:59:14.206747 | 
2026-04-15 00:59:14.206953 | TASK [Gathering Facts]
2026-04-15 00:59:15.166948 | localhost | ok
2026-04-15 00:59:15.176474 | 
2026-04-15 00:59:15.176582 | TASK [Setup log path fact]
2026-04-15 00:59:15.193538 | localhost | ok
2026-04-15 00:59:15.205329 | 
2026-04-15 00:59:15.205433 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-15 00:59:15.246241 | localhost | ok
2026-04-15 00:59:15.257512 | 
2026-04-15 00:59:15.257603 | TASK [emit-job-header : Print job information]
2026-04-15 00:59:15.291018 | # Job Information
2026-04-15 00:59:15.291193 | Ansible Version: 2.16.16
2026-04-15 00:59:15.291239 | Job: pre-commit
2026-04-15 00:59:15.291270 | Pipeline: check
2026-04-15 00:59:15.291297 | Executor: 0a8996d2b663
2026-04-15 00:59:15.291345 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/102
2026-04-15 00:59:15.291378 | Event ID: 24745760-3866-11f1-9631-53252c2f9552
2026-04-15 00:59:15.297277 | 
2026-04-15 00:59:15.297342 | LOOP [emit-job-header : Print node information]
2026-04-15 00:59:15.392781 | localhost | ok:
2026-04-15 00:59:15.393149 | localhost | # Node Information
2026-04-15 00:59:15.393206 | localhost | Inventory Hostname: ubuntu-noble
2026-04-15 00:59:15.393242 | localhost | Hostname: np0000166316
2026-04-15 00:59:15.393276 | localhost | Username: zuul
2026-04-15 00:59:15.393310 | localhost | Distro: Ubuntu 24.04
2026-04-15 00:59:15.393341 | localhost | Provider: yul1
2026-04-15 00:59:15.393370 | localhost | Region: ca-ymq-1
2026-04-15 00:59:15.393398 | localhost | Label: ubuntu-noble
2026-04-15 00:59:15.393426 | localhost | Product Name: OpenStack Nova
2026-04-15 00:59:15.393455 | localhost | Interface IP: 199.204.45.23
2026-04-15 00:59:15.408907 | 
2026-04-15 00:59:15.409468 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-15 00:59:15.848069 | localhost -> localhost | changed
2026-04-15 00:59:15.853427 | 
2026-04-15 00:59:15.853495 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-15 00:59:16.655223 | localhost -> localhost | changed
2026-04-15 00:59:16.660729 | 
2026-04-15 00:59:16.660785 | PLAY [all]
2026-04-15 00:59:16.668605 | 
2026-04-15 00:59:16.668669 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-15 00:59:16.884088 | ubuntu-noble -> localhost | ok
2026-04-15 00:59:16.891503 | 
2026-04-15 00:59:16.891591 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-15 00:59:16.912730 | ubuntu-noble | ok
2026-04-15 00:59:16.925648 | ubuntu-noble | included: /var/lib/zuul/builds/a797f1dceb174aecbf9c8814d04f81fa/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-15 00:59:16.931512 | 
2026-04-15 00:59:16.931571 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-15 00:59:18.081159 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-04-15 00:59:18.081313 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a797f1dceb174aecbf9c8814d04f81fa/work/a797f1dceb174aecbf9c8814d04f81fa_id_rsa
2026-04-15 00:59:18.081345 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a797f1dceb174aecbf9c8814d04f81fa/work/a797f1dceb174aecbf9c8814d04f81fa_id_rsa.pub
2026-04-15 00:59:18.081369 | ubuntu-noble -> localhost | The key fingerprint is:
2026-04-15 00:59:18.081391 | ubuntu-noble -> localhost | SHA256:QWrcVh+tVinWuUESnPkwU1ozSwVHL4q3TU+AKV1SJaE zuul-build-sshkey
2026-04-15 00:59:18.081420 | ubuntu-noble -> localhost | The key's randomart image is:
2026-04-15 00:59:18.081442 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-04-15 00:59:18.081465 | ubuntu-noble -> localhost | |        . ..=X&O=|
2026-04-15 00:59:18.081486 | ubuntu-noble -> localhost | |     . + . oX%B*.|
2026-04-15 00:59:18.081506 | ubuntu-noble -> localhost | |      + + ..EO+o.|
2026-04-15 00:59:18.081526 | ubuntu-noble -> localhost | |     . . . oo.oo |
2026-04-15 00:59:18.081546 | ubuntu-noble -> localhost | |        S ..o . .|
2026-04-15 00:59:18.081566 | ubuntu-noble -> localhost | |           . + o |
2026-04-15 00:59:18.081585 | ubuntu-noble -> localhost | |            . . .|
2026-04-15 00:59:18.081604 | ubuntu-noble -> localhost | |                 |
2026-04-15 00:59:18.081626 | ubuntu-noble -> localhost | |                 |
2026-04-15 00:59:18.081645 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-04-15 00:59:18.081688 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.673068
2026-04-15 00:59:18.087078 | 
2026-04-15 00:59:18.087139 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-15 00:59:18.126984 | ubuntu-noble | ok
2026-04-15 00:59:18.135841 | ubuntu-noble | included: /var/lib/zuul/builds/a797f1dceb174aecbf9c8814d04f81fa/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-15 00:59:18.143675 | 
2026-04-15 00:59:18.143740 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-15 00:59:18.171054 | ubuntu-noble | skipping: Conditional result was False
2026-04-15 00:59:18.177037 | 
2026-04-15 00:59:18.177101 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-15 00:59:18.770943 | ubuntu-noble | changed
2026-04-15 00:59:18.777971 | 
2026-04-15 00:59:18.778035 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-15 00:59:19.005043 | ubuntu-noble | ok
2026-04-15 00:59:19.011391 | 
2026-04-15 00:59:19.011457 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-15 00:59:19.569338 | ubuntu-noble | changed
2026-04-15 00:59:19.576277 | 
2026-04-15 00:59:19.576346 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-15 00:59:20.143164 | ubuntu-noble | changed
2026-04-15 00:59:20.416341 | 
2026-04-15 00:59:20.416483 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-15 00:59:20.431903 | ubuntu-noble | skipping: Conditional result was False
2026-04-15 00:59:20.438378 | 
2026-04-15 00:59:20.438465 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-15 00:59:20.869291 | ubuntu-noble -> localhost | changed
2026-04-15 00:59:20.880738 | 
2026-04-15 00:59:20.880821 | TASK [add-build-sshkey : Add back temp key]
2026-04-15 00:59:21.595539 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a797f1dceb174aecbf9c8814d04f81fa/work/a797f1dceb174aecbf9c8814d04f81fa_id_rsa (zuul-build-sshkey)
2026-04-15 00:59:21.595722 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013868
2026-04-15 00:59:21.607663 | 
2026-04-15 00:59:21.607770 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-15 00:59:21.962598 | ubuntu-noble | ok
2026-04-15 00:59:21.967785 | 
2026-04-15 00:59:21.967852 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-15 00:59:22.007374 | ubuntu-noble | skipping: Conditional result was False
2026-04-15 00:59:22.019685 | 
2026-04-15 00:59:22.019790 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-15 00:59:22.427467 | ubuntu-noble | ok
2026-04-15 00:59:22.467270 | 
2026-04-15 00:59:22.467384 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-15 00:59:23.395165 | ubuntu-noble | Output suppressed because no_log was given
2026-04-15 00:59:23.507954 | 
2026-04-15 00:59:23.508126 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-15 00:59:23.807115 | ubuntu-noble | ok: "logs"
2026-04-15 00:59:23.873486 | ubuntu-noble | ok: All items complete
2026-04-15 00:59:23.873586 | 
2026-04-15 00:59:23.929195 | ubuntu-noble | ok: "artifacts"
2026-04-15 00:59:24.197970 | ubuntu-noble | ok: "docs"
2026-04-15 00:59:24.214406 | 
2026-04-15 00:59:24.214543 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-15 00:59:24.462913 | ubuntu-noble | changed: "logs"
2026-04-15 00:59:24.657605 | ubuntu-noble | changed: "artifacts"
2026-04-15 00:59:24.849072 | ubuntu-noble | changed: "docs"
2026-04-15 00:59:24.871954 | 
2026-04-15 00:59:24.872072 | PLAY RECAP
2026-04-15 00:59:24.872144 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-15 00:59:24.872193 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-15 00:59:24.872227 | 
2026-04-15 00:59:25.095161 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-15 00:59:25.098444 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-15 00:59:25.759277 | 
2026-04-15 00:59:25.759600 | PLAY [all]
2026-04-15 00:59:25.773555 | 
2026-04-15 00:59:25.773722 | TASK [setup-uv : Extract archive]
2026-04-15 00:59:28.209079 | ubuntu-noble | changed
2026-04-15 00:59:28.216362 | 
2026-04-15 00:59:28.216976 | TASK [setup-uv : Print version]
2026-04-15 00:59:28.562312 | ubuntu-noble | uv 0.8.13
2026-04-15 00:59:28.802253 | ubuntu-noble | ok: Runtime: 0:00:00.015048
2026-04-15 00:59:28.809019 | 
2026-04-15 00:59:28.809090 | PLAY RECAP
2026-04-15 00:59:28.809135 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-15 00:59:28.809161 | 
2026-04-15 00:59:28.946762 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-15 00:59:28.959013 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-15 00:59:29.652378 | 
2026-04-15 00:59:29.652506 | PLAY [all]
2026-04-15 00:59:29.666017 | 
2026-04-15 00:59:29.666120 | TASK [Run "pre-commit"]
2026-04-15 00:59:30.299307 | ubuntu-noble | Downloading virtualenv (5.6MiB)
2026-04-15 00:59:30.391780 | ubuntu-noble |  Downloading virtualenv
2026-04-15 00:59:30.408592 | ubuntu-noble | Installed 10 packages in 16ms
2026-04-15 00:59:30.785330 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-15 00:59:31.321501 | 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-15 00:59:31.327505 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-04-15 00:59:31.972094 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-04-15 00:59:32.367733 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-04-15 00:59:32.790558 | 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-15 00:59:32.792516 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-04-15 00:59:33.322388 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-04-15 00:59:33.880123 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-15 00:59:33.880186 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-15 00:59:33.880203 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-15 00:59:37.912340 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-04-15 00:59:37.912435 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-15 00:59:37.912446 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-15 00:59:43.191321 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-04-15 00:59:43.191412 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-15 00:59:43.191425 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-15 00:59:46.529345 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-04-15 00:59:46.529419 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-15 00:59:46.529424 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-15 00:59:49.287590 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-04-15 00:59:49.287705 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-15 00:59:49.287718 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-15 01:00:00.065939 | ubuntu-noble | fix end of files.........................................................Passed
2026-04-15 01:00:00.126085 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-04-15 01:00:00.393809 | ubuntu-noble | black....................................................................Passed
2026-04-15 01:00:00.581388 | ubuntu-noble | flake8...................................................................Passed
2026-04-15 01:00:00.709261 | ubuntu-noble | isort....................................................................Passed
2026-04-15 01:00:17.577858 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-04-15 01:00:17.727317 | ubuntu-noble | ok: Runtime: 0:00:47.649605
2026-04-15 01:00:17.729217 | 
2026-04-15 01:00:17.729262 | PLAY RECAP
2026-04-15 01:00:17.729359 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-15 01:00:17.729385 | 
2026-04-15 01:00:17.848122 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-15 01:00:17.849654 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-15 01:00:18.424532 | 
2026-04-15 01:00:18.658627 | PLAY [all]
2026-04-15 01:00:18.673627 | 
2026-04-15 01:00:18.673756 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-15 01:00:18.739461 | ubuntu-noble | skipping: Conditional result was False
2026-04-15 01:00:18.750616 | 
2026-04-15 01:00:18.750804 | TASK [fetch-output : Set log path for single node]
2026-04-15 01:00:18.815179 | ubuntu-noble | ok
2026-04-15 01:00:18.822680 | 
2026-04-15 01:00:18.822778 | LOOP [fetch-output : Ensure local output dirs]
2026-04-15 01:00:19.256808 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/a797f1dceb174aecbf9c8814d04f81fa/work/logs"
2026-04-15 01:00:19.473772 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/a797f1dceb174aecbf9c8814d04f81fa/work/artifacts"
2026-04-15 01:00:19.826975 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/a797f1dceb174aecbf9c8814d04f81fa/work/docs"
2026-04-15 01:00:19.835986 | 
2026-04-15 01:00:19.836299 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-15 01:00:20.541558 | ubuntu-noble | ok
2026-04-15 01:00:20.541833 | ubuntu-noble | changed: All items complete
2026-04-15 01:00:20.541875 | 
2026-04-15 01:00:21.145661 | ubuntu-noble | changed: .d..t...... ./
2026-04-15 01:00:21.611516 | ubuntu-noble | changed: .d..t...... ./
2026-04-15 01:00:21.645686 | 
2026-04-15 01:00:21.645854 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-15 01:00:22.170945 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007294
2026-04-15 01:00:22.401768 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.006048
2026-04-15 01:00:22.429010 | 
2026-04-15 01:00:22.429120 | PLAY [all]
2026-04-15 01:00:22.435436 | 
2026-04-15 01:00:22.435500 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-15 01:00:22.953202 | ubuntu-noble | changed
2026-04-15 01:00:22.959109 | 
2026-04-15 01:00:22.959161 | PLAY RECAP
2026-04-15 01:00:22.959207 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-15 01:00:22.959230 | 
2026-04-15 01:00:23.079080 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-15 01:00:23.374593 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-15 01:00:23.982403 | 
2026-04-15 01:00:23.982560 | PLAY [localhost]
2026-04-15 01:00:23.995513 | 
2026-04-15 01:00:23.995635 | TASK [Generate Zuul manifest]
2026-04-15 01:00:24.016060 | localhost | ok
2026-04-15 01:00:24.031628 | 
2026-04-15 01:00:24.031710 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-15 01:00:24.399155 | localhost | changed
2026-04-15 01:00:24.411387 | 
2026-04-15 01:00:24.411469 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-15 01:00:24.442656 | localhost | ok
2026-04-15 01:00:24.449278 | 
2026-04-15 01:00:24.449346 | TASK [Upload logs]
2026-04-15 01:00:24.471714 | localhost | ok
2026-04-15 01:00:24.546842 | 
2026-04-15 01:00:24.547052 | TASK [Set zuul-log-path fact]
2026-04-15 01:00:24.570044 | localhost | ok
2026-04-15 01:00:24.586772 | 
2026-04-15 01:00:24.586891 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-15 01:00:24.631317 | localhost | ok
2026-04-15 01:00:24.832789 | 
2026-04-15 01:00:24.833089 | TASK [upload-logs : Create log directories]
2026-04-15 01:00:25.248753 | localhost | changed
2026-04-15 01:00:25.257002 | 
2026-04-15 01:00:25.257095 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-15 01:00:26.099716 | localhost -> localhost | ok: Runtime: 0:00:00.005745
2026-04-15 01:00:26.105307 | 
2026-04-15 01:00:26.105371 | TASK [upload-logs : Upload logs to log server]
2026-04-15 01:00:26.572410 | localhost | Output suppressed because no_log was given
2026-04-15 01:00:26.575902 | 
2026-04-15 01:00:26.575965 | LOOP [upload-logs : Compress console log and json output]
2026-04-15 01:00:26.636352 | localhost | skipping: Conditional result was False
2026-04-15 01:00:26.644052 | localhost | skipping: Conditional result was False
2026-04-15 01:00:26.654462 | 
2026-04-15 01:00:26.654547 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-15 01:00:26.695824 | localhost | skipping: Conditional result was False
2026-04-15 01:00:26.696051 | 
2026-04-15 01:00:26.700843 | localhost | skipping: Conditional result was False
2026-04-15 01:00:26.714845 | 
2026-04-15 01:00:26.714951 | LOOP [upload-logs : Upload console log and json output]