2026-04-28 01:03:54.565537 | Job console starting
2026-04-28 01:03:54.575723 | Updating git repos
2026-04-28 01:03:54.603237 | Cloning repos into workspace
2026-04-28 01:03:54.659321 | Restoring repo states
2026-04-28 01:03:54.677524 | Merging changes
2026-04-28 01:03:54.964767 | Checking out repos
2026-04-28 01:03:54.999649 | Preparing playbooks
2026-04-28 01:03:57.302020 | Running Ansible setup
2026-04-28 01:04:01.324105 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-28 01:04:01.882842 | 
2026-04-28 01:04:01.882956 | PLAY [localhost]
2026-04-28 01:04:01.890183 | 
2026-04-28 01:04:01.890248 | TASK [Gathering Facts]
2026-04-28 01:04:02.827311 | localhost | ok
2026-04-28 01:04:02.839472 | 
2026-04-28 01:04:02.839595 | TASK [Setup log path fact]
2026-04-28 01:04:02.868659 | localhost | ok
2026-04-28 01:04:02.884990 | 
2026-04-28 01:04:02.885076 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-28 01:04:02.912948 | localhost | ok
2026-04-28 01:04:02.920439 | 
2026-04-28 01:04:02.920505 | TASK [emit-job-header : Print job information]
2026-04-28 01:04:02.958668 | # Job Information
2026-04-28 01:04:02.958814 | Ansible Version: 2.16.16
2026-04-28 01:04:02.958857 | Job: pre-commit
2026-04-28 01:04:02.958886 | Pipeline: check
2026-04-28 01:04:02.958914 | Executor: 0a8996d2b663
2026-04-28 01:04:02.958940 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/125
2026-04-28 01:04:02.959031 | Event ID: 07f9bf70-429e-11f1-8b75-3e63c4c208bf
2026-04-28 01:04:02.962742 | 
2026-04-28 01:04:02.962827 | LOOP [emit-job-header : Print node information]
2026-04-28 01:04:03.058730 | localhost | ok:
2026-04-28 01:04:03.058957 | localhost | # Node Information
2026-04-28 01:04:03.058994 | localhost | Inventory Hostname: ubuntu-noble
2026-04-28 01:04:03.059022 | localhost | Hostname: np0000170761
2026-04-28 01:04:03.059047 | localhost | Username: zuul
2026-04-28 01:04:03.059077 | localhost | Distro: Ubuntu 24.04
2026-04-28 01:04:03.059104 | localhost | Provider: yul1
2026-04-28 01:04:03.059129 | localhost | Region: ca-ymq-1
2026-04-28 01:04:03.059153 | localhost | Label: ubuntu-noble
2026-04-28 01:04:03.059176 | localhost | Product Name: OpenStack Nova
2026-04-28 01:04:03.059201 | localhost | Interface IP: 199.204.45.210
2026-04-28 01:04:03.068762 | 
2026-04-28 01:04:03.068931 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-28 01:04:03.513350 | localhost -> localhost | changed
2026-04-28 01:04:03.556244 | 
2026-04-28 01:04:03.556343 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-28 01:04:04.401640 | localhost -> localhost | changed
2026-04-28 01:04:04.415918 | 
2026-04-28 01:04:04.416060 | PLAY [all]
2026-04-28 01:04:04.432540 | 
2026-04-28 01:04:04.432676 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-28 01:04:04.693287 | ubuntu-noble -> localhost | ok
2026-04-28 01:04:04.701595 | 
2026-04-28 01:04:04.701666 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-28 01:04:04.740033 | ubuntu-noble | ok
2026-04-28 01:04:04.758919 | ubuntu-noble | included: /var/lib/zuul/builds/a6fc70b955c5495492363fe17f4798cd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-28 01:04:04.904386 | 
2026-04-28 01:04:04.904556 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-28 01:04:05.931091 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-04-28 01:04:05.931291 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a6fc70b955c5495492363fe17f4798cd/work/a6fc70b955c5495492363fe17f4798cd_id_rsa
2026-04-28 01:04:05.931323 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a6fc70b955c5495492363fe17f4798cd/work/a6fc70b955c5495492363fe17f4798cd_id_rsa.pub
2026-04-28 01:04:05.931346 | ubuntu-noble -> localhost | The key fingerprint is:
2026-04-28 01:04:05.931367 | ubuntu-noble -> localhost | SHA256:vMpWLGMLxjhQpskyjBxLKSHoMueOud78m2JOQMm+IzM zuul-build-sshkey
2026-04-28 01:04:05.931398 | ubuntu-noble -> localhost | The key's randomart image is:
2026-04-28 01:04:05.931420 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-04-28 01:04:05.931445 | ubuntu-noble -> localhost | |+..              |
2026-04-28 01:04:05.931467 | ubuntu-noble -> localhost | |=++              |
2026-04-28 01:04:05.931487 | ubuntu-noble -> localhost | |OOo              |
2026-04-28 01:04:05.931507 | ubuntu-noble -> localhost | |%*.    .         |
2026-04-28 01:04:05.931527 | ubuntu-noble -> localhost | |oO o   .S        |
2026-04-28 01:04:05.931547 | ubuntu-noble -> localhost | |  * + + o.       |
2026-04-28 01:04:05.931566 | ubuntu-noble -> localhost | |E* + o =.        |
2026-04-28 01:04:05.931586 | ubuntu-noble -> localhost | |+o*o .+.         |
2026-04-28 01:04:05.931608 | ubuntu-noble -> localhost | |ooo+o=+          |
2026-04-28 01:04:05.931629 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-04-28 01:04:05.931678 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.619823
2026-04-28 01:04:05.937988 | 
2026-04-28 01:04:05.938055 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-28 01:04:05.970753 | ubuntu-noble | ok
2026-04-28 01:04:06.161017 | ubuntu-noble | included: /var/lib/zuul/builds/a6fc70b955c5495492363fe17f4798cd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-28 01:04:06.179009 | 
2026-04-28 01:04:06.179157 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-28 01:04:06.203827 | ubuntu-noble | skipping: Conditional result was False
2026-04-28 01:04:06.216718 | 
2026-04-28 01:04:06.216898 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-28 01:04:06.748929 | ubuntu-noble | changed
2026-04-28 01:04:07.092252 | 
2026-04-28 01:04:07.092378 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-28 01:04:07.320566 | ubuntu-noble | ok
2026-04-28 01:04:07.327739 | 
2026-04-28 01:04:07.327807 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-28 01:04:07.892172 | ubuntu-noble | changed
2026-04-28 01:04:08.081385 | 
2026-04-28 01:04:08.081497 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-28 01:04:08.636653 | ubuntu-noble | changed
2026-04-28 01:04:08.894648 | 
2026-04-28 01:04:08.894767 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-28 01:04:08.919068 | ubuntu-noble | skipping: Conditional result was False
2026-04-28 01:04:08.930347 | 
2026-04-28 01:04:08.930448 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-28 01:04:09.348831 | ubuntu-noble -> localhost | changed
2026-04-28 01:04:09.369019 | 
2026-04-28 01:04:09.369117 | TASK [add-build-sshkey : Add back temp key]
2026-04-28 01:04:09.662841 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a6fc70b955c5495492363fe17f4798cd/work/a6fc70b955c5495492363fe17f4798cd_id_rsa (zuul-build-sshkey)
2026-04-28 01:04:09.663157 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013113
2026-04-28 01:04:09.669221 | 
2026-04-28 01:04:10.037857 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-28 01:04:10.407777 | ubuntu-noble | ok
2026-04-28 01:04:10.415428 | 
2026-04-28 01:04:10.415499 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-28 01:04:10.450528 | ubuntu-noble | skipping: Conditional result was False
2026-04-28 01:04:10.718542 | 
2026-04-28 01:04:10.718670 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-28 01:04:11.138609 | ubuntu-noble | ok
2026-04-28 01:04:11.156161 | 
2026-04-28 01:04:11.156269 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-28 01:04:12.121987 | ubuntu-noble | Output suppressed because no_log was given
2026-04-28 01:04:12.133567 | 
2026-04-28 01:04:12.133700 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-28 01:04:12.407031 | ubuntu-noble | ok: "logs"
2026-04-28 01:04:12.407223 | ubuntu-noble | ok: All items complete
2026-04-28 01:04:12.407261 | 
2026-04-28 01:04:12.550646 | ubuntu-noble | ok: "artifacts"
2026-04-28 01:04:12.803166 | ubuntu-noble | ok: "docs"
2026-04-28 01:04:12.819974 | 
2026-04-28 01:04:12.820111 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-28 01:04:13.048514 | ubuntu-noble | changed: "logs"
2026-04-28 01:04:13.232440 | ubuntu-noble | changed: "artifacts"
2026-04-28 01:04:13.434397 | ubuntu-noble | changed: "docs"
2026-04-28 01:04:13.447939 | 
2026-04-28 01:04:13.448001 | PLAY RECAP
2026-04-28 01:04:13.448044 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-28 01:04:13.448073 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-28 01:04:13.448094 | 
2026-04-28 01:04:13.616218 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-28 01:04:13.619752 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-28 01:04:14.247779 | 
2026-04-28 01:04:14.248427 | PLAY [all]
2026-04-28 01:04:14.260897 | 
2026-04-28 01:04:14.261017 | TASK [setup-uv : Extract archive]
2026-04-28 01:04:16.757429 | ubuntu-noble | changed
2026-04-28 01:04:16.767052 | 
2026-04-28 01:04:16.767153 | TASK [setup-uv : Print version]
2026-04-28 01:04:15.990116 | ubuntu-noble | uv 0.8.13
2026-04-28 01:04:17.315946 | ubuntu-noble | ok: Runtime: 0:00:00.015583
2026-04-28 01:04:17.325973 | 
2026-04-28 01:04:17.326062 | PLAY RECAP
2026-04-28 01:04:17.326114 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-28 01:04:17.326140 | 
2026-04-28 01:04:17.455800 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-28 01:04:17.456886 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-28 01:04:18.074881 | 
2026-04-28 01:04:18.075968 | PLAY [all]
2026-04-28 01:04:18.087371 | 
2026-04-28 01:04:18.087463 | TASK [Run "pre-commit"]
2026-04-28 01:04:17.554131 | ubuntu-noble | Downloading virtualenv (7.2MiB)
2026-04-28 01:04:17.655033 | ubuntu-noble |  Downloading virtualenv
2026-04-28 01:04:17.667641 | ubuntu-noble | Installed 10 packages in 11ms
2026-04-28 01:04:18.035050 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-28 01:04:20.844948 | 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-28 01:04:20.849947 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-04-28 01:04:21.364570 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-04-28 01:04:21.765943 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-04-28 01:04:22.182331 | 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-28 01:04:22.184225 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-04-28 01:04:22.716284 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-04-28 01:04:23.241076 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-28 01:04:23.241175 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-28 01:04:23.241194 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-28 01:04:27.121773 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-04-28 01:04:27.121907 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-28 01:04:27.121924 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-28 01:04:31.270200 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-04-28 01:04:31.270296 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-28 01:04:31.270318 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-28 01:04:34.579422 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-04-28 01:04:34.579489 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-28 01:04:34.579500 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-28 01:04:37.316787 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-04-28 01:04:37.316944 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-28 01:04:37.316971 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-28 01:04:47.634806 | ubuntu-noble | fix end of files.........................................................Passed
2026-04-28 01:04:47.693969 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-04-28 01:04:47.953359 | ubuntu-noble | black....................................................................Passed
2026-04-28 01:04:48.150807 | ubuntu-noble | flake8...................................................................Passed
2026-04-28 01:04:48.275464 | ubuntu-noble | isort....................................................................Passed
2026-04-28 01:05:05.379037 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-04-28 01:05:05.710912 | ubuntu-noble | ok: Runtime: 0:00:48.145202
2026-04-28 01:05:05.713264 | 
2026-04-28 01:05:05.713334 | PLAY RECAP
2026-04-28 01:05:05.713399 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-28 01:05:05.713430 | 
2026-04-28 01:05:05.848109 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-28 01:05:05.850226 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-28 01:05:06.450141 | 
2026-04-28 01:05:06.646794 | PLAY [all]
2026-04-28 01:05:06.667599 | 
2026-04-28 01:05:06.905199 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-28 01:05:06.953814 | ubuntu-noble | skipping: Conditional result was False
2026-04-28 01:05:06.963948 | 
2026-04-28 01:05:06.964061 | TASK [fetch-output : Set log path for single node]
2026-04-28 01:05:07.008190 | ubuntu-noble | ok
2026-04-28 01:05:07.013521 | 
2026-04-28 01:05:07.013591 | LOOP [fetch-output : Ensure local output dirs]
2026-04-28 01:05:07.424482 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/a6fc70b955c5495492363fe17f4798cd/work/logs"
2026-04-28 01:05:07.645802 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/a6fc70b955c5495492363fe17f4798cd/work/artifacts"
2026-04-28 01:05:07.855529 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/a6fc70b955c5495492363fe17f4798cd/work/docs"
2026-04-28 01:05:07.872450 | 
2026-04-28 01:05:07.872588 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-28 01:05:08.537307 | ubuntu-noble | changed: .d..t...... ./
2026-04-28 01:05:08.537767 | ubuntu-noble | changed: All items complete
2026-04-28 01:05:08.537797 | 
2026-04-28 01:05:09.022102 | ubuntu-noble | changed: .d..t...... ./
2026-04-28 01:05:09.805873 | ubuntu-noble | changed: .d..t...... ./
2026-04-28 01:05:09.827185 | 
2026-04-28 01:05:09.827369 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-28 01:05:10.233943 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007596
2026-04-28 01:05:10.490488 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008527
2026-04-28 01:05:10.512816 | 
2026-04-28 01:05:10.513031 | PLAY [all]
2026-04-28 01:05:10.527569 | 
2026-04-28 01:05:10.527943 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-28 01:05:10.983787 | ubuntu-noble | changed
2026-04-28 01:05:10.990003 | 
2026-04-28 01:05:10.990062 | PLAY RECAP
2026-04-28 01:05:10.990114 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-28 01:05:10.990136 | 
2026-04-28 01:05:11.106830 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-28 01:05:11.108495 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-28 01:05:11.739395 | 
2026-04-28 01:05:12.067445 | PLAY [localhost]
2026-04-28 01:05:12.084760 | 
2026-04-28 01:05:12.084891 | TASK [Generate Zuul manifest]
2026-04-28 01:05:12.106555 | localhost | ok
2026-04-28 01:05:12.123917 | 
2026-04-28 01:05:12.124086 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-28 01:05:13.209970 | localhost | changed
2026-04-28 01:05:13.223685 | 
2026-04-28 01:05:13.223822 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-28 01:05:13.479451 | localhost | ok
2026-04-28 01:05:13.495860 | 
2026-04-28 01:05:13.495962 | TASK [Upload logs]
2026-04-28 01:05:13.518090 | localhost | ok
2026-04-28 01:05:13.577011 | 
2026-04-28 01:05:13.754191 | TASK [Set zuul-log-path fact]
2026-04-28 01:05:13.777500 | localhost | ok
2026-04-28 01:05:13.790223 | 
2026-04-28 01:05:13.790301 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-28 01:05:13.832772 | localhost | ok
2026-04-28 01:05:13.842339 | 
2026-04-28 01:05:13.842404 | TASK [upload-logs : Create log directories]
2026-04-28 01:05:14.321841 | localhost | changed
2026-04-28 01:05:14.328071 | 
2026-04-28 01:05:14.328136 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-28 01:05:14.762809 | localhost -> localhost | ok: Runtime: 0:00:00.016874
2026-04-28 01:05:14.767750 | 
2026-04-28 01:05:14.767815 | TASK [upload-logs : Upload logs to log server]
2026-04-28 01:05:15.247877 | localhost | Output suppressed because no_log was given
2026-04-28 01:05:15.251487 | 
2026-04-28 01:05:15.251548 | LOOP [upload-logs : Compress console log and json output]
2026-04-28 01:05:15.312093 | localhost | skipping: Conditional result was False
2026-04-28 01:05:15.319763 | localhost | skipping: Conditional result was False
2026-04-28 01:05:15.331843 | 
2026-04-28 01:05:15.331969 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-28 01:05:15.375028 | localhost | skipping: Conditional result was False
2026-04-28 01:05:15.375297 | 
2026-04-28 01:05:15.379741 | localhost | skipping: Conditional result was False
2026-04-28 01:05:15.394511 | 
2026-04-28 01:05:15.394666 | LOOP [upload-logs : Upload console log and json output]