2025-02-18 19:35:12.972238 | Job console starting... 2025-02-18 19:35:13.017546 | Updating repositories 2025-02-18 19:35:13.072874 | Preparing job workspace 2025-02-18 19:35:16.445301 | Running Ansible setup... 2025-02-18 19:35:23.387015 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-18 19:35:24.453230 | 2025-02-18 19:35:24.453394 | PLAY [Base pre] 2025-02-18 19:35:24.519124 | 2025-02-18 19:35:24.519478 | TASK [Setup log path fact] 2025-02-18 19:35:24.561449 | ubuntu-noble | ok 2025-02-18 19:35:24.585248 | 2025-02-18 19:35:24.585411 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-18 19:35:24.668148 | ubuntu-noble | ok 2025-02-18 19:35:24.687252 | 2025-02-18 19:35:24.687400 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-18 19:35:24.732728 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 19:35:24.740550 | 2025-02-18 19:35:24.740699 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-18 19:35:24.785972 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 19:35:24.794207 | 2025-02-18 19:35:24.794340 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-18 19:35:24.819533 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 19:35:24.830613 | 2025-02-18 19:35:24.830963 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-18 19:35:24.880262 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 19:35:24.888318 | 2025-02-18 19:35:24.888493 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-18 19:35:24.923387 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 19:35:24.964859 | 2025-02-18 19:35:24.965033 | TASK [emit-job-header : Print job information] 2025-02-18 19:35:25.028289 | # Job Information 2025-02-18 19:35:25.028518 | Ansible Version: 2.15.3 2025-02-18 19:35:25.028553 | Job: ansible-collection-ensure-readme 2025-02-18 19:35:25.028583 | Pipeline: check 2025-02-18 19:35:25.028604 | Executor: 7d211f194f6a 2025-02-18 19:35:25.028623 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1764 2025-02-18 19:35:25.028642 | Event ID: 730cd870-ee2f-11ef-8caf-70954c2c5fe0 2025-02-18 19:35:25.043888 | 2025-02-18 19:35:25.044033 | LOOP [emit-job-header : Print node information] 2025-02-18 19:35:25.298527 | ubuntu-noble | ok: 2025-02-18 19:35:25.298753 | ubuntu-noble | # Node Information 2025-02-18 19:35:25.298789 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-18 19:35:25.298826 | ubuntu-noble | Hostname: ubuntu 2025-02-18 19:35:25.298849 | ubuntu-noble | Username: zuul 2025-02-18 19:35:25.298869 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-18 19:35:25.298889 | ubuntu-noble | Provider: regiocloud-a 2025-02-18 19:35:25.298909 | ubuntu-noble | Label: ubuntu-noble 2025-02-18 19:35:25.298928 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-18 19:35:25.298949 | ubuntu-noble | Interface IP: 81.163.192.43 2025-02-18 19:35:25.317010 | 2025-02-18 19:35:25.317105 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-18 19:35:25.887211 | ubuntu-noble -> localhost | changed 2025-02-18 19:35:25.894084 | 2025-02-18 19:35:25.894161 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-18 19:35:27.089005 | ubuntu-noble -> localhost | changed 2025-02-18 19:35:27.110532 | 2025-02-18 19:35:27.110643 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-18 19:35:27.525387 | ubuntu-noble -> localhost | ok 2025-02-18 19:35:27.532179 | 2025-02-18 19:35:27.532270 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-18 19:35:27.581419 | ubuntu-noble | ok 2025-02-18 19:35:27.602714 | ubuntu-noble | included: /var/lib/zuul/builds/9cf9221fff01463b9b24d7f0b76a920a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-18 19:35:27.617901 | 2025-02-18 19:35:27.617989 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-18 19:35:28.478172 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-18 19:35:28.478331 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/9cf9221fff01463b9b24d7f0b76a920a/work/9cf9221fff01463b9b24d7f0b76a920a_id_rsa 2025-02-18 19:35:28.478364 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/9cf9221fff01463b9b24d7f0b76a920a/work/9cf9221fff01463b9b24d7f0b76a920a_id_rsa.pub 2025-02-18 19:35:28.478385 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-18 19:35:28.478405 | ubuntu-noble -> localhost | SHA256:3QZh1H0t5YJXBmVRfq5Ilob26L75jEdPU/DTpPG+aAA zuul-build-sshkey 2025-02-18 19:35:28.478424 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-18 19:35:28.478444 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-18 19:35:28.478462 | ubuntu-noble -> localhost | | .+. ..=@| 2025-02-18 19:35:28.478478 | ubuntu-noble -> localhost | | . ...=*+| 2025-02-18 19:35:28.478495 | ubuntu-noble -> localhost | | . . oX=| 2025-02-18 19:35:28.478511 | ubuntu-noble -> localhost | | E + o.+*| 2025-02-18 19:35:28.478527 | ubuntu-noble -> localhost | | S = B oo| 2025-02-18 19:35:28.478543 | ubuntu-noble -> localhost | | . O..o..| 2025-02-18 19:35:28.478559 | ubuntu-noble -> localhost | | ..+oo..| 2025-02-18 19:35:28.478575 | ubuntu-noble -> localhost | | . +.o.. | 2025-02-18 19:35:28.478591 | ubuntu-noble -> localhost | | .*++ | 2025-02-18 19:35:28.478607 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-18 19:35:28.478647 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.137355 2025-02-18 19:35:28.485592 | 2025-02-18 19:35:28.485674 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-18 19:35:28.533618 | ubuntu-noble | ok 2025-02-18 19:35:28.543764 | ubuntu-noble | included: /var/lib/zuul/builds/9cf9221fff01463b9b24d7f0b76a920a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-18 19:35:28.568450 | 2025-02-18 19:35:28.568527 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-18 19:35:28.602003 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 19:35:28.607920 | 2025-02-18 19:35:28.608000 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-18 19:35:29.233627 | ubuntu-noble | changed 2025-02-18 19:35:29.240049 | 2025-02-18 19:35:29.240122 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-18 19:35:29.522378 | ubuntu-noble | ok 2025-02-18 19:35:29.531927 | 2025-02-18 19:35:29.532037 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-18 19:35:30.239449 | ubuntu-noble | changed 2025-02-18 19:35:30.245817 | 2025-02-18 19:35:30.245902 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-18 19:35:31.026437 | ubuntu-noble | changed 2025-02-18 19:35:31.037490 | 2025-02-18 19:35:31.037591 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-18 19:35:31.058920 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 19:35:31.066349 | 2025-02-18 19:35:31.066440 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-18 19:35:31.564705 | ubuntu-noble -> localhost | changed 2025-02-18 19:35:31.578221 | 2025-02-18 19:35:31.578326 | TASK [add-build-sshkey : Add back temp key] 2025-02-18 19:35:32.006389 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/9cf9221fff01463b9b24d7f0b76a920a/work/9cf9221fff01463b9b24d7f0b76a920a_id_rsa (zuul-build-sshkey) 2025-02-18 19:35:32.006586 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009148 2025-02-18 19:35:32.038398 | 2025-02-18 19:35:32.038493 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-18 19:35:32.450350 | ubuntu-noble | ok 2025-02-18 19:35:32.458668 | 2025-02-18 19:35:32.458761 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-18 19:35:32.505755 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 19:35:32.517235 | 2025-02-18 19:35:32.517327 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-18 19:35:32.952223 | ubuntu-noble | ok 2025-02-18 19:35:32.973191 | 2025-02-18 19:35:32.973284 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-18 19:35:33.031866 | ubuntu-noble | ok 2025-02-18 19:35:33.039092 | 2025-02-18 19:35:33.039187 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-18 19:35:33.319747 | ubuntu-noble -> localhost | ok 2025-02-18 19:35:33.335547 | 2025-02-18 19:35:33.335679 | TASK [validate-host : Collect information about the host] 2025-02-18 19:35:34.546557 | ubuntu-noble | ok 2025-02-18 19:35:34.558097 | 2025-02-18 19:35:34.558191 | TASK [validate-host : Sanitize hostname] 2025-02-18 19:35:34.634676 | ubuntu-noble | ok 2025-02-18 19:35:34.642801 | 2025-02-18 19:35:34.642919 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-18 19:35:35.190594 | ubuntu-noble -> localhost | changed 2025-02-18 19:35:35.211944 | 2025-02-18 19:35:35.212047 | TASK [validate-host : Collect information about zuul worker] 2025-02-18 19:35:35.714822 | ubuntu-noble | ok 2025-02-18 19:35:35.721292 | 2025-02-18 19:35:35.721389 | TASK [validate-host : Write out all zuul information for each host] 2025-02-18 19:35:36.215056 | ubuntu-noble -> localhost | changed 2025-02-18 19:35:36.225354 | 2025-02-18 19:35:36.225434 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-18 19:35:36.580683 | ubuntu-noble | ok 2025-02-18 19:35:36.587758 | 2025-02-18 19:35:36.587870 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-18 19:35:38.022714 | ubuntu-noble | changed: 2025-02-18 19:35:38.022888 | ubuntu-noble | cd+++++++++ src/ 2025-02-18 19:35:38.022923 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-18 19:35:38.022947 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-18 19:35:38.022970 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-02-18 19:35:38.022990 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008477 2025-02-18 19:35:57.728380 | 2025-02-18 19:35:57.728590 | TASK [upload-logs : Upload logs to log server] 2025-02-18 19:35:58.327673 | localhost | Output suppressed because no_log was given 2025-02-18 19:35:58.333283 | 2025-02-18 19:35:58.333438 | LOOP [upload-logs : Compress console log and json output] 2025-02-18 19:35:58.417269 | localhost | skipping: Conditional result was False 2025-02-18 19:35:58.435509 | localhost | skipping: Conditional result was False 2025-02-18 19:35:58.449619 | 2025-02-18 19:35:58.449865 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-18 19:35:58.520152 | localhost | skipping: Conditional result was False 2025-02-18 19:35:58.520671 | 2025-02-18 19:35:58.536720 | localhost | skipping: Conditional result was False 2025-02-18 19:35:58.546166 | 2025-02-18 19:35:58.546277 | LOOP [upload-logs : Upload console log and json output]