2026-04-10 00:54:32.113169 | Job console starting
2026-04-10 00:54:32.122110 | Updating git repos
2026-04-10 00:54:32.149548 | Cloning repos into workspace
2026-04-10 00:54:32.338080 | Restoring repo states
2026-04-10 00:54:32.347265 | Merging changes
2026-04-10 00:54:32.666672 | Checking out repos
2026-04-10 00:54:32.701333 | Preparing playbooks
2026-04-10 00:54:34.271827 | Running Ansible setup
2026-04-10 00:54:38.851062 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-10 00:54:39.482723 | 
2026-04-10 00:54:39.482872 | PLAY [localhost]
2026-04-10 00:54:39.490420 | 
2026-04-10 00:54:39.490493 | TASK [Gathering Facts]
2026-04-10 00:54:40.402190 | localhost | ok
2026-04-10 00:54:40.413344 | 
2026-04-10 00:54:40.413447 | TASK [Setup log path fact]
2026-04-10 00:54:40.447204 | localhost | ok
2026-04-10 00:54:40.459905 | 
2026-04-10 00:54:40.459988 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-10 00:54:40.490248 | localhost | ok
2026-04-10 00:54:40.498564 | 
2026-04-10 00:54:40.498655 | TASK [emit-job-header : Print job information]
2026-04-10 00:54:40.550511 | # Job Information
2026-04-10 00:54:40.550714 | Ansible Version: 2.16.16
2026-04-10 00:54:40.550761 | Job: pre-commit
2026-04-10 00:54:40.550794 | Pipeline: check
2026-04-10 00:54:40.550824 | Executor: 0a8996d2b663
2026-04-10 00:54:40.550854 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/102
2026-04-10 00:54:40.550887 | Event ID: a13b32c0-3477-11f1-8c27-8c298754fe0d
2026-04-10 00:54:40.554989 | 
2026-04-10 00:54:40.555084 | LOOP [emit-job-header : Print node information]
2026-04-10 00:54:40.662214 | localhost | ok:
2026-04-10 00:54:40.662438 | localhost | # Node Information
2026-04-10 00:54:40.662486 | localhost | Inventory Hostname: ubuntu-noble
2026-04-10 00:54:40.662524 | localhost | Hostname: np0000164770
2026-04-10 00:54:40.662560 | localhost | Username: zuul
2026-04-10 00:54:40.662602 | localhost | Distro: Ubuntu 24.04
2026-04-10 00:54:40.662637 | localhost | Provider: yul1
2026-04-10 00:54:40.662671 | localhost | Region: ca-ymq-1
2026-04-10 00:54:40.662703 | localhost | Label: ubuntu-noble
2026-04-10 00:54:40.662735 | localhost | Product Name: OpenStack Nova
2026-04-10 00:54:40.662767 | localhost | Interface IP: 199.204.45.205
2026-04-10 00:54:40.674435 | 
2026-04-10 00:54:40.674579 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-10 00:54:41.116268 | localhost -> localhost | changed
2026-04-10 00:54:41.124786 | 
2026-04-10 00:54:41.124887 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-10 00:54:42.327719 | localhost -> localhost | changed
2026-04-10 00:54:42.343068 | 
2026-04-10 00:54:42.343200 | PLAY [all]
2026-04-10 00:54:42.352003 | 
2026-04-10 00:54:42.352080 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-10 00:54:42.590704 | ubuntu-noble -> localhost | ok
2026-04-10 00:54:42.598537 | 
2026-04-10 00:54:42.598615 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-10 00:54:42.633682 | ubuntu-noble | ok
2026-04-10 00:54:42.647988 | ubuntu-noble | included: /var/lib/zuul/builds/7e305336dff24f73b56b846fb525239f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-10 00:54:42.654208 | 
2026-04-10 00:54:42.654272 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-10 00:54:43.668810 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-04-10 00:54:43.669032 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/7e305336dff24f73b56b846fb525239f/work/7e305336dff24f73b56b846fb525239f_id_rsa
2026-04-10 00:54:43.669067 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/7e305336dff24f73b56b846fb525239f/work/7e305336dff24f73b56b846fb525239f_id_rsa.pub
2026-04-10 00:54:43.669091 | ubuntu-noble -> localhost | The key fingerprint is:
2026-04-10 00:54:43.669114 | ubuntu-noble -> localhost | SHA256:BLjBnEbX5z/J3sC3TzNofX/iLFdOw1p0a2SkyQ3wqgg zuul-build-sshkey
2026-04-10 00:54:43.669152 | ubuntu-noble -> localhost | The key's randomart image is:
2026-04-10 00:54:43.669175 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-04-10 00:54:43.669204 | ubuntu-noble -> localhost | |   +.oo.   ..    |
2026-04-10 00:54:43.669226 | ubuntu-noble -> localhost | |    B. .. . .. . |
2026-04-10 00:54:43.669247 | ubuntu-noble -> localhost | |   . o  .o  ..*  |
2026-04-10 00:54:43.669267 | ubuntu-noble -> localhost | |    .  .  . .+ =.|
2026-04-10 00:54:43.669288 | ubuntu-noble -> localhost | |     E  S  = .= o|
2026-04-10 00:54:43.669308 | ubuntu-noble -> localhost | |      . . . B +*o|
2026-04-10 00:54:43.669328 | ubuntu-noble -> localhost | |       . . . B+O+|
2026-04-10 00:54:43.669349 | ubuntu-noble -> localhost | |            +o=.B|
2026-04-10 00:54:43.669371 | ubuntu-noble -> localhost | |             +oo+|
2026-04-10 00:54:43.669392 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-04-10 00:54:43.669443 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.598091
2026-04-10 00:54:43.675243 | 
2026-04-10 00:54:43.675306 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-10 00:54:43.712800 | ubuntu-noble | ok
2026-04-10 00:54:43.724844 | ubuntu-noble | included: /var/lib/zuul/builds/7e305336dff24f73b56b846fb525239f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-10 00:54:43.754974 | 
2026-04-10 00:54:43.755128 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-10 00:54:43.780511 | ubuntu-noble | skipping: Conditional result was False
2026-04-10 00:54:43.793903 | 
2026-04-10 00:54:43.794079 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-10 00:54:44.423449 | ubuntu-noble | changed
2026-04-10 00:54:44.430409 | 
2026-04-10 00:54:44.430493 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-10 00:54:44.682762 | ubuntu-noble | ok
2026-04-10 00:54:45.017995 | 
2026-04-10 00:54:45.018113 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-10 00:54:45.629723 | ubuntu-noble | changed
2026-04-10 00:54:45.637553 | 
2026-04-10 00:54:45.637634 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-10 00:54:46.248465 | ubuntu-noble | changed
2026-04-10 00:54:46.254496 | 
2026-04-10 00:54:46.254581 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-10 00:54:46.280617 | ubuntu-noble | skipping: Conditional result was False
2026-04-10 00:54:46.292912 | 
2026-04-10 00:54:46.293083 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-10 00:54:46.842207 | ubuntu-noble -> localhost | changed
2026-04-10 00:54:46.860345 | 
2026-04-10 00:54:46.860544 | TASK [add-build-sshkey : Add back temp key]
2026-04-10 00:54:47.143297 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/7e305336dff24f73b56b846fb525239f/work/7e305336dff24f73b56b846fb525239f_id_rsa (zuul-build-sshkey)
2026-04-10 00:54:47.143508 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011176
2026-04-10 00:54:47.155539 | 
2026-04-10 00:54:47.155640 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-10 00:54:47.533882 | ubuntu-noble | ok
2026-04-10 00:54:47.544221 | 
2026-04-10 00:54:47.544355 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-10 00:54:47.574233 | ubuntu-noble | skipping: Conditional result was False
2026-04-10 00:54:47.589688 | 
2026-04-10 00:54:47.589832 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-10 00:54:47.979625 | ubuntu-noble | ok
2026-04-10 00:54:47.987174 | 
2026-04-10 00:54:47.987248 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-10 00:54:48.833327 | ubuntu-noble | Output suppressed because no_log was given
2026-04-10 00:54:48.844869 | 
2026-04-10 00:54:48.845022 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-10 00:54:49.123170 | ubuntu-noble | ok: "logs"
2026-04-10 00:54:49.123373 | ubuntu-noble | ok: All items complete
2026-04-10 00:54:49.123417 | 
2026-04-10 00:54:49.299066 | ubuntu-noble | ok: "artifacts"
2026-04-10 00:54:49.542555 | ubuntu-noble | ok: "docs"
2026-04-10 00:54:49.557950 | 
2026-04-10 00:54:49.558093 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-10 00:54:49.784409 | ubuntu-noble | changed: "logs"
2026-04-10 00:54:49.996222 | ubuntu-noble | changed: "artifacts"
2026-04-10 00:54:50.200377 | ubuntu-noble | changed: "docs"
2026-04-10 00:54:50.214277 | 
2026-04-10 00:54:50.214394 | PLAY RECAP
2026-04-10 00:54:50.214439 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-10 00:54:50.214469 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-10 00:54:50.214492 | 
2026-04-10 00:54:50.353909 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-10 00:54:50.356088 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-10 00:54:50.941279 | 
2026-04-10 00:54:50.953979 | PLAY [all]
2026-04-10 00:54:50.973874 | 
2026-04-10 00:54:50.974018 | TASK [setup-uv : Extract archive]
2026-04-10 00:54:53.439278 | ubuntu-noble | changed
2026-04-10 00:54:53.448472 | 
2026-04-10 00:54:53.448571 | TASK [setup-uv : Print version]
2026-04-10 00:54:53.817966 | ubuntu-noble | uv 0.8.13
2026-04-10 00:54:54.258224 | ubuntu-noble | ok: Runtime: 0:00:00.016724
2026-04-10 00:54:54.265352 | 
2026-04-10 00:54:54.265404 | PLAY RECAP
2026-04-10 00:54:54.265450 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-10 00:54:54.265475 | 
2026-04-10 00:54:54.411627 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-10 00:54:54.412951 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-10 00:54:55.071530 | 
2026-04-10 00:54:55.072033 | PLAY [all]
2026-04-10 00:54:55.087266 | 
2026-04-10 00:54:55.087391 | TASK [Run "pre-commit"]
2026-04-10 00:54:55.796871 | ubuntu-noble | Downloading virtualenv (5.6MiB)
2026-04-10 00:54:55.923588 | ubuntu-noble |  Downloading virtualenv
2026-04-10 00:54:55.939482 | ubuntu-noble | Installed 10 packages in 15ms
2026-04-10 00:54:56.510413 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-10 00:54:57.133652 | 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-10 00:54:57.139750 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-04-10 00:54:57.675572 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-04-10 00:54:58.067333 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-04-10 00:54:58.496369 | 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-10 00:54:58.498376 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-04-10 00:54:59.064755 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-04-10 00:54:59.591013 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-10 00:54:59.591083 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-10 00:54:59.591103 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-10 00:55:04.428752 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-04-10 00:55:04.428864 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-10 00:55:04.428878 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-10 00:55:10.940124 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-04-10 00:55:10.940243 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-10 00:55:10.940256 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-10 00:55:15.677066 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-04-10 00:55:15.677126 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-10 00:55:15.677131 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-10 00:55:18.703143 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-04-10 00:55:18.703240 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-10 00:55:18.703247 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-10 00:55:36.067518 | ubuntu-noble | fix end of files.........................................................Passed
2026-04-10 00:55:36.133528 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-04-10 00:55:36.440536 | ubuntu-noble | black....................................................................Passed
2026-04-10 00:55:36.642739 | ubuntu-noble | flake8...................................................................Passed
2026-04-10 00:55:36.771476 | ubuntu-noble | isort....................................................................Passed
2026-04-10 00:55:53.825225 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-04-10 00:55:54.141723 | ubuntu-noble | ok: Runtime: 0:00:58.443593
2026-04-10 00:55:54.144114 | 
2026-04-10 00:55:54.144180 | PLAY RECAP
2026-04-10 00:55:54.144238 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-10 00:55:54.144269 | 
2026-04-10 00:55:54.268458 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-10 00:55:54.271131 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-10 00:55:54.909896 | 
2026-04-10 00:55:54.910050 | PLAY [all]
2026-04-10 00:55:54.922121 | 
2026-04-10 00:55:54.922218 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-10 00:55:54.987475 | ubuntu-noble | skipping: Conditional result was False
2026-04-10 00:55:55.000104 | 
2026-04-10 00:55:55.000291 | TASK [fetch-output : Set log path for single node]
2026-04-10 00:55:55.047676 | ubuntu-noble | ok
2026-04-10 00:55:55.053378 | 
2026-04-10 00:55:55.053450 | LOOP [fetch-output : Ensure local output dirs]
2026-04-10 00:55:55.469764 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/7e305336dff24f73b56b846fb525239f/work/logs"
2026-04-10 00:55:55.681786 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/7e305336dff24f73b56b846fb525239f/work/artifacts"
2026-04-10 00:55:55.936252 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/7e305336dff24f73b56b846fb525239f/work/docs"
2026-04-10 00:55:55.947886 | 
2026-04-10 00:55:55.948096 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-10 00:55:56.670592 | ubuntu-noble | changed: .d..t...... ./
2026-04-10 00:55:56.670858 | ubuntu-noble | changed: All items complete
2026-04-10 00:55:56.670894 | 
2026-04-10 00:55:57.144750 | ubuntu-noble | changed: .d..t...... ./
2026-04-10 00:55:57.614755 | ubuntu-noble | changed: .d..t...... ./
2026-04-10 00:55:57.634016 | 
2026-04-10 00:55:57.634138 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-10 00:55:58.076464 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.009160
2026-04-10 00:55:58.308091 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008459
2026-04-10 00:55:58.328644 | 
2026-04-10 00:55:58.328894 | PLAY [all]
2026-04-10 00:55:58.337703 | 
2026-04-10 00:55:58.337859 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-10 00:55:58.821235 | ubuntu-noble | changed
2026-04-10 00:55:58.830930 | 
2026-04-10 00:55:58.831001 | PLAY RECAP
2026-04-10 00:55:58.831060 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-10 00:55:58.831090 | 
2026-04-10 00:55:58.973882 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-10 00:55:58.975465 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-10 00:55:59.570780 | 
2026-04-10 00:55:59.570921 | PLAY [localhost]
2026-04-10 00:55:59.580715 | 
2026-04-10 00:55:59.580788 | TASK [Generate Zuul manifest]
2026-04-10 00:55:59.609186 | localhost | ok
2026-04-10 00:55:59.623213 | 
2026-04-10 00:55:59.623322 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-10 00:55:59.996829 | localhost | changed
2026-04-10 00:56:00.008165 | 
2026-04-10 00:56:00.008254 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-10 00:56:00.052702 | localhost | ok
2026-04-10 00:56:00.062013 | 
2026-04-10 00:56:00.062156 | TASK [Upload logs]
2026-04-10 00:56:00.082175 | localhost | ok
2026-04-10 00:56:00.144481 | 
2026-04-10 00:56:00.144608 | TASK [Set zuul-log-path fact]
2026-04-10 00:56:00.167385 | localhost | ok
2026-04-10 00:56:00.180299 | 
2026-04-10 00:56:00.180370 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-10 00:56:00.209483 | localhost | ok
2026-04-10 00:56:00.220242 | 
2026-04-10 00:56:00.220338 | TASK [upload-logs : Create log directories]
2026-04-10 00:56:00.676620 | localhost | changed
2026-04-10 00:56:00.682966 | 
2026-04-10 00:56:00.683065 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-10 00:56:01.121693 | localhost -> localhost | ok: Runtime: 0:00:00.005220
2026-04-10 00:56:01.129432 | 
2026-04-10 00:56:01.129517 | TASK [upload-logs : Upload logs to log server]
2026-04-10 00:56:01.586270 | localhost | Output suppressed because no_log was given
2026-04-10 00:56:01.591119 | 
2026-04-10 00:56:01.591204 | LOOP [upload-logs : Compress console log and json output]
2026-04-10 00:56:01.641206 | localhost | skipping: Conditional result was False
2026-04-10 00:56:01.649175 | localhost | skipping: Conditional result was False
2026-04-10 00:56:01.666511 | 
2026-04-10 00:56:01.666633 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-10 00:56:01.707341 | localhost | skipping: Conditional result was False
2026-04-10 00:56:01.707623 | 
2026-04-10 00:56:01.711992 | localhost | skipping: Conditional result was False
2026-04-10 00:56:01.727689 | 
2026-04-10 00:56:01.727855 | LOOP [upload-logs : Upload console log and json output]