2026-08-14 00:40:26.434496 | Job console starting
2026-08-14 00:40:26.449763 | Updating git repos
2026-08-14 00:40:26.490785 | Cloning repos into workspace
2026-08-14 00:40:26.539774 | Restoring repo states
2026-08-14 00:40:26.548881 | Merging changes
2026-08-14 00:40:27.132818 | Checking out repos
2026-08-14 00:40:27.227367 | Preparing playbooks
2026-08-14 00:40:28.853847 | Running Ansible setup
2026-08-14 00:40:33.792587 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-14 00:40:34.432657 | 
2026-08-14 00:40:34.432814 | PLAY [localhost]
2026-08-14 00:40:34.440355 | 
2026-08-14 00:40:34.440424 | TASK [Gathering Facts]
2026-08-14 00:40:35.371714 | localhost | ok
2026-08-14 00:40:35.378899 | 
2026-08-14 00:40:35.378977 | TASK [Setup log path fact]
2026-08-14 00:40:35.398875 | localhost | ok
2026-08-14 00:40:35.411285 | 
2026-08-14 00:40:35.413540 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-14 00:40:35.444565 | localhost | ok
2026-08-14 00:40:35.451898 | 
2026-08-14 00:40:35.451972 | TASK [emit-job-header : Print job information]
2026-08-14 00:40:35.483188 | # Job Information
2026-08-14 00:40:35.483345 | Ansible Version: 2.16.18
2026-08-14 00:40:35.483391 | Job: pre-commit
2026-08-14 00:40:35.483422 | Pipeline: check
2026-08-14 00:40:35.483450 | Executor: 2d72f0692154
2026-08-14 00:40:35.483478 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/136
2026-08-14 00:40:35.483509 | Event ID: 2468e580-9778-11f1-8091-189546dadf6b
2026-08-14 00:40:35.487214 | 
2026-08-14 00:40:35.487303 | LOOP [emit-job-header : Print node information]
2026-08-14 00:40:35.582197 | localhost | ok:
2026-08-14 00:40:35.582801 | localhost | # Node Information
2026-08-14 00:40:35.582833 | localhost | Inventory Hostname: ubuntu-noble
2026-08-14 00:40:35.582856 | localhost | Hostname: np0000189467
2026-08-14 00:40:35.582878 | localhost | Username: zuul
2026-08-14 00:40:35.582903 | localhost | Distro: Ubuntu 24.04
2026-08-14 00:40:35.582924 | localhost | Provider: yul1
2026-08-14 00:40:35.582943 | localhost | Region: ca-ymq-1
2026-08-14 00:40:35.582963 | localhost | Label: ubuntu-noble
2026-08-14 00:40:35.582982 | localhost | Product Name: OpenStack Nova
2026-08-14 00:40:35.583002 | localhost | Interface IP: 199.204.45.72
2026-08-14 00:40:35.595439 | 
2026-08-14 00:40:35.595557 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-14 00:40:36.076423 | localhost -> localhost | changed
2026-08-14 00:40:36.086208 | 
2026-08-14 00:40:36.086425 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-14 00:40:36.932905 | localhost -> localhost | changed
2026-08-14 00:40:36.941003 | 
2026-08-14 00:40:36.941058 | PLAY [all]
2026-08-14 00:40:36.949339 | 
2026-08-14 00:40:36.949409 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-14 00:40:37.195685 | ubuntu-noble -> localhost | ok
2026-08-14 00:40:37.208948 | 
2026-08-14 00:40:37.209034 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-14 00:40:37.240098 | ubuntu-noble | ok
2026-08-14 00:40:37.257064 | ubuntu-noble | included: /var/lib/zuul/builds/97a9af2938174e2dbefc447db6ecf6f7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-14 00:40:37.263030 | 
2026-08-14 00:40:37.263103 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-14 00:40:38.843434 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-08-14 00:40:38.843680 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/97a9af2938174e2dbefc447db6ecf6f7/work/97a9af2938174e2dbefc447db6ecf6f7_id_rsa
2026-08-14 00:40:38.843723 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/97a9af2938174e2dbefc447db6ecf6f7/work/97a9af2938174e2dbefc447db6ecf6f7_id_rsa.pub
2026-08-14 00:40:38.843755 | ubuntu-noble -> localhost | The key fingerprint is:
2026-08-14 00:40:38.843784 | ubuntu-noble -> localhost | SHA256:q6hjmcEzYKD1yocwfTvCfvdCo3Y9X5iSWKbu3fDWBqI zuul-build-sshkey
2026-08-14 00:40:38.843833 | ubuntu-noble -> localhost | The key's randomart image is:
2026-08-14 00:40:38.843862 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-08-14 00:40:38.843898 | ubuntu-noble -> localhost | |                 |
2026-08-14 00:40:38.843928 | ubuntu-noble -> localhost | |. .              |
2026-08-14 00:40:38.843957 | ubuntu-noble -> localhost | |oo .             |
2026-08-14 00:40:38.843985 | ubuntu-noble -> localhost | |=.. o            |
2026-08-14 00:40:38.844013 | ubuntu-noble -> localhost | |.B + .  S        |
2026-08-14 00:40:38.844041 | ubuntu-noble -> localhost | |  @ + o=.o.o     |
2026-08-14 00:40:38.844069 | ubuntu-noble -> localhost | | . O +o+=.oo.    |
2026-08-14 00:40:38.844096 | ubuntu-noble -> localhost | |  * +oEoo=..o    |
2026-08-14 00:40:38.844128 | ubuntu-noble -> localhost | | ..=.++oo++.     |
2026-08-14 00:40:38.844157 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-08-14 00:40:38.844221 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.118334
2026-08-14 00:40:38.851790 | 
2026-08-14 00:40:38.851860 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-14 00:40:38.888306 | ubuntu-noble | ok
2026-08-14 00:40:38.899144 | ubuntu-noble | included: /var/lib/zuul/builds/97a9af2938174e2dbefc447db6ecf6f7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-14 00:40:38.910109 | 
2026-08-14 00:40:38.910169 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-14 00:40:38.935171 | ubuntu-noble | skipping: Conditional result was False
2026-08-14 00:40:38.943384 | 
2026-08-14 00:40:38.943480 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-14 00:40:39.507408 | ubuntu-noble | changed
2026-08-14 00:40:39.515008 | 
2026-08-14 00:40:39.515073 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-14 00:40:39.745774 | ubuntu-noble | ok
2026-08-14 00:40:39.754120 | 
2026-08-14 00:40:39.754200 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-14 00:40:40.345479 | ubuntu-noble | changed
2026-08-14 00:40:40.352515 | 
2026-08-14 00:40:40.352636 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-14 00:40:40.925299 | ubuntu-noble | changed
2026-08-14 00:40:40.933121 | 
2026-08-14 00:40:40.933189 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-14 00:40:40.957759 | ubuntu-noble | skipping: Conditional result was False
2026-08-14 00:40:40.970412 | 
2026-08-14 00:40:40.970550 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-14 00:40:41.346358 | ubuntu-noble -> localhost | changed
2026-08-14 00:40:41.362832 | 
2026-08-14 00:40:41.362907 | TASK [add-build-sshkey : Add back temp key]
2026-08-14 00:40:41.655077 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/97a9af2938174e2dbefc447db6ecf6f7/work/97a9af2938174e2dbefc447db6ecf6f7_id_rsa (zuul-build-sshkey)
2026-08-14 00:40:41.655327 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014188
2026-08-14 00:40:41.661903 | 
2026-08-14 00:40:41.661967 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-14 00:40:42.040427 | ubuntu-noble | ok
2026-08-14 00:40:42.048141 | 
2026-08-14 00:40:42.048246 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-14 00:40:42.074510 | ubuntu-noble | skipping: Conditional result was False
2026-08-14 00:40:42.091096 | 
2026-08-14 00:40:42.091219 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-14 00:40:42.447584 | ubuntu-noble | ok
2026-08-14 00:40:42.527510 | 
2026-08-14 00:40:42.527728 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-14 00:40:43.259528 | ubuntu-noble | Output suppressed because no_log was given
2026-08-14 00:40:43.271790 | 
2026-08-14 00:40:43.271880 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-14 00:40:43.501461 | ubuntu-noble | ok: "logs"
2026-08-14 00:40:43.501773 | ubuntu-noble | ok: All items complete
2026-08-14 00:40:43.501826 | 
2026-08-14 00:40:43.701537 | ubuntu-noble | ok: "artifacts"
2026-08-14 00:40:43.896537 | ubuntu-noble | ok: "docs"
2026-08-14 00:40:43.908285 | 
2026-08-14 00:40:43.908450 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-14 00:40:44.142357 | ubuntu-noble | changed: "logs"
2026-08-14 00:40:44.336440 | ubuntu-noble | changed: "artifacts"
2026-08-14 00:40:44.538492 | ubuntu-noble | changed: "docs"
2026-08-14 00:40:44.554702 | 
2026-08-14 00:40:44.554826 | PLAY RECAP
2026-08-14 00:40:44.554875 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-14 00:40:44.554906 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-14 00:40:44.554930 | 
2026-08-14 00:40:44.749458 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-14 00:40:44.751819 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-08-14 00:40:45.345602 | 
2026-08-14 00:40:45.345758 | PLAY [all]
2026-08-14 00:40:45.359022 | 
2026-08-14 00:40:45.359152 | TASK [setup-uv : Extract archive]
2026-08-14 00:40:47.948166 | ubuntu-noble | changed
2026-08-14 00:40:47.956833 | 
2026-08-14 00:40:47.956918 | TASK [setup-uv : Print version]
2026-08-14 00:40:48.349774 | ubuntu-noble | uv 0.8.13
2026-08-14 00:40:48.495576 | ubuntu-noble | ok: Runtime: 0:00:00.015345
2026-08-14 00:40:48.504221 | 
2026-08-14 00:40:48.504288 | PLAY RECAP
2026-08-14 00:40:48.504334 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-14 00:40:48.504359 | 
2026-08-14 00:40:48.643950 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-08-14 00:40:48.646087 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-08-14 00:40:49.241186 | 
2026-08-14 00:40:49.241344 | PLAY [all]
2026-08-14 00:40:49.254035 | 
2026-08-14 00:40:49.254153 | TASK [Run "pre-commit"]
2026-08-14 00:40:49.818533 | ubuntu-noble | Downloading virtualenv (5.1MiB)
2026-08-14 00:40:49.901819 | ubuntu-noble |  Downloading virtualenv
2026-08-14 00:40:49.915184 | ubuntu-noble | Installed 10 packages in 12ms
2026-08-14 00:40:50.310577 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-08-14 00:40:51.339020 | 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-14 00:40:51.345055 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-08-14 00:40:52.635568 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-08-14 00:40:53.341133 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-08-14 00:40:54.585016 | 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-14 00:40:54.586835 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-08-14 00:40:55.246125 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-08-14 00:40:56.714007 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-08-14 00:40:56.714077 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-14 00:40:56.714095 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-14 00:41:00.538054 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-08-14 00:41:00.538147 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-14 00:41:00.538159 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-14 00:41:04.933695 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-08-14 00:41:04.933796 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-14 00:41:04.933819 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-14 00:41:08.158683 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-08-14 00:41:08.158842 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-14 00:41:08.158866 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-14 00:41:10.960633 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-08-14 00:41:10.960780 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-14 00:41:10.960800 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-14 00:41:21.900560 | ubuntu-noble | fix end of files.........................................................Passed
2026-08-14 00:41:21.954109 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-08-14 00:41:22.235411 | ubuntu-noble | black....................................................................Passed
2026-08-14 00:41:22.435494 | ubuntu-noble | flake8...................................................................Passed
2026-08-14 00:41:22.557071 | ubuntu-noble | isort....................................................................Passed
2026-08-14 00:41:46.575671 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-08-14 00:41:46.879335 | ubuntu-noble | ok: Runtime: 0:00:57.008082
2026-08-14 00:41:46.881819 | 
2026-08-14 00:41:46.881891 | PLAY RECAP
2026-08-14 00:41:46.881952 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-14 00:41:46.881982 | 
2026-08-14 00:41:47.002541 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-08-14 00:41:47.005215 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-14 00:41:47.567488 | 
2026-08-14 00:41:47.567616 | PLAY [all]
2026-08-14 00:41:47.579970 | 
2026-08-14 00:41:47.580057 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-14 00:41:47.624492 | ubuntu-noble | skipping: Conditional result was False
2026-08-14 00:41:47.636185 | 
2026-08-14 00:41:47.636345 | TASK [fetch-output : Set log path for single node]
2026-08-14 00:41:47.670158 | ubuntu-noble | ok
2026-08-14 00:41:47.677008 | 
2026-08-14 00:41:47.677103 | LOOP [fetch-output : Ensure local output dirs]
2026-08-14 00:41:48.081631 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/97a9af2938174e2dbefc447db6ecf6f7/work/logs"
2026-08-14 00:41:48.289681 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/97a9af2938174e2dbefc447db6ecf6f7/work/artifacts"
2026-08-14 00:41:48.514830 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/97a9af2938174e2dbefc447db6ecf6f7/work/docs"
2026-08-14 00:41:48.537341 | 
2026-08-14 00:41:48.537526 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-14 00:41:49.235024 | ubuntu-noble | ok
2026-08-14 00:41:49.235259 | ubuntu-noble | changed: All items complete
2026-08-14 00:41:49.235286 | 
2026-08-14 00:41:49.726125 | ubuntu-noble | changed: .d..t...... ./
2026-08-14 00:41:50.217974 | ubuntu-noble | changed: .d..t...... ./
2026-08-14 00:41:50.243721 | 
2026-08-14 00:41:50.243896 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-14 00:41:50.701128 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008811
2026-08-14 00:41:50.914728 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007661
2026-08-14 00:41:50.934181 | 
2026-08-14 00:41:50.934309 | PLAY [all]
2026-08-14 00:41:50.940884 | 
2026-08-14 00:41:50.940966 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-14 00:41:51.470272 | ubuntu-noble | changed
2026-08-14 00:41:51.478631 | 
2026-08-14 00:41:51.478696 | PLAY RECAP
2026-08-14 00:41:51.478762 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-14 00:41:51.478794 | 
2026-08-14 00:41:51.598766 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-14 00:41:51.599869 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-14 00:41:52.192593 | 
2026-08-14 00:41:52.192738 | PLAY [localhost]
2026-08-14 00:41:52.203748 | 
2026-08-14 00:41:52.203818 | TASK [Generate Zuul manifest]
2026-08-14 00:41:52.222742 | localhost | ok
2026-08-14 00:41:52.240278 | 
2026-08-14 00:41:52.240351 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-14 00:41:52.604988 | localhost | changed
2026-08-14 00:41:52.617233 | 
2026-08-14 00:41:52.617307 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-14 00:41:52.646008 | localhost | ok
2026-08-14 00:41:52.656746 | 
2026-08-14 00:41:52.656838 | TASK [Upload logs]
2026-08-14 00:41:52.676341 | localhost | ok
2026-08-14 00:41:52.733351 | 
2026-08-14 00:41:52.733435 | TASK [Set zuul-log-path fact]
2026-08-14 00:41:52.754470 | localhost | ok
2026-08-14 00:41:52.769379 | 
2026-08-14 00:41:52.769445 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-14 00:41:52.800033 | localhost | ok
2026-08-14 00:41:52.811128 | 
2026-08-14 00:41:52.811191 | TASK [upload-logs : Create log directories]
2026-08-14 00:41:53.196565 | localhost | changed
2026-08-14 00:41:53.203020 | 
2026-08-14 00:41:53.203116 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-14 00:41:53.599617 | localhost -> localhost | ok: Runtime: 0:00:00.005484
2026-08-14 00:41:53.604372 | 
2026-08-14 00:41:53.604437 | TASK [upload-logs : Upload logs to log server]
2026-08-14 00:41:54.069376 | localhost | Output suppressed because no_log was given
2026-08-14 00:41:54.074479 | 
2026-08-14 00:41:54.074568 | LOOP [upload-logs : Compress console log and json output]
2026-08-14 00:41:54.117295 | localhost | skipping: Conditional result was False
2026-08-14 00:41:54.124332 | localhost | skipping: Conditional result was False
2026-08-14 00:41:54.135499 | 
2026-08-14 00:41:54.135674 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-14 00:41:54.175294 | localhost | skipping: Conditional result was False
2026-08-14 00:41:54.175701 | 
2026-08-14 00:41:54.178949 | localhost | skipping: Conditional result was False
2026-08-14 00:41:54.189540 | 
2026-08-14 00:41:54.189741 | LOOP [upload-logs : Upload console log and json output]