2026-04-09 16:02:09.987053 | Job console starting 2026-04-09 16:02:10.001490 | Updating git repos 2026-04-09 16:02:10.024397 | Cloning repos into workspace 2026-04-09 16:02:15.475757 | Restoring repo states 2026-04-09 16:02:15.489617 | Merging changes 2026-04-09 16:02:16.147046 | Checking out repos 2026-04-09 16:02:16.897113 | Preparing playbooks 2026-04-09 16:02:40.155985 | Running Ansible setup 2026-04-09 16:02:44.080225 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-09 16:02:44.671431 | 2026-04-09 16:02:44.671776 | PLAY [localhost] 2026-04-09 16:02:44.680455 | 2026-04-09 16:02:44.680526 | TASK [Gathering Facts] 2026-04-09 16:02:45.607405 | localhost | ok 2026-04-09 16:02:45.619539 | 2026-04-09 16:02:45.619789 | TASK [Setup log path fact] 2026-04-09 16:02:45.642432 | localhost | ok 2026-04-09 16:02:45.657072 | 2026-04-09 16:02:45.657405 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-09 16:02:45.685464 | localhost | ok 2026-04-09 16:02:45.692211 | 2026-04-09 16:02:45.692362 | TASK [emit-job-header : Print job information] 2026-04-09 16:02:45.744821 | # Job Information 2026-04-09 16:02:45.745598 | Ansible Version: 2.16.16 2026-04-09 16:02:45.745639 | Job: pre-commit 2026-04-09 16:02:45.745662 | Pipeline: check 2026-04-09 16:02:45.745682 | Executor: 0a8996d2b663 2026-04-09 16:02:45.745702 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/93 2026-04-09 16:02:45.746194 | Event ID: 592c8010-342c-11f1-8e5e-2b2d0b84186e 2026-04-09 16:02:45.754471 | 2026-04-09 16:02:45.755100 | LOOP [emit-job-header : Print node information] 2026-04-09 16:02:45.856323 | localhost | ok: 2026-04-09 16:02:45.856675 | localhost | # Node Information 2026-04-09 16:02:45.856762 | localhost | Inventory Hostname: ubuntu-noble 2026-04-09 16:02:45.856801 | localhost | Hostname: np0000164587 2026-04-09 16:02:45.856835 | localhost | Username: zuul 2026-04-09 16:02:45.856876 | localhost | Distro: Ubuntu 24.04 2026-04-09 16:02:45.856912 | localhost | Provider: yul1 2026-04-09 16:02:45.856944 | localhost | Region: ca-ymq-1 2026-04-09 16:02:45.856984 | localhost | Label: ubuntu-noble 2026-04-09 16:02:45.857065 | localhost | Product Name: OpenStack Nova 2026-04-09 16:02:45.857095 | localhost | Interface IP: 199.19.213.66 2026-04-09 16:02:45.872983 | 2026-04-09 16:02:45.873104 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-09 16:02:46.363591 | localhost -> localhost | changed 2026-04-09 16:02:46.368493 | 2026-04-09 16:02:46.368561 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-09 16:02:47.205167 | localhost -> localhost | changed 2026-04-09 16:02:47.215033 | 2026-04-09 16:02:47.215160 | PLAY [all] 2026-04-09 16:02:47.223785 | 2026-04-09 16:02:47.223939 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-09 16:02:47.443250 | ubuntu-noble -> localhost | ok 2026-04-09 16:02:47.454943 | 2026-04-09 16:02:47.455302 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-09 16:02:47.496854 | ubuntu-noble | ok 2026-04-09 16:02:47.522184 | ubuntu-noble | included: /var/lib/zuul/builds/53def7a696d1425b84a39f927008b8f5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-09 16:02:47.532500 | 2026-04-09 16:02:47.532643 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-09 16:02:49.122029 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-04-09 16:02:49.122209 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/53def7a696d1425b84a39f927008b8f5/work/53def7a696d1425b84a39f927008b8f5_id_rsa 2026-04-09 16:02:49.122258 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/53def7a696d1425b84a39f927008b8f5/work/53def7a696d1425b84a39f927008b8f5_id_rsa.pub 2026-04-09 16:02:49.122285 | ubuntu-noble -> localhost | The key fingerprint is: 2026-04-09 16:02:49.122309 | ubuntu-noble -> localhost | SHA256:TEtA0dJhlbjTRA5ee8oQktdnv6dsfqHCThYd81QLs0Q zuul-build-sshkey 2026-04-09 16:02:49.122349 | ubuntu-noble -> localhost | The key's randomart image is: 2026-04-09 16:02:49.122373 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-04-09 16:02:49.122403 | ubuntu-noble -> localhost | | .===*+..E .| 2026-04-09 16:02:49.122427 | ubuntu-noble -> localhost | | o===+.+ + o| 2026-04-09 16:02:49.122451 | ubuntu-noble -> localhost | | o=+oo.= o | 2026-04-09 16:02:49.122475 | ubuntu-noble -> localhost | | +o+.o. * | 2026-04-09 16:02:49.122498 | ubuntu-noble -> localhost | | S.o. . o | 2026-04-09 16:02:49.122526 | ubuntu-noble -> localhost | | . ...| 2026-04-09 16:02:49.122565 | ubuntu-noble -> localhost | | .o ..o.| 2026-04-09 16:02:49.122593 | ubuntu-noble -> localhost | | oo .+ .| 2026-04-09 16:02:49.122619 | ubuntu-noble -> localhost | | ...o.. | 2026-04-09 16:02:49.122642 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-04-09 16:02:49.122696 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.171140 2026-04-09 16:02:49.130026 | 2026-04-09 16:02:49.130250 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-09 16:02:49.167310 | ubuntu-noble | ok 2026-04-09 16:02:49.176311 | ubuntu-noble | included: /var/lib/zuul/builds/53def7a696d1425b84a39f927008b8f5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-09 16:02:49.184135 | 2026-04-09 16:02:49.184203 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-09 16:02:49.208400 | ubuntu-noble | skipping: Conditional result was False 2026-04-09 16:02:49.218267 | 2026-04-09 16:02:49.218357 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-09 16:02:49.969935 | ubuntu-noble | changed 2026-04-09 16:02:49.977731 | 2026-04-09 16:02:49.977807 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-09 16:02:50.203125 | ubuntu-noble | ok 2026-04-09 16:02:50.209465 | 2026-04-09 16:02:50.209528 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-09 16:02:51.580866 | ubuntu-noble | changed 2026-04-09 16:02:51.593410 | 2026-04-09 16:02:51.593501 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-09 16:02:52.171481 | ubuntu-noble | changed 2026-04-09 16:02:52.655313 | 2026-04-09 16:02:52.655409 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-09 16:02:52.680378 | ubuntu-noble | skipping: Conditional result was False 2026-04-09 16:02:52.692243 | 2026-04-09 16:02:52.692309 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-09 16:02:53.083752 | ubuntu-noble -> localhost | changed 2026-04-09 16:02:53.100164 | 2026-04-09 16:02:53.100236 | TASK [add-build-sshkey : Add back temp key] 2026-04-09 16:02:53.385869 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/53def7a696d1425b84a39f927008b8f5/work/53def7a696d1425b84a39f927008b8f5_id_rsa (zuul-build-sshkey) 2026-04-09 16:02:53.386097 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011580 2026-04-09 16:02:53.392172 | 2026-04-09 16:02:53.392258 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-09 16:02:53.762360 | ubuntu-noble | ok 2026-04-09 16:02:53.767346 | 2026-04-09 16:02:53.767407 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-09 16:02:53.792199 | ubuntu-noble | skipping: Conditional result was False 2026-04-09 16:02:53.808973 | 2026-04-09 16:02:53.809065 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-09 16:02:54.187260 | ubuntu-noble | ok 2026-04-09 16:02:54.195960 | 2026-04-09 16:02:54.196065 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-09 16:02:55.067489 | ubuntu-noble | Output suppressed because no_log was given 2026-04-09 16:02:55.078129 | 2026-04-09 16:02:55.078196 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-09 16:02:55.366247 | ubuntu-noble | ok: "logs" 2026-04-09 16:02:55.366468 | ubuntu-noble | ok: All items complete 2026-04-09 16:02:55.366518 | 2026-04-09 16:02:55.535533 | ubuntu-noble | ok: "artifacts" 2026-04-09 16:02:55.782341 | ubuntu-noble | ok: "docs" 2026-04-09 16:02:55.793907 | 2026-04-09 16:02:55.794114 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-09 16:02:56.011424 | ubuntu-noble | changed: "logs" 2026-04-09 16:02:56.199054 | ubuntu-noble | changed: "artifacts" 2026-04-09 16:02:56.384862 | ubuntu-noble | changed: "docs" 2026-04-09 16:02:56.406230 | 2026-04-09 16:02:56.406380 | PLAY RECAP 2026-04-09 16:02:56.406431 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-09 16:02:56.406464 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-09 16:02:56.406487 | 2026-04-09 16:02:56.596095 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-09 16:02:56.597343 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-04-09 16:02:57.504516 | 2026-04-09 16:02:57.640428 | PLAY [all] 2026-04-09 16:02:57.659954 | 2026-04-09 16:02:57.660070 | TASK [setup-uv : Extract archive] 2026-04-09 16:03:00.395713 | ubuntu-noble | changed 2026-04-09 16:03:00.403787 | 2026-04-09 16:03:00.403866 | TASK [setup-uv : Print version] 2026-04-09 16:03:00.820269 | ubuntu-noble | uv 0.8.13 2026-04-09 16:03:00.961816 | ubuntu-noble | ok: Runtime: 0:00:00.015299 2026-04-09 16:03:00.970004 | 2026-04-09 16:03:00.970054 | PLAY RECAP 2026-04-09 16:03:00.970101 | ubuntu-noble | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-09 16:03:00.970186 | 2026-04-09 16:03:01.069696 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/pre.yaml@main] 2026-04-09 16:03:01.072058 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-04-09 16:03:01.643299 | 2026-04-09 16:03:01.643434 | PLAY [all] 2026-04-09 16:03:01.655091 | 2026-04-09 16:03:01.655181 | TASK [Run "pre-commit"] 2026-04-09 16:03:02.292221 | ubuntu-noble | Downloading virtualenv (5.6MiB) 2026-04-09 16:03:02.386425 | ubuntu-noble | Downloading virtualenv 2026-04-09 16:03:02.399474 | ubuntu-noble | Installed 10 packages in 12ms 2026-04-09 16:03:03.019286 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-04-09 16:03:03.969358 | 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-09 16:03:03.975300 | ubuntu-noble | [INFO] Initializing environment for https://github.com/psf/black. 2026-04-09 16:03:05.600393 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/flake8. 2026-04-09 16:03:06.219070 | ubuntu-noble | [INFO] Initializing environment for https://github.com/pycqa/isort. 2026-04-09 16:03:06.714500 | 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-09 16:03:06.716005 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git. 2026-04-09 16:03:07.316485 | ubuntu-noble | [INFO] Initializing environment for https://github.com/ansible/ansible-lint.git:ansible-core>=2.16.0. 2026-04-09 16:03:07.917921 | ubuntu-noble | [INFO] Installing environment for https://github.com/pre-commit/pre-commit-hooks. 2026-04-09 16:03:07.917970 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-04-09 16:03:07.917981 | ubuntu-noble | [INFO] This may take a few minutes... 2026-04-09 16:03:11.924473 | ubuntu-noble | [INFO] Installing environment for https://github.com/psf/black. 2026-04-09 16:03:11.924594 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-04-09 16:03:11.924605 | ubuntu-noble | [INFO] This may take a few minutes... 2026-04-09 16:03:23.250446 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/flake8. 2026-04-09 16:03:23.250563 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-04-09 16:03:23.250575 | ubuntu-noble | [INFO] This may take a few minutes... 2026-04-09 16:03:28.397706 | ubuntu-noble | [INFO] Installing environment for https://github.com/pycqa/isort. 2026-04-09 16:03:28.397786 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-04-09 16:03:28.397800 | ubuntu-noble | [INFO] This may take a few minutes... 2026-04-09 16:03:31.687865 | ubuntu-noble | [INFO] Installing environment for https://github.com/ansible/ansible-lint.git. 2026-04-09 16:03:31.687946 | ubuntu-noble | [INFO] Once installed this environment will be reused. 2026-04-09 16:03:31.687974 | ubuntu-noble | [INFO] This may take a few minutes... 2026-04-09 16:03:44.140390 | ubuntu-noble | fix end of files.........................................................Passed 2026-04-09 16:03:44.199526 | ubuntu-noble | trim trailing whitespace.................................................Passed 2026-04-09 16:03:44.472428 | ubuntu-noble | black....................................................................Passed 2026-04-09 16:03:44.684296 | ubuntu-noble | flake8...................................................................Passed 2026-04-09 16:03:44.826100 | ubuntu-noble | isort....................................................................Passed 2026-04-09 16:04:03.181507 | ubuntu-noble | Ansible-lint.............................................................Passed 2026-04-09 16:04:03.309983 | ubuntu-noble | ok: Runtime: 0:01:01.182262 2026-04-09 16:04:03.311975 | 2026-04-09 16:04:03.312023 | PLAY RECAP 2026-04-09 16:04:03.312063 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-09 16:04:03.312086 | 2026-04-09 16:04:03.451783 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/pre-commit/run.yaml@main] 2026-04-09 16:04:03.453131 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-09 16:04:04.046808 | 2026-04-09 16:04:04.046984 | PLAY [all] 2026-04-09 16:04:04.059186 | 2026-04-09 16:04:04.059264 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-09 16:04:04.093473 | ubuntu-noble | skipping: Conditional result was False 2026-04-09 16:04:04.104358 | 2026-04-09 16:04:04.104444 | TASK [fetch-output : Set log path for single node] 2026-04-09 16:04:04.149129 | ubuntu-noble | ok 2026-04-09 16:04:04.154034 | 2026-04-09 16:04:04.154099 | LOOP [fetch-output : Ensure local output dirs] 2026-04-09 16:04:04.536224 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/53def7a696d1425b84a39f927008b8f5/work/logs" 2026-04-09 16:04:04.736132 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/53def7a696d1425b84a39f927008b8f5/work/artifacts" 2026-04-09 16:04:04.925345 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/53def7a696d1425b84a39f927008b8f5/work/docs" 2026-04-09 16:04:04.949246 | 2026-04-09 16:04:04.949405 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-09 16:04:05.582975 | ubuntu-noble | changed: .d..t...... ./ 2026-04-09 16:04:05.583210 | ubuntu-noble | changed: All items complete 2026-04-09 16:04:05.583240 | 2026-04-09 16:04:06.040374 | ubuntu-noble | changed: .d..t...... ./ 2026-04-09 16:04:06.523445 | ubuntu-noble | changed: .d..t...... ./ 2026-04-09 16:04:06.542588 | 2026-04-09 16:04:06.543013 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-09 16:04:06.982287 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008792 2026-04-09 16:04:07.219912 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007903 2026-04-09 16:04:07.236603 | 2026-04-09 16:04:07.236763 | PLAY [all] 2026-04-09 16:04:07.243337 | 2026-04-09 16:04:07.243407 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-09 16:04:07.744284 | ubuntu-noble | changed 2026-04-09 16:04:07.751785 | 2026-04-09 16:04:07.751840 | PLAY RECAP 2026-04-09 16:04:07.751888 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-09 16:04:07.751910 | 2026-04-09 16:04:07.902383 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-09 16:04:07.904750 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-09 16:04:08.502683 | 2026-04-09 16:04:08.503012 | PLAY [localhost] 2026-04-09 16:04:08.512933 | 2026-04-09 16:04:08.513026 | TASK [Generate Zuul manifest] 2026-04-09 16:04:08.531423 | localhost | ok 2026-04-09 16:04:08.549451 | 2026-04-09 16:04:08.552426 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-09 16:04:08.875530 | localhost | changed 2026-04-09 16:04:08.888188 | 2026-04-09 16:04:08.888263 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-09 16:04:08.919567 | localhost | ok 2026-04-09 16:04:08.927788 | 2026-04-09 16:04:08.927852 | TASK [Upload logs] 2026-04-09 16:04:08.950751 | localhost | ok 2026-04-09 16:04:09.018607 | 2026-04-09 16:04:09.018748 | TASK [Set zuul-log-path fact] 2026-04-09 16:04:09.040075 | localhost | ok 2026-04-09 16:04:09.052554 | 2026-04-09 16:04:09.052627 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-09 16:04:09.083879 | localhost | ok 2026-04-09 16:04:09.092378 | 2026-04-09 16:04:09.092445 | TASK [upload-logs : Create log directories] 2026-04-09 16:04:09.710136 | localhost | changed 2026-04-09 16:04:09.716384 | 2026-04-09 16:04:09.716455 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-09 16:04:10.121706 | localhost -> localhost | ok: Runtime: 0:00:00.005912 2026-04-09 16:04:10.128280 | 2026-04-09 16:04:10.128344 | TASK [upload-logs : Upload logs to log server] 2026-04-09 16:04:10.574742 | localhost | Output suppressed because no_log was given 2026-04-09 16:04:10.580192 | 2026-04-09 16:04:10.580276 | LOOP [upload-logs : Compress console log and json output] 2026-04-09 16:04:10.629133 | localhost | skipping: Conditional result was False 2026-04-09 16:04:10.635858 | localhost | skipping: Conditional result was False 2026-04-09 16:04:10.652433 | 2026-04-09 16:04:10.652580 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-09 16:04:10.695972 | localhost | skipping: Conditional result was False 2026-04-09 16:04:10.696558 | 2026-04-09 16:04:10.699539 | localhost | skipping: Conditional result was False 2026-04-09 16:04:10.717710 | 2026-04-09 16:04:10.717854 | LOOP [upload-logs : Upload console log and json output]