2026-06-04 17:58:55.344768 | Job console starting 2026-06-04 17:58:55.358179 | Updating git repos 2026-06-04 17:58:55.388090 | Cloning repos into workspace 2026-06-04 17:58:59.900918 | Restoring repo states 2026-06-04 17:58:59.909760 | Merging changes 2026-06-04 17:59:00.526417 | Checking out repos 2026-06-04 17:59:01.295887 | Preparing playbooks 2026-06-04 17:59:29.962372 | Running Ansible setup 2026-06-04 17:59:34.900440 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-04 17:59:35.570437 | 2026-06-04 17:59:35.570650 | PLAY [localhost] 2026-06-04 17:59:35.580586 | 2026-06-04 17:59:35.580664 | TASK [Gathering Facts] 2026-06-04 17:59:36.540369 | localhost | ok 2026-06-04 17:59:36.547461 | 2026-06-04 17:59:36.547544 | TASK [Setup log path fact] 2026-06-04 17:59:36.567850 | localhost | ok 2026-06-04 17:59:36.579624 | 2026-06-04 17:59:36.579687 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-04 17:59:36.611495 | localhost | ok 2026-06-04 17:59:36.618553 | 2026-06-04 17:59:36.618632 | TASK [emit-job-header : Print job information] 2026-06-04 17:59:36.670373 | # Job Information 2026-06-04 17:59:36.670642 | Ansible Version: 2.16.18 2026-06-04 17:59:36.670719 | Job: pre-commit 2026-06-04 17:59:36.670769 | Pipeline: check 2026-06-04 17:59:36.670813 | Executor: 2d72f0692154 2026-06-04 17:59:36.670856 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/134 2026-06-04 17:59:36.670906 | Event ID: f1cae1c0-603e-11f1-90c0-a491a17f1f0e 2026-06-04 17:59:36.679516 | 2026-06-04 17:59:36.679593 | LOOP [emit-job-header : Print node information] 2026-06-04 17:59:36.808296 | localhost | ok: 2026-06-04 17:59:36.808470 | localhost | # Node Information 2026-06-04 17:59:36.808505 | localhost | Inventory Hostname: ubuntu-noble 2026-06-04 17:59:36.808533 | localhost | Hostname: np0000178572 2026-06-04 17:59:36.808558 | localhost | Username: zuul 2026-06-04 17:59:36.808586 | localhost | Distro: Ubuntu 24.04 2026-06-04 17:59:36.808612 | localhost | Provider: yul1 2026-06-04 17:59:36.808636 | localhost | Region: ca-ymq-1 2026-06-04 17:59:36.808660 | localhost | Label: ubuntu-noble 2026-06-04 17:59:36.808684 | localhost | Product Name: OpenStack Nova 2026-06-04 17:59:36.808706 | localhost | Interface IP: 199.19.213.216 2026-06-04 17:59:36.820310 | 2026-06-04 17:59:36.820510 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-04 17:59:37.210670 | localhost -> localhost | changed 2026-06-04 17:59:37.217025 | 2026-06-04 17:59:37.217122 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-04 17:59:38.098503 | localhost -> localhost | changed 2026-06-04 17:59:38.107796 | 2026-06-04 17:59:38.108040 | PLAY [all] 2026-06-04 17:59:38.117498 | 2026-06-04 17:59:38.117659 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-04 17:59:38.353824 | ubuntu-noble -> localhost | ok 2026-06-04 17:59:38.360056 | 2026-06-04 17:59:38.360144 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-04 17:59:38.391700 | ubuntu-noble | ok 2026-06-04 17:59:38.408870 | ubuntu-noble | included: /var/lib/zuul/builds/07746166a64848d5920ff17c0fc6d9d9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-04 17:59:38.415319 | 2026-06-04 17:59:38.415385 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-04 17:59:39.629490 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-06-04 17:59:39.629663 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/07746166a64848d5920ff17c0fc6d9d9/work/07746166a64848d5920ff17c0fc6d9d9_id_rsa 2026-06-04 17:59:39.629696 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/07746166a64848d5920ff17c0fc6d9d9/work/07746166a64848d5920ff17c0fc6d9d9_id_rsa.pub 2026-06-04 17:59:39.629719 | ubuntu-noble -> localhost | The key fingerprint is: 2026-06-04 17:59:39.629740 | ubuntu-noble -> localhost | SHA256:9K9FNqcjlMxaxhYnU+klsGuv/K2ZKWHkuuHIYfcxDAs zuul-build-sshkey 2026-06-04 17:59:39.629774 | ubuntu-noble -> localhost | The key's randomart image is: 2026-06-04 17:59:39.629796 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-06-04 17:59:39.629824 | ubuntu-noble -> localhost | | .... | 2026-06-04 17:59:39.629847 | ubuntu-noble -> localhost | | oo . | 2026-06-04 17:59:39.629868 | ubuntu-noble -> localhost | | . =..o | 2026-06-04 17:59:39.629888 | ubuntu-noble -> localhost | | . =.B. | 2026-06-04 17:59:39.629908 | ubuntu-noble -> localhost | | E So& + . | 2026-06-04 17:59:39.629928 | ubuntu-noble -> localhost | | . @+= + | 2026-06-04 17:59:39.629949 | ubuntu-noble -> localhost | | o =o=.* | 2026-06-04 17:59:39.629968 | ubuntu-noble -> localhost | | o =.+.B * | 2026-06-04 17:59:39.629991 | ubuntu-noble -> localhost | | o o.=o*.. | 2026-06-04 17:59:39.630012 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-06-04 17:59:39.630063 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.793691 2026-06-04 17:59:39.635780 | 2026-06-04 17:59:39.635844 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-04 17:59:39.667583 | ubuntu-noble | ok 2026-06-04 17:59:39.678856 | ubuntu-noble | included: /var/lib/zuul/builds/07746166a64848d5920ff17c0fc6d9d9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-04 17:59:39.686710 | 2026-06-04 17:59:39.686783 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-04 17:59:39.711728 | ubuntu-noble | skipping: Conditional result was False 2026-06-04 17:59:39.723429 | 2026-06-04 17:59:39.723527 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-04 17:59:40.279331 | ubuntu-noble | changed 2026-06-04 17:59:40.286799 | 2026-06-04 17:59:40.286883 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-04 17:59:40.545211 | ubuntu-noble | ok 2026-06-04 17:59:40.550606 | 2026-06-04 17:59:40.550667 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-04 17:59:41.136442 | ubuntu-noble | changed 2026-06-04 17:59:41.143445 | 2026-06-04 17:59:41.143627 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-04 17:59:41.685997 | ubuntu-noble | changed 2026-06-04 17:59:41.693131 | 2026-06-04 17:59:41.693205 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-04 17:59:41.721257 | ubuntu-noble | skipping: Conditional result was False 2026-06-04 17:59:41.730051 | 2026-06-04 17:59:41.730133 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-04 17:59:42.079990 | ubuntu-noble -> localhost | changed 2026-06-04 17:59:42.097834 | 2026-06-04 17:59:42.097913 | TASK [add-build-sshkey : Add back temp key] 2026-06-04 17:59:42.389708 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/07746166a64848d5920ff17c0fc6d9d9/work/07746166a64848d5920ff17c0fc6d9d9_id_rsa (zuul-build-sshkey) 2026-06-04 17:59:42.389923 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011935 2026-06-04 17:59:42.398007 | 2026-06-04 17:59:42.398105 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-04 17:59:42.779785 | ubuntu-noble | ok 2026-06-04 17:59:42.789447 | 2026-06-04 17:59:42.789561 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-04 17:59:42.815426 | ubuntu-noble | skipping: Conditional result was False 2026-06-04 17:59:42.834069 | 2026-06-04 17:59:42.834228 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-04 17:59:43.235662 | ubuntu-noble | ok 2026-06-04 17:59:43.273210 | 2026-06-04 17:59:43.273334 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-04 17:59:44.171688 | ubuntu-noble | Output suppressed because no_log was given 2026-06-04 17:59:44.192029 | 2026-06-04 17:59:44.192255 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-04 17:59:44.422799 | ubuntu-noble | ok: "logs" 2026-06-04 17:59:44.423149 | ubuntu-noble | ok: All items complete 2026-06-04 17:59:44.423210 | 2026-06-04 17:59:44.614903 | ubuntu-noble | ok: "artifacts" 2026-06-04 17:59:44.798143 | ubuntu-noble | ok: "docs" 2026-06-04 17:59:44.807113 | 2026-06-04 17:59:44.807242 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-04 17:59:45.032812 | ubuntu-noble | changed: "logs" 2026-06-04 17:59:45.227193 | ubuntu-noble | changed: "artifacts" 2026-06-04 17:59:45.412478 | ubuntu-noble | changed: "docs" 2026-06-04 17:59:45.424897 | 2026-06-04 17:59:45.425016 | PLAY RECAP 2026-06-04 17:59:45.425066 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-04 17:59:45.425095 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-04 17:59:45.425117 | 2026-06-04 17:59:45.578859 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-04 17:59:45.580315 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-06-04 17:59:46.221286 | 2026-06-04 17:59:46.221449 | PLAY [all] 2026-06-04 17:59:46.234499 | 2026-06-04 17:59:46.234603 | TASK [setup-uv : Extract archive] 2026-06-04 17:59:48.705758 | ubuntu-noble | changed 2026-06-04 17:59:48.886606 | 2026-06-04 17:59:48.886792 | TASK [setup-uv : Print version] 2026-06-04 17:59:49.295643 | ubuntu-noble | uv 0.8.13 2026-06-04 17:59:49.440978 | ubuntu-noble | ok: Runtime: 0:00:00.015285 2026-06-04 17:59:49.451814 | 2026-06-04 17:59:49.452437 | PLAY RECAP 2026-06-04 17:59:49.452555 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-04 17:59:49.452618 | 2026-06-04 17:59:49.634148 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-06-04 17:59:49.636846 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-06-04 17:59:50.287788 | 2026-06-04 17:59:50.287954 | PLAY [all] 2026-06-04 17:59:50.300665 | 2026-06-04 17:59:50.300757 | TASK [Run "pre-commit"] 2026-06-04 17:59:50.923339 | ubuntu-noble | Downloading virtualenv (7.2MiB) 2026-06-04 17:59:51.033477 | ubuntu-noble | Downloading virtualenv 2026-06-04 17:59:51.046974 | ubuntu-noble | Installed 10 packages in 12ms 2026-06-04 17:59:51.417768 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-06-04 17:59:52.540675 | 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-06-04 17:59:52.545841 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black. 2026-06-04 17:59:53.101388 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8. 2026-06-04 17:59:53.541759 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort. 2026-06-04 17:59:54.749980 | 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-06-04 17:59:54.750830 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git. 2026-06-04 17:59:55.314758 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0. 2026-06-04 17:59:56.984379 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-06-04 17:59:56.984462 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-06-04 17:59:56.984473 | ubuntu-noble | [INFO] This may take a few minutes... 2026-06-04 18:00:00.934968 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black. 2026-06-04 18:00:00.935081 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-06-04 18:00:00.935098 | ubuntu-noble | [INFO] This may take a few minutes... 2026-06-04 18:00:05.125808 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8. 2026-06-04 18:00:05.125879 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-06-04 18:00:05.125889 | ubuntu-noble | [INFO] This may take a few minutes... 2026-06-04 18:00:08.370582 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort. 2026-06-04 18:00:08.370658 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-06-04 18:00:08.370676 | ubuntu-noble | [INFO] This may take a few minutes... 2026-06-04 18:00:11.627198 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git. 2026-06-04 18:00:11.627250 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-06-04 18:00:11.627255 | ubuntu-noble | [INFO] This may take a few minutes... 2026-06-04 18:00:22.761450 | ubuntu-noble | fix end of files.........................................................Passed 2026-06-04 18:00:22.819733 | ubuntu-noble | trim trailing whitespace.................................................Passed 2026-06-04 18:00:23.097094 | ubuntu-noble | black....................................................................Passed 2026-06-04 18:00:23.290961 | ubuntu-noble | flake8...................................................................Passed 2026-06-04 18:00:23.416678 | ubuntu-noble | isort....................................................................Passed 2026-06-04 18:01:00.812583 | ubuntu-noble | Ansible-lint.............................................................Passed 2026-06-04 18:01:00.941767 | ubuntu-noble | ok: Runtime: 0:01:10.149868 2026-06-04 18:01:00.943951 | 2026-06-04 18:01:00.944012 | PLAY RECAP 2026-06-04 18:01:00.944070 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-04 18:01:00.944102 | 2026-06-04 18:01:01.062220 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-06-04 18:01:01.063747 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-04 18:01:01.651506 | 2026-06-04 18:01:01.651637 | PLAY [all] 2026-06-04 18:01:01.663534 | 2026-06-04 18:01:01.663629 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-04 18:01:01.698578 | ubuntu-noble | skipping: Conditional result was False 2026-06-04 18:01:01.706687 | 2026-06-04 18:01:01.706808 | TASK [fetch-output : Set log path for single node] 2026-06-04 18:01:01.750831 | ubuntu-noble | ok 2026-06-04 18:01:01.760100 | 2026-06-04 18:01:01.760196 | LOOP [fetch-output : Ensure local output dirs] 2026-06-04 18:01:02.226984 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/07746166a64848d5920ff17c0fc6d9d9/work/logs" 2026-06-04 18:01:02.439925 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/07746166a64848d5920ff17c0fc6d9d9/work/artifacts" 2026-06-04 18:01:02.661056 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/07746166a64848d5920ff17c0fc6d9d9/work/docs" 2026-06-04 18:01:02.679549 | 2026-06-04 18:01:02.679766 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-04 18:01:03.382408 | ubuntu-noble | ok 2026-06-04 18:01:03.382613 | ubuntu-noble | changed: All items complete 2026-06-04 18:01:03.382641 | 2026-06-04 18:01:03.859698 | ubuntu-noble | changed: .d..t...... ./ 2026-06-04 18:01:04.340426 | ubuntu-noble | changed: .d..t...... ./ 2026-06-04 18:01:04.369728 | 2026-06-04 18:01:04.369874 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-04 18:01:04.811260 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007488 2026-06-04 18:01:05.034403 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007226 2026-06-04 18:01:05.054526 | 2026-06-04 18:01:05.055047 | PLAY [all] 2026-06-04 18:01:05.061286 | 2026-06-04 18:01:05.061347 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-04 18:01:05.539219 | ubuntu-noble | changed 2026-06-04 18:01:05.547166 | 2026-06-04 18:01:05.547228 | PLAY RECAP 2026-06-04 18:01:05.547272 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-04 18:01:05.547294 | 2026-06-04 18:01:05.660892 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-04 18:01:05.662404 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-04 18:01:06.239813 | 2026-06-04 18:01:06.239925 | PLAY [localhost] 2026-06-04 18:01:06.250420 | 2026-06-04 18:01:06.250501 | TASK [Generate Zuul manifest] 2026-06-04 18:01:06.271747 | localhost | ok 2026-06-04 18:01:06.288426 | 2026-06-04 18:01:06.288499 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-04 18:01:06.694818 | localhost | changed 2026-06-04 18:01:06.707306 | 2026-06-04 18:01:06.707464 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-04 18:01:06.737797 | localhost | ok 2026-06-04 18:01:06.749030 | 2026-06-04 18:01:06.749183 | TASK [Upload logs] 2026-06-04 18:01:06.768991 | localhost | ok 2026-06-04 18:01:06.829640 | 2026-06-04 18:01:06.829770 | TASK [Set zuul-log-path fact] 2026-06-04 18:01:06.851691 | localhost | ok 2026-06-04 18:01:06.864436 | 2026-06-04 18:01:06.864504 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-04 18:01:06.896068 | localhost | ok 2026-06-04 18:01:06.904529 | 2026-06-04 18:01:06.904598 | TASK [upload-logs : Create log directories] 2026-06-04 18:01:07.323070 | localhost | changed 2026-06-04 18:01:07.330383 | 2026-06-04 18:01:07.330536 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-04 18:01:07.779990 | localhost -> localhost | ok: Runtime: 0:00:00.005751 2026-06-04 18:01:07.785174 | 2026-06-04 18:01:07.785275 | TASK [upload-logs : Upload logs to log server] 2026-06-04 18:01:08.229792 | localhost | Output suppressed because no_log was given 2026-06-04 18:01:08.235487 | 2026-06-04 18:01:08.235561 | LOOP [upload-logs : Compress console log and json output] 2026-06-04 18:01:08.287892 | localhost | skipping: Conditional result was False 2026-06-04 18:01:08.295587 | localhost | skipping: Conditional result was False 2026-06-04 18:01:08.308549 | 2026-06-04 18:01:08.308741 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-04 18:01:08.356779 | localhost | skipping: Conditional result was False 2026-06-04 18:01:08.357186 | 2026-06-04 18:01:08.361259 | localhost | skipping: Conditional result was False 2026-06-04 18:01:08.377109 | 2026-06-04 18:01:08.377287 | LOOP [upload-logs : Upload console log and json output]