2025-05-26 18:27:30.243276 | Job console starting 2025-05-26 18:27:30.282678 | Updating git repos 2025-05-26 18:27:30.382895 | Cloning repos into workspace 2025-05-26 18:27:30.462323 | Restoring repo states 2025-05-26 18:27:30.510075 | Merging changes 2025-05-26 18:27:31.162736 | Checking out repos 2025-05-26 18:27:31.281391 | Preparing playbooks 2025-05-26 18:27:32.392016 | Running Ansible setup 2025-05-26 18:27:38.039530 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-26 18:27:38.940736 | 2025-05-26 18:27:38.944089 | PLAY [Base pre] 2025-05-26 18:27:38.991118 | 2025-05-26 18:27:38.991312 | TASK [Setup log path fact] 2025-05-26 18:27:39.030012 | debian-bookworm | ok 2025-05-26 18:27:39.053535 | 2025-05-26 18:27:39.053762 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-26 18:27:39.119527 | debian-bookworm | ok 2025-05-26 18:27:39.131326 | 2025-05-26 18:27:39.131490 | TASK [emit-job-header : Print job information] 2025-05-26 18:27:39.172002 | # Job Information 2025-05-26 18:27:39.172221 | Ansible Version: 2.16.14 2025-05-26 18:27:39.172256 | Job: ansible-collection-ensure-readme 2025-05-26 18:27:39.172290 | Pipeline: check 2025-05-26 18:27:39.172313 | Executor: 521e9411259a 2025-05-26 18:27:39.172333 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1865 2025-05-26 18:27:39.172355 | Event ID: 1074ce80-3a5f-11f0-8f8a-e000fc7ed7e3 2025-05-26 18:27:39.177946 | 2025-05-26 18:27:39.178093 | LOOP [emit-job-header : Print node information] 2025-05-26 18:27:39.324663 | debian-bookworm | ok: 2025-05-26 18:27:39.324921 | debian-bookworm | # Node Information 2025-05-26 18:27:39.324965 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-26 18:27:39.324992 | debian-bookworm | Hostname: debian 2025-05-26 18:27:39.325014 | debian-bookworm | Username: zuul 2025-05-26 18:27:39.325035 | debian-bookworm | Distro: Debian 12.11 2025-05-26 18:27:39.325064 | debian-bookworm | Provider: regiocloud-a 2025-05-26 18:27:39.325092 | debian-bookworm | Region: 2025-05-26 18:27:39.325118 | debian-bookworm | Label: debian-bookworm 2025-05-26 18:27:39.325143 | debian-bookworm | Product Name: OpenStack Nova 2025-05-26 18:27:39.325168 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fead:df5b 2025-05-26 18:27:39.347655 | 2025-05-26 18:27:39.347842 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-26 18:27:40.082359 | debian-bookworm -> localhost | changed 2025-05-26 18:27:40.091324 | 2025-05-26 18:27:40.091727 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-26 18:27:42.099779 | debian-bookworm -> localhost | changed 2025-05-26 18:27:42.127990 | 2025-05-26 18:27:42.128194 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-26 18:27:42.714546 | debian-bookworm -> localhost | ok 2025-05-26 18:27:42.721405 | 2025-05-26 18:27:42.721543 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-26 18:27:42.774619 | debian-bookworm | ok 2025-05-26 18:27:42.808540 | debian-bookworm | included: /var/lib/zuul/builds/95043cac89e34e4abd63ffb6a472d843/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-26 18:27:42.827139 | 2025-05-26 18:27:42.827287 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-26 18:27:44.779586 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-26 18:27:44.779938 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/95043cac89e34e4abd63ffb6a472d843/work/95043cac89e34e4abd63ffb6a472d843_id_rsa 2025-05-26 18:27:44.779985 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/95043cac89e34e4abd63ffb6a472d843/work/95043cac89e34e4abd63ffb6a472d843_id_rsa.pub 2025-05-26 18:27:44.780013 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-26 18:27:44.780039 | debian-bookworm -> localhost | SHA256:Vzh3jzlL0aWVBqezm3spKmhenOsQJ2kMSvTyvGuLv+M zuul-build-sshkey 2025-05-26 18:27:44.780077 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-26 18:27:44.780100 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-26 18:27:44.780121 | debian-bookworm -> localhost | | . ...+| 2025-05-26 18:27:44.780144 | debian-bookworm -> localhost | | . . . o*.| 2025-05-26 18:27:44.780164 | debian-bookworm -> localhost | | o o o oo= .| 2025-05-26 18:27:44.780185 | debian-bookworm -> localhost | | . = o . + .o= | 2025-05-26 18:27:44.780206 | debian-bookworm -> localhost | | . o *S.. .= .| 2025-05-26 18:27:44.780234 | debian-bookworm -> localhost | | o =.. .oo | 2025-05-26 18:27:44.780255 | debian-bookworm -> localhost | | . ..+ o. .| 2025-05-26 18:27:44.780275 | debian-bookworm -> localhost | | .o.oo.. ..o | 2025-05-26 18:27:44.780295 | debian-bookworm -> localhost | | .+E*..o....o | 2025-05-26 18:27:44.780315 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-26 18:27:44.780388 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.993457 2025-05-26 18:27:44.788124 | 2025-05-26 18:27:44.788265 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-26 18:27:44.846407 | debian-bookworm | ok 2025-05-26 18:27:44.873301 | debian-bookworm | included: /var/lib/zuul/builds/95043cac89e34e4abd63ffb6a472d843/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-26 18:27:44.911280 | 2025-05-26 18:27:44.911447 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-26 18:27:44.958166 | debian-bookworm | skipping: Conditional result was False 2025-05-26 18:27:44.965458 | 2025-05-26 18:27:44.965605 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-26 18:27:46.009751 | debian-bookworm | changed 2025-05-26 18:27:46.023106 | 2025-05-26 18:27:46.031254 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-26 18:27:46.365700 | debian-bookworm | ok 2025-05-26 18:27:46.375305 | 2025-05-26 18:27:46.375427 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-26 18:27:46.978222 | debian-bookworm | changed 2025-05-26 18:27:46.987291 | 2025-05-26 18:27:46.987462 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-26 18:27:47.549807 | debian-bookworm | changed 2025-05-26 18:27:47.554332 | 2025-05-26 18:27:47.554418 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-26 18:27:47.567014 | debian-bookworm | skipping: Conditional result was False 2025-05-26 18:27:47.571658 | 2025-05-26 18:27:47.571744 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-26 18:27:47.963196 | debian-bookworm -> localhost | changed 2025-05-26 18:27:47.975485 | 2025-05-26 18:27:47.975597 | TASK [add-build-sshkey : Add back temp key] 2025-05-26 18:27:48.303425 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/95043cac89e34e4abd63ffb6a472d843/work/95043cac89e34e4abd63ffb6a472d843_id_rsa (zuul-build-sshkey) 2025-05-26 18:27:48.303638 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015422 2025-05-26 18:27:48.310563 | 2025-05-26 18:27:48.310667 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-26 18:27:48.734424 | debian-bookworm | ok 2025-05-26 18:27:48.739826 | 2025-05-26 18:27:48.739921 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-26 18:27:48.781534 | debian-bookworm | skipping: Conditional result was False 2025-05-26 18:27:48.800722 | 2025-05-26 18:27:48.800856 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-26 18:27:49.207950 | debian-bookworm | ok 2025-05-26 18:27:49.223497 | 2025-05-26 18:27:49.223609 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-26 18:27:49.282662 | debian-bookworm | ok 2025-05-26 18:27:49.288674 | 2025-05-26 18:27:49.288782 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-26 18:27:49.700078 | debian-bookworm -> localhost | ok 2025-05-26 18:27:49.705441 | 2025-05-26 18:27:49.705541 | TASK [validate-host : Collect information about the host] 2025-05-26 18:27:50.944895 | debian-bookworm | ok 2025-05-26 18:27:50.968275 | 2025-05-26 18:27:50.968393 | TASK [validate-host : Sanitize hostname] 2025-05-26 18:27:51.096600 | debian-bookworm | ok 2025-05-26 18:27:51.171891 | 2025-05-26 18:27:51.172009 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-26 18:27:51.777585 | debian-bookworm -> localhost | changed 2025-05-26 18:27:51.788785 | 2025-05-26 18:27:51.788943 | TASK [validate-host : Collect information about zuul worker] 2025-05-26 18:27:52.185557 | debian-bookworm | ok 2025-05-26 18:27:52.190269 | 2025-05-26 18:27:52.190359 | TASK [validate-host : Write out all zuul information for each host] 2025-05-26 18:27:52.996909 | debian-bookworm -> localhost | changed 2025-05-26 18:27:53.006172 | 2025-05-26 18:27:53.006287 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-26 18:27:53.307773 | debian-bookworm | ok 2025-05-26 18:27:53.313207 | 2025-05-26 18:27:53.313295 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-26 18:27:54.479240 | debian-bookworm | changed: 2025-05-26 18:27:54.479490 | debian-bookworm | cd+++++++++ src/ 2025-05-26 18:27:54.479527 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-26 18:27:54.479551 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-26 18:27:54.479573 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-05-26 18:27:54.479594 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009153 2025-05-26 18:28:11.667945 | 2025-05-26 18:28:11.668103 | TASK [upload-logs : Upload logs to log server] 2025-05-26 18:28:12.345364 | localhost | Output suppressed because no_log was given 2025-05-26 18:28:12.349666 | 2025-05-26 18:28:12.349912 | LOOP [upload-logs : Compress console log and json output] 2025-05-26 18:28:12.415995 | localhost | skipping: Conditional result was False 2025-05-26 18:28:12.419218 | localhost | skipping: Conditional result was False 2025-05-26 18:28:12.436773 | 2025-05-26 18:28:12.437259 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-26 18:28:12.523028 | localhost | skipping: Conditional result was False 2025-05-26 18:28:12.523361 | 2025-05-26 18:28:12.535955 | localhost | skipping: Conditional result was False 2025-05-26 18:28:12.553065 | 2025-05-26 18:28:12.553226 | LOOP [upload-logs : Upload console log and json output]