2025-06-25 13:30:22.615565 | Job console starting 2025-06-25 13:30:22.627670 | Updating git repos 2025-06-25 13:30:22.680642 | Cloning repos into workspace 2025-06-25 13:30:22.725387 | Restoring repo states 2025-06-25 13:30:22.743494 | Merging changes 2025-06-25 13:30:23.337754 | Checking out repos 2025-06-25 13:30:23.409666 | Preparing playbooks 2025-06-25 13:30:24.071136 | Running Ansible setup 2025-06-25 13:30:28.386184 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-25 13:30:29.211717 | 2025-06-25 13:30:29.211924 | PLAY [Base pre] 2025-06-25 13:30:29.228742 | 2025-06-25 13:30:29.228883 | TASK [Setup log path fact] 2025-06-25 13:30:29.259856 | debian-bookworm | ok 2025-06-25 13:30:29.275372 | 2025-06-25 13:30:29.275504 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-25 13:30:29.306953 | debian-bookworm | ok 2025-06-25 13:30:29.317162 | 2025-06-25 13:30:29.317275 | TASK [emit-job-header : Print job information] 2025-06-25 13:30:29.376646 | # Job Information 2025-06-25 13:30:29.376961 | Ansible Version: 2.16.14 2025-06-25 13:30:29.377057 | Job: ansible-collection-ensure-readme 2025-06-25 13:30:29.377118 | Pipeline: check 2025-06-25 13:30:29.377160 | Executor: 521e9411259a 2025-06-25 13:30:29.377197 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1920 2025-06-25 13:30:29.377235 | Event ID: 828070d0-51c8-11f0-9b86-90ad6056e0f4 2025-06-25 13:30:29.385172 | 2025-06-25 13:30:29.385335 | LOOP [emit-job-header : Print node information] 2025-06-25 13:30:29.505253 | debian-bookworm | ok: 2025-06-25 13:30:29.505560 | debian-bookworm | # Node Information 2025-06-25 13:30:29.505619 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-25 13:30:29.505661 | debian-bookworm | Hostname: debian 2025-06-25 13:30:29.505698 | debian-bookworm | Username: zuul 2025-06-25 13:30:29.505736 | debian-bookworm | Distro: Debian 12.11 2025-06-25 13:30:29.505777 | debian-bookworm | Provider: regiocloud-a 2025-06-25 13:30:29.505815 | debian-bookworm | Region: 2025-06-25 13:30:29.505855 | debian-bookworm | Label: debian-bookworm 2025-06-25 13:30:29.505891 | debian-bookworm | Product Name: OpenStack Nova 2025-06-25 13:30:29.505925 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9b:f1a 2025-06-25 13:30:29.532227 | 2025-06-25 13:30:29.532432 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-25 13:30:30.045561 | debian-bookworm -> localhost | changed 2025-06-25 13:30:30.060119 | 2025-06-25 13:30:30.060304 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-25 13:30:31.173937 | debian-bookworm -> localhost | changed 2025-06-25 13:30:31.184878 | 2025-06-25 13:30:31.185013 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-25 13:30:31.506177 | debian-bookworm -> localhost | ok 2025-06-25 13:30:31.520626 | 2025-06-25 13:30:31.520841 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-25 13:30:31.545066 | debian-bookworm | ok 2025-06-25 13:30:31.565660 | debian-bookworm | included: /var/lib/zuul/builds/a2a7108dbf434c88a09c21359b9d9a6f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-25 13:30:31.571864 | 2025-06-25 13:30:31.571969 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-25 13:30:32.961880 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-25 13:30:32.962313 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a2a7108dbf434c88a09c21359b9d9a6f/work/a2a7108dbf434c88a09c21359b9d9a6f_id_rsa 2025-06-25 13:30:32.962386 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a2a7108dbf434c88a09c21359b9d9a6f/work/a2a7108dbf434c88a09c21359b9d9a6f_id_rsa.pub 2025-06-25 13:30:32.962431 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-25 13:30:32.962472 | debian-bookworm -> localhost | SHA256:l1vKEtp8KIFFT9iHPPYowUzgXn0D01nwgi8qHlAbQxc zuul-build-sshkey 2025-06-25 13:30:32.962528 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-25 13:30:32.962567 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-25 13:30:32.962604 | debian-bookworm -> localhost | | o=E=+o.+. | 2025-06-25 13:30:32.962642 | debian-bookworm -> localhost | | o o=+*++. | 2025-06-25 13:30:32.962676 | debian-bookworm -> localhost | | = oo+=+ . | 2025-06-25 13:30:32.962710 | debian-bookworm -> localhost | | o B. .o.+ | 2025-06-25 13:30:32.962744 | debian-bookworm -> localhost | | . + ..S + . | 2025-06-25 13:30:32.962784 | debian-bookworm -> localhost | | . * * + | 2025-06-25 13:30:32.962876 | debian-bookworm -> localhost | | o + = = | 2025-06-25 13:30:32.962949 | debian-bookworm -> localhost | | . o . o | 2025-06-25 13:30:32.963046 | debian-bookworm -> localhost | | . | 2025-06-25 13:30:32.963091 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-25 13:30:32.963202 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.844523 2025-06-25 13:30:32.972685 | 2025-06-25 13:30:32.972817 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-25 13:30:33.009388 | debian-bookworm | ok 2025-06-25 13:30:33.022024 | debian-bookworm | included: /var/lib/zuul/builds/a2a7108dbf434c88a09c21359b9d9a6f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-25 13:30:33.032378 | 2025-06-25 13:30:33.032509 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-25 13:30:33.056789 | debian-bookworm | skipping: Conditional result was False 2025-06-25 13:30:33.064951 | 2025-06-25 13:30:33.065107 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-25 13:30:33.701176 | debian-bookworm | changed 2025-06-25 13:30:33.709342 | 2025-06-25 13:30:33.709477 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-25 13:30:33.966671 | debian-bookworm | ok 2025-06-25 13:30:33.972806 | 2025-06-25 13:30:33.972931 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-25 13:30:34.658530 | debian-bookworm | changed 2025-06-25 13:30:34.669119 | 2025-06-25 13:30:34.669260 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-25 13:30:35.334065 | debian-bookworm | changed 2025-06-25 13:30:35.343231 | 2025-06-25 13:30:35.343369 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-25 13:30:35.368234 | debian-bookworm | skipping: Conditional result was False 2025-06-25 13:30:35.377451 | 2025-06-25 13:30:35.377623 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-25 13:30:35.848787 | debian-bookworm -> localhost | changed 2025-06-25 13:30:35.865559 | 2025-06-25 13:30:35.865703 | TASK [add-build-sshkey : Add back temp key] 2025-06-25 13:30:36.206225 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a2a7108dbf434c88a09c21359b9d9a6f/work/a2a7108dbf434c88a09c21359b9d9a6f_id_rsa (zuul-build-sshkey) 2025-06-25 13:30:36.206719 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017773 2025-06-25 13:30:36.222396 | 2025-06-25 13:30:36.222528 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-25 13:30:36.627168 | debian-bookworm | ok 2025-06-25 13:30:36.637215 | 2025-06-25 13:30:36.637362 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-25 13:30:36.674234 | debian-bookworm | skipping: Conditional result was False 2025-06-25 13:30:36.691767 | 2025-06-25 13:30:36.691898 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-25 13:30:37.152076 | debian-bookworm | ok 2025-06-25 13:30:37.167435 | 2025-06-25 13:30:37.167567 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-25 13:30:37.214053 | debian-bookworm | ok 2025-06-25 13:30:37.222182 | 2025-06-25 13:30:37.222316 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-25 13:30:37.530314 | debian-bookworm -> localhost | ok 2025-06-25 13:30:37.537369 | 2025-06-25 13:30:37.537479 | TASK [validate-host : Collect information about the host] 2025-06-25 13:30:38.679581 | debian-bookworm | ok 2025-06-25 13:30:38.690142 | 2025-06-25 13:30:38.690264 | TASK [validate-host : Sanitize hostname] 2025-06-25 13:30:38.819048 | debian-bookworm | ok 2025-06-25 13:30:38.866669 | 2025-06-25 13:30:38.866910 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-25 13:30:39.473121 | debian-bookworm -> localhost | changed 2025-06-25 13:30:39.487958 | 2025-06-25 13:30:39.488097 | TASK [validate-host : Collect information about zuul worker] 2025-06-25 13:30:39.910075 | debian-bookworm | ok 2025-06-25 13:30:39.917814 | 2025-06-25 13:30:39.917970 | TASK [validate-host : Write out all zuul information for each host] 2025-06-25 13:30:40.490816 | debian-bookworm -> localhost | changed 2025-06-25 13:30:40.506992 | 2025-06-25 13:30:40.507195 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-25 13:30:40.788600 | debian-bookworm | ok 2025-06-25 13:30:40.798456 | 2025-06-25 13:30:40.798605 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-25 13:30:41.921544 | debian-bookworm | changed: 2025-06-25 13:30:41.921812 | debian-bookworm | cd+++++++++ src/ 2025-06-25 13:30:41.921848 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-25 13:30:41.921872 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-25 13:30:41.921893 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-06-25 13:30:41.921912 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005527 2025-06-25 13:30:57.429373 | 2025-06-25 13:30:57.429549 | TASK [upload-logs : Upload logs to log server] 2025-06-25 13:30:58.041661 | localhost | Output suppressed because no_log was given 2025-06-25 13:30:58.044272 | 2025-06-25 13:30:58.044441 | LOOP [upload-logs : Compress console log and json output] 2025-06-25 13:30:58.102084 | localhost | skipping: Conditional result was False 2025-06-25 13:30:58.107890 | localhost | skipping: Conditional result was False 2025-06-25 13:30:58.120865 | 2025-06-25 13:30:58.121173 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-25 13:30:58.178649 | localhost | skipping: Conditional result was False 2025-06-25 13:30:58.178986 | 2025-06-25 13:30:58.189835 | localhost | skipping: Conditional result was False 2025-06-25 13:30:58.193631 | 2025-06-25 13:30:58.193795 | LOOP [upload-logs : Upload console log and json output]