2026-02-04 13:51:55.591553 | Job console starting
2026-02-04 13:51:55.600959 | Updating git repos
2026-02-04 13:51:55.629015 | Cloning repos into workspace
2026-02-04 13:51:55.672543 | Restoring repo states
2026-02-04 13:51:55.684035 | Merging changes
2026-02-04 13:51:55.937703 | Checking out repos
2026-02-04 13:51:55.970287 | Preparing playbooks
2026-02-04 13:51:57.110114 | Running Ansible setup
2026-02-04 13:52:00.676784 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-04 13:52:01.308393 | 
2026-02-04 13:52:01.308574 | PLAY [localhost]
2026-02-04 13:52:01.317370 | 
2026-02-04 13:52:01.317492 | TASK [Gathering Facts]
2026-02-04 13:52:02.222027 | localhost | ok
2026-02-04 13:52:02.232022 | 
2026-02-04 13:52:02.232109 | TASK [Setup log path fact]
2026-02-04 13:52:02.253222 | localhost | ok
2026-02-04 13:52:02.266098 | 
2026-02-04 13:52:02.266236 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-04 13:52:02.297197 | localhost | ok
2026-02-04 13:52:02.307617 | 
2026-02-04 13:52:02.307776 | TASK [emit-job-header : Print job information]
2026-02-04 13:52:02.358730 | # Job Information
2026-02-04 13:52:02.358926 | Ansible Version: 2.16.15
2026-02-04 13:52:02.358958 | Job: pre-commit
2026-02-04 13:52:02.358979 | Pipeline: check
2026-02-04 13:52:02.358999 | Executor: 3a2793d2bd32
2026-02-04 13:52:02.359018 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/93
2026-02-04 13:52:02.359039 | Event ID: 8df6747e-01d0-11f1-93f2-82fc7d812c5c
2026-02-04 13:52:02.362279 | 
2026-02-04 13:52:02.362365 | LOOP [emit-job-header : Print node information]
2026-02-04 13:52:02.465611 | localhost | ok:
2026-02-04 13:52:02.465930 | localhost | # Node Information
2026-02-04 13:52:02.466004 | localhost | Inventory Hostname: ubuntu-noble
2026-02-04 13:52:02.466057 | localhost | Hostname: np0000154866
2026-02-04 13:52:02.466103 | localhost | Username: zuul
2026-02-04 13:52:02.466153 | localhost | Distro: Ubuntu 24.04
2026-02-04 13:52:02.466197 | localhost | Provider: yul1
2026-02-04 13:52:02.466240 | localhost | Region: ca-ymq-1
2026-02-04 13:52:02.466281 | localhost | Label: ubuntu-noble
2026-02-04 13:52:02.466322 | localhost | Product Name: OpenStack Nova
2026-02-04 13:52:02.466363 | localhost | Interface IP: 199.19.213.216
2026-02-04 13:52:02.483785 | 
2026-02-04 13:52:02.483943 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-04 13:52:02.884891 | localhost -> localhost | changed
2026-02-04 13:52:02.894384 | 
2026-02-04 13:52:02.894458 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-04 13:52:03.810434 | localhost -> localhost | changed
2026-02-04 13:52:03.817079 | 
2026-02-04 13:52:03.817136 | PLAY [all]
2026-02-04 13:52:03.825551 | 
2026-02-04 13:52:03.825617 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-04 13:52:04.211284 | ubuntu-noble -> localhost | ok
2026-02-04 13:52:04.222097 | 
2026-02-04 13:52:04.222208 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-04 13:52:04.257688 | ubuntu-noble | ok
2026-02-04 13:52:04.273217 | ubuntu-noble | included: /var/lib/zuul/builds/b220a3adad8d455bab86798b4960aa58/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-04 13:52:04.279458 | 
2026-02-04 13:52:04.279522 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-04 13:52:05.095627 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-02-04 13:52:05.095845 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/b220a3adad8d455bab86798b4960aa58/work/b220a3adad8d455bab86798b4960aa58_id_rsa
2026-02-04 13:52:05.095890 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/b220a3adad8d455bab86798b4960aa58/work/b220a3adad8d455bab86798b4960aa58_id_rsa.pub
2026-02-04 13:52:05.095923 | ubuntu-noble -> localhost | The key fingerprint is:
2026-02-04 13:52:05.095953 | ubuntu-noble -> localhost | SHA256:2QyRCspXy94EC80cYwiyVO/FKmrUkLzhAJMMb9P4nwk zuul-build-sshkey
2026-02-04 13:52:05.096001 | ubuntu-noble -> localhost | The key's randomart image is:
2026-02-04 13:52:05.096032 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-02-04 13:52:05.096064 | ubuntu-noble -> localhost | |Booo =+...       |
2026-02-04 13:52:05.096095 | ubuntu-noble -> localhost | |=*.o=.B...       |
2026-02-04 13:52:05.096123 | ubuntu-noble -> localhost | |o*=..* B.        |
2026-02-04 13:52:05.096152 | ubuntu-noble -> localhost | |o.Boo B .=       |
2026-02-04 13:52:05.096181 | ubuntu-noble -> localhost | | + +E+ oS o      |
2026-02-04 13:52:05.096209 | ubuntu-noble -> localhost | |. . .o.o.        |
2026-02-04 13:52:05.096236 | ubuntu-noble -> localhost | | o    +          |
2026-02-04 13:52:05.096263 | ubuntu-noble -> localhost | |.                |
2026-02-04 13:52:05.096295 | ubuntu-noble -> localhost | |                 |
2026-02-04 13:52:05.096324 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-02-04 13:52:05.096387 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.293230
2026-02-04 13:52:05.103497 | 
2026-02-04 13:52:05.103564 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-04 13:52:05.124410 | ubuntu-noble | ok
2026-02-04 13:52:05.208125 | ubuntu-noble | included: /var/lib/zuul/builds/b220a3adad8d455bab86798b4960aa58/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-04 13:52:05.217383 | 
2026-02-04 13:52:05.217466 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-04 13:52:05.241589 | ubuntu-noble | skipping: Conditional result was False
2026-02-04 13:52:05.253161 | 
2026-02-04 13:52:05.253274 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-04 13:52:05.859786 | ubuntu-noble | changed
2026-02-04 13:52:05.866431 | 
2026-02-04 13:52:05.866500 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-04 13:52:06.084651 | ubuntu-noble | ok
2026-02-04 13:52:06.090037 | 
2026-02-04 13:52:06.090101 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-04 13:52:06.636348 | ubuntu-noble | changed
2026-02-04 13:52:06.642289 | 
2026-02-04 13:52:06.642357 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-04 13:52:07.175144 | ubuntu-noble | changed
2026-02-04 13:52:07.182297 | 
2026-02-04 13:52:07.182361 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-04 13:52:07.206651 | ubuntu-noble | skipping: Conditional result was False
2026-02-04 13:52:07.218756 | 
2026-02-04 13:52:07.218848 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-04 13:52:07.639414 | ubuntu-noble -> localhost | changed
2026-02-04 13:52:07.657542 | 
2026-02-04 13:52:07.657619 | TASK [add-build-sshkey : Add back temp key]
2026-02-04 13:52:07.954310 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/b220a3adad8d455bab86798b4960aa58/work/b220a3adad8d455bab86798b4960aa58_id_rsa (zuul-build-sshkey)
2026-02-04 13:52:07.954506 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013196
2026-02-04 13:52:07.959822 | 
2026-02-04 13:52:07.959883 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-04 13:52:08.314293 | ubuntu-noble | ok
2026-02-04 13:52:08.323482 | 
2026-02-04 13:52:08.323584 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-04 13:52:08.349179 | ubuntu-noble | skipping: Conditional result was False
2026-02-04 13:52:08.478531 | 
2026-02-04 13:52:08.478686 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-04 13:52:08.883011 | ubuntu-noble | ok
2026-02-04 13:52:08.895403 | 
2026-02-04 13:52:08.895491 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-04 13:52:09.721431 | ubuntu-noble | Output suppressed because no_log was given
2026-02-04 13:52:09.733453 | 
2026-02-04 13:52:09.733541 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-04 13:52:09.970630 | ubuntu-noble | ok: "logs"
2026-02-04 13:52:09.970930 | ubuntu-noble | ok: All items complete
2026-02-04 13:52:09.970987 | 
2026-02-04 13:52:10.169839 | ubuntu-noble | ok: "artifacts"
2026-02-04 13:52:10.424687 | ubuntu-noble | ok: "docs"
2026-02-04 13:52:10.440804 | 
2026-02-04 13:52:10.440953 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-04 13:52:10.666380 | ubuntu-noble | changed: "logs"
2026-02-04 13:52:10.863443 | ubuntu-noble | changed: "artifacts"
2026-02-04 13:52:11.057476 | ubuntu-noble | changed: "docs"
2026-02-04 13:52:11.085836 | 
2026-02-04 13:52:11.086030 | PLAY RECAP
2026-02-04 13:52:11.086113 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-04 13:52:11.086165 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-02-04 13:52:11.086222 | 
2026-02-04 13:52:11.272337 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-04 13:52:11.277982 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-02-04 13:52:11.872911 | 
2026-02-04 13:52:11.873125 | PLAY [all]
2026-02-04 13:52:11.885621 | 
2026-02-04 13:52:11.885704 | TASK [setup-uv : Extract archive]
2026-02-04 13:52:14.329262 | ubuntu-noble | changed
2026-02-04 13:52:14.374794 | 
2026-02-04 13:52:14.374978 | TASK [setup-uv : Print version]
2026-02-04 13:52:13.816425 | ubuntu-noble | uv 0.8.13
2026-02-04 13:52:14.912824 | ubuntu-noble | ok: Runtime: 0:00:00.016669
2026-02-04 13:52:14.920860 | 
2026-02-04 13:52:14.920933 | PLAY RECAP
2026-02-04 13:52:14.921026 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-04 13:52:14.921054 | 
2026-02-04 13:52:15.077485 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-02-04 13:52:15.080155 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-02-04 13:52:15.645984 | 
2026-02-04 13:52:15.646259 | PLAY [all]
2026-02-04 13:52:15.670130 | 
2026-02-04 13:52:15.670234 | TASK [Run "pre-commit"]
2026-02-04 13:52:15.331253 | ubuntu-noble | Downloading virtualenv (5.7MiB)
2026-02-04 13:52:15.429467 | ubuntu-noble |  Downloading virtualenv
2026-02-04 13:52:15.440784 | ubuntu-noble | Installed 9 packages in 10ms
2026-02-04 13:52:15.809217 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-02-04 13:52:16.312194 | 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-02-04 13:52:16.316182 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-02-04 13:52:16.801711 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-02-04 13:52:17.224204 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-02-04 13:52:17.838251 | 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-02-04 13:52:17.840227 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-02-04 13:52:18.360355 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-02-04 13:52:18.866095 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-02-04 13:52:18.866159 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-04 13:52:18.866168 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-04 13:52:22.764103 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-02-04 13:52:22.764173 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-04 13:52:22.764180 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-04 13:52:29.061228 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-02-04 13:52:29.061284 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-04 13:52:29.061290 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-04 13:52:32.403214 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-02-04 13:52:32.403294 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-04 13:52:32.403304 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-04 13:52:34.975620 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-02-04 13:52:34.975670 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-04 13:52:34.975677 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-04 13:52:46.239273 | ubuntu-noble | fix end of files.........................................................Passed
2026-02-04 13:52:46.278777 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-02-04 13:52:46.530205 | ubuntu-noble | black....................................................................Passed
2026-02-04 13:52:46.730819 | ubuntu-noble | flake8...................................................................Passed
2026-02-04 13:52:46.858064 | ubuntu-noble | isort....................................................................Passed
2026-02-04 13:53:05.185503 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-02-04 13:53:05.263944 | ubuntu-noble | ok: Runtime: 0:00:50.085895
2026-02-04 13:53:05.266558 | 
2026-02-04 13:53:05.266679 | PLAY RECAP
2026-02-04 13:53:05.266753 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-04 13:53:05.266786 | 
2026-02-04 13:53:05.404682 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-02-04 13:53:05.407095 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-04 13:53:05.982483 | 
2026-02-04 13:53:05.982634 | PLAY [all]
2026-02-04 13:53:05.994599 | 
2026-02-04 13:53:05.994681 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-04 13:53:06.041153 | ubuntu-noble | skipping: Conditional result was False
2026-02-04 13:53:06.051041 | 
2026-02-04 13:53:06.051150 | TASK [fetch-output : Set log path for single node]
2026-02-04 13:53:06.101189 | ubuntu-noble | ok
2026-02-04 13:53:06.108930 | 
2026-02-04 13:53:06.109089 | LOOP [fetch-output : Ensure local output dirs]
2026-02-04 13:53:06.473708 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/b220a3adad8d455bab86798b4960aa58/work/logs"
2026-02-04 13:53:06.677414 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/b220a3adad8d455bab86798b4960aa58/work/artifacts"
2026-02-04 13:53:06.881133 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/b220a3adad8d455bab86798b4960aa58/work/docs"
2026-02-04 13:53:06.900376 | 
2026-02-04 13:53:06.900523 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-04 13:53:07.522247 | ubuntu-noble | changed: .d..t...... ./
2026-02-04 13:53:07.522566 | ubuntu-noble | changed: All items complete
2026-02-04 13:53:07.522615 | 
2026-02-04 13:53:07.975211 | ubuntu-noble | changed: .d..t...... ./
2026-02-04 13:53:08.417252 | ubuntu-noble | changed: .d..t...... ./
2026-02-04 13:53:08.443071 | 
2026-02-04 13:53:08.443203 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-04 13:53:08.856664 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.006864
2026-02-04 13:53:09.083088 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007871
2026-02-04 13:53:09.101584 | 
2026-02-04 13:53:09.101730 | PLAY [all]
2026-02-04 13:53:09.109359 | 
2026-02-04 13:53:09.109425 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-02-04 13:53:09.581829 | ubuntu-noble | changed
2026-02-04 13:53:09.588034 | 
2026-02-04 13:53:09.588086 | PLAY RECAP
2026-02-04 13:53:09.588137 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-02-04 13:53:09.588158 | 
2026-02-04 13:53:09.727808 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-04 13:53:09.729132 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main]
2026-02-04 13:53:10.274286 | 
2026-02-04 13:53:10.274409 | PLAY [localhost]
2026-02-04 13:53:10.284804 | 
2026-02-04 13:53:10.284878 | TASK [Generate Zuul manifest]
2026-02-04 13:53:10.306065 | localhost | ok
2026-02-04 13:53:10.322969 | 
2026-02-04 13:53:10.323047 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-04 13:53:10.699716 | localhost | changed
2026-02-04 13:53:10.711656 | 
2026-02-04 13:53:10.711731 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-04 13:53:10.746197 | localhost | ok
2026-02-04 13:53:10.753376 | 
2026-02-04 13:53:10.753438 | TASK [Upload logs]
2026-02-04 13:53:10.772683 | localhost | ok
2026-02-04 13:53:10.832066 | 
2026-02-04 13:53:10.832191 | TASK [Set zuul-log-path fact]
2026-02-04 13:53:10.853516 | localhost | ok
2026-02-04 13:53:10.866109 | 
2026-02-04 13:53:10.866179 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-04 13:53:10.898544 | localhost | ok
2026-02-04 13:53:10.905751 | 
2026-02-04 13:53:10.905817 | TASK [upload-logs : Create log directories]
2026-02-04 13:53:11.313175 | localhost | changed
2026-02-04 13:53:11.319406 | 
2026-02-04 13:53:11.319482 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-02-04 13:53:11.718155 | localhost -> localhost | ok: Runtime: 0:00:00.005305
2026-02-04 13:53:11.723784 | 
2026-02-04 13:53:11.723850 | TASK [upload-logs : Upload logs to log server]
2026-02-04 13:53:12.192602 | localhost | Output suppressed because no_log was given
2026-02-04 13:53:12.198830 | 
2026-02-04 13:53:12.198897 | LOOP [upload-logs : Compress console log and json output]
2026-02-04 13:53:12.248951 | localhost | skipping: Conditional result was False
2026-02-04 13:53:12.255265 | localhost | skipping: Conditional result was False
2026-02-04 13:53:12.272927 | 
2026-02-04 13:53:12.273081 | LOOP [upload-logs : Upload compressed console log and json output]
2026-02-04 13:53:12.328276 | localhost | skipping: Conditional result was False
2026-02-04 13:53:12.328555 | 
2026-02-04 13:53:12.332125 | localhost | skipping: Conditional result was False
2026-02-04 13:53:12.350232 | 
2026-02-04 13:53:12.350366 | LOOP [upload-logs : Upload console log and json output]