2026-02-13 23:19:20.859264 | Job console starting
2026-02-13 23:19:20.870184 | Updating git repos
2026-02-13 23:19:20.901292 | Cloning repos into workspace
2026-02-13 23:19:21.052427 | Restoring repo states
2026-02-13 23:19:21.061068 | Merging changes
2026-02-13 23:19:21.575641 | Checking out repos
2026-02-13 23:19:21.654307 | Preparing playbooks
2026-02-13 23:19:23.963495 | Running Ansible setup
2026-02-13 23:19:29.483990 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-13 23:19:30.118608 | 
2026-02-13 23:19:30.133107 | PLAY [localhost]
2026-02-13 23:19:30.147517 | 
2026-02-13 23:19:30.147669 | TASK [Gathering Facts]
2026-02-13 23:19:31.145349 | localhost | ok
2026-02-13 23:19:31.152516 | 
2026-02-13 23:19:31.152601 | TASK [Setup log path fact]
2026-02-13 23:19:31.170223 | localhost | ok
2026-02-13 23:19:31.180180 | 
2026-02-13 23:19:31.282869 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-13 23:19:31.313936 | localhost | ok
2026-02-13 23:19:31.320189 | 
2026-02-13 23:19:31.320266 | TASK [emit-job-header : Print job information]
2026-02-13 23:19:31.359645 | # Job Information
2026-02-13 23:19:31.359855 | Ansible Version: 2.16.15
2026-02-13 23:19:31.359891 | Job: pre-commit
2026-02-13 23:19:31.359912 | Pipeline: check
2026-02-13 23:19:31.359931 | Executor: 3a2793d2bd32
2026-02-13 23:19:31.359950 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/93
2026-02-13 23:19:31.359972 | Event ID: 40d80630-0932-11f1-9f6d-138448d30538
2026-02-13 23:19:31.362844 | 
2026-02-13 23:19:31.362947 | LOOP [emit-job-header : Print node information]
2026-02-13 23:19:31.465186 | localhost | ok:
2026-02-13 23:19:31.465430 | localhost | # Node Information
2026-02-13 23:19:31.465466 | localhost | Inventory Hostname: ubuntu-noble
2026-02-13 23:19:31.465488 | localhost | Hostname: np0000155495
2026-02-13 23:19:31.465507 | localhost | Username: zuul
2026-02-13 23:19:31.465528 | localhost | Distro: Ubuntu 24.04
2026-02-13 23:19:31.465573 | localhost | Provider: yul1
2026-02-13 23:19:31.465609 | localhost | Region: ca-ymq-1
2026-02-13 23:19:31.465628 | localhost | Label: ubuntu-noble
2026-02-13 23:19:31.465655 | localhost | Product Name: OpenStack Nova
2026-02-13 23:19:31.465678 | localhost | Interface IP: 199.204.45.72
2026-02-13 23:19:31.485489 | 
2026-02-13 23:19:31.485656 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-13 23:19:31.991094 | localhost -> localhost | changed
2026-02-13 23:19:32.013388 | 
2026-02-13 23:19:32.013641 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-13 23:19:33.147726 | localhost -> localhost | changed
2026-02-13 23:19:33.182734 | 
2026-02-13 23:19:33.182824 | PLAY [all]
2026-02-13 23:19:33.192781 | 
2026-02-13 23:19:33.192852 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-13 23:19:33.462736 | ubuntu-noble -> localhost | ok
2026-02-13 23:19:33.470161 | 
2026-02-13 23:19:33.470234 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-13 23:19:33.501320 | ubuntu-noble | ok
2026-02-13 23:19:33.516962 | ubuntu-noble | included: /var/lib/zuul/builds/31bf720cd4e4435e9287da14eb772264/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-13 23:19:33.523426 | 
2026-02-13 23:19:33.523496 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-13 23:19:34.346247 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-02-13 23:19:34.347049 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/31bf720cd4e4435e9287da14eb772264/work/31bf720cd4e4435e9287da14eb772264_id_rsa
2026-02-13 23:19:34.347107 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/31bf720cd4e4435e9287da14eb772264/work/31bf720cd4e4435e9287da14eb772264_id_rsa.pub
2026-02-13 23:19:34.347145 | ubuntu-noble -> localhost | The key fingerprint is:
2026-02-13 23:19:34.347180 | ubuntu-noble -> localhost | SHA256:Et+7fKxKJruMSUhi4vBnDkdQb19waMp59Gw1UysmEK4 zuul-build-sshkey
2026-02-13 23:19:34.347228 | ubuntu-noble -> localhost | The key's randomart image is:
2026-02-13 23:19:34.347262 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-02-13 23:19:34.347294 | ubuntu-noble -> localhost | |    .   +o.  ..  |
2026-02-13 23:19:34.347326 | ubuntu-noble -> localhost | |   . . .++  +  . |
2026-02-13 23:19:34.347358 | ubuntu-noble -> localhost | |  .  .+=.oo.oo.  |
2026-02-13 23:19:34.347390 | ubuntu-noble -> localhost | |   . .+=.o+o .   |
2026-02-13 23:19:34.347424 | ubuntu-noble -> localhost | |+.. . E.S..      |
2026-02-13 23:19:34.347455 | ubuntu-noble -> localhost | |=+ o   .   .     |
2026-02-13 23:19:34.347488 | ubuntu-noble -> localhost | | .+ = . o ..     |
2026-02-13 23:19:34.347519 | ubuntu-noble -> localhost | |   B + = . .o    |
2026-02-13 23:19:34.347550 | ubuntu-noble -> localhost | |    + +...+o     |
2026-02-13 23:19:34.347578 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-02-13 23:19:34.347664 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.362012
2026-02-13 23:19:34.353975 | 
2026-02-13 23:19:34.354075 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-13 23:19:34.384311 | ubuntu-noble | ok
2026-02-13 23:19:34.396990 | ubuntu-noble | included: /var/lib/zuul/builds/31bf720cd4e4435e9287da14eb772264/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-13 23:19:34.412127 | 
2026-02-13 23:19:34.412202 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-13 23:19:34.438457 | ubuntu-noble | skipping: Conditional result was False
2026-02-13 23:19:34.446484 | 
2026-02-13 23:19:34.446555 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-13 23:19:35.042280 | ubuntu-noble | changed
2026-02-13 23:19:35.049207 | 
2026-02-13 23:19:35.049313 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-13 23:19:35.258504 | ubuntu-noble | ok
2026-02-13 23:19:35.264128 | 
2026-02-13 23:19:35.264201 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-13 23:19:35.881716 | ubuntu-noble | changed
2026-02-13 23:19:35.889119 | 
2026-02-13 23:19:35.889425 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-13 23:19:36.453862 | ubuntu-noble | changed
2026-02-13 23:19:36.473558 | 
2026-02-13 23:19:36.473661 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-13 23:19:36.504828 | ubuntu-noble | skipping: Conditional result was False
2026-02-13 23:19:36.554803 | 
2026-02-13 23:19:36.554959 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-13 23:19:37.030612 | ubuntu-noble -> localhost | changed
2026-02-13 23:19:37.041683 | 
2026-02-13 23:19:37.041750 | TASK [add-build-sshkey : Add back temp key]
2026-02-13 23:19:37.368129 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/31bf720cd4e4435e9287da14eb772264/work/31bf720cd4e4435e9287da14eb772264_id_rsa (zuul-build-sshkey)
2026-02-13 23:19:37.368328 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.024350
2026-02-13 23:19:37.373766 | 
2026-02-13 23:19:37.373828 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-13 23:19:37.805864 | ubuntu-noble | ok
2026-02-13 23:19:37.815376 | 
2026-02-13 23:19:37.872692 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-13 23:19:37.899055 | ubuntu-noble | skipping: Conditional result was False
2026-02-13 23:19:37.913657 | 
2026-02-13 23:19:37.913743 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-13 23:19:38.374434 | ubuntu-noble | ok
2026-02-13 23:19:38.385929 | 
2026-02-13 23:19:38.386002 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-13 23:19:39.241912 | ubuntu-noble | Output suppressed because no_log was given
2026-02-13 23:19:39.252549 | 
2026-02-13 23:19:39.253194 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-13 23:19:39.482738 | ubuntu-noble | ok: "logs"
2026-02-13 23:19:39.483008 | ubuntu-noble | ok: All items complete
2026-02-13 23:19:39.483048 | 
2026-02-13 23:19:39.662843 | ubuntu-noble | ok: "artifacts"
2026-02-13 23:19:39.920811 | ubuntu-noble | ok: "docs"
2026-02-13 23:19:39.933909 | 
2026-02-13 23:19:39.934087 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-13 23:19:40.167425 | ubuntu-noble | changed: "logs"
2026-02-13 23:19:40.368196 | ubuntu-noble | changed: "artifacts"
2026-02-13 23:19:40.554820 | ubuntu-noble | changed: "docs"
2026-02-13 23:19:40.573048 | 
2026-02-13 23:19:40.573823 | PLAY RECAP
2026-02-13 23:19:40.573914 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-13 23:19:40.573959 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-02-13 23:19:40.573991 | 
2026-02-13 23:19:40.766269 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-13 23:19:40.773288 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-02-13 23:19:41.375302 | 
2026-02-13 23:19:41.376024 | PLAY [all]
2026-02-13 23:19:41.388908 | 
2026-02-13 23:19:41.389013 | TASK [setup-uv : Extract archive]
2026-02-13 23:19:43.696746 | ubuntu-noble | changed
2026-02-13 23:19:43.703541 | 
2026-02-13 23:19:43.703637 | TASK [setup-uv : Print version]
2026-02-13 23:19:43.687574 | ubuntu-noble | uv 0.8.13
2026-02-13 23:19:44.244851 | ubuntu-noble | ok: Runtime: 0:00:00.009273
2026-02-13 23:19:44.256803 | 
2026-02-13 23:19:44.257124 | PLAY RECAP
2026-02-13 23:19:44.257248 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-13 23:19:44.257307 | 
2026-02-13 23:19:44.483474 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-02-13 23:19:44.532179 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-02-13 23:19:45.151896 | 
2026-02-13 23:19:45.187986 | PLAY [all]
2026-02-13 23:19:45.205076 | 
2026-02-13 23:19:45.205174 | TASK [Run "pre-commit"]
2026-02-13 23:19:45.400319 | ubuntu-noble | Downloading virtualenv (5.7MiB)
2026-02-13 23:19:45.515773 | ubuntu-noble |  Downloading virtualenv
2026-02-13 23:19:45.528216 | ubuntu-noble | Installed 9 packages in 11ms
2026-02-13 23:19:45.936421 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-02-13 23:19:46.440196 | 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-02-13 23:19:46.445635 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-02-13 23:19:47.076800 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-02-13 23:19:47.473935 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-02-13 23:19:47.942472 | 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-02-13 23:19:47.943791 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-02-13 23:19:48.495677 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-02-13 23:19:49.000322 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-02-13 23:19:49.000389 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-13 23:19:49.000401 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-13 23:19:52.804410 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-02-13 23:19:52.804440 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-13 23:19:52.805130 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-13 23:19:57.106163 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-02-13 23:19:57.106203 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-13 23:19:57.106209 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-13 23:20:00.434559 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-02-13 23:20:00.434599 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-13 23:20:00.434634 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-13 23:20:03.541132 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-02-13 23:20:03.541161 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-02-13 23:20:03.541166 | ubuntu-noble | [INFO] This may take a few minutes...
2026-02-13 23:20:16.269914 | ubuntu-noble | fix end of files.........................................................Passed
2026-02-13 23:20:16.318399 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-02-13 23:20:16.582836 | ubuntu-noble | black....................................................................Passed
2026-02-13 23:20:16.855336 | ubuntu-noble | flake8...................................................................Passed
2026-02-13 23:20:16.973066 | ubuntu-noble | isort....................................................................Passed
2026-02-13 23:20:37.562148 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-02-13 23:20:37.887676 | ubuntu-noble | ok: Runtime: 0:00:52.415021
2026-02-13 23:20:37.889769 | 
2026-02-13 23:20:37.889821 | PLAY RECAP
2026-02-13 23:20:37.889868 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-13 23:20:37.889890 | 
2026-02-13 23:20:38.064253 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-02-13 23:20:38.066755 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-13 23:20:38.661804 | 
2026-02-13 23:20:38.661953 | PLAY [all]
2026-02-13 23:20:38.674119 | 
2026-02-13 23:20:38.674217 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-13 23:20:38.730196 | ubuntu-noble | skipping: Conditional result was False
2026-02-13 23:20:38.740412 | 
2026-02-13 23:20:38.740569 | TASK [fetch-output : Set log path for single node]
2026-02-13 23:20:38.785603 | ubuntu-noble | ok
2026-02-13 23:20:38.791808 | 
2026-02-13 23:20:38.791895 | LOOP [fetch-output : Ensure local output dirs]
2026-02-13 23:20:39.199530 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/31bf720cd4e4435e9287da14eb772264/work/logs"
2026-02-13 23:20:39.419260 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/31bf720cd4e4435e9287da14eb772264/work/artifacts"
2026-02-13 23:20:39.622643 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/31bf720cd4e4435e9287da14eb772264/work/docs"
2026-02-13 23:20:39.637400 | 
2026-02-13 23:20:39.637552 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-13 23:20:40.295195 | ubuntu-noble | changed: .d..t...... ./
2026-02-13 23:20:40.295420 | ubuntu-noble | changed: All items complete
2026-02-13 23:20:40.295459 | 
2026-02-13 23:20:40.790119 | ubuntu-noble | changed: .d..t...... ./
2026-02-13 23:20:41.234828 | ubuntu-noble | changed: .d..t...... ./
2026-02-13 23:20:41.264617 | 
2026-02-13 23:20:41.264838 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-13 23:20:41.718167 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007998
2026-02-13 23:20:41.953075 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008908
2026-02-13 23:20:41.969247 | 
2026-02-13 23:20:41.969481 | PLAY [all]
2026-02-13 23:20:41.978745 | 
2026-02-13 23:20:41.978823 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-02-13 23:20:42.477866 | ubuntu-noble | changed
2026-02-13 23:20:42.484381 | 
2026-02-13 23:20:42.484429 | PLAY RECAP
2026-02-13 23:20:42.484468 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-02-13 23:20:42.484489 | 
2026-02-13 23:20:42.623484 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-13 23:20:42.625601 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main]
2026-02-13 23:20:43.208151 | 
2026-02-13 23:20:43.208304 | PLAY [localhost]
2026-02-13 23:20:43.220260 | 
2026-02-13 23:20:43.220408 | TASK [Generate Zuul manifest]
2026-02-13 23:20:43.241930 | localhost | ok
2026-02-13 23:20:43.258894 | 
2026-02-13 23:20:43.259050 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-13 23:20:43.582600 | localhost | changed
2026-02-13 23:20:43.607256 | 
2026-02-13 23:20:43.607544 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-13 23:20:43.649473 | localhost | ok
2026-02-13 23:20:43.666409 | 
2026-02-13 23:20:43.666537 | TASK [Upload logs]
2026-02-13 23:20:43.689356 | localhost | ok
2026-02-13 23:20:43.754162 | 
2026-02-13 23:20:43.754316 | TASK [Set zuul-log-path fact]
2026-02-13 23:20:43.776605 | localhost | ok
2026-02-13 23:20:43.791835 | 
2026-02-13 23:20:43.791977 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-13 23:20:43.826930 | localhost | ok
2026-02-13 23:20:43.834542 | 
2026-02-13 23:20:43.834621 | TASK [upload-logs : Create log directories]
2026-02-13 23:20:44.250330 | localhost | changed
2026-02-13 23:20:44.264416 | 
2026-02-13 23:20:44.264670 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-02-13 23:20:44.703662 | localhost -> localhost | ok: Runtime: 0:00:00.006522
2026-02-13 23:20:44.708789 | 
2026-02-13 23:20:44.708858 | TASK [upload-logs : Upload logs to log server]
2026-02-13 23:20:45.220563 | localhost | Output suppressed because no_log was given
2026-02-13 23:20:45.224686 | 
2026-02-13 23:20:45.224757 | LOOP [upload-logs : Compress console log and json output]
2026-02-13 23:20:45.270832 | localhost | skipping: Conditional result was False
2026-02-13 23:20:45.277595 | localhost | skipping: Conditional result was False
2026-02-13 23:20:45.289036 | 
2026-02-13 23:20:45.289175 | LOOP [upload-logs : Upload compressed console log and json output]
2026-02-13 23:20:45.339804 | localhost | skipping: Conditional result was False
2026-02-13 23:20:45.340071 | 
2026-02-13 23:20:45.343716 | localhost | skipping: Conditional result was False
2026-02-13 23:20:45.356279 | 
2026-02-13 23:20:45.356519 | LOOP [upload-logs : Upload console log and json output]