2026-02-13 23:20:27.484171 | Job console starting
2026-02-13 23:20:27.521086 | Updating git repos
2026-02-13 23:20:27.557614 | Cloning repos into workspace
2026-02-13 23:20:27.635638 | Restoring repo states
2026-02-13 23:20:27.642250 | Merging changes
2026-02-13 23:20:27.976358 | Checking out repos
2026-02-13 23:20:28.071887 | Preparing playbooks
2026-02-13 23:20:31.144523 | Running Ansible setup
2026-02-13 23:20:35.163106 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-13 23:20:35.797756 | 
2026-02-13 23:20:35.797888 | PLAY [localhost]
2026-02-13 23:20:35.805408 | 
2026-02-13 23:20:35.805478 | TASK [Gathering Facts]
2026-02-13 23:20:36.795093 | localhost | ok
2026-02-13 23:20:36.809852 | 
2026-02-13 23:20:36.810021 | TASK [Setup log path fact]
2026-02-13 23:20:36.832243 | localhost | ok
2026-02-13 23:20:36.847233 | 
2026-02-13 23:20:36.847347 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-13 23:20:36.881233 | localhost | ok
2026-02-13 23:20:37.022592 | 
2026-02-13 23:20:37.022730 | TASK [emit-job-header : Print job information]
2026-02-13 23:20:37.065203 | # Job Information
2026-02-13 23:20:37.065427 | Ansible Version: 2.16.15
2026-02-13 23:20:37.065474 | Job: pre-commit
2026-02-13 23:20:37.065506 | Pipeline: check
2026-02-13 23:20:37.065535 | Executor: 3a2793d2bd32
2026-02-13 23:20:37.065563 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/96
2026-02-13 23:20:37.065595 | Event ID: 4d80af90-0932-11f1-94bb-f36709d2ee90
2026-02-13 23:20:37.069884 | 
2026-02-13 23:20:37.069987 | LOOP [emit-job-header : Print node information]
2026-02-13 23:20:37.166026 | localhost | ok:
2026-02-13 23:20:37.166235 | localhost | # Node Information
2026-02-13 23:20:37.166264 | localhost | Inventory Hostname: ubuntu-noble
2026-02-13 23:20:37.166286 | localhost | Hostname: np0000155517
2026-02-13 23:20:37.166307 | localhost | Username: zuul
2026-02-13 23:20:37.166332 | localhost | Distro: Ubuntu 24.04
2026-02-13 23:20:37.166354 | localhost | Provider: yul1
2026-02-13 23:20:37.166374 | localhost | Region: ca-ymq-1
2026-02-13 23:20:37.166393 | localhost | Label: ubuntu-noble
2026-02-13 23:20:37.166411 | localhost | Product Name: OpenStack Nova
2026-02-13 23:20:37.166430 | localhost | Interface IP: 199.204.45.78
2026-02-13 23:20:37.176032 | 
2026-02-13 23:20:37.176203 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-13 23:20:37.596683 | localhost -> localhost | changed
2026-02-13 23:20:37.605059 | 
2026-02-13 23:20:37.605174 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-13 23:20:38.473364 | localhost -> localhost | changed
2026-02-13 23:20:38.483061 | 
2026-02-13 23:20:38.483689 | PLAY [all]
2026-02-13 23:20:38.493407 | 
2026-02-13 23:20:38.493510 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-13 23:20:38.706487 | ubuntu-noble -> localhost | ok
2026-02-13 23:20:38.718151 | 
2026-02-13 23:20:38.718226 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-13 23:20:38.752227 | ubuntu-noble | ok
2026-02-13 23:20:38.769521 | ubuntu-noble | included: /var/lib/zuul/builds/e2a8dad40546446089401a4f0e652918/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-13 23:20:38.777495 | 
2026-02-13 23:20:38.777576 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-13 23:20:39.951692 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-02-13 23:20:39.951976 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/e2a8dad40546446089401a4f0e652918/work/e2a8dad40546446089401a4f0e652918_id_rsa
2026-02-13 23:20:39.952017 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/e2a8dad40546446089401a4f0e652918/work/e2a8dad40546446089401a4f0e652918_id_rsa.pub
2026-02-13 23:20:39.952041 | ubuntu-noble -> localhost | The key fingerprint is:
2026-02-13 23:20:39.952062 | ubuntu-noble -> localhost | SHA256:xIE7kcSbOjqYmVstjzAbZJFPiwIwUxHiKIIvIXMnSxg zuul-build-sshkey
2026-02-13 23:20:39.952096 | ubuntu-noble -> localhost | The key's randomart image is:
2026-02-13 23:20:39.952167 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-02-13 23:20:39.952214 | ubuntu-noble -> localhost | |E.+o o.o.        |
2026-02-13 23:20:39.952238 | ubuntu-noble -> localhost | |=*.   =. .       |
2026-02-13 23:20:39.952259 | ubuntu-noble -> localhost | |@++..  =o        |
2026-02-13 23:20:39.952279 | ubuntu-noble -> localhost | |=*=+. =.         |
2026-02-13 23:20:39.952298 | ubuntu-noble -> localhost | |o+oo . .S        |
2026-02-13 23:20:39.952318 | ubuntu-noble -> localhost | |+. .o            |
2026-02-13 23:20:39.952337 | ubuntu-noble -> localhost | |+=o...           |
2026-02-13 23:20:39.952356 | ubuntu-noble -> localhost | |=*o+             |
2026-02-13 23:20:39.952378 | ubuntu-noble -> localhost | |o....            |
2026-02-13 23:20:39.952398 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-02-13 23:20:39.952487 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.724825
2026-02-13 23:20:39.959291 | 
2026-02-13 23:20:39.959355 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-13 23:20:40.005222 | ubuntu-noble | ok
2026-02-13 23:20:40.021128 | ubuntu-noble | included: /var/lib/zuul/builds/e2a8dad40546446089401a4f0e652918/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-13 23:20:40.031008 | 
2026-02-13 23:20:40.031114 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-13 23:20:40.057043 | ubuntu-noble | skipping: Conditional result was False
2026-02-13 23:20:40.068173 | 
2026-02-13 23:20:40.068535 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-13 23:20:40.677910 | ubuntu-noble | changed
2026-02-13 23:20:40.686200 | 
2026-02-13 23:20:40.686287 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-13 23:20:40.915865 | ubuntu-noble | ok
2026-02-13 23:20:40.922148 | 
2026-02-13 23:20:40.922259 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-13 23:20:41.504320 | ubuntu-noble | changed
2026-02-13 23:20:41.511793 | 
2026-02-13 23:20:41.511865 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-13 23:20:42.064849 | ubuntu-noble | changed
2026-02-13 23:20:42.071033 | 
2026-02-13 23:20:42.071135 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-13 23:20:42.086254 | ubuntu-noble | skipping: Conditional result was False
2026-02-13 23:20:42.096285 | 
2026-02-13 23:20:42.096375 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-13 23:20:42.475639 | ubuntu-noble -> localhost | changed
2026-02-13 23:20:42.487387 | 
2026-02-13 23:20:42.487469 | TASK [add-build-sshkey : Add back temp key]
2026-02-13 23:20:42.776983 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/e2a8dad40546446089401a4f0e652918/work/e2a8dad40546446089401a4f0e652918_id_rsa (zuul-build-sshkey)
2026-02-13 23:20:42.777195 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011097
2026-02-13 23:20:42.782660 | 
2026-02-13 23:20:42.782723 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-13 23:20:43.120634 | ubuntu-noble | ok
2026-02-13 23:20:43.125610 | 
2026-02-13 23:20:43.125674 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-13 23:20:43.159646 | ubuntu-noble | skipping: Conditional result was False
2026-02-13 23:20:43.176679 | 
2026-02-13 23:20:43.176750 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-13 23:20:43.553630 | ubuntu-noble | ok
2026-02-13 23:20:43.563982 | 
2026-02-13 23:20:43.564082 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-13 23:20:44.420440 | ubuntu-noble | Output suppressed because no_log was given
2026-02-13 23:20:44.432441 | 
2026-02-13 23:20:44.432545 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-13 23:20:44.654131 | ubuntu-noble | ok: "logs"
2026-02-13 23:20:44.654405 | ubuntu-noble | ok: All items complete
2026-02-13 23:20:44.654445 | 
2026-02-13 23:20:44.864493 | ubuntu-noble | ok: "artifacts"
2026-02-13 23:20:45.101911 | ubuntu-noble | ok: "docs"
2026-02-13 23:20:45.119753 | 
2026-02-13 23:20:45.119918 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-13 23:20:45.338206 | ubuntu-noble | changed: "logs"
2026-02-13 23:20:45.517038 | ubuntu-noble | changed: "artifacts"
2026-02-13 23:20:45.713313 | ubuntu-noble | changed: "docs"
2026-02-13 23:20:45.735438 | 
2026-02-13 23:20:45.735558 | PLAY RECAP
2026-02-13 23:20:45.735606 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-13 23:20:45.735636 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-02-13 23:20:45.735660 | 
2026-02-13 23:20:45.871981 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-13 23:20:45.874116 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-02-13 23:20:46.473384 | 
2026-02-13 23:20:46.473510 | PLAY [all]
2026-02-13 23:20:46.485741 | 
2026-02-13 23:20:46.485841 | TASK [setup-uv : Extract archive]
2026-02-13 23:20:49.005297 | ubuntu-noble | changed
2026-02-13 23:20:49.012265 | 
2026-02-13 23:20:49.012348 | TASK [setup-uv : Print version]
2026-02-13 23:20:49.416026 | ubuntu-noble | uv 0.8.13
2026-02-13 23:20:49.557418 | ubuntu-noble | ok: Runtime: 0:00:00.009738
2026-02-13 23:20:49.565446 | 
2026-02-13 23:20:49.565498 | PLAY RECAP
2026-02-13 23:20:49.565544 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-13 23:20:49.565568 | 
2026-02-13 23:20:49.685073 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-02-13 23:20:49.686497 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-02-13 23:20:50.280623 | 
2026-02-13 23:20:50.280763 | PLAY [all]
2026-02-13 23:20:50.293970 | 
2026-02-13 23:20:50.294066 | TASK [Run "pre-commit"]
2026-02-13 23:20:50.823601 | ubuntu-noble | Downloading virtualenv (5.7MiB)
2026-02-13 23:20:51.018467 | ubuntu-noble |  Downloading virtualenv
2026-02-13 23:20:51.030354 | ubuntu-noble | Installed 9 packages in 10ms
2026-02-13 23:20:51.443379 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-02-13 23:20:51.918544 | 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-02-13 23:20:51.921820 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-02-13 23:20:52.405076 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-02-13 23:20:52.761940 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-02-13 23:20:53.156545 | 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-02-13 23:20:53.156971 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-02-13 23:20:53.648529 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-02-13 23:20:54.124999 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-02-13 23:20:54.125047 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-13 23:20:54.125057 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-13 23:20:59.158098 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-02-13 23:20:59.158127 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-13 23:20:59.158132 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-13 23:21:03.435658 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-02-13 23:21:03.435693 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-13 23:21:03.435713 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-13 23:21:06.700551 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-02-13 23:21:06.700599 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-13 23:21:06.700638 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-13 23:21:09.964511 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-02-13 23:21:09.964543 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-13 23:21:09.964547 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-13 23:21:27.096500 | ubuntu-noble | fix end of files.........................................................Passed
2026-02-13 23:21:27.138357 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-02-13 23:21:27.395223 | ubuntu-noble | black....................................................................Passed
2026-02-13 23:21:27.571110 | ubuntu-noble | flake8...................................................................Passed
2026-02-13 23:21:27.689965 | ubuntu-noble | isort....................................................................Passed
2026-02-13 23:21:46.087195 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-02-13 23:21:46.367620 | ubuntu-noble | ok: Runtime: 0:00:55.461540
2026-02-13 23:21:46.370315 | 
2026-02-13 23:21:46.370413 | PLAY RECAP
2026-02-13 23:21:46.370477 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-13 23:21:46.370544 | 
2026-02-13 23:21:46.518856 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-02-13 23:21:46.520698 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-13 23:21:47.116764 | 
2026-02-13 23:21:47.116968 | PLAY [all]
2026-02-13 23:21:47.129157 | 
2026-02-13 23:21:47.129243 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-13 23:21:47.173912 | ubuntu-noble | skipping: Conditional result was False
2026-02-13 23:21:47.186262 | 
2026-02-13 23:21:47.186371 | TASK [fetch-output : Set log path for single node]
2026-02-13 23:21:47.239194 | ubuntu-noble | ok
2026-02-13 23:21:47.248107 | 
2026-02-13 23:21:47.248264 | LOOP [fetch-output : Ensure local output dirs]
2026-02-13 23:21:47.664375 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/e2a8dad40546446089401a4f0e652918/work/logs"
2026-02-13 23:21:47.886432 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/e2a8dad40546446089401a4f0e652918/work/artifacts"
2026-02-13 23:21:48.099138 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/e2a8dad40546446089401a4f0e652918/work/docs"
2026-02-13 23:21:48.114905 | 
2026-02-13 23:21:48.115089 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-13 23:21:48.793524 | ubuntu-noble | changed: .d..t...... ./
2026-02-13 23:21:48.794281 | ubuntu-noble | changed: All items complete
2026-02-13 23:21:48.794326 | 
2026-02-13 23:21:49.265623 | ubuntu-noble | changed: .d..t...... ./
2026-02-13 23:21:49.744869 | ubuntu-noble | changed: .d..t...... ./
2026-02-13 23:21:49.771650 | 
2026-02-13 23:21:49.771792 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-13 23:21:50.224720 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008846
2026-02-13 23:21:50.466924 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007897
2026-02-13 23:21:50.476855 | 
2026-02-13 23:21:50.476991 | PLAY [all]
2026-02-13 23:21:50.484335 | 
2026-02-13 23:21:50.484402 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-02-13 23:21:51.026316 | ubuntu-noble | changed
2026-02-13 23:21:51.031868 | 
2026-02-13 23:21:51.031916 | PLAY RECAP
2026-02-13 23:21:51.031958 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-02-13 23:21:51.031979 | 
2026-02-13 23:21:51.146557 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-13 23:21:51.148705 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main]
2026-02-13 23:21:51.731465 | 
2026-02-13 23:21:51.731649 | PLAY [localhost]
2026-02-13 23:21:51.747924 | 
2026-02-13 23:21:51.748114 | TASK [Generate Zuul manifest]
2026-02-13 23:21:51.770121 | localhost | ok
2026-02-13 23:21:51.786276 | 
2026-02-13 23:21:51.786359 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-13 23:21:52.101943 | localhost | changed
2026-02-13 23:21:52.115345 | 
2026-02-13 23:21:52.115508 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-13 23:21:52.149557 | localhost | ok
2026-02-13 23:21:52.158515 | 
2026-02-13 23:21:52.158607 | TASK [Upload logs]
2026-02-13 23:21:52.181219 | localhost | ok
2026-02-13 23:21:52.243636 | 
2026-02-13 23:21:52.243787 | TASK [Set zuul-log-path fact]
2026-02-13 23:21:52.265330 | localhost | ok
2026-02-13 23:21:52.278388 | 
2026-02-13 23:21:52.278501 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-13 23:21:52.310439 | localhost | ok
2026-02-13 23:21:52.319680 | 
2026-02-13 23:21:52.319751 | TASK [upload-logs : Create log directories]
2026-02-13 23:21:52.716189 | localhost | changed
2026-02-13 23:21:52.722373 | 
2026-02-13 23:21:52.722466 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-02-13 23:21:53.136424 | localhost -> localhost | ok: Runtime: 0:00:00.005779
2026-02-13 23:21:53.141333 | 
2026-02-13 23:21:53.141427 | TASK [upload-logs : Upload logs to log server]
2026-02-13 23:21:53.607971 | localhost | Output suppressed because no_log was given
2026-02-13 23:21:53.612833 | 
2026-02-13 23:21:53.612931 | LOOP [upload-logs : Compress console log and json output]
2026-02-13 23:21:53.655961 | localhost | skipping: Conditional result was False
2026-02-13 23:21:53.662257 | localhost | skipping: Conditional result was False
2026-02-13 23:21:53.676991 | 
2026-02-13 23:21:53.677211 | LOOP [upload-logs : Upload compressed console log and json output]
2026-02-13 23:21:53.719295 | localhost | skipping: Conditional result was False
2026-02-13 23:21:53.719635 | 
2026-02-13 23:21:53.722596 | localhost | skipping: Conditional result was False
2026-02-13 23:21:53.732570 | 
2026-02-13 23:21:53.732778 | LOOP [upload-logs : Upload console log and json output]