2025-08-23 21:48:15.105362 | Job console starting 2025-08-23 21:48:15.115797 | Updating git repos 2025-08-23 21:48:15.160434 | Cloning repos into workspace 2025-08-23 21:48:15.255415 | Restoring repo states 2025-08-23 21:48:15.288105 | Merging changes 2025-08-23 21:48:15.982863 | Checking out repos 2025-08-23 21:48:16.029970 | Preparing playbooks 2025-08-23 21:48:16.512328 | Running Ansible setup 2025-08-23 21:48:20.986862 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-23 21:48:21.793269 | 2025-08-23 21:48:21.793462 | PLAY [Base pre] 2025-08-23 21:48:21.811791 | 2025-08-23 21:48:21.811949 | TASK [Setup log path fact] 2025-08-23 21:48:21.831429 | debian-bookworm | ok 2025-08-23 21:48:21.847090 | 2025-08-23 21:48:21.847255 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-23 21:48:21.880509 | debian-bookworm | ok 2025-08-23 21:48:21.891201 | 2025-08-23 21:48:21.891357 | TASK [emit-job-header : Print job information] 2025-08-23 21:48:21.945078 | # Job Information 2025-08-23 21:48:21.945368 | Ansible Version: 2.16.14 2025-08-23 21:48:21.945423 | Job: ansible-collection-ensure-readme 2025-08-23 21:48:21.945470 | Pipeline: check 2025-08-23 21:48:21.945504 | Executor: 521e9411259a 2025-08-23 21:48:21.945534 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1961 2025-08-23 21:48:21.945566 | Event ID: 9fdd6220-806a-11f0-8533-9b33fbac3839 2025-08-23 21:48:21.951784 | 2025-08-23 21:48:21.951911 | LOOP [emit-job-header : Print node information] 2025-08-23 21:48:22.076414 | debian-bookworm | ok: 2025-08-23 21:48:22.076711 | debian-bookworm | # Node Information 2025-08-23 21:48:22.076750 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-23 21:48:22.076776 | debian-bookworm | Hostname: debian 2025-08-23 21:48:22.076798 | debian-bookworm | Username: zuul 2025-08-23 21:48:22.076818 | debian-bookworm | Distro: Debian 12.11 2025-08-23 21:48:22.076842 | debian-bookworm | Provider: regiocloud-a 2025-08-23 21:48:22.076864 | debian-bookworm | Region: 2025-08-23 21:48:22.076884 | debian-bookworm | Label: debian-bookworm 2025-08-23 21:48:22.076904 | debian-bookworm | Product Name: OpenStack Nova 2025-08-23 21:48:22.076923 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb4:e91 2025-08-23 21:48:22.101843 | 2025-08-23 21:48:22.102002 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-23 21:48:22.630767 | debian-bookworm -> localhost | changed 2025-08-23 21:48:22.642235 | 2025-08-23 21:48:22.642409 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-23 21:48:23.834292 | debian-bookworm -> localhost | changed 2025-08-23 21:48:23.845659 | 2025-08-23 21:48:23.845780 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-23 21:48:24.143944 | debian-bookworm -> localhost | ok 2025-08-23 21:48:24.150428 | 2025-08-23 21:48:24.150545 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-23 21:48:24.186813 | debian-bookworm | ok 2025-08-23 21:48:24.219350 | debian-bookworm | included: /var/lib/zuul/builds/714d84ed07fb4881bff323c9fcdde9e0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-23 21:48:24.226908 | 2025-08-23 21:48:24.227012 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-23 21:48:25.963563 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-23 21:48:25.963794 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/714d84ed07fb4881bff323c9fcdde9e0/work/714d84ed07fb4881bff323c9fcdde9e0_id_rsa 2025-08-23 21:48:25.963832 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/714d84ed07fb4881bff323c9fcdde9e0/work/714d84ed07fb4881bff323c9fcdde9e0_id_rsa.pub 2025-08-23 21:48:25.963858 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-23 21:48:25.963884 | debian-bookworm -> localhost | SHA256:Fyu8jk3WDIotHZSoT1D9GRs5vl8KEljCeSS7ENtt6Wc zuul-build-sshkey 2025-08-23 21:48:25.963923 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-23 21:48:25.963947 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-23 21:48:25.963968 | debian-bookworm -> localhost | | ..o+. . | 2025-08-23 21:48:25.963990 | debian-bookworm -> localhost | | =+=+o= | 2025-08-23 21:48:25.964010 | debian-bookworm -> localhost | | + +=*o *. | 2025-08-23 21:48:25.964030 | debian-bookworm -> localhost | | +.=..= o | 2025-08-23 21:48:25.964050 | debian-bookworm -> localhost | | . o o.E.o | 2025-08-23 21:48:25.964076 | debian-bookworm -> localhost | | o +.=oB . | 2025-08-23 21:48:25.964097 | debian-bookworm -> localhost | | + +.+ooo | 2025-08-23 21:48:25.964116 | debian-bookworm -> localhost | | . * o | 2025-08-23 21:48:25.964137 | debian-bookworm -> localhost | | . o | 2025-08-23 21:48:25.964157 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-23 21:48:25.964217 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.166746 2025-08-23 21:48:25.970922 | 2025-08-23 21:48:25.971045 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-23 21:48:26.009320 | debian-bookworm | ok 2025-08-23 21:48:26.023882 | debian-bookworm | included: /var/lib/zuul/builds/714d84ed07fb4881bff323c9fcdde9e0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-23 21:48:26.033318 | 2025-08-23 21:48:26.033426 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-23 21:48:26.061609 | debian-bookworm | skipping: Conditional result was False 2025-08-23 21:48:26.067728 | 2025-08-23 21:48:26.067838 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-23 21:48:26.804267 | debian-bookworm | changed 2025-08-23 21:48:26.812263 | 2025-08-23 21:48:26.812411 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-23 21:48:27.097142 | debian-bookworm | ok 2025-08-23 21:48:27.102979 | 2025-08-23 21:48:27.103093 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-23 21:48:27.808416 | debian-bookworm | changed 2025-08-23 21:48:27.819872 | 2025-08-23 21:48:27.819999 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-23 21:48:28.566493 | debian-bookworm | changed 2025-08-23 21:48:28.572536 | 2025-08-23 21:48:28.572642 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-23 21:48:28.599178 | debian-bookworm | skipping: Conditional result was False 2025-08-23 21:48:28.606372 | 2025-08-23 21:48:28.606481 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-23 21:48:29.191111 | debian-bookworm -> localhost | changed 2025-08-23 21:48:29.216932 | 2025-08-23 21:48:29.217075 | TASK [add-build-sshkey : Add back temp key] 2025-08-23 21:48:29.598614 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/714d84ed07fb4881bff323c9fcdde9e0/work/714d84ed07fb4881bff323c9fcdde9e0_id_rsa (zuul-build-sshkey) 2025-08-23 21:48:29.599166 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014531 2025-08-23 21:48:29.607821 | 2025-08-23 21:48:29.607936 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-23 21:48:30.090529 | debian-bookworm | ok 2025-08-23 21:48:30.101967 | 2025-08-23 21:48:30.102083 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-23 21:48:30.125991 | debian-bookworm | skipping: Conditional result was False 2025-08-23 21:48:30.138669 | 2025-08-23 21:48:30.138773 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-23 21:48:30.570583 | debian-bookworm | ok 2025-08-23 21:48:30.590550 | 2025-08-23 21:48:30.590804 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-23 21:48:30.630636 | debian-bookworm | ok 2025-08-23 21:48:30.636024 | 2025-08-23 21:48:30.636136 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-23 21:48:30.924410 | debian-bookworm -> localhost | ok 2025-08-23 21:48:30.937930 | 2025-08-23 21:48:30.938082 | TASK [validate-host : Collect information about the host] 2025-08-23 21:48:32.025885 | debian-bookworm | ok 2025-08-23 21:48:32.041262 | 2025-08-23 21:48:32.041428 | TASK [validate-host : Sanitize hostname] 2025-08-23 21:48:32.164348 | debian-bookworm | ok 2025-08-23 21:48:32.216236 | 2025-08-23 21:48:32.216413 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-23 21:48:32.813015 | debian-bookworm -> localhost | changed 2025-08-23 21:48:32.828100 | 2025-08-23 21:48:32.828261 | TASK [validate-host : Collect information about zuul worker] 2025-08-23 21:48:33.267715 | debian-bookworm | ok 2025-08-23 21:48:33.275912 | 2025-08-23 21:48:33.276365 | TASK [validate-host : Write out all zuul information for each host] 2025-08-23 21:48:33.806910 | debian-bookworm -> localhost | changed 2025-08-23 21:48:33.816893 | 2025-08-23 21:48:33.817000 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-23 21:48:34.099345 | debian-bookworm | ok 2025-08-23 21:48:34.105140 | 2025-08-23 21:48:34.105246 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-23 21:48:35.191731 | debian-bookworm | changed: 2025-08-23 21:48:35.191953 | debian-bookworm | cd+++++++++ src/ 2025-08-23 21:48:35.191990 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-23 21:48:35.192015 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-23 21:48:35.192037 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-08-23 21:48:35.192057 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008617 2025-08-23 21:48:51.317468 | 2025-08-23 21:48:51.317592 | TASK [upload-logs : Upload logs to log server] 2025-08-23 21:48:51.872581 | localhost | Output suppressed because no_log was given 2025-08-23 21:48:51.874630 | 2025-08-23 21:48:51.874740 | LOOP [upload-logs : Compress console log and json output] 2025-08-23 21:48:51.940124 | localhost | skipping: Conditional result was False 2025-08-23 21:48:51.946260 | localhost | skipping: Conditional result was False 2025-08-23 21:48:51.956351 | 2025-08-23 21:48:51.956469 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-23 21:48:52.008621 | localhost | skipping: Conditional result was False 2025-08-23 21:48:52.008911 | 2025-08-23 21:48:52.022546 | localhost | skipping: Conditional result was False 2025-08-23 21:48:52.033811 | 2025-08-23 21:48:52.033950 | LOOP [upload-logs : Upload console log and json output]