2026-04-20 02:13:36.970227 | Job console starting
2026-04-20 02:13:36.981276 | Updating git repos
2026-04-20 02:13:37.003901 | Cloning repos into workspace
2026-04-20 02:13:37.058810 | Restoring repo states
2026-04-20 02:13:37.067375 | Merging changes
2026-04-20 02:13:37.348759 | Checking out repos
2026-04-20 02:13:37.403930 | Preparing playbooks
2026-04-20 02:13:38.898445 | Running Ansible setup
2026-04-20 02:13:43.094189 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-20 02:13:43.812701 | 
2026-04-20 02:13:43.812857 | PLAY [localhost]
2026-04-20 02:13:43.821382 | 
2026-04-20 02:13:43.821481 | TASK [Gathering Facts]
2026-04-20 02:13:44.807849 | localhost | ok
2026-04-20 02:13:44.817236 | 
2026-04-20 02:13:44.817358 | TASK [Setup log path fact]
2026-04-20 02:13:44.838502 | localhost | ok
2026-04-20 02:13:44.853875 | 
2026-04-20 02:13:44.854195 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-20 02:13:44.885592 | localhost | ok
2026-04-20 02:13:44.894234 | 
2026-04-20 02:13:44.894302 | TASK [emit-job-header : Print job information]
2026-04-20 02:13:44.939386 | # Job Information
2026-04-20 02:13:44.939565 | Ansible Version: 2.16.16
2026-04-20 02:13:44.939613 | Job: pre-commit
2026-04-20 02:13:44.939810 | Pipeline: check
2026-04-20 02:13:44.939848 | Executor: 0a8996d2b663
2026-04-20 02:13:44.939876 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/115
2026-04-20 02:13:44.939907 | Event ID: cfe5e050-3c5d-11f1-8637-8a96a3f2147c
2026-04-20 02:13:44.945570 | 
2026-04-20 02:13:44.945719 | LOOP [emit-job-header : Print node information]
2026-04-20 02:13:45.068296 | localhost | ok:
2026-04-20 02:13:45.068533 | localhost | # Node Information
2026-04-20 02:13:45.068581 | localhost | Inventory Hostname: ubuntu-noble
2026-04-20 02:13:45.068617 | localhost | Hostname: np0000167882
2026-04-20 02:13:45.068652 | localhost | Username: zuul
2026-04-20 02:13:45.068688 | localhost | Distro: Ubuntu 24.04
2026-04-20 02:13:45.068723 | localhost | Provider: yul1
2026-04-20 02:13:45.068758 | localhost | Region: ca-ymq-1
2026-04-20 02:13:45.068789 | localhost | Label: ubuntu-noble
2026-04-20 02:13:45.068815 | localhost | Product Name: OpenStack Nova
2026-04-20 02:13:45.068838 | localhost | Interface IP: 199.19.213.246
2026-04-20 02:13:45.076441 | 
2026-04-20 02:13:45.076587 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-20 02:13:45.509921 | localhost -> localhost | changed
2026-04-20 02:13:45.519707 | 
2026-04-20 02:13:45.519786 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-20 02:13:46.752032 | localhost -> localhost | changed
2026-04-20 02:13:46.758703 | 
2026-04-20 02:13:46.758820 | PLAY [all]
2026-04-20 02:13:46.778089 | 
2026-04-20 02:13:46.778262 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-20 02:13:47.025993 | ubuntu-noble -> localhost | ok
2026-04-20 02:13:47.035602 | 
2026-04-20 02:13:47.035814 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-20 02:13:47.075050 | ubuntu-noble | ok
2026-04-20 02:13:47.098085 | ubuntu-noble | included: /var/lib/zuul/builds/988588aba645424dbb56f9d3cc563f06/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-20 02:13:47.106990 | 
2026-04-20 02:13:47.107178 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-20 02:13:48.440634 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-04-20 02:13:48.441023 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/988588aba645424dbb56f9d3cc563f06/work/988588aba645424dbb56f9d3cc563f06_id_rsa
2026-04-20 02:13:48.441061 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/988588aba645424dbb56f9d3cc563f06/work/988588aba645424dbb56f9d3cc563f06_id_rsa.pub
2026-04-20 02:13:48.441086 | ubuntu-noble -> localhost | The key fingerprint is:
2026-04-20 02:13:48.441108 | ubuntu-noble -> localhost | SHA256:i6sUCMfIaqXmvzVbsR1fSqHMgTRMLXy7WV/Ev5kSw5M zuul-build-sshkey
2026-04-20 02:13:48.441149 | ubuntu-noble -> localhost | The key's randomart image is:
2026-04-20 02:13:48.441171 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-04-20 02:13:48.441199 | ubuntu-noble -> localhost | |      ++.     .  |
2026-04-20 02:13:48.441221 | ubuntu-noble -> localhost | |.o    .+oo     o |
2026-04-20 02:13:48.441241 | ubuntu-noble -> localhost | |o.o.   .o.... o .|
2026-04-20 02:13:48.441262 | ubuntu-noble -> localhost | |.oo.    o.o..E ..|
2026-04-20 02:13:48.441282 | ubuntu-noble -> localhost | |.+. .  .S=+...= +|
2026-04-20 02:13:48.441304 | ubuntu-noble -> localhost | |+    . .+++ oo + |
2026-04-20 02:13:48.441324 | ubuntu-noble -> localhost | | .  .o.o.. o  .  |
2026-04-20 02:13:48.441345 | ubuntu-noble -> localhost | |  ... +.         |
2026-04-20 02:13:48.441369 | ubuntu-noble -> localhost | |   ooo.          |
2026-04-20 02:13:48.441390 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-04-20 02:13:48.441449 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.811487
2026-04-20 02:13:48.447225 | 
2026-04-20 02:13:48.447314 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-20 02:13:48.478402 | ubuntu-noble | ok
2026-04-20 02:13:48.487850 | ubuntu-noble | included: /var/lib/zuul/builds/988588aba645424dbb56f9d3cc563f06/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-20 02:13:48.496668 | 
2026-04-20 02:13:48.496785 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-20 02:13:48.521745 | ubuntu-noble | skipping: Conditional result was False
2026-04-20 02:13:48.533469 | 
2026-04-20 02:13:48.533645 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-20 02:13:49.158180 | ubuntu-noble | changed
2026-04-20 02:13:49.165562 | 
2026-04-20 02:13:49.165641 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-20 02:13:49.397149 | ubuntu-noble | ok
2026-04-20 02:13:49.411325 | 
2026-04-20 02:13:49.411456 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-20 02:13:50.015005 | ubuntu-noble | changed
2026-04-20 02:13:50.028933 | 
2026-04-20 02:13:50.029123 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-20 02:13:50.607311 | ubuntu-noble | changed
2026-04-20 02:13:50.615080 | 
2026-04-20 02:13:50.615243 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-20 02:13:50.632088 | ubuntu-noble | skipping: Conditional result was False
2026-04-20 02:13:50.643354 | 
2026-04-20 02:13:50.643467 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-20 02:13:51.052391 | ubuntu-noble -> localhost | changed
2026-04-20 02:13:51.070971 | 
2026-04-20 02:13:51.071136 | TASK [add-build-sshkey : Add back temp key]
2026-04-20 02:13:51.363583 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/988588aba645424dbb56f9d3cc563f06/work/988588aba645424dbb56f9d3cc563f06_id_rsa (zuul-build-sshkey)
2026-04-20 02:13:51.363854 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.015275
2026-04-20 02:13:51.373690 | 
2026-04-20 02:13:51.373844 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-20 02:13:51.777230 | ubuntu-noble | ok
2026-04-20 02:13:51.782628 | 
2026-04-20 02:13:51.782700 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-20 02:13:51.817835 | ubuntu-noble | skipping: Conditional result was False
2026-04-20 02:13:51.834178 | 
2026-04-20 02:13:51.834333 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-20 02:13:52.247134 | ubuntu-noble | ok
2026-04-20 02:13:52.259306 | 
2026-04-20 02:13:52.259395 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-20 02:13:53.216113 | ubuntu-noble | Output suppressed because no_log was given
2026-04-20 02:13:53.229609 | 
2026-04-20 02:13:53.229745 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-20 02:13:53.500235 | ubuntu-noble | ok: "logs"
2026-04-20 02:13:53.554636 | ubuntu-noble | ok: All items complete
2026-04-20 02:13:53.554820 | 
2026-04-20 02:13:53.663628 | ubuntu-noble | ok: "artifacts"
2026-04-20 02:13:53.921743 | ubuntu-noble | ok: "docs"
2026-04-20 02:13:53.940464 | 
2026-04-20 02:13:53.940632 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-20 02:13:54.198276 | ubuntu-noble | changed: "logs"
2026-04-20 02:13:54.398950 | ubuntu-noble | changed: "artifacts"
2026-04-20 02:13:54.616856 | ubuntu-noble | changed: "docs"
2026-04-20 02:13:54.632166 | 
2026-04-20 02:13:54.632404 | PLAY RECAP
2026-04-20 02:13:54.632538 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-20 02:13:54.632579 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-20 02:13:54.632605 | 
2026-04-20 02:13:54.819922 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-20 02:13:54.821511 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-20 02:13:55.433689 | 
2026-04-20 02:13:55.545068 | PLAY [all]
2026-04-20 02:13:55.563322 | 
2026-04-20 02:13:55.563494 | TASK [setup-uv : Extract archive]
2026-04-20 02:13:58.072489 | ubuntu-noble | changed
2026-04-20 02:13:58.081581 | 
2026-04-20 02:13:58.081756 | TASK [setup-uv : Print version]
2026-04-20 02:13:58.484809 | ubuntu-noble | uv 0.8.13
2026-04-20 02:13:58.628071 | ubuntu-noble | ok: Runtime: 0:00:00.012451
2026-04-20 02:13:58.637857 | 
2026-04-20 02:13:58.637969 | PLAY RECAP
2026-04-20 02:13:58.638019 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-20 02:13:58.638043 | 
2026-04-20 02:13:58.807344 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-20 02:13:58.810272 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-20 02:13:59.508382 | 
2026-04-20 02:13:59.508538 | PLAY [all]
2026-04-20 02:13:59.520415 | 
2026-04-20 02:13:59.520557 | TASK [Run "pre-commit"]
2026-04-20 02:14:00.183103 | ubuntu-noble | Downloading virtualenv (5.6MiB)
2026-04-20 02:14:00.299996 | ubuntu-noble |  Downloading virtualenv
2026-04-20 02:14:00.313649 | ubuntu-noble | Installed 10 packages in 12ms
2026-04-20 02:14:00.804885 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-20 02:14:01.340892 | 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-04-20 02:14:01.348601 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-04-20 02:14:02.175502 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-04-20 02:14:02.599926 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-04-20 02:14:03.030179 | 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-04-20 02:14:03.032030 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-04-20 02:14:03.583874 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-04-20 02:14:04.105368 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-20 02:14:04.105464 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-20 02:14:04.105516 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-20 02:14:08.415457 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-04-20 02:14:08.415556 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-20 02:14:08.415562 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-20 02:14:12.928324 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-04-20 02:14:12.928365 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-20 02:14:12.928412 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-20 02:14:16.209134 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-04-20 02:14:16.209207 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-20 02:14:16.209217 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-20 02:14:18.908874 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-04-20 02:14:18.908946 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-20 02:14:18.908971 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-20 02:14:32.296915 | ubuntu-noble | fix end of files.........................................................Passed
2026-04-20 02:14:32.356186 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-04-20 02:14:32.649859 | ubuntu-noble | black....................................................................Passed
2026-04-20 02:14:32.881777 | ubuntu-noble | flake8...................................................................Passed
2026-04-20 02:14:33.024451 | ubuntu-noble | isort....................................................................Passed
2026-04-20 02:14:49.479191 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-04-20 02:14:49.600349 | ubuntu-noble | ok: Runtime: 0:00:49.622708
2026-04-20 02:14:49.602750 | 
2026-04-20 02:14:49.602822 | PLAY RECAP
2026-04-20 02:14:49.602950 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-20 02:14:49.602986 | 
2026-04-20 02:14:49.805971 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-20 02:14:49.807579 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-20 02:14:50.503388 | 
2026-04-20 02:14:50.503565 | PLAY [all]
2026-04-20 02:14:50.516601 | 
2026-04-20 02:14:50.516744 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-20 02:14:50.563357 | ubuntu-noble | skipping: Conditional result was False
2026-04-20 02:14:50.576266 | 
2026-04-20 02:14:50.576479 | TASK [fetch-output : Set log path for single node]
2026-04-20 02:14:50.644164 | ubuntu-noble | ok
2026-04-20 02:14:50.709674 | 
2026-04-20 02:14:50.709808 | LOOP [fetch-output : Ensure local output dirs]
2026-04-20 02:14:51.188766 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/988588aba645424dbb56f9d3cc563f06/work/logs"
2026-04-20 02:14:51.434548 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/988588aba645424dbb56f9d3cc563f06/work/artifacts"
2026-04-20 02:14:51.741949 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/988588aba645424dbb56f9d3cc563f06/work/docs"
2026-04-20 02:14:51.763357 | 
2026-04-20 02:14:51.763540 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-20 02:14:52.492347 | ubuntu-noble | ok
2026-04-20 02:14:52.492637 | ubuntu-noble | changed: All items complete
2026-04-20 02:14:52.492687 | 
2026-04-20 02:14:52.977365 | ubuntu-noble | changed: .d..t...... ./
2026-04-20 02:14:53.473884 | ubuntu-noble | changed: .d..t...... ./
2026-04-20 02:14:53.505162 | 
2026-04-20 02:14:53.506357 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-20 02:14:53.961002 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007293
2026-04-20 02:14:54.224375 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.011340
2026-04-20 02:14:54.242054 | 
2026-04-20 02:14:54.242167 | PLAY [all]
2026-04-20 02:14:54.249993 | 
2026-04-20 02:14:54.250069 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-20 02:14:54.739135 | ubuntu-noble | changed
2026-04-20 02:14:54.745610 | 
2026-04-20 02:14:54.745693 | PLAY RECAP
2026-04-20 02:14:54.745740 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-20 02:14:54.745761 | 
2026-04-20 02:14:54.874680 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-20 02:14:54.875700 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-20 02:14:55.515937 | 
2026-04-20 02:14:55.516137 | PLAY [localhost]
2026-04-20 02:14:55.527035 | 
2026-04-20 02:14:55.527149 | TASK [Generate Zuul manifest]
2026-04-20 02:14:55.550301 | localhost | ok
2026-04-20 02:14:55.567762 | 
2026-04-20 02:14:55.567939 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-20 02:14:55.957379 | localhost | changed
2026-04-20 02:14:55.972979 | 
2026-04-20 02:14:55.973153 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-20 02:14:56.004440 | localhost | ok
2026-04-20 02:14:56.016360 | 
2026-04-20 02:14:56.016490 | TASK [Upload logs]
2026-04-20 02:14:56.037288 | localhost | ok
2026-04-20 02:14:56.106518 | 
2026-04-20 02:14:56.106678 | TASK [Set zuul-log-path fact]
2026-04-20 02:14:56.129545 | localhost | ok
2026-04-20 02:14:56.143300 | 
2026-04-20 02:14:56.143438 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-20 02:14:56.176143 | localhost | ok
2026-04-20 02:14:56.186682 | 
2026-04-20 02:14:56.186832 | TASK [upload-logs : Create log directories]
2026-04-20 02:14:56.636173 | localhost | changed
2026-04-20 02:14:56.643957 | 
2026-04-20 02:14:56.644138 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-20 02:14:57.070963 | localhost -> localhost | ok: Runtime: 0:00:00.008369
2026-04-20 02:14:57.076814 | 
2026-04-20 02:14:57.076910 | TASK [upload-logs : Upload logs to log server]
2026-04-20 02:14:57.579377 | localhost | Output suppressed because no_log was given
2026-04-20 02:14:57.585190 | 
2026-04-20 02:14:57.585307 | LOOP [upload-logs : Compress console log and json output]
2026-04-20 02:14:57.648455 | localhost | skipping: Conditional result was False
2026-04-20 02:14:57.655252 | localhost | skipping: Conditional result was False
2026-04-20 02:14:57.668670 | 
2026-04-20 02:14:57.668844 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-20 02:14:57.725303 | localhost | skipping: Conditional result was False
2026-04-20 02:14:57.725600 | 
2026-04-20 02:14:57.726438 | localhost | skipping: Conditional result was False
2026-04-20 02:14:57.745817 | 
2026-04-20 02:14:57.745985 | LOOP [upload-logs : Upload console log and json output]