2025-10-11 18:35:36.562366 | Job console starting 2025-10-11 18:35:36.579297 | Updating git repos 2025-10-11 18:35:36.647416 | Cloning repos into workspace 2025-10-11 18:35:36.767140 | Restoring repo states 2025-10-11 18:35:36.786744 | Merging changes 2025-10-11 18:35:37.357010 | Checking out repos 2025-10-11 18:35:37.388530 | Preparing playbooks 2025-10-11 18:35:37.994236 | Running Ansible setup 2025-10-11 18:35:42.973462 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-11 18:35:43.765604 | 2025-10-11 18:35:43.765767 | PLAY [Base pre] 2025-10-11 18:35:43.781745 | 2025-10-11 18:35:43.781874 | TASK [Setup log path fact] 2025-10-11 18:35:43.801367 | debian-bookworm | ok 2025-10-11 18:35:43.822455 | 2025-10-11 18:35:43.822607 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-11 18:35:43.869791 | debian-bookworm | ok 2025-10-11 18:35:43.884041 | 2025-10-11 18:35:43.884160 | TASK [emit-job-header : Print job information] 2025-10-11 18:35:43.943844 | # Job Information 2025-10-11 18:35:43.944143 | Ansible Version: 2.16.14 2025-10-11 18:35:43.944207 | Job: ansible-collection-ensure-readme 2025-10-11 18:35:43.944266 | Pipeline: check 2025-10-11 18:35:43.944308 | Executor: 521e9411259a 2025-10-11 18:35:43.944344 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1819 2025-10-11 18:35:43.944382 | Event ID: d09fa9c0-a6c8-11f0-8908-d1ce26540cda 2025-10-11 18:35:43.953182 | 2025-10-11 18:35:43.953331 | LOOP [emit-job-header : Print node information] 2025-10-11 18:35:44.093845 | debian-bookworm | ok: 2025-10-11 18:35:44.094133 | debian-bookworm | # Node Information 2025-10-11 18:35:44.094174 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-11 18:35:44.094201 | debian-bookworm | Hostname: debian 2025-10-11 18:35:44.094224 | debian-bookworm | Username: zuul 2025-10-11 18:35:44.094245 | debian-bookworm | Distro: Debian 12.12 2025-10-11 18:35:44.094269 | debian-bookworm | Provider: regiocloud-a 2025-10-11 18:35:44.094291 | debian-bookworm | Region: 2025-10-11 18:35:44.094312 | debian-bookworm | Label: debian-bookworm 2025-10-11 18:35:44.094332 | debian-bookworm | Product Name: OpenStack Nova 2025-10-11 18:35:44.094351 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed7:67f0 2025-10-11 18:35:44.139078 | 2025-10-11 18:35:44.139300 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-11 18:35:44.646657 | debian-bookworm -> localhost | changed 2025-10-11 18:35:44.654382 | 2025-10-11 18:35:44.654510 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-11 18:35:45.730002 | debian-bookworm -> localhost | changed 2025-10-11 18:35:45.741145 | 2025-10-11 18:35:45.741276 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-11 18:35:46.100028 | debian-bookworm -> localhost | ok 2025-10-11 18:35:46.106308 | 2025-10-11 18:35:46.106426 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-11 18:35:46.137165 | debian-bookworm | ok 2025-10-11 18:35:46.169452 | debian-bookworm | included: /var/lib/zuul/builds/f9fd7bb945284aebace8f105aaa7f443/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-11 18:35:46.176140 | 2025-10-11 18:35:46.176253 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-11 18:35:47.978944 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-11 18:35:47.979141 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f9fd7bb945284aebace8f105aaa7f443/work/f9fd7bb945284aebace8f105aaa7f443_id_rsa 2025-10-11 18:35:47.979177 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f9fd7bb945284aebace8f105aaa7f443/work/f9fd7bb945284aebace8f105aaa7f443_id_rsa.pub 2025-10-11 18:35:47.979203 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-11 18:35:47.979226 | debian-bookworm -> localhost | SHA256:kcJWbNjbXExd6TBZJMrChnV6kVQBdBCfTKCTOyvHYTc zuul-build-sshkey 2025-10-11 18:35:47.979259 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-11 18:35:47.979799 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-11 18:35:47.979833 | debian-bookworm -> localhost | | +..o%OB=+o| 2025-10-11 18:35:47.979857 | debian-bookworm -> localhost | | ...B.*.X++. | 2025-10-11 18:35:47.979891 | debian-bookworm -> localhost | | +oo% = ++ | 2025-10-11 18:35:47.979913 | debian-bookworm -> localhost | | . .o.B . | 2025-10-11 18:35:47.979934 | debian-bookworm -> localhost | | S= E | 2025-10-11 18:35:47.979959 | debian-bookworm -> localhost | | o = . | 2025-10-11 18:35:47.979980 | debian-bookworm -> localhost | | . + | 2025-10-11 18:35:47.980000 | debian-bookworm -> localhost | | o | 2025-10-11 18:35:47.980021 | debian-bookworm -> localhost | | | 2025-10-11 18:35:47.980042 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-11 18:35:47.980101 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.287670 2025-10-11 18:35:47.986100 | 2025-10-11 18:35:47.986191 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-11 18:35:48.004044 | debian-bookworm | ok 2025-10-11 18:35:48.013106 | debian-bookworm | included: /var/lib/zuul/builds/f9fd7bb945284aebace8f105aaa7f443/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-11 18:35:48.021462 | 2025-10-11 18:35:48.021538 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-11 18:35:48.034260 | debian-bookworm | skipping: Conditional result was False 2025-10-11 18:35:48.040382 | 2025-10-11 18:35:48.040465 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-11 18:35:48.738634 | debian-bookworm | changed 2025-10-11 18:35:48.746870 | 2025-10-11 18:35:48.747480 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-11 18:35:48.992819 | debian-bookworm | ok 2025-10-11 18:35:48.998014 | 2025-10-11 18:35:48.998097 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-11 18:35:49.615220 | debian-bookworm | changed 2025-10-11 18:35:49.623405 | 2025-10-11 18:35:49.623502 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-11 18:35:50.348583 | debian-bookworm | changed 2025-10-11 18:35:50.358147 | 2025-10-11 18:35:50.358250 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-11 18:35:50.374541 | debian-bookworm | skipping: Conditional result was False 2025-10-11 18:35:50.380467 | 2025-10-11 18:35:50.380556 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-11 18:35:51.023132 | debian-bookworm -> localhost | changed 2025-10-11 18:35:51.052509 | 2025-10-11 18:35:51.052616 | TASK [add-build-sshkey : Add back temp key] 2025-10-11 18:35:51.630734 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f9fd7bb945284aebace8f105aaa7f443/work/f9fd7bb945284aebace8f105aaa7f443_id_rsa (zuul-build-sshkey) 2025-10-11 18:35:51.630973 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025254 2025-10-11 18:35:51.639702 | 2025-10-11 18:35:51.639788 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-11 18:35:52.021234 | debian-bookworm | ok 2025-10-11 18:35:52.026084 | 2025-10-11 18:35:52.026169 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-11 18:35:52.048839 | debian-bookworm | skipping: Conditional result was False 2025-10-11 18:35:52.058506 | 2025-10-11 18:35:52.058591 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-11 18:35:52.629032 | debian-bookworm | ok 2025-10-11 18:35:52.644918 | 2025-10-11 18:35:52.645042 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-11 18:35:52.673871 | debian-bookworm | ok 2025-10-11 18:35:52.679136 | 2025-10-11 18:35:52.679224 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-11 18:35:53.049282 | debian-bookworm -> localhost | ok 2025-10-11 18:35:53.055337 | 2025-10-11 18:35:53.055425 | TASK [validate-host : Collect information about the host] 2025-10-11 18:35:54.194959 | debian-bookworm | ok 2025-10-11 18:35:54.208479 | 2025-10-11 18:35:54.208658 | TASK [validate-host : Sanitize hostname] 2025-10-11 18:35:54.382502 | debian-bookworm | ok 2025-10-11 18:35:54.425463 | 2025-10-11 18:35:54.425594 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-11 18:35:55.024600 | debian-bookworm -> localhost | changed 2025-10-11 18:35:55.031512 | 2025-10-11 18:35:55.031621 | TASK [validate-host : Collect information about zuul worker] 2025-10-11 18:35:55.458491 | debian-bookworm | ok 2025-10-11 18:35:55.466951 | 2025-10-11 18:35:55.467072 | TASK [validate-host : Write out all zuul information for each host] 2025-10-11 18:35:56.140850 | debian-bookworm -> localhost | changed 2025-10-11 18:35:56.160712 | 2025-10-11 18:35:56.160853 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-11 18:35:56.446619 | debian-bookworm | ok 2025-10-11 18:35:56.454743 | 2025-10-11 18:35:56.454918 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-11 18:35:57.614766 | debian-bookworm | changed: 2025-10-11 18:35:57.615073 | debian-bookworm | cd+++++++++ src/ 2025-10-11 18:35:57.615111 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-11 18:35:57.615137 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-11 18:35:57.615159 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-10-11 18:35:57.615180 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009066 2025-10-11 18:36:16.311302 | 2025-10-11 18:36:16.311390 | TASK [upload-logs : Upload logs to log server] 2025-10-11 18:36:16.801174 | localhost | Output suppressed because no_log was given 2025-10-11 18:36:16.802546 | 2025-10-11 18:36:16.802623 | LOOP [upload-logs : Compress console log and json output] 2025-10-11 18:36:16.842993 | localhost | skipping: Conditional result was False 2025-10-11 18:36:16.848504 | localhost | skipping: Conditional result was False 2025-10-11 18:36:16.857402 | 2025-10-11 18:36:16.857484 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-11 18:36:16.904742 | localhost | skipping: Conditional result was False 2025-10-11 18:36:16.905085 | 2025-10-11 18:36:16.908186 | localhost | skipping: Conditional result was False 2025-10-11 18:36:16.912811 | 2025-10-11 18:36:16.912899 | LOOP [upload-logs : Upload console log and json output]