2026-07-15 00:49:55.628169 | Job console starting
2026-07-15 00:49:55.643624 | Updating git repos
2026-07-15 00:49:55.672992 | Cloning repos into workspace
2026-07-15 00:49:59.887842 | Restoring repo states
2026-07-15 00:49:59.905161 | Merging changes
2026-07-15 00:50:00.756227 | Checking out repos
2026-07-15 00:50:01.031673 | Preparing playbooks
2026-07-15 00:50:17.324788 | Running Ansible setup
2026-07-15 00:50:22.930000 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-15 00:50:23.553476 | 
2026-07-15 00:50:23.553606 | PLAY [localhost]
2026-07-15 00:50:23.561088 | 
2026-07-15 00:50:23.561163 | TASK [Gathering Facts]
2026-07-15 00:50:24.867789 | localhost | ok
2026-07-15 00:50:24.877666 | 
2026-07-15 00:50:24.877772 | TASK [Setup log path fact]
2026-07-15 00:50:24.899882 | localhost | ok
2026-07-15 00:50:24.914316 | 
2026-07-15 00:50:24.914465 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-15 00:50:24.943469 | localhost | ok
2026-07-15 00:50:24.952006 | 
2026-07-15 00:50:24.952105 | TASK [emit-job-header : Print job information]
2026-07-15 00:50:24.991187 | # Job Information
2026-07-15 00:50:24.991383 | Ansible Version: 2.16.18
2026-07-15 00:50:24.991430 | Job: pre-commit
2026-07-15 00:50:24.991462 | Pipeline: check
2026-07-15 00:50:24.991491 | Executor: 2d72f0692154
2026-07-15 00:50:24.991519 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/139
2026-07-15 00:50:24.991554 | Event ID: 4ca5b590-7fe6-11f1-8348-b50f7f188349
2026-07-15 00:50:24.995485 | 
2026-07-15 00:50:24.995570 | LOOP [emit-job-header : Print node information]
2026-07-15 00:50:25.098097 | localhost | ok:
2026-07-15 00:50:25.098528 | localhost | # Node Information
2026-07-15 00:50:25.098560 | localhost | Inventory Hostname: ubuntu-noble
2026-07-15 00:50:25.098583 | localhost | Hostname: np0000185372
2026-07-15 00:50:25.098603 | localhost | Username: zuul
2026-07-15 00:50:25.098626 | localhost | Distro: Ubuntu 24.04
2026-07-15 00:50:25.098646 | localhost | Provider: yul1
2026-07-15 00:50:25.098665 | localhost | Region: ca-ymq-1
2026-07-15 00:50:25.098684 | localhost | Label: ubuntu-noble
2026-07-15 00:50:25.098782 | localhost | Product Name: OpenStack Nova
2026-07-15 00:50:25.098862 | localhost | Interface IP: 199.204.45.235
2026-07-15 00:50:25.114909 | 
2026-07-15 00:50:25.115119 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-15 00:50:25.562945 | localhost -> localhost | changed
2026-07-15 00:50:25.569429 | 
2026-07-15 00:50:25.569504 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-15 00:50:26.436398 | localhost -> localhost | changed
2026-07-15 00:50:26.449163 | 
2026-07-15 00:50:26.449261 | PLAY [all]
2026-07-15 00:50:26.464333 | 
2026-07-15 00:50:26.464455 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-15 00:50:26.766811 | ubuntu-noble -> localhost | ok
2026-07-15 00:50:26.776492 | 
2026-07-15 00:50:26.776568 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-15 00:50:26.808539 | ubuntu-noble | ok
2026-07-15 00:50:26.825731 | ubuntu-noble | included: /var/lib/zuul/builds/eda520f83d794fc3b815ca6a061ef504/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-15 00:50:26.832348 | 
2026-07-15 00:50:26.832413 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-15 00:50:28.083912 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-07-15 00:50:28.084076 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/eda520f83d794fc3b815ca6a061ef504/work/eda520f83d794fc3b815ca6a061ef504_id_rsa
2026-07-15 00:50:28.084109 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/eda520f83d794fc3b815ca6a061ef504/work/eda520f83d794fc3b815ca6a061ef504_id_rsa.pub
2026-07-15 00:50:28.084133 | ubuntu-noble -> localhost | The key fingerprint is:
2026-07-15 00:50:28.084156 | ubuntu-noble -> localhost | SHA256:JB5cH0xb9sId9c75smaLmIdLf/SvECxIFDSF5WYOqDY zuul-build-sshkey
2026-07-15 00:50:28.084188 | ubuntu-noble -> localhost | The key's randomart image is:
2026-07-15 00:50:28.084210 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-07-15 00:50:28.084233 | ubuntu-noble -> localhost | |       .*B= o ...|
2026-07-15 00:50:28.084255 | ubuntu-noble -> localhost | |     . +.+.* o ..|
2026-07-15 00:50:28.084276 | ubuntu-noble -> localhost | |      = + * o o .|
2026-07-15 00:50:28.084297 | ubuntu-noble -> localhost | |     o = * . . o.|
2026-07-15 00:50:28.084318 | ubuntu-noble -> localhost | |    E . S o o  .o|
2026-07-15 00:50:28.084339 | ubuntu-noble -> localhost | |   . .     . .. .|
2026-07-15 00:50:28.084360 | ubuntu-noble -> localhost | |          .......|
2026-07-15 00:50:28.084380 | ubuntu-noble -> localhost | |         ..+.o+o.|
2026-07-15 00:50:28.084404 | ubuntu-noble -> localhost | |          +oo++oo|
2026-07-15 00:50:28.084425 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-07-15 00:50:28.084472 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.846590
2026-07-15 00:50:28.090085 | 
2026-07-15 00:50:28.090152 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-15 00:50:28.122509 | ubuntu-noble | ok
2026-07-15 00:50:28.135436 | ubuntu-noble | included: /var/lib/zuul/builds/eda520f83d794fc3b815ca6a061ef504/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-15 00:50:28.178827 | 
2026-07-15 00:50:28.178896 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-15 00:50:28.203036 | ubuntu-noble | skipping: Conditional result was False
2026-07-15 00:50:28.212850 | 
2026-07-15 00:50:28.213018 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-15 00:50:28.730795 | ubuntu-noble | changed
2026-07-15 00:50:28.736548 | 
2026-07-15 00:50:28.736618 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-15 00:50:28.998069 | ubuntu-noble | ok
2026-07-15 00:50:29.017950 | 
2026-07-15 00:50:29.018156 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-15 00:50:29.589941 | ubuntu-noble | changed
2026-07-15 00:50:29.598469 | 
2026-07-15 00:50:29.598562 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-15 00:50:30.151846 | ubuntu-noble | changed
2026-07-15 00:50:30.159981 | 
2026-07-15 00:50:30.160044 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-15 00:50:30.182871 | ubuntu-noble | skipping: Conditional result was False
2026-07-15 00:50:30.192556 | 
2026-07-15 00:50:30.192655 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-15 00:50:30.584030 | ubuntu-noble -> localhost | changed
2026-07-15 00:50:30.597059 | 
2026-07-15 00:50:30.597130 | TASK [add-build-sshkey : Add back temp key]
2026-07-15 00:50:30.864177 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/eda520f83d794fc3b815ca6a061ef504/work/eda520f83d794fc3b815ca6a061ef504_id_rsa (zuul-build-sshkey)
2026-07-15 00:50:30.864393 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013141
2026-07-15 00:50:30.871547 | 
2026-07-15 00:50:30.871629 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-15 00:50:31.228079 | ubuntu-noble | ok
2026-07-15 00:50:31.233619 | 
2026-07-15 00:50:31.233688 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-15 00:50:31.257710 | ubuntu-noble | skipping: Conditional result was False
2026-07-15 00:50:31.274418 | 
2026-07-15 00:50:31.274528 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-15 00:50:31.642480 | ubuntu-noble | ok
2026-07-15 00:50:31.682683 | 
2026-07-15 00:50:31.682809 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-15 00:50:32.540302 | ubuntu-noble | Output suppressed because no_log was given
2026-07-15 00:50:32.550615 | 
2026-07-15 00:50:32.550678 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-15 00:50:32.777239 | ubuntu-noble | ok: "logs"
2026-07-15 00:50:32.777515 | ubuntu-noble | ok: All items complete
2026-07-15 00:50:32.777569 | 
2026-07-15 00:50:32.970206 | ubuntu-noble | ok: "artifacts"
2026-07-15 00:50:33.173177 | ubuntu-noble | ok: "docs"
2026-07-15 00:50:33.190807 | 
2026-07-15 00:50:33.190943 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-15 00:50:33.411726 | ubuntu-noble | changed: "logs"
2026-07-15 00:50:33.609429 | ubuntu-noble | changed: "artifacts"
2026-07-15 00:50:33.802611 | ubuntu-noble | changed: "docs"
2026-07-15 00:50:33.819045 | 
2026-07-15 00:50:33.819145 | PLAY RECAP
2026-07-15 00:50:33.819189 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-15 00:50:33.819220 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-15 00:50:33.819242 | 
2026-07-15 00:50:33.973060 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-15 00:50:33.975085 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-07-15 00:50:34.556290 | 
2026-07-15 00:50:34.556422 | PLAY [all]
2026-07-15 00:50:34.569046 | 
2026-07-15 00:50:34.569130 | TASK [setup-uv : Extract archive]
2026-07-15 00:50:37.049707 | ubuntu-noble | changed
2026-07-15 00:50:37.059811 | 
2026-07-15 00:50:37.060019 | TASK [setup-uv : Print version]
2026-07-15 00:50:37.447253 | ubuntu-noble | uv 0.8.13
2026-07-15 00:50:37.612089 | ubuntu-noble | ok: Runtime: 0:00:00.014925
2026-07-15 00:50:37.620653 | 
2026-07-15 00:50:37.620754 | PLAY RECAP
2026-07-15 00:50:37.620801 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-15 00:50:37.620826 | 
2026-07-15 00:50:37.784121 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-07-15 00:50:37.785205 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-07-15 00:50:38.414260 | 
2026-07-15 00:50:38.414389 | PLAY [all]
2026-07-15 00:50:38.426049 | 
2026-07-15 00:50:38.426126 | TASK [Run "pre-commit"]
2026-07-15 00:50:39.246985 | ubuntu-noble | Downloading virtualenv (5.3MiB)
2026-07-15 00:50:39.335282 | ubuntu-noble |  Downloading virtualenv
2026-07-15 00:50:39.347872 | ubuntu-noble | Installed 10 packages in 11ms
2026-07-15 00:50:39.714723 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-07-15 00:50:40.204996 | 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-07-15 00:50:40.210864 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-07-15 00:50:40.751044 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-07-15 00:50:41.154276 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-07-15 00:50:41.602380 | 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-07-15 00:50:41.603196 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-07-15 00:50:42.128246 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-07-15 00:50:42.650020 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-07-15 00:50:42.650103 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-07-15 00:50:42.650109 | ubuntu-noble | [INFO] This may take a few minutes...
2026-07-15 00:50:47.222138 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-07-15 00:50:47.222273 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-07-15 00:50:47.222284 | ubuntu-noble | [INFO] This may take a few minutes...
2026-07-15 00:50:52.205206 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-07-15 00:50:52.205390 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-07-15 00:50:52.205407 | ubuntu-noble | [INFO] This may take a few minutes...
2026-07-15 00:50:55.743046 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-07-15 00:50:55.743135 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-07-15 00:50:55.743146 | ubuntu-noble | [INFO] This may take a few minutes...
2026-07-15 00:50:58.559599 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-07-15 00:50:58.559680 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-07-15 00:50:58.559699 | ubuntu-noble | [INFO] This may take a few minutes...
2026-07-15 00:51:11.853250 | ubuntu-noble | fix end of files.........................................................Passed
2026-07-15 00:51:11.908071 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-07-15 00:51:12.186883 | ubuntu-noble | black....................................................................Passed
2026-07-15 00:51:12.379816 | ubuntu-noble | flake8...................................................................Passed
2026-07-15 00:51:12.502237 | ubuntu-noble | isort....................................................................Passed
2026-07-15 00:51:33.315444 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-07-15 00:51:33.505216 | ubuntu-noble | ok: Runtime: 0:00:54.569319
2026-07-15 00:51:33.507691 | 
2026-07-15 00:51:33.507741 | PLAY RECAP
2026-07-15 00:51:33.507783 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-15 00:51:33.507806 | 
2026-07-15 00:51:33.634256 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-07-15 00:51:33.647039 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-15 00:51:34.262434 | 
2026-07-15 00:51:34.262553 | PLAY [all]
2026-07-15 00:51:34.274294 | 
2026-07-15 00:51:34.274375 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-15 00:51:34.319201 | ubuntu-noble | skipping: Conditional result was False
2026-07-15 00:51:34.328154 | 
2026-07-15 00:51:34.328259 | TASK [fetch-output : Set log path for single node]
2026-07-15 00:51:34.360464 | ubuntu-noble | ok
2026-07-15 00:51:34.366421 | 
2026-07-15 00:51:34.366512 | LOOP [fetch-output : Ensure local output dirs]
2026-07-15 00:51:34.795306 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/eda520f83d794fc3b815ca6a061ef504/work/logs"
2026-07-15 00:51:35.015474 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/eda520f83d794fc3b815ca6a061ef504/work/artifacts"
2026-07-15 00:51:35.256179 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/eda520f83d794fc3b815ca6a061ef504/work/docs"
2026-07-15 00:51:35.274861 | 
2026-07-15 00:51:35.274975 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-15 00:51:35.928002 | ubuntu-noble | ok
2026-07-15 00:51:35.928265 | ubuntu-noble | changed: All items complete
2026-07-15 00:51:35.928308 | 
2026-07-15 00:51:36.432826 | ubuntu-noble | changed: .d..t...... ./
2026-07-15 00:51:36.931792 | ubuntu-noble | changed: .d..t...... ./
2026-07-15 00:51:36.963946 | 
2026-07-15 00:51:36.964122 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-15 00:51:37.418705 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007592
2026-07-15 00:51:37.655851 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.005994
2026-07-15 00:51:37.678709 | 
2026-07-15 00:51:37.678766 | PLAY [all]
2026-07-15 00:51:37.687636 | 
2026-07-15 00:51:37.687722 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-15 00:51:38.205412 | ubuntu-noble | changed
2026-07-15 00:51:38.211224 | 
2026-07-15 00:51:38.211277 | PLAY RECAP
2026-07-15 00:51:38.211321 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-15 00:51:38.211343 | 
2026-07-15 00:51:38.424782 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-15 00:51:38.446419 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-15 00:51:39.106725 | 
2026-07-15 00:51:39.106848 | PLAY [localhost]
2026-07-15 00:51:39.118761 | 
2026-07-15 00:51:39.130959 | TASK [Generate Zuul manifest]
2026-07-15 00:51:39.161751 | localhost | ok
2026-07-15 00:51:39.181429 | 
2026-07-15 00:51:39.181518 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-15 00:51:39.798972 | localhost | changed
2026-07-15 00:51:39.810882 | 
2026-07-15 00:51:39.810961 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-15 00:51:39.861553 | localhost | ok
2026-07-15 00:51:39.870738 | 
2026-07-15 00:51:39.870804 | TASK [Upload logs]
2026-07-15 00:51:39.892156 | localhost | ok
2026-07-15 00:51:39.948752 | 
2026-07-15 00:51:39.948875 | TASK [Set zuul-log-path fact]
2026-07-15 00:51:39.969883 | localhost | ok
2026-07-15 00:51:39.980943 | 
2026-07-15 00:51:39.981027 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-15 00:51:40.011328 | localhost | ok
2026-07-15 00:51:40.020105 | 
2026-07-15 00:51:40.020168 | TASK [upload-logs : Create log directories]
2026-07-15 00:51:40.523260 | localhost | changed
2026-07-15 00:51:40.527815 | 
2026-07-15 00:51:40.527897 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-15 00:51:40.929983 | localhost -> localhost | ok: Runtime: 0:00:00.005706
2026-07-15 00:51:40.934748 | 
2026-07-15 00:51:40.934810 | TASK [upload-logs : Upload logs to log server]
2026-07-15 00:51:41.523931 | localhost | Output suppressed because no_log was given
2026-07-15 00:51:41.528315 | 
2026-07-15 00:51:41.528381 | LOOP [upload-logs : Compress console log and json output]
2026-07-15 00:51:41.571385 | localhost | skipping: Conditional result was False
2026-07-15 00:51:41.579714 | localhost | skipping: Conditional result was False
2026-07-15 00:51:41.588308 | 
2026-07-15 00:51:41.588427 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-15 00:51:41.627521 | localhost | skipping: Conditional result was False
2026-07-15 00:51:41.662582 | 
2026-07-15 00:51:41.664438 | localhost | skipping: Conditional result was False
2026-07-15 00:51:41.685166 | 
2026-07-15 00:51:41.724482 | LOOP [upload-logs : Upload console log and json output]