2026-04-01 00:58:21.185951 | Job console starting
2026-04-01 00:58:21.207099 | Updating git repos
2026-04-01 00:58:21.238765 | Cloning repos into workspace
2026-04-01 00:58:21.463524 | Restoring repo states
2026-04-01 00:58:21.474189 | Merging changes
2026-04-01 00:58:22.124104 | Checking out repos
2026-04-01 00:58:22.284365 | Preparing playbooks
2026-04-01 00:58:26.284906 | Running Ansible setup
2026-04-01 00:58:31.023916 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-01 00:58:31.652479 | 
2026-04-01 00:58:31.652642 | PLAY [localhost]
2026-04-01 00:58:31.660768 | 
2026-04-01 00:58:31.660845 | TASK [Gathering Facts]
2026-04-01 00:58:32.530696 | localhost | ok
2026-04-01 00:58:32.548793 | 
2026-04-01 00:58:32.549121 | TASK [Setup log path fact]
2026-04-01 00:58:32.568891 | localhost | ok
2026-04-01 00:58:32.584384 | 
2026-04-01 00:58:32.584464 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-01 00:58:32.614770 | localhost | ok
2026-04-01 00:58:32.625202 | 
2026-04-01 00:58:32.625272 | TASK [emit-job-header : Print job information]
2026-04-01 00:58:32.666833 | # Job Information
2026-04-01 00:58:32.667038 | Ansible Version: 2.16.16
2026-04-01 00:58:32.667107 | Job: pre-commit
2026-04-01 00:58:32.667155 | Pipeline: check
2026-04-01 00:58:32.667201 | Executor: 0a8996d2b663
2026-04-01 00:58:32.667245 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/105
2026-04-01 00:58:32.667294 | Event ID: ba6bf4a0-2d65-11f1-99f2-ed7bf96431dc
2026-04-01 00:58:32.672005 | 
2026-04-01 00:58:32.672066 | LOOP [emit-job-header : Print node information]
2026-04-01 00:58:32.767520 | localhost | ok:
2026-04-01 00:58:32.767707 | localhost | # Node Information
2026-04-01 00:58:32.767736 | localhost | Inventory Hostname: ubuntu-noble
2026-04-01 00:58:32.767758 | localhost | Hostname: np0000162054
2026-04-01 00:58:32.767778 | localhost | Username: zuul
2026-04-01 00:58:32.767801 | localhost | Distro: Ubuntu 24.04
2026-04-01 00:58:32.767821 | localhost | Provider: yul1
2026-04-01 00:58:32.767839 | localhost | Region: ca-ymq-1
2026-04-01 00:58:32.767858 | localhost | Label: ubuntu-noble
2026-04-01 00:58:32.767876 | localhost | Product Name: OpenStack Nova
2026-04-01 00:58:32.767894 | localhost | Interface IP: 199.204.45.57
2026-04-01 00:58:32.778574 | 
2026-04-01 00:58:32.778731 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-01 00:58:33.200475 | localhost -> localhost | changed
2026-04-01 00:58:33.206013 | 
2026-04-01 00:58:33.206088 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-01 00:58:34.104517 | localhost -> localhost | changed
2026-04-01 00:58:34.114217 | 
2026-04-01 00:58:34.114293 | PLAY [all]
2026-04-01 00:58:34.125649 | 
2026-04-01 00:58:34.125711 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-01 00:58:34.362330 | ubuntu-noble -> localhost | ok
2026-04-01 00:58:34.369774 | 
2026-04-01 00:58:34.369844 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-01 00:58:34.412806 | ubuntu-noble | ok
2026-04-01 00:58:34.428145 | ubuntu-noble | included: /var/lib/zuul/builds/4d8ddc98713045119f1cbdcf7d21692a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-01 00:58:34.434407 | 
2026-04-01 00:58:34.434469 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-01 00:58:35.427874 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-04-01 00:58:35.428065 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/4d8ddc98713045119f1cbdcf7d21692a/work/4d8ddc98713045119f1cbdcf7d21692a_id_rsa
2026-04-01 00:58:35.428098 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/4d8ddc98713045119f1cbdcf7d21692a/work/4d8ddc98713045119f1cbdcf7d21692a_id_rsa.pub
2026-04-01 00:58:35.428122 | ubuntu-noble -> localhost | The key fingerprint is:
2026-04-01 00:58:35.428145 | ubuntu-noble -> localhost | SHA256:ODa0zqi0dMMP9Bzn9INJM3ypQd4EFb1d9TedqO5a+9w zuul-build-sshkey
2026-04-01 00:58:35.428182 | ubuntu-noble -> localhost | The key's randomart image is:
2026-04-01 00:58:35.428205 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-04-01 00:58:35.428233 | ubuntu-noble -> localhost | |        ..oo    o|
2026-04-01 00:58:35.428256 | ubuntu-noble -> localhost | |         .  . . =|
2026-04-01 00:58:35.428278 | ubuntu-noble -> localhost | |      . . .  + ++|
2026-04-01 00:58:35.428299 | ubuntu-noble -> localhost | |     . * o .o . o|
2026-04-01 00:58:35.428320 | ubuntu-noble -> localhost | |    . B S +.     |
2026-04-01 00:58:35.428340 | ubuntu-noble -> localhost | |   o B O X.      |
2026-04-01 00:58:35.428377 | ubuntu-noble -> localhost | |  o * = = oo     |
2026-04-01 00:58:35.428399 | ubuntu-noble -> localhost | | o + +    o.o .  |
2026-04-01 00:58:35.428423 | ubuntu-noble -> localhost | |  o   .  ..o.o E |
2026-04-01 00:58:35.428444 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-04-01 00:58:35.428491 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.542425
2026-04-01 00:58:35.434055 | 
2026-04-01 00:58:35.434122 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-01 00:58:35.467888 | ubuntu-noble | ok
2026-04-01 00:58:35.478790 | ubuntu-noble | included: /var/lib/zuul/builds/4d8ddc98713045119f1cbdcf7d21692a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-01 00:58:35.492358 | 
2026-04-01 00:58:35.502328 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-01 00:58:35.531853 | ubuntu-noble | skipping: Conditional result was False
2026-04-01 00:58:35.538946 | 
2026-04-01 00:58:35.539018 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-01 00:58:36.115770 | ubuntu-noble | changed
2026-04-01 00:58:36.121881 | 
2026-04-01 00:58:36.121944 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-01 00:58:36.342391 | ubuntu-noble | ok
2026-04-01 00:58:36.350414 | 
2026-04-01 00:58:36.350498 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-01 00:58:36.901933 | ubuntu-noble | changed
2026-04-01 00:58:36.909056 | 
2026-04-01 00:58:36.909134 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-01 00:58:37.461527 | ubuntu-noble | changed
2026-04-01 00:58:37.855875 | 
2026-04-01 00:58:37.856033 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-01 00:58:37.904417 | ubuntu-noble | skipping: Conditional result was False
2026-04-01 00:58:37.915410 | 
2026-04-01 00:58:37.915503 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-01 00:58:38.345487 | ubuntu-noble -> localhost | changed
2026-04-01 00:58:38.362252 | 
2026-04-01 00:58:38.362324 | TASK [add-build-sshkey : Add back temp key]
2026-04-01 00:58:38.675504 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/4d8ddc98713045119f1cbdcf7d21692a/work/4d8ddc98713045119f1cbdcf7d21692a_id_rsa (zuul-build-sshkey)
2026-04-01 00:58:38.676255 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.015345
2026-04-01 00:58:38.683980 | 
2026-04-01 00:58:38.684053 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-01 00:58:39.039974 | ubuntu-noble | ok
2026-04-01 00:58:39.053285 | 
2026-04-01 00:58:39.053371 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-01 00:58:39.084307 | ubuntu-noble | skipping: Conditional result was False
2026-04-01 00:58:39.102287 | 
2026-04-01 00:58:39.102375 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-01 00:58:39.516437 | ubuntu-noble | ok
2026-04-01 00:58:39.524532 | 
2026-04-01 00:58:39.524616 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-01 00:58:40.398208 | ubuntu-noble | Output suppressed because no_log was given
2026-04-01 00:58:40.559223 | 
2026-04-01 00:58:40.559324 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-01 00:58:40.861078 | ubuntu-noble | ok: "logs"
2026-04-01 00:58:40.861386 | ubuntu-noble | ok: All items complete
2026-04-01 00:58:40.861447 | 
2026-04-01 00:58:41.086086 | ubuntu-noble | ok: "artifacts"
2026-04-01 00:58:41.323627 | ubuntu-noble | ok: "docs"
2026-04-01 00:58:41.335825 | 
2026-04-01 00:58:41.335969 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-01 00:58:41.569108 | ubuntu-noble | changed: "logs"
2026-04-01 00:58:41.805300 | ubuntu-noble | changed: "artifacts"
2026-04-01 00:58:42.013450 | ubuntu-noble | changed: "docs"
2026-04-01 00:58:42.033117 | 
2026-04-01 00:58:42.033213 | PLAY RECAP
2026-04-01 00:58:42.033258 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-01 00:58:42.033290 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-01 00:58:42.033312 | 
2026-04-01 00:58:42.139425 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-01 00:58:42.140548 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-01 00:58:42.727232 | 
2026-04-01 00:58:42.727409 | PLAY [all]
2026-04-01 00:58:42.740260 | 
2026-04-01 00:58:42.740369 | TASK [setup-uv : Extract archive]
2026-04-01 00:58:45.169699 | ubuntu-noble | changed
2026-04-01 00:58:45.175724 | 
2026-04-01 00:58:45.175800 | TASK [setup-uv : Print version]
2026-04-01 00:58:45.590161 | ubuntu-noble | uv 0.8.13
2026-04-01 00:58:45.714485 | ubuntu-noble | ok: Runtime: 0:00:00.017059
2026-04-01 00:58:45.724610 | 
2026-04-01 00:58:45.724675 | PLAY RECAP
2026-04-01 00:58:45.724719 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-01 00:58:45.724742 | 
2026-04-01 00:58:45.850283 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-01 00:58:45.852273 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-01 00:58:46.425535 | 
2026-04-01 00:58:46.425683 | PLAY [all]
2026-04-01 00:58:46.436943 | 
2026-04-01 00:58:46.437045 | TASK [Run "pre-commit"]
2026-04-01 00:58:47.355965 | ubuntu-noble | Downloading virtualenv (5.6MiB)
2026-04-01 00:58:47.574319 | ubuntu-noble |  Downloading virtualenv
2026-04-01 00:58:47.585546 | ubuntu-noble | Installed 10 packages in 10ms
2026-04-01 00:58:47.989870 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-01 00:58:48.518163 | 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-01 00:58:48.523516 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-04-01 00:58:49.047829 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-04-01 00:58:49.430843 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-04-01 00:58:50.039542 | 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-01 00:58:50.041967 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-04-01 00:58:50.589838 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-04-01 00:58:51.230517 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-01 00:58:51.230620 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-01 00:58:51.230632 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-01 00:58:55.646347 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-04-01 00:58:55.646472 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-01 00:58:55.646485 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-01 00:59:01.408407 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-04-01 00:59:01.408586 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-01 00:59:01.408604 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-01 00:59:05.631448 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-04-01 00:59:05.631657 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-01 00:59:05.631691 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-01 00:59:08.799773 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-04-01 00:59:08.799860 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-01 00:59:08.799872 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-01 00:59:23.813931 | ubuntu-noble | fix end of files.........................................................Passed
2026-04-01 00:59:23.877066 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-04-01 00:59:24.167966 | ubuntu-noble | black....................................................................Passed
2026-04-01 00:59:24.358701 | ubuntu-noble | flake8...................................................................Passed
2026-04-01 00:59:24.483747 | ubuntu-noble | isort....................................................................Passed
2026-04-01 00:59:41.846371 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-04-01 00:59:42.036861 | ubuntu-noble | ok: Runtime: 0:00:55.047743
2026-04-01 00:59:42.038912 | 
2026-04-01 00:59:42.038971 | PLAY RECAP
2026-04-01 00:59:42.039025 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-01 00:59:42.039056 | 
2026-04-01 00:59:42.143544 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-01 00:59:42.145740 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-01 00:59:42.707040 | 
2026-04-01 00:59:42.707151 | PLAY [all]
2026-04-01 00:59:42.718652 | 
2026-04-01 00:59:42.718725 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-01 00:59:42.762870 | ubuntu-noble | skipping: Conditional result was False
2026-04-01 00:59:42.772187 | 
2026-04-01 00:59:42.772317 | TASK [fetch-output : Set log path for single node]
2026-04-01 00:59:42.817975 | ubuntu-noble | ok
2026-04-01 00:59:42.823365 | 
2026-04-01 00:59:42.823428 | LOOP [fetch-output : Ensure local output dirs]
2026-04-01 00:59:43.224561 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/4d8ddc98713045119f1cbdcf7d21692a/work/logs"
2026-04-01 00:59:43.427633 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/4d8ddc98713045119f1cbdcf7d21692a/work/artifacts"
2026-04-01 00:59:43.627893 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/4d8ddc98713045119f1cbdcf7d21692a/work/docs"
2026-04-01 00:59:43.644249 | 
2026-04-01 00:59:43.644421 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-01 00:59:44.285464 | ubuntu-noble | changed: .d..t...... ./
2026-04-01 00:59:44.285704 | ubuntu-noble | changed: All items complete
2026-04-01 00:59:44.285742 | 
2026-04-01 00:59:44.748218 | ubuntu-noble | changed: .d..t...... ./
2026-04-01 00:59:45.208905 | ubuntu-noble | changed: .d..t...... ./
2026-04-01 00:59:45.233329 | 
2026-04-01 00:59:45.234407 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-01 00:59:45.623439 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007868
2026-04-01 00:59:45.835786 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.006278
2026-04-01 00:59:45.849701 | 
2026-04-01 00:59:45.849945 | PLAY [all]
2026-04-01 00:59:45.856274 | 
2026-04-01 00:59:45.856334 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-01 00:59:46.344886 | ubuntu-noble | changed
2026-04-01 00:59:46.351528 | 
2026-04-01 00:59:46.351572 | PLAY RECAP
2026-04-01 00:59:46.351613 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-01 00:59:46.351634 | 
2026-04-01 00:59:46.471486 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-01 00:59:46.472537 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-01 00:59:47.022652 | 
2026-04-01 00:59:47.022802 | PLAY [localhost]
2026-04-01 00:59:47.032917 | 
2026-04-01 00:59:47.033018 | TASK [Generate Zuul manifest]
2026-04-01 00:59:47.054425 | localhost | ok
2026-04-01 00:59:47.070251 | 
2026-04-01 00:59:47.070342 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-01 00:59:47.378968 | localhost | changed
2026-04-01 00:59:47.393463 | 
2026-04-01 00:59:47.393599 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-01 00:59:47.426934 | localhost | ok
2026-04-01 00:59:47.435699 | 
2026-04-01 00:59:47.435774 | TASK [Upload logs]
2026-04-01 00:59:47.457153 | localhost | ok
2026-04-01 00:59:47.520595 | 
2026-04-01 00:59:47.520816 | TASK [Set zuul-log-path fact]
2026-04-01 00:59:47.545865 | localhost | ok
2026-04-01 00:59:47.561498 | 
2026-04-01 00:59:47.561610 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-01 00:59:47.594878 | localhost | ok
2026-04-01 00:59:47.603884 | 
2026-04-01 00:59:47.603986 | TASK [upload-logs : Create log directories]
2026-04-01 00:59:47.993048 | localhost | changed
2026-04-01 00:59:47.999040 | 
2026-04-01 00:59:47.999116 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-01 00:59:48.377858 | localhost -> localhost | ok: Runtime: 0:00:00.004112
2026-04-01 00:59:48.386033 | 
2026-04-01 00:59:48.386134 | TASK [upload-logs : Upload logs to log server]
2026-04-01 00:59:48.816000 | localhost | Output suppressed because no_log was given
2026-04-01 00:59:48.820054 | 
2026-04-01 00:59:48.820123 | LOOP [upload-logs : Compress console log and json output]
2026-04-01 00:59:48.863069 | localhost | skipping: Conditional result was False
2026-04-01 00:59:48.870288 | localhost | skipping: Conditional result was False
2026-04-01 00:59:48.885430 | 
2026-04-01 00:59:48.885611 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-01 00:59:48.940576 | localhost | skipping: Conditional result was False
2026-04-01 00:59:48.941052 | 
2026-04-01 00:59:48.945738 | localhost | skipping: Conditional result was False
2026-04-01 00:59:48.957795 | 
2026-04-01 00:59:48.957978 | LOOP [upload-logs : Upload console log and json output]