2025-10-30 19:04:28.314478 | Job console starting 2025-10-30 19:04:28.331985 | Updating git repos 2025-10-30 19:04:28.392825 | Cloning repos into workspace 2025-10-30 19:04:28.476745 | Restoring repo states 2025-10-30 19:04:28.494956 | Merging changes 2025-10-30 19:04:29.211222 | Checking out repos 2025-10-30 19:04:29.280355 | Preparing playbooks 2025-10-30 19:04:30.121184 | Running Ansible setup 2025-10-30 19:04:35.738188 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-30 19:04:36.728266 | 2025-10-30 19:04:36.728431 | PLAY [Base pre] 2025-10-30 19:04:36.745159 | 2025-10-30 19:04:36.745319 | TASK [Setup log path fact] 2025-10-30 19:04:36.764648 | debian-bookworm | ok 2025-10-30 19:04:36.781161 | 2025-10-30 19:04:36.781349 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-30 19:04:36.841369 | debian-bookworm | ok 2025-10-30 19:04:36.851749 | 2025-10-30 19:04:36.851876 | TASK [emit-job-header : Print job information] 2025-10-30 19:04:36.922075 | # Job Information 2025-10-30 19:04:36.922351 | Ansible Version: 2.16.14 2025-10-30 19:04:36.922393 | Job: ansible-collection-ensure-readme 2025-10-30 19:04:36.922428 | Pipeline: check 2025-10-30 19:04:36.922452 | Executor: 521e9411259a 2025-10-30 19:04:36.922472 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2017 2025-10-30 19:04:36.922494 | Event ID: 3d740830-b5c3-11f0-87b9-957ae46ae158 2025-10-30 19:04:36.927856 | 2025-10-30 19:04:36.927989 | LOOP [emit-job-header : Print node information] 2025-10-30 19:04:37.079267 | debian-bookworm | ok: 2025-10-30 19:04:37.079464 | debian-bookworm | # Node Information 2025-10-30 19:04:37.079499 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-30 19:04:37.079524 | debian-bookworm | Hostname: debian 2025-10-30 19:04:37.079546 | debian-bookworm | Username: zuul 2025-10-30 19:04:37.079568 | debian-bookworm | Distro: Debian 12.12 2025-10-30 19:04:37.079592 | debian-bookworm | Provider: regiocloud-a 2025-10-30 19:04:37.079612 | debian-bookworm | Region: 2025-10-30 19:04:37.079633 | debian-bookworm | Label: debian-bookworm 2025-10-30 19:04:37.079653 | debian-bookworm | Product Name: OpenStack Nova 2025-10-30 19:04:37.079673 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9c:ce4d 2025-10-30 19:04:37.098314 | 2025-10-30 19:04:37.098451 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-30 19:04:37.719271 | debian-bookworm -> localhost | changed 2025-10-30 19:04:37.726670 | 2025-10-30 19:04:37.726793 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-30 19:04:38.879984 | debian-bookworm -> localhost | changed 2025-10-30 19:04:38.890127 | 2025-10-30 19:04:38.890229 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-30 19:04:39.295227 | debian-bookworm -> localhost | ok 2025-10-30 19:04:39.301005 | 2025-10-30 19:04:39.301110 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-30 19:04:39.328859 | debian-bookworm | ok 2025-10-30 19:04:39.357389 | debian-bookworm | included: /var/lib/zuul/builds/0a250b42090942d18fd47022556760c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-30 19:04:39.375127 | 2025-10-30 19:04:39.375232 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-30 19:04:42.465055 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-30 19:04:42.465219 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0a250b42090942d18fd47022556760c3/work/0a250b42090942d18fd47022556760c3_id_rsa 2025-10-30 19:04:42.465272 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0a250b42090942d18fd47022556760c3/work/0a250b42090942d18fd47022556760c3_id_rsa.pub 2025-10-30 19:04:42.465296 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-30 19:04:42.465317 | debian-bookworm -> localhost | SHA256:rGqo5BQDXtsVQtwgSRzfNlE9WF4xH74ABa3g2w/Kn6g zuul-build-sshkey 2025-10-30 19:04:42.465346 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-30 19:04:42.465365 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-30 19:04:42.465383 | debian-bookworm -> localhost | | o+=+oo..+++=.. | 2025-10-30 19:04:42.465402 | debian-bookworm -> localhost | | oo.o.oo.oo.+ .| 2025-10-30 19:04:42.465419 | debian-bookworm -> localhost | |. . . =. ..o. o | 2025-10-30 19:04:42.465435 | debian-bookworm -> localhost | |o . o o... . . .| 2025-10-30 19:04:42.465452 | debian-bookworm -> localhost | | + . . S o . | 2025-10-30 19:04:42.465472 | debian-bookworm -> localhost | | o . . o | 2025-10-30 19:04:42.465489 | debian-bookworm -> localhost | | o . . . . o | 2025-10-30 19:04:42.465505 | debian-bookworm -> localhost | |+ . .. o. .. | 2025-10-30 19:04:42.465522 | debian-bookworm -> localhost | |.o .. E...o | 2025-10-30 19:04:42.465539 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-30 19:04:42.465576 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.462375 2025-10-30 19:04:42.470723 | 2025-10-30 19:04:42.470800 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-30 19:04:42.486558 | debian-bookworm | ok 2025-10-30 19:04:42.494003 | debian-bookworm | included: /var/lib/zuul/builds/0a250b42090942d18fd47022556760c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-30 19:04:42.501239 | 2025-10-30 19:04:42.501319 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-30 19:04:42.513904 | debian-bookworm | skipping: Conditional result was False 2025-10-30 19:04:42.528433 | 2025-10-30 19:04:42.528551 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-30 19:04:43.125044 | debian-bookworm | changed 2025-10-30 19:04:43.130934 | 2025-10-30 19:04:43.131021 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-30 19:04:43.393296 | debian-bookworm | ok 2025-10-30 19:04:43.401236 | 2025-10-30 19:04:43.401369 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-30 19:04:44.056614 | debian-bookworm | changed 2025-10-30 19:04:44.063926 | 2025-10-30 19:04:44.064017 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-30 19:04:44.762716 | debian-bookworm | changed 2025-10-30 19:04:44.769866 | 2025-10-30 19:04:44.769954 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-30 19:04:44.806421 | debian-bookworm | skipping: Conditional result was False 2025-10-30 19:04:44.813624 | 2025-10-30 19:04:44.813722 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-30 19:04:45.434397 | debian-bookworm -> localhost | changed 2025-10-30 19:04:45.444991 | 2025-10-30 19:04:45.445086 | TASK [add-build-sshkey : Add back temp key] 2025-10-30 19:04:45.722000 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0a250b42090942d18fd47022556760c3/work/0a250b42090942d18fd47022556760c3_id_rsa (zuul-build-sshkey) 2025-10-30 19:04:45.722249 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015736 2025-10-30 19:04:45.729811 | 2025-10-30 19:04:45.729908 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-30 19:04:46.067602 | debian-bookworm | ok 2025-10-30 19:04:46.072426 | 2025-10-30 19:04:46.072510 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-30 19:04:46.085340 | debian-bookworm | skipping: Conditional result was False 2025-10-30 19:04:46.103647 | 2025-10-30 19:04:46.103764 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-30 19:04:46.549692 | debian-bookworm | ok 2025-10-30 19:04:46.559876 | 2025-10-30 19:04:46.559975 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-30 19:04:46.587484 | debian-bookworm | ok 2025-10-30 19:04:46.593312 | 2025-10-30 19:04:46.593404 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-30 19:04:46.867482 | debian-bookworm -> localhost | ok 2025-10-30 19:04:46.873484 | 2025-10-30 19:04:46.873568 | TASK [validate-host : Collect information about the host] 2025-10-30 19:04:48.031413 | debian-bookworm | ok 2025-10-30 19:04:48.039506 | 2025-10-30 19:04:48.039581 | TASK [validate-host : Sanitize hostname] 2025-10-30 19:04:48.125161 | debian-bookworm | ok 2025-10-30 19:04:48.155171 | 2025-10-30 19:04:48.155279 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-30 19:04:48.879452 | debian-bookworm -> localhost | changed 2025-10-30 19:04:48.884032 | 2025-10-30 19:04:48.884106 | TASK [validate-host : Collect information about zuul worker] 2025-10-30 19:04:49.389203 | debian-bookworm | ok 2025-10-30 19:04:49.392970 | 2025-10-30 19:04:49.393051 | TASK [validate-host : Write out all zuul information for each host] 2025-10-30 19:04:50.083537 | debian-bookworm -> localhost | changed 2025-10-30 19:04:50.092783 | 2025-10-30 19:04:50.092869 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-30 19:04:50.353693 | debian-bookworm | ok 2025-10-30 19:04:50.358928 | 2025-10-30 19:04:50.359028 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-30 19:04:51.520947 | debian-bookworm | changed: 2025-10-30 19:04:51.521122 | debian-bookworm | cd+++++++++ src/ 2025-10-30 19:04:51.521157 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-30 19:04:51.521181 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-30 19:04:51.521203 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-10-30 19:04:51.521223 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007165 2025-10-30 19:05:07.752203 | 2025-10-30 19:05:07.752405 | TASK [upload-logs : Upload logs to log server] 2025-10-30 19:05:08.289126 | localhost | Output suppressed because no_log was given 2025-10-30 19:05:08.291756 | 2025-10-30 19:05:08.291892 | LOOP [upload-logs : Compress console log and json output] 2025-10-30 19:05:08.347335 | localhost | skipping: Conditional result was False 2025-10-30 19:05:08.352378 | localhost | skipping: Conditional result was False 2025-10-30 19:05:08.364214 | 2025-10-30 19:05:08.364448 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-30 19:05:08.410807 | localhost | skipping: Conditional result was False 2025-10-30 19:05:08.411522 | 2025-10-30 19:05:08.414576 | localhost | skipping: Conditional result was False 2025-10-30 19:05:08.428638 | 2025-10-30 19:05:08.428848 | LOOP [upload-logs : Upload console log and json output]