2026-04-28 06:34:40.361668 | Job console starting
2026-04-28 06:34:40.371789 | Updating git repos
2026-04-28 06:34:40.399002 | Cloning repos into workspace
2026-04-28 06:34:42.236919 | Restoring repo states
2026-04-28 06:34:42.253904 | Merging changes
2026-04-28 06:34:42.640842 | Checking out repos
2026-04-28 06:34:43.185986 | Preparing playbooks
2026-04-28 06:34:57.735048 | Running Ansible setup
2026-04-28 06:35:02.093670 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-28 06:35:02.684922 | 
2026-04-28 06:35:02.875381 | PLAY [localhost]
2026-04-28 06:35:02.889905 | 
2026-04-28 06:35:02.890016 | TASK [Gathering Facts]
2026-04-28 06:35:03.881330 | localhost | ok
2026-04-28 06:35:03.893889 | 
2026-04-28 06:35:03.894058 | TASK [Setup log path fact]
2026-04-28 06:35:03.924428 | localhost | ok
2026-04-28 06:35:03.938187 | 
2026-04-28 06:35:03.938279 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-28 06:35:03.969266 | localhost | ok
2026-04-28 06:35:03.978353 | 
2026-04-28 06:35:03.978446 | TASK [emit-job-header : Print job information]
2026-04-28 06:35:04.019306 | # Job Information
2026-04-28 06:35:04.019464 | Ansible Version: 2.16.16
2026-04-28 06:35:04.019499 | Job: pre-commit
2026-04-28 06:35:04.019522 | Pipeline: check
2026-04-28 06:35:04.019542 | Executor: 0a8996d2b663
2026-04-28 06:35:04.019561 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/123
2026-04-28 06:35:04.019584 | Event ID: dc61fe80-42cb-11f1-988f-93e08c803a2a
2026-04-28 06:35:04.022624 | 
2026-04-28 06:35:04.022692 | LOOP [emit-job-header : Print node information]
2026-04-28 06:35:04.120300 | localhost | ok:
2026-04-28 06:35:04.120522 | localhost | # Node Information
2026-04-28 06:35:04.120563 | localhost | Inventory Hostname: ubuntu-noble
2026-04-28 06:35:04.120595 | localhost | Hostname: np0000170982
2026-04-28 06:35:04.120625 | localhost | Username: zuul
2026-04-28 06:35:04.120658 | localhost | Distro: Ubuntu 24.04
2026-04-28 06:35:04.120688 | localhost | Provider: yul1
2026-04-28 06:35:04.120717 | localhost | Region: ca-ymq-1
2026-04-28 06:35:04.120744 | localhost | Label: ubuntu-noble
2026-04-28 06:35:04.120771 | localhost | Product Name: OpenStack Nova
2026-04-28 06:35:04.120799 | localhost | Interface IP: 199.204.45.246
2026-04-28 06:35:04.139344 | 
2026-04-28 06:35:04.139508 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-28 06:35:04.539309 | localhost -> localhost | changed
2026-04-28 06:35:04.544355 | 
2026-04-28 06:35:04.544421 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-28 06:35:05.398012 | localhost -> localhost | changed
2026-04-28 06:35:05.403804 | 
2026-04-28 06:35:05.403861 | PLAY [all]
2026-04-28 06:35:05.412001 | 
2026-04-28 06:35:05.412070 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-28 06:35:05.628645 | ubuntu-noble -> localhost | ok
2026-04-28 06:35:05.638796 | 
2026-04-28 06:35:05.638930 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-28 06:35:05.663825 | ubuntu-noble | ok
2026-04-28 06:35:05.677779 | ubuntu-noble | included: /var/lib/zuul/builds/f27b2a8dc3aa42d3b2bdcfbb01f84f25/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-28 06:35:05.684025 | 
2026-04-28 06:35:05.684108 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-28 06:35:06.407983 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-04-28 06:35:06.408209 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/f27b2a8dc3aa42d3b2bdcfbb01f84f25/work/f27b2a8dc3aa42d3b2bdcfbb01f84f25_id_rsa
2026-04-28 06:35:06.408256 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/f27b2a8dc3aa42d3b2bdcfbb01f84f25/work/f27b2a8dc3aa42d3b2bdcfbb01f84f25_id_rsa.pub
2026-04-28 06:35:06.408289 | ubuntu-noble -> localhost | The key fingerprint is:
2026-04-28 06:35:06.408321 | ubuntu-noble -> localhost | SHA256:O/KGfPFKALYNmXLXWaM6dKlPdT7d+bIliwxfQR2WgKQ zuul-build-sshkey
2026-04-28 06:35:06.408370 | ubuntu-noble -> localhost | The key's randomart image is:
2026-04-28 06:35:06.408402 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-04-28 06:35:06.408438 | ubuntu-noble -> localhost | |          +....o.|
2026-04-28 06:35:06.408471 | ubuntu-noble -> localhost | |     o . =.o  .o.|
2026-04-28 06:35:06.408602 | ubuntu-noble -> localhost | |  . B o *E. . . .|
2026-04-28 06:35:06.408657 | ubuntu-noble -> localhost | |   + B + . o o ..|
2026-04-28 06:35:06.408691 | ubuntu-noble -> localhost | |    . * S   o o..|
2026-04-28 06:35:06.408721 | ubuntu-noble -> localhost | |       =..   . ..|
2026-04-28 06:35:06.408751 | ubuntu-noble -> localhost | |     ...=o.   + o|
2026-04-28 06:35:06.408781 | ubuntu-noble -> localhost | |      o+o..+ o * |
2026-04-28 06:35:06.408812 | ubuntu-noble -> localhost | |       oo.  + o  |
2026-04-28 06:35:06.408841 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-04-28 06:35:06.408911 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.287924
2026-04-28 06:35:06.417117 | 
2026-04-28 06:35:06.417211 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-28 06:35:06.459103 | ubuntu-noble | ok
2026-04-28 06:35:06.468276 | ubuntu-noble | included: /var/lib/zuul/builds/f27b2a8dc3aa42d3b2bdcfbb01f84f25/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-28 06:35:06.475954 | 
2026-04-28 06:35:06.476021 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-28 06:35:06.500828 | ubuntu-noble | skipping: Conditional result was False
2026-04-28 06:35:06.511245 | 
2026-04-28 06:35:06.511409 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-28 06:35:07.091519 | ubuntu-noble | changed
2026-04-28 06:35:07.099416 | 
2026-04-28 06:35:07.099501 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-28 06:35:07.329906 | ubuntu-noble | ok
2026-04-28 06:35:07.337565 | 
2026-04-28 06:35:07.337637 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-28 06:35:07.942527 | ubuntu-noble | changed
2026-04-28 06:35:07.948163 | 
2026-04-28 06:35:07.948249 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-28 06:35:08.513493 | ubuntu-noble | changed
2026-04-28 06:35:08.519068 | 
2026-04-28 06:35:08.519193 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-28 06:35:08.543919 | ubuntu-noble | skipping: Conditional result was False
2026-04-28 06:35:08.551152 | 
2026-04-28 06:35:08.551221 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-28 06:35:08.939140 | ubuntu-noble -> localhost | changed
2026-04-28 06:35:08.950772 | 
2026-04-28 06:35:08.950835 | TASK [add-build-sshkey : Add back temp key]
2026-04-28 06:35:09.234767 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/f27b2a8dc3aa42d3b2bdcfbb01f84f25/work/f27b2a8dc3aa42d3b2bdcfbb01f84f25_id_rsa (zuul-build-sshkey)
2026-04-28 06:35:09.234949 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013171
2026-04-28 06:35:09.240247 | 
2026-04-28 06:35:09.240311 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-28 06:35:09.617693 | ubuntu-noble | ok
2026-04-28 06:35:09.625800 | 
2026-04-28 06:35:09.625880 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-28 06:35:09.653084 | ubuntu-noble | skipping: Conditional result was False
2026-04-28 06:35:09.673380 | 
2026-04-28 06:35:09.673650 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-28 06:35:10.074069 | ubuntu-noble | ok
2026-04-28 06:35:10.097631 | 
2026-04-28 06:35:10.097742 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-28 06:35:11.029244 | ubuntu-noble | Output suppressed because no_log was given
2026-04-28 06:35:11.041390 | 
2026-04-28 06:35:11.041467 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-28 06:35:11.320244 | ubuntu-noble | ok: "logs"
2026-04-28 06:35:11.320484 | ubuntu-noble | ok: All items complete
2026-04-28 06:35:11.320529 | 
2026-04-28 06:35:11.473344 | ubuntu-noble | ok: "artifacts"
2026-04-28 06:35:11.736630 | ubuntu-noble | ok: "docs"
2026-04-28 06:35:11.916263 | 
2026-04-28 06:35:11.916588 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-28 06:35:12.180145 | ubuntu-noble | changed: "logs"
2026-04-28 06:35:12.375391 | ubuntu-noble | changed: "artifacts"
2026-04-28 06:35:12.600931 | ubuntu-noble | changed: "docs"
2026-04-28 06:35:12.617490 | 
2026-04-28 06:35:12.617642 | PLAY RECAP
2026-04-28 06:35:12.617697 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-28 06:35:12.617728 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-28 06:35:12.617749 | 
2026-04-28 06:35:12.800660 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-28 06:35:12.802691 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-28 06:35:13.469246 | 
2026-04-28 06:35:13.469400 | PLAY [all]
2026-04-28 06:35:13.481783 | 
2026-04-28 06:35:13.481881 | TASK [setup-uv : Extract archive]
2026-04-28 06:35:16.018610 | ubuntu-noble | changed
2026-04-28 06:35:16.026109 | 
2026-04-28 06:35:16.026186 | TASK [setup-uv : Print version]
2026-04-28 06:35:16.466048 | ubuntu-noble | uv 0.8.13
2026-04-28 06:35:16.566463 | ubuntu-noble | ok: Runtime: 0:00:00.017484
2026-04-28 06:35:16.575012 | 
2026-04-28 06:35:16.575076 | PLAY RECAP
2026-04-28 06:35:16.575135 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-28 06:35:16.575167 | 
2026-04-28 06:35:16.695045 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-28 06:35:16.744261 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-28 06:35:17.377511 | 
2026-04-28 06:35:17.377640 | PLAY [all]
2026-04-28 06:35:17.398241 | 
2026-04-28 06:35:17.398519 | TASK [Run "pre-commit"]
2026-04-28 06:35:18.129131 | ubuntu-noble | Downloading virtualenv (7.2MiB)
2026-04-28 06:35:18.275243 | ubuntu-noble |  Downloading virtualenv
2026-04-28 06:35:18.289486 | ubuntu-noble | Installed 10 packages in 13ms
2026-04-28 06:35:18.674307 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-28 06:35:19.207809 | 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 06:35:19.214040 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-04-28 06:35:19.746506 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-04-28 06:35:20.154693 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-04-28 06:35:20.642366 | 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 06:35:20.644439 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-04-28 06:35:21.175142 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-04-28 06:35:21.880570 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-28 06:35:21.880670 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-28 06:35:21.880682 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-28 06:35:26.057445 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-04-28 06:35:26.057545 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-28 06:35:26.057564 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-28 06:35:30.606932 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-04-28 06:35:30.607004 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-28 06:35:30.607017 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-28 06:35:33.980292 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-04-28 06:35:33.980371 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-28 06:35:33.980388 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-28 06:35:36.702396 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-04-28 06:35:36.702504 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-28 06:35:36.702525 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-28 06:35:48.175905 | ubuntu-noble | fix end of files.........................................................Passed
2026-04-28 06:35:48.243656 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-04-28 06:35:48.507403 | ubuntu-noble | black....................................................................Passed
2026-04-28 06:35:48.694667 | ubuntu-noble | flake8...................................................................Passed
2026-04-28 06:35:48.820043 | ubuntu-noble | isort....................................................................Passed
2026-04-28 06:36:06.461290 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-04-28 06:36:06.575672 | ubuntu-noble | ok: Runtime: 0:00:48.653142
2026-04-28 06:36:06.577327 | 
2026-04-28 06:36:06.577370 | PLAY RECAP
2026-04-28 06:36:06.577413 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-28 06:36:06.577434 | 
2026-04-28 06:36:06.705600 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-28 06:36:06.707060 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-28 06:36:07.297916 | 
2026-04-28 06:36:07.298090 | PLAY [all]
2026-04-28 06:36:07.311783 | 
2026-04-28 06:36:07.311921 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-28 06:36:07.356940 | ubuntu-noble | skipping: Conditional result was False
2026-04-28 06:36:07.367483 | 
2026-04-28 06:36:07.367601 | TASK [fetch-output : Set log path for single node]
2026-04-28 06:36:07.415138 | ubuntu-noble | ok
2026-04-28 06:36:07.422282 | 
2026-04-28 06:36:07.422375 | LOOP [fetch-output : Ensure local output dirs]
2026-04-28 06:36:07.796699 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/f27b2a8dc3aa42d3b2bdcfbb01f84f25/work/logs"
2026-04-28 06:36:07.997461 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/f27b2a8dc3aa42d3b2bdcfbb01f84f25/work/artifacts"
2026-04-28 06:36:08.213899 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/f27b2a8dc3aa42d3b2bdcfbb01f84f25/work/docs"
2026-04-28 06:36:08.235844 | 
2026-04-28 06:36:08.236041 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-28 06:36:08.902444 | ubuntu-noble | ok
2026-04-28 06:36:08.902731 | ubuntu-noble | changed: All items complete
2026-04-28 06:36:08.902771 | 
2026-04-28 06:36:09.372896 | ubuntu-noble | changed: .d..t...... ./
2026-04-28 06:36:09.851369 | ubuntu-noble | changed: .d..t...... ./
2026-04-28 06:36:09.875591 | 
2026-04-28 06:36:09.875745 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-28 06:36:10.357409 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008978
2026-04-28 06:36:10.586762 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008883
2026-04-28 06:36:10.610122 | 
2026-04-28 06:36:10.610769 | PLAY [all]
2026-04-28 06:36:10.617138 | 
2026-04-28 06:36:10.617207 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-28 06:36:11.120067 | ubuntu-noble | changed
2026-04-28 06:36:11.126106 | 
2026-04-28 06:36:11.126154 | PLAY RECAP
2026-04-28 06:36:11.126200 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-28 06:36:11.126221 | 
2026-04-28 06:36:11.244875 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-28 06:36:11.246350 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-28 06:36:11.845772 | 
2026-04-28 06:36:11.895464 | PLAY [localhost]
2026-04-28 06:36:11.913371 | 
2026-04-28 06:36:11.913616 | TASK [Generate Zuul manifest]
2026-04-28 06:36:11.935039 | localhost | ok
2026-04-28 06:36:11.958094 | 
2026-04-28 06:36:11.958357 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-28 06:36:12.276525 | localhost | changed
2026-04-28 06:36:12.290251 | 
2026-04-28 06:36:12.290348 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-28 06:36:12.325069 | localhost | ok
2026-04-28 06:36:12.334496 | 
2026-04-28 06:36:12.334633 | TASK [Upload logs]
2026-04-28 06:36:12.357651 | localhost | ok
2026-04-28 06:36:12.427004 | 
2026-04-28 06:36:12.427169 | TASK [Set zuul-log-path fact]
2026-04-28 06:36:12.457416 | localhost | ok
2026-04-28 06:36:12.470985 | 
2026-04-28 06:36:12.471062 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-28 06:36:12.503781 | localhost | ok
2026-04-28 06:36:12.513261 | 
2026-04-28 06:36:12.513330 | TASK [upload-logs : Create log directories]
2026-04-28 06:36:12.930912 | localhost | changed
2026-04-28 06:36:12.937827 | 
2026-04-28 06:36:12.937901 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-28 06:36:13.396122 | localhost -> localhost | ok: Runtime: 0:00:00.005998
2026-04-28 06:36:13.403199 | 
2026-04-28 06:36:13.403317 | TASK [upload-logs : Upload logs to log server]
2026-04-28 06:36:13.881074 | localhost | Output suppressed because no_log was given
2026-04-28 06:36:13.885991 | 
2026-04-28 06:36:13.886081 | LOOP [upload-logs : Compress console log and json output]
2026-04-28 06:36:13.936006 | localhost | skipping: Conditional result was False
2026-04-28 06:36:13.943584 | localhost | skipping: Conditional result was False
2026-04-28 06:36:13.961600 | 
2026-04-28 06:36:13.961839 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-28 06:36:14.012698 | localhost | skipping: Conditional result was False
2026-04-28 06:36:14.013194 | 
2026-04-28 06:36:14.021420 | localhost | skipping: Conditional result was False
2026-04-28 06:36:14.034119 | 
2026-04-28 06:36:14.034291 | LOOP [upload-logs : Upload console log and json output]