2026-08-12 06:14:40.394914 | Job console starting
2026-08-12 06:14:40.405234 | Updating git repos
2026-08-12 06:14:40.445257 | Cloning repos into workspace
2026-08-12 06:14:40.477407 | Restoring repo states
2026-08-12 06:14:40.485086 | Merging changes
2026-08-12 06:14:40.833419 | Checking out repos
2026-08-12 06:14:40.915466 | Preparing playbooks
2026-08-12 06:14:42.080859 | Running Ansible setup
2026-08-12 06:14:45.961646 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-12 06:14:46.544941 | 
2026-08-12 06:14:46.545511 | PLAY [localhost]
2026-08-12 06:14:46.553226 | 
2026-08-12 06:14:46.553292 | TASK [Gathering Facts]
2026-08-12 06:14:47.443637 | localhost | ok
2026-08-12 06:14:47.453098 | 
2026-08-12 06:14:47.453184 | TASK [Setup log path fact]
2026-08-12 06:14:47.472990 | localhost | ok
2026-08-12 06:14:47.484737 | 
2026-08-12 06:14:47.484810 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-12 06:14:47.515983 | localhost | ok
2026-08-12 06:14:47.523935 | 
2026-08-12 06:14:47.524007 | TASK [emit-job-header : Print job information]
2026-08-12 06:14:47.565988 | # Job Information
2026-08-12 06:14:47.566245 | Ansible Version: 2.16.18
2026-08-12 06:14:47.566317 | Job: pre-commit
2026-08-12 06:14:47.566365 | Pipeline: check
2026-08-12 06:14:47.566410 | Executor: 2d72f0692154
2026-08-12 06:14:47.566454 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/145
2026-08-12 06:14:47.566504 | Event ID: 6acdf1b0-9614-11f1-95d9-d6c8a61b474e
2026-08-12 06:14:47.570084 | 
2026-08-12 06:14:47.570151 | LOOP [emit-job-header : Print node information]
2026-08-12 06:14:47.667460 | localhost | ok:
2026-08-12 06:14:47.667725 | localhost | # Node Information
2026-08-12 06:14:47.667791 | localhost | Inventory Hostname: ubuntu-noble
2026-08-12 06:14:47.667841 | localhost | Hostname: np0000188861
2026-08-12 06:14:47.667886 | localhost | Username: zuul
2026-08-12 06:14:47.667937 | localhost | Distro: Ubuntu 24.04
2026-08-12 06:14:47.667980 | localhost | Provider: yul1
2026-08-12 06:14:47.668019 | localhost | Region: ca-ymq-1
2026-08-12 06:14:47.668058 | localhost | Label: ubuntu-noble
2026-08-12 06:14:47.668143 | localhost | Product Name: OpenStack Nova
2026-08-12 06:14:47.668189 | localhost | Interface IP: 199.204.45.65
2026-08-12 06:14:47.687384 | 
2026-08-12 06:14:47.687482 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-12 06:14:48.190299 | localhost -> localhost | changed
2026-08-12 06:14:48.197222 | 
2026-08-12 06:14:48.197302 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-12 06:14:49.064477 | localhost -> localhost | changed
2026-08-12 06:14:49.071114 | 
2026-08-12 06:14:49.071177 | PLAY [all]
2026-08-12 06:14:49.083208 | 
2026-08-12 06:14:49.083300 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-12 06:14:49.321827 | ubuntu-noble -> localhost | ok
2026-08-12 06:14:49.332553 | 
2026-08-12 06:14:49.332647 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-12 06:14:49.369555 | ubuntu-noble | ok
2026-08-12 06:14:49.389828 | ubuntu-noble | included: /var/lib/zuul/builds/46622888c25e40fba3327606492a0f62/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-12 06:14:49.396496 | 
2026-08-12 06:14:49.396569 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-12 06:14:50.659618 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-08-12 06:14:50.659966 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/46622888c25e40fba3327606492a0f62/work/46622888c25e40fba3327606492a0f62_id_rsa
2026-08-12 06:14:50.660031 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/46622888c25e40fba3327606492a0f62/work/46622888c25e40fba3327606492a0f62_id_rsa.pub
2026-08-12 06:14:50.660449 | ubuntu-noble -> localhost | The key fingerprint is:
2026-08-12 06:14:50.660485 | ubuntu-noble -> localhost | SHA256:jgBxTcLWiGHH8fb5H6tTNatJJJKqPKrh/5DNw9P4lnY zuul-build-sshkey
2026-08-12 06:14:50.660527 | ubuntu-noble -> localhost | The key's randomart image is:
2026-08-12 06:14:50.660550 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-08-12 06:14:50.660579 | ubuntu-noble -> localhost | |  +==*.          |
2026-08-12 06:14:50.660602 | ubuntu-noble -> localhost | | ..+=oo          |
2026-08-12 06:14:50.660622 | ubuntu-noble -> localhost | |  ..  o  .       |
2026-08-12 06:14:50.660642 | ubuntu-noble -> localhost | |   . . .o.. . o  |
2026-08-12 06:14:50.660662 | ubuntu-noble -> localhost | |    .  .S. o . o |
2026-08-12 06:14:50.660682 | ubuntu-noble -> localhost | |    =.+o .  o .  |
2026-08-12 06:14:50.660702 | ubuntu-noble -> localhost | |.  + O..o .o.o   |
2026-08-12 06:14:50.660722 | ubuntu-noble -> localhost | |..  = ++ E..oo   |
2026-08-12 06:14:50.660745 | ubuntu-noble -> localhost | |.ooo.oo.. .oo    |
2026-08-12 06:14:50.660766 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-08-12 06:14:50.660817 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.824203
2026-08-12 06:14:50.668670 | 
2026-08-12 06:14:50.668785 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-12 06:14:50.703984 | ubuntu-noble | ok
2026-08-12 06:14:50.721883 | ubuntu-noble | included: /var/lib/zuul/builds/46622888c25e40fba3327606492a0f62/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-12 06:14:50.733620 | 
2026-08-12 06:14:50.733758 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-12 06:14:50.761767 | ubuntu-noble | skipping: Conditional result was False
2026-08-12 06:14:50.772199 | 
2026-08-12 06:14:50.772292 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-12 06:14:51.301218 | ubuntu-noble | changed
2026-08-12 06:14:51.307563 | 
2026-08-12 06:14:51.307633 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-12 06:14:51.537275 | ubuntu-noble | ok
2026-08-12 06:14:51.542891 | 
2026-08-12 06:14:51.542958 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-12 06:14:52.092622 | ubuntu-noble | changed
2026-08-12 06:14:52.100829 | 
2026-08-12 06:14:52.100920 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-12 06:14:52.650221 | ubuntu-noble | changed
2026-08-12 06:14:52.657655 | 
2026-08-12 06:14:52.657718 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-12 06:14:52.692339 | ubuntu-noble | skipping: Conditional result was False
2026-08-12 06:14:52.703148 | 
2026-08-12 06:14:52.703215 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-12 06:14:53.235349 | ubuntu-noble -> localhost | changed
2026-08-12 06:14:53.252170 | 
2026-08-12 06:14:53.252243 | TASK [add-build-sshkey : Add back temp key]
2026-08-12 06:14:53.537251 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/46622888c25e40fba3327606492a0f62/work/46622888c25e40fba3327606492a0f62_id_rsa (zuul-build-sshkey)
2026-08-12 06:14:53.537448 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.015778
2026-08-12 06:14:53.542805 | 
2026-08-12 06:14:53.542866 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-12 06:14:53.916600 | ubuntu-noble | ok
2026-08-12 06:14:53.922707 | 
2026-08-12 06:14:53.922777 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-12 06:14:53.949652 | ubuntu-noble | skipping: Conditional result was False
2026-08-12 06:14:53.964577 | 
2026-08-12 06:14:53.964648 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-12 06:14:54.334308 | ubuntu-noble | ok
2026-08-12 06:14:54.380878 | 
2026-08-12 06:14:54.381039 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-12 06:14:55.130331 | ubuntu-noble | Output suppressed because no_log was given
2026-08-12 06:14:55.140106 | 
2026-08-12 06:14:55.140177 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-12 06:14:55.364897 | ubuntu-noble | ok: "logs"
2026-08-12 06:14:55.365196 | ubuntu-noble | ok: All items complete
2026-08-12 06:14:55.365240 | 
2026-08-12 06:14:55.558889 | ubuntu-noble | ok: "artifacts"
2026-08-12 06:14:55.745869 | ubuntu-noble | ok: "docs"
2026-08-12 06:14:55.937637 | 
2026-08-12 06:14:55.937811 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-12 06:14:56.159910 | ubuntu-noble | changed: "logs"
2026-08-12 06:14:56.334203 | ubuntu-noble | changed: "artifacts"
2026-08-12 06:14:56.516693 | ubuntu-noble | changed: "docs"
2026-08-12 06:14:56.534157 | 
2026-08-12 06:14:56.534286 | PLAY RECAP
2026-08-12 06:14:56.534337 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-12 06:14:56.534370 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-12 06:14:56.534391 | 
2026-08-12 06:14:56.675165 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-12 06:14:56.677353 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-08-12 06:14:57.300893 | 
2026-08-12 06:14:57.301073 | PLAY [all]
2026-08-12 06:14:57.314072 | 
2026-08-12 06:14:57.314170 | TASK [setup-uv : Extract archive]
2026-08-12 06:14:59.758838 | ubuntu-noble | changed
2026-08-12 06:14:59.765027 | 
2026-08-12 06:14:59.765104 | TASK [setup-uv : Print version]
2026-08-12 06:15:00.165800 | ubuntu-noble | uv 0.8.13
2026-08-12 06:15:00.300979 | ubuntu-noble | ok: Runtime: 0:00:00.012451
2026-08-12 06:15:00.307920 | 
2026-08-12 06:15:00.307979 | PLAY RECAP
2026-08-12 06:15:00.308027 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-12 06:15:00.308051 | 
2026-08-12 06:15:00.434735 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-08-12 06:15:00.437219 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-08-12 06:15:01.043123 | 
2026-08-12 06:15:01.046307 | PLAY [all]
2026-08-12 06:15:01.061712 | 
2026-08-12 06:15:01.062079 | TASK [Run "pre-commit"]
2026-08-12 06:15:01.702333 | ubuntu-noble | Downloading virtualenv (5.1MiB)
2026-08-12 06:15:01.799485 | ubuntu-noble |  Downloading virtualenv
2026-08-12 06:15:01.812575 | ubuntu-noble | Installed 10 packages in 12ms
2026-08-12 06:15:02.204266 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-08-12 06:15:02.861454 | 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-08-12 06:15:02.867161 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-08-12 06:15:03.525693 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-08-12 06:15:04.041517 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-08-12 06:15:04.671113 | 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-08-12 06:15:04.673082 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-08-12 06:15:05.346547 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-08-12 06:15:06.029141 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-08-12 06:15:06.029248 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-12 06:15:06.029266 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-12 06:15:09.846282 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-08-12 06:15:09.846358 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-12 06:15:09.846373 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-12 06:15:14.022273 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-08-12 06:15:14.022354 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-12 06:15:14.022367 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-12 06:15:17.111277 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-08-12 06:15:17.111377 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-12 06:15:17.111395 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-12 06:15:19.687113 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-08-12 06:15:19.687168 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-08-12 06:15:19.687212 | ubuntu-noble | [INFO] This may take a few minutes...
2026-08-12 06:15:30.653751 | ubuntu-noble | fix end of files.........................................................Passed
2026-08-12 06:15:30.709486 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-08-12 06:15:30.980670 | ubuntu-noble | black....................................................................Passed
2026-08-12 06:15:31.173727 | ubuntu-noble | flake8...................................................................Passed
2026-08-12 06:15:31.299334 | ubuntu-noble | isort....................................................................Passed
2026-08-12 06:16:11.608040 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-08-12 06:16:11.699161 | ubuntu-noble | ok: Runtime: 0:01:10.208572
2026-08-12 06:16:11.701469 | 
2026-08-12 06:16:11.701805 | PLAY RECAP
2026-08-12 06:16:11.701856 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-12 06:16:11.701881 | 
2026-08-12 06:16:11.829962 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-08-12 06:16:11.855694 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-12 06:16:12.480289 | 
2026-08-12 06:16:12.480432 | PLAY [all]
2026-08-12 06:16:12.493024 | 
2026-08-12 06:16:12.493104 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-12 06:16:12.539505 | ubuntu-noble | skipping: Conditional result was False
2026-08-12 06:16:12.548520 | 
2026-08-12 06:16:12.548722 | TASK [fetch-output : Set log path for single node]
2026-08-12 06:16:12.593920 | ubuntu-noble | ok
2026-08-12 06:16:12.600460 | 
2026-08-12 06:16:12.600532 | LOOP [fetch-output : Ensure local output dirs]
2026-08-12 06:16:13.009962 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/46622888c25e40fba3327606492a0f62/work/logs"
2026-08-12 06:16:13.231655 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/46622888c25e40fba3327606492a0f62/work/artifacts"
2026-08-12 06:16:13.467055 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/46622888c25e40fba3327606492a0f62/work/docs"
2026-08-12 06:16:13.483807 | 
2026-08-12 06:16:13.483944 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-12 06:16:14.212788 | ubuntu-noble | ok
2026-08-12 06:16:14.213062 | ubuntu-noble | changed: All items complete
2026-08-12 06:16:14.213112 | 
2026-08-12 06:16:14.730414 | ubuntu-noble | changed: .d..t...... ./
2026-08-12 06:16:15.221958 | ubuntu-noble | changed: .d..t...... ./
2026-08-12 06:16:15.250818 | 
2026-08-12 06:16:15.251512 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-12 06:16:15.674200 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007315
2026-08-12 06:16:15.900108 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007918
2026-08-12 06:16:15.924018 | 
2026-08-12 06:16:15.924247 | PLAY [all]
2026-08-12 06:16:15.932395 | 
2026-08-12 06:16:15.932519 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-12 06:16:16.412196 | ubuntu-noble | changed
2026-08-12 06:16:16.418509 | 
2026-08-12 06:16:16.418562 | PLAY RECAP
2026-08-12 06:16:16.418610 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-12 06:16:16.418633 | 
2026-08-12 06:16:16.558750 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-12 06:16:16.561049 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-12 06:16:17.144532 | 
2026-08-12 06:16:17.144657 | PLAY [localhost]
2026-08-12 06:16:17.155049 | 
2026-08-12 06:16:17.155302 | TASK [Generate Zuul manifest]
2026-08-12 06:16:17.175249 | localhost | ok
2026-08-12 06:16:17.189054 | 
2026-08-12 06:16:17.189131 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-12 06:16:17.583086 | localhost | changed
2026-08-12 06:16:17.594291 | 
2026-08-12 06:16:17.594368 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-12 06:16:17.623893 | localhost | ok
2026-08-12 06:16:17.631582 | 
2026-08-12 06:16:17.631644 | TASK [Upload logs]
2026-08-12 06:16:17.649964 | localhost | ok
2026-08-12 06:16:17.707317 | 
2026-08-12 06:16:17.707446 | TASK [Set zuul-log-path fact]
2026-08-12 06:16:17.729401 | localhost | ok
2026-08-12 06:16:17.746373 | 
2026-08-12 06:16:17.746472 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-12 06:16:17.779081 | localhost | ok
2026-08-12 06:16:17.787773 | 
2026-08-12 06:16:17.787838 | TASK [upload-logs : Create log directories]
2026-08-12 06:16:18.215248 | localhost | changed
2026-08-12 06:16:18.222595 | 
2026-08-12 06:16:18.222712 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-12 06:16:18.643135 | localhost -> localhost | ok: Runtime: 0:00:00.006281
2026-08-12 06:16:18.648209 | 
2026-08-12 06:16:18.648281 | TASK [upload-logs : Upload logs to log server]
2026-08-12 06:16:19.111537 | localhost | Output suppressed because no_log was given
2026-08-12 06:16:19.115392 | 
2026-08-12 06:16:19.115460 | LOOP [upload-logs : Compress console log and json output]
2026-08-12 06:16:19.162086 | localhost | skipping: Conditional result was False
2026-08-12 06:16:19.168823 | localhost | skipping: Conditional result was False
2026-08-12 06:16:19.182235 | 
2026-08-12 06:16:19.182356 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-12 06:16:19.228356 | localhost | skipping: Conditional result was False
2026-08-12 06:16:19.228756 | 
2026-08-12 06:16:19.232460 | localhost | skipping: Conditional result was False
2026-08-12 06:16:19.249398 | 
2026-08-12 06:16:19.249701 | LOOP [upload-logs : Upload console log and json output]