2026-04-20 02:13:15.814049 | Job console starting
2026-04-20 02:13:15.838995 | Updating git repos
2026-04-20 02:13:15.859028 | Cloning repos into workspace
2026-04-20 02:13:16.032790 | Restoring repo states
2026-04-20 02:13:16.040703 | Merging changes
2026-04-20 02:13:16.404280 | Checking out repos
2026-04-20 02:13:16.452234 | Preparing playbooks
2026-04-20 02:13:18.258493 | Running Ansible setup
2026-04-20 02:13:23.522146 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-20 02:13:24.301402 | 
2026-04-20 02:13:24.301609 | PLAY [localhost]
2026-04-20 02:13:24.312704 | 
2026-04-20 02:13:24.312816 | TASK [Gathering Facts]
2026-04-20 02:13:25.310738 | localhost | ok
2026-04-20 02:13:25.317381 | 
2026-04-20 02:13:25.317459 | TASK [Setup log path fact]
2026-04-20 02:13:25.346311 | localhost | ok
2026-04-20 02:13:25.359780 | 
2026-04-20 02:13:25.359883 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-20 02:13:25.398474 | localhost | ok
2026-04-20 02:13:25.413231 | 
2026-04-20 02:13:25.413359 | TASK [emit-job-header : Print job information]
2026-04-20 02:13:25.451055 | # Job Information
2026-04-20 02:13:25.451261 | Ansible Version: 2.16.16
2026-04-20 02:13:25.451308 | Job: pre-commit
2026-04-20 02:13:25.451340 | Pipeline: check
2026-04-20 02:13:25.451368 | Executor: 0a8996d2b663
2026-04-20 02:13:25.451396 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/108
2026-04-20 02:13:25.451428 | Event ID: d8bdab90-3c5d-11f1-9e83-70ae08c54185
2026-04-20 02:13:25.455766 | 
2026-04-20 02:13:25.455860 | LOOP [emit-job-header : Print node information]
2026-04-20 02:13:25.607201 | localhost | ok:
2026-04-20 02:13:25.607406 | localhost | # Node Information
2026-04-20 02:13:25.607452 | localhost | Inventory Hostname: ubuntu-noble
2026-04-20 02:13:25.607487 | localhost | Hostname: np0000167924
2026-04-20 02:13:25.607519 | localhost | Username: zuul
2026-04-20 02:13:25.607555 | localhost | Distro: Ubuntu 24.04
2026-04-20 02:13:25.607588 | localhost | Provider: yul1
2026-04-20 02:13:25.607619 | localhost | Region: ca-ymq-1
2026-04-20 02:13:25.607651 | localhost | Label: ubuntu-noble
2026-04-20 02:13:25.607681 | localhost | Product Name: OpenStack Nova
2026-04-20 02:13:25.607710 | localhost | Interface IP: 199.19.213.27
2026-04-20 02:13:25.623335 | 
2026-04-20 02:13:25.623500 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-20 02:13:26.088311 | localhost -> localhost | changed
2026-04-20 02:13:26.093895 | 
2026-04-20 02:13:26.093985 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-20 02:13:27.184353 | localhost -> localhost | changed
2026-04-20 02:13:27.198415 | 
2026-04-20 02:13:27.237293 | PLAY [all]
2026-04-20 02:13:27.256072 | 
2026-04-20 02:13:27.256230 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-20 02:13:27.515173 | ubuntu-noble -> localhost | ok
2026-04-20 02:13:27.535704 | 
2026-04-20 02:13:27.535813 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-20 02:13:27.569702 | ubuntu-noble | ok
2026-04-20 02:13:27.589054 | ubuntu-noble | included: /var/lib/zuul/builds/7dfebe64b543418bb86b4f6bb1754873/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-20 02:13:27.596589 | 
2026-04-20 02:13:27.596699 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-20 02:13:28.415747 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-04-20 02:13:28.415922 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/7dfebe64b543418bb86b4f6bb1754873/work/7dfebe64b543418bb86b4f6bb1754873_id_rsa
2026-04-20 02:13:28.415955 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/7dfebe64b543418bb86b4f6bb1754873/work/7dfebe64b543418bb86b4f6bb1754873_id_rsa.pub
2026-04-20 02:13:28.415979 | ubuntu-noble -> localhost | The key fingerprint is:
2026-04-20 02:13:28.416075 | ubuntu-noble -> localhost | SHA256:Cg6NZJa4+VcmGo3tqd7ith2pE41dfcGJuWmk7EuNJrw zuul-build-sshkey
2026-04-20 02:13:28.416121 | ubuntu-noble -> localhost | The key's randomart image is:
2026-04-20 02:13:28.416145 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-04-20 02:13:28.416174 | ubuntu-noble -> localhost | |         + .     |
2026-04-20 02:13:28.416197 | ubuntu-noble -> localhost | | . .    + +      |
2026-04-20 02:13:28.416218 | ubuntu-noble -> localhost | |. =  . + o .     |
2026-04-20 02:13:28.416238 | ubuntu-noble -> localhost | | * *  + = .      |
2026-04-20 02:13:28.416259 | ubuntu-noble -> localhost | |o ==*oo+S.       |
2026-04-20 02:13:28.416279 | ubuntu-noble -> localhost | | .o*=B=..        |
2026-04-20 02:13:28.416299 | ubuntu-noble -> localhost | |  o.B=..         |
2026-04-20 02:13:28.416319 | ubuntu-noble -> localhost | |  +*E..          |
2026-04-20 02:13:28.416342 | ubuntu-noble -> localhost | | +*+o            |
2026-04-20 02:13:28.416362 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-04-20 02:13:28.416426 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.316216
2026-04-20 02:13:28.423649 | 
2026-04-20 02:13:28.423735 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-20 02:13:28.473647 | ubuntu-noble | ok
2026-04-20 02:13:28.483725 | ubuntu-noble | included: /var/lib/zuul/builds/7dfebe64b543418bb86b4f6bb1754873/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-20 02:13:28.493070 | 
2026-04-20 02:13:28.493156 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-20 02:13:28.518342 | ubuntu-noble | skipping: Conditional result was False
2026-04-20 02:13:28.530413 | 
2026-04-20 02:13:28.530548 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-20 02:13:29.304591 | ubuntu-noble | changed
2026-04-20 02:13:29.312882 | 
2026-04-20 02:13:29.313040 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-20 02:13:29.556231 | ubuntu-noble | ok
2026-04-20 02:13:29.561946 | 
2026-04-20 02:13:29.562027 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-20 02:13:30.165523 | ubuntu-noble | changed
2026-04-20 02:13:30.172816 | 
2026-04-20 02:13:30.173076 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-20 02:13:30.789491 | ubuntu-noble | changed
2026-04-20 02:13:32.130150 | 
2026-04-20 02:13:32.130624 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-20 02:13:32.156011 | ubuntu-noble | skipping: Conditional result was False
2026-04-20 02:13:32.162538 | 
2026-04-20 02:13:32.162663 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-20 02:13:32.624596 | ubuntu-noble -> localhost | changed
2026-04-20 02:13:32.646950 | 
2026-04-20 02:13:32.682277 | TASK [add-build-sshkey : Add back temp key]
2026-04-20 02:13:33.074352 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/7dfebe64b543418bb86b4f6bb1754873/work/7dfebe64b543418bb86b4f6bb1754873_id_rsa (zuul-build-sshkey)
2026-04-20 02:13:33.074625 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016283
2026-04-20 02:13:33.084969 | 
2026-04-20 02:13:33.085310 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-20 02:13:33.495261 | ubuntu-noble | ok
2026-04-20 02:13:33.503230 | 
2026-04-20 02:13:33.503372 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-20 02:13:33.527964 | ubuntu-noble | skipping: Conditional result was False
2026-04-20 02:13:33.541273 | 
2026-04-20 02:13:33.541420 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-20 02:13:33.962244 | ubuntu-noble | ok
2026-04-20 02:13:33.968942 | 
2026-04-20 02:13:33.969106 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-20 02:13:34.962751 | ubuntu-noble | Output suppressed because no_log was given
2026-04-20 02:13:35.049355 | 
2026-04-20 02:13:35.049515 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-20 02:13:35.352156 | ubuntu-noble | ok: "logs"
2026-04-20 02:13:35.352387 | ubuntu-noble | ok: All items complete
2026-04-20 02:13:35.352436 | 
2026-04-20 02:13:35.495859 | ubuntu-noble | ok: "artifacts"
2026-04-20 02:13:35.807098 | ubuntu-noble | ok: "docs"
2026-04-20 02:13:35.821520 | 
2026-04-20 02:13:35.821685 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-20 02:13:36.058140 | ubuntu-noble | changed: "logs"
2026-04-20 02:13:36.252299 | ubuntu-noble | changed: "artifacts"
2026-04-20 02:13:36.455372 | ubuntu-noble | changed: "docs"
2026-04-20 02:13:36.466106 | 
2026-04-20 02:13:36.466214 | PLAY RECAP
2026-04-20 02:13:36.466260 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-20 02:13:36.466289 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-20 02:13:36.466311 | 
2026-04-20 02:13:36.674262 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-20 02:13:36.675301 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-20 02:13:37.387072 | 
2026-04-20 02:13:37.387305 | PLAY [all]
2026-04-20 02:13:37.400389 | 
2026-04-20 02:13:37.400484 | TASK [setup-uv : Extract archive]
2026-04-20 02:13:39.840912 | ubuntu-noble | changed
2026-04-20 02:13:39.847868 | 
2026-04-20 02:13:39.847970 | TASK [setup-uv : Print version]
2026-04-20 02:13:40.311486 | ubuntu-noble | uv 0.8.13
2026-04-20 02:13:40.386225 | ubuntu-noble | ok: Runtime: 0:00:00.015438
2026-04-20 02:13:40.395712 | 
2026-04-20 02:13:40.395816 | PLAY RECAP
2026-04-20 02:13:40.395866 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-20 02:13:40.395892 | 
2026-04-20 02:13:40.622613 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main]
2026-04-20 02:13:40.624674 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-20 02:13:41.398612 | 
2026-04-20 02:13:41.421088 | PLAY [all]
2026-04-20 02:13:41.436241 | 
2026-04-20 02:13:41.436393 | TASK [Run "pre-commit"]
2026-04-20 02:13:42.225036 | ubuntu-noble | Downloading virtualenv (5.6MiB)
2026-04-20 02:13:42.346486 | ubuntu-noble |  Downloading virtualenv
2026-04-20 02:13:42.358617 | ubuntu-noble | Installed 10 packages in 11ms
2026-04-20 02:13:42.759120 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-20 02:13:43.286868 | 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-20 02:13:43.293672 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black.
2026-04-20 02:13:43.839663 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8.
2026-04-20 02:13:44.249229 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort.
2026-04-20 02:13:44.681387 | 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-20 02:13:44.682669 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git.
2026-04-20 02:13:45.241255 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0.
2026-04-20 02:13:45.757082 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks.
2026-04-20 02:13:45.757147 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-20 02:13:45.757159 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-20 02:13:50.049303 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black.
2026-04-20 02:13:50.049351 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-20 02:13:50.049358 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-20 02:13:54.689377 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8.
2026-04-20 02:13:54.689465 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-20 02:13:54.689478 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-20 02:13:58.090881 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort.
2026-04-20 02:13:58.090951 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-20 02:13:58.090962 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-20 02:14:00.812067 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git.
2026-04-20 02:14:00.812163 | ubuntu-noble | [INFO] Once installed this environment will be reused.
2026-04-20 02:14:00.812182 | ubuntu-noble | [INFO] This may take a few minutes...
2026-04-20 02:14:12.718267 | ubuntu-noble | fix end of files.........................................................Passed
2026-04-20 02:14:12.778446 | ubuntu-noble | trim trailing whitespace.................................................Passed
2026-04-20 02:14:13.044487 | ubuntu-noble | black....................................................................Passed
2026-04-20 02:14:13.235383 | ubuntu-noble | flake8...................................................................Passed
2026-04-20 02:14:13.360867 | ubuntu-noble | isort....................................................................Passed
2026-04-20 02:14:29.988280 | ubuntu-noble | Ansible-lint.............................................................Passed
2026-04-20 02:14:30.512848 | ubuntu-noble | ok: Runtime: 0:00:48.130547
2026-04-20 02:14:30.515258 | 
2026-04-20 02:14:30.515356 | PLAY RECAP
2026-04-20 02:14:30.515418 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-20 02:14:30.515450 | 
2026-04-20 02:14:30.685322 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main]
2026-04-20 02:14:30.687634 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-20 02:14:31.371662 | 
2026-04-20 02:14:31.371787 | PLAY [all]
2026-04-20 02:14:31.383762 | 
2026-04-20 02:14:31.383845 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-20 02:14:31.449159 | ubuntu-noble | skipping: Conditional result was False
2026-04-20 02:14:31.551006 | 
2026-04-20 02:14:31.551168 | TASK [fetch-output : Set log path for single node]
2026-04-20 02:14:31.597167 | ubuntu-noble | ok
2026-04-20 02:14:31.603740 | 
2026-04-20 02:14:31.603824 | LOOP [fetch-output : Ensure local output dirs]
2026-04-20 02:14:32.061615 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/7dfebe64b543418bb86b4f6bb1754873/work/logs"
2026-04-20 02:14:32.332720 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/7dfebe64b543418bb86b4f6bb1754873/work/artifacts"
2026-04-20 02:14:32.567558 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/7dfebe64b543418bb86b4f6bb1754873/work/docs"
2026-04-20 02:14:32.585567 | 
2026-04-20 02:14:32.585718 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-20 02:14:33.303018 | ubuntu-noble | ok
2026-04-20 02:14:33.303334 | ubuntu-noble | changed: All items complete
2026-04-20 02:14:33.303391 | 
2026-04-20 02:14:33.793403 | ubuntu-noble | changed: .d..t...... ./
2026-04-20 02:14:34.280381 | ubuntu-noble | changed: .d..t...... ./
2026-04-20 02:14:34.300096 | 
2026-04-20 02:14:34.300250 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-20 02:14:34.792900 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008895
2026-04-20 02:14:35.061415 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.010032
2026-04-20 02:14:35.089767 | 
2026-04-20 02:14:35.089907 | PLAY [all]
2026-04-20 02:14:35.102214 | 
2026-04-20 02:14:35.102343 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-20 02:14:35.648164 | ubuntu-noble | changed
2026-04-20 02:14:35.654883 | 
2026-04-20 02:14:35.654967 | PLAY RECAP
2026-04-20 02:14:35.655014 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-20 02:14:35.655036 | 
2026-04-20 02:14:35.853091 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-20 02:14:35.857972 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-20 02:14:36.473500 | 
2026-04-20 02:14:36.473640 | PLAY [localhost]
2026-04-20 02:14:36.483855 | 
2026-04-20 02:14:36.483944 | TASK [Generate Zuul manifest]
2026-04-20 02:14:36.506969 | localhost | ok
2026-04-20 02:14:36.525729 | 
2026-04-20 02:14:36.525841 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-20 02:14:36.917059 | localhost | changed
2026-04-20 02:14:36.930124 | 
2026-04-20 02:14:36.930236 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-20 02:14:36.961242 | localhost | ok
2026-04-20 02:14:36.970944 | 
2026-04-20 02:14:36.971081 | TASK [Upload logs]
2026-04-20 02:14:36.992474 | localhost | ok
2026-04-20 02:14:37.050441 | 
2026-04-20 02:14:37.050573 | TASK [Set zuul-log-path fact]
2026-04-20 02:14:37.073126 | localhost | ok
2026-04-20 02:14:37.089545 | 
2026-04-20 02:14:37.089626 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-20 02:14:37.119247 | localhost | ok
2026-04-20 02:14:37.129841 | 
2026-04-20 02:14:37.129972 | TASK [upload-logs : Create log directories]
2026-04-20 02:14:37.556325 | localhost | changed
2026-04-20 02:14:37.562791 | 
2026-04-20 02:14:37.562889 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-20 02:14:38.023159 | localhost -> localhost | ok: Runtime: 0:00:00.006760
2026-04-20 02:14:38.030040 | 
2026-04-20 02:14:38.030129 | TASK [upload-logs : Upload logs to log server]
2026-04-20 02:14:38.557185 | localhost | Output suppressed because no_log was given
2026-04-20 02:14:38.562655 | 
2026-04-20 02:14:38.562770 | LOOP [upload-logs : Compress console log and json output]
2026-04-20 02:14:38.615047 | localhost | skipping: Conditional result was False
2026-04-20 02:14:38.622105 | localhost | skipping: Conditional result was False
2026-04-20 02:14:38.640156 | 
2026-04-20 02:14:38.640411 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-20 02:14:38.690177 | localhost | skipping: Conditional result was False
2026-04-20 02:14:38.690716 | 
2026-04-20 02:14:38.693089 | localhost | skipping: Conditional result was False
2026-04-20 02:14:38.711558 | 
2026-04-20 02:14:38.711707 | LOOP [upload-logs : Upload console log and json output]