2026-03-14 00:47:00.383861 | Job console starting
2026-03-14 00:47:00.399332 | Updating git repos
2026-03-14 00:47:00.424275 | Cloning repos into workspace
2026-03-14 00:47:00.473248 | Restoring repo states
2026-03-14 00:47:00.488189 | Merging changes
2026-03-14 00:47:00.731050 | Checking out repos
2026-03-14 00:47:00.768626 | Preparing playbooks
2026-03-14 00:47:01.728029 | Running Ansible setup
2026-03-14 00:47:06.452838 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-14 00:47:07.122272 | 
2026-03-14 00:47:07.122394 | PLAY [localhost]
2026-03-14 00:47:07.129651 | 
2026-03-14 00:47:07.129718 | TASK [Gathering Facts]
2026-03-14 00:47:07.996906 | localhost | ok
2026-03-14 00:47:08.008054 | 
2026-03-14 00:47:08.008134 | TASK [Setup log path fact]
2026-03-14 00:47:08.026744 | localhost | ok
2026-03-14 00:47:08.046143 | 
2026-03-14 00:47:08.046316 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-14 00:47:08.075997 | localhost | ok
2026-03-14 00:47:08.083730 | 
2026-03-14 00:47:08.083794 | TASK [emit-job-header : Print job information]
2026-03-14 00:47:08.124272 | # Job Information
2026-03-14 00:47:08.124502 | Ansible Version: 2.16.16
2026-03-14 00:47:08.124571 | Job: pre-commit
2026-03-14 00:47:08.124620 | Pipeline: check
2026-03-14 00:47:08.124664 | Executor: 0a8996d2b663
2026-03-14 00:47:08.124706 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/100
2026-03-14 00:47:08.124755 | Event ID: ef854cc0-1f3e-11f1-85d0-e7c2c9645e81
2026-03-14 00:47:08.129678 | 
2026-03-14 00:47:08.129885 | LOOP [emit-job-header : Print node information]
2026-03-14 00:47:08.229476 | localhost | ok:
2026-03-14 00:47:08.229766 | localhost | # Node Information
2026-03-14 00:47:08.229829 | localhost | Inventory Hostname: ubuntu-noble
2026-03-14 00:47:08.229878 | localhost | Hostname: np0000158764
2026-03-14 00:47:08.229923 | localhost | Username: zuul
2026-03-14 00:47:08.229972 | localhost | Distro: Ubuntu 24.04
2026-03-14 00:47:08.230016 | localhost | Provider: yul1
2026-03-14 00:47:08.230059 | localhost | Region: ca-ymq-1
2026-03-14 00:47:08.230101 | localhost | Label: ubuntu-noble
2026-03-14 00:47:08.230141 | localhost | Product Name: OpenStack Nova
2026-03-14 00:47:08.230183 | localhost | Interface IP: 162.253.55.200
2026-03-14 00:47:08.256356 | 
2026-03-14 00:47:08.256508 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-14 00:47:08.625988 | localhost -> localhost | changed
2026-03-14 00:47:08.635555 | 
2026-03-14 00:47:08.635625 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-14 00:47:09.427080 | localhost -> localhost | changed
2026-03-14 00:47:09.437601 | 
2026-03-14 00:47:09.437657 | PLAY [all]
2026-03-14 00:47:09.445806 | 
2026-03-14 00:47:09.445869 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-14 00:47:09.672924 | ubuntu-noble -> localhost | ok
2026-03-14 00:47:09.682776 | 
2026-03-14 00:47:09.682862 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-14 00:47:09.718723 | ubuntu-noble | ok
2026-03-14 00:47:09.731743 | ubuntu-noble | included: /var/lib/zuul/builds/85a58c069c0b469b9ea3aa055f329181/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-14 00:47:09.737780 | 
2026-03-14 00:47:09.737929 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-14 00:47:10.576691 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-03-14 00:47:10.577619 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/85a58c069c0b469b9ea3aa055f329181/work/85a58c069c0b469b9ea3aa055f329181_id_rsa
2026-03-14 00:47:10.577693 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/85a58c069c0b469b9ea3aa055f329181/work/85a58c069c0b469b9ea3aa055f329181_id_rsa.pub
2026-03-14 00:47:10.577746 | ubuntu-noble -> localhost | The key fingerprint is:
2026-03-14 00:47:10.577774 | ubuntu-noble -> localhost | SHA256:4wOqYLhhdXAHbcdxWt/+FCYKyrOf/FaluOFCh4Yn6V0 zuul-build-sshkey
2026-03-14 00:47:10.577829 | ubuntu-noble -> localhost | The key's randomart image is:
2026-03-14 00:47:10.577874 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-03-14 00:47:10.577918 | ubuntu-noble -> localhost | |     .. ...o     |
2026-03-14 00:47:10.577949 | ubuntu-noble -> localhost | |      .o o+ . .  |
2026-03-14 00:47:10.578009 | ubuntu-noble -> localhost | |   . ....o   o + |
2026-03-14 00:47:10.578037 | ubuntu-noble -> localhost | |    o o . . . +..|
2026-03-14 00:47:10.578088 | ubuntu-noble -> localhost | |   . ..+S ... o..|
2026-03-14 00:47:10.578112 | ubuntu-noble -> localhost | |. . .. *o* E o ..|
2026-03-14 00:47:10.578132 | ubuntu-noble -> localhost | |+o  . ..O + +   .|
2026-03-14 00:47:10.578169 | ubuntu-noble -> localhost | |o+ .   .o+.+     |
2026-03-14 00:47:10.578197 | ubuntu-noble -> localhost | |. .      ++.     |
2026-03-14 00:47:10.578227 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-03-14 00:47:10.578279 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.478695
2026-03-14 00:47:10.584401 | 
2026-03-14 00:47:10.584464 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-14 00:47:10.614457 | ubuntu-noble | ok
2026-03-14 00:47:10.623881 | ubuntu-noble | included: /var/lib/zuul/builds/85a58c069c0b469b9ea3aa055f329181/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-14 00:47:10.632265 | 
2026-03-14 00:47:10.632334 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-14 00:47:10.656061 | ubuntu-noble | skipping: Conditional result was False
2026-03-14 00:47:10.662235 | 
2026-03-14 00:47:10.662310 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-14 00:47:11.236429 | ubuntu-noble | changed
2026-03-14 00:47:11.242736 | 
2026-03-14 00:47:11.242799 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-14 00:47:11.467827 | ubuntu-noble | ok
2026-03-14 00:47:11.475407 | 
2026-03-14 00:47:11.475470 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-14 00:47:12.046963 | ubuntu-noble | changed
2026-03-14 00:47:12.052571 | 
2026-03-14 00:47:12.052633 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-14 00:47:12.608289 | ubuntu-noble | changed
2026-03-14 00:47:12.617181 | 
2026-03-14 00:47:12.617282 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-14 00:47:12.651618 | ubuntu-noble | skipping: Conditional result was False
2026-03-14 00:47:12.661723 | 
2026-03-14 00:47:12.661825 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-14 00:47:13.007420 | ubuntu-noble -> localhost | changed
2026-03-14 00:47:13.028032 | 
2026-03-14 00:47:13.028217 | TASK [add-build-sshkey : Add back temp key]
2026-03-14 00:47:13.289952 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/85a58c069c0b469b9ea3aa055f329181/work/85a58c069c0b469b9ea3aa055f329181_id_rsa (zuul-build-sshkey)
2026-03-14 00:47:13.290148 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009033
2026-03-14 00:47:13.297707 | 
2026-03-14 00:47:13.297772 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-14 00:47:13.652794 | ubuntu-noble | ok
2026-03-14 00:47:13.660114 | 
2026-03-14 00:47:13.660198 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-14 00:47:13.687324 | ubuntu-noble | skipping: Conditional result was False
2026-03-14 00:47:13.704843 | 
2026-03-14 00:47:13.704925 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-14 00:47:14.051707 | ubuntu-noble | ok
2026-03-14 00:47:14.057793 | 
2026-03-14 00:47:14.057858 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-14 00:47:14.883139 | ubuntu-noble | Output suppressed because no_log was given
2026-03-14 00:47:14.895321 | 
2026-03-14 00:47:14.895401 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-14 00:47:15.165933 | ubuntu-noble | ok: "logs"
2026-03-14 00:47:15.166102 | ubuntu-noble | ok: All items complete
2026-03-14 00:47:15.166141 | 
2026-03-14 00:47:15.325406 | ubuntu-noble | ok: "artifacts"
2026-03-14 00:47:15.519559 | ubuntu-noble | ok: "docs"
2026-03-14 00:47:15.527372 | 
2026-03-14 00:47:15.527487 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-14 00:47:15.774500 | ubuntu-noble | changed: "logs"
2026-03-14 00:47:15.965883 | ubuntu-noble | changed: "artifacts"
2026-03-14 00:47:16.172744 | ubuntu-noble | changed: "docs"
2026-03-14 00:47:16.196037 | 
2026-03-14 00:47:16.196130 | PLAY RECAP
2026-03-14 00:47:16.196175 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-14 00:47:16.196205 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-14 00:47:16.196227 | 
2026-03-14 00:47:16.306397 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-14 00:47:16.308340 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-03-14 00:47:16.843923 | 
2026-03-14 00:47:16.844032 | PLAY [all]
2026-03-14 00:47:16.855350 | 
2026-03-14 00:47:16.855424 | TASK [setup-uv : Extract archive]
2026-03-14 00:47:19.344983 | ubuntu-noble | changed
2026-03-14 00:47:19.351097 | 
2026-03-14 00:47:19.351181 | TASK [setup-uv : Print version]
2026-03-14 00:47:19.777906 | ubuntu-noble | uv 0.8.13
2026-03-14 00:47:19.887586 | ubuntu-noble | ok: Runtime: 0:00:00.015906
2026-03-14 00:47:19.896500 | 
2026-03-14 00:47:19.896550 | PLAY RECAP
2026-03-14 00:47:19.896592 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-14 00:47:19.896615 | 
2026-03-14 00:47:19.992545 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-03-14 00:47:19.996280 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-03-14 00:47:20.577472 | 
2026-03-14 00:47:20.577655 | PLAY [all]
2026-03-14 00:47:20.590043 | 
2026-03-14 00:47:20.590131 | TASK [Run "pre-commit"]
2026-03-14 00:47:21.398338 | ubuntu-noble | Downloading virtualenv (5.6MiB)
2026-03-14 00:47:21.576219 | ubuntu-noble |  Downloading virtualenv
2026-03-14 00:47:21.588344 | ubuntu-noble | Installed 10 packages in 11ms
2026-03-14 00:47:22.012176 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-03-14 00:47:22.535630 | 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-14 00:47:22.541258 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-03-14 00:47:23.177880 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-03-14 00:47:23.562694 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-03-14 00:47:24.041043 | 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-14 00:47:24.043138 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-03-14 00:47:24.621143 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-03-14 00:47:25.213758 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-03-14 00:47:25.213844 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-03-14 00:47:25.213855 | ubuntu-noble | [INFO] This may take a few minutes...
2026-03-14 00:47:29.624344 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-03-14 00:47:29.624429 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-03-14 00:47:29.624437 | ubuntu-noble | [INFO] This may take a few minutes...
2026-03-14 00:47:35.028085 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-03-14 00:47:35.028170 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-03-14 00:47:35.028182 | ubuntu-noble | [INFO] This may take a few minutes...
2026-03-14 00:47:38.468150 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-03-14 00:47:38.468227 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-03-14 00:47:38.468232 | ubuntu-noble | [INFO] This may take a few minutes...
2026-03-14 00:47:41.443473 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-03-14 00:47:41.443568 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-03-14 00:47:41.443581 | ubuntu-noble | [INFO] This may take a few minutes...
2026-03-14 00:47:53.429856 | ubuntu-noble | fix end of files.........................................................Passed
2026-03-14 00:47:53.493014 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-03-14 00:47:53.762992 | ubuntu-noble | black....................................................................Passed
2026-03-14 00:47:53.945926 | ubuntu-noble | flake8...................................................................Passed
2026-03-14 00:47:54.064756 | ubuntu-noble | isort....................................................................Passed
2026-03-14 00:48:10.605027 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-03-14 00:48:10.689116 | ubuntu-noble | ok: Runtime: 0:00:49.696749
2026-03-14 00:48:10.691933 | 
2026-03-14 00:48:10.691982 | PLAY RECAP
2026-03-14 00:48:10.692094 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-14 00:48:10.692137 | 
2026-03-14 00:48:10.824746 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-03-14 00:48:10.826851 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-14 00:48:11.434390 | 
2026-03-14 00:48:11.434511 | PLAY [all]
2026-03-14 00:48:11.447123 | 
2026-03-14 00:48:11.447231 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-14 00:48:11.494328 | ubuntu-noble | skipping: Conditional result was False
2026-03-14 00:48:11.503845 | 
2026-03-14 00:48:11.503961 | TASK [fetch-output : Set log path for single node]
2026-03-14 00:48:11.547886 | ubuntu-noble | ok
2026-03-14 00:48:11.553416 | 
2026-03-14 00:48:11.553487 | LOOP [fetch-output : Ensure local output dirs]
2026-03-14 00:48:11.955731 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/85a58c069c0b469b9ea3aa055f329181/work/logs"
2026-03-14 00:48:12.159819 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/85a58c069c0b469b9ea3aa055f329181/work/artifacts"
2026-03-14 00:48:12.385461 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/85a58c069c0b469b9ea3aa055f329181/work/docs"
2026-03-14 00:48:12.398631 | 
2026-03-14 00:48:12.398799 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-14 00:48:13.034737 | ubuntu-noble | changed: .d..t...... ./
2026-03-14 00:48:13.035094 | ubuntu-noble | changed: All items complete
2026-03-14 00:48:13.035135 | 
2026-03-14 00:48:13.661740 | ubuntu-noble | changed: .d..t...... ./
2026-03-14 00:48:14.129161 | ubuntu-noble | changed: .d..t...... ./
2026-03-14 00:48:14.154430 | 
2026-03-14 00:48:14.155123 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-14 00:48:14.548016 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008861
2026-03-14 00:48:14.844420 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007912
2026-03-14 00:48:14.861053 | 
2026-03-14 00:48:14.861190 | PLAY [all]
2026-03-14 00:48:14.867777 | 
2026-03-14 00:48:14.867854 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-14 00:48:15.381123 | ubuntu-noble | changed
2026-03-14 00:48:15.386941 | 
2026-03-14 00:48:15.386994 | PLAY RECAP
2026-03-14 00:48:15.387038 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-14 00:48:15.387068 | 
2026-03-14 00:48:15.487128 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-14 00:48:15.489411 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-14 00:48:16.039937 | 
2026-03-14 00:48:16.040052 | PLAY [localhost]
2026-03-14 00:48:16.049603 | 
2026-03-14 00:48:16.049673 | TASK [Generate Zuul manifest]
2026-03-14 00:48:16.069104 | localhost | ok
2026-03-14 00:48:16.086180 | 
2026-03-14 00:48:16.086257 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-14 00:48:16.420988 | localhost | changed
2026-03-14 00:48:16.437948 | 
2026-03-14 00:48:16.438034 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-14 00:48:16.470034 | localhost | ok
2026-03-14 00:48:16.479218 | 
2026-03-14 00:48:16.479311 | TASK [Upload logs]
2026-03-14 00:48:16.497723 | localhost | ok
2026-03-14 00:48:16.561656 | 
2026-03-14 00:48:16.561790 | TASK [Set zuul-log-path fact]
2026-03-14 00:48:16.584130 | localhost | ok
2026-03-14 00:48:16.596889 | 
2026-03-14 00:48:16.596976 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-14 00:48:16.629802 | localhost | ok
2026-03-14 00:48:16.637680 | 
2026-03-14 00:48:16.637750 | TASK [upload-logs : Create log directories]
2026-03-14 00:48:17.047171 | localhost | changed
2026-03-14 00:48:17.052382 | 
2026-03-14 00:48:17.052456 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-14 00:48:17.560105 | localhost -> localhost | ok: Runtime: 0:00:00.005519
2026-03-14 00:48:17.565937 | 
2026-03-14 00:48:17.566008 | TASK [upload-logs : Upload logs to log server]
2026-03-14 00:48:18.271824 | localhost | Output suppressed because no_log was given
2026-03-14 00:48:18.275582 | 
2026-03-14 00:48:18.275645 | LOOP [upload-logs : Compress console log and json output]
2026-03-14 00:48:18.324808 | localhost | skipping: Conditional result was False
2026-03-14 00:48:18.332950 | localhost | skipping: Conditional result was False
2026-03-14 00:48:18.344884 | 
2026-03-14 00:48:18.345050 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-14 00:48:18.393428 | localhost | skipping: Conditional result was False
2026-03-14 00:48:18.393836 | 
2026-03-14 00:48:18.397574 | localhost | skipping: Conditional result was False
2026-03-14 00:48:18.410220 | 
2026-03-14 00:48:18.410408 | LOOP [upload-logs : Upload console log and json output]