2026-09-17 00:57:43.490773 | Job console starting
2026-09-17 00:57:43.499856 | Updating git repos
2026-09-17 00:57:43.522768 | Cloning repos into workspace
2026-09-17 00:57:43.579656 | Restoring repo states
2026-09-17 00:57:43.591443 | Merging changes
2026-09-17 00:57:44.271035 | Checking out repos
2026-09-17 00:57:44.314464 | Preparing playbooks
2026-09-17 00:57:45.576302 | Running Ansible setup
2026-09-17 00:57:49.285378 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-17 00:57:49.895995 | 
2026-09-17 00:57:49.971606 | PLAY [localhost]
2026-09-17 00:57:49.988767 | 
2026-09-17 00:57:49.988907 | TASK [Gathering Facts]
2026-09-17 00:57:50.920418 | localhost | ok
2026-09-17 00:57:50.927285 | 
2026-09-17 00:57:50.927369 | TASK [Setup log path fact]
2026-09-17 00:57:50.945790 | localhost | ok
2026-09-17 00:57:50.955718 | 
2026-09-17 00:57:50.955786 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-17 00:57:50.985051 | localhost | ok
2026-09-17 00:57:50.993326 | 
2026-09-17 00:57:50.993531 | TASK [emit-job-header : Print job information]
2026-09-17 00:57:51.044627 | # Job Information
2026-09-17 00:57:51.044869 | Ansible Version: 2.16.18
2026-09-17 00:57:51.044909 | Job: pre-commit
2026-09-17 00:57:51.044936 | Pipeline: check
2026-09-17 00:57:51.044959 | Executor: 2d72f0692154
2026-09-17 00:57:51.044983 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/149
2026-09-17 00:57:51.045011 | Event ID: fdcba780-b231-11f1-9399-d3d30f48488d
2026-09-17 00:57:51.048756 | 
2026-09-17 00:57:51.048843 | LOOP [emit-job-header : Print node information]
2026-09-17 00:57:51.152612 | localhost | ok:
2026-09-17 00:57:51.152884 | localhost | # Node Information
2026-09-17 00:57:51.152938 | localhost | Inventory Hostname: ubuntu-noble
2026-09-17 00:57:51.152980 | localhost | Hostname: np0000192976
2026-09-17 00:57:51.153019 | localhost | Username: zuul
2026-09-17 00:57:51.153062 | localhost | Distro: Ubuntu 24.04
2026-09-17 00:57:51.153099 | localhost | Provider: yul1
2026-09-17 00:57:51.153137 | localhost | Region: ca-ymq-1
2026-09-17 00:57:51.153174 | localhost | Label: ubuntu-noble
2026-09-17 00:57:51.153210 | localhost | Product Name: OpenStack Nova
2026-09-17 00:57:51.153245 | localhost | Interface IP: 162.253.55.241
2026-09-17 00:57:51.169653 | 
2026-09-17 00:57:51.169948 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-17 00:57:51.582408 | localhost -> localhost | changed
2026-09-17 00:57:51.590284 | 
2026-09-17 00:57:51.590380 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-17 00:57:52.524995 | localhost -> localhost | changed
2026-09-17 00:57:52.537900 | 
2026-09-17 00:57:52.538010 | PLAY [all]
2026-09-17 00:57:52.553606 | 
2026-09-17 00:57:52.553743 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-17 00:57:52.802487 | ubuntu-noble -> localhost | ok
2026-09-17 00:57:52.807933 | 
2026-09-17 00:57:52.807996 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-17 00:57:52.836720 | ubuntu-noble | ok
2026-09-17 00:57:52.850332 | ubuntu-noble | included: /var/lib/zuul/builds/77f5e273e2ea4ec3a8fbaebc1236887d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-17 00:57:52.855604 | 
2026-09-17 00:57:52.855659 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-17 00:57:54.430546 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-09-17 00:57:54.430706 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/77f5e273e2ea4ec3a8fbaebc1236887d/work/77f5e273e2ea4ec3a8fbaebc1236887d_id_rsa
2026-09-17 00:57:54.430734 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/77f5e273e2ea4ec3a8fbaebc1236887d/work/77f5e273e2ea4ec3a8fbaebc1236887d_id_rsa.pub
2026-09-17 00:57:54.430754 | ubuntu-noble -> localhost | The key fingerprint is:
2026-09-17 00:57:54.430774 | ubuntu-noble -> localhost | SHA256:iMmcSXaC8wSyvm+80OZLbiHWtjkLgeJddaMXihLpj9o zuul-build-sshkey
2026-09-17 00:57:54.430804 | ubuntu-noble -> localhost | The key's randomart image is:
2026-09-17 00:57:54.430823 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-09-17 00:57:54.430847 | ubuntu-noble -> localhost | |. .              |
2026-09-17 00:57:54.430867 | ubuntu-noble -> localhost | | o o.            |
2026-09-17 00:57:54.430885 | ubuntu-noble -> localhost | |. oo= .. +       |
2026-09-17 00:57:54.430903 | ubuntu-noble -> localhost | |o .O.Bo.+ o      |
2026-09-17 00:57:54.430922 | ubuntu-noble -> localhost | |oo.oOo.oS.       |
2026-09-17 00:57:54.430940 | ubuntu-noble -> localhost | |oo=+=   .        |
2026-09-17 00:57:54.430958 | ubuntu-noble -> localhost | |.=+*+.           |
2026-09-17 00:57:54.430975 | ubuntu-noble -> localhost | |  @B             |
2026-09-17 00:57:54.430996 | ubuntu-noble -> localhost | | .oE=            |
2026-09-17 00:57:54.431014 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-09-17 00:57:54.431062 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.058954
2026-09-17 00:57:54.435883 | 
2026-09-17 00:57:54.435944 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-17 00:57:54.465807 | ubuntu-noble | ok
2026-09-17 00:57:54.477429 | ubuntu-noble | included: /var/lib/zuul/builds/77f5e273e2ea4ec3a8fbaebc1236887d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-17 00:57:54.488383 | 
2026-09-17 00:57:54.488457 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-17 00:57:54.512664 | ubuntu-noble | skipping: Conditional result was False
2026-09-17 00:57:54.519847 | 
2026-09-17 00:57:54.519929 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-17 00:57:55.050360 | ubuntu-noble | changed
2026-09-17 00:57:55.060816 | 
2026-09-17 00:57:55.060943 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-17 00:57:55.324260 | ubuntu-noble | ok
2026-09-17 00:57:55.335090 | 
2026-09-17 00:57:55.335413 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-17 00:57:55.950363 | ubuntu-noble | changed
2026-09-17 00:57:55.961072 | 
2026-09-17 00:57:55.961199 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-17 00:57:56.602753 | ubuntu-noble | changed
2026-09-17 00:57:56.614522 | 
2026-09-17 00:57:56.614647 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-17 00:57:56.650173 | ubuntu-noble | skipping: Conditional result was False
2026-09-17 00:57:56.663533 | 
2026-09-17 00:57:56.663983 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-17 00:57:57.087419 | ubuntu-noble -> localhost | changed
2026-09-17 00:57:57.113374 | 
2026-09-17 00:57:57.113508 | TASK [add-build-sshkey : Add back temp key]
2026-09-17 00:57:57.417358 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/77f5e273e2ea4ec3a8fbaebc1236887d/work/77f5e273e2ea4ec3a8fbaebc1236887d_id_rsa (zuul-build-sshkey)
2026-09-17 00:57:57.417638 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013979
2026-09-17 00:57:57.424258 | 
2026-09-17 00:57:57.424355 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-17 00:57:57.787040 | ubuntu-noble | ok
2026-09-17 00:57:57.796723 | 
2026-09-17 00:57:57.796903 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-17 00:57:57.832522 | ubuntu-noble | skipping: Conditional result was False
2026-09-17 00:57:57.852654 | 
2026-09-17 00:57:57.852785 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-17 00:57:58.267995 | ubuntu-noble | ok
2026-09-17 00:57:58.323118 | 
2026-09-17 00:57:58.323264 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-17 00:57:59.201237 | ubuntu-noble | Output suppressed because no_log was given
2026-09-17 00:57:59.220750 | 
2026-09-17 00:57:59.220839 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-17 00:57:59.498497 | ubuntu-noble | ok: "logs"
2026-09-17 00:57:59.501198 | ubuntu-noble | ok: All items complete
2026-09-17 00:57:59.501343 | 
2026-09-17 00:57:59.706596 | ubuntu-noble | ok: "artifacts"
2026-09-17 00:57:59.938908 | ubuntu-noble | ok: "docs"
2026-09-17 00:58:00.002172 | 
2026-09-17 00:58:00.002426 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-17 00:58:00.263504 | ubuntu-noble | changed: "logs"
2026-09-17 00:58:00.490306 | ubuntu-noble | changed: "artifacts"
2026-09-17 00:58:00.686110 | ubuntu-noble | changed: "docs"
2026-09-17 00:58:00.710159 | 
2026-09-17 00:58:00.710354 | PLAY RECAP
2026-09-17 00:58:00.710443 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-17 00:58:00.710503 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-17 00:58:00.710548 | 
2026-09-17 00:58:00.969856 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-17 00:58:00.970982 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-09-17 00:58:01.671839 | 
2026-09-17 00:58:01.672060 | PLAY [all]
2026-09-17 00:58:01.689348 | 
2026-09-17 00:58:01.689440 | TASK [setup-uv : Extract archive]
2026-09-17 00:58:04.432183 | ubuntu-noble | changed
2026-09-17 00:58:04.444091 | 
2026-09-17 00:58:04.444249 | TASK [setup-uv : Print version]
2026-09-17 00:58:04.887320 | ubuntu-noble | uv 0.8.13
2026-09-17 00:58:04.996414 | ubuntu-noble | ok: Runtime: 0:00:00.020569
2026-09-17 00:58:05.011357 | 
2026-09-17 00:58:05.011540 | PLAY RECAP
2026-09-17 00:58:05.011649 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-17 00:58:05.011706 | 
2026-09-17 00:58:05.162247 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-09-17 00:58:05.163608 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-09-17 00:58:05.764351 | 
2026-09-17 00:58:05.764486 | PLAY [all]
2026-09-17 00:58:05.776057 | 
2026-09-17 00:58:05.776144 | TASK [Run "pre-commit"]
2026-09-17 00:58:07.440516 | ubuntu-noble | Downloading virtualenv (5.1MiB)
2026-09-17 00:58:07.632488 | ubuntu-noble |  Downloading virtualenv
2026-09-17 00:58:07.648328 | ubuntu-noble | Installed 10 packages in 15ms
2026-09-17 00:58:08.002914 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-09-17 00:58:08.658977 | 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-09-17 00:58:08.667163 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-09-17 00:58:09.343353 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-09-17 00:58:09.868830 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-09-17 00:58:10.616483 | 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-09-17 00:58:10.618281 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-09-17 00:58:11.347915 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-09-17 00:58:12.074418 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-09-17 00:58:12.074473 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-09-17 00:58:12.074478 | ubuntu-noble | [INFO] This may take a few minutes...
2026-09-17 00:58:19.485438 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-09-17 00:58:19.485504 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-09-17 00:58:19.485514 | ubuntu-noble | [INFO] This may take a few minutes...
2026-09-17 00:58:32.961717 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-09-17 00:58:32.961788 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-09-17 00:58:32.961800 | ubuntu-noble | [INFO] This may take a few minutes...
2026-09-17 00:58:39.345606 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-09-17 00:58:39.345668 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-09-17 00:58:39.345673 | ubuntu-noble | [INFO] This may take a few minutes...
2026-09-17 00:58:46.544147 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-09-17 00:58:46.544223 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-09-17 00:58:46.544236 | ubuntu-noble | [INFO] This may take a few minutes...
2026-09-17 00:58:59.111314 | ubuntu-noble | fix end of files.........................................................Passed
2026-09-17 00:58:59.179323 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-09-17 00:58:59.458929 | ubuntu-noble | black....................................................................Passed
2026-09-17 00:58:59.683015 | ubuntu-noble | flake8...................................................................Passed
2026-09-17 00:58:59.809077 | ubuntu-noble | isort....................................................................Passed
2026-09-17 01:04:07.468886 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-09-17 01:04:07.588772 | ubuntu-noble | ok: Runtime: 0:06:01.283369
2026-09-17 01:04:07.592170 | 
2026-09-17 01:04:07.592292 | PLAY RECAP
2026-09-17 01:04:07.592387 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-17 01:04:07.592432 | 
2026-09-17 01:04:07.755841 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-09-17 01:04:07.758253 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-17 01:04:08.306301 | 
2026-09-17 01:04:08.306412 | PLAY [all]
2026-09-17 01:04:08.317314 | 
2026-09-17 01:04:08.317386 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-17 01:04:08.381307 | ubuntu-noble | skipping: Conditional result was False
2026-09-17 01:04:08.388639 | 
2026-09-17 01:04:08.388740 | TASK [fetch-output : Set log path for single node]
2026-09-17 01:04:08.442618 | ubuntu-noble | ok
2026-09-17 01:04:08.452412 | 
2026-09-17 01:04:08.452615 | LOOP [fetch-output : Ensure local output dirs]
2026-09-17 01:04:08.908782 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/77f5e273e2ea4ec3a8fbaebc1236887d/work/logs"
2026-09-17 01:04:09.134682 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/77f5e273e2ea4ec3a8fbaebc1236887d/work/artifacts"
2026-09-17 01:04:09.367921 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/77f5e273e2ea4ec3a8fbaebc1236887d/work/docs"
2026-09-17 01:04:09.386579 | 
2026-09-17 01:04:09.386762 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-17 01:04:10.098181 | ubuntu-noble | ok
2026-09-17 01:04:10.098521 | ubuntu-noble | changed: All items complete
2026-09-17 01:04:10.098579 | 
2026-09-17 01:04:10.627617 | ubuntu-noble | changed: .d..t...... ./
2026-09-17 01:04:11.156355 | ubuntu-noble | changed: .d..t...... ./
2026-09-17 01:04:11.186763 | 
2026-09-17 01:04:11.187000 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-17 01:04:11.688674 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007378
2026-09-17 01:04:11.980450 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.006094
2026-09-17 01:04:12.004989 | 
2026-09-17 01:04:12.005131 | PLAY [all]
2026-09-17 01:04:12.012213 | 
2026-09-17 01:04:12.012288 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-17 01:04:12.499072 | ubuntu-noble | changed
2026-09-17 01:04:12.511458 | 
2026-09-17 01:04:12.511552 | PLAY RECAP
2026-09-17 01:04:12.511635 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-17 01:04:12.511678 | 
2026-09-17 01:04:12.674846 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-17 01:04:12.676230 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-17 01:04:13.230526 | 
2026-09-17 01:04:13.230638 | PLAY [localhost]
2026-09-17 01:04:13.240130 | 
2026-09-17 01:04:13.240205 | TASK [Generate Zuul manifest]
2026-09-17 01:04:13.256635 | localhost | ok
2026-09-17 01:04:13.269301 | 
2026-09-17 01:04:13.269374 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-17 01:04:13.754254 | localhost | changed
2026-09-17 01:04:13.773900 | 
2026-09-17 01:04:13.774055 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-17 01:04:13.806215 | localhost | ok
2026-09-17 01:04:13.821000 | 
2026-09-17 01:04:13.821136 | TASK [Upload logs]
2026-09-17 01:04:13.843411 | localhost | ok
2026-09-17 01:04:13.934185 | 
2026-09-17 01:04:13.934336 | TASK [Set zuul-log-path fact]
2026-09-17 01:04:13.951409 | localhost | ok
2026-09-17 01:04:13.961095 | 
2026-09-17 01:04:13.961156 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-17 01:04:13.998879 | localhost | ok
2026-09-17 01:04:14.007732 | 
2026-09-17 01:04:14.007837 | TASK [upload-logs : Create log directories]
2026-09-17 01:04:14.466829 | localhost | changed
2026-09-17 01:04:14.481077 | 
2026-09-17 01:04:14.481436 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-17 01:04:15.004298 | localhost -> localhost | ok: Runtime: 0:00:00.005272
2026-09-17 01:04:15.013452 | 
2026-09-17 01:04:15.013587 | TASK [upload-logs : Upload logs to log server]
2026-09-17 01:04:15.507406 | localhost | Output suppressed because no_log was given
2026-09-17 01:04:15.510747 | 
2026-09-17 01:04:15.510811 | LOOP [upload-logs : Compress console log and json output]
2026-09-17 01:04:15.569751 | localhost | skipping: Conditional result was False
2026-09-17 01:04:15.576593 | localhost | skipping: Conditional result was False
2026-09-17 01:04:15.592932 | 
2026-09-17 01:04:15.593164 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-17 01:04:15.633099 | localhost | skipping: Conditional result was False
2026-09-17 01:04:15.633625 | 
2026-09-17 01:04:15.636071 | localhost | skipping: Conditional result was False
2026-09-17 01:04:15.646226 | 
2026-09-17 01:04:15.646455 | LOOP [upload-logs : Upload console log and json output]