2026-08-13 20:45:25.081286 | Job console starting
2026-08-13 20:45:25.091671 | Updating git repos
2026-08-13 20:45:25.116804 | Cloning repos into workspace
2026-08-13 20:45:25.329576 | Restoring repo states
2026-08-13 20:45:25.339264 | Merging changes
2026-08-13 20:45:25.654455 | Checking out repos
2026-08-13 20:45:25.687397 | Preparing playbooks
2026-08-13 20:45:26.667088 | Running Ansible setup
2026-08-13 20:45:30.079236 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-13 20:45:30.666818 | 
2026-08-13 20:45:30.666936 | PLAY [localhost]
2026-08-13 20:45:30.674380 | 
2026-08-13 20:45:30.674451 | TASK [Gathering Facts]
2026-08-13 20:45:31.514676 | localhost | ok
2026-08-13 20:45:31.523987 | 
2026-08-13 20:45:31.524092 | TASK [Setup log path fact]
2026-08-13 20:45:31.541674 | localhost | ok
2026-08-13 20:45:31.552904 | 
2026-08-13 20:45:31.552989 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-13 20:45:31.581916 | localhost | ok
2026-08-13 20:45:31.590508 | 
2026-08-13 20:45:31.590592 | TASK [emit-job-header : Print job information]
2026-08-13 20:45:31.631486 | # Job Information
2026-08-13 20:45:31.631674 | Ansible Version: 2.16.18
2026-08-13 20:45:31.631744 | Job: pre-commit
2026-08-13 20:45:31.631792 | Pipeline: check
2026-08-13 20:45:31.631835 | Executor: 2d72f0692154
2026-08-13 20:45:31.631877 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/146
2026-08-13 20:45:31.631925 | Event ID: 738be850-9751-11f1-9eb3-c0dee0b23850
2026-08-13 20:45:31.637054 | 
2026-08-13 20:45:31.637118 | LOOP [emit-job-header : Print node information]
2026-08-13 20:45:31.737209 | localhost | ok:
2026-08-13 20:45:31.737500 | localhost | # Node Information
2026-08-13 20:45:31.737561 | localhost | Inventory Hostname: ubuntu-noble
2026-08-13 20:45:31.737608 | localhost | Hostname: np0000189457
2026-08-13 20:45:31.737651 | localhost | Username: zuul
2026-08-13 20:45:31.737701 | localhost | Distro: Ubuntu 24.04
2026-08-13 20:45:31.737745 | localhost | Provider: yul1
2026-08-13 20:45:31.737789 | localhost | Region: ca-ymq-1
2026-08-13 20:45:31.737831 | localhost | Label: ubuntu-noble
2026-08-13 20:45:31.737872 | localhost | Product Name: OpenStack Nova
2026-08-13 20:45:31.737912 | localhost | Interface IP: 199.204.45.65
2026-08-13 20:45:31.744988 | 
2026-08-13 20:45:31.745058 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-13 20:45:32.115205 | localhost -> localhost | changed
2026-08-13 20:45:32.125175 | 
2026-08-13 20:45:32.125275 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-13 20:45:32.922536 | localhost -> localhost | changed
2026-08-13 20:45:32.932285 | 
2026-08-13 20:45:32.932555 | PLAY [all]
2026-08-13 20:45:32.942243 | 
2026-08-13 20:45:32.942360 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-13 20:45:33.170678 | ubuntu-noble -> localhost | ok
2026-08-13 20:45:33.184841 | 
2026-08-13 20:45:33.187993 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-13 20:45:33.224385 | ubuntu-noble | ok
2026-08-13 20:45:33.239711 | ubuntu-noble | included: /var/lib/zuul/builds/69be578112cb41919cd2c50e4d301d2d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-13 20:45:33.245743 | 
2026-08-13 20:45:33.245804 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-13 20:45:34.880468 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-08-13 20:45:34.880654 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/69be578112cb41919cd2c50e4d301d2d/work/69be578112cb41919cd2c50e4d301d2d_id_rsa
2026-08-13 20:45:34.880696 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/69be578112cb41919cd2c50e4d301d2d/work/69be578112cb41919cd2c50e4d301d2d_id_rsa.pub
2026-08-13 20:45:34.880728 | ubuntu-noble -> localhost | The key fingerprint is:
2026-08-13 20:45:34.880758 | ubuntu-noble -> localhost | SHA256:CzbA8lnSptP7CMYGIQXgBxSzdbHMJqIxDbiqS42uj5E zuul-build-sshkey
2026-08-13 20:45:34.880799 | ubuntu-noble -> localhost | The key's randomart image is:
2026-08-13 20:45:34.880828 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-08-13 20:45:34.880864 | ubuntu-noble -> localhost | |B*o. o.          |
2026-08-13 20:45:34.880894 | ubuntu-noble -> localhost | |o+=.+..          |
2026-08-13 20:45:34.880922 | ubuntu-noble -> localhost | |+=+o+=+          |
2026-08-13 20:45:34.880951 | ubuntu-noble -> localhost | |o+o+oO           |
2026-08-13 20:45:34.881001 | ubuntu-noble -> localhost | |o . = = S        |
2026-08-13 20:45:34.881029 | ubuntu-noble -> localhost | |..oo o + .       |
2026-08-13 20:45:34.881056 | ubuntu-noble -> localhost | |Eo .= . .        |
2026-08-13 20:45:34.881083 | ubuntu-noble -> localhost | |+o o . o         |
2026-08-13 20:45:34.881114 | ubuntu-noble -> localhost | |=+.   . .        |
2026-08-13 20:45:34.881143 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-08-13 20:45:34.881203 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.253707
2026-08-13 20:45:34.889011 | 
2026-08-13 20:45:34.889100 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-13 20:45:34.921692 | ubuntu-noble | ok
2026-08-13 20:45:34.934064 | ubuntu-noble | included: /var/lib/zuul/builds/69be578112cb41919cd2c50e4d301d2d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-13 20:45:34.941845 | 
2026-08-13 20:45:34.941906 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-13 20:45:34.966814 | ubuntu-noble | skipping: Conditional result was False
2026-08-13 20:45:34.975910 | 
2026-08-13 20:45:34.975999 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-13 20:45:35.479981 | ubuntu-noble | changed
2026-08-13 20:45:35.485613 | 
2026-08-13 20:45:35.485675 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-13 20:45:35.712987 | ubuntu-noble | ok
2026-08-13 20:45:35.721584 | 
2026-08-13 20:45:35.721656 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-13 20:45:36.313903 | ubuntu-noble | changed
2026-08-13 20:45:36.321639 | 
2026-08-13 20:45:36.321708 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-13 20:45:36.875407 | ubuntu-noble | changed
2026-08-13 20:45:36.883292 | 
2026-08-13 20:45:36.883407 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-13 20:45:36.909379 | ubuntu-noble | skipping: Conditional result was False
2026-08-13 20:45:36.921645 | 
2026-08-13 20:45:36.921710 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-13 20:45:37.281287 | ubuntu-noble -> localhost | changed
2026-08-13 20:45:37.300390 | 
2026-08-13 20:45:37.300500 | TASK [add-build-sshkey : Add back temp key]
2026-08-13 20:45:37.579742 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/69be578112cb41919cd2c50e4d301d2d/work/69be578112cb41919cd2c50e4d301d2d_id_rsa (zuul-build-sshkey)
2026-08-13 20:45:37.580023 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.012748
2026-08-13 20:45:37.587775 | 
2026-08-13 20:45:37.587862 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-13 20:45:37.930675 | ubuntu-noble | ok
2026-08-13 20:45:37.936403 | 
2026-08-13 20:45:37.936467 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-13 20:45:37.959925 | ubuntu-noble | skipping: Conditional result was False
2026-08-13 20:45:37.976637 | 
2026-08-13 20:45:37.976724 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-13 20:45:38.338232 | ubuntu-noble | ok
2026-08-13 20:45:38.382970 | 
2026-08-13 20:45:38.383103 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-13 20:45:39.097058 | ubuntu-noble | Output suppressed because no_log was given
2026-08-13 20:45:39.106727 | 
2026-08-13 20:45:39.106797 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-13 20:45:39.329647 | ubuntu-noble | ok: "logs"
2026-08-13 20:45:39.329914 | ubuntu-noble | ok: All items complete
2026-08-13 20:45:39.329957 | 
2026-08-13 20:45:39.524788 | ubuntu-noble | ok: "artifacts"
2026-08-13 20:45:39.731751 | ubuntu-noble | ok: "docs"
2026-08-13 20:45:39.750448 | 
2026-08-13 20:45:39.750579 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-13 20:45:39.981771 | ubuntu-noble | changed: "logs"
2026-08-13 20:45:40.187694 | ubuntu-noble | changed: "artifacts"
2026-08-13 20:45:40.379133 | ubuntu-noble | changed: "docs"
2026-08-13 20:45:40.394320 | 
2026-08-13 20:45:40.394447 | PLAY RECAP
2026-08-13 20:45:40.394509 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-13 20:45:40.394552 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-13 20:45:40.394584 | 
2026-08-13 20:45:40.515162 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-13 20:45:40.517517 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-08-13 20:45:41.105350 | 
2026-08-13 20:45:41.105468 | PLAY [all]
2026-08-13 20:45:41.117990 | 
2026-08-13 20:45:41.118080 | TASK [setup-uv : Extract archive]
2026-08-13 20:45:43.650993 | ubuntu-noble | changed
2026-08-13 20:45:43.657167 | 
2026-08-13 20:45:43.657245 | TASK [setup-uv : Print version]
2026-08-13 20:45:44.018696 | ubuntu-noble | uv 0.8.13
2026-08-13 20:45:44.195191 | ubuntu-noble | ok: Runtime: 0:00:00.015365
2026-08-13 20:45:44.203881 | 
2026-08-13 20:45:44.546717 | PLAY RECAP
2026-08-13 20:45:44.547027 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-13 20:45:44.547094 | 
2026-08-13 20:45:44.678572 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-08-13 20:45:44.679631 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-08-13 20:45:45.226506 | 
2026-08-13 20:45:45.226623 | PLAY [all]
2026-08-13 20:45:45.237668 | 
2026-08-13 20:45:45.237743 | TASK [Run "pre-commit"]
2026-08-13 20:45:45.795587 | ubuntu-noble | Downloading virtualenv (5.1MiB)
2026-08-13 20:45:45.881371 | ubuntu-noble |  Downloading virtualenv
2026-08-13 20:45:45.894366 | ubuntu-noble | Installed 10 packages in 12ms
2026-08-13 20:45:46.265335 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-08-13 20:45:46.885249 | 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-08-13 20:45:46.891702 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-08-13 20:45:48.275798 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-08-13 20:45:48.941030 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-08-13 20:45:49.474732 | 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-08-13 20:45:49.475944 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-08-13 20:45:53.936687 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-08-13 20:45:55.355896 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-08-13 20:45:55.356036 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-13 20:45:55.356047 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-13 20:45:59.266751 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-08-13 20:45:59.266844 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-13 20:45:59.266856 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-13 20:46:03.870107 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-08-13 20:46:03.870173 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-13 20:46:03.870180 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-13 20:46:07.152023 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-08-13 20:46:07.152131 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-13 20:46:07.152142 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-13 20:46:09.965048 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-08-13 20:46:09.965169 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-13 20:46:09.965181 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-13 20:46:20.809021 | ubuntu-noble | fix end of files.........................................................Passed
2026-08-13 20:46:20.867506 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-08-13 20:46:21.160703 | ubuntu-noble | black....................................................................Passed
2026-08-13 20:46:21.353824 | ubuntu-noble | flake8...................................................................Passed
2026-08-13 20:46:21.477600 | ubuntu-noble | isort....................................................................Passed
2026-08-13 20:47:03.736853 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-08-13 20:47:03.825677 | ubuntu-noble | ok: Runtime: 0:01:18.139590
2026-08-13 20:47:03.827281 | 
2026-08-13 20:47:03.827327 | PLAY RECAP
2026-08-13 20:47:03.827368 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-13 20:47:03.827390 | 
2026-08-13 20:47:03.929863 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-08-13 20:47:03.931449 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-13 20:47:04.516031 | 
2026-08-13 20:47:04.516156 | PLAY [all]
2026-08-13 20:47:04.527817 | 
2026-08-13 20:47:04.527895 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-13 20:47:04.572380 | ubuntu-noble | skipping: Conditional result was False
2026-08-13 20:47:04.583386 | 
2026-08-13 20:47:04.583488 | TASK [fetch-output : Set log path for single node]
2026-08-13 20:47:04.627152 | ubuntu-noble | ok
2026-08-13 20:47:04.632061 | 
2026-08-13 20:47:04.632127 | LOOP [fetch-output : Ensure local output dirs]
2026-08-13 20:47:05.014047 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/69be578112cb41919cd2c50e4d301d2d/work/logs"
2026-08-13 20:47:05.213777 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/69be578112cb41919cd2c50e4d301d2d/work/artifacts"
2026-08-13 20:47:05.407760 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/69be578112cb41919cd2c50e4d301d2d/work/docs"
2026-08-13 20:47:05.428908 | 
2026-08-13 20:47:05.429094 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-13 20:47:06.065846 | ubuntu-noble | changed: .d..t...... ./
2026-08-13 20:47:06.066041 | ubuntu-noble | changed: All items complete
2026-08-13 20:47:06.066070 | 
2026-08-13 20:47:06.514865 | ubuntu-noble | changed: .d..t...... ./
2026-08-13 20:47:06.969444 | ubuntu-noble | changed: .d..t...... ./
2026-08-13 20:47:06.989293 | 
2026-08-13 20:47:06.989406 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-13 20:47:07.386024 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.006697
2026-08-13 20:47:07.593271 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.006471
2026-08-13 20:47:07.613069 | 
2026-08-13 20:47:07.613185 | PLAY [all]
2026-08-13 20:47:07.620147 | 
2026-08-13 20:47:07.620210 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-13 20:47:08.109656 | ubuntu-noble | changed
2026-08-13 20:47:08.115364 | 
2026-08-13 20:47:08.115417 | PLAY RECAP
2026-08-13 20:47:08.115460 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-13 20:47:08.115481 | 
2026-08-13 20:47:08.228754 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-13 20:47:08.231654 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-13 20:47:08.814559 | 
2026-08-13 20:47:08.814718 | PLAY [localhost]
2026-08-13 20:47:08.825896 | 
2026-08-13 20:47:08.825974 | TASK [Generate Zuul manifest]
2026-08-13 20:47:08.847280 | localhost | ok
2026-08-13 20:47:08.865599 | 
2026-08-13 20:47:08.865681 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-13 20:47:09.221888 | localhost | changed
2026-08-13 20:47:09.235232 | 
2026-08-13 20:47:09.235343 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-13 20:47:09.266796 | localhost | ok
2026-08-13 20:47:09.277526 | 
2026-08-13 20:47:09.277591 | TASK [Upload logs]
2026-08-13 20:47:09.295365 | localhost | ok
2026-08-13 20:47:09.353852 | 
2026-08-13 20:47:09.353993 | TASK [Set zuul-log-path fact]
2026-08-13 20:47:09.375094 | localhost | ok
2026-08-13 20:47:09.390656 | 
2026-08-13 20:47:09.390778 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-13 20:47:09.422124 | localhost | ok
2026-08-13 20:47:09.432584 | 
2026-08-13 20:47:09.432684 | TASK [upload-logs : Create log directories]
2026-08-13 20:47:09.809411 | localhost | changed
2026-08-13 20:47:09.815757 | 
2026-08-13 20:47:09.815849 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-13 20:47:10.202817 | localhost -> localhost | ok: Runtime: 0:00:00.004586
2026-08-13 20:47:10.207928 | 
2026-08-13 20:47:10.207993 | TASK [upload-logs : Upload logs to log server]
2026-08-13 20:47:10.685191 | localhost | Output suppressed because no_log was given
2026-08-13 20:47:10.690831 | 
2026-08-13 20:47:10.690946 | LOOP [upload-logs : Compress console log and json output]
2026-08-13 20:47:10.732567 | localhost | skipping: Conditional result was False
2026-08-13 20:47:10.739666 | localhost | skipping: Conditional result was False
2026-08-13 20:47:10.755360 | 
2026-08-13 20:47:10.755502 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-13 20:47:10.793083 | localhost | skipping: Conditional result was False
2026-08-13 20:47:10.793411 | 
2026-08-13 20:47:10.797350 | localhost | skipping: Conditional result was False
2026-08-13 20:47:10.807677 | 
2026-08-13 20:47:10.807813 | LOOP [upload-logs : Upload console log and json output]