2026-07-28 01:01:04.237732 | Job console starting
2026-07-28 01:01:04.254121 | Updating git repos
2026-07-28 01:01:04.278910 | Cloning repos into workspace
2026-07-28 01:01:04.410441 | Restoring repo states
2026-07-28 01:01:04.416579 | Merging changes
2026-07-28 01:01:04.809084 | Checking out repos
2026-07-28 01:01:04.860100 | Preparing playbooks
2026-07-28 01:01:05.854826 | Running Ansible setup
2026-07-28 01:01:09.287301 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-28 01:01:09.895084 | 
2026-07-28 01:01:09.895238 | PLAY [localhost]
2026-07-28 01:01:09.904681 | 
2026-07-28 01:01:09.904773 | TASK [Gathering Facts]
2026-07-28 01:01:10.742353 | localhost | ok
2026-07-28 01:01:10.755766 | 
2026-07-28 01:01:10.755864 | TASK [Setup log path fact]
2026-07-28 01:01:10.776630 | localhost | ok
2026-07-28 01:01:10.788530 | 
2026-07-28 01:01:10.788599 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-28 01:01:10.818470 | localhost | ok
2026-07-28 01:01:10.826189 | 
2026-07-28 01:01:10.826280 | TASK [emit-job-header : Print job information]
2026-07-28 01:01:10.866629 | # Job Information
2026-07-28 01:01:10.866774 | Ansible Version: 2.16.18
2026-07-28 01:01:10.866817 | Job: pre-commit
2026-07-28 01:01:10.866847 | Pipeline: check
2026-07-28 01:01:10.866874 | Executor: 2d72f0692154
2026-07-28 01:01:10.866902 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/139
2026-07-28 01:01:10.866932 | Event ID: f0dc7360-8a1d-11f1-954b-ffcde9937cba
2026-07-28 01:01:10.871131 | 
2026-07-28 01:01:10.871220 | LOOP [emit-job-header : Print node information]
2026-07-28 01:01:10.965756 | localhost | ok:
2026-07-28 01:01:10.965956 | localhost | # Node Information
2026-07-28 01:01:10.965995 | localhost | Inventory Hostname: ubuntu-noble
2026-07-28 01:01:10.966024 | localhost | Hostname: np0000187221
2026-07-28 01:01:10.966051 | localhost | Username: zuul
2026-07-28 01:01:10.966082 | localhost | Distro: Ubuntu 24.04
2026-07-28 01:01:10.966108 | localhost | Provider: yul1
2026-07-28 01:01:10.966135 | localhost | Region: ca-ymq-1
2026-07-28 01:01:10.966161 | localhost | Label: ubuntu-noble
2026-07-28 01:01:10.966187 | localhost | Product Name: OpenStack Nova
2026-07-28 01:01:10.966212 | localhost | Interface IP: 199.204.45.248
2026-07-28 01:01:10.977966 | 
2026-07-28 01:01:10.978094 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-28 01:01:11.329686 | localhost -> localhost | changed
2026-07-28 01:01:11.337629 | 
2026-07-28 01:01:11.337720 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-28 01:01:12.140446 | localhost -> localhost | changed
2026-07-28 01:01:12.151234 | 
2026-07-28 01:01:12.151289 | PLAY [all]
2026-07-28 01:01:12.159212 | 
2026-07-28 01:01:12.159276 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-28 01:01:12.385782 | ubuntu-noble -> localhost | ok
2026-07-28 01:01:12.397149 | 
2026-07-28 01:01:12.397238 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-28 01:01:12.433287 | ubuntu-noble | ok
2026-07-28 01:01:12.451355 | ubuntu-noble | included: /var/lib/zuul/builds/70c00092f54d42a28f3e7d337d82ef49/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-28 01:01:12.457575 | 
2026-07-28 01:01:12.457636 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-28 01:01:13.332830 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-07-28 01:01:13.333039 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/70c00092f54d42a28f3e7d337d82ef49/work/70c00092f54d42a28f3e7d337d82ef49_id_rsa
2026-07-28 01:01:13.333075 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/70c00092f54d42a28f3e7d337d82ef49/work/70c00092f54d42a28f3e7d337d82ef49_id_rsa.pub
2026-07-28 01:01:13.333099 | ubuntu-noble -> localhost | The key fingerprint is:
2026-07-28 01:01:13.333121 | ubuntu-noble -> localhost | SHA256:QpSEQrNxI1VmrzZ8XsjSLYGxkk16AOY2RxctOX9zKEQ zuul-build-sshkey
2026-07-28 01:01:13.333152 | ubuntu-noble -> localhost | The key's randomart image is:
2026-07-28 01:01:13.333174 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-07-28 01:01:13.333204 | ubuntu-noble -> localhost | | .Bo*+@*E        |
2026-07-28 01:01:13.333226 | ubuntu-noble -> localhost | | o.B.%==o        |
2026-07-28 01:01:13.333246 | ubuntu-noble -> localhost | |  =.= *=o  .     |
2026-07-28 01:01:13.333267 | ubuntu-noble -> localhost | | . o = +o++ .    |
2026-07-28 01:01:13.333287 | ubuntu-noble -> localhost | |      B Sooo     |
2026-07-28 01:01:13.333306 | ubuntu-noble -> localhost | |     . * o       |
2026-07-28 01:01:13.333326 | ubuntu-noble -> localhost | |        .        |
2026-07-28 01:01:13.333346 | ubuntu-noble -> localhost | |                 |
2026-07-28 01:01:13.333369 | ubuntu-noble -> localhost | |                 |
2026-07-28 01:01:13.333389 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-07-28 01:01:13.333443 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.464882
2026-07-28 01:01:13.339037 | 
2026-07-28 01:01:13.339125 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-28 01:01:13.373577 | ubuntu-noble | ok
2026-07-28 01:01:13.386337 | ubuntu-noble | included: /var/lib/zuul/builds/70c00092f54d42a28f3e7d337d82ef49/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-28 01:01:13.397161 | 
2026-07-28 01:01:13.397245 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-28 01:01:13.422145 | ubuntu-noble | skipping: Conditional result was False
2026-07-28 01:01:13.431897 | 
2026-07-28 01:01:13.431991 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-28 01:01:14.009548 | ubuntu-noble | changed
2026-07-28 01:01:14.019025 | 
2026-07-28 01:01:14.019125 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-28 01:01:14.248170 | ubuntu-noble | ok
2026-07-28 01:01:14.254296 | 
2026-07-28 01:01:14.254397 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-28 01:01:14.781392 | ubuntu-noble | changed
2026-07-28 01:01:14.788941 | 
2026-07-28 01:01:14.789091 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-28 01:01:15.367590 | ubuntu-noble | changed
2026-07-28 01:01:15.374630 | 
2026-07-28 01:01:15.374721 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-28 01:01:15.399330 | ubuntu-noble | skipping: Conditional result was False
2026-07-28 01:01:15.407386 | 
2026-07-28 01:01:15.407482 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-28 01:01:15.791722 | ubuntu-noble -> localhost | changed
2026-07-28 01:01:15.808886 | 
2026-07-28 01:01:15.809058 | TASK [add-build-sshkey : Add back temp key]
2026-07-28 01:01:16.075953 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/70c00092f54d42a28f3e7d337d82ef49/work/70c00092f54d42a28f3e7d337d82ef49_id_rsa (zuul-build-sshkey)
2026-07-28 01:01:16.076160 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009685
2026-07-28 01:01:16.083396 | 
2026-07-28 01:01:16.083479 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-28 01:01:16.434360 | ubuntu-noble | ok
2026-07-28 01:01:16.439434 | 
2026-07-28 01:01:16.439497 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-28 01:01:16.463837 | ubuntu-noble | skipping: Conditional result was False
2026-07-28 01:01:16.480907 | 
2026-07-28 01:01:16.481030 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-28 01:01:16.839516 | ubuntu-noble | ok
2026-07-28 01:01:16.879602 | 
2026-07-28 01:01:16.879732 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-28 01:01:17.744070 | ubuntu-noble | Output suppressed because no_log was given
2026-07-28 01:01:17.754388 | 
2026-07-28 01:01:17.754456 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-28 01:01:17.984146 | ubuntu-noble | ok: "logs"
2026-07-28 01:01:17.984550 | ubuntu-noble | ok: All items complete
2026-07-28 01:01:17.984743 | 
2026-07-28 01:01:18.178783 | ubuntu-noble | ok: "artifacts"
2026-07-28 01:01:18.364813 | ubuntu-noble | ok: "docs"
2026-07-28 01:01:18.376571 | 
2026-07-28 01:01:18.376742 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-28 01:01:18.600825 | ubuntu-noble | changed: "logs"
2026-07-28 01:01:18.798407 | ubuntu-noble | changed: "artifacts"
2026-07-28 01:01:18.988763 | ubuntu-noble | changed: "docs"
2026-07-28 01:01:19.010515 | 
2026-07-28 01:01:19.010640 | PLAY RECAP
2026-07-28 01:01:19.010700 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-28 01:01:19.010741 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-28 01:01:19.010772 | 
2026-07-28 01:01:19.141194 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-28 01:01:19.143337 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-07-28 01:01:19.694304 | 
2026-07-28 01:01:19.694417 | PLAY [all]
2026-07-28 01:01:19.706256 | 
2026-07-28 01:01:19.706337 | TASK [setup-uv : Extract archive]
2026-07-28 01:01:22.020793 | ubuntu-noble | changed
2026-07-28 01:01:22.030741 | 
2026-07-28 01:01:22.030825 | TASK [setup-uv : Print version]
2026-07-28 01:01:22.429727 | ubuntu-noble | uv 0.8.13
2026-07-28 01:01:22.569698 | ubuntu-noble | ok: Runtime: 0:00:00.010824
2026-07-28 01:01:22.579045 | 
2026-07-28 01:01:22.579104 | PLAY RECAP
2026-07-28 01:01:22.579155 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-28 01:01:22.579179 | 
2026-07-28 01:01:22.706268 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-07-28 01:01:22.708409 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-07-28 01:01:23.313833 | 
2026-07-28 01:01:23.314002 | PLAY [all]
2026-07-28 01:01:23.327136 | 
2026-07-28 01:01:23.327259 | TASK [Run "pre-commit"]
2026-07-28 01:01:23.901988 | ubuntu-noble | Downloading virtualenv (5.3MiB)
2026-07-28 01:01:24.011480 | ubuntu-noble |  Downloading virtualenv
2026-07-28 01:01:24.025734 | ubuntu-noble | Installed 10 packages in 13ms
2026-07-28 01:01:24.408844 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-07-28 01:01:24.930416 | 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-07-28 01:01:24.936731 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-07-28 01:01:25.431498 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-07-28 01:01:25.832535 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-07-28 01:01:26.264244 | 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-07-28 01:01:26.266075 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-07-28 01:01:27.496539 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-07-28 01:01:28.192479 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-07-28 01:01:28.192569 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-07-28 01:01:28.192581 | ubuntu-noble | [INFO] This may take a few minutes...
2026-07-28 01:01:32.197926 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-07-28 01:01:32.198003 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-07-28 01:01:32.198014 | ubuntu-noble | [INFO] This may take a few minutes...
2026-07-28 01:01:36.699018 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-07-28 01:01:36.699140 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-07-28 01:01:36.699154 | ubuntu-noble | [INFO] This may take a few minutes...
2026-07-28 01:01:40.112928 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-07-28 01:01:40.113043 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-07-28 01:01:40.113053 | ubuntu-noble | [INFO] This may take a few minutes...
2026-07-28 01:01:42.923394 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-07-28 01:01:42.923487 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-07-28 01:01:42.923497 | ubuntu-noble | [INFO] This may take a few minutes...
2026-07-28 01:01:53.884689 | ubuntu-noble | fix end of files.........................................................Passed
2026-07-28 01:01:53.940432 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-07-28 01:01:54.215273 | ubuntu-noble | black....................................................................Passed
2026-07-28 01:01:54.426161 | ubuntu-noble | flake8...................................................................Passed
2026-07-28 01:01:54.548502 | ubuntu-noble | isort....................................................................Passed
2026-07-28 01:02:56.484313 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-07-28 01:02:56.942163 | ubuntu-noble | ok: Runtime: 0:01:32.832525
2026-07-28 01:02:56.944554 | 
2026-07-28 01:02:56.944605 | PLAY RECAP
2026-07-28 01:02:56.944648 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-28 01:02:56.944670 | 
2026-07-28 01:02:57.067981 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-07-28 01:02:57.069258 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-28 01:02:57.686989 | 
2026-07-28 01:02:57.687105 | PLAY [all]
2026-07-28 01:02:57.698800 | 
2026-07-28 01:02:57.698921 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-28 01:02:57.733552 | ubuntu-noble | skipping: Conditional result was False
2026-07-28 01:02:57.743156 | 
2026-07-28 01:02:57.743261 | TASK [fetch-output : Set log path for single node]
2026-07-28 01:02:57.788563 | ubuntu-noble | ok
2026-07-28 01:02:57.793590 | 
2026-07-28 01:02:57.793655 | LOOP [fetch-output : Ensure local output dirs]
2026-07-28 01:02:58.168460 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/70c00092f54d42a28f3e7d337d82ef49/work/logs"
2026-07-28 01:02:58.387788 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/70c00092f54d42a28f3e7d337d82ef49/work/artifacts"
2026-07-28 01:02:58.623169 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/70c00092f54d42a28f3e7d337d82ef49/work/docs"
2026-07-28 01:02:58.638989 | 
2026-07-28 01:02:58.639128 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-28 01:02:59.245384 | ubuntu-noble | changed: .d..t...... ./
2026-07-28 01:02:59.245610 | ubuntu-noble | changed: All items complete
2026-07-28 01:02:59.245649 | 
2026-07-28 01:02:59.715736 | ubuntu-noble | changed: .d..t...... ./
2026-07-28 01:03:00.210132 | ubuntu-noble | changed: .d..t...... ./
2026-07-28 01:03:00.243644 | 
2026-07-28 01:03:00.243970 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-28 01:03:00.657438 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007816
2026-07-28 01:03:00.878642 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007667
2026-07-28 01:03:00.899895 | 
2026-07-28 01:03:00.900278 | PLAY [all]
2026-07-28 01:03:00.907067 | 
2026-07-28 01:03:00.907133 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-28 01:03:01.374001 | ubuntu-noble | changed
2026-07-28 01:03:01.379550 | 
2026-07-28 01:03:01.379597 | PLAY RECAP
2026-07-28 01:03:01.379642 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-28 01:03:01.379663 | 
2026-07-28 01:03:01.499005 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-28 01:03:01.508307 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-28 01:03:02.095199 | 
2026-07-28 01:03:02.095314 | PLAY [localhost]
2026-07-28 01:03:02.105716 | 
2026-07-28 01:03:02.105791 | TASK [Generate Zuul manifest]
2026-07-28 01:03:02.125725 | localhost | ok
2026-07-28 01:03:02.141935 | 
2026-07-28 01:03:02.142012 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-28 01:03:02.498141 | localhost | changed
2026-07-28 01:03:02.508192 | 
2026-07-28 01:03:02.508272 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-28 01:03:02.541098 | localhost | ok
2026-07-28 01:03:02.550357 | 
2026-07-28 01:03:02.550542 | TASK [Upload logs]
2026-07-28 01:03:02.567530 | localhost | ok
2026-07-28 01:03:02.623673 | 
2026-07-28 01:03:02.623756 | TASK [Set zuul-log-path fact]
2026-07-28 01:03:02.640726 | localhost | ok
2026-07-28 01:03:02.651482 | 
2026-07-28 01:03:02.651551 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-28 01:03:02.678535 | localhost | ok
2026-07-28 01:03:02.684936 | 
2026-07-28 01:03:02.685015 | TASK [upload-logs : Create log directories]
2026-07-28 01:03:03.080396 | localhost | changed
2026-07-28 01:03:03.087650 | 
2026-07-28 01:03:03.087743 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-28 01:03:03.475249 | localhost -> localhost | ok: Runtime: 0:00:00.007707
2026-07-28 01:03:03.480408 | 
2026-07-28 01:03:03.480474 | TASK [upload-logs : Upload logs to log server]
2026-07-28 01:03:03.913263 | localhost | Output suppressed because no_log was given
2026-07-28 01:03:03.917005 | 
2026-07-28 01:03:03.917074 | LOOP [upload-logs : Compress console log and json output]
2026-07-28 01:03:03.967689 | localhost | skipping: Conditional result was False
2026-07-28 01:03:03.975109 | localhost | skipping: Conditional result was False
2026-07-28 01:03:03.992008 | 
2026-07-28 01:03:03.992226 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-28 01:03:04.037801 | localhost | skipping: Conditional result was False
2026-07-28 01:03:04.038193 | 
2026-07-28 01:03:04.042185 | localhost | skipping: Conditional result was False
2026-07-28 01:03:04.054086 | 
2026-07-28 01:03:04.054213 | LOOP [upload-logs : Upload console log and json output]