2026-03-13 09:42:46.453363 | Job console starting
2026-03-13 09:42:46.830772 | Updating git repos
2026-03-13 09:42:46.888535 | Cloning repos into workspace
2026-03-13 09:42:47.054531 | Restoring repo states
2026-03-13 09:42:47.062213 | Merging changes
2026-03-13 09:42:47.797119 | Checking out repos
2026-03-13 09:42:48.458142 | Preparing playbooks
2026-03-13 09:42:51.570491 | Running Ansible setup
2026-03-13 09:42:55.758329 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-13 09:42:56.390550 | 
2026-03-13 09:42:56.390712 | PLAY [localhost]
2026-03-13 09:42:56.399402 | 
2026-03-13 09:42:56.399496 | TASK [Gathering Facts]
2026-03-13 09:42:57.493793 | localhost | ok
2026-03-13 09:42:57.501711 | 
2026-03-13 09:42:57.501805 | TASK [Setup log path fact]
2026-03-13 09:42:57.522027 | localhost | ok
2026-03-13 09:42:57.540775 | 
2026-03-13 09:42:57.540895 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-13 09:42:57.581017 | localhost | ok
2026-03-13 09:42:57.587408 | 
2026-03-13 09:42:57.587479 | TASK [emit-job-header : Print job information]
2026-03-13 09:42:57.626196 | # Job Information
2026-03-13 09:42:57.648281 | Ansible Version: 2.16.16
2026-03-13 09:42:57.648421 | Job: pre-commit
2026-03-13 09:42:57.648484 | Pipeline: check
2026-03-13 09:42:57.648534 | Executor: 0a8996d2b663
2026-03-13 09:42:57.648582 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/93
2026-03-13 09:42:57.648637 | Event ID: 35b6d780-1e78-11f1-8b5e-2a8ec2027042
2026-03-13 09:42:57.655345 | 
2026-03-13 09:42:57.655453 | LOOP [emit-job-header : Print node information]
2026-03-13 09:42:57.788740 | localhost | ok:
2026-03-13 09:42:57.789070 | localhost | # Node Information
2026-03-13 09:42:57.789137 | localhost | Inventory Hostname: ubuntu-noble
2026-03-13 09:42:57.789188 | localhost | Hostname: np0000158635
2026-03-13 09:42:57.789232 | localhost | Username: zuul
2026-03-13 09:42:57.789282 | localhost | Distro: Ubuntu 24.04
2026-03-13 09:42:57.789326 | localhost | Provider: yul1
2026-03-13 09:42:57.789368 | localhost | Region: ca-ymq-1
2026-03-13 09:42:57.789409 | localhost | Label: ubuntu-noble
2026-03-13 09:42:57.789450 | localhost | Product Name: OpenStack Nova
2026-03-13 09:42:57.789492 | localhost | Interface IP: 199.19.213.226
2026-03-13 09:42:57.802920 | 
2026-03-13 09:42:57.803065 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-13 09:42:58.699438 | localhost -> localhost | changed
2026-03-13 09:42:58.706439 | 
2026-03-13 09:42:58.706608 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-13 09:43:00.829535 | localhost -> localhost | changed
2026-03-13 09:43:00.835880 | 
2026-03-13 09:43:00.835986 | PLAY [all]
2026-03-13 09:43:00.850847 | 
2026-03-13 09:43:00.850965 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-13 09:43:01.129750 | ubuntu-noble -> localhost | ok
2026-03-13 09:43:01.141079 | 
2026-03-13 09:43:01.141176 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-13 09:43:01.174121 | ubuntu-noble | ok
2026-03-13 09:43:01.189495 | ubuntu-noble | included: /var/lib/zuul/builds/4810b3faf3ba44a88e1fb24e6b2c291d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-13 09:43:01.196798 | 
2026-03-13 09:43:01.197005 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-13 09:43:02.246368 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-03-13 09:43:02.246633 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/4810b3faf3ba44a88e1fb24e6b2c291d/work/4810b3faf3ba44a88e1fb24e6b2c291d_id_rsa
2026-03-13 09:43:02.246698 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/4810b3faf3ba44a88e1fb24e6b2c291d/work/4810b3faf3ba44a88e1fb24e6b2c291d_id_rsa.pub
2026-03-13 09:43:02.246747 | ubuntu-noble -> localhost | The key fingerprint is:
2026-03-13 09:43:02.246794 | ubuntu-noble -> localhost | SHA256:l9em0AXCg1ckm9U0Bif4HdeWNQdEyqNWWY7jYy7D1w0 zuul-build-sshkey
2026-03-13 09:43:02.246857 | ubuntu-noble -> localhost | The key's randomart image is:
2026-03-13 09:43:02.246903 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-03-13 09:43:02.246958 | ubuntu-noble -> localhost | |         oo+B*Xo*|
2026-03-13 09:43:02.247005 | ubuntu-noble -> localhost | |        . =B @oo*|
2026-03-13 09:43:02.247049 | ubuntu-noble -> localhost | |         .ooO.o+ |
2026-03-13 09:43:02.247093 | ubuntu-noble -> localhost | |           *.=.  |
2026-03-13 09:43:02.247136 | ubuntu-noble -> localhost | |        S * * E  |
2026-03-13 09:43:02.247178 | ubuntu-noble -> localhost | |         + = = o |
2026-03-13 09:43:02.247220 | ubuntu-noble -> localhost | |          + + . .|
2026-03-13 09:43:02.247263 | ubuntu-noble -> localhost | |           +     |
2026-03-13 09:43:02.247310 | ubuntu-noble -> localhost | |                 |
2026-03-13 09:43:02.247355 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-03-13 09:43:02.247463 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.645956
2026-03-13 09:43:02.256630 | 
2026-03-13 09:43:02.256714 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-13 09:43:02.291924 | ubuntu-noble | ok
2026-03-13 09:43:02.490658 | ubuntu-noble | included: /var/lib/zuul/builds/4810b3faf3ba44a88e1fb24e6b2c291d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-13 09:43:02.541636 | 
2026-03-13 09:43:02.541724 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-13 09:43:02.565598 | ubuntu-noble | skipping: Conditional result was False
2026-03-13 09:43:02.576720 | 
2026-03-13 09:43:02.576814 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-13 09:43:03.154464 | ubuntu-noble | changed
2026-03-13 09:43:03.161056 | 
2026-03-13 09:43:03.161142 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-13 09:43:03.404594 | ubuntu-noble | ok
2026-03-13 09:43:03.413177 | 
2026-03-13 09:43:03.413317 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-13 09:43:04.011251 | ubuntu-noble | changed
2026-03-13 09:43:04.016780 | 
2026-03-13 09:43:04.016851 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-13 09:43:04.577109 | ubuntu-noble | changed
2026-03-13 09:43:04.583016 | 
2026-03-13 09:43:04.583083 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-13 09:43:04.607576 | ubuntu-noble | skipping: Conditional result was False
2026-03-13 09:43:04.619220 | 
2026-03-13 09:43:04.619322 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-13 09:43:05.153637 | ubuntu-noble -> localhost | changed
2026-03-13 09:43:05.172635 | 
2026-03-13 09:43:05.172722 | TASK [add-build-sshkey : Add back temp key]
2026-03-13 09:43:05.490027 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/4810b3faf3ba44a88e1fb24e6b2c291d/work/4810b3faf3ba44a88e1fb24e6b2c291d_id_rsa (zuul-build-sshkey)
2026-03-13 09:43:05.490234 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009722
2026-03-13 09:43:05.495861 | 
2026-03-13 09:43:05.495929 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-13 09:43:05.833794 | ubuntu-noble | ok
2026-03-13 09:43:05.839849 | 
2026-03-13 09:43:05.839940 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-13 09:43:05.865554 | ubuntu-noble | skipping: Conditional result was False
2026-03-13 09:43:05.882847 | 
2026-03-13 09:43:05.882971 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-13 09:43:06.249198 | ubuntu-noble | ok
2026-03-13 09:43:06.255515 | 
2026-03-13 09:43:06.255591 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-13 09:43:07.116301 | ubuntu-noble | Output suppressed because no_log was given
2026-03-13 09:43:07.126528 | 
2026-03-13 09:43:07.126694 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-13 09:43:07.418875 | ubuntu-noble | ok: "logs"
2026-03-13 09:43:07.419132 | ubuntu-noble | ok: All items complete
2026-03-13 09:43:07.419192 | 
2026-03-13 09:43:07.552450 | ubuntu-noble | ok: "artifacts"
2026-03-13 09:43:07.761343 | ubuntu-noble | ok: "docs"
2026-03-13 09:43:07.780508 | 
2026-03-13 09:43:07.780668 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-13 09:43:08.034228 | ubuntu-noble | changed: "logs"
2026-03-13 09:43:08.237578 | ubuntu-noble | changed: "artifacts"
2026-03-13 09:43:08.438632 | ubuntu-noble | changed: "docs"
2026-03-13 09:43:08.455618 | 
2026-03-13 09:43:08.456246 | PLAY RECAP
2026-03-13 09:43:08.456348 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-13 09:43:08.456416 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-13 09:43:08.456527 | 
2026-03-13 09:43:08.604508 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-13 09:43:08.605735 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-03-13 09:43:09.183193 | 
2026-03-13 09:43:09.183310 | PLAY [all]
2026-03-13 09:43:09.195559 | 
2026-03-13 09:43:09.195666 | TASK [setup-uv : Extract archive]
2026-03-13 09:43:11.573050 | ubuntu-noble | changed
2026-03-13 09:43:11.581107 | 
2026-03-13 09:43:11.581206 | TASK [setup-uv : Print version]
2026-03-13 09:43:11.969319 | ubuntu-noble | uv 0.8.13
2026-03-13 09:43:12.127349 | ubuntu-noble | ok: Runtime: 0:00:00.017631
2026-03-13 09:43:12.139797 | 
2026-03-13 09:43:12.139906 | PLAY RECAP
2026-03-13 09:43:12.139975 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-13 09:43:12.140029 | 
2026-03-13 09:43:12.289080 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-03-13 09:43:12.290977 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-03-13 09:43:12.941340 | 
2026-03-13 09:43:12.941499 | PLAY [all]
2026-03-13 09:43:12.964790 | 
2026-03-13 09:43:12.964992 | TASK [Run "pre-commit"]
2026-03-13 09:43:13.613931 | ubuntu-noble | Downloading virtualenv (5.6MiB)
2026-03-13 09:43:13.896560 | ubuntu-noble |  Downloading virtualenv
2026-03-13 09:43:13.909436 | ubuntu-noble | Installed 10 packages in 11ms
2026-03-13 09:43:14.301366 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-03-13 09:43:14.842531 | 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-03-13 09:43:14.848245 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-03-13 09:43:15.430703 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-03-13 09:43:15.814535 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-03-13 09:43:16.295628 | 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-03-13 09:43:16.297877 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-03-13 09:43:16.849015 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-03-13 09:43:17.386766 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-03-13 09:43:17.386833 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-03-13 09:43:17.386839 | ubuntu-noble | [INFO] This may take a few minutes...
2026-03-13 09:43:21.402346 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-03-13 09:43:21.402404 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-03-13 09:43:21.402415 | ubuntu-noble | [INFO] This may take a few minutes...
2026-03-13 09:43:26.028702 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-03-13 09:43:26.028796 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-03-13 09:43:26.028809 | ubuntu-noble | [INFO] This may take a few minutes...
2026-03-13 09:43:29.361856 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-03-13 09:43:29.361929 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-03-13 09:43:29.361945 | ubuntu-noble | [INFO] This may take a few minutes...
2026-03-13 09:43:32.028051 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-03-13 09:43:32.028088 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-03-13 09:43:32.028093 | ubuntu-noble | [INFO] This may take a few minutes...
2026-03-13 09:43:44.102712 | ubuntu-noble | fix end of files.........................................................Passed
2026-03-13 09:43:44.164919 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-03-13 09:43:44.438945 | ubuntu-noble | black....................................................................Passed
2026-03-13 09:43:44.676607 | ubuntu-noble | flake8...................................................................Passed
2026-03-13 09:43:44.808787 | ubuntu-noble | isort....................................................................Passed
2026-03-13 09:44:00.371030 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-03-13 09:44:00.590865 | ubuntu-noble | ok: Runtime: 0:00:47.033121
2026-03-13 09:44:00.594162 | 
2026-03-13 09:44:00.594302 | PLAY RECAP
2026-03-13 09:44:00.594357 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-13 09:44:00.594381 | 
2026-03-13 09:44:00.719894 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-03-13 09:44:00.721453 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-13 09:44:01.350693 | 
2026-03-13 09:44:01.350844 | PLAY [all]
2026-03-13 09:44:01.362985 | 
2026-03-13 09:44:01.363124 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-13 09:44:01.407987 | ubuntu-noble | skipping: Conditional result was False
2026-03-13 09:44:01.520543 | 
2026-03-13 09:44:01.520718 | TASK [fetch-output : Set log path for single node]
2026-03-13 09:44:01.574756 | ubuntu-noble | ok
2026-03-13 09:44:01.581993 | 
2026-03-13 09:44:01.582068 | LOOP [fetch-output : Ensure local output dirs]
2026-03-13 09:44:02.043321 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/4810b3faf3ba44a88e1fb24e6b2c291d/work/logs"
2026-03-13 09:44:02.622690 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/4810b3faf3ba44a88e1fb24e6b2c291d/work/artifacts"
2026-03-13 09:44:02.910396 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/4810b3faf3ba44a88e1fb24e6b2c291d/work/docs"
2026-03-13 09:44:02.929173 | 
2026-03-13 09:44:02.929319 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-13 09:44:03.627408 | ubuntu-noble | changed: .d..t...... ./
2026-03-13 09:44:03.627655 | ubuntu-noble | changed: All items complete
2026-03-13 09:44:03.627685 | 
2026-03-13 09:44:04.287593 | ubuntu-noble | changed: .d..t...... ./
2026-03-13 09:44:04.788177 | ubuntu-noble | changed: .d..t...... ./
2026-03-13 09:44:04.805565 | 
2026-03-13 09:44:04.805764 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-13 09:44:05.409563 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.136455
2026-03-13 09:44:06.038942 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.009648
2026-03-13 09:44:06.063254 | 
2026-03-13 09:44:06.084016 | PLAY [all]
2026-03-13 09:44:06.107450 | 
2026-03-13 09:44:06.107532 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-13 09:44:06.587053 | ubuntu-noble | changed
2026-03-13 09:44:06.670275 | 
2026-03-13 09:44:06.670407 | PLAY RECAP
2026-03-13 09:44:06.670474 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-13 09:44:06.670506 | 
2026-03-13 09:44:06.793066 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-13 09:44:06.923030 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-13 09:44:07.500249 | 
2026-03-13 09:44:07.500372 | PLAY [localhost]
2026-03-13 09:44:07.510156 | 
2026-03-13 09:44:07.510229 | TASK [Generate Zuul manifest]
2026-03-13 09:44:07.531308 | localhost | ok
2026-03-13 09:44:07.646084 | 
2026-03-13 09:44:07.646210 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-13 09:44:08.072443 | localhost | changed
2026-03-13 09:44:08.086952 | 
2026-03-13 09:44:08.143654 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-13 09:44:08.180263 | localhost | ok
2026-03-13 09:44:08.191223 | 
2026-03-13 09:44:08.191373 | TASK [Upload logs]
2026-03-13 09:44:08.211351 | localhost | ok
2026-03-13 09:44:08.284618 | 
2026-03-13 09:44:08.569166 | TASK [Set zuul-log-path fact]
2026-03-13 09:44:08.595332 | localhost | ok
2026-03-13 09:44:08.610041 | 
2026-03-13 09:44:08.610187 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-13 09:44:08.643822 | localhost | ok
2026-03-13 09:44:08.658308 | 
2026-03-13 09:44:08.658588 | TASK [upload-logs : Create log directories]
2026-03-13 09:44:09.128582 | localhost | changed
2026-03-13 09:44:09.136152 | 
2026-03-13 09:44:09.136244 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-13 09:44:09.863501 | localhost -> localhost | ok: Runtime: 0:00:00.017793
2026-03-13 09:44:09.873531 | 
2026-03-13 09:44:09.873758 | TASK [upload-logs : Upload logs to log server]
2026-03-13 09:44:10.478484 | localhost | Output suppressed because no_log was given
2026-03-13 09:44:10.489630 | 
2026-03-13 09:44:10.489948 | LOOP [upload-logs : Compress console log and json output]
2026-03-13 09:44:10.536422 | localhost | skipping: Conditional result was False
2026-03-13 09:44:10.657219 | localhost | skipping: Conditional result was False
2026-03-13 09:44:10.671825 | 
2026-03-13 09:44:10.672042 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-13 09:44:10.722106 | localhost | skipping: Conditional result was False
2026-03-13 09:44:10.723257 | 
2026-03-13 09:44:10.727716 | localhost | skipping: Conditional result was False
2026-03-13 09:44:10.743034 | 
2026-03-13 09:44:10.743193 | LOOP [upload-logs : Upload console log and json output]