2025-10-14 18:59:38.543081 | Job console starting 2025-10-14 18:59:38.562581 | Updating git repos 2025-10-14 18:59:38.634502 | Cloning repos into workspace 2025-10-14 18:59:38.725989 | Restoring repo states 2025-10-14 18:59:38.752262 | Merging changes 2025-10-14 18:59:39.550066 | Checking out repos 2025-10-14 18:59:39.606105 | Preparing playbooks 2025-10-14 18:59:40.588393 | Running Ansible setup 2025-10-14 18:59:45.979183 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-14 18:59:46.712886 | 2025-10-14 18:59:46.713007 | PLAY [Base pre] 2025-10-14 18:59:46.744808 | 2025-10-14 18:59:46.744916 | TASK [Setup log path fact] 2025-10-14 18:59:46.774135 | debian-bookworm | ok 2025-10-14 18:59:46.788439 | 2025-10-14 18:59:46.788540 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-14 18:59:46.827317 | debian-bookworm | ok 2025-10-14 18:59:46.840392 | 2025-10-14 18:59:46.840478 | TASK [emit-job-header : Print job information] 2025-10-14 18:59:46.908878 | # Job Information 2025-10-14 18:59:46.909030 | Ansible Version: 2.16.14 2025-10-14 18:59:46.909064 | Job: ansible-collection-ensure-readme 2025-10-14 18:59:46.909096 | Pipeline: check 2025-10-14 18:59:46.909119 | Executor: 521e9411259a 2025-10-14 18:59:46.909140 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2010 2025-10-14 18:59:46.909172 | Event ID: e9b20340-a92f-11f0-917a-d6e49f2906ef 2025-10-14 18:59:46.914689 | 2025-10-14 18:59:46.914778 | LOOP [emit-job-header : Print node information] 2025-10-14 18:59:47.027104 | debian-bookworm | ok: 2025-10-14 18:59:47.027258 | debian-bookworm | # Node Information 2025-10-14 18:59:47.027285 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-14 18:59:47.027306 | debian-bookworm | Hostname: debian 2025-10-14 18:59:47.027323 | debian-bookworm | Username: zuul 2025-10-14 18:59:47.027340 | debian-bookworm | Distro: Debian 12.12 2025-10-14 18:59:47.027359 | debian-bookworm | Provider: regiocloud-a 2025-10-14 18:59:47.027377 | debian-bookworm | Region: 2025-10-14 18:59:47.027394 | debian-bookworm | Label: debian-bookworm 2025-10-14 18:59:47.027410 | debian-bookworm | Product Name: OpenStack Nova 2025-10-14 18:59:47.027426 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe72:c041 2025-10-14 18:59:47.042071 | 2025-10-14 18:59:47.042197 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-14 18:59:47.518025 | debian-bookworm -> localhost | changed 2025-10-14 18:59:47.524903 | 2025-10-14 18:59:47.525001 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-14 18:59:48.609396 | debian-bookworm -> localhost | changed 2025-10-14 18:59:48.624102 | 2025-10-14 18:59:48.624227 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-14 18:59:49.103725 | debian-bookworm -> localhost | ok 2025-10-14 18:59:49.110277 | 2025-10-14 18:59:49.110382 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-14 18:59:49.150820 | debian-bookworm | ok 2025-10-14 18:59:49.168772 | debian-bookworm | included: /var/lib/zuul/builds/77c4c9cdf4f9403f92d4a99e9b6b4e7b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-14 18:59:49.174568 | 2025-10-14 18:59:49.174651 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-14 18:59:51.376073 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-14 18:59:51.376280 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/77c4c9cdf4f9403f92d4a99e9b6b4e7b/work/77c4c9cdf4f9403f92d4a99e9b6b4e7b_id_rsa 2025-10-14 18:59:51.376318 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/77c4c9cdf4f9403f92d4a99e9b6b4e7b/work/77c4c9cdf4f9403f92d4a99e9b6b4e7b_id_rsa.pub 2025-10-14 18:59:51.376343 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-14 18:59:51.376367 | debian-bookworm -> localhost | SHA256:gkr1b8GgIhgwC3wbTrQWsPGnPty7GSKhuojVMRl3dEY zuul-build-sshkey 2025-10-14 18:59:51.376399 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-14 18:59:51.376421 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-14 18:59:51.376442 | debian-bookworm -> localhost | |=ooo ..E | 2025-10-14 18:59:51.376463 | debian-bookworm -> localhost | |o+++o . o | 2025-10-14 18:59:51.376483 | debian-bookworm -> localhost | |o.++=.o . | 2025-10-14 18:59:51.376503 | debian-bookworm -> localhost | |...+oB + | 2025-10-14 18:59:51.376523 | debian-bookworm -> localhost | |o.o.* o S | 2025-10-14 18:59:51.376550 | debian-bookworm -> localhost | |.o++.o o . | 2025-10-14 18:59:51.376571 | debian-bookworm -> localhost | |..o=.o o | 2025-10-14 18:59:51.376592 | debian-bookworm -> localhost | |+.. o +. | 2025-10-14 18:59:51.376614 | debian-bookworm -> localhost | |=. +. | 2025-10-14 18:59:51.376635 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-14 18:59:51.376686 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.495764 2025-10-14 18:59:51.382786 | 2025-10-14 18:59:51.382886 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-14 18:59:51.403383 | debian-bookworm | ok 2025-10-14 18:59:51.434496 | debian-bookworm | included: /var/lib/zuul/builds/77c4c9cdf4f9403f92d4a99e9b6b4e7b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-14 18:59:51.463122 | 2025-10-14 18:59:51.463276 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-14 18:59:51.496236 | debian-bookworm | skipping: Conditional result was False 2025-10-14 18:59:51.502884 | 2025-10-14 18:59:51.502976 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-14 18:59:52.165341 | debian-bookworm | changed 2025-10-14 18:59:52.178274 | 2025-10-14 18:59:52.178356 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-14 18:59:52.439431 | debian-bookworm | ok 2025-10-14 18:59:52.444856 | 2025-10-14 18:59:52.444940 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-14 18:59:53.042101 | debian-bookworm | changed 2025-10-14 18:59:53.065745 | 2025-10-14 18:59:53.065958 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-14 18:59:53.715304 | debian-bookworm | changed 2025-10-14 18:59:53.720690 | 2025-10-14 18:59:53.720773 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-14 18:59:53.764763 | debian-bookworm | skipping: Conditional result was False 2025-10-14 18:59:53.779807 | 2025-10-14 18:59:53.779984 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-14 18:59:54.212089 | debian-bookworm -> localhost | changed 2025-10-14 18:59:54.222500 | 2025-10-14 18:59:54.222601 | TASK [add-build-sshkey : Add back temp key] 2025-10-14 18:59:54.650297 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/77c4c9cdf4f9403f92d4a99e9b6b4e7b/work/77c4c9cdf4f9403f92d4a99e9b6b4e7b_id_rsa (zuul-build-sshkey) 2025-10-14 18:59:54.650505 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024380 2025-10-14 18:59:54.657730 | 2025-10-14 18:59:54.657816 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-14 18:59:55.042585 | debian-bookworm | ok 2025-10-14 18:59:55.050315 | 2025-10-14 18:59:55.050408 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-14 18:59:55.073722 | debian-bookworm | skipping: Conditional result was False 2025-10-14 18:59:55.083798 | 2025-10-14 18:59:55.083894 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-14 18:59:55.518816 | debian-bookworm | ok 2025-10-14 18:59:55.533856 | 2025-10-14 18:59:55.533958 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-14 18:59:55.585829 | debian-bookworm | ok 2025-10-14 18:59:55.590646 | 2025-10-14 18:59:55.590729 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-14 18:59:55.827210 | debian-bookworm -> localhost | ok 2025-10-14 18:59:55.844513 | 2025-10-14 18:59:55.844637 | TASK [validate-host : Collect information about the host] 2025-10-14 18:59:56.943228 | debian-bookworm | ok 2025-10-14 18:59:56.960831 | 2025-10-14 18:59:56.960931 | TASK [validate-host : Sanitize hostname] 2025-10-14 18:59:57.070341 | debian-bookworm | ok 2025-10-14 18:59:57.106088 | 2025-10-14 18:59:57.106220 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-14 18:59:57.707330 | debian-bookworm -> localhost | changed 2025-10-14 18:59:57.712709 | 2025-10-14 18:59:57.712795 | TASK [validate-host : Collect information about zuul worker] 2025-10-14 18:59:58.124396 | debian-bookworm | ok 2025-10-14 18:59:58.128857 | 2025-10-14 18:59:58.128942 | TASK [validate-host : Write out all zuul information for each host] 2025-10-14 18:59:58.707820 | debian-bookworm -> localhost | changed 2025-10-14 18:59:58.716777 | 2025-10-14 18:59:58.716861 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-14 18:59:58.970804 | debian-bookworm | ok 2025-10-14 18:59:58.976962 | 2025-10-14 18:59:58.977054 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-14 19:00:00.092839 | debian-bookworm | changed: 2025-10-14 19:00:00.093094 | debian-bookworm | cd+++++++++ src/ 2025-10-14 19:00:00.093129 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-14 19:00:00.093173 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-14 19:00:00.093196 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-10-14 19:00:00.093217 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007720 2025-10-14 19:00:18.106043 | 2025-10-14 19:00:18.106252 | TASK [upload-logs : Upload logs to log server] 2025-10-14 19:00:18.706304 | localhost | Output suppressed because no_log was given 2025-10-14 19:00:18.714020 | 2025-10-14 19:00:18.714201 | LOOP [upload-logs : Compress console log and json output] 2025-10-14 19:00:18.774574 | localhost | skipping: Conditional result was False 2025-10-14 19:00:18.779770 | localhost | skipping: Conditional result was False 2025-10-14 19:00:18.787409 | 2025-10-14 19:00:18.787683 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-14 19:00:18.835242 | localhost | skipping: Conditional result was False 2025-10-14 19:00:18.835876 | 2025-10-14 19:00:18.839461 | localhost | skipping: Conditional result was False 2025-10-14 19:00:18.853039 | 2025-10-14 19:00:18.853331 | LOOP [upload-logs : Upload console log and json output]