2026-08-12 06:31:19.437732 | Job console starting
2026-08-12 06:31:19.447086 | Updating git repos
2026-08-12 06:31:19.475294 | Cloning repos into workspace
2026-08-12 06:31:19.627311 | Restoring repo states
2026-08-12 06:31:19.636050 | Merging changes
2026-08-12 06:31:19.983940 | Checking out repos
2026-08-12 06:31:20.022532 | Preparing playbooks
2026-08-12 06:31:20.935419 | Running Ansible setup
2026-08-12 06:31:24.499216 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-12 06:31:25.082497 | 
2026-08-12 06:31:25.082633 | PLAY [localhost]
2026-08-12 06:31:25.090298 | 
2026-08-12 06:31:25.090370 | TASK [Gathering Facts]
2026-08-12 06:31:25.949590 | localhost | ok
2026-08-12 06:31:25.959986 | 
2026-08-12 06:31:25.960154 | TASK [Setup log path fact]
2026-08-12 06:31:25.982446 | localhost | ok
2026-08-12 06:31:25.995959 | 
2026-08-12 06:31:25.996033 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-12 06:31:26.027866 | localhost | ok
2026-08-12 06:31:26.035817 | 
2026-08-12 06:31:26.035908 | TASK [emit-job-header : Print job information]
2026-08-12 06:31:26.076424 | # Job Information
2026-08-12 06:31:26.076614 | Ansible Version: 2.16.18
2026-08-12 06:31:26.076659 | Job: pre-commit
2026-08-12 06:31:26.076683 | Pipeline: check
2026-08-12 06:31:26.076703 | Executor: 2d72f0692154
2026-08-12 06:31:26.076723 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/145
2026-08-12 06:31:26.076745 | Event ID: e7be6410-9615-11f1-947a-8fda8788f96a
2026-08-12 06:31:26.081820 | 
2026-08-12 06:31:26.081894 | LOOP [emit-job-header : Print node information]
2026-08-12 06:31:26.176209 | localhost | ok:
2026-08-12 06:31:26.176529 | localhost | # Node Information
2026-08-12 06:31:26.176605 | localhost | Inventory Hostname: ubuntu-noble
2026-08-12 06:31:26.176664 | localhost | Hostname: np0000188921
2026-08-12 06:31:26.176718 | localhost | Username: zuul
2026-08-12 06:31:26.176775 | localhost | Distro: Ubuntu 24.04
2026-08-12 06:31:26.176834 | localhost | Provider: yul1
2026-08-12 06:31:26.176909 | localhost | Region: ca-ymq-1
2026-08-12 06:31:26.177084 | localhost | Label: ubuntu-noble
2026-08-12 06:31:26.177147 | localhost | Product Name: OpenStack Nova
2026-08-12 06:31:26.177200 | localhost | Interface IP: 199.204.45.248
2026-08-12 06:31:26.199949 | 
2026-08-12 06:31:26.200173 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-12 06:31:26.569035 | localhost -> localhost | changed
2026-08-12 06:31:26.578113 | 
2026-08-12 06:31:26.578222 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-12 06:31:27.374404 | localhost -> localhost | changed
2026-08-12 06:31:27.381277 | 
2026-08-12 06:31:27.381332 | PLAY [all]
2026-08-12 06:31:27.390169 | 
2026-08-12 06:31:27.390235 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-12 06:31:27.607509 | ubuntu-noble -> localhost | ok
2026-08-12 06:31:27.618536 | 
2026-08-12 06:31:27.618610 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-12 06:31:27.653460 | ubuntu-noble | ok
2026-08-12 06:31:27.669423 | ubuntu-noble | included: /var/lib/zuul/builds/1ef260e1f4dc47b588f16e07eb170b37/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-12 06:31:27.675517 | 
2026-08-12 06:31:27.675577 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-12 06:31:28.925109 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-08-12 06:31:28.925535 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/1ef260e1f4dc47b588f16e07eb170b37/work/1ef260e1f4dc47b588f16e07eb170b37_id_rsa
2026-08-12 06:31:28.925584 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/1ef260e1f4dc47b588f16e07eb170b37/work/1ef260e1f4dc47b588f16e07eb170b37_id_rsa.pub
2026-08-12 06:31:28.925618 | ubuntu-noble -> localhost | The key fingerprint is:
2026-08-12 06:31:28.925656 | ubuntu-noble -> localhost | SHA256:cT62aI0oRtElt1H6A9Qr+4Kdu4P1GjLWbvh2Ur6pNFQ zuul-build-sshkey
2026-08-12 06:31:28.925703 | ubuntu-noble -> localhost | The key's randomart image is:
2026-08-12 06:31:28.925736 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-08-12 06:31:28.925784 | ubuntu-noble -> localhost | |      . =o.      |
2026-08-12 06:31:28.925816 | ubuntu-noble -> localhost | |     . = +.      |
2026-08-12 06:31:28.925845 | ubuntu-noble -> localhost | |    . . = E.     |
2026-08-12 06:31:28.925875 | ubuntu-noble -> localhost | |     .  .B.      |
2026-08-12 06:31:28.925906 | ubuntu-noble -> localhost | |    .   So*      |
2026-08-12 06:31:28.925935 | ubuntu-noble -> localhost | |   .   +o=.+     |
2026-08-12 06:31:28.925964 | ubuntu-noble -> localhost | |    o =*O*o      |
2026-08-12 06:31:28.925993 | ubuntu-noble -> localhost | |   . o+*Oo=.     |
2026-08-12 06:31:28.926026 | ubuntu-noble -> localhost | |       +BXo.     |
2026-08-12 06:31:28.926058 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-08-12 06:31:28.926152 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.854014
2026-08-12 06:31:28.933915 | 
2026-08-12 06:31:28.933981 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-12 06:31:28.968872 | ubuntu-noble | ok
2026-08-12 06:31:28.978644 | ubuntu-noble | included: /var/lib/zuul/builds/1ef260e1f4dc47b588f16e07eb170b37/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-12 06:31:28.986711 | 
2026-08-12 06:31:28.986779 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-12 06:31:29.011522 | ubuntu-noble | skipping: Conditional result was False
2026-08-12 06:31:29.019463 | 
2026-08-12 06:31:29.019559 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-12 06:31:29.568007 | ubuntu-noble | changed
2026-08-12 06:31:29.577013 | 
2026-08-12 06:31:29.577084 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-12 06:31:29.806437 | ubuntu-noble | ok
2026-08-12 06:31:29.830898 | 
2026-08-12 06:31:29.831148 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-12 06:31:30.440105 | ubuntu-noble | changed
2026-08-12 06:31:30.446082 | 
2026-08-12 06:31:30.446156 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-12 06:31:31.001797 | ubuntu-noble | changed
2026-08-12 06:31:31.010558 | 
2026-08-12 06:31:31.010649 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-12 06:31:31.036616 | ubuntu-noble | skipping: Conditional result was False
2026-08-12 06:31:31.048888 | 
2026-08-12 06:31:31.049056 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-12 06:31:31.420196 | ubuntu-noble -> localhost | changed
2026-08-12 06:31:31.437183 | 
2026-08-12 06:31:31.437315 | TASK [add-build-sshkey : Add back temp key]
2026-08-12 06:31:31.724268 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/1ef260e1f4dc47b588f16e07eb170b37/work/1ef260e1f4dc47b588f16e07eb170b37_id_rsa (zuul-build-sshkey)
2026-08-12 06:31:31.724627 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014760
2026-08-12 06:31:31.731332 | 
2026-08-12 06:31:31.731400 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-12 06:31:32.093969 | ubuntu-noble | ok
2026-08-12 06:31:32.099147 | 
2026-08-12 06:31:32.099228 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-12 06:31:32.125454 | ubuntu-noble | skipping: Conditional result was False
2026-08-12 06:31:32.143917 | 
2026-08-12 06:31:32.143982 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-12 06:31:32.520240 | ubuntu-noble | ok
2026-08-12 06:31:32.572879 | 
2026-08-12 06:31:32.573059 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-12 06:31:33.371563 | ubuntu-noble | Output suppressed because no_log was given
2026-08-12 06:31:33.382420 | 
2026-08-12 06:31:33.382491 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-12 06:31:33.608856 | ubuntu-noble | ok: "logs"
2026-08-12 06:31:33.609148 | ubuntu-noble | ok: All items complete
2026-08-12 06:31:33.609193 | 
2026-08-12 06:31:33.797316 | ubuntu-noble | ok: "artifacts"
2026-08-12 06:31:33.994612 | ubuntu-noble | ok: "docs"
2026-08-12 06:31:34.020219 | 
2026-08-12 06:31:34.020815 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-12 06:31:34.239069 | ubuntu-noble | changed: "logs"
2026-08-12 06:31:34.437241 | ubuntu-noble | changed: "artifacts"
2026-08-12 06:31:34.634450 | ubuntu-noble | changed: "docs"
2026-08-12 06:31:34.651755 | 
2026-08-12 06:31:34.651901 | PLAY RECAP
2026-08-12 06:31:34.651949 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-12 06:31:34.651980 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-12 06:31:34.652004 | 
2026-08-12 06:31:34.898809 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-12 06:31:34.900017 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-08-12 06:31:35.514798 | 
2026-08-12 06:31:35.590716 | PLAY [all]
2026-08-12 06:31:35.604353 | 
2026-08-12 06:31:35.604448 | TASK [setup-uv : Extract archive]
2026-08-12 06:31:38.105172 | ubuntu-noble | changed
2026-08-12 06:31:38.114497 | 
2026-08-12 06:31:38.114632 | TASK [setup-uv : Print version]
2026-08-12 06:31:38.506652 | ubuntu-noble | uv 0.8.13
2026-08-12 06:31:38.654853 | ubuntu-noble | ok: Runtime: 0:00:00.015283
2026-08-12 06:31:38.663884 | 
2026-08-12 06:31:38.663952 | PLAY RECAP
2026-08-12 06:31:38.664012 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-12 06:31:38.664045 | 
2026-08-12 06:31:38.802787 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-08-12 06:31:38.805176 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-08-12 06:31:39.430272 | 
2026-08-12 06:31:39.430457 | PLAY [all]
2026-08-12 06:31:39.442217 | 
2026-08-12 06:31:39.442294 | TASK [Run "pre-commit"]
2026-08-12 06:31:39.976719 | ubuntu-noble | Downloading virtualenv (5.1MiB)
2026-08-12 06:31:40.064648 | ubuntu-noble |  Downloading virtualenv
2026-08-12 06:31:40.077746 | ubuntu-noble | Installed 10 packages in 12ms
2026-08-12 06:31:40.460022 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-08-12 06:31:41.059967 | 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-12 06:31:41.065269 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-08-12 06:31:41.698648 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-08-12 06:31:42.191170 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-08-12 06:31:42.779600 | 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-12 06:31:42.780815 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-08-12 06:31:43.461899 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-08-12 06:31:44.121759 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-08-12 06:31:44.121807 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-12 06:31:44.121818 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-12 06:31:48.169592 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-08-12 06:31:48.169674 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-12 06:31:48.169685 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-12 06:31:52.228260 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-08-12 06:31:52.228312 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-12 06:31:52.228319 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-12 06:31:55.408030 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-08-12 06:31:55.408360 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-12 06:31:55.408406 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-12 06:31:58.113198 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-08-12 06:31:58.113271 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-12 06:31:58.113276 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-12 06:32:08.891339 | ubuntu-noble | fix end of files.........................................................Passed
2026-08-12 06:32:08.944036 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-08-12 06:32:09.234377 | ubuntu-noble | black....................................................................Passed
2026-08-12 06:32:09.425774 | ubuntu-noble | flake8...................................................................Passed
2026-08-12 06:32:09.550749 | ubuntu-noble | isort....................................................................Passed
2026-08-12 06:32:43.267211 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-08-12 06:32:43.551338 | ubuntu-noble | ok: Runtime: 0:01:03.487491
2026-08-12 06:32:43.555065 | 
2026-08-12 06:32:43.566647 | PLAY RECAP
2026-08-12 06:32:43.566785 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-12 06:32:43.566841 | 
2026-08-12 06:32:43.704756 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-08-12 06:32:43.706471 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-12 06:32:44.345698 | 
2026-08-12 06:32:44.346056 | PLAY [all]
2026-08-12 06:32:44.358724 | 
2026-08-12 06:32:44.377537 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-12 06:32:44.424362 | ubuntu-noble | skipping: Conditional result was False
2026-08-12 06:32:44.434303 | 
2026-08-12 06:32:44.434416 | TASK [fetch-output : Set log path for single node]
2026-08-12 06:32:44.477931 | ubuntu-noble | ok
2026-08-12 06:32:44.482945 | 
2026-08-12 06:32:44.489551 | LOOP [fetch-output : Ensure local output dirs]
2026-08-12 06:32:44.869359 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/1ef260e1f4dc47b588f16e07eb170b37/work/logs"
2026-08-12 06:32:45.098054 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/1ef260e1f4dc47b588f16e07eb170b37/work/artifacts"
2026-08-12 06:32:45.287569 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/1ef260e1f4dc47b588f16e07eb170b37/work/docs"
2026-08-12 06:32:45.310654 | 
2026-08-12 06:32:45.310732 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-12 06:32:45.992042 | ubuntu-noble | ok
2026-08-12 06:32:45.992284 | ubuntu-noble | changed: All items complete
2026-08-12 06:32:45.992311 | 
2026-08-12 06:32:46.482313 | ubuntu-noble | changed: .d..t...... ./
2026-08-12 06:32:46.956521 | ubuntu-noble | changed: .d..t...... ./
2026-08-12 06:32:46.978825 | 
2026-08-12 06:32:46.978992 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-12 06:32:47.388253 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.006442
2026-08-12 06:32:47.619738 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007553
2026-08-12 06:32:47.640229 | 
2026-08-12 06:32:47.640346 | PLAY [all]
2026-08-12 06:32:47.646735 | 
2026-08-12 06:32:47.646800 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-12 06:32:48.127485 | ubuntu-noble | changed
2026-08-12 06:32:48.133170 | 
2026-08-12 06:32:48.133217 | PLAY RECAP
2026-08-12 06:32:48.133259 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-12 06:32:48.133281 | 
2026-08-12 06:32:49.841617 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-12 06:32:49.849362 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-12 06:32:50.440376 | 
2026-08-12 06:32:50.440498 | PLAY [localhost]
2026-08-12 06:32:50.450604 | 
2026-08-12 06:32:50.450676 | TASK [Generate Zuul manifest]
2026-08-12 06:32:50.471302 | localhost | ok
2026-08-12 06:32:50.488242 | 
2026-08-12 06:32:50.488325 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-12 06:32:50.842176 | localhost | changed
2026-08-12 06:32:50.856285 | 
2026-08-12 06:32:50.856393 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-12 06:32:50.886692 | localhost | ok
2026-08-12 06:32:50.897306 | 
2026-08-12 06:32:50.897373 | TASK [Upload logs]
2026-08-12 06:32:50.913905 | localhost | ok
2026-08-12 06:32:50.971343 | 
2026-08-12 06:32:50.971451 | TASK [Set zuul-log-path fact]
2026-08-12 06:32:50.991096 | localhost | ok
2026-08-12 06:32:51.004751 | 
2026-08-12 06:32:51.004819 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-12 06:32:51.035962 | localhost | ok
2026-08-12 06:32:51.045430 | 
2026-08-12 06:32:51.045517 | TASK [upload-logs : Create log directories]
2026-08-12 06:32:51.448405 | localhost | changed
2026-08-12 06:32:51.454804 | 
2026-08-12 06:32:51.454897 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-12 06:32:51.898741 | localhost -> localhost | ok: Runtime: 0:00:00.006766
2026-08-12 06:32:51.905344 | 
2026-08-12 06:32:51.905431 | TASK [upload-logs : Upload logs to log server]
2026-08-12 06:32:52.401660 | localhost | Output suppressed because no_log was given
2026-08-12 06:32:52.406015 | 
2026-08-12 06:32:52.406090 | LOOP [upload-logs : Compress console log and json output]
2026-08-12 06:32:52.453962 | localhost | skipping: Conditional result was False
2026-08-12 06:32:52.460851 | localhost | skipping: Conditional result was False
2026-08-12 06:32:52.472652 | 
2026-08-12 06:32:52.472841 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-12 06:32:52.515326 | localhost | skipping: Conditional result was False
2026-08-12 06:32:52.515711 | 
2026-08-12 06:32:52.521333 | localhost | skipping: Conditional result was False
2026-08-12 06:32:52.540136 | 
2026-08-12 06:32:52.540314 | LOOP [upload-logs : Upload console log and json output]