2026-04-26 13:38:41.054890 | Job console starting
2026-04-26 13:38:41.081889 | Updating git repos
2026-04-26 13:38:41.111654 | Cloning repos into workspace
2026-04-26 13:38:41.237561 | Restoring repo states
2026-04-26 13:38:41.244184 | Merging changes
2026-04-26 13:38:41.851791 | Checking out repos
2026-04-26 13:38:41.889458 | Preparing playbooks
2026-04-26 13:38:43.029137 | Running Ansible setup
2026-04-26 13:38:47.424776 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-26 13:38:48.060935 | 
2026-04-26 13:38:48.061099 | PLAY [localhost]
2026-04-26 13:38:48.068825 | 
2026-04-26 13:38:48.068910 | TASK [Gathering Facts]
2026-04-26 13:38:49.043298 | localhost | ok
2026-04-26 13:38:49.050133 | 
2026-04-26 13:38:49.050212 | TASK [Setup log path fact]
2026-04-26 13:38:49.078397 | localhost | ok
2026-04-26 13:38:49.089787 | 
2026-04-26 13:38:49.089853 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-26 13:38:49.115695 | localhost | ok
2026-04-26 13:38:49.124175 | 
2026-04-26 13:38:49.124266 | TASK [emit-job-header : Print job information]
2026-04-26 13:38:49.162398 | # Job Information
2026-04-26 13:38:49.162641 | Ansible Version: 2.16.16
2026-04-26 13:38:49.162689 | Job: pre-commit
2026-04-26 13:38:49.162720 | Pipeline: check
2026-04-26 13:38:49.162748 | Executor: 0a8996d2b663
2026-04-26 13:38:49.162775 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/122
2026-04-26 13:38:49.162808 | Event ID: 1b10a210-4175-11f1-9d04-fb4ed4f3c7b1
2026-04-26 13:38:49.166849 | 
2026-04-26 13:38:49.166919 | LOOP [emit-job-header : Print node information]
2026-04-26 13:38:49.283116 | localhost | ok:
2026-04-26 13:38:49.283363 | localhost | # Node Information
2026-04-26 13:38:49.283399 | localhost | Inventory Hostname: ubuntu-noble
2026-04-26 13:38:49.283433 | localhost | Hostname: np0000170313
2026-04-26 13:38:49.283461 | localhost | Username: zuul
2026-04-26 13:38:49.283500 | localhost | Distro: Ubuntu 24.04
2026-04-26 13:38:49.283530 | localhost | Provider: yul1
2026-04-26 13:38:49.283557 | localhost | Region: ca-ymq-1
2026-04-26 13:38:49.283582 | localhost | Label: ubuntu-noble
2026-04-26 13:38:49.283608 | localhost | Product Name: OpenStack Nova
2026-04-26 13:38:49.283632 | localhost | Interface IP: 199.204.45.89
2026-04-26 13:38:49.301087 | 
2026-04-26 13:38:49.301291 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-26 13:38:49.739588 | localhost -> localhost | changed
2026-04-26 13:38:49.745554 | 
2026-04-26 13:38:49.745633 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-26 13:38:50.694211 | localhost -> localhost | changed
2026-04-26 13:38:50.702341 | 
2026-04-26 13:38:50.702425 | PLAY [all]
2026-04-26 13:38:50.712239 | 
2026-04-26 13:38:50.712348 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-26 13:38:50.953132 | ubuntu-noble -> localhost | ok
2026-04-26 13:38:50.965387 | 
2026-04-26 13:38:50.965471 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-26 13:38:51.001877 | ubuntu-noble | ok
2026-04-26 13:38:51.016522 | ubuntu-noble | included: /var/lib/zuul/builds/326d0436ebc341519de4adf441598014/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-26 13:38:51.022877 | 
2026-04-26 13:38:51.022944 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-26 13:38:52.176094 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-04-26 13:38:52.176293 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/326d0436ebc341519de4adf441598014/work/326d0436ebc341519de4adf441598014_id_rsa
2026-04-26 13:38:52.176327 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/326d0436ebc341519de4adf441598014/work/326d0436ebc341519de4adf441598014_id_rsa.pub
2026-04-26 13:38:52.176350 | ubuntu-noble -> localhost | The key fingerprint is:
2026-04-26 13:38:52.176373 | ubuntu-noble -> localhost | SHA256:uQIdMqH7McQ5QYv31LDqu/lq4ED5HblKbWOF4I5lyBo zuul-build-sshkey
2026-04-26 13:38:52.176413 | ubuntu-noble -> localhost | The key's randomart image is:
2026-04-26 13:38:52.176435 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-04-26 13:38:52.176465 | ubuntu-noble -> localhost | |   .+ .          |
2026-04-26 13:38:52.176487 | ubuntu-noble -> localhost | |   = = +         |
2026-04-26 13:38:52.176508 | ubuntu-noble -> localhost | |. * @ * .        |
2026-04-26 13:38:52.176528 | ubuntu-noble -> localhost | |E= B % o .       |
2026-04-26 13:38:52.176548 | ubuntu-noble -> localhost | |o.B B * S        |
2026-04-26 13:38:52.176568 | ubuntu-noble -> localhost | |o..* @   .       |
2026-04-26 13:38:52.176588 | ubuntu-noble -> localhost | | o..* o .        |
2026-04-26 13:38:52.176607 | ubuntu-noble -> localhost | |  ...o .         |
2026-04-26 13:38:52.176629 | ubuntu-noble -> localhost | |   .=+.          |
2026-04-26 13:38:52.176649 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-04-26 13:38:52.176701 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.480195
2026-04-26 13:38:52.182449 | 
2026-04-26 13:38:52.182519 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-26 13:38:52.221432 | ubuntu-noble | ok
2026-04-26 13:38:52.231721 | ubuntu-noble | included: /var/lib/zuul/builds/326d0436ebc341519de4adf441598014/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-26 13:38:52.239749 | 
2026-04-26 13:38:52.239817 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-26 13:38:52.266624 | ubuntu-noble | skipping: Conditional result was False
2026-04-26 13:38:52.274610 | 
2026-04-26 13:38:52.274707 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-26 13:38:52.914652 | ubuntu-noble | changed
2026-04-26 13:38:52.924430 | 
2026-04-26 13:38:52.924553 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-26 13:38:53.151087 | ubuntu-noble | ok
2026-04-26 13:38:53.161574 | 
2026-04-26 13:38:53.161727 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-26 13:38:53.764822 | ubuntu-noble | changed
2026-04-26 13:38:53.773789 | 
2026-04-26 13:38:53.773903 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-26 13:38:54.393867 | ubuntu-noble | changed
2026-04-26 13:38:54.399685 | 
2026-04-26 13:38:54.399752 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-26 13:38:54.422609 | ubuntu-noble | skipping: Conditional result was False
2026-04-26 13:38:54.433615 | 
2026-04-26 13:38:54.433693 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-26 13:38:54.815609 | ubuntu-noble -> localhost | changed
2026-04-26 13:38:54.826583 | 
2026-04-26 13:38:54.830876 | TASK [add-build-sshkey : Add back temp key]
2026-04-26 13:38:55.117722 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/326d0436ebc341519de4adf441598014/work/326d0436ebc341519de4adf441598014_id_rsa (zuul-build-sshkey)
2026-04-26 13:38:55.117918 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.023876
2026-04-26 13:38:55.123383 | 
2026-04-26 13:38:55.123459 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-26 13:38:55.488161 | ubuntu-noble | ok
2026-04-26 13:38:55.493373 | 
2026-04-26 13:38:55.493438 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-26 13:38:55.518174 | ubuntu-noble | skipping: Conditional result was False
2026-04-26 13:38:55.533204 | 
2026-04-26 13:38:55.533275 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-26 13:38:55.920793 | ubuntu-noble | ok
2026-04-26 13:38:55.928029 | 
2026-04-26 13:38:55.928096 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-26 13:38:56.860854 | ubuntu-noble | Output suppressed because no_log was given
2026-04-26 13:38:56.871684 | 
2026-04-26 13:38:56.871755 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-26 13:38:57.141383 | ubuntu-noble | ok: "logs"
2026-04-26 13:38:57.141606 | ubuntu-noble | ok: All items complete
2026-04-26 13:38:57.141722 | 
2026-04-26 13:38:57.318898 | ubuntu-noble | ok: "artifacts"
2026-04-26 13:38:57.575104 | ubuntu-noble | ok: "docs"
2026-04-26 13:38:57.596840 | 
2026-04-26 13:38:57.596939 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-26 13:38:57.845286 | ubuntu-noble | changed: "logs"
2026-04-26 13:38:58.060058 | ubuntu-noble | changed: "artifacts"
2026-04-26 13:38:58.270947 | ubuntu-noble | changed: "docs"
2026-04-26 13:38:58.284848 | 
2026-04-26 13:38:58.285024 | PLAY RECAP
2026-04-26 13:38:58.285091 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-26 13:38:58.285128 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-26 13:38:58.285158 | 
2026-04-26 13:38:58.439561 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-26 13:38:58.441041 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-26 13:38:59.070309 | 
2026-04-26 13:38:59.070487 | PLAY [all]
2026-04-26 13:38:59.083200 | 
2026-04-26 13:38:59.083328 | TASK [setup-uv : Extract archive]
2026-04-26 13:39:01.583499 | ubuntu-noble | changed
2026-04-26 13:39:01.590388 | 
2026-04-26 13:39:01.590475 | TASK [setup-uv : Print version]
2026-04-26 13:39:02.325882 | ubuntu-noble | uv 0.8.13
2026-04-26 13:39:02.135270 | ubuntu-noble | ok: Runtime: 0:00:00.015030
2026-04-26 13:39:02.144653 | 
2026-04-26 13:39:02.144729 | PLAY RECAP
2026-04-26 13:39:02.144779 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-26 13:39:02.144804 | 
2026-04-26 13:39:02.302112 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-26 13:39:02.304644 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-26 13:39:02.896905 | 
2026-04-26 13:39:02.897057 | PLAY [all]
2026-04-26 13:39:02.908302 | 
2026-04-26 13:39:02.908380 | TASK [Run "pre-commit"]
2026-04-26 13:39:03.913035 | ubuntu-noble | Downloading virtualenv (5.6MiB)
2026-04-26 13:39:03.998001 | ubuntu-noble |  Downloading virtualenv
2026-04-26 13:39:04.014603 | ubuntu-noble | Installed 10 packages in 15ms
2026-04-26 13:39:04.415380 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-26 13:39:05.189743 | 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-26 13:39:05.194121 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-04-26 13:39:05.739265 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-04-26 13:39:06.167590 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-04-26 13:39:06.627645 | 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-26 13:39:06.630310 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-04-26 13:39:07.257265 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-04-26 13:39:07.819447 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-26 13:39:07.819548 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-26 13:39:07.819568 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-26 13:39:11.988633 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-04-26 13:39:11.988702 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-26 13:39:11.988707 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-26 13:39:17.708707 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-04-26 13:39:17.708786 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-26 13:39:17.708806 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-26 13:39:22.178338 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-04-26 13:39:22.178443 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-26 13:39:22.178454 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-26 13:39:25.546999 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-04-26 13:39:25.547050 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-26 13:39:25.547055 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-26 13:39:58.212269 | ubuntu-noble | fix end of files.........................................................Passed
2026-04-26 13:39:58.274616 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-04-26 13:39:58.558644 | ubuntu-noble | black....................................................................Passed
2026-04-26 13:39:58.761609 | ubuntu-noble | flake8...................................................................Passed
2026-04-26 13:39:58.888367 | ubuntu-noble | isort....................................................................Passed
2026-04-26 13:40:15.124684 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-04-26 13:40:15.352925 | ubuntu-noble | ok: Runtime: 0:01:11.513304
2026-04-26 13:40:15.356157 | 
2026-04-26 13:40:15.356253 | PLAY RECAP
2026-04-26 13:40:15.356335 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-26 13:40:15.356357 | 
2026-04-26 13:40:15.481936 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-26 13:40:15.485145 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-26 13:40:16.061943 | 
2026-04-26 13:40:16.062082 | PLAY [all]
2026-04-26 13:40:16.073609 | 
2026-04-26 13:40:16.073691 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-26 13:40:16.139838 | ubuntu-noble | skipping: Conditional result was False
2026-04-26 13:40:16.148636 | 
2026-04-26 13:40:16.148762 | TASK [fetch-output : Set log path for single node]
2026-04-26 13:40:16.192879 | ubuntu-noble | ok
2026-04-26 13:40:16.200456 | 
2026-04-26 13:40:16.200550 | LOOP [fetch-output : Ensure local output dirs]
2026-04-26 13:40:16.613107 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/326d0436ebc341519de4adf441598014/work/logs"
2026-04-26 13:40:16.839933 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/326d0436ebc341519de4adf441598014/work/artifacts"
2026-04-26 13:40:17.053124 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/326d0436ebc341519de4adf441598014/work/docs"
2026-04-26 13:40:17.067784 | 
2026-04-26 13:40:17.067915 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-26 13:40:17.722732 | ubuntu-noble | ok
2026-04-26 13:40:17.723070 | ubuntu-noble | changed: All items complete
2026-04-26 13:40:17.723118 | 
2026-04-26 13:40:18.164877 | ubuntu-noble | changed: .d..t...... ./
2026-04-26 13:40:18.615997 | ubuntu-noble | changed: .d..t...... ./
2026-04-26 13:40:18.636495 | 
2026-04-26 13:40:18.636614 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-26 13:40:19.051897 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.006252
2026-04-26 13:40:19.270726 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008832
2026-04-26 13:40:19.287200 | 
2026-04-26 13:40:19.287338 | PLAY [all]
2026-04-26 13:40:19.294102 | 
2026-04-26 13:40:19.294170 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-26 13:40:19.820381 | ubuntu-noble | changed
2026-04-26 13:40:19.829440 | 
2026-04-26 13:40:19.829547 | PLAY RECAP
2026-04-26 13:40:19.829614 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-26 13:40:19.829726 | 
2026-04-26 13:40:19.968129 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-26 13:40:19.970184 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-26 13:40:20.571724 | 
2026-04-26 13:40:20.571865 | PLAY [localhost]
2026-04-26 13:40:20.582101 | 
2026-04-26 13:40:20.582177 | TASK [Generate Zuul manifest]
2026-04-26 13:40:20.603936 | localhost | ok
2026-04-26 13:40:20.619789 | 
2026-04-26 13:40:20.619890 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-26 13:40:20.935935 | localhost | changed
2026-04-26 13:40:20.950376 | 
2026-04-26 13:40:20.950533 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-26 13:40:20.981878 | localhost | ok
2026-04-26 13:40:20.991298 | 
2026-04-26 13:40:20.991465 | TASK [Upload logs]
2026-04-26 13:40:21.013529 | localhost | ok
2026-04-26 13:40:21.080020 | 
2026-04-26 13:40:21.080157 | TASK [Set zuul-log-path fact]
2026-04-26 13:40:21.110677 | localhost | ok
2026-04-26 13:40:21.121831 | 
2026-04-26 13:40:21.121902 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-26 13:40:21.157546 | localhost | ok
2026-04-26 13:40:21.166645 | 
2026-04-26 13:40:21.166727 | TASK [upload-logs : Create log directories]
2026-04-26 13:40:21.569428 | localhost | changed
2026-04-26 13:40:21.575769 | 
2026-04-26 13:40:21.575863 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-26 13:40:21.981351 | localhost -> localhost | ok: Runtime: 0:00:00.005413
2026-04-26 13:40:21.988129 | 
2026-04-26 13:40:21.988199 | TASK [upload-logs : Upload logs to log server]
2026-04-26 13:40:22.447352 | localhost | Output suppressed because no_log was given
2026-04-26 13:40:22.452184 | 
2026-04-26 13:40:22.452269 | LOOP [upload-logs : Compress console log and json output]
2026-04-26 13:40:22.500203 | localhost | skipping: Conditional result was False
2026-04-26 13:40:22.507922 | localhost | skipping: Conditional result was False
2026-04-26 13:40:22.516747 | 
2026-04-26 13:40:22.516896 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-26 13:40:22.563610 | localhost | skipping: Conditional result was False
2026-04-26 13:40:22.563949 | 
2026-04-26 13:40:22.570911 | localhost | skipping: Conditional result was False
2026-04-26 13:40:22.583954 | 
2026-04-26 13:40:22.584022 | LOOP [upload-logs : Upload console log and json output]